builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1460748253.42 results: success (0) buildid: 20160415114641 builduid: 48579ca061c642c6bbc9183ea206671d revision: 009d7df1ba6d97a5abd2ed417a3464a8e948742c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:13.422558) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:13.423086) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:13.423362) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:13.448704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:13.448972) ========= 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=ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 12:24:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-04-15 12:24:14 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.069695 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:13.531464) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:13.531754) ========= 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=ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014199 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:13.580608) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 12:24:13.580976) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 009d7df1ba6d97a5abd2ed417a3464a8e948742c --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 009d7df1ba6d97a5abd2ed417a3464a8e948742c --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=ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 12:24:14,327 truncating revision to first 12 chars 2016-04-15 12:24:14,327 Setting DEBUG logging. 2016-04-15 12:24:14,327 attempt 1/10 2016-04-15 12:24:14,327 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/009d7df1ba6d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 12:24:15,412 unpacking tar archive at: fx-team-009d7df1ba6d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.436524 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 12:24:15.029930) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:15.030228) ========= script_repo_revision: 009d7df1ba6d97a5abd2ed417a3464a8e948742c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:15.033166) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:15.033454) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:15.041956) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-15 12:24:15.042239) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:24:15 INFO - MultiFileLogger online at 20160415 12:24:15 in /builds/slave/test 12:24:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:24:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:24:15 INFO - {'append_to_log': False, 12:24:15 INFO - 'base_work_dir': '/builds/slave/test', 12:24:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:24:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:24:15 INFO - 'branch': 'Fx-Team-Non-PGO', 12:24:15 INFO - 'buildbot_json_path': 'buildprops.json', 12:24:15 INFO - 'config_files': ('talos/linux_config.py',), 12:24:15 INFO - 'default_actions': ('clobber', 12:24:15 INFO - 'read-buildbot-config', 12:24:15 INFO - 'download-and-extract', 12:24:15 INFO - 'populate-webroot', 12:24:15 INFO - 'create-virtualenv', 12:24:15 INFO - 'install', 12:24:15 INFO - 'run-tests'), 12:24:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:24:15 INFO - 'download_minidump_stackwalk': True, 12:24:15 INFO - 'download_symbols': 'ondemand', 12:24:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:24:15 INFO - 'tooltool.py': '/tools/tooltool.py', 12:24:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:24:15 INFO - '/tools/misc-python/virtualenv.py')}, 12:24:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:24:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:24:15 INFO - 'installer_path': 'installer.exe', 12:24:15 INFO - 'log_level': 'info', 12:24:15 INFO - 'log_name': 'talos', 12:24:15 INFO - 'log_to_console': True, 12:24:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:24:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:24:15 INFO - 'opt_config_files': (), 12:24:15 INFO - 'pip_index': False, 12:24:15 INFO - 'sps_profile': False, 12:24:15 INFO - 'sps_profile_interval': 0, 12:24:15 INFO - 'suite': 'dromaeojs-e10s', 12:24:15 INFO - 'system_bits': '32', 12:24:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:24:15 INFO - 'title': 'talos-linux64-ix-035', 12:24:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:24:15 INFO - 'use_talos_json': True, 12:24:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:24:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:24:15 INFO - 'work_dir': 'build'} 12:24:15 INFO - ##### 12:24:15 INFO - ##### Running clobber step. 12:24:15 INFO - ##### 12:24:15 INFO - Running pre-action listener: _resource_record_pre_action 12:24:15 INFO - Running main action method: clobber 12:24:15 INFO - rmtree: /builds/slave/test/build 12:24:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:24:16 INFO - Running post-action listener: _resource_record_post_action 12:24:16 INFO - ##### 12:24:16 INFO - ##### Running read-buildbot-config step. 12:24:16 INFO - ##### 12:24:16 INFO - Running pre-action listener: _resource_record_pre_action 12:24:16 INFO - Running main action method: read_buildbot_config 12:24:16 INFO - Using buildbot properties: 12:24:16 INFO - { 12:24:16 INFO - "project": "", 12:24:16 INFO - "product": "firefox", 12:24:16 INFO - "script_repo_revision": "production", 12:24:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:24:16 INFO - "repository": "", 12:24:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 12:24:16 INFO - "buildid": "20160415114641", 12:24:16 INFO - "pgo_build": "False", 12:24:16 INFO - "basedir": "/builds/slave/test", 12:24:16 INFO - "buildnumber": 1159, 12:24:16 INFO - "slavename": "talos-linux64-ix-035", 12:24:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:24:16 INFO - "platform": "ubuntu64_hw", 12:24:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:24:16 INFO - "branch": "fx-team", 12:24:16 INFO - "repo_path": "integration/fx-team", 12:24:16 INFO - "revision": "009d7df1ba6d97a5abd2ed417a3464a8e948742c", 12:24:16 INFO - "stage_platform": "linux64", 12:24:16 INFO - "builduid": "48579ca061c642c6bbc9183ea206671d", 12:24:16 INFO - "slavebuilddir": "test" 12:24:16 INFO - } 12:24:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:24:16 INFO - Running post-action listener: _resource_record_post_action 12:24:16 INFO - ##### 12:24:16 INFO - ##### Running download-and-extract step. 12:24:16 INFO - ##### 12:24:16 INFO - Running pre-action listener: _resource_record_pre_action 12:24:16 INFO - Running main action method: download_and_extract 12:24:16 INFO - mkdir: /builds/slave/test/build/tests 12:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:16 INFO - https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:24:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:24:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:24:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:25 INFO - Downloaded 1361 bytes. 12:24:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:24:25 INFO - Using the following test package requirements: 12:24:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:24:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:24:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:24:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:25 INFO - u'jsshell-linux-x86_64.zip'], 12:24:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:24:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:24:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:24:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:24:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:24:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:24:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:25 INFO - https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:24:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:24:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:24:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:28 INFO - Downloaded 22205647 bytes. 12:24:28 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'] 12:24:28 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 12:24:29 INFO - Return code: 0 12:24:29 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 12:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:29 INFO - https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:24:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:24:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:24:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:31 INFO - Downloaded 22205647 bytes. 12:24:31 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'] 12:24:31 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 12:24:33 INFO - Return code: 0 12:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:33 INFO - https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:24:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:24:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:24:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:33 INFO - Downloaded 10841076 bytes. 12:24:33 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'] 12:24:33 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 12:24:34 INFO - Return code: 0 12:24:34 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')]} 12:24:34 INFO - https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:24:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:24:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:24:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:35 INFO - Downloaded 54451733 bytes. 12:24:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:24:35 INFO - mkdir: /builds/slave/test/properties 12:24:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:24:35 INFO - Writing to file /builds/slave/test/properties/build_url 12:24:35 INFO - Contents: 12:24:35 INFO - build_url:https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:24:37 INFO - Running post-action listener: _resource_record_post_action 12:24:37 INFO - Running post-action listener: set_extra_try_arguments 12:24:37 INFO - ##### 12:24:37 INFO - ##### Running populate-webroot step. 12:24:37 INFO - ##### 12:24:37 INFO - Running pre-action listener: _resource_record_pre_action 12:24:37 INFO - Running main action method: populate_webroot 12:24:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:24:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:24:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:24:37 INFO - '--tppagecycles', 12:24:37 INFO - '7'], 12:24:37 INFO - 'tests': ['tsvgm']}}, 12:24:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:24:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:24:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:24:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:24:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:24:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:24:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:37 INFO - 'talos_options': ['--disable-e10s'], 12:24:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:24:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:24:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:37 INFO - 'talos_options': ['--disable-e10s'], 12:24:37 INFO - 'tests': ['damp', 'tps']}, 12:24:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:37 INFO - 'tests': ['damp', 'tps']}, 12:24:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:24:37 INFO - 'tests': ['dromaeo_dom']}, 12:24:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:24:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:24:37 INFO - 'tests': ['a11yr', 12:24:37 INFO - 'ts_paint', 12:24:37 INFO - 'tpaint', 12:24:37 INFO - 'sessionrestore', 12:24:37 INFO - 'sessionrestore_no_auto_restore', 12:24:37 INFO - 'tabpaint']}, 12:24:37 INFO - 'other-e10s': {'tests': ['a11yr', 12:24:37 INFO - 'ts_paint', 12:24:37 INFO - 'tpaint', 12:24:37 INFO - 'sessionrestore', 12:24:37 INFO - 'sessionrestore_no_auto_restore', 12:24:37 INFO - 'tabpaint']}, 12:24:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:24:37 INFO - 'ts_paint', 12:24:37 INFO - 'tpaint', 12:24:37 INFO - 'sessionrestore', 12:24:37 INFO - 'sessionrestore_no_auto_restore', 12:24:37 INFO - 'tabpaint']}, 12:24:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:24:37 INFO - 'ts_paint', 12:24:37 INFO - 'tpaint', 12:24:37 INFO - 'sessionrestore', 12:24:37 INFO - 'sessionrestore_no_auto_restore', 12:24:37 INFO - 'tabpaint']}, 12:24:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:24:37 INFO - 'tests': ['a11yr', 12:24:37 INFO - 'ts_paint', 12:24:37 INFO - 'tpaint', 12:24:37 INFO - 'sessionrestore', 12:24:37 INFO - 'sessionrestore_no_auto_restore', 12:24:37 INFO - 'tabpaint']}, 12:24:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:24:37 INFO - 'tests': ['a11yr', 12:24:37 INFO - 'ts_paint', 12:24:37 INFO - 'tpaint', 12:24:37 INFO - 'sessionrestore', 12:24:37 INFO - 'sessionrestore_no_auto_restore', 12:24:37 INFO - 'tabpaint']}, 12:24:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:24:37 INFO - 'tests': ['tsvgx', 12:24:37 INFO - 'tsvgr_opacity', 12:24:37 INFO - 'tart', 12:24:37 INFO - 'tscrollx', 12:24:37 INFO - 'cart']}, 12:24:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:24:37 INFO - 'tsvgr_opacity', 12:24:37 INFO - 'tart', 12:24:37 INFO - 'tscrollx', 12:24:37 INFO - 'cart']}, 12:24:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:37 INFO - 'talos_options': ['--disable-e10s'], 12:24:37 INFO - 'tests': ['tp5o']}, 12:24:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:37 INFO - 'tests': ['tp5o']}, 12:24:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:37 INFO - 'talos_options': ['--disable-e10s', 12:24:37 INFO - '--xperf_path', 12:24:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:24:37 INFO - 'tests': ['tp5n']}, 12:24:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:37 INFO - 'talos_options': ['--xperf_path', 12:24:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:24:37 INFO - 'tests': ['tp5n']}}, 12:24:37 INFO - 'talos.zip': {'path': '', 12:24:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:24:37 INFO - Running post-action listener: _resource_record_post_action 12:24:37 INFO - ##### 12:24:37 INFO - ##### Running create-virtualenv step. 12:24:37 INFO - ##### 12:24:37 INFO - Running pre-action listener: _resource_record_pre_action 12:24:37 INFO - Running main action method: create_virtualenv 12:24:37 INFO - Creating virtualenv /builds/slave/test/build/venv 12:24:37 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 12:24:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:24:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:24:37 INFO - Using real prefix '/usr' 12:24:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:24:37 INFO - Installing distribute.............................................................................................................................................................................................done. 12:24:39 INFO - Installing pip.................done. 12:24:39 INFO - Return code: 0 12:24:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:24: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')]} 12:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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')]} 12:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2e2b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b90410>, '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 0x1b91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b917a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099', '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 12:24:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:24:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:24:39 INFO - Using env: {'DISPLAY': ':0', 12:24:39 INFO - 'HOME': '/home/cltbld', 12:24:39 INFO - 'LANG': 'en_US.UTF-8', 12:24:39 INFO - 'LANGUAGE': 'en_US:en', 12:24:39 INFO - 'LOGNAME': 'cltbld', 12:24:39 INFO - 'MAIL': '/var/mail/cltbld', 12:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:39 INFO - 'MOZ_NO_REMOTE': '1', 12:24:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:39 INFO - 'NO_EM_RESTART': '1', 12:24:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:39 INFO - 'PWD': '/builds/slave/test', 12:24:39 INFO - 'SHELL': '/bin/bash', 12:24:39 INFO - 'SHLVL': '1', 12:24:39 INFO - 'TERM': 'linux', 12:24:39 INFO - 'TMOUT': '86400', 12:24:39 INFO - 'USER': 'cltbld', 12:24:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099', 12:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:39 INFO - '_': '/tools/buildbot/bin/python'} 12:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:40 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 12:24:40 INFO - Cleaning up... 12:24:40 INFO - Return code: 0 12:24:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa2e2b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b90410>, '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 0x1b91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b917a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099', '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 12:24:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:24:40 INFO - Using env: {'DISPLAY': ':0', 12:24:40 INFO - 'HOME': '/home/cltbld', 12:24:40 INFO - 'LANG': 'en_US.UTF-8', 12:24:40 INFO - 'LANGUAGE': 'en_US:en', 12:24:40 INFO - 'LOGNAME': 'cltbld', 12:24:40 INFO - 'MAIL': '/var/mail/cltbld', 12:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:40 INFO - 'MOZ_NO_REMOTE': '1', 12:24:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:40 INFO - 'NO_EM_RESTART': '1', 12:24:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:40 INFO - 'PWD': '/builds/slave/test', 12:24:40 INFO - 'SHELL': '/bin/bash', 12:24:40 INFO - 'SHLVL': '1', 12:24:40 INFO - 'TERM': 'linux', 12:24:40 INFO - 'TMOUT': '86400', 12:24:40 INFO - 'USER': 'cltbld', 12:24:40 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099', 12:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:40 INFO - '_': '/tools/buildbot/bin/python'} 12:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:40 INFO - Downloading/unpacking psutil>=0.7.1 12:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:24:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:24:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:24:42 INFO - Installing collected packages: psutil 12:24:42 INFO - Running setup.py install for psutil 12:24:42 INFO - building 'psutil._psutil_linux' extension 12:24:42 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 12:24:42 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 12:24:42 INFO - building 'psutil._psutil_posix' extension 12:24:42 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 12:24:42 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 12:24:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:24:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:24:42 INFO - Successfully installed psutil 12:24:42 INFO - Cleaning up... 12:24:42 INFO - Return code: 0 12:24:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:24: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')]} 12:24:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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')]} 12:24:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:42 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 0x7fa2e2b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b90410>, '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 0x1b91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b917a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099', '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 12:24:42 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 12:24:42 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 12:24:42 INFO - Using env: {'DISPLAY': ':0', 12:24:42 INFO - 'HOME': '/home/cltbld', 12:24:42 INFO - 'LANG': 'en_US.UTF-8', 12:24:42 INFO - 'LANGUAGE': 'en_US:en', 12:24:42 INFO - 'LOGNAME': 'cltbld', 12:24:42 INFO - 'MAIL': '/var/mail/cltbld', 12:24:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:42 INFO - 'MOZ_NO_REMOTE': '1', 12:24:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:42 INFO - 'NO_EM_RESTART': '1', 12:24:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:42 INFO - 'PWD': '/builds/slave/test', 12:24:42 INFO - 'SHELL': '/bin/bash', 12:24:42 INFO - 'SHLVL': '1', 12:24:42 INFO - 'TERM': 'linux', 12:24:42 INFO - 'TMOUT': '86400', 12:24:42 INFO - 'USER': 'cltbld', 12:24:42 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099', 12:24:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:42 INFO - '_': '/tools/buildbot/bin/python'} 12:24:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:24:44 INFO - Installing collected packages: mozsystemmonitor 12:24:44 INFO - Running setup.py install for mozsystemmonitor 12:24:45 INFO - Successfully installed mozsystemmonitor 12:24:45 INFO - Cleaning up... 12:24:45 INFO - Return code: 0 12:24:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:24:45 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')]} 12:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:45 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')]} 12:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:45 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 0x7fa2e2b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b90410>, '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 0x1b91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b917a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099', '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 12:24:45 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 12:24:45 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 12:24:45 INFO - Using env: {'DISPLAY': ':0', 12:24:45 INFO - 'HOME': '/home/cltbld', 12:24:45 INFO - 'LANG': 'en_US.UTF-8', 12:24:45 INFO - 'LANGUAGE': 'en_US:en', 12:24:45 INFO - 'LOGNAME': 'cltbld', 12:24:45 INFO - 'MAIL': '/var/mail/cltbld', 12:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:45 INFO - 'MOZ_NO_REMOTE': '1', 12:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:45 INFO - 'NO_EM_RESTART': '1', 12:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:45 INFO - 'PWD': '/builds/slave/test', 12:24:45 INFO - 'SHELL': '/bin/bash', 12:24:45 INFO - 'SHLVL': '1', 12:24:45 INFO - 'TERM': 'linux', 12:24:45 INFO - 'TMOUT': '86400', 12:24:45 INFO - 'USER': 'cltbld', 12:24:45 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099', 12:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:45 INFO - '_': '/tools/buildbot/bin/python'} 12:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:45 INFO - Downloading/unpacking blobuploader==1.2.4 12:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:47 INFO - Downloading blobuploader-1.2.4.tar.gz 12:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:24:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:24:47 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 12:24:47 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 12:24:47 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 12:24:47 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 12:24:47 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 12:24:47 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 12:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:24:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:24:47 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 12:24:47 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 12:24:47 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 12:24:47 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 12:24:47 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 12:24:47 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 12:24:47 INFO - Downloading docopt-0.6.1.tar.gz 12:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:24:47 INFO - Installing collected packages: blobuploader, requests, docopt 12:24:47 INFO - Running setup.py install for blobuploader 12:24:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:24:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:24:48 INFO - Running setup.py install for requests 12:24:48 INFO - Running setup.py install for docopt 12:24:48 INFO - Successfully installed blobuploader requests docopt 12:24:48 INFO - Cleaning up... 12:24:48 INFO - Return code: 0 12:24:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:48 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 0x7fa2e2b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b90410>, '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 0x1b91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b917a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099', '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 12:24:48 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 12:24:48 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 12:24:48 INFO - Using env: {'DISPLAY': ':0', 12:24:48 INFO - 'HOME': '/home/cltbld', 12:24:48 INFO - 'LANG': 'en_US.UTF-8', 12:24:48 INFO - 'LANGUAGE': 'en_US:en', 12:24:48 INFO - 'LOGNAME': 'cltbld', 12:24:48 INFO - 'MAIL': '/var/mail/cltbld', 12:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:48 INFO - 'MOZ_NO_REMOTE': '1', 12:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:48 INFO - 'NO_EM_RESTART': '1', 12:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:48 INFO - 'PWD': '/builds/slave/test', 12:24:48 INFO - 'SHELL': '/bin/bash', 12:24:48 INFO - 'SHLVL': '1', 12:24:48 INFO - 'TERM': 'linux', 12:24:48 INFO - 'TMOUT': '86400', 12:24:48 INFO - 'USER': 'cltbld', 12:24:48 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099', 12:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:48 INFO - '_': '/tools/buildbot/bin/python'} 12:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:24:48 INFO - Running setup.py (path:/tmp/pip-QCBbVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:24:48 INFO - Running setup.py (path:/tmp/pip-7QwLYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:24:48 INFO - Running setup.py (path:/tmp/pip-3VoaGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:24:49 INFO - Running setup.py (path:/tmp/pip-bYupSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:24:49 INFO - Running setup.py (path:/tmp/pip-x6MpHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:24:49 INFO - Running setup.py (path:/tmp/pip-ZOQ3EP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:24:49 INFO - Running setup.py (path:/tmp/pip-vvC466-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:24:49 INFO - Running setup.py (path:/tmp/pip-Q3hRva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:24:49 INFO - Running setup.py (path:/tmp/pip-83nVGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:24:49 INFO - Running setup.py (path:/tmp/pip-0vyulJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:24:49 INFO - Running setup.py (path:/tmp/pip-1ey6zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:24:49 INFO - Running setup.py (path:/tmp/pip-9Kfrnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:24:49 INFO - Running setup.py (path:/tmp/pip-4kBGW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:24:49 INFO - Running setup.py (path:/tmp/pip-sFAy2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:49 INFO - Running setup.py (path:/tmp/pip-ukOXrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:24:49 INFO - Running setup.py (path:/tmp/pip-Bl4aSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:24:49 INFO - Running setup.py (path:/tmp/pip-pSXujX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:24:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:24:50 INFO - Running setup.py install for manifestparser 12:24:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:24:50 INFO - Running setup.py install for mozcrash 12:24:50 INFO - Running setup.py install for mozdebug 12:24:50 INFO - Running setup.py install for mozdevice 12:24:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:24:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:24:50 INFO - Running setup.py install for mozfile 12:24:50 INFO - Running setup.py install for mozhttpd 12:24:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:24:50 INFO - Running setup.py install for mozinfo 12:24:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:24:50 INFO - Running setup.py install for mozInstall 12:24:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:24:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:24:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:24:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:24:50 INFO - Running setup.py install for mozleak 12:24:50 INFO - Running setup.py install for mozlog 12:24:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:24:51 INFO - Running setup.py install for moznetwork 12:24:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:24:51 INFO - Running setup.py install for mozprocess 12:24:51 INFO - Running setup.py install for mozprofile 12:24:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:24:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:24:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:24:51 INFO - Running setup.py install for mozrunner 12:24:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:24:51 INFO - Running setup.py install for mozscreenshot 12:24:51 INFO - Running setup.py install for moztest 12:24:51 INFO - Running setup.py install for mozversion 12:24:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:24:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:24:51 INFO - Cleaning up... 12:24:51 INFO - Return code: 0 12:24:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:51 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 0x7fa2e2b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b90410>, '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 0x1b91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b917a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099', '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 12:24:51 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 12:24:51 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 12:24:51 INFO - Using env: {'DISPLAY': ':0', 12:24:51 INFO - 'HOME': '/home/cltbld', 12:24:51 INFO - 'LANG': 'en_US.UTF-8', 12:24:51 INFO - 'LANGUAGE': 'en_US:en', 12:24:51 INFO - 'LOGNAME': 'cltbld', 12:24:51 INFO - 'MAIL': '/var/mail/cltbld', 12:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:51 INFO - 'MOZ_NO_REMOTE': '1', 12:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:51 INFO - 'NO_EM_RESTART': '1', 12:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:51 INFO - 'PWD': '/builds/slave/test', 12:24:51 INFO - 'SHELL': '/bin/bash', 12:24:51 INFO - 'SHLVL': '1', 12:24:51 INFO - 'TERM': 'linux', 12:24:51 INFO - 'TMOUT': '86400', 12:24:51 INFO - 'USER': 'cltbld', 12:24:51 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099', 12:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:51 INFO - '_': '/tools/buildbot/bin/python'} 12:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:24:52 INFO - Running setup.py (path:/tmp/pip-J2eCgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:24:52 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)) 12:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:24:52 INFO - Running setup.py (path:/tmp/pip-zQsOiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:24:52 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)) 12:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:24:52 INFO - Running setup.py (path:/tmp/pip-pKaDrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:24:52 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)) 12:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:24:52 INFO - Running setup.py (path:/tmp/pip-87KYnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:24:52 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)) 12:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:24:52 INFO - Running setup.py (path:/tmp/pip-Bwm1iu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:24:52 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)) 12:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:24:52 INFO - Running setup.py (path:/tmp/pip-EzdObz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:24:52 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)) 12:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:24:52 INFO - Running setup.py (path:/tmp/pip-j7evrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:24:52 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)) 12:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:24:52 INFO - Running setup.py (path:/tmp/pip-WH80UH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:24:52 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)) 12:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:24:52 INFO - Running setup.py (path:/tmp/pip-3Vzdpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:24:52 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)) 12:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:24:52 INFO - Running setup.py (path:/tmp/pip-zjKx5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:24:52 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)) 12:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:24:52 INFO - Running setup.py (path:/tmp/pip-KKyRnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:24:52 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)) 12:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:24:52 INFO - Running setup.py (path:/tmp/pip-Z_pbnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:24:52 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)) 12:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:24:52 INFO - Running setup.py (path:/tmp/pip-HiY0vZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:24:52 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)) 12:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:24:52 INFO - Running setup.py (path:/tmp/pip-CG5XKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:24:53 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)) 12:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:53 INFO - Running setup.py (path:/tmp/pip-7_HRpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:53 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)) 12:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:24:53 INFO - Running setup.py (path:/tmp/pip-XHieGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:24:53 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)) 12:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:24:53 INFO - Running setup.py (path:/tmp/pip-p5BCPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:24:53 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)) 12:24:53 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)) 12:24:53 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)) 12:24:53 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)) 12:24:53 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)) 12:24:53 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)) 12:24:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:55 INFO - Downloading blessings-1.6.tar.gz 12:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:24:55 INFO - Installing collected packages: blessings 12:24:55 INFO - Running setup.py install for blessings 12:24:55 INFO - Successfully installed blessings 12:24:55 INFO - Cleaning up... 12:24:55 INFO - Return code: 0 12:24:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:24:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:24:55 INFO - Reading from file tmpfile_stdout 12:24:55 INFO - Current package versions: 12:24:55 INFO - argparse == 1.2.1 12:24:55 INFO - blessings == 1.6 12:24:55 INFO - blobuploader == 1.2.4 12:24:55 INFO - docopt == 0.6.1 12:24:55 INFO - manifestparser == 1.1 12:24:55 INFO - mozInstall == 1.12 12:24:55 INFO - mozcrash == 0.17 12:24:55 INFO - mozdebug == 0.1 12:24:55 INFO - mozdevice == 0.48 12:24:55 INFO - mozfile == 1.2 12:24:55 INFO - mozhttpd == 0.7 12:24:55 INFO - mozinfo == 0.9 12:24:55 INFO - mozleak == 0.1 12:24:55 INFO - mozlog == 3.1 12:24:55 INFO - moznetwork == 0.27 12:24:55 INFO - mozprocess == 0.22 12:24:55 INFO - mozprofile == 0.28 12:24:55 INFO - mozrunner == 6.11 12:24:55 INFO - mozscreenshot == 0.1 12:24:55 INFO - mozsystemmonitor == 0.0 12:24:55 INFO - moztest == 0.7 12:24:55 INFO - mozversion == 1.4 12:24:55 INFO - psutil == 3.1.1 12:24:55 INFO - requests == 1.2.3 12:24:55 INFO - wsgiref == 0.1.2 12:24:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:55 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 0x7fa2e2b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b90410>, '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 0x1b91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b917a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099', '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 12:24:55 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 12:24:55 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 12:24:55 INFO - Using env: {'DISPLAY': ':0', 12:24:55 INFO - 'HOME': '/home/cltbld', 12:24:55 INFO - 'LANG': 'en_US.UTF-8', 12:24:55 INFO - 'LANGUAGE': 'en_US:en', 12:24:55 INFO - 'LOGNAME': 'cltbld', 12:24:55 INFO - 'MAIL': '/var/mail/cltbld', 12:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:55 INFO - 'MOZ_NO_REMOTE': '1', 12:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:55 INFO - 'NO_EM_RESTART': '1', 12:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:55 INFO - 'PWD': '/builds/slave/test', 12:24:55 INFO - 'SHELL': '/bin/bash', 12:24:55 INFO - 'SHLVL': '1', 12:24:55 INFO - 'TERM': 'linux', 12:24:55 INFO - 'TMOUT': '86400', 12:24:55 INFO - 'USER': 'cltbld', 12:24:55 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099', 12:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:55 INFO - '_': '/tools/buildbot/bin/python'} 12:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:55 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)) 12:24:55 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)) 12:24:55 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)) 12:24:55 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)) 12:24:55 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)) 12:24:55 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)) 12:24:55 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)) 12:24:55 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)) 12:24:55 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)) 12:24:55 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)) 12:24:55 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)) 12:24:55 INFO - Cleaning up... 12:24:55 INFO - Return code: 0 12:24:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2e2b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b90410>, '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 0x1b91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b917a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099', '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 12:24:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:24:55 INFO - Using env: {'DISPLAY': ':0', 12:24:55 INFO - 'HOME': '/home/cltbld', 12:24:55 INFO - 'LANG': 'en_US.UTF-8', 12:24:55 INFO - 'LANGUAGE': 'en_US:en', 12:24:55 INFO - 'LOGNAME': 'cltbld', 12:24:55 INFO - 'MAIL': '/var/mail/cltbld', 12:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:55 INFO - 'MOZ_NO_REMOTE': '1', 12:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:55 INFO - 'NO_EM_RESTART': '1', 12:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:55 INFO - 'PWD': '/builds/slave/test', 12:24:55 INFO - 'SHELL': '/bin/bash', 12:24:55 INFO - 'SHLVL': '1', 12:24:55 INFO - 'TERM': 'linux', 12:24:55 INFO - 'TMOUT': '86400', 12:24:55 INFO - 'USER': 'cltbld', 12:24:55 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099', 12:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:55 INFO - '_': '/tools/buildbot/bin/python'} 12:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:56 INFO - Downloading/unpacking jsonschema 12:24:56 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 12:24:56 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 12:24:56 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 12:24:56 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 12:24:56 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 12:24:56 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 12:24:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:24:57 INFO - Downloading/unpacking functools32 (from jsonschema) 12:24: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 12:24: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 12:24: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 12:24: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 12:24: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 12:24: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 12:24:58 INFO - Downloading functools32-3.2.3-2.tar.gz 12:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:24:58 INFO - warning: no files found matching '*.txt' 12:24:58 INFO - no previously-included directories found matching 'build' 12:24:58 INFO - no previously-included directories found matching 'dist' 12:24:58 INFO - no previously-included directories found matching '.git*' 12:24:58 INFO - Installing collected packages: jsonschema, functools32 12:24:58 INFO - Running setup.py install for functools32 12:24:58 INFO - warning: no files found matching '*.txt' 12:24:58 INFO - no previously-included directories found matching 'build' 12:24:58 INFO - no previously-included directories found matching 'dist' 12:24:58 INFO - no previously-included directories found matching '.git*' 12:24:58 INFO - Successfully installed jsonschema functools32 12:24:58 INFO - Cleaning up... 12:24:58 INFO - Return code: 0 12:24:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2e2b95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b015a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b90410>, '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 0x1b91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b917a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099', '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 12:24:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:24:58 INFO - Using env: {'DISPLAY': ':0', 12:24:58 INFO - 'HOME': '/home/cltbld', 12:24:58 INFO - 'LANG': 'en_US.UTF-8', 12:24:58 INFO - 'LANGUAGE': 'en_US:en', 12:24:58 INFO - 'LOGNAME': 'cltbld', 12:24:58 INFO - 'MAIL': '/var/mail/cltbld', 12:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:58 INFO - 'MOZ_NO_REMOTE': '1', 12:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:58 INFO - 'NO_EM_RESTART': '1', 12:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:58 INFO - 'PWD': '/builds/slave/test', 12:24:58 INFO - 'SHELL': '/bin/bash', 12:24:58 INFO - 'SHLVL': '1', 12:24:58 INFO - 'TERM': 'linux', 12:24:58 INFO - 'TMOUT': '86400', 12:24:58 INFO - 'USER': 'cltbld', 12:24:58 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099', 12:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:58 INFO - '_': '/tools/buildbot/bin/python'} 12:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:58 INFO - Downloading/unpacking flake8 12:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:25:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:25:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:25:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:25:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:25:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:25:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:25:01 INFO - no previously-included directories found matching 'docs/_build' 12:25:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:25:01 INFO - Running setup.py install for pep8 12:25:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:25:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:25:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:25:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:25:01 INFO - no previously-included directories found matching 'docs/_build' 12:25:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:25:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:25:01 INFO - Cleaning up... 12:25:01 INFO - Return code: 0 12:25:01 INFO - Running post-action listener: _resource_record_post_action 12:25:01 INFO - Running post-action listener: _start_resource_monitoring 12:25:01 INFO - Starting resource monitoring. 12:25:01 INFO - ##### 12:25:01 INFO - ##### Running install step. 12:25:01 INFO - ##### 12:25:01 INFO - Running pre-action listener: _resource_record_pre_action 12:25:01 INFO - Running main action method: install 12:25:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:25:01 INFO - Reading from file tmpfile_stdout 12:25:01 INFO - Detecting whether we're running mozinstall >=1.0... 12:25:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:25:01 INFO - Reading from file tmpfile_stdout 12:25:01 INFO - Output received: 12:25:01 INFO - Usage: mozinstall [options] installer 12:25:01 INFO - Options: 12:25:01 INFO - -h, --help show this help message and exit 12:25:01 INFO - -d DEST, --destination=DEST 12:25:01 INFO - Directory to install application into. [default: 12:25:01 INFO - "/builds/slave/test"] 12:25:01 INFO - --app=APP Application being installed. [default: firefox] 12:25:01 INFO - mkdir: /builds/slave/test/build/application 12:25:01 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'] 12:25:01 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 12:25:17 INFO - Reading from file tmpfile_stdout 12:25:17 INFO - Output received: 12:25:17 INFO - /builds/slave/test/build/application/firefox/firefox 12:25:17 INFO - Running post-action listener: _resource_record_post_action 12:25:17 INFO - ##### 12:25:17 INFO - ##### Running run-tests step. 12:25:17 INFO - ##### 12:25:17 INFO - Running pre-action listener: _resource_record_pre_action 12:25:17 INFO - Running main action method: run_tests 12:25:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:25:17 INFO - Python 2.7.3 12:25:17 INFO - Return code: 0 12:25:17 INFO - grabbing minidump binary from tooltool 12:25:17 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')]} 12:25:17 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 0x1b90410>, '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 0x1b91310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b917a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:25:17 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 12:25:17 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 12:25:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:25:17 INFO - Return code: 0 12:25:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:25:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:25:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:25:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:25:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:25:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:25:18 INFO - Return code: 0 12:25:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 12:25:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 12:25:18 INFO - Using env: {'DISPLAY': ':0', 12:25:18 INFO - 'HOME': '/home/cltbld', 12:25:18 INFO - 'LANG': 'en_US.UTF-8', 12:25:18 INFO - 'LANGUAGE': 'en_US:en', 12:25:18 INFO - 'LOGNAME': 'cltbld', 12:25:18 INFO - 'MAIL': '/var/mail/cltbld', 12:25:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:25:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:25:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:18 INFO - 'MOZ_NO_REMOTE': '1', 12:25:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:25:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:18 INFO - 'NO_EM_RESTART': '1', 12:25:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:18 INFO - 'PWD': '/builds/slave/test', 12:25:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:25:18 INFO - 'SHELL': '/bin/bash', 12:25:18 INFO - 'SHLVL': '1', 12:25:18 INFO - 'TERM': 'linux', 12:25:18 INFO - 'TMOUT': '86400', 12:25:18 INFO - 'USER': 'cltbld', 12:25:18 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099', 12:25:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:18 INFO - '_': '/tools/buildbot/bin/python'} 12:25:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 12:25:18 INFO - mozversion application_buildid: 20160415114641 12:25:18 INFO - mozversion application_changeset: 009d7df1ba6d97a5abd2ed417a3464a8e948742c 12:25:18 INFO - mozversion application_display_name: Nightly 12:25:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:25:18 INFO - mozversion application_name: Firefox 12:25:18 INFO - mozversion application_remotingname: firefox 12:25:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:25:18 INFO - mozversion application_vendor: Mozilla 12:25:18 INFO - mozversion application_version: 48.0a1 12:25:18 INFO - mozversion platform_buildid: 20160415114641 12:25:18 INFO - mozversion platform_changeset: 009d7df1ba6d97a5abd2ed417a3464a8e948742c 12:25:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:25:18 INFO - mozversion platform_version: 48.0a1 12:25:18 INFO - using testdate: 1460748318 12:25:18 INFO - actual date: 1460748318 12:25:18 INFO - starting webserver on 'localhost:60690' 12:25:18 INFO - SUITE-START | Running 2 tests 12:25:18 INFO - TEST-START | dromaeo_css 12:25:18 INFO - operating with platform_type : linux_ 12:25:18 INFO - Initialising browser for dromaeo_css test... 12:25:18 INFO - TEST-INFO | started process 24631 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEVDZ1m/profile http://localhost:60690/getInfo.html) 12:25:22 INFO - PROCESS | 24631 | 12:25:22 INFO - PROCESS | 24631 | (process:24701): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:25:22 INFO - PROCESS | 24631 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 12:25:23 INFO - PROCESS | 24631 | __metrics Screen width/height:1600/1200 12:25:23 INFO - PROCESS | 24631 | colorDepth:24 12:25:23 INFO - PROCESS | 24631 | Browser inner width/height: 1024/697 12:25:23 INFO - PROCESS | 24631 | __metrics 12:25:24 ERROR - PROCESS | 24631 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 12:25:25 INFO - TEST-INFO | 24631: exit 0 12:25:25 INFO - Browser initialized. 12:25:25 INFO - Running cycle 1/1 for dromaeo_css test... 12:25:25 INFO - TEST-INFO | started process 24752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEVDZ1m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:25:27 INFO - PROCESS | 24752 | 12:25:27 INFO - PROCESS | 24752 | (process:24811): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:25:37 INFO - PROCESS | 24752 | RSS: Main: 165072896 12:25:37 INFO - PROCESS | 24752 | 12:26:26 INFO - PROCESS | 24752 | 1460748386701 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] 12:28:38 INFO - PROCESS | 24752 | Cycle 1(1): loaded http://localhost:60690/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60690/tests/dromaeo/cssquery-ext.html) 12:28:39 INFO - PROCESS | 24752 | RSS: Main: 167284736 12:28:39 INFO - PROCESS | 24752 | 12:31:41 INFO - PROCESS | 24752 | Cycle 1(1): loaded http://localhost:60690/tests/dromaeo/cssquery-ext.html (next: http://localhost:60690/tests/dromaeo/cssquery-jquery.html) 12:31:42 INFO - PROCESS | 24752 | RSS: Main: 165642240 12:31:42 INFO - PROCESS | 24752 | 12:34:44 INFO - PROCESS | 24752 | Cycle 1(1): loaded http://localhost:60690/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60690/tests/dromaeo/cssquery-mootools.html) 12:34:44 INFO - PROCESS | 24752 | RSS: Main: 167276544 12:34:44 INFO - PROCESS | 24752 | 12:37:46 INFO - PROCESS | 24752 | Cycle 1(1): loaded http://localhost:60690/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60690/tests/dromaeo/cssquery-prototype.html) 12:37:47 INFO - PROCESS | 24752 | RSS: Main: 164724736 12:37:47 INFO - PROCESS | 24752 | 12:40:49 INFO - PROCESS | 24752 | Cycle 1(1): loaded http://localhost:60690/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60690/tests/dromaeo/cssquery-yui.html) 12:40:50 INFO - PROCESS | 24752 | RSS: Main: 165404672 12:40:50 INFO - PROCESS | 24752 | 12:43:53 INFO - PROCESS | 24752 | Cycle 1(1): loaded http://localhost:60690/tests/dromaeo/cssquery-yui.html (next: http://localhost:60690/tests/dromaeo/cssquery-dojo.html) 12:43:53 INFO - PROCESS | 24752 | RSS: Main: 168566784 12:43:53 INFO - PROCESS | 24752 | 12:43:53 INFO - PROCESS | 24752 | __start_tp_report 12:43:53 INFO - PROCESS | 24752 | _x_x_mozilla_page_load 12:43:53 INFO - PROCESS | 24752 | _x_x_mozilla_page_load_details 12:43:53 INFO - PROCESS | 24752 | |i|pagename|runs| 12:43:53 INFO - PROCESS | 24752 | |0;dojo.html;2548.3374322676104;2651.496215719014;2673.211402636222;2679.866006699666;2692.165428717097;4603.516630753773;4650.7442090685045;4663.067386522696;4665.136949664306;4674.696144750589;4570.908581828361;4639.443266807988;4719.834805781798;4734.928976065353;4743.667943243974;4342.8914277143085;4387.956120438803;4437.267850804614;4448.733076015434;4480.462344518646;4358.476982762073;4457.33140028995;4465.5311192324825;4488.730676159441;4499.302608095734;4126.381042843567;4209.2423363794505;4268.082362292091;4368.519462859099;4450.354698568722;4280.101178752466;4311.655067594585;4324.437823082979;4332.415123958257;4375.2780791169735;4314.78426078698;4340.218760623086;4345.630621397185;4355.150745604608;4402.163588918127;4589.977050114761;4634.698744581591;4661.18429274879;4680.461746899116;4698.859034228979;5034.647574669774;5048.873778155539;5052;5061.949380506185;5085.669431486942;4805.807767689288;5063;5088.949110508885;5099.36257967754;5144.794208231666;4638.605718513897;4689.296605509201;4699.271612900006;4716.622670186412;4737.928931066037;5156.303898973665;5219.5041471060185;5234.953009398136;5249.868753281198;5268.209768534751;4805.183118869801;4915.21356582945;4959.958408734206;5013.298138260647;5013.817216548961;5043.546080852668;5046.646734728607;5061.266116413173;5069.264956581275;5127.359080114986;4723.669343146015;4996.475370086161;5014.09746245672;5046.520580544842;5052;4745.477997420281;4864.854054378375;4986.202207646759;4987.177115775857;5088.160453525127;4124.938125928114;4134.111166099243;4246.660267178619;4323.805428755651;4342.934855977162;3664.76179048361;3697.4453831925425;3697.9091168105474;3709.146896213886;3738.5700644425697;4299.290617048215;4301.892452688645;4326.307790753464;4328.653707703376;4332.870013899588;4918.704877707349;5087.821926232564;5154.7938082476285;5179.818706345335;5210.739463026834;4326.978365108154;4347.282698354736;4360.149770794728;4374.825006999748;4413.514513403523;4389.209942210433;4524.524924882906;4526.456825181;4535.297028960516;4572.428446444194;4763.285507173951;4796.880077998078;4814.133455977958;4816.807327706852;4838.7338696370625;4917.803287868588;4921.409430868175;4956.628252880976;4973.154563724103;4980.651354405301;4604.447466304065;4648.837290694944;4659.5573420525;4685.273782563708;4735.479097299363;4986.102501549756;4993.725345106054;5013.172826483589;5030.195168773125;5053.924191137063;5067.7212753297445;5074.670146440617;5087.898242035212;5095.286659867696;5124.30821839047;4730.148573256709;4929.433115191799;4936.963237720119;4941.703497790144;5014.598832093351;4664.207084795661;4851.56335929768;4916.582090522345;4936.629752768485;4949.331840201527;4831.178699621002;4834.274858771212;4864.537868902448;4876.634252431153;4922.261660750916;4730.574248317668;4895;4912.312276281252;4939.802407903644;4990.750462476934;4844.0554091951735;4851.32081508582;4865.221564549655;4873.853784386474;4901.583365413837 12:43:53 INFO - PROCESS | 24752 | |1;ext.html;579.2469789273943;610.0635524469939;620.5842085802515;626.5332327416074;646.9450096741776;33082.338353232924;34324.65675343246;34398.31203375934;34474;34493.48259776105;33012.66987330126;33388.33223335538;33622;33642.49536256958;33670.49494257582;7475.738349157794;7590.1650818409935;7595.620218989056;7620.123685776123;7646.808829779272;7499.962500187491;7677.769666910001;7707.036620422447;7715.961420192919;7743.26438988298;7757.650905709256;7792.649330780128;7825.256600622932;7839.294463498284;7853.136155022971;7694.153643099255;7715.72994945177;7770.106437759617;7784.844303113934;7795.61021948906;7778;7853.057633084067;7880.290773830326;7885.172056933997;7888.80277993049;29297.853510732522;34537.30925381504;35142.29715405703;35278.29443411117;35459.29081418383;3063.908082757521;3154.3691261747513;3241;3272.934541309184;3312.271300313927;27313;27655;27959.440811183664;28494.43011139786;28861.855690721623;3328.1679580104974;3364.108511244522;3377.257003459235;3460.0311912664492;3491.0748651607346;241795;247816;248281;248820;252092;34351.31297374039;35247.11882202965;56576;56998.43001569931;57172;36223.094422639646;36290;36503.26993460116;36654.63345366566;36676.63323366785;13343.466261349631;13589.932050339685;13673.427555831007;13700.862991370159;13715.725685486233;10847.566097356175;11069.114470842313;11102.333859968428;11105.555777768961;11106.888931110747;8290;8303.916960830315;8355.373346999;8358.414910956297;8379.539125348043;3233.7040701102483;3245.3996010738088;3248.3016151527536;3332.366850298484;3362.5796775403073;941.5668792355593;947.9052094790466;984.5077461269366;1038.46000079958;1048.9772471840047;26924.461510769674;27557.862210688818;27786.722132778414;28215.458072217167;28494;1027.9383237005804;1037.9896201037893;1060.8514807926897;1102.4377567440504;1109.3288560420829;14528.273586320642;15051.1721855299;15063.246837658073;15231.238438078051;15239.923800380928;348449;352188;353207;354070;355237;48892.7555362228;49614.75192624086;49811;49954.50045499571;50010.749946250035;1236.567201479475;1257.6352857671357;1263.9494420223089;1269.6444995401303;1274.1463219642862;26395;27470.5879411805;27938;27941.30146746266;28108.85945570341;42881.78559107184;42978.14043719046;43028.56971430246;43436;43437;300299;302319;304858;304887;305917;23739.52520949606;23896.76103239015;24057.639135413334;24082.157124500558;24095.156669516484;42090.36864447097;42519;42776.78611606922;42871.14257714766;42963.785181073894;36068.63931360653;36193.45709814302;36196.4570531437;36416.635833641325;36456.0835133194;36127.81936090303;36398;36647.63352366442;36791.26417471689;37492.62507374891;35638.465423018155;35809.82095089508;35913.64086359103;35974.64025359713;36319.63680363163;32399.51400728944;32619;33026.504602430505;33354.4996825043;33574.83212583922;25064.248072557853;25776.742232577435;25853;25908.740912590634;26093.73906260913 12:43:53 INFO - PROCESS | 24752 | |2;jquery.html;383.6278809554732;383.90786211309285;384.5539174557512;392.69958481761455;400.7295075823818;15556.766648500281;16644.751643626714;16769.329226830927;16827.999999999985;16908.746368804477;15386.923065384657;15868.444604438848;16257;16285.83714162858;16381.672366552692;4965.6524043316895;5113.105206588851;5163.690178589297;5172.482751724816;5175.896482070356;3657.670809627133;5604.103343465046;5903.586748927555;5922.644641321534;5926.792562260322;5671.546276297886;5839.416058394169;5843.590948633598;5851.15158302046;5867.178594996704;5837.678927658977;5884.6469211847425;5911.054231323011;5912.704364781765;5919.970400148015;4562.954370456286;4874.439439464471;5127.692338459704;5200.713960732158;5220.582353411718;12139.15025948184;12191.207571507824;12209.694757631041;12222.205556638879;15977.760333595006;1858.1545396844538;1934.0619799397282;1954.4654313251585;1994.2521554417094;2006.7190593316948;8933.64265429382;9059.870930331366;9185.17333439987;9318.534073296309;9411.717648470556;1762.118940529735;1768.7612172356696;1809.6471188118192;1830.3136323878546;1847.8607918263128;68060;70266.297337027;70336.29663703349;70648.2935170652;70854.29145708529;9766.267529935283;9847.359921605073;10033.598656053822;10146.949265253626;10204.183665306758;14026;14074.507392241427;14107.294635268196;14111.858881411055;14141.3737420198;7230.56616602995;7320.67056982437;7372.705091796375;7412.555246685216;7436.107667079985;6812.352826481576;6832.863342733118;6846.726130954806;6948.791536253921;6969.30306969299;4271.380649805761;4280.6789490788315;4311.935320970188;4312.525622181557;4379.4525684289465;1711.649111932051;1760.3750668512494;1845.8800177988387;1850.8982005989799;1862.1061890292735;779.5907148746953;874.8906386701663;905.1898550797;936.990630093704;938.1228551304553;14990.550283491513;15005;15649.98275112114;16002.279897404645;16085.356585736674;843.0768308701962;853.8206976534873;864.3301441382853;897.9955100224457;925.486355072941;8959.462432254086;9027.729168124966;9045.276377889753;9075.682351117679;9235.1688348049;396242;398929;406236;406439;409405;73803;74810.62594686991;75414.62292688501;76555.61722191353;80215;941.8398872191743;955.8757361543094;978.4911845840123;988.2785566536324;991.8016396720541;15080.622984425478;15171.848281517043;15209.923950380176;15308.693826123637;15694.450694225647;34211.828940855135;34526.654733453346;35213.29573408569;35571.822140890166;35895.28209435849;50361;50861.74569127131;50877;50969.490305097956;51262;7363.263673632594;7567.772966811004;7632.580208088609;7633.847323053396;7846.215378462108;8555.700550480704;11499.655010349703;11620.244684095507;11767.470463828977;11975.922167005012;9863.210943124677;10092.243081769044;10197.745056373353;10326.432046237529;10367.429791361246;9626.47054412014;9983.351082179635;10094.596216151273;10255.897441025494;10320.380777153396;9148.771280718036;10336.586536538754;10481.37111773296;10645.467726613793;10783.568657253621;7945.562994035384;8021.959890200512;8032.397570182143;8034.076081250731;8070.27367536901;7924.049114106344;10150.187984961038;10562.735931601772;10595;10724.785504290026 12:43:53 INFO - PROCESS | 24752 | |3;mootools.html;1439.9136051836888;1468.2732047636418;1591.5861875912267;1700.7278835386342;1751.3957684598809;6705.463562914967;7650.770476885696;7786.299233069023;7917.802054948622;7982.281594656487;7827.178146294643;7836.451448398614;7907.16974717655;7938.642761075751;7939.404544659159;2269.8751568663674;2298.586254474202;2304.68886700295;2310.89600967956;2312.3063081075693;2245.41619179013;2273.6362182050875;2275.6927814745045;2285.200179937017;2288.4850908545527;2273.9886300568555;2277.271273192579;2280.749117597063;2294.8164146868294;2296.8047715944167;2215.125025614881;2221.80003799658;2223.1996481266733;2224.0325458425636;2225.63277059285;2214.568159208955;2216.34617787753;2217.7227846519186;2221.378014156023;2227.1425501182;8027.7190298339865;8034.276915077613;8067.636956336979;8089.676412943475;8107.95946020272;4663.743494107823;4849.660523763338;4861.854144375674;4869.220924652074;4875.488073752276;2835.9858200708863;2946.351802603424;2954.0989998050586;2984.0301901881976;3005.0534081764176;1733.3759846455266;1746.7467217253427;1751.1856986501211;1775.2366482412558;1778.065222258163;10387.428691421968;10581.36511809294;10592.62925797601;10608.416537090457;10629.096526795232;4168.874933751992;4173.768738222232;4315.7194782339675;4363.214621368184;4449.977750111293;9171.495567743837;9177.311701622404;9210.861837072449;9381.859272110923;9390.953045234866;4784.354112194809;4826.517348265145;4867.050925069578;4871.025794840975;4879.780409881564;3807.2575847709986;4294.656427485794;4360.629346505582;4425.955740442619;4452.265376212953;3792.4311353296675;3797.5063241778944;3900.063984643722;3903.4730311408166;3921.274564205631;1241.2862604002735;1245.2901845947722;1254.5420921363636;1255.0649765924445;1257.6730050187018;754.8980887580216;858.6179150278191;859.334016137486;860.1312674198979;875.2035647560689;5165.354330708661;5213.374395072539;5263.4473380295285;5409.323834520685;5546.473085056913;408.216224848292;413.2747028964209;413.9337705967031;414.22539850479797;432.94155289035575;3691.335559599298;3757.5866654667966;3773.9433908491396;3802.657760801486;3815.771053736785;9676.9032309676;9892.703218903445;9938.552765125587;10038.548265327932;10087.142592879542;9763.023697630322;9825.754356141011;9876.111149996535;9942.900570994341;9955.55200016001;7162.427005839624;7210.639468026578;7241.927580724231;7282.198958114604;7303.123625165014;5184.585233181412;5248.160294352885;5268.76290566933;5364.624476286623;5425.945740542702;8639.136086391562;8764.298856091626;8889.155530224618;9082.863757043782;9160;8920.107989201288;8926.241269491906;9035.50304733246;9173.174414302744;9213.262938965001;6058.757649693963;6735.595864248161;6757.3242675732035;6799.422049125682;6969.58182509051;7549.396048316012;7556.8488630228185;7604.619769011417;7628.618569071636;7633.6946522140715;6662.267150613526;6886.345797149263;6922.27316131819;6930.896036559355;7053.0830991970715;6634.170728658918;6652.900206497004;6730.93269067303;6737.730490780314;6771.830704232237;5969.671668058125;6357.618542887441;6407.231132264158;6408.807735767934;6428.935710642833;4489.820407183676;4539.341795439709;4559.749213793273;4647.395838541103;4808.158572249912;4433.578810013044;4575.153596584642;4600.240960241523;4701.647376446712;4732.266498692708 12:43:53 INFO - PROCESS | 24752 | |4;prototype.html;313.8305315129829;315.4007385966664;321.9581454410926;326.99999999999994;327.10047369733235;5157.5616072633875;5168.793248270064;5339.839804805857;5357.866053348668;5359;5267.631265811395;5317.12267475866;5341.145416733323;5347.786088556462;5366.865828354293;4148.522919864224;4172.082141928786;4199.320271891253;4202.810873510699;4214.2414365414215;3899.51256092987;4094.529129150141;4209.852655157055;4210.51579068408;4218.240716670998;4033.3949907513816;4036.9394459083137;4057.782665200443;4060.2488539620117;4064.2074795414906;4037.3540233562635;4061.1674606705556;4069.674426045909;4073.490813648279;4075.714699971003;3436.1237884339585;3563.8574457021687;3570.892873213808;3577.5349204603494;3582.0865679251883;5099.36257967754;5125.692458452505;5133.230015497668;5139.820106296262;5161.483851614808;4681.9297710534365;4687.718736875764;4704.811807527695;4708.964027913854;4733.9763301183275;5379;5605.523530499912;5634.352049514277;5680.375158732536;5692.715364231772;3985.342418500944;3998.420229066798;4003.679705623543;4029.37544680575;4029.49631296088;5858.736356863951;5865.384134665841;5908.704564771744;5935.465808077251;6002.2197114375285;4042.5957404259925;4120.21715873989;4141.834326626901;4145.647619952338;4160.417541544186;4188.743376986953;4209.7474151551005;4214.473190851144;4220.345846393752;4222.071144348239;4706.317583950308;4792.2332426811545;4794.7362895040405;4831.51684831514;4835.709857408567;5355.7054362009685;5461.617686761889;5640.125780504029;5673.546116310686;5700.40145784695;1414.974143745776;1466.3914475492763;1472.8306244781772;1473.2191938272733;1479.7706355514913;980.1325826643472;985.792404304721;1007.7279134633754;1012.1346248957183;1012.6152062216458;4850.981293928244;4890.437599676012;4896.5837903777865;4907.2393778964315;4913.336699545515;5763.366029736726;5773.566982476331;5782.306123265235;5783.88432231353;5784.248047753765;4710.9764451177525;4911.803527858846;4926.187179115477;4935.8519244422005;4946.678465899705;3122.734567561737;3152.8423578820966;3157.1002264354547;3174.920527020824;3186.952195717066;5540.279763630702;5583.218349431083;5586.636868603528;5586.748596313176;5588.91616625751;5847.795327163614;5975.462208401264;6027.48766354856;6067.332593414721;6071.757129714851;5500.514860987591;5507.146392309199;5549.750261238254;5553.888922221614;5582.720863956786;5650.63270887391;5834.299884013776;5869.266341707286;5876.324222714272;5883.705814709333;5727;5750.856228594319;5759.999999999833;5767.509761670137;5785.9132113017495;5481.780728770805;5560.721963901708;5567.359753628222;5568.331800184003;5597.216389705363;3775.905602359963;3961.7028722845325;3964.742291751027;3998;4006.09862780872;5662.556048207681;5749.195112684144;5823.563232757476;5853;5867.266591676041;5700.600957933071;5714.342850572238;5723.427657234243;5730.398308177748;5739.598228123991;5648.870225954744;5668.659880407189;5694.4590263924865;5707.143928410772;5727.5417966561745;5495.587830912617;5559.525296689569;5576.5817563683695;5647.265855438766;5653.519450846724;5714.428557144419;5724.112762521816;5740.799072032459;5752.979685665059;5756.884862302647;5510.586705996986;5611.663300202001;5621.297337832771;5638.4925356718095;5668.291463567054 12:43:53 INFO - PROCESS | 24752 | |5;yui.html;725.7459889038836;760.9391248700105;765.5253742679539;770.1951460723543;787.1420152034283;12046.81929771053;12048.15662903596;12144.210626309283;12201.877981220196;12262.93868530656;12239.571614993478;12244.081693872951;12268.570600029001;12312.13815032948;12337.691557711061;636.2015670333725;713.55759429154;753.7211231844198;756.4440136499668;757.322196634015;805.3074356053789;806.9993208421573;808.8018435483315;817.4032955942166;820.5076953827686;847.2163248994686;849.5921957460423;850.8596081646521;853.5390888919976;854.478767951549;845.7589586967746;846.6190214403513;848.6987119572556;850.0352100366129;852.7569642651814;619.8326451857973;621.4810633121349;624.6595605395071;624.9625022498665;626.139058794158;12802.935985320108;12871.356432178447;12882.291473968928;12890.677733056655;12899.871001290056;12793;12918.935405322913;12945.352732363439;13010.609681709564;13082.280474573894;9545.856812147824;9708.75728106796;9810.607575696964;9811.950940245324;9927.751806204831;3290;3312.685294896981;3343.632200457948;3366.9326613467592;3375.746818988586;45846.54153458456;46261;46273.305900411186;46463.76768116171;46482.302765458546;10164.847527287096;10199.235057370726;10219.948900255451;10315.84526232107;10422;16820.243089061023;18156.546086347946;18212.726809097872;18288.81711182871;18308.450746477625;7111.288871112847;7124.038254835635;7151.53515021522;7159.463040272;7182.676779544933;3829.4447305141157;3888.416737489399;3911.1395492992065;3923.948018878695;3928.273269445162;2717.062613398374;2808.2137001639576;2812.6765421976324;2820.9985455163533;2822.012295696531;531.0653250279458;536.9824183172943;539.1185411851651;543.3642638113416;556.9832905012856;631.2298995225817;651.4430162211336;654.4248382614428;657.8289644692319;661.2527843536773;7514.624268786539;7555.433342499335;7878.094019187867;7891.408144389194;8301.211384918422;461.1654096190168;507.82733870484213;565.4244914414879;615.1664494609829;628.9402357028422;3731.850725970985;3783.9243215135543;3831.9616803832164;3835.827387767557;3879.8060096995036;53119.140830071534;53857.46142538603;53928.730356347965;54756.452435475934;55754.72122639361;42618.57381426146;43469.56530434718;43543;46972.530274696815;46991;40301.59698403037;40893;41908.37137442941;42425.78787106045;42689.786551067664;7367.889481657887;7576.545407275581;7604.923950760643;7714.6914123434435;7731.304182623591;27128.728712712622;27470.725292746818;27835.860820696576;27994.16017519478;28116.85941570279;34790.65209347874;37289.254214916094;37320.253594928494;38248.23503529858;38451.230975380895;10368.585256589651;10472;10574;10580.312279701795;10653.360798352123;11446.427678616203;11466;11661.591844285409;11779.35213563228;12416;10552;10595.735106622087;10688.305260158066;10700.143988480748;10900.236983411085;11217.383043932661;11428.25716328436;11462.197646165023;11506.597269095542;11595.5941542049;10591.4704264788;10775.892241077489;10825.729356766144;11095.667129986114;11299.09607231403;9688.657303426788;9825.459599722084;9928.553215105194;9949.950250248703;10056.19550435978;9536.57085431171;9589.808203836024;9648.517574121126;9777.364471309342;9842.704718858446 12:43:53 INFO - PROCESS | 24752 | __end_tp_report 12:43:53 INFO - PROCESS | 24752 | __start_cc_report 12:43:53 INFO - PROCESS | 24752 | _x_x_mozilla_cycle_collect,381 12:43:53 INFO - PROCESS | 24752 | __end_cc_report 12:43:53 INFO - PROCESS | 24752 | __startTimestamp1460749433260__endTimestamp 12:43:53 INFO - PROCESS | 24752 | 12:43:53 INFO - PROCESS | 24752 | ------- Summary: start ------- 12:43:53 INFO - PROCESS | 24752 | Number of tests: 6 12:43:53 INFO - PROCESS | 24752 | 12:43:53 INFO - PROCESS | 24752 | [#0] dojo.html Cycles:165 Average:4653.57 Median:4737.93 stddev:489.61 (10.3%) stddev-sans-first:462.42 12:43:53 INFO - PROCESS | 24752 | Values: 2548.3 2651.5 2673.2 2679.9 2692.2 4603.5 4650.7 4663.1 4665.1 4674.7 4570.9 4639.4 4719.8 4734.9 4743.7 4342.9 4388.0 4437.3 4448.7 4480.5 4358.5 4457.3 4465.5 4488.7 4499.3 4126.4 4209.2 4268.1 4368.5 4450.4 4280.1 4311.7 4324.4 4332.4 4375.3 4314.8 4340.2 4345.6 4355.2 4402.2 4590.0 4634.7 4661.2 4680.5 4698.9 5034.6 5048.9 5052.0 5061.9 5085.7 4805.8 5063.0 5088.9 5099.4 5144.8 4638.6 4689.3 4699.3 4716.6 4737.9 5156.3 5219.5 5235.0 5249.9 5268.2 4805.2 4915.2 4960.0 5013.3 5013.8 5043.5 5046.6 5061.3 5069.3 5127.4 4723.7 4996.5 5014.1 5046.5 5052.0 4745.5 4864.9 4986.2 4987.2 5088.2 4124.9 4134.1 4246.7 4323.8 4342.9 3664.8 3697.4 3697.9 3709.1 3738.6 4299.3 4301.9 4326.3 4328.7 4332.9 4918.7 5087.8 5154.8 5179.8 5210.7 4327.0 4347.3 4360.1 4374.8 4413.5 4389.2 4524.5 4526.5 4535.3 4572.4 4763.3 4796.9 4814.1 4816.8 4838.7 4917.8 4921.4 4956.6 4973.2 4980.7 4604.4 4648.8 4659.6 4685.3 4735.5 4986.1 4993.7 5013.2 5030.2 5053.9 5067.7 5074.7 5087.9 5095.3 5124.3 4730.1 4929.4 4937.0 4941.7 5014.6 4664.2 4851.6 4916.6 4936.6 4949.3 4831.2 4834.3 4864.5 4876.6 4922.3 4730.6 4895.0 4912.3 4939.8 4990.8 4844.1 4851.3 4865.2 4873.9 4901.6 12:43:53 INFO - PROCESS | 24752 | 12:43:53 INFO - PROCESS | 24752 | [#1] ext.html Cycles:180 Average:44476.31 Median:34483.74 stddev:80090.05 (232.3%) stddev-sans-first:80246.90 12:43:53 INFO - PROCESS | 24752 | Values: 579.2 610.1 620.6 626.5 646.9 33082.3 34324.7 34398.3 34474.0 34493.5 33012.7 33388.3 33622.0 33642.5 33670.5 7475.7 7590.2 7595.6 7620.1 7646.8 7500.0 7677.8 7707.0 7716.0 7743.3 7757.7 7792.6 7825.3 7839.3 7853.1 7694.2 7715.7 7770.1 7784.8 7795.6 7778.0 7853.1 7880.3 7885.2 7888.8 29297.9 34537.3 35142.3 35278.3 35459.3 3063.9 3154.4 3241.0 3272.9 3312.3 27313.0 27655.0 27959.4 28494.4 28861.9 3328.2 3364.1 3377.3 3460.0 3491.1 241795.0 247816.0 248281.0 248820.0 252092.0 34351.3 35247.1 56576.0 56998.4 57172.0 36223.1 36290.0 36503.3 36654.6 36676.6 13343.5 13589.9 13673.4 13700.9 13715.7 10847.6 11069.1 11102.3 11105.6 11106.9 8290.0 8303.9 8355.4 8358.4 8379.5 3233.7 3245.4 3248.3 3332.4 3362.6 941.6 947.9 984.5 1038.5 1049.0 26924.5 27557.9 27786.7 28215.5 28494.0 1027.9 1038.0 1060.9 1102.4 1109.3 14528.3 15051.2 15063.2 15231.2 15239.9 348449.0 352188.0 353207.0 354070.0 355237.0 48892.8 49614.8 49811.0 49954.5 50010.7 1236.6 1257.6 1263.9 1269.6 1274.1 26395.0 27470.6 27938.0 27941.3 28108.9 42881.8 42978.1 43028.6 43436.0 43437.0 300299.0 302319.0 304858.0 304887.0 305917.0 23739.5 23896.8 24057.6 24082.2 24095.2 42090.4 42519.0 42776.8 42871.1 42963.8 36068.6 36193.5 36196.5 36416.6 36456.1 36127.8 36398.0 36647.6 36791.3 37492.6 35638.5 35809.8 35913.6 35974.6 36319.6 32399.5 32619.0 33026.5 33354.5 33574.8 25064.2 25776.7 25853.0 25908.7 26093.7 12:43:53 INFO - PROCESS | 24752 | 12:43:53 INFO - PROCESS | 24752 | [#2] jquery.html Cycles:180 Average:24332.44 Median:27663.33 stddev:66558.53 (240.6%) stddev-sans-first:66720.95 12:43:53 INFO - PROCESS | 24752 | Values: 383.6 383.9 384.6 392.7 400.7 15556.8 16644.8 16769.3 16828.0 16908.7 15386.9 15868.4 16257.0 16285.8 16381.7 4965.7 5113.1 5163.7 5172.5 5175.9 3657.7 5604.1 5903.6 5922.6 5926.8 5671.5 5839.4 5843.6 5851.2 5867.2 5837.7 5884.6 5911.1 5912.7 5920.0 4563.0 4874.4 5127.7 5200.7 5220.6 12139.2 12191.2 12209.7 12222.2 15977.8 1858.2 1934.1 1954.5 1994.3 2006.7 8933.6 9059.9 9185.2 9318.5 9411.7 1762.1 1768.8 1809.6 1830.3 1847.9 68060.0 70266.3 70336.3 70648.3 70854.3 9766.3 9847.4 10033.6 10146.9 10204.2 14026.0 14074.5 14107.3 14111.9 14141.4 7230.6 7320.7 7372.7 7412.6 7436.1 6812.4 6832.9 6846.7 6948.8 6969.3 4271.4 4280.7 4311.9 4312.5 4379.5 1711.6 1760.4 1845.9 1850.9 1862.1 779.6 874.9 905.2 937.0 938.1 14990.6 15005.0 15650.0 16002.3 16085.4 843.1 853.8 864.3 898.0 925.5 8959.5 9027.7 9045.3 9075.7 9235.2 396242.0 398929.0 406236.0 406439.0 409405.0 73803.0 74810.6 75414.6 76555.6 80215.0 941.8 955.9 978.5 988.3 991.8 15080.6 15171.8 15209.9 15308.7 15694.5 34211.8 34526.7 35213.3 35571.8 35895.3 50361.0 50861.7 50877.0 50969.5 51262.0 7363.3 7567.8 7632.6 7633.8 7846.2 8555.7 11499.7 11620.2 11767.5 11975.9 9863.2 10092.2 10197.7 10326.4 10367.4 9626.5 9983.4 10094.6 10255.9 10320.4 9148.8 10336.6 10481.4 10645.5 10783.6 7945.6 8022.0 8032.4 8034.1 8070.3 7924.0 10150.2 10562.7 10595.0 10724.8 12:43:53 INFO - PROCESS | 24752 | 12:43:53 INFO - PROCESS | 24752 | [#3] mootools.html Cycles:180 Average:5232.20 Median:4855.76 stddev:2872.80 (59.2%) stddev-sans-first:2866.73 12:43:53 INFO - PROCESS | 24752 | Values: 1439.9 1468.3 1591.6 1700.7 1751.4 6705.5 7650.8 7786.3 7917.8 7982.3 7827.2 7836.5 7907.2 7938.6 7939.4 2269.9 2298.6 2304.7 2310.9 2312.3 2245.4 2273.6 2275.7 2285.2 2288.5 2274.0 2277.3 2280.7 2294.8 2296.8 2215.1 2221.8 2223.2 2224.0 2225.6 2214.6 2216.3 2217.7 2221.4 2227.1 8027.7 8034.3 8067.6 8089.7 8108.0 4663.7 4849.7 4861.9 4869.2 4875.5 2836.0 2946.4 2954.1 2984.0 3005.1 1733.4 1746.7 1751.2 1775.2 1778.1 10387.4 10581.4 10592.6 10608.4 10629.1 4168.9 4173.8 4315.7 4363.2 4450.0 9171.5 9177.3 9210.9 9381.9 9391.0 4784.4 4826.5 4867.1 4871.0 4879.8 3807.3 4294.7 4360.6 4426.0 4452.3 3792.4 3797.5 3900.1 3903.5 3921.3 1241.3 1245.3 1254.5 1255.1 1257.7 754.9 858.6 859.3 860.1 875.2 5165.4 5213.4 5263.4 5409.3 5546.5 408.2 413.3 413.9 414.2 432.9 3691.3 3757.6 3773.9 3802.7 3815.8 9676.9 9892.7 9938.6 10038.5 10087.1 9763.0 9825.8 9876.1 9942.9 9955.6 7162.4 7210.6 7241.9 7282.2 7303.1 5184.6 5248.2 5268.8 5364.6 5425.9 8639.1 8764.3 8889.2 9082.9 9160.0 8920.1 8926.2 9035.5 9173.2 9213.3 6058.8 6735.6 6757.3 6799.4 6969.6 7549.4 7556.8 7604.6 7628.6 7633.7 6662.3 6886.3 6922.3 6930.9 7053.1 6634.2 6652.9 6730.9 6737.7 6771.8 5969.7 6357.6 6407.2 6408.8 6428.9 4489.8 4539.3 4559.7 4647.4 4808.2 4433.6 4575.2 4600.2 4701.6 4732.3 12:43:53 INFO - PROCESS | 24752 | 12:43:53 INFO - PROCESS | 24752 | [#4] prototype.html Cycles:180 Average:4679.22 Median:5292.38 stddev:1373.80 (26.0%) stddev-sans-first:1338.01 12:43:53 INFO - PROCESS | 24752 | Values: 313.8 315.4 322.0 327.0 327.1 5157.6 5168.8 5339.8 5357.9 5359.0 5267.6 5317.1 5341.1 5347.8 5366.9 4148.5 4172.1 4199.3 4202.8 4214.2 3899.5 4094.5 4209.9 4210.5 4218.2 4033.4 4036.9 4057.8 4060.2 4064.2 4037.4 4061.2 4069.7 4073.5 4075.7 3436.1 3563.9 3570.9 3577.5 3582.1 5099.4 5125.7 5133.2 5139.8 5161.5 4681.9 4687.7 4704.8 4709.0 4734.0 5379.0 5605.5 5634.4 5680.4 5692.7 3985.3 3998.4 4003.7 4029.4 4029.5 5858.7 5865.4 5908.7 5935.5 6002.2 4042.6 4120.2 4141.8 4145.6 4160.4 4188.7 4209.7 4214.5 4220.3 4222.1 4706.3 4792.2 4794.7 4831.5 4835.7 5355.7 5461.6 5640.1 5673.5 5700.4 1415.0 1466.4 1472.8 1473.2 1479.8 980.1 985.8 1007.7 1012.1 1012.6 4851.0 4890.4 4896.6 4907.2 4913.3 5763.4 5773.6 5782.3 5783.9 5784.2 4711.0 4911.8 4926.2 4935.9 4946.7 3122.7 3152.8 3157.1 3174.9 3187.0 5540.3 5583.2 5586.6 5586.7 5588.9 5847.8 5975.5 6027.5 6067.3 6071.8 5500.5 5507.1 5549.8 5553.9 5582.7 5650.6 5834.3 5869.3 5876.3 5883.7 5727.0 5750.9 5760.0 5767.5 5785.9 5481.8 5560.7 5567.4 5568.3 5597.2 3775.9 3961.7 3964.7 3998.0 4006.1 5662.6 5749.2 5823.6 5853.0 5867.3 5700.6 5714.3 5723.4 5730.4 5739.6 5648.9 5668.7 5694.5 5707.1 5727.5 5495.6 5559.5 5576.6 5647.3 5653.5 5714.4 5724.1 5740.8 5753.0 5756.9 5510.6 5611.7 5621.3 5638.5 5668.3 12:43:53 INFO - PROCESS | 24752 | 12:43:53 INFO - PROCESS | 24752 | [#5] yui.html Cycles:180 Average:12715.22 Median:42654.18 stddev:14323.24 (33.6%) stddev-sans-first:14335.12 12:43:53 INFO - PROCESS | 24752 | Values: 725.7 760.9 765.5 770.2 787.1 12046.8 12048.2 12144.2 12201.9 12262.9 12239.6 12244.1 12268.6 12312.1 12337.7 636.2 713.6 753.7 756.4 757.3 805.3 807.0 808.8 817.4 820.5 847.2 849.6 850.9 853.5 854.5 845.8 846.6 848.7 850.0 852.8 619.8 621.5 624.7 625.0 626.1 12802.9 12871.4 12882.3 12890.7 12899.9 12793.0 12918.9 12945.4 13010.6 13082.3 9545.9 9708.8 9810.6 9812.0 9927.8 3290.0 3312.7 3343.6 3366.9 3375.7 45846.5 46261.0 46273.3 46463.8 46482.3 10164.8 10199.2 10219.9 10315.8 10422.0 16820.2 18156.5 18212.7 18288.8 18308.5 7111.3 7124.0 7151.5 7159.5 7182.7 3829.4 3888.4 3911.1 3923.9 3928.3 2717.1 2808.2 2812.7 2821.0 2822.0 531.1 537.0 539.1 543.4 557.0 631.2 651.4 654.4 657.8 661.3 7514.6 7555.4 7878.1 7891.4 8301.2 461.2 507.8 565.4 615.2 628.9 3731.9 3783.9 3832.0 3835.8 3879.8 53119.1 53857.5 53928.7 54756.5 55754.7 42618.6 43469.6 43543.0 46972.5 46991.0 40301.6 40893.0 41908.4 42425.8 42689.8 7367.9 7576.5 7604.9 7714.7 7731.3 27128.7 27470.7 27835.9 27994.2 28116.9 34790.7 37289.3 37320.3 38248.2 38451.2 10368.6 10472.0 10574.0 10580.3 10653.4 11446.4 11466.0 11661.6 11779.4 12416.0 10552.0 10595.7 10688.3 10700.1 10900.2 11217.4 11428.3 11462.2 11506.6 11595.6 10591.5 10775.9 10825.7 11095.7 11299.1 9688.7 9825.5 9928.6 9950.0 10056.2 9536.6 9589.8 9648.5 9777.4 9842.7 12:43:53 INFO - PROCESS | 24752 | -------- Summary: end -------- 12:43:53 INFO - PROCESS | 24752 | 12:43:53 INFO - TEST-INFO | 24752: exit 0 12:43:53 INFO - TEST-OK | dromaeo_css | took 1115233ms 12:43:53 INFO - TEST-START | kraken 12:43:53 INFO - operating with platform_type : linux_ 12:43:53 INFO - Initialising browser for kraken test... 12:43:53 INFO - TEST-INFO | started process 24988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCNJbZ8/profile http://localhost:60690/getInfo.html) 12:43:57 INFO - PROCESS | 24988 | 12:43:57 INFO - PROCESS | 24988 | (process:25056): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:43:58 INFO - PROCESS | 24988 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 12:43:58 INFO - PROCESS | 24988 | __metrics Screen width/height:1600/1200 12:43:58 INFO - PROCESS | 24988 | colorDepth:24 12:43:58 INFO - PROCESS | 24988 | Browser inner width/height: 1024/697 12:43:58 INFO - PROCESS | 24988 | __metrics 12:43:59 ERROR - PROCESS | 24988 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 12:44:00 INFO - TEST-INFO | 24988: exit 0 12:44:00 INFO - Browser initialized. 12:44:00 INFO - Running cycle 1/1 for kraken test... 12:44:00 INFO - TEST-INFO | started process 25108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCNJbZ8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:44:02 INFO - PROCESS | 25108 | 12:44:02 INFO - PROCESS | 25108 | (process:25166): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:44:12 INFO - PROCESS | 25108 | RSS: Main: 164614144 12:44:12 INFO - PROCESS | 25108 | 12:44:14 INFO - PROCESS | 25108 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60690/tests/kraken/driver.html?testName=audio-beat-detection) 12:44:15 INFO - PROCESS | 25108 | RSS: Main: 169177088 12:44:15 INFO - PROCESS | 25108 | 12:44:18 INFO - PROCESS | 25108 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60690/tests/kraken/driver.html?testName=audio-dft) 12:44:19 INFO - PROCESS | 25108 | RSS: Main: 172490752 12:44:19 INFO - PROCESS | 25108 | 12:44:22 INFO - PROCESS | 25108 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60690/tests/kraken/driver.html?testName=audio-fft) 12:44:22 INFO - PROCESS | 25108 | RSS: Main: 163004416 12:44:22 INFO - PROCESS | 25108 | 12:44:24 INFO - PROCESS | 25108 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60690/tests/kraken/driver.html?testName=audio-oscillator) 12:44:25 INFO - PROCESS | 25108 | RSS: Main: 163418112 12:44:25 INFO - PROCESS | 25108 | 12:44:27 INFO - PROCESS | 25108 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60690/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:44:28 INFO - PROCESS | 25108 | RSS: Main: 164646912 12:44:28 INFO - PROCESS | 25108 | 12:44:31 INFO - PROCESS | 25108 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60690/tests/kraken/driver.html?testName=imaging-darkroom) 12:44:32 INFO - PROCESS | 25108 | RSS: Main: 165019648 12:44:32 INFO - PROCESS | 25108 | 12:44:35 INFO - PROCESS | 25108 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60690/tests/kraken/driver.html?testName=imaging-desaturate) 12:44:36 INFO - PROCESS | 25108 | RSS: Main: 164581376 12:44:36 INFO - PROCESS | 25108 | 12:44:39 INFO - PROCESS | 25108 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60690/tests/kraken/driver.html?testName=json-parse-financial) 12:44:39 INFO - PROCESS | 25108 | RSS: Main: 164978688 12:44:39 INFO - PROCESS | 25108 | 12:44:41 INFO - PROCESS | 25108 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60690/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:44:42 INFO - PROCESS | 25108 | RSS: Main: 165146624 12:44:42 INFO - PROCESS | 25108 | 12:44:44 INFO - PROCESS | 25108 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60690/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:44:44 INFO - PROCESS | 25108 | RSS: Main: 165228544 12:44:44 INFO - PROCESS | 25108 | 12:44:46 INFO - PROCESS | 25108 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60690/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:44:47 INFO - PROCESS | 25108 | RSS: Main: 165834752 12:44:47 INFO - PROCESS | 25108 | 12:44:50 INFO - PROCESS | 25108 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:44:51 INFO - PROCESS | 25108 | RSS: Main: 166215680 12:44:51 INFO - PROCESS | 25108 | 12:44:53 INFO - PROCESS | 25108 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:44:54 INFO - PROCESS | 25108 | RSS: Main: 165625856 12:44:54 INFO - PROCESS | 25108 | 12:44:56 INFO - PROCESS | 25108 | Cycle 1(1): loaded http://localhost:60690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60690/tests/kraken/driver.html?testName=ai-astar) 12:44:56 INFO - PROCESS | 25108 | RSS: Main: 167772160 12:44:56 INFO - PROCESS | 25108 | 12:44:56 INFO - PROCESS | 25108 | __start_tp_report 12:44:56 INFO - PROCESS | 25108 | _x_x_mozilla_page_load 12:44:56 INFO - PROCESS | 25108 | _x_x_mozilla_page_load_details 12:44:56 INFO - PROCESS | 25108 | |i|pagename|runs| 12:44:56 INFO - PROCESS | 25108 | |0;ai-astar;114;108;114;114;118;125;116;115;114;113 12:44:56 INFO - PROCESS | 25108 | |1;audio-beat-detection;162;139;158;189;138;156;162;143;188;134 12:44:56 INFO - PROCESS | 25108 | |2;audio-dft;162;164;165;178;163;164;163;177;165;163 12:44:56 INFO - PROCESS | 25108 | |3;audio-fft;74;74;75;162;79;79;77;73;155;76 12:44:56 INFO - PROCESS | 25108 | |4;audio-oscillator;94;96;153;96;95;94;140;94;93;142 12:44:56 INFO - PROCESS | 25108 | |5;imaging-gaussian-blur;117;117;117;117;118;117;118;118;117;117 12:44:56 INFO - PROCESS | 25108 | |6;imaging-darkroom;147;146;147;147;146;147;148;149;147;147 12:44:56 INFO - PROCESS | 25108 | |7;imaging-desaturate;95;96;95;95;95;96;96;96;96;95 12:44:56 INFO - PROCESS | 25108 | |8;json-parse-financial;68;69;68;67;66;66;67;69;67;66 12:44:56 INFO - PROCESS | 25108 | |9;json-stringify-tinderbox;64;64;64;64;64;64;64;64;64;65 12:44:56 INFO - PROCESS | 25108 | |10;stanford-crypto-aes;78;81;80;77;86;81;80;79;113;88 12:44:56 INFO - PROCESS | 25108 | |11;stanford-crypto-ccm;144;132;138;136;134;146;142;139;140;141 12:44:56 INFO - PROCESS | 25108 | |12;stanford-crypto-pbkdf2;178;176;180;175;176;175;173;177;171;170 12:44:56 INFO - PROCESS | 25108 | |13;stanford-crypto-sha256-iterative;72;74;75;72;72;73;73;71;72;73 12:44:56 INFO - PROCESS | 25108 | __end_tp_report 12:44:56 INFO - PROCESS | 25108 | __start_cc_report 12:44:56 INFO - PROCESS | 25108 | _x_x_mozilla_cycle_collect,907 12:44:56 INFO - PROCESS | 25108 | __end_cc_report 12:44:56 INFO - PROCESS | 25108 | __startTimestamp1460749496653__endTimestamp 12:44:56 INFO - PROCESS | 25108 | 12:44:56 INFO - PROCESS | 25108 | ------- Summary: start ------- 12:44:56 INFO - PROCESS | 25108 | Number of tests: 14 12:44:56 INFO - PROCESS | 25108 | 12:44:56 INFO - PROCESS | 25108 | [#0] ai-astar Cycles:10 Average:115.10 Median:114.50 stddev:4.31 (3.8%) stddev-sans-first:4.55 12:44:56 INFO - PROCESS | 25108 | Values: 114.0 108.0 114.0 114.0 118.0 125.0 116.0 115.0 114.0 113.0 12:44:56 INFO - PROCESS | 25108 | 12:44:56 INFO - PROCESS | 25108 | [#1] audio-beat-detection Cycles:10 Average:156.90 Median:160.00 stddev:19.57 (12.2%) stddev-sans-first:20.67 12:44:56 INFO - PROCESS | 25108 | Values: 162.0 139.0 158.0 189.0 138.0 156.0 162.0 143.0 188.0 134.0 12:44:56 INFO - PROCESS | 25108 | 12:44:56 INFO - PROCESS | 25108 | [#2] audio-dft Cycles:10 Average:166.40 Median:164.50 stddev:5.93 (3.6%) stddev-sans-first:6.07 12:44:56 INFO - PROCESS | 25108 | Values: 162.0 164.0 165.0 178.0 163.0 164.0 163.0 177.0 165.0 163.0 12:44:56 INFO - PROCESS | 25108 | 12:44:56 INFO - PROCESS | 25108 | [#3] audio-fft Cycles:10 Average:92.40 Median:75.50 stddev:34.94 (46.3%) stddev-sans-first:36.41 12:44:56 INFO - PROCESS | 25108 | Values: 74.0 74.0 75.0 162.0 79.0 79.0 77.0 73.0 155.0 76.0 12:44:56 INFO - PROCESS | 25108 | 12:44:56 INFO - PROCESS | 25108 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:94.00 stddev:24.60 (26.2%) stddev-sans-first:25.43 12:44:56 INFO - PROCESS | 25108 | Values: 94.0 96.0 153.0 96.0 95.0 94.0 140.0 94.0 93.0 142.0 12:44:56 INFO - PROCESS | 25108 | 12:44:56 INFO - PROCESS | 25108 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 12:44:56 INFO - PROCESS | 25108 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 117.0 117.0 12:44:56 INFO - PROCESS | 25108 | 12:44:56 INFO - PROCESS | 25108 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 12:44:56 INFO - PROCESS | 25108 | Values: 147.0 146.0 147.0 147.0 146.0 147.0 148.0 149.0 147.0 147.0 12:44:56 INFO - PROCESS | 25108 | 12:44:56 INFO - PROCESS | 25108 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 12:44:56 INFO - PROCESS | 25108 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 12:44:56 INFO - PROCESS | 25108 | 12:44:56 INFO - PROCESS | 25108 | [#8] json-parse-financial Cycles:10 Average:67.30 Median:67.50 stddev:1.16 (1.7%) stddev-sans-first:1.20 12:44:56 INFO - PROCESS | 25108 | Values: 68.0 69.0 68.0 67.0 66.0 66.0 67.0 69.0 67.0 66.0 12:44:56 INFO - PROCESS | 25108 | 12:44:56 INFO - PROCESS | 25108 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 12:44:56 INFO - PROCESS | 25108 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 65.0 12:44:56 INFO - PROCESS | 25108 | 12:44:56 INFO - PROCESS | 25108 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:80.50 stddev:10.65 (13.2%) stddev-sans-first:11.05 12:44:56 INFO - PROCESS | 25108 | Values: 78.0 81.0 80.0 77.0 86.0 81.0 80.0 79.0 113.0 88.0 12:44:56 INFO - PROCESS | 25108 | 12:44:56 INFO - PROCESS | 25108 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:140.50 stddev:4.37 (3.1%) stddev-sans-first:4.27 12:44:56 INFO - PROCESS | 25108 | Values: 144.0 132.0 138.0 136.0 134.0 146.0 142.0 139.0 140.0 141.0 12:44:56 INFO - PROCESS | 25108 | 12:44:56 INFO - PROCESS | 25108 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.10 Median:176.00 stddev:3.07 (1.7%) stddev-sans-first:3.07 12:44:56 INFO - PROCESS | 25108 | Values: 178.0 176.0 180.0 175.0 176.0 175.0 173.0 177.0 171.0 170.0 12:44:56 INFO - PROCESS | 25108 | 12:44:56 INFO - PROCESS | 25108 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:73.00 stddev:1.16 (1.6%) stddev-sans-first:1.20 12:44:56 INFO - PROCESS | 25108 | Values: 72.0 74.0 75.0 72.0 72.0 73.0 73.0 71.0 72.0 73.0 12:44:56 INFO - PROCESS | 25108 | -------- Summary: end -------- 12:44:56 INFO - PROCESS | 25108 | 12:44:57 INFO - TEST-INFO | 25108: exit 0 12:44:57 INFO - TEST-OK | kraken | took 63670ms 12:44:57 INFO - SUITE-END | took 1178s 12:44:57 INFO - Completed test suite (00:19:39) 12:44:57 INFO - javascript benchmark 12:44:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2548.3374322676104, 2651.496215719014, 2673.211402636222, 2679.866006699666, 2692.165428717097, 4603.516630753773, 4650.7442090685045, 4663.067386522696, 4665.136949664306, 4674.696144750589, 4570.908581828361, 4639.443266807988, 4719.834805781798, 4734.928976065353, 4743.667943243974, 4342.8914277143085, 4387.956120438803, 4437.267850804614, 4448.733076015434, 4480.462344518646, 4358.476982762073, 4457.33140028995, 4465.5311192324825, 4488.730676159441, 4499.302608095734, 4126.381042843567, 4209.2423363794505, 4268.082362292091, 4368.519462859099, 4450.354698568722, 4280.101178752466, 4311.655067594585, 4324.437823082979, 4332.415123958257, 4375.2780791169735, 4314.78426078698, 4340.218760623086, 4345.630621397185, 4355.150745604608, 4402.163588918127, 4589.977050114761, 4634.698744581591, 4661.18429274879, 4680.461746899116, 4698.859034228979, 5034.647574669774, 5048.873778155539, 5052.0, 5061.949380506185, 5085.669431486942, 4805.807767689288, 5063.0, 5088.949110508885, 5099.36257967754, 5144.794208231666, 4638.605718513897, 4689.296605509201, 4699.271612900006, 4716.622670186412, 4737.928931066037, 5156.303898973665, 5219.5041471060185, 5234.953009398136, 5249.868753281198, 5268.209768534751, 4805.183118869801, 4915.21356582945, 4959.958408734206, 5013.298138260647, 5013.817216548961, 5043.546080852668, 5046.646734728607, 5061.266116413173, 5069.264956581275, 5127.359080114986, 4723.669343146015, 4996.475370086161, 5014.09746245672, 5046.520580544842, 5052.0, 4745.477997420281, 4864.854054378375, 4986.202207646759, 4987.177115775857, 5088.160453525127, 4124.938125928114, 4134.111166099243, 4246.660267178619, 4323.805428755651, 4342.934855977162, 3664.76179048361, 3697.4453831925425, 3697.9091168105474, 3709.146896213886, 3738.5700644425697, 4299.290617048215, 4301.892452688645, 4326.307790753464, 4328.653707703376, 4332.870013899588, 4918.704877707349, 5087.821926232564, 5154.7938082476285, 5179.818706345335, 5210.739463026834, 4326.978365108154, 4347.282698354736, 4360.149770794728, 4374.825006999748, 4413.514513403523, 4389.209942210433, 4524.524924882906, 4526.456825181, 4535.297028960516, 4572.428446444194, 4763.285507173951, 4796.880077998078, 4814.133455977958, 4816.807327706852, 4838.7338696370625, 4917.803287868588, 4921.409430868175, 4956.628252880976, 4973.154563724103, 4980.651354405301, 4604.447466304065, 4648.837290694944, 4659.5573420525, 4685.273782563708, 4735.479097299363, 4986.102501549756, 4993.725345106054, 5013.172826483589, 5030.195168773125, 5053.924191137063, 5067.7212753297445, 5074.670146440617, 5087.898242035212, 5095.286659867696, 5124.30821839047, 4730.148573256709, 4929.433115191799, 4936.963237720119, 4941.703497790144, 5014.598832093351, 4664.207084795661, 4851.56335929768, 4916.582090522345, 4936.629752768485, 4949.331840201527, 4831.178699621002, 4834.274858771212, 4864.537868902448, 4876.634252431153, 4922.261660750916, 4730.574248317668, 4895.0, 4912.312276281252, 4939.802407903644, 4990.750462476934, 4844.0554091951735, 4851.32081508582, 4865.221564549655, 4873.853784386474, 4901.583365413837], "value": 4622.641072505209, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.2469789273943, 610.0635524469939, 620.5842085802515, 626.5332327416074, 646.9450096741776, 33082.338353232924, 34324.65675343246, 34398.31203375934, 34474.0, 34493.48259776105, 33012.66987330126, 33388.33223335538, 33622.0, 33642.49536256958, 33670.49494257582, 7475.738349157794, 7590.1650818409935, 7595.620218989056, 7620.123685776123, 7646.808829779272, 7499.962500187491, 7677.769666910001, 7707.036620422447, 7715.961420192919, 7743.26438988298, 7757.650905709256, 7792.649330780128, 7825.256600622932, 7839.294463498284, 7853.136155022971, 7694.153643099255, 7715.72994945177, 7770.106437759617, 7784.844303113934, 7795.61021948906, 7778.0, 7853.057633084067, 7880.290773830326, 7885.172056933997, 7888.80277993049, 29297.853510732522, 34537.30925381504, 35142.29715405703, 35278.29443411117, 35459.29081418383, 3063.908082757521, 3154.3691261747513, 3241.0, 3272.934541309184, 3312.271300313927, 27313.0, 27655.0, 27959.440811183664, 28494.43011139786, 28861.855690721623, 3328.1679580104974, 3364.108511244522, 3377.257003459235, 3460.0311912664492, 3491.0748651607346, 241795.0, 247816.0, 248281.0, 248820.0, 252092.0, 34351.31297374039, 35247.11882202965, 56576.0, 56998.43001569931, 57172.0, 36223.094422639646, 36290.0, 36503.26993460116, 36654.63345366566, 36676.63323366785, 13343.466261349631, 13589.932050339685, 13673.427555831007, 13700.862991370159, 13715.725685486233, 10847.566097356175, 11069.114470842313, 11102.333859968428, 11105.555777768961, 11106.888931110747, 8290.0, 8303.916960830315, 8355.373346999, 8358.414910956297, 8379.539125348043, 3233.7040701102483, 3245.3996010738088, 3248.3016151527536, 3332.366850298484, 3362.5796775403073, 941.5668792355593, 947.9052094790466, 984.5077461269366, 1038.46000079958, 1048.9772471840047, 26924.461510769674, 27557.862210688818, 27786.722132778414, 28215.458072217167, 28494.0, 1027.9383237005804, 1037.9896201037893, 1060.8514807926897, 1102.4377567440504, 1109.3288560420829, 14528.273586320642, 15051.1721855299, 15063.246837658073, 15231.238438078051, 15239.923800380928, 348449.0, 352188.0, 353207.0, 354070.0, 355237.0, 48892.7555362228, 49614.75192624086, 49811.0, 49954.50045499571, 50010.749946250035, 1236.567201479475, 1257.6352857671357, 1263.9494420223089, 1269.6444995401303, 1274.1463219642862, 26395.0, 27470.5879411805, 27938.0, 27941.30146746266, 28108.85945570341, 42881.78559107184, 42978.14043719046, 43028.56971430246, 43436.0, 43437.0, 300299.0, 302319.0, 304858.0, 304887.0, 305917.0, 23739.52520949606, 23896.76103239015, 24057.639135413334, 24082.157124500558, 24095.156669516484, 42090.36864447097, 42519.0, 42776.78611606922, 42871.14257714766, 42963.785181073894, 36068.63931360653, 36193.45709814302, 36196.4570531437, 36416.635833641325, 36456.0835133194, 36127.81936090303, 36398.0, 36647.63352366442, 36791.26417471689, 37492.62507374891, 35638.465423018155, 35809.82095089508, 35913.64086359103, 35974.64025359713, 36319.63680363163, 32399.51400728944, 32619.0, 33026.504602430505, 33354.4996825043, 33574.83212583922, 25064.248072557853, 25776.742232577435, 25853.0, 25908.740912590634, 26093.73906260913], "value": 16392.669295206015, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.6278809554732, 383.90786211309285, 384.5539174557512, 392.69958481761455, 400.7295075823818, 15556.766648500281, 16644.751643626714, 16769.329226830927, 16827.999999999985, 16908.746368804477, 15386.923065384657, 15868.444604438848, 16257.0, 16285.83714162858, 16381.672366552692, 4965.6524043316895, 5113.105206588851, 5163.690178589297, 5172.482751724816, 5175.896482070356, 3657.670809627133, 5604.103343465046, 5903.586748927555, 5922.644641321534, 5926.792562260322, 5671.546276297886, 5839.416058394169, 5843.590948633598, 5851.15158302046, 5867.178594996704, 5837.678927658977, 5884.6469211847425, 5911.054231323011, 5912.704364781765, 5919.970400148015, 4562.954370456286, 4874.439439464471, 5127.692338459704, 5200.713960732158, 5220.582353411718, 12139.15025948184, 12191.207571507824, 12209.694757631041, 12222.205556638879, 15977.760333595006, 1858.1545396844538, 1934.0619799397282, 1954.4654313251585, 1994.2521554417094, 2006.7190593316948, 8933.64265429382, 9059.870930331366, 9185.17333439987, 9318.534073296309, 9411.717648470556, 1762.118940529735, 1768.7612172356696, 1809.6471188118192, 1830.3136323878546, 1847.8607918263128, 68060.0, 70266.297337027, 70336.29663703349, 70648.2935170652, 70854.29145708529, 9766.267529935283, 9847.359921605073, 10033.598656053822, 10146.949265253626, 10204.183665306758, 14026.0, 14074.507392241427, 14107.294635268196, 14111.858881411055, 14141.3737420198, 7230.56616602995, 7320.67056982437, 7372.705091796375, 7412.555246685216, 7436.107667079985, 6812.352826481576, 6832.863342733118, 6846.726130954806, 6948.791536253921, 6969.30306969299, 4271.380649805761, 4280.6789490788315, 4311.935320970188, 4312.525622181557, 4379.4525684289465, 1711.649111932051, 1760.3750668512494, 1845.8800177988387, 1850.8982005989799, 1862.1061890292735, 779.5907148746953, 874.8906386701663, 905.1898550797, 936.990630093704, 938.1228551304553, 14990.550283491513, 15005.0, 15649.98275112114, 16002.279897404645, 16085.356585736674, 843.0768308701962, 853.8206976534873, 864.3301441382853, 897.9955100224457, 925.486355072941, 8959.462432254086, 9027.729168124966, 9045.276377889753, 9075.682351117679, 9235.1688348049, 396242.0, 398929.0, 406236.0, 406439.0, 409405.0, 73803.0, 74810.62594686991, 75414.62292688501, 76555.61722191353, 80215.0, 941.8398872191743, 955.8757361543094, 978.4911845840123, 988.2785566536324, 991.8016396720541, 15080.622984425478, 15171.848281517043, 15209.923950380176, 15308.693826123637, 15694.450694225647, 34211.828940855135, 34526.654733453346, 35213.29573408569, 35571.822140890166, 35895.28209435849, 50361.0, 50861.74569127131, 50877.0, 50969.490305097956, 51262.0, 7363.263673632594, 7567.772966811004, 7632.580208088609, 7633.847323053396, 7846.215378462108, 8555.700550480704, 11499.655010349703, 11620.244684095507, 11767.470463828977, 11975.922167005012, 9863.210943124677, 10092.243081769044, 10197.745056373353, 10326.432046237529, 10367.429791361246, 9626.47054412014, 9983.351082179635, 10094.596216151273, 10255.897441025494, 10320.380777153396, 9148.771280718036, 10336.586536538754, 10481.37111773296, 10645.467726613793, 10783.568657253621, 7945.562994035384, 8021.959890200512, 8032.397570182143, 8034.076081250731, 8070.27367536901, 7924.049114106344, 10150.187984961038, 10562.735931601772, 10595.0, 10724.785504290026], "value": 8099.91307056147, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.9136051836888, 1468.2732047636418, 1591.5861875912267, 1700.7278835386342, 1751.3957684598809, 6705.463562914967, 7650.770476885696, 7786.299233069023, 7917.802054948622, 7982.281594656487, 7827.178146294643, 7836.451448398614, 7907.16974717655, 7938.642761075751, 7939.404544659159, 2269.8751568663674, 2298.586254474202, 2304.68886700295, 2310.89600967956, 2312.3063081075693, 2245.41619179013, 2273.6362182050875, 2275.6927814745045, 2285.200179937017, 2288.4850908545527, 2273.9886300568555, 2277.271273192579, 2280.749117597063, 2294.8164146868294, 2296.8047715944167, 2215.125025614881, 2221.80003799658, 2223.1996481266733, 2224.0325458425636, 2225.63277059285, 2214.568159208955, 2216.34617787753, 2217.7227846519186, 2221.378014156023, 2227.1425501182, 8027.7190298339865, 8034.276915077613, 8067.636956336979, 8089.676412943475, 8107.95946020272, 4663.743494107823, 4849.660523763338, 4861.854144375674, 4869.220924652074, 4875.488073752276, 2835.9858200708863, 2946.351802603424, 2954.0989998050586, 2984.0301901881976, 3005.0534081764176, 1733.3759846455266, 1746.7467217253427, 1751.1856986501211, 1775.2366482412558, 1778.065222258163, 10387.428691421968, 10581.36511809294, 10592.62925797601, 10608.416537090457, 10629.096526795232, 4168.874933751992, 4173.768738222232, 4315.7194782339675, 4363.214621368184, 4449.977750111293, 9171.495567743837, 9177.311701622404, 9210.861837072449, 9381.859272110923, 9390.953045234866, 4784.354112194809, 4826.517348265145, 4867.050925069578, 4871.025794840975, 4879.780409881564, 3807.2575847709986, 4294.656427485794, 4360.629346505582, 4425.955740442619, 4452.265376212953, 3792.4311353296675, 3797.5063241778944, 3900.063984643722, 3903.4730311408166, 3921.274564205631, 1241.2862604002735, 1245.2901845947722, 1254.5420921363636, 1255.0649765924445, 1257.6730050187018, 754.8980887580216, 858.6179150278191, 859.334016137486, 860.1312674198979, 875.2035647560689, 5165.354330708661, 5213.374395072539, 5263.4473380295285, 5409.323834520685, 5546.473085056913, 408.216224848292, 413.2747028964209, 413.9337705967031, 414.22539850479797, 432.94155289035575, 3691.335559599298, 3757.5866654667966, 3773.9433908491396, 3802.657760801486, 3815.771053736785, 9676.9032309676, 9892.703218903445, 9938.552765125587, 10038.548265327932, 10087.142592879542, 9763.023697630322, 9825.754356141011, 9876.111149996535, 9942.900570994341, 9955.55200016001, 7162.427005839624, 7210.639468026578, 7241.927580724231, 7282.198958114604, 7303.123625165014, 5184.585233181412, 5248.160294352885, 5268.76290566933, 5364.624476286623, 5425.945740542702, 8639.136086391562, 8764.298856091626, 8889.155530224618, 9082.863757043782, 9160.0, 8920.107989201288, 8926.241269491906, 9035.50304733246, 9173.174414302744, 9213.262938965001, 6058.757649693963, 6735.595864248161, 6757.3242675732035, 6799.422049125682, 6969.58182509051, 7549.396048316012, 7556.8488630228185, 7604.619769011417, 7628.618569071636, 7633.6946522140715, 6662.267150613526, 6886.345797149263, 6922.27316131819, 6930.896036559355, 7053.0830991970715, 6634.170728658918, 6652.900206497004, 6730.93269067303, 6737.730490780314, 6771.830704232237, 5969.671668058125, 6357.618542887441, 6407.231132264158, 6408.807735767934, 6428.935710642833, 4489.820407183676, 4539.341795439709, 4559.749213793273, 4647.395838541103, 4808.158572249912, 4433.578810013044, 4575.153596584642, 4600.240960241523, 4701.647376446712, 4732.266498692708], "value": 4217.9322859718595, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.8305315129829, 315.4007385966664, 321.9581454410926, 326.99999999999994, 327.10047369733235, 5157.5616072633875, 5168.793248270064, 5339.839804805857, 5357.866053348668, 5359.0, 5267.631265811395, 5317.12267475866, 5341.145416733323, 5347.786088556462, 5366.865828354293, 4148.522919864224, 4172.082141928786, 4199.320271891253, 4202.810873510699, 4214.2414365414215, 3899.51256092987, 4094.529129150141, 4209.852655157055, 4210.51579068408, 4218.240716670998, 4033.3949907513816, 4036.9394459083137, 4057.782665200443, 4060.2488539620117, 4064.2074795414906, 4037.3540233562635, 4061.1674606705556, 4069.674426045909, 4073.490813648279, 4075.714699971003, 3436.1237884339585, 3563.8574457021687, 3570.892873213808, 3577.5349204603494, 3582.0865679251883, 5099.36257967754, 5125.692458452505, 5133.230015497668, 5139.820106296262, 5161.483851614808, 4681.9297710534365, 4687.718736875764, 4704.811807527695, 4708.964027913854, 4733.9763301183275, 5379.0, 5605.523530499912, 5634.352049514277, 5680.375158732536, 5692.715364231772, 3985.342418500944, 3998.420229066798, 4003.679705623543, 4029.37544680575, 4029.49631296088, 5858.736356863951, 5865.384134665841, 5908.704564771744, 5935.465808077251, 6002.2197114375285, 4042.5957404259925, 4120.21715873989, 4141.834326626901, 4145.647619952338, 4160.417541544186, 4188.743376986953, 4209.7474151551005, 4214.473190851144, 4220.345846393752, 4222.071144348239, 4706.317583950308, 4792.2332426811545, 4794.7362895040405, 4831.51684831514, 4835.709857408567, 5355.7054362009685, 5461.617686761889, 5640.125780504029, 5673.546116310686, 5700.40145784695, 1414.974143745776, 1466.3914475492763, 1472.8306244781772, 1473.2191938272733, 1479.7706355514913, 980.1325826643472, 985.792404304721, 1007.7279134633754, 1012.1346248957183, 1012.6152062216458, 4850.981293928244, 4890.437599676012, 4896.5837903777865, 4907.2393778964315, 4913.336699545515, 5763.366029736726, 5773.566982476331, 5782.306123265235, 5783.88432231353, 5784.248047753765, 4710.9764451177525, 4911.803527858846, 4926.187179115477, 4935.8519244422005, 4946.678465899705, 3122.734567561737, 3152.8423578820966, 3157.1002264354547, 3174.920527020824, 3186.952195717066, 5540.279763630702, 5583.218349431083, 5586.636868603528, 5586.748596313176, 5588.91616625751, 5847.795327163614, 5975.462208401264, 6027.48766354856, 6067.332593414721, 6071.757129714851, 5500.514860987591, 5507.146392309199, 5549.750261238254, 5553.888922221614, 5582.720863956786, 5650.63270887391, 5834.299884013776, 5869.266341707286, 5876.324222714272, 5883.705814709333, 5727.0, 5750.856228594319, 5759.999999999833, 5767.509761670137, 5785.9132113017495, 5481.780728770805, 5560.721963901708, 5567.359753628222, 5568.331800184003, 5597.216389705363, 3775.905602359963, 3961.7028722845325, 3964.742291751027, 3998.0, 4006.09862780872, 5662.556048207681, 5749.195112684144, 5823.563232757476, 5853.0, 5867.266591676041, 5700.600957933071, 5714.342850572238, 5723.427657234243, 5730.398308177748, 5739.598228123991, 5648.870225954744, 5668.659880407189, 5694.4590263924865, 5707.143928410772, 5727.5417966561745, 5495.587830912617, 5559.525296689569, 5576.5817563683695, 5647.265855438766, 5653.519450846724, 5714.428557144419, 5724.112762521816, 5740.799072032459, 5752.979685665059, 5756.884862302647, 5510.586705996986, 5611.663300202001, 5621.297337832771, 5638.4925356718095, 5668.291463567054], "value": 4244.0257850522385, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.7459889038836, 760.9391248700105, 765.5253742679539, 770.1951460723543, 787.1420152034283, 12046.81929771053, 12048.15662903596, 12144.210626309283, 12201.877981220196, 12262.93868530656, 12239.571614993478, 12244.081693872951, 12268.570600029001, 12312.13815032948, 12337.691557711061, 636.2015670333725, 713.55759429154, 753.7211231844198, 756.4440136499668, 757.322196634015, 805.3074356053789, 806.9993208421573, 808.8018435483315, 817.4032955942166, 820.5076953827686, 847.2163248994686, 849.5921957460423, 850.8596081646521, 853.5390888919976, 854.478767951549, 845.7589586967746, 846.6190214403513, 848.6987119572556, 850.0352100366129, 852.7569642651814, 619.8326451857973, 621.4810633121349, 624.6595605395071, 624.9625022498665, 626.139058794158, 12802.935985320108, 12871.356432178447, 12882.291473968928, 12890.677733056655, 12899.871001290056, 12793.0, 12918.935405322913, 12945.352732363439, 13010.609681709564, 13082.280474573894, 9545.856812147824, 9708.75728106796, 9810.607575696964, 9811.950940245324, 9927.751806204831, 3290.0, 3312.685294896981, 3343.632200457948, 3366.9326613467592, 3375.746818988586, 45846.54153458456, 46261.0, 46273.305900411186, 46463.76768116171, 46482.302765458546, 10164.847527287096, 10199.235057370726, 10219.948900255451, 10315.84526232107, 10422.0, 16820.243089061023, 18156.546086347946, 18212.726809097872, 18288.81711182871, 18308.450746477625, 7111.288871112847, 7124.038254835635, 7151.53515021522, 7159.463040272, 7182.676779544933, 3829.4447305141157, 3888.416737489399, 3911.1395492992065, 3923.948018878695, 3928.273269445162, 2717.062613398374, 2808.2137001639576, 2812.6765421976324, 2820.9985455163533, 2822.012295696531, 531.0653250279458, 536.9824183172943, 539.1185411851651, 543.3642638113416, 556.9832905012856, 631.2298995225817, 651.4430162211336, 654.4248382614428, 657.8289644692319, 661.2527843536773, 7514.624268786539, 7555.433342499335, 7878.094019187867, 7891.408144389194, 8301.211384918422, 461.1654096190168, 507.82733870484213, 565.4244914414879, 615.1664494609829, 628.9402357028422, 3731.850725970985, 3783.9243215135543, 3831.9616803832164, 3835.827387767557, 3879.8060096995036, 53119.140830071534, 53857.46142538603, 53928.730356347965, 54756.452435475934, 55754.72122639361, 42618.57381426146, 43469.56530434718, 43543.0, 46972.530274696815, 46991.0, 40301.59698403037, 40893.0, 41908.37137442941, 42425.78787106045, 42689.786551067664, 7367.889481657887, 7576.545407275581, 7604.923950760643, 7714.6914123434435, 7731.304182623591, 27128.728712712622, 27470.725292746818, 27835.860820696576, 27994.16017519478, 28116.85941570279, 34790.65209347874, 37289.254214916094, 37320.253594928494, 38248.23503529858, 38451.230975380895, 10368.585256589651, 10472.0, 10574.0, 10580.312279701795, 10653.360798352123, 11446.427678616203, 11466.0, 11661.591844285409, 11779.35213563228, 12416.0, 10552.0, 10595.735106622087, 10688.305260158066, 10700.143988480748, 10900.236983411085, 11217.383043932661, 11428.25716328436, 11462.197646165023, 11506.597269095542, 11595.5941542049, 10591.4704264788, 10775.892241077489, 10825.729356766144, 11095.667129986114, 11299.09607231403, 9688.657303426788, 9825.459599722084, 9928.553215105194, 9949.950250248703, 10056.19550435978, 9536.57085431171, 9589.808203836024, 9648.517574121126, 9777.364471309342, 9842.704718858446], "value": 5958.163823224562, "unit": "score"}], "name": "dromaeo_css", "value": 6348.561653802792, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 114.0, 114.0, 118.0, 125.0, 116.0, 115.0, 114.0, 113.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 139.0, 158.0, 189.0, 138.0, 156.0, 162.0, 143.0, 188.0, 134.0], "value": 156.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 165.0, 178.0, 163.0, 164.0, 163.0, 177.0, 165.0, 163.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 162.0, 79.0, 79.0, 77.0, 73.0, 155.0, 76.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 153.0, 96.0, 95.0, 94.0, 140.0, 94.0, 93.0, 142.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 148.0, 149.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 67.0, 66.0, 66.0, 67.0, 69.0, 67.0, 66.0], "value": 67.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 80.0, 77.0, 86.0, 81.0, 80.0, 79.0, 113.0, 88.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 132.0, 138.0, 136.0, 134.0, 146.0, 142.0, 139.0, 140.0, 141.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 176.0, 180.0, 175.0, 176.0, 175.0, 173.0, 177.0, 171.0, 170.0], "value": 175.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 75.0, 72.0, 72.0, 73.0, 73.0, 71.0, 72.0, 73.0], "value": 72.7, "unit": "score"}], "name": "kraken", "value": 1603.1, "alertThreshold": 2.0}]} 12:44:57 INFO - Return code: 0 12:44:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:44:57 ERROR - # TBPL SUCCESS # 12:44:57 INFO - Running post-action listener: _resource_record_post_action 12:44:57 INFO - Running post-run listener: _resource_record_post_run 12:44:59 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 517591040; Read time: 8; Write time: 453296 12:44:59 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233988096; Read time: 0; Write time: 261292 12:44:59 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283602944; Read time: 8; Write time: 192004 12:44:59 INFO - Running post-run listener: _upload_blobber_files 12:44:59 INFO - Blob upload gear active. 12:44:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:44:59 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 12:44:59 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:44:59 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:44:59 INFO - (blobuploader) - INFO - Open directory for files ... 12:44:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:44:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:44:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:45:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:45:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:45:00 INFO - (blobuploader) - INFO - Done attempting. 12:45:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:45:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:45:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:45:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:45:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:45:01 INFO - (blobuploader) - INFO - Done attempting. 12:45:01 INFO - (blobuploader) - INFO - Iteration through files over. 12:45:01 INFO - Return code: 0 12:45:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:45:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:45:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/872216aa515bba72bca6282b0f0b785dd27b6e4139a5b5d171aea431fec9bbcf081f8088ed8688a5a6bd4a1c0dd1e1ba7062d51563b4a45332fb9abef1cbd6a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/69f12e6b429883471a293767362d1066beb75ed9ae06818e2af9b0f2fa61752899780b3c6635c7a60d01f01e8e218a85b54588dec501a718f63bb4bb74c54fa9"} 12:45:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:45:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:45:01 INFO - Contents: 12:45:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/872216aa515bba72bca6282b0f0b785dd27b6e4139a5b5d171aea431fec9bbcf081f8088ed8688a5a6bd4a1c0dd1e1ba7062d51563b4a45332fb9abef1cbd6a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/69f12e6b429883471a293767362d1066beb75ed9ae06818e2af9b0f2fa61752899780b3c6635c7a60d01f01e8e218a85b54588dec501a718f63bb4bb74c54fa9"} 12:45:01 INFO - Running post-run listener: copy_logs_to_upload_dir 12:45:01 INFO - Copying logs to upload dir... 12:45:01 INFO - mkdir: /builds/slave/test/build/upload/logs 12:45:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.311351 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-15 12:45:00.367140) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 12:45:00.370564) ========= 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=ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099 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-Non-PGO/sha512/872216aa515bba72bca6282b0f0b785dd27b6e4139a5b5d171aea431fec9bbcf081f8088ed8688a5a6bd4a1c0dd1e1ba7062d51563b4a45332fb9abef1cbd6a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/69f12e6b429883471a293767362d1066beb75ed9ae06818e2af9b0f2fa61752899780b3c6635c7a60d01f01e8e218a85b54588dec501a718f63bb4bb74c54fa9"} build_url:https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/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-Non-PGO/sha512/872216aa515bba72bca6282b0f0b785dd27b6e4139a5b5d171aea431fec9bbcf081f8088ed8688a5a6bd4a1c0dd1e1ba7062d51563b4a45332fb9abef1cbd6a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/69f12e6b429883471a293767362d1066beb75ed9ae06818e2af9b0f2fa61752899780b3c6635c7a60d01f01e8e218a85b54588dec501a718f63bb4bb74c54fa9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 12:45:00.395116) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:45:00.395410) ========= 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=ed14279e38b05397cf4aa391000001a4-1460744551.278991-1272656099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:45:00.477908) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 12:45:00.478249) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 12:45:00.478528) ========= ========= Total master_lag: 0.16 =========