builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1469147080.88 results: success (0) buildid: 20160721144529 builduid: 6b6105d498cf46c68ad489880c3c3c0e revision: 05853bb06a8739b77c2937f418cdf4e1610d0d9f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 17:24:40.883231) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 17:24:40.883724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 17:24:40.883998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 17:24:40.899007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 17:24:40.899364) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 17:24:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-07-21 17:24:41 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094497 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 17:24:41.009327) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 17:24:41.009650) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018663 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 17:24:41.058968) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 17:24:41.059301) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 05853bb06a8739b77c2937f418cdf4e1610d0d9f --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 05853bb06a8739b77c2937f418cdf4e1610d0d9f --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=5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 17:24:41,309 truncating revision to first 12 chars 2016-07-21 17:24:41,309 Setting DEBUG logging. 2016-07-21 17:24:41,309 attempt 1/10 2016-07-21 17:24:41,309 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/05853bb06a87?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 17:24:41,883 unpacking tar archive at: mozilla-beta-05853bb06a87/testing/mozharness/ program finished with exit code 0 elapsedTime=0.881939 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 17:24:41.954572) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 17:24:41.954893) ========= script_repo_revision: 05853bb06a8739b77c2937f418cdf4e1610d0d9f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 17:24:41.955266) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 17:24:41.955547) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 17:24:41.965123) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-07-21 17:24:41.965424) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:24:42 INFO - MultiFileLogger online at 20160721 17:24:42 in /builds/slave/test 17:24:42 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 17:24:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:24:42 INFO - {'append_to_log': False, 17:24:42 INFO - 'base_work_dir': '/builds/slave/test', 17:24:42 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:24:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:24:42 INFO - 'branch': 'Mozilla-Beta', 17:24:42 INFO - 'buildbot_json_path': 'buildprops.json', 17:24:42 INFO - 'config_files': ('talos/linux_config.py',), 17:24:42 INFO - 'default_actions': ('clobber', 17:24:42 INFO - 'read-buildbot-config', 17:24:42 INFO - 'download-and-extract', 17:24:42 INFO - 'populate-webroot', 17:24:42 INFO - 'create-virtualenv', 17:24:42 INFO - 'install', 17:24:42 INFO - 'run-tests'), 17:24:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:24:42 INFO - 'download_minidump_stackwalk': True, 17:24:42 INFO - 'download_symbols': 'ondemand', 17:24:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:24:42 INFO - 'tooltool.py': '/tools/tooltool.py', 17:24:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:24:42 INFO - '/tools/misc-python/virtualenv.py')}, 17:24:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:24:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:24:42 INFO - 'installer_path': 'installer.exe', 17:24:42 INFO - 'log_level': 'info', 17:24:42 INFO - 'log_name': 'talos', 17:24:42 INFO - 'log_to_console': True, 17:24:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:24:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:24:42 INFO - 'opt_config_files': (), 17:24:42 INFO - 'pip_index': False, 17:24:42 INFO - 'sps_profile': False, 17:24:42 INFO - 'sps_profile_interval': 0, 17:24:42 INFO - 'suite': 'dromaeojs-e10s', 17:24:42 INFO - 'system_bits': '32', 17:24:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:24:42 INFO - 'title': 'talos-linux64-ix-051', 17:24:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:24:42 INFO - 'use_talos_json': True, 17:24:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:24:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:24:42 INFO - 'work_dir': 'build'} 17:24:42 INFO - ##### 17:24:42 INFO - ##### Running clobber step. 17:24:42 INFO - ##### 17:24:42 INFO - Running pre-action listener: _resource_record_pre_action 17:24:42 INFO - Running main action method: clobber 17:24:42 INFO - rmtree: /builds/slave/test/build 17:24:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:24:43 INFO - Running post-action listener: _resource_record_post_action 17:24:43 INFO - ##### 17:24:43 INFO - ##### Running read-buildbot-config step. 17:24:43 INFO - ##### 17:24:43 INFO - Running pre-action listener: _resource_record_pre_action 17:24:43 INFO - Running main action method: read_buildbot_config 17:24:43 INFO - Using buildbot properties: 17:24:43 INFO - { 17:24:43 INFO - "project": "", 17:24:43 INFO - "product": "firefox", 17:24:43 INFO - "script_repo_revision": "production", 17:24:43 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 17:24:43 INFO - "repository": "", 17:24:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 17:24:43 INFO - "buildid": "20160721144529", 17:24:43 INFO - "pgo_build": "True", 17:24:43 INFO - "basedir": "/builds/slave/test", 17:24:43 INFO - "buildnumber": 184, 17:24:43 INFO - "slavename": "talos-linux64-ix-051", 17:24:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:24:43 INFO - "platform": "ubuntu64_hw", 17:24:43 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 17:24:43 INFO - "branch": "mozilla-beta", 17:24:43 INFO - "repo_path": "releases/mozilla-beta", 17:24:43 INFO - "revision": "05853bb06a8739b77c2937f418cdf4e1610d0d9f", 17:24:43 INFO - "stage_platform": "linux64-pgo", 17:24:43 INFO - "builduid": "6b6105d498cf46c68ad489880c3c3c0e", 17:24:43 INFO - "slavebuilddir": "test" 17:24:43 INFO - } 17:24:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 17:24:43 INFO - Running post-action listener: _resource_record_post_action 17:24:43 INFO - ##### 17:24:43 INFO - ##### Running download-and-extract step. 17:24:43 INFO - ##### 17:24:43 INFO - Running pre-action listener: _resource_record_pre_action 17:24:43 INFO - Running main action method: download_and_extract 17:24:43 INFO - mkdir: /builds/slave/test/build/tests 17:24: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')]} 17:24:43 INFO - https://queue.taskcluster.net/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:24:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 17:24:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 17:24:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/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 17:24:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/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 17:24:43 INFO - Downloaded 1327 bytes. 17:24:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 17:24:43 INFO - Using the following test package requirements: 17:24:43 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 17:24:43 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:24:43 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 17:24:43 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:24:43 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 17:24:43 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:24:43 INFO - u'jsshell-linux-x86_64.zip'], 17:24:43 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:24:43 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 17:24:43 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 17:24:43 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:24:43 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 17:24:43 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:24:43 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 17:24:43 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:24:43 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 17:24:43 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:24:43 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 17:24:43 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:24: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')]} 17:24:43 INFO - https://queue.taskcluster.net/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:24:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:24:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:24:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/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 17:24:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/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 17:24:44 INFO - Downloaded 24199506 bytes. 17:24:44 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'] 17:24:44 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 17:24:46 INFO - Return code: 0 17:24:46 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 17:24:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:46 INFO - https://queue.taskcluster.net/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:24:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:24:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:24:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/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 17:24:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/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 17:24:47 INFO - Downloaded 24199506 bytes. 17:24:47 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'] 17:24:47 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 17:24:48 INFO - Return code: 0 17:24:48 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')]} 17:24:48 INFO - https://queue.taskcluster.net/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:24:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 17:24:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 17:24:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/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 17:24:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/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 17:24:49 INFO - Downloaded 10840145 bytes. 17:24:49 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'] 17:24:49 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 17:24:49 INFO - Return code: 0 17:24:49 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')]} 17:24:49 INFO - https://queue.taskcluster.net/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:24:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:24:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:24:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/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 17:24:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/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 17:24:51 INFO - Downloaded 56033242 bytes. 17:24:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:24:51 INFO - mkdir: /builds/slave/test/properties 17:24:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:24:51 INFO - Writing to file /builds/slave/test/properties/build_url 17:24:51 INFO - Contents: 17:24:51 INFO - build_url:https://queue.taskcluster.net/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:24:52 INFO - Running post-action listener: _resource_record_post_action 17:24:52 INFO - Running post-action listener: set_extra_try_arguments 17:24:52 INFO - ##### 17:24:52 INFO - ##### Running populate-webroot step. 17:24:52 INFO - ##### 17:24:52 INFO - Running pre-action listener: _resource_record_pre_action 17:24:52 INFO - Running main action method: populate_webroot 17:24:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:24:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:24:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:24:52 INFO - '--tppagecycles', 17:24:52 INFO - '7'], 17:24:52 INFO - 'tests': ['tsvgm']}}, 17:24:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:24:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:24:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:24:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:24:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:24:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:24:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:52 INFO - 'talos_options': ['--disable-e10s'], 17:24:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:52 INFO - 'talos_options': ['--disable-e10s'], 17:24:52 INFO - 'tests': ['damp', 'tps']}, 17:24:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:52 INFO - 'tests': ['damp', 'tps']}, 17:24:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:24:52 INFO - 'tests': ['dromaeo_dom']}, 17:24:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:24:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:24:52 INFO - 'tests': ['a11yr', 17:24:52 INFO - 'ts_paint', 17:24:52 INFO - 'tpaint', 17:24:52 INFO - 'sessionrestore', 17:24:52 INFO - 'sessionrestore_no_auto_restore', 17:24:52 INFO - 'tabpaint']}, 17:24:52 INFO - 'other-e10s': {'tests': ['a11yr', 17:24:52 INFO - 'ts_paint', 17:24:52 INFO - 'tpaint', 17:24:52 INFO - 'sessionrestore', 17:24:52 INFO - 'sessionrestore_no_auto_restore', 17:24:52 INFO - 'tabpaint']}, 17:24:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:24:52 INFO - 'ts_paint', 17:24:52 INFO - 'tpaint', 17:24:52 INFO - 'sessionrestore', 17:24:52 INFO - 'sessionrestore_no_auto_restore', 17:24:52 INFO - 'tabpaint']}, 17:24:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:24:52 INFO - 'ts_paint', 17:24:52 INFO - 'tpaint', 17:24:52 INFO - 'sessionrestore', 17:24:52 INFO - 'sessionrestore_no_auto_restore', 17:24:52 INFO - 'tabpaint']}, 17:24:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:24:52 INFO - 'tests': ['a11yr', 17:24:52 INFO - 'ts_paint', 17:24:52 INFO - 'tpaint', 17:24:52 INFO - 'sessionrestore', 17:24:52 INFO - 'sessionrestore_no_auto_restore', 17:24:52 INFO - 'tabpaint']}, 17:24:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:24:52 INFO - 'tests': ['a11yr', 17:24:52 INFO - 'ts_paint', 17:24:52 INFO - 'tpaint', 17:24:52 INFO - 'sessionrestore', 17:24:52 INFO - 'sessionrestore_no_auto_restore', 17:24:52 INFO - 'tabpaint']}, 17:24:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:24:52 INFO - 'tests': ['tsvgx', 17:24:52 INFO - 'tsvgr_opacity', 17:24:52 INFO - 'tart', 17:24:52 INFO - 'tscrollx', 17:24:52 INFO - 'cart']}, 17:24:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:24:52 INFO - 'tsvgr_opacity', 17:24:52 INFO - 'tart', 17:24:52 INFO - 'tscrollx', 17:24:52 INFO - 'cart']}, 17:24:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:52 INFO - 'talos_options': ['--disable-e10s'], 17:24:52 INFO - 'tests': ['tp5o']}, 17:24:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:52 INFO - 'tests': ['tp5o']}, 17:24:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:52 INFO - 'talos_options': ['--disable-e10s', 17:24:52 INFO - '--xperf_path', 17:24:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:52 INFO - 'tests': ['tp5n']}, 17:24:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:52 INFO - 'talos_options': ['--xperf_path', 17:24:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:52 INFO - 'tests': ['tp5n']}}, 17:24:52 INFO - 'talos.zip': {'path': '', 17:24:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:24:52 INFO - Running post-action listener: _resource_record_post_action 17:24:52 INFO - ##### 17:24:52 INFO - ##### Running create-virtualenv step. 17:24:52 INFO - ##### 17:24:52 INFO - Running pre-action listener: _resource_record_pre_action 17:24:52 INFO - Running main action method: create_virtualenv 17:24:52 INFO - Creating virtualenv /builds/slave/test/build/venv 17:24:52 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 17:24:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:24:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:24:52 INFO - Using real prefix '/usr' 17:24:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:24:53 INFO - Installing distribute.............................................................................................................................................................................................done. 17:24:55 INFO - Installing pip.................done. 17:24:55 INFO - Return code: 0 17:24:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:24:55 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')]} 17:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:55 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')]} 17:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:55 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 0x7fdc058bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d77d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866640>, '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 0x2867540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28679d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287', '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 17:24:55 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 17:24:55 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 17:24:55 INFO - Using env: {'DISPLAY': ':0', 17:24:55 INFO - 'HOME': '/home/cltbld', 17:24:55 INFO - 'LANG': 'en_US.UTF-8', 17:24:55 INFO - 'LANGUAGE': 'en_US:en', 17:24:55 INFO - 'LOGNAME': 'cltbld', 17:24:55 INFO - 'MAIL': '/var/mail/cltbld', 17:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:55 INFO - 'MOZ_NO_REMOTE': '1', 17:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:55 INFO - 'NO_EM_RESTART': '1', 17:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:55 INFO - 'PWD': '/builds/slave/test', 17:24:55 INFO - 'SHELL': '/bin/bash', 17:24:55 INFO - 'SHLVL': '1', 17:24:55 INFO - 'TERM': 'linux', 17:24:55 INFO - 'TMOUT': '86400', 17:24:55 INFO - 'USER': 'cltbld', 17:24:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287', 17:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:55 INFO - '_': '/tools/buildbot/bin/python'} 17:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:55 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 17:24:55 INFO - Cleaning up... 17:24:55 INFO - Return code: 0 17:24:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:24:55 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')]} 17:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:55 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')]} 17:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:55 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 0x7fdc058bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d77d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866640>, '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 0x2867540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28679d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287', '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 17:24:55 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 17:24:55 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 17:24:55 INFO - Using env: {'DISPLAY': ':0', 17:24:55 INFO - 'HOME': '/home/cltbld', 17:24:55 INFO - 'LANG': 'en_US.UTF-8', 17:24:55 INFO - 'LANGUAGE': 'en_US:en', 17:24:55 INFO - 'LOGNAME': 'cltbld', 17:24:55 INFO - 'MAIL': '/var/mail/cltbld', 17:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:55 INFO - 'MOZ_NO_REMOTE': '1', 17:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:55 INFO - 'NO_EM_RESTART': '1', 17:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:55 INFO - 'PWD': '/builds/slave/test', 17:24:55 INFO - 'SHELL': '/bin/bash', 17:24:55 INFO - 'SHLVL': '1', 17:24:55 INFO - 'TERM': 'linux', 17:24:55 INFO - 'TMOUT': '86400', 17:24:55 INFO - 'USER': 'cltbld', 17:24:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287', 17:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:55 INFO - '_': '/tools/buildbot/bin/python'} 17:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:55 INFO - Downloading/unpacking psutil>=0.7.1 17:24:55 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 17:24:55 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 17:24:55 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 17:24:55 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 17:24:55 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 17:24:55 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 17:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:24:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:57 INFO - Installing collected packages: psutil 17:24:57 INFO - Running setup.py install for psutil 17:24:57 INFO - building 'psutil._psutil_linux' extension 17:24:57 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 17:24:57 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 17:24:57 INFO - building 'psutil._psutil_posix' extension 17:24:57 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 17:24:57 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 17:24:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:58 INFO - Successfully installed psutil 17:24:58 INFO - Cleaning up... 17:24:58 INFO - Return code: 0 17:24:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdc058bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d77d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866640>, '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 0x2867540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28679d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287', '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 17:24:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:24:58 INFO - Using env: {'DISPLAY': ':0', 17:24:58 INFO - 'HOME': '/home/cltbld', 17:24:58 INFO - 'LANG': 'en_US.UTF-8', 17:24:58 INFO - 'LANGUAGE': 'en_US:en', 17:24:58 INFO - 'LOGNAME': 'cltbld', 17:24:58 INFO - 'MAIL': '/var/mail/cltbld', 17:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:58 INFO - 'MOZ_NO_REMOTE': '1', 17:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:58 INFO - 'NO_EM_RESTART': '1', 17:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:58 INFO - 'PWD': '/builds/slave/test', 17:24:58 INFO - 'SHELL': '/bin/bash', 17:24:58 INFO - 'SHLVL': '1', 17:24:58 INFO - 'TERM': 'linux', 17:24:58 INFO - 'TMOUT': '86400', 17:24:58 INFO - 'USER': 'cltbld', 17:24:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287', 17:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:58 INFO - '_': '/tools/buildbot/bin/python'} 17:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:25:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:25:00 INFO - Installing collected packages: mozsystemmonitor 17:25:00 INFO - Running setup.py install for mozsystemmonitor 17:25:00 INFO - Successfully installed mozsystemmonitor 17:25:00 INFO - Cleaning up... 17:25:00 INFO - Return code: 0 17:25:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:25: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')]} 17:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdc058bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d77d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866640>, '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 0x2867540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28679d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287', '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 17:25:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:25:00 INFO - Using env: {'DISPLAY': ':0', 17:25:00 INFO - 'HOME': '/home/cltbld', 17:25:00 INFO - 'LANG': 'en_US.UTF-8', 17:25:00 INFO - 'LANGUAGE': 'en_US:en', 17:25:00 INFO - 'LOGNAME': 'cltbld', 17:25:00 INFO - 'MAIL': '/var/mail/cltbld', 17:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:00 INFO - 'MOZ_NO_REMOTE': '1', 17:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:00 INFO - 'NO_EM_RESTART': '1', 17:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:00 INFO - 'PWD': '/builds/slave/test', 17:25:00 INFO - 'SHELL': '/bin/bash', 17:25:00 INFO - 'SHLVL': '1', 17:25:00 INFO - 'TERM': 'linux', 17:25:00 INFO - 'TMOUT': '86400', 17:25:00 INFO - 'USER': 'cltbld', 17:25:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287', 17:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:00 INFO - '_': '/tools/buildbot/bin/python'} 17:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:00 INFO - Downloading/unpacking blobuploader==1.2.4 17:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:02 INFO - Downloading blobuploader-1.2.4.tar.gz 17:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:25:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:25:02 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 17:25:02 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 17:25:02 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 17:25:02 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 17:25:02 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 17:25:02 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 17:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:25:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:25:02 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 17:25:02 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 17:25:02 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 17:25:02 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 17:25:02 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 17:25:02 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 17:25:03 INFO - Downloading docopt-0.6.1.tar.gz 17:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:25:03 INFO - Installing collected packages: blobuploader, requests, docopt 17:25:03 INFO - Running setup.py install for blobuploader 17:25:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:25:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:25:03 INFO - Running setup.py install for requests 17:25:03 INFO - Running setup.py install for docopt 17:25:03 INFO - Successfully installed blobuploader requests docopt 17:25:03 INFO - Cleaning up... 17:25:03 INFO - Return code: 0 17:25:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25: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')]} 17:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:03 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 0x7fdc058bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d77d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866640>, '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 0x2867540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28679d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287', '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 17:25:03 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 17:25:03 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 17:25:03 INFO - Using env: {'DISPLAY': ':0', 17:25:03 INFO - 'HOME': '/home/cltbld', 17:25:03 INFO - 'LANG': 'en_US.UTF-8', 17:25:03 INFO - 'LANGUAGE': 'en_US:en', 17:25:03 INFO - 'LOGNAME': 'cltbld', 17:25:03 INFO - 'MAIL': '/var/mail/cltbld', 17:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:03 INFO - 'MOZ_NO_REMOTE': '1', 17:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:03 INFO - 'NO_EM_RESTART': '1', 17:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:03 INFO - 'PWD': '/builds/slave/test', 17:25:03 INFO - 'SHELL': '/bin/bash', 17:25:03 INFO - 'SHLVL': '1', 17:25:03 INFO - 'TERM': 'linux', 17:25:03 INFO - 'TMOUT': '86400', 17:25:03 INFO - 'USER': 'cltbld', 17:25:03 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287', 17:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:03 INFO - '_': '/tools/buildbot/bin/python'} 17:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:25:04 INFO - Running setup.py (path:/tmp/pip-iJZQnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:25:04 INFO - Running setup.py (path:/tmp/pip-Fb003M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:25:04 INFO - Running setup.py (path:/tmp/pip-gtJAri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:25:04 INFO - Running setup.py (path:/tmp/pip-57GM1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:25:04 INFO - Running setup.py (path:/tmp/pip-rUCKt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:25:04 INFO - Running setup.py (path:/tmp/pip-2X7tHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:25:04 INFO - Running setup.py (path:/tmp/pip-ph4PLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:25:04 INFO - Running setup.py (path:/tmp/pip-nBj_nZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:25:04 INFO - Running setup.py (path:/tmp/pip-NpeAz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:25:04 INFO - Running setup.py (path:/tmp/pip-yr7N5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:25:04 INFO - Running setup.py (path:/tmp/pip-TwypbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:25:04 INFO - Running setup.py (path:/tmp/pip-nIA4XZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:25:04 INFO - Running setup.py (path:/tmp/pip-lV1H2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:25:05 INFO - Running setup.py (path:/tmp/pip-Y_Q1Pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:05 INFO - Running setup.py (path:/tmp/pip-AnzynU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:25:05 INFO - Running setup.py (path:/tmp/pip-FvrS4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:25:05 INFO - Running setup.py (path:/tmp/pip-mZkq3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:25:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:25:05 INFO - Running setup.py install for manifestparser 17:25:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:25:05 INFO - Running setup.py install for mozcrash 17:25:05 INFO - Running setup.py install for mozdebug 17:25:05 INFO - Running setup.py install for mozdevice 17:25:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:25:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:25:05 INFO - Running setup.py install for mozfile 17:25:05 INFO - Running setup.py install for mozhttpd 17:25:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:25:05 INFO - Running setup.py install for mozinfo 17:25:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:25:05 INFO - Running setup.py install for mozInstall 17:25:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:25:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:25:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:25:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:25:06 INFO - Running setup.py install for mozleak 17:25:06 INFO - Running setup.py install for mozlog 17:25:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:25:06 INFO - Running setup.py install for moznetwork 17:25:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:25:06 INFO - Running setup.py install for mozprocess 17:25:06 INFO - Running setup.py install for mozprofile 17:25:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:25:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:25:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:25:06 INFO - Running setup.py install for mozrunner 17:25:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:25:06 INFO - Running setup.py install for mozscreenshot 17:25:06 INFO - Running setup.py install for moztest 17:25:06 INFO - Running setup.py install for mozversion 17:25:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:25:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:25:07 INFO - Cleaning up... 17:25:07 INFO - Return code: 0 17:25:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25: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')]} 17:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:07 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 0x7fdc058bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d77d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866640>, '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 0x2867540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28679d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287', '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 17:25:07 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 17:25:07 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 17:25:07 INFO - Using env: {'DISPLAY': ':0', 17:25:07 INFO - 'HOME': '/home/cltbld', 17:25:07 INFO - 'LANG': 'en_US.UTF-8', 17:25:07 INFO - 'LANGUAGE': 'en_US:en', 17:25:07 INFO - 'LOGNAME': 'cltbld', 17:25:07 INFO - 'MAIL': '/var/mail/cltbld', 17:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:07 INFO - 'MOZ_NO_REMOTE': '1', 17:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:07 INFO - 'NO_EM_RESTART': '1', 17:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:07 INFO - 'PWD': '/builds/slave/test', 17:25:07 INFO - 'SHELL': '/bin/bash', 17:25:07 INFO - 'SHLVL': '1', 17:25:07 INFO - 'TERM': 'linux', 17:25:07 INFO - 'TMOUT': '86400', 17:25:07 INFO - 'USER': 'cltbld', 17:25:07 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287', 17:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:07 INFO - '_': '/tools/buildbot/bin/python'} 17:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:25:07 INFO - Running setup.py (path:/tmp/pip-XiuUb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:25:07 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)) 17:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:25:07 INFO - Running setup.py (path:/tmp/pip-4ZoDLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:25:07 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)) 17:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:25:07 INFO - Running setup.py (path:/tmp/pip-XebWxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:25:07 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)) 17:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:25:07 INFO - Running setup.py (path:/tmp/pip-0q_IBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:25:07 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)) 17:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:25:07 INFO - Running setup.py (path:/tmp/pip-5nXJqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:25:07 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)) 17:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:25:07 INFO - Running setup.py (path:/tmp/pip-5PUkl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:25:07 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)) 17:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:25:07 INFO - Running setup.py (path:/tmp/pip-_VIkOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:25:07 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)) 17:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:25:07 INFO - Running setup.py (path:/tmp/pip-iCdn6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:25:07 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)) 17:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:25:07 INFO - Running setup.py (path:/tmp/pip-uhJ5DT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:25:07 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)) 17:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:25:07 INFO - Running setup.py (path:/tmp/pip-mXImMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:25:08 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)) 17:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:25:08 INFO - Running setup.py (path:/tmp/pip-xR8iuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:25:08 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)) 17:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:25:08 INFO - Running setup.py (path:/tmp/pip-TDbkOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:25:08 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)) 17:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:25:08 INFO - Running setup.py (path:/tmp/pip-5gFI2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:25:08 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)) 17:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:25:08 INFO - Running setup.py (path:/tmp/pip-GxzStZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:25:08 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)) 17:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:08 INFO - Running setup.py (path:/tmp/pip-lBEMub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:08 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)) 17:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:25:08 INFO - Running setup.py (path:/tmp/pip-INX1Vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:25:08 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)) 17:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:25:08 INFO - Running setup.py (path:/tmp/pip-hY2gSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:25:08 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)) 17:25:08 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)) 17:25:08 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)) 17:25:08 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)) 17:25:08 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)) 17:25:08 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)) 17:25:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:10 INFO - Downloading blessings-1.6.tar.gz 17:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:25:10 INFO - Installing collected packages: blessings 17:25:10 INFO - Running setup.py install for blessings 17:25:10 INFO - Successfully installed blessings 17:25:10 INFO - Cleaning up... 17:25:10 INFO - Return code: 0 17:25:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:25:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:25:10 INFO - Reading from file tmpfile_stdout 17:25:10 INFO - Current package versions: 17:25:10 INFO - argparse == 1.2.1 17:25:10 INFO - blessings == 1.6 17:25:10 INFO - blobuploader == 1.2.4 17:25:10 INFO - docopt == 0.6.1 17:25:10 INFO - manifestparser == 1.1 17:25:10 INFO - mozInstall == 1.12 17:25:10 INFO - mozcrash == 0.17 17:25:10 INFO - mozdebug == 0.1 17:25:10 INFO - mozdevice == 0.48 17:25:10 INFO - mozfile == 1.2 17:25:10 INFO - mozhttpd == 0.7 17:25:10 INFO - mozinfo == 0.9 17:25:10 INFO - mozleak == 0.1 17:25:10 INFO - mozlog == 3.1 17:25:10 INFO - moznetwork == 0.27 17:25:10 INFO - mozprocess == 0.22 17:25:10 INFO - mozprofile == 0.28 17:25:10 INFO - mozrunner == 6.11 17:25:10 INFO - mozscreenshot == 0.1 17:25:10 INFO - mozsystemmonitor == 0.0 17:25:10 INFO - moztest == 0.7 17:25:10 INFO - mozversion == 1.4 17:25:10 INFO - psutil == 3.1.1 17:25:10 INFO - requests == 1.2.3 17:25:10 INFO - wsgiref == 0.1.2 17:25:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:10 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 0x7fdc058bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d77d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866640>, '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 0x2867540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28679d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287', '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 17:25:10 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 17:25:10 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 17:25:10 INFO - Using env: {'DISPLAY': ':0', 17:25:10 INFO - 'HOME': '/home/cltbld', 17:25:10 INFO - 'LANG': 'en_US.UTF-8', 17:25:10 INFO - 'LANGUAGE': 'en_US:en', 17:25:10 INFO - 'LOGNAME': 'cltbld', 17:25:10 INFO - 'MAIL': '/var/mail/cltbld', 17:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:10 INFO - 'MOZ_NO_REMOTE': '1', 17:25:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:10 INFO - 'NO_EM_RESTART': '1', 17:25:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:10 INFO - 'PWD': '/builds/slave/test', 17:25:10 INFO - 'SHELL': '/bin/bash', 17:25:10 INFO - 'SHLVL': '1', 17:25:10 INFO - 'TERM': 'linux', 17:25:10 INFO - 'TMOUT': '86400', 17:25:10 INFO - 'USER': 'cltbld', 17:25:10 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287', 17:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:10 INFO - '_': '/tools/buildbot/bin/python'} 17:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:11 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)) 17:25:11 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)) 17:25:11 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)) 17:25:11 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)) 17:25:11 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)) 17:25:11 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)) 17:25:11 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)) 17:25:11 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)) 17:25:11 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)) 17:25:11 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)) 17:25:11 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)) 17:25:11 INFO - Cleaning up... 17:25:11 INFO - Return code: 0 17:25:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc058bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d77d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866640>, '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 0x2867540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28679d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287', '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 17:25:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:25:11 INFO - Using env: {'DISPLAY': ':0', 17:25:11 INFO - 'HOME': '/home/cltbld', 17:25:11 INFO - 'LANG': 'en_US.UTF-8', 17:25:11 INFO - 'LANGUAGE': 'en_US:en', 17:25:11 INFO - 'LOGNAME': 'cltbld', 17:25:11 INFO - 'MAIL': '/var/mail/cltbld', 17:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:11 INFO - 'MOZ_NO_REMOTE': '1', 17:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:11 INFO - 'NO_EM_RESTART': '1', 17:25:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:11 INFO - 'PWD': '/builds/slave/test', 17:25:11 INFO - 'SHELL': '/bin/bash', 17:25:11 INFO - 'SHLVL': '1', 17:25:11 INFO - 'TERM': 'linux', 17:25:11 INFO - 'TMOUT': '86400', 17:25:11 INFO - 'USER': 'cltbld', 17:25:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287', 17:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:11 INFO - '_': '/tools/buildbot/bin/python'} 17:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:11 INFO - Downloading/unpacking jsonschema 17:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:25:13 INFO - Downloading/unpacking functools32 (from jsonschema) 17:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:13 INFO - Downloading functools32-3.2.3-2.tar.gz 17:25:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:25:13 INFO - warning: no files found matching '*.txt' 17:25:13 INFO - no previously-included directories found matching 'build' 17:25:13 INFO - no previously-included directories found matching 'dist' 17:25:13 INFO - no previously-included directories found matching '.git*' 17:25:13 INFO - Installing collected packages: jsonschema, functools32 17:25:13 INFO - Running setup.py install for functools32 17:25:13 INFO - warning: no files found matching '*.txt' 17:25:13 INFO - no previously-included directories found matching 'build' 17:25:13 INFO - no previously-included directories found matching 'dist' 17:25:13 INFO - no previously-included directories found matching '.git*' 17:25:13 INFO - Successfully installed jsonschema functools32 17:25:13 INFO - Cleaning up... 17:25:13 INFO - Return code: 0 17:25:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:13 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 0x7fdc058bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d77d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2866640>, '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 0x2867540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28679d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287', '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 17:25:13 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 17:25:13 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 17:25:13 INFO - Using env: {'DISPLAY': ':0', 17:25:13 INFO - 'HOME': '/home/cltbld', 17:25:13 INFO - 'LANG': 'en_US.UTF-8', 17:25:13 INFO - 'LANGUAGE': 'en_US:en', 17:25:13 INFO - 'LOGNAME': 'cltbld', 17:25:13 INFO - 'MAIL': '/var/mail/cltbld', 17:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:13 INFO - 'MOZ_NO_REMOTE': '1', 17:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:13 INFO - 'NO_EM_RESTART': '1', 17:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:13 INFO - 'PWD': '/builds/slave/test', 17:25:13 INFO - 'SHELL': '/bin/bash', 17:25:13 INFO - 'SHLVL': '1', 17:25:13 INFO - 'TERM': 'linux', 17:25:13 INFO - 'TMOUT': '86400', 17:25:13 INFO - 'USER': 'cltbld', 17:25:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287', 17:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:13 INFO - '_': '/tools/buildbot/bin/python'} 17:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:13 INFO - Downloading/unpacking flake8 17:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:25:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:25:15 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 17:25:15 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 17:25:15 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 17:25:15 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 17:25:15 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 17:25:15 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 17:25:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:25:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:25:15 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 17:25:15 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 17:25:15 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 17:25:15 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 17:25:15 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 17:25:15 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 17:25:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:25:16 INFO - no previously-included directories found matching 'docs/_build' 17:25:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:25:16 INFO - Running setup.py install for pep8 17:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:25:16 INFO - no previously-included directories found matching 'docs/_build' 17:25:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:25:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:25:16 INFO - Cleaning up... 17:25:16 INFO - Return code: 0 17:25:16 INFO - Running post-action listener: _resource_record_post_action 17:25:16 INFO - Running post-action listener: _start_resource_monitoring 17:25:16 INFO - Starting resource monitoring. 17:25:16 INFO - ##### 17:25:16 INFO - ##### Running install step. 17:25:16 INFO - ##### 17:25:16 INFO - Running pre-action listener: _resource_record_pre_action 17:25:16 INFO - Running main action method: install 17:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:25:16 INFO - Reading from file tmpfile_stdout 17:25:16 INFO - Detecting whether we're running mozinstall >=1.0... 17:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:25:17 INFO - Reading from file tmpfile_stdout 17:25:17 INFO - Output received: 17:25:17 INFO - Usage: mozinstall [options] installer 17:25:17 INFO - Options: 17:25:17 INFO - -h, --help show this help message and exit 17:25:17 INFO - -d DEST, --destination=DEST 17:25:17 INFO - Directory to install application into. [default: 17:25:17 INFO - "/builds/slave/test"] 17:25:17 INFO - --app=APP Application being installed. [default: firefox] 17:25:17 INFO - mkdir: /builds/slave/test/build/application 17:25:17 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'] 17:25:17 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 17:25:30 INFO - Reading from file tmpfile_stdout 17:25:30 INFO - Output received: 17:25:30 INFO - /builds/slave/test/build/application/firefox/firefox 17:25:30 INFO - Running post-action listener: _resource_record_post_action 17:25:30 INFO - ##### 17:25:30 INFO - ##### Running run-tests step. 17:25:30 INFO - ##### 17:25:30 INFO - Running pre-action listener: _resource_record_pre_action 17:25:30 INFO - Running main action method: run_tests 17:25:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:25:30 INFO - Python 2.7.3 17:25:30 INFO - Return code: 0 17:25:30 INFO - grabbing minidump binary from tooltool 17:25: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')]} 17:25:30 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 0x2866640>, '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 0x2867540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28679d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:25:30 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 17:25:30 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 17:25:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:25:30 INFO - Return code: 0 17:25:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:25:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:25:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:25:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:25:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:25:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:25:31 INFO - Return code: 0 17:25:31 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/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 17:25:31 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/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 17:25:31 INFO - Using env: {'DISPLAY': ':0', 17:25:31 INFO - 'HOME': '/home/cltbld', 17:25:31 INFO - 'LANG': 'en_US.UTF-8', 17:25:31 INFO - 'LANGUAGE': 'en_US:en', 17:25:31 INFO - 'LOGNAME': 'cltbld', 17:25:31 INFO - 'MAIL': '/var/mail/cltbld', 17:25:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:25:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:31 INFO - 'MOZ_NO_REMOTE': '1', 17:25:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:31 INFO - 'NO_EM_RESTART': '1', 17:25:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:31 INFO - 'PWD': '/builds/slave/test', 17:25:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:25:31 INFO - 'SHELL': '/bin/bash', 17:25:31 INFO - 'SHLVL': '1', 17:25:31 INFO - 'TERM': 'linux', 17:25:31 INFO - 'TMOUT': '86400', 17:25:31 INFO - 'USER': 'cltbld', 17:25:31 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287', 17:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:31 INFO - '_': '/tools/buildbot/bin/python'} 17:25:31 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/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 17:25:31 INFO - mozversion application_buildid: 20160721144529 17:25:31 INFO - mozversion application_changeset: 05853bb06a8739b77c2937f418cdf4e1610d0d9f 17:25:31 INFO - mozversion application_display_name: Firefox 17:25:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:25:31 INFO - mozversion application_name: Firefox 17:25:31 INFO - mozversion application_remotingname: firefox 17:25:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:25:31 INFO - mozversion application_vendor: Mozilla 17:25:31 INFO - mozversion application_version: 48.0 17:25:31 INFO - mozversion platform_buildid: 20160721144529 17:25:31 INFO - mozversion platform_changeset: 05853bb06a8739b77c2937f418cdf4e1610d0d9f 17:25:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:25:31 INFO - mozversion platform_version: 48.0 17:25:31 INFO - using testdate: 1469147131 17:25:31 INFO - actual date: 1469147131 17:25:31 INFO - starting webserver on 'localhost:35443' 17:25:31 INFO - SUITE-START | Running 2 tests 17:25:31 INFO - TEST-START | dromaeo_css 17:25:31 INFO - operating with platform_type : linux_ 17:25:31 INFO - Initialising browser for dromaeo_css test... 17:25:31 INFO - TEST-INFO | started process 15264 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2kYLdv/profile http://localhost:35443/getInfo.html) 17:25:34 INFO - PROCESS | 15264 | 17:25:34 INFO - PROCESS | 15264 | (process:15341): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:25:35 INFO - PROCESS | 15264 | __metrics Screen width/height:1600/1200 17:25:35 INFO - PROCESS | 15264 | colorDepth:24 17:25:35 INFO - PROCESS | 15264 | Browser inner width/height: 1024/697 17:25:35 INFO - PROCESS | 15264 | __metrics 17:25:36 ERROR - PROCESS | 15264 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 17:25:37 INFO - TEST-INFO | 15264: exit 0 17:25:37 INFO - Browser initialized. 17:25:37 INFO - Running cycle 1/1 for dromaeo_css test... 17:25:37 INFO - TEST-INFO | started process 15391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2kYLdv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:25:38 INFO - PROCESS | 15391 | 17:25:38 INFO - PROCESS | 15391 | (process:15461): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:25:48 INFO - PROCESS | 15391 | RSS: Main: 150724608 17:25:48 INFO - PROCESS | 15391 | 17:26:38 INFO - PROCESS | 15391 | 1469147198448 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] 17:28:45 INFO - PROCESS | 15391 | Cycle 1(1): loaded http://localhost:35443/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35443/tests/dromaeo/cssquery-ext.html) 17:28:46 INFO - PROCESS | 15391 | RSS: Main: 154562560 17:28:46 INFO - PROCESS | 15391 | 17:31:48 INFO - PROCESS | 15391 | Cycle 1(1): loaded http://localhost:35443/tests/dromaeo/cssquery-ext.html (next: http://localhost:35443/tests/dromaeo/cssquery-jquery.html) 17:31:49 INFO - PROCESS | 15391 | RSS: Main: 152387584 17:31:49 INFO - PROCESS | 15391 | 17:34:50 INFO - PROCESS | 15391 | Cycle 1(1): loaded http://localhost:35443/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35443/tests/dromaeo/cssquery-mootools.html) 17:34:51 INFO - PROCESS | 15391 | RSS: Main: 152248320 17:34:51 INFO - PROCESS | 15391 | 17:37:52 INFO - PROCESS | 15391 | Cycle 1(1): loaded http://localhost:35443/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35443/tests/dromaeo/cssquery-prototype.html) 17:37:53 INFO - PROCESS | 15391 | RSS: Main: 153571328 17:37:53 INFO - PROCESS | 15391 | 17:40:55 INFO - PROCESS | 15391 | Cycle 1(1): loaded http://localhost:35443/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35443/tests/dromaeo/cssquery-yui.html) 17:40:56 INFO - PROCESS | 15391 | RSS: Main: 152264704 17:40:56 INFO - PROCESS | 15391 | 17:43:58 INFO - PROCESS | 15391 | Cycle 1(1): loaded http://localhost:35443/tests/dromaeo/cssquery-yui.html (next: http://localhost:35443/tests/dromaeo/cssquery-dojo.html) 17:43:58 INFO - PROCESS | 15391 | RSS: Main: 156123136 17:43:58 INFO - PROCESS | 15391 | 17:43:58 INFO - PROCESS | 15391 | __start_tp_report 17:43:58 INFO - PROCESS | 15391 | _x_x_mozilla_page_load 17:43:58 INFO - PROCESS | 15391 | _x_x_mozilla_page_load_details 17:43:58 INFO - PROCESS | 15391 | |i|pagename|runs| 17:43:58 INFO - PROCESS | 15391 | |0;dojo.html;3327.783694059886;3358.7648864579487;3371.477420999746;3386.932261354773;3420.350133474639;5454.263674403955;5482.342118945722;5505.504504594585;5519.392866784656;5568.276124103861;5486.890262194764;5533.170024496328;5554.555635549156;5555.388907220203;5557.499825015748;4966.50334966504;5028.84913452597;5071.061853557086;5079.085764562377;5085.1863701807715;4951.257311403282;4998.250262460624;5028.874278143039;5091.541761241488;5119.590432765389;5024.874378140539;5042.520960508746;5092.032513822381;5114.258432527281;5116.539511443969;5027.2207807789855;5039.899202015976;5044.571211447032;5059.519345662156;5066.721330326831;4750.548697873696;4833.854984350475;4843.75781210938;4932.7421507515355;4940.925886111711;5254.238135470336;5268.736563171864;5279.604029697788;5288.576913846883;5295.285136506561;5774.4802967732685;5780.653160810322;5781.421857814227;5781.739821708034;5783.681897495636;5789.536837053026;5797.710114494301;5844.9415505845245;5860.619059761102;5865;5472.288602481692;5478.753456094445;5485.807996720136;5494.642848214893;5499.202615620753;5881.235439392852;5925.259342582177;5934.13954976526;5939.46544810969;5951.613145145551;5674.290713660793;5729.541636669056;5776.537876969833;5784.566157538202;5810.331811841692;5928.911066334009;5976.282846058501;5980.940190598125;5985.491233245223;5988.101784732325;5661.745221465044;5925.170476133345;5951.791687290924;5954.970225148933;5959.344472108065;5805;5833.270841144857;5850.414958504116;5866.472017518358;5879.617824841372;4504.414426124583;4507.5943165115295;4520.073384956077;4535.886602834889;4557.635389168859;3967.920641587152;4012.217617564547;4083.2445997489967;4085.346344584852;4095.8361665533043;5462.235287059815;5561.082421400504;5583.05088135018;5616.1014237721765;5676.744546495418;5967.16459695643;5979.431953964367;6031.035034394564;6034.668093254913;6041.909371359433;5405.486478784509;5605.5515558755205;5643.294588176478;5700.600957932905;5702.258706368146;5049.015441988777;5062.7468626568525;5066.290719299301;5082.364704411949;5098;5956.702164891738;5993.640381577119;5994.430529099728;6029.216201893726;6038.30559485656;5714.5999780015;5909.468147866713;5924.259467566554;5937.376575459514;5990.161377407079;5964.612300200473;5982.7307771149535;5983.222181116601;5991.400859914148;6000.0999850022845;5733.3406658234835;5739.770409183586;5742.569307301886;5746.13807928814;5752.964466396089;5854.004819180835;5866.472017518444;5875.735591898289;5901.380355062828;5971.4327138921735;5623;5634.295713035871;5640.689762063126;5654;5660.830175094754;5641.435856414326;5642.069058605448;5644.745986430703;5646.209530665792;5668.943310567007;5627.380988091389;5669.6314739541795;5700.315962084576;5741.45456181662;5758.1650660654805;5794.159846822272;5808.099744539603;5818.94181058201;5833.270841144857;5834.416558344132;5617.578681598815;5704.600677952503;5733.541316694571;5749.540036796962;5753.71231438418 17:43:58 INFO - PROCESS | 15391 | |1;ext.html;668.6723505482315;670.6143967218849;704.1057856522214;735.8417940142872;741.5958302725013;33075.17312067199;39862.60137398629;40243.99999999993;40685.59314406855;40772.59227407725;44627.77686111573;45161.54838451614;45173;45367.77316113423;45418;8541.829163416744;8766.736997890073;8778.780530486756;8787;8789.560521973908;8402.831943361129;8477.279431248351;8479;8520.105388934166;8526.957365213166;9015.639374425014;9025.95487022564;9030.142136497056;9040.819183616324;9094.54527273637;8914.55427228636;8983;8988.415752976069;9004.189622933902;9032.27741780656;8870.246029087535;8976.281897448189;8980.236679882219;8980.416272942239;8984.460932344015;38029;38057.619423805685;38145.42781858274;38283.660071897626;38304;3688.686461650763;3712.238991006864;3872.3610604250266;4035.656969157625;4292.849750258726;29166.125016249545;29170.562441563394;29326.41347173066;29396.853015734785;30012.24969375761;4018.3570628699267;4028.7784171870535;4032.3951407288846;4091.7954102294766;4268.018355778188;308760;309164;309460;309511.4524427386;310557;39035.80482097571;39874.40188397176;39941.2011759769;40209.79895100506;63445.36554634487;38576.8071159648;38794.6120538791;38910.80544597316;39057.60942390597;39059.80470097631;17111.401100961408;17133.914330428517;17258.568535786453;17286.913565432344;17292.135393230288;14491.710165796836;14588;14623.707525849424;14643.194624295766;14718.55844324672;9371.578278977462;9417.246620270362;9421.293402994803;9486.525673716287;9507.049295070576;3348.22544051653;3642.453631955228;3642.635736426389;3651.4887915691825;3674.52231209941;1106.551846502168;1130.2540323386525;1136.5851464215666;1194.199886076331;1219.3293688471306;32821.835890820395;33307.833460833026;33563;33617.327653446795;33845;1185.9288442693294;1199.6700907250577;1233.1244816180613;1234.7777400068073;1254.9811752823714;17176.31294748196;17344.566385840204;17365.392211272545;17439.389621363192;17485.823712971967;491041;497570;560078;603715;615804;57940.42059579435;58481.415185847596;58489.4151058484;58496.415035849095;58940.41059589349;1530.5943924859698;1535.7158925598576;1550.3023639362107;1555.4866893924977;1565.3190861975077;32845.67154328426;33340.499892501146;33827.3234535303;34478.82760586181;34508;45349;46068.53931460642;46306.76846615745;46460.7676961613;46556.30165547452;452314;461136;461150;463044;465108;27881.442371152058;47000;47501.52498475109;47701.28448073351;47748.761256193495;38850.6114938847;39106.217875641756;39310.41034384544;39524;51537.22694159516;35996.280074397844;36405.63594364023;36600.45099323565;36626.63373366339;36917;36491;36644.81677591702;37570.24859502849;37719.81140094282;39642.60357396389;37317.81341093277;37552;38141.23717525578;39681;40431;31716.841415792773;32100.83949580237;32487.67512324941;32577.511337329484;32851.67148328486;26051.73948260493;26331.868340658173;26675;26702.664866756197;26738.732612673622 17:43:58 INFO - PROCESS | 15391 | |2;jquery.html;412.9380592911063;419.21397379912645;421.58473903205356;427.4165763732505;432.62793997162436;18667.906660466695;19155;19321;19323.420297391065;20015.099320530575;19249.13378897953;19294.324698635515;19377.51556211092;19648.70526942097;19674;5639.802606908759;5706.800261990821;5844.766209351621;5924.992751232279;5975.731092100844;5779;5796.768129274845;5810.3027636683655;5856.063029915214;5862.267216597926;5587.38538760736;5773.162891380747;5773.913391299134;5784.479396854283;5801;5680.11958146488;5683;5685.687287199203;5686.630369026021;5718.313802343704;4973.701577905337;5064.569511591482;5068.974655126701;5098.515641014098;5318.388385335697;23156.073757049697;23164.420889477897;23225.7677423227;23231.651525227135;23517;2561.782248508879;2562.4618830045524;2563.5257477366745;2620.751028652275;2747.6840163381066;14821.703565928621;14862.331195096138;14928.62678433037;15131.470398536108;15204.391824327015;2030.472077259923;2048.6107639548586;2092.1735914313763;2143.0570548958563;2178.281167214831;78149;79889.60055199744;80092;80103.5994820028;80215;10717.624883129209;10767.946160269305;11280.435978201222;11339.94330028361;11499.310041397375;15746.606334841492;15760.448384306723;15825.129617871127;15866.20668966547;15873.682526349408;8982.101789820965;9099.727008189764;9102.772430689154;9108.089191080839;9127.22418594427;8926.241269492166;8965.775855603662;8982.146696063863;9050.683226087056;9079.137481939206;6800.387965083166;6917.7232910684015;6957;6981.720731170798;6996.300369962963;1937.9418617441218;2007.498125468633;2046.2940285601444;2054.7431571053617;2059.227789578908;1058.4125810175426;1105.7456784939347;1171.3437695430773;1174.9060075193963;1193.8209268609605;19711.310104146287;19858.801411985984;20017.399478015683;20461.386158415273;20720.58558828845;1089.003561741014;1089.9182561307935;1120.6413947536873;1169.3743847041792;1250.7060840702427;11389.145814063979;11620;11650;11683.415829208505;11784.469698863571;375379;379914;386598;512160;513422;95598.52200739091;100298.498507507;100722.49638751759;100787.49606251922;101511.49244253732;1184.218415845555;1184.3190165654783;1210.673118258083;1227.3495047624774;1241.4736012215278;17440.563985900455;17575.648487030445;17735.556611084827;17776.466705998842;18230.72653910219;39567;39610.40584391179;40811;40891.59108408997;41089.178216434906;57644.13533796913;59160.70419648047;59447.1082933765;59840;59922.70038649779;8971.102889711237;9065.138811812867;9083.318751093562;9143.405678630868;9252.21356184705;12686.175398599062;13802.982809910884;13827.86172138306;13899.861001390262;13960.58118256454;11405.657830265105;12339.62981110568;12412.875871241533;12421.130520863453;12444.253344799341;11716.355600441717;11830.763384732429;12116.75766484683;12146;12152.817707734568;12454.875451245734;12456.128071035304;12518.186317889673;12590;12795.61613151607;8697.391182617155;8765.737027889174;8884.60019299146;8957.059508751487;8957.10428957099;9232.03063678331;11174.66476005721;11989.880101199225;12114.091443141975;12312.815307770212 17:43:58 INFO - PROCESS | 15391 | |3;mootools.html;1334.8398192216935;1458.540559723687;1582.580616136724;1860.0234876689728;1865.5709186887016;7688.615569221544;8261.50430974142;8357.958210208948;8574.69988550401;8651.17813807688;8383.748487545368;8432.91567084329;8506.91493085069;8549.230569248783;8595.18345757152;2428.4900170964074;2458.7172475165407;2464.605663093905;2480.4790993891306;2482.925512234636;2488.5396201702742;2516.811239157061;2516.937076573082;2518.49630073985;2519.546481633305;2446.730859605451;2456.1771806444863;2468.4322605800676;2471.3203868936007;2474.8391354561986;2401.483681008574;2414.034386245507;2417.504411595619;2441.584930561809;2447.486027934136;2396.604560247557;2427.3446169534304;2440.9755902440925;2444.7433019532873;2502.9374265643323;8589.269912057483;8612.827743445096;8633.827323453495;8657.740267791976;8658.393912426132;5334.4398838122215;5481.643693159932;5483.287172667568;5484.698341591211;5520.779168833242;3403.50649155871;3406.5912090549045;3417.7607567470286;3528.259065596228;3549.716022718176;1033.204432586904;1034.7516596016976;1039.8804137524205;1073.785242951405;1091.8198497247945;11805.940970295094;12078.27530348182;12117.515299388015;12118.091143164298;12134.5146194153;4734;4734;4748.097861406391;4763.499832517605;4835.274708793709;10399.064084232305;10437.739056523647;10458.215633827493;10462.319949203278;10502.422366769748;5363.356397232279;5388.488093631099;5393.946060539422;5407.972960135174;5414.620976531605;4408.294672852392;4868.391451068616;4887.34020907173;4985.351904252424;4989.501049894981;4087.6525495332635;4136.090060186754;4139.577153928363;4183.790810459525;4185.267578173807;1343.1068339554088;1349.197227649547;1359.3067535556936;1365.6312795545148;1368.2679766324968;890.6826247303587;1000.694788089625;1002.1631937332409;1033.9793204135874;1050.0287234308234;5807.912881306784;5881.941180588225;5932.555058370639;6055.2128223331565;6109.480694140959;955.4553904274496;1006.1196453103535;1031.2626472072504;1039.3971496531992;1054.0776820282254;4081.571434999342;4102.876913692594;4105.651019663303;4328.848490302824;4371.803268852909;10389.272750907365;10705.518251678694;10801.081908037904;10808.29746066519;10863.51114199863;10516.631917882838;10588.947055264829;10628.787424251472;10690.62582809598;10725.78548429027;8263.793405164919;8375.497470151811;8385.790355241046;8445.071042185355;8480.703175388831;5886.94113058864;5979.701014949148;6037.909431358621;6058.485028772604;6104.298005729221;9483.620655173716;9525.952370238381;9664.71005869825;9695;9751.3661611995;9496.19282361007;9772.755681108029;9783.75540611462;9958.900410995797;10004.699859004242;6572.474202063728;6962.1297337832775;7156.570605763671;7428.1086269647985;7509.061367329084;7655.846883062419;7685.538867667958;7725.381969442544;7743.845123097394;7758.456908016385;7041.436685065285;7278.599677017603;7279.963600181965;7308.671109799965;7418.072740907387;7037.768390531534;7105.609191494517;7162.89255661155;7215.67529461165;7257.927420725937;6700.731970721312;6783.898241526283;6869.519133660796;6871.725130994704;6903.1716194057035;5169.612279079009;5199.55803756685;5275.419703832498;5287;5303.496167864047;5225.843224703265;5258.553022993088;5259;5285.075111855487;5313.149896016619 17:43:58 INFO - PROCESS | 15391 | |4;prototype.html;341.3359870630675;341.7300332737138;343.48820257815856;361.79739345966243;361.9113317237277;6252.531060170494;6309.68451577421;6316.715747791349;6343.873122537552;6345.270293916201;6247.750089996406;6254.781082662108;6270.686465676721;6310.810675679725;6326.177596912395;4632.745199014044;4766.7616619169075;4807.759612019402;4807.807687692488;4824.469308376076;4763.642726795487;4787.760611969405;4799.856004319876;4804.303376010476;4808.038392321532;4730.337752714623;4731.550502702238;4742.359781429514;4744.14605371033;4751.714897106167;4741.691790033654;4757.048590281957;4758.214894542396;4758.714477131349;4767.261074533453;4138.358554424069;4138.461999940018;4141.544430112685;4144.026153853842;4149.211649786531;5890.175375447441;6119.87760244797;6124.785632502885;6131.110988906628;6143.416375444371;5587;5593.272874526327;5601.495865372136;5604.131359639263;5620.57845661577;6731.697073631698;6743.59538427691;6745.325467453215;6746.190457145125;6770.52606317558;4639.188142075123;4642.094791515656;4643.16423043852;4645.907081858378;4649.628029757645;6943.652817359162;7015.82460438488;7018.263082376328;7019.82450438738;7043.225245223021;4593.793279302439;4729.43246810385;4755.5719985201495;4759;4786.664933454695;4813.061453016699;4836.153673107263;4849.612031037508;4851.345068415719;4862.270659401118;5579.13523403873;5583.134614134816;5593.8321850344555;5596.636218645775;5608.242887210256;6766.391024807693;6767.492438067165;6778.356056174655;6788.389044985876;6793.082933803873;1670.298474640654;1711.8972861628342;1712.2294967264781;1714.0315721617496;1714.4685147604282;1093.7375029992904;1114.0474893965704;1123.07346439188;1132.824412216108;1145.1297014269214;6443.420092191632;6445.065465507475;6445.645489498029;6452.12896258999;6462.870742585216;6947.652617369111;6953.130858642669;6967.93032069683;6984.511084224056;6990.126234220723;6353.936460635335;6467.51493637979;6472.255690595642;6478.255000674889;6487.7080531376205;3757.3236817373136;3782;3801.7718936863325;3815.065308999313;3834.405667121601;7243.348098671145;7244.420446364278;7248.96375518119;7250.4199664026755;7255.274472552703;7157.821054473576;7162.677679504435;7164.749233776793;7165.319294666998;7179.1026121734785;6988.405985491188;7127.89308160378;7135.892961605477;7148.964255178795;7211.747588834471;7009.96495017542;7024.929750702428;7026.19198792125;7035.050268213726;7043.471739619446;6887.896681549881;6932.549384290005;6936.79189624312;6937.063496427918;6945.374916257561;7165.068541089625;7211.134663840373;7211.783646490614;7220.097487814023;7247.927520724726;4572.702774319791;4713.835015774432;4714.740689262124;4718.221493453541;4718.7168769873915;6976.6860491277;6980.965095174492;7019.192792828686;7021.087258656342;7024.613646249505;6776.728930842711;6815.386615204656;6817.93182068173;6818;6818.045473633596;6801.591904485746;6802;6816.079829222991;6828.248892621907;6869.107016087876;6535.248446428722;6678.198616166092;6680.83297917556;6681.665916704243;6697.899531506934;6819.829504262433;6831.351021652935;6840.418564421881;6853.691583878638;6868.484863635147;6688.531802773954;6691.966540167268;6692.263850976291;6713.295104014203;6715.664216789043 17:43:58 INFO - PROCESS | 15391 | |5;yui.html;846.4413487098516;847.28404498199;885.8095509465463;948.3551185194067;954.1460392948311;13545.864541354584;13643;13719.862801371983;13740.519081832126;13892.374843132058;13652.24912629805;16014.83985160148;16202.756958645601;16211.513654590352;16268.51194464165;774.6591499740097;920.3097676742426;929.6792606550729;930.2139691960316;930.2836815651943;907.1880666803207;913.1690161952624;920.1764420843341;920.4155361345527;925.6852670092168;978.295627148452;978.5107446276861;978.8287049766298;979.5053497983508;980.1766516126453;958.5111593087506;960.2270172511126;963.657901444984;965.8213230552335;966.5698764049965;701.2076353720263;709.435998381283;710.3926143147586;711.1643818513227;712.5012491256141;14899.553013409615;14916.2541872907;14933.178675172861;14999.250037498081;15014.699706005818;15390.07659540431;15426;15456.30446629893;15532.92233538825;15562.22188890551;11638.6508404748;11893.762124757457;11914.642560723192;11996.940015299955;12315.876841231562;4051.493563304587;4053.2298863215897;4162.354835000579;4208.684348673831;4271.423357846682;52137.47862521402;52543;52886.47113528892;59066.70466647639;60373;12457.813132803016;12503.624891253095;12558.442268230678;12690.66747991466;12692.80960785589;22190.88904555499;22230.221942231943;22233.444163895707;22263.220787272367;22303.442413939458;9061.728148155566;9168.724938251864;9244.168024877794;9317.580708868118;9381.5309234538;4923.630727695438;4977.8257760978195;5013.974930125399;5021.246812978083;5115.897682046412;3708.962910370916;3756.7745935243975;3764.981175094107;3765.7740535567955;3771.7548359356556;611.6207951070364;662.8508585568305;676.736072931557;678.4979115454528;680.4080450008524;707.5294928872243;772.9536227826236;775.135723668106;793.0285400384483;800.6677228950037;9448.95275523618;10023.69928902134;10229.130523905551;10484.842727359095;10521.947390263153;737.5648367463223;782.1201148707704;796.5618909599697;818.9918100818916;820.9179082091863;4592.977035114803;4641.303804429363;4724.716517008922;4765.0946320199055;4858.95141048585;63903;64050;64491.35508644854;64696;65169.34830651728;50668.746656266485;51164.74417627888;51836;52041.21938170931;52349.2147617786;50892;51061.744691276304;51390.22914656283;51796.48203517992;52263;9758.80482390334;9815.754606134904;9871.802563948537;9909.851352229867;10061.434334245014;37024.81487592545;38756.2248755029;38933.610663894135;41298.58701412947;41765.37351939663;46012.53987460083;47354.52645473501;48091.75954120207;48455.757721212576;48712.26931595958;12443.688907777378;12475.625731228078;12497.125201235825;12589.87410125887;12754.48982040708;13057.869421306046;13184.274864882524;13561.321933903462;13589.592312230649;15216.08703477795;12766.361681915681;12894.097413181362;13197.340132993504;13424.597262082154;13717.862821371658;12529.310887901252;13219.933900330438;13222.933885330513;13296.468141274241;13827.861721382658;12845.807312890502;13250.536231231861;13334.599962001155;13423.395947182205;13891.374888129856;10768.569257229623;11150.330980141218;11246.831297530707;11285.548578057114;11551.249168804;11455.828162577734;11482.311061336346;11670.474828632561;11740.765184696087;11870.406479676154 17:43:58 INFO - PROCESS | 15391 | __end_tp_report 17:43:58 INFO - PROCESS | 15391 | __start_cc_report 17:43:58 INFO - PROCESS | 15391 | _x_x_mozilla_cycle_collect,314 17:43:58 INFO - PROCESS | 15391 | __end_cc_report 17:43:58 INFO - PROCESS | 15391 | __startTimestamp1469148238893__endTimestamp 17:43:58 INFO - PROCESS | 15391 | 17:43:58 INFO - PROCESS | 15391 | ------- Summary: start ------- 17:43:58 INFO - PROCESS | 15391 | Number of tests: 6 17:43:58 INFO - PROCESS | 15391 | 17:43:58 INFO - PROCESS | 15391 | [#0] dojo.html Cycles:165 Average:5458.78 Median:5660.83 stddev:587.94 (10.4%) stddev-sans-first:565.48 17:43:58 INFO - PROCESS | 15391 | Values: 3327.8 3358.8 3371.5 3386.9 3420.4 5454.3 5482.3 5505.5 5519.4 5568.3 5486.9 5533.2 5554.6 5555.4 5557.5 4966.5 5028.8 5071.1 5079.1 5085.2 4951.3 4998.3 5028.9 5091.5 5119.6 5024.9 5042.5 5092.0 5114.3 5116.5 5027.2 5039.9 5044.6 5059.5 5066.7 4750.5 4833.9 4843.8 4932.7 4940.9 5254.2 5268.7 5279.6 5288.6 5295.3 5774.5 5780.7 5781.4 5781.7 5783.7 5789.5 5797.7 5844.9 5860.6 5865.0 5472.3 5478.8 5485.8 5494.6 5499.2 5881.2 5925.3 5934.1 5939.5 5951.6 5674.3 5729.5 5776.5 5784.6 5810.3 5928.9 5976.3 5980.9 5985.5 5988.1 5661.7 5925.2 5951.8 5955.0 5959.3 5805.0 5833.3 5850.4 5866.5 5879.6 4504.4 4507.6 4520.1 4535.9 4557.6 3967.9 4012.2 4083.2 4085.3 4095.8 5462.2 5561.1 5583.1 5616.1 5676.7 5967.2 5979.4 6031.0 6034.7 6041.9 5405.5 5605.6 5643.3 5700.6 5702.3 5049.0 5062.7 5066.3 5082.4 5098.0 5956.7 5993.6 5994.4 6029.2 6038.3 5714.6 5909.5 5924.3 5937.4 5990.2 5964.6 5982.7 5983.2 5991.4 6000.1 5733.3 5739.8 5742.6 5746.1 5753.0 5854.0 5866.5 5875.7 5901.4 5971.4 5623.0 5634.3 5640.7 5654.0 5660.8 5641.4 5642.1 5644.7 5646.2 5668.9 5627.4 5669.6 5700.3 5741.5 5758.2 5794.2 5808.1 5818.9 5833.3 5834.4 5617.6 5704.6 5733.5 5749.5 5753.7 17:43:58 INFO - PROCESS | 15391 | 17:43:58 INFO - PROCESS | 15391 | [#1] ext.html Cycles:180 Average:58512.70 Median:38973.31 stddev:120774.89 (309.9%) stddev-sans-first:121035.61 17:43:58 INFO - PROCESS | 15391 | Values: 668.7 670.6 704.1 735.8 741.6 33075.2 39862.6 40244.0 40685.6 40772.6 44627.8 45161.5 45173.0 45367.8 45418.0 8541.8 8766.7 8778.8 8787.0 8789.6 8402.8 8477.3 8479.0 8520.1 8527.0 9015.6 9026.0 9030.1 9040.8 9094.5 8914.6 8983.0 8988.4 9004.2 9032.3 8870.2 8976.3 8980.2 8980.4 8984.5 38029.0 38057.6 38145.4 38283.7 38304.0 3688.7 3712.2 3872.4 4035.7 4292.8 29166.1 29170.6 29326.4 29396.9 30012.2 4018.4 4028.8 4032.4 4091.8 4268.0 308760.0 309164.0 309460.0 309511.5 310557.0 39035.8 39874.4 39941.2 40209.8 63445.4 38576.8 38794.6 38910.8 39057.6 39059.8 17111.4 17133.9 17258.6 17286.9 17292.1 14491.7 14588.0 14623.7 14643.2 14718.6 9371.6 9417.2 9421.3 9486.5 9507.0 3348.2 3642.5 3642.6 3651.5 3674.5 1106.6 1130.3 1136.6 1194.2 1219.3 32821.8 33307.8 33563.0 33617.3 33845.0 1185.9 1199.7 1233.1 1234.8 1255.0 17176.3 17344.6 17365.4 17439.4 17485.8 491041.0 497570.0 560078.0 603715.0 615804.0 57940.4 58481.4 58489.4 58496.4 58940.4 1530.6 1535.7 1550.3 1555.5 1565.3 32845.7 33340.5 33827.3 34478.8 34508.0 45349.0 46068.5 46306.8 46460.8 46556.3 452314.0 461136.0 461150.0 463044.0 465108.0 27881.4 47000.0 47501.5 47701.3 47748.8 38850.6 39106.2 39310.4 39524.0 51537.2 35996.3 36405.6 36600.5 36626.6 36917.0 36491.0 36644.8 37570.2 37719.8 39642.6 37317.8 37552.0 38141.2 39681.0 40431.0 31716.8 32100.8 32487.7 32577.5 32851.7 26051.7 26331.9 26675.0 26702.7 26738.7 17:43:58 INFO - PROCESS | 15391 | 17:43:58 INFO - PROCESS | 15391 | [#2] jquery.html Cycles:180 Average:28043.99 Median:2117.62 stddev:72721.63 (3434.1%) stddev-sans-first:72896.03 17:43:58 INFO - PROCESS | 15391 | Values: 412.9 419.2 421.6 427.4 432.6 18667.9 19155.0 19321.0 19323.4 20015.1 19249.1 19294.3 19377.5 19648.7 19674.0 5639.8 5706.8 5844.8 5925.0 5975.7 5779.0 5796.8 5810.3 5856.1 5862.3 5587.4 5773.2 5773.9 5784.5 5801.0 5680.1 5683.0 5685.7 5686.6 5718.3 4973.7 5064.6 5069.0 5098.5 5318.4 23156.1 23164.4 23225.8 23231.7 23517.0 2561.8 2562.5 2563.5 2620.8 2747.7 14821.7 14862.3 14928.6 15131.5 15204.4 2030.5 2048.6 2092.2 2143.1 2178.3 78149.0 79889.6 80092.0 80103.6 80215.0 10717.6 10767.9 11280.4 11339.9 11499.3 15746.6 15760.4 15825.1 15866.2 15873.7 8982.1 9099.7 9102.8 9108.1 9127.2 8926.2 8965.8 8982.1 9050.7 9079.1 6800.4 6917.7 6957.0 6981.7 6996.3 1937.9 2007.5 2046.3 2054.7 2059.2 1058.4 1105.7 1171.3 1174.9 1193.8 19711.3 19858.8 20017.4 20461.4 20720.6 1089.0 1089.9 1120.6 1169.4 1250.7 11389.1 11620.0 11650.0 11683.4 11784.5 375379.0 379914.0 386598.0 512160.0 513422.0 95598.5 100298.5 100722.5 100787.5 101511.5 1184.2 1184.3 1210.7 1227.3 1241.5 17440.6 17575.6 17735.6 17776.5 18230.7 39567.0 39610.4 40811.0 40891.6 41089.2 57644.1 59160.7 59447.1 59840.0 59922.7 8971.1 9065.1 9083.3 9143.4 9252.2 12686.2 13803.0 13827.9 13899.9 13960.6 11405.7 12339.6 12412.9 12421.1 12444.3 11716.4 11830.8 12116.8 12146.0 12152.8 12454.9 12456.1 12518.2 12590.0 12795.6 8697.4 8765.7 8884.6 8957.1 8957.1 9232.0 11174.7 11989.9 12114.1 12312.8 17:43:58 INFO - PROCESS | 15391 | 17:43:58 INFO - PROCESS | 15391 | [#3] mootools.html Cycles:180 Average:5729.70 Median:4877.87 stddev:3140.33 (64.4%) stddev-sans-first:3131.77 17:43:58 INFO - PROCESS | 15391 | Values: 1334.8 1458.5 1582.6 1860.0 1865.6 7688.6 8261.5 8358.0 8574.7 8651.2 8383.7 8432.9 8506.9 8549.2 8595.2 2428.5 2458.7 2464.6 2480.5 2482.9 2488.5 2516.8 2516.9 2518.5 2519.5 2446.7 2456.2 2468.4 2471.3 2474.8 2401.5 2414.0 2417.5 2441.6 2447.5 2396.6 2427.3 2441.0 2444.7 2502.9 8589.3 8612.8 8633.8 8657.7 8658.4 5334.4 5481.6 5483.3 5484.7 5520.8 3403.5 3406.6 3417.8 3528.3 3549.7 1033.2 1034.8 1039.9 1073.8 1091.8 11805.9 12078.3 12117.5 12118.1 12134.5 4734.0 4734.0 4748.1 4763.5 4835.3 10399.1 10437.7 10458.2 10462.3 10502.4 5363.4 5388.5 5393.9 5408.0 5414.6 4408.3 4868.4 4887.3 4985.4 4989.5 4087.7 4136.1 4139.6 4183.8 4185.3 1343.1 1349.2 1359.3 1365.6 1368.3 890.7 1000.7 1002.2 1034.0 1050.0 5807.9 5881.9 5932.6 6055.2 6109.5 955.5 1006.1 1031.3 1039.4 1054.1 4081.6 4102.9 4105.7 4328.8 4371.8 10389.3 10705.5 10801.1 10808.3 10863.5 10516.6 10588.9 10628.8 10690.6 10725.8 8263.8 8375.5 8385.8 8445.1 8480.7 5886.9 5979.7 6037.9 6058.5 6104.3 9483.6 9526.0 9664.7 9695.0 9751.4 9496.2 9772.8 9783.8 9958.9 10004.7 6572.5 6962.1 7156.6 7428.1 7509.1 7655.8 7685.5 7725.4 7743.8 7758.5 7041.4 7278.6 7280.0 7308.7 7418.1 7037.8 7105.6 7162.9 7215.7 7257.9 6700.7 6783.9 6869.5 6871.7 6903.2 5169.6 5199.6 5275.4 5287.0 5303.5 5225.8 5258.6 5259.0 5285.1 5313.1 17:43:58 INFO - PROCESS | 15391 | 17:43:58 INFO - PROCESS | 15391 | [#4] prototype.html Cycles:180 Average:5635.78 Median:6398.68 stddev:1720.26 (26.9%) stddev-sans-first:1678.56 17:43:58 INFO - PROCESS | 15391 | Values: 341.3 341.7 343.5 361.8 361.9 6252.5 6309.7 6316.7 6343.9 6345.3 6247.8 6254.8 6270.7 6310.8 6326.2 4632.7 4766.8 4807.8 4807.8 4824.5 4763.6 4787.8 4799.9 4804.3 4808.0 4730.3 4731.6 4742.4 4744.1 4751.7 4741.7 4757.0 4758.2 4758.7 4767.3 4138.4 4138.5 4141.5 4144.0 4149.2 5890.2 6119.9 6124.8 6131.1 6143.4 5587.0 5593.3 5601.5 5604.1 5620.6 6731.7 6743.6 6745.3 6746.2 6770.5 4639.2 4642.1 4643.2 4645.9 4649.6 6943.7 7015.8 7018.3 7019.8 7043.2 4593.8 4729.4 4755.6 4759.0 4786.7 4813.1 4836.2 4849.6 4851.3 4862.3 5579.1 5583.1 5593.8 5596.6 5608.2 6766.4 6767.5 6778.4 6788.4 6793.1 1670.3 1711.9 1712.2 1714.0 1714.5 1093.7 1114.0 1123.1 1132.8 1145.1 6443.4 6445.1 6445.6 6452.1 6462.9 6947.7 6953.1 6967.9 6984.5 6990.1 6353.9 6467.5 6472.3 6478.3 6487.7 3757.3 3782.0 3801.8 3815.1 3834.4 7243.3 7244.4 7249.0 7250.4 7255.3 7157.8 7162.7 7164.7 7165.3 7179.1 6988.4 7127.9 7135.9 7149.0 7211.7 7010.0 7024.9 7026.2 7035.1 7043.5 6887.9 6932.5 6936.8 6937.1 6945.4 7165.1 7211.1 7211.8 7220.1 7247.9 4572.7 4713.8 4714.7 4718.2 4718.7 6976.7 6981.0 7019.2 7021.1 7024.6 6776.7 6815.4 6817.9 6818.0 6818.0 6801.6 6802.0 6816.1 6828.2 6869.1 6535.2 6678.2 6680.8 6681.7 6697.9 6819.8 6831.4 6840.4 6853.7 6868.5 6688.5 6692.0 6692.3 6713.3 6715.7 17:43:58 INFO - PROCESS | 15391 | 17:43:58 INFO - PROCESS | 15391 | [#5] yui.html Cycles:180 Average:15560.56 Median:25302.76 stddev:17434.41 (68.9%) stddev-sans-first:17448.30 17:43:58 INFO - PROCESS | 15391 | Values: 846.4 847.3 885.8 948.4 954.1 13545.9 13643.0 13719.9 13740.5 13892.4 13652.2 16014.8 16202.8 16211.5 16268.5 774.7 920.3 929.7 930.2 930.3 907.2 913.2 920.2 920.4 925.7 978.3 978.5 978.8 979.5 980.2 958.5 960.2 963.7 965.8 966.6 701.2 709.4 710.4 711.2 712.5 14899.6 14916.3 14933.2 14999.3 15014.7 15390.1 15426.0 15456.3 15532.9 15562.2 11638.7 11893.8 11914.6 11996.9 12315.9 4051.5 4053.2 4162.4 4208.7 4271.4 52137.5 52543.0 52886.5 59066.7 60373.0 12457.8 12503.6 12558.4 12690.7 12692.8 22190.9 22230.2 22233.4 22263.2 22303.4 9061.7 9168.7 9244.2 9317.6 9381.5 4923.6 4977.8 5014.0 5021.2 5115.9 3709.0 3756.8 3765.0 3765.8 3771.8 611.6 662.9 676.7 678.5 680.4 707.5 773.0 775.1 793.0 800.7 9449.0 10023.7 10229.1 10484.8 10521.9 737.6 782.1 796.6 819.0 820.9 4593.0 4641.3 4724.7 4765.1 4859.0 63903.0 64050.0 64491.4 64696.0 65169.3 50668.7 51164.7 51836.0 52041.2 52349.2 50892.0 51061.7 51390.2 51796.5 52263.0 9758.8 9815.8 9871.8 9909.9 10061.4 37024.8 38756.2 38933.6 41298.6 41765.4 46012.5 47354.5 48091.8 48455.8 48712.3 12443.7 12475.6 12497.1 12589.9 12754.5 13057.9 13184.3 13561.3 13589.6 15216.1 12766.4 12894.1 13197.3 13424.6 13717.9 12529.3 13219.9 13222.9 13296.5 13827.9 12845.8 13250.5 13334.6 13423.4 13891.4 10768.6 11150.3 11246.8 11285.5 11551.2 11455.8 11482.3 11670.5 11740.8 11870.4 17:43:58 INFO - PROCESS | 15391 | -------- Summary: end -------- 17:43:58 INFO - PROCESS | 15391 | 17:43:59 INFO - TEST-INFO | 15391: exit 0 17:43:59 INFO - TEST-OK | dromaeo_css | took 1108138ms 17:43:59 INFO - TEST-START | kraken 17:43:59 INFO - operating with platform_type : linux_ 17:43:59 INFO - Initialising browser for kraken test... 17:43:59 INFO - TEST-INFO | started process 15636 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6bkc6k/profile http://localhost:35443/getInfo.html) 17:44:02 INFO - PROCESS | 15636 | 17:44:02 INFO - PROCESS | 15636 | (process:15713): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:44:03 INFO - PROCESS | 15636 | __metrics Screen width/height:1600/1200 17:44:03 INFO - PROCESS | 15636 | colorDepth:24 17:44:03 INFO - PROCESS | 15636 | Browser inner width/height: 1024/697 17:44:03 INFO - PROCESS | 15636 | __metrics 17:44:04 ERROR - PROCESS | 15636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 17:44:04 INFO - TEST-INFO | 15636: exit 0 17:44:04 INFO - Browser initialized. 17:44:04 INFO - Running cycle 1/1 for kraken test... 17:44:04 INFO - TEST-INFO | started process 15764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6bkc6k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:06 INFO - PROCESS | 15764 | 17:44:06 INFO - PROCESS | 15764 | (process:15833): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:44:16 INFO - PROCESS | 15764 | RSS: Main: 150863872 17:44:16 INFO - PROCESS | 15764 | 17:44:19 INFO - PROCESS | 15764 | Cycle 1(1): loaded http://localhost:35443/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35443/tests/kraken/driver.html?testName=audio-beat-detection) 17:44:20 INFO - PROCESS | 15764 | RSS: Main: 156639232 17:44:20 INFO - PROCESS | 15764 | 17:44:22 INFO - PROCESS | 15764 | Cycle 1(1): loaded http://localhost:35443/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35443/tests/kraken/driver.html?testName=audio-dft) 17:44:23 INFO - PROCESS | 15764 | RSS: Main: 156045312 17:44:23 INFO - PROCESS | 15764 | 17:44:26 INFO - PROCESS | 15764 | Cycle 1(1): loaded http://localhost:35443/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35443/tests/kraken/driver.html?testName=audio-fft) 17:44:26 INFO - PROCESS | 15764 | RSS: Main: 156393472 17:44:26 INFO - PROCESS | 15764 | 17:44:28 INFO - PROCESS | 15764 | Cycle 1(1): loaded http://localhost:35443/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35443/tests/kraken/driver.html?testName=audio-oscillator) 17:44:29 INFO - PROCESS | 15764 | RSS: Main: 156262400 17:44:29 INFO - PROCESS | 15764 | 17:44:31 INFO - PROCESS | 15764 | Cycle 1(1): loaded http://localhost:35443/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35443/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:44:32 INFO - PROCESS | 15764 | RSS: Main: 156110848 17:44:32 INFO - PROCESS | 15764 | 17:44:35 INFO - PROCESS | 15764 | Cycle 1(1): loaded http://localhost:35443/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35443/tests/kraken/driver.html?testName=imaging-darkroom) 17:44:35 INFO - PROCESS | 15764 | RSS: Main: 156565504 17:44:35 INFO - PROCESS | 15764 | 17:44:39 INFO - PROCESS | 15764 | Cycle 1(1): loaded http://localhost:35443/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35443/tests/kraken/driver.html?testName=imaging-desaturate) 17:44:39 INFO - PROCESS | 15764 | RSS: Main: 156647424 17:44:39 INFO - PROCESS | 15764 | 17:44:42 INFO - PROCESS | 15764 | Cycle 1(1): loaded http://localhost:35443/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35443/tests/kraken/driver.html?testName=json-parse-financial) 17:44:43 INFO - PROCESS | 15764 | RSS: Main: 156516352 17:44:43 INFO - PROCESS | 15764 | 17:44:44 INFO - PROCESS | 15764 | Cycle 1(1): loaded http://localhost:35443/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35443/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:44:45 INFO - PROCESS | 15764 | RSS: Main: 156057600 17:44:45 INFO - PROCESS | 15764 | 17:44:47 INFO - PROCESS | 15764 | Cycle 1(1): loaded http://localhost:35443/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35443/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:44:47 INFO - PROCESS | 15764 | RSS: Main: 156090368 17:44:47 INFO - PROCESS | 15764 | 17:44:49 INFO - PROCESS | 15764 | Cycle 1(1): loaded http://localhost:35443/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35443/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:44:50 INFO - PROCESS | 15764 | RSS: Main: 156659712 17:44:50 INFO - PROCESS | 15764 | 17:44:52 INFO - PROCESS | 15764 | Cycle 1(1): loaded http://localhost:35443/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35443/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:44:53 INFO - PROCESS | 15764 | RSS: Main: 156917760 17:44:53 INFO - PROCESS | 15764 | 17:44:56 INFO - PROCESS | 15764 | Cycle 1(1): loaded http://localhost:35443/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35443/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:44:56 INFO - PROCESS | 15764 | RSS: Main: 156680192 17:44:56 INFO - PROCESS | 15764 | 17:44:58 INFO - PROCESS | 15764 | Cycle 1(1): loaded http://localhost:35443/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35443/tests/kraken/driver.html?testName=ai-astar) 17:44:58 INFO - PROCESS | 15764 | RSS: Main: 158056448 17:44:58 INFO - PROCESS | 15764 | 17:44:58 INFO - PROCESS | 15764 | __start_tp_report 17:44:58 INFO - PROCESS | 15764 | _x_x_mozilla_page_load 17:44:58 INFO - PROCESS | 15764 | _x_x_mozilla_page_load_details 17:44:58 INFO - PROCESS | 15764 | |i|pagename|runs| 17:44:58 INFO - PROCESS | 15764 | |0;ai-astar;108;111;104;110;111;111;103;113;111;111 17:44:58 INFO - PROCESS | 15764 | |1;audio-beat-detection;157;124;158;168;128;164;149;134;176;127 17:44:58 INFO - PROCESS | 15764 | |2;audio-dft;162;160;162;164;163;161;164;161;162;160 17:44:58 INFO - PROCESS | 15764 | |3;audio-fft;77;74;75;165;76;74;77;77;158;76 17:44:58 INFO - PROCESS | 15764 | |4;audio-oscillator;92;92;158;93;92;93;146;93;93;147 17:44:58 INFO - PROCESS | 15764 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 17:44:58 INFO - PROCESS | 15764 | |6;imaging-darkroom;148;147;147;147;148;148;149;147;148;148 17:44:58 INFO - PROCESS | 15764 | |7;imaging-desaturate;95;95;95;96;95;95;95;94;95;95 17:44:58 INFO - PROCESS | 15764 | |8;json-parse-financial;57;64;59;55;58;56;56;78;55;55 17:44:58 INFO - PROCESS | 15764 | |9;json-stringify-tinderbox;57;58;58;58;59;58;59;58;59;58 17:44:58 INFO - PROCESS | 15764 | |10;stanford-crypto-aes;71;74;73;73;74;74;73;74;73;72 17:44:58 INFO - PROCESS | 15764 | |11;stanford-crypto-ccm;119;113;113;112;114;121;123;112;126;130 17:44:58 INFO - PROCESS | 15764 | |12;stanford-crypto-pbkdf2;166;163;168;164;162;162;163;162;165;166 17:44:58 INFO - PROCESS | 15764 | |13;stanford-crypto-sha256-iterative;67;67;67;66;66;66;67;66;68;66 17:44:58 INFO - PROCESS | 15764 | __end_tp_report 17:44:58 INFO - PROCESS | 15764 | __start_cc_report 17:44:58 INFO - PROCESS | 15764 | _x_x_mozilla_cycle_collect,847 17:44:58 INFO - PROCESS | 15764 | __end_cc_report 17:44:58 INFO - PROCESS | 15764 | __startTimestamp1469148298675__endTimestamp 17:44:58 INFO - PROCESS | 15764 | 17:44:58 INFO - PROCESS | 15764 | ------- Summary: start ------- 17:44:58 INFO - PROCESS | 15764 | Number of tests: 14 17:44:58 INFO - PROCESS | 15764 | 17:44:58 INFO - PROCESS | 15764 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:3.30 (3.0%) stddev-sans-first:3.47 17:44:58 INFO - PROCESS | 15764 | Values: 108.0 111.0 104.0 110.0 111.0 111.0 103.0 113.0 111.0 111.0 17:44:58 INFO - PROCESS | 15764 | 17:44:58 INFO - PROCESS | 15764 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:157.50 stddev:18.95 (12.0%) stddev-sans-first:19.85 17:44:58 INFO - PROCESS | 15764 | Values: 157.0 124.0 158.0 168.0 128.0 164.0 149.0 134.0 176.0 127.0 17:44:58 INFO - PROCESS | 15764 | 17:44:58 INFO - PROCESS | 15764 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.45 (0.9%) stddev-sans-first:1.54 17:44:58 INFO - PROCESS | 15764 | Values: 162.0 160.0 162.0 164.0 163.0 161.0 164.0 161.0 162.0 160.0 17:44:58 INFO - PROCESS | 15764 | 17:44:58 INFO - PROCESS | 15764 | [#3] audio-fft Cycles:10 Average:92.90 Median:76.00 stddev:36.21 (47.6%) stddev-sans-first:37.95 17:44:58 INFO - PROCESS | 15764 | Values: 77.0 74.0 75.0 165.0 76.0 74.0 77.0 77.0 158.0 76.0 17:44:58 INFO - PROCESS | 15764 | 17:44:58 INFO - PROCESS | 15764 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:92.50 stddev:28.08 (30.4%) stddev-sans-first:29.03 17:44:58 INFO - PROCESS | 15764 | Values: 92.0 92.0 158.0 93.0 92.0 93.0 146.0 93.0 93.0 147.0 17:44:58 INFO - PROCESS | 15764 | 17:44:58 INFO - PROCESS | 15764 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:44:58 INFO - PROCESS | 15764 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 17:44:58 INFO - PROCESS | 15764 | 17:44:58 INFO - PROCESS | 15764 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 17:44:58 INFO - PROCESS | 15764 | Values: 148.0 147.0 147.0 147.0 148.0 148.0 149.0 147.0 148.0 148.0 17:44:58 INFO - PROCESS | 15764 | 17:44:58 INFO - PROCESS | 15764 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 17:44:58 INFO - PROCESS | 15764 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 17:44:58 INFO - PROCESS | 15764 | 17:44:58 INFO - PROCESS | 15764 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:57.50 stddev:7.12 (12.4%) stddev-sans-first:7.50 17:44:58 INFO - PROCESS | 15764 | Values: 57.0 64.0 59.0 55.0 58.0 56.0 56.0 78.0 55.0 55.0 17:44:58 INFO - PROCESS | 15764 | 17:44:58 INFO - PROCESS | 15764 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 17:44:58 INFO - PROCESS | 15764 | Values: 57.0 58.0 58.0 58.0 59.0 58.0 59.0 58.0 59.0 58.0 17:44:58 INFO - PROCESS | 15764 | 17:44:58 INFO - PROCESS | 15764 | [#10] stanford-crypto-aes Cycles:10 Average:73.10 Median:73.50 stddev:0.99 (1.4%) stddev-sans-first:0.71 17:44:58 INFO - PROCESS | 15764 | Values: 71.0 74.0 73.0 73.0 74.0 74.0 73.0 74.0 73.0 72.0 17:44:58 INFO - PROCESS | 15764 | 17:44:58 INFO - PROCESS | 15764 | [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:120.00 stddev:6.50 (5.4%) stddev-sans-first:6.89 17:44:58 INFO - PROCESS | 15764 | Values: 119.0 113.0 113.0 112.0 114.0 121.0 123.0 112.0 126.0 130.0 17:44:58 INFO - PROCESS | 15764 | 17:44:58 INFO - PROCESS | 15764 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:164.50 stddev:2.08 (1.3%) stddev-sans-first:2.09 17:44:58 INFO - PROCESS | 15764 | Values: 166.0 163.0 168.0 164.0 162.0 162.0 163.0 162.0 165.0 166.0 17:44:58 INFO - PROCESS | 15764 | 17:44:58 INFO - PROCESS | 15764 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 17:44:58 INFO - PROCESS | 15764 | Values: 67.0 67.0 67.0 66.0 66.0 66.0 67.0 66.0 68.0 66.0 17:44:58 INFO - PROCESS | 15764 | -------- Summary: end -------- 17:44:58 INFO - PROCESS | 15764 | 17:44:59 INFO - TEST-INFO | 15764: exit 0 17:44:59 INFO - TEST-OK | kraken | took 59985ms 17:44:59 INFO - SUITE-END | took 1168s 17:44:59 INFO - Completed test suite (00:19:28) 17:44:59 INFO - javascript benchmark 17:44:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3327.783694059886, 3358.7648864579487, 3371.477420999746, 3386.932261354773, 3420.350133474639, 5454.263674403955, 5482.342118945722, 5505.504504594585, 5519.392866784656, 5568.276124103861, 5486.890262194764, 5533.170024496328, 5554.555635549156, 5555.388907220203, 5557.499825015748, 4966.50334966504, 5028.84913452597, 5071.061853557086, 5079.085764562377, 5085.1863701807715, 4951.257311403282, 4998.250262460624, 5028.874278143039, 5091.541761241488, 5119.590432765389, 5024.874378140539, 5042.520960508746, 5092.032513822381, 5114.258432527281, 5116.539511443969, 5027.2207807789855, 5039.899202015976, 5044.571211447032, 5059.519345662156, 5066.721330326831, 4750.548697873696, 4833.854984350475, 4843.75781210938, 4932.7421507515355, 4940.925886111711, 5254.238135470336, 5268.736563171864, 5279.604029697788, 5288.576913846883, 5295.285136506561, 5774.4802967732685, 5780.653160810322, 5781.421857814227, 5781.739821708034, 5783.681897495636, 5789.536837053026, 5797.710114494301, 5844.9415505845245, 5860.619059761102, 5865.0, 5472.288602481692, 5478.753456094445, 5485.807996720136, 5494.642848214893, 5499.202615620753, 5881.235439392852, 5925.259342582177, 5934.13954976526, 5939.46544810969, 5951.613145145551, 5674.290713660793, 5729.541636669056, 5776.537876969833, 5784.566157538202, 5810.331811841692, 5928.911066334009, 5976.282846058501, 5980.940190598125, 5985.491233245223, 5988.101784732325, 5661.745221465044, 5925.170476133345, 5951.791687290924, 5954.970225148933, 5959.344472108065, 5805.0, 5833.270841144857, 5850.414958504116, 5866.472017518358, 5879.617824841372, 4504.414426124583, 4507.5943165115295, 4520.073384956077, 4535.886602834889, 4557.635389168859, 3967.920641587152, 4012.217617564547, 4083.2445997489967, 4085.346344584852, 4095.8361665533043, 5462.235287059815, 5561.082421400504, 5583.05088135018, 5616.1014237721765, 5676.744546495418, 5967.16459695643, 5979.431953964367, 6031.035034394564, 6034.668093254913, 6041.909371359433, 5405.486478784509, 5605.5515558755205, 5643.294588176478, 5700.600957932905, 5702.258706368146, 5049.015441988777, 5062.7468626568525, 5066.290719299301, 5082.364704411949, 5098.0, 5956.702164891738, 5993.640381577119, 5994.430529099728, 6029.216201893726, 6038.30559485656, 5714.5999780015, 5909.468147866713, 5924.259467566554, 5937.376575459514, 5990.161377407079, 5964.612300200473, 5982.7307771149535, 5983.222181116601, 5991.400859914148, 6000.0999850022845, 5733.3406658234835, 5739.770409183586, 5742.569307301886, 5746.13807928814, 5752.964466396089, 5854.004819180835, 5866.472017518444, 5875.735591898289, 5901.380355062828, 5971.4327138921735, 5623.0, 5634.295713035871, 5640.689762063126, 5654.0, 5660.830175094754, 5641.435856414326, 5642.069058605448, 5644.745986430703, 5646.209530665792, 5668.943310567007, 5627.380988091389, 5669.6314739541795, 5700.315962084576, 5741.45456181662, 5758.1650660654805, 5794.159846822272, 5808.099744539603, 5818.94181058201, 5833.270841144857, 5834.416558344132, 5617.578681598815, 5704.600677952503, 5733.541316694571, 5749.540036796962, 5753.71231438418], "value": 5421.985067432867, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.6723505482315, 670.6143967218849, 704.1057856522214, 735.8417940142872, 741.5958302725013, 33075.17312067199, 39862.60137398629, 40243.99999999993, 40685.59314406855, 40772.59227407725, 44627.77686111573, 45161.54838451614, 45173.0, 45367.77316113423, 45418.0, 8541.829163416744, 8766.736997890073, 8778.780530486756, 8787.0, 8789.560521973908, 8402.831943361129, 8477.279431248351, 8479.0, 8520.105388934166, 8526.957365213166, 9015.639374425014, 9025.95487022564, 9030.142136497056, 9040.819183616324, 9094.54527273637, 8914.55427228636, 8983.0, 8988.415752976069, 9004.189622933902, 9032.27741780656, 8870.246029087535, 8976.281897448189, 8980.236679882219, 8980.416272942239, 8984.460932344015, 38029.0, 38057.619423805685, 38145.42781858274, 38283.660071897626, 38304.0, 3688.686461650763, 3712.238991006864, 3872.3610604250266, 4035.656969157625, 4292.849750258726, 29166.125016249545, 29170.562441563394, 29326.41347173066, 29396.853015734785, 30012.24969375761, 4018.3570628699267, 4028.7784171870535, 4032.3951407288846, 4091.7954102294766, 4268.018355778188, 308760.0, 309164.0, 309460.0, 309511.4524427386, 310557.0, 39035.80482097571, 39874.40188397176, 39941.2011759769, 40209.79895100506, 63445.36554634487, 38576.8071159648, 38794.6120538791, 38910.80544597316, 39057.60942390597, 39059.80470097631, 17111.401100961408, 17133.914330428517, 17258.568535786453, 17286.913565432344, 17292.135393230288, 14491.710165796836, 14588.0, 14623.707525849424, 14643.194624295766, 14718.55844324672, 9371.578278977462, 9417.246620270362, 9421.293402994803, 9486.525673716287, 9507.049295070576, 3348.22544051653, 3642.453631955228, 3642.635736426389, 3651.4887915691825, 3674.52231209941, 1106.551846502168, 1130.2540323386525, 1136.5851464215666, 1194.199886076331, 1219.3293688471306, 32821.835890820395, 33307.833460833026, 33563.0, 33617.327653446795, 33845.0, 1185.9288442693294, 1199.6700907250577, 1233.1244816180613, 1234.7777400068073, 1254.9811752823714, 17176.31294748196, 17344.566385840204, 17365.392211272545, 17439.389621363192, 17485.823712971967, 491041.0, 497570.0, 560078.0, 603715.0, 615804.0, 57940.42059579435, 58481.415185847596, 58489.4151058484, 58496.415035849095, 58940.41059589349, 1530.5943924859698, 1535.7158925598576, 1550.3023639362107, 1555.4866893924977, 1565.3190861975077, 32845.67154328426, 33340.499892501146, 33827.3234535303, 34478.82760586181, 34508.0, 45349.0, 46068.53931460642, 46306.76846615745, 46460.7676961613, 46556.30165547452, 452314.0, 461136.0, 461150.0, 463044.0, 465108.0, 27881.442371152058, 47000.0, 47501.52498475109, 47701.28448073351, 47748.761256193495, 38850.6114938847, 39106.217875641756, 39310.41034384544, 39524.0, 51537.22694159516, 35996.280074397844, 36405.63594364023, 36600.45099323565, 36626.63373366339, 36917.0, 36491.0, 36644.81677591702, 37570.24859502849, 37719.81140094282, 39642.60357396389, 37317.81341093277, 37552.0, 38141.23717525578, 39681.0, 40431.0, 31716.841415792773, 32100.83949580237, 32487.67512324941, 32577.511337329484, 32851.67148328486, 26051.73948260493, 26331.868340658173, 26675.0, 26702.664866756197, 26738.732612673622], "value": 19112.74311213594, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.9380592911063, 419.21397379912645, 421.58473903205356, 427.4165763732505, 432.62793997162436, 18667.906660466695, 19155.0, 19321.0, 19323.420297391065, 20015.099320530575, 19249.13378897953, 19294.324698635515, 19377.51556211092, 19648.70526942097, 19674.0, 5639.802606908759, 5706.800261990821, 5844.766209351621, 5924.992751232279, 5975.731092100844, 5779.0, 5796.768129274845, 5810.3027636683655, 5856.063029915214, 5862.267216597926, 5587.38538760736, 5773.162891380747, 5773.913391299134, 5784.479396854283, 5801.0, 5680.11958146488, 5683.0, 5685.687287199203, 5686.630369026021, 5718.313802343704, 4973.701577905337, 5064.569511591482, 5068.974655126701, 5098.515641014098, 5318.388385335697, 23156.073757049697, 23164.420889477897, 23225.7677423227, 23231.651525227135, 23517.0, 2561.782248508879, 2562.4618830045524, 2563.5257477366745, 2620.751028652275, 2747.6840163381066, 14821.703565928621, 14862.331195096138, 14928.62678433037, 15131.470398536108, 15204.391824327015, 2030.472077259923, 2048.6107639548586, 2092.1735914313763, 2143.0570548958563, 2178.281167214831, 78149.0, 79889.60055199744, 80092.0, 80103.5994820028, 80215.0, 10717.624883129209, 10767.946160269305, 11280.435978201222, 11339.94330028361, 11499.310041397375, 15746.606334841492, 15760.448384306723, 15825.129617871127, 15866.20668966547, 15873.682526349408, 8982.101789820965, 9099.727008189764, 9102.772430689154, 9108.089191080839, 9127.22418594427, 8926.241269492166, 8965.775855603662, 8982.146696063863, 9050.683226087056, 9079.137481939206, 6800.387965083166, 6917.7232910684015, 6957.0, 6981.720731170798, 6996.300369962963, 1937.9418617441218, 2007.498125468633, 2046.2940285601444, 2054.7431571053617, 2059.227789578908, 1058.4125810175426, 1105.7456784939347, 1171.3437695430773, 1174.9060075193963, 1193.8209268609605, 19711.310104146287, 19858.801411985984, 20017.399478015683, 20461.386158415273, 20720.58558828845, 1089.003561741014, 1089.9182561307935, 1120.6413947536873, 1169.3743847041792, 1250.7060840702427, 11389.145814063979, 11620.0, 11650.0, 11683.415829208505, 11784.469698863571, 375379.0, 379914.0, 386598.0, 512160.0, 513422.0, 95598.52200739091, 100298.498507507, 100722.49638751759, 100787.49606251922, 101511.49244253732, 1184.218415845555, 1184.3190165654783, 1210.673118258083, 1227.3495047624774, 1241.4736012215278, 17440.563985900455, 17575.648487030445, 17735.556611084827, 17776.466705998842, 18230.72653910219, 39567.0, 39610.40584391179, 40811.0, 40891.59108408997, 41089.178216434906, 57644.13533796913, 59160.70419648047, 59447.1082933765, 59840.0, 59922.70038649779, 8971.102889711237, 9065.138811812867, 9083.318751093562, 9143.405678630868, 9252.21356184705, 12686.175398599062, 13802.982809910884, 13827.86172138306, 13899.861001390262, 13960.58118256454, 11405.657830265105, 12339.62981110568, 12412.875871241533, 12421.130520863453, 12444.253344799341, 11716.355600441717, 11830.763384732429, 12116.75766484683, 12146.0, 12152.817707734568, 12454.875451245734, 12456.128071035304, 12518.186317889673, 12590.0, 12795.61613151607, 8697.391182617155, 8765.737027889174, 8884.60019299146, 8957.059508751487, 8957.10428957099, 9232.03063678331, 11174.66476005721, 11989.880101199225, 12114.091443141975, 12312.815307770212], "value": 9768.933878353273, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.8398192216935, 1458.540559723687, 1582.580616136724, 1860.0234876689728, 1865.5709186887016, 7688.615569221544, 8261.50430974142, 8357.958210208948, 8574.69988550401, 8651.17813807688, 8383.748487545368, 8432.91567084329, 8506.91493085069, 8549.230569248783, 8595.18345757152, 2428.4900170964074, 2458.7172475165407, 2464.605663093905, 2480.4790993891306, 2482.925512234636, 2488.5396201702742, 2516.811239157061, 2516.937076573082, 2518.49630073985, 2519.546481633305, 2446.730859605451, 2456.1771806444863, 2468.4322605800676, 2471.3203868936007, 2474.8391354561986, 2401.483681008574, 2414.034386245507, 2417.504411595619, 2441.584930561809, 2447.486027934136, 2396.604560247557, 2427.3446169534304, 2440.9755902440925, 2444.7433019532873, 2502.9374265643323, 8589.269912057483, 8612.827743445096, 8633.827323453495, 8657.740267791976, 8658.393912426132, 5334.4398838122215, 5481.643693159932, 5483.287172667568, 5484.698341591211, 5520.779168833242, 3403.50649155871, 3406.5912090549045, 3417.7607567470286, 3528.259065596228, 3549.716022718176, 1033.204432586904, 1034.7516596016976, 1039.8804137524205, 1073.785242951405, 1091.8198497247945, 11805.940970295094, 12078.27530348182, 12117.515299388015, 12118.091143164298, 12134.5146194153, 4734.0, 4734.0, 4748.097861406391, 4763.499832517605, 4835.274708793709, 10399.064084232305, 10437.739056523647, 10458.215633827493, 10462.319949203278, 10502.422366769748, 5363.356397232279, 5388.488093631099, 5393.946060539422, 5407.972960135174, 5414.620976531605, 4408.294672852392, 4868.391451068616, 4887.34020907173, 4985.351904252424, 4989.501049894981, 4087.6525495332635, 4136.090060186754, 4139.577153928363, 4183.790810459525, 4185.267578173807, 1343.1068339554088, 1349.197227649547, 1359.3067535556936, 1365.6312795545148, 1368.2679766324968, 890.6826247303587, 1000.694788089625, 1002.1631937332409, 1033.9793204135874, 1050.0287234308234, 5807.912881306784, 5881.941180588225, 5932.555058370639, 6055.2128223331565, 6109.480694140959, 955.4553904274496, 1006.1196453103535, 1031.2626472072504, 1039.3971496531992, 1054.0776820282254, 4081.571434999342, 4102.876913692594, 4105.651019663303, 4328.848490302824, 4371.803268852909, 10389.272750907365, 10705.518251678694, 10801.081908037904, 10808.29746066519, 10863.51114199863, 10516.631917882838, 10588.947055264829, 10628.787424251472, 10690.62582809598, 10725.78548429027, 8263.793405164919, 8375.497470151811, 8385.790355241046, 8445.071042185355, 8480.703175388831, 5886.94113058864, 5979.701014949148, 6037.909431358621, 6058.485028772604, 6104.298005729221, 9483.620655173716, 9525.952370238381, 9664.71005869825, 9695.0, 9751.3661611995, 9496.19282361007, 9772.755681108029, 9783.75540611462, 9958.900410995797, 10004.699859004242, 6572.474202063728, 6962.1297337832775, 7156.570605763671, 7428.1086269647985, 7509.061367329084, 7655.846883062419, 7685.538867667958, 7725.381969442544, 7743.845123097394, 7758.456908016385, 7041.436685065285, 7278.599677017603, 7279.963600181965, 7308.671109799965, 7418.072740907387, 7037.768390531534, 7105.609191494517, 7162.89255661155, 7215.67529461165, 7257.927420725937, 6700.731970721312, 6783.898241526283, 6869.519133660796, 6871.725130994704, 6903.1716194057035, 5169.612279079009, 5199.55803756685, 5275.419703832498, 5287.0, 5303.496167864047, 5225.843224703265, 5258.553022993088, 5259.0, 5285.075111855487, 5313.149896016619], "value": 4660.590869518465, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.3359870630675, 341.7300332737138, 343.48820257815856, 361.79739345966243, 361.9113317237277, 6252.531060170494, 6309.68451577421, 6316.715747791349, 6343.873122537552, 6345.270293916201, 6247.750089996406, 6254.781082662108, 6270.686465676721, 6310.810675679725, 6326.177596912395, 4632.745199014044, 4766.7616619169075, 4807.759612019402, 4807.807687692488, 4824.469308376076, 4763.642726795487, 4787.760611969405, 4799.856004319876, 4804.303376010476, 4808.038392321532, 4730.337752714623, 4731.550502702238, 4742.359781429514, 4744.14605371033, 4751.714897106167, 4741.691790033654, 4757.048590281957, 4758.214894542396, 4758.714477131349, 4767.261074533453, 4138.358554424069, 4138.461999940018, 4141.544430112685, 4144.026153853842, 4149.211649786531, 5890.175375447441, 6119.87760244797, 6124.785632502885, 6131.110988906628, 6143.416375444371, 5587.0, 5593.272874526327, 5601.495865372136, 5604.131359639263, 5620.57845661577, 6731.697073631698, 6743.59538427691, 6745.325467453215, 6746.190457145125, 6770.52606317558, 4639.188142075123, 4642.094791515656, 4643.16423043852, 4645.907081858378, 4649.628029757645, 6943.652817359162, 7015.82460438488, 7018.263082376328, 7019.82450438738, 7043.225245223021, 4593.793279302439, 4729.43246810385, 4755.5719985201495, 4759.0, 4786.664933454695, 4813.061453016699, 4836.153673107263, 4849.612031037508, 4851.345068415719, 4862.270659401118, 5579.13523403873, 5583.134614134816, 5593.8321850344555, 5596.636218645775, 5608.242887210256, 6766.391024807693, 6767.492438067165, 6778.356056174655, 6788.389044985876, 6793.082933803873, 1670.298474640654, 1711.8972861628342, 1712.2294967264781, 1714.0315721617496, 1714.4685147604282, 1093.7375029992904, 1114.0474893965704, 1123.07346439188, 1132.824412216108, 1145.1297014269214, 6443.420092191632, 6445.065465507475, 6445.645489498029, 6452.12896258999, 6462.870742585216, 6947.652617369111, 6953.130858642669, 6967.93032069683, 6984.511084224056, 6990.126234220723, 6353.936460635335, 6467.51493637979, 6472.255690595642, 6478.255000674889, 6487.7080531376205, 3757.3236817373136, 3782.0, 3801.7718936863325, 3815.065308999313, 3834.405667121601, 7243.348098671145, 7244.420446364278, 7248.96375518119, 7250.4199664026755, 7255.274472552703, 7157.821054473576, 7162.677679504435, 7164.749233776793, 7165.319294666998, 7179.1026121734785, 6988.405985491188, 7127.89308160378, 7135.892961605477, 7148.964255178795, 7211.747588834471, 7009.96495017542, 7024.929750702428, 7026.19198792125, 7035.050268213726, 7043.471739619446, 6887.896681549881, 6932.549384290005, 6936.79189624312, 6937.063496427918, 6945.374916257561, 7165.068541089625, 7211.134663840373, 7211.783646490614, 7220.097487814023, 7247.927520724726, 4572.702774319791, 4713.835015774432, 4714.740689262124, 4718.221493453541, 4718.7168769873915, 6976.6860491277, 6980.965095174492, 7019.192792828686, 7021.087258656342, 7024.613646249505, 6776.728930842711, 6815.386615204656, 6817.93182068173, 6818.0, 6818.045473633596, 6801.591904485746, 6802.0, 6816.079829222991, 6828.248892621907, 6869.107016087876, 6535.248446428722, 6678.198616166092, 6680.83297917556, 6681.665916704243, 6697.899531506934, 6819.829504262433, 6831.351021652935, 6840.418564421881, 6853.691583878638, 6868.484863635147, 6688.531802773954, 6691.966540167268, 6692.263850976291, 6713.295104014203, 6715.664216789043], "value": 5073.186755909393, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [846.4413487098516, 847.28404498199, 885.8095509465463, 948.3551185194067, 954.1460392948311, 13545.864541354584, 13643.0, 13719.862801371983, 13740.519081832126, 13892.374843132058, 13652.24912629805, 16014.83985160148, 16202.756958645601, 16211.513654590352, 16268.51194464165, 774.6591499740097, 920.3097676742426, 929.6792606550729, 930.2139691960316, 930.2836815651943, 907.1880666803207, 913.1690161952624, 920.1764420843341, 920.4155361345527, 925.6852670092168, 978.295627148452, 978.5107446276861, 978.8287049766298, 979.5053497983508, 980.1766516126453, 958.5111593087506, 960.2270172511126, 963.657901444984, 965.8213230552335, 966.5698764049965, 701.2076353720263, 709.435998381283, 710.3926143147586, 711.1643818513227, 712.5012491256141, 14899.553013409615, 14916.2541872907, 14933.178675172861, 14999.250037498081, 15014.699706005818, 15390.07659540431, 15426.0, 15456.30446629893, 15532.92233538825, 15562.22188890551, 11638.6508404748, 11893.762124757457, 11914.642560723192, 11996.940015299955, 12315.876841231562, 4051.493563304587, 4053.2298863215897, 4162.354835000579, 4208.684348673831, 4271.423357846682, 52137.47862521402, 52543.0, 52886.47113528892, 59066.70466647639, 60373.0, 12457.813132803016, 12503.624891253095, 12558.442268230678, 12690.66747991466, 12692.80960785589, 22190.88904555499, 22230.221942231943, 22233.444163895707, 22263.220787272367, 22303.442413939458, 9061.728148155566, 9168.724938251864, 9244.168024877794, 9317.580708868118, 9381.5309234538, 4923.630727695438, 4977.8257760978195, 5013.974930125399, 5021.246812978083, 5115.897682046412, 3708.962910370916, 3756.7745935243975, 3764.981175094107, 3765.7740535567955, 3771.7548359356556, 611.6207951070364, 662.8508585568305, 676.736072931557, 678.4979115454528, 680.4080450008524, 707.5294928872243, 772.9536227826236, 775.135723668106, 793.0285400384483, 800.6677228950037, 9448.95275523618, 10023.69928902134, 10229.130523905551, 10484.842727359095, 10521.947390263153, 737.5648367463223, 782.1201148707704, 796.5618909599697, 818.9918100818916, 820.9179082091863, 4592.977035114803, 4641.303804429363, 4724.716517008922, 4765.0946320199055, 4858.95141048585, 63903.0, 64050.0, 64491.35508644854, 64696.0, 65169.34830651728, 50668.746656266485, 51164.74417627888, 51836.0, 52041.21938170931, 52349.2147617786, 50892.0, 51061.744691276304, 51390.22914656283, 51796.48203517992, 52263.0, 9758.80482390334, 9815.754606134904, 9871.802563948537, 9909.851352229867, 10061.434334245014, 37024.81487592545, 38756.2248755029, 38933.610663894135, 41298.58701412947, 41765.37351939663, 46012.53987460083, 47354.52645473501, 48091.75954120207, 48455.757721212576, 48712.26931595958, 12443.688907777378, 12475.625731228078, 12497.125201235825, 12589.87410125887, 12754.48982040708, 13057.869421306046, 13184.274864882524, 13561.321933903462, 13589.592312230649, 15216.08703477795, 12766.361681915681, 12894.097413181362, 13197.340132993504, 13424.597262082154, 13717.862821371658, 12529.310887901252, 13219.933900330438, 13222.933885330513, 13296.468141274241, 13827.861721382658, 12845.807312890502, 13250.536231231861, 13334.599962001155, 13423.395947182205, 13891.374888129856, 10768.569257229623, 11150.330980141218, 11246.831297530707, 11285.548578057114, 11551.249168804, 11455.828162577734, 11482.311061336346, 11670.474828632561, 11740.765184696087, 11870.406479676154], "value": 7275.497798296521, "unit": "score"}], "name": "dromaeo_css", "value": 7472.943268850117, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 104.0, 110.0, 111.0, 111.0, 103.0, 113.0, 111.0, 111.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 124.0, 158.0, 168.0, 128.0, 164.0, 149.0, 134.0, 176.0, 127.0], "value": 148.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 164.0, 163.0, 161.0, 164.0, 161.0, 162.0, 160.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 75.0, 165.0, 76.0, 74.0, 77.0, 77.0, 158.0, 76.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 158.0, 93.0, 92.0, 93.0, 146.0, 93.0, 93.0, 147.0], "value": 109.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.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": [148.0, 147.0, 147.0, 147.0, 148.0, 148.0, 149.0, 147.0, 148.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 64.0, 59.0, 55.0, 58.0, 56.0, 56.0, 78.0, 55.0, 55.0], "value": 59.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 59.0, 58.0, 59.0, 58.0, 59.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 73.0, 73.0, 74.0, 74.0, 73.0, 74.0, 73.0, 72.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 113.0, 113.0, 112.0, 114.0, 121.0, 123.0, 112.0, 126.0, 130.0], "value": 118.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 168.0, 164.0, 162.0, 162.0, 163.0, 162.0, 165.0, 166.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0, 68.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1521.7999999999997, "alertThreshold": 2.0}]} 17:44:59 INFO - Return code: 0 17:44:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:44:59 ERROR - # TBPL SUCCESS # 17:44:59 INFO - Running post-action listener: _resource_record_post_action 17:44:59 INFO - Running post-run listener: _resource_record_post_run 17:45:01 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 28672; Write bytes: 465768448; Read time: 20; Write time: 306136 17:45:01 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 241897472; Read time: 0; Write time: 221488 17:45:01 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 4096; Write bytes: 223555584; Read time: 12; Write time: 84620 17:45:01 INFO - Running post-run listener: _upload_blobber_files 17:45:01 INFO - Blob upload gear active. 17:45:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:45:01 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 17:45:01 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'] 17:45:01 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 17:45:01 INFO - (blobuploader) - INFO - Open directory for files ... 17:45:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:45:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:45:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:02 INFO - (blobuploader) - INFO - Done attempting. 17:45:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:45:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:45:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:03 INFO - (blobuploader) - INFO - Done attempting. 17:45:03 INFO - (blobuploader) - INFO - Iteration through files over. 17:45:03 INFO - Return code: 0 17:45:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:45:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:45:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a467f79a37dc1561d12b7304f564a8c1bb0f4b323df6916c0fcec512103b0926ed853fc0311c5c1cc2fad27f8dec4ac901ce9bc4d6bd414c26c8c3e0eb8c66da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/86c85db9af37fc80d69fded03e68e1266c486febdd9cf1172846d35cd9a20af9fb308bcebe0f787e3886b0acc228039e520f7c64d1c8a972cb6baef37f598f26"} 17:45:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:45:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:45:03 INFO - Contents: 17:45:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a467f79a37dc1561d12b7304f564a8c1bb0f4b323df6916c0fcec512103b0926ed853fc0311c5c1cc2fad27f8dec4ac901ce9bc4d6bd414c26c8c3e0eb8c66da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/86c85db9af37fc80d69fded03e68e1266c486febdd9cf1172846d35cd9a20af9fb308bcebe0f787e3886b0acc228039e520f7c64d1c8a972cb6baef37f598f26"} 17:45:03 INFO - Running post-run listener: copy_logs_to_upload_dir 17:45:03 INFO - Copying logs to upload dir... 17:45:03 INFO - mkdir: /builds/slave/test/build/upload/logs 17:45:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1221.454616 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 21 secs) (at 2016-07-21 17:45:03.427067) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 17:45:03.432799) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287 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/a467f79a37dc1561d12b7304f564a8c1bb0f4b323df6916c0fcec512103b0926ed853fc0311c5c1cc2fad27f8dec4ac901ce9bc4d6bd414c26c8c3e0eb8c66da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/86c85db9af37fc80d69fded03e68e1266c486febdd9cf1172846d35cd9a20af9fb308bcebe0f787e3886b0acc228039e520f7c64d1c8a972cb6baef37f598f26"} build_url:https://queue.taskcluster.net/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/WpzQ1zaISNSV8Vgy3NqOMg/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/a467f79a37dc1561d12b7304f564a8c1bb0f4b323df6916c0fcec512103b0926ed853fc0311c5c1cc2fad27f8dec4ac901ce9bc4d6bd414c26c8c3e0eb8c66da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/86c85db9af37fc80d69fded03e68e1266c486febdd9cf1172846d35cd9a20af9fb308bcebe0f787e3886b0acc228039e520f7c64d1c8a972cb6baef37f598f26"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 17:45:03.458090) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 17:45:03.458427) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1469147080.61136-712636287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 17:45:03.541127) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 17:45:03.541455) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 17:45:03.541752) ========= ========= Total master_lag: 0.16 =========