builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-002 starttime: 1467395221.52 results: success (0) buildid: 20160701074922 builduid: ad5179a2fa9c4befaf28b0702cae2bba revision: 4c7636b942946b1057c6f8fe5ae92377011a86bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 10:47:01.524228) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 10:47:01.524675) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 10:47:01.524952) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 10:47:01.540397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 10:47:01.540704) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 10:47:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 100M=0s 2016-07-01 10:47:02 (100 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134161 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 10:47:01.688997) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 10:47:01.689308) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018289 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 10:47:01.739448) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 10:47:01.739852) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4c7636b942946b1057c6f8fe5ae92377011a86bf --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 4c7636b942946b1057c6f8fe5ae92377011a86bf --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=a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 10:47:02,169 truncating revision to first 12 chars 2016-07-01 10:47:02,169 Setting DEBUG logging. 2016-07-01 10:47:02,170 attempt 1/10 2016-07-01 10:47:02,170 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4c7636b94294?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 10:47:02,507 unpacking tar archive at: mozilla-beta-4c7636b94294/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645928 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 10:47:02.399032) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 10:47:02.399361) ========= script_repo_revision: 4c7636b942946b1057c6f8fe5ae92377011a86bf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 10:47:02.399769) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 10:47:02.400079) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 10:47:02.411237) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-01 10:47:02.411640) ========= /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=a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:47:02 INFO - MultiFileLogger online at 20160701 10:47:02 in /builds/slave/test 10:47:02 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:47:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:47:02 INFO - {'append_to_log': False, 10:47:02 INFO - 'base_work_dir': '/builds/slave/test', 10:47:02 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:47:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:47:02 INFO - 'branch': 'Mozilla-Beta', 10:47:02 INFO - 'buildbot_json_path': 'buildprops.json', 10:47:02 INFO - 'config_files': ('talos/linux_config.py',), 10:47:02 INFO - 'default_actions': ('clobber', 10:47:02 INFO - 'read-buildbot-config', 10:47:02 INFO - 'download-and-extract', 10:47:02 INFO - 'populate-webroot', 10:47:02 INFO - 'create-virtualenv', 10:47:02 INFO - 'install', 10:47:02 INFO - 'run-tests'), 10:47:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:47:02 INFO - 'download_minidump_stackwalk': True, 10:47:02 INFO - 'download_symbols': 'ondemand', 10:47:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:47:02 INFO - 'tooltool.py': '/tools/tooltool.py', 10:47:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:47:02 INFO - '/tools/misc-python/virtualenv.py')}, 10:47:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:47:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:47:02 INFO - 'installer_path': 'installer.exe', 10:47:02 INFO - 'log_level': 'info', 10:47:02 INFO - 'log_name': 'talos', 10:47:02 INFO - 'log_to_console': True, 10:47:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:47:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:47:02 INFO - 'opt_config_files': (), 10:47:02 INFO - 'pip_index': False, 10:47:02 INFO - 'sps_profile': False, 10:47:02 INFO - 'sps_profile_interval': 0, 10:47:02 INFO - 'suite': 'dromaeojs-e10s', 10:47:02 INFO - 'system_bits': '32', 10:47:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:47:02 INFO - 'title': 'talos-linux64-ix-002', 10:47:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:47:02 INFO - 'use_talos_json': True, 10:47:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:47:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:47:02 INFO - 'work_dir': 'build'} 10:47:02 INFO - ##### 10:47:02 INFO - ##### Running clobber step. 10:47:02 INFO - ##### 10:47:02 INFO - Running pre-action listener: _resource_record_pre_action 10:47:02 INFO - Running main action method: clobber 10:47:02 INFO - rmtree: /builds/slave/test/build 10:47:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:47:03 INFO - Running post-action listener: _resource_record_post_action 10:47:03 INFO - ##### 10:47:03 INFO - ##### Running read-buildbot-config step. 10:47:03 INFO - ##### 10:47:03 INFO - Running pre-action listener: _resource_record_pre_action 10:47:03 INFO - Running main action method: read_buildbot_config 10:47:03 INFO - Using buildbot properties: 10:47:03 INFO - { 10:47:03 INFO - "project": "", 10:47:03 INFO - "product": "firefox", 10:47:03 INFO - "script_repo_revision": "production", 10:47:03 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 10:47:03 INFO - "repository": "", 10:47:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 10:47:03 INFO - "buildid": "20160701074922", 10:47:03 INFO - "pgo_build": "True", 10:47:03 INFO - "basedir": "/builds/slave/test", 10:47:03 INFO - "buildnumber": 74, 10:47:03 INFO - "slavename": "talos-linux64-ix-002", 10:47:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:47:03 INFO - "platform": "ubuntu64_hw", 10:47:03 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:47:03 INFO - "branch": "mozilla-beta", 10:47:03 INFO - "repo_path": "releases/mozilla-beta", 10:47:03 INFO - "revision": "4c7636b942946b1057c6f8fe5ae92377011a86bf", 10:47:03 INFO - "stage_platform": "linux64-pgo", 10:47:03 INFO - "builduid": "ad5179a2fa9c4befaf28b0702cae2bba", 10:47:03 INFO - "slavebuilddir": "test" 10:47:03 INFO - } 10:47:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 10:47:03 INFO - Running post-action listener: _resource_record_post_action 10:47:03 INFO - ##### 10:47:03 INFO - ##### Running download-and-extract step. 10:47:03 INFO - ##### 10:47:03 INFO - Running pre-action listener: _resource_record_pre_action 10:47:03 INFO - Running main action method: download_and_extract 10:47:03 INFO - mkdir: /builds/slave/test/build/tests 10:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:03 INFO - https://queue.taskcluster.net/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:47:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:47:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:47:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/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:47:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/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:47:05 INFO - Downloaded 1327 bytes. 10:47:05 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 10:47:05 INFO - Using the following test package requirements: 10:47:05 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:47:05 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:47:05 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:47:05 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:47:05 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 10:47:05 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:47:05 INFO - u'jsshell-linux-x86_64.zip'], 10:47:05 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:47:05 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:47:05 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 10:47:05 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:47:05 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 10:47:05 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:47:05 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 10:47:05 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:47:05 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:47:05 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 10:47:05 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:47:05 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:05 INFO - https://queue.taskcluster.net/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:47:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:47:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:47:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/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:47:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/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:47:06 INFO - Downloaded 24237168 bytes. 10:47:06 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:47:06 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:47:07 INFO - Return code: 0 10:47:07 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:47:07 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:47:07 INFO - https://queue.taskcluster.net/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:47:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:47:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 10:47:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/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:47:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/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:47:17 INFO - Downloaded 24237168 bytes. 10:47:17 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:47:17 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:47:18 INFO - Return code: 0 10:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:18 INFO - https://queue.taskcluster.net/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:47:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:47:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 10:47:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/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:47:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/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:47:19 INFO - Downloaded 10840145 bytes. 10:47:19 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:47:19 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:47:19 INFO - Return code: 0 10:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:19 INFO - https://queue.taskcluster.net/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:47:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:47:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:47:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/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:47:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/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:47:21 INFO - Downloaded 56017991 bytes. 10:47:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:47:21 INFO - mkdir: /builds/slave/test/properties 10:47:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:47:21 INFO - Writing to file /builds/slave/test/properties/build_url 10:47:21 INFO - Contents: 10:47:21 INFO - build_url:https://queue.taskcluster.net/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 10:47:22 INFO - Running post-action listener: _resource_record_post_action 10:47:22 INFO - Running post-action listener: set_extra_try_arguments 10:47:22 INFO - ##### 10:47:22 INFO - ##### Running populate-webroot step. 10:47:22 INFO - ##### 10:47:22 INFO - Running pre-action listener: _resource_record_pre_action 10:47:22 INFO - Running main action method: populate_webroot 10:47:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:47:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:47:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:47:22 INFO - '--tppagecycles', 10:47:22 INFO - '7'], 10:47:22 INFO - 'tests': ['tsvgm']}}, 10:47:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:47:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:47:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:47:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:47:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:47:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:47:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:22 INFO - 'talos_options': ['--disable-e10s'], 10:47:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:47:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:47:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:22 INFO - 'talos_options': ['--disable-e10s'], 10:47:22 INFO - 'tests': ['damp', 'tps']}, 10:47:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:22 INFO - 'tests': ['damp', 'tps']}, 10:47:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:47:22 INFO - 'tests': ['dromaeo_dom']}, 10:47:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:47:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:47:22 INFO - 'tests': ['a11yr', 10:47:22 INFO - 'ts_paint', 10:47:22 INFO - 'tpaint', 10:47:22 INFO - 'sessionrestore', 10:47:22 INFO - 'sessionrestore_no_auto_restore', 10:47:22 INFO - 'tabpaint']}, 10:47:22 INFO - 'other-e10s': {'tests': ['a11yr', 10:47:22 INFO - 'ts_paint', 10:47:22 INFO - 'tpaint', 10:47:22 INFO - 'sessionrestore', 10:47:22 INFO - 'sessionrestore_no_auto_restore', 10:47:22 INFO - 'tabpaint']}, 10:47:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:47:22 INFO - 'ts_paint', 10:47:22 INFO - 'tpaint', 10:47:22 INFO - 'sessionrestore', 10:47:22 INFO - 'sessionrestore_no_auto_restore', 10:47:22 INFO - 'tabpaint']}, 10:47:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:47:22 INFO - 'ts_paint', 10:47:22 INFO - 'tpaint', 10:47:22 INFO - 'sessionrestore', 10:47:22 INFO - 'sessionrestore_no_auto_restore', 10:47:22 INFO - 'tabpaint']}, 10:47:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:47:22 INFO - 'tests': ['a11yr', 10:47:22 INFO - 'ts_paint', 10:47:22 INFO - 'tpaint', 10:47:22 INFO - 'sessionrestore', 10:47:22 INFO - 'sessionrestore_no_auto_restore', 10:47:22 INFO - 'tabpaint']}, 10:47:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:47:22 INFO - 'tests': ['a11yr', 10:47:22 INFO - 'ts_paint', 10:47:22 INFO - 'tpaint', 10:47:22 INFO - 'sessionrestore', 10:47:22 INFO - 'sessionrestore_no_auto_restore', 10:47:22 INFO - 'tabpaint']}, 10:47:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:47:22 INFO - 'tests': ['tsvgx', 10:47:22 INFO - 'tsvgr_opacity', 10:47:22 INFO - 'tart', 10:47:22 INFO - 'tscrollx', 10:47:22 INFO - 'cart']}, 10:47:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:47:22 INFO - 'tsvgr_opacity', 10:47:22 INFO - 'tart', 10:47:22 INFO - 'tscrollx', 10:47:22 INFO - 'cart']}, 10:47:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:22 INFO - 'talos_options': ['--disable-e10s'], 10:47:22 INFO - 'tests': ['tp5o']}, 10:47:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:22 INFO - 'tests': ['tp5o']}, 10:47:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:22 INFO - 'talos_options': ['--disable-e10s', 10:47:22 INFO - '--xperf_path', 10:47:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:47:22 INFO - 'tests': ['tp5n']}, 10:47:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:22 INFO - 'talos_options': ['--xperf_path', 10:47:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:47:22 INFO - 'tests': ['tp5n']}}, 10:47:22 INFO - 'talos.zip': {'path': '', 10:47:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:47:22 INFO - Running post-action listener: _resource_record_post_action 10:47:22 INFO - ##### 10:47:22 INFO - ##### Running create-virtualenv step. 10:47:22 INFO - ##### 10:47:22 INFO - Running pre-action listener: _resource_record_pre_action 10:47:22 INFO - Running main action method: create_virtualenv 10:47:22 INFO - Creating virtualenv /builds/slave/test/build/venv 10:47:22 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:47:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:47:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:47:22 INFO - Using real prefix '/usr' 10:47:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:47:22 INFO - Installing distribute.............................................................................................................................................................................................done. 10:47:24 INFO - Installing pip.................done. 10:47:24 INFO - Return code: 0 10:47:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:47: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:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3af0fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14967d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525640>, '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 0x1526540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15269d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126', '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:47: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', 'pip>=1.5'] in /builds/slave/test/build 10:47: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 pip>=1.5 10:47:24 INFO - Using env: {'DISPLAY': ':0', 10:47:24 INFO - 'HOME': '/home/cltbld', 10:47:24 INFO - 'LANG': 'en_US.UTF-8', 10:47:24 INFO - 'LANGUAGE': 'en_US:en', 10:47:24 INFO - 'LOGNAME': 'cltbld', 10:47:24 INFO - 'MAIL': '/var/mail/cltbld', 10:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:24 INFO - 'MOZ_NO_REMOTE': '1', 10:47:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:24 INFO - 'NO_EM_RESTART': '1', 10:47:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:24 INFO - 'PWD': '/builds/slave/test', 10:47:24 INFO - 'SHELL': '/bin/bash', 10:47:24 INFO - 'SHLVL': '1', 10:47:24 INFO - 'TERM': 'linux', 10:47:24 INFO - 'TMOUT': '86400', 10:47:24 INFO - 'USER': 'cltbld', 10:47:24 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126', 10:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:24 INFO - '_': '/tools/buildbot/bin/python'} 10:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:25 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:47:25 INFO - Cleaning up... 10:47:25 INFO - Return code: 0 10:47:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:47:25 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:47:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:25 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:47:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:25 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 0x7f3af0fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14967d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525640>, '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 0x1526540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15269d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126', '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:47:25 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:47:25 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:47:25 INFO - Using env: {'DISPLAY': ':0', 10:47:25 INFO - 'HOME': '/home/cltbld', 10:47:25 INFO - 'LANG': 'en_US.UTF-8', 10:47:25 INFO - 'LANGUAGE': 'en_US:en', 10:47:25 INFO - 'LOGNAME': 'cltbld', 10:47:25 INFO - 'MAIL': '/var/mail/cltbld', 10:47:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:25 INFO - 'MOZ_NO_REMOTE': '1', 10:47:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:25 INFO - 'NO_EM_RESTART': '1', 10:47:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:25 INFO - 'PWD': '/builds/slave/test', 10:47:25 INFO - 'SHELL': '/bin/bash', 10:47:25 INFO - 'SHLVL': '1', 10:47:25 INFO - 'TERM': 'linux', 10:47:25 INFO - 'TMOUT': '86400', 10:47:25 INFO - 'USER': 'cltbld', 10:47:25 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126', 10:47:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:25 INFO - '_': '/tools/buildbot/bin/python'} 10:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:25 INFO - Downloading/unpacking psutil>=0.7.1 10:47:25 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:47:25 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:47:25 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:47:25 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:47:25 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:47:25 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:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:47:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:47:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:47:27 INFO - Installing collected packages: psutil 10:47:27 INFO - Running setup.py install for psutil 10:47:27 INFO - building 'psutil._psutil_linux' extension 10:47:27 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:47:27 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:47:27 INFO - building 'psutil._psutil_posix' extension 10:47:27 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:47:27 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:47:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:47:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:47:27 INFO - Successfully installed psutil 10:47:27 INFO - Cleaning up... 10:47:27 INFO - Return code: 0 10:47:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:27 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 0x7f3af0fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14967d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525640>, '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 0x1526540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15269d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126', '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:47:27 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:47:27 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:47:27 INFO - Using env: {'DISPLAY': ':0', 10:47:27 INFO - 'HOME': '/home/cltbld', 10:47:27 INFO - 'LANG': 'en_US.UTF-8', 10:47:27 INFO - 'LANGUAGE': 'en_US:en', 10:47:27 INFO - 'LOGNAME': 'cltbld', 10:47:27 INFO - 'MAIL': '/var/mail/cltbld', 10:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:27 INFO - 'MOZ_NO_REMOTE': '1', 10:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:27 INFO - 'NO_EM_RESTART': '1', 10:47:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:27 INFO - 'PWD': '/builds/slave/test', 10:47:27 INFO - 'SHELL': '/bin/bash', 10:47:27 INFO - 'SHLVL': '1', 10:47:27 INFO - 'TERM': 'linux', 10:47:27 INFO - 'TMOUT': '86400', 10:47:27 INFO - 'USER': 'cltbld', 10:47:27 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126', 10:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:27 INFO - '_': '/tools/buildbot/bin/python'} 10:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:47: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:47: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:47: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:47: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:47: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:47: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:47:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:47:30 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:47:30 INFO - Installing collected packages: mozsystemmonitor 10:47:30 INFO - Running setup.py install for mozsystemmonitor 10:47:30 INFO - Successfully installed mozsystemmonitor 10:47:30 INFO - Cleaning up... 10:47:30 INFO - Return code: 0 10:47:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:47:30 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:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:30 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:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:30 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 0x7f3af0fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14967d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525640>, '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 0x1526540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15269d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126', '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:47:30 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:47:30 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:47:30 INFO - Using env: {'DISPLAY': ':0', 10:47:30 INFO - 'HOME': '/home/cltbld', 10:47:30 INFO - 'LANG': 'en_US.UTF-8', 10:47:30 INFO - 'LANGUAGE': 'en_US:en', 10:47:30 INFO - 'LOGNAME': 'cltbld', 10:47:30 INFO - 'MAIL': '/var/mail/cltbld', 10:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:30 INFO - 'MOZ_NO_REMOTE': '1', 10:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:30 INFO - 'NO_EM_RESTART': '1', 10:47:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:30 INFO - 'PWD': '/builds/slave/test', 10:47:30 INFO - 'SHELL': '/bin/bash', 10:47:30 INFO - 'SHLVL': '1', 10:47:30 INFO - 'TERM': 'linux', 10:47:30 INFO - 'TMOUT': '86400', 10:47:30 INFO - 'USER': 'cltbld', 10:47:30 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126', 10:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:30 INFO - '_': '/tools/buildbot/bin/python'} 10:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:30 INFO - Downloading/unpacking blobuploader==1.2.4 10:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:32 INFO - Downloading blobuploader-1.2.4.tar.gz 10:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:47:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:47:32 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:47:32 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:47:32 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:47:32 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:47:32 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:47:32 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:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:47:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:47:32 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:47:32 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:47:32 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:47:32 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:47:32 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:47:32 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:47:32 INFO - Downloading docopt-0.6.1.tar.gz 10:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:47:33 INFO - Installing collected packages: blobuploader, requests, docopt 10:47:33 INFO - Running setup.py install for blobuploader 10:47:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:47:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:47:33 INFO - Running setup.py install for requests 10:47:33 INFO - Running setup.py install for docopt 10:47:33 INFO - Successfully installed blobuploader requests docopt 10:47:33 INFO - Cleaning up... 10:47:33 INFO - Return code: 0 10:47:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47: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:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:33 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 0x7f3af0fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14967d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525640>, '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 0x1526540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15269d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126', '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:47:33 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:47:33 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:47:33 INFO - Using env: {'DISPLAY': ':0', 10:47:33 INFO - 'HOME': '/home/cltbld', 10:47:33 INFO - 'LANG': 'en_US.UTF-8', 10:47:33 INFO - 'LANGUAGE': 'en_US:en', 10:47:33 INFO - 'LOGNAME': 'cltbld', 10:47:33 INFO - 'MAIL': '/var/mail/cltbld', 10:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:33 INFO - 'MOZ_NO_REMOTE': '1', 10:47:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:33 INFO - 'NO_EM_RESTART': '1', 10:47:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:33 INFO - 'PWD': '/builds/slave/test', 10:47:33 INFO - 'SHELL': '/bin/bash', 10:47:33 INFO - 'SHLVL': '1', 10:47:33 INFO - 'TERM': 'linux', 10:47:33 INFO - 'TMOUT': '86400', 10:47:33 INFO - 'USER': 'cltbld', 10:47:33 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126', 10:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:33 INFO - '_': '/tools/buildbot/bin/python'} 10:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:47:33 INFO - Running setup.py (path:/tmp/pip-R2taK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:47:33 INFO - Running setup.py (path:/tmp/pip-1dYenb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:47:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:47:33 INFO - Running setup.py (path:/tmp/pip-b6GDfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:47:34 INFO - Running setup.py (path:/tmp/pip-bgryEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:47:34 INFO - Running setup.py (path:/tmp/pip-tmN_uu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:47:34 INFO - Running setup.py (path:/tmp/pip-Fw3vJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:47:34 INFO - Running setup.py (path:/tmp/pip-EIaJwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:47:34 INFO - Running setup.py (path:/tmp/pip-on9OLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:47:34 INFO - Running setup.py (path:/tmp/pip-tgKcZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:47:34 INFO - Running setup.py (path:/tmp/pip-tZNi6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:47:34 INFO - Running setup.py (path:/tmp/pip-zkmvNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:47:34 INFO - Running setup.py (path:/tmp/pip-4VFxX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:47:34 INFO - Running setup.py (path:/tmp/pip-9T0WFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:47:34 INFO - Running setup.py (path:/tmp/pip-FLfWRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:34 INFO - Running setup.py (path:/tmp/pip-UwdYe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:47:34 INFO - Running setup.py (path:/tmp/pip-IVNTeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:47:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:47:34 INFO - Running setup.py (path:/tmp/pip-ccA71l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:47:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:47:35 INFO - Running setup.py install for manifestparser 10:47:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:47:35 INFO - Running setup.py install for mozcrash 10:47:35 INFO - Running setup.py install for mozdebug 10:47:35 INFO - Running setup.py install for mozdevice 10:47:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:47:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:47:35 INFO - Running setup.py install for mozfile 10:47:35 INFO - Running setup.py install for mozhttpd 10:47:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:47:35 INFO - Running setup.py install for mozinfo 10:47:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:47:35 INFO - Running setup.py install for mozInstall 10:47:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:47:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:47:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:47:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:47:35 INFO - Running setup.py install for mozleak 10:47:35 INFO - Running setup.py install for mozlog 10:47:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:47:36 INFO - Running setup.py install for moznetwork 10:47:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:47:36 INFO - Running setup.py install for mozprocess 10:47:36 INFO - Running setup.py install for mozprofile 10:47:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:47:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:47:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:47:36 INFO - Running setup.py install for mozrunner 10:47:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:47:36 INFO - Running setup.py install for mozscreenshot 10:47:36 INFO - Running setup.py install for moztest 10:47:36 INFO - Running setup.py install for mozversion 10:47:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:47:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:47:36 INFO - Cleaning up... 10:47:36 INFO - Return code: 0 10:47:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47: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:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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:47:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:36 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 0x7f3af0fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14967d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525640>, '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 0x1526540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15269d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126', '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:47:36 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:47:36 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:47:36 INFO - Using env: {'DISPLAY': ':0', 10:47:36 INFO - 'HOME': '/home/cltbld', 10:47:36 INFO - 'LANG': 'en_US.UTF-8', 10:47:36 INFO - 'LANGUAGE': 'en_US:en', 10:47:36 INFO - 'LOGNAME': 'cltbld', 10:47:36 INFO - 'MAIL': '/var/mail/cltbld', 10:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:36 INFO - 'MOZ_NO_REMOTE': '1', 10:47:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:36 INFO - 'NO_EM_RESTART': '1', 10:47:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:36 INFO - 'PWD': '/builds/slave/test', 10:47:36 INFO - 'SHELL': '/bin/bash', 10:47:36 INFO - 'SHLVL': '1', 10:47:36 INFO - 'TERM': 'linux', 10:47:36 INFO - 'TMOUT': '86400', 10:47:36 INFO - 'USER': 'cltbld', 10:47:36 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126', 10:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:36 INFO - '_': '/tools/buildbot/bin/python'} 10:47:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:47:37 INFO - Running setup.py (path:/tmp/pip-2k4iId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:47:37 INFO - Running setup.py (path:/tmp/pip-wIy7so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:47:37 INFO - Running setup.py (path:/tmp/pip-LICXmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:47:37 INFO - Running setup.py (path:/tmp/pip-RHknyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:47:37 INFO - Running setup.py (path:/tmp/pip-LKrGOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:47:37 INFO - Running setup.py (path:/tmp/pip-3Wg35C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:47:37 INFO - Running setup.py (path:/tmp/pip-zFz1fn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:47:37 INFO - Running setup.py (path:/tmp/pip-FK8QS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:47:37 INFO - Running setup.py (path:/tmp/pip-f_TIXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:47:37 INFO - Running setup.py (path:/tmp/pip-cXiOjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:47:37 INFO - Running setup.py (path:/tmp/pip-lG7hKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:47:37 INFO - Running setup.py (path:/tmp/pip-rNm_q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:47:37 INFO - Running setup.py (path:/tmp/pip-n1j62l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:47:37 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:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:47:37 INFO - Running setup.py (path:/tmp/pip-1oZGYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:47:38 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:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:38 INFO - Running setup.py (path:/tmp/pip-UHg379-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:38 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:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:47:38 INFO - Running setup.py (path:/tmp/pip-PBoqPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:47:38 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:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:47:38 INFO - Running setup.py (path:/tmp/pip-JPxo9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:47:38 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:47:38 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:47:38 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:47:38 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:47:38 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:47:38 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:47:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:47:38 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:47:38 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:47:38 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:47:38 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:47:38 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:47:38 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:47:40 INFO - Downloading blessings-1.6.tar.gz 10:47:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:47:40 INFO - Installing collected packages: blessings 10:47:40 INFO - Running setup.py install for blessings 10:47:40 INFO - Successfully installed blessings 10:47:40 INFO - Cleaning up... 10:47:40 INFO - Return code: 0 10:47:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:47:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:47:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:47:40 INFO - Reading from file tmpfile_stdout 10:47:40 INFO - Current package versions: 10:47:40 INFO - argparse == 1.2.1 10:47:40 INFO - blessings == 1.6 10:47:40 INFO - blobuploader == 1.2.4 10:47:40 INFO - docopt == 0.6.1 10:47:40 INFO - manifestparser == 1.1 10:47:40 INFO - mozInstall == 1.12 10:47:40 INFO - mozcrash == 0.17 10:47:40 INFO - mozdebug == 0.1 10:47:40 INFO - mozdevice == 0.48 10:47:40 INFO - mozfile == 1.2 10:47:40 INFO - mozhttpd == 0.7 10:47:40 INFO - mozinfo == 0.9 10:47:40 INFO - mozleak == 0.1 10:47:40 INFO - mozlog == 3.1 10:47:40 INFO - moznetwork == 0.27 10:47:40 INFO - mozprocess == 0.22 10:47:40 INFO - mozprofile == 0.28 10:47:40 INFO - mozrunner == 6.11 10:47:40 INFO - mozscreenshot == 0.1 10:47:40 INFO - mozsystemmonitor == 0.0 10:47:40 INFO - moztest == 0.7 10:47:40 INFO - mozversion == 1.4 10:47:40 INFO - psutil == 3.1.1 10:47:40 INFO - requests == 1.2.3 10:47:40 INFO - wsgiref == 0.1.2 10:47:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47:40 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:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:40 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:47:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:40 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 0x7f3af0fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14967d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525640>, '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 0x1526540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15269d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126', '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:47:40 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:47:40 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:47:40 INFO - Using env: {'DISPLAY': ':0', 10:47:40 INFO - 'HOME': '/home/cltbld', 10:47:40 INFO - 'LANG': 'en_US.UTF-8', 10:47:40 INFO - 'LANGUAGE': 'en_US:en', 10:47:40 INFO - 'LOGNAME': 'cltbld', 10:47:40 INFO - 'MAIL': '/var/mail/cltbld', 10:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:40 INFO - 'MOZ_NO_REMOTE': '1', 10:47:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:40 INFO - 'NO_EM_RESTART': '1', 10:47:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:40 INFO - 'PWD': '/builds/slave/test', 10:47:40 INFO - 'SHELL': '/bin/bash', 10:47:40 INFO - 'SHLVL': '1', 10:47:40 INFO - 'TERM': 'linux', 10:47:40 INFO - 'TMOUT': '86400', 10:47:40 INFO - 'USER': 'cltbld', 10:47:40 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126', 10:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:40 INFO - '_': '/tools/buildbot/bin/python'} 10:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:40 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:47:40 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:47:40 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:47:40 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:47:40 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:47:40 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:47:40 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:47:40 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:47:40 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:47:40 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:47:40 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:47:40 INFO - Cleaning up... 10:47:40 INFO - Return code: 0 10:47:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:47:40 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:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:40 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:47:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:40 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 0x7f3af0fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14967d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525640>, '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 0x1526540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15269d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126', '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:47:40 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:47:40 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:47:40 INFO - Using env: {'DISPLAY': ':0', 10:47:40 INFO - 'HOME': '/home/cltbld', 10:47:40 INFO - 'LANG': 'en_US.UTF-8', 10:47:40 INFO - 'LANGUAGE': 'en_US:en', 10:47:40 INFO - 'LOGNAME': 'cltbld', 10:47:40 INFO - 'MAIL': '/var/mail/cltbld', 10:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:40 INFO - 'MOZ_NO_REMOTE': '1', 10:47:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:40 INFO - 'NO_EM_RESTART': '1', 10:47:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:40 INFO - 'PWD': '/builds/slave/test', 10:47:40 INFO - 'SHELL': '/bin/bash', 10:47:40 INFO - 'SHLVL': '1', 10:47:40 INFO - 'TERM': 'linux', 10:47:40 INFO - 'TMOUT': '86400', 10:47:40 INFO - 'USER': 'cltbld', 10:47:40 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126', 10:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:40 INFO - '_': '/tools/buildbot/bin/python'} 10:47:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:41 INFO - Downloading/unpacking jsonschema 10:47: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:47: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:47: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:47: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:47: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:47: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:47:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:47:42 INFO - Downloading/unpacking functools32 (from jsonschema) 10:47: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:47: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:47: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:47: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:47: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:47: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:47:43 INFO - Downloading functools32-3.2.3-2.tar.gz 10:47:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:47:43 INFO - warning: no files found matching '*.txt' 10:47:43 INFO - no previously-included directories found matching 'build' 10:47:43 INFO - no previously-included directories found matching 'dist' 10:47:43 INFO - no previously-included directories found matching '.git*' 10:47:43 INFO - Installing collected packages: jsonschema, functools32 10:47:43 INFO - Running setup.py install for functools32 10:47:43 INFO - warning: no files found matching '*.txt' 10:47:43 INFO - no previously-included directories found matching 'build' 10:47:43 INFO - no previously-included directories found matching 'dist' 10:47:43 INFO - no previously-included directories found matching '.git*' 10:47:43 INFO - Successfully installed jsonschema functools32 10:47:43 INFO - Cleaning up... 10:47:43 INFO - Return code: 0 10:47:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:47:43 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:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:43 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:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:43 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 0x7f3af0fa7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14967d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525640>, '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 0x1526540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15269d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126', '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:47:43 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:47:43 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:47:43 INFO - Using env: {'DISPLAY': ':0', 10:47:43 INFO - 'HOME': '/home/cltbld', 10:47:43 INFO - 'LANG': 'en_US.UTF-8', 10:47:43 INFO - 'LANGUAGE': 'en_US:en', 10:47:43 INFO - 'LOGNAME': 'cltbld', 10:47:43 INFO - 'MAIL': '/var/mail/cltbld', 10:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:43 INFO - 'MOZ_NO_REMOTE': '1', 10:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:43 INFO - 'NO_EM_RESTART': '1', 10:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:43 INFO - 'PWD': '/builds/slave/test', 10:47:43 INFO - 'SHELL': '/bin/bash', 10:47:43 INFO - 'SHLVL': '1', 10:47:43 INFO - 'TERM': 'linux', 10:47:43 INFO - 'TMOUT': '86400', 10:47:43 INFO - 'USER': 'cltbld', 10:47:43 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126', 10:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:43 INFO - '_': '/tools/buildbot/bin/python'} 10:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:43 INFO - Downloading/unpacking flake8 10:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:47:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:47:45 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:47:45 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:47:45 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:47:45 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:47:45 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:47:45 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:47:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:47:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:47:45 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:47:45 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:47:45 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:47:45 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:47:45 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:47:45 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:47:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:47:45 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:47:45 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:47:45 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:47:45 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:47:45 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:47:45 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:47:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:47:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:47:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:47:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:47:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:47:46 INFO - no previously-included directories found matching 'docs/_build' 10:47:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:47:46 INFO - Running setup.py install for pep8 10:47:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:47:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:47:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:47:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:47:46 INFO - no previously-included directories found matching 'docs/_build' 10:47:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:47:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:47:46 INFO - Cleaning up... 10:47:46 INFO - Return code: 0 10:47:46 INFO - Running post-action listener: _resource_record_post_action 10:47:46 INFO - Running post-action listener: _start_resource_monitoring 10:47:46 INFO - Starting resource monitoring. 10:47:46 INFO - ##### 10:47:46 INFO - ##### Running install step. 10:47:46 INFO - ##### 10:47:46 INFO - Running pre-action listener: _resource_record_pre_action 10:47:46 INFO - Running main action method: install 10:47:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:47:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:47:46 INFO - Reading from file tmpfile_stdout 10:47:46 INFO - Detecting whether we're running mozinstall >=1.0... 10:47:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:47:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:47:46 INFO - Reading from file tmpfile_stdout 10:47:46 INFO - Output received: 10:47:46 INFO - Usage: mozinstall [options] installer 10:47:46 INFO - Options: 10:47:46 INFO - -h, --help show this help message and exit 10:47:46 INFO - -d DEST, --destination=DEST 10:47:46 INFO - Directory to install application into. [default: 10:47:46 INFO - "/builds/slave/test"] 10:47:46 INFO - --app=APP Application being installed. [default: firefox] 10:47:46 INFO - mkdir: /builds/slave/test/build/application 10:47:46 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:47:46 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:48:00 INFO - Reading from file tmpfile_stdout 10:48:00 INFO - Output received: 10:48:00 INFO - /builds/slave/test/build/application/firefox/firefox 10:48:00 INFO - Running post-action listener: _resource_record_post_action 10:48:00 INFO - ##### 10:48:00 INFO - ##### Running run-tests step. 10:48:00 INFO - ##### 10:48:00 INFO - Running pre-action listener: _resource_record_pre_action 10:48:00 INFO - Running main action method: run_tests 10:48:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:48:00 INFO - Python 2.7.3 10:48:00 INFO - Return code: 0 10:48:00 INFO - grabbing minidump binary from tooltool 10:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:48:00 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1525640>, '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 0x1526540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15269d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:48:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:48:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:48:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:48:00 INFO - Return code: 0 10:48:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:48:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:48:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:48:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:48:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:48:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:48:01 INFO - Return code: 0 10:48:01 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/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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:48:01 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/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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:48:01 INFO - Using env: {'DISPLAY': ':0', 10:48:01 INFO - 'HOME': '/home/cltbld', 10:48:01 INFO - 'LANG': 'en_US.UTF-8', 10:48:01 INFO - 'LANGUAGE': 'en_US:en', 10:48:01 INFO - 'LOGNAME': 'cltbld', 10:48:01 INFO - 'MAIL': '/var/mail/cltbld', 10:48:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:48:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:01 INFO - 'MOZ_NO_REMOTE': '1', 10:48:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:01 INFO - 'NO_EM_RESTART': '1', 10:48:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:01 INFO - 'PWD': '/builds/slave/test', 10:48:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:48:01 INFO - 'SHELL': '/bin/bash', 10:48:01 INFO - 'SHLVL': '1', 10:48:01 INFO - 'TERM': 'linux', 10:48:01 INFO - 'TMOUT': '86400', 10:48:01 INFO - 'USER': 'cltbld', 10:48:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126', 10:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:01 INFO - '_': '/tools/buildbot/bin/python'} 10:48:01 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/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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:48:01 INFO - mozversion application_buildid: 20160701074922 10:48:01 INFO - mozversion application_changeset: 4c7636b942946b1057c6f8fe5ae92377011a86bf 10:48:01 INFO - mozversion application_display_name: Firefox 10:48:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:48:01 INFO - mozversion application_name: Firefox 10:48:01 INFO - mozversion application_remotingname: firefox 10:48:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:48:01 INFO - mozversion application_vendor: Mozilla 10:48:01 INFO - mozversion application_version: 48.0 10:48:01 INFO - mozversion platform_buildid: 20160701074922 10:48:01 INFO - mozversion platform_changeset: 4c7636b942946b1057c6f8fe5ae92377011a86bf 10:48:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:48:01 INFO - mozversion platform_version: 48.0 10:48:01 INFO - using testdate: 1467395281 10:48:01 INFO - actual date: 1467395281 10:48:01 INFO - starting webserver on 'localhost:59758' 10:48:01 INFO - SUITE-START | Running 2 tests 10:48:01 INFO - TEST-START | dromaeo_css 10:48:01 INFO - operating with platform_type : linux_ 10:48:01 INFO - Initialising browser for dromaeo_css test... 10:48:01 INFO - TEST-INFO | started process 3822 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7s0Mwz/profile http://localhost:59758/getInfo.html) 10:48:04 INFO - PROCESS | 3822 | 10:48:04 INFO - PROCESS | 3822 | (process:3901): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:48:05 INFO - PROCESS | 3822 | __metrics Screen width/height:1600/1200 10:48:05 INFO - PROCESS | 3822 | colorDepth:24 10:48:05 INFO - PROCESS | 3822 | Browser inner width/height: 1024/697 10:48:05 INFO - PROCESS | 3822 | __metrics 10:48:06 ERROR - PROCESS | 3822 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:48:06 INFO - TEST-INFO | 3822: exit 0 10:48:06 INFO - Browser initialized. 10:48:06 INFO - Running cycle 1/1 for dromaeo_css test... 10:48:06 INFO - TEST-INFO | started process 3952 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7s0Mwz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:48:08 INFO - PROCESS | 3952 | 10:48:08 INFO - PROCESS | 3952 | (process:4021): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:48:18 INFO - PROCESS | 3952 | RSS: Main: 150724608 10:48:18 INFO - PROCESS | 3952 | 10:49:08 INFO - PROCESS | 3952 | 1467395348137 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] 10:51:15 INFO - PROCESS | 3952 | Cycle 1(1): loaded http://localhost:59758/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59758/tests/dromaeo/cssquery-ext.html) 10:51:16 INFO - PROCESS | 3952 | RSS: Main: 156069888 10:51:16 INFO - PROCESS | 3952 | 10:54:18 INFO - PROCESS | 3952 | Cycle 1(1): loaded http://localhost:59758/tests/dromaeo/cssquery-ext.html (next: http://localhost:59758/tests/dromaeo/cssquery-jquery.html) 10:54:18 INFO - PROCESS | 3952 | RSS: Main: 152961024 10:54:18 INFO - PROCESS | 3952 | 10:57:20 INFO - PROCESS | 3952 | Cycle 1(1): loaded http://localhost:59758/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59758/tests/dromaeo/cssquery-mootools.html) 10:57:21 INFO - PROCESS | 3952 | RSS: Main: 153083904 10:57:21 INFO - PROCESS | 3952 | 11:00:22 INFO - PROCESS | 3952 | Cycle 1(1): loaded http://localhost:59758/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59758/tests/dromaeo/cssquery-prototype.html) 11:00:23 INFO - PROCESS | 3952 | RSS: Main: 154050560 11:00:23 INFO - PROCESS | 3952 | 11:03:25 INFO - PROCESS | 3952 | Cycle 1(1): loaded http://localhost:59758/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59758/tests/dromaeo/cssquery-yui.html) 11:03:26 INFO - PROCESS | 3952 | RSS: Main: 152596480 11:03:26 INFO - PROCESS | 3952 | 11:06:28 INFO - PROCESS | 3952 | Cycle 1(1): loaded http://localhost:59758/tests/dromaeo/cssquery-yui.html (next: http://localhost:59758/tests/dromaeo/cssquery-dojo.html) 11:06:28 INFO - PROCESS | 3952 | RSS: Main: 156381184 11:06:28 INFO - PROCESS | 3952 | 11:06:28 INFO - PROCESS | 3952 | __start_tp_report 11:06:28 INFO - PROCESS | 3952 | _x_x_mozilla_page_load 11:06:28 INFO - PROCESS | 3952 | _x_x_mozilla_page_load_details 11:06:28 INFO - PROCESS | 3952 | |i|pagename|runs| 11:06:28 INFO - PROCESS | 3952 | |0;dojo.html;3316.3864685033273;3332.6833950774667;3337.7997320160794;3370.140614143393;3379.2903490267045;5585.497305242528;5595.076812325967;5601.663900165993;5630.296212973379;5638.464345887144;5593.105103183491;5621.522170615503;5647;5649.689267090308;5652.886942261152;5098.464661210575;5140.33175687162;5156.510131537498;5159.922601160985;5175.404828444721;5149.253358263049;5202.92195617066;5283.1546952487415;5287.550558202557;5291.179867120583;5067.189249720045;5103.260027296058;5134.332536770215;5192.091384007803;5292.285541451913;5129.487051294878;5144.6141539384325;5151.81968631098;5159.948400516022;5164.793408263665;4932.827351042696;4974.701517908937;5042.470540593222;5091.032703786269;5101.617378696613;5435.374931882805;5475.288212532385;5493.478119578634;5517.2551705519645;5569.832905012856;5828.9417105828825;5876.97061514694;5877.441643043904;5887.970560147171;5904.645721256738;5831.475167234927;5915.3788852170765;5930.881382372371;5950.256217972754;6067.817965461043;5668.829935101912;5756.050251708463;5756.539476841843;5758.049921762904;5797.304323481167;6238.376162383725;6238.875222495525;6249.312575616678;6258.874822503615;6276.529260305404;5803.738831752581;5880.294364676266;5966.880662386815;5991.5206783457215;6006;6118.694065296806;6130.785422510191;6132.202813634199;6137.140800287963;6149.938500615026;6058.606190597597;6072.483838873657;6076.4531192192035;6109.14471973924;6110.908336374958;5741.339745929188;5967.16459695643;6034.1853849730605;6086.452219300196;6088.847778805565;4610.170169369479;4619.214733495247;4619.722816631013;4634.72191668501;4639.327297541838;4132.070284186034;4149.315362965077;4160.50073991123;4160.958390416117;4172.561881002512;5685.289338832646;5728.77084916607;5782.884342313214;5798.246227990334;5835.270591176103;5851.444112809277;5951.821445356646;5952.375000624958;5954.851128721816;5994.0409534474275;5683.147527870852;5801.419858014249;5841.912371314349;5844.357120716718;5863.061910094364;5010.49895010496;5058.064258112261;5072.416672082684;5082.085224659597;5094.363204599425;6260.060990851318;6281.842953926097;6296.0555916612875;6323.557350985387;6332.746690132435;5928.703564821655;6015.879682406415;6077.361877003028;6098.146259523582;6102.755889764359;6183.659898705614;6200.81397558056;6227.532935029982;6234.906476402767;6249;5896.734646940984;5896.911546326723;5899.410058994066;5916.171735956884;5934.050551911673;5859.091840764689;5918.201042859331;6007.789727359522;6014.278286605635;6059.575829692056;5918.940810591839;5922.851928701817;5924.259467566554;5928.970355148197;5939.554533409925;5837.503812176013;5862.472377486047;5900.940990590211;5904.498117660047;5904.527637789052;5542.307211598551;5746.511546518593;5809.448102430262;5845.152452894392;5875.73559189846;5988.131720900532;5995.6702381367695;6006.939930600638;6045.697715114139;6047.425494578008;5865;5901.793437229677;5902.291724993029;5903.26209223847;5920.407959204045 11:06:28 INFO - PROCESS | 3952 | |1;ext.html;670.6546128743698;685.1059367525378;689.9478295599212;730.0837449001502;751.9774406767797;33589;39254;39505.40741888874;39541.802290988504;39576.2084758305;44851.77574112125;45381.09237815242;45471;45496.54503454964;45536.31695524562;8785.121487851196;8986.191242788147;8991;8996.100389960984;9039.909600903973;8843.95578022109;8925.107489251088;8934.10658934108;8944.8658270126;8946.64213431462;9147.908520914772;9188.954055229748;9203.263738900905;9228.215601673866;9236.630534778635;9149.63401463944;9149.95425022874;9171.908280917205;9172.357934944557;9178.449293042439;9016.278697704169;9122.5438728064;9143.359964802466;9148.176664100263;9176.220021298197;43245.837708114785;43775.34336984948;43787.78106109449;43819.56180438187;44010.77994610006;3839.6736277416453;3906.726529142961;3955.5055618047745;4028.516578010628;4642.930356044662;33830.323393532235;33930.66069339324;34273.48589771155;34315.6568434315;34346.656533434594;4159.438475805758;4338;4363.629091527224;4364.454443194601;4375.409319741826;321431;321856;322277;323753.38123309467;324656;62979.37020629827;64276.35723642704;64316;64499.35500644933;64704;72323.6383818088;73242.63378683073;73248.63375683194;73337;73387.63306183435;15896.443624473319;15898.920505397398;16020.75968860468;16050.598735031717;16087.276072576527;12023.63929082129;12091.637250882488;12135.15053946233;12144.878551214375;12194.451249693786;20474;20618.381448556567;20714.067866946025;20743.377698669065;21716.457088572595;8033;8090.555019473985;8271.54506502148;8285.95857020723;8321.916780832235;1180.8582970043478;1196.7845787758288;1219.378117160237;1240.9451965828973;1250.6060590913833;30512.847435763124;31588.52617210744;32271;35806;36198;1159.7680463907252;1218;1221.1574013930538;1243.421808858885;1283.5315109984974;16684.6663066738;17358.218880150424;17520.561985950455;17535.73696394555;17790.37733679315;496943;501162;524727;574889;580213;58568.414315856295;59588.5102872423;59693;59849;59870.10194847081;1491.888108391875;1546.9922650386902;1552.7205103081553;1554.6268895465007;1556.8131824180944;31232.531512026882;31942.20144496313;32024.51963220507;32603.34793304073;33180.83409582936;56076;56680;56787.71606141943;56818;56928.43071569231;438169;444973;445920;446161;446560;31952.84023579867;32016.51975220327;32407.51388729218;32450.188745281557;32560.185995350304;52293.7385313071;52351.476485236184;52393.166239181446;53005;54023.189652156034;42987.78506107449;43467.56532434762;43481.130377391644;43795;44325;43812;44492.77753611211;44696.32955505605;44785.10429791451;45023.774881125384;44654.3301850466;45283.773581131885;45389.54610453853;45505.54494455145;45508;37502.249955001294;37619;38426;38811.61188388193;39188;29130.854345728134;30018.24954376158;30175.849120754257;30419.695803041686;30809.8459507701 11:06:28 INFO - PROCESS | 3952 | |2;jquery.html;432.8463395494599;438.3162266863693;448.2379954078068;448.60260289199147;459.9586037256646;18908.48732101432;18979.71530427043;19472.610547789034;19876.304329348477;19896.90051549744;17743.822561774377;17936.013519256467;19960.600787984233;20323.59352812943;20484.69272960907;4231.428757117788;5819.912701309484;6006.819795406123;6007.219061521996;6013.128096426038;5655.236543066695;5904.734286957076;5925.229720136376;5961.433663801932;5984.611000284989;5651.632643878155;5902.704864756766;5938.317093534234;5940.524758019348;5943.435373639497;5857.970710146444;5911.940880591182;5930.762769489215;5943.494802941756;5949.137375080611;5696.601237913348;5961.791337303173;6101.847453813646;6115.541334399938;6139.662318572477;14740.705185896222;15079.698406031817;15265.847341526554;23484;24219.152329668552;2454.275988583372;2479;2524.2553446733073;2547.7961763059097;2628.5925681519393;11806.822897656542;14295.642608934755;14781.408743650241;14905.776413353808;15395.461158859498;2072.3161356752234;2107.6417009108486;2110.9788902110936;2113.7146485224607;2140.5076832328496;83993.16006839975;84061.57969210176;84412.57793711053;85684.57157714234;86709;11511.769764604662;11835.171537992257;11897.524099036114;11930.343831089373;12022.398880055962;16716.83283167177;16843.91578042102;16854.41009564659;16859.662806743796;16931.576710582332;8369.455985360932;8401.873971890427;8431.662733490592;8501.574921253912;8517.914820851713;7931.2068793120225;7941;7961;8018.118007019223;8057.113717491071;5147.742612869416;5152.227165925066;5186.714730689773;5225.4774522548205;5233.084210263189;3511.2626348466597;3753.7560058596105;3842.6733727632904;3907.902302442462;3913.92172156561;945.7824700318965;1028.321307936758;1040.5785656808853;1047.209356935524;1115.8493603363604;18174.273029078955;19013.524661883286;19644.803551964582;19845;20102.09540570678;1039.194624166262;1059.920505962056;1076.7146706122883;1085.10478854945;1102.4818335382358;9261.629534818532;11310.547578096948;11330.490127944262;11390.886091139148;11464.828027579593;519526;524030;529658;538271;542336;91873.54063229641;92439;94649.5267523658;96557.51721241348;96768;1074.97312567188;1106.833974903771;1132.4903793293051;1143.1597775634903;1147.1281825812443;17406.39077632277;17442.302307907543;17708;17712.734308985633;17864.91067544706;39240.803795980835;39587.20825583414;40305.79847100746;40308.59691403166;40502;54780.72609636926;58797.70601146967;59016.40983590281;59121;59351.40648593631;9200.171984521425;9232.446053236827;9352.85313562444;9392.530373481435;9438.103380178873;12539;13846.238456884968;14024.859751402355;14037.087589306662;14085.788713169515;11769.882301176878;12076.939615301868;12149;12288.262704237774;12698.682532936751;11814.936655701029;11912.940435297767;12075.879241207476;12109.69725756828;12135.75728485443;12444.377781110727;12525.185862918881;12641.304728240035;12660.113792034837;12721.109522333718;8908.955455222682;9000.819983600422;9093.454392736458;9291.396059256127;9368.906310936803;11819.645410637695;12326;12363.443645035815;12368;12402.627921162379 11:06:28 INFO - PROCESS | 3952 | |3;mootools.html;1569.152657564915;1575.7872687187225;1785.2323500894618;1911.7132430135487;1916.2622390379718;8428.283595894349;8463.999999999985;8612.569371531421;8643.265322447583;8689.478631282127;8742.475451472916;8761.342899282547;8828.514431706253;8836.248918841906;8850.91149088509;2467.8272520923542;2475.6905386826647;2481.702195736514;2484.5776218042884;2491.7757401833833;2470.407102295454;2492.4142826435864;2494.4387512809562;2494.9251522454265;2497.1384872219055;2496.425822060927;2503.5368456835454;2504.261242933339;2508.423062695581;2517.5216708825265;2428.538577670237;2464.3346296499844;2474;2478.615814548739;2492.0654754467073;2452.4359397338535;2462.22439931421;2463.531928933497;2480.131953816168;2491.3273416177713;8688.869666955;8739;8762.912370876273;8820;8830.24942879856;5239.973800131013;5373.194020896896;5395.379531353905;5404.4325345838515;5407.053765591045;3508.368493671164;3509.3683137035323;3580.4092324766384;3595.7482976191677;3627.183883626163;1192.7435601345753;1209.2019267283638;1220.2373516552154;1242.0498318786135;1266.6643339515035;12060.035197184205;12105.515779368727;12125.333106679129;12131.757364852654;12158.756824863542;4336.3278691802825;4363.956360436418;4473.038296766211;4478.641708663299;4480.529544397857;9120.908790912139;9148.451092934445;9156.175944164925;9169.40398874071;9221.53892305382;5135.486451354835;5138.486151384832;5139.486051394905;5144.6655967362;5180.404253510819;4722.574968252874;4846.39420072491;4895.143349913751;4943.752812359367;4953.90092198154;3896.1818018215927;3949;3968.7817170055346;3975.383815508601;4071.5521292657786;1182.2079206931376;1191.0293111114413;1191.0352614382377;1199.316389657904;1233.734747029393;872.4590753732726;981.7202097402206;997.7505623594102;1046.785408991155;1076.2950267574595;5990.9700451497465;6021.939780602225;6043.305019922677;6043.7280322385595;6206.286277078104;452.38927447945014;452.4977275224498;453.96822222444774;479.7936887138564;483.9733814640158;3995.420664003703;4039.111395492987;4050.0684842486394;4060.2082593893906;4099.098198396348;10446.373217606968;10927.945360273148;10956.397398143019;10969.945150274198;10971.83542246867;10731.731706707238;10734.463276836126;10736.57053717858;10751.301165424222;10791.244612877023;7832.608369581498;8011.319037881729;8026.27763501276;8325.292350150305;8325.625346859406;5805.564582656233;5827.5337972961215;5845.503132233808;5930.406959304208;5967.910481342697;9215.262778977532;9283.257339412965;9393.201577865684;9420.858687119835;9582.856257156009;9426.245900328095;9527.618895244113;9576.23390128774;9580.377275477073;9599.856002159833;7335.266473352622;7341.082364704412;7503.887441688488;7547.73582924595;7555.848883022419;8360.28937540316;8368.958155209186;8378.706745263886;8396.286315663237;8402.663893444194;7342.70629174827;7381.704731810883;7497.700091996259;7561.5085019475755;7618.619069046415;7555.357794587521;7580.696772129274;7588.430867684835;7603.201663825219;7720.806979825549;6671.33286671329;6678.49911256648;6700.865982680221;6710.060591517289;6747.257801641717;5035.320231768665;5066.113430149783;5155.613329000265;5187.351581052369;5221.112410890082;4932;5092.949070509396;5136.768845402041;5137.768800403916;5202.843914682566 11:06:28 INFO - PROCESS | 3952 | |4;prototype.html;346.95663042119725;348.9023073539409;351.6343003276593;351.64659517185225;353.89029400885744;6457.935420645792;6542.116814230078;6598.439132673729;6609.173853268329;6618.933810661892;6542.084108224853;6547.3125321841235;6553.180852393451;6555.672216389174;6578.473722102232;4799.304100905367;4926.285688575154;4928.310036594879;4946.282788995593;4949.480304568023;4921.384826896638;4921.458639549646;4925.26121081837;4941.332920055783;4950.702957822524;4885.462599114095;4889.535494128052;4897.751073476258;4902.509749025086;4903.607711383099;4881.585065269439;4892;4893.4617192108835;4894.657373983822;4894.926576101361;4252.2345977724;4255.489341279035;4255.659547236213;4259.12687898983;4261.041265715189;6072.757089716406;6266.780662676784;6302.243730752293;6305.180326557564;6314.4001319875;5684.971575142098;5709.8287051388525;5715.799947001877;5719.771209151629;5727.11229759388;6896.448284137257;6903.930960690379;6905.482088843357;6906.06768086307;6906.965465172642;4697.0840686065885;4702.3416721659;4706.858794236178;4707.388039554836;4714.976425117887;7153.570785752871;7158.391536719385;7164.0328555645365;7218.855622887565;7221.4944953853255;4701.764911754467;4771.117343291433;4790.880227994258;4798.520147985243;4805.591524720368;4829.348038014823;4837.05677392912;4844.055409195244;4852.781624826891;4853.6602437829015;5663.178839068312;5677.545796336283;5690.772369105272;5703.08750599902;5714.685692286964;6928.688209030605;6930.861382772317;6970.477214208955;6970.616616086062;6996.8950465743055;1690.1549225387307;1726.9481915542553;1727.5767436978022;1728.6024214430752;1730.4462571977099;1084.837274408845;1118.2060736876747;1121.61864965912;1126.4030064066058;1132.841402203692;6741.528093033538;6760.594364338057;6762.898556521656;6764.661766911733;6766.424853887376;7115.5730656160795;7157.856842863113;7191.712331506681;7208.27917208275;7208.315210055036;6566.1135746674545;6671.899921501182;6706.564073335315;6711.664416779239;6774.085498457744;3885.1646895916947;3899.200663863901;3903.1608204236227;3919.098607320332;3923.705722070856;7509.13644930829;7514.0607424071995;7543.50967187142;7590.1650818409935;7592.316691497792;7285.344319011315;7393.889091663629;7404.074490688664;7439.702411903571;7459.254074592497;7562;7563.243675632502;7566.394688424913;7570.394368450621;7578.12851522071;7190.7483238086415;7190.784276471714;7198.5320954137815;7219.278072192738;7228.819279518054;7124;7141.178764442156;7141.357277845019;7145.642717863982;7157.534760240567;7393.889091663522;7550.509216900884;7552.584607846401;7563.432742544442;7580.128285247047;4851.539103785135;4866.95133048665;4894.388201474816;4895.363602731622;4896.436909755424;7254.165770936199;7256;7256.7097316106765;7257.673404696696;7264.527805692613;7000.894986575104;7009.334113259232;7015.719371225094;7015.929840701732;7024.824379390556;6874.312568743086;6964.025036494793;7006.334398232159;7007.754728584475;7022.08712867324;6814.2163651180745;6878.38094571491;6878.965605171942;6887.621180835102;6894.620795856276;6968.198657154492;7024.26245244242;7040.295970402919;7043.260457652078;7046.295370462913;6846.144231971004;6864.107666003388;6870.553414028072;6873.20958089806;6880.69036893331 11:06:28 INFO - PROCESS | 3952 | |5;yui.html;725.9020032295642;736.0615215600109;751.211228210379;876.6493402638944;908.477625365415;14597.635059123528;14597.927010364947;14703.485378011745;14709.558713238606;14944.626384340383;14299.213543255142;14314.928425357884;14326.068805527633;14337.784933225983;14408;774.3959711425069;883.134528162398;909.8089401225751;916.9679061232858;917.4495302818323;914.3782228084899;914.8993610702818;915.1123410292006;920.6593560382668;927.1099744245532;972.2027937091588;972.7811242470423;972.9610815567369;973.6835528453246;974.4299584742934;957.042957042957;957.4159762544842;962.7111866440075;962.7978124593843;964.0504103458088;708.8369674974784;709.0498731699496;709.6558169287891;712.4015826705593;713.5041146403252;14708.705825883422;14748.188849613267;14788.556343309718;14800.925995370062;14864.777028344584;15491.690166196613;15502.767458488132;15519.146446945413;15759.133247671374;15795.289211985488;12028.759424811542;12279.754404911851;12290.569830055994;12305.938470307681;12318.445669944875;4073.103917138225;4079.286124928126;4129.006668484599;4164.146349998243;4206.41110244566;57237.14144287839;57266;57306.71346643282;57329.713351432976;57524;10938.890611093946;11108.222424430374;11482.827757583644;12284.570040048555;12362.814557781641;21293;21566.676499852514;21567.67648485274;21571.460713481974;21584.244551440624;8472.195141461674;8529.914700852913;8574.82850343002;9176.90823091774;9546.093121153479;4942.258661200777;5075.593952483792;5156.226566015128;5366.597505187126;5368.087425137736;3575.713942884563;3626.6192049834917;3635.836387362575;3635.9091022724115;3639.9818000909827;681.1213534540387;687.4500399680236;689.5724650716588;696.140266770538;708.8830342993348;679.8096532970776;752.8945947567345;812.3176531713389;815.1848151848152;858.000429499626;9730.805383892282;10203.642872499428;10354.326968747007;10444.425556594308;10469.895301046892;687.3710554842363;710.8755967705735;790.9604519774103;805.8630032894422;821.3470291118575;4514.774261286922;4656.231721765938;4828.420589529279;4846.200376937766;4931.950680493221;67090.32909670938;69032;69158.30841691518;69447;69631;56825.43174568284;57622.423775762545;58091.4190858086;58134.70932645394;59427.70286148628;54467;54487.72756136194;54853.45146548563;54885.451145488834;55224.723876379554;9161.221296189899;9265.109071402825;9276.397034192756;9353.719388418358;9362.110599493037;41428.58571414247;41629.16741665089;41646.58353416548;42013.57986420097;42482.57517424786;47387;47469;52425;53456.198157028455;53602;12164.148509604243;13030.4136313868;13088.934555327163;13338.733225335633;13575.38910748999;13544.525941591997;14922.403103876157;15039.849601504282;15602.453914112952;15673.529794106194;13858.514951976633;14659;14854.034487758261;14890.702185956437;14932.328045238208;14290.499832505813;14539.92730036343;14861.628459288604;14978.925105374403;15115.31981060833;13830.170189788645;13882.652933676738;14271.286435678383;14320.641983950069;14671.413143474141;11737.88262117402;11935.403229838299;11994.820077698667;12168.391580420766;12422.751544968869;10611.2041596879;10745.946270268598;11356.886431135583;11488.885111148782;11494.94252528732 11:06:28 INFO - PROCESS | 3952 | __end_tp_report 11:06:28 INFO - PROCESS | 3952 | __start_cc_report 11:06:28 INFO - PROCESS | 3952 | _x_x_mozilla_cycle_collect,349 11:06:28 INFO - PROCESS | 3952 | __end_cc_report 11:06:28 INFO - PROCESS | 3952 | __startTimestamp1467396388894__endTimestamp 11:06:28 INFO - PROCESS | 3952 | 11:06:28 INFO - PROCESS | 3952 | ------- Summary: start ------- 11:06:28 INFO - PROCESS | 3952 | Number of tests: 6 11:06:28 INFO - PROCESS | 3952 | 11:06:28 INFO - PROCESS | 3952 | [#0] dojo.html Cycles:165 Average:5607.54 Median:5845.15 stddev:628.02 (10.7%) stddev-sans-first:603.68 11:06:28 INFO - PROCESS | 3952 | Values: 3316.4 3332.7 3337.8 3370.1 3379.3 5585.5 5595.1 5601.7 5630.3 5638.5 5593.1 5621.5 5647.0 5649.7 5652.9 5098.5 5140.3 5156.5 5159.9 5175.4 5149.3 5202.9 5283.2 5287.6 5291.2 5067.2 5103.3 5134.3 5192.1 5292.3 5129.5 5144.6 5151.8 5159.9 5164.8 4932.8 4974.7 5042.5 5091.0 5101.6 5435.4 5475.3 5493.5 5517.3 5569.8 5828.9 5877.0 5877.4 5888.0 5904.6 5831.5 5915.4 5930.9 5950.3 6067.8 5668.8 5756.1 5756.5 5758.0 5797.3 6238.4 6238.9 6249.3 6258.9 6276.5 5803.7 5880.3 5966.9 5991.5 6006.0 6118.7 6130.8 6132.2 6137.1 6149.9 6058.6 6072.5 6076.5 6109.1 6110.9 5741.3 5967.2 6034.2 6086.5 6088.8 4610.2 4619.2 4619.7 4634.7 4639.3 4132.1 4149.3 4160.5 4161.0 4172.6 5685.3 5728.8 5782.9 5798.2 5835.3 5851.4 5951.8 5952.4 5954.9 5994.0 5683.1 5801.4 5841.9 5844.4 5863.1 5010.5 5058.1 5072.4 5082.1 5094.4 6260.1 6281.8 6296.1 6323.6 6332.7 5928.7 6015.9 6077.4 6098.1 6102.8 6183.7 6200.8 6227.5 6234.9 6249.0 5896.7 5896.9 5899.4 5916.2 5934.1 5859.1 5918.2 6007.8 6014.3 6059.6 5918.9 5922.9 5924.3 5929.0 5939.6 5837.5 5862.5 5900.9 5904.5 5904.5 5542.3 5746.5 5809.4 5845.2 5875.7 5988.1 5995.7 6006.9 6045.7 6047.4 5865.0 5901.8 5902.3 5903.3 5920.4 11:06:28 INFO - PROCESS | 3952 | 11:06:28 INFO - PROCESS | 3952 | [#1] ext.html Cycles:180 Average:61197.08 Median:43803.50 stddev:117436.58 (268.1%) stddev-sans-first:117678.09 11:06:28 INFO - PROCESS | 3952 | Values: 670.7 685.1 689.9 730.1 752.0 33589.0 39254.0 39505.4 39541.8 39576.2 44851.8 45381.1 45471.0 45496.5 45536.3 8785.1 8986.2 8991.0 8996.1 9039.9 8844.0 8925.1 8934.1 8944.9 8946.6 9147.9 9189.0 9203.3 9228.2 9236.6 9149.6 9150.0 9171.9 9172.4 9178.4 9016.3 9122.5 9143.4 9148.2 9176.2 43245.8 43775.3 43787.8 43819.6 44010.8 3839.7 3906.7 3955.5 4028.5 4642.9 33830.3 33930.7 34273.5 34315.7 34346.7 4159.4 4338.0 4363.6 4364.5 4375.4 321431.0 321856.0 322277.0 323753.4 324656.0 62979.4 64276.4 64316.0 64499.4 64704.0 72323.6 73242.6 73248.6 73337.0 73387.6 15896.4 15898.9 16020.8 16050.6 16087.3 12023.6 12091.6 12135.2 12144.9 12194.5 20474.0 20618.4 20714.1 20743.4 21716.5 8033.0 8090.6 8271.5 8286.0 8321.9 1180.9 1196.8 1219.4 1240.9 1250.6 30512.8 31588.5 32271.0 35806.0 36198.0 1159.8 1218.0 1221.2 1243.4 1283.5 16684.7 17358.2 17520.6 17535.7 17790.4 496943.0 501162.0 524727.0 574889.0 580213.0 58568.4 59588.5 59693.0 59849.0 59870.1 1491.9 1547.0 1552.7 1554.6 1556.8 31232.5 31942.2 32024.5 32603.3 33180.8 56076.0 56680.0 56787.7 56818.0 56928.4 438169.0 444973.0 445920.0 446161.0 446560.0 31952.8 32016.5 32407.5 32450.2 32560.2 52293.7 52351.5 52393.2 53005.0 54023.2 42987.8 43467.6 43481.1 43795.0 44325.0 43812.0 44492.8 44696.3 44785.1 45023.8 44654.3 45283.8 45389.5 45505.5 45508.0 37502.2 37619.0 38426.0 38811.6 39188.0 29130.9 30018.2 30175.8 30419.7 30809.8 11:06:28 INFO - PROCESS | 3952 | 11:06:28 INFO - PROCESS | 3952 | [#2] jquery.html Cycles:180 Average:30576.58 Median:2536.03 stddev:87347.23 (3444.3%) stddev-sans-first:87562.93 11:06:28 INFO - PROCESS | 3952 | Values: 432.8 438.3 448.2 448.6 460.0 18908.5 18979.7 19472.6 19876.3 19896.9 17743.8 17936.0 19960.6 20323.6 20484.7 4231.4 5819.9 6006.8 6007.2 6013.1 5655.2 5904.7 5925.2 5961.4 5984.6 5651.6 5902.7 5938.3 5940.5 5943.4 5858.0 5911.9 5930.8 5943.5 5949.1 5696.6 5961.8 6101.8 6115.5 6139.7 14740.7 15079.7 15265.8 23484.0 24219.2 2454.3 2479.0 2524.3 2547.8 2628.6 11806.8 14295.6 14781.4 14905.8 15395.5 2072.3 2107.6 2111.0 2113.7 2140.5 83993.2 84061.6 84412.6 85684.6 86709.0 11511.8 11835.2 11897.5 11930.3 12022.4 16716.8 16843.9 16854.4 16859.7 16931.6 8369.5 8401.9 8431.7 8501.6 8517.9 7931.2 7941.0 7961.0 8018.1 8057.1 5147.7 5152.2 5186.7 5225.5 5233.1 3511.3 3753.8 3842.7 3907.9 3913.9 945.8 1028.3 1040.6 1047.2 1115.8 18174.3 19013.5 19644.8 19845.0 20102.1 1039.2 1059.9 1076.7 1085.1 1102.5 9261.6 11310.5 11330.5 11390.9 11464.8 519526.0 524030.0 529658.0 538271.0 542336.0 91873.5 92439.0 94649.5 96557.5 96768.0 1075.0 1106.8 1132.5 1143.2 1147.1 17406.4 17442.3 17708.0 17712.7 17864.9 39240.8 39587.2 40305.8 40308.6 40502.0 54780.7 58797.7 59016.4 59121.0 59351.4 9200.2 9232.4 9352.9 9392.5 9438.1 12539.0 13846.2 14024.9 14037.1 14085.8 11769.9 12076.9 12149.0 12288.3 12698.7 11814.9 11912.9 12075.9 12109.7 12135.8 12444.4 12525.2 12641.3 12660.1 12721.1 8909.0 9000.8 9093.5 9291.4 9368.9 11819.6 12326.0 12363.4 12368.0 12402.6 11:06:28 INFO - PROCESS | 3952 | 11:06:28 INFO - PROCESS | 3952 | [#3] mootools.html Cycles:180 Average:5702.62 Median:5114.22 stddev:3152.94 (61.7%) stddev-sans-first:3146.48 11:06:28 INFO - PROCESS | 3952 | Values: 1569.2 1575.8 1785.2 1911.7 1916.3 8428.3 8464.0 8612.6 8643.3 8689.5 8742.5 8761.3 8828.5 8836.2 8850.9 2467.8 2475.7 2481.7 2484.6 2491.8 2470.4 2492.4 2494.4 2494.9 2497.1 2496.4 2503.5 2504.3 2508.4 2517.5 2428.5 2464.3 2474.0 2478.6 2492.1 2452.4 2462.2 2463.5 2480.1 2491.3 8688.9 8739.0 8762.9 8820.0 8830.2 5240.0 5373.2 5395.4 5404.4 5407.1 3508.4 3509.4 3580.4 3595.7 3627.2 1192.7 1209.2 1220.2 1242.0 1266.7 12060.0 12105.5 12125.3 12131.8 12158.8 4336.3 4364.0 4473.0 4478.6 4480.5 9120.9 9148.5 9156.2 9169.4 9221.5 5135.5 5138.5 5139.5 5144.7 5180.4 4722.6 4846.4 4895.1 4943.8 4953.9 3896.2 3949.0 3968.8 3975.4 4071.6 1182.2 1191.0 1191.0 1199.3 1233.7 872.5 981.7 997.8 1046.8 1076.3 5991.0 6021.9 6043.3 6043.7 6206.3 452.4 452.5 454.0 479.8 484.0 3995.4 4039.1 4050.1 4060.2 4099.1 10446.4 10927.9 10956.4 10969.9 10971.8 10731.7 10734.5 10736.6 10751.3 10791.2 7832.6 8011.3 8026.3 8325.3 8325.6 5805.6 5827.5 5845.5 5930.4 5967.9 9215.3 9283.3 9393.2 9420.9 9582.9 9426.2 9527.6 9576.2 9580.4 9599.9 7335.3 7341.1 7503.9 7547.7 7555.8 8360.3 8369.0 8378.7 8396.3 8402.7 7342.7 7381.7 7497.7 7561.5 7618.6 7555.4 7580.7 7588.4 7603.2 7720.8 6671.3 6678.5 6700.9 6710.1 6747.3 5035.3 5066.1 5155.6 5187.4 5221.1 4932.0 5092.9 5136.8 5137.8 5202.8 11:06:28 INFO - PROCESS | 3952 | 11:06:28 INFO - PROCESS | 3952 | [#4] prototype.html Cycles:180 Average:5806.23 Median:6645.42 stddev:1793.80 (27.0%) stddev-sans-first:1751.41 11:06:28 INFO - PROCESS | 3952 | Values: 347.0 348.9 351.6 351.6 353.9 6457.9 6542.1 6598.4 6609.2 6618.9 6542.1 6547.3 6553.2 6555.7 6578.5 4799.3 4926.3 4928.3 4946.3 4949.5 4921.4 4921.5 4925.3 4941.3 4950.7 4885.5 4889.5 4897.8 4902.5 4903.6 4881.6 4892.0 4893.5 4894.7 4894.9 4252.2 4255.5 4255.7 4259.1 4261.0 6072.8 6266.8 6302.2 6305.2 6314.4 5685.0 5709.8 5715.8 5719.8 5727.1 6896.4 6903.9 6905.5 6906.1 6907.0 4697.1 4702.3 4706.9 4707.4 4715.0 7153.6 7158.4 7164.0 7218.9 7221.5 4701.8 4771.1 4790.9 4798.5 4805.6 4829.3 4837.1 4844.1 4852.8 4853.7 5663.2 5677.5 5690.8 5703.1 5714.7 6928.7 6930.9 6970.5 6970.6 6996.9 1690.2 1726.9 1727.6 1728.6 1730.4 1084.8 1118.2 1121.6 1126.4 1132.8 6741.5 6760.6 6762.9 6764.7 6766.4 7115.6 7157.9 7191.7 7208.3 7208.3 6566.1 6671.9 6706.6 6711.7 6774.1 3885.2 3899.2 3903.2 3919.1 3923.7 7509.1 7514.1 7543.5 7590.2 7592.3 7285.3 7393.9 7404.1 7439.7 7459.3 7562.0 7563.2 7566.4 7570.4 7578.1 7190.7 7190.8 7198.5 7219.3 7228.8 7124.0 7141.2 7141.4 7145.6 7157.5 7393.9 7550.5 7552.6 7563.4 7580.1 4851.5 4867.0 4894.4 4895.4 4896.4 7254.2 7256.0 7256.7 7257.7 7264.5 7000.9 7009.3 7015.7 7015.9 7024.8 6874.3 6964.0 7006.3 7007.8 7022.1 6814.2 6878.4 6879.0 6887.6 6894.6 6968.2 7024.3 7040.3 7043.3 7046.3 6846.1 6864.1 6870.6 6873.2 6880.7 11:06:28 INFO - PROCESS | 3952 | 11:06:28 INFO - PROCESS | 3952 | [#5] yui.html Cycles:180 Average:16247.03 Median:26021.62 stddev:18708.25 (71.9%) stddev-sans-first:18724.42 11:06:28 INFO - PROCESS | 3952 | Values: 725.9 736.1 751.2 876.6 908.5 14597.6 14597.9 14703.5 14709.6 14944.6 14299.2 14314.9 14326.1 14337.8 14408.0 774.4 883.1 909.8 917.0 917.4 914.4 914.9 915.1 920.7 927.1 972.2 972.8 973.0 973.7 974.4 957.0 957.4 962.7 962.8 964.1 708.8 709.0 709.7 712.4 713.5 14708.7 14748.2 14788.6 14800.9 14864.8 15491.7 15502.8 15519.1 15759.1 15795.3 12028.8 12279.8 12290.6 12305.9 12318.4 4073.1 4079.3 4129.0 4164.1 4206.4 57237.1 57266.0 57306.7 57329.7 57524.0 10938.9 11108.2 11482.8 12284.6 12362.8 21293.0 21566.7 21567.7 21571.5 21584.2 8472.2 8529.9 8574.8 9176.9 9546.1 4942.3 5075.6 5156.2 5366.6 5368.1 3575.7 3626.6 3635.8 3635.9 3640.0 681.1 687.5 689.6 696.1 708.9 679.8 752.9 812.3 815.2 858.0 9730.8 10203.6 10354.3 10444.4 10469.9 687.4 710.9 791.0 805.9 821.3 4514.8 4656.2 4828.4 4846.2 4932.0 67090.3 69032.0 69158.3 69447.0 69631.0 56825.4 57622.4 58091.4 58134.7 59427.7 54467.0 54487.7 54853.5 54885.5 55224.7 9161.2 9265.1 9276.4 9353.7 9362.1 41428.6 41629.2 41646.6 42013.6 42482.6 47387.0 47469.0 52425.0 53456.2 53602.0 12164.1 13030.4 13088.9 13338.7 13575.4 13544.5 14922.4 15039.8 15602.5 15673.5 13858.5 14659.0 14854.0 14890.7 14932.3 14290.5 14539.9 14861.6 14978.9 15115.3 13830.2 13882.7 14271.3 14320.6 14671.4 11737.9 11935.4 11994.8 12168.4 12422.8 10611.2 10745.9 11356.9 11488.9 11494.9 11:06:28 INFO - PROCESS | 3952 | -------- Summary: end -------- 11:06:28 INFO - PROCESS | 3952 | 11:06:29 INFO - TEST-INFO | 3952: exit 0 11:06:29 INFO - TEST-OK | dromaeo_css | took 1108356ms 11:06:29 INFO - TEST-START | kraken 11:06:29 INFO - operating with platform_type : linux_ 11:06:29 INFO - Initialising browser for kraken test... 11:06:29 INFO - TEST-INFO | started process 4194 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfDNIgW/profile http://localhost:59758/getInfo.html) 11:06:33 INFO - PROCESS | 4194 | 11:06:33 INFO - PROCESS | 4194 | (process:4269): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:06:33 INFO - PROCESS | 4194 | __metrics Screen width/height:1600/1200 11:06:33 INFO - PROCESS | 4194 | colorDepth:24 11:06:33 INFO - PROCESS | 4194 | Browser inner width/height: 1024/697 11:06:33 INFO - PROCESS | 4194 | __metrics 11:06:34 ERROR - PROCESS | 4194 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 11:06:35 INFO - TEST-INFO | 4194: exit 0 11:06:35 INFO - Browser initialized. 11:06:35 INFO - Running cycle 1/1 for kraken test... 11:06:35 INFO - TEST-INFO | started process 4320 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfDNIgW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:06:36 INFO - PROCESS | 4320 | 11:06:36 INFO - PROCESS | 4320 | (process:4385): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:06:46 INFO - PROCESS | 4320 | RSS: Main: 150810624 11:06:46 INFO - PROCESS | 4320 | 11:06:49 INFO - PROCESS | 4320 | Cycle 1(1): loaded http://localhost:59758/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59758/tests/kraken/driver.html?testName=audio-beat-detection) 11:06:50 INFO - PROCESS | 4320 | RSS: Main: 156528640 11:06:50 INFO - PROCESS | 4320 | 11:06:52 INFO - PROCESS | 4320 | Cycle 1(1): loaded http://localhost:59758/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59758/tests/kraken/driver.html?testName=audio-dft) 11:06:53 INFO - PROCESS | 4320 | RSS: Main: 156528640 11:06:53 INFO - PROCESS | 4320 | 11:06:56 INFO - PROCESS | 4320 | Cycle 1(1): loaded http://localhost:59758/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59758/tests/kraken/driver.html?testName=audio-fft) 11:06:56 INFO - PROCESS | 4320 | RSS: Main: 156663808 11:06:56 INFO - PROCESS | 4320 | 11:06:59 INFO - PROCESS | 4320 | Cycle 1(1): loaded http://localhost:59758/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59758/tests/kraken/driver.html?testName=audio-oscillator) 11:06:59 INFO - PROCESS | 4320 | RSS: Main: 156598272 11:06:59 INFO - PROCESS | 4320 | 11:07:01 INFO - PROCESS | 4320 | Cycle 1(1): loaded http://localhost:59758/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59758/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:07:02 INFO - PROCESS | 4320 | RSS: Main: 156327936 11:07:02 INFO - PROCESS | 4320 | 11:07:05 INFO - PROCESS | 4320 | Cycle 1(1): loaded http://localhost:59758/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59758/tests/kraken/driver.html?testName=imaging-darkroom) 11:07:06 INFO - PROCESS | 4320 | RSS: Main: 156848128 11:07:06 INFO - PROCESS | 4320 | 11:07:09 INFO - PROCESS | 4320 | Cycle 1(1): loaded http://localhost:59758/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59758/tests/kraken/driver.html?testName=imaging-desaturate) 11:07:10 INFO - PROCESS | 4320 | RSS: Main: 156598272 11:07:10 INFO - PROCESS | 4320 | 11:07:12 INFO - PROCESS | 4320 | Cycle 1(1): loaded http://localhost:59758/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59758/tests/kraken/driver.html?testName=json-parse-financial) 11:07:13 INFO - PROCESS | 4320 | RSS: Main: 156430336 11:07:13 INFO - PROCESS | 4320 | 11:07:14 INFO - PROCESS | 4320 | Cycle 1(1): loaded http://localhost:59758/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59758/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:07:15 INFO - PROCESS | 4320 | RSS: Main: 155967488 11:07:15 INFO - PROCESS | 4320 | 11:07:17 INFO - PROCESS | 4320 | Cycle 1(1): loaded http://localhost:59758/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59758/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:07:17 INFO - PROCESS | 4320 | RSS: Main: 155996160 11:07:17 INFO - PROCESS | 4320 | 11:07:19 INFO - PROCESS | 4320 | Cycle 1(1): loaded http://localhost:59758/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59758/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:07:20 INFO - PROCESS | 4320 | RSS: Main: 156540928 11:07:20 INFO - PROCESS | 4320 | 11:07:23 INFO - PROCESS | 4320 | Cycle 1(1): loaded http://localhost:59758/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59758/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:07:23 INFO - PROCESS | 4320 | RSS: Main: 157089792 11:07:23 INFO - PROCESS | 4320 | 11:07:26 INFO - PROCESS | 4320 | Cycle 1(1): loaded http://localhost:59758/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59758/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:07:27 INFO - PROCESS | 4320 | RSS: Main: 157171712 11:07:27 INFO - PROCESS | 4320 | 11:07:28 INFO - PROCESS | 4320 | Cycle 1(1): loaded http://localhost:59758/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59758/tests/kraken/driver.html?testName=ai-astar) 11:07:28 INFO - PROCESS | 4320 | RSS: Main: 158531584 11:07:28 INFO - PROCESS | 4320 | 11:07:28 INFO - PROCESS | 4320 | __start_tp_report 11:07:28 INFO - PROCESS | 4320 | _x_x_mozilla_page_load 11:07:28 INFO - PROCESS | 4320 | _x_x_mozilla_page_load_details 11:07:28 INFO - PROCESS | 4320 | |i|pagename|runs| 11:07:28 INFO - PROCESS | 4320 | |0;ai-astar;107;111;103;111;112;110;100;110;110;111 11:07:28 INFO - PROCESS | 4320 | |1;audio-beat-detection;160;126;156;191;133;155;149;127;175;140 11:07:28 INFO - PROCESS | 4320 | |2;audio-dft;163;161;162;168;161;164;161;161;163;163 11:07:28 INFO - PROCESS | 4320 | |3;audio-fft;77;75;77;163;73;75;74;76;182;76 11:07:28 INFO - PROCESS | 4320 | |4;audio-oscillator;93;94;161;92;92;93;153;92;92;155 11:07:28 INFO - PROCESS | 4320 | |5;imaging-gaussian-blur;118;118;117;116;116;117;117;117;117;117 11:07:28 INFO - PROCESS | 4320 | |6;imaging-darkroom;146;146;147;146;147;146;146;146;147;147 11:07:28 INFO - PROCESS | 4320 | |7;imaging-desaturate;94;95;96;96;95;95;95;95;95;95 11:07:28 INFO - PROCESS | 4320 | |8;json-parse-financial;57;55;55;58;55;57;57;73;56;55 11:07:28 INFO - PROCESS | 4320 | |9;json-stringify-tinderbox;59;59;60;60;60;59;62;60;59;59 11:07:28 INFO - PROCESS | 4320 | |10;stanford-crypto-aes;74;73;72;75;76;75;76;75;75;74 11:07:28 INFO - PROCESS | 4320 | |11;stanford-crypto-ccm;123;124;113;122;116;124;114;115;132;135 11:07:28 INFO - PROCESS | 4320 | |12;stanford-crypto-pbkdf2;164;166;165;164;165;161;158;155;164;157 11:07:28 INFO - PROCESS | 4320 | |13;stanford-crypto-sha256-iterative;67;71;68;67;71;66;67;75;66;66 11:07:28 INFO - PROCESS | 4320 | __end_tp_report 11:07:28 INFO - PROCESS | 4320 | __start_cc_report 11:07:28 INFO - PROCESS | 4320 | _x_x_mozilla_cycle_collect,842 11:07:28 INFO - PROCESS | 4320 | __end_cc_report 11:07:28 INFO - PROCESS | 4320 | __startTimestamp1467396448952__endTimestamp 11:07:28 INFO - PROCESS | 4320 | 11:07:28 INFO - PROCESS | 4320 | ------- Summary: start ------- 11:07:28 INFO - PROCESS | 4320 | Number of tests: 14 11:07:28 INFO - PROCESS | 4320 | 11:07:28 INFO - PROCESS | 4320 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.50 stddev:3.98 (3.6%) stddev-sans-first:4.18 11:07:28 INFO - PROCESS | 4320 | Values: 107.0 111.0 103.0 111.0 112.0 110.0 100.0 110.0 110.0 111.0 11:07:28 INFO - PROCESS | 4320 | 11:07:28 INFO - PROCESS | 4320 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:155.50 stddev:20.94 (13.5%) stddev-sans-first:21.97 11:07:28 INFO - PROCESS | 4320 | Values: 160.0 126.0 156.0 191.0 133.0 155.0 149.0 127.0 175.0 140.0 11:07:28 INFO - PROCESS | 4320 | 11:07:28 INFO - PROCESS | 4320 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:2.16 (1.3%) stddev-sans-first:2.29 11:07:28 INFO - PROCESS | 4320 | Values: 163.0 161.0 162.0 168.0 161.0 164.0 161.0 161.0 163.0 163.0 11:07:28 INFO - PROCESS | 4320 | 11:07:28 INFO - PROCESS | 4320 | [#3] audio-fft Cycles:10 Average:94.80 Median:75.50 stddev:41.21 (54.6%) stddev-sans-first:43.21 11:07:28 INFO - PROCESS | 4320 | Values: 77.0 75.0 77.0 163.0 73.0 75.0 74.0 76.0 182.0 76.0 11:07:28 INFO - PROCESS | 4320 | 11:07:28 INFO - PROCESS | 4320 | [#4] audio-oscillator Cycles:10 Average:111.70 Median:92.00 stddev:30.87 (33.6%) stddev-sans-first:31.99 11:07:28 INFO - PROCESS | 4320 | Values: 93.0 94.0 161.0 92.0 92.0 93.0 153.0 92.0 92.0 155.0 11:07:28 INFO - PROCESS | 4320 | 11:07:28 INFO - PROCESS | 4320 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 11:07:28 INFO - PROCESS | 4320 | Values: 118.0 118.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 11:07:28 INFO - PROCESS | 4320 | 11:07:28 INFO - PROCESS | 4320 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:07:28 INFO - PROCESS | 4320 | Values: 146.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 147.0 147.0 11:07:28 INFO - PROCESS | 4320 | 11:07:28 INFO - PROCESS | 4320 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 11:07:28 INFO - PROCESS | 4320 | Values: 94.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 11:07:28 INFO - PROCESS | 4320 | 11:07:28 INFO - PROCESS | 4320 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.00 stddev:5.45 (9.6%) stddev-sans-first:5.78 11:07:28 INFO - PROCESS | 4320 | Values: 57.0 55.0 55.0 58.0 55.0 57.0 57.0 73.0 56.0 55.0 11:07:28 INFO - PROCESS | 4320 | 11:07:28 INFO - PROCESS | 4320 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.95 (1.6%) stddev-sans-first:0.97 11:07:28 INFO - PROCESS | 4320 | Values: 59.0 59.0 60.0 60.0 60.0 59.0 62.0 60.0 59.0 59.0 11:07:28 INFO - PROCESS | 4320 | 11:07:28 INFO - PROCESS | 4320 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:75.00 stddev:1.27 (1.7%) stddev-sans-first:1.33 11:07:28 INFO - PROCESS | 4320 | Values: 74.0 73.0 72.0 75.0 76.0 75.0 76.0 75.0 75.0 74.0 11:07:28 INFO - PROCESS | 4320 | 11:07:28 INFO - PROCESS | 4320 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:123.50 stddev:7.51 (6.1%) stddev-sans-first:7.95 11:07:28 INFO - PROCESS | 4320 | Values: 123.0 124.0 113.0 122.0 116.0 124.0 114.0 115.0 132.0 135.0 11:07:28 INFO - PROCESS | 4320 | 11:07:28 INFO - PROCESS | 4320 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:164.00 stddev:3.90 (2.4%) stddev-sans-first:4.06 11:07:28 INFO - PROCESS | 4320 | Values: 164.0 166.0 165.0 164.0 165.0 161.0 158.0 155.0 164.0 157.0 11:07:28 INFO - PROCESS | 4320 | 11:07:28 INFO - PROCESS | 4320 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:67.50 stddev:2.99 (4.4%) stddev-sans-first:3.13 11:07:28 INFO - PROCESS | 4320 | Values: 67.0 71.0 68.0 67.0 71.0 66.0 67.0 75.0 66.0 66.0 11:07:28 INFO - PROCESS | 4320 | -------- Summary: end -------- 11:07:28 INFO - PROCESS | 4320 | 11:07:29 INFO - TEST-INFO | 4320: exit 0 11:07:29 INFO - TEST-OK | kraken | took 60296ms 11:07:29 INFO - SUITE-END | took 1168s 11:07:30 INFO - Completed test suite (00:19:28) 11:07:30 INFO - javascript benchmark 11:07:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3316.3864685033273, 3332.6833950774667, 3337.7997320160794, 3370.140614143393, 3379.2903490267045, 5585.497305242528, 5595.076812325967, 5601.663900165993, 5630.296212973379, 5638.464345887144, 5593.105103183491, 5621.522170615503, 5647.0, 5649.689267090308, 5652.886942261152, 5098.464661210575, 5140.33175687162, 5156.510131537498, 5159.922601160985, 5175.404828444721, 5149.253358263049, 5202.92195617066, 5283.1546952487415, 5287.550558202557, 5291.179867120583, 5067.189249720045, 5103.260027296058, 5134.332536770215, 5192.091384007803, 5292.285541451913, 5129.487051294878, 5144.6141539384325, 5151.81968631098, 5159.948400516022, 5164.793408263665, 4932.827351042696, 4974.701517908937, 5042.470540593222, 5091.032703786269, 5101.617378696613, 5435.374931882805, 5475.288212532385, 5493.478119578634, 5517.2551705519645, 5569.832905012856, 5828.9417105828825, 5876.97061514694, 5877.441643043904, 5887.970560147171, 5904.645721256738, 5831.475167234927, 5915.3788852170765, 5930.881382372371, 5950.256217972754, 6067.817965461043, 5668.829935101912, 5756.050251708463, 5756.539476841843, 5758.049921762904, 5797.304323481167, 6238.376162383725, 6238.875222495525, 6249.312575616678, 6258.874822503615, 6276.529260305404, 5803.738831752581, 5880.294364676266, 5966.880662386815, 5991.5206783457215, 6006.0, 6118.694065296806, 6130.785422510191, 6132.202813634199, 6137.140800287963, 6149.938500615026, 6058.606190597597, 6072.483838873657, 6076.4531192192035, 6109.14471973924, 6110.908336374958, 5741.339745929188, 5967.16459695643, 6034.1853849730605, 6086.452219300196, 6088.847778805565, 4610.170169369479, 4619.214733495247, 4619.722816631013, 4634.72191668501, 4639.327297541838, 4132.070284186034, 4149.315362965077, 4160.50073991123, 4160.958390416117, 4172.561881002512, 5685.289338832646, 5728.77084916607, 5782.884342313214, 5798.246227990334, 5835.270591176103, 5851.444112809277, 5951.821445356646, 5952.375000624958, 5954.851128721816, 5994.0409534474275, 5683.147527870852, 5801.419858014249, 5841.912371314349, 5844.357120716718, 5863.061910094364, 5010.49895010496, 5058.064258112261, 5072.416672082684, 5082.085224659597, 5094.363204599425, 6260.060990851318, 6281.842953926097, 6296.0555916612875, 6323.557350985387, 6332.746690132435, 5928.703564821655, 6015.879682406415, 6077.361877003028, 6098.146259523582, 6102.755889764359, 6183.659898705614, 6200.81397558056, 6227.532935029982, 6234.906476402767, 6249.0, 5896.734646940984, 5896.911546326723, 5899.410058994066, 5916.171735956884, 5934.050551911673, 5859.091840764689, 5918.201042859331, 6007.789727359522, 6014.278286605635, 6059.575829692056, 5918.940810591839, 5922.851928701817, 5924.259467566554, 5928.970355148197, 5939.554533409925, 5837.503812176013, 5862.472377486047, 5900.940990590211, 5904.498117660047, 5904.527637789052, 5542.307211598551, 5746.511546518593, 5809.448102430262, 5845.152452894392, 5875.73559189846, 5988.131720900532, 5995.6702381367695, 6006.939930600638, 6045.697715114139, 6047.425494578008, 5865.0, 5901.793437229677, 5902.291724993029, 5903.26209223847, 5920.407959204045], "value": 5566.260308320656, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.6546128743698, 685.1059367525378, 689.9478295599212, 730.0837449001502, 751.9774406767797, 33589.0, 39254.0, 39505.40741888874, 39541.802290988504, 39576.2084758305, 44851.77574112125, 45381.09237815242, 45471.0, 45496.54503454964, 45536.31695524562, 8785.121487851196, 8986.191242788147, 8991.0, 8996.100389960984, 9039.909600903973, 8843.95578022109, 8925.107489251088, 8934.10658934108, 8944.8658270126, 8946.64213431462, 9147.908520914772, 9188.954055229748, 9203.263738900905, 9228.215601673866, 9236.630534778635, 9149.63401463944, 9149.95425022874, 9171.908280917205, 9172.357934944557, 9178.449293042439, 9016.278697704169, 9122.5438728064, 9143.359964802466, 9148.176664100263, 9176.220021298197, 43245.837708114785, 43775.34336984948, 43787.78106109449, 43819.56180438187, 44010.77994610006, 3839.6736277416453, 3906.726529142961, 3955.5055618047745, 4028.516578010628, 4642.930356044662, 33830.323393532235, 33930.66069339324, 34273.48589771155, 34315.6568434315, 34346.656533434594, 4159.438475805758, 4338.0, 4363.629091527224, 4364.454443194601, 4375.409319741826, 321431.0, 321856.0, 322277.0, 323753.38123309467, 324656.0, 62979.37020629827, 64276.35723642704, 64316.0, 64499.35500644933, 64704.0, 72323.6383818088, 73242.63378683073, 73248.63375683194, 73337.0, 73387.63306183435, 15896.443624473319, 15898.920505397398, 16020.75968860468, 16050.598735031717, 16087.276072576527, 12023.63929082129, 12091.637250882488, 12135.15053946233, 12144.878551214375, 12194.451249693786, 20474.0, 20618.381448556567, 20714.067866946025, 20743.377698669065, 21716.457088572595, 8033.0, 8090.555019473985, 8271.54506502148, 8285.95857020723, 8321.916780832235, 1180.8582970043478, 1196.7845787758288, 1219.378117160237, 1240.9451965828973, 1250.6060590913833, 30512.847435763124, 31588.52617210744, 32271.0, 35806.0, 36198.0, 1159.7680463907252, 1218.0, 1221.1574013930538, 1243.421808858885, 1283.5315109984974, 16684.6663066738, 17358.218880150424, 17520.561985950455, 17535.73696394555, 17790.37733679315, 496943.0, 501162.0, 524727.0, 574889.0, 580213.0, 58568.414315856295, 59588.5102872423, 59693.0, 59849.0, 59870.10194847081, 1491.888108391875, 1546.9922650386902, 1552.7205103081553, 1554.6268895465007, 1556.8131824180944, 31232.531512026882, 31942.20144496313, 32024.51963220507, 32603.34793304073, 33180.83409582936, 56076.0, 56680.0, 56787.71606141943, 56818.0, 56928.43071569231, 438169.0, 444973.0, 445920.0, 446161.0, 446560.0, 31952.84023579867, 32016.51975220327, 32407.51388729218, 32450.188745281557, 32560.185995350304, 52293.7385313071, 52351.476485236184, 52393.166239181446, 53005.0, 54023.189652156034, 42987.78506107449, 43467.56532434762, 43481.130377391644, 43795.0, 44325.0, 43812.0, 44492.77753611211, 44696.32955505605, 44785.10429791451, 45023.774881125384, 44654.3301850466, 45283.773581131885, 45389.54610453853, 45505.54494455145, 45508.0, 37502.249955001294, 37619.0, 38426.0, 38811.61188388193, 39188.0, 29130.854345728134, 30018.24954376158, 30175.849120754257, 30419.695803041686, 30809.8459507701], "value": 21232.920292777962, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.8463395494599, 438.3162266863693, 448.2379954078068, 448.60260289199147, 459.9586037256646, 18908.48732101432, 18979.71530427043, 19472.610547789034, 19876.304329348477, 19896.90051549744, 17743.822561774377, 17936.013519256467, 19960.600787984233, 20323.59352812943, 20484.69272960907, 4231.428757117788, 5819.912701309484, 6006.819795406123, 6007.219061521996, 6013.128096426038, 5655.236543066695, 5904.734286957076, 5925.229720136376, 5961.433663801932, 5984.611000284989, 5651.632643878155, 5902.704864756766, 5938.317093534234, 5940.524758019348, 5943.435373639497, 5857.970710146444, 5911.940880591182, 5930.762769489215, 5943.494802941756, 5949.137375080611, 5696.601237913348, 5961.791337303173, 6101.847453813646, 6115.541334399938, 6139.662318572477, 14740.705185896222, 15079.698406031817, 15265.847341526554, 23484.0, 24219.152329668552, 2454.275988583372, 2479.0, 2524.2553446733073, 2547.7961763059097, 2628.5925681519393, 11806.822897656542, 14295.642608934755, 14781.408743650241, 14905.776413353808, 15395.461158859498, 2072.3161356752234, 2107.6417009108486, 2110.9788902110936, 2113.7146485224607, 2140.5076832328496, 83993.16006839975, 84061.57969210176, 84412.57793711053, 85684.57157714234, 86709.0, 11511.769764604662, 11835.171537992257, 11897.524099036114, 11930.343831089373, 12022.398880055962, 16716.83283167177, 16843.91578042102, 16854.41009564659, 16859.662806743796, 16931.576710582332, 8369.455985360932, 8401.873971890427, 8431.662733490592, 8501.574921253912, 8517.914820851713, 7931.2068793120225, 7941.0, 7961.0, 8018.118007019223, 8057.113717491071, 5147.742612869416, 5152.227165925066, 5186.714730689773, 5225.4774522548205, 5233.084210263189, 3511.2626348466597, 3753.7560058596105, 3842.6733727632904, 3907.902302442462, 3913.92172156561, 945.7824700318965, 1028.321307936758, 1040.5785656808853, 1047.209356935524, 1115.8493603363604, 18174.273029078955, 19013.524661883286, 19644.803551964582, 19845.0, 20102.09540570678, 1039.194624166262, 1059.920505962056, 1076.7146706122883, 1085.10478854945, 1102.4818335382358, 9261.629534818532, 11310.547578096948, 11330.490127944262, 11390.886091139148, 11464.828027579593, 519526.0, 524030.0, 529658.0, 538271.0, 542336.0, 91873.54063229641, 92439.0, 94649.5267523658, 96557.51721241348, 96768.0, 1074.97312567188, 1106.833974903771, 1132.4903793293051, 1143.1597775634903, 1147.1281825812443, 17406.39077632277, 17442.302307907543, 17708.0, 17712.734308985633, 17864.91067544706, 39240.803795980835, 39587.20825583414, 40305.79847100746, 40308.59691403166, 40502.0, 54780.72609636926, 58797.70601146967, 59016.40983590281, 59121.0, 59351.40648593631, 9200.171984521425, 9232.446053236827, 9352.85313562444, 9392.530373481435, 9438.103380178873, 12539.0, 13846.238456884968, 14024.859751402355, 14037.087589306662, 14085.788713169515, 11769.882301176878, 12076.939615301868, 12149.0, 12288.262704237774, 12698.682532936751, 11814.936655701029, 11912.940435297767, 12075.879241207476, 12109.69725756828, 12135.75728485443, 12444.377781110727, 12525.185862918881, 12641.304728240035, 12660.113792034837, 12721.109522333718, 8908.955455222682, 9000.819983600422, 9093.454392736458, 9291.396059256127, 9368.906310936803, 11819.645410637695, 12326.0, 12363.443645035815, 12368.0, 12402.627921162379], "value": 9822.224067289657, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1569.152657564915, 1575.7872687187225, 1785.2323500894618, 1911.7132430135487, 1916.2622390379718, 8428.283595894349, 8463.999999999985, 8612.569371531421, 8643.265322447583, 8689.478631282127, 8742.475451472916, 8761.342899282547, 8828.514431706253, 8836.248918841906, 8850.91149088509, 2467.8272520923542, 2475.6905386826647, 2481.702195736514, 2484.5776218042884, 2491.7757401833833, 2470.407102295454, 2492.4142826435864, 2494.4387512809562, 2494.9251522454265, 2497.1384872219055, 2496.425822060927, 2503.5368456835454, 2504.261242933339, 2508.423062695581, 2517.5216708825265, 2428.538577670237, 2464.3346296499844, 2474.0, 2478.615814548739, 2492.0654754467073, 2452.4359397338535, 2462.22439931421, 2463.531928933497, 2480.131953816168, 2491.3273416177713, 8688.869666955, 8739.0, 8762.912370876273, 8820.0, 8830.24942879856, 5239.973800131013, 5373.194020896896, 5395.379531353905, 5404.4325345838515, 5407.053765591045, 3508.368493671164, 3509.3683137035323, 3580.4092324766384, 3595.7482976191677, 3627.183883626163, 1192.7435601345753, 1209.2019267283638, 1220.2373516552154, 1242.0498318786135, 1266.6643339515035, 12060.035197184205, 12105.515779368727, 12125.333106679129, 12131.757364852654, 12158.756824863542, 4336.3278691802825, 4363.956360436418, 4473.038296766211, 4478.641708663299, 4480.529544397857, 9120.908790912139, 9148.451092934445, 9156.175944164925, 9169.40398874071, 9221.53892305382, 5135.486451354835, 5138.486151384832, 5139.486051394905, 5144.6655967362, 5180.404253510819, 4722.574968252874, 4846.39420072491, 4895.143349913751, 4943.752812359367, 4953.90092198154, 3896.1818018215927, 3949.0, 3968.7817170055346, 3975.383815508601, 4071.5521292657786, 1182.2079206931376, 1191.0293111114413, 1191.0352614382377, 1199.316389657904, 1233.734747029393, 872.4590753732726, 981.7202097402206, 997.7505623594102, 1046.785408991155, 1076.2950267574595, 5990.9700451497465, 6021.939780602225, 6043.305019922677, 6043.7280322385595, 6206.286277078104, 452.38927447945014, 452.4977275224498, 453.96822222444774, 479.7936887138564, 483.9733814640158, 3995.420664003703, 4039.111395492987, 4050.0684842486394, 4060.2082593893906, 4099.098198396348, 10446.373217606968, 10927.945360273148, 10956.397398143019, 10969.945150274198, 10971.83542246867, 10731.731706707238, 10734.463276836126, 10736.57053717858, 10751.301165424222, 10791.244612877023, 7832.608369581498, 8011.319037881729, 8026.27763501276, 8325.292350150305, 8325.625346859406, 5805.564582656233, 5827.5337972961215, 5845.503132233808, 5930.406959304208, 5967.910481342697, 9215.262778977532, 9283.257339412965, 9393.201577865684, 9420.858687119835, 9582.856257156009, 9426.245900328095, 9527.618895244113, 9576.23390128774, 9580.377275477073, 9599.856002159833, 7335.266473352622, 7341.082364704412, 7503.887441688488, 7547.73582924595, 7555.848883022419, 8360.28937540316, 8368.958155209186, 8378.706745263886, 8396.286315663237, 8402.663893444194, 7342.70629174827, 7381.704731810883, 7497.700091996259, 7561.5085019475755, 7618.619069046415, 7555.357794587521, 7580.696772129274, 7588.430867684835, 7603.201663825219, 7720.806979825549, 6671.33286671329, 6678.49911256648, 6700.865982680221, 6710.060591517289, 6747.257801641717, 5035.320231768665, 5066.113430149783, 5155.613329000265, 5187.351581052369, 5221.112410890082, 4932.0, 5092.949070509396, 5136.768845402041, 5137.768800403916, 5202.843914682566], "value": 4560.797646442025, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.95663042119725, 348.9023073539409, 351.6343003276593, 351.64659517185225, 353.89029400885744, 6457.935420645792, 6542.116814230078, 6598.439132673729, 6609.173853268329, 6618.933810661892, 6542.084108224853, 6547.3125321841235, 6553.180852393451, 6555.672216389174, 6578.473722102232, 4799.304100905367, 4926.285688575154, 4928.310036594879, 4946.282788995593, 4949.480304568023, 4921.384826896638, 4921.458639549646, 4925.26121081837, 4941.332920055783, 4950.702957822524, 4885.462599114095, 4889.535494128052, 4897.751073476258, 4902.509749025086, 4903.607711383099, 4881.585065269439, 4892.0, 4893.4617192108835, 4894.657373983822, 4894.926576101361, 4252.2345977724, 4255.489341279035, 4255.659547236213, 4259.12687898983, 4261.041265715189, 6072.757089716406, 6266.780662676784, 6302.243730752293, 6305.180326557564, 6314.4001319875, 5684.971575142098, 5709.8287051388525, 5715.799947001877, 5719.771209151629, 5727.11229759388, 6896.448284137257, 6903.930960690379, 6905.482088843357, 6906.06768086307, 6906.965465172642, 4697.0840686065885, 4702.3416721659, 4706.858794236178, 4707.388039554836, 4714.976425117887, 7153.570785752871, 7158.391536719385, 7164.0328555645365, 7218.855622887565, 7221.4944953853255, 4701.764911754467, 4771.117343291433, 4790.880227994258, 4798.520147985243, 4805.591524720368, 4829.348038014823, 4837.05677392912, 4844.055409195244, 4852.781624826891, 4853.6602437829015, 5663.178839068312, 5677.545796336283, 5690.772369105272, 5703.08750599902, 5714.685692286964, 6928.688209030605, 6930.861382772317, 6970.477214208955, 6970.616616086062, 6996.8950465743055, 1690.1549225387307, 1726.9481915542553, 1727.5767436978022, 1728.6024214430752, 1730.4462571977099, 1084.837274408845, 1118.2060736876747, 1121.61864965912, 1126.4030064066058, 1132.841402203692, 6741.528093033538, 6760.594364338057, 6762.898556521656, 6764.661766911733, 6766.424853887376, 7115.5730656160795, 7157.856842863113, 7191.712331506681, 7208.27917208275, 7208.315210055036, 6566.1135746674545, 6671.899921501182, 6706.564073335315, 6711.664416779239, 6774.085498457744, 3885.1646895916947, 3899.200663863901, 3903.1608204236227, 3919.098607320332, 3923.705722070856, 7509.13644930829, 7514.0607424071995, 7543.50967187142, 7590.1650818409935, 7592.316691497792, 7285.344319011315, 7393.889091663629, 7404.074490688664, 7439.702411903571, 7459.254074592497, 7562.0, 7563.243675632502, 7566.394688424913, 7570.394368450621, 7578.12851522071, 7190.7483238086415, 7190.784276471714, 7198.5320954137815, 7219.278072192738, 7228.819279518054, 7124.0, 7141.178764442156, 7141.357277845019, 7145.642717863982, 7157.534760240567, 7393.889091663522, 7550.509216900884, 7552.584607846401, 7563.432742544442, 7580.128285247047, 4851.539103785135, 4866.95133048665, 4894.388201474816, 4895.363602731622, 4896.436909755424, 7254.165770936199, 7256.0, 7256.7097316106765, 7257.673404696696, 7264.527805692613, 7000.894986575104, 7009.334113259232, 7015.719371225094, 7015.929840701732, 7024.824379390556, 6874.312568743086, 6964.025036494793, 7006.334398232159, 7007.754728584475, 7022.08712867324, 6814.2163651180745, 6878.38094571491, 6878.965605171942, 6887.621180835102, 6894.620795856276, 6968.198657154492, 7024.26245244242, 7040.295970402919, 7043.260457652078, 7046.295370462913, 6846.144231971004, 6864.107666003388, 6870.553414028072, 6873.20958089806, 6880.69036893331], "value": 5212.786892788092, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.9020032295642, 736.0615215600109, 751.211228210379, 876.6493402638944, 908.477625365415, 14597.635059123528, 14597.927010364947, 14703.485378011745, 14709.558713238606, 14944.626384340383, 14299.213543255142, 14314.928425357884, 14326.068805527633, 14337.784933225983, 14408.0, 774.3959711425069, 883.134528162398, 909.8089401225751, 916.9679061232858, 917.4495302818323, 914.3782228084899, 914.8993610702818, 915.1123410292006, 920.6593560382668, 927.1099744245532, 972.2027937091588, 972.7811242470423, 972.9610815567369, 973.6835528453246, 974.4299584742934, 957.042957042957, 957.4159762544842, 962.7111866440075, 962.7978124593843, 964.0504103458088, 708.8369674974784, 709.0498731699496, 709.6558169287891, 712.4015826705593, 713.5041146403252, 14708.705825883422, 14748.188849613267, 14788.556343309718, 14800.925995370062, 14864.777028344584, 15491.690166196613, 15502.767458488132, 15519.146446945413, 15759.133247671374, 15795.289211985488, 12028.759424811542, 12279.754404911851, 12290.569830055994, 12305.938470307681, 12318.445669944875, 4073.103917138225, 4079.286124928126, 4129.006668484599, 4164.146349998243, 4206.41110244566, 57237.14144287839, 57266.0, 57306.71346643282, 57329.713351432976, 57524.0, 10938.890611093946, 11108.222424430374, 11482.827757583644, 12284.570040048555, 12362.814557781641, 21293.0, 21566.676499852514, 21567.67648485274, 21571.460713481974, 21584.244551440624, 8472.195141461674, 8529.914700852913, 8574.82850343002, 9176.90823091774, 9546.093121153479, 4942.258661200777, 5075.593952483792, 5156.226566015128, 5366.597505187126, 5368.087425137736, 3575.713942884563, 3626.6192049834917, 3635.836387362575, 3635.9091022724115, 3639.9818000909827, 681.1213534540387, 687.4500399680236, 689.5724650716588, 696.140266770538, 708.8830342993348, 679.8096532970776, 752.8945947567345, 812.3176531713389, 815.1848151848152, 858.000429499626, 9730.805383892282, 10203.642872499428, 10354.326968747007, 10444.425556594308, 10469.895301046892, 687.3710554842363, 710.8755967705735, 790.9604519774103, 805.8630032894422, 821.3470291118575, 4514.774261286922, 4656.231721765938, 4828.420589529279, 4846.200376937766, 4931.950680493221, 67090.32909670938, 69032.0, 69158.30841691518, 69447.0, 69631.0, 56825.43174568284, 57622.423775762545, 58091.4190858086, 58134.70932645394, 59427.70286148628, 54467.0, 54487.72756136194, 54853.45146548563, 54885.451145488834, 55224.723876379554, 9161.221296189899, 9265.109071402825, 9276.397034192756, 9353.719388418358, 9362.110599493037, 41428.58571414247, 41629.16741665089, 41646.58353416548, 42013.57986420097, 42482.57517424786, 47387.0, 47469.0, 52425.0, 53456.198157028455, 53602.0, 12164.148509604243, 13030.4136313868, 13088.934555327163, 13338.733225335633, 13575.38910748999, 13544.525941591997, 14922.403103876157, 15039.849601504282, 15602.453914112952, 15673.529794106194, 13858.514951976633, 14659.0, 14854.034487758261, 14890.702185956437, 14932.328045238208, 14290.499832505813, 14539.92730036343, 14861.628459288604, 14978.925105374403, 15115.31981060833, 13830.170189788645, 13882.652933676738, 14271.286435678383, 14320.641983950069, 14671.413143474141, 11737.88262117402, 11935.403229838299, 11994.820077698667, 12168.391580420766, 12422.751544968869, 10611.2041596879, 10745.946270268598, 11356.886431135583, 11488.885111148782, 11494.94252528732], "value": 7380.7080668275985, "unit": "score"}], "name": "dromaeo_css", "value": 7670.765508708685, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 103.0, 111.0, 112.0, 110.0, 100.0, 110.0, 110.0, 111.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 126.0, 156.0, 191.0, 133.0, 155.0, 149.0, 127.0, 175.0, 140.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 168.0, 161.0, 164.0, 161.0, 161.0, 163.0, 163.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 77.0, 163.0, 73.0, 75.0, 74.0, 76.0, 182.0, 76.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 161.0, 92.0, 92.0, 93.0, 153.0, 92.0, 92.0, 155.0], "value": 111.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.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": [57.0, 55.0, 55.0, 58.0, 55.0, 57.0, 57.0, 73.0, 56.0, 55.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 60.0, 60.0, 59.0, 62.0, 60.0, 59.0, 59.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 75.0, 76.0, 75.0, 76.0, 75.0, 75.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 124.0, 113.0, 122.0, 116.0, 124.0, 114.0, 115.0, 132.0, 135.0], "value": 121.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 165.0, 164.0, 165.0, 161.0, 158.0, 155.0, 164.0, 157.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 68.0, 67.0, 71.0, 66.0, 67.0, 75.0, 66.0, 66.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1531.5000000000002, "alertThreshold": 2.0}]} 11:07:30 INFO - Return code: 0 11:07:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:07:30 ERROR - # TBPL SUCCESS # 11:07:30 INFO - Running post-action listener: _resource_record_post_action 11:07:30 INFO - Running post-run listener: _resource_record_post_run 11:07:31 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 464052224; Read time: 16; Write time: 411096 11:07:31 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242528256; Read time: 0; Write time: 283720 11:07:31 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 221523968; Read time: 16; Write time: 127376 11:07:31 INFO - Running post-run listener: _upload_blobber_files 11:07:31 INFO - Blob upload gear active. 11:07:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:07:31 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:07:31 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:07:31 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:07:31 INFO - (blobuploader) - INFO - Open directory for files ... 11:07:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:07:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:07:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:07:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:07:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:07:32 INFO - (blobuploader) - INFO - Done attempting. 11:07:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:07:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:07:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:07:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:07:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:07:33 INFO - (blobuploader) - INFO - Done attempting. 11:07:33 INFO - (blobuploader) - INFO - Iteration through files over. 11:07:33 INFO - Return code: 0 11:07:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:07:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:07:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bef0549b760d2b068aa09aa391f762761f2537eabe977cbd851dcf62c0b37e63ce97a26be79577a823577d81c1e7c3f507d4cd3afede5a70065a2f27851e25a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c900da345e86a61b217fd6cbe85c380e91d801fcf44cc03547d52cd7bf5bd9263021ed59f44f8f4ea05f05952236083b3e98ad1ecd4693cbcb0b90c90d428640"} 11:07:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:07:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:07:33 INFO - Contents: 11:07:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bef0549b760d2b068aa09aa391f762761f2537eabe977cbd851dcf62c0b37e63ce97a26be79577a823577d81c1e7c3f507d4cd3afede5a70065a2f27851e25a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c900da345e86a61b217fd6cbe85c380e91d801fcf44cc03547d52cd7bf5bd9263021ed59f44f8f4ea05f05952236083b3e98ad1ecd4693cbcb0b90c90d428640"} 11:07:33 INFO - Running post-run listener: copy_logs_to_upload_dir 11:07:33 INFO - Copying logs to upload dir... 11:07:33 INFO - mkdir: /builds/slave/test/build/upload/logs 11:07:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.602954 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-01 11:07:33.032586) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 11:07:33.035889) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126 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/bef0549b760d2b068aa09aa391f762761f2537eabe977cbd851dcf62c0b37e63ce97a26be79577a823577d81c1e7c3f507d4cd3afede5a70065a2f27851e25a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c900da345e86a61b217fd6cbe85c380e91d801fcf44cc03547d52cd7bf5bd9263021ed59f44f8f4ea05f05952236083b3e98ad1ecd4693cbcb0b90c90d428640"} build_url:https://queue.taskcluster.net/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011139 build_url: 'https://queue.taskcluster.net/v1/task/MoUuEb0WSwSuCzK_KY7LPQ/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/bef0549b760d2b068aa09aa391f762761f2537eabe977cbd851dcf62c0b37e63ce97a26be79577a823577d81c1e7c3f507d4cd3afede5a70065a2f27851e25a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c900da345e86a61b217fd6cbe85c380e91d801fcf44cc03547d52cd7bf5bd9263021ed59f44f8f4ea05f05952236083b3e98ad1ecd4693cbcb0b90c90d428640"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 11:07:33.060601) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 11:07:33.060936) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467394516.929184-71940126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 11:07:33.144715) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 11:07:33.145034) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 11:07:33.145323) ========= ========= Total master_lag: 0.17 =========