builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1465430777.21 results: success (0) buildid: 20160608141429 builduid: 8dc57391f080448fabb9bf7ba70ae880 revision: ec56d351f9a0677f9ef34a6f6cefbf7addf86145 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 17:06:17.208671) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 17:06:17.209175) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 17:06:17.209500) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 17:06:17.224417) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:06:17.224729) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 17:06:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.1M=0s 2016-06-08 17:06:17 (51.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131315 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:06:17.373572) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:06:17.374180) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016374 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:06:17.425806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:06:17.426541) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ec56d351f9a0677f9ef34a6f6cefbf7addf86145 --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 ec56d351f9a0677f9ef34a6f6cefbf7addf86145 --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=9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 17:06:17,427 truncating revision to first 12 chars 2016-06-08 17:06:17,427 Setting DEBUG logging. 2016-06-08 17:06:17,427 attempt 1/10 2016-06-08 17:06:17,428 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ec56d351f9a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 17:06:17,732 unpacking tar archive at: mozilla-beta-ec56d351f9a0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632953 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:06:18.078463) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 17:06:18.079597) ========= script_repo_revision: ec56d351f9a0677f9ef34a6f6cefbf7addf86145 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 17:06:18.080531) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 17:06:18.081151) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 17:06:18.092415) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-08 17:06:18.092739) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:06:18 INFO - MultiFileLogger online at 20160608 17:06:18 in /builds/slave/test 17:06:18 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:06:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:06:18 INFO - {'append_to_log': False, 17:06:18 INFO - 'base_work_dir': '/builds/slave/test', 17:06:18 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:06:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:06:18 INFO - 'branch': 'Mozilla-Beta', 17:06:18 INFO - 'buildbot_json_path': 'buildprops.json', 17:06:18 INFO - 'config_files': ('talos/linux_config.py',), 17:06:18 INFO - 'default_actions': ('clobber', 17:06:18 INFO - 'read-buildbot-config', 17:06:18 INFO - 'download-and-extract', 17:06:18 INFO - 'populate-webroot', 17:06:18 INFO - 'create-virtualenv', 17:06:18 INFO - 'install', 17:06:18 INFO - 'run-tests'), 17:06:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:06:18 INFO - 'download_minidump_stackwalk': True, 17:06:18 INFO - 'download_symbols': 'ondemand', 17:06:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:06:18 INFO - 'tooltool.py': '/tools/tooltool.py', 17:06:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:06:18 INFO - '/tools/misc-python/virtualenv.py')}, 17:06:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:06:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:06:18 INFO - 'installer_path': 'installer.exe', 17:06:18 INFO - 'log_level': 'info', 17:06:18 INFO - 'log_name': 'talos', 17:06:18 INFO - 'log_to_console': True, 17:06:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:06:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:06:18 INFO - 'opt_config_files': (), 17:06:18 INFO - 'pip_index': False, 17:06:18 INFO - 'sps_profile': False, 17:06:18 INFO - 'sps_profile_interval': 0, 17:06:18 INFO - 'suite': 'dromaeojs-e10s', 17:06:18 INFO - 'system_bits': '32', 17:06:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:06:18 INFO - 'title': 'talos-linux64-ix-013', 17:06:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:06:18 INFO - 'use_talos_json': True, 17:06:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:06:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:06:18 INFO - 'work_dir': 'build'} 17:06:18 INFO - ##### 17:06:18 INFO - ##### Running clobber step. 17:06:18 INFO - ##### 17:06:18 INFO - Running pre-action listener: _resource_record_pre_action 17:06:18 INFO - Running main action method: clobber 17:06:18 INFO - rmtree: /builds/slave/test/build 17:06:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:06:18 INFO - Running post-action listener: _resource_record_post_action 17:06:18 INFO - ##### 17:06:18 INFO - ##### Running read-buildbot-config step. 17:06:18 INFO - ##### 17:06:18 INFO - Running pre-action listener: _resource_record_pre_action 17:06:18 INFO - Running main action method: read_buildbot_config 17:06:18 INFO - Using buildbot properties: 17:06:18 INFO - { 17:06:18 INFO - "project": "", 17:06:18 INFO - "product": "firefox", 17:06:18 INFO - "script_repo_revision": "production", 17:06:18 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 17:06:18 INFO - "repository": "", 17:06:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 17:06:18 INFO - "buildid": "20160608141429", 17:06:18 INFO - "pgo_build": "True", 17:06:18 INFO - "basedir": "/builds/slave/test", 17:06:18 INFO - "buildnumber": 33, 17:06:18 INFO - "slavename": "talos-linux64-ix-013", 17:06:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:06:18 INFO - "platform": "ubuntu64_hw", 17:06:18 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 17:06:18 INFO - "branch": "mozilla-beta", 17:06:18 INFO - "repo_path": "releases/mozilla-beta", 17:06:18 INFO - "revision": "ec56d351f9a0677f9ef34a6f6cefbf7addf86145", 17:06:18 INFO - "stage_platform": "linux64-pgo", 17:06:18 INFO - "builduid": "8dc57391f080448fabb9bf7ba70ae880", 17:06:18 INFO - "slavebuilddir": "test" 17:06:18 INFO - } 17:06:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 17:06:18 INFO - Running post-action listener: _resource_record_post_action 17:06:18 INFO - ##### 17:06:18 INFO - ##### Running download-and-extract step. 17:06:18 INFO - ##### 17:06:18 INFO - Running pre-action listener: _resource_record_pre_action 17:06:18 INFO - Running main action method: download_and_extract 17:06:18 INFO - mkdir: /builds/slave/test/build/tests 17:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:18 INFO - https://queue.taskcluster.net/v1/task/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:06:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 17:06:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 17:06:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/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:06:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/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:06:19 INFO - Downloaded 1327 bytes. 17:06:19 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 17:06:19 INFO - Using the following test package requirements: 17:06:19 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 17:06:19 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:06:19 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 17:06:19 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:06:19 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 17:06:19 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:06:19 INFO - u'jsshell-linux-x86_64.zip'], 17:06:19 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:06:19 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 17:06:19 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 17:06:19 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:06:19 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 17:06:19 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:06:19 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 17:06:19 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:06:19 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 17:06:19 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 17:06:19 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 17:06:19 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:19 INFO - https://queue.taskcluster.net/v1/task/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:06:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:06:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/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:06:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/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:06:20 INFO - Downloaded 24176653 bytes. 17:06:20 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:06:20 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:06:21 INFO - Return code: 0 17:06:21 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:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:21 INFO - https://queue.taskcluster.net/v1/task/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:06:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 17:06:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/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:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/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:06:22 INFO - Downloaded 24176653 bytes. 17:06:22 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:06:22 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:06:24 INFO - Return code: 0 17:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:24 INFO - https://queue.taskcluster.net/v1/task/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:06:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 17:06:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 17:06:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/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:06:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/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:06:25 INFO - Downloaded 10840145 bytes. 17:06:25 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:06:25 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:06:25 INFO - Return code: 0 17:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:25 INFO - https://queue.taskcluster.net/v1/task/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:06:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:06:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:06:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/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:06:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsVbPEdOQTW9IpxP7bkUow/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:06:26 INFO - Downloaded 56010486 bytes. 17:06:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:06:26 INFO - mkdir: /builds/slave/test/properties 17:06:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:06:26 INFO - Writing to file /builds/slave/test/properties/build_url 17:06:26 INFO - Contents: 17:06:26 INFO - build_url:https://queue.taskcluster.net/v1/task/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 17:06:27 INFO - Running post-action listener: _resource_record_post_action 17:06:27 INFO - Running post-action listener: set_extra_try_arguments 17:06:27 INFO - ##### 17:06:27 INFO - ##### Running populate-webroot step. 17:06:27 INFO - ##### 17:06:27 INFO - Running pre-action listener: _resource_record_pre_action 17:06:27 INFO - Running main action method: populate_webroot 17:06:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:06:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:06:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:06:27 INFO - '--tppagecycles', 17:06:27 INFO - '7'], 17:06:27 INFO - 'tests': ['tsvgm']}}, 17:06:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:06:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:06:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:06:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:06:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:06:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:06:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:27 INFO - 'talos_options': ['--disable-e10s'], 17:06:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:27 INFO - 'talos_options': ['--disable-e10s'], 17:06:27 INFO - 'tests': ['damp', 'tps']}, 17:06:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:27 INFO - 'tests': ['damp', 'tps']}, 17:06:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:06:27 INFO - 'tests': ['dromaeo_dom']}, 17:06:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:06:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:06:27 INFO - 'tests': ['a11yr', 17:06:27 INFO - 'ts_paint', 17:06:27 INFO - 'tpaint', 17:06:27 INFO - 'sessionrestore', 17:06:27 INFO - 'sessionrestore_no_auto_restore', 17:06:27 INFO - 'tabpaint']}, 17:06:27 INFO - 'other-e10s': {'tests': ['a11yr', 17:06:27 INFO - 'ts_paint', 17:06:27 INFO - 'tpaint', 17:06:27 INFO - 'sessionrestore', 17:06:27 INFO - 'sessionrestore_no_auto_restore', 17:06:27 INFO - 'tabpaint']}, 17:06:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:06:27 INFO - 'ts_paint', 17:06:27 INFO - 'tpaint', 17:06:27 INFO - 'sessionrestore', 17:06:27 INFO - 'sessionrestore_no_auto_restore', 17:06:27 INFO - 'tabpaint']}, 17:06:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:06:27 INFO - 'ts_paint', 17:06:27 INFO - 'tpaint', 17:06:27 INFO - 'sessionrestore', 17:06:27 INFO - 'sessionrestore_no_auto_restore', 17:06:27 INFO - 'tabpaint']}, 17:06:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:06:27 INFO - 'tests': ['a11yr', 17:06:27 INFO - 'ts_paint', 17:06:27 INFO - 'tpaint', 17:06:27 INFO - 'sessionrestore', 17:06:27 INFO - 'sessionrestore_no_auto_restore', 17:06:27 INFO - 'tabpaint']}, 17:06:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:06:27 INFO - 'tests': ['a11yr', 17:06:27 INFO - 'ts_paint', 17:06:27 INFO - 'tpaint', 17:06:27 INFO - 'sessionrestore', 17:06:27 INFO - 'sessionrestore_no_auto_restore', 17:06:27 INFO - 'tabpaint']}, 17:06:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:06:27 INFO - 'tests': ['tsvgx', 17:06:27 INFO - 'tsvgr_opacity', 17:06:27 INFO - 'tart', 17:06:27 INFO - 'tscrollx', 17:06:27 INFO - 'cart']}, 17:06:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:06:27 INFO - 'tsvgr_opacity', 17:06:27 INFO - 'tart', 17:06:27 INFO - 'tscrollx', 17:06:27 INFO - 'cart']}, 17:06:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:27 INFO - 'talos_options': ['--disable-e10s'], 17:06:27 INFO - 'tests': ['tp5o']}, 17:06:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:27 INFO - 'tests': ['tp5o']}, 17:06:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:27 INFO - 'talos_options': ['--disable-e10s', 17:06:27 INFO - '--xperf_path', 17:06:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:27 INFO - 'tests': ['tp5n']}, 17:06:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:27 INFO - 'talos_options': ['--xperf_path', 17:06:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:27 INFO - 'tests': ['tp5n']}}, 17:06:27 INFO - 'talos.zip': {'path': '', 17:06:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:06:27 INFO - Running post-action listener: _resource_record_post_action 17:06:27 INFO - ##### 17:06:27 INFO - ##### Running create-virtualenv step. 17:06:27 INFO - ##### 17:06:27 INFO - Running pre-action listener: _resource_record_pre_action 17:06:27 INFO - Running main action method: create_virtualenv 17:06:27 INFO - Creating virtualenv /builds/slave/test/build/venv 17:06:27 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:06:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:06:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:06:27 INFO - Using real prefix '/usr' 17:06:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:06:28 INFO - Installing distribute.............................................................................................................................................................................................done. 17:06:30 INFO - Installing pip.................done. 17:06:30 INFO - Return code: 0 17:06:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:06: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:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5aa5d4ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2091410>, '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 0x2092310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20927a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668', '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:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:06:30 INFO - Using env: {'DISPLAY': ':0', 17:06:30 INFO - 'HOME': '/home/cltbld', 17:06:30 INFO - 'LANG': 'en_US.UTF-8', 17:06:30 INFO - 'LANGUAGE': 'en_US:en', 17:06:30 INFO - 'LOGNAME': 'cltbld', 17:06:30 INFO - 'MAIL': '/var/mail/cltbld', 17:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:30 INFO - 'MOZ_NO_REMOTE': '1', 17:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:30 INFO - 'NO_EM_RESTART': '1', 17:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:30 INFO - 'PWD': '/builds/slave/test', 17:06:30 INFO - 'SHELL': '/bin/bash', 17:06:30 INFO - 'SHLVL': '1', 17:06:30 INFO - 'TERM': 'linux', 17:06:30 INFO - 'TMOUT': '86400', 17:06:30 INFO - 'USER': 'cltbld', 17:06:30 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668', 17:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:30 INFO - '_': '/tools/buildbot/bin/python'} 17:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:30 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:06:30 INFO - Cleaning up... 17:06:30 INFO - Return code: 0 17:06:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:06: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:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5aa5d4ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2091410>, '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 0x2092310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20927a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668', '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:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:06:30 INFO - Using env: {'DISPLAY': ':0', 17:06:30 INFO - 'HOME': '/home/cltbld', 17:06:30 INFO - 'LANG': 'en_US.UTF-8', 17:06:30 INFO - 'LANGUAGE': 'en_US:en', 17:06:30 INFO - 'LOGNAME': 'cltbld', 17:06:30 INFO - 'MAIL': '/var/mail/cltbld', 17:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:30 INFO - 'MOZ_NO_REMOTE': '1', 17:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:30 INFO - 'NO_EM_RESTART': '1', 17:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:30 INFO - 'PWD': '/builds/slave/test', 17:06:30 INFO - 'SHELL': '/bin/bash', 17:06:30 INFO - 'SHLVL': '1', 17:06:30 INFO - 'TERM': 'linux', 17:06:30 INFO - 'TMOUT': '86400', 17:06:30 INFO - 'USER': 'cltbld', 17:06:30 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668', 17:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:30 INFO - '_': '/tools/buildbot/bin/python'} 17:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:31 INFO - Downloading/unpacking psutil>=0.7.1 17:06:31 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:06:31 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:06:31 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:06:31 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:06:31 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:06:31 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:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:06:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:33 INFO - Installing collected packages: psutil 17:06:33 INFO - Running setup.py install for psutil 17:06:33 INFO - building 'psutil._psutil_linux' extension 17:06:33 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:06:33 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:06:33 INFO - building 'psutil._psutil_posix' extension 17:06:33 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:06:34 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:06:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:34 INFO - Successfully installed psutil 17:06:34 INFO - Cleaning up... 17:06:35 INFO - Return code: 0 17:06:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:06:35 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:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:35 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:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:35 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 0x7f5aa5d4ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2091410>, '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 0x2092310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20927a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668', '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:06:35 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:06:35 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:06:35 INFO - Using env: {'DISPLAY': ':0', 17:06:35 INFO - 'HOME': '/home/cltbld', 17:06:35 INFO - 'LANG': 'en_US.UTF-8', 17:06:35 INFO - 'LANGUAGE': 'en_US:en', 17:06:35 INFO - 'LOGNAME': 'cltbld', 17:06:35 INFO - 'MAIL': '/var/mail/cltbld', 17:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:35 INFO - 'MOZ_NO_REMOTE': '1', 17:06:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:35 INFO - 'NO_EM_RESTART': '1', 17:06:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:35 INFO - 'PWD': '/builds/slave/test', 17:06:35 INFO - 'SHELL': '/bin/bash', 17:06:35 INFO - 'SHLVL': '1', 17:06:35 INFO - 'TERM': 'linux', 17:06:35 INFO - 'TMOUT': '86400', 17:06:35 INFO - 'USER': 'cltbld', 17:06:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668', 17:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:35 INFO - '_': '/tools/buildbot/bin/python'} 17:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:06:35 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:06:35 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:06:35 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:06:35 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:06:35 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:06:35 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:06:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:06:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:06:37 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:06:37 INFO - Installing collected packages: mozsystemmonitor 17:06:37 INFO - Running setup.py install for mozsystemmonitor 17:06:37 INFO - Successfully installed mozsystemmonitor 17:06:37 INFO - Cleaning up... 17:06:37 INFO - Return code: 0 17:06:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5aa5d4ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2091410>, '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 0x2092310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20927a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668', '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:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:06:37 INFO - Using env: {'DISPLAY': ':0', 17:06:37 INFO - 'HOME': '/home/cltbld', 17:06:37 INFO - 'LANG': 'en_US.UTF-8', 17:06:37 INFO - 'LANGUAGE': 'en_US:en', 17:06:37 INFO - 'LOGNAME': 'cltbld', 17:06:37 INFO - 'MAIL': '/var/mail/cltbld', 17:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:37 INFO - 'MOZ_NO_REMOTE': '1', 17:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:37 INFO - 'NO_EM_RESTART': '1', 17:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:37 INFO - 'PWD': '/builds/slave/test', 17:06:37 INFO - 'SHELL': '/bin/bash', 17:06:37 INFO - 'SHLVL': '1', 17:06:37 INFO - 'TERM': 'linux', 17:06:37 INFO - 'TMOUT': '86400', 17:06:37 INFO - 'USER': 'cltbld', 17:06:37 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668', 17:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:37 INFO - '_': '/tools/buildbot/bin/python'} 17:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:38 INFO - Downloading/unpacking blobuploader==1.2.4 17:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:40 INFO - Downloading blobuploader-1.2.4.tar.gz 17:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:06:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:06:40 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:06:40 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:06:40 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:06:40 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:06:40 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:06:40 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:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:06:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:06:40 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:06:40 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:06:40 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:06:40 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:06:40 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:06:40 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:06:40 INFO - Downloading docopt-0.6.1.tar.gz 17:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:06:40 INFO - Installing collected packages: blobuploader, requests, docopt 17:06:40 INFO - Running setup.py install for blobuploader 17:06:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:06:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:06:41 INFO - Running setup.py install for requests 17:06:41 INFO - Running setup.py install for docopt 17:06:41 INFO - Successfully installed blobuploader requests docopt 17:06:41 INFO - Cleaning up... 17:06:41 INFO - Return code: 0 17:06:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:41 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 0x7f5aa5d4ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2091410>, '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 0x2092310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20927a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668', '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:06:41 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:06:41 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:06:41 INFO - Using env: {'DISPLAY': ':0', 17:06:41 INFO - 'HOME': '/home/cltbld', 17:06:41 INFO - 'LANG': 'en_US.UTF-8', 17:06:41 INFO - 'LANGUAGE': 'en_US:en', 17:06:41 INFO - 'LOGNAME': 'cltbld', 17:06:41 INFO - 'MAIL': '/var/mail/cltbld', 17:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:41 INFO - 'MOZ_NO_REMOTE': '1', 17:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:41 INFO - 'NO_EM_RESTART': '1', 17:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:41 INFO - 'PWD': '/builds/slave/test', 17:06:41 INFO - 'SHELL': '/bin/bash', 17:06:41 INFO - 'SHLVL': '1', 17:06:41 INFO - 'TERM': 'linux', 17:06:41 INFO - 'TMOUT': '86400', 17:06:41 INFO - 'USER': 'cltbld', 17:06:41 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668', 17:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:41 INFO - '_': '/tools/buildbot/bin/python'} 17:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:41 INFO - Running setup.py (path:/tmp/pip-66hmoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:41 INFO - Running setup.py (path:/tmp/pip-DajoWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:41 INFO - Running setup.py (path:/tmp/pip-oLuNdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:41 INFO - Running setup.py (path:/tmp/pip-OdhDhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:42 INFO - Running setup.py (path:/tmp/pip-ZNYrUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:42 INFO - Running setup.py (path:/tmp/pip-2SkCrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:42 INFO - Running setup.py (path:/tmp/pip-EAuJ03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:42 INFO - Running setup.py (path:/tmp/pip-JPSGq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:42 INFO - Running setup.py (path:/tmp/pip-GvZk9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:42 INFO - Running setup.py (path:/tmp/pip-jn_2KR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:42 INFO - Running setup.py (path:/tmp/pip-swnT81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:42 INFO - Running setup.py (path:/tmp/pip-ZzLqZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:42 INFO - Running setup.py (path:/tmp/pip-4I2YbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:42 INFO - Running setup.py (path:/tmp/pip-UxNLP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:42 INFO - Running setup.py (path:/tmp/pip-VCRvOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:42 INFO - Running setup.py (path:/tmp/pip-ARv9hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:42 INFO - Running setup.py (path:/tmp/pip-EjuZqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:06:42 INFO - Running setup.py install for manifestparser 17:06:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:06:43 INFO - Running setup.py install for mozcrash 17:06:43 INFO - Running setup.py install for mozdebug 17:06:43 INFO - Running setup.py install for mozdevice 17:06:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:06:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:06:43 INFO - Running setup.py install for mozfile 17:06:43 INFO - Running setup.py install for mozhttpd 17:06:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:06:43 INFO - Running setup.py install for mozinfo 17:06:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:06:43 INFO - Running setup.py install for mozInstall 17:06:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:06:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:06:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:06:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:06:43 INFO - Running setup.py install for mozleak 17:06:43 INFO - Running setup.py install for mozlog 17:06:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:06:43 INFO - Running setup.py install for moznetwork 17:06:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:06:44 INFO - Running setup.py install for mozprocess 17:06:44 INFO - Running setup.py install for mozprofile 17:06:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:06:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:06:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:06:44 INFO - Running setup.py install for mozrunner 17:06:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:06:44 INFO - Running setup.py install for mozscreenshot 17:06:44 INFO - Running setup.py install for moztest 17:06:44 INFO - Running setup.py install for mozversion 17:06:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:06:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:06:44 INFO - Cleaning up... 17:06:44 INFO - Return code: 0 17:06:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:44 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 0x7f5aa5d4ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2091410>, '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 0x2092310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20927a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668', '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:06:44 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:06:44 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:06:44 INFO - Using env: {'DISPLAY': ':0', 17:06:44 INFO - 'HOME': '/home/cltbld', 17:06:44 INFO - 'LANG': 'en_US.UTF-8', 17:06:44 INFO - 'LANGUAGE': 'en_US:en', 17:06:44 INFO - 'LOGNAME': 'cltbld', 17:06:44 INFO - 'MAIL': '/var/mail/cltbld', 17:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:44 INFO - 'MOZ_NO_REMOTE': '1', 17:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:44 INFO - 'NO_EM_RESTART': '1', 17:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:44 INFO - 'PWD': '/builds/slave/test', 17:06:44 INFO - 'SHELL': '/bin/bash', 17:06:44 INFO - 'SHLVL': '1', 17:06:44 INFO - 'TERM': 'linux', 17:06:44 INFO - 'TMOUT': '86400', 17:06:44 INFO - 'USER': 'cltbld', 17:06:44 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668', 17:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:44 INFO - '_': '/tools/buildbot/bin/python'} 17:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:44 INFO - Running setup.py (path:/tmp/pip-mFqkYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:45 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:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:45 INFO - Running setup.py (path:/tmp/pip-0Ot6W6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:45 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:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:45 INFO - Running setup.py (path:/tmp/pip-4wOOB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:45 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:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:45 INFO - Running setup.py (path:/tmp/pip-EQq6oB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:45 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:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:45 INFO - Running setup.py (path:/tmp/pip-hRb_0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:45 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:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:45 INFO - Running setup.py (path:/tmp/pip-_eArto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:45 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:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:45 INFO - Running setup.py (path:/tmp/pip-c0hmRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:45 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:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:45 INFO - Running setup.py (path:/tmp/pip-MWCMnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06:45 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:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:45 INFO - Running setup.py (path:/tmp/pip-U7EBUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06:45 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:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:45 INFO - Running setup.py (path:/tmp/pip-bKSRvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06:45 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:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:45 INFO - Running setup.py (path:/tmp/pip-3XpXDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06:45 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:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:45 INFO - Running setup.py (path:/tmp/pip-MbNgUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06:45 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:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:45 INFO - Running setup.py (path:/tmp/pip-0H5ada-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06:45 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:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:45 INFO - Running setup.py (path:/tmp/pip-LGEKxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06:45 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:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:45 INFO - Running setup.py (path:/tmp/pip-YAMF8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:46 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:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:46 INFO - Running setup.py (path:/tmp/pip-rKhsHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:46 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:06:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:46 INFO - Running setup.py (path:/tmp/pip-BQ3j2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:46 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:06:46 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:06:46 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:06:46 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:06:46 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:06:46 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:06:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:06:46 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:06:46 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:06:46 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:06:46 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:06:46 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:06:46 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:06:48 INFO - Downloading blessings-1.6.tar.gz 17:06:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:06:48 INFO - Installing collected packages: blessings 17:06:48 INFO - Running setup.py install for blessings 17:06:48 INFO - Successfully installed blessings 17:06:48 INFO - Cleaning up... 17:06:48 INFO - Return code: 0 17:06:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:06:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:06:48 INFO - Reading from file tmpfile_stdout 17:06:48 INFO - Current package versions: 17:06:48 INFO - argparse == 1.2.1 17:06:48 INFO - blessings == 1.6 17:06:48 INFO - blobuploader == 1.2.4 17:06:48 INFO - docopt == 0.6.1 17:06:48 INFO - manifestparser == 1.1 17:06:48 INFO - mozInstall == 1.12 17:06:48 INFO - mozcrash == 0.17 17:06:48 INFO - mozdebug == 0.1 17:06:48 INFO - mozdevice == 0.48 17:06:48 INFO - mozfile == 1.2 17:06:48 INFO - mozhttpd == 0.7 17:06:48 INFO - mozinfo == 0.9 17:06:48 INFO - mozleak == 0.1 17:06:48 INFO - mozlog == 3.1 17:06:48 INFO - moznetwork == 0.27 17:06:48 INFO - mozprocess == 0.22 17:06:48 INFO - mozprofile == 0.28 17:06:48 INFO - mozrunner == 6.11 17:06:48 INFO - mozscreenshot == 0.1 17:06:48 INFO - mozsystemmonitor == 0.0 17:06:48 INFO - moztest == 0.7 17:06:48 INFO - mozversion == 1.4 17:06:48 INFO - psutil == 3.1.1 17:06:48 INFO - requests == 1.2.3 17:06:48 INFO - wsgiref == 0.1.2 17:06:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06: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:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:48 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 0x7f5aa5d4ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2091410>, '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 0x2092310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20927a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668', '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:06:48 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:06:48 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:06:48 INFO - Using env: {'DISPLAY': ':0', 17:06:48 INFO - 'HOME': '/home/cltbld', 17:06:48 INFO - 'LANG': 'en_US.UTF-8', 17:06:48 INFO - 'LANGUAGE': 'en_US:en', 17:06:48 INFO - 'LOGNAME': 'cltbld', 17:06:48 INFO - 'MAIL': '/var/mail/cltbld', 17:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:48 INFO - 'MOZ_NO_REMOTE': '1', 17:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:48 INFO - 'NO_EM_RESTART': '1', 17:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:48 INFO - 'PWD': '/builds/slave/test', 17:06:48 INFO - 'SHELL': '/bin/bash', 17:06:48 INFO - 'SHLVL': '1', 17:06:48 INFO - 'TERM': 'linux', 17:06:48 INFO - 'TMOUT': '86400', 17:06:48 INFO - 'USER': 'cltbld', 17:06:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668', 17:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:48 INFO - '_': '/tools/buildbot/bin/python'} 17:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:48 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:06:48 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:06:48 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:06:48 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:06:48 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:06:48 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:06:48 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:06:48 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:06:48 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:06:48 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:06:48 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:06:48 INFO - Cleaning up... 17:06:48 INFO - Return code: 0 17:06:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:06: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:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:48 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 0x7f5aa5d4ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2091410>, '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 0x2092310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20927a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668', '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:06:48 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:06:48 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:06:48 INFO - Using env: {'DISPLAY': ':0', 17:06:48 INFO - 'HOME': '/home/cltbld', 17:06:48 INFO - 'LANG': 'en_US.UTF-8', 17:06:48 INFO - 'LANGUAGE': 'en_US:en', 17:06:48 INFO - 'LOGNAME': 'cltbld', 17:06:48 INFO - 'MAIL': '/var/mail/cltbld', 17:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:48 INFO - 'MOZ_NO_REMOTE': '1', 17:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:48 INFO - 'NO_EM_RESTART': '1', 17:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:48 INFO - 'PWD': '/builds/slave/test', 17:06:48 INFO - 'SHELL': '/bin/bash', 17:06:48 INFO - 'SHLVL': '1', 17:06:48 INFO - 'TERM': 'linux', 17:06:48 INFO - 'TMOUT': '86400', 17:06:48 INFO - 'USER': 'cltbld', 17:06:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668', 17:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:48 INFO - '_': '/tools/buildbot/bin/python'} 17:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:48 INFO - Downloading/unpacking jsonschema 17:06:48 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:06:48 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:06:48 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:06:48 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:06:48 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:06:48 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:06:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:06:50 INFO - Downloading/unpacking functools32 (from jsonschema) 17:06:50 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:06:50 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:06:50 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:06:50 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:06:50 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:06:50 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:06:51 INFO - Downloading functools32-3.2.3-2.tar.gz 17:06:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:06:51 INFO - warning: no files found matching '*.txt' 17:06:51 INFO - no previously-included directories found matching 'build' 17:06:51 INFO - no previously-included directories found matching 'dist' 17:06:51 INFO - no previously-included directories found matching '.git*' 17:06:51 INFO - Installing collected packages: jsonschema, functools32 17:06:51 INFO - Running setup.py install for functools32 17:06:51 INFO - warning: no files found matching '*.txt' 17:06:51 INFO - no previously-included directories found matching 'build' 17:06:51 INFO - no previously-included directories found matching 'dist' 17:06:51 INFO - no previously-included directories found matching '.git*' 17:06:51 INFO - Successfully installed jsonschema functools32 17:06:51 INFO - Cleaning up... 17:06:51 INFO - Return code: 0 17:06:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:06:51 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:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:51 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:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:51 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 0x7f5aa5d4ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20025a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2091410>, '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 0x2092310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20927a0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668', '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:06:51 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:06:51 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:06:51 INFO - Using env: {'DISPLAY': ':0', 17:06:51 INFO - 'HOME': '/home/cltbld', 17:06:51 INFO - 'LANG': 'en_US.UTF-8', 17:06:51 INFO - 'LANGUAGE': 'en_US:en', 17:06:51 INFO - 'LOGNAME': 'cltbld', 17:06:51 INFO - 'MAIL': '/var/mail/cltbld', 17:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:51 INFO - 'MOZ_NO_REMOTE': '1', 17:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:51 INFO - 'NO_EM_RESTART': '1', 17:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:51 INFO - 'PWD': '/builds/slave/test', 17:06:51 INFO - 'SHELL': '/bin/bash', 17:06:51 INFO - 'SHLVL': '1', 17:06:51 INFO - 'TERM': 'linux', 17:06:51 INFO - 'TMOUT': '86400', 17:06:51 INFO - 'USER': 'cltbld', 17:06:51 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668', 17:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:51 INFO - '_': '/tools/buildbot/bin/python'} 17:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:51 INFO - Downloading/unpacking flake8 17:06:51 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:06:51 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:06:51 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:06:51 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:06:51 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:06:51 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:06:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:06:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:06:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:06:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:06:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:06:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:06:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:06:54 INFO - no previously-included directories found matching 'docs/_build' 17:06:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:06:54 INFO - Running setup.py install for pep8 17:06:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:06:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:06:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:06:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:06:54 INFO - no previously-included directories found matching 'docs/_build' 17:06:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:06:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:06:54 INFO - Cleaning up... 17:06:54 INFO - Return code: 0 17:06:54 INFO - Running post-action listener: _resource_record_post_action 17:06:54 INFO - Running post-action listener: _start_resource_monitoring 17:06:54 INFO - Starting resource monitoring. 17:06:54 INFO - ##### 17:06:54 INFO - ##### Running install step. 17:06:54 INFO - ##### 17:06:54 INFO - Running pre-action listener: _resource_record_pre_action 17:06:54 INFO - Running main action method: install 17:06:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:06:54 INFO - Reading from file tmpfile_stdout 17:06:54 INFO - Detecting whether we're running mozinstall >=1.0... 17:06:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:06:54 INFO - Reading from file tmpfile_stdout 17:06:54 INFO - Output received: 17:06:54 INFO - Usage: mozinstall [options] installer 17:06:54 INFO - Options: 17:06:54 INFO - -h, --help show this help message and exit 17:06:54 INFO - -d DEST, --destination=DEST 17:06:54 INFO - Directory to install application into. [default: 17:06:54 INFO - "/builds/slave/test"] 17:06:54 INFO - --app=APP Application being installed. [default: firefox] 17:06:54 INFO - mkdir: /builds/slave/test/build/application 17:06:54 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:06:54 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:07:07 INFO - Reading from file tmpfile_stdout 17:07:07 INFO - Output received: 17:07:07 INFO - /builds/slave/test/build/application/firefox/firefox 17:07:07 INFO - Running post-action listener: _resource_record_post_action 17:07:07 INFO - ##### 17:07:07 INFO - ##### Running run-tests step. 17:07:07 INFO - ##### 17:07:07 INFO - Running pre-action listener: _resource_record_pre_action 17:07:07 INFO - Running main action method: run_tests 17:07:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:07:07 INFO - Python 2.7.3 17:07:07 INFO - Return code: 0 17:07:07 INFO - grabbing minidump binary from tooltool 17:07: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:07:07 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 0x2091410>, '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 0x2092310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20927a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:07:07 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:07:07 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:07:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:07:07 INFO - Return code: 0 17:07:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:07:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:07:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:07:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:07:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:07:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:07:08 INFO - Return code: 0 17:07:08 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/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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:07:08 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/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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:07:08 INFO - Using env: {'DISPLAY': ':0', 17:07:08 INFO - 'HOME': '/home/cltbld', 17:07:08 INFO - 'LANG': 'en_US.UTF-8', 17:07:08 INFO - 'LANGUAGE': 'en_US:en', 17:07:08 INFO - 'LOGNAME': 'cltbld', 17:07:08 INFO - 'MAIL': '/var/mail/cltbld', 17:07:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:07:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:08 INFO - 'MOZ_NO_REMOTE': '1', 17:07:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:07:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:08 INFO - 'NO_EM_RESTART': '1', 17:07:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:08 INFO - 'PWD': '/builds/slave/test', 17:07:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:07:08 INFO - 'SHELL': '/bin/bash', 17:07:08 INFO - 'SHLVL': '1', 17:07:08 INFO - 'TERM': 'linux', 17:07:08 INFO - 'TMOUT': '86400', 17:07:08 INFO - 'USER': 'cltbld', 17:07:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668', 17:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:08 INFO - '_': '/tools/buildbot/bin/python'} 17:07:08 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/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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:07:09 INFO - mozversion application_buildid: 20160608141429 17:07:09 INFO - mozversion application_changeset: ec56d351f9a0677f9ef34a6f6cefbf7addf86145 17:07:09 INFO - mozversion application_display_name: Firefox 17:07:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:07:09 INFO - mozversion application_name: Firefox 17:07:09 INFO - mozversion application_remotingname: firefox 17:07:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:07:09 INFO - mozversion application_vendor: Mozilla 17:07:09 INFO - mozversion application_version: 48.0 17:07:09 INFO - mozversion platform_buildid: 20160608141429 17:07:09 INFO - mozversion platform_changeset: ec56d351f9a0677f9ef34a6f6cefbf7addf86145 17:07:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:07:09 INFO - mozversion platform_version: 48.0 17:07:09 INFO - using testdate: 1465430829 17:07:09 INFO - actual date: 1465430829 17:07:09 INFO - starting webserver on 'localhost:49928' 17:07:09 INFO - SUITE-START | Running 2 tests 17:07:09 INFO - TEST-START | dromaeo_css 17:07:09 INFO - operating with platform_type : linux_ 17:07:09 INFO - Initialising browser for dromaeo_css test... 17:07:09 INFO - TEST-INFO | started process 12801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpubvcbw/profile http://localhost:49928/getInfo.html) 17:07:12 INFO - PROCESS | 12801 | 17:07:12 INFO - PROCESS | 12801 | (process:12877): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:07:13 INFO - PROCESS | 12801 | __metrics Screen width/height:1600/1200 17:07:13 INFO - PROCESS | 12801 | colorDepth:24 17:07:13 INFO - PROCESS | 12801 | Browser inner width/height: 1024/697 17:07:13 INFO - PROCESS | 12801 | __metrics 17:07:14 ERROR - PROCESS | 12801 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 17:07:15 INFO - TEST-INFO | 12801: exit 0 17:07:15 INFO - Browser initialized. 17:07:15 INFO - Running cycle 1/1 for dromaeo_css test... 17:07:15 INFO - TEST-INFO | started process 12927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpubvcbw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:07:16 INFO - PROCESS | 12927 | 17:07:16 INFO - PROCESS | 12927 | (process:12994): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:07:26 INFO - PROCESS | 12927 | RSS: Main: 150949888 17:07:26 INFO - PROCESS | 12927 | 17:08:16 INFO - PROCESS | 12927 | 1465430896503 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:10:23 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:49928/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49928/tests/dromaeo/cssquery-ext.html) 17:10:24 INFO - PROCESS | 12927 | RSS: Main: 154779648 17:10:24 INFO - PROCESS | 12927 | 17:13:26 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:49928/tests/dromaeo/cssquery-ext.html (next: http://localhost:49928/tests/dromaeo/cssquery-jquery.html) 17:13:27 INFO - PROCESS | 12927 | RSS: Main: 153059328 17:13:27 INFO - PROCESS | 12927 | 17:16:29 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:49928/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49928/tests/dromaeo/cssquery-mootools.html) 17:16:29 INFO - PROCESS | 12927 | RSS: Main: 152977408 17:16:29 INFO - PROCESS | 12927 | 17:19:31 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:49928/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49928/tests/dromaeo/cssquery-prototype.html) 17:19:32 INFO - PROCESS | 12927 | RSS: Main: 154402816 17:19:32 INFO - PROCESS | 12927 | 17:22:34 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:49928/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49928/tests/dromaeo/cssquery-yui.html) 17:22:35 INFO - PROCESS | 12927 | RSS: Main: 152838144 17:22:35 INFO - PROCESS | 12927 | 17:25:37 INFO - PROCESS | 12927 | Cycle 1(1): loaded http://localhost:49928/tests/dromaeo/cssquery-yui.html (next: http://localhost:49928/tests/dromaeo/cssquery-dojo.html) 17:25:37 INFO - PROCESS | 12927 | RSS: Main: 156639232 17:25:37 INFO - PROCESS | 12927 | 17:25:37 INFO - PROCESS | 12927 | __start_tp_report 17:25:37 INFO - PROCESS | 12927 | _x_x_mozilla_page_load 17:25:37 INFO - PROCESS | 12927 | _x_x_mozilla_page_load_details 17:25:37 INFO - PROCESS | 12927 | |i|pagename|runs| 17:25:37 INFO - PROCESS | 12927 | |0;dojo.html;3356.647552007039;3384.8646054157834;3390.627031026587;3410.5736782902136;3433.7596368254226;5502.752376143073;5528;5535.446455354472;5552.500274975251;5554.305711786022;5508.586855985807;5533.750981205845;5551.750171242294;5556.055470570002;5566.693831839248;5017.147084995559;5079.136546787036;5106.157484015133;5113.207452844815;5113.718745468997;4984.75076246188;5027.874303142414;5054.41874184468;5067.5185857343495;5140.203268493389;5069.188929771238;5125.282460455539;5134.948650513503;5155.3040339554245;5168.457311982244;5127.897442051157;5130.358705161855;5140.074786538403;5144.4083930348115;5174;4959.8016079356785;4969.031038947407;5041.369828771403;5079.466656001104;5119.66722163062;5386.67679939201;5388.137897936312;5398.811041613525;5409.810656627039;5430;5822.155787410844;5843;5854.18041474194;5858.648481091148;5864.530837532987;5843.211166492511;5850.297964244275;5866.354700982888;5928.881422371528;5949;5597.692126933017;5640.2667653205235;5645.830625081254;5648.717564121777;5654.321481422215;6019.247594050744;6038.184845045863;6045.697715114226;6046.516278697693;6046.546509011841;5744.167095771089;5786.594938354275;5827.184194212814;5828.504577110908;5864.824055278348;5801.7099145042575;5855.209546711139;5857.88284234313;5862.179294898718;5863.824085277449;5715.657060576379;5805.6806875621405;5814.854628634318;5819.912701309484;5828.854278643068;5871.060630299132;5877.500412464903;5938.228030356113;5948.167256584082;5967.850803729942;4474.418325617649;4506.211413002711;4515.932261016087;4528.728276303433;4529.048899731028;3983.42240375144;3986.7009974252046;4066.4916885389325;4067.918641627151;4083.1221287423346;5633.549316054706;5642.322921249476;5644.915326270109;5674.375818659944;5680.40355762639;5829.795957141479;5839.591228614041;5847.6783776891825;5856.414358564195;5887.882242355129;5594.580406469531;5603.3836278009385;5610.803621873215;5615.18579805934;5732.455416735404;5070.087384270793;5071.366079240095;5074.923876141861;5075.390953085654;5106.923396149061;6072.210612620331;6109.969450152721;6114.11345354921;6129.570930034944;6137.539684523678;5908.615939963888;5909.261342332208;5923.378045305181;6007.519398448027;6074.757009719562;6062.151298818081;6067.180930574316;6069.666168360783;6070.696465176635;6099.207103076572;5726.198332233574;5736.4263573643975;5737.139429085503;5738.569607279387;5769.163471296554;5820.272465941757;5837.795677151449;5938;5990.281166260077;6029.306629737636;5691.658500489983;5692.857678558069;5696.886062278649;5702.230198923092;5707.372189059283;5677.914831277451;5685.175649530877;5714.942850571441;5716.9142462862255;5720.74256658443;5585.525230355465;5729.713514324184;5782.277215348082;5801.912971305349;5831.679257640701;5695.572832037531;5717.628354156966;5744.4829965303325;5776.306843178677;5781.4218578141845;5628.718564071698;5684.687342196219;5689.6586204827845;5690.203371527907;5697.7151142443545 17:25:37 INFO - PROCESS | 12927 | |1;ext.html;659.2155335151169;673.3165836675778;675.1931441926897;729.4674887332244;744.1368013104798;39407.2118557629;40237.59762402375;40282.194356112894;40306.59693403065;40329.19341613166;43737.343939840925;44044.55955440445;44045.7797711011;44066.559334406644;44099;8793.95603021984;8935.419197752126;8970.910290897073;8982.955085224565;8988.056254093324;8736.51949142797;8811.823763524726;8812.515311657888;8818.426802257865;8859.468431894074;9194.770130746718;9250.768730781718;9271.443713377184;9273.443593384418;9301.581428835718;9138.588763505659;9179.954100229523;9194.586243618985;9208.49353285569;9210.907890921071;9175.128362805523;9278.1649651531;9281.953590232073;9303.627854885797;9321;43209.35185972213;43393.132137357075;43611.12777744459;43960;43971.34042989358;3776.9244615107546;3992.920141597152;4028.617281358266;4099.446574712406;4144;33675;33677.32645347104;33816.6618333816;33836.32327353464;33983.32033359319;4594.264917613166;4611.4696809866955;4648.74431906245;4678.415198100238;4747.643926705477;354261;382576;386675;387952;389584.99999999715;56873.14690279649;57234.42765572374;57320.14019789707;57336.71331643315;57382;59568.702156488944;59665.40334596685;59917.700411497666;71281.2871871285;71970;18405;18550.257989680533;18575.81424185768;18635.068246587616;18640.16119274636;14396.640083997983;14398.20809855468;14446.927765361106;14517;14532.85467145315;19405.156510131514;19646.508837279183;19875.403737887886;19922.800771992093;19945.60108797816;7585.317321440986;7655.885161722578;7665.578393188428;7714.575698336533;7989.241022102891;1030.5877648940334;1099.4008265495165;1131.3639220615946;1131.5813149134872;1179.339569840892;28757.85621071881;30974.380512389627;31061;31222.843885780425;31470.842645786626;1155.8381826544291;1161.924474909128;1171.9355435451132;1202.320688810819;1204.8192771084232;16510.17449127563;16675;16678.33286668544;16707.749383759252;16748.58128546796;529298;534571;877432;893031;900236;62679.686601566704;63107;64068.35931640717;64125;64131.67934160299;1500.2423775993054;1538.261634415487;1543.1898253417046;1550.1861522700672;1659.2035822805121;32528.837355814016;33085;33208.66791332152;33379.33241335208;34153.829230853684;53325.200121997426;54298.72850635721;54339;54387.18419223636;54467.45532544782;455619;458513;458965;458995;459318;31327.21681957969;31609;48149.518504815904;48539.5146048535;48663.513364867315;45220.54779452163;45962.515676761526;46493.76753116213;46953;47508.7624561875;40599;42158.74348060726;43497.34753978756;43641.56358436502;43671.781641092864;41419;42545.36181957335;43733;43781.34327985019;44001;38851;39035.41446878242;39264.411033833945;39358.803205983786;39557;33747.83126084354;33768.662313377536;33856;34340;34571.30857382889;28362.359285070896;28822.567661484674;29365.41269174647;29450.263743406587;29567.112986610435 17:25:37 INFO - PROCESS | 12927 | |2;jquery.html;422.4487044407051;427.4613986377164;429.63481041115034;437.48595400404525;438.2330920888445;18566.164522596482;19255.518612034688;19265.518362040955;20666.68999964998;21561.892190539063;12999.220046797198;13333.599992000256;17035.233414496346;20298;20463.18147274111;5232.398274198468;5420.376656684472;5464.644798088111;5493.862653433676;5687.232223649817;5837.970810145944;5912.733926973275;5919.37846526115;5944.316403613597;5948.910766338487;5692.658440493563;5897.616654917438;5914.792982245623;5928.3775203603645;5934.43622855828;1681.3274690123926;1687.088971955155;1694.8474637282704;1702.0808763267821;2629.618705287732;5305.204219367087;5309;5331.546818520431;5332.066888294533;5363.195520671891;23683.289501314986;24020.159294424786;24455.755442445527;24651.630225546633;24652.876735616388;2341.6838726772007;2477.6159695247084;2481.305234534333;2579.9097031603806;2640.4983053219826;10095.192384609214;10334.173266138767;10365.378077315385;10383.480825958748;10766.138708903269;1908.2557802457052;1990.870593411438;2021.3935819254166;2027.3512476007684;2073.1085633177727;83332.58333708292;85466.57266713689;86234;88295;89781;11531.365774882293;11668.124890633237;11808.76382472363;11817.350045747395;11954.163208575315;16952.152392380332;17081.48755537336;17083;17111;17119;9084.81830363389;9153.17621414076;9157.908420915706;9236.5843537041;9369.672061477815;9028.413153145024;9042.728718138467;9081.818363632823;9094.36339456245;9130.178283954343;5150.562202212779;5166.3800343958965;5200.427952925175;5222.582193424517;5246.711430871339;2114.312848324301;2123.607132680459;2125.8830764307804;2192.901319440629;2231.787980141884;970.7330484116924;1053.6470282455464;1074.6722249713912;1108.634150730257;1130.1862658885589;19581.90209048974;19847.60304793896;19905.303314383927;19962.401127966183;20238.595228095357;1102.5193315041158;1120.8374785656035;1130.949107290174;1139.145640769423;1183.7454947186395;11150.832737508943;11669.183157178915;11693.298402095901;11710.76578468426;11728.76542469163;482595;495455;498448;502309;503551;92304.53847730852;93549.53225233966;94881.5255923716;96296;96394.51802741081;1134.665273744231;1139.2708666453477;1144.9141314401454;1160.22265082395;1168.7253495428567;17424.390146344816;18006.459806205836;18021.1890464932;18032.549186270448;18353.449396518125;38743.22513549657;40216.79891600523;40737.79631101825;41438.171236575705;41529.58470415378;57757;57791.71104144453;58102.4189758097;58217.4178258212;58533.4146658528;9350;9428.10433008863;9450.243980481682;9457.29070319715;9532;11651.941740291244;13638;13950.372233249731;13999.650008749863;14380.28098595045;11580.710482238012;12445.937770311091;12565.371731413576;12609.621711348675;12680.809787853004;11679.708007299545;11831.704207394883;11844;12088.879111208775;12670.049746268882;11672.941635291769;11768.411579421167;12513.749725005267;12715.427805748948;12765.808512872129;8706.869396959177;9263.351565390358;9435.905640943503;9469.10043545862;9528.95235523818;10926.672199834018;11602.47788849487;11627.302361858316;11654.41727913584;11795.351255680676 17:25:37 INFO - PROCESS | 12927 | |3;mootools.html;1615.8626516746076;1629.103992803958;1896.5258685328668;1988.3040935672525;1999.290251960553;7690.8846367304395;8517.446365986207;8595.31237501;8775.297976161908;8806.559672016405;8108.027036755583;8238.382121340894;8282.91717082829;8431.70489032884;8505.957470212656;2477.9380515487123;2491.7134529529153;2492.763187497194;2506.448581312108;2521.369657585604;2429.5626787178303;2530.468601593658;2530.5571524983147;2543.55487789637;2545.2745967399296;2466.8149888758417;2469.061756532524;2487.5398051360557;2496.9375765605823;2497.3756560859783;2482.8758562072003;2495.9376015599664;2496.950060998788;2497.425592113824;2499.4376265340334;2490.601503759408;2497.475530138673;2506.6240063990367;2528.582783840664;2530.253575195322;8791.64833406663;8845.469271843709;8861.335399844973;8864.689735859214;8865.911340886638;5517.36550296717;5663.915041274384;5699.658020518782;5708.486236238717;5714.314282286111;3598.838052287653;3613.2050948791225;3627.5102861113673;3758.3047136279874;3777.1501412182315;1229.932353720545;1257.7673130470891;1277.948882044717;1278.9808152877715;1279.0535004096994;12431.254124752453;12527.498900043987;12540.310282934435;12541.623751287476;12563.874361256361;4664.813407463731;4719.858404247878;4754.334393184957;4792.185328494164;4822.42130944289;9987.600495980225;10007.699769006942;10037;10042.598296068076;10067.59729610822;5518.475744804317;5518.724063796794;5535.501804837584;5539.889202215933;5548.86127846799;4442.977785111054;4943.060818444484;4992.750362481861;5060.620453466005;5120.206368012964;4022.0950286185375;4074.1851629673592;4102.200070986189;4107.137501124737;4214.978925105354;1269.0862578943147;1291.6383412644475;1292.6380613428255;1298.8766067223598;1302.4594793160923;1089.0742868561658;1090.2368342160362;1091.792559413709;1094.179365475893;1099.0657940750298;6082.75668973245;6098.69506524672;6151.84620384494;6162.106494558264;6180.876382472416;445.65907081083;447.47421779409063;451.1833581218006;500.7496251874063;502.6757741256942;4197.643200327945;4312.310030395121;4341.978290108593;4422.491413487426;4457.665675074382;10528.052475277109;10728.570857165781;10813;10845.566177352976;10856.294340867977;10552.577896884191;10557;10576.682699519026;10581.84127238092;10617.044465998097;7900.920990790133;8159.265666089962;8162.714304999416;8323.500589964622;8328.625211865481;5987.700614969322;6047.365026672312;6054.061620448838;6136.018237082046;6150.923588372107;9023;9204.49375284339;9310.208632266333;9316;9385.15533601979;9275.489848058422;9313.068693130634;9444.905550944402;9451.385659932082;9546.997565255826;7628.694852205849;7695;7712.344450721752;7759.72840950564;7806.219378062148;8399.328053755562;8422.5788710563;8450.070492245972;8464.026636936831;8490.59905115649;7488.663010164447;7630.542167469969;7712.537247764928;7880.605969701377;7883.408744344082;7534.510256833289;7696.384289256734;7792.6103694816165;7817.570033648204;7856.37149028065;7315.890261645973;7393.07586551681;7400.074990626172;7428.294312040348;7453.807390817443;5427.402985671494;5506.476884696108;5539.418361072029;5583.581231407742;5617.775288988395;5621.494065534122;5636.21093046982;5652.830415087554;5757.050086735641;5775 17:25:37 INFO - PROCESS | 12927 | |4;prototype.html;360.90616439725665;364.60258318432903;368.1055036261884;373.3764613096129;374.1525444867375;6421.807345779628;6448.838779030527;6532.020196970445;6535.901961470576;6650.368215019577;6431.614103153803;6558.573692709971;6581.407673309413;6587.53887227893;6589.868202635945;4902.264660300957;4996.625253106014;5002.1746411842005;5009.223570346584;5012.72430016349;4983.252512123175;4993.825216117437;4994.4506104328675;4994.825181118662;5011.198208286675;4922.064807686528;4923.8276660316715;4948.653594248404;4949.109160351135;4957.975210123945;4957.900841983176;4965.776540055688;4969.130402179622;5021.69869807809;5043.167877300241;4447.5552444755585;4448.243798554254;4459.44256967879;4459.843905463294;4461.5315391883705;6086.969565152146;6270.216222972129;6335.904961425582;6353.0152826312;6355.936440635627;5710.2576665033275;5734.770609175628;5756.251687280626;5761.876434095353;5779.768809247625;6968.616726080114;6991.196012458581;6992.440604751608;7004.789856304319;7028.753993610199;4926.704397736147;4926.950730492685;4930.235813448921;4932.309476673268;4955.554000140005;7234.529755565872;7300.12398512182;7314.451416143757;7317.231690672456;7324.08448943882;4957.454679985199;5042.294078828967;5049.697018178921;5061.063703214917;5066.265391518209;5113.795448182031;5116.8209112681625;5122.897542049138;5127.794888204505;5128.307678463434;5660.235868157746;5781.959247335436;5798.855028624318;5843.912341314884;5850.678212698257;7058.647067646597;7075.363217310467;7082.114735658043;7093.361597456254;7105.076340075757;1786.8927864328182;1815.019889259785;1815.4190658988996;1818.1818181818235;1820.526663067612;1183.5620820296544;1201.285235285004;1208.8730683278304;1209.1838009343658;1225.9754804903853;6846.144231971004;6858.3827455529245;6858.931410685829;6859.862802744017;6860.3139686031;7263.237360077222;7296.343329100407;7297.562146271241;7318.975343451921;7331.560106393634;6785.389314961579;6822.113125293779;6841.486888483384;6845.14435695538;6849.383555479931;3824.541055073353;3885.4171874218528;3927.509061367329;3927.7250592458254;3934.2918274710255;7563.243675632392;7592.544447333178;7598.8100297493;7612.733554325572;7620.085589729268;7422.703091876372;7462.813429664302;7473.813154671177;7478.326950574475;7494.775156745306;7601.467897247139;7660.655270512729;7674.731384401519;7675.15573286938;7681.7695469136015;7178.3898368637165;7261.346478816932;7301.926980730337;7305.3425191732995;7316.268373162641;7138.750143744944;7156;7159.140903091454;7175.784726458214;7208;7573.242675732383;7683.577403242875;7685.615719214129;7694.807629809299;7694.884576731465;4783.091212669582;4832.637552183671;4836.564709176191;4839.758012099452;4850.1997170466475;6979.651017449006;7230.530015548972;7231.240719724353;7234.674439650334;7238.059052323164;6998.055262539696;7022.719091236498;7026.648667566704;7055.2944705529035;7056.1179852518435;6964.860702786017;7038;7040.577565346096;7044.682989265598;7044.9432585112645;6875.724971001104;6876.243613202644;6921.411680007256;6933.064036355229;6955.965220173866;6918.481113916577;7062.788116356517;7077.68150433242;7082.397996170177;7102.218755936739;6820.31796820314;6863.725450982104;6868.931310686829;6876.793696189123;6885.51801373899 17:25:37 INFO - PROCESS | 12927 | |5;yui.html;766.7738017284902;792.4967645545078;808.7331180710366;859.9613017414212;878.7978764884073;14724.77912831307;14903.18032508213;14980.250987450625;14992.850071499282;15016.174110423923;14334.71330573388;14342.067765595255;14412.567622971328;14424.78362824556;14438.927805360985;902.7652810269344;912.3066469483191;936.8220038192756;939.7086903060073;940.7459985803829;931.1479995803832;935.504182783126;936.5832204668925;937.0348541002778;938.6057855700623;988.184747583243;988.8368419210858;989.8218320702271;990.5146478225689;992.93545919515;982.2142286171035;983.4492684096929;984.0307297312141;984.2667212926344;985.6993616946828;719.5143278287135;721.743780957763;724.655788500458;725.7858931615133;727.2000799120977;14993.100413975088;15040.623984400368;15061.698766024618;15063.924680376638;15156;14766;14848.703025939421;14860.331285092198;14873.47942822007;14888.62778430537;11515.039675216836;11602.187846850724;11628.592999245071;11700.122490813137;11877.643670689893;3917.8824635260703;3953.743006704584;4022.0146064214455;4074.388841673743;4077.7553346799286;59742.40257597412;59871;60322.698386507785;60503.39496605022;60734.696326518526;11449.885501145049;11516;11652.708682283012;11710.297382157098;11913.583024594098;19418.61162776765;19887.60224795496;20090.296839610837;20126;20172;8654.091320411391;8708.477491350539;8891.110888911056;9013.278937685101;9073.546322683971;4880.097182021337;4913.729744863996;4928.28539861718;4952.90094198114;4999.525045120708;3687.8340474678703;3707.277080969185;3715.1826598148364;3717.628237176261;3719.4420836874683;655.8884989551788;656.1633916756174;659.864727730814;670.9597424154566;675.2774531251612;783.2480818414272;844.2907957315884;852.261426468823;854.0050840770433;876.2595606712318;9942.403455792675;9979.501024948724;10235.488225588691;10255.58977640901;10374.22193335503;823.6952327638692;824.9917500825035;848.7708318753902;853.9701110461104;860.642833224205;4785.449673287617;4836.879078023077;4878.146324393288;4878.609711223094;4935.063637135899;62080;63773;63789;63868.68065659642;63955.680221598595;55750.16374754382;56305;56357.43642563522;56781.71609141928;56943.43056569464;49971.500284996684;50319;51540.45378638647;51580.22629660558;52859.471405286225;9392.154706076486;9776.462294573867;9896.257780666334;9921;9982.500874956078;37275.81362093172;37960.62039379571;38411.039724007125;38559.42160867533;38598;42964;47865.28202076902;48130;48719.75640121777;48881.5111848877;11187.272827266203;11834.704132396415;11996;12044.578439754567;12060.51757929673;13322.600321990356;13875.79186312186;14024.439022439396;14216.857831421967;15158.24208789534;13059.412326445523;13127.081104322606;13395.263260520765;13547.187168769906;13888.861111388756;12919.354032298535;13052.738945221232;13074.150180238254;13620.591382258151;13721.382537786023;12192.75614487723;12442.502299907903;12478.188917720683;12754.170978886343;12971.870281297066;11182.440877955907;11192.272502287326;11262.605808796652;11331.490082946451;11508.53965841357;11154.776904461703;11167;11202.934814032353;11283.66149015531;11310.303454481564 17:25:37 INFO - PROCESS | 12927 | __end_tp_report 17:25:37 INFO - PROCESS | 12927 | __start_cc_report 17:25:37 INFO - PROCESS | 12927 | _x_x_mozilla_cycle_collect,348 17:25:37 INFO - PROCESS | 12927 | __end_cc_report 17:25:37 INFO - PROCESS | 12927 | __startTimestamp1465431937624__endTimestamp 17:25:37 INFO - PROCESS | 12927 | 17:25:37 INFO - PROCESS | 12927 | ------- Summary: start ------- 17:25:37 INFO - PROCESS | 12927 | Number of tests: 6 17:25:37 INFO - PROCESS | 12927 | 17:25:37 INFO - PROCESS | 12927 | [#0] dojo.html Cycles:165 Average:5492.87 Median:5692.86 stddev:585.67 (10.3%) stddev-sans-first:562.98 17:25:37 INFO - PROCESS | 12927 | Values: 3356.6 3384.9 3390.6 3410.6 3433.8 5502.8 5528.0 5535.4 5552.5 5554.3 5508.6 5533.8 5551.8 5556.1 5566.7 5017.1 5079.1 5106.2 5113.2 5113.7 4984.8 5027.9 5054.4 5067.5 5140.2 5069.2 5125.3 5134.9 5155.3 5168.5 5127.9 5130.4 5140.1 5144.4 5174.0 4959.8 4969.0 5041.4 5079.5 5119.7 5386.7 5388.1 5398.8 5409.8 5430.0 5822.2 5843.0 5854.2 5858.6 5864.5 5843.2 5850.3 5866.4 5928.9 5949.0 5597.7 5640.3 5645.8 5648.7 5654.3 6019.2 6038.2 6045.7 6046.5 6046.5 5744.2 5786.6 5827.2 5828.5 5864.8 5801.7 5855.2 5857.9 5862.2 5863.8 5715.7 5805.7 5814.9 5819.9 5828.9 5871.1 5877.5 5938.2 5948.2 5967.9 4474.4 4506.2 4515.9 4528.7 4529.0 3983.4 3986.7 4066.5 4067.9 4083.1 5633.5 5642.3 5644.9 5674.4 5680.4 5829.8 5839.6 5847.7 5856.4 5887.9 5594.6 5603.4 5610.8 5615.2 5732.5 5070.1 5071.4 5074.9 5075.4 5106.9 6072.2 6110.0 6114.1 6129.6 6137.5 5908.6 5909.3 5923.4 6007.5 6074.8 6062.2 6067.2 6069.7 6070.7 6099.2 5726.2 5736.4 5737.1 5738.6 5769.2 5820.3 5837.8 5938.0 5990.3 6029.3 5691.7 5692.9 5696.9 5702.2 5707.4 5677.9 5685.2 5714.9 5716.9 5720.7 5585.5 5729.7 5782.3 5801.9 5831.7 5695.6 5717.6 5744.5 5776.3 5781.4 5628.7 5684.7 5689.7 5690.2 5697.7 17:25:37 INFO - PROCESS | 12927 | 17:25:37 INFO - PROCESS | 12927 | [#1] ext.html Cycles:180 Average:68403.41 Median:43656.67 stddev:150518.60 (344.8%) stddev-sans-first:150854.91 17:25:37 INFO - PROCESS | 12927 | Values: 659.2 673.3 675.2 729.5 744.1 39407.2 40237.6 40282.2 40306.6 40329.2 43737.3 44044.6 44045.8 44066.6 44099.0 8794.0 8935.4 8970.9 8983.0 8988.1 8736.5 8811.8 8812.5 8818.4 8859.5 9194.8 9250.8 9271.4 9273.4 9301.6 9138.6 9180.0 9194.6 9208.5 9210.9 9175.1 9278.2 9282.0 9303.6 9321.0 43209.4 43393.1 43611.1 43960.0 43971.3 3776.9 3992.9 4028.6 4099.4 4144.0 33675.0 33677.3 33816.7 33836.3 33983.3 4594.3 4611.5 4648.7 4678.4 4747.6 354261.0 382576.0 386675.0 387952.0 389585.0 56873.1 57234.4 57320.1 57336.7 57382.0 59568.7 59665.4 59917.7 71281.3 71970.0 18405.0 18550.3 18575.8 18635.1 18640.2 14396.6 14398.2 14446.9 14517.0 14532.9 19405.2 19646.5 19875.4 19922.8 19945.6 7585.3 7655.9 7665.6 7714.6 7989.2 1030.6 1099.4 1131.4 1131.6 1179.3 28757.9 30974.4 31061.0 31222.8 31470.8 1155.8 1161.9 1171.9 1202.3 1204.8 16510.2 16675.0 16678.3 16707.7 16748.6 529298.0 534571.0 877432.0 893031.0 900236.0 62679.7 63107.0 64068.4 64125.0 64131.7 1500.2 1538.3 1543.2 1550.2 1659.2 32528.8 33085.0 33208.7 33379.3 34153.8 53325.2 54298.7 54339.0 54387.2 54467.5 455619.0 458513.0 458965.0 458995.0 459318.0 31327.2 31609.0 48149.5 48539.5 48663.5 45220.5 45962.5 46493.8 46953.0 47508.8 40599.0 42158.7 43497.3 43641.6 43671.8 41419.0 42545.4 43733.0 43781.3 44001.0 38851.0 39035.4 39264.4 39358.8 39557.0 33747.8 33768.7 33856.0 34340.0 34571.3 28362.4 28822.6 29365.4 29450.3 29567.1 17:25:37 INFO - PROCESS | 12927 | 17:25:37 INFO - PROCESS | 12927 | [#2] jquery.html Cycles:180 Average:29580.16 Median:11877.40 stddev:81961.09 (690.1%) stddev-sans-first:82161.77 17:25:37 INFO - PROCESS | 12927 | Values: 422.4 427.5 429.6 437.5 438.2 18566.2 19255.5 19265.5 20666.7 21561.9 12999.2 13333.6 17035.2 20298.0 20463.2 5232.4 5420.4 5464.6 5493.9 5687.2 5838.0 5912.7 5919.4 5944.3 5948.9 5692.7 5897.6 5914.8 5928.4 5934.4 1681.3 1687.1 1694.8 1702.1 2629.6 5305.2 5309.0 5331.5 5332.1 5363.2 23683.3 24020.2 24455.8 24651.6 24652.9 2341.7 2477.6 2481.3 2579.9 2640.5 10095.2 10334.2 10365.4 10383.5 10766.1 1908.3 1990.9 2021.4 2027.4 2073.1 83332.6 85466.6 86234.0 88295.0 89781.0 11531.4 11668.1 11808.8 11817.4 11954.2 16952.2 17081.5 17083.0 17111.0 17119.0 9084.8 9153.2 9157.9 9236.6 9369.7 9028.4 9042.7 9081.8 9094.4 9130.2 5150.6 5166.4 5200.4 5222.6 5246.7 2114.3 2123.6 2125.9 2192.9 2231.8 970.7 1053.6 1074.7 1108.6 1130.2 19581.9 19847.6 19905.3 19962.4 20238.6 1102.5 1120.8 1130.9 1139.1 1183.7 11150.8 11669.2 11693.3 11710.8 11728.8 482595.0 495455.0 498448.0 502309.0 503551.0 92304.5 93549.5 94881.5 96296.0 96394.5 1134.7 1139.3 1144.9 1160.2 1168.7 17424.4 18006.5 18021.2 18032.5 18353.4 38743.2 40216.8 40737.8 41438.2 41529.6 57757.0 57791.7 58102.4 58217.4 58533.4 9350.0 9428.1 9450.2 9457.3 9532.0 11651.9 13638.0 13950.4 13999.7 14380.3 11580.7 12445.9 12565.4 12609.6 12680.8 11679.7 11831.7 11844.0 12088.9 12670.0 11672.9 11768.4 12513.7 12715.4 12765.8 8706.9 9263.4 9435.9 9469.1 9529.0 10926.7 11602.5 11627.3 11654.4 11795.4 17:25:37 INFO - PROCESS | 12927 | 17:25:37 INFO - PROCESS | 12927 | [#3] mootools.html Cycles:180 Average:5839.74 Median:501.71 stddev:3163.26 (630.5%) stddev-sans-first:3156.21 17:25:37 INFO - PROCESS | 12927 | Values: 1615.9 1629.1 1896.5 1988.3 1999.3 7690.9 8517.4 8595.3 8775.3 8806.6 8108.0 8238.4 8282.9 8431.7 8506.0 2477.9 2491.7 2492.8 2506.4 2521.4 2429.6 2530.5 2530.6 2543.6 2545.3 2466.8 2469.1 2487.5 2496.9 2497.4 2482.9 2495.9 2497.0 2497.4 2499.4 2490.6 2497.5 2506.6 2528.6 2530.3 8791.6 8845.5 8861.3 8864.7 8865.9 5517.4 5663.9 5699.7 5708.5 5714.3 3598.8 3613.2 3627.5 3758.3 3777.2 1229.9 1257.8 1277.9 1279.0 1279.1 12431.3 12527.5 12540.3 12541.6 12563.9 4664.8 4719.9 4754.3 4792.2 4822.4 9987.6 10007.7 10037.0 10042.6 10067.6 5518.5 5518.7 5535.5 5539.9 5548.9 4443.0 4943.1 4992.8 5060.6 5120.2 4022.1 4074.2 4102.2 4107.1 4215.0 1269.1 1291.6 1292.6 1298.9 1302.5 1089.1 1090.2 1091.8 1094.2 1099.1 6082.8 6098.7 6151.8 6162.1 6180.9 445.7 447.5 451.2 500.7 502.7 4197.6 4312.3 4342.0 4422.5 4457.7 10528.1 10728.6 10813.0 10845.6 10856.3 10552.6 10557.0 10576.7 10581.8 10617.0 7900.9 8159.3 8162.7 8323.5 8328.6 5987.7 6047.4 6054.1 6136.0 6150.9 9023.0 9204.5 9310.2 9316.0 9385.2 9275.5 9313.1 9444.9 9451.4 9547.0 7628.7 7695.0 7712.3 7759.7 7806.2 8399.3 8422.6 8450.1 8464.0 8490.6 7488.7 7630.5 7712.5 7880.6 7883.4 7534.5 7696.4 7792.6 7817.6 7856.4 7315.9 7393.1 7400.1 7428.3 7453.8 5427.4 5506.5 5539.4 5583.6 5617.8 5621.5 5636.2 5652.8 5757.1 5775.0 17:25:37 INFO - PROCESS | 12927 | 17:25:37 INFO - PROCESS | 12927 | [#4] prototype.html Cycles:180 Average:5881.00 Median:6802.85 stddev:1785.40 (26.2%) stddev-sans-first:1741.67 17:25:37 INFO - PROCESS | 12927 | Values: 360.9 364.6 368.1 373.4 374.2 6421.8 6448.8 6532.0 6535.9 6650.4 6431.6 6558.6 6581.4 6587.5 6589.9 4902.3 4996.6 5002.2 5009.2 5012.7 4983.3 4993.8 4994.5 4994.8 5011.2 4922.1 4923.8 4948.7 4949.1 4958.0 4957.9 4965.8 4969.1 5021.7 5043.2 4447.6 4448.2 4459.4 4459.8 4461.5 6087.0 6270.2 6335.9 6353.0 6355.9 5710.3 5734.8 5756.3 5761.9 5779.8 6968.6 6991.2 6992.4 7004.8 7028.8 4926.7 4927.0 4930.2 4932.3 4955.6 7234.5 7300.1 7314.5 7317.2 7324.1 4957.5 5042.3 5049.7 5061.1 5066.3 5113.8 5116.8 5122.9 5127.8 5128.3 5660.2 5782.0 5798.9 5843.9 5850.7 7058.6 7075.4 7082.1 7093.4 7105.1 1786.9 1815.0 1815.4 1818.2 1820.5 1183.6 1201.3 1208.9 1209.2 1226.0 6846.1 6858.4 6858.9 6859.9 6860.3 7263.2 7296.3 7297.6 7319.0 7331.6 6785.4 6822.1 6841.5 6845.1 6849.4 3824.5 3885.4 3927.5 3927.7 3934.3 7563.2 7592.5 7598.8 7612.7 7620.1 7422.7 7462.8 7473.8 7478.3 7494.8 7601.5 7660.7 7674.7 7675.2 7681.8 7178.4 7261.3 7301.9 7305.3 7316.3 7138.8 7156.0 7159.1 7175.8 7208.0 7573.2 7683.6 7685.6 7694.8 7694.9 4783.1 4832.6 4836.6 4839.8 4850.2 6979.7 7230.5 7231.2 7234.7 7238.1 6998.1 7022.7 7026.6 7055.3 7056.1 6964.9 7038.0 7040.6 7044.7 7044.9 6875.7 6876.2 6921.4 6933.1 6956.0 6918.5 7062.8 7077.7 7082.4 7102.2 6820.3 6863.7 6868.9 6876.8 6885.5 17:25:37 INFO - PROCESS | 12927 | 17:25:37 INFO - PROCESS | 12927 | [#5] yui.html Cycles:180 Average:15587.14 Median:47997.64 stddev:17877.81 (37.2%) stddev-sans-first:17893.32 17:25:37 INFO - PROCESS | 12927 | Values: 766.8 792.5 808.7 860.0 878.8 14724.8 14903.2 14980.3 14992.9 15016.2 14334.7 14342.1 14412.6 14424.8 14438.9 902.8 912.3 936.8 939.7 940.7 931.1 935.5 936.6 937.0 938.6 988.2 988.8 989.8 990.5 992.9 982.2 983.4 984.0 984.3 985.7 719.5 721.7 724.7 725.8 727.2 14993.1 15040.6 15061.7 15063.9 15156.0 14766.0 14848.7 14860.3 14873.5 14888.6 11515.0 11602.2 11628.6 11700.1 11877.6 3917.9 3953.7 4022.0 4074.4 4077.8 59742.4 59871.0 60322.7 60503.4 60734.7 11449.9 11516.0 11652.7 11710.3 11913.6 19418.6 19887.6 20090.3 20126.0 20172.0 8654.1 8708.5 8891.1 9013.3 9073.5 4880.1 4913.7 4928.3 4952.9 4999.5 3687.8 3707.3 3715.2 3717.6 3719.4 655.9 656.2 659.9 671.0 675.3 783.2 844.3 852.3 854.0 876.3 9942.4 9979.5 10235.5 10255.6 10374.2 823.7 825.0 848.8 854.0 860.6 4785.4 4836.9 4878.1 4878.6 4935.1 62080.0 63773.0 63789.0 63868.7 63955.7 55750.2 56305.0 56357.4 56781.7 56943.4 49971.5 50319.0 51540.5 51580.2 52859.5 9392.2 9776.5 9896.3 9921.0 9982.5 37275.8 37960.6 38411.0 38559.4 38598.0 42964.0 47865.3 48130.0 48719.8 48881.5 11187.3 11834.7 11996.0 12044.6 12060.5 13322.6 13875.8 14024.4 14216.9 15158.2 13059.4 13127.1 13395.3 13547.2 13888.9 12919.4 13052.7 13074.2 13620.6 13721.4 12192.8 12442.5 12478.2 12754.2 12971.9 11182.4 11192.3 11262.6 11331.5 11508.5 11154.8 11167.0 11202.9 11283.7 11310.3 17:25:37 INFO - PROCESS | 12927 | -------- Summary: end -------- 17:25:37 INFO - PROCESS | 12927 | 17:25:38 INFO - TEST-INFO | 12927: exit 0 17:25:38 INFO - TEST-OK | dromaeo_css | took 1109212ms 17:25:38 INFO - TEST-START | kraken 17:25:38 INFO - operating with platform_type : linux_ 17:25:38 INFO - Initialising browser for kraken test... 17:25:38 INFO - TEST-INFO | started process 13171 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprGS_Oi/profile http://localhost:49928/getInfo.html) 17:25:41 INFO - PROCESS | 13171 | 17:25:41 INFO - PROCESS | 13171 | (process:13250): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:25:42 INFO - PROCESS | 13171 | __metrics Screen width/height:1600/1200 17:25:42 INFO - PROCESS | 13171 | colorDepth:24 17:25:42 INFO - PROCESS | 13171 | Browser inner width/height: 1024/697 17:25:42 INFO - PROCESS | 13171 | __metrics 17:25:43 ERROR - PROCESS | 13171 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 17:25:44 INFO - TEST-INFO | 13171: exit 0 17:25:44 INFO - Browser initialized. 17:25:44 INFO - Running cycle 1/1 for kraken test... 17:25:44 INFO - TEST-INFO | started process 13300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprGS_Oi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:25:46 INFO - PROCESS | 13300 | 17:25:46 INFO - PROCESS | 13300 | (process:13370): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:25:56 INFO - PROCESS | 13300 | RSS: Main: 151146496 17:25:56 INFO - PROCESS | 13300 | 17:25:58 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:49928/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49928/tests/kraken/driver.html?testName=audio-beat-detection) 17:25:59 INFO - PROCESS | 13300 | RSS: Main: 156667904 17:25:59 INFO - PROCESS | 13300 | 17:26:01 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:49928/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49928/tests/kraken/driver.html?testName=audio-dft) 17:26:02 INFO - PROCESS | 13300 | RSS: Main: 156954624 17:26:02 INFO - PROCESS | 13300 | 17:26:05 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:49928/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49928/tests/kraken/driver.html?testName=audio-fft) 17:26:05 INFO - PROCESS | 13300 | RSS: Main: 157257728 17:26:06 INFO - PROCESS | 13300 | 17:26:08 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:49928/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49928/tests/kraken/driver.html?testName=audio-oscillator) 17:26:08 INFO - PROCESS | 13300 | RSS: Main: 156594176 17:26:08 INFO - PROCESS | 13300 | 17:26:10 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:49928/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49928/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:26:11 INFO - PROCESS | 13300 | RSS: Main: 156495872 17:26:11 INFO - PROCESS | 13300 | 17:26:14 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:49928/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49928/tests/kraken/driver.html?testName=imaging-darkroom) 17:26:15 INFO - PROCESS | 13300 | RSS: Main: 156983296 17:26:15 INFO - PROCESS | 13300 | 17:26:18 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:49928/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49928/tests/kraken/driver.html?testName=imaging-desaturate) 17:26:19 INFO - PROCESS | 13300 | RSS: Main: 157122560 17:26:19 INFO - PROCESS | 13300 | 17:26:21 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:49928/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49928/tests/kraken/driver.html?testName=json-parse-financial) 17:26:22 INFO - PROCESS | 13300 | RSS: Main: 156884992 17:26:22 INFO - PROCESS | 13300 | 17:26:24 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:49928/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49928/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:26:24 INFO - PROCESS | 13300 | RSS: Main: 156581888 17:26:24 INFO - PROCESS | 13300 | 17:26:26 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:49928/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49928/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:26:26 INFO - PROCESS | 13300 | RSS: Main: 156835840 17:26:26 INFO - PROCESS | 13300 | 17:26:28 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:49928/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49928/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:26:29 INFO - PROCESS | 13300 | RSS: Main: 157343744 17:26:29 INFO - PROCESS | 13300 | 17:26:32 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:49928/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49928/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:26:32 INFO - PROCESS | 13300 | RSS: Main: 157769728 17:26:32 INFO - PROCESS | 13300 | 17:26:35 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:49928/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49928/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:26:36 INFO - PROCESS | 13300 | RSS: Main: 157589504 17:26:36 INFO - PROCESS | 13300 | 17:26:37 INFO - PROCESS | 13300 | Cycle 1(1): loaded http://localhost:49928/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49928/tests/kraken/driver.html?testName=ai-astar) 17:26:37 INFO - PROCESS | 13300 | RSS: Main: 159059968 17:26:37 INFO - PROCESS | 13300 | 17:26:37 INFO - PROCESS | 13300 | __start_tp_report 17:26:37 INFO - PROCESS | 13300 | _x_x_mozilla_page_load 17:26:37 INFO - PROCESS | 13300 | _x_x_mozilla_page_load_details 17:26:37 INFO - PROCESS | 13300 | |i|pagename|runs| 17:26:37 INFO - PROCESS | 13300 | |0;ai-astar;107;110;103;110;111;111;102;109;113;111 17:26:37 INFO - PROCESS | 13300 | |1;audio-beat-detection;149;126;157;180;131;159;154;124;171;125 17:26:37 INFO - PROCESS | 13300 | |2;audio-dft;163;162;162;161;162;165;161;163;161;164 17:26:37 INFO - PROCESS | 13300 | |3;audio-fft;73;75;76;167;74;73;76;73;168;78 17:26:37 INFO - PROCESS | 13300 | |4;audio-oscillator;92;92;148;92;93;92;142;92;92;158 17:26:37 INFO - PROCESS | 13300 | |5;imaging-gaussian-blur;118;117;117;118;118;118;116;116;117;118 17:26:37 INFO - PROCESS | 13300 | |6;imaging-darkroom;146;148;146;146;146;148;148;145;146;146 17:26:37 INFO - PROCESS | 13300 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;95 17:26:37 INFO - PROCESS | 13300 | |8;json-parse-financial;58;60;59;61;59;61;61;76;56;57 17:26:37 INFO - PROCESS | 13300 | |9;json-stringify-tinderbox;58;60;57;57;58;57;64;58;58;58 17:26:37 INFO - PROCESS | 13300 | |10;stanford-crypto-aes;74;76;73;74;75;73;75;76;75;73 17:26:37 INFO - PROCESS | 13300 | |11;stanford-crypto-ccm;122;119;113;114;116;113;114;116;139;130 17:26:37 INFO - PROCESS | 13300 | |12;stanford-crypto-pbkdf2;168;159;169;167;161;160;160;168;173;160 17:26:37 INFO - PROCESS | 13300 | |13;stanford-crypto-sha256-iterative;69;68;73;68;70;68;67;67;67;66 17:26:37 INFO - PROCESS | 13300 | __end_tp_report 17:26:37 INFO - PROCESS | 13300 | __start_cc_report 17:26:37 INFO - PROCESS | 13300 | _x_x_mozilla_cycle_collect,858 17:26:37 INFO - PROCESS | 13300 | __end_cc_report 17:26:37 INFO - PROCESS | 13300 | __startTimestamp1465431997941__endTimestamp 17:26:37 INFO - PROCESS | 13300 | 17:26:37 INFO - PROCESS | 13300 | ------- Summary: start ------- 17:26:37 INFO - PROCESS | 13300 | Number of tests: 14 17:26:37 INFO - PROCESS | 13300 | 17:26:37 INFO - PROCESS | 13300 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.50 stddev:3.62 (3.3%) stddev-sans-first:3.79 17:26:37 INFO - PROCESS | 13300 | Values: 107.0 110.0 103.0 110.0 111.0 111.0 102.0 109.0 113.0 111.0 17:26:37 INFO - PROCESS | 13300 | 17:26:37 INFO - PROCESS | 13300 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:155.50 stddev:20.19 (13.0%) stddev-sans-first:21.41 17:26:37 INFO - PROCESS | 13300 | Values: 149.0 126.0 157.0 180.0 131.0 159.0 154.0 124.0 171.0 125.0 17:26:37 INFO - PROCESS | 13300 | 17:26:37 INFO - PROCESS | 13300 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:1.35 (0.8%) stddev-sans-first:1.41 17:26:37 INFO - PROCESS | 13300 | Values: 163.0 162.0 162.0 161.0 162.0 165.0 161.0 163.0 161.0 164.0 17:26:37 INFO - PROCESS | 13300 | 17:26:37 INFO - PROCESS | 13300 | [#3] audio-fft Cycles:10 Average:93.30 Median:74.50 stddev:39.14 (52.5%) stddev-sans-first:40.82 17:26:37 INFO - PROCESS | 13300 | Values: 73.0 75.0 76.0 167.0 74.0 73.0 76.0 73.0 168.0 78.0 17:26:37 INFO - PROCESS | 13300 | 17:26:37 INFO - PROCESS | 13300 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:92.00 stddev:27.89 (30.3%) stddev-sans-first:28.87 17:26:37 INFO - PROCESS | 13300 | Values: 92.0 92.0 148.0 92.0 93.0 92.0 142.0 92.0 92.0 158.0 17:26:37 INFO - PROCESS | 13300 | 17:26:37 INFO - PROCESS | 13300 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 17:26:37 INFO - PROCESS | 13300 | Values: 118.0 117.0 117.0 118.0 118.0 118.0 116.0 116.0 117.0 118.0 17:26:37 INFO - PROCESS | 13300 | 17:26:37 INFO - PROCESS | 13300 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 17:26:37 INFO - PROCESS | 13300 | Values: 146.0 148.0 146.0 146.0 146.0 148.0 148.0 145.0 146.0 146.0 17:26:37 INFO - PROCESS | 13300 | 17:26:37 INFO - PROCESS | 13300 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:26:37 INFO - PROCESS | 13300 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 17:26:37 INFO - PROCESS | 13300 | 17:26:37 INFO - PROCESS | 13300 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:60.50 stddev:5.61 (9.3%) stddev-sans-first:5.86 17:26:37 INFO - PROCESS | 13300 | Values: 58.0 60.0 59.0 61.0 59.0 61.0 61.0 76.0 56.0 57.0 17:26:37 INFO - PROCESS | 13300 | 17:26:37 INFO - PROCESS | 13300 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:58.00 stddev:2.12 (3.7%) stddev-sans-first:2.24 17:26:37 INFO - PROCESS | 13300 | Values: 58.0 60.0 57.0 57.0 58.0 57.0 64.0 58.0 58.0 58.0 17:26:37 INFO - PROCESS | 13300 | 17:26:37 INFO - PROCESS | 13300 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:75.00 stddev:1.17 (1.6%) stddev-sans-first:1.24 17:26:37 INFO - PROCESS | 13300 | Values: 74.0 76.0 73.0 74.0 75.0 73.0 75.0 76.0 75.0 73.0 17:26:37 INFO - PROCESS | 13300 | 17:26:37 INFO - PROCESS | 13300 | [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:117.50 stddev:8.60 (7.3%) stddev-sans-first:9.08 17:26:37 INFO - PROCESS | 13300 | Values: 122.0 119.0 113.0 114.0 116.0 113.0 114.0 116.0 139.0 130.0 17:26:37 INFO - PROCESS | 13300 | 17:26:37 INFO - PROCESS | 13300 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:167.50 stddev:5.02 (3.0%) stddev-sans-first:5.16 17:26:37 INFO - PROCESS | 13300 | Values: 168.0 159.0 169.0 167.0 161.0 160.0 160.0 168.0 173.0 160.0 17:26:37 INFO - PROCESS | 13300 | 17:26:37 INFO - PROCESS | 13300 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:2.00 (2.9%) stddev-sans-first:2.11 17:26:37 INFO - PROCESS | 13300 | Values: 69.0 68.0 73.0 68.0 70.0 68.0 67.0 67.0 67.0 66.0 17:26:37 INFO - PROCESS | 13300 | -------- Summary: end -------- 17:26:37 INFO - PROCESS | 13300 | 17:26:38 INFO - TEST-INFO | 13300: exit 0 17:26:38 INFO - TEST-OK | kraken | took 60503ms 17:26:38 INFO - SUITE-END | took 1169s 17:26:39 INFO - Completed test suite (00:19:30) 17:26:39 INFO - javascript benchmark 17:26:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3356.647552007039, 3384.8646054157834, 3390.627031026587, 3410.5736782902136, 3433.7596368254226, 5502.752376143073, 5528.0, 5535.446455354472, 5552.500274975251, 5554.305711786022, 5508.586855985807, 5533.750981205845, 5551.750171242294, 5556.055470570002, 5566.693831839248, 5017.147084995559, 5079.136546787036, 5106.157484015133, 5113.207452844815, 5113.718745468997, 4984.75076246188, 5027.874303142414, 5054.41874184468, 5067.5185857343495, 5140.203268493389, 5069.188929771238, 5125.282460455539, 5134.948650513503, 5155.3040339554245, 5168.457311982244, 5127.897442051157, 5130.358705161855, 5140.074786538403, 5144.4083930348115, 5174.0, 4959.8016079356785, 4969.031038947407, 5041.369828771403, 5079.466656001104, 5119.66722163062, 5386.67679939201, 5388.137897936312, 5398.811041613525, 5409.810656627039, 5430.0, 5822.155787410844, 5843.0, 5854.18041474194, 5858.648481091148, 5864.530837532987, 5843.211166492511, 5850.297964244275, 5866.354700982888, 5928.881422371528, 5949.0, 5597.692126933017, 5640.2667653205235, 5645.830625081254, 5648.717564121777, 5654.321481422215, 6019.247594050744, 6038.184845045863, 6045.697715114226, 6046.516278697693, 6046.546509011841, 5744.167095771089, 5786.594938354275, 5827.184194212814, 5828.504577110908, 5864.824055278348, 5801.7099145042575, 5855.209546711139, 5857.88284234313, 5862.179294898718, 5863.824085277449, 5715.657060576379, 5805.6806875621405, 5814.854628634318, 5819.912701309484, 5828.854278643068, 5871.060630299132, 5877.500412464903, 5938.228030356113, 5948.167256584082, 5967.850803729942, 4474.418325617649, 4506.211413002711, 4515.932261016087, 4528.728276303433, 4529.048899731028, 3983.42240375144, 3986.7009974252046, 4066.4916885389325, 4067.918641627151, 4083.1221287423346, 5633.549316054706, 5642.322921249476, 5644.915326270109, 5674.375818659944, 5680.40355762639, 5829.795957141479, 5839.591228614041, 5847.6783776891825, 5856.414358564195, 5887.882242355129, 5594.580406469531, 5603.3836278009385, 5610.803621873215, 5615.18579805934, 5732.455416735404, 5070.087384270793, 5071.366079240095, 5074.923876141861, 5075.390953085654, 5106.923396149061, 6072.210612620331, 6109.969450152721, 6114.11345354921, 6129.570930034944, 6137.539684523678, 5908.615939963888, 5909.261342332208, 5923.378045305181, 6007.519398448027, 6074.757009719562, 6062.151298818081, 6067.180930574316, 6069.666168360783, 6070.696465176635, 6099.207103076572, 5726.198332233574, 5736.4263573643975, 5737.139429085503, 5738.569607279387, 5769.163471296554, 5820.272465941757, 5837.795677151449, 5938.0, 5990.281166260077, 6029.306629737636, 5691.658500489983, 5692.857678558069, 5696.886062278649, 5702.230198923092, 5707.372189059283, 5677.914831277451, 5685.175649530877, 5714.942850571441, 5716.9142462862255, 5720.74256658443, 5585.525230355465, 5729.713514324184, 5782.277215348082, 5801.912971305349, 5831.679257640701, 5695.572832037531, 5717.628354156966, 5744.4829965303325, 5776.306843178677, 5781.4218578141845, 5628.718564071698, 5684.687342196219, 5689.6586204827845, 5690.203371527907, 5697.7151142443545], "value": 5456.29328666346, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.2155335151169, 673.3165836675778, 675.1931441926897, 729.4674887332244, 744.1368013104798, 39407.2118557629, 40237.59762402375, 40282.194356112894, 40306.59693403065, 40329.19341613166, 43737.343939840925, 44044.55955440445, 44045.7797711011, 44066.559334406644, 44099.0, 8793.95603021984, 8935.419197752126, 8970.910290897073, 8982.955085224565, 8988.056254093324, 8736.51949142797, 8811.823763524726, 8812.515311657888, 8818.426802257865, 8859.468431894074, 9194.770130746718, 9250.768730781718, 9271.443713377184, 9273.443593384418, 9301.581428835718, 9138.588763505659, 9179.954100229523, 9194.586243618985, 9208.49353285569, 9210.907890921071, 9175.128362805523, 9278.1649651531, 9281.953590232073, 9303.627854885797, 9321.0, 43209.35185972213, 43393.132137357075, 43611.12777744459, 43960.0, 43971.34042989358, 3776.9244615107546, 3992.920141597152, 4028.617281358266, 4099.446574712406, 4144.0, 33675.0, 33677.32645347104, 33816.6618333816, 33836.32327353464, 33983.32033359319, 4594.264917613166, 4611.4696809866955, 4648.74431906245, 4678.415198100238, 4747.643926705477, 354261.0, 382576.0, 386675.0, 387952.0, 389584.99999999715, 56873.14690279649, 57234.42765572374, 57320.14019789707, 57336.71331643315, 57382.0, 59568.702156488944, 59665.40334596685, 59917.700411497666, 71281.2871871285, 71970.0, 18405.0, 18550.257989680533, 18575.81424185768, 18635.068246587616, 18640.16119274636, 14396.640083997983, 14398.20809855468, 14446.927765361106, 14517.0, 14532.85467145315, 19405.156510131514, 19646.508837279183, 19875.403737887886, 19922.800771992093, 19945.60108797816, 7585.317321440986, 7655.885161722578, 7665.578393188428, 7714.575698336533, 7989.241022102891, 1030.5877648940334, 1099.4008265495165, 1131.3639220615946, 1131.5813149134872, 1179.339569840892, 28757.85621071881, 30974.380512389627, 31061.0, 31222.843885780425, 31470.842645786626, 1155.8381826544291, 1161.924474909128, 1171.9355435451132, 1202.320688810819, 1204.8192771084232, 16510.17449127563, 16675.0, 16678.33286668544, 16707.749383759252, 16748.58128546796, 529298.0, 534571.0, 877432.0, 893031.0, 900236.0, 62679.686601566704, 63107.0, 64068.35931640717, 64125.0, 64131.67934160299, 1500.2423775993054, 1538.261634415487, 1543.1898253417046, 1550.1861522700672, 1659.2035822805121, 32528.837355814016, 33085.0, 33208.66791332152, 33379.33241335208, 34153.829230853684, 53325.200121997426, 54298.72850635721, 54339.0, 54387.18419223636, 54467.45532544782, 455619.0, 458513.0, 458965.0, 458995.0, 459318.0, 31327.21681957969, 31609.0, 48149.518504815904, 48539.5146048535, 48663.513364867315, 45220.54779452163, 45962.515676761526, 46493.76753116213, 46953.0, 47508.7624561875, 40599.0, 42158.74348060726, 43497.34753978756, 43641.56358436502, 43671.781641092864, 41419.0, 42545.36181957335, 43733.0, 43781.34327985019, 44001.0, 38851.0, 39035.41446878242, 39264.411033833945, 39358.803205983786, 39557.0, 33747.83126084354, 33768.662313377536, 33856.0, 34340.0, 34571.30857382889, 28362.359285070896, 28822.567661484674, 29365.41269174647, 29450.263743406587, 29567.112986610435], "value": 21322.473071402732, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.4487044407051, 427.4613986377164, 429.63481041115034, 437.48595400404525, 438.2330920888445, 18566.164522596482, 19255.518612034688, 19265.518362040955, 20666.68999964998, 21561.892190539063, 12999.220046797198, 13333.599992000256, 17035.233414496346, 20298.0, 20463.18147274111, 5232.398274198468, 5420.376656684472, 5464.644798088111, 5493.862653433676, 5687.232223649817, 5837.970810145944, 5912.733926973275, 5919.37846526115, 5944.316403613597, 5948.910766338487, 5692.658440493563, 5897.616654917438, 5914.792982245623, 5928.3775203603645, 5934.43622855828, 1681.3274690123926, 1687.088971955155, 1694.8474637282704, 1702.0808763267821, 2629.618705287732, 5305.204219367087, 5309.0, 5331.546818520431, 5332.066888294533, 5363.195520671891, 23683.289501314986, 24020.159294424786, 24455.755442445527, 24651.630225546633, 24652.876735616388, 2341.6838726772007, 2477.6159695247084, 2481.305234534333, 2579.9097031603806, 2640.4983053219826, 10095.192384609214, 10334.173266138767, 10365.378077315385, 10383.480825958748, 10766.138708903269, 1908.2557802457052, 1990.870593411438, 2021.3935819254166, 2027.3512476007684, 2073.1085633177727, 83332.58333708292, 85466.57266713689, 86234.0, 88295.0, 89781.0, 11531.365774882293, 11668.124890633237, 11808.76382472363, 11817.350045747395, 11954.163208575315, 16952.152392380332, 17081.48755537336, 17083.0, 17111.0, 17119.0, 9084.81830363389, 9153.17621414076, 9157.908420915706, 9236.5843537041, 9369.672061477815, 9028.413153145024, 9042.728718138467, 9081.818363632823, 9094.36339456245, 9130.178283954343, 5150.562202212779, 5166.3800343958965, 5200.427952925175, 5222.582193424517, 5246.711430871339, 2114.312848324301, 2123.607132680459, 2125.8830764307804, 2192.901319440629, 2231.787980141884, 970.7330484116924, 1053.6470282455464, 1074.6722249713912, 1108.634150730257, 1130.1862658885589, 19581.90209048974, 19847.60304793896, 19905.303314383927, 19962.401127966183, 20238.595228095357, 1102.5193315041158, 1120.8374785656035, 1130.949107290174, 1139.145640769423, 1183.7454947186395, 11150.832737508943, 11669.183157178915, 11693.298402095901, 11710.76578468426, 11728.76542469163, 482595.0, 495455.0, 498448.0, 502309.0, 503551.0, 92304.53847730852, 93549.53225233966, 94881.5255923716, 96296.0, 96394.51802741081, 1134.665273744231, 1139.2708666453477, 1144.9141314401454, 1160.22265082395, 1168.7253495428567, 17424.390146344816, 18006.459806205836, 18021.1890464932, 18032.549186270448, 18353.449396518125, 38743.22513549657, 40216.79891600523, 40737.79631101825, 41438.171236575705, 41529.58470415378, 57757.0, 57791.71104144453, 58102.4189758097, 58217.4178258212, 58533.4146658528, 9350.0, 9428.10433008863, 9450.243980481682, 9457.29070319715, 9532.0, 11651.941740291244, 13638.0, 13950.372233249731, 13999.650008749863, 14380.28098595045, 11580.710482238012, 12445.937770311091, 12565.371731413576, 12609.621711348675, 12680.809787853004, 11679.708007299545, 11831.704207394883, 11844.0, 12088.879111208775, 12670.049746268882, 11672.941635291769, 11768.411579421167, 12513.749725005267, 12715.427805748948, 12765.808512872129, 8706.869396959177, 9263.351565390358, 9435.905640943503, 9469.10043545862, 9528.95235523818, 10926.672199834018, 11602.47788849487, 11627.302361858316, 11654.41727913584, 11795.351255680676], "value": 9354.407986158085, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1615.8626516746076, 1629.103992803958, 1896.5258685328668, 1988.3040935672525, 1999.290251960553, 7690.8846367304395, 8517.446365986207, 8595.31237501, 8775.297976161908, 8806.559672016405, 8108.027036755583, 8238.382121340894, 8282.91717082829, 8431.70489032884, 8505.957470212656, 2477.9380515487123, 2491.7134529529153, 2492.763187497194, 2506.448581312108, 2521.369657585604, 2429.5626787178303, 2530.468601593658, 2530.5571524983147, 2543.55487789637, 2545.2745967399296, 2466.8149888758417, 2469.061756532524, 2487.5398051360557, 2496.9375765605823, 2497.3756560859783, 2482.8758562072003, 2495.9376015599664, 2496.950060998788, 2497.425592113824, 2499.4376265340334, 2490.601503759408, 2497.475530138673, 2506.6240063990367, 2528.582783840664, 2530.253575195322, 8791.64833406663, 8845.469271843709, 8861.335399844973, 8864.689735859214, 8865.911340886638, 5517.36550296717, 5663.915041274384, 5699.658020518782, 5708.486236238717, 5714.314282286111, 3598.838052287653, 3613.2050948791225, 3627.5102861113673, 3758.3047136279874, 3777.1501412182315, 1229.932353720545, 1257.7673130470891, 1277.948882044717, 1278.9808152877715, 1279.0535004096994, 12431.254124752453, 12527.498900043987, 12540.310282934435, 12541.623751287476, 12563.874361256361, 4664.813407463731, 4719.858404247878, 4754.334393184957, 4792.185328494164, 4822.42130944289, 9987.600495980225, 10007.699769006942, 10037.0, 10042.598296068076, 10067.59729610822, 5518.475744804317, 5518.724063796794, 5535.501804837584, 5539.889202215933, 5548.86127846799, 4442.977785111054, 4943.060818444484, 4992.750362481861, 5060.620453466005, 5120.206368012964, 4022.0950286185375, 4074.1851629673592, 4102.200070986189, 4107.137501124737, 4214.978925105354, 1269.0862578943147, 1291.6383412644475, 1292.6380613428255, 1298.8766067223598, 1302.4594793160923, 1089.0742868561658, 1090.2368342160362, 1091.792559413709, 1094.179365475893, 1099.0657940750298, 6082.75668973245, 6098.69506524672, 6151.84620384494, 6162.106494558264, 6180.876382472416, 445.65907081083, 447.47421779409063, 451.1833581218006, 500.7496251874063, 502.6757741256942, 4197.643200327945, 4312.310030395121, 4341.978290108593, 4422.491413487426, 4457.665675074382, 10528.052475277109, 10728.570857165781, 10813.0, 10845.566177352976, 10856.294340867977, 10552.577896884191, 10557.0, 10576.682699519026, 10581.84127238092, 10617.044465998097, 7900.920990790133, 8159.265666089962, 8162.714304999416, 8323.500589964622, 8328.625211865481, 5987.700614969322, 6047.365026672312, 6054.061620448838, 6136.018237082046, 6150.923588372107, 9023.0, 9204.49375284339, 9310.208632266333, 9316.0, 9385.15533601979, 9275.489848058422, 9313.068693130634, 9444.905550944402, 9451.385659932082, 9546.997565255826, 7628.694852205849, 7695.0, 7712.344450721752, 7759.72840950564, 7806.219378062148, 8399.328053755562, 8422.5788710563, 8450.070492245972, 8464.026636936831, 8490.59905115649, 7488.663010164447, 7630.542167469969, 7712.537247764928, 7880.605969701377, 7883.408744344082, 7534.510256833289, 7696.384289256734, 7792.6103694816165, 7817.570033648204, 7856.37149028065, 7315.890261645973, 7393.07586551681, 7400.074990626172, 7428.294312040348, 7453.807390817443, 5427.402985671494, 5506.476884696108, 5539.418361072029, 5583.581231407742, 5617.775288988395, 5621.494065534122, 5636.21093046982, 5652.830415087554, 5757.050086735641, 5775.0], "value": 4697.537592780865, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.90616439725665, 364.60258318432903, 368.1055036261884, 373.3764613096129, 374.1525444867375, 6421.807345779628, 6448.838779030527, 6532.020196970445, 6535.901961470576, 6650.368215019577, 6431.614103153803, 6558.573692709971, 6581.407673309413, 6587.53887227893, 6589.868202635945, 4902.264660300957, 4996.625253106014, 5002.1746411842005, 5009.223570346584, 5012.72430016349, 4983.252512123175, 4993.825216117437, 4994.4506104328675, 4994.825181118662, 5011.198208286675, 4922.064807686528, 4923.8276660316715, 4948.653594248404, 4949.109160351135, 4957.975210123945, 4957.900841983176, 4965.776540055688, 4969.130402179622, 5021.69869807809, 5043.167877300241, 4447.5552444755585, 4448.243798554254, 4459.44256967879, 4459.843905463294, 4461.5315391883705, 6086.969565152146, 6270.216222972129, 6335.904961425582, 6353.0152826312, 6355.936440635627, 5710.2576665033275, 5734.770609175628, 5756.251687280626, 5761.876434095353, 5779.768809247625, 6968.616726080114, 6991.196012458581, 6992.440604751608, 7004.789856304319, 7028.753993610199, 4926.704397736147, 4926.950730492685, 4930.235813448921, 4932.309476673268, 4955.554000140005, 7234.529755565872, 7300.12398512182, 7314.451416143757, 7317.231690672456, 7324.08448943882, 4957.454679985199, 5042.294078828967, 5049.697018178921, 5061.063703214917, 5066.265391518209, 5113.795448182031, 5116.8209112681625, 5122.897542049138, 5127.794888204505, 5128.307678463434, 5660.235868157746, 5781.959247335436, 5798.855028624318, 5843.912341314884, 5850.678212698257, 7058.647067646597, 7075.363217310467, 7082.114735658043, 7093.361597456254, 7105.076340075757, 1786.8927864328182, 1815.019889259785, 1815.4190658988996, 1818.1818181818235, 1820.526663067612, 1183.5620820296544, 1201.285235285004, 1208.8730683278304, 1209.1838009343658, 1225.9754804903853, 6846.144231971004, 6858.3827455529245, 6858.931410685829, 6859.862802744017, 6860.3139686031, 7263.237360077222, 7296.343329100407, 7297.562146271241, 7318.975343451921, 7331.560106393634, 6785.389314961579, 6822.113125293779, 6841.486888483384, 6845.14435695538, 6849.383555479931, 3824.541055073353, 3885.4171874218528, 3927.509061367329, 3927.7250592458254, 3934.2918274710255, 7563.243675632392, 7592.544447333178, 7598.8100297493, 7612.733554325572, 7620.085589729268, 7422.703091876372, 7462.813429664302, 7473.813154671177, 7478.326950574475, 7494.775156745306, 7601.467897247139, 7660.655270512729, 7674.731384401519, 7675.15573286938, 7681.7695469136015, 7178.3898368637165, 7261.346478816932, 7301.926980730337, 7305.3425191732995, 7316.268373162641, 7138.750143744944, 7156.0, 7159.140903091454, 7175.784726458214, 7208.0, 7573.242675732383, 7683.577403242875, 7685.615719214129, 7694.807629809299, 7694.884576731465, 4783.091212669582, 4832.637552183671, 4836.564709176191, 4839.758012099452, 4850.1997170466475, 6979.651017449006, 7230.530015548972, 7231.240719724353, 7234.674439650334, 7238.059052323164, 6998.055262539696, 7022.719091236498, 7026.648667566704, 7055.2944705529035, 7056.1179852518435, 6964.860702786017, 7038.0, 7040.577565346096, 7044.682989265598, 7044.9432585112645, 6875.724971001104, 6876.243613202644, 6921.411680007256, 6933.064036355229, 6955.965220173866, 6918.481113916577, 7062.788116356517, 7077.68150433242, 7082.397996170177, 7102.218755936739, 6820.31796820314, 6863.725450982104, 6868.931310686829, 6876.793696189123, 6885.51801373899], "value": 5301.950477743172, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.7738017284902, 792.4967645545078, 808.7331180710366, 859.9613017414212, 878.7978764884073, 14724.77912831307, 14903.18032508213, 14980.250987450625, 14992.850071499282, 15016.174110423923, 14334.71330573388, 14342.067765595255, 14412.567622971328, 14424.78362824556, 14438.927805360985, 902.7652810269344, 912.3066469483191, 936.8220038192756, 939.7086903060073, 940.7459985803829, 931.1479995803832, 935.504182783126, 936.5832204668925, 937.0348541002778, 938.6057855700623, 988.184747583243, 988.8368419210858, 989.8218320702271, 990.5146478225689, 992.93545919515, 982.2142286171035, 983.4492684096929, 984.0307297312141, 984.2667212926344, 985.6993616946828, 719.5143278287135, 721.743780957763, 724.655788500458, 725.7858931615133, 727.2000799120977, 14993.100413975088, 15040.623984400368, 15061.698766024618, 15063.924680376638, 15156.0, 14766.0, 14848.703025939421, 14860.331285092198, 14873.47942822007, 14888.62778430537, 11515.039675216836, 11602.187846850724, 11628.592999245071, 11700.122490813137, 11877.643670689893, 3917.8824635260703, 3953.743006704584, 4022.0146064214455, 4074.388841673743, 4077.7553346799286, 59742.40257597412, 59871.0, 60322.698386507785, 60503.39496605022, 60734.696326518526, 11449.885501145049, 11516.0, 11652.708682283012, 11710.297382157098, 11913.583024594098, 19418.61162776765, 19887.60224795496, 20090.296839610837, 20126.0, 20172.0, 8654.091320411391, 8708.477491350539, 8891.110888911056, 9013.278937685101, 9073.546322683971, 4880.097182021337, 4913.729744863996, 4928.28539861718, 4952.90094198114, 4999.525045120708, 3687.8340474678703, 3707.277080969185, 3715.1826598148364, 3717.628237176261, 3719.4420836874683, 655.8884989551788, 656.1633916756174, 659.864727730814, 670.9597424154566, 675.2774531251612, 783.2480818414272, 844.2907957315884, 852.261426468823, 854.0050840770433, 876.2595606712318, 9942.403455792675, 9979.501024948724, 10235.488225588691, 10255.58977640901, 10374.22193335503, 823.6952327638692, 824.9917500825035, 848.7708318753902, 853.9701110461104, 860.642833224205, 4785.449673287617, 4836.879078023077, 4878.146324393288, 4878.609711223094, 4935.063637135899, 62080.0, 63773.0, 63789.0, 63868.68065659642, 63955.680221598595, 55750.16374754382, 56305.0, 56357.43642563522, 56781.71609141928, 56943.43056569464, 49971.500284996684, 50319.0, 51540.45378638647, 51580.22629660558, 52859.471405286225, 9392.154706076486, 9776.462294573867, 9896.257780666334, 9921.0, 9982.500874956078, 37275.81362093172, 37960.62039379571, 38411.039724007125, 38559.42160867533, 38598.0, 42964.0, 47865.28202076902, 48130.0, 48719.75640121777, 48881.5111848877, 11187.272827266203, 11834.704132396415, 11996.0, 12044.578439754567, 12060.51757929673, 13322.600321990356, 13875.79186312186, 14024.439022439396, 14216.857831421967, 15158.24208789534, 13059.412326445523, 13127.081104322606, 13395.263260520765, 13547.187168769906, 13888.861111388756, 12919.354032298535, 13052.738945221232, 13074.150180238254, 13620.591382258151, 13721.382537786023, 12192.75614487723, 12442.502299907903, 12478.188917720683, 12754.170978886343, 12971.870281297066, 11182.440877955907, 11192.272502287326, 11262.605808796652, 11331.490082946451, 11508.53965841357, 11154.776904461703, 11167.0, 11202.934814032353, 11283.66149015531, 11310.303454481564], "value": 7246.74393660671, "unit": "score"}], "name": "dromaeo_css", "value": 7624.415527972848, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 103.0, 110.0, 111.0, 111.0, 102.0, 109.0, 113.0, 111.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 157.0, 180.0, 131.0, 159.0, 154.0, 124.0, 171.0, 125.0], "value": 147.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 162.0, 165.0, 161.0, 163.0, 161.0, 164.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 76.0, 167.0, 74.0, 73.0, 76.0, 73.0, 168.0, 78.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 148.0, 92.0, 93.0, 92.0, 142.0, 92.0, 92.0, 158.0], "value": 109.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 116.0, 116.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 146.0, 148.0, 148.0, 145.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 59.0, 61.0, 59.0, 61.0, 61.0, 76.0, 56.0, 57.0], "value": 60.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 57.0, 57.0, 58.0, 57.0, 64.0, 58.0, 58.0, 58.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 73.0, 74.0, 75.0, 73.0, 75.0, 76.0, 75.0, 73.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 119.0, 113.0, 114.0, 116.0, 113.0, 114.0, 116.0, 139.0, 130.0], "value": 119.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 159.0, 169.0, 167.0, 161.0, 160.0, 160.0, 168.0, 173.0, 160.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 73.0, 68.0, 70.0, 68.0, 67.0, 67.0, 67.0, 66.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1526.3, "alertThreshold": 2.0}]} 17:26:39 INFO - Return code: 0 17:26:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:26:39 ERROR - # TBPL SUCCESS # 17:26:39 INFO - Running post-action listener: _resource_record_post_action 17:26:39 INFO - Running post-run listener: _resource_record_post_run 17:26:40 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 385024; Write bytes: 221102080; Read time: 124; Write time: 127264 17:26:40 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 5189632; Read time: 0; Write time: 464 17:26:40 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 385024; Write bytes: 215912448; Read time: 124; Write time: 126800 17:26:40 INFO - Running post-run listener: _upload_blobber_files 17:26:40 INFO - Blob upload gear active. 17:26:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:26:40 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:26:40 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:26:40 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:26:40 INFO - (blobuploader) - INFO - Open directory for files ... 17:26:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:26:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:26:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:26:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:26:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:26:41 INFO - (blobuploader) - INFO - Done attempting. 17:26:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:26:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:26:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:26:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:26:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:26:42 INFO - (blobuploader) - INFO - Done attempting. 17:26:42 INFO - (blobuploader) - INFO - Iteration through files over. 17:26:42 INFO - Return code: 0 17:26:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:26:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:26:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ca517a28fe8f54b7a86b2a3a65592b3ef1874e470ca8cda0633aca9c7a250ef28aa7f31f95c46495aa8eea7b5ef19130adea374c8a05000f4952d17e51558879", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/139ee553225a2a2c4d633f992c839e23fd76b9be59511e92c35ad5c3f6de02dbe7378b38cd8f4913922793d07037b8d2fa47c4a261318313a998a8941c7096f6"} 17:26:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:26:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:26:42 INFO - Contents: 17:26:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ca517a28fe8f54b7a86b2a3a65592b3ef1874e470ca8cda0633aca9c7a250ef28aa7f31f95c46495aa8eea7b5ef19130adea374c8a05000f4952d17e51558879", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/139ee553225a2a2c4d633f992c839e23fd76b9be59511e92c35ad5c3f6de02dbe7378b38cd8f4913922793d07037b8d2fa47c4a261318313a998a8941c7096f6"} 17:26:42 INFO - Running post-run listener: copy_logs_to_upload_dir 17:26:42 INFO - Copying logs to upload dir... 17:26:42 INFO - mkdir: /builds/slave/test/build/upload/logs 17:26:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.409103 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-06-08 17:26:42.531418) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 17:26:42.534956) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668 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/ca517a28fe8f54b7a86b2a3a65592b3ef1874e470ca8cda0633aca9c7a250ef28aa7f31f95c46495aa8eea7b5ef19130adea374c8a05000f4952d17e51558879", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/139ee553225a2a2c4d633f992c839e23fd76b9be59511e92c35ad5c3f6de02dbe7378b38cd8f4913922793d07037b8d2fa47c4a261318313a998a8941c7096f6"} build_url:https://queue.taskcluster.net/v1/task/JsVbPEdOQTW9IpxP7bkUow/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011251 build_url: 'https://queue.taskcluster.net/v1/task/JsVbPEdOQTW9IpxP7bkUow/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/ca517a28fe8f54b7a86b2a3a65592b3ef1874e470ca8cda0633aca9c7a250ef28aa7f31f95c46495aa8eea7b5ef19130adea374c8a05000f4952d17e51558879", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/139ee553225a2a2c4d633f992c839e23fd76b9be59511e92c35ad5c3f6de02dbe7378b38cd8f4913922793d07037b8d2fa47c4a261318313a998a8941c7096f6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 17:26:42.565629) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:26:42.566421) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1465430776.471158-1966481668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 17:26:42.652019) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 17:26:42.652889) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 17:26:42.653639) ========= ========= Total master_lag: 0.20 =========