builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1461895236.39 results: success (0) buildid: 20160428162445 builduid: 78a74070105a4d8798abe4833f88b9b5 revision: 11eb6b661fe4b6d889af99aeec890a9f1706944a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 19:00:36.385611) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 19:00:36.386066) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 19:00:36.386352) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 19:00:36.403331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 19:00:36.403728) ========= 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=32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 19:00:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-04-28 19:00:36 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140965 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 19:00:36.560065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 19:00:36.560424) ========= 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=32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018140 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 19:00:36.609666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 19:00:36.610126) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 11eb6b661fe4b6d889af99aeec890a9f1706944a --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-beta --rev 11eb6b661fe4b6d889af99aeec890a9f1706944a --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=32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 19:00:36,910 truncating revision to first 12 chars 2016-04-28 19:00:36,910 Setting DEBUG logging. 2016-04-28 19:00:36,910 attempt 1/10 2016-04-28 19:00:36,910 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/11eb6b661fe4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 19:00:37,465 unpacking tar archive at: mozilla-beta-11eb6b661fe4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.890494 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 19:00:37.513499) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 19:00:37.513812) ========= script_repo_revision: 11eb6b661fe4b6d889af99aeec890a9f1706944a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 19:00:37.514231) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 19:00:37.514513) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 19:00:37.522983) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-04-28 19:00:37.523315) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:00:37 INFO - MultiFileLogger online at 20160428 19:00:37 in /builds/slave/test 19:00:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 19:00:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:00:37 INFO - {'append_to_log': False, 19:00:37 INFO - 'base_work_dir': '/builds/slave/test', 19:00:37 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:00:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:00:37 INFO - 'branch': 'Mozilla-Beta', 19:00:37 INFO - 'buildbot_json_path': 'buildprops.json', 19:00:37 INFO - 'config_files': ('talos/linux_config.py',), 19:00:37 INFO - 'default_actions': ('clobber', 19:00:37 INFO - 'read-buildbot-config', 19:00:37 INFO - 'download-and-extract', 19:00:37 INFO - 'populate-webroot', 19:00:37 INFO - 'create-virtualenv', 19:00:37 INFO - 'install', 19:00:37 INFO - 'run-tests'), 19:00:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:00:37 INFO - 'download_minidump_stackwalk': True, 19:00:37 INFO - 'download_symbols': 'ondemand', 19:00:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:00:37 INFO - 'tooltool.py': '/tools/tooltool.py', 19:00:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:00:37 INFO - '/tools/misc-python/virtualenv.py')}, 19:00:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:00:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:00:37 INFO - 'installer_path': 'installer.exe', 19:00:37 INFO - 'log_level': 'info', 19:00:37 INFO - 'log_name': 'talos', 19:00:37 INFO - 'log_to_console': True, 19:00:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:00:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:00:37 INFO - 'opt_config_files': (), 19:00:37 INFO - 'pip_index': False, 19:00:37 INFO - 'sps_profile': False, 19:00:37 INFO - 'sps_profile_interval': 0, 19:00:37 INFO - 'suite': 'dromaeojs-e10s', 19:00:37 INFO - 'system_bits': '32', 19:00:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:00:37 INFO - 'title': 'talos-linux64-ix-008', 19:00:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:00:37 INFO - 'use_talos_json': True, 19:00:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:00:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:00:37 INFO - 'work_dir': 'build'} 19:00:37 INFO - ##### 19:00:37 INFO - ##### Running clobber step. 19:00:37 INFO - ##### 19:00:37 INFO - Running pre-action listener: _resource_record_pre_action 19:00:37 INFO - Running main action method: clobber 19:00:37 INFO - rmtree: /builds/slave/test/build 19:00:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:00:38 INFO - Running post-action listener: _resource_record_post_action 19:00:38 INFO - ##### 19:00:38 INFO - ##### Running read-buildbot-config step. 19:00:38 INFO - ##### 19:00:38 INFO - Running pre-action listener: _resource_record_pre_action 19:00:38 INFO - Running main action method: read_buildbot_config 19:00:38 INFO - Using buildbot properties: 19:00:38 INFO - { 19:00:38 INFO - "project": "", 19:00:38 INFO - "product": "firefox", 19:00:38 INFO - "script_repo_revision": "production", 19:00:38 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 19:00:38 INFO - "repository": "", 19:00:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 19:00:38 INFO - "buildid": "20160428162445", 19:00:38 INFO - "pgo_build": "True", 19:00:38 INFO - "basedir": "/builds/slave/test", 19:00:38 INFO - "buildnumber": 65, 19:00:38 INFO - "slavename": "talos-linux64-ix-008", 19:00:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:00:38 INFO - "platform": "ubuntu64_hw", 19:00:38 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 19:00:38 INFO - "branch": "mozilla-beta", 19:00:38 INFO - "repo_path": "releases/mozilla-beta", 19:00:38 INFO - "revision": "11eb6b661fe4b6d889af99aeec890a9f1706944a", 19:00:38 INFO - "stage_platform": "linux64-pgo", 19:00:38 INFO - "builduid": "78a74070105a4d8798abe4833f88b9b5", 19:00:38 INFO - "slavebuilddir": "test" 19:00:38 INFO - } 19:00:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 19:00:38 INFO - Running post-action listener: _resource_record_post_action 19:00:38 INFO - ##### 19:00:38 INFO - ##### Running download-and-extract step. 19:00:38 INFO - ##### 19:00:38 INFO - Running pre-action listener: _resource_record_pre_action 19:00:38 INFO - Running main action method: download_and_extract 19:00:38 INFO - mkdir: /builds/slave/test/build/tests 19:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:38 INFO - https://queue.taskcluster.net/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:00:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 19:00:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 19:00:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 19:00:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:00:39 INFO - Downloaded 1412 bytes. 19:00:39 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 19:00:39 INFO - Using the following test package requirements: 19:00:39 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 19:00:39 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:00:39 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 19:00:39 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:00:39 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 19:00:39 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:00:39 INFO - u'jsshell-linux-x86_64.zip'], 19:00:39 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:00:39 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 19:00:39 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 19:00:39 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:00:39 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 19:00:39 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:00:39 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 19:00:39 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:00:39 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 19:00:39 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 19:00:39 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 19:00:39 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 19:00:39 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:39 INFO - https://queue.taskcluster.net/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:00:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 19:00:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 19:00:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 19:00:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:00:40 INFO - Downloaded 23362730 bytes. 19:00:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:00:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:00:41 INFO - Return code: 0 19:00:41 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:41 INFO - https://queue.taskcluster.net/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:00:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 19:00:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 19:00:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 19:00:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:00:43 INFO - Downloaded 23362730 bytes. 19:00:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:00:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:00:45 INFO - Return code: 0 19:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:45 INFO - https://queue.taskcluster.net/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:00:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 19:00:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 19:00:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 19:00:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:00:46 INFO - Downloaded 10845194 bytes. 19:00:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:00:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:00:46 INFO - Return code: 0 19:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:46 INFO - https://queue.taskcluster.net/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:00:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 19:00:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 19:00:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 19:00:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:00:49 INFO - Downloaded 53785021 bytes. 19:00:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 19:00:49 INFO - mkdir: /builds/slave/test/properties 19:00:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:00:49 INFO - Writing to file /builds/slave/test/properties/build_url 19:00:49 INFO - Contents: 19:00:49 INFO - build_url:https://queue.taskcluster.net/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 19:00:50 INFO - Running post-action listener: _resource_record_post_action 19:00:50 INFO - Running post-action listener: set_extra_try_arguments 19:00:50 INFO - ##### 19:00:50 INFO - ##### Running populate-webroot step. 19:00:50 INFO - ##### 19:00:50 INFO - Running pre-action listener: _resource_record_pre_action 19:00:50 INFO - Running main action method: populate_webroot 19:00:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:00:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:00:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:00:50 INFO - '--tppagecycles', 19:00:50 INFO - '7'], 19:00:50 INFO - 'tests': ['tsvgm']}}, 19:00:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:00:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:00:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:00:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:00:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:00:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:00:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:50 INFO - 'talos_options': ['--e10s'], 19:00:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:50 INFO - 'tests': ['damp', 'tps']}, 19:00:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:50 INFO - 'talos_options': ['--e10s'], 19:00:50 INFO - 'tests': ['damp', 'tps']}, 19:00:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:00:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:00:50 INFO - 'other': {'tests': ['a11yr', 19:00:50 INFO - 'ts_paint', 19:00:50 INFO - 'tpaint', 19:00:50 INFO - 'sessionrestore', 19:00:50 INFO - 'sessionrestore_no_auto_restore', 19:00:50 INFO - 'tabpaint']}, 19:00:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:00:50 INFO - 'tests': ['a11yr', 19:00:50 INFO - 'ts_paint', 19:00:50 INFO - 'tpaint', 19:00:50 INFO - 'sessionrestore', 19:00:50 INFO - 'sessionrestore_no_auto_restore', 19:00:50 INFO - 'tabpaint']}, 19:00:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:00:50 INFO - 'tests': ['a11yr', 19:00:50 INFO - 'ts_paint', 19:00:50 INFO - 'tpaint', 19:00:50 INFO - 'sessionrestore', 19:00:50 INFO - 'sessionrestore_no_auto_restore', 19:00:50 INFO - 'tabpaint']}, 19:00:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:00:50 INFO - 'tests': ['a11yr', 19:00:50 INFO - 'ts_paint', 19:00:50 INFO - 'tpaint', 19:00:50 INFO - 'sessionrestore', 19:00:50 INFO - 'sessionrestore_no_auto_restore', 19:00:50 INFO - 'tabpaint']}, 19:00:50 INFO - 'other_l64': {'tests': ['a11yr', 19:00:50 INFO - 'ts_paint', 19:00:50 INFO - 'tpaint', 19:00:50 INFO - 'sessionrestore', 19:00:50 INFO - 'sessionrestore_no_auto_restore', 19:00:50 INFO - 'tabpaint']}, 19:00:50 INFO - 'other_nol64': {'tests': ['a11yr', 19:00:50 INFO - 'ts_paint', 19:00:50 INFO - 'tpaint', 19:00:50 INFO - 'sessionrestore', 19:00:50 INFO - 'sessionrestore_no_auto_restore', 19:00:50 INFO - 'tabpaint']}, 19:00:50 INFO - 'svgr': {'tests': ['tsvgx', 19:00:50 INFO - 'tsvgr_opacity', 19:00:50 INFO - 'tart', 19:00:50 INFO - 'tscrollx', 19:00:50 INFO - 'cart']}, 19:00:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:00:50 INFO - 'tests': ['tsvgx', 19:00:50 INFO - 'tsvgr_opacity', 19:00:50 INFO - 'tart', 19:00:50 INFO - 'tscrollx', 19:00:50 INFO - 'cart']}, 19:00:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:50 INFO - 'tests': ['tp5o']}, 19:00:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:50 INFO - 'talos_options': ['--e10s'], 19:00:50 INFO - 'tests': ['tp5o']}, 19:00:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:50 INFO - 'talos_options': ['--xperf_path', 19:00:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:50 INFO - 'tests': ['tp5n']}, 19:00:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:00:50 INFO - 'talos_options': ['--e10s', 19:00:50 INFO - '--xperf_path', 19:00:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:50 INFO - 'tests': ['tp5n']}}, 19:00:50 INFO - 'talos.zip': {'path': '', 19:00:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:00:50 INFO - Running post-action listener: _resource_record_post_action 19:00:50 INFO - ##### 19:00:50 INFO - ##### Running create-virtualenv step. 19:00:50 INFO - ##### 19:00:50 INFO - Running pre-action listener: _resource_record_pre_action 19:00:50 INFO - Running main action method: create_virtualenv 19:00:50 INFO - Creating virtualenv /builds/slave/test/build/venv 19:00:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:00:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:00:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:00:50 INFO - Using real prefix '/usr' 19:00:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:00:51 INFO - Installing distribute.............................................................................................................................................................................................done. 19:00:53 INFO - Installing pip.................done. 19:00:53 INFO - Return code: 0 19:00:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:53 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 0x7fb0ea181f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f160>, '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 0xe60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe604f0>, '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': '32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:00:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:00:53 INFO - Using env: {'DISPLAY': ':0', 19:00:53 INFO - 'HOME': '/home/cltbld', 19:00:53 INFO - 'LANG': 'en_US.UTF-8', 19:00:53 INFO - 'LANGUAGE': 'en_US:en', 19:00:53 INFO - 'LOGNAME': 'cltbld', 19:00:53 INFO - 'MAIL': '/var/mail/cltbld', 19:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:53 INFO - 'MOZ_NO_REMOTE': '1', 19:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:53 INFO - 'NO_EM_RESTART': '1', 19:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:53 INFO - 'PWD': '/builds/slave/test', 19:00:53 INFO - 'SHELL': '/bin/bash', 19:00:53 INFO - 'SHLVL': '1', 19:00:53 INFO - 'TERM': 'linux', 19:00:53 INFO - 'TMOUT': '86400', 19:00:53 INFO - 'USER': 'cltbld', 19:00:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626', 19:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:53 INFO - '_': '/tools/buildbot/bin/python'} 19:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:00:53 INFO - Cleaning up... 19:00:53 INFO - Return code: 0 19:00:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:53 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 0x7fb0ea181f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f160>, '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 0xe60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe604f0>, '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': '32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:00:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:00:53 INFO - Using env: {'DISPLAY': ':0', 19:00:53 INFO - 'HOME': '/home/cltbld', 19:00:53 INFO - 'LANG': 'en_US.UTF-8', 19:00:53 INFO - 'LANGUAGE': 'en_US:en', 19:00:53 INFO - 'LOGNAME': 'cltbld', 19:00:53 INFO - 'MAIL': '/var/mail/cltbld', 19:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:53 INFO - 'MOZ_NO_REMOTE': '1', 19:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:53 INFO - 'NO_EM_RESTART': '1', 19:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:53 INFO - 'PWD': '/builds/slave/test', 19:00:53 INFO - 'SHELL': '/bin/bash', 19:00:53 INFO - 'SHLVL': '1', 19:00:53 INFO - 'TERM': 'linux', 19:00:53 INFO - 'TMOUT': '86400', 19:00:53 INFO - 'USER': 'cltbld', 19:00:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626', 19:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:53 INFO - '_': '/tools/buildbot/bin/python'} 19:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:53 INFO - Downloading/unpacking psutil>=0.7.1 19:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:00:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:55 INFO - Installing collected packages: psutil 19:00:55 INFO - Running setup.py install for psutil 19:00:55 INFO - building 'psutil._psutil_linux' extension 19:00:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:00:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:00:56 INFO - building 'psutil._psutil_posix' extension 19:00:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:00:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:00:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:56 INFO - Successfully installed psutil 19:00:56 INFO - Cleaning up... 19:00:56 INFO - Return code: 0 19:00:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:56 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 0x7fb0ea181f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f160>, '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 0xe60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe604f0>, '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': '32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 19:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:00:56 INFO - Using env: {'DISPLAY': ':0', 19:00:56 INFO - 'HOME': '/home/cltbld', 19:00:56 INFO - 'LANG': 'en_US.UTF-8', 19:00:56 INFO - 'LANGUAGE': 'en_US:en', 19:00:56 INFO - 'LOGNAME': 'cltbld', 19:00:56 INFO - 'MAIL': '/var/mail/cltbld', 19:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:56 INFO - 'MOZ_NO_REMOTE': '1', 19:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:56 INFO - 'NO_EM_RESTART': '1', 19:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:56 INFO - 'PWD': '/builds/slave/test', 19:00:56 INFO - 'SHELL': '/bin/bash', 19:00:56 INFO - 'SHLVL': '1', 19:00:56 INFO - 'TERM': 'linux', 19:00:56 INFO - 'TMOUT': '86400', 19:00:56 INFO - 'USER': 'cltbld', 19:00:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626', 19:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:56 INFO - '_': '/tools/buildbot/bin/python'} 19:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:00:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:00:58 INFO - Installing collected packages: mozsystemmonitor 19:00:58 INFO - Running setup.py install for mozsystemmonitor 19:00:58 INFO - Successfully installed mozsystemmonitor 19:00:58 INFO - Cleaning up... 19:00:58 INFO - Return code: 0 19:00:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:58 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 0x7fb0ea181f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f160>, '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 0xe60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe604f0>, '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': '32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:00:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:00:58 INFO - Using env: {'DISPLAY': ':0', 19:00:58 INFO - 'HOME': '/home/cltbld', 19:00:58 INFO - 'LANG': 'en_US.UTF-8', 19:00:58 INFO - 'LANGUAGE': 'en_US:en', 19:00:58 INFO - 'LOGNAME': 'cltbld', 19:00:58 INFO - 'MAIL': '/var/mail/cltbld', 19:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:58 INFO - 'MOZ_NO_REMOTE': '1', 19:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:58 INFO - 'NO_EM_RESTART': '1', 19:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:58 INFO - 'PWD': '/builds/slave/test', 19:00:58 INFO - 'SHELL': '/bin/bash', 19:00:58 INFO - 'SHLVL': '1', 19:00:58 INFO - 'TERM': 'linux', 19:00:58 INFO - 'TMOUT': '86400', 19:00:58 INFO - 'USER': 'cltbld', 19:00:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626', 19:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:58 INFO - '_': '/tools/buildbot/bin/python'} 19:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:58 INFO - Downloading/unpacking blobuploader==1.2.4 19:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:00 INFO - Downloading blobuploader-1.2.4.tar.gz 19:01:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:01:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:01: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 19:01: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 19:01: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 19:01: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 19:01: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 19:01: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 19:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:01:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:01 INFO - Downloading docopt-0.6.1.tar.gz 19:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:01:01 INFO - Installing collected packages: blobuploader, requests, docopt 19:01:01 INFO - Running setup.py install for blobuploader 19:01:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:01:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:01:01 INFO - Running setup.py install for requests 19:01:01 INFO - Running setup.py install for docopt 19:01:02 INFO - Successfully installed blobuploader requests docopt 19:01:02 INFO - Cleaning up... 19:01:02 INFO - Return code: 0 19:01:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:02 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 0x7fb0ea181f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f160>, '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 0xe60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe604f0>, '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': '32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:01:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:01:02 INFO - Using env: {'DISPLAY': ':0', 19:01:02 INFO - 'HOME': '/home/cltbld', 19:01:02 INFO - 'LANG': 'en_US.UTF-8', 19:01:02 INFO - 'LANGUAGE': 'en_US:en', 19:01:02 INFO - 'LOGNAME': 'cltbld', 19:01:02 INFO - 'MAIL': '/var/mail/cltbld', 19:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:02 INFO - 'MOZ_NO_REMOTE': '1', 19:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:02 INFO - 'NO_EM_RESTART': '1', 19:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:02 INFO - 'PWD': '/builds/slave/test', 19:01:02 INFO - 'SHELL': '/bin/bash', 19:01:02 INFO - 'SHLVL': '1', 19:01:02 INFO - 'TERM': 'linux', 19:01:02 INFO - 'TMOUT': '86400', 19:01:02 INFO - 'USER': 'cltbld', 19:01:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626', 19:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:02 INFO - '_': '/tools/buildbot/bin/python'} 19:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:01:02 INFO - Running setup.py (path:/tmp/pip-HxKEGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:01:02 INFO - Running setup.py (path:/tmp/pip-hYA7Tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:01:02 INFO - Running setup.py (path:/tmp/pip-cOeKss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:01:02 INFO - Running setup.py (path:/tmp/pip-fAyNFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:01:02 INFO - Running setup.py (path:/tmp/pip-XrmkFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:01:02 INFO - Running setup.py (path:/tmp/pip-33Glyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:01:02 INFO - Running setup.py (path:/tmp/pip-inoB0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:01:02 INFO - Running setup.py (path:/tmp/pip-rEXINm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:01:02 INFO - Running setup.py (path:/tmp/pip-hSqmPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:01:02 INFO - Running setup.py (path:/tmp/pip-haISXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:01:03 INFO - Running setup.py (path:/tmp/pip-H_NbSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:01:03 INFO - Running setup.py (path:/tmp/pip-Se5FGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:01:03 INFO - Running setup.py (path:/tmp/pip-_T3x78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:01:03 INFO - Running setup.py (path:/tmp/pip-C7Bcak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:01:03 INFO - Running setup.py (path:/tmp/pip-vBWNqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:01:03 INFO - Running setup.py (path:/tmp/pip-reCW2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:01:03 INFO - Running setup.py (path:/tmp/pip-n2FOCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:01:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:01:03 INFO - Running setup.py install for manifestparser 19:01:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:01:03 INFO - Running setup.py install for mozcrash 19:01:03 INFO - Running setup.py install for mozdebug 19:01:03 INFO - Running setup.py install for mozdevice 19:01:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:01:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:01:03 INFO - Running setup.py install for mozfile 19:01:04 INFO - Running setup.py install for mozhttpd 19:01:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:01:04 INFO - Running setup.py install for mozinfo 19:01:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:01:04 INFO - Running setup.py install for mozInstall 19:01:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:01:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:01:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:01:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:01:04 INFO - Running setup.py install for mozleak 19:01:04 INFO - Running setup.py install for mozlog 19:01:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:01:04 INFO - Running setup.py install for moznetwork 19:01:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:01:04 INFO - Running setup.py install for mozprocess 19:01:04 INFO - Running setup.py install for mozprofile 19:01:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:01:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:01:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:01:04 INFO - Running setup.py install for mozrunner 19:01:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:01:04 INFO - Running setup.py install for mozscreenshot 19:01:05 INFO - Running setup.py install for moztest 19:01:05 INFO - Running setup.py install for mozversion 19:01:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:01:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:01:05 INFO - Cleaning up... 19:01:05 INFO - Return code: 0 19:01:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:01: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')]} 19:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01: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')]} 19:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:05 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 0x7fb0ea181f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f160>, '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 0xe60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe604f0>, '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': '32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:01:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:01:05 INFO - Using env: {'DISPLAY': ':0', 19:01:05 INFO - 'HOME': '/home/cltbld', 19:01:05 INFO - 'LANG': 'en_US.UTF-8', 19:01:05 INFO - 'LANGUAGE': 'en_US:en', 19:01:05 INFO - 'LOGNAME': 'cltbld', 19:01:05 INFO - 'MAIL': '/var/mail/cltbld', 19:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:05 INFO - 'MOZ_NO_REMOTE': '1', 19:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:05 INFO - 'NO_EM_RESTART': '1', 19:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:05 INFO - 'PWD': '/builds/slave/test', 19:01:05 INFO - 'SHELL': '/bin/bash', 19:01:05 INFO - 'SHLVL': '1', 19:01:05 INFO - 'TERM': 'linux', 19:01:05 INFO - 'TMOUT': '86400', 19:01:05 INFO - 'USER': 'cltbld', 19:01:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626', 19:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:05 INFO - '_': '/tools/buildbot/bin/python'} 19:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:01:05 INFO - Running setup.py (path:/tmp/pip-gIIOPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:01:05 INFO - Running setup.py (path:/tmp/pip-BNaAO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:01:05 INFO - Running setup.py (path:/tmp/pip-dcNyHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:01:05 INFO - Running setup.py (path:/tmp/pip-vTyF47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:01:05 INFO - Running setup.py (path:/tmp/pip-aKWuuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:01:05 INFO - Running setup.py (path:/tmp/pip-WHkzhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:01:05 INFO - Running setup.py (path:/tmp/pip-O2nXC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:01:06 INFO - Running setup.py (path:/tmp/pip-SF1A_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:01:06 INFO - Running setup.py (path:/tmp/pip-1_wb0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:01:06 INFO - Running setup.py (path:/tmp/pip-cYYRF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:01:06 INFO - Running setup.py (path:/tmp/pip-cd1QsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:01:06 INFO - Running setup.py (path:/tmp/pip-Z1vkIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:01:06 INFO - Running setup.py (path:/tmp/pip-KobGJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:01:06 INFO - Running setup.py (path:/tmp/pip-9bChNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:01:06 INFO - Running setup.py (path:/tmp/pip-8z2DGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:01:06 INFO - Running setup.py (path:/tmp/pip-UKy7AW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:01:06 INFO - Running setup.py (path:/tmp/pip-kf7OQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:01:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:08 INFO - Downloading blessings-1.6.tar.gz 19:01:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:01:08 INFO - Installing collected packages: blessings 19:01:08 INFO - Running setup.py install for blessings 19:01:08 INFO - Successfully installed blessings 19:01:08 INFO - Cleaning up... 19:01:08 INFO - Return code: 0 19:01:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:01:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:01:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:01:09 INFO - Reading from file tmpfile_stdout 19:01:09 INFO - Current package versions: 19:01:09 INFO - argparse == 1.2.1 19:01:09 INFO - blessings == 1.6 19:01:09 INFO - blobuploader == 1.2.4 19:01:09 INFO - docopt == 0.6.1 19:01:09 INFO - manifestparser == 1.1 19:01:09 INFO - mozInstall == 1.12 19:01:09 INFO - mozcrash == 0.17 19:01:09 INFO - mozdebug == 0.1 19:01:09 INFO - mozdevice == 0.48 19:01:09 INFO - mozfile == 1.2 19:01:09 INFO - mozhttpd == 0.7 19:01:09 INFO - mozinfo == 0.9 19:01:09 INFO - mozleak == 0.1 19:01:09 INFO - mozlog == 3.1 19:01:09 INFO - moznetwork == 0.27 19:01:09 INFO - mozprocess == 0.22 19:01:09 INFO - mozprofile == 0.28 19:01:09 INFO - mozrunner == 6.11 19:01:09 INFO - mozscreenshot == 0.1 19:01:09 INFO - mozsystemmonitor == 0.0 19:01:09 INFO - moztest == 0.7 19:01:09 INFO - mozversion == 1.4 19:01:09 INFO - psutil == 3.1.1 19:01:09 INFO - requests == 1.2.3 19:01:09 INFO - wsgiref == 0.1.2 19:01:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:09 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 0x7fb0ea181f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f160>, '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 0xe60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe604f0>, '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': '32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:01:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:01:09 INFO - Using env: {'DISPLAY': ':0', 19:01:09 INFO - 'HOME': '/home/cltbld', 19:01:09 INFO - 'LANG': 'en_US.UTF-8', 19:01:09 INFO - 'LANGUAGE': 'en_US:en', 19:01:09 INFO - 'LOGNAME': 'cltbld', 19:01:09 INFO - 'MAIL': '/var/mail/cltbld', 19:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:09 INFO - 'MOZ_NO_REMOTE': '1', 19:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:09 INFO - 'NO_EM_RESTART': '1', 19:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:09 INFO - 'PWD': '/builds/slave/test', 19:01:09 INFO - 'SHELL': '/bin/bash', 19:01:09 INFO - 'SHLVL': '1', 19:01:09 INFO - 'TERM': 'linux', 19:01:09 INFO - 'TMOUT': '86400', 19:01:09 INFO - 'USER': 'cltbld', 19:01:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626', 19:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:09 INFO - '_': '/tools/buildbot/bin/python'} 19:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:01:09 INFO - Cleaning up... 19:01:09 INFO - Return code: 0 19:01:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0ea181f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f160>, '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 0xe60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe604f0>, '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': '32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:01:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:01:09 INFO - Using env: {'DISPLAY': ':0', 19:01:09 INFO - 'HOME': '/home/cltbld', 19:01:09 INFO - 'LANG': 'en_US.UTF-8', 19:01:09 INFO - 'LANGUAGE': 'en_US:en', 19:01:09 INFO - 'LOGNAME': 'cltbld', 19:01:09 INFO - 'MAIL': '/var/mail/cltbld', 19:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:09 INFO - 'MOZ_NO_REMOTE': '1', 19:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:09 INFO - 'NO_EM_RESTART': '1', 19:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:09 INFO - 'PWD': '/builds/slave/test', 19:01:09 INFO - 'SHELL': '/bin/bash', 19:01:09 INFO - 'SHLVL': '1', 19:01:09 INFO - 'TERM': 'linux', 19:01:09 INFO - 'TMOUT': '86400', 19:01:09 INFO - 'USER': 'cltbld', 19:01:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626', 19:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:09 INFO - '_': '/tools/buildbot/bin/python'} 19:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:09 INFO - Downloading/unpacking jsonschema 19:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:01:11 INFO - Downloading/unpacking functools32 (from jsonschema) 19:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:11 INFO - Downloading functools32-3.2.3-2.tar.gz 19:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:01:11 INFO - warning: no files found matching '*.txt' 19:01:11 INFO - no previously-included directories found matching 'build' 19:01:11 INFO - no previously-included directories found matching 'dist' 19:01:11 INFO - no previously-included directories found matching '.git*' 19:01:11 INFO - Installing collected packages: jsonschema, functools32 19:01:11 INFO - Running setup.py install for functools32 19:01:11 INFO - warning: no files found matching '*.txt' 19:01:11 INFO - no previously-included directories found matching 'build' 19:01:11 INFO - no previously-included directories found matching 'dist' 19:01:11 INFO - no previously-included directories found matching '.git*' 19:01:11 INFO - Successfully installed jsonschema functools32 19:01:11 INFO - Cleaning up... 19:01:11 INFO - Return code: 0 19:01:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:01:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:01:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:01:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:01:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0ea181f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd0410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5f160>, '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 0xe60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe604f0>, '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': '32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:01:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:01:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:01:11 INFO - Using env: {'DISPLAY': ':0', 19:01:11 INFO - 'HOME': '/home/cltbld', 19:01:11 INFO - 'LANG': 'en_US.UTF-8', 19:01:11 INFO - 'LANGUAGE': 'en_US:en', 19:01:11 INFO - 'LOGNAME': 'cltbld', 19:01:11 INFO - 'MAIL': '/var/mail/cltbld', 19:01:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:11 INFO - 'MOZ_NO_REMOTE': '1', 19:01:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:11 INFO - 'NO_EM_RESTART': '1', 19:01:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:11 INFO - 'PWD': '/builds/slave/test', 19:01:11 INFO - 'SHELL': '/bin/bash', 19:01:11 INFO - 'SHLVL': '1', 19:01:11 INFO - 'TERM': 'linux', 19:01:11 INFO - 'TMOUT': '86400', 19:01:11 INFO - 'USER': 'cltbld', 19:01:11 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626', 19:01:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:11 INFO - '_': '/tools/buildbot/bin/python'} 19:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:01:12 INFO - Downloading/unpacking flake8 19:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:01:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:01: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 19:01: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 19:01: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 19:01: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 19:01: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 19:01: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 19:01:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:01:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:01:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:01:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:01:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:01:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:01:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:01:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:01:14 INFO - no previously-included directories found matching 'docs/_build' 19:01:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:01:14 INFO - Running setup.py install for pep8 19:01:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:01:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:01:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:01:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:01:14 INFO - no previously-included directories found matching 'docs/_build' 19:01:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:01:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:01:14 INFO - Cleaning up... 19:01:14 INFO - Return code: 0 19:01:14 INFO - Running post-action listener: _resource_record_post_action 19:01:14 INFO - Running post-action listener: _start_resource_monitoring 19:01:14 INFO - Starting resource monitoring. 19:01:14 INFO - ##### 19:01:14 INFO - ##### Running install step. 19:01:14 INFO - ##### 19:01:14 INFO - Running pre-action listener: _resource_record_pre_action 19:01:14 INFO - Running main action method: install 19:01:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:01:15 INFO - Reading from file tmpfile_stdout 19:01:15 INFO - Detecting whether we're running mozinstall >=1.0... 19:01:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:01:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:01:15 INFO - Reading from file tmpfile_stdout 19:01:15 INFO - Output received: 19:01:15 INFO - Usage: mozinstall [options] installer 19:01:15 INFO - Options: 19:01:15 INFO - -h, --help show this help message and exit 19:01:15 INFO - -d DEST, --destination=DEST 19:01:15 INFO - Directory to install application into. [default: 19:01:15 INFO - "/builds/slave/test"] 19:01:15 INFO - --app=APP Application being installed. [default: firefox] 19:01:15 INFO - mkdir: /builds/slave/test/build/application 19:01:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:01:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:01:27 INFO - Reading from file tmpfile_stdout 19:01:27 INFO - Output received: 19:01:27 INFO - /builds/slave/test/build/application/firefox/firefox 19:01:27 INFO - Running post-action listener: _resource_record_post_action 19:01:27 INFO - ##### 19:01:27 INFO - ##### Running run-tests step. 19:01:27 INFO - ##### 19:01:27 INFO - Running pre-action listener: _resource_record_pre_action 19:01:27 INFO - Running main action method: run_tests 19:01:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:01:27 INFO - Python 2.7.3 19:01:27 INFO - Return code: 0 19:01:27 INFO - grabbing minidump binary from tooltool 19:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:01:27 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 0xe5f160>, '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 0xe60060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe604f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:01:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:01:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:01:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:01:27 INFO - Return code: 0 19:01:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:01:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:01:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:01:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:01:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:01:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:01:28 INFO - Return code: 0 19:01:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:01:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:01:28 INFO - Using env: {'DISPLAY': ':0', 19:01:28 INFO - 'HOME': '/home/cltbld', 19:01:28 INFO - 'LANG': 'en_US.UTF-8', 19:01:28 INFO - 'LANGUAGE': 'en_US:en', 19:01:28 INFO - 'LOGNAME': 'cltbld', 19:01:28 INFO - 'MAIL': '/var/mail/cltbld', 19:01:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:01:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:01:28 INFO - 'MOZ_NO_REMOTE': '1', 19:01:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:01:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:01:28 INFO - 'NO_EM_RESTART': '1', 19:01:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:01:28 INFO - 'PWD': '/builds/slave/test', 19:01:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:01:28 INFO - 'SHELL': '/bin/bash', 19:01:28 INFO - 'SHLVL': '1', 19:01:28 INFO - 'TERM': 'linux', 19:01:28 INFO - 'TMOUT': '86400', 19:01:28 INFO - 'USER': 'cltbld', 19:01:28 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626', 19:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:01:28 INFO - '_': '/tools/buildbot/bin/python'} 19:01:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:01:29 INFO - mozversion application_buildid: 20160428162445 19:01:29 INFO - mozversion application_changeset: 11eb6b661fe4b6d889af99aeec890a9f1706944a 19:01:29 INFO - mozversion application_display_name: Firefox 19:01:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:01:29 INFO - mozversion application_name: Firefox 19:01:29 INFO - mozversion application_remotingname: firefox 19:01:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:01:29 INFO - mozversion application_vendor: Mozilla 19:01:29 INFO - mozversion application_version: 47.0 19:01:29 INFO - mozversion platform_buildid: 20160428162445 19:01:29 INFO - mozversion platform_changeset: 11eb6b661fe4b6d889af99aeec890a9f1706944a 19:01:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:01:29 INFO - mozversion platform_version: 47.0 19:01:29 INFO - using testdate: 1461895289 19:01:29 INFO - actual date: 1461895289 19:01:29 INFO - starting webserver on 'localhost:47200' 19:01:29 INFO - SUITE-START | Running 2 tests 19:01:29 INFO - TEST-START | dromaeo_css 19:01:29 INFO - operating with platform_type : linux_ 19:01:29 INFO - Initialising browser for dromaeo_css test... 19:01:29 INFO - TEST-INFO | started process 16195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAVnIp5/profile http://localhost:47200/getInfo.html) 19:01:32 INFO - PROCESS | 16195 | 19:01:32 INFO - PROCESS | 16195 | (process:16272): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:01:33 INFO - PROCESS | 16195 | __metrics Screen width/height:1600/1200 19:01:33 INFO - PROCESS | 16195 | colorDepth:24 19:01:33 INFO - PROCESS | 16195 | Browser inner width/height: 1024/697 19:01:33 INFO - PROCESS | 16195 | __metrics 19:01:34 ERROR - PROCESS | 16195 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 19:01:35 INFO - TEST-INFO | 16195: exit 0 19:01:35 INFO - Browser initialized. 19:01:35 INFO - Running cycle 1/1 for dromaeo_css test... 19:01:35 INFO - TEST-INFO | started process 16323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAVnIp5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:01:36 INFO - PROCESS | 16323 | 19:01:36 INFO - PROCESS | 16323 | (process:16390): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:01:46 INFO - PROCESS | 16323 | RSS: Main: 150089728 19:01:46 INFO - PROCESS | 16323 | 19:02:36 INFO - PROCESS | 16323 | 1461895356515 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:04:44 INFO - PROCESS | 16323 | Cycle 1(1): loaded http://localhost:47200/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47200/tests/dromaeo/cssquery-ext.html) 19:04:45 INFO - PROCESS | 16323 | RSS: Main: 153837568 19:04:45 INFO - PROCESS | 16323 | 19:07:47 INFO - PROCESS | 16323 | Cycle 1(1): loaded http://localhost:47200/tests/dromaeo/cssquery-ext.html (next: http://localhost:47200/tests/dromaeo/cssquery-jquery.html) 19:07:47 INFO - PROCESS | 16323 | RSS: Main: 152309760 19:07:47 INFO - PROCESS | 16323 | 19:10:49 INFO - PROCESS | 16323 | Cycle 1(1): loaded http://localhost:47200/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47200/tests/dromaeo/cssquery-mootools.html) 19:10:50 INFO - PROCESS | 16323 | RSS: Main: 151519232 19:10:50 INFO - PROCESS | 16323 | 19:13:51 INFO - PROCESS | 16323 | Cycle 1(1): loaded http://localhost:47200/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47200/tests/dromaeo/cssquery-prototype.html) 19:13:52 INFO - PROCESS | 16323 | RSS: Main: 152248320 19:13:52 INFO - PROCESS | 16323 | 19:16:54 INFO - PROCESS | 16323 | Cycle 1(1): loaded http://localhost:47200/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47200/tests/dromaeo/cssquery-yui.html) 19:16:55 INFO - PROCESS | 16323 | RSS: Main: 151142400 19:16:55 INFO - PROCESS | 16323 | 19:19:57 INFO - PROCESS | 16323 | Cycle 1(1): loaded http://localhost:47200/tests/dromaeo/cssquery-yui.html (next: http://localhost:47200/tests/dromaeo/cssquery-dojo.html) 19:19:57 INFO - PROCESS | 16323 | RSS: Main: 155463680 19:19:57 INFO - PROCESS | 16323 | 19:19:57 INFO - PROCESS | 16323 | __start_tp_report 19:19:57 INFO - PROCESS | 16323 | _x_x_mozilla_page_load 19:19:57 INFO - PROCESS | 16323 | _x_x_mozilla_page_load_details 19:19:57 INFO - PROCESS | 16323 | |i|pagename|runs| 19:19:57 INFO - PROCESS | 16323 | |0;dojo.html;3315.071779901627;3364.764466487347;3377.4258376076064;3403.353362861056;3407.8807241746545;5376.489233522819;5387.838364849056;5388.515033646971;5393.541548968337;5395.271638328829;5404.216388623648;5420.349558053029;5434.483724046209;5441.918371224435;5448.073827449333;4923.606111511089;4937.136001199794;4990.725510096943;5027.321311622939;5053.77258023388;4868.756562171895;4955.430125535556;4977.7262250576205;5022.547970682638;5034.320366750497;4992.07646585381;5024.924626130611;5088.440271570124;5131.743412829363;5144.845654630367;5053.317802096707;5067.986402719434;5071.112555302826;5076.0863044652315;5086.77109530072;4864.756762161913;4881;4972.602191824645;5014.122528557525;5042.294078828967;5282.867928301785;5319.388270348882;5328.44051374604;5334.733263336818;5372.623916325859;5821.767129314865;5833.79581714638;5869.295684517842;5875.823725288248;5882.264716910387;5939.287285525721;5976.103584462322;5977.402259774031;6047.7580896764075;6060.2424696912885;5501.779928802843;5518.19986102013;5519;5526.557875370001;5560.777568897199;5928.436798504135;6054.757809687563;6072.271327440735;6080.635161890213;6080.726367313481;5856.00447923854;5869.882602347929;5886.352501224862;5912.3496415394275;5927.407259274038;5982.49148822355;5998.040313549811;6001.5798894077;6003.0695242237525;6014.609050411709;5700.030994730906;5885.264341957255;5926.733297001645;5940.376260492672;5941.673207973603;5846.853828654318;5882;5889.146073819272;5900.0264956281735;5912.320083190402;4466.4640243171025;4476;4491.910161796745;4494.3707880896045;4511.616512596401;3996.440498330236;4001.559828418872;4029.49631296088;4040.595940405936;4071.75569465833;5460.208269800856;5585.69278689676;5590.776368945278;5614.185943038318;5640.351359593699;6059.091136329585;6061.302950160788;6064.4541991221;6066.545009124334;6085.5435842312;5514.61397702157;5664.51851592611;5684.857878553069;5704.087346024616;5757.424257574209;5127.794888204505;5144.279800827887;5164.431912489623;5170;5172.250023746536;6135.693215339215;6149;6156.938430615726;6168.814935551941;6169.907451388232;5952.136940143655;6022.126791615104;6047.183630210041;6050.667213303311;6058.212432383762;6028.758849645965;6116.35778243278;6117.051856962178;6123.540734445023;6124.755009799558;5738.770449181986;5824.5631577631;5857.150713146655;5871.853203669943;5880.94119058804;6059.606125601822;6111.738457788292;6115.027386288435;6116.616043419844;6126.264848218064;5906.7341969612335;5952.642841429528;5954.345022047484;5956.731947062306;5963.552733545088;5742.942570574408;5791.652500849962;5827.446392592697;5918.348981611933;5946.672932988554;5786.42135786418;5800.506956908541;5803.158542011469;5809.912851307318;5813.76744930198;5836.708164591839;5913.852153696192;5923.7926672566255;5940.46535811779;5942.257217847769;5594.86012849682;5746.16680581305;5799.130130480462;5818.185454036354;5847.298324201123 19:19:57 INFO - PROCESS | 16323 | |1;ext.html;537.0667890750516;575.9251297331348;595.1340799137256;603.4508597176568;610.2311088029082;41564.16871662569;42452.78773606128;42459.36310955334;42516;42569;41367.79316103423;41902;42081.15837683244;42141.36787948183;42194.36708449368;9014.36899417041;9056.094390560957;9193.632254709804;9194.35639505235;9200;8967.506787126706;9104.408213466137;9106.13491718289;9120.224780893632;9123.543822808866;9126.680566180185;9132.452052876815;9139.543022848864;9170.128837760436;9219.953900230523;9086.182243598076;9175.724728258163;9176.72469825903;9207.585658645343;9227.169554740105;8929.508877011762;9054.868141482315;9061.048589898031;9082.046385129532;9090.63637454501;39954.60045399538;40303.19393612141;40324.19351612981;43008.35487467691;43143.56856431427;3459.636738142484;3568.1793187566745;3610.9638903611153;3668.743187976816;3692.723045771551;32416;32831;33108.503372449435;33506;33631.49552756711;4079.2755477450432;4094.9181016379507;4158.334666453383;4162.6253637172495;4182.769947652878;296688;300101;301035;301080;301420;66681;67110.66444667843;67199.32800671931;67435;67442.32557674458;68498.65750671315;72180;73040.63479682567;73196.63401682957;73200.63399682968;18523.536911577317;18652.720209196872;18748.343807966656;18782.248710051717;18914.621707566046;14390.856091439162;14393.064450810663;14400.495982640557;14402.711945761026;14416.279186040865;21922.780772192393;22390.440238994157;22509.4372640682;22520.986555604708;22555.210567630053;8172.6730930762105;8326;8404.243618074403;8451.83096338082;8469.05211801289;1000.9749756256006;1014.9441780702132;1039.7140786283833;1117.1621284036971;1162.575659884153;28815.135545933656;29147.562786558217;29227;29530.55704164439;30002.84998574993;1105.5688281570033;1113.1651261553834;1200.4897918384652;1213.3387303919385;1239.5165885304739;14604.634884127769;14654.487092951695;14846.480373186887;14925.776113358308;15113.773293400607;398741;488334;505242;507920;515587;56549.43450565442;57225.85548289094;57282.713586431804;57290.42709572851;57317;1491.8806495480335;1499.293774736589;1499.8275198352112;1510.8111486064022;1526.8167819861465;28647.856760716062;29300.56049159307;30094.84952575223;30983.225419364695;30998.845005774827;49200.50799491959;49356;49738;50071.74964125156;50083;308951;310631;311963;312535;314248;33740.83129584337;34113.31773364569;34202.48696269608;34282.48576271408;34308.48537271993;43664.781676091414;43804.78097609492;44160;44396.33405498985;44438.333424998;38236.617633823305;38310.6168938307;38408.61591384162;38481.23037539177;38868.41697374598;37430;37497.2500549982;37816.81091594524;38137.42793858039;38861;37119.62880371162;37643.435348470346;38012.61987380202;38209.4268585977;38451.42322865103;33008;33186.83406582951;33281.83359083189;33485.33029339448;33581.496277555365;25482;26203.344916377242;26232.73767262303;26353.102720881863;26483.60274595844 19:19:57 INFO - PROCESS | 16323 | |2;jquery.html;357.6066327040256;368.11101190624635;369.4845690262084;371.0501117140123;375.84214629855455;17775;18148.727769083456;18930.432087037378;19078.618427631474;19114.13986370615;17583.29666813326;17932.55168620785;18120.822146560466;18239;18243.54391140219;5608.130739735348;5887;5910.231669882909;5912.822615321547;5941.643501389909;5362.865928351784;5608.355039170507;5616.410276920926;5634.859128521779;5764.193012978187;5534.142207957773;5577.358603760558;5590.217369568264;5612.607117501777;6022.8795424091495;5932.762689492415;5935.050391937312;5946.732397042144;5979.641221526701;5986.072158815369;5263.815766448156;5517.337919449652;5719.857003574903;5731.656100633933;5734.111212761987;14187.858121418756;14367.497137600134;14378.928105359511;14390.352434140488;21965.34103976883;2166.9783302166934;2257.2776711452343;2267.7958983691547;2316.1893337331967;2843.7156284371604;9897.15874150698;10108.848367274497;10395.064444200058;11884.762304753944;13673.658158546017;1947.2405761752927;1966.6460037193299;2007.7389939307943;2018.5256464730776;2024.483756642047;63183;66279;67125.32874671288;67970.3202967969;68220;9757.219422446187;9912.959139290415;10274.280800344053;10559.313644613076;10674.78650426987;13557.525486607921;13565.525206617722;13589.320533973261;13607.523736669169;13671;7838.960805195938;7859.17478664732;7917.920820791834;7957.482763620346;7994.840103197904;7756.108047574488;7861.960690196627;7879.975603171551;7889.487183333065;7905.28852403275;4176.436181115571;4216.810243539048;4271.988248284952;4447.399601053881;4668.8599342019115;1861.0694652673662;1862.394721715448;1889.8677092603662;1906.1803424527309;1915.52111972007;886.1935638568872;968.1286841842398;969.7333233360741;1012.1649639047668;1021.8824835144054;17039.712626260185;17585.912070439565;17712.46862594124;17813.554661133316;18223.544411389823;971.5433746139303;978.5009645080918;978.7308490165261;978.7944531648291;993.9403635781877;6540.836479087966;6582.308857569887;6828.760993365208;6848.417884479775;10149.492525373702;261426;268199;347326;350038;461832;81741;82595.5870220645;85153;86297.5685121583;86333;487.30072346182635;503.34816412745585;504.4350327633001;506.4884466688671;508.336620709977;10697;11028.613998510014;11071.50178241965;11251.099912006855;11301.943490282496;36583.45124823183;36927.261454771295;37309.6269037317;37411;38386.232275354894;54016;54054.729726351114;54064.18903716526;54145.45854541562;54366.72816635892;8542.82914341722;8663.350248731496;8663.783405414915;8847.115288471101;8929;12454.564090256797;12918;13304;13318;13439;10984.725381865517;11091.833622495507;11179.496922638338;11303.604373846876;11497.712557186138;10333.431661258703;11325.433728313716;11475.655730328104;11593.884061159617;11695.239809412362;11328.490217940047;11517.82723259135;11550.48022838991;11626.88373116258;11811.940940295588;8719.869201961848;8752.21230089295;8755.168259015383;8756.956215218883;8930.062343454103;8668.30653547702;11405.600803971822;11643.941780291045;11645.359505227294;11888.702782430508 19:19:57 INFO - PROCESS | 16323 | |3;mootools.html;1590.5228431470557;1599.768033635123;1823.9270429182834;1874.8125187481262;1977.7330060441845;7455.254474552542;7927.445078844483;8107.63515641796;8379.790505237364;8391.328693704505;8231.09457959624;8343.582820858948;8393.412461127724;8402.033766116898;8446.15538446155;2389.7251816041116;2402.60357041088;2403.807695384365;2410.7950824179966;2414.9034038638433;2355.1639168095335;2355.3640517060385;2416.915407960722;2420.5279970405777;2425.1754403502805;2387.069043073203;2394.461246219604;2410.554047501218;2418.2503423938633;2418.443757935676;2284.7029886114865;2291.232437133546;2307.8615283082986;2312.4912519245822;2330.4523436992295;2337.2053501809464;2348.0607756897207;2369.5260947810507;2371.087131454385;2382.9880850595637;8332.62503187352;8336.166383361677;8369.748907532783;8393.916060839436;8414.284785793154;5062.82280120194;5157.58739300855;5162.2772811806;5164.561012313958;5171.456997015334;3138.937221255585;3143.0413723814227;3183.984080079608;3225.4194245035883;3267.3628642414737;1082.269468109031;2006.0972562346856;2064.7935206479233;2070.223666125203;2075.7509098908076;11305.095592352674;11319.943400282946;11342.886571134348;11423.600173993871;11463.713407164803;4186.246475634415;4313.202057619351;4362.934555981663;4371.431713877176;4381.737095774264;9035.909640903637;9045.77385565366;9119.954400227956;9137.223336016514;9182.081791820765;5036.6726162799305;5049.394072711299;5058.3929928408825;5069.391672999263;5078.7460626968505;4616.699914505546;4673.556012178838;4674.649401294849;4695.295705644113;4739.123262196505;3527.3827080260853;3566.928661426809;3577.5170352002147;3579.3557159711504;3596.496490491333;1071.1698433713934;1071.844582535528;1077.849101125843;1078.5793540519203;1092.8306112552566;1141.8344340070644;1163.2903928603546;1167.4046236419317;1420.5383250443647;1474.7345477814097;7421.183669796318;7536.6985320587655;7981.241782030698;7988.880166797503;8010.279074883289;1228.2016689152122;1231.0582404460595;1244.5333000124954;1247.6568943540417;1252.380071864433;5684.431556844283;5773.018586840247;5791.449812267828;5797.88404231913;5936.495397891227;10117.949410252902;10333.63832265882;10343.120834728981;10372.429516376671;10499.895001050045;10108.848367274497;10190.847137292947;10192.745181370525;10240.129588985019;10354.068133867988;7945.523268603903;8050.315723163597;8060.193980601893;8082.515049097073;8136.064352599408;7651.961740191486;7671.07947046358;7772.650230739518;7783.53298802051;7783.610819459118;8955.686550970684;9070.18368346852;9210.171084602418;9233.769155771159;9240.168384845396;9393.24854011691;9455.669051583161;9458.527073646152;9514.619415223591;9669.468179250209;6232.594881332699;6449.290578036506;6657.933420665731;7109.253528379446;7172.892406613801;7777.300042995931;7800.84398312042;7828.412869034959;7880.802979925547;7904.486208396436;7056.15326160864;7286.890696639449;7357.117145942521;7386.0767404074495;7456.142543607554;7047.260037695968;7224.963875180801;7261.818454538678;7309.049823523121;7354.448416368687;7256.129264488295;7301.488895777245;7320.63396830167;7326.523775954546;7333.559986400833;6681.46548276127;6692.59844409337;6725.596464212163;6761.966190169018;6766.357196066366;6665.366790154928;6833.965830170818;6837.179538455417;6839.897401538881;6842.828929276808 19:19:57 INFO - PROCESS | 16323 | |4;prototype.html;368.6387340406403;369.04601604851456;371.18895213957506;372.81731951343835;377.95653499847526;6357.396047375503;6395.58428702134;6403.583767055144;6413.583117097385;6418.6469744164115;6368.745250189999;6386.680665966706;6390.904136437957;6408.679566021704;6416.743330266795;4725.55107264811;4790.928136077944;4866.926996095061;4870.683405578644;4938.80244790208;4837.7339246341435;4858.392700912386;4863.173260545698;4871.951280487203;4885.462599114112;4797.6401769867225;4820.180569303209;4821.783019764119;4823.72171374586;4828.275758636215;4820.758962051884;4829.806807727687;4832.323474713543;4832.347633069526;4843.515648435164;4188.832446702128;4190.245755763961;4197.664186865043;4206.137741762962;4212.831486740527;6011.458968692795;6157.107219453154;6163.691815409256;6165.691715414257;6182.84542886427;5733.312002559678;5745.942540574582;5747.339056008571;5751.7699292028265;5763.1355296705415;6770.8307292317595;6819.761308354184;6833.931660683379;6834.316568343175;6852.862942741167;4710.128626204163;4719.669623126382;4722.929156062662;4728.71627702339;4733.668643194977;7111.146662400545;7197.136343638745;7204.423646108299;7205.747798827068;7220.98906153139;4635.466921304093;4696.976515117402;4704.976475117603;4794.184988551954;4880.194767863334;4758.500357462417;4758.809647614126;4766.571008609242;4773.427188737373;4782.210935195653;5566.165075238747;5571.1086226203615;5571.359293681278;5671.404502527258;5675.290588676416;6870.965645171842;6893;6898.206706228748;6904;6904.930950690529;1732.159902447312;1763.867709921761;1766.7084930986243;1767.2842498788011;1767.7878654561534;1117.2291119127776;1131.134681968295;1133.4616057372848;1154.359330571524;1171.2855158353398;6584.539082264196;6612.90080648781;6614.603123812587;6615.007748837616;6619.768308109193;7131.215566287704;7132.17979932304;7133.7146514139895;7134.714611415485;7135.857282854314;6548.934510654833;6562.934370656328;6584.7695330664155;6589.143411356493;6590.406863382319;3797.4303854421505;3839.7696138231795;3861;3875.302445559826;3886.145048089416;7361.779146625609;7419.554826710415;7423.703051877865;7430.331270185709;7431.739889103856;7299.306565876233;7326.120865496068;7344.926550734531;7360.815979600446;7385.187629360766;7369.263073692588;7370.6314684266645;7381.11426628808;7391.223921488274;7393.667284972189;6987.580745155307;7145.214026456982;7145.285471452813;7147.571145731273;7151.678174482265;7082.008518807268;7094.219635840157;7118.181409138016;7118.433944532195;7122.287771222836;7465.328120469184;7477.813054673677;7485.326320631169;7491.475596708178;7499.737509187153;4743;4756.9048619026735;4762.309465127468;4765.309030190672;4770.141374552614;6996.650167491503;7202.099737532809;7205.351518363373;7233.602151881487;7240.637968101469;6978.755743548952;7004.509684322048;7007.369336759716;7010.684519196547;7028.578285302899;6988.965055174692;7001.684924178526;7017.578945263301;7018.33325834045;7027.4729395294535;6809.625470599165;6841.247462778991;6855.314468553105;6858.862822743617;6859.5541289816;6880.518363714692;7012.894806577803;7022.683979221049;7025.718971241093;7049.189343225389;6824.5564038339335;6830.248672645906;6837.692303846438;6861.348171923659;6864.862702745817 19:19:57 INFO - PROCESS | 16323 | |5;yui.html;804.3766081287006;834.1783343406745;904.7331037343984;906.4380084347705;906.8549032154853;14372.856271437282;14567.271636418189;14569.562913112624;14584.270786460675;14631.487897923575;12336.321502317369;14011.089279196845;14122.929385353085;14132.081414708062;14154.363053662584;913.876626655403;945.3902233059672;946.432140715572;947.4504787223428;951.029949451559;937.5078084005884;946.5314669238736;947.6493697331997;951.0584521323874;952.1858810716807;993.4933184076137;994.8109859126779;998.6654470752306;1000.7698229407241;1002.9749256268615;973.737090985437;975.3465178330536;975.7560609847538;979.7697541077805;979.7991411760607;736.0210919477082;736.5028605691191;736.6905899522213;737.8598066367373;738.6048464071696;15090.849091509053;15111.244437778067;15112.848871511364;15145.167015814126;15150.469733559272;13661.590152295446;14307.64230894236;14333;14382.784258236135;14563.49027784033;11412.657620271322;11485.655430337103;11499.252548584314;11682.12384071198;11715.121365897592;3893.5133108361456;3920.313945059603;3924.823382947774;3955.3275943089743;3993.0416699992084;51654;51789.482105178846;51906.22140667893;51937;51946.99999999962;10928;11172.44137793107;11339.206255562196;11442.771144577062;11448.599299024494;19626.11682474292;20537.17851285932;20541.178352865718;20547.589048218953;20623.896880515502;8839.60221790021;8882.644694212158;8905.688300909436;8978.191962723386;9067.773305667411;4740.6681532292405;4785.449673287617;4808.855734327975;4827.106985207748;4978.551930326288;3430.073880052422;3436.553248077784;3440.208751987057;3440.8107554084263;3482.495038219444;625.3121566277059;630.5208041888199;636.4367534731796;639.2169592249458;645.909572659828;629.9244090709053;655.2824657000576;666.7166454256921;718.3227164570682;725.5030304241611;9123.726288211365;9579.233661307078;10089.596416143271;10115.291929565006;10166.390016599027;604.6734763227807;714.9821254468576;798.1858504325555;798.4211446701095;804.5494523067101;4324.978375108104;4357.952590183869;4496.775161241925;4556.384888040138;4576.954230457653;60571.39428605657;63215;64455.67772161109;64517.35482645207;66265.33734662688;54268;54451.45548544543;55242.72378638081;55331.72334138384;55486;49243.50756492461;49751.502484974684;50008.24987625189;50203.49796501988;50392.74803625958;9446.291528135554;9619.615215391306;9636.71089867305;9852.458114803754;9886.110250077527;35160.82419587886;37118.628813712596;37865.053373665876;38368.6163138365;38547.036324091;43089.13821723485;46888.53111468978;46969;51198.74400627973;51400.74299628478;12890.291033992846;13101.475940962255;13357.866421335662;13743.587692369245;13796.655083622989;13279.86720132825;13448.731025379242;13596.320183990958;13692.246926419142;13850.09974351664;13022.153560018569;13037.543685970946;13088.28014459214;13143.342832858127;13298.401571929093;12134.271943683407;12380.81428778551;12384.62846114618;12434.378281085728;12628;11803.611805604058;11804.2327248732;12271.938640306742;12302.507899683913;12698.492060317853;10030.899691002996;10227.642032528825;10270.486475676336;10438.53026613789;10577.735556611146;10193.286469947032;10349.430781307101;10636.680899573024;10669.733256668645;10908 19:19:57 INFO - PROCESS | 16323 | __end_tp_report 19:19:57 INFO - PROCESS | 16323 | __start_cc_report 19:19:57 INFO - PROCESS | 16323 | _x_x_mozilla_cycle_collect,334 19:19:57 INFO - PROCESS | 16323 | __end_cc_report 19:19:57 INFO - PROCESS | 16323 | __startTimestamp1461896397424__endTimestamp 19:19:57 INFO - PROCESS | 16323 | 19:19:57 INFO - PROCESS | 16323 | ------- Summary: start ------- 19:19:57 INFO - PROCESS | 16323 | Number of tests: 6 19:19:57 INFO - PROCESS | 16323 | 19:19:57 INFO - PROCESS | 16323 | [#0] dojo.html Cycles:165 Average:5519.26 Median:5799.13 stddev:630.91 (10.9%) stddev-sans-first:608.69 19:19:57 INFO - PROCESS | 16323 | Values: 3315.1 3364.8 3377.4 3403.4 3407.9 5376.5 5387.8 5388.5 5393.5 5395.3 5404.2 5420.3 5434.5 5441.9 5448.1 4923.6 4937.1 4990.7 5027.3 5053.8 4868.8 4955.4 4977.7 5022.5 5034.3 4992.1 5024.9 5088.4 5131.7 5144.8 5053.3 5068.0 5071.1 5076.1 5086.8 4864.8 4881.0 4972.6 5014.1 5042.3 5282.9 5319.4 5328.4 5334.7 5372.6 5821.8 5833.8 5869.3 5875.8 5882.3 5939.3 5976.1 5977.4 6047.8 6060.2 5501.8 5518.2 5519.0 5526.6 5560.8 5928.4 6054.8 6072.3 6080.6 6080.7 5856.0 5869.9 5886.4 5912.3 5927.4 5982.5 5998.0 6001.6 6003.1 6014.6 5700.0 5885.3 5926.7 5940.4 5941.7 5846.9 5882.0 5889.1 5900.0 5912.3 4466.5 4476.0 4491.9 4494.4 4511.6 3996.4 4001.6 4029.5 4040.6 4071.8 5460.2 5585.7 5590.8 5614.2 5640.4 6059.1 6061.3 6064.5 6066.5 6085.5 5514.6 5664.5 5684.9 5704.1 5757.4 5127.8 5144.3 5164.4 5170.0 5172.3 6135.7 6149.0 6156.9 6168.8 6169.9 5952.1 6022.1 6047.2 6050.7 6058.2 6028.8 6116.4 6117.1 6123.5 6124.8 5738.8 5824.6 5857.2 5871.9 5880.9 6059.6 6111.7 6115.0 6116.6 6126.3 5906.7 5952.6 5954.3 5956.7 5963.6 5742.9 5791.7 5827.4 5918.3 5946.7 5786.4 5800.5 5803.2 5809.9 5813.8 5836.7 5913.9 5923.8 5940.5 5942.3 5594.9 5746.2 5799.1 5818.2 5847.3 19:19:57 INFO - PROCESS | 16323 | 19:19:57 INFO - PROCESS | 16323 | [#1] ext.html Cycles:180 Average:54091.57 Median:38430.02 stddev:99126.18 (257.9%) stddev-sans-first:99322.70 19:19:57 INFO - PROCESS | 16323 | Values: 537.1 575.9 595.1 603.5 610.2 41564.2 42452.8 42459.4 42516.0 42569.0 41367.8 41902.0 42081.2 42141.4 42194.4 9014.4 9056.1 9193.6 9194.4 9200.0 8967.5 9104.4 9106.1 9120.2 9123.5 9126.7 9132.5 9139.5 9170.1 9220.0 9086.2 9175.7 9176.7 9207.6 9227.2 8929.5 9054.9 9061.0 9082.0 9090.6 39954.6 40303.2 40324.2 43008.4 43143.6 3459.6 3568.2 3611.0 3668.7 3692.7 32416.0 32831.0 33108.5 33506.0 33631.5 4079.3 4094.9 4158.3 4162.6 4182.8 296688.0 300101.0 301035.0 301080.0 301420.0 66681.0 67110.7 67199.3 67435.0 67442.3 68498.7 72180.0 73040.6 73196.6 73200.6 18523.5 18652.7 18748.3 18782.2 18914.6 14390.9 14393.1 14400.5 14402.7 14416.3 21922.8 22390.4 22509.4 22521.0 22555.2 8172.7 8326.0 8404.2 8451.8 8469.1 1001.0 1014.9 1039.7 1117.2 1162.6 28815.1 29147.6 29227.0 29530.6 30002.8 1105.6 1113.2 1200.5 1213.3 1239.5 14604.6 14654.5 14846.5 14925.8 15113.8 398741.0 488334.0 505242.0 507920.0 515587.0 56549.4 57225.9 57282.7 57290.4 57317.0 1491.9 1499.3 1499.8 1510.8 1526.8 28647.9 29300.6 30094.8 30983.2 30998.8 49200.5 49356.0 49738.0 50071.7 50083.0 308951.0 310631.0 311963.0 312535.0 314248.0 33740.8 34113.3 34202.5 34282.5 34308.5 43664.8 43804.8 44160.0 44396.3 44438.3 38236.6 38310.6 38408.6 38481.2 38868.4 37430.0 37497.3 37816.8 38137.4 38861.0 37119.6 37643.4 38012.6 38209.4 38451.4 33008.0 33186.8 33281.8 33485.3 33581.5 25482.0 26203.3 26232.7 26353.1 26483.6 19:19:57 INFO - PROCESS | 16323 | 19:19:57 INFO - PROCESS | 16323 | [#2] jquery.html Cycles:180 Average:23261.90 Median:18893.42 stddev:57594.29 (304.8%) stddev-sans-first:57730.18 19:19:57 INFO - PROCESS | 16323 | Values: 357.6 368.1 369.5 371.1 375.8 17775.0 18148.7 18930.4 19078.6 19114.1 17583.3 17932.6 18120.8 18239.0 18243.5 5608.1 5887.0 5910.2 5912.8 5941.6 5362.9 5608.4 5616.4 5634.9 5764.2 5534.1 5577.4 5590.2 5612.6 6022.9 5932.8 5935.1 5946.7 5979.6 5986.1 5263.8 5517.3 5719.9 5731.7 5734.1 14187.9 14367.5 14378.9 14390.4 21965.3 2167.0 2257.3 2267.8 2316.2 2843.7 9897.2 10108.8 10395.1 11884.8 13673.7 1947.2 1966.6 2007.7 2018.5 2024.5 63183.0 66279.0 67125.3 67970.3 68220.0 9757.2 9913.0 10274.3 10559.3 10674.8 13557.5 13565.5 13589.3 13607.5 13671.0 7839.0 7859.2 7917.9 7957.5 7994.8 7756.1 7862.0 7880.0 7889.5 7905.3 4176.4 4216.8 4272.0 4447.4 4668.9 1861.1 1862.4 1889.9 1906.2 1915.5 886.2 968.1 969.7 1012.2 1021.9 17039.7 17585.9 17712.5 17813.6 18223.5 971.5 978.5 978.7 978.8 993.9 6540.8 6582.3 6828.8 6848.4 10149.5 261426.0 268199.0 347326.0 350038.0 461832.0 81741.0 82595.6 85153.0 86297.6 86333.0 487.3 503.3 504.4 506.5 508.3 10697.0 11028.6 11071.5 11251.1 11301.9 36583.5 36927.3 37309.6 37411.0 38386.2 54016.0 54054.7 54064.2 54145.5 54366.7 8542.8 8663.4 8663.8 8847.1 8929.0 12454.6 12918.0 13304.0 13318.0 13439.0 10984.7 11091.8 11179.5 11303.6 11497.7 10333.4 11325.4 11475.7 11593.9 11695.2 11328.5 11517.8 11550.5 11626.9 11811.9 8719.9 8752.2 8755.2 8757.0 8930.1 8668.3 11405.6 11643.9 11645.4 11888.7 19:19:57 INFO - PROCESS | 16323 | 19:19:57 INFO - PROCESS | 16323 | [#3] mootools.html Cycles:180 Average:5800.98 Median:5118.17 stddev:2999.98 (58.6%) stddev-sans-first:2991.70 19:19:57 INFO - PROCESS | 16323 | Values: 1590.5 1599.8 1823.9 1874.8 1977.7 7455.3 7927.4 8107.6 8379.8 8391.3 8231.1 8343.6 8393.4 8402.0 8446.2 2389.7 2402.6 2403.8 2410.8 2414.9 2355.2 2355.4 2416.9 2420.5 2425.2 2387.1 2394.5 2410.6 2418.3 2418.4 2284.7 2291.2 2307.9 2312.5 2330.5 2337.2 2348.1 2369.5 2371.1 2383.0 8332.6 8336.2 8369.7 8393.9 8414.3 5062.8 5157.6 5162.3 5164.6 5171.5 3138.9 3143.0 3184.0 3225.4 3267.4 1082.3 2006.1 2064.8 2070.2 2075.8 11305.1 11319.9 11342.9 11423.6 11463.7 4186.2 4313.2 4362.9 4371.4 4381.7 9035.9 9045.8 9120.0 9137.2 9182.1 5036.7 5049.4 5058.4 5069.4 5078.7 4616.7 4673.6 4674.6 4695.3 4739.1 3527.4 3566.9 3577.5 3579.4 3596.5 1071.2 1071.8 1077.8 1078.6 1092.8 1141.8 1163.3 1167.4 1420.5 1474.7 7421.2 7536.7 7981.2 7988.9 8010.3 1228.2 1231.1 1244.5 1247.7 1252.4 5684.4 5773.0 5791.4 5797.9 5936.5 10117.9 10333.6 10343.1 10372.4 10499.9 10108.8 10190.8 10192.7 10240.1 10354.1 7945.5 8050.3 8060.2 8082.5 8136.1 7652.0 7671.1 7772.7 7783.5 7783.6 8955.7 9070.2 9210.2 9233.8 9240.2 9393.2 9455.7 9458.5 9514.6 9669.5 6232.6 6449.3 6657.9 7109.3 7172.9 7777.3 7800.8 7828.4 7880.8 7904.5 7056.2 7286.9 7357.1 7386.1 7456.1 7047.3 7225.0 7261.8 7309.0 7354.4 7256.1 7301.5 7320.6 7326.5 7333.6 6681.5 6692.6 6725.6 6762.0 6766.4 6665.4 6834.0 6837.2 6839.9 6842.8 19:19:57 INFO - PROCESS | 16323 | 19:19:57 INFO - PROCESS | 16323 | [#4] prototype.html Cycles:180 Average:5747.30 Median:6555.93 stddev:1770.15 (27.0%) stddev-sans-first:1728.46 19:19:57 INFO - PROCESS | 16323 | Values: 368.6 369.0 371.2 372.8 378.0 6357.4 6395.6 6403.6 6413.6 6418.6 6368.7 6386.7 6390.9 6408.7 6416.7 4725.6 4790.9 4866.9 4870.7 4938.8 4837.7 4858.4 4863.2 4872.0 4885.5 4797.6 4820.2 4821.8 4823.7 4828.3 4820.8 4829.8 4832.3 4832.3 4843.5 4188.8 4190.2 4197.7 4206.1 4212.8 6011.5 6157.1 6163.7 6165.7 6182.8 5733.3 5745.9 5747.3 5751.8 5763.1 6770.8 6819.8 6833.9 6834.3 6852.9 4710.1 4719.7 4722.9 4728.7 4733.7 7111.1 7197.1 7204.4 7205.7 7221.0 4635.5 4697.0 4705.0 4794.2 4880.2 4758.5 4758.8 4766.6 4773.4 4782.2 5566.2 5571.1 5571.4 5671.4 5675.3 6871.0 6893.0 6898.2 6904.0 6904.9 1732.2 1763.9 1766.7 1767.3 1767.8 1117.2 1131.1 1133.5 1154.4 1171.3 6584.5 6612.9 6614.6 6615.0 6619.8 7131.2 7132.2 7133.7 7134.7 7135.9 6548.9 6562.9 6584.8 6589.1 6590.4 3797.4 3839.8 3861.0 3875.3 3886.1 7361.8 7419.6 7423.7 7430.3 7431.7 7299.3 7326.1 7344.9 7360.8 7385.2 7369.3 7370.6 7381.1 7391.2 7393.7 6987.6 7145.2 7145.3 7147.6 7151.7 7082.0 7094.2 7118.2 7118.4 7122.3 7465.3 7477.8 7485.3 7491.5 7499.7 4743.0 4756.9 4762.3 4765.3 4770.1 6996.7 7202.1 7205.4 7233.6 7240.6 6978.8 7004.5 7007.4 7010.7 7028.6 6989.0 7001.7 7017.6 7018.3 7027.5 6809.6 6841.2 6855.3 6858.9 6859.6 6880.5 7012.9 7022.7 7025.7 7049.2 6824.6 6830.2 6837.7 6861.3 6864.9 19:19:57 INFO - PROCESS | 16323 | 19:19:57 INFO - PROCESS | 16323 | [#5] yui.html Cycles:180 Average:15134.94 Median:23707.06 stddev:17244.80 (72.7%) stddev-sans-first:17259.60 19:19:57 INFO - PROCESS | 16323 | Values: 804.4 834.2 904.7 906.4 906.9 14372.9 14567.3 14569.6 14584.3 14631.5 12336.3 14011.1 14122.9 14132.1 14154.4 913.9 945.4 946.4 947.5 951.0 937.5 946.5 947.6 951.1 952.2 993.5 994.8 998.7 1000.8 1003.0 973.7 975.3 975.8 979.8 979.8 736.0 736.5 736.7 737.9 738.6 15090.8 15111.2 15112.8 15145.2 15150.5 13661.6 14307.6 14333.0 14382.8 14563.5 11412.7 11485.7 11499.3 11682.1 11715.1 3893.5 3920.3 3924.8 3955.3 3993.0 51654.0 51789.5 51906.2 51937.0 51947.0 10928.0 11172.4 11339.2 11442.8 11448.6 19626.1 20537.2 20541.2 20547.6 20623.9 8839.6 8882.6 8905.7 8978.2 9067.8 4740.7 4785.4 4808.9 4827.1 4978.6 3430.1 3436.6 3440.2 3440.8 3482.5 625.3 630.5 636.4 639.2 645.9 629.9 655.3 666.7 718.3 725.5 9123.7 9579.2 10089.6 10115.3 10166.4 604.7 715.0 798.2 798.4 804.5 4325.0 4358.0 4496.8 4556.4 4577.0 60571.4 63215.0 64455.7 64517.4 66265.3 54268.0 54451.5 55242.7 55331.7 55486.0 49243.5 49751.5 50008.2 50203.5 50392.7 9446.3 9619.6 9636.7 9852.5 9886.1 35160.8 37118.6 37865.1 38368.6 38547.0 43089.1 46888.5 46969.0 51198.7 51400.7 12890.3 13101.5 13357.9 13743.6 13796.7 13279.9 13448.7 13596.3 13692.2 13850.1 13022.2 13037.5 13088.3 13143.3 13298.4 12134.3 12380.8 12384.6 12434.4 12628.0 11803.6 11804.2 12271.9 12302.5 12698.5 10030.9 10227.6 10270.5 10438.5 10577.7 10193.3 10349.4 10636.7 10669.7 10908.0 19:19:57 INFO - PROCESS | 16323 | -------- Summary: end -------- 19:19:57 INFO - PROCESS | 16323 | 19:19:58 INFO - TEST-INFO | 16323: exit 0 19:19:58 INFO - TEST-OK | dromaeo_css | took 1109036ms 19:19:58 INFO - TEST-START | kraken 19:19:58 INFO - operating with platform_type : linux_ 19:19:58 INFO - Initialising browser for kraken test... 19:19:58 INFO - TEST-INFO | started process 16564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfPyQUz/profile http://localhost:47200/getInfo.html) 19:20:01 INFO - PROCESS | 16564 | 19:20:01 INFO - PROCESS | 16564 | (process:16642): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:20:02 INFO - PROCESS | 16564 | __metrics Screen width/height:1600/1200 19:20:02 INFO - PROCESS | 16564 | colorDepth:24 19:20:02 INFO - PROCESS | 16564 | Browser inner width/height: 1024/697 19:20:02 INFO - PROCESS | 16564 | __metrics 19:20:03 ERROR - PROCESS | 16564 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 19:20:04 INFO - TEST-INFO | 16564: exit 0 19:20:04 INFO - Browser initialized. 19:20:04 INFO - Running cycle 1/1 for kraken test... 19:20:04 INFO - TEST-INFO | started process 16692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfPyQUz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:20:05 INFO - PROCESS | 16692 | 19:20:05 INFO - PROCESS | 16692 | (process:16759): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:20:15 INFO - PROCESS | 16692 | RSS: Main: 150327296 19:20:15 INFO - PROCESS | 16692 | 19:20:18 INFO - PROCESS | 16692 | Cycle 1(1): loaded http://localhost:47200/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47200/tests/kraken/driver.html?testName=audio-beat-detection) 19:20:18 INFO - PROCESS | 16692 | RSS: Main: 154894336 19:20:18 INFO - PROCESS | 16692 | 19:20:21 INFO - PROCESS | 16692 | Cycle 1(1): loaded http://localhost:47200/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47200/tests/kraken/driver.html?testName=audio-dft) 19:20:22 INFO - PROCESS | 16692 | RSS: Main: 154890240 19:20:22 INFO - PROCESS | 16692 | 19:20:24 INFO - PROCESS | 16692 | Cycle 1(1): loaded http://localhost:47200/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47200/tests/kraken/driver.html?testName=audio-fft) 19:20:25 INFO - PROCESS | 16692 | RSS: Main: 155295744 19:20:25 INFO - PROCESS | 16692 | 19:20:27 INFO - PROCESS | 16692 | Cycle 1(1): loaded http://localhost:47200/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47200/tests/kraken/driver.html?testName=audio-oscillator) 19:20:28 INFO - PROCESS | 16692 | RSS: Main: 155271168 19:20:28 INFO - PROCESS | 16692 | 19:20:30 INFO - PROCESS | 16692 | Cycle 1(1): loaded http://localhost:47200/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47200/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:20:31 INFO - PROCESS | 16692 | RSS: Main: 155090944 19:20:31 INFO - PROCESS | 16692 | 19:20:34 INFO - PROCESS | 16692 | Cycle 1(1): loaded http://localhost:47200/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47200/tests/kraken/driver.html?testName=imaging-darkroom) 19:20:34 INFO - PROCESS | 16692 | RSS: Main: 155197440 19:20:34 INFO - PROCESS | 16692 | 19:20:38 INFO - PROCESS | 16692 | Cycle 1(1): loaded http://localhost:47200/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47200/tests/kraken/driver.html?testName=imaging-desaturate) 19:20:38 INFO - PROCESS | 16692 | RSS: Main: 155443200 19:20:38 INFO - PROCESS | 16692 | 19:20:41 INFO - PROCESS | 16692 | Cycle 1(1): loaded http://localhost:47200/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47200/tests/kraken/driver.html?testName=json-parse-financial) 19:20:42 INFO - PROCESS | 16692 | RSS: Main: 155271168 19:20:42 INFO - PROCESS | 16692 | 19:20:43 INFO - PROCESS | 16692 | Cycle 1(1): loaded http://localhost:47200/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47200/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:20:44 INFO - PROCESS | 16692 | RSS: Main: 155226112 19:20:44 INFO - PROCESS | 16692 | 19:20:45 INFO - PROCESS | 16692 | Cycle 1(1): loaded http://localhost:47200/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47200/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:20:46 INFO - PROCESS | 16692 | RSS: Main: 155283456 19:20:46 INFO - PROCESS | 16692 | 19:20:48 INFO - PROCESS | 16692 | Cycle 1(1): loaded http://localhost:47200/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47200/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:20:49 INFO - PROCESS | 16692 | RSS: Main: 155607040 19:20:49 INFO - PROCESS | 16692 | 19:20:51 INFO - PROCESS | 16692 | Cycle 1(1): loaded http://localhost:47200/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:20:52 INFO - PROCESS | 16692 | RSS: Main: 155713536 19:20:52 INFO - PROCESS | 16692 | 19:20:54 INFO - PROCESS | 16692 | Cycle 1(1): loaded http://localhost:47200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:20:55 INFO - PROCESS | 16692 | RSS: Main: 155680768 19:20:55 INFO - PROCESS | 16692 | 19:20:56 INFO - PROCESS | 16692 | Cycle 1(1): loaded http://localhost:47200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47200/tests/kraken/driver.html?testName=ai-astar) 19:20:57 INFO - PROCESS | 16692 | RSS: Main: 157343744 19:20:57 INFO - PROCESS | 16692 | 19:20:57 INFO - PROCESS | 16692 | __start_tp_report 19:20:57 INFO - PROCESS | 16692 | _x_x_mozilla_page_load 19:20:57 INFO - PROCESS | 16692 | _x_x_mozilla_page_load_details 19:20:57 INFO - PROCESS | 16692 | |i|pagename|runs| 19:20:57 INFO - PROCESS | 16692 | |0;ai-astar;111;104;111;110;110;121;110;111;110;110 19:20:57 INFO - PROCESS | 16692 | |1;audio-beat-detection;161;126;153;165;128;150;166;125;170;129 19:20:57 INFO - PROCESS | 16692 | |2;audio-dft;162;170;162;162;162;164;164;162;164;161 19:20:57 INFO - PROCESS | 16692 | |3;audio-fft;74;78;76;171;77;74;73;75;163;74 19:20:57 INFO - PROCESS | 16692 | |4;audio-oscillator;93;93;152;93;94;92;151;94;95;141 19:20:57 INFO - PROCESS | 16692 | |5;imaging-gaussian-blur;117;122;118;117;117;117;117;117;118;117 19:20:57 INFO - PROCESS | 16692 | |6;imaging-darkroom;147;147;147;146;147;146;146;145;147;146 19:20:57 INFO - PROCESS | 16692 | |7;imaging-desaturate;96;96;95;96;96;96;96;96;96;96 19:20:57 INFO - PROCESS | 16692 | |8;json-parse-financial;56;60;55;55;56;55;55;61;54;59 19:20:57 INFO - PROCESS | 16692 | |9;json-stringify-tinderbox;64;65;65;64;64;65;64;64;65;65 19:20:57 INFO - PROCESS | 16692 | |10;stanford-crypto-aes;78;78;86;86;86;77;77;78;77;77 19:20:57 INFO - PROCESS | 16692 | |11;stanford-crypto-ccm;113;117;118;115;129;121;113;115;114;121 19:20:57 INFO - PROCESS | 16692 | |12;stanford-crypto-pbkdf2;134;160;148;155;154;145;145;147;145;137 19:20:57 INFO - PROCESS | 16692 | |13;stanford-crypto-sha256-iterative;67;68;69;70;67;65;67;65;67;66 19:20:57 INFO - PROCESS | 16692 | __end_tp_report 19:20:57 INFO - PROCESS | 16692 | __start_cc_report 19:20:57 INFO - PROCESS | 16692 | _x_x_mozilla_cycle_collect,868 19:20:57 INFO - PROCESS | 16692 | __end_cc_report 19:20:57 INFO - PROCESS | 16692 | __startTimestamp1461896457238__endTimestamp 19:20:57 INFO - PROCESS | 16692 | 19:20:57 INFO - PROCESS | 16692 | ------- Summary: start ------- 19:20:57 INFO - PROCESS | 16692 | Number of tests: 14 19:20:57 INFO - PROCESS | 16692 | 19:20:57 INFO - PROCESS | 16692 | [#0] ai-astar Cycles:10 Average:110.80 Median:110.50 stddev:4.13 (3.7%) stddev-sans-first:4.38 19:20:57 INFO - PROCESS | 16692 | Values: 111.0 104.0 111.0 110.0 110.0 121.0 110.0 111.0 110.0 110.0 19:20:57 INFO - PROCESS | 16692 | 19:20:57 INFO - PROCESS | 16692 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:157.00 stddev:18.45 (11.8%) stddev-sans-first:18.89 19:20:57 INFO - PROCESS | 16692 | Values: 161.0 126.0 153.0 165.0 128.0 150.0 166.0 125.0 170.0 129.0 19:20:57 INFO - PROCESS | 16692 | 19:20:57 INFO - PROCESS | 16692 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:2.58 (1.6%) stddev-sans-first:2.70 19:20:57 INFO - PROCESS | 16692 | Values: 162.0 170.0 162.0 162.0 162.0 164.0 164.0 162.0 164.0 161.0 19:20:57 INFO - PROCESS | 16692 | 19:20:57 INFO - PROCESS | 16692 | [#3] audio-fft Cycles:10 Average:93.50 Median:74.50 stddev:38.81 (52.1%) stddev-sans-first:40.52 19:20:57 INFO - PROCESS | 16692 | Values: 74.0 78.0 76.0 171.0 77.0 74.0 73.0 75.0 163.0 74.0 19:20:57 INFO - PROCESS | 16692 | 19:20:57 INFO - PROCESS | 16692 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:93.00 stddev:26.53 (28.5%) stddev-sans-first:27.43 19:20:57 INFO - PROCESS | 16692 | Values: 93.0 93.0 152.0 93.0 94.0 92.0 151.0 94.0 95.0 141.0 19:20:57 INFO - PROCESS | 16692 | 19:20:57 INFO - PROCESS | 16692 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:117.00 stddev:1.57 (1.3%) stddev-sans-first:1.64 19:20:57 INFO - PROCESS | 16692 | Values: 117.0 122.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 19:20:57 INFO - PROCESS | 16692 | 19:20:57 INFO - PROCESS | 16692 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 19:20:57 INFO - PROCESS | 16692 | Values: 147.0 147.0 147.0 146.0 147.0 146.0 146.0 145.0 147.0 146.0 19:20:57 INFO - PROCESS | 16692 | 19:20:57 INFO - PROCESS | 16692 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:20:57 INFO - PROCESS | 16692 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 19:20:57 INFO - PROCESS | 16692 | 19:20:57 INFO - PROCESS | 16692 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.00 stddev:2.46 (4.4%) stddev-sans-first:2.60 19:20:57 INFO - PROCESS | 16692 | Values: 56.0 60.0 55.0 55.0 56.0 55.0 55.0 61.0 54.0 59.0 19:20:57 INFO - PROCESS | 16692 | 19:20:57 INFO - PROCESS | 16692 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 19:20:57 INFO - PROCESS | 16692 | Values: 64.0 65.0 65.0 64.0 64.0 65.0 64.0 64.0 65.0 65.0 19:20:57 INFO - PROCESS | 16692 | 19:20:57 INFO - PROCESS | 16692 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:78.00 stddev:4.16 (5.3%) stddev-sans-first:4.35 19:20:57 INFO - PROCESS | 16692 | Values: 78.0 78.0 86.0 86.0 86.0 77.0 77.0 78.0 77.0 77.0 19:20:57 INFO - PROCESS | 16692 | 19:20:57 INFO - PROCESS | 16692 | [#11] stanford-crypto-ccm Cycles:10 Average:117.60 Median:117.50 stddev:4.97 (4.2%) stddev-sans-first:4.99 19:20:57 INFO - PROCESS | 16692 | Values: 113.0 117.0 118.0 115.0 129.0 121.0 113.0 115.0 114.0 121.0 19:20:57 INFO - PROCESS | 16692 | 19:20:57 INFO - PROCESS | 16692 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.00 Median:147.50 stddev:7.92 (5.4%) stddev-sans-first:6.86 19:20:57 INFO - PROCESS | 16692 | Values: 134.0 160.0 148.0 155.0 154.0 145.0 145.0 147.0 145.0 137.0 19:20:57 INFO - PROCESS | 16692 | 19:20:57 INFO - PROCESS | 16692 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.60 (2.4%) stddev-sans-first:1.69 19:20:57 INFO - PROCESS | 16692 | Values: 67.0 68.0 69.0 70.0 67.0 65.0 67.0 65.0 67.0 66.0 19:20:57 INFO - PROCESS | 16692 | -------- Summary: end -------- 19:20:57 INFO - PROCESS | 16692 | 19:20:58 INFO - TEST-INFO | 16692: exit 0 19:20:58 INFO - TEST-OK | kraken | took 60125ms 19:20:58 INFO - SUITE-END | took 1169s 19:20:58 INFO - Completed test suite (00:19:29) 19:20:58 INFO - javascript benchmark 19:20:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3315.071779901627, 3364.764466487347, 3377.4258376076064, 3403.353362861056, 3407.8807241746545, 5376.489233522819, 5387.838364849056, 5388.515033646971, 5393.541548968337, 5395.271638328829, 5404.216388623648, 5420.349558053029, 5434.483724046209, 5441.918371224435, 5448.073827449333, 4923.606111511089, 4937.136001199794, 4990.725510096943, 5027.321311622939, 5053.77258023388, 4868.756562171895, 4955.430125535556, 4977.7262250576205, 5022.547970682638, 5034.320366750497, 4992.07646585381, 5024.924626130611, 5088.440271570124, 5131.743412829363, 5144.845654630367, 5053.317802096707, 5067.986402719434, 5071.112555302826, 5076.0863044652315, 5086.77109530072, 4864.756762161913, 4881.0, 4972.602191824645, 5014.122528557525, 5042.294078828967, 5282.867928301785, 5319.388270348882, 5328.44051374604, 5334.733263336818, 5372.623916325859, 5821.767129314865, 5833.79581714638, 5869.295684517842, 5875.823725288248, 5882.264716910387, 5939.287285525721, 5976.103584462322, 5977.402259774031, 6047.7580896764075, 6060.2424696912885, 5501.779928802843, 5518.19986102013, 5519.0, 5526.557875370001, 5560.777568897199, 5928.436798504135, 6054.757809687563, 6072.271327440735, 6080.635161890213, 6080.726367313481, 5856.00447923854, 5869.882602347929, 5886.352501224862, 5912.3496415394275, 5927.407259274038, 5982.49148822355, 5998.040313549811, 6001.5798894077, 6003.0695242237525, 6014.609050411709, 5700.030994730906, 5885.264341957255, 5926.733297001645, 5940.376260492672, 5941.673207973603, 5846.853828654318, 5882.0, 5889.146073819272, 5900.0264956281735, 5912.320083190402, 4466.4640243171025, 4476.0, 4491.910161796745, 4494.3707880896045, 4511.616512596401, 3996.440498330236, 4001.559828418872, 4029.49631296088, 4040.595940405936, 4071.75569465833, 5460.208269800856, 5585.69278689676, 5590.776368945278, 5614.185943038318, 5640.351359593699, 6059.091136329585, 6061.302950160788, 6064.4541991221, 6066.545009124334, 6085.5435842312, 5514.61397702157, 5664.51851592611, 5684.857878553069, 5704.087346024616, 5757.424257574209, 5127.794888204505, 5144.279800827887, 5164.431912489623, 5170.0, 5172.250023746536, 6135.693215339215, 6149.0, 6156.938430615726, 6168.814935551941, 6169.907451388232, 5952.136940143655, 6022.126791615104, 6047.183630210041, 6050.667213303311, 6058.212432383762, 6028.758849645965, 6116.35778243278, 6117.051856962178, 6123.540734445023, 6124.755009799558, 5738.770449181986, 5824.5631577631, 5857.150713146655, 5871.853203669943, 5880.94119058804, 6059.606125601822, 6111.738457788292, 6115.027386288435, 6116.616043419844, 6126.264848218064, 5906.7341969612335, 5952.642841429528, 5954.345022047484, 5956.731947062306, 5963.552733545088, 5742.942570574408, 5791.652500849962, 5827.446392592697, 5918.348981611933, 5946.672932988554, 5786.42135786418, 5800.506956908541, 5803.158542011469, 5809.912851307318, 5813.76744930198, 5836.708164591839, 5913.852153696192, 5923.7926672566255, 5940.46535811779, 5942.257217847769, 5594.86012849682, 5746.16680581305, 5799.130130480462, 5818.185454036354, 5847.298324201123], "unit": "score", "name": "dojo.html", "value": 5477.570845930955}, {"lowerIsBetter": false, "replicates": [537.0667890750516, 575.9251297331348, 595.1340799137256, 603.4508597176568, 610.2311088029082, 41564.16871662569, 42452.78773606128, 42459.36310955334, 42516.0, 42569.0, 41367.79316103423, 41902.0, 42081.15837683244, 42141.36787948183, 42194.36708449368, 9014.36899417041, 9056.094390560957, 9193.632254709804, 9194.35639505235, 9200.0, 8967.506787126706, 9104.408213466137, 9106.13491718289, 9120.224780893632, 9123.543822808866, 9126.680566180185, 9132.452052876815, 9139.543022848864, 9170.128837760436, 9219.953900230523, 9086.182243598076, 9175.724728258163, 9176.72469825903, 9207.585658645343, 9227.169554740105, 8929.508877011762, 9054.868141482315, 9061.048589898031, 9082.046385129532, 9090.63637454501, 39954.60045399538, 40303.19393612141, 40324.19351612981, 43008.35487467691, 43143.56856431427, 3459.636738142484, 3568.1793187566745, 3610.9638903611153, 3668.743187976816, 3692.723045771551, 32416.0, 32831.0, 33108.503372449435, 33506.0, 33631.49552756711, 4079.2755477450432, 4094.9181016379507, 4158.334666453383, 4162.6253637172495, 4182.769947652878, 296688.0, 300101.0, 301035.0, 301080.0, 301420.0, 66681.0, 67110.66444667843, 67199.32800671931, 67435.0, 67442.32557674458, 68498.65750671315, 72180.0, 73040.63479682567, 73196.63401682957, 73200.63399682968, 18523.536911577317, 18652.720209196872, 18748.343807966656, 18782.248710051717, 18914.621707566046, 14390.856091439162, 14393.064450810663, 14400.495982640557, 14402.711945761026, 14416.279186040865, 21922.780772192393, 22390.440238994157, 22509.4372640682, 22520.986555604708, 22555.210567630053, 8172.6730930762105, 8326.0, 8404.243618074403, 8451.83096338082, 8469.05211801289, 1000.9749756256006, 1014.9441780702132, 1039.7140786283833, 1117.1621284036971, 1162.575659884153, 28815.135545933656, 29147.562786558217, 29227.0, 29530.55704164439, 30002.84998574993, 1105.5688281570033, 1113.1651261553834, 1200.4897918384652, 1213.3387303919385, 1239.5165885304739, 14604.634884127769, 14654.487092951695, 14846.480373186887, 14925.776113358308, 15113.773293400607, 398741.0, 488334.0, 505242.0, 507920.0, 515587.0, 56549.43450565442, 57225.85548289094, 57282.713586431804, 57290.42709572851, 57317.0, 1491.8806495480335, 1499.293774736589, 1499.8275198352112, 1510.8111486064022, 1526.8167819861465, 28647.856760716062, 29300.56049159307, 30094.84952575223, 30983.225419364695, 30998.845005774827, 49200.50799491959, 49356.0, 49738.0, 50071.74964125156, 50083.0, 308951.0, 310631.0, 311963.0, 312535.0, 314248.0, 33740.83129584337, 34113.31773364569, 34202.48696269608, 34282.48576271408, 34308.48537271993, 43664.781676091414, 43804.78097609492, 44160.0, 44396.33405498985, 44438.333424998, 38236.617633823305, 38310.6168938307, 38408.61591384162, 38481.23037539177, 38868.41697374598, 37430.0, 37497.2500549982, 37816.81091594524, 38137.42793858039, 38861.0, 37119.62880371162, 37643.435348470346, 38012.61987380202, 38209.4268585977, 38451.42322865103, 33008.0, 33186.83406582951, 33281.83359083189, 33485.33029339448, 33581.496277555365, 25482.0, 26203.344916377242, 26232.73767262303, 26353.102720881863, 26483.60274595844], "unit": "score", "name": "ext.html", "value": 20047.319461036044}, {"lowerIsBetter": false, "replicates": [357.6066327040256, 368.11101190624635, 369.4845690262084, 371.0501117140123, 375.84214629855455, 17775.0, 18148.727769083456, 18930.432087037378, 19078.618427631474, 19114.13986370615, 17583.29666813326, 17932.55168620785, 18120.822146560466, 18239.0, 18243.54391140219, 5608.130739735348, 5887.0, 5910.231669882909, 5912.822615321547, 5941.643501389909, 5362.865928351784, 5608.355039170507, 5616.410276920926, 5634.859128521779, 5764.193012978187, 5534.142207957773, 5577.358603760558, 5590.217369568264, 5612.607117501777, 6022.8795424091495, 5932.762689492415, 5935.050391937312, 5946.732397042144, 5979.641221526701, 5986.072158815369, 5263.815766448156, 5517.337919449652, 5719.857003574903, 5731.656100633933, 5734.111212761987, 14187.858121418756, 14367.497137600134, 14378.928105359511, 14390.352434140488, 21965.34103976883, 2166.9783302166934, 2257.2776711452343, 2267.7958983691547, 2316.1893337331967, 2843.7156284371604, 9897.15874150698, 10108.848367274497, 10395.064444200058, 11884.762304753944, 13673.658158546017, 1947.2405761752927, 1966.6460037193299, 2007.7389939307943, 2018.5256464730776, 2024.483756642047, 63183.0, 66279.0, 67125.32874671288, 67970.3202967969, 68220.0, 9757.219422446187, 9912.959139290415, 10274.280800344053, 10559.313644613076, 10674.78650426987, 13557.525486607921, 13565.525206617722, 13589.320533973261, 13607.523736669169, 13671.0, 7838.960805195938, 7859.17478664732, 7917.920820791834, 7957.482763620346, 7994.840103197904, 7756.108047574488, 7861.960690196627, 7879.975603171551, 7889.487183333065, 7905.28852403275, 4176.436181115571, 4216.810243539048, 4271.988248284952, 4447.399601053881, 4668.8599342019115, 1861.0694652673662, 1862.394721715448, 1889.8677092603662, 1906.1803424527309, 1915.52111972007, 886.1935638568872, 968.1286841842398, 969.7333233360741, 1012.1649639047668, 1021.8824835144054, 17039.712626260185, 17585.912070439565, 17712.46862594124, 17813.554661133316, 18223.544411389823, 971.5433746139303, 978.5009645080918, 978.7308490165261, 978.7944531648291, 993.9403635781877, 6540.836479087966, 6582.308857569887, 6828.760993365208, 6848.417884479775, 10149.492525373702, 261426.0, 268199.0, 347326.0, 350038.0, 461832.0, 81741.0, 82595.5870220645, 85153.0, 86297.5685121583, 86333.0, 487.30072346182635, 503.34816412745585, 504.4350327633001, 506.4884466688671, 508.336620709977, 10697.0, 11028.613998510014, 11071.50178241965, 11251.099912006855, 11301.943490282496, 36583.45124823183, 36927.261454771295, 37309.6269037317, 37411.0, 38386.232275354894, 54016.0, 54054.729726351114, 54064.18903716526, 54145.45854541562, 54366.72816635892, 8542.82914341722, 8663.350248731496, 8663.783405414915, 8847.115288471101, 8929.0, 12454.564090256797, 12918.0, 13304.0, 13318.0, 13439.0, 10984.725381865517, 11091.833622495507, 11179.496922638338, 11303.604373846876, 11497.712557186138, 10333.431661258703, 11325.433728313716, 11475.655730328104, 11593.884061159617, 11695.239809412362, 11328.490217940047, 11517.82723259135, 11550.48022838991, 11626.88373116258, 11811.940940295588, 8719.869201961848, 8752.21230089295, 8755.168259015383, 8756.956215218883, 8930.062343454103, 8668.30653547702, 11405.600803971822, 11643.941780291045, 11645.359505227294, 11888.702782430508], "unit": "score", "name": "jquery.html", "value": 8411.472501531633}, {"lowerIsBetter": false, "replicates": [1590.5228431470557, 1599.768033635123, 1823.9270429182834, 1874.8125187481262, 1977.7330060441845, 7455.254474552542, 7927.445078844483, 8107.63515641796, 8379.790505237364, 8391.328693704505, 8231.09457959624, 8343.582820858948, 8393.412461127724, 8402.033766116898, 8446.15538446155, 2389.7251816041116, 2402.60357041088, 2403.807695384365, 2410.7950824179966, 2414.9034038638433, 2355.1639168095335, 2355.3640517060385, 2416.915407960722, 2420.5279970405777, 2425.1754403502805, 2387.069043073203, 2394.461246219604, 2410.554047501218, 2418.2503423938633, 2418.443757935676, 2284.7029886114865, 2291.232437133546, 2307.8615283082986, 2312.4912519245822, 2330.4523436992295, 2337.2053501809464, 2348.0607756897207, 2369.5260947810507, 2371.087131454385, 2382.9880850595637, 8332.62503187352, 8336.166383361677, 8369.748907532783, 8393.916060839436, 8414.284785793154, 5062.82280120194, 5157.58739300855, 5162.2772811806, 5164.561012313958, 5171.456997015334, 3138.937221255585, 3143.0413723814227, 3183.984080079608, 3225.4194245035883, 3267.3628642414737, 1082.269468109031, 2006.0972562346856, 2064.7935206479233, 2070.223666125203, 2075.7509098908076, 11305.095592352674, 11319.943400282946, 11342.886571134348, 11423.600173993871, 11463.713407164803, 4186.246475634415, 4313.202057619351, 4362.934555981663, 4371.431713877176, 4381.737095774264, 9035.909640903637, 9045.77385565366, 9119.954400227956, 9137.223336016514, 9182.081791820765, 5036.6726162799305, 5049.394072711299, 5058.3929928408825, 5069.391672999263, 5078.7460626968505, 4616.699914505546, 4673.556012178838, 4674.649401294849, 4695.295705644113, 4739.123262196505, 3527.3827080260853, 3566.928661426809, 3577.5170352002147, 3579.3557159711504, 3596.496490491333, 1071.1698433713934, 1071.844582535528, 1077.849101125843, 1078.5793540519203, 1092.8306112552566, 1141.8344340070644, 1163.2903928603546, 1167.4046236419317, 1420.5383250443647, 1474.7345477814097, 7421.183669796318, 7536.6985320587655, 7981.241782030698, 7988.880166797503, 8010.279074883289, 1228.2016689152122, 1231.0582404460595, 1244.5333000124954, 1247.6568943540417, 1252.380071864433, 5684.431556844283, 5773.018586840247, 5791.449812267828, 5797.88404231913, 5936.495397891227, 10117.949410252902, 10333.63832265882, 10343.120834728981, 10372.429516376671, 10499.895001050045, 10108.848367274497, 10190.847137292947, 10192.745181370525, 10240.129588985019, 10354.068133867988, 7945.523268603903, 8050.315723163597, 8060.193980601893, 8082.515049097073, 8136.064352599408, 7651.961740191486, 7671.07947046358, 7772.650230739518, 7783.53298802051, 7783.610819459118, 8955.686550970684, 9070.18368346852, 9210.171084602418, 9233.769155771159, 9240.168384845396, 9393.24854011691, 9455.669051583161, 9458.527073646152, 9514.619415223591, 9669.468179250209, 6232.594881332699, 6449.290578036506, 6657.933420665731, 7109.253528379446, 7172.892406613801, 7777.300042995931, 7800.84398312042, 7828.412869034959, 7880.802979925547, 7904.486208396436, 7056.15326160864, 7286.890696639449, 7357.117145942521, 7386.0767404074495, 7456.142543607554, 7047.260037695968, 7224.963875180801, 7261.818454538678, 7309.049823523121, 7354.448416368687, 7256.129264488295, 7301.488895777245, 7320.63396830167, 7326.523775954546, 7333.559986400833, 6681.46548276127, 6692.59844409337, 6725.596464212163, 6761.966190169018, 6766.357196066366, 6665.366790154928, 6833.965830170818, 6837.179538455417, 6839.897401538881, 6842.828929276808], "unit": "score", "name": "mootools.html", "value": 4808.734029595583}, {"lowerIsBetter": false, "replicates": [368.6387340406403, 369.04601604851456, 371.18895213957506, 372.81731951343835, 377.95653499847526, 6357.396047375503, 6395.58428702134, 6403.583767055144, 6413.583117097385, 6418.6469744164115, 6368.745250189999, 6386.680665966706, 6390.904136437957, 6408.679566021704, 6416.743330266795, 4725.55107264811, 4790.928136077944, 4866.926996095061, 4870.683405578644, 4938.80244790208, 4837.7339246341435, 4858.392700912386, 4863.173260545698, 4871.951280487203, 4885.462599114112, 4797.6401769867225, 4820.180569303209, 4821.783019764119, 4823.72171374586, 4828.275758636215, 4820.758962051884, 4829.806807727687, 4832.323474713543, 4832.347633069526, 4843.515648435164, 4188.832446702128, 4190.245755763961, 4197.664186865043, 4206.137741762962, 4212.831486740527, 6011.458968692795, 6157.107219453154, 6163.691815409256, 6165.691715414257, 6182.84542886427, 5733.312002559678, 5745.942540574582, 5747.339056008571, 5751.7699292028265, 5763.1355296705415, 6770.8307292317595, 6819.761308354184, 6833.931660683379, 6834.316568343175, 6852.862942741167, 4710.128626204163, 4719.669623126382, 4722.929156062662, 4728.71627702339, 4733.668643194977, 7111.146662400545, 7197.136343638745, 7204.423646108299, 7205.747798827068, 7220.98906153139, 4635.466921304093, 4696.976515117402, 4704.976475117603, 4794.184988551954, 4880.194767863334, 4758.500357462417, 4758.809647614126, 4766.571008609242, 4773.427188737373, 4782.210935195653, 5566.165075238747, 5571.1086226203615, 5571.359293681278, 5671.404502527258, 5675.290588676416, 6870.965645171842, 6893.0, 6898.206706228748, 6904.0, 6904.930950690529, 1732.159902447312, 1763.867709921761, 1766.7084930986243, 1767.2842498788011, 1767.7878654561534, 1117.2291119127776, 1131.134681968295, 1133.4616057372848, 1154.359330571524, 1171.2855158353398, 6584.539082264196, 6612.90080648781, 6614.603123812587, 6615.007748837616, 6619.768308109193, 7131.215566287704, 7132.17979932304, 7133.7146514139895, 7134.714611415485, 7135.857282854314, 6548.934510654833, 6562.934370656328, 6584.7695330664155, 6589.143411356493, 6590.406863382319, 3797.4303854421505, 3839.7696138231795, 3861.0, 3875.302445559826, 3886.145048089416, 7361.779146625609, 7419.554826710415, 7423.703051877865, 7430.331270185709, 7431.739889103856, 7299.306565876233, 7326.120865496068, 7344.926550734531, 7360.815979600446, 7385.187629360766, 7369.263073692588, 7370.6314684266645, 7381.11426628808, 7391.223921488274, 7393.667284972189, 6987.580745155307, 7145.214026456982, 7145.285471452813, 7147.571145731273, 7151.678174482265, 7082.008518807268, 7094.219635840157, 7118.181409138016, 7118.433944532195, 7122.287771222836, 7465.328120469184, 7477.813054673677, 7485.326320631169, 7491.475596708178, 7499.737509187153, 4743.0, 4756.9048619026735, 4762.309465127468, 4765.309030190672, 4770.141374552614, 6996.650167491503, 7202.099737532809, 7205.351518363373, 7233.602151881487, 7240.637968101469, 6978.755743548952, 7004.509684322048, 7007.369336759716, 7010.684519196547, 7028.578285302899, 6988.965055174692, 7001.684924178526, 7017.578945263301, 7018.33325834045, 7027.4729395294535, 6809.625470599165, 6841.247462778991, 6855.314468553105, 6858.862822743617, 6859.5541289816, 6880.518363714692, 7012.894806577803, 7022.683979221049, 7025.718971241093, 7049.189343225389, 6824.5564038339335, 6830.248672645906, 6837.692303846438, 6861.348171923659, 6864.862702745817], "unit": "score", "name": "prototype.html", "value": 5175.281871844752}, {"lowerIsBetter": false, "replicates": [804.3766081287006, 834.1783343406745, 904.7331037343984, 906.4380084347705, 906.8549032154853, 14372.856271437282, 14567.271636418189, 14569.562913112624, 14584.270786460675, 14631.487897923575, 12336.321502317369, 14011.089279196845, 14122.929385353085, 14132.081414708062, 14154.363053662584, 913.876626655403, 945.3902233059672, 946.432140715572, 947.4504787223428, 951.029949451559, 937.5078084005884, 946.5314669238736, 947.6493697331997, 951.0584521323874, 952.1858810716807, 993.4933184076137, 994.8109859126779, 998.6654470752306, 1000.7698229407241, 1002.9749256268615, 973.737090985437, 975.3465178330536, 975.7560609847538, 979.7697541077805, 979.7991411760607, 736.0210919477082, 736.5028605691191, 736.6905899522213, 737.8598066367373, 738.6048464071696, 15090.849091509053, 15111.244437778067, 15112.848871511364, 15145.167015814126, 15150.469733559272, 13661.590152295446, 14307.64230894236, 14333.0, 14382.784258236135, 14563.49027784033, 11412.657620271322, 11485.655430337103, 11499.252548584314, 11682.12384071198, 11715.121365897592, 3893.5133108361456, 3920.313945059603, 3924.823382947774, 3955.3275943089743, 3993.0416699992084, 51654.0, 51789.482105178846, 51906.22140667893, 51937.0, 51946.99999999962, 10928.0, 11172.44137793107, 11339.206255562196, 11442.771144577062, 11448.599299024494, 19626.11682474292, 20537.17851285932, 20541.178352865718, 20547.589048218953, 20623.896880515502, 8839.60221790021, 8882.644694212158, 8905.688300909436, 8978.191962723386, 9067.773305667411, 4740.6681532292405, 4785.449673287617, 4808.855734327975, 4827.106985207748, 4978.551930326288, 3430.073880052422, 3436.553248077784, 3440.208751987057, 3440.8107554084263, 3482.495038219444, 625.3121566277059, 630.5208041888199, 636.4367534731796, 639.2169592249458, 645.909572659828, 629.9244090709053, 655.2824657000576, 666.7166454256921, 718.3227164570682, 725.5030304241611, 9123.726288211365, 9579.233661307078, 10089.596416143271, 10115.291929565006, 10166.390016599027, 604.6734763227807, 714.9821254468576, 798.1858504325555, 798.4211446701095, 804.5494523067101, 4324.978375108104, 4357.952590183869, 4496.775161241925, 4556.384888040138, 4576.954230457653, 60571.39428605657, 63215.0, 64455.67772161109, 64517.35482645207, 66265.33734662688, 54268.0, 54451.45548544543, 55242.72378638081, 55331.72334138384, 55486.0, 49243.50756492461, 49751.502484974684, 50008.24987625189, 50203.49796501988, 50392.74803625958, 9446.291528135554, 9619.615215391306, 9636.71089867305, 9852.458114803754, 9886.110250077527, 35160.82419587886, 37118.628813712596, 37865.053373665876, 38368.6163138365, 38547.036324091, 43089.13821723485, 46888.53111468978, 46969.0, 51198.74400627973, 51400.74299628478, 12890.291033992846, 13101.475940962255, 13357.866421335662, 13743.587692369245, 13796.655083622989, 13279.86720132825, 13448.731025379242, 13596.320183990958, 13692.246926419142, 13850.09974351664, 13022.153560018569, 13037.543685970946, 13088.28014459214, 13143.342832858127, 13298.401571929093, 12134.271943683407, 12380.81428778551, 12384.62846114618, 12434.378281085728, 12628.0, 11803.611805604058, 11804.2327248732, 12271.938640306742, 12302.507899683913, 12698.492060317853, 10030.899691002996, 10227.642032528825, 10270.486475676336, 10438.53026613789, 10577.735556611146, 10193.286469947032, 10349.430781307101, 10636.680899573024, 10669.733256668645, 10908.0], "unit": "score", "name": "yui.html", "value": 7040.546403884052}], "name": "dromaeo_css", "value": 7382.223064895066}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 104.0, 111.0, 110.0, 110.0, 121.0, 110.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [161.0, 126.0, 153.0, 165.0, 128.0, 150.0, 166.0, 125.0, 170.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 147.3}, {"lowerIsBetter": true, "replicates": [162.0, 170.0, 162.0, 162.0, 162.0, 164.0, 164.0, 162.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [74.0, 78.0, 76.0, 171.0, 77.0, 74.0, 73.0, 75.0, 163.0, 74.0], "unit": "score", "name": "audio-fft", "value": 93.5}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 152.0, 93.0, 94.0, 92.0, 151.0, 94.0, 95.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [117.0, 122.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.7}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 145.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [56.0, 60.0, 55.0, 55.0, 56.0, 55.0, 55.0, 61.0, 54.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 86.0, 86.0, 86.0, 77.0, 77.0, 78.0, 77.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.0}, {"lowerIsBetter": true, "replicates": [113.0, 117.0, 118.0, 115.0, 129.0, 121.0, 113.0, 115.0, 114.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.6}, {"lowerIsBetter": true, "replicates": [134.0, 160.0, 148.0, 155.0, 154.0, 145.0, 145.0, 147.0, 145.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.0}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 70.0, 67.0, 65.0, 67.0, 65.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1517.4999999999998}]} 19:20:58 INFO - Return code: 0 19:20:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:20:58 ERROR - # TBPL SUCCESS # 19:20:58 INFO - Running post-action listener: _resource_record_post_action 19:20:58 INFO - Running post-run listener: _resource_record_post_run 19:20:59 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 12288; Write bytes: 470265856; Read time: 16; Write time: 466236 19:20:59 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 247468032; Read time: 0; Write time: 306348 19:20:59 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 12288; Write bytes: 222797824; Read time: 16; Write time: 159888 19:20:59 INFO - Running post-run listener: _upload_blobber_files 19:20:59 INFO - Blob upload gear active. 19:20:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:20:59 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 19:20:59 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:20:59 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:21:00 INFO - (blobuploader) - INFO - Open directory for files ... 19:21:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:21:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:21:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:21:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:21:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:21:00 INFO - (blobuploader) - INFO - Done attempting. 19:21:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:21:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:21:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:21:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:21:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:21:01 INFO - (blobuploader) - INFO - Done attempting. 19:21:01 INFO - (blobuploader) - INFO - Iteration through files over. 19:21:01 INFO - Return code: 0 19:21:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:21:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:21:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bd2386c29d1b88514364ceddb93b576ce0a7f2ffb154d2ccccf3d4bbdf08d03428d2854eab832d2db619d29dd2742e94bcb24da1ce0ea8395b550b5ee19936b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7d78d036a8586594e194b237a9024679fff0ccee4edc7bc7de7e230f2a42aa28aab3e66cc938045e6a9e451dd8fd20305c9e56ded8d64ac1a1a2cda663059204"} 19:21:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:21:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:21:01 INFO - Contents: 19:21:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bd2386c29d1b88514364ceddb93b576ce0a7f2ffb154d2ccccf3d4bbdf08d03428d2854eab832d2db619d29dd2742e94bcb24da1ce0ea8395b550b5ee19936b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7d78d036a8586594e194b237a9024679fff0ccee4edc7bc7de7e230f2a42aa28aab3e66cc938045e6a9e451dd8fd20305c9e56ded8d64ac1a1a2cda663059204"} 19:21:01 INFO - Running post-run listener: copy_logs_to_upload_dir 19:21:01 INFO - Copying logs to upload dir... 19:21:01 INFO - mkdir: /builds/slave/test/build/upload/logs 19:21:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.038415 ========= master_lag: 0.66 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-04-28 19:21:02.224830) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 19:21:02.228431) ========= 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=32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bd2386c29d1b88514364ceddb93b576ce0a7f2ffb154d2ccccf3d4bbdf08d03428d2854eab832d2db619d29dd2742e94bcb24da1ce0ea8395b550b5ee19936b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7d78d036a8586594e194b237a9024679fff0ccee4edc7bc7de7e230f2a42aa28aab3e66cc938045e6a9e451dd8fd20305c9e56ded8d64ac1a1a2cda663059204"} build_url:https://queue.taskcluster.net/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011220 build_url: 'https://queue.taskcluster.net/v1/task/MFLW-UOhQV-SFCFa8qNSsQ/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bd2386c29d1b88514364ceddb93b576ce0a7f2ffb154d2ccccf3d4bbdf08d03428d2854eab832d2db619d29dd2742e94bcb24da1ce0ea8395b550b5ee19936b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7d78d036a8586594e194b237a9024679fff0ccee4edc7bc7de7e230f2a42aa28aab3e66cc938045e6a9e451dd8fd20305c9e56ded8d64ac1a1a2cda663059204"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 19:21:02.253984) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 19:21:02.254338) ========= 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=32c5991c409366f7fec8a718000001d2-1461893648.195807-954641626 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004603 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 19:21:02.304153) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 19:21:02.304492) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 19:21:02.304818) ========= ========= Total master_lag: 0.78 =========