builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1461855695.78 results: success (0) buildid: 20160428045211 builduid: 1bd39b36d92a4286987c24b728568253 revision: 7d48a5e12f18fe69f08cc46043a1d8ed64277ee5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 08:01:35.777459) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 08:01:35.777854) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 08:01:35.778137) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 08:01:35.794563) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:01:35.794828) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-28 08:01:35-- 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% 42.9M=0s 2016-04-28 08:01:36 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123573 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:01:35.931464) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:01:35.931826) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019343 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:01:35.987895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:01:35.988240) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7d48a5e12f18fe69f08cc46043a1d8ed64277ee5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 7d48a5e12f18fe69f08cc46043a1d8ed64277ee5 --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=934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-28 08:01:36,218 truncating revision to first 12 chars 2016-04-28 08:01:36,219 Setting DEBUG logging. 2016-04-28 08:01:36,219 attempt 1/10 2016-04-28 08:01:36,219 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7d48a5e12f18?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 08:01:36,474 unpacking tar archive at: fx-team-7d48a5e12f18/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532592 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:01:36.533219) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 08:01:36.533512) ========= script_repo_revision: 7d48a5e12f18fe69f08cc46043a1d8ed64277ee5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 08:01:36.533894) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 08:01:36.534169) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 08:01:36.545305) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-28 08:01:36.545579) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:01:36 INFO - MultiFileLogger online at 20160428 08:01:36 in /builds/slave/test 08:01:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:01:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:01:36 INFO - {'append_to_log': False, 08:01:36 INFO - 'base_work_dir': '/builds/slave/test', 08:01:36 INFO - 'blob_upload_branch': 'Fx-Team', 08:01:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:01:36 INFO - 'branch': 'Fx-Team', 08:01:36 INFO - 'buildbot_json_path': 'buildprops.json', 08:01:36 INFO - 'config_files': ('talos/linux_config.py',), 08:01:36 INFO - 'default_actions': ('clobber', 08:01:36 INFO - 'read-buildbot-config', 08:01:36 INFO - 'download-and-extract', 08:01:36 INFO - 'populate-webroot', 08:01:36 INFO - 'create-virtualenv', 08:01:36 INFO - 'install', 08:01:36 INFO - 'run-tests'), 08:01:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:01:36 INFO - 'download_minidump_stackwalk': True, 08:01:36 INFO - 'download_symbols': 'ondemand', 08:01:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:01:36 INFO - 'tooltool.py': '/tools/tooltool.py', 08:01:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:01:36 INFO - '/tools/misc-python/virtualenv.py')}, 08:01:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:01:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:01:36 INFO - 'installer_path': 'installer.exe', 08:01:36 INFO - 'log_level': 'info', 08:01:36 INFO - 'log_name': 'talos', 08:01:36 INFO - 'log_to_console': True, 08:01:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:01:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:01:36 INFO - 'opt_config_files': (), 08:01:36 INFO - 'pip_index': False, 08:01:36 INFO - 'sps_profile': False, 08:01:36 INFO - 'sps_profile_interval': 0, 08:01:36 INFO - 'suite': 'dromaeojs-e10s', 08:01:36 INFO - 'system_bits': '32', 08:01:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:01:36 INFO - 'title': 'talos-linux64-ix-057', 08:01:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:01:36 INFO - 'use_talos_json': True, 08:01:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:01:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:01:36 INFO - 'work_dir': 'build'} 08:01:36 INFO - ##### 08:01:36 INFO - ##### Running clobber step. 08:01:36 INFO - ##### 08:01:36 INFO - Running pre-action listener: _resource_record_pre_action 08:01:36 INFO - Running main action method: clobber 08:01:36 INFO - rmtree: /builds/slave/test/build 08:01:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:01:37 INFO - Running post-action listener: _resource_record_post_action 08:01:37 INFO - ##### 08:01:37 INFO - ##### Running read-buildbot-config step. 08:01:37 INFO - ##### 08:01:37 INFO - Running pre-action listener: _resource_record_pre_action 08:01:37 INFO - Running main action method: read_buildbot_config 08:01:37 INFO - Using buildbot properties: 08:01:37 INFO - { 08:01:37 INFO - "project": "", 08:01:37 INFO - "product": "firefox", 08:01:37 INFO - "script_repo_revision": "production", 08:01:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:01:37 INFO - "repository": "", 08:01:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:01:37 INFO - "buildid": "20160428045211", 08:01:37 INFO - "pgo_build": "True", 08:01:37 INFO - "basedir": "/builds/slave/test", 08:01:37 INFO - "buildnumber": 421, 08:01:37 INFO - "slavename": "talos-linux64-ix-057", 08:01:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:01:37 INFO - "platform": "ubuntu64_hw", 08:01:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:01:37 INFO - "branch": "fx-team", 08:01:37 INFO - "repo_path": "integration/fx-team", 08:01:37 INFO - "revision": "7d48a5e12f18fe69f08cc46043a1d8ed64277ee5", 08:01:37 INFO - "stage_platform": "linux64-pgo", 08:01:37 INFO - "builduid": "1bd39b36d92a4286987c24b728568253", 08:01:37 INFO - "slavebuilddir": "test" 08:01:37 INFO - } 08:01:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:01:37 INFO - Running post-action listener: _resource_record_post_action 08:01:37 INFO - ##### 08:01:37 INFO - ##### Running download-and-extract step. 08:01:37 INFO - ##### 08:01:37 INFO - Running pre-action listener: _resource_record_pre_action 08:01:37 INFO - Running main action method: download_and_extract 08:01:37 INFO - mkdir: /builds/slave/test/build/tests 08:01: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')]} 08:01:37 INFO - https://queue.taskcluster.net/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:01:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:01:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:01:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:01:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:01:39 INFO - Downloaded 1361 bytes. 08:01:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:01:39 INFO - Using the following test package requirements: 08:01:39 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:01:39 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:01:39 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:01:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:39 INFO - u'jsshell-linux-x86_64.zip'], 08:01:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:01:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:01:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:01:39 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:01:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:01:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:01:39 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:01:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:39 INFO - https://queue.taskcluster.net/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:01:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:01:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:01:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:01:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:01:41 INFO - Downloaded 23860699 bytes. 08:01:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:01:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:01:42 INFO - Return code: 0 08:01:42 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:01:42 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')]} 08:01:42 INFO - https://queue.taskcluster.net/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:01:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:01:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:01:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:01:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:01:49 INFO - Downloaded 23860699 bytes. 08:01:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:01:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:01:50 INFO - Return code: 0 08:01:50 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')]} 08:01:50 INFO - https://queue.taskcluster.net/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:01:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:01:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:01:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:01:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:01:51 INFO - Downloaded 10840145 bytes. 08:01:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:01:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:01:52 INFO - Return code: 0 08:01:52 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')]} 08:01:52 INFO - https://queue.taskcluster.net/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:01:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:01:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:01:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:01:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:01:53 INFO - Downloaded 58357448 bytes. 08:01:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:01:53 INFO - mkdir: /builds/slave/test/properties 08:01:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:01:53 INFO - Writing to file /builds/slave/test/properties/build_url 08:01:53 INFO - Contents: 08:01:53 INFO - build_url:https://queue.taskcluster.net/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:01:54 INFO - Running post-action listener: _resource_record_post_action 08:01:54 INFO - Running post-action listener: set_extra_try_arguments 08:01:54 INFO - ##### 08:01:54 INFO - ##### Running populate-webroot step. 08:01:54 INFO - ##### 08:01:54 INFO - Running pre-action listener: _resource_record_pre_action 08:01:54 INFO - Running main action method: populate_webroot 08:01:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:01:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:01:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:01:54 INFO - '--tppagecycles', 08:01:54 INFO - '7'], 08:01:54 INFO - 'tests': ['tsvgm']}}, 08:01:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:01:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:01:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:01:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:01:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:01:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:01:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:54 INFO - 'talos_options': ['--disable-e10s'], 08:01:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:01:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:01:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:54 INFO - 'talos_options': ['--disable-e10s'], 08:01:54 INFO - 'tests': ['damp', 'tps']}, 08:01:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:54 INFO - 'tests': ['damp', 'tps']}, 08:01:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:01:54 INFO - 'tests': ['dromaeo_dom']}, 08:01:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:01:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:01:54 INFO - 'tests': ['a11yr', 08:01:54 INFO - 'ts_paint', 08:01:54 INFO - 'tpaint', 08:01:54 INFO - 'sessionrestore', 08:01:54 INFO - 'sessionrestore_no_auto_restore', 08:01:54 INFO - 'tabpaint']}, 08:01:54 INFO - 'other-e10s': {'tests': ['a11yr', 08:01:54 INFO - 'ts_paint', 08:01:54 INFO - 'tpaint', 08:01:54 INFO - 'sessionrestore', 08:01:54 INFO - 'sessionrestore_no_auto_restore', 08:01:54 INFO - 'tabpaint']}, 08:01:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:01:54 INFO - 'ts_paint', 08:01:54 INFO - 'tpaint', 08:01:54 INFO - 'sessionrestore', 08:01:54 INFO - 'sessionrestore_no_auto_restore', 08:01:54 INFO - 'tabpaint']}, 08:01:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:01:54 INFO - 'ts_paint', 08:01:54 INFO - 'tpaint', 08:01:54 INFO - 'sessionrestore', 08:01:54 INFO - 'sessionrestore_no_auto_restore', 08:01:54 INFO - 'tabpaint']}, 08:01:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:01:54 INFO - 'tests': ['a11yr', 08:01:54 INFO - 'ts_paint', 08:01:54 INFO - 'tpaint', 08:01:54 INFO - 'sessionrestore', 08:01:54 INFO - 'sessionrestore_no_auto_restore', 08:01:54 INFO - 'tabpaint']}, 08:01:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:01:54 INFO - 'tests': ['a11yr', 08:01:54 INFO - 'ts_paint', 08:01:54 INFO - 'tpaint', 08:01:54 INFO - 'sessionrestore', 08:01:54 INFO - 'sessionrestore_no_auto_restore', 08:01:54 INFO - 'tabpaint']}, 08:01:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:01:54 INFO - 'tests': ['tsvgx', 08:01:54 INFO - 'tsvgr_opacity', 08:01:54 INFO - 'tart', 08:01:54 INFO - 'tscrollx', 08:01:54 INFO - 'cart']}, 08:01:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:01:54 INFO - 'tsvgr_opacity', 08:01:54 INFO - 'tart', 08:01:54 INFO - 'tscrollx', 08:01:54 INFO - 'cart']}, 08:01:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:54 INFO - 'talos_options': ['--disable-e10s'], 08:01:54 INFO - 'tests': ['tp5o']}, 08:01:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:54 INFO - 'tests': ['tp5o']}, 08:01:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:54 INFO - 'talos_options': ['--disable-e10s', 08:01:54 INFO - '--xperf_path', 08:01:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:01:54 INFO - 'tests': ['tp5n']}, 08:01:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:01:54 INFO - 'talos_options': ['--xperf_path', 08:01:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:01:54 INFO - 'tests': ['tp5n']}}, 08:01:54 INFO - 'talos.zip': {'path': '', 08:01:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:01:54 INFO - Running post-action listener: _resource_record_post_action 08:01:54 INFO - ##### 08:01:54 INFO - ##### Running create-virtualenv step. 08:01:54 INFO - ##### 08:01:54 INFO - Running pre-action listener: _resource_record_pre_action 08:01:54 INFO - Running main action method: create_virtualenv 08:01:54 INFO - Creating virtualenv /builds/slave/test/build/venv 08:01:54 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 08:01:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:01:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:01:54 INFO - Using real prefix '/usr' 08:01:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:01:54 INFO - Installing distribute.............................................................................................................................................................................................done. 08:01:56 INFO - Installing pip.................done. 08:01:56 INFO - Return code: 0 08:01:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3c73216f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c57410>, '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 0x1c58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c587a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907', '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 08:01:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:01:56 INFO - Using env: {'DISPLAY': ':0', 08:01:56 INFO - 'HOME': '/home/cltbld', 08:01:56 INFO - 'LANG': 'en_US.UTF-8', 08:01:56 INFO - 'LANGUAGE': 'en_US:en', 08:01:56 INFO - 'LOGNAME': 'cltbld', 08:01:56 INFO - 'MAIL': '/var/mail/cltbld', 08:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:56 INFO - 'MOZ_NO_REMOTE': '1', 08:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:56 INFO - 'NO_EM_RESTART': '1', 08:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:56 INFO - 'PWD': '/builds/slave/test', 08:01:56 INFO - 'SHELL': '/bin/bash', 08:01:56 INFO - 'SHLVL': '1', 08:01:56 INFO - 'TERM': 'linux', 08:01:56 INFO - 'TMOUT': '86400', 08:01:56 INFO - 'USER': 'cltbld', 08:01:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907', 08:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:56 INFO - '_': '/tools/buildbot/bin/python'} 08:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:57 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 08:01:57 INFO - Cleaning up... 08:01:57 INFO - Return code: 0 08:01:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:01:57 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')]} 08:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:57 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')]} 08:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:57 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 0x7f3c73216f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c57410>, '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 0x1c58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c587a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907', '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 08:01:57 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 08:01:57 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 08:01:57 INFO - Using env: {'DISPLAY': ':0', 08:01:57 INFO - 'HOME': '/home/cltbld', 08:01:57 INFO - 'LANG': 'en_US.UTF-8', 08:01:57 INFO - 'LANGUAGE': 'en_US:en', 08:01:57 INFO - 'LOGNAME': 'cltbld', 08:01:57 INFO - 'MAIL': '/var/mail/cltbld', 08:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:57 INFO - 'MOZ_NO_REMOTE': '1', 08:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:57 INFO - 'NO_EM_RESTART': '1', 08:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:57 INFO - 'PWD': '/builds/slave/test', 08:01:57 INFO - 'SHELL': '/bin/bash', 08:01:57 INFO - 'SHLVL': '1', 08:01:57 INFO - 'TERM': 'linux', 08:01:57 INFO - 'TMOUT': '86400', 08:01:57 INFO - 'USER': 'cltbld', 08:01:57 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907', 08:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:57 INFO - '_': '/tools/buildbot/bin/python'} 08:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:01:57 INFO - Downloading/unpacking psutil>=0.7.1 08:01:57 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 08:01:57 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 08:01:57 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 08:01:57 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 08:01:57 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 08:01:57 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 08:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:01:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:01:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:01:59 INFO - Installing collected packages: psutil 08:01:59 INFO - Running setup.py install for psutil 08:01:59 INFO - building 'psutil._psutil_linux' extension 08:01:59 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 08:01:59 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 08:01:59 INFO - building 'psutil._psutil_posix' extension 08:01:59 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 08:01:59 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 08:01:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:01:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:01:59 INFO - Successfully installed psutil 08:01:59 INFO - Cleaning up... 08:01:59 INFO - Return code: 0 08:01:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:01:59 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')]} 08:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:59 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')]} 08:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:01:59 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 0x7f3c73216f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c57410>, '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 0x1c58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c587a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907', '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 08:01:59 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 08:01:59 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 08:01:59 INFO - Using env: {'DISPLAY': ':0', 08:01:59 INFO - 'HOME': '/home/cltbld', 08:01:59 INFO - 'LANG': 'en_US.UTF-8', 08:01:59 INFO - 'LANGUAGE': 'en_US:en', 08:01:59 INFO - 'LOGNAME': 'cltbld', 08:01:59 INFO - 'MAIL': '/var/mail/cltbld', 08:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:01:59 INFO - 'MOZ_NO_REMOTE': '1', 08:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:01:59 INFO - 'NO_EM_RESTART': '1', 08:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:01:59 INFO - 'PWD': '/builds/slave/test', 08:01:59 INFO - 'SHELL': '/bin/bash', 08:01:59 INFO - 'SHLVL': '1', 08:01:59 INFO - 'TERM': 'linux', 08:01:59 INFO - 'TMOUT': '86400', 08:01:59 INFO - 'USER': 'cltbld', 08:01:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907', 08:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:01:59 INFO - '_': '/tools/buildbot/bin/python'} 08:02:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:02:01 INFO - Installing collected packages: mozsystemmonitor 08:02:01 INFO - Running setup.py install for mozsystemmonitor 08:02:02 INFO - Successfully installed mozsystemmonitor 08:02:02 INFO - Cleaning up... 08:02:02 INFO - Return code: 0 08:02:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:02 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 0x7f3c73216f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c57410>, '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 0x1c58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c587a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907', '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 08:02:02 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 08:02:02 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 08:02:02 INFO - Using env: {'DISPLAY': ':0', 08:02:02 INFO - 'HOME': '/home/cltbld', 08:02:02 INFO - 'LANG': 'en_US.UTF-8', 08:02:02 INFO - 'LANGUAGE': 'en_US:en', 08:02:02 INFO - 'LOGNAME': 'cltbld', 08:02:02 INFO - 'MAIL': '/var/mail/cltbld', 08:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:02 INFO - 'MOZ_NO_REMOTE': '1', 08:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:02 INFO - 'NO_EM_RESTART': '1', 08:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:02 INFO - 'PWD': '/builds/slave/test', 08:02:02 INFO - 'SHELL': '/bin/bash', 08:02:02 INFO - 'SHLVL': '1', 08:02:02 INFO - 'TERM': 'linux', 08:02:02 INFO - 'TMOUT': '86400', 08:02:02 INFO - 'USER': 'cltbld', 08:02:02 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907', 08:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:02 INFO - '_': '/tools/buildbot/bin/python'} 08:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:02 INFO - Downloading/unpacking blobuploader==1.2.4 08:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:04 INFO - Downloading blobuploader-1.2.4.tar.gz 08:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:02:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:02:04 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 08:02:04 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 08:02:04 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 08:02:04 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 08:02:04 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 08:02:04 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 08:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:02:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:02:04 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 08:02:04 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 08:02:04 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 08:02:04 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 08:02:04 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 08:02:04 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 08:02:04 INFO - Downloading docopt-0.6.1.tar.gz 08:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:02:04 INFO - Installing collected packages: blobuploader, requests, docopt 08:02:04 INFO - Running setup.py install for blobuploader 08:02:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:02:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:02:05 INFO - Running setup.py install for requests 08:02:05 INFO - Running setup.py install for docopt 08:02:05 INFO - Successfully installed blobuploader requests docopt 08:02:05 INFO - Cleaning up... 08:02:05 INFO - Return code: 0 08:02:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:05 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 0x7f3c73216f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c57410>, '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 0x1c58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c587a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907', '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 08:02:05 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 08:02:05 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 08:02:05 INFO - Using env: {'DISPLAY': ':0', 08:02:05 INFO - 'HOME': '/home/cltbld', 08:02:05 INFO - 'LANG': 'en_US.UTF-8', 08:02:05 INFO - 'LANGUAGE': 'en_US:en', 08:02:05 INFO - 'LOGNAME': 'cltbld', 08:02:05 INFO - 'MAIL': '/var/mail/cltbld', 08:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:05 INFO - 'MOZ_NO_REMOTE': '1', 08:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:05 INFO - 'NO_EM_RESTART': '1', 08:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:05 INFO - 'PWD': '/builds/slave/test', 08:02:05 INFO - 'SHELL': '/bin/bash', 08:02:05 INFO - 'SHLVL': '1', 08:02:05 INFO - 'TERM': 'linux', 08:02:05 INFO - 'TMOUT': '86400', 08:02:05 INFO - 'USER': 'cltbld', 08:02:05 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907', 08:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:05 INFO - '_': '/tools/buildbot/bin/python'} 08:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:05 INFO - Running setup.py (path:/tmp/pip-lbIrlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:05 INFO - Running setup.py (path:/tmp/pip-OZpEDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:05 INFO - Running setup.py (path:/tmp/pip-XZLHOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:05 INFO - Running setup.py (path:/tmp/pip-2rYFwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:06 INFO - Running setup.py (path:/tmp/pip-EmAYr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:06 INFO - Running setup.py (path:/tmp/pip-PjS0R_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:06 INFO - Running setup.py (path:/tmp/pip-aSFZTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:06 INFO - Running setup.py (path:/tmp/pip-MtkhbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:06 INFO - Running setup.py (path:/tmp/pip-sLUb3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:06 INFO - Running setup.py (path:/tmp/pip-4BH9_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:06 INFO - Running setup.py (path:/tmp/pip-vSLAMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:06 INFO - Running setup.py (path:/tmp/pip-gkxLwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:06 INFO - Running setup.py (path:/tmp/pip-zthlk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:06 INFO - Running setup.py (path:/tmp/pip-n65JfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:06 INFO - Running setup.py (path:/tmp/pip-14E7yH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:06 INFO - Running setup.py (path:/tmp/pip-njAhSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:06 INFO - Running setup.py (path:/tmp/pip-ijYlb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:02:06 INFO - Running setup.py install for manifestparser 08:02:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:02:07 INFO - Running setup.py install for mozcrash 08:02:07 INFO - Running setup.py install for mozdebug 08:02:07 INFO - Running setup.py install for mozdevice 08:02:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:02:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:02:07 INFO - Running setup.py install for mozfile 08:02:07 INFO - Running setup.py install for mozhttpd 08:02:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:02:07 INFO - Running setup.py install for mozinfo 08:02:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:02:07 INFO - Running setup.py install for mozInstall 08:02:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:02:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:02:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:02:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:02:07 INFO - Running setup.py install for mozleak 08:02:07 INFO - Running setup.py install for mozlog 08:02:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:02:07 INFO - Running setup.py install for moznetwork 08:02:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:02:08 INFO - Running setup.py install for mozprocess 08:02:08 INFO - Running setup.py install for mozprofile 08:02:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:02:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:02:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:02:08 INFO - Running setup.py install for mozrunner 08:02:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:02:08 INFO - Running setup.py install for mozscreenshot 08:02:08 INFO - Running setup.py install for moztest 08:02:08 INFO - Running setup.py install for mozversion 08:02:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:02:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:02:08 INFO - Cleaning up... 08:02:08 INFO - Return code: 0 08:02:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:08 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')]} 08:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:08 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')]} 08:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:08 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 0x7f3c73216f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c57410>, '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 0x1c58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c587a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907', '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 08:02:08 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 08:02:08 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 08:02:08 INFO - Using env: {'DISPLAY': ':0', 08:02:08 INFO - 'HOME': '/home/cltbld', 08:02:08 INFO - 'LANG': 'en_US.UTF-8', 08:02:08 INFO - 'LANGUAGE': 'en_US:en', 08:02:08 INFO - 'LOGNAME': 'cltbld', 08:02:08 INFO - 'MAIL': '/var/mail/cltbld', 08:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:08 INFO - 'MOZ_NO_REMOTE': '1', 08:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:08 INFO - 'NO_EM_RESTART': '1', 08:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:08 INFO - 'PWD': '/builds/slave/test', 08:02:08 INFO - 'SHELL': '/bin/bash', 08:02:08 INFO - 'SHLVL': '1', 08:02:08 INFO - 'TERM': 'linux', 08:02:08 INFO - 'TMOUT': '86400', 08:02:08 INFO - 'USER': 'cltbld', 08:02:08 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907', 08:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:08 INFO - '_': '/tools/buildbot/bin/python'} 08:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:08 INFO - Running setup.py (path:/tmp/pip-CR1bqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:09 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)) 08:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:09 INFO - Running setup.py (path:/tmp/pip-o8qrXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:09 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)) 08:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:09 INFO - Running setup.py (path:/tmp/pip-7TA7C9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:09 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)) 08:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:09 INFO - Running setup.py (path:/tmp/pip-VajsMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:09 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)) 08:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:09 INFO - Running setup.py (path:/tmp/pip-3_6nZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:09 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)) 08:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:09 INFO - Running setup.py (path:/tmp/pip-5ClPj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:09 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)) 08:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:09 INFO - Running setup.py (path:/tmp/pip-QkscPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:09 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)) 08:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:09 INFO - Running setup.py (path:/tmp/pip-1_inu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:09 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)) 08:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:09 INFO - Running setup.py (path:/tmp/pip-nT4E07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:09 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)) 08:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:09 INFO - Running setup.py (path:/tmp/pip-PrhRCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:09 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)) 08:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:09 INFO - Running setup.py (path:/tmp/pip-GEp5Td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:09 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)) 08:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:09 INFO - Running setup.py (path:/tmp/pip-Rs4soj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:09 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)) 08:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:09 INFO - Running setup.py (path:/tmp/pip-OwaKLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:09 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)) 08:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:09 INFO - Running setup.py (path:/tmp/pip-hv8ypI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:09 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)) 08:02:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:09 INFO - Running setup.py (path:/tmp/pip-3QaOzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:10 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)) 08:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:10 INFO - Running setup.py (path:/tmp/pip-Mb_Uxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:10 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)) 08:02:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:10 INFO - Running setup.py (path:/tmp/pip-hFwoCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:10 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)) 08:02:10 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)) 08:02:10 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)) 08:02:10 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)) 08:02:10 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)) 08:02:10 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)) 08:02:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:02:10 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 08:02:10 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 08:02:10 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 08:02:10 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 08:02:10 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 08:02:10 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 08:02:12 INFO - Downloading blessings-1.6.tar.gz 08:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:02:12 INFO - Installing collected packages: blessings 08:02:12 INFO - Running setup.py install for blessings 08:02:12 INFO - Successfully installed blessings 08:02:12 INFO - Cleaning up... 08:02:12 INFO - Return code: 0 08:02:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:02:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:12 INFO - Reading from file tmpfile_stdout 08:02:12 INFO - Current package versions: 08:02:12 INFO - argparse == 1.2.1 08:02:12 INFO - blessings == 1.6 08:02:12 INFO - blobuploader == 1.2.4 08:02:12 INFO - docopt == 0.6.1 08:02:12 INFO - manifestparser == 1.1 08:02:12 INFO - mozInstall == 1.12 08:02:12 INFO - mozcrash == 0.17 08:02:12 INFO - mozdebug == 0.1 08:02:12 INFO - mozdevice == 0.48 08:02:12 INFO - mozfile == 1.2 08:02:12 INFO - mozhttpd == 0.7 08:02:12 INFO - mozinfo == 0.9 08:02:12 INFO - mozleak == 0.1 08:02:12 INFO - mozlog == 3.1 08:02:12 INFO - moznetwork == 0.27 08:02:12 INFO - mozprocess == 0.22 08:02:12 INFO - mozprofile == 0.28 08:02:12 INFO - mozrunner == 6.11 08:02:12 INFO - mozscreenshot == 0.1 08:02:12 INFO - mozsystemmonitor == 0.0 08:02:12 INFO - moztest == 0.7 08:02:12 INFO - mozversion == 1.4 08:02:12 INFO - psutil == 3.1.1 08:02:12 INFO - requests == 1.2.3 08:02:12 INFO - wsgiref == 0.1.2 08:02:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:12 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 0x7f3c73216f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c57410>, '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 0x1c58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c587a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907', '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 08:02:12 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 08:02:12 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 08:02:12 INFO - Using env: {'DISPLAY': ':0', 08:02:12 INFO - 'HOME': '/home/cltbld', 08:02:12 INFO - 'LANG': 'en_US.UTF-8', 08:02:12 INFO - 'LANGUAGE': 'en_US:en', 08:02:12 INFO - 'LOGNAME': 'cltbld', 08:02:12 INFO - 'MAIL': '/var/mail/cltbld', 08:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:12 INFO - 'MOZ_NO_REMOTE': '1', 08:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:12 INFO - 'NO_EM_RESTART': '1', 08:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:12 INFO - 'PWD': '/builds/slave/test', 08:02:12 INFO - 'SHELL': '/bin/bash', 08:02:12 INFO - 'SHLVL': '1', 08:02:12 INFO - 'TERM': 'linux', 08:02:12 INFO - 'TMOUT': '86400', 08:02:12 INFO - 'USER': 'cltbld', 08:02:12 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907', 08:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:12 INFO - '_': '/tools/buildbot/bin/python'} 08:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:12 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)) 08:02:12 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)) 08:02:12 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)) 08:02:12 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)) 08:02:12 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)) 08:02:12 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)) 08:02:12 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)) 08:02:12 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)) 08:02:12 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)) 08:02:12 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)) 08:02:12 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)) 08:02:12 INFO - Cleaning up... 08:02:12 INFO - Return code: 0 08:02:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:12 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 0x7f3c73216f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c57410>, '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 0x1c58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c587a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907', '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 08:02:12 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 08:02:12 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 08:02:12 INFO - Using env: {'DISPLAY': ':0', 08:02:12 INFO - 'HOME': '/home/cltbld', 08:02:12 INFO - 'LANG': 'en_US.UTF-8', 08:02:12 INFO - 'LANGUAGE': 'en_US:en', 08:02:12 INFO - 'LOGNAME': 'cltbld', 08:02:12 INFO - 'MAIL': '/var/mail/cltbld', 08:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:12 INFO - 'MOZ_NO_REMOTE': '1', 08:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:12 INFO - 'NO_EM_RESTART': '1', 08:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:12 INFO - 'PWD': '/builds/slave/test', 08:02:12 INFO - 'SHELL': '/bin/bash', 08:02:12 INFO - 'SHLVL': '1', 08:02:12 INFO - 'TERM': 'linux', 08:02:12 INFO - 'TMOUT': '86400', 08:02:12 INFO - 'USER': 'cltbld', 08:02:12 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907', 08:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:12 INFO - '_': '/tools/buildbot/bin/python'} 08:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:12 INFO - Downloading/unpacking jsonschema 08:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:02:14 INFO - Downloading/unpacking functools32 (from jsonschema) 08:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:15 INFO - Downloading functools32-3.2.3-2.tar.gz 08:02:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:02:15 INFO - warning: no files found matching '*.txt' 08:02:15 INFO - no previously-included directories found matching 'build' 08:02:15 INFO - no previously-included directories found matching 'dist' 08:02:15 INFO - no previously-included directories found matching '.git*' 08:02:15 INFO - Installing collected packages: jsonschema, functools32 08:02:15 INFO - Running setup.py install for functools32 08:02:15 INFO - warning: no files found matching '*.txt' 08:02:15 INFO - no previously-included directories found matching 'build' 08:02:15 INFO - no previously-included directories found matching 'dist' 08:02:15 INFO - no previously-included directories found matching '.git*' 08:02:15 INFO - Successfully installed jsonschema functools32 08:02:15 INFO - Cleaning up... 08:02:15 INFO - Return code: 0 08:02:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:15 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 0x7f3c73216f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c57410>, '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 0x1c58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c587a0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907', '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 08:02:15 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 08:02:15 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 08:02:15 INFO - Using env: {'DISPLAY': ':0', 08:02:15 INFO - 'HOME': '/home/cltbld', 08:02:15 INFO - 'LANG': 'en_US.UTF-8', 08:02:15 INFO - 'LANGUAGE': 'en_US:en', 08:02:15 INFO - 'LOGNAME': 'cltbld', 08:02:15 INFO - 'MAIL': '/var/mail/cltbld', 08:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:15 INFO - 'MOZ_NO_REMOTE': '1', 08:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:15 INFO - 'NO_EM_RESTART': '1', 08:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:15 INFO - 'PWD': '/builds/slave/test', 08:02:15 INFO - 'SHELL': '/bin/bash', 08:02:15 INFO - 'SHLVL': '1', 08:02:15 INFO - 'TERM': 'linux', 08:02:15 INFO - 'TMOUT': '86400', 08:02:15 INFO - 'USER': 'cltbld', 08:02:15 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907', 08:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:15 INFO - '_': '/tools/buildbot/bin/python'} 08:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:15 INFO - Downloading/unpacking flake8 08:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:02:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:02:17 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 08:02:17 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 08:02:17 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 08:02:17 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 08:02:17 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 08:02:17 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 08:02:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:02:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:02:17 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 08:02:17 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 08:02:17 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 08:02:17 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 08:02:17 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 08:02:17 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 08:02:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:02:17 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 08:02:17 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 08:02:17 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 08:02:17 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 08:02:17 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 08:02:17 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 08:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:02:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:02:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:02:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:02:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:02:18 INFO - no previously-included directories found matching 'docs/_build' 08:02:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:02:18 INFO - Running setup.py install for pep8 08:02:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:02:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:02:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:02:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:02:18 INFO - no previously-included directories found matching 'docs/_build' 08:02:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:02:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:02:18 INFO - Cleaning up... 08:02:18 INFO - Return code: 0 08:02:18 INFO - Running post-action listener: _resource_record_post_action 08:02:18 INFO - Running post-action listener: _start_resource_monitoring 08:02:18 INFO - Starting resource monitoring. 08:02:18 INFO - ##### 08:02:18 INFO - ##### Running install step. 08:02:18 INFO - ##### 08:02:18 INFO - Running pre-action listener: _resource_record_pre_action 08:02:18 INFO - Running main action method: install 08:02:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:18 INFO - Reading from file tmpfile_stdout 08:02:18 INFO - Detecting whether we're running mozinstall >=1.0... 08:02:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:02:18 INFO - Reading from file tmpfile_stdout 08:02:18 INFO - Output received: 08:02:18 INFO - Usage: mozinstall [options] installer 08:02:18 INFO - Options: 08:02:18 INFO - -h, --help show this help message and exit 08:02:18 INFO - -d DEST, --destination=DEST 08:02:18 INFO - Directory to install application into. [default: 08:02:18 INFO - "/builds/slave/test"] 08:02:18 INFO - --app=APP Application being installed. [default: firefox] 08:02:18 INFO - mkdir: /builds/slave/test/build/application 08:02:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:02:35 INFO - Reading from file tmpfile_stdout 08:02:35 INFO - Output received: 08:02:35 INFO - /builds/slave/test/build/application/firefox/firefox 08:02:35 INFO - Running post-action listener: _resource_record_post_action 08:02:35 INFO - ##### 08:02:35 INFO - ##### Running run-tests step. 08:02:35 INFO - ##### 08:02:35 INFO - Running pre-action listener: _resource_record_pre_action 08:02:35 INFO - Running main action method: run_tests 08:02:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:02:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:02:35 INFO - Python 2.7.3 08:02:35 INFO - Return code: 0 08:02:35 INFO - grabbing minidump binary from tooltool 08:02: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')]} 08:02:35 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 0x1c57410>, '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 0x1c58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c587a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:02:35 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 08:02:35 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 08:02:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:02:35 INFO - Return code: 0 08:02:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:02:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:02:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:02:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:02:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:02:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:02:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:02:36 INFO - Return code: 0 08:02:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 08:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 08:02:36 INFO - Using env: {'DISPLAY': ':0', 08:02:36 INFO - 'HOME': '/home/cltbld', 08:02:36 INFO - 'LANG': 'en_US.UTF-8', 08:02:36 INFO - 'LANGUAGE': 'en_US:en', 08:02:36 INFO - 'LOGNAME': 'cltbld', 08:02:36 INFO - 'MAIL': '/var/mail/cltbld', 08:02:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:02:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:36 INFO - 'MOZ_NO_REMOTE': '1', 08:02:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:36 INFO - 'NO_EM_RESTART': '1', 08:02:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:36 INFO - 'PWD': '/builds/slave/test', 08:02:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:02:36 INFO - 'SHELL': '/bin/bash', 08:02:36 INFO - 'SHLVL': '1', 08:02:36 INFO - 'TERM': 'linux', 08:02:36 INFO - 'TMOUT': '86400', 08:02:36 INFO - 'USER': 'cltbld', 08:02:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907', 08:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:36 INFO - '_': '/tools/buildbot/bin/python'} 08:02:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 08:02:36 INFO - mozversion application_buildid: 20160428045211 08:02:36 INFO - mozversion application_changeset: 7d48a5e12f18fe69f08cc46043a1d8ed64277ee5 08:02:36 INFO - mozversion application_display_name: Nightly 08:02:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:02:36 INFO - mozversion application_name: Firefox 08:02:36 INFO - mozversion application_remotingname: firefox 08:02:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:02:36 INFO - mozversion application_vendor: Mozilla 08:02:36 INFO - mozversion application_version: 48.0a1 08:02:36 INFO - mozversion platform_buildid: 20160428045211 08:02:36 INFO - mozversion platform_changeset: 7d48a5e12f18fe69f08cc46043a1d8ed64277ee5 08:02:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:02:36 INFO - mozversion platform_version: 48.0a1 08:02:36 INFO - using testdate: 1461855756 08:02:36 INFO - actual date: 1461855756 08:02:36 INFO - starting webserver on 'localhost:41116' 08:02:36 INFO - SUITE-START | Running 2 tests 08:02:36 INFO - TEST-START | dromaeo_css 08:02:36 INFO - operating with platform_type : linux_ 08:02:36 INFO - Initialising browser for dromaeo_css test... 08:02:36 INFO - TEST-INFO | started process 22931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ebHt4/profile http://localhost:41116/getInfo.html) 08:02:40 INFO - PROCESS | 22931 | 08:02:40 INFO - PROCESS | 22931 | (process:22999): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:02:41 INFO - PROCESS | 22931 | __metrics Screen width/height:1600/1200 08:02:41 INFO - PROCESS | 22931 | colorDepth:24 08:02:41 INFO - PROCESS | 22931 | Browser inner width/height: 1024/697 08:02:41 INFO - PROCESS | 22931 | __metrics 08:02:41 ERROR - PROCESS | 22931 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:02:42 INFO - TEST-INFO | 22931: exit 0 08:02:42 INFO - Browser initialized. 08:02:42 INFO - Running cycle 1/1 for dromaeo_css test... 08:02:42 INFO - TEST-INFO | started process 23050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ebHt4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:02:44 INFO - PROCESS | 23050 | 08:02:44 INFO - PROCESS | 23050 | (process:23111): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:02:54 INFO - PROCESS | 23050 | RSS: Main: 164982784 08:02:54 INFO - PROCESS | 23050 | 08:03:44 INFO - PROCESS | 23050 | 1461855824128 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] 08:05:51 INFO - PROCESS | 23050 | Cycle 1(1): loaded http://localhost:41116/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41116/tests/dromaeo/cssquery-ext.html) 08:05:52 INFO - PROCESS | 23050 | RSS: Main: 168288256 08:05:52 INFO - PROCESS | 23050 | 08:08:54 INFO - PROCESS | 23050 | Cycle 1(1): loaded http://localhost:41116/tests/dromaeo/cssquery-ext.html (next: http://localhost:41116/tests/dromaeo/cssquery-jquery.html) 08:08:55 INFO - PROCESS | 23050 | RSS: Main: 166662144 08:08:55 INFO - PROCESS | 23050 | 08:11:57 INFO - PROCESS | 23050 | Cycle 1(1): loaded http://localhost:41116/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41116/tests/dromaeo/cssquery-mootools.html) 08:11:57 INFO - PROCESS | 23050 | RSS: Main: 167743488 08:11:57 INFO - PROCESS | 23050 | 08:14:59 INFO - PROCESS | 23050 | Cycle 1(1): loaded http://localhost:41116/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41116/tests/dromaeo/cssquery-prototype.html) 08:15:00 INFO - PROCESS | 23050 | RSS: Main: 165212160 08:15:00 INFO - PROCESS | 23050 | 08:18:02 INFO - PROCESS | 23050 | Cycle 1(1): loaded http://localhost:41116/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41116/tests/dromaeo/cssquery-yui.html) 08:18:03 INFO - PROCESS | 23050 | RSS: Main: 167002112 08:18:03 INFO - PROCESS | 23050 | 08:21:05 INFO - PROCESS | 23050 | Cycle 1(1): loaded http://localhost:41116/tests/dromaeo/cssquery-yui.html (next: http://localhost:41116/tests/dromaeo/cssquery-dojo.html) 08:21:05 INFO - PROCESS | 23050 | RSS: Main: 169164800 08:21:05 INFO - PROCESS | 23050 | 08:21:05 INFO - PROCESS | 23050 | __start_tp_report 08:21:05 INFO - PROCESS | 23050 | _x_x_mozilla_page_load 08:21:05 INFO - PROCESS | 23050 | _x_x_mozilla_page_load_details 08:21:05 INFO - PROCESS | 23050 | |i|pagename|runs| 08:21:05 INFO - PROCESS | 23050 | |0;dojo.html;3112.875484980601;3176.301213732978;3191.3936352093115;3225.838708064596;3236.3203727217283;5308.177232528959;5337.733113344332;5399.163129714901;5416.891662166754;5424;5318.574514038877;5386.542143917772;5406.486383793543;5414.106672399059;5418.91871621926;4936.308916751657;5029.7988080476825;5032.949670503303;5050.545450909417;5090.770915308802;1140.8349214476016;4992.700437973715;5033.270175824521;5051.040302342543;5098.158803797369;4894.290327902452;4952.975235123801;4989.750512474362;4997.400311962551;5036.622253330978;4964.329815474937;4968.527989840959;4975.427825800043;5012.473690262506;5039.596832253411;4851.490593487668;5018.924716129261;5022.698638081727;5028.245763135523;5076.517730815566;5252.973735131338;5315.069862774038;5321.228421878806;5322.92015619766;5406.107992181285;5853.0635098384055;5853.092770620518;5857.912131318034;5869.647821130746;5869.941300587025;5886.1465087562065;5903.645781253095;5908.911366329508;5910.113482977545;5990.73041713124;5422.240886275925;5466.945330546723;5472.097103977839;5478.342598888119;5511.696856672881;5940.198073260054;5962.165296858443;5963.105534169909;5963.463288304073;5971.28344598651;5595.328560572757;5615.410381909923;5669.603127781098;5688.431156884279;5739;5838.299404071538;5840.88318233633;5847.795327163529;5854.882902342015;5869.735861886225;5822.650640961556;5835.153902684087;5836.387179346108;5839.065749480063;5845.912311315334;5665.065264231355;5849.853753656193;5907.350191478934;5921.555883308769;5959.821205363846;4271.893202669959;4341.869743907688;4381.101874115799;4389.034412429261;4405.823767049346;3903.434002069741;3919.3729003359895;3943.6253555912144;3956.97808995485;3971.860984865516;5335.306410166653;5465;5556.638818476786;5610;5621.634593751393;5746.770129194785;5766.192733017381;5766.654000759884;5783.987802134694;5801.53587712982;5409.053415652245;5457.890842183134;5469.425710300441;5473.397926228112;5476.205950137208;4766.976165119152;4953.7275449849885;5009.699418034929;5055.115354812893;5063.746812659352;5926.7925622603;5927;5939.732712027969;5972.343042265347;5979.850503737442;5684.971575142098;5786.826395208151;5792.82621521355;5821.534277257894;5830.154627579062;5974.342822289458;6027.336992930862;6035.517158627387;6039.15451836752;6076.817695469143;5754;5815.970920145542;5841.240638716939;5845.386234445322;5852.268466441695;5548.0845660467185;5823.912641310299;5850.5027072699295;5856.707164641665;5880.411958804086;5680.176374425768;5681.0910254359105;5700.458456446631;5711.457411545896;5751.683657398883;5664.5751568631695;5666.801661941812;5673;5694.1458781183155;5694.402087780723;5380.273663055594;5549.1676248563035;5574.693391863487;5607.41122182165;5636.802711905064;5327.067763141357;5496.093144631251;5803.622764520293;5809.796657116981;5829;5652.773889044557;5653.180288858175;5670.489655930986;5690;5700.173474846207 08:21:05 INFO - PROCESS | 23050 | |1;ext.html;608.6743592178185;639.4852144024061;647.8769033883561;653.9705713242902;670.213880009774;36751;37170.8141459293;37196.814015929885;37544.62455375445;37589.24821503572;40936.18127637445;41714.37428438576;41963;42043.3693494597;42084;8479.533625650587;8688.782780430509;8708.956455217714;8731.432456890281;8752.649894004233;8698;8742;8808.955955220215;8826.955865220665;8827.646894124227;8815.338849586275;8816.515091669955;8844.204021638052;8901.620248861436;8909;8755.693550725726;8791.824163516694;8859.955700221457;8873;8874.955625221864;8640.481571105754;8702.216800487986;8746.169113934166;8752.299816014704;8787.956060219722;37665.045170257;37991;38045.61954380448;38244.80877595594;38471;2846.6762955225713;3286.917827054319;3335.182880194344;3369.9663003369897;3418.2479854431986;30735.846320768476;30827;31219.687803121906;31304.21739456509;31324.530132048036;4087.7751723655188;4099.282625540519;4103.97948010258;4109.260333140033;4115.8765237042935;273670;273825;274115;274824;276001;32021.19947001297;32874.17814554607;36012.279754404764;36224.45663315053;36316;33796.831015844764;33884.49173262403;33954.32091358209;34080.65919340775;34171.658283417346;14827.555173344817;14947.327370268364;15037;15056.548303550911;15085;13139.14595551286;13235.66910827237;13264.602061937965;13266.204027758366;13314.533991310258;8218.917810821935;8264.297534709496;8292.880461137669;8301.750947471586;8370;3279.754018448626;3315.535824984504;3316.6185888623118;3333.8999830005137;3347.5982882053822;1075.1291453922347;1115.5426275227119;1158.8841115888345;1272.929988850622;1282.6472720002075;32080.679193208234;32333.838330808667;32406.83796581002;32699.346013079605;32723.50914736281;1114.1588100983706;1122.3322123336602;1145.9427028648533;1146.4267866066966;1172.8006238939402;16355;16448;17163.227654755567;17229.827701723072;17336.39322623702;498202;501920;502567;506577;507048;55336.16995745067;55603.44396556063;55827.441725582226;56024;56036.71981640147;1352.1751731443812;1356.5591182865608;1358.8777010069339;1370.0272806307435;1388.3821699343896;30136.547951780303;30744.385112298078;30880.845595771876;30887.38225235438;31681.5247771279;48907.75546122246;48939.75530122327;49007.50992490172;49242.26136607882;49312;302242;303287;304157;304913;305300;27381.726182738716;27705.168844934684;28157.155285341472;28280.575791363557;28302.292442689097;47986.760066199444;48595.27107093467;48816.2677559844;49199.50800492092;49893.501064990334;39511;39885;40197;40355.1928961425;40997.59002409938;38039.80980095082;39463.21073578455;39964.60035399609;39975.40036899507;40450.34820995623;33830.661693383736;36181.638183617826;37546.06134846651;40247;42224.57775422329;30668.233294167825;31677;31802.681973179973;31827.522587160747;31848.840755796075;25170.24489265325;25490.10784622529;25600.359991000372;25878;26134.607980879922 08:21:05 INFO - PROCESS | 23050 | |2;jquery.html;397.3205818051134;401.71076824686253;402.9617186367295;403.5802765124271;412.5152945289285;13597.52408665697;17887.195076221567;18287.26850925963;18406.171722272495;18568.257269709196;16779.83220167798;17200.655986880287;17510.299588016464;17587.648247035053;17735.73396399055;5540.667559946396;5557.972210138953;5659.462351076661;5687.914681279784;5690.800821971232;5742.942570574303;5778.422157784209;5781.248437703092;5816.098504731774;5839.474447299742;5733.111367738007;5760.4815566599;5761.308642962829;5765.394633563478;5803.50670193032;5649.745761440725;5796.217510636052;5805.5065319447895;5870.236869207019;5894.970525147368;5445.319335083114;5672.801451949162;5697.743601537941;5750.65496070233;5751.539876809887;13341.733165336736;13654.658633534142;13687;13763.31183440824;13930.164190148624;2158.1475317249756;2170.0885628036262;2244.62963611004;2289.3132060381818;2564.3460917466114;9231.261499080058;9272.629094836198;9334.953325233399;9474.763130921714;9671.758206044835;1895.3934740882924;1948.6395016921915;1966.783653798081;1967.9901600491905;2021.706852506393;81566.59216703937;82144.17855821425;82388;82879.58560207221;83018;10816.945915270373;10928.562857485611;10930.070943969851;10965.342079475256;10998.560057597606;15466.226688665522;15479.226038698245;15520.844791552166;15565.509518477216;15581.688366232838;8152.551609661526;8181.140980197112;8267.29727973117;8385.496870187808;8500.74497765068;7632.46572739914;7830.491018083806;7880.2513761192595;7922.207779222032;8263.049749278789;4624.838130665411;4719.197736384823;4731.219348807408;4739.976300118477;4846.055019271279;1893.2616279650672;1970.5960278142945;1981.8810871347766;1991.9800801991794;2010.6776672942774;942.820864035831;968.4576637083256;1001.5593139018808;1059.9735006624896;1085.9728506787235;17392.913035434995;18082.728759068625;18569.721454178198;18577.323286688064;18683.15925783343;994.6568433890296;1008.621766837436;1033.2767063055892;1077.369738702852;1086.1365214654368;10259.435731034864;10428.530716117793;10524.684259472227;10578.735531611617;10692.946535267274;460831;471968;484846;486132;489240;64417.67791161014;67921;81544;90247.54876225708;97179.51410242904;1006.942710154335;1025.5590096258532;1026.3944272879037;1030.6289735695143;1058.8411738239479;16350;16923.576910577332;16986.320547177973;17108.401205957733;17439.47681569555;38641;38684.22631547297;39552;39714.40428393634;39766;54345;54467.72766136144;54865;54907.72546137404;55252;6072.1498990140535;8111.229433203836;8149.877751833846;8480.236778689947;8579.871301930601;9303.069693030642;12875.935620322212;12903.354832258537;13105.868941310466;13873.58379248624;11350.54597816078;11568.13239007061;11805.881941180478;11861.822072668745;12202.084843636585;11082.725486569148;11220.495077721685;11308.604198853001;11331.32012079278;11567.421628918688;11627.6511704649;11727.824082638597;11831.585894493652;12330.50677972871;12349.19730217533;8374.413791034813;8789.648414063366;8903.821923561363;8905.064968178507;9041.05068967749;8545.273651739672;10947.507362168562;12429.12996090265;12459.377031148588;12517.31016312786 08:21:05 INFO - PROCESS | 23050 | |3;mootools.html;1372.6774208061104;1445.4868521674805;1511.8488151184877;1677.094369040718;1704.917377465309;7212.495125341228;7880.527168369902;8039.075506316775;8357.456765310251;8373.832523349536;8057.073436554798;8080.757577272677;8145.877811832813;8155.510669359843;8173.7139200128;2227.2984010036866;2269.3305474884946;2271.432141964509;2273.977260227393;2276.84062115652;2231.0852550454315;2252.31304452142;2272.602294598447;2290.141197051106;2299.6435552489306;2261.118163916074;2262.4570103175283;2273.863568185914;2279.430142464384;2296.437372843656;2185.2351676913113;2205.889705514726;2209.1936443198197;2221.6112180368373;2228.732552093743;2197.077227564411;2200.922967696123;2205.3604454708116;2206.205765924266;2213.8450308478414;8054.275115239657;8093.069297030858;8099.230573095547;8136.389770767157;8166.918330816675;4734.55021772931;4865.391826021747;4928.1129396708575;4934.037862616791;4936.679115857493;3141.4659507883716;3187.1394723424546;3314.9668503315143;3318.3529211803707;3332.2002719347424;1107.9667609971634;1112.9499172537173;1120.7086157599;1162.1690491298677;1182.834403183555;11323.320600763898;11330.320180789178;11333.773324533464;11377.94311028448;11424.543018279343;4242.342436922282;4297.828086876552;4341.15347507233;4379;4397.614751353313;9635.181009614122;9654.855177172349;9675.612975481043;9690;9724.17344525709;4801.063792560487;4843.539863712942;4904.239842824368;4904.8038078477175;4916.926246106311;4048.959510404917;4457.621102206349;4525.932111018337;4559.772011399416;4607.0785842831565;3835.4822099016274;3881.204353107606;3935.7244992850224;3977.204559088194;3992.940105898414;1268.9555865544662;1279.2324605236784;1284.563248495516;1287.6394609509352;1306.3598836570202;842.7640260727006;884.3146561414826;890.6036813618007;909.8771665825161;914.5930061122737;5396.9730151348995;5471.699056551928;5545.944540554624;5631.915521267184;5650.943490565041;965.6475386484024;976.3263348289657;1002.5538635307364;1011.3982180602529;1023.0741179232806;3784.7729136251914;3926.784026878549;3963.504561929759;4001.459802926626;4011.13760541485;9863.260255480867;10153.4923253837;10301.9484902575;10330.690079297634;10357.792844143074;10148.492575371201;10186.592536298613;10258.487075646188;10262.486875656337;10262.538185781657;7356.786130288442;7534.849303013909;7626.733064342832;7672.386209103258;7966.721164759206;5447.812590455873;5635.323761148688;5745.770169193185;5748.626339287933;5817.331006934257;9110.772230694285;9477.952610236905;9503.762405939908;9540.189083927944;9695.51522423862;9565.760855978378;9637.566309515949;9693.079157480028;9737.80524389494;9846.409215447096;6611.801645950629;7125.3230943060325;7285.890711639224;7429.07136607924;7474.588897610466;7726.7681969541;7781.572013539309;7844.411669124953;7870.960645196967;7875.409344299086;6991.650417479004;7313.488055836253;7353.926460735324;7381.704731810883;7447.292507211806;6777.457803375817;6869.725210991504;6889.207741109836;6921.826954326182;6960.825979350557;6218.81343559694;6402.775902843378;6409.679516024087;6421.229452465734;6421.903671445026;4849.248366503198;4889.168841296917;4902.093112774148;4930.556249937523;4949.727764972817;4815.6388270880525;4863.48933362006;4938.827141050046;4956.479569645136;5060.089183946778 08:21:05 INFO - PROCESS | 23050 | |4;prototype.html;305.0680172074313;309.1251757526201;311.23281112058777;317.6902520042958;321.9613646362437;5532.446755324466;5580.358258800239;5583.8604034899145;5589.049861523541;5621.57838162138;5503.229547863302;5504.64219825711;5509.807156749514;5516.9448305516935;5518.641288316257;4073.3075377185874;4191.119864828374;4340.435743353375;4354.303311470166;4367.672424568154;4339.956600433987;4347.869553915989;4365.672574556921;4365.934510982322;4376.146651402978;4290.721103128302;4341.4790225172865;4356.433663623725;4361.127774445108;4363.38912552243;4098.815553300094;4317.4819021717285;4336.761478118702;4340.587644173798;4374.147041326943;3726.5341832270965;3728.8694895678523;3732.720045996561;3753.8686145985034;3758.022914042341;5302.840914772524;5334.0665383557725;5368.516833485005;5373.570114390839;5378.112611419111;4715.4577223619035;4909.21452567591;4934.1611925972675;4963.900721985576;4972.353594032788;5749.770009199627;5825.854353641151;5860.648361098305;5872.7357268923;5878.559108066869;4111.177764447122;4122.6083522065355;4136.524299705542;4156.085661154541;4156.605122513356;5887.234659494281;6067.484263837579;6079.148919151322;6101.328853826076;6107.175531303306;4176.644985176234;4178.979105104455;4190.916181676349;4193.475815523059;4193.895152621209;4204.180184863983;4210.894727631834;4241.660667146621;4259;4274.829006839692;4751.95248047522;4851.611871050308;4915.483874193158;4927.792690790708;4940.555350018443;5853.443922827325;5880;5898.84972430372;5925.851853703692;5951.3751056139345;1531.2420351925869;1535.4932872152385;1545.4359158907143;1550.3333566566484;1555.7277476441577;917.4266083697689;1013.4324778124274;1025.8153532364247;1028.1928685981468;1037.0510982451124;5882.941170588239;5897.970510147422;5918.319393269743;5920.37189772816;5959.553033522503;6307;6352.174217351715;6370.490360771128;6381.649009304533;6421.8073457796345;5791.420857914175;5826.73779679907;5888.735006924699;5945.851353716105;5966.701664916737;3341.5655964724915;3396.541466901986;3402.6937575618313;3407.744419168572;3411.9658803412144;6485.902711459332;6540.509461790385;6565.277819439858;6573.934260657428;6578.026592022374;6515.902261466082;6525.5740736112975;6563.540552161398;6586.308437614078;6615.437687796495;6051.213342265565;6358.598149989733;6615.669216539154;6636.270010298863;6677.766278180337;6065.666388348507;6089.376820791799;6114.419130182626;6149.292831324455;6154.323024467394;5917.378675239038;6054.303755068047;6057.515398768176;6068.393160683896;6075.483583895419;6139.969300153471;6280.780172693934;6291;6302.180716506825;6333.20834895638;4147.108371700099;4247.66018718508;4258.87223383299;4259.318509038539;4272.957270427256;5817.94182058174;6171.413715697002;6190.1952746142715;6197.4732147767945;6199.442050215503;5839.299284085937;5890.676012819336;5891.499222565958;5945.64326140433;5979.133025711334;5959.22530071088;5967.343592204767;5986.4013598639785;5992.520598352208;6003.309619393651;5602.775888964396;5844.181814545882;5867.178594996619;5868.23712917318;5888.528917686661;5885.76398956224;5896.410358964241;5988.191594134911;5994.550408719277;6046.244219472566;5703.62926409782;5863;5867.383924688017;5870.383609721089;5895.263092113486 08:21:05 INFO - PROCESS | 23050 | |5;yui.html;679.1646275081648;700.2332445971663;725.1775691650525;735.9227281135484;749.3892477630731;11235.157363197752;11450.7137321567;11486.483108260127;11543.538258469662;11559.133065020114;11207.439628018587;11243.212975091747;11256.268342557729;11275.210735248536;11284.830727539073;782.3154739602847;802.5425507460735;818.0551463060175;826.962786674601;830.1366578758084;807.8545861744883;824.1758241758242;826.2027143806225;827.1934863508092;827.2017503109498;847.4068152293388;852.1180578101666;852.3479538153317;855.4952577978992;856.2379482260793;843.6414523827349;847.6439895244013;849.049065047145;852.1393392673444;853.0190281176665;619.3991827926903;620.1751670278519;620.4756980351596;620.5066971757464;621.6643012773097;12074.758504829942;12166.81749773754;12176.330301833395;12176.634700958986;12223.14437989341;10778.946105269502;10889;10974.231803773739;10982.890171098346;11204.15968802335;9829.459379734111;10014.59941602335;10042.849357259647;10098.394096354243;10320.79358412835;3606.1705807664384;3610.981945090284;3663.139162296858;3693.1505753676806;3756.69946404287;48382.758086209695;48819.02361952741;49276;49280.75359623215;49555.25667114996;8316.37627177964;8341.666333346599;8429.957850210709;8509.149085091565;8653.6538538459;15155.696886062216;15524.379024839105;15550.300236489385;15551.611209719622;15575.299111540007;6780.796576102724;6816.284290149463;6824.761133360308;6837.760678376233;6967.965160174167;4161.500619925629;4223.429836972031;4263.573642635712;4264.545359391126;4279.422277992493;3060.3726236121543;3071.170783888382;3077.9846100769355;3098.690130986883;3105.6894310568764;553.9446055394428;563.5041163775851;575.8013485347549;576.3544829790577;583.9328477225089;612.3203244398803;617.274702224884;619.4734475695623;637.7385272038442;650.0314531348257;7891.644875980594;8154.347652187811;8160.877586836202;8298.70954516589;8319.376046796515;580.4891695308102;595.3689089565075;618.9257289125334;623.6943897490288;650.2197363164222;3860.729748917549;3887.78617176058;3895.917122496241;3959.762414255154;4022.517297924268;59805.401945980855;61034.084488732704;61444.38555614476;63148.684256578425;63464;52657.736711316196;52679.73660131675;54662;55682.16476752852;55754;49518.75240623774;50038.24942625863;50349.74825125851;50393.24410133851;52424.903003879415;8116.431849770459;8315.916840831514;8325.221757990535;8340.541270230196;8377.83244335122;31896.49138594706;32425.67574324321;32467.837660811543;32515.18712032218;33285;40435.191296173325;41903.27628704125;44924.326135107345;45501.77249113733;45727.77136114298;10225.693229203136;10401.115905148146;10406.47967601632;10443.112335451571;10544.472776360997;10826.13390928708;10995.450227488753;11030.393328367018;11117.27737697047;11131.154076141185;10596.033110729008;10626.256162068581;10745.785084298426;10774.892251077388;10964.890351096707;10280.897191027994;10406.219533534864;10501.26491145643;10608.628697995533;10684.358938463716;10486.318389304672;10700.83948740754;10724.839127413252;10955.50700218476;11060.059894908702;8973.37186396946;9099.636014559343;9198;9257.120573545502;9634.855477167708;8954.820903582022;9590.232781377334;9614.51927403613;9653.855192172263;9735.610575576897 08:21:05 INFO - PROCESS | 23050 | __end_tp_report 08:21:05 INFO - PROCESS | 23050 | __start_cc_report 08:21:05 INFO - PROCESS | 23050 | _x_x_mozilla_cycle_collect,360 08:21:05 INFO - PROCESS | 23050 | __end_cc_report 08:21:05 INFO - PROCESS | 23050 | __startTimestamp1461856865641__endTimestamp 08:21:05 INFO - PROCESS | 23050 | 08:21:05 INFO - PROCESS | 23050 | ------- Summary: start ------- 08:21:05 INFO - PROCESS | 23050 | Number of tests: 6 08:21:05 INFO - PROCESS | 23050 | 08:21:05 INFO - PROCESS | 23050 | [#0] dojo.html Cycles:165 Average:5382.00 Median:5615.41 stddev:697.19 (12.4%) stddev-sans-first:676.22 08:21:05 INFO - PROCESS | 23050 | Values: 3112.9 3176.3 3191.4 3225.8 3236.3 5308.2 5337.7 5399.2 5416.9 5424.0 5318.6 5386.5 5406.5 5414.1 5418.9 4936.3 5029.8 5032.9 5050.5 5090.8 1140.8 4992.7 5033.3 5051.0 5098.2 4894.3 4953.0 4989.8 4997.4 5036.6 4964.3 4968.5 4975.4 5012.5 5039.6 4851.5 5018.9 5022.7 5028.2 5076.5 5253.0 5315.1 5321.2 5322.9 5406.1 5853.1 5853.1 5857.9 5869.6 5869.9 5886.1 5903.6 5908.9 5910.1 5990.7 5422.2 5466.9 5472.1 5478.3 5511.7 5940.2 5962.2 5963.1 5963.5 5971.3 5595.3 5615.4 5669.6 5688.4 5739.0 5838.3 5840.9 5847.8 5854.9 5869.7 5822.7 5835.2 5836.4 5839.1 5845.9 5665.1 5849.9 5907.4 5921.6 5959.8 4271.9 4341.9 4381.1 4389.0 4405.8 3903.4 3919.4 3943.6 3957.0 3971.9 5335.3 5465.0 5556.6 5610.0 5621.6 5746.8 5766.2 5766.7 5784.0 5801.5 5409.1 5457.9 5469.4 5473.4 5476.2 4767.0 4953.7 5009.7 5055.1 5063.7 5926.8 5927.0 5939.7 5972.3 5979.9 5685.0 5786.8 5792.8 5821.5 5830.2 5974.3 6027.3 6035.5 6039.2 6076.8 5754.0 5816.0 5841.2 5845.4 5852.3 5548.1 5823.9 5850.5 5856.7 5880.4 5680.2 5681.1 5700.5 5711.5 5751.7 5664.6 5666.8 5673.0 5694.1 5694.4 5380.3 5549.2 5574.7 5607.4 5636.8 5327.1 5496.1 5803.6 5809.8 5829.0 5652.8 5653.2 5670.5 5690.0 5700.2 08:21:05 INFO - PROCESS | 23050 | 08:21:05 INFO - PROCESS | 23050 | [#1] ext.html Cycles:180 Average:50857.85 Median:36270.23 stddev:99439.65 (274.2%) stddev-sans-first:99647.03 08:21:05 INFO - PROCESS | 23050 | Values: 608.7 639.5 647.9 654.0 670.2 36751.0 37170.8 37196.8 37544.6 37589.2 40936.2 41714.4 41963.0 42043.4 42084.0 8479.5 8688.8 8709.0 8731.4 8752.6 8698.0 8742.0 8809.0 8827.0 8827.6 8815.3 8816.5 8844.2 8901.6 8909.0 8755.7 8791.8 8860.0 8873.0 8875.0 8640.5 8702.2 8746.2 8752.3 8788.0 37665.0 37991.0 38045.6 38244.8 38471.0 2846.7 3286.9 3335.2 3370.0 3418.2 30735.8 30827.0 31219.7 31304.2 31324.5 4087.8 4099.3 4104.0 4109.3 4115.9 273670.0 273825.0 274115.0 274824.0 276001.0 32021.2 32874.2 36012.3 36224.5 36316.0 33796.8 33884.5 33954.3 34080.7 34171.7 14827.6 14947.3 15037.0 15056.5 15085.0 13139.1 13235.7 13264.6 13266.2 13314.5 8218.9 8264.3 8292.9 8301.8 8370.0 3279.8 3315.5 3316.6 3333.9 3347.6 1075.1 1115.5 1158.9 1272.9 1282.6 32080.7 32333.8 32406.8 32699.3 32723.5 1114.2 1122.3 1145.9 1146.4 1172.8 16355.0 16448.0 17163.2 17229.8 17336.4 498202.0 501920.0 502567.0 506577.0 507048.0 55336.2 55603.4 55827.4 56024.0 56036.7 1352.2 1356.6 1358.9 1370.0 1388.4 30136.5 30744.4 30880.8 30887.4 31681.5 48907.8 48939.8 49007.5 49242.3 49312.0 302242.0 303287.0 304157.0 304913.0 305300.0 27381.7 27705.2 28157.2 28280.6 28302.3 47986.8 48595.3 48816.3 49199.5 49893.5 39511.0 39885.0 40197.0 40355.2 40997.6 38039.8 39463.2 39964.6 39975.4 40450.3 33830.7 36181.6 37546.1 40247.0 42224.6 30668.2 31677.0 31802.7 31827.5 31848.8 25170.2 25490.1 25600.4 25878.0 26134.6 08:21:05 INFO - PROCESS | 23050 | 08:21:05 INFO - PROCESS | 23050 | [#2] jquery.html Cycles:180 Average:27779.20 Median:38662.61 stddev:78831.01 (203.9%) stddev-sans-first:79025.34 08:21:05 INFO - PROCESS | 23050 | Values: 397.3 401.7 403.0 403.6 412.5 13597.5 17887.2 18287.3 18406.2 18568.3 16779.8 17200.7 17510.3 17587.6 17735.7 5540.7 5558.0 5659.5 5687.9 5690.8 5742.9 5778.4 5781.2 5816.1 5839.5 5733.1 5760.5 5761.3 5765.4 5803.5 5649.7 5796.2 5805.5 5870.2 5895.0 5445.3 5672.8 5697.7 5750.7 5751.5 13341.7 13654.7 13687.0 13763.3 13930.2 2158.1 2170.1 2244.6 2289.3 2564.3 9231.3 9272.6 9335.0 9474.8 9671.8 1895.4 1948.6 1966.8 1968.0 2021.7 81566.6 82144.2 82388.0 82879.6 83018.0 10816.9 10928.6 10930.1 10965.3 10998.6 15466.2 15479.2 15520.8 15565.5 15581.7 8152.6 8181.1 8267.3 8385.5 8500.7 7632.5 7830.5 7880.3 7922.2 8263.0 4624.8 4719.2 4731.2 4740.0 4846.1 1893.3 1970.6 1981.9 1992.0 2010.7 942.8 968.5 1001.6 1060.0 1086.0 17392.9 18082.7 18569.7 18577.3 18683.2 994.7 1008.6 1033.3 1077.4 1086.1 10259.4 10428.5 10524.7 10578.7 10692.9 460831.0 471968.0 484846.0 486132.0 489240.0 64417.7 67921.0 81544.0 90247.5 97179.5 1006.9 1025.6 1026.4 1030.6 1058.8 16350.0 16923.6 16986.3 17108.4 17439.5 38641.0 38684.2 39552.0 39714.4 39766.0 54345.0 54467.7 54865.0 54907.7 55252.0 6072.1 8111.2 8149.9 8480.2 8579.9 9303.1 12875.9 12903.4 13105.9 13873.6 11350.5 11568.1 11805.9 11861.8 12202.1 11082.7 11220.5 11308.6 11331.3 11567.4 11627.7 11727.8 11831.6 12330.5 12349.2 8374.4 8789.6 8903.8 8905.1 9041.1 8545.3 10947.5 12429.1 12459.4 12517.3 08:21:05 INFO - PROCESS | 23050 | 08:21:05 INFO - PROCESS | 23050 | [#3] mootools.html Cycles:180 Average:5438.51 Median:4903.17 stddev:3033.13 (61.9%) stddev-sans-first:3026.24 08:21:05 INFO - PROCESS | 23050 | Values: 1372.7 1445.5 1511.8 1677.1 1704.9 7212.5 7880.5 8039.1 8357.5 8373.8 8057.1 8080.8 8145.9 8155.5 8173.7 2227.3 2269.3 2271.4 2274.0 2276.8 2231.1 2252.3 2272.6 2290.1 2299.6 2261.1 2262.5 2273.9 2279.4 2296.4 2185.2 2205.9 2209.2 2221.6 2228.7 2197.1 2200.9 2205.4 2206.2 2213.8 8054.3 8093.1 8099.2 8136.4 8166.9 4734.6 4865.4 4928.1 4934.0 4936.7 3141.5 3187.1 3315.0 3318.4 3332.2 1108.0 1112.9 1120.7 1162.2 1182.8 11323.3 11330.3 11333.8 11377.9 11424.5 4242.3 4297.8 4341.2 4379.0 4397.6 9635.2 9654.9 9675.6 9690.0 9724.2 4801.1 4843.5 4904.2 4904.8 4916.9 4049.0 4457.6 4525.9 4559.8 4607.1 3835.5 3881.2 3935.7 3977.2 3992.9 1269.0 1279.2 1284.6 1287.6 1306.4 842.8 884.3 890.6 909.9 914.6 5397.0 5471.7 5545.9 5631.9 5650.9 965.6 976.3 1002.6 1011.4 1023.1 3784.8 3926.8 3963.5 4001.5 4011.1 9863.3 10153.5 10301.9 10330.7 10357.8 10148.5 10186.6 10258.5 10262.5 10262.5 7356.8 7534.8 7626.7 7672.4 7966.7 5447.8 5635.3 5745.8 5748.6 5817.3 9110.8 9478.0 9503.8 9540.2 9695.5 9565.8 9637.6 9693.1 9737.8 9846.4 6611.8 7125.3 7285.9 7429.1 7474.6 7726.8 7781.6 7844.4 7871.0 7875.4 6991.7 7313.5 7353.9 7381.7 7447.3 6777.5 6869.7 6889.2 6921.8 6960.8 6218.8 6402.8 6409.7 6421.2 6421.9 4849.2 4889.2 4902.1 4930.6 4949.7 4815.6 4863.5 4938.8 4956.5 5060.1 08:21:05 INFO - PROCESS | 23050 | 08:21:05 INFO - PROCESS | 23050 | [#4] prototype.html Cycles:180 Average:4995.72 Median:5726.70 stddev:1511.32 (26.4%) stddev-sans-first:1473.98 08:21:05 INFO - PROCESS | 23050 | Values: 305.1 309.1 311.2 317.7 322.0 5532.4 5580.4 5583.9 5589.0 5621.6 5503.2 5504.6 5509.8 5516.9 5518.6 4073.3 4191.1 4340.4 4354.3 4367.7 4340.0 4347.9 4365.7 4365.9 4376.1 4290.7 4341.5 4356.4 4361.1 4363.4 4098.8 4317.5 4336.8 4340.6 4374.1 3726.5 3728.9 3732.7 3753.9 3758.0 5302.8 5334.1 5368.5 5373.6 5378.1 4715.5 4909.2 4934.2 4963.9 4972.4 5749.8 5825.9 5860.6 5872.7 5878.6 4111.2 4122.6 4136.5 4156.1 4156.6 5887.2 6067.5 6079.1 6101.3 6107.2 4176.6 4179.0 4190.9 4193.5 4193.9 4204.2 4210.9 4241.7 4259.0 4274.8 4752.0 4851.6 4915.5 4927.8 4940.6 5853.4 5880.0 5898.8 5925.9 5951.4 1531.2 1535.5 1545.4 1550.3 1555.7 917.4 1013.4 1025.8 1028.2 1037.1 5882.9 5898.0 5918.3 5920.4 5959.6 6307.0 6352.2 6370.5 6381.6 6421.8 5791.4 5826.7 5888.7 5945.9 5966.7 3341.6 3396.5 3402.7 3407.7 3412.0 6485.9 6540.5 6565.3 6573.9 6578.0 6515.9 6525.6 6563.5 6586.3 6615.4 6051.2 6358.6 6615.7 6636.3 6677.8 6065.7 6089.4 6114.4 6149.3 6154.3 5917.4 6054.3 6057.5 6068.4 6075.5 6140.0 6280.8 6291.0 6302.2 6333.2 4147.1 4247.7 4258.9 4259.3 4273.0 5817.9 6171.4 6190.2 6197.5 6199.4 5839.3 5890.7 5891.5 5945.6 5979.1 5959.2 5967.3 5986.4 5992.5 6003.3 5602.8 5844.2 5867.2 5868.2 5888.5 5885.8 5896.4 5988.2 5994.6 6046.2 5703.6 5863.0 5867.4 5870.4 5895.3 08:21:05 INFO - PROCESS | 23050 | 08:21:05 INFO - PROCESS | 23050 | [#5] yui.html Cycles:180 Average:13572.40 Median:50194.00 stddev:16713.08 (33.3%) stddev-sans-first:16731.92 08:21:05 INFO - PROCESS | 23050 | Values: 679.2 700.2 725.2 735.9 749.4 11235.2 11450.7 11486.5 11543.5 11559.1 11207.4 11243.2 11256.3 11275.2 11284.8 782.3 802.5 818.1 827.0 830.1 807.9 824.2 826.2 827.2 827.2 847.4 852.1 852.3 855.5 856.2 843.6 847.6 849.0 852.1 853.0 619.4 620.2 620.5 620.5 621.7 12074.8 12166.8 12176.3 12176.6 12223.1 10778.9 10889.0 10974.2 10982.9 11204.2 9829.5 10014.6 10042.8 10098.4 10320.8 3606.2 3611.0 3663.1 3693.2 3756.7 48382.8 48819.0 49276.0 49280.8 49555.3 8316.4 8341.7 8430.0 8509.1 8653.7 15155.7 15524.4 15550.3 15551.6 15575.3 6780.8 6816.3 6824.8 6837.8 6968.0 4161.5 4223.4 4263.6 4264.5 4279.4 3060.4 3071.2 3078.0 3098.7 3105.7 553.9 563.5 575.8 576.4 583.9 612.3 617.3 619.5 637.7 650.0 7891.6 8154.3 8160.9 8298.7 8319.4 580.5 595.4 618.9 623.7 650.2 3860.7 3887.8 3895.9 3959.8 4022.5 59805.4 61034.1 61444.4 63148.7 63464.0 52657.7 52679.7 54662.0 55682.2 55754.0 49518.8 50038.2 50349.7 50393.2 52424.9 8116.4 8315.9 8325.2 8340.5 8377.8 31896.5 32425.7 32467.8 32515.2 33285.0 40435.2 41903.3 44924.3 45501.8 45727.8 10225.7 10401.1 10406.5 10443.1 10544.5 10826.1 10995.5 11030.4 11117.3 11131.2 10596.0 10626.3 10745.8 10774.9 10964.9 10280.9 10406.2 10501.3 10608.6 10684.4 10486.3 10700.8 10724.8 10955.5 11060.1 8973.4 9099.6 9198.0 9257.1 9634.9 8954.8 9590.2 9614.5 9653.9 9735.6 08:21:05 INFO - PROCESS | 23050 | -------- Summary: end -------- 08:21:05 INFO - PROCESS | 23050 | 08:21:06 INFO - TEST-INFO | 23050: exit 0 08:21:06 INFO - TEST-OK | dromaeo_css | took 1109865ms 08:21:06 INFO - TEST-START | kraken 08:21:06 INFO - operating with platform_type : linux_ 08:21:06 INFO - Initialising browser for kraken test... 08:21:06 INFO - TEST-INFO | started process 23283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpejyqN8/profile http://localhost:41116/getInfo.html) 08:21:09 INFO - PROCESS | 23283 | 08:21:09 INFO - PROCESS | 23283 | (process:23353): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:21:10 INFO - PROCESS | 23283 | __metrics Screen width/height:1600/1200 08:21:10 INFO - PROCESS | 23283 | colorDepth:24 08:21:10 INFO - PROCESS | 23283 | Browser inner width/height: 1024/697 08:21:10 INFO - PROCESS | 23283 | __metrics 08:21:11 ERROR - PROCESS | 23283 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:21:12 INFO - TEST-INFO | 23283: exit 0 08:21:12 INFO - Browser initialized. 08:21:12 INFO - Running cycle 1/1 for kraken test... 08:21:12 INFO - TEST-INFO | started process 23404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpejyqN8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:21:14 INFO - PROCESS | 23404 | 08:21:14 INFO - PROCESS | 23404 | (process:23465): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:21:24 INFO - PROCESS | 23404 | RSS: Main: 164864000 08:21:24 INFO - PROCESS | 23404 | 08:21:26 INFO - PROCESS | 23404 | Cycle 1(1): loaded http://localhost:41116/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41116/tests/kraken/driver.html?testName=audio-beat-detection) 08:21:27 INFO - PROCESS | 23404 | RSS: Main: 169488384 08:21:27 INFO - PROCESS | 23404 | 08:21:30 INFO - PROCESS | 23404 | Cycle 1(1): loaded http://localhost:41116/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41116/tests/kraken/driver.html?testName=audio-dft) 08:21:30 INFO - PROCESS | 23404 | RSS: Main: 172728320 08:21:30 INFO - PROCESS | 23404 | 08:21:33 INFO - PROCESS | 23404 | Cycle 1(1): loaded http://localhost:41116/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41116/tests/kraken/driver.html?testName=audio-fft) 08:21:34 INFO - PROCESS | 23404 | RSS: Main: 163414016 08:21:34 INFO - PROCESS | 23404 | 08:21:36 INFO - PROCESS | 23404 | Cycle 1(1): loaded http://localhost:41116/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41116/tests/kraken/driver.html?testName=audio-oscillator) 08:21:37 INFO - PROCESS | 23404 | RSS: Main: 162918400 08:21:37 INFO - PROCESS | 23404 | 08:21:39 INFO - PROCESS | 23404 | Cycle 1(1): loaded http://localhost:41116/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41116/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:21:40 INFO - PROCESS | 23404 | RSS: Main: 164257792 08:21:40 INFO - PROCESS | 23404 | 08:21:43 INFO - PROCESS | 23404 | Cycle 1(1): loaded http://localhost:41116/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41116/tests/kraken/driver.html?testName=imaging-darkroom) 08:21:43 INFO - PROCESS | 23404 | RSS: Main: 165085184 08:21:43 INFO - PROCESS | 23404 | 08:21:47 INFO - PROCESS | 23404 | Cycle 1(1): loaded http://localhost:41116/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41116/tests/kraken/driver.html?testName=imaging-desaturate) 08:21:47 INFO - PROCESS | 23404 | RSS: Main: 167047168 08:21:47 INFO - PROCESS | 23404 | 08:21:50 INFO - PROCESS | 23404 | Cycle 1(1): loaded http://localhost:41116/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41116/tests/kraken/driver.html?testName=json-parse-financial) 08:21:51 INFO - PROCESS | 23404 | RSS: Main: 167989248 08:21:51 INFO - PROCESS | 23404 | 08:21:52 INFO - PROCESS | 23404 | Cycle 1(1): loaded http://localhost:41116/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41116/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:21:53 INFO - PROCESS | 23404 | RSS: Main: 167682048 08:21:53 INFO - PROCESS | 23404 | 08:21:55 INFO - PROCESS | 23404 | Cycle 1(1): loaded http://localhost:41116/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41116/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:21:55 INFO - PROCESS | 23404 | RSS: Main: 167374848 08:21:55 INFO - PROCESS | 23404 | 08:21:57 INFO - PROCESS | 23404 | Cycle 1(1): loaded http://localhost:41116/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41116/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:21:58 INFO - PROCESS | 23404 | RSS: Main: 167718912 08:21:58 INFO - PROCESS | 23404 | 08:22:01 INFO - PROCESS | 23404 | Cycle 1(1): loaded http://localhost:41116/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41116/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:22:01 INFO - PROCESS | 23404 | RSS: Main: 168206336 08:22:01 INFO - PROCESS | 23404 | 08:22:04 INFO - PROCESS | 23404 | Cycle 1(1): loaded http://localhost:41116/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41116/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:22:05 INFO - PROCESS | 23404 | RSS: Main: 168275968 08:22:05 INFO - PROCESS | 23404 | 08:22:06 INFO - PROCESS | 23404 | Cycle 1(1): loaded http://localhost:41116/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41116/tests/kraken/driver.html?testName=ai-astar) 08:22:07 INFO - PROCESS | 23404 | RSS: Main: 169832448 08:22:07 INFO - PROCESS | 23404 | 08:22:07 INFO - PROCESS | 23404 | __start_tp_report 08:22:07 INFO - PROCESS | 23404 | _x_x_mozilla_page_load 08:22:07 INFO - PROCESS | 23404 | _x_x_mozilla_page_load_details 08:22:07 INFO - PROCESS | 23404 | |i|pagename|runs| 08:22:07 INFO - PROCESS | 23404 | |0;ai-astar;113;107;112;111;112;126;113;111;111;112 08:22:07 INFO - PROCESS | 23404 | |1;audio-beat-detection;156;134;159;192;128;157;153;150;176;134 08:22:07 INFO - PROCESS | 23404 | |2;audio-dft;163;163;162;161;163;165;173;163;165;164 08:22:07 INFO - PROCESS | 23404 | |3;audio-fft;76;74;75;158;77;74;77;75;149;73 08:22:07 INFO - PROCESS | 23404 | |4;audio-oscillator;96;93;146;93;94;95;157;93;93;141 08:22:07 INFO - PROCESS | 23404 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;118;118 08:22:07 INFO - PROCESS | 23404 | |6;imaging-darkroom;147;149;146;148;146;147;146;146;147;145 08:22:07 INFO - PROCESS | 23404 | |7;imaging-desaturate;97;95;96;95;96;95;95;96;95;96 08:22:07 INFO - PROCESS | 23404 | |8;json-parse-financial;58;59;63;57;59;61;59;80;60;57 08:22:07 INFO - PROCESS | 23404 | |9;json-stringify-tinderbox;61;60;63;61;62;61;61;61;60;61 08:22:07 INFO - PROCESS | 23404 | |10;stanford-crypto-aes;77;84;77;77;77;78;78;79;79;79 08:22:07 INFO - PROCESS | 23404 | |11;stanford-crypto-ccm;133;130;123;133;123;125;126;126;164;132 08:22:07 INFO - PROCESS | 23404 | |12;stanford-crypto-pbkdf2;171;170;166;167;172;170;171;173;175;167 08:22:07 INFO - PROCESS | 23404 | |13;stanford-crypto-sha256-iterative;72;70;69;71;72;69;70;70;70;70 08:22:07 INFO - PROCESS | 23404 | __end_tp_report 08:22:07 INFO - PROCESS | 23404 | __start_cc_report 08:22:07 INFO - PROCESS | 23404 | _x_x_mozilla_cycle_collect,852 08:22:07 INFO - PROCESS | 23404 | __end_cc_report 08:22:07 INFO - PROCESS | 23404 | __startTimestamp1461856927093__endTimestamp 08:22:07 INFO - PROCESS | 23404 | 08:22:07 INFO - PROCESS | 23404 | ------- Summary: start ------- 08:22:07 INFO - PROCESS | 23404 | Number of tests: 14 08:22:07 INFO - PROCESS | 23404 | 08:22:07 INFO - PROCESS | 23404 | [#0] ai-astar Cycles:10 Average:112.80 Median:112.00 stddev:4.94 (4.4%) stddev-sans-first:5.24 08:22:07 INFO - PROCESS | 23404 | Values: 113.0 107.0 112.0 111.0 112.0 126.0 113.0 111.0 111.0 112.0 08:22:07 INFO - PROCESS | 23404 | 08:22:07 INFO - PROCESS | 23404 | [#1] audio-beat-detection Cycles:10 Average:153.90 Median:156.50 stddev:19.60 (12.5%) stddev-sans-first:20.78 08:22:07 INFO - PROCESS | 23404 | Values: 156.0 134.0 159.0 192.0 128.0 157.0 153.0 150.0 176.0 134.0 08:22:07 INFO - PROCESS | 23404 | 08:22:07 INFO - PROCESS | 23404 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:3.33 (2.0%) stddev-sans-first:3.50 08:22:07 INFO - PROCESS | 23404 | Values: 163.0 163.0 162.0 161.0 163.0 165.0 173.0 163.0 165.0 164.0 08:22:07 INFO - PROCESS | 23404 | 08:22:07 INFO - PROCESS | 23404 | [#3] audio-fft Cycles:10 Average:90.80 Median:75.00 stddev:33.14 (44.2%) stddev-sans-first:34.71 08:22:07 INFO - PROCESS | 23404 | Values: 76.0 74.0 75.0 158.0 77.0 74.0 77.0 75.0 149.0 73.0 08:22:07 INFO - PROCESS | 23404 | 08:22:07 INFO - PROCESS | 23404 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:93.00 stddev:26.46 (28.4%) stddev-sans-first:27.56 08:22:07 INFO - PROCESS | 23404 | Values: 96.0 93.0 146.0 93.0 94.0 95.0 157.0 93.0 93.0 141.0 08:22:07 INFO - PROCESS | 23404 | 08:22:07 INFO - PROCESS | 23404 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:22:07 INFO - PROCESS | 23404 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 08:22:07 INFO - PROCESS | 23404 | 08:22:07 INFO - PROCESS | 23404 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:1.16 (0.8%) stddev-sans-first:1.22 08:22:07 INFO - PROCESS | 23404 | Values: 147.0 149.0 146.0 148.0 146.0 147.0 146.0 146.0 147.0 145.0 08:22:07 INFO - PROCESS | 23404 | 08:22:07 INFO - PROCESS | 23404 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 08:22:07 INFO - PROCESS | 23404 | Values: 97.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 08:22:07 INFO - PROCESS | 23404 | 08:22:07 INFO - PROCESS | 23404 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:59.50 stddev:6.82 (11.5%) stddev-sans-first:7.12 08:22:07 INFO - PROCESS | 23404 | Values: 58.0 59.0 63.0 57.0 59.0 61.0 59.0 80.0 60.0 57.0 08:22:07 INFO - PROCESS | 23404 | 08:22:07 INFO - PROCESS | 23404 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.88 (1.4%) stddev-sans-first:0.93 08:22:07 INFO - PROCESS | 23404 | Values: 61.0 60.0 63.0 61.0 62.0 61.0 61.0 61.0 60.0 61.0 08:22:07 INFO - PROCESS | 23404 | 08:22:07 INFO - PROCESS | 23404 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:78.50 stddev:2.12 (2.7%) stddev-sans-first:2.18 08:22:07 INFO - PROCESS | 23404 | Values: 77.0 84.0 77.0 77.0 77.0 78.0 78.0 79.0 79.0 79.0 08:22:07 INFO - PROCESS | 23404 | 08:22:07 INFO - PROCESS | 23404 | [#11] stanford-crypto-ccm Cycles:10 Average:131.50 Median:131.00 stddev:12.07 (9.2%) stddev-sans-first:12.79 08:22:07 INFO - PROCESS | 23404 | Values: 133.0 130.0 123.0 133.0 123.0 125.0 126.0 126.0 164.0 132.0 08:22:07 INFO - PROCESS | 23404 | 08:22:07 INFO - PROCESS | 23404 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:171.00 stddev:2.86 (1.7%) stddev-sans-first:3.02 08:22:07 INFO - PROCESS | 23404 | Values: 171.0 170.0 166.0 167.0 172.0 170.0 171.0 173.0 175.0 167.0 08:22:07 INFO - PROCESS | 23404 | 08:22:07 INFO - PROCESS | 23404 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.00 stddev:1.06 (1.5%) stddev-sans-first:0.93 08:22:07 INFO - PROCESS | 23404 | Values: 72.0 70.0 69.0 71.0 72.0 69.0 70.0 70.0 70.0 70.0 08:22:07 INFO - PROCESS | 23404 | -------- Summary: end -------- 08:22:07 INFO - PROCESS | 23404 | 08:22:08 INFO - TEST-INFO | 23404: exit 0 08:22:08 INFO - TEST-OK | kraken | took 61759ms 08:22:08 INFO - SUITE-END | took 1171s 08:22:08 INFO - Completed test suite (00:19:31) 08:22:08 INFO - javascript benchmark 08:22:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3112.875484980601, 3176.301213732978, 3191.3936352093115, 3225.838708064596, 3236.3203727217283, 5308.177232528959, 5337.733113344332, 5399.163129714901, 5416.891662166754, 5424.0, 5318.574514038877, 5386.542143917772, 5406.486383793543, 5414.106672399059, 5418.91871621926, 4936.308916751657, 5029.7988080476825, 5032.949670503303, 5050.545450909417, 5090.770915308802, 1140.8349214476016, 4992.700437973715, 5033.270175824521, 5051.040302342543, 5098.158803797369, 4894.290327902452, 4952.975235123801, 4989.750512474362, 4997.400311962551, 5036.622253330978, 4964.329815474937, 4968.527989840959, 4975.427825800043, 5012.473690262506, 5039.596832253411, 4851.490593487668, 5018.924716129261, 5022.698638081727, 5028.245763135523, 5076.517730815566, 5252.973735131338, 5315.069862774038, 5321.228421878806, 5322.92015619766, 5406.107992181285, 5853.0635098384055, 5853.092770620518, 5857.912131318034, 5869.647821130746, 5869.941300587025, 5886.1465087562065, 5903.645781253095, 5908.911366329508, 5910.113482977545, 5990.73041713124, 5422.240886275925, 5466.945330546723, 5472.097103977839, 5478.342598888119, 5511.696856672881, 5940.198073260054, 5962.165296858443, 5963.105534169909, 5963.463288304073, 5971.28344598651, 5595.328560572757, 5615.410381909923, 5669.603127781098, 5688.431156884279, 5739.0, 5838.299404071538, 5840.88318233633, 5847.795327163529, 5854.882902342015, 5869.735861886225, 5822.650640961556, 5835.153902684087, 5836.387179346108, 5839.065749480063, 5845.912311315334, 5665.065264231355, 5849.853753656193, 5907.350191478934, 5921.555883308769, 5959.821205363846, 4271.893202669959, 4341.869743907688, 4381.101874115799, 4389.034412429261, 4405.823767049346, 3903.434002069741, 3919.3729003359895, 3943.6253555912144, 3956.97808995485, 3971.860984865516, 5335.306410166653, 5465.0, 5556.638818476786, 5610.0, 5621.634593751393, 5746.770129194785, 5766.192733017381, 5766.654000759884, 5783.987802134694, 5801.53587712982, 5409.053415652245, 5457.890842183134, 5469.425710300441, 5473.397926228112, 5476.205950137208, 4766.976165119152, 4953.7275449849885, 5009.699418034929, 5055.115354812893, 5063.746812659352, 5926.7925622603, 5927.0, 5939.732712027969, 5972.343042265347, 5979.850503737442, 5684.971575142098, 5786.826395208151, 5792.82621521355, 5821.534277257894, 5830.154627579062, 5974.342822289458, 6027.336992930862, 6035.517158627387, 6039.15451836752, 6076.817695469143, 5754.0, 5815.970920145542, 5841.240638716939, 5845.386234445322, 5852.268466441695, 5548.0845660467185, 5823.912641310299, 5850.5027072699295, 5856.707164641665, 5880.411958804086, 5680.176374425768, 5681.0910254359105, 5700.458456446631, 5711.457411545896, 5751.683657398883, 5664.5751568631695, 5666.801661941812, 5673.0, 5694.1458781183155, 5694.402087780723, 5380.273663055594, 5549.1676248563035, 5574.693391863487, 5607.41122182165, 5636.802711905064, 5327.067763141357, 5496.093144631251, 5803.622764520293, 5809.796657116981, 5829.0, 5652.773889044557, 5653.180288858175, 5670.489655930986, 5690.0, 5700.173474846207], "value": 5337.2810509947685, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.6743592178185, 639.4852144024061, 647.8769033883561, 653.9705713242902, 670.213880009774, 36751.0, 37170.8141459293, 37196.814015929885, 37544.62455375445, 37589.24821503572, 40936.18127637445, 41714.37428438576, 41963.0, 42043.3693494597, 42084.0, 8479.533625650587, 8688.782780430509, 8708.956455217714, 8731.432456890281, 8752.649894004233, 8698.0, 8742.0, 8808.955955220215, 8826.955865220665, 8827.646894124227, 8815.338849586275, 8816.515091669955, 8844.204021638052, 8901.620248861436, 8909.0, 8755.693550725726, 8791.824163516694, 8859.955700221457, 8873.0, 8874.955625221864, 8640.481571105754, 8702.216800487986, 8746.169113934166, 8752.299816014704, 8787.956060219722, 37665.045170257, 37991.0, 38045.61954380448, 38244.80877595594, 38471.0, 2846.6762955225713, 3286.917827054319, 3335.182880194344, 3369.9663003369897, 3418.2479854431986, 30735.846320768476, 30827.0, 31219.687803121906, 31304.21739456509, 31324.530132048036, 4087.7751723655188, 4099.282625540519, 4103.97948010258, 4109.260333140033, 4115.8765237042935, 273670.0, 273825.0, 274115.0, 274824.0, 276001.0, 32021.19947001297, 32874.17814554607, 36012.279754404764, 36224.45663315053, 36316.0, 33796.831015844764, 33884.49173262403, 33954.32091358209, 34080.65919340775, 34171.658283417346, 14827.555173344817, 14947.327370268364, 15037.0, 15056.548303550911, 15085.0, 13139.14595551286, 13235.66910827237, 13264.602061937965, 13266.204027758366, 13314.533991310258, 8218.917810821935, 8264.297534709496, 8292.880461137669, 8301.750947471586, 8370.0, 3279.754018448626, 3315.535824984504, 3316.6185888623118, 3333.8999830005137, 3347.5982882053822, 1075.1291453922347, 1115.5426275227119, 1158.8841115888345, 1272.929988850622, 1282.6472720002075, 32080.679193208234, 32333.838330808667, 32406.83796581002, 32699.346013079605, 32723.50914736281, 1114.1588100983706, 1122.3322123336602, 1145.9427028648533, 1146.4267866066966, 1172.8006238939402, 16355.0, 16448.0, 17163.227654755567, 17229.827701723072, 17336.39322623702, 498202.0, 501920.0, 502567.0, 506577.0, 507048.0, 55336.16995745067, 55603.44396556063, 55827.441725582226, 56024.0, 56036.71981640147, 1352.1751731443812, 1356.5591182865608, 1358.8777010069339, 1370.0272806307435, 1388.3821699343896, 30136.547951780303, 30744.385112298078, 30880.845595771876, 30887.38225235438, 31681.5247771279, 48907.75546122246, 48939.75530122327, 49007.50992490172, 49242.26136607882, 49312.0, 302242.0, 303287.0, 304157.0, 304913.0, 305300.0, 27381.726182738716, 27705.168844934684, 28157.155285341472, 28280.575791363557, 28302.292442689097, 47986.760066199444, 48595.27107093467, 48816.2677559844, 49199.50800492092, 49893.501064990334, 39511.0, 39885.0, 40197.0, 40355.1928961425, 40997.59002409938, 38039.80980095082, 39463.21073578455, 39964.60035399609, 39975.40036899507, 40450.34820995623, 33830.661693383736, 36181.638183617826, 37546.06134846651, 40247.0, 42224.57775422329, 30668.233294167825, 31677.0, 31802.681973179973, 31827.522587160747, 31848.840755796075, 25170.24489265325, 25490.10784622529, 25600.359991000372, 25878.0, 26134.607980879922], "value": 17902.46354991021, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.3205818051134, 401.71076824686253, 402.9617186367295, 403.5802765124271, 412.5152945289285, 13597.52408665697, 17887.195076221567, 18287.26850925963, 18406.171722272495, 18568.257269709196, 16779.83220167798, 17200.655986880287, 17510.299588016464, 17587.648247035053, 17735.73396399055, 5540.667559946396, 5557.972210138953, 5659.462351076661, 5687.914681279784, 5690.800821971232, 5742.942570574303, 5778.422157784209, 5781.248437703092, 5816.098504731774, 5839.474447299742, 5733.111367738007, 5760.4815566599, 5761.308642962829, 5765.394633563478, 5803.50670193032, 5649.745761440725, 5796.217510636052, 5805.5065319447895, 5870.236869207019, 5894.970525147368, 5445.319335083114, 5672.801451949162, 5697.743601537941, 5750.65496070233, 5751.539876809887, 13341.733165336736, 13654.658633534142, 13687.0, 13763.31183440824, 13930.164190148624, 2158.1475317249756, 2170.0885628036262, 2244.62963611004, 2289.3132060381818, 2564.3460917466114, 9231.261499080058, 9272.629094836198, 9334.953325233399, 9474.763130921714, 9671.758206044835, 1895.3934740882924, 1948.6395016921915, 1966.783653798081, 1967.9901600491905, 2021.706852506393, 81566.59216703937, 82144.17855821425, 82388.0, 82879.58560207221, 83018.0, 10816.945915270373, 10928.562857485611, 10930.070943969851, 10965.342079475256, 10998.560057597606, 15466.226688665522, 15479.226038698245, 15520.844791552166, 15565.509518477216, 15581.688366232838, 8152.551609661526, 8181.140980197112, 8267.29727973117, 8385.496870187808, 8500.74497765068, 7632.46572739914, 7830.491018083806, 7880.2513761192595, 7922.207779222032, 8263.049749278789, 4624.838130665411, 4719.197736384823, 4731.219348807408, 4739.976300118477, 4846.055019271279, 1893.2616279650672, 1970.5960278142945, 1981.8810871347766, 1991.9800801991794, 2010.6776672942774, 942.820864035831, 968.4576637083256, 1001.5593139018808, 1059.9735006624896, 1085.9728506787235, 17392.913035434995, 18082.728759068625, 18569.721454178198, 18577.323286688064, 18683.15925783343, 994.6568433890296, 1008.621766837436, 1033.2767063055892, 1077.369738702852, 1086.1365214654368, 10259.435731034864, 10428.530716117793, 10524.684259472227, 10578.735531611617, 10692.946535267274, 460831.0, 471968.0, 484846.0, 486132.0, 489240.0, 64417.67791161014, 67921.0, 81544.0, 90247.54876225708, 97179.51410242904, 1006.942710154335, 1025.5590096258532, 1026.3944272879037, 1030.6289735695143, 1058.8411738239479, 16350.0, 16923.576910577332, 16986.320547177973, 17108.401205957733, 17439.47681569555, 38641.0, 38684.22631547297, 39552.0, 39714.40428393634, 39766.0, 54345.0, 54467.72766136144, 54865.0, 54907.72546137404, 55252.0, 6072.1498990140535, 8111.229433203836, 8149.877751833846, 8480.236778689947, 8579.871301930601, 9303.069693030642, 12875.935620322212, 12903.354832258537, 13105.868941310466, 13873.58379248624, 11350.54597816078, 11568.13239007061, 11805.881941180478, 11861.822072668745, 12202.084843636585, 11082.725486569148, 11220.495077721685, 11308.604198853001, 11331.32012079278, 11567.421628918688, 11627.6511704649, 11727.824082638597, 11831.585894493652, 12330.50677972871, 12349.19730217533, 8374.413791034813, 8789.648414063366, 8903.821923561363, 8905.064968178507, 9041.05068967749, 8545.273651739672, 10947.507362168562, 12429.12996090265, 12459.377031148588, 12517.31016312786], "value": 8927.674636547263, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.6774208061104, 1445.4868521674805, 1511.8488151184877, 1677.094369040718, 1704.917377465309, 7212.495125341228, 7880.527168369902, 8039.075506316775, 8357.456765310251, 8373.832523349536, 8057.073436554798, 8080.757577272677, 8145.877811832813, 8155.510669359843, 8173.7139200128, 2227.2984010036866, 2269.3305474884946, 2271.432141964509, 2273.977260227393, 2276.84062115652, 2231.0852550454315, 2252.31304452142, 2272.602294598447, 2290.141197051106, 2299.6435552489306, 2261.118163916074, 2262.4570103175283, 2273.863568185914, 2279.430142464384, 2296.437372843656, 2185.2351676913113, 2205.889705514726, 2209.1936443198197, 2221.6112180368373, 2228.732552093743, 2197.077227564411, 2200.922967696123, 2205.3604454708116, 2206.205765924266, 2213.8450308478414, 8054.275115239657, 8093.069297030858, 8099.230573095547, 8136.389770767157, 8166.918330816675, 4734.55021772931, 4865.391826021747, 4928.1129396708575, 4934.037862616791, 4936.679115857493, 3141.4659507883716, 3187.1394723424546, 3314.9668503315143, 3318.3529211803707, 3332.2002719347424, 1107.9667609971634, 1112.9499172537173, 1120.7086157599, 1162.1690491298677, 1182.834403183555, 11323.320600763898, 11330.320180789178, 11333.773324533464, 11377.94311028448, 11424.543018279343, 4242.342436922282, 4297.828086876552, 4341.15347507233, 4379.0, 4397.614751353313, 9635.181009614122, 9654.855177172349, 9675.612975481043, 9690.0, 9724.17344525709, 4801.063792560487, 4843.539863712942, 4904.239842824368, 4904.8038078477175, 4916.926246106311, 4048.959510404917, 4457.621102206349, 4525.932111018337, 4559.772011399416, 4607.0785842831565, 3835.4822099016274, 3881.204353107606, 3935.7244992850224, 3977.204559088194, 3992.940105898414, 1268.9555865544662, 1279.2324605236784, 1284.563248495516, 1287.6394609509352, 1306.3598836570202, 842.7640260727006, 884.3146561414826, 890.6036813618007, 909.8771665825161, 914.5930061122737, 5396.9730151348995, 5471.699056551928, 5545.944540554624, 5631.915521267184, 5650.943490565041, 965.6475386484024, 976.3263348289657, 1002.5538635307364, 1011.3982180602529, 1023.0741179232806, 3784.7729136251914, 3926.784026878549, 3963.504561929759, 4001.459802926626, 4011.13760541485, 9863.260255480867, 10153.4923253837, 10301.9484902575, 10330.690079297634, 10357.792844143074, 10148.492575371201, 10186.592536298613, 10258.487075646188, 10262.486875656337, 10262.538185781657, 7356.786130288442, 7534.849303013909, 7626.733064342832, 7672.386209103258, 7966.721164759206, 5447.812590455873, 5635.323761148688, 5745.770169193185, 5748.626339287933, 5817.331006934257, 9110.772230694285, 9477.952610236905, 9503.762405939908, 9540.189083927944, 9695.51522423862, 9565.760855978378, 9637.566309515949, 9693.079157480028, 9737.80524389494, 9846.409215447096, 6611.801645950629, 7125.3230943060325, 7285.890711639224, 7429.07136607924, 7474.588897610466, 7726.7681969541, 7781.572013539309, 7844.411669124953, 7870.960645196967, 7875.409344299086, 6991.650417479004, 7313.488055836253, 7353.926460735324, 7381.704731810883, 7447.292507211806, 6777.457803375817, 6869.725210991504, 6889.207741109836, 6921.826954326182, 6960.825979350557, 6218.81343559694, 6402.775902843378, 6409.679516024087, 6421.229452465734, 6421.903671445026, 4849.248366503198, 4889.168841296917, 4902.093112774148, 4930.556249937523, 4949.727764972817, 4815.6388270880525, 4863.48933362006, 4938.827141050046, 4956.479569645136, 5060.089183946778], "value": 4404.364290564027, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.0680172074313, 309.1251757526201, 311.23281112058777, 317.6902520042958, 321.9613646362437, 5532.446755324466, 5580.358258800239, 5583.8604034899145, 5589.049861523541, 5621.57838162138, 5503.229547863302, 5504.64219825711, 5509.807156749514, 5516.9448305516935, 5518.641288316257, 4073.3075377185874, 4191.119864828374, 4340.435743353375, 4354.303311470166, 4367.672424568154, 4339.956600433987, 4347.869553915989, 4365.672574556921, 4365.934510982322, 4376.146651402978, 4290.721103128302, 4341.4790225172865, 4356.433663623725, 4361.127774445108, 4363.38912552243, 4098.815553300094, 4317.4819021717285, 4336.761478118702, 4340.587644173798, 4374.147041326943, 3726.5341832270965, 3728.8694895678523, 3732.720045996561, 3753.8686145985034, 3758.022914042341, 5302.840914772524, 5334.0665383557725, 5368.516833485005, 5373.570114390839, 5378.112611419111, 4715.4577223619035, 4909.21452567591, 4934.1611925972675, 4963.900721985576, 4972.353594032788, 5749.770009199627, 5825.854353641151, 5860.648361098305, 5872.7357268923, 5878.559108066869, 4111.177764447122, 4122.6083522065355, 4136.524299705542, 4156.085661154541, 4156.605122513356, 5887.234659494281, 6067.484263837579, 6079.148919151322, 6101.328853826076, 6107.175531303306, 4176.644985176234, 4178.979105104455, 4190.916181676349, 4193.475815523059, 4193.895152621209, 4204.180184863983, 4210.894727631834, 4241.660667146621, 4259.0, 4274.829006839692, 4751.95248047522, 4851.611871050308, 4915.483874193158, 4927.792690790708, 4940.555350018443, 5853.443922827325, 5880.0, 5898.84972430372, 5925.851853703692, 5951.3751056139345, 1531.2420351925869, 1535.4932872152385, 1545.4359158907143, 1550.3333566566484, 1555.7277476441577, 917.4266083697689, 1013.4324778124274, 1025.8153532364247, 1028.1928685981468, 1037.0510982451124, 5882.941170588239, 5897.970510147422, 5918.319393269743, 5920.37189772816, 5959.553033522503, 6307.0, 6352.174217351715, 6370.490360771128, 6381.649009304533, 6421.8073457796345, 5791.420857914175, 5826.73779679907, 5888.735006924699, 5945.851353716105, 5966.701664916737, 3341.5655964724915, 3396.541466901986, 3402.6937575618313, 3407.744419168572, 3411.9658803412144, 6485.902711459332, 6540.509461790385, 6565.277819439858, 6573.934260657428, 6578.026592022374, 6515.902261466082, 6525.5740736112975, 6563.540552161398, 6586.308437614078, 6615.437687796495, 6051.213342265565, 6358.598149989733, 6615.669216539154, 6636.270010298863, 6677.766278180337, 6065.666388348507, 6089.376820791799, 6114.419130182626, 6149.292831324455, 6154.323024467394, 5917.378675239038, 6054.303755068047, 6057.515398768176, 6068.393160683896, 6075.483583895419, 6139.969300153471, 6280.780172693934, 6291.0, 6302.180716506825, 6333.20834895638, 4147.108371700099, 4247.66018718508, 4258.87223383299, 4259.318509038539, 4272.957270427256, 5817.94182058174, 6171.413715697002, 6190.1952746142715, 6197.4732147767945, 6199.442050215503, 5839.299284085937, 5890.676012819336, 5891.499222565958, 5945.64326140433, 5979.133025711334, 5959.22530071088, 5967.343592204767, 5986.4013598639785, 5992.520598352208, 6003.309619393651, 5602.775888964396, 5844.181814545882, 5867.178594996619, 5868.23712917318, 5888.528917686661, 5885.76398956224, 5896.410358964241, 5988.191594134911, 5994.550408719277, 6046.244219472566, 5703.62926409782, 5863.0, 5867.383924688017, 5870.383609721089, 5895.263092113486], "value": 4504.670025499415, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.1646275081648, 700.2332445971663, 725.1775691650525, 735.9227281135484, 749.3892477630731, 11235.157363197752, 11450.7137321567, 11486.483108260127, 11543.538258469662, 11559.133065020114, 11207.439628018587, 11243.212975091747, 11256.268342557729, 11275.210735248536, 11284.830727539073, 782.3154739602847, 802.5425507460735, 818.0551463060175, 826.962786674601, 830.1366578758084, 807.8545861744883, 824.1758241758242, 826.2027143806225, 827.1934863508092, 827.2017503109498, 847.4068152293388, 852.1180578101666, 852.3479538153317, 855.4952577978992, 856.2379482260793, 843.6414523827349, 847.6439895244013, 849.049065047145, 852.1393392673444, 853.0190281176665, 619.3991827926903, 620.1751670278519, 620.4756980351596, 620.5066971757464, 621.6643012773097, 12074.758504829942, 12166.81749773754, 12176.330301833395, 12176.634700958986, 12223.14437989341, 10778.946105269502, 10889.0, 10974.231803773739, 10982.890171098346, 11204.15968802335, 9829.459379734111, 10014.59941602335, 10042.849357259647, 10098.394096354243, 10320.79358412835, 3606.1705807664384, 3610.981945090284, 3663.139162296858, 3693.1505753676806, 3756.69946404287, 48382.758086209695, 48819.02361952741, 49276.0, 49280.75359623215, 49555.25667114996, 8316.37627177964, 8341.666333346599, 8429.957850210709, 8509.149085091565, 8653.6538538459, 15155.696886062216, 15524.379024839105, 15550.300236489385, 15551.611209719622, 15575.299111540007, 6780.796576102724, 6816.284290149463, 6824.761133360308, 6837.760678376233, 6967.965160174167, 4161.500619925629, 4223.429836972031, 4263.573642635712, 4264.545359391126, 4279.422277992493, 3060.3726236121543, 3071.170783888382, 3077.9846100769355, 3098.690130986883, 3105.6894310568764, 553.9446055394428, 563.5041163775851, 575.8013485347549, 576.3544829790577, 583.9328477225089, 612.3203244398803, 617.274702224884, 619.4734475695623, 637.7385272038442, 650.0314531348257, 7891.644875980594, 8154.347652187811, 8160.877586836202, 8298.70954516589, 8319.376046796515, 580.4891695308102, 595.3689089565075, 618.9257289125334, 623.6943897490288, 650.2197363164222, 3860.729748917549, 3887.78617176058, 3895.917122496241, 3959.762414255154, 4022.517297924268, 59805.401945980855, 61034.084488732704, 61444.38555614476, 63148.684256578425, 63464.0, 52657.736711316196, 52679.73660131675, 54662.0, 55682.16476752852, 55754.0, 49518.75240623774, 50038.24942625863, 50349.74825125851, 50393.24410133851, 52424.903003879415, 8116.431849770459, 8315.916840831514, 8325.221757990535, 8340.541270230196, 8377.83244335122, 31896.49138594706, 32425.67574324321, 32467.837660811543, 32515.18712032218, 33285.0, 40435.191296173325, 41903.27628704125, 44924.326135107345, 45501.77249113733, 45727.77136114298, 10225.693229203136, 10401.115905148146, 10406.47967601632, 10443.112335451571, 10544.472776360997, 10826.13390928708, 10995.450227488753, 11030.393328367018, 11117.27737697047, 11131.154076141185, 10596.033110729008, 10626.256162068581, 10745.785084298426, 10774.892251077388, 10964.890351096707, 10280.897191027994, 10406.219533534864, 10501.26491145643, 10608.628697995533, 10684.358938463716, 10486.318389304672, 10700.83948740754, 10724.839127413252, 10955.50700218476, 11060.059894908702, 8973.37186396946, 9099.636014559343, 9198.0, 9257.120573545502, 9634.855477167708, 8954.820903582022, 9590.232781377334, 9614.51927403613, 9653.855192172263, 9735.610575576897], "value": 6046.702009870212, "unit": "score"}], "name": "dromaeo_css", "value": 6839.316240625761, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 112.0, 111.0, 112.0, 126.0, 113.0, 111.0, 111.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 134.0, 159.0, 192.0, 128.0, 157.0, 153.0, 150.0, 176.0, 134.0], "value": 153.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 161.0, 163.0, 165.0, 173.0, 163.0, 165.0, 164.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 158.0, 77.0, 74.0, 77.0, 75.0, 149.0, 73.0], "value": 90.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 93.0, 146.0, 93.0, 94.0, 95.0, 157.0, 93.0, 93.0, 141.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 146.0, 148.0, 146.0, 147.0, 146.0, 146.0, 147.0, 145.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 63.0, 57.0, 59.0, 61.0, 59.0, 80.0, 60.0, 57.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 63.0, 61.0, 62.0, 61.0, 61.0, 61.0, 60.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 84.0, 77.0, 77.0, 77.0, 78.0, 78.0, 79.0, 79.0, 79.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 123.0, 133.0, 123.0, 125.0, 126.0, 126.0, 164.0, 132.0], "value": 131.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 166.0, 167.0, 172.0, 170.0, 171.0, 173.0, 175.0, 167.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 69.0, 71.0, 72.0, 69.0, 70.0, 70.0, 70.0, 70.0], "value": 70.3, "unit": "score"}], "name": "kraken", "value": 1564.3, "alertThreshold": 2.0}]} 08:22:08 INFO - Return code: 0 08:22:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:22:08 ERROR - # TBPL SUCCESS # 08:22:08 INFO - Running post-action listener: _resource_record_post_action 08:22:08 INFO - Running post-run listener: _resource_record_post_run 08:22:09 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535179264; Read time: 16; Write time: 420184 08:22:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 244518912; Read time: 0; Write time: 216172 08:22:09 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290660352; Read time: 16; Write time: 204012 08:22:09 INFO - Running post-run listener: _upload_blobber_files 08:22:09 INFO - Blob upload gear active. 08:22:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:22:09 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 08:22:09 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:22:09 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:22:09 INFO - (blobuploader) - INFO - Open directory for files ... 08:22:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:22:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:22:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:10 INFO - (blobuploader) - INFO - Done attempting. 08:22:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:22:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:22:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:22:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:22:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:22:11 INFO - (blobuploader) - INFO - Done attempting. 08:22:11 INFO - (blobuploader) - INFO - Iteration through files over. 08:22:11 INFO - Return code: 0 08:22:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:22:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:22:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa133b50459a95d8a6da9d5ec22b405e964a95021368460e18ac746b330c3408ac146a94bc353f61e1c2bb433ab9ea7854008217554395b8818488ae478aacd2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/798fdc89d386219c5f8ca442908d6b06b5c341076da73cf6074cfedfd6a3e0be48884841171606fb07c61b132eea7dbed837c5199c942055e74bf2eedb6011de"} 08:22:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:22:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:22:11 INFO - Contents: 08:22:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa133b50459a95d8a6da9d5ec22b405e964a95021368460e18ac746b330c3408ac146a94bc353f61e1c2bb433ab9ea7854008217554395b8818488ae478aacd2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/798fdc89d386219c5f8ca442908d6b06b5c341076da73cf6074cfedfd6a3e0be48884841171606fb07c61b132eea7dbed837c5199c942055e74bf2eedb6011de"} 08:22:11 INFO - Running post-run listener: copy_logs_to_upload_dir 08:22:11 INFO - Copying logs to upload dir... 08:22:11 INFO - mkdir: /builds/slave/test/build/upload/logs 08:22:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.009967 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-28 08:22:11.569843) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 08:22:11.573414) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907 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/Fx-Team/sha512/aa133b50459a95d8a6da9d5ec22b405e964a95021368460e18ac746b330c3408ac146a94bc353f61e1c2bb433ab9ea7854008217554395b8818488ae478aacd2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/798fdc89d386219c5f8ca442908d6b06b5c341076da73cf6074cfedfd6a3e0be48884841171606fb07c61b132eea7dbed837c5199c942055e74bf2eedb6011de"} build_url:https://queue.taskcluster.net/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011261 build_url: 'https://queue.taskcluster.net/v1/task/abqn52Y9TSukNZsUxjhkHw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aa133b50459a95d8a6da9d5ec22b405e964a95021368460e18ac746b330c3408ac146a94bc353f61e1c2bb433ab9ea7854008217554395b8818488ae478aacd2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/798fdc89d386219c5f8ca442908d6b06b5c341076da73cf6074cfedfd6a3e0be48884841171606fb07c61b132eea7dbed837c5199c942055e74bf2eedb6011de"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 08:22:11.597969) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:22:11.598320) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1461852615.561793-557732907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 08:22:11.680870) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 08:22:11.681202) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 08:22:11.681522) ========= ========= Total master_lag: 0.17 =========