builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1467741486.29 results: success (0) buildid: 20160705080222 builduid: d8f172d1295a49149a1d56034bc9c957 revision: 4e1aa4b6f7b4de6e4b7f34b016c3e1d8505dcd1f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 10:58:06.289736) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 10:58:06.290191) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 10:58:06.290493) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 10:58:06.305052) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:58:06.305364) ========= 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=41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 10:58:06-- 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% 5.65M=0.002s 2016-07-05 10:58:06 (5.65 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123351 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:58:06.443534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:58:06.443869) ========= 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=41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018614 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 10:58:06.493172) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 10:58:06.493564) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4e1aa4b6f7b4de6e4b7f34b016c3e1d8505dcd1f --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 4e1aa4b6f7b4de6e4b7f34b016c3e1d8505dcd1f --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=41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 10:58:06,721 truncating revision to first 12 chars 2016-07-05 10:58:06,722 Setting DEBUG logging. 2016-07-05 10:58:06,722 attempt 1/10 2016-07-05 10:58:06,722 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4e1aa4b6f7b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 10:58:07,955 unpacking tar archive at: mozilla-beta-4e1aa4b6f7b4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.575432 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 10:58:08.083796) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 10:58:08.084148) ========= script_repo_revision: 4e1aa4b6f7b4de6e4b7f34b016c3e1d8505dcd1f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 10:58:08.084597) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 10:58:08.084874) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 10:58:08.094390) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-07-05 10:58:08.094854) ========= /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=41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:58:08 INFO - MultiFileLogger online at 20160705 10:58:08 in /builds/slave/test 10:58:08 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 10:58:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:58:08 INFO - {'append_to_log': False, 10:58:08 INFO - 'base_work_dir': '/builds/slave/test', 10:58:08 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:58:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:58:08 INFO - 'branch': 'Mozilla-Beta', 10:58:08 INFO - 'buildbot_json_path': 'buildprops.json', 10:58:08 INFO - 'config_files': ('talos/linux_config.py',), 10:58:08 INFO - 'default_actions': ('clobber', 10:58:08 INFO - 'read-buildbot-config', 10:58:08 INFO - 'download-and-extract', 10:58:08 INFO - 'populate-webroot', 10:58:08 INFO - 'create-virtualenv', 10:58:08 INFO - 'install', 10:58:08 INFO - 'run-tests'), 10:58:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:58:08 INFO - 'download_minidump_stackwalk': True, 10:58:08 INFO - 'download_symbols': 'ondemand', 10:58:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:58:08 INFO - 'tooltool.py': '/tools/tooltool.py', 10:58:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:58:08 INFO - '/tools/misc-python/virtualenv.py')}, 10:58:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:58:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:58:08 INFO - 'installer_path': 'installer.exe', 10:58:08 INFO - 'log_level': 'info', 10:58:08 INFO - 'log_name': 'talos', 10:58:08 INFO - 'log_to_console': True, 10:58:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:58:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:58:08 INFO - 'opt_config_files': (), 10:58:08 INFO - 'pip_index': False, 10:58:08 INFO - 'sps_profile': False, 10:58:08 INFO - 'sps_profile_interval': 0, 10:58:08 INFO - 'suite': 'dromaeojs-e10s', 10:58:08 INFO - 'system_bits': '32', 10:58:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:58:08 INFO - 'title': 'talos-linux64-ix-024', 10:58:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:58:08 INFO - 'use_talos_json': True, 10:58:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:58:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:58:08 INFO - 'work_dir': 'build'} 10:58:08 INFO - ##### 10:58:08 INFO - ##### Running clobber step. 10:58:08 INFO - ##### 10:58:08 INFO - Running pre-action listener: _resource_record_pre_action 10:58:08 INFO - Running main action method: clobber 10:58:08 INFO - rmtree: /builds/slave/test/build 10:58:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:58:09 INFO - Running post-action listener: _resource_record_post_action 10:58:09 INFO - ##### 10:58:09 INFO - ##### Running read-buildbot-config step. 10:58:09 INFO - ##### 10:58:09 INFO - Running pre-action listener: _resource_record_pre_action 10:58:09 INFO - Running main action method: read_buildbot_config 10:58:09 INFO - Using buildbot properties: 10:58:09 INFO - { 10:58:09 INFO - "project": "", 10:58:09 INFO - "product": "firefox", 10:58:09 INFO - "script_repo_revision": "production", 10:58:09 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 10:58:09 INFO - "repository": "", 10:58:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 10:58:09 INFO - "buildid": "20160705080222", 10:58:09 INFO - "pgo_build": "True", 10:58:09 INFO - "basedir": "/builds/slave/test", 10:58:09 INFO - "buildnumber": 30, 10:58:09 INFO - "slavename": "talos-linux64-ix-024", 10:58:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:58:09 INFO - "platform": "ubuntu64_hw", 10:58:09 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:58:09 INFO - "branch": "mozilla-beta", 10:58:09 INFO - "repo_path": "releases/mozilla-beta", 10:58:09 INFO - "revision": "4e1aa4b6f7b4de6e4b7f34b016c3e1d8505dcd1f", 10:58:09 INFO - "stage_platform": "linux64-pgo", 10:58:09 INFO - "builduid": "d8f172d1295a49149a1d56034bc9c957", 10:58:09 INFO - "slavebuilddir": "test" 10:58:09 INFO - } 10:58:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 10:58:09 INFO - Running post-action listener: _resource_record_post_action 10:58:09 INFO - ##### 10:58:09 INFO - ##### Running download-and-extract step. 10:58:09 INFO - ##### 10:58:09 INFO - Running pre-action listener: _resource_record_pre_action 10:58:09 INFO - Running main action method: download_and_extract 10:58:09 INFO - mkdir: /builds/slave/test/build/tests 10:58: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')]} 10:58:09 INFO - https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:58:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:58:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:58:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:58:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:58:10 INFO - Downloaded 1327 bytes. 10:58:10 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:58:10 INFO - Using the following test package requirements: 10:58:10 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:58:10 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:58:10 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:58:10 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:58:10 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 10:58:10 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:58:10 INFO - u'jsshell-linux-x86_64.zip'], 10:58:10 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:58:10 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:58:10 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:58:10 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:58:10 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 10:58:10 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:58:10 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 10:58:10 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:58:10 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:58:10 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:58:10 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:58:10 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:10 INFO - https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:58:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:58:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:58:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:58:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:58:11 INFO - Downloaded 24235782 bytes. 10:58:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:58:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:58:12 INFO - Return code: 0 10:58:12 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:12 INFO - https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:58:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:58:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:58:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:58:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:58:13 INFO - Downloaded 24235782 bytes. 10:58:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:58:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:58:15 INFO - Return code: 0 10:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:15 INFO - https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:58:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:58:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:58:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:58:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:58:16 INFO - Downloaded 10840145 bytes. 10:58:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:58:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:58:16 INFO - Return code: 0 10:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:16 INFO - https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:58:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:58:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:58:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:58:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:58:17 INFO - Downloaded 56023777 bytes. 10:58:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:58:17 INFO - mkdir: /builds/slave/test/properties 10:58:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:58:17 INFO - Writing to file /builds/slave/test/properties/build_url 10:58:17 INFO - Contents: 10:58:17 INFO - build_url:https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:58:18 INFO - Running post-action listener: _resource_record_post_action 10:58:18 INFO - Running post-action listener: set_extra_try_arguments 10:58:18 INFO - ##### 10:58:18 INFO - ##### Running populate-webroot step. 10:58:18 INFO - ##### 10:58:18 INFO - Running pre-action listener: _resource_record_pre_action 10:58:18 INFO - Running main action method: populate_webroot 10:58:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:58:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:58:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:58:18 INFO - '--tppagecycles', 10:58:18 INFO - '7'], 10:58:18 INFO - 'tests': ['tsvgm']}}, 10:58:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:58:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:58:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:58:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:58:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:58:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:58:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:18 INFO - 'talos_options': ['--disable-e10s'], 10:58:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:58:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:58:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:18 INFO - 'talos_options': ['--disable-e10s'], 10:58:18 INFO - 'tests': ['damp', 'tps']}, 10:58:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:18 INFO - 'tests': ['damp', 'tps']}, 10:58:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:58:18 INFO - 'tests': ['dromaeo_dom']}, 10:58:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:58:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:58:18 INFO - 'tests': ['a11yr', 10:58:18 INFO - 'ts_paint', 10:58:18 INFO - 'tpaint', 10:58:18 INFO - 'sessionrestore', 10:58:18 INFO - 'sessionrestore_no_auto_restore', 10:58:18 INFO - 'tabpaint']}, 10:58:18 INFO - 'other-e10s': {'tests': ['a11yr', 10:58:18 INFO - 'ts_paint', 10:58:18 INFO - 'tpaint', 10:58:18 INFO - 'sessionrestore', 10:58:18 INFO - 'sessionrestore_no_auto_restore', 10:58:18 INFO - 'tabpaint']}, 10:58:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:58:18 INFO - 'ts_paint', 10:58:18 INFO - 'tpaint', 10:58:18 INFO - 'sessionrestore', 10:58:18 INFO - 'sessionrestore_no_auto_restore', 10:58:18 INFO - 'tabpaint']}, 10:58:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:58:18 INFO - 'ts_paint', 10:58:18 INFO - 'tpaint', 10:58:18 INFO - 'sessionrestore', 10:58:18 INFO - 'sessionrestore_no_auto_restore', 10:58:18 INFO - 'tabpaint']}, 10:58:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:58:18 INFO - 'tests': ['a11yr', 10:58:18 INFO - 'ts_paint', 10:58:18 INFO - 'tpaint', 10:58:18 INFO - 'sessionrestore', 10:58:18 INFO - 'sessionrestore_no_auto_restore', 10:58:18 INFO - 'tabpaint']}, 10:58:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:58:18 INFO - 'tests': ['a11yr', 10:58:18 INFO - 'ts_paint', 10:58:18 INFO - 'tpaint', 10:58:18 INFO - 'sessionrestore', 10:58:18 INFO - 'sessionrestore_no_auto_restore', 10:58:18 INFO - 'tabpaint']}, 10:58:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:58:18 INFO - 'tests': ['tsvgx', 10:58:18 INFO - 'tsvgr_opacity', 10:58:18 INFO - 'tart', 10:58:18 INFO - 'tscrollx', 10:58:18 INFO - 'cart']}, 10:58:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:58:18 INFO - 'tsvgr_opacity', 10:58:18 INFO - 'tart', 10:58:18 INFO - 'tscrollx', 10:58:18 INFO - 'cart']}, 10:58:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:18 INFO - 'talos_options': ['--disable-e10s'], 10:58:18 INFO - 'tests': ['tp5o']}, 10:58:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:18 INFO - 'tests': ['tp5o']}, 10:58:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:18 INFO - 'talos_options': ['--disable-e10s', 10:58:18 INFO - '--xperf_path', 10:58:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:58:18 INFO - 'tests': ['tp5n']}, 10:58:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:18 INFO - 'talos_options': ['--xperf_path', 10:58:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:58:18 INFO - 'tests': ['tp5n']}}, 10:58:18 INFO - 'talos.zip': {'path': '', 10:58:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:58:18 INFO - Running post-action listener: _resource_record_post_action 10:58:18 INFO - ##### 10:58:18 INFO - ##### Running create-virtualenv step. 10:58:18 INFO - ##### 10:58:18 INFO - Running pre-action listener: _resource_record_pre_action 10:58:18 INFO - Running main action method: create_virtualenv 10:58:18 INFO - Creating virtualenv /builds/slave/test/build/venv 10:58:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:58:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:58:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:58:18 INFO - Using real prefix '/usr' 10:58:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:58:19 INFO - Installing distribute.............................................................................................................................................................................................done. 10:58:21 INFO - Installing pip.................done. 10:58:21 INFO - Return code: 0 10:58:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:21 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 0x7f5756356f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2862410>, '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 0x2863310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28637a0>, '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': '41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:58:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:58:21 INFO - Using env: {'DISPLAY': ':0', 10:58:21 INFO - 'HOME': '/home/cltbld', 10:58:21 INFO - 'LANG': 'en_US.UTF-8', 10:58:21 INFO - 'LANGUAGE': 'en_US:en', 10:58:21 INFO - 'LOGNAME': 'cltbld', 10:58:21 INFO - 'MAIL': '/var/mail/cltbld', 10:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:21 INFO - 'MOZ_NO_REMOTE': '1', 10:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:21 INFO - 'NO_EM_RESTART': '1', 10:58:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:21 INFO - 'PWD': '/builds/slave/test', 10:58:21 INFO - 'SHELL': '/bin/bash', 10:58:21 INFO - 'SHLVL': '1', 10:58:21 INFO - 'TERM': 'linux', 10:58:21 INFO - 'TMOUT': '86400', 10:58:21 INFO - 'USER': 'cltbld', 10:58:21 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414', 10:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:21 INFO - '_': '/tools/buildbot/bin/python'} 10:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:58:21 INFO - Cleaning up... 10:58:21 INFO - Return code: 0 10:58:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:21 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 0x7f5756356f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2862410>, '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 0x2863310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28637a0>, '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': '41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:58:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:58:21 INFO - Using env: {'DISPLAY': ':0', 10:58:21 INFO - 'HOME': '/home/cltbld', 10:58:21 INFO - 'LANG': 'en_US.UTF-8', 10:58:21 INFO - 'LANGUAGE': 'en_US:en', 10:58:21 INFO - 'LOGNAME': 'cltbld', 10:58:21 INFO - 'MAIL': '/var/mail/cltbld', 10:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:21 INFO - 'MOZ_NO_REMOTE': '1', 10:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:21 INFO - 'NO_EM_RESTART': '1', 10:58:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:21 INFO - 'PWD': '/builds/slave/test', 10:58:21 INFO - 'SHELL': '/bin/bash', 10:58:21 INFO - 'SHLVL': '1', 10:58:21 INFO - 'TERM': 'linux', 10:58:21 INFO - 'TMOUT': '86400', 10:58:21 INFO - 'USER': 'cltbld', 10:58:21 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414', 10:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:21 INFO - '_': '/tools/buildbot/bin/python'} 10:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:21 INFO - Downloading/unpacking psutil>=0.7.1 10:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:58:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:58:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:58:23 INFO - Installing collected packages: psutil 10:58:23 INFO - Running setup.py install for psutil 10:58:23 INFO - building 'psutil._psutil_linux' extension 10:58:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:58:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:58:23 INFO - building 'psutil._psutil_posix' extension 10:58:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:58:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:58:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:58:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:58:23 INFO - Successfully installed psutil 10:58:23 INFO - Cleaning up... 10:58:24 INFO - Return code: 0 10:58:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:24 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 0x7f5756356f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2862410>, '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 0x2863310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28637a0>, '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': '41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:58:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:58:24 INFO - Using env: {'DISPLAY': ':0', 10:58:24 INFO - 'HOME': '/home/cltbld', 10:58:24 INFO - 'LANG': 'en_US.UTF-8', 10:58:24 INFO - 'LANGUAGE': 'en_US:en', 10:58:24 INFO - 'LOGNAME': 'cltbld', 10:58:24 INFO - 'MAIL': '/var/mail/cltbld', 10:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:24 INFO - 'MOZ_NO_REMOTE': '1', 10:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:24 INFO - 'NO_EM_RESTART': '1', 10:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:24 INFO - 'PWD': '/builds/slave/test', 10:58:24 INFO - 'SHELL': '/bin/bash', 10:58:24 INFO - 'SHLVL': '1', 10:58:24 INFO - 'TERM': 'linux', 10:58:24 INFO - 'TMOUT': '86400', 10:58:24 INFO - 'USER': 'cltbld', 10:58:24 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414', 10:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:24 INFO - '_': '/tools/buildbot/bin/python'} 10:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:58:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:58:26 INFO - Installing collected packages: mozsystemmonitor 10:58:26 INFO - Running setup.py install for mozsystemmonitor 10:58:26 INFO - Successfully installed mozsystemmonitor 10:58:26 INFO - Cleaning up... 10:58:26 INFO - Return code: 0 10:58:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5756356f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2862410>, '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 0x2863310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28637a0>, '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': '41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:58:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:58:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:58:26 INFO - Using env: {'DISPLAY': ':0', 10:58:26 INFO - 'HOME': '/home/cltbld', 10:58:26 INFO - 'LANG': 'en_US.UTF-8', 10:58:26 INFO - 'LANGUAGE': 'en_US:en', 10:58:26 INFO - 'LOGNAME': 'cltbld', 10:58:26 INFO - 'MAIL': '/var/mail/cltbld', 10:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:26 INFO - 'MOZ_NO_REMOTE': '1', 10:58:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:26 INFO - 'NO_EM_RESTART': '1', 10:58:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:26 INFO - 'PWD': '/builds/slave/test', 10:58:26 INFO - 'SHELL': '/bin/bash', 10:58:26 INFO - 'SHLVL': '1', 10:58:26 INFO - 'TERM': 'linux', 10:58:26 INFO - 'TMOUT': '86400', 10:58:26 INFO - 'USER': 'cltbld', 10:58:26 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414', 10:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:26 INFO - '_': '/tools/buildbot/bin/python'} 10:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:26 INFO - Downloading/unpacking blobuploader==1.2.4 10:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:28 INFO - Downloading blobuploader-1.2.4.tar.gz 10:58:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:58:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:58:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:29 INFO - Downloading docopt-0.6.1.tar.gz 10:58:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:58:29 INFO - Installing collected packages: blobuploader, requests, docopt 10:58:29 INFO - Running setup.py install for blobuploader 10:58:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:58:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:58:29 INFO - Running setup.py install for requests 10:58:29 INFO - Running setup.py install for docopt 10:58:29 INFO - Successfully installed blobuploader requests docopt 10:58:29 INFO - Cleaning up... 10:58:29 INFO - Return code: 0 10:58:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:29 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 0x7f5756356f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2862410>, '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 0x2863310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28637a0>, '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': '41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:58:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:58:29 INFO - Using env: {'DISPLAY': ':0', 10:58:29 INFO - 'HOME': '/home/cltbld', 10:58:29 INFO - 'LANG': 'en_US.UTF-8', 10:58:29 INFO - 'LANGUAGE': 'en_US:en', 10:58:29 INFO - 'LOGNAME': 'cltbld', 10:58:29 INFO - 'MAIL': '/var/mail/cltbld', 10:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:29 INFO - 'MOZ_NO_REMOTE': '1', 10:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:29 INFO - 'NO_EM_RESTART': '1', 10:58:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:29 INFO - 'PWD': '/builds/slave/test', 10:58:29 INFO - 'SHELL': '/bin/bash', 10:58:29 INFO - 'SHLVL': '1', 10:58:29 INFO - 'TERM': 'linux', 10:58:29 INFO - 'TMOUT': '86400', 10:58:29 INFO - 'USER': 'cltbld', 10:58:29 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414', 10:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:29 INFO - '_': '/tools/buildbot/bin/python'} 10:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:58:30 INFO - Running setup.py (path:/tmp/pip-vrCgrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:58:30 INFO - Running setup.py (path:/tmp/pip-W2Ctkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:58:30 INFO - Running setup.py (path:/tmp/pip-NBJ_pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:58:30 INFO - Running setup.py (path:/tmp/pip-GrwJtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:58:30 INFO - Running setup.py (path:/tmp/pip-25Sfbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:58:30 INFO - Running setup.py (path:/tmp/pip-Tn_xL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:58:30 INFO - Running setup.py (path:/tmp/pip-erlQg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:58:30 INFO - Running setup.py (path:/tmp/pip-a78eav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:58:30 INFO - Running setup.py (path:/tmp/pip-yCsfPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:58:30 INFO - Running setup.py (path:/tmp/pip-pjuH3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:58:30 INFO - Running setup.py (path:/tmp/pip-mNJb9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:58:30 INFO - Running setup.py (path:/tmp/pip-JanynK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:58:30 INFO - Running setup.py (path:/tmp/pip-Imam1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:58:30 INFO - Running setup.py (path:/tmp/pip-SUazzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:58:31 INFO - Running setup.py (path:/tmp/pip-u8ynCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:58:31 INFO - Running setup.py (path:/tmp/pip-OIMJvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:58:31 INFO - Running setup.py (path:/tmp/pip-n7eqwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:58:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:58:31 INFO - Running setup.py install for manifestparser 10:58:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:58:31 INFO - Running setup.py install for mozcrash 10:58:31 INFO - Running setup.py install for mozdebug 10:58:31 INFO - Running setup.py install for mozdevice 10:58:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:58:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:58:31 INFO - Running setup.py install for mozfile 10:58:31 INFO - Running setup.py install for mozhttpd 10:58:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:58:31 INFO - Running setup.py install for mozinfo 10:58:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:58:31 INFO - Running setup.py install for mozInstall 10:58:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:58:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:58:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:58:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:58:32 INFO - Running setup.py install for mozleak 10:58:32 INFO - Running setup.py install for mozlog 10:58:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:58:32 INFO - Running setup.py install for moznetwork 10:58:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:58:32 INFO - Running setup.py install for mozprocess 10:58:32 INFO - Running setup.py install for mozprofile 10:58:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:58:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:58:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:58:32 INFO - Running setup.py install for mozrunner 10:58:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:58:32 INFO - Running setup.py install for mozscreenshot 10:58:32 INFO - Running setup.py install for moztest 10:58:32 INFO - Running setup.py install for mozversion 10:58:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:58:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:58:33 INFO - Cleaning up... 10:58:33 INFO - Return code: 0 10:58:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:33 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 0x7f5756356f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2862410>, '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 0x2863310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28637a0>, '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': '41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:58:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:58:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:58:33 INFO - Using env: {'DISPLAY': ':0', 10:58:33 INFO - 'HOME': '/home/cltbld', 10:58:33 INFO - 'LANG': 'en_US.UTF-8', 10:58:33 INFO - 'LANGUAGE': 'en_US:en', 10:58:33 INFO - 'LOGNAME': 'cltbld', 10:58:33 INFO - 'MAIL': '/var/mail/cltbld', 10:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:33 INFO - 'MOZ_NO_REMOTE': '1', 10:58:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:33 INFO - 'NO_EM_RESTART': '1', 10:58:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:33 INFO - 'PWD': '/builds/slave/test', 10:58:33 INFO - 'SHELL': '/bin/bash', 10:58:33 INFO - 'SHLVL': '1', 10:58:33 INFO - 'TERM': 'linux', 10:58:33 INFO - 'TMOUT': '86400', 10:58:33 INFO - 'USER': 'cltbld', 10:58:33 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414', 10:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:33 INFO - '_': '/tools/buildbot/bin/python'} 10:58:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:58:33 INFO - Running setup.py (path:/tmp/pip-2XUZ3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:58:33 INFO - Running setup.py (path:/tmp/pip-R8ZPDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:58:33 INFO - Running setup.py (path:/tmp/pip-0ZGyqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:58:33 INFO - Running setup.py (path:/tmp/pip-nAd3D1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:58:33 INFO - Running setup.py (path:/tmp/pip-KoXxMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:58:33 INFO - Running setup.py (path:/tmp/pip-Fo3Fap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:58:33 INFO - Running setup.py (path:/tmp/pip-o2vWV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:58:33 INFO - Running setup.py (path:/tmp/pip-LRyOAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:58:33 INFO - Running setup.py (path:/tmp/pip-kQ3Kou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:58:33 INFO - Running setup.py (path:/tmp/pip-sUmTvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:58:33 INFO - Running setup.py (path:/tmp/pip-Jh6IA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:58:34 INFO - Running setup.py (path:/tmp/pip-iRuiDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:58:34 INFO - Running setup.py (path:/tmp/pip-_XlzpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:58:34 INFO - Running setup.py (path:/tmp/pip-Gc5kwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:58:34 INFO - Running setup.py (path:/tmp/pip-2Hn4In-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:58:34 INFO - Running setup.py (path:/tmp/pip-x7RnE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:58:34 INFO - Running setup.py (path:/tmp/pip-TniP5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:58:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:36 INFO - Downloading blessings-1.6.tar.gz 10:58:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:58:36 INFO - Installing collected packages: blessings 10:58:36 INFO - Running setup.py install for blessings 10:58:36 INFO - Successfully installed blessings 10:58:36 INFO - Cleaning up... 10:58:36 INFO - Return code: 0 10:58:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:58:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:58:36 INFO - Reading from file tmpfile_stdout 10:58:36 INFO - Current package versions: 10:58:36 INFO - argparse == 1.2.1 10:58:36 INFO - blessings == 1.6 10:58:36 INFO - blobuploader == 1.2.4 10:58:36 INFO - docopt == 0.6.1 10:58:36 INFO - manifestparser == 1.1 10:58:36 INFO - mozInstall == 1.12 10:58:36 INFO - mozcrash == 0.17 10:58:36 INFO - mozdebug == 0.1 10:58:36 INFO - mozdevice == 0.48 10:58:36 INFO - mozfile == 1.2 10:58:36 INFO - mozhttpd == 0.7 10:58:36 INFO - mozinfo == 0.9 10:58:36 INFO - mozleak == 0.1 10:58:36 INFO - mozlog == 3.1 10:58:36 INFO - moznetwork == 0.27 10:58:36 INFO - mozprocess == 0.22 10:58:36 INFO - mozprofile == 0.28 10:58:36 INFO - mozrunner == 6.11 10:58:36 INFO - mozscreenshot == 0.1 10:58:36 INFO - mozsystemmonitor == 0.0 10:58:36 INFO - moztest == 0.7 10:58:36 INFO - mozversion == 1.4 10:58:36 INFO - psutil == 3.1.1 10:58:36 INFO - requests == 1.2.3 10:58:36 INFO - wsgiref == 0.1.2 10:58:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:36 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 0x7f5756356f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2862410>, '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 0x2863310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28637a0>, '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': '41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:58:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:58:36 INFO - Using env: {'DISPLAY': ':0', 10:58:36 INFO - 'HOME': '/home/cltbld', 10:58:36 INFO - 'LANG': 'en_US.UTF-8', 10:58:36 INFO - 'LANGUAGE': 'en_US:en', 10:58:36 INFO - 'LOGNAME': 'cltbld', 10:58:36 INFO - 'MAIL': '/var/mail/cltbld', 10:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:36 INFO - 'MOZ_NO_REMOTE': '1', 10:58:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:36 INFO - 'NO_EM_RESTART': '1', 10:58:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:36 INFO - 'PWD': '/builds/slave/test', 10:58:36 INFO - 'SHELL': '/bin/bash', 10:58:36 INFO - 'SHLVL': '1', 10:58:36 INFO - 'TERM': 'linux', 10:58:36 INFO - 'TMOUT': '86400', 10:58:36 INFO - 'USER': 'cltbld', 10:58:36 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414', 10:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:36 INFO - '_': '/tools/buildbot/bin/python'} 10:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:58:37 INFO - Cleaning up... 10:58:37 INFO - Return code: 0 10:58:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:37 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 0x7f5756356f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2862410>, '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 0x2863310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28637a0>, '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': '41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:58:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:58:37 INFO - Using env: {'DISPLAY': ':0', 10:58:37 INFO - 'HOME': '/home/cltbld', 10:58:37 INFO - 'LANG': 'en_US.UTF-8', 10:58:37 INFO - 'LANGUAGE': 'en_US:en', 10:58:37 INFO - 'LOGNAME': 'cltbld', 10:58:37 INFO - 'MAIL': '/var/mail/cltbld', 10:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:37 INFO - 'MOZ_NO_REMOTE': '1', 10:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:37 INFO - 'NO_EM_RESTART': '1', 10:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:37 INFO - 'PWD': '/builds/slave/test', 10:58:37 INFO - 'SHELL': '/bin/bash', 10:58:37 INFO - 'SHLVL': '1', 10:58:37 INFO - 'TERM': 'linux', 10:58:37 INFO - 'TMOUT': '86400', 10:58:37 INFO - 'USER': 'cltbld', 10:58:37 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414', 10:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:37 INFO - '_': '/tools/buildbot/bin/python'} 10:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:37 INFO - Downloading/unpacking jsonschema 10:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:58:39 INFO - Downloading/unpacking functools32 (from jsonschema) 10:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:39 INFO - Downloading functools32-3.2.3-2.tar.gz 10:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:58:39 INFO - warning: no files found matching '*.txt' 10:58:39 INFO - no previously-included directories found matching 'build' 10:58:39 INFO - no previously-included directories found matching 'dist' 10:58:39 INFO - no previously-included directories found matching '.git*' 10:58:39 INFO - Installing collected packages: jsonschema, functools32 10:58:39 INFO - Running setup.py install for functools32 10:58:39 INFO - warning: no files found matching '*.txt' 10:58:39 INFO - no previously-included directories found matching 'build' 10:58:39 INFO - no previously-included directories found matching 'dist' 10:58:39 INFO - no previously-included directories found matching '.git*' 10:58:39 INFO - Successfully installed jsonschema functools32 10:58:39 INFO - Cleaning up... 10:58:39 INFO - Return code: 0 10:58:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:58: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')]} 10:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58: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')]} 10:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5756356f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d35a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2862410>, '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 0x2863310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28637a0>, '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': '41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:58:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:58:39 INFO - Using env: {'DISPLAY': ':0', 10:58:39 INFO - 'HOME': '/home/cltbld', 10:58:39 INFO - 'LANG': 'en_US.UTF-8', 10:58:39 INFO - 'LANGUAGE': 'en_US:en', 10:58:39 INFO - 'LOGNAME': 'cltbld', 10:58:39 INFO - 'MAIL': '/var/mail/cltbld', 10:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:39 INFO - 'MOZ_NO_REMOTE': '1', 10:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:39 INFO - 'NO_EM_RESTART': '1', 10:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:39 INFO - 'PWD': '/builds/slave/test', 10:58:39 INFO - 'SHELL': '/bin/bash', 10:58:39 INFO - 'SHLVL': '1', 10:58:39 INFO - 'TERM': 'linux', 10:58:39 INFO - 'TMOUT': '86400', 10:58:39 INFO - 'USER': 'cltbld', 10:58:39 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414', 10:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:39 INFO - '_': '/tools/buildbot/bin/python'} 10:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:39 INFO - Downloading/unpacking flake8 10:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:58:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:58:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:58:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:58:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:58:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:58:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:58:42 INFO - no previously-included directories found matching 'docs/_build' 10:58:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:58:42 INFO - Running setup.py install for pep8 10:58:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:58:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:58:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:58:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:58:42 INFO - no previously-included directories found matching 'docs/_build' 10:58:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:58:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:58:42 INFO - Cleaning up... 10:58:42 INFO - Return code: 0 10:58:42 INFO - Running post-action listener: _resource_record_post_action 10:58:42 INFO - Running post-action listener: _start_resource_monitoring 10:58:42 INFO - Starting resource monitoring. 10:58:42 INFO - ##### 10:58:42 INFO - ##### Running install step. 10:58:42 INFO - ##### 10:58:42 INFO - Running pre-action listener: _resource_record_pre_action 10:58:42 INFO - Running main action method: install 10:58:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:58:42 INFO - Reading from file tmpfile_stdout 10:58:42 INFO - Detecting whether we're running mozinstall >=1.0... 10:58:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:58:43 INFO - Reading from file tmpfile_stdout 10:58:43 INFO - Output received: 10:58:43 INFO - Usage: mozinstall [options] installer 10:58:43 INFO - Options: 10:58:43 INFO - -h, --help show this help message and exit 10:58:43 INFO - -d DEST, --destination=DEST 10:58:43 INFO - Directory to install application into. [default: 10:58:43 INFO - "/builds/slave/test"] 10:58:43 INFO - --app=APP Application being installed. [default: firefox] 10:58:43 INFO - mkdir: /builds/slave/test/build/application 10:58:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:58:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:58:56 INFO - Reading from file tmpfile_stdout 10:58:56 INFO - Output received: 10:58:56 INFO - /builds/slave/test/build/application/firefox/firefox 10:58:56 INFO - Running post-action listener: _resource_record_post_action 10:58:56 INFO - ##### 10:58:56 INFO - ##### Running run-tests step. 10:58:56 INFO - ##### 10:58:56 INFO - Running pre-action listener: _resource_record_pre_action 10:58:56 INFO - Running main action method: run_tests 10:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:58:56 INFO - Python 2.7.3 10:58:56 INFO - Return code: 0 10:58:56 INFO - grabbing minidump binary from tooltool 10:58: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')]} 10:58:56 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 0x2862410>, '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 0x2863310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28637a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:58:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:58:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:58:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:58:56 INFO - Return code: 0 10:58:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:58:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:58:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:58:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:58:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:58:57 INFO - Return code: 0 10:58:57 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/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 10:58:57 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/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 10:58:57 INFO - Using env: {'DISPLAY': ':0', 10:58:57 INFO - 'HOME': '/home/cltbld', 10:58:57 INFO - 'LANG': 'en_US.UTF-8', 10:58:57 INFO - 'LANGUAGE': 'en_US:en', 10:58:57 INFO - 'LOGNAME': 'cltbld', 10:58:57 INFO - 'MAIL': '/var/mail/cltbld', 10:58:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:58:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:57 INFO - 'MOZ_NO_REMOTE': '1', 10:58:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:57 INFO - 'NO_EM_RESTART': '1', 10:58:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:57 INFO - 'PWD': '/builds/slave/test', 10:58:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:58:57 INFO - 'SHELL': '/bin/bash', 10:58:57 INFO - 'SHLVL': '1', 10:58:57 INFO - 'TERM': 'linux', 10:58:57 INFO - 'TMOUT': '86400', 10:58:57 INFO - 'USER': 'cltbld', 10:58:57 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414', 10:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:57 INFO - '_': '/tools/buildbot/bin/python'} 10:58:57 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/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 10:58:57 INFO - mozversion application_buildid: 20160705080222 10:58:57 INFO - mozversion application_changeset: 4e1aa4b6f7b4de6e4b7f34b016c3e1d8505dcd1f 10:58:57 INFO - mozversion application_display_name: Firefox 10:58:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:58:57 INFO - mozversion application_name: Firefox 10:58:57 INFO - mozversion application_remotingname: firefox 10:58:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:58:57 INFO - mozversion application_vendor: Mozilla 10:58:57 INFO - mozversion application_version: 48.0 10:58:57 INFO - mozversion platform_buildid: 20160705080222 10:58:57 INFO - mozversion platform_changeset: 4e1aa4b6f7b4de6e4b7f34b016c3e1d8505dcd1f 10:58:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:58:57 INFO - mozversion platform_version: 48.0 10:58:57 INFO - using testdate: 1467741537 10:58:57 INFO - actual date: 1467741537 10:58:57 INFO - starting webserver on 'localhost:50802' 10:58:57 INFO - SUITE-START | Running 2 tests 10:58:57 INFO - TEST-START | dromaeo_css 10:58:57 INFO - operating with platform_type : linux_ 10:58:57 INFO - Initialising browser for dromaeo_css test... 10:58:57 INFO - TEST-INFO | started process 10175 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNVisoN/profile http://localhost:50802/getInfo.html) 10:59:01 INFO - PROCESS | 10175 | 10:59:01 INFO - PROCESS | 10175 | (process:10251): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:59:01 INFO - PROCESS | 10175 | __metrics Screen width/height:1600/1200 10:59:01 INFO - PROCESS | 10175 | colorDepth:24 10:59:01 INFO - PROCESS | 10175 | Browser inner width/height: 1024/697 10:59:01 INFO - PROCESS | 10175 | __metrics 10:59:02 ERROR - PROCESS | 10175 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:59:03 INFO - TEST-INFO | 10175: exit 0 10:59:03 INFO - Browser initialized. 10:59:03 INFO - Running cycle 1/1 for dromaeo_css test... 10:59:03 INFO - TEST-INFO | started process 10301 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNVisoN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:59:05 INFO - PROCESS | 10301 | 10:59:05 INFO - PROCESS | 10301 | (process:10368): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:59:15 INFO - PROCESS | 10301 | RSS: Main: 150806528 10:59:15 INFO - PROCESS | 10301 | 11:00:04 INFO - PROCESS | 10301 | 1467741604604 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] 11:02:11 INFO - PROCESS | 10301 | Cycle 1(1): loaded http://localhost:50802/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50802/tests/dromaeo/cssquery-ext.html) 11:02:12 INFO - PROCESS | 10301 | RSS: Main: 155729920 11:02:12 INFO - PROCESS | 10301 | 11:05:14 INFO - PROCESS | 10301 | Cycle 1(1): loaded http://localhost:50802/tests/dromaeo/cssquery-ext.html (next: http://localhost:50802/tests/dromaeo/cssquery-jquery.html) 11:05:15 INFO - PROCESS | 10301 | RSS: Main: 152653824 11:05:15 INFO - PROCESS | 10301 | 11:08:17 INFO - PROCESS | 10301 | Cycle 1(1): loaded http://localhost:50802/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50802/tests/dromaeo/cssquery-mootools.html) 11:08:17 INFO - PROCESS | 10301 | RSS: Main: 152363008 11:08:17 INFO - PROCESS | 10301 | 11:11:19 INFO - PROCESS | 10301 | Cycle 1(1): loaded http://localhost:50802/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50802/tests/dromaeo/cssquery-prototype.html) 11:11:19 INFO - PROCESS | 10301 | RSS: Main: 153989120 11:11:19 INFO - PROCESS | 10301 | 11:14:22 INFO - PROCESS | 10301 | Cycle 1(1): loaded http://localhost:50802/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50802/tests/dromaeo/cssquery-yui.html) 11:14:22 INFO - PROCESS | 10301 | RSS: Main: 152461312 11:14:22 INFO - PROCESS | 10301 | 11:17:24 INFO - PROCESS | 10301 | Cycle 1(1): loaded http://localhost:50802/tests/dromaeo/cssquery-yui.html (next: http://localhost:50802/tests/dromaeo/cssquery-dojo.html) 11:17:25 INFO - PROCESS | 10301 | RSS: Main: 156282880 11:17:25 INFO - PROCESS | 10301 | 11:17:25 INFO - PROCESS | 10301 | __start_tp_report 11:17:25 INFO - PROCESS | 10301 | _x_x_mozilla_page_load 11:17:25 INFO - PROCESS | 10301 | _x_x_mozilla_page_load_details 11:17:25 INFO - PROCESS | 10301 | |i|pagename|runs| 11:17:25 INFO - PROCESS | 10301 | |0;dojo.html;3312.420326442872;3372.645872183419;3404.625491195968;3419.1964888251255;3419.350323438548;5500.339959204896;5515.889682206363;5522.061249587569;5549.500544950959;5562.916556251659;5501.0648189807725;5527.198556209357;5532.723363831812;5544.445555444454;5552.611317207797;4979.278004689318;4980.999999999991;5036.471170527097;5038.5969122470115;5052.6210534209895;4858.125537403266;4924.285978533128;5065.594752419797;5099.107656160176;5147.510986456281;5006.299118123447;5041.243813427996;5096.184610462326;5119.846404607849;5124.154514505102;4952.5542701157065;4973.452920178777;5011.699298042093;5020.874478138057;5038.067957427887;4713;4940.98709764501;4945.505449455061;4988.451270360294;4991.950080499185;5412.621116521845;5492.780288788484;5513.724313784335;5558.027345214571;5590.944090559083;6018.608790428608;6028.7588496460085;6046.969765151146;6058.878822423571;6071.119687645267;5895.55783316253;5981.342052374235;6092.878142437126;6118.174046503709;6138.785142520035;5545.9185458835545;5562.9443705563235;5563.638363506399;5573.219749235111;5599.188117722948;6027.879442411215;6028.336882942873;6028.4272994065495;6028.879422411527;6034.758609655652;5697.259356283739;5760.53915686744;5791.3339965903615;5799.159121927297;5818.069108942549;5978.073398623221;5981.312149102909;5982.341942386334;5985.191999080155;5995.160677505153;5886.499647530008;5927;5942.821715348547;5943.405659434022;5952.839196356756;5781.219535362672;5840.182374467578;5873.735681894325;5940.405959404025;5973.820785376446;4566;4567.063751930913;4569.97175635486;4574.679772415899;4600.033992861469;4086.836526538905;4106.7125301229225;4114.794260286973;4119.649829764444;4132.710710250253;5706.201131841545;5743.655380677173;5744.770209191669;5747.885042299131;5784.363719990798;5908.084246941731;5973.402659733992;6025.186599809057;6028.819135425944;6030.18592490017;5579.804706835323;5714.399988001283;5749.568782341341;5753.683547404933;5762.135679648002;4973.428055773632;5006.774695138654;5008.84973450797;5020.221865610836;5051.2423136529815;6189.659568723763;6196.597221180609;6203.96898015507;6219.751209951642;6222.564420490613;5941.22764040672;5953.553483488669;5963.7912673056235;5972.970135149297;5984.461398474071;6137.478314343152;6242.344553821783;6335.3981371769605;6364;6385.840353991188;5968.343482217039;5969.3732158122775;5994.133147715443;6003.519718422603;6003.609765365237;5868.823935281948;6101.816945491642;6111.84720381994;6114.0828875669;6120.08198770188;5845.18167456565;5892.558058145571;5917.497012753965;5925.259342582177;5954.166416701752;5757.510611597893;5775.393583673822;5776.162456443708;5800.01399762033;5815.069588865761;5586.385497595343;5671.914921276267;5720.856978575569;5722.942770572241;5726.828195154152;5904.911426328695;5908.113782932594;5921.111833225051;5943.405659434022;5959.76160953557;5786.884262314814;5787.479126878601;5788.247527821356;5795.710214489343;5805.187273781758 11:17:25 INFO - PROCESS | 10301 | |1;ext.html;671.3856821008777;683.0676127086526;701.4178232067385;730.7698075106345;743.3310020981116;38004;39058.60941390589;39078.80460597693;39081.218375632474;39328.803355983255;41869.79065104678;42739.57260427395;42747.57252427482;42776.57223427765;42854;8767.693130740441;9017.59420826061;9017.684381046665;9031.23234525066;9039.502827344493;8851.203391694746;8952.328575356874;8968.686095986643;9155.359124861263;9162.541872906362;9188.1730644242;9228.8615670765;9236.907630923706;9244.8613270801;9246.76883077925;9103.49930753805;9105.226055785266;9109.99790023097;9113.225375843062;9164.679236226733;8951;9078.046805085436;9089.454632721992;9101;9166.724998249996;42058.57941420577;42731;42802.35796463056;42809;42953.57046429527;3766.303233901737;3782.0544863784053;3845.057960799594;4029.576894426072;4424.535423780521;32433.351332973445;32497.6750232497;32720;33121.668783312096;34442.31115377704;4554.2485489894125;4603.447586289667;4605.861824145248;4609.354690343354;4652.232381657022;232327;232687;232986;234049;234492;39374.40938385927;60706;61063.694681527195;61517;61565;37198.44202336967;37285.62714372821;37285.81357093197;37380.81309593435;37400.43899341512;17046.14769261532;17317;17321.30714771395;17411.65176696459;17434.47696569105;13342.466301348031;13375.264360460074;13414.865851341558;13444.798328025088;13483.865161348262;9173.082691730773;9184.8622270666;9318.95340523293;9422.104900034486;9440.867095948393;3631.382664946965;3667.4132138857653;3709.295233905549;3759.191773768653;3780.092777733324;1109.2457129152253;1116.1182665694173;1127.7406196574834;1174.8179032250016;1187.6733898177897;31869;32615.51076733851;33671.66328336734;35753.28493430117;35774;1241.267652085274;1259.5213818748816;1266.5756971414496;1281.8461784585909;1305.8694130586866;15960;16016.279267432994;16293.266802993894;16295;16604.169791510376;462093;525261;569506;571758;576441;55181.72409138009;55685.721571391885;55710.44289557134;55745.721271393384;56007.71996139993;1508.720886635954;1524.8651887357787;1529.1818876900804;1532.417681281106;1548.4735190035442;31974.840125799223;32615.347693046482;32917.17707057343;33039;33131.83434082814;51953.22070168875;52155;52691.20963185632;52724;52733.7363313181;405773;410750;410981;413288;416261;30329.848350758988;30486.23784405319;30915.0725478236;30935.0719478416;31137;46507;46814.29778553393;47493.76253118712;47670.523294768;47874.281885771044;40522.59477405188;41148.1770364597;43208.56791432171;46334.073318534116;47473.050538989715;39809.2038159241;40486.1902761949;40745.29829368539;40776.3883541753;41012.384814228404;40766.79616601898;41096.589034110475;41336.58663413327;41359;41744;33388.8313909012;33645.327093457505;33738.662613373555;33978;34011;28281.292967675974;28829.423411532072;28861.134165975054;28896.7110328894;28924.276893077 11:17:25 INFO - PROCESS | 10301 | |2;jquery.html;411.25283108832986;412.2970335577839;413.37993010484274;421.890308519785;422.61964232191036;17198.39805606804;18701.34545290915;19151.90424047878;19288.710669339955;20036.499087522818;12347.506099756021;12685.61943141705;12688.873111268907;14796.6300842479;18894.527636809085;5099.566536844372;5278.762455689503;5296.602754793386;5308.442613525582;5334.386545547253;5241.790328386879;5327.547158491533;5538.47384498472;5829.9708501457435;5848.239728835246;5690.800821971232;5796.9275683998385;5801.767929282823;5818.767249310023;5832.795852145176;5902.291724992985;5919.023361145406;5932.792352267671;5938.703064846741;5952;5844.064949608042;5867.090600956859;5870.530357571384;5874.118882167666;5895.115732640095;21156;22143.224987125373;22243.22148724803;22741.772582274298;22813.201537946094;2290.404494831339;2443.6945381827272;2460.778529932297;2507.962380564293;2964.377480729028;13942.581722548239;14181.716365672732;14382.35279412429;14426.278686065654;14597;1948.4836518322657;2040.5714799892041;2050.5181282398626;2092.194505115526;2120.416885356524;73493.63253183699;80115;80789;82759.9999999994;84844;11387.37369444672;11396.886031139748;11467.369294688871;11817.88182118185;11834.408279586158;16082.839171608368;16222.675546489005;16284.26720797567;16364.754528682079;16466.341346346013;8664.523451210243;8875.023747387782;8888.511131887679;8936.8659470108;8973.910260897437;8657;8755.124487551195;8831.64673413069;8917.464952102895;9085.36402451822;5010.649254552146;5023.271625614266;5037.496250374933;5043.420006699276;5046.545810876965;2067.8759274443582;2072.7927207279154;2097.8741275523516;2131;2141.100737690174;980.3333733061444;1039.4335087377397;1065.728239298974;1074.897884700952;1195.970100747471;19305.51736206578;19356.4193074208;19783;19913.701294480594;20064.297749578694;1108.9057430118369;1141.8287256911365;1151.2574389518713;1175.5415387998687;1197.9161458697808;10733.248672592843;10826.133909287239;11025.503852326665;11082.556697732161;11166.497507612014;507235;509486;513865.72268554417;514248;517566;84624.57687711646;89004.10995889959;89178.55410723035;94963;97258;1089.3953855610055;1120.887911208889;1160.512584714422;1165.3590525211268;1166.4634268236537;16885.746713799548;17041.91479042597;17163;17171.055591942564;17264.482065538054;27081.59377609298;37455.2508949814;37789.244215116094;38208.235835283696;40376.79811600923;59740.402595975225;60106.69946650239;60107.699461502416;60218.69890650519;60532.6973365148;8605.483670979762;8891.688790892287;9018.549072546477;9099.226565741987;9104.908950910407;12419.130660854014;12802.60730906292;13180.604581862559;13235.933820330836;13771.242581657703;11702.414879255834;11780.469878855301;11993.34036627959;12170.330631815335;12282.815757763461;11291.266067705574;11432.971032607105;11662.88337116652;11687.707807304885;11798.587049453228;11949;11963.162578619413;12012;12140.575079872162;12502;8978.910210898068;9022.097790220925;9122.498262595622;9215.617657351451;9249.86125208109;8940.329475289509;11941.343226122299;11975.101867359808;12026.458809353426;12154.270743755404 11:17:25 INFO - PROCESS | 10301 | |3;mootools.html;1540.1067380919064;1559.945401910933;1744.1976690722267;1827.3421568235442;1873.0541076756235;7131.037309963153;7771.844563108734;7838.333741631961;7847.803804904866;7889;7975.7607271781935;8064.71773487928;8073.757787266377;8110.310623596986;8178.386621003434;2090.247510896076;2116.597846409185;2122.840786940978;2131.5417185305155;2134.551744133734;2177.477405422695;2184.3665337052234;2283.22370394066;2288.6910267113976;2292.621717416624;2238.563480121377;2253.616885129532;2274.9545009099807;2285.3600991722346;2288.107638021173;2171.880546569938;2207.2054060538194;2221.4779526811267;2228.2758103616306;2234.4190510467397;2258.435391152212;2269.5687819314444;2270.182734215681;2273.999440246286;2283.9771602284095;8021.478603890729;8037.397195210383;8100.878486822702;8103.878441823377;8121.634526446324;4871.683340582851;4949.82675606352;4965.255211718271;4982.850514484571;4992.276119962585;3129.4523458394688;3199.936001279961;3315.419801534746;3324.335132973391;3339.5825521809775;1205.6142034548948;1206.4563331491781;1208.7945049341633;1230.028277660647;1237.616338934933;11253.381064041474;11302.095832333394;11305.830412543819;11329.773404531945;11333.26333788301;3955.4462375267485;4034.919301613951;4063.146739184745;4064.8577299794956;4067.9796601016806;9175.954120229357;9242.630294788134;9266.07339266068;9266.536673166314;9268.165865072177;4850.272459131159;4859.757012149378;4875.293082503017;4876.122297986397;4892.143874821892;4094.549599544048;4485.439320084989;4537.160625284333;4545.38637283969;4573.771311434415;3713.7586056906216;3726.832292546788;3809.695224382043;3811.637894400083;3836.5204349456317;1128.114430172311;1169.6666450061691;1174.3717111345388;1184.1237484261756;1186.5194596188558;939.6006697153819;1048.7797562511957;1061.766411389493;1068.0974576482859;1070.2240875365299;5674.729423986436;5834.3290521589715;5873.3874582856515;5935.821925342247;5945.048792193228;437.2522985694498;444.2647418522351;451.3748458385095;451.51462178158613;455.45573040217283;4024.75851448914;4054.878353649395;4064.5935406459707;4087.8364865405647;4111.773852438145;9856.211503079736;10105.494725263707;10136.695899123039;10210.846837297446;10251.179905607534;10001;10018;10023.448710320856;10029.047240512285;10033.247506437046;7418.740344087931;7603.9619801900635;7632.847343053108;7706.807329816799;7751.108622508371;5698.629589076697;5742.483176514133;5801.883962320646;5807;5861.912071319019;8993.055729148346;9026.503542305236;9084.364094513321;9128.589213485277;9154.450732956044;9293.581788819654;9389.718308450485;9416.76458088526;9418.10527999839;9428.481433521221;6216.968915155395;6938.826529336807;7028.929710702828;7171.820704482429;7274.16347120088;7885;7944;7951.642176101974;7963.960180199062;7992.16082311349;7009.684564194521;7085.433165346863;7155.356017958408;7185.712571497082;7332.743353982585;7101.254368291255;7165;7183.5330703504105;7184.209736928829;7288.927110728825;6482;6628.90056649141;6669.299723529154;6680.899786503109;6693.866122677617;4982.526659967298;5064.44291127983;5112.769925353294;5120.897582048413;5142.485751424828;5106.617003724661;5126.231065340229;5177.404598471224;5297.947020529746;5302.1781623848365 11:17:25 INFO - PROCESS | 10301 | |4;prototype.html;335.9391403278335;338.77132935268696;341.73344791062965;343.1130527586188;344.86722611794454;6289.899267628158;6391.392817682313;6487.837804054895;6502.642354670497;6561.245456772473;6417.935820641792;6440.806775796734;6465.418112369885;6473.611583305005;6486.351364863512;4854.975725121379;4862.319275301443;4864.075825593126;4864.294677271793;4872.878178045559;4867.732274724889;4872.561469467747;4877.487863774306;4879.048585525824;4889.804407823701;4841.467438581753;4845.127876982142;4845.466998630148;4845.685030473026;4852.393450818648;4646.883827904296;4837.806487740486;4837.903241935159;4841.225403935371;4843.055604157191;4116.91766164678;4144.5233798113;4144.52337981133;4150.27370210215;4154.231467178582;6136.509079273647;6141.385861413867;6161.6303021818385;6178.814635560941;6207.968960155215;5648.039833228361;5653.038983372795;5655.802046928337;5664.178694089334;5665.433456654343;6790.932090679129;6832.282610325944;6852.794416167523;6858.074159988388;6859.039734437133;4632.305154226893;4659.930101048487;4666.9766651166865;4675.789589468448;4678.415198100238;6886.758963436256;7131.71473141079;7141.500094993353;7159.928400715979;7181.102362204724;4675.953240467552;4731.384919960383;4735.644826638016;4737.45519265282;4738.19450693383;4796.760161991887;4800;4802.567768900815;4811.037792441456;4815.807367705253;5636.154576813511;5636.661800291996;5640.32316122068;5642.6614403135945;5642.7178641067785;6678.465722742169;6909.1018167637885;6910.239873613898;6920.342567456084;6921.342472465108;1651.5128037229047;1661.8338166183528;1675.1121905390162;1677.0943690407287;1680.7226807576612;1075.166745772033;1086.163653986426;1101.4823033174396;1107.2581370481796;1110.5224753356135;6596.967015164893;6776.322367763184;6790.694418751069;6793.796186114425;6813.216480104752;7168.175659799085;7169.89245161323;7178.389836863925;7186.353228209487;7189.2810718927685;6722.865542689216;6777.1189745332795;6784.389404953479;6786.59280443175;6790.151231096113;3819.751716138442;3872.6320999505;3876.205377897524;3879.7090218233743;3881.2819628368843;7401.666924988388;7478.401727861758;7558.470907036454;7564.773056808304;7574.697012119564;7233.493655444174;7287.161976372785;7288.744893928687;7311.232320606367;7320.853582928312;7496.325330720152;7513.586752728653;7555.357794587411;7556.58438785872;7559.3196612305155;6973.965130174317;7126.180489243596;7126.429885609035;7140.178879428932;7168.4265258780215;7017.684204210925;7024.332688394595;7025.824354391181;7033.402160816183;7042.471814613822;7479.962600187182;7481.66332515049;7494.362979146834;7518.28576285252;7576.886346704694;4721.197396442682;4745.928811067905;4746.264329029006;4750.097481478508;4762.14281429346;7118.85762284741;7147.785566433015;7148.821279468055;7151;7152.856942861218;6667.899981500378;6924.169099708067;6927.134108236471;6936.618485983319;6941.236463989058;6897.2757860423935;6905.102336696398;6914.688839002358;6930.549514281555;6942.409895158766;6800.047993281044;6807.489438292049;6811.489138314745;6826.965865170642;6828.897566536407;6771.729130834711;6947.40947019509;6958.304169583002;6966.059581956371;6972.825679358057;6631.535792494672;6796.966015169893;6802.537454447318;6810.250872404131;6837.829054273683 11:17:25 INFO - PROCESS | 10301 | |5;yui.html;766.8236305649697;798.536848627796;915.5330781301536;915.9954200229;945.7966537194502;15145.242737863118;15331;15360.692786144271;15397.615059623515;15458.613534661625;14279;15586.532404027897;16049.83950160498;16108.838911610881;16178.029318240913;741.9146798118204;898.4743924803981;906.1301150895149;909.6634245329204;909.8635204719279;896.6458248991645;907.4645958884257;908.1055160666738;909.236241557092;911.4804561400005;921.617528725578;932.4871320773582;935.4574346878828;935.873657056299;937.4890684576887;920.4983284110176;921.8985911549757;929.525941769699;930.1303281431883;931.3061768982084;679.4021261290034;680.0649107477219;681.3016657925616;681.6182937554936;684.637142314574;13433.261170635611;13439.395227214702;13483.258420786853;13491.595252142451;13530.661733456644;14351.067180633225;14359.210243436606;14434.20611866347;14543;14616.123032618078;12236.388180590935;12340.62978110649;12363.567275145328;12401.751964960651;12721.363931803466;4015.217032678629;4062.3906414037833;4084.326086195774;4123.381492776078;4237.258479766028;56819.14771278434;56840.43159568434;57057.429425705624;57463.13805292966;58142;11506.884931150582;11621.360825154528;11716.355600442057;11812.70468238301;11868.287902725864;20869.68695469569;21039.474013149487;21111.26110586122;21148;21299;8928.910710892938;9019;9088.591013404413;9230.907690923139;9293.117153870371;4797.856064318076;4831.371921650163;4880.072786170616;4911.607071434277;4998.975005124951;3522.6653467920505;3578.6779189873037;3591.06632275605;3598.4062629666337;3599.190182208982;625.2778041362234;644.5005121031238;644.9193850768654;644.9709763060673;666.976655817044;792.647271963982;805.7421625080035;816.2898278497745;818.0265484073933;843.3632607381388;9720.31957762964;9797.461139637388;9929.553170107363;10029;10032.197424206046;684.2849222562335;709.4076446167405;737.6311844077961;843.7595285343771;852.2159613155911;4493.573110554492;4761.500042495488;4795.160846851857;4875.609951203966;4905.166121759309;60863.351771625334;61375.386246136964;62079.379206208265;62278;62317.065244021374;54261.1860822088;54517.182242265604;54879.725601371734;56755.71622141863;56802.71598642063;49585.50414495881;50609.24086138711;50668.746656266485;50881.74559127255;51361.229581556305;9208.539573021188;9283.535823208947;9355.298352623717;9413.199878010446;9495.987541042006;35307.82346088253;35924;36400.63599363973;36532;36897;42534;43347.34978975381;46812.7659361701;47241.76379118083;47299.76350118227;11712;11869.406529673655;11896;12044.51821927113;12058.638240852788;13088.149270297401;13104;13140.868591313965;13284.070115092238;13285.269310188032;11817.881821182022;12019.399030048637;12403.379831008233;12527.93736031314;12620.242785432903;11999.520019199133;12405.44175512086;12419.316937568521;12442.626721198378;12549.121561490972;12425.751484970431;12427.89433992407;12577.559785407468;12649.87350126487;12896.355182241037;10473.162147028372;10559.419231942316;10592.311499752492;10646.254762166574;10723.03492685662;10356.275060745675;10454.947725261629;10478.37129772216;10487.475626218811;10659.786804264026 11:17:25 INFO - PROCESS | 10301 | __end_tp_report 11:17:25 INFO - PROCESS | 10301 | __start_cc_report 11:17:25 INFO - PROCESS | 10301 | _x_x_mozilla_cycle_collect,341 11:17:25 INFO - PROCESS | 10301 | __end_cc_report 11:17:25 INFO - PROCESS | 10301 | __startTimestamp1467742645108__endTimestamp 11:17:25 INFO - PROCESS | 10301 | 11:17:25 INFO - PROCESS | 10301 | ------- Summary: start ------- 11:17:25 INFO - PROCESS | 10301 | Number of tests: 6 11:17:25 INFO - PROCESS | 10301 | 11:17:25 INFO - PROCESS | 10301 | [#0] dojo.html Cycles:165 Average:5545.79 Median:5775.39 stddev:630.86 (10.9%) stddev-sans-first:607.98 11:17:25 INFO - PROCESS | 10301 | Values: 3312.4 3372.6 3404.6 3419.2 3419.4 5500.3 5515.9 5522.1 5549.5 5562.9 5501.1 5527.2 5532.7 5544.4 5552.6 4979.3 4981.0 5036.5 5038.6 5052.6 4858.1 4924.3 5065.6 5099.1 5147.5 5006.3 5041.2 5096.2 5119.8 5124.2 4952.6 4973.5 5011.7 5020.9 5038.1 4713.0 4941.0 4945.5 4988.5 4992.0 5412.6 5492.8 5513.7 5558.0 5590.9 6018.6 6028.8 6047.0 6058.9 6071.1 5895.6 5981.3 6092.9 6118.2 6138.8 5545.9 5562.9 5563.6 5573.2 5599.2 6027.9 6028.3 6028.4 6028.9 6034.8 5697.3 5760.5 5791.3 5799.2 5818.1 5978.1 5981.3 5982.3 5985.2 5995.2 5886.5 5927.0 5942.8 5943.4 5952.8 5781.2 5840.2 5873.7 5940.4 5973.8 4566.0 4567.1 4570.0 4574.7 4600.0 4086.8 4106.7 4114.8 4119.6 4132.7 5706.2 5743.7 5744.8 5747.9 5784.4 5908.1 5973.4 6025.2 6028.8 6030.2 5579.8 5714.4 5749.6 5753.7 5762.1 4973.4 5006.8 5008.8 5020.2 5051.2 6189.7 6196.6 6204.0 6219.8 6222.6 5941.2 5953.6 5963.8 5973.0 5984.5 6137.5 6242.3 6335.4 6364.0 6385.8 5968.3 5969.4 5994.1 6003.5 6003.6 5868.8 6101.8 6111.8 6114.1 6120.1 5845.2 5892.6 5917.5 5925.3 5954.2 5757.5 5775.4 5776.2 5800.0 5815.1 5586.4 5671.9 5720.9 5722.9 5726.8 5904.9 5908.1 5921.1 5943.4 5959.8 5786.9 5787.5 5788.2 5795.7 5805.2 11:17:25 INFO - PROCESS | 10301 | 11:17:25 INFO - PROCESS | 10301 | [#1] ext.html Cycles:180 Average:55461.57 Median:40771.59 stddev:110647.34 (271.4%) stddev-sans-first:110881.26 11:17:25 INFO - PROCESS | 10301 | Values: 671.4 683.1 701.4 730.8 743.3 38004.0 39058.6 39078.8 39081.2 39328.8 41869.8 42739.6 42747.6 42776.6 42854.0 8767.7 9017.6 9017.7 9031.2 9039.5 8851.2 8952.3 8968.7 9155.4 9162.5 9188.2 9228.9 9236.9 9244.9 9246.8 9103.5 9105.2 9110.0 9113.2 9164.7 8951.0 9078.0 9089.5 9101.0 9166.7 42058.6 42731.0 42802.4 42809.0 42953.6 3766.3 3782.1 3845.1 4029.6 4424.5 32433.4 32497.7 32720.0 33121.7 34442.3 4554.2 4603.4 4605.9 4609.4 4652.2 232327.0 232687.0 232986.0 234049.0 234492.0 39374.4 60706.0 61063.7 61517.0 61565.0 37198.4 37285.6 37285.8 37380.8 37400.4 17046.1 17317.0 17321.3 17411.7 17434.5 13342.5 13375.3 13414.9 13444.8 13483.9 9173.1 9184.9 9319.0 9422.1 9440.9 3631.4 3667.4 3709.3 3759.2 3780.1 1109.2 1116.1 1127.7 1174.8 1187.7 31869.0 32615.5 33671.7 35753.3 35774.0 1241.3 1259.5 1266.6 1281.8 1305.9 15960.0 16016.3 16293.3 16295.0 16604.2 462093.0 525261.0 569506.0 571758.0 576441.0 55181.7 55685.7 55710.4 55745.7 56007.7 1508.7 1524.9 1529.2 1532.4 1548.5 31974.8 32615.3 32917.2 33039.0 33131.8 51953.2 52155.0 52691.2 52724.0 52733.7 405773.0 410750.0 410981.0 413288.0 416261.0 30329.8 30486.2 30915.1 30935.1 31137.0 46507.0 46814.3 47493.8 47670.5 47874.3 40522.6 41148.2 43208.6 46334.1 47473.1 39809.2 40486.2 40745.3 40776.4 41012.4 40766.8 41096.6 41336.6 41359.0 41744.0 33388.8 33645.3 33738.7 33978.0 34011.0 28281.3 28829.4 28861.1 28896.7 28924.3 11:17:25 INFO - PROCESS | 10301 | 11:17:25 INFO - PROCESS | 10301 | [#2] jquery.html Cycles:180 Average:29593.51 Median:22492.50 stddev:84326.19 (374.9%) stddev-sans-first:84534.28 11:17:25 INFO - PROCESS | 10301 | Values: 411.3 412.3 413.4 421.9 422.6 17198.4 18701.3 19151.9 19288.7 20036.5 12347.5 12685.6 12688.9 14796.6 18894.5 5099.6 5278.8 5296.6 5308.4 5334.4 5241.8 5327.5 5538.5 5830.0 5848.2 5690.8 5796.9 5801.8 5818.8 5832.8 5902.3 5919.0 5932.8 5938.7 5952.0 5844.1 5867.1 5870.5 5874.1 5895.1 21156.0 22143.2 22243.2 22741.8 22813.2 2290.4 2443.7 2460.8 2508.0 2964.4 13942.6 14181.7 14382.4 14426.3 14597.0 1948.5 2040.6 2050.5 2092.2 2120.4 73493.6 80115.0 80789.0 82760.0 84844.0 11387.4 11396.9 11467.4 11817.9 11834.4 16082.8 16222.7 16284.3 16364.8 16466.3 8664.5 8875.0 8888.5 8936.9 8973.9 8657.0 8755.1 8831.6 8917.5 9085.4 5010.6 5023.3 5037.5 5043.4 5046.5 2067.9 2072.8 2097.9 2131.0 2141.1 980.3 1039.4 1065.7 1074.9 1196.0 19305.5 19356.4 19783.0 19913.7 20064.3 1108.9 1141.8 1151.3 1175.5 1197.9 10733.2 10826.1 11025.5 11082.6 11166.5 507235.0 509486.0 513865.7 514248.0 517566.0 84624.6 89004.1 89178.6 94963.0 97258.0 1089.4 1120.9 1160.5 1165.4 1166.5 16885.7 17041.9 17163.0 17171.1 17264.5 27081.6 37455.3 37789.2 38208.2 40376.8 59740.4 60106.7 60107.7 60218.7 60532.7 8605.5 8891.7 9018.5 9099.2 9104.9 12419.1 12802.6 13180.6 13235.9 13771.2 11702.4 11780.5 11993.3 12170.3 12282.8 11291.3 11433.0 11662.9 11687.7 11798.6 11949.0 11963.2 12012.0 12140.6 12502.0 8978.9 9022.1 9122.5 9215.6 9249.9 8940.3 11941.3 11975.1 12026.5 12154.3 11:17:25 INFO - PROCESS | 10301 | 11:17:25 INFO - PROCESS | 10301 | [#3] mootools.html Cycles:180 Average:5402.89 Median:4873.49 stddev:2989.41 (61.3%) stddev-sans-first:2983.70 11:17:25 INFO - PROCESS | 10301 | Values: 1540.1 1559.9 1744.2 1827.3 1873.1 7131.0 7771.8 7838.3 7847.8 7889.0 7975.8 8064.7 8073.8 8110.3 8178.4 2090.2 2116.6 2122.8 2131.5 2134.6 2177.5 2184.4 2283.2 2288.7 2292.6 2238.6 2253.6 2275.0 2285.4 2288.1 2171.9 2207.2 2221.5 2228.3 2234.4 2258.4 2269.6 2270.2 2274.0 2284.0 8021.5 8037.4 8100.9 8103.9 8121.6 4871.7 4949.8 4965.3 4982.9 4992.3 3129.5 3199.9 3315.4 3324.3 3339.6 1205.6 1206.5 1208.8 1230.0 1237.6 11253.4 11302.1 11305.8 11329.8 11333.3 3955.4 4034.9 4063.1 4064.9 4068.0 9176.0 9242.6 9266.1 9266.5 9268.2 4850.3 4859.8 4875.3 4876.1 4892.1 4094.5 4485.4 4537.2 4545.4 4573.8 3713.8 3726.8 3809.7 3811.6 3836.5 1128.1 1169.7 1174.4 1184.1 1186.5 939.6 1048.8 1061.8 1068.1 1070.2 5674.7 5834.3 5873.4 5935.8 5945.0 437.3 444.3 451.4 451.5 455.5 4024.8 4054.9 4064.6 4087.8 4111.8 9856.2 10105.5 10136.7 10210.8 10251.2 10001.0 10018.0 10023.4 10029.0 10033.2 7418.7 7604.0 7632.8 7706.8 7751.1 5698.6 5742.5 5801.9 5807.0 5861.9 8993.1 9026.5 9084.4 9128.6 9154.5 9293.6 9389.7 9416.8 9418.1 9428.5 6217.0 6938.8 7028.9 7171.8 7274.2 7885.0 7944.0 7951.6 7964.0 7992.2 7009.7 7085.4 7155.4 7185.7 7332.7 7101.3 7165.0 7183.5 7184.2 7288.9 6482.0 6628.9 6669.3 6680.9 6693.9 4982.5 5064.4 5112.8 5120.9 5142.5 5106.6 5126.2 5177.4 5297.9 5302.2 11:17:25 INFO - PROCESS | 10301 | 11:17:25 INFO - PROCESS | 10301 | [#4] prototype.html Cycles:180 Average:5743.28 Median:6614.25 stddev:1785.35 (27.0%) stddev-sans-first:1743.62 11:17:25 INFO - PROCESS | 10301 | Values: 335.9 338.8 341.7 343.1 344.9 6289.9 6391.4 6487.8 6502.6 6561.2 6417.9 6440.8 6465.4 6473.6 6486.4 4855.0 4862.3 4864.1 4864.3 4872.9 4867.7 4872.6 4877.5 4879.0 4889.8 4841.5 4845.1 4845.5 4845.7 4852.4 4646.9 4837.8 4837.9 4841.2 4843.1 4116.9 4144.5 4144.5 4150.3 4154.2 6136.5 6141.4 6161.6 6178.8 6208.0 5648.0 5653.0 5655.8 5664.2 5665.4 6790.9 6832.3 6852.8 6858.1 6859.0 4632.3 4659.9 4667.0 4675.8 4678.4 6886.8 7131.7 7141.5 7159.9 7181.1 4676.0 4731.4 4735.6 4737.5 4738.2 4796.8 4800.0 4802.6 4811.0 4815.8 5636.2 5636.7 5640.3 5642.7 5642.7 6678.5 6909.1 6910.2 6920.3 6921.3 1651.5 1661.8 1675.1 1677.1 1680.7 1075.2 1086.2 1101.5 1107.3 1110.5 6597.0 6776.3 6790.7 6793.8 6813.2 7168.2 7169.9 7178.4 7186.4 7189.3 6722.9 6777.1 6784.4 6786.6 6790.2 3819.8 3872.6 3876.2 3879.7 3881.3 7401.7 7478.4 7558.5 7564.8 7574.7 7233.5 7287.2 7288.7 7311.2 7320.9 7496.3 7513.6 7555.4 7556.6 7559.3 6974.0 7126.2 7126.4 7140.2 7168.4 7017.7 7024.3 7025.8 7033.4 7042.5 7480.0 7481.7 7494.4 7518.3 7576.9 4721.2 4745.9 4746.3 4750.1 4762.1 7118.9 7147.8 7148.8 7151.0 7152.9 6667.9 6924.2 6927.1 6936.6 6941.2 6897.3 6905.1 6914.7 6930.5 6942.4 6800.0 6807.5 6811.5 6827.0 6828.9 6771.7 6947.4 6958.3 6966.1 6972.8 6631.5 6797.0 6802.5 6810.3 6837.8 11:17:25 INFO - PROCESS | 10301 | 11:17:25 INFO - PROCESS | 10301 | [#5] yui.html Cycles:180 Average:15206.39 Median:47027.26 stddev:17329.03 (36.8%) stddev-sans-first:17343.72 11:17:25 INFO - PROCESS | 10301 | Values: 766.8 798.5 915.5 916.0 945.8 15145.2 15331.0 15360.7 15397.6 15458.6 14279.0 15586.5 16049.8 16108.8 16178.0 741.9 898.5 906.1 909.7 909.9 896.6 907.5 908.1 909.2 911.5 921.6 932.5 935.5 935.9 937.5 920.5 921.9 929.5 930.1 931.3 679.4 680.1 681.3 681.6 684.6 13433.3 13439.4 13483.3 13491.6 13530.7 14351.1 14359.2 14434.2 14543.0 14616.1 12236.4 12340.6 12363.6 12401.8 12721.4 4015.2 4062.4 4084.3 4123.4 4237.3 56819.1 56840.4 57057.4 57463.1 58142.0 11506.9 11621.4 11716.4 11812.7 11868.3 20869.7 21039.5 21111.3 21148.0 21299.0 8928.9 9019.0 9088.6 9230.9 9293.1 4797.9 4831.4 4880.1 4911.6 4999.0 3522.7 3578.7 3591.1 3598.4 3599.2 625.3 644.5 644.9 645.0 667.0 792.6 805.7 816.3 818.0 843.4 9720.3 9797.5 9929.6 10029.0 10032.2 684.3 709.4 737.6 843.8 852.2 4493.6 4761.5 4795.2 4875.6 4905.2 60863.4 61375.4 62079.4 62278.0 62317.1 54261.2 54517.2 54879.7 56755.7 56802.7 49585.5 50609.2 50668.7 50881.7 51361.2 9208.5 9283.5 9355.3 9413.2 9496.0 35307.8 35924.0 36400.6 36532.0 36897.0 42534.0 43347.3 46812.8 47241.8 47299.8 11712.0 11869.4 11896.0 12044.5 12058.6 13088.1 13104.0 13140.9 13284.1 13285.3 11817.9 12019.4 12403.4 12527.9 12620.2 11999.5 12405.4 12419.3 12442.6 12549.1 12425.8 12427.9 12577.6 12649.9 12896.4 10473.2 10559.4 10592.3 10646.3 10723.0 10356.3 10454.9 10478.4 10487.5 10659.8 11:17:25 INFO - PROCESS | 10301 | -------- Summary: end -------- 11:17:25 INFO - PROCESS | 10301 | 11:17:25 INFO - TEST-INFO | 10301: exit 0 11:17:25 INFO - TEST-OK | dromaeo_css | took 1108334ms 11:17:25 INFO - TEST-START | kraken 11:17:25 INFO - operating with platform_type : linux_ 11:17:25 INFO - Initialising browser for kraken test... 11:17:25 INFO - TEST-INFO | started process 10545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8CX3Rj/profile http://localhost:50802/getInfo.html) 11:17:29 INFO - PROCESS | 10545 | 11:17:29 INFO - PROCESS | 10545 | (process:10622): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:17:30 INFO - PROCESS | 10545 | __metrics Screen width/height:1600/1200 11:17:30 INFO - PROCESS | 10545 | colorDepth:24 11:17:30 INFO - PROCESS | 10545 | Browser inner width/height: 1024/697 11:17:30 INFO - PROCESS | 10545 | __metrics 11:17:30 ERROR - PROCESS | 10545 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 11:17:31 INFO - TEST-INFO | 10545: exit 0 11:17:31 INFO - Browser initialized. 11:17:31 INFO - Running cycle 1/1 for kraken test... 11:17:31 INFO - TEST-INFO | started process 10672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8CX3Rj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:17:33 INFO - PROCESS | 10672 | 11:17:33 INFO - PROCESS | 10672 | (process:10741): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:17:43 INFO - PROCESS | 10672 | RSS: Main: 150704128 11:17:43 INFO - PROCESS | 10672 | 11:17:45 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:50802/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50802/tests/kraken/driver.html?testName=audio-beat-detection) 11:17:46 INFO - PROCESS | 10672 | RSS: Main: 156180480 11:17:46 INFO - PROCESS | 10672 | 11:17:49 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:50802/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50802/tests/kraken/driver.html?testName=audio-dft) 11:17:50 INFO - PROCESS | 10672 | RSS: Main: 155959296 11:17:50 INFO - PROCESS | 10672 | 11:17:52 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:50802/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50802/tests/kraken/driver.html?testName=audio-fft) 11:17:53 INFO - PROCESS | 10672 | RSS: Main: 155893760 11:17:53 INFO - PROCESS | 10672 | 11:17:55 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:50802/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50802/tests/kraken/driver.html?testName=audio-oscillator) 11:17:56 INFO - PROCESS | 10672 | RSS: Main: 156094464 11:17:56 INFO - PROCESS | 10672 | 11:17:58 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:50802/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50802/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:17:59 INFO - PROCESS | 10672 | RSS: Main: 156467200 11:17:59 INFO - PROCESS | 10672 | 11:18:02 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:50802/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50802/tests/kraken/driver.html?testName=imaging-darkroom) 11:18:02 INFO - PROCESS | 10672 | RSS: Main: 156594176 11:18:02 INFO - PROCESS | 10672 | 11:18:05 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:50802/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50802/tests/kraken/driver.html?testName=imaging-desaturate) 11:18:06 INFO - PROCESS | 10672 | RSS: Main: 156332032 11:18:06 INFO - PROCESS | 10672 | 11:18:09 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:50802/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50802/tests/kraken/driver.html?testName=json-parse-financial) 11:18:09 INFO - PROCESS | 10672 | RSS: Main: 156233728 11:18:09 INFO - PROCESS | 10672 | 11:18:11 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:50802/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50802/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:18:12 INFO - PROCESS | 10672 | RSS: Main: 155926528 11:18:12 INFO - PROCESS | 10672 | 11:18:13 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:50802/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50802/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:18:14 INFO - PROCESS | 10672 | RSS: Main: 156180480 11:18:14 INFO - PROCESS | 10672 | 11:18:16 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:50802/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50802/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:18:17 INFO - PROCESS | 10672 | RSS: Main: 156553216 11:18:17 INFO - PROCESS | 10672 | 11:18:19 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:50802/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:18:20 INFO - PROCESS | 10672 | RSS: Main: 157081600 11:18:20 INFO - PROCESS | 10672 | 11:18:22 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:50802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:18:23 INFO - PROCESS | 10672 | RSS: Main: 156651520 11:18:23 INFO - PROCESS | 10672 | 11:18:25 INFO - PROCESS | 10672 | Cycle 1(1): loaded http://localhost:50802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50802/tests/kraken/driver.html?testName=ai-astar) 11:18:25 INFO - PROCESS | 10672 | RSS: Main: 157835264 11:18:25 INFO - PROCESS | 10672 | 11:18:25 INFO - PROCESS | 10672 | __start_tp_report 11:18:25 INFO - PROCESS | 10672 | _x_x_mozilla_page_load 11:18:25 INFO - PROCESS | 10672 | _x_x_mozilla_page_load_details 11:18:25 INFO - PROCESS | 10672 | |i|pagename|runs| 11:18:25 INFO - PROCESS | 10672 | |0;ai-astar;108;110;104;109;113;114;101;113;113;111 11:18:25 INFO - PROCESS | 10672 | |1;audio-beat-detection;156;127;160;181;129;151;157;129;193;128 11:18:25 INFO - PROCESS | 10672 | |2;audio-dft;160;162;163;163;164;165;162;161;163;163 11:18:25 INFO - PROCESS | 10672 | |3;audio-fft;74;77;76;177;75;76;74;77;156;76 11:18:25 INFO - PROCESS | 10672 | |4;audio-oscillator;93;92;153;92;92;93;149;92;91;153 11:18:25 INFO - PROCESS | 10672 | |5;imaging-gaussian-blur;118;117;117;117;118;120;118;117;118;117 11:18:25 INFO - PROCESS | 10672 | |6;imaging-darkroom;146;146;146;147;147;146;146;145;146;146 11:18:25 INFO - PROCESS | 10672 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;95;95 11:18:25 INFO - PROCESS | 10672 | |8;json-parse-financial;55;56;57;57;57;61;57;72;55;57 11:18:25 INFO - PROCESS | 10672 | |9;json-stringify-tinderbox;59;71;58;59;59;58;58;59;58;58 11:18:25 INFO - PROCESS | 10672 | |10;stanford-crypto-aes;74;73;72;73;73;74;74;73;75;72 11:18:25 INFO - PROCESS | 10672 | |11;stanford-crypto-ccm;122;122;111;119;113;116;116;120;135;130 11:18:25 INFO - PROCESS | 10672 | |12;stanford-crypto-pbkdf2;165;161;159;166;162;157;160;174;162;157 11:18:25 INFO - PROCESS | 10672 | |13;stanford-crypto-sha256-iterative;70;68;69;67;70;69;67;67;67;68 11:18:25 INFO - PROCESS | 10672 | __end_tp_report 11:18:25 INFO - PROCESS | 10672 | __start_cc_report 11:18:25 INFO - PROCESS | 10672 | _x_x_mozilla_cycle_collect,845 11:18:25 INFO - PROCESS | 10672 | __end_cc_report 11:18:25 INFO - PROCESS | 10672 | __startTimestamp1467742705371__endTimestamp 11:18:25 INFO - PROCESS | 10672 | 11:18:25 INFO - PROCESS | 10672 | ------- Summary: start ------- 11:18:25 INFO - PROCESS | 10672 | Number of tests: 14 11:18:25 INFO - PROCESS | 10672 | 11:18:25 INFO - PROCESS | 10672 | [#0] ai-astar Cycles:10 Average:109.60 Median:112.00 stddev:4.27 (3.8%) stddev-sans-first:4.49 11:18:25 INFO - PROCESS | 10672 | Values: 108.0 110.0 104.0 109.0 113.0 114.0 101.0 113.0 113.0 111.0 11:18:25 INFO - PROCESS | 10672 | 11:18:25 INFO - PROCESS | 10672 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:156.50 stddev:23.28 (14.9%) stddev-sans-first:24.63 11:18:25 INFO - PROCESS | 10672 | Values: 156.0 127.0 160.0 181.0 129.0 151.0 157.0 129.0 193.0 128.0 11:18:25 INFO - PROCESS | 10672 | 11:18:25 INFO - PROCESS | 10672 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.43 (0.9%) stddev-sans-first:1.17 11:18:25 INFO - PROCESS | 10672 | Values: 160.0 162.0 163.0 163.0 164.0 165.0 162.0 161.0 163.0 163.0 11:18:25 INFO - PROCESS | 10672 | 11:18:25 INFO - PROCESS | 10672 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.00 stddev:38.65 (50.9%) stddev-sans-first:40.32 11:18:25 INFO - PROCESS | 10672 | Values: 74.0 77.0 76.0 177.0 75.0 76.0 74.0 77.0 156.0 76.0 11:18:25 INFO - PROCESS | 10672 | 11:18:25 INFO - PROCESS | 10672 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:92.00 stddev:28.78 (31.3%) stddev-sans-first:29.86 11:18:25 INFO - PROCESS | 10672 | Values: 93.0 92.0 153.0 92.0 92.0 93.0 149.0 92.0 91.0 153.0 11:18:25 INFO - PROCESS | 10672 | 11:18:25 INFO - PROCESS | 10672 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:1.00 11:18:25 INFO - PROCESS | 10672 | Values: 118.0 117.0 117.0 117.0 118.0 120.0 118.0 117.0 118.0 117.0 11:18:25 INFO - PROCESS | 10672 | 11:18:25 INFO - PROCESS | 10672 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 11:18:25 INFO - PROCESS | 10672 | Values: 146.0 146.0 146.0 147.0 147.0 146.0 146.0 145.0 146.0 146.0 11:18:25 INFO - PROCESS | 10672 | 11:18:25 INFO - PROCESS | 10672 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:18:25 INFO - PROCESS | 10672 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 11:18:25 INFO - PROCESS | 10672 | 11:18:25 INFO - PROCESS | 10672 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:57.00 stddev:5.06 (8.9%) stddev-sans-first:5.21 11:18:25 INFO - PROCESS | 10672 | Values: 55.0 56.0 57.0 57.0 57.0 61.0 57.0 72.0 55.0 57.0 11:18:25 INFO - PROCESS | 10672 | 11:18:25 INFO - PROCESS | 10672 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:59.00 stddev:4.00 (6.8%) stddev-sans-first:4.24 11:18:25 INFO - PROCESS | 10672 | Values: 59.0 71.0 58.0 59.0 59.0 58.0 58.0 59.0 58.0 58.0 11:18:25 INFO - PROCESS | 10672 | 11:18:25 INFO - PROCESS | 10672 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:73.50 stddev:0.95 (1.3%) stddev-sans-first:0.97 11:18:25 INFO - PROCESS | 10672 | Values: 74.0 73.0 72.0 73.0 73.0 74.0 74.0 73.0 75.0 72.0 11:18:25 INFO - PROCESS | 10672 | 11:18:25 INFO - PROCESS | 10672 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:121.00 stddev:7.41 (6.1%) stddev-sans-first:7.84 11:18:25 INFO - PROCESS | 10672 | Values: 122.0 122.0 111.0 119.0 113.0 116.0 116.0 120.0 135.0 130.0 11:18:25 INFO - PROCESS | 10672 | 11:18:25 INFO - PROCESS | 10672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:162.00 stddev:5.08 (3.1%) stddev-sans-first:5.29 11:18:25 INFO - PROCESS | 10672 | Values: 165.0 161.0 159.0 166.0 162.0 157.0 160.0 174.0 162.0 157.0 11:18:25 INFO - PROCESS | 10672 | 11:18:25 INFO - PROCESS | 10672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:1.23 (1.8%) stddev-sans-first:1.12 11:18:25 INFO - PROCESS | 10672 | Values: 70.0 68.0 69.0 67.0 70.0 69.0 67.0 67.0 67.0 68.0 11:18:25 INFO - PROCESS | 10672 | -------- Summary: end -------- 11:18:25 INFO - PROCESS | 10672 | 11:18:26 INFO - TEST-INFO | 10672: exit 0 11:18:26 INFO - TEST-OK | kraken | took 60454ms 11:18:26 INFO - SUITE-END | took 1168s 11:18:26 INFO - Completed test suite (00:19:29) 11:18:26 INFO - javascript benchmark 11:18:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3312.420326442872, 3372.645872183419, 3404.625491195968, 3419.1964888251255, 3419.350323438548, 5500.339959204896, 5515.889682206363, 5522.061249587569, 5549.500544950959, 5562.916556251659, 5501.0648189807725, 5527.198556209357, 5532.723363831812, 5544.445555444454, 5552.611317207797, 4979.278004689318, 4980.999999999991, 5036.471170527097, 5038.5969122470115, 5052.6210534209895, 4858.125537403266, 4924.285978533128, 5065.594752419797, 5099.107656160176, 5147.510986456281, 5006.299118123447, 5041.243813427996, 5096.184610462326, 5119.846404607849, 5124.154514505102, 4952.5542701157065, 4973.452920178777, 5011.699298042093, 5020.874478138057, 5038.067957427887, 4713.0, 4940.98709764501, 4945.505449455061, 4988.451270360294, 4991.950080499185, 5412.621116521845, 5492.780288788484, 5513.724313784335, 5558.027345214571, 5590.944090559083, 6018.608790428608, 6028.7588496460085, 6046.969765151146, 6058.878822423571, 6071.119687645267, 5895.55783316253, 5981.342052374235, 6092.878142437126, 6118.174046503709, 6138.785142520035, 5545.9185458835545, 5562.9443705563235, 5563.638363506399, 5573.219749235111, 5599.188117722948, 6027.879442411215, 6028.336882942873, 6028.4272994065495, 6028.879422411527, 6034.758609655652, 5697.259356283739, 5760.53915686744, 5791.3339965903615, 5799.159121927297, 5818.069108942549, 5978.073398623221, 5981.312149102909, 5982.341942386334, 5985.191999080155, 5995.160677505153, 5886.499647530008, 5927.0, 5942.821715348547, 5943.405659434022, 5952.839196356756, 5781.219535362672, 5840.182374467578, 5873.735681894325, 5940.405959404025, 5973.820785376446, 4566.0, 4567.063751930913, 4569.97175635486, 4574.679772415899, 4600.033992861469, 4086.836526538905, 4106.7125301229225, 4114.794260286973, 4119.649829764444, 4132.710710250253, 5706.201131841545, 5743.655380677173, 5744.770209191669, 5747.885042299131, 5784.363719990798, 5908.084246941731, 5973.402659733992, 6025.186599809057, 6028.819135425944, 6030.18592490017, 5579.804706835323, 5714.399988001283, 5749.568782341341, 5753.683547404933, 5762.135679648002, 4973.428055773632, 5006.774695138654, 5008.84973450797, 5020.221865610836, 5051.2423136529815, 6189.659568723763, 6196.597221180609, 6203.96898015507, 6219.751209951642, 6222.564420490613, 5941.22764040672, 5953.553483488669, 5963.7912673056235, 5972.970135149297, 5984.461398474071, 6137.478314343152, 6242.344553821783, 6335.3981371769605, 6364.0, 6385.840353991188, 5968.343482217039, 5969.3732158122775, 5994.133147715443, 6003.519718422603, 6003.609765365237, 5868.823935281948, 6101.816945491642, 6111.84720381994, 6114.0828875669, 6120.08198770188, 5845.18167456565, 5892.558058145571, 5917.497012753965, 5925.259342582177, 5954.166416701752, 5757.510611597893, 5775.393583673822, 5776.162456443708, 5800.01399762033, 5815.069588865761, 5586.385497595343, 5671.914921276267, 5720.856978575569, 5722.942770572241, 5726.828195154152, 5904.911426328695, 5908.113782932594, 5921.111833225051, 5943.405659434022, 5959.76160953557, 5786.884262314814, 5787.479126878601, 5788.247527821356, 5795.710214489343, 5805.187273781758], "value": 5504.443097027474, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.3856821008777, 683.0676127086526, 701.4178232067385, 730.7698075106345, 743.3310020981116, 38004.0, 39058.60941390589, 39078.80460597693, 39081.218375632474, 39328.803355983255, 41869.79065104678, 42739.57260427395, 42747.57252427482, 42776.57223427765, 42854.0, 8767.693130740441, 9017.59420826061, 9017.684381046665, 9031.23234525066, 9039.502827344493, 8851.203391694746, 8952.328575356874, 8968.686095986643, 9155.359124861263, 9162.541872906362, 9188.1730644242, 9228.8615670765, 9236.907630923706, 9244.8613270801, 9246.76883077925, 9103.49930753805, 9105.226055785266, 9109.99790023097, 9113.225375843062, 9164.679236226733, 8951.0, 9078.046805085436, 9089.454632721992, 9101.0, 9166.724998249996, 42058.57941420577, 42731.0, 42802.35796463056, 42809.0, 42953.57046429527, 3766.303233901737, 3782.0544863784053, 3845.057960799594, 4029.576894426072, 4424.535423780521, 32433.351332973445, 32497.6750232497, 32720.0, 33121.668783312096, 34442.31115377704, 4554.2485489894125, 4603.447586289667, 4605.861824145248, 4609.354690343354, 4652.232381657022, 232327.0, 232687.0, 232986.0, 234049.0, 234492.0, 39374.40938385927, 60706.0, 61063.694681527195, 61517.0, 61565.0, 37198.44202336967, 37285.62714372821, 37285.81357093197, 37380.81309593435, 37400.43899341512, 17046.14769261532, 17317.0, 17321.30714771395, 17411.65176696459, 17434.47696569105, 13342.466301348031, 13375.264360460074, 13414.865851341558, 13444.798328025088, 13483.865161348262, 9173.082691730773, 9184.8622270666, 9318.95340523293, 9422.104900034486, 9440.867095948393, 3631.382664946965, 3667.4132138857653, 3709.295233905549, 3759.191773768653, 3780.092777733324, 1109.2457129152253, 1116.1182665694173, 1127.7406196574834, 1174.8179032250016, 1187.6733898177897, 31869.0, 32615.51076733851, 33671.66328336734, 35753.28493430117, 35774.0, 1241.267652085274, 1259.5213818748816, 1266.5756971414496, 1281.8461784585909, 1305.8694130586866, 15960.0, 16016.279267432994, 16293.266802993894, 16295.0, 16604.169791510376, 462093.0, 525261.0, 569506.0, 571758.0, 576441.0, 55181.72409138009, 55685.721571391885, 55710.44289557134, 55745.721271393384, 56007.71996139993, 1508.720886635954, 1524.8651887357787, 1529.1818876900804, 1532.417681281106, 1548.4735190035442, 31974.840125799223, 32615.347693046482, 32917.17707057343, 33039.0, 33131.83434082814, 51953.22070168875, 52155.0, 52691.20963185632, 52724.0, 52733.7363313181, 405773.0, 410750.0, 410981.0, 413288.0, 416261.0, 30329.848350758988, 30486.23784405319, 30915.0725478236, 30935.0719478416, 31137.0, 46507.0, 46814.29778553393, 47493.76253118712, 47670.523294768, 47874.281885771044, 40522.59477405188, 41148.1770364597, 43208.56791432171, 46334.073318534116, 47473.050538989715, 39809.2038159241, 40486.1902761949, 40745.29829368539, 40776.3883541753, 41012.384814228404, 40766.79616601898, 41096.589034110475, 41336.58663413327, 41359.0, 41744.0, 33388.8313909012, 33645.327093457505, 33738.662613373555, 33978.0, 34011.0, 28281.292967675974, 28829.423411532072, 28861.134165975054, 28896.7110328894, 28924.276893077], "value": 19325.106702699923, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.25283108832986, 412.2970335577839, 413.37993010484274, 421.890308519785, 422.61964232191036, 17198.39805606804, 18701.34545290915, 19151.90424047878, 19288.710669339955, 20036.499087522818, 12347.506099756021, 12685.61943141705, 12688.873111268907, 14796.6300842479, 18894.527636809085, 5099.566536844372, 5278.762455689503, 5296.602754793386, 5308.442613525582, 5334.386545547253, 5241.790328386879, 5327.547158491533, 5538.47384498472, 5829.9708501457435, 5848.239728835246, 5690.800821971232, 5796.9275683998385, 5801.767929282823, 5818.767249310023, 5832.795852145176, 5902.291724992985, 5919.023361145406, 5932.792352267671, 5938.703064846741, 5952.0, 5844.064949608042, 5867.090600956859, 5870.530357571384, 5874.118882167666, 5895.115732640095, 21156.0, 22143.224987125373, 22243.22148724803, 22741.772582274298, 22813.201537946094, 2290.404494831339, 2443.6945381827272, 2460.778529932297, 2507.962380564293, 2964.377480729028, 13942.581722548239, 14181.716365672732, 14382.35279412429, 14426.278686065654, 14597.0, 1948.4836518322657, 2040.5714799892041, 2050.5181282398626, 2092.194505115526, 2120.416885356524, 73493.63253183699, 80115.0, 80789.0, 82759.9999999994, 84844.0, 11387.37369444672, 11396.886031139748, 11467.369294688871, 11817.88182118185, 11834.408279586158, 16082.839171608368, 16222.675546489005, 16284.26720797567, 16364.754528682079, 16466.341346346013, 8664.523451210243, 8875.023747387782, 8888.511131887679, 8936.8659470108, 8973.910260897437, 8657.0, 8755.124487551195, 8831.64673413069, 8917.464952102895, 9085.36402451822, 5010.649254552146, 5023.271625614266, 5037.496250374933, 5043.420006699276, 5046.545810876965, 2067.8759274443582, 2072.7927207279154, 2097.8741275523516, 2131.0, 2141.100737690174, 980.3333733061444, 1039.4335087377397, 1065.728239298974, 1074.897884700952, 1195.970100747471, 19305.51736206578, 19356.4193074208, 19783.0, 19913.701294480594, 20064.297749578694, 1108.9057430118369, 1141.8287256911365, 1151.2574389518713, 1175.5415387998687, 1197.9161458697808, 10733.248672592843, 10826.133909287239, 11025.503852326665, 11082.556697732161, 11166.497507612014, 507235.0, 509486.0, 513865.72268554417, 514248.0, 517566.0, 84624.57687711646, 89004.10995889959, 89178.55410723035, 94963.0, 97258.0, 1089.3953855610055, 1120.887911208889, 1160.512584714422, 1165.3590525211268, 1166.4634268236537, 16885.746713799548, 17041.91479042597, 17163.0, 17171.055591942564, 17264.482065538054, 27081.59377609298, 37455.2508949814, 37789.244215116094, 38208.235835283696, 40376.79811600923, 59740.402595975225, 60106.69946650239, 60107.699461502416, 60218.69890650519, 60532.6973365148, 8605.483670979762, 8891.688790892287, 9018.549072546477, 9099.226565741987, 9104.908950910407, 12419.130660854014, 12802.60730906292, 13180.604581862559, 13235.933820330836, 13771.242581657703, 11702.414879255834, 11780.469878855301, 11993.34036627959, 12170.330631815335, 12282.815757763461, 11291.266067705574, 11432.971032607105, 11662.88337116652, 11687.707807304885, 11798.587049453228, 11949.0, 11963.162578619413, 12012.0, 12140.575079872162, 12502.0, 8978.910210898068, 9022.097790220925, 9122.498262595622, 9215.617657351451, 9249.86125208109, 8940.329475289509, 11941.343226122299, 11975.101867359808, 12026.458809353426, 12154.270743755404], "value": 9485.697486606006, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1540.1067380919064, 1559.945401910933, 1744.1976690722267, 1827.3421568235442, 1873.0541076756235, 7131.037309963153, 7771.844563108734, 7838.333741631961, 7847.803804904866, 7889.0, 7975.7607271781935, 8064.71773487928, 8073.757787266377, 8110.310623596986, 8178.386621003434, 2090.247510896076, 2116.597846409185, 2122.840786940978, 2131.5417185305155, 2134.551744133734, 2177.477405422695, 2184.3665337052234, 2283.22370394066, 2288.6910267113976, 2292.621717416624, 2238.563480121377, 2253.616885129532, 2274.9545009099807, 2285.3600991722346, 2288.107638021173, 2171.880546569938, 2207.2054060538194, 2221.4779526811267, 2228.2758103616306, 2234.4190510467397, 2258.435391152212, 2269.5687819314444, 2270.182734215681, 2273.999440246286, 2283.9771602284095, 8021.478603890729, 8037.397195210383, 8100.878486822702, 8103.878441823377, 8121.634526446324, 4871.683340582851, 4949.82675606352, 4965.255211718271, 4982.850514484571, 4992.276119962585, 3129.4523458394688, 3199.936001279961, 3315.419801534746, 3324.335132973391, 3339.5825521809775, 1205.6142034548948, 1206.4563331491781, 1208.7945049341633, 1230.028277660647, 1237.616338934933, 11253.381064041474, 11302.095832333394, 11305.830412543819, 11329.773404531945, 11333.26333788301, 3955.4462375267485, 4034.919301613951, 4063.146739184745, 4064.8577299794956, 4067.9796601016806, 9175.954120229357, 9242.630294788134, 9266.07339266068, 9266.536673166314, 9268.165865072177, 4850.272459131159, 4859.757012149378, 4875.293082503017, 4876.122297986397, 4892.143874821892, 4094.549599544048, 4485.439320084989, 4537.160625284333, 4545.38637283969, 4573.771311434415, 3713.7586056906216, 3726.832292546788, 3809.695224382043, 3811.637894400083, 3836.5204349456317, 1128.114430172311, 1169.6666450061691, 1174.3717111345388, 1184.1237484261756, 1186.5194596188558, 939.6006697153819, 1048.7797562511957, 1061.766411389493, 1068.0974576482859, 1070.2240875365299, 5674.729423986436, 5834.3290521589715, 5873.3874582856515, 5935.821925342247, 5945.048792193228, 437.2522985694498, 444.2647418522351, 451.3748458385095, 451.51462178158613, 455.45573040217283, 4024.75851448914, 4054.878353649395, 4064.5935406459707, 4087.8364865405647, 4111.773852438145, 9856.211503079736, 10105.494725263707, 10136.695899123039, 10210.846837297446, 10251.179905607534, 10001.0, 10018.0, 10023.448710320856, 10029.047240512285, 10033.247506437046, 7418.740344087931, 7603.9619801900635, 7632.847343053108, 7706.807329816799, 7751.108622508371, 5698.629589076697, 5742.483176514133, 5801.883962320646, 5807.0, 5861.912071319019, 8993.055729148346, 9026.503542305236, 9084.364094513321, 9128.589213485277, 9154.450732956044, 9293.581788819654, 9389.718308450485, 9416.76458088526, 9418.10527999839, 9428.481433521221, 6216.968915155395, 6938.826529336807, 7028.929710702828, 7171.820704482429, 7274.16347120088, 7885.0, 7944.0, 7951.642176101974, 7963.960180199062, 7992.16082311349, 7009.684564194521, 7085.433165346863, 7155.356017958408, 7185.712571497082, 7332.743353982585, 7101.254368291255, 7165.0, 7183.5330703504105, 7184.209736928829, 7288.927110728825, 6482.0, 6628.90056649141, 6669.299723529154, 6680.899786503109, 6693.866122677617, 4982.526659967298, 5064.44291127983, 5112.769925353294, 5120.897582048413, 5142.485751424828, 5106.617003724661, 5126.231065340229, 5177.404598471224, 5297.947020529746, 5302.1781623848365], "value": 4323.390118546646, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.9391403278335, 338.77132935268696, 341.73344791062965, 343.1130527586188, 344.86722611794454, 6289.899267628158, 6391.392817682313, 6487.837804054895, 6502.642354670497, 6561.245456772473, 6417.935820641792, 6440.806775796734, 6465.418112369885, 6473.611583305005, 6486.351364863512, 4854.975725121379, 4862.319275301443, 4864.075825593126, 4864.294677271793, 4872.878178045559, 4867.732274724889, 4872.561469467747, 4877.487863774306, 4879.048585525824, 4889.804407823701, 4841.467438581753, 4845.127876982142, 4845.466998630148, 4845.685030473026, 4852.393450818648, 4646.883827904296, 4837.806487740486, 4837.903241935159, 4841.225403935371, 4843.055604157191, 4116.91766164678, 4144.5233798113, 4144.52337981133, 4150.27370210215, 4154.231467178582, 6136.509079273647, 6141.385861413867, 6161.6303021818385, 6178.814635560941, 6207.968960155215, 5648.039833228361, 5653.038983372795, 5655.802046928337, 5664.178694089334, 5665.433456654343, 6790.932090679129, 6832.282610325944, 6852.794416167523, 6858.074159988388, 6859.039734437133, 4632.305154226893, 4659.930101048487, 4666.9766651166865, 4675.789589468448, 4678.415198100238, 6886.758963436256, 7131.71473141079, 7141.500094993353, 7159.928400715979, 7181.102362204724, 4675.953240467552, 4731.384919960383, 4735.644826638016, 4737.45519265282, 4738.19450693383, 4796.760161991887, 4800.0, 4802.567768900815, 4811.037792441456, 4815.807367705253, 5636.154576813511, 5636.661800291996, 5640.32316122068, 5642.6614403135945, 5642.7178641067785, 6678.465722742169, 6909.1018167637885, 6910.239873613898, 6920.342567456084, 6921.342472465108, 1651.5128037229047, 1661.8338166183528, 1675.1121905390162, 1677.0943690407287, 1680.7226807576612, 1075.166745772033, 1086.163653986426, 1101.4823033174396, 1107.2581370481796, 1110.5224753356135, 6596.967015164893, 6776.322367763184, 6790.694418751069, 6793.796186114425, 6813.216480104752, 7168.175659799085, 7169.89245161323, 7178.389836863925, 7186.353228209487, 7189.2810718927685, 6722.865542689216, 6777.1189745332795, 6784.389404953479, 6786.59280443175, 6790.151231096113, 3819.751716138442, 3872.6320999505, 3876.205377897524, 3879.7090218233743, 3881.2819628368843, 7401.666924988388, 7478.401727861758, 7558.470907036454, 7564.773056808304, 7574.697012119564, 7233.493655444174, 7287.161976372785, 7288.744893928687, 7311.232320606367, 7320.853582928312, 7496.325330720152, 7513.586752728653, 7555.357794587411, 7556.58438785872, 7559.3196612305155, 6973.965130174317, 7126.180489243596, 7126.429885609035, 7140.178879428932, 7168.4265258780215, 7017.684204210925, 7024.332688394595, 7025.824354391181, 7033.402160816183, 7042.471814613822, 7479.962600187182, 7481.66332515049, 7494.362979146834, 7518.28576285252, 7576.886346704694, 4721.197396442682, 4745.928811067905, 4746.264329029006, 4750.097481478508, 4762.14281429346, 7118.85762284741, 7147.785566433015, 7148.821279468055, 7151.0, 7152.856942861218, 6667.899981500378, 6924.169099708067, 6927.134108236471, 6936.618485983319, 6941.236463989058, 6897.2757860423935, 6905.102336696398, 6914.688839002358, 6930.549514281555, 6942.409895158766, 6800.047993281044, 6807.489438292049, 6811.489138314745, 6826.965865170642, 6828.897566536407, 6771.729130834711, 6947.40947019509, 6958.304169583002, 6966.059581956371, 6972.825679358057, 6631.535792494672, 6796.966015169893, 6802.537454447318, 6810.250872404131, 6837.829054273683], "value": 5149.083753504523, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.8236305649697, 798.536848627796, 915.5330781301536, 915.9954200229, 945.7966537194502, 15145.242737863118, 15331.0, 15360.692786144271, 15397.615059623515, 15458.613534661625, 14279.0, 15586.532404027897, 16049.83950160498, 16108.838911610881, 16178.029318240913, 741.9146798118204, 898.4743924803981, 906.1301150895149, 909.6634245329204, 909.8635204719279, 896.6458248991645, 907.4645958884257, 908.1055160666738, 909.236241557092, 911.4804561400005, 921.617528725578, 932.4871320773582, 935.4574346878828, 935.873657056299, 937.4890684576887, 920.4983284110176, 921.8985911549757, 929.525941769699, 930.1303281431883, 931.3061768982084, 679.4021261290034, 680.0649107477219, 681.3016657925616, 681.6182937554936, 684.637142314574, 13433.261170635611, 13439.395227214702, 13483.258420786853, 13491.595252142451, 13530.661733456644, 14351.067180633225, 14359.210243436606, 14434.20611866347, 14543.0, 14616.123032618078, 12236.388180590935, 12340.62978110649, 12363.567275145328, 12401.751964960651, 12721.363931803466, 4015.217032678629, 4062.3906414037833, 4084.326086195774, 4123.381492776078, 4237.258479766028, 56819.14771278434, 56840.43159568434, 57057.429425705624, 57463.13805292966, 58142.0, 11506.884931150582, 11621.360825154528, 11716.355600442057, 11812.70468238301, 11868.287902725864, 20869.68695469569, 21039.474013149487, 21111.26110586122, 21148.0, 21299.0, 8928.910710892938, 9019.0, 9088.591013404413, 9230.907690923139, 9293.117153870371, 4797.856064318076, 4831.371921650163, 4880.072786170616, 4911.607071434277, 4998.975005124951, 3522.6653467920505, 3578.6779189873037, 3591.06632275605, 3598.4062629666337, 3599.190182208982, 625.2778041362234, 644.5005121031238, 644.9193850768654, 644.9709763060673, 666.976655817044, 792.647271963982, 805.7421625080035, 816.2898278497745, 818.0265484073933, 843.3632607381388, 9720.31957762964, 9797.461139637388, 9929.553170107363, 10029.0, 10032.197424206046, 684.2849222562335, 709.4076446167405, 737.6311844077961, 843.7595285343771, 852.2159613155911, 4493.573110554492, 4761.500042495488, 4795.160846851857, 4875.609951203966, 4905.166121759309, 60863.351771625334, 61375.386246136964, 62079.379206208265, 62278.0, 62317.065244021374, 54261.1860822088, 54517.182242265604, 54879.725601371734, 56755.71622141863, 56802.71598642063, 49585.50414495881, 50609.24086138711, 50668.746656266485, 50881.74559127255, 51361.229581556305, 9208.539573021188, 9283.535823208947, 9355.298352623717, 9413.199878010446, 9495.987541042006, 35307.82346088253, 35924.0, 36400.63599363973, 36532.0, 36897.0, 42534.0, 43347.34978975381, 46812.7659361701, 47241.76379118083, 47299.76350118227, 11712.0, 11869.406529673655, 11896.0, 12044.51821927113, 12058.638240852788, 13088.149270297401, 13104.0, 13140.868591313965, 13284.070115092238, 13285.269310188032, 11817.881821182022, 12019.399030048637, 12403.379831008233, 12527.93736031314, 12620.242785432903, 11999.520019199133, 12405.44175512086, 12419.316937568521, 12442.626721198378, 12549.121561490972, 12425.751484970431, 12427.89433992407, 12577.559785407468, 12649.87350126487, 12896.355182241037, 10473.162147028372, 10559.419231942316, 10592.311499752492, 10646.254762166574, 10723.03492685662, 10356.275060745675, 10454.947725261629, 10478.37129772216, 10487.475626218811, 10659.786804264026], "value": 7065.41224579194, "unit": "score"}], "name": "dromaeo_css", "value": 7358.217499514803, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 104.0, 109.0, 113.0, 114.0, 101.0, 113.0, 113.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 160.0, 181.0, 129.0, 151.0, 157.0, 129.0, 193.0, 128.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 163.0, 163.0, 164.0, 165.0, 162.0, 161.0, 163.0, 163.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 177.0, 75.0, 76.0, 74.0, 77.0, 156.0, 76.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 153.0, 92.0, 92.0, 93.0, 149.0, 92.0, 91.0, 153.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 120.0, 118.0, 117.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 57.0, 57.0, 57.0, 61.0, 57.0, 72.0, 55.0, 57.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 71.0, 58.0, 59.0, 59.0, 58.0, 58.0, 59.0, 58.0, 58.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 73.0, 73.0, 74.0, 74.0, 73.0, 75.0, 72.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 111.0, 119.0, 113.0, 116.0, 116.0, 120.0, 135.0, 130.0], "value": 120.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 159.0, 166.0, 162.0, 157.0, 160.0, 174.0, 162.0, 157.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 67.0, 70.0, 69.0, 67.0, 67.0, 67.0, 68.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1528.3000000000002, "alertThreshold": 2.0}]} 11:18:26 INFO - Return code: 0 11:18:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:18:26 ERROR - # TBPL SUCCESS # 11:18:26 INFO - Running post-action listener: _resource_record_post_action 11:18:26 INFO - Running post-run listener: _resource_record_post_run 11:18:27 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 457887744; Read time: 0; Write time: 301988 11:18:27 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242380800; Read time: 0; Write time: 197508 11:18:27 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 208461824; Read time: 0; Write time: 103372 11:18:27 INFO - Running post-run listener: _upload_blobber_files 11:18:27 INFO - Blob upload gear active. 11:18:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:18:27 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 11:18:27 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'] 11:18:27 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 11:18:28 INFO - (blobuploader) - INFO - Open directory for files ... 11:18:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:18:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:18:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:18:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:18:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:18:29 INFO - (blobuploader) - INFO - Done attempting. 11:18:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:18:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:18:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:18:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:18:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:18:29 INFO - (blobuploader) - INFO - Done attempting. 11:18:29 INFO - (blobuploader) - INFO - Iteration through files over. 11:18:29 INFO - Return code: 0 11:18:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:18:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:18:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2158e0a6a6fecb4da3cc40726fc2bbdf0811530538f1fba432f935fc777289e16b16ebcfc8440604cd95417b8e94c6b67366823c59c8af7a2c5c8357ae07122c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9f172068362661333dc8bf2235c9232da8f44fdc9440be648cd76aa2667f0d791e14ff5a1767b776da5f56aa0baa926edd194f5eac8b2a0ad95d8d5d3ef1097"} 11:18:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:18:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:18:29 INFO - Contents: 11:18:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2158e0a6a6fecb4da3cc40726fc2bbdf0811530538f1fba432f935fc777289e16b16ebcfc8440604cd95417b8e94c6b67366823c59c8af7a2c5c8357ae07122c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9f172068362661333dc8bf2235c9232da8f44fdc9440be648cd76aa2667f0d791e14ff5a1767b776da5f56aa0baa926edd194f5eac8b2a0ad95d8d5d3ef1097"} 11:18:29 INFO - Running post-run listener: copy_logs_to_upload_dir 11:18:29 INFO - Copying logs to upload dir... 11:18:29 INFO - mkdir: /builds/slave/test/build/upload/logs 11:18:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1221.655431 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-07-05 11:18:29.776699) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 11:18:29.780732) ========= 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=41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414 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/2158e0a6a6fecb4da3cc40726fc2bbdf0811530538f1fba432f935fc777289e16b16ebcfc8440604cd95417b8e94c6b67366823c59c8af7a2c5c8357ae07122c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9f172068362661333dc8bf2235c9232da8f44fdc9440be648cd76aa2667f0d791e14ff5a1767b776da5f56aa0baa926edd194f5eac8b2a0ad95d8d5d3ef1097"} build_url:https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011664 build_url: 'https://queue.taskcluster.net/v1/task/fcVDmdgaTJabwWsnJs4ptw/artifacts/public/build/firefox-48.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/2158e0a6a6fecb4da3cc40726fc2bbdf0811530538f1fba432f935fc777289e16b16ebcfc8440604cd95417b8e94c6b67366823c59c8af7a2c5c8357ae07122c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a9f172068362661333dc8bf2235c9232da8f44fdc9440be648cd76aa2667f0d791e14ff5a1767b776da5f56aa0baa926edd194f5eac8b2a0ad95d8d5d3ef1097"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 11:18:29.810618) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:18:29.810965) ========= 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=41a7e32711b8e08598a63237000001d6-1467741485.560955-2005450414 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:18:29.894235) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 11:18:29.895049) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 11:18:29.895680) ========= ========= Total master_lag: 0.18 =========