builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-019 starttime: 1464871876.45 results: success (0) buildid: 20160602030220 builduid: 8d834d93c2314782aa56f6ea25f5cfbd revision: 34a8be4346a9231e472fc36b1d7c0531e0fbf7c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 05:51:16.448270) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 05:51:16.448768) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 05:51:16.449063) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 05:51:16.463549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 05:51:16.463852) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 05:51:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.6M=0.001s 2016-06-02 05:51:16 (21.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083204 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 05:51:16.560847) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 05:51:16.561166) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019951 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 05:51:16.611509) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 05:51:16.611855) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 34a8be4346a9231e472fc36b1d7c0531e0fbf7c5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 34a8be4346a9231e472fc36b1d7c0531e0fbf7c5 --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=78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 05:51:16,718 truncating revision to first 12 chars 2016-06-02 05:51:16,718 Setting DEBUG logging. 2016-06-02 05:51:16,718 attempt 1/10 2016-06-02 05:51:16,719 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/34a8be4346a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 05:51:17,451 unpacking tar archive at: mozilla-central-34a8be4346a9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.085334 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 05:51:17.711061) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 05:51:17.711384) ========= script_repo_revision: 34a8be4346a9231e472fc36b1d7c0531e0fbf7c5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 05:51:17.714831) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 05:51:17.715111) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 05:51:17.724421) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-02 05:51:17.724724) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:51:17 INFO - MultiFileLogger online at 20160602 05:51:17 in /builds/slave/test 05:51:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:51:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:51:17 INFO - {'append_to_log': False, 05:51:17 INFO - 'base_work_dir': '/builds/slave/test', 05:51:17 INFO - 'blob_upload_branch': 'Firefox', 05:51:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:51:17 INFO - 'branch': 'Firefox', 05:51:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:51:17 INFO - 'config_files': ('talos/linux_config.py',), 05:51:17 INFO - 'default_actions': ('clobber', 05:51:17 INFO - 'read-buildbot-config', 05:51:17 INFO - 'download-and-extract', 05:51:17 INFO - 'populate-webroot', 05:51:17 INFO - 'create-virtualenv', 05:51:17 INFO - 'install', 05:51:17 INFO - 'run-tests'), 05:51:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:51:17 INFO - 'download_minidump_stackwalk': True, 05:51:17 INFO - 'download_symbols': 'ondemand', 05:51:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:51:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:51:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:51:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:51:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:51:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:51:17 INFO - 'installer_path': 'installer.exe', 05:51:17 INFO - 'log_level': 'info', 05:51:17 INFO - 'log_name': 'talos', 05:51:17 INFO - 'log_to_console': True, 05:51:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:51:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:51:17 INFO - 'opt_config_files': (), 05:51:17 INFO - 'pip_index': False, 05:51:17 INFO - 'sps_profile': False, 05:51:17 INFO - 'sps_profile_interval': 0, 05:51:17 INFO - 'suite': 'dromaeojs-e10s', 05:51:17 INFO - 'system_bits': '32', 05:51:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:51:17 INFO - 'title': 'talos-linux64-ix-019', 05:51:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:51:17 INFO - 'use_talos_json': True, 05:51:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:51:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:51:17 INFO - 'work_dir': 'build'} 05:51:17 INFO - ##### 05:51:17 INFO - ##### Running clobber step. 05:51:17 INFO - ##### 05:51:17 INFO - Running pre-action listener: _resource_record_pre_action 05:51:17 INFO - Running main action method: clobber 05:51:17 INFO - rmtree: /builds/slave/test/build 05:51:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:51:18 INFO - Running post-action listener: _resource_record_post_action 05:51:18 INFO - ##### 05:51:18 INFO - ##### Finished clobber step (success) 05:51:18 INFO - ##### 05:51:18 INFO - ##### 05:51:18 INFO - ##### Running read-buildbot-config step. 05:51:18 INFO - ##### 05:51:18 INFO - Running pre-action listener: _resource_record_pre_action 05:51:18 INFO - Running main action method: read_buildbot_config 05:51:18 INFO - Using buildbot properties: 05:51:18 INFO - { 05:51:18 INFO - "project": "", 05:51:18 INFO - "product": "firefox", 05:51:18 INFO - "script_repo_revision": "production", 05:51:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:51:18 INFO - "repository": "", 05:51:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:51:18 INFO - "buildid": "20160602030220", 05:51:18 INFO - "stage_platform": "linux64-pgo", 05:51:18 INFO - "basedir": "/builds/slave/test", 05:51:18 INFO - "nightly_build": "True", 05:51:18 INFO - "buildnumber": 55, 05:51:18 INFO - "slavename": "talos-linux64-ix-019", 05:51:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:51:18 INFO - "platform": "ubuntu64_hw", 05:51:18 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:51:18 INFO - "branch": "mozilla-central", 05:51:18 INFO - "repo_path": "mozilla-central", 05:51:18 INFO - "revision": "34a8be4346a9231e472fc36b1d7c0531e0fbf7c5", 05:51:18 INFO - "pgo_build": "True", 05:51:18 INFO - "builduid": "8d834d93c2314782aa56f6ea25f5cfbd", 05:51:18 INFO - "slavebuilddir": "test" 05:51:18 INFO - } 05:51:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:51:18 INFO - Running post-action listener: _resource_record_post_action 05:51:18 INFO - ##### 05:51:18 INFO - ##### Finished read-buildbot-config step (success) 05:51:18 INFO - ##### 05:51:18 INFO - ##### 05:51:18 INFO - ##### Running download-and-extract step. 05:51:18 INFO - ##### 05:51:18 INFO - Running pre-action listener: _resource_record_pre_action 05:51:18 INFO - Running main action method: download_and_extract 05:51:18 INFO - mkdir: /builds/slave/test/build/tests 05:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:18 INFO - https://queue.taskcluster.net/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:51:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:51:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:51:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:51:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:51:19 INFO - Downloaded 1361 bytes. 05:51:19 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:51:19 INFO - Using the following test package requirements: 05:51:19 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:51:19 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:51:19 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:51:19 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:19 INFO - u'jsshell-linux-x86_64.zip'], 05:51:19 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:51:19 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:51:19 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:51:19 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:51:19 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:51:19 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:51:19 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:19 INFO - https://queue.taskcluster.net/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:51:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:51:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:51:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:51:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:51:20 INFO - Downloaded 24422877 bytes. 05:51:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:51:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:51:21 INFO - Return code: 0 05:51:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:21 INFO - https://queue.taskcluster.net/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:51:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:51:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:51:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:51:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:51:22 INFO - Downloaded 24422877 bytes. 05:51:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:51:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:51:24 INFO - Return code: 0 05:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:24 INFO - https://queue.taskcluster.net/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:51:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:51:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:51:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:51:25 INFO - Downloaded 10834055 bytes. 05:51:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:51:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:51:25 INFO - Return code: 0 05:51: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')]} 05:51:25 INFO - https://queue.taskcluster.net/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:51:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:51:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:51:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:51:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:51:26 INFO - Downloaded 59055430 bytes. 05:51:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:51:26 INFO - mkdir: /builds/slave/test/properties 05:51:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:51:26 INFO - Writing to file /builds/slave/test/properties/build_url 05:51:26 INFO - Contents: 05:51:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:51:27 INFO - Running post-action listener: _resource_record_post_action 05:51:27 INFO - Running post-action listener: set_extra_try_arguments 05:51:27 INFO - ##### 05:51:27 INFO - ##### Finished download-and-extract step (success) 05:51:27 INFO - ##### 05:51:27 INFO - ##### 05:51:27 INFO - ##### Running populate-webroot step. 05:51:27 INFO - ##### 05:51:27 INFO - Running pre-action listener: _resource_record_pre_action 05:51:27 INFO - Running main action method: populate_webroot 05:51:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:51:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:51:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:51:27 INFO - '--tppagecycles', 05:51:27 INFO - '7'], 05:51:27 INFO - 'tests': ['tsvgm']}}, 05:51:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:51:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:51:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:51:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:51:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:27 INFO - 'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:27 INFO - 'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['damp', 'tps']}, 05:51:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:27 INFO - 'tests': ['damp', 'tps']}, 05:51:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['dromaeo_dom']}, 05:51:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:51:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['a11yr', 05:51:27 INFO - 'ts_paint', 05:51:27 INFO - 'tpaint', 05:51:27 INFO - 'sessionrestore', 05:51:27 INFO - 'sessionrestore_no_auto_restore', 05:51:27 INFO - 'tabpaint']}, 05:51:27 INFO - 'other-e10s': {'tests': ['a11yr', 05:51:27 INFO - 'ts_paint', 05:51:27 INFO - 'tpaint', 05:51:27 INFO - 'sessionrestore', 05:51:27 INFO - 'sessionrestore_no_auto_restore', 05:51:27 INFO - 'tabpaint']}, 05:51:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:51:27 INFO - 'ts_paint', 05:51:27 INFO - 'tpaint', 05:51:27 INFO - 'sessionrestore', 05:51:27 INFO - 'sessionrestore_no_auto_restore', 05:51:27 INFO - 'tabpaint']}, 05:51:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:51:27 INFO - 'ts_paint', 05:51:27 INFO - 'tpaint', 05:51:27 INFO - 'sessionrestore', 05:51:27 INFO - 'sessionrestore_no_auto_restore', 05:51:27 INFO - 'tabpaint']}, 05:51:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['a11yr', 05:51:27 INFO - 'ts_paint', 05:51:27 INFO - 'tpaint', 05:51:27 INFO - 'sessionrestore', 05:51:27 INFO - 'sessionrestore_no_auto_restore', 05:51:27 INFO - 'tabpaint']}, 05:51:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['a11yr', 05:51:27 INFO - 'ts_paint', 05:51:27 INFO - 'tpaint', 05:51:27 INFO - 'sessionrestore', 05:51:27 INFO - 'sessionrestore_no_auto_restore', 05:51:27 INFO - 'tabpaint']}, 05:51:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['tsvgx', 05:51:27 INFO - 'tsvgr_opacity', 05:51:27 INFO - 'tart', 05:51:27 INFO - 'tscrollx', 05:51:27 INFO - 'cart']}, 05:51:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:51:27 INFO - 'tsvgr_opacity', 05:51:27 INFO - 'tart', 05:51:27 INFO - 'tscrollx', 05:51:27 INFO - 'cart']}, 05:51:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:27 INFO - 'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['tp5o']}, 05:51:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:27 INFO - 'tests': ['tp5o']}, 05:51:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:27 INFO - 'talos_options': ['--disable-e10s', 05:51:27 INFO - '--xperf_path', 05:51:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:27 INFO - 'tests': ['tp5n']}, 05:51:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:27 INFO - 'talos_options': ['--xperf_path', 05:51:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:27 INFO - 'tests': ['tp5n']}}, 05:51:27 INFO - 'talos.zip': {'path': '', 05:51:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:51:27 INFO - Running post-action listener: _resource_record_post_action 05:51:27 INFO - ##### 05:51:27 INFO - ##### Finished populate-webroot step (success) 05:51:27 INFO - ##### 05:51:27 INFO - ##### 05:51:27 INFO - ##### Running create-virtualenv step. 05:51:27 INFO - ##### 05:51:27 INFO - Running pre-action listener: _resource_record_pre_action 05:51:27 INFO - Running main action method: create_virtualenv 05:51:27 INFO - Creating virtualenv /builds/slave/test/build/venv 05:51:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:51:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:51:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:51:27 INFO - Using real prefix '/usr' 05:51:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:51:28 INFO - Installing distribute.............................................................................................................................................................................................done. 05:51:30 INFO - Installing pip.................done. 05:51:30 INFO - Return code: 0 05:51:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e89d04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19639c0>, '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 0x19648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309', '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 05:51:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:51:30 INFO - Using env: {'DISPLAY': ':0', 05:51:30 INFO - 'HOME': '/home/cltbld', 05:51:30 INFO - 'LANG': 'en_US.UTF-8', 05:51:30 INFO - 'LANGUAGE': 'en_US:en', 05:51:30 INFO - 'LOGNAME': 'cltbld', 05:51:30 INFO - 'MAIL': '/var/mail/cltbld', 05:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:30 INFO - 'MOZ_NO_REMOTE': '1', 05:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:30 INFO - 'NO_EM_RESTART': '1', 05:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:30 INFO - 'PWD': '/builds/slave/test', 05:51:30 INFO - 'SHELL': '/bin/bash', 05:51:30 INFO - 'SHLVL': '1', 05:51:30 INFO - 'TERM': 'linux', 05:51:30 INFO - 'TMOUT': '86400', 05:51:30 INFO - 'USER': 'cltbld', 05:51:30 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309', 05:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:30 INFO - '_': '/tools/buildbot/bin/python'} 05:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:51:30 INFO - Cleaning up... 05:51:30 INFO - Return code: 0 05:51:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e89d04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19639c0>, '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 0x19648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309', '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 05:51:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:51:30 INFO - Using env: {'DISPLAY': ':0', 05:51:30 INFO - 'HOME': '/home/cltbld', 05:51:30 INFO - 'LANG': 'en_US.UTF-8', 05:51:30 INFO - 'LANGUAGE': 'en_US:en', 05:51:30 INFO - 'LOGNAME': 'cltbld', 05:51:30 INFO - 'MAIL': '/var/mail/cltbld', 05:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:30 INFO - 'MOZ_NO_REMOTE': '1', 05:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:30 INFO - 'NO_EM_RESTART': '1', 05:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:30 INFO - 'PWD': '/builds/slave/test', 05:51:30 INFO - 'SHELL': '/bin/bash', 05:51:30 INFO - 'SHLVL': '1', 05:51:30 INFO - 'TERM': 'linux', 05:51:30 INFO - 'TMOUT': '86400', 05:51:30 INFO - 'USER': 'cltbld', 05:51:30 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309', 05:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:30 INFO - '_': '/tools/buildbot/bin/python'} 05:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:30 INFO - Downloading/unpacking psutil>=3.1.1 05:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:51:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:32 INFO - Installing collected packages: psutil 05:51:32 INFO - Running setup.py install for psutil 05:51:32 INFO - building 'psutil._psutil_linux' extension 05:51:32 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 05:51:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:51:33 INFO - building 'psutil._psutil_posix' extension 05:51:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:51:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:51:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:33 INFO - Successfully installed psutil 05:51:33 INFO - Cleaning up... 05:51:33 INFO - Return code: 0 05:51:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:33 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e89d04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19639c0>, '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 0x19648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309', '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 05:51:33 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.3'] in /builds/slave/test/build 05:51:33 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.3 05:51:33 INFO - Using env: {'DISPLAY': ':0', 05:51:33 INFO - 'HOME': '/home/cltbld', 05:51:33 INFO - 'LANG': 'en_US.UTF-8', 05:51:33 INFO - 'LANGUAGE': 'en_US:en', 05:51:33 INFO - 'LOGNAME': 'cltbld', 05:51:33 INFO - 'MAIL': '/var/mail/cltbld', 05:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:33 INFO - 'MOZ_NO_REMOTE': '1', 05:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:33 INFO - 'NO_EM_RESTART': '1', 05:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:33 INFO - 'PWD': '/builds/slave/test', 05:51:33 INFO - 'SHELL': '/bin/bash', 05:51:33 INFO - 'SHLVL': '1', 05:51:33 INFO - 'TERM': 'linux', 05:51:33 INFO - 'TMOUT': '86400', 05:51:33 INFO - 'USER': 'cltbld', 05:51:33 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309', 05:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:33 INFO - '_': '/tools/buildbot/bin/python'} 05:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:51:33 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 05:51:33 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 05:51:33 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 05:51:33 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 05:51:33 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 05:51:33 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 05:51:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:51:35 INFO - Installing collected packages: mozsystemmonitor 05:51:35 INFO - Running setup.py install for mozsystemmonitor 05:51:35 INFO - Successfully installed mozsystemmonitor 05:51:35 INFO - Cleaning up... 05:51:35 INFO - Return code: 0 05:51:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7e89d04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19639c0>, '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 0x19648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309', '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 05:51:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:51:35 INFO - Using env: {'DISPLAY': ':0', 05:51:35 INFO - 'HOME': '/home/cltbld', 05:51:35 INFO - 'LANG': 'en_US.UTF-8', 05:51:35 INFO - 'LANGUAGE': 'en_US:en', 05:51:35 INFO - 'LOGNAME': 'cltbld', 05:51:35 INFO - 'MAIL': '/var/mail/cltbld', 05:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:35 INFO - 'MOZ_NO_REMOTE': '1', 05:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:35 INFO - 'NO_EM_RESTART': '1', 05:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:35 INFO - 'PWD': '/builds/slave/test', 05:51:35 INFO - 'SHELL': '/bin/bash', 05:51:35 INFO - 'SHLVL': '1', 05:51:35 INFO - 'TERM': 'linux', 05:51:35 INFO - 'TMOUT': '86400', 05:51:35 INFO - 'USER': 'cltbld', 05:51:35 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309', 05:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:35 INFO - '_': '/tools/buildbot/bin/python'} 05:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:35 INFO - Downloading/unpacking blobuploader==1.2.4 05:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:37 INFO - Downloading blobuploader-1.2.4.tar.gz 05:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:51:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:51:37 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 05:51:37 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 05:51:37 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 05:51:37 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 05:51:37 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 05:51:37 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 05:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:51:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:38 INFO - Downloading docopt-0.6.1.tar.gz 05:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:51:38 INFO - Installing collected packages: blobuploader, requests, docopt 05:51:38 INFO - Running setup.py install for blobuploader 05:51:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:51:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:51:38 INFO - Running setup.py install for requests 05:51:38 INFO - Running setup.py install for docopt 05:51:38 INFO - Successfully installed blobuploader requests docopt 05:51:38 INFO - Cleaning up... 05:51:39 INFO - Return code: 0 05:51:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:39 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 0x7f7e89d04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19639c0>, '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 0x19648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309', '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 05:51:39 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 05:51:39 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 05:51:39 INFO - Using env: {'DISPLAY': ':0', 05:51:39 INFO - 'HOME': '/home/cltbld', 05:51:39 INFO - 'LANG': 'en_US.UTF-8', 05:51:39 INFO - 'LANGUAGE': 'en_US:en', 05:51:39 INFO - 'LOGNAME': 'cltbld', 05:51:39 INFO - 'MAIL': '/var/mail/cltbld', 05:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:39 INFO - 'MOZ_NO_REMOTE': '1', 05:51:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:39 INFO - 'NO_EM_RESTART': '1', 05:51:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:39 INFO - 'PWD': '/builds/slave/test', 05:51:39 INFO - 'SHELL': '/bin/bash', 05:51:39 INFO - 'SHLVL': '1', 05:51:39 INFO - 'TERM': 'linux', 05:51:39 INFO - 'TMOUT': '86400', 05:51:39 INFO - 'USER': 'cltbld', 05:51:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309', 05:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:39 INFO - '_': '/tools/buildbot/bin/python'} 05:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:39 INFO - Running setup.py (path:/tmp/pip-MyQnSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:39 INFO - Running setup.py (path:/tmp/pip-OyWYNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:39 INFO - Running setup.py (path:/tmp/pip-QG5bOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:39 INFO - Running setup.py (path:/tmp/pip-7vaiwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:39 INFO - Running setup.py (path:/tmp/pip-cmPfSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:39 INFO - Running setup.py (path:/tmp/pip-Jx3m6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:39 INFO - Running setup.py (path:/tmp/pip-lzE2F2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:39 INFO - Running setup.py (path:/tmp/pip-ijQh4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:39 INFO - Running setup.py (path:/tmp/pip-SZsfwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:39 INFO - Running setup.py (path:/tmp/pip-ojIvNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:40 INFO - Running setup.py (path:/tmp/pip-xtmFQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:40 INFO - Running setup.py (path:/tmp/pip-l4GY3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:40 INFO - Running setup.py (path:/tmp/pip-c3MPjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:40 INFO - Running setup.py (path:/tmp/pip-cImvUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:40 INFO - Running setup.py (path:/tmp/pip-HcRT7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:40 INFO - Running setup.py (path:/tmp/pip-yvKxOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:40 INFO - Running setup.py (path:/tmp/pip-2AtKp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:51:40 INFO - Running setup.py install for manifestparser 05:51:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:51:40 INFO - Running setup.py install for mozcrash 05:51:40 INFO - Running setup.py install for mozdebug 05:51:40 INFO - Running setup.py install for mozdevice 05:51:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:51:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:51:40 INFO - Running setup.py install for mozfile 05:51:41 INFO - Running setup.py install for mozhttpd 05:51:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:51:41 INFO - Running setup.py install for mozinfo 05:51:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:51:41 INFO - Running setup.py install for mozInstall 05:51:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:51:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:51:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:51:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:51:41 INFO - Running setup.py install for mozleak 05:51:41 INFO - Running setup.py install for mozlog 05:51:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:51:41 INFO - Running setup.py install for moznetwork 05:51:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:51:41 INFO - Running setup.py install for mozprocess 05:51:41 INFO - Running setup.py install for mozprofile 05:51:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:51:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:51:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:51:41 INFO - Running setup.py install for mozrunner 05:51:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:51:41 INFO - Running setup.py install for mozscreenshot 05:51:42 INFO - Running setup.py install for moztest 05:51:42 INFO - Running setup.py install for mozversion 05:51:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:51:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:51:42 INFO - Cleaning up... 05:51:42 INFO - Return code: 0 05:51:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:42 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 0x7f7e89d04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19639c0>, '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 0x19648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309', '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 05:51:42 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 05:51:42 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 05:51:42 INFO - Using env: {'DISPLAY': ':0', 05:51:42 INFO - 'HOME': '/home/cltbld', 05:51:42 INFO - 'LANG': 'en_US.UTF-8', 05:51:42 INFO - 'LANGUAGE': 'en_US:en', 05:51:42 INFO - 'LOGNAME': 'cltbld', 05:51:42 INFO - 'MAIL': '/var/mail/cltbld', 05:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:42 INFO - 'MOZ_NO_REMOTE': '1', 05:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:42 INFO - 'NO_EM_RESTART': '1', 05:51:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:42 INFO - 'PWD': '/builds/slave/test', 05:51:42 INFO - 'SHELL': '/bin/bash', 05:51:42 INFO - 'SHLVL': '1', 05:51:42 INFO - 'TERM': 'linux', 05:51:42 INFO - 'TMOUT': '86400', 05:51:42 INFO - 'USER': 'cltbld', 05:51:42 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309', 05:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:42 INFO - '_': '/tools/buildbot/bin/python'} 05:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:42 INFO - Running setup.py (path:/tmp/pip-59AWA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:42 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)) 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:42 INFO - Running setup.py (path:/tmp/pip-ScOLvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:42 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)) 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:42 INFO - Running setup.py (path:/tmp/pip-uwv_sP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:42 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)) 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:42 INFO - Running setup.py (path:/tmp/pip-8_mnjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:42 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)) 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:42 INFO - Running setup.py (path:/tmp/pip-161dYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:42 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)) 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:42 INFO - Running setup.py (path:/tmp/pip-eZHCC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:42 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)) 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:42 INFO - Running setup.py (path:/tmp/pip-AYpOE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:43 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)) 05:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:43 INFO - Running setup.py (path:/tmp/pip-UU_4qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:43 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)) 05:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:43 INFO - Running setup.py (path:/tmp/pip-1B_J0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:43 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)) 05:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:43 INFO - Running setup.py (path:/tmp/pip-nCno8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 05:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:43 INFO - Running setup.py (path:/tmp/pip-gBTGsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:43 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)) 05:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:43 INFO - Running setup.py (path:/tmp/pip-Jtn0Jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:43 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)) 05:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:43 INFO - Running setup.py (path:/tmp/pip-HdqAfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:43 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)) 05:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:43 INFO - Running setup.py (path:/tmp/pip-9byLfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:43 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)) 05:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:43 INFO - Running setup.py (path:/tmp/pip-w11XDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:43 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)) 05:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:43 INFO - Running setup.py (path:/tmp/pip-C2M8z5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:43 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)) 05:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:43 INFO - Running setup.py (path:/tmp/pip-Oc0lHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:43 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)) 05:51:43 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)) 05:51:43 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)) 05:51:43 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)) 05:51:43 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)) 05:51:43 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)) 05:51:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51:45 INFO - Downloading blessings-1.6.tar.gz 05:51:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:51:45 INFO - Installing collected packages: blessings 05:51:45 INFO - Running setup.py install for blessings 05:51:45 INFO - Successfully installed blessings 05:51:45 INFO - Cleaning up... 05:51:45 INFO - Return code: 0 05:51:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:51:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:46 INFO - Reading from file tmpfile_stdout 05:51:46 INFO - Current package versions: 05:51:46 INFO - argparse == 1.2.1 05:51:46 INFO - blessings == 1.6 05:51:46 INFO - blobuploader == 1.2.4 05:51:46 INFO - docopt == 0.6.1 05:51:46 INFO - manifestparser == 1.1 05:51:46 INFO - mozInstall == 1.12 05:51:46 INFO - mozcrash == 0.17 05:51:46 INFO - mozdebug == 0.1 05:51:46 INFO - mozdevice == 0.48 05:51:46 INFO - mozfile == 1.2 05:51:46 INFO - mozhttpd == 0.7 05:51:46 INFO - mozinfo == 0.9 05:51:46 INFO - mozleak == 0.1 05:51:46 INFO - mozlog == 3.2 05:51:46 INFO - moznetwork == 0.27 05:51:46 INFO - mozprocess == 0.22 05:51:46 INFO - mozprofile == 0.28 05:51:46 INFO - mozrunner == 6.11 05:51:46 INFO - mozscreenshot == 0.1 05:51:46 INFO - mozsystemmonitor == 0.3 05:51:46 INFO - moztest == 0.7 05:51:46 INFO - mozversion == 1.4 05:51:46 INFO - psutil == 3.1.1 05:51:46 INFO - requests == 1.2.3 05:51:46 INFO - wsgiref == 0.1.2 05:51:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:46 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 0x7f7e89d04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19639c0>, '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 0x19648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309', '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 05:51:46 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 05:51:46 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 05:51:46 INFO - Using env: {'DISPLAY': ':0', 05:51:46 INFO - 'HOME': '/home/cltbld', 05:51:46 INFO - 'LANG': 'en_US.UTF-8', 05:51:46 INFO - 'LANGUAGE': 'en_US:en', 05:51:46 INFO - 'LOGNAME': 'cltbld', 05:51:46 INFO - 'MAIL': '/var/mail/cltbld', 05:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:46 INFO - 'MOZ_NO_REMOTE': '1', 05:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:46 INFO - 'NO_EM_RESTART': '1', 05:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:46 INFO - 'PWD': '/builds/slave/test', 05:51:46 INFO - 'SHELL': '/bin/bash', 05:51:46 INFO - 'SHLVL': '1', 05:51:46 INFO - 'TERM': 'linux', 05:51:46 INFO - 'TMOUT': '86400', 05:51:46 INFO - 'USER': 'cltbld', 05:51:46 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309', 05:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:46 INFO - '_': '/tools/buildbot/bin/python'} 05:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:46 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)) 05:51:46 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)) 05:51:46 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)) 05:51:46 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)) 05:51:46 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)) 05:51:46 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)) 05:51:46 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)) 05:51:46 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)) 05:51:46 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)) 05:51:46 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)) 05:51:46 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)) 05:51:46 INFO - Cleaning up... 05:51:46 INFO - Return code: 0 05:51:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:46 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 0x7f7e89d04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19639c0>, '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 0x19648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309', '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 05:51:46 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 05:51:46 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 05:51:46 INFO - Using env: {'DISPLAY': ':0', 05:51:46 INFO - 'HOME': '/home/cltbld', 05:51:46 INFO - 'LANG': 'en_US.UTF-8', 05:51:46 INFO - 'LANGUAGE': 'en_US:en', 05:51:46 INFO - 'LOGNAME': 'cltbld', 05:51:46 INFO - 'MAIL': '/var/mail/cltbld', 05:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:46 INFO - 'MOZ_NO_REMOTE': '1', 05:51:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:46 INFO - 'NO_EM_RESTART': '1', 05:51:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:46 INFO - 'PWD': '/builds/slave/test', 05:51:46 INFO - 'SHELL': '/bin/bash', 05:51:46 INFO - 'SHLVL': '1', 05:51:46 INFO - 'TERM': 'linux', 05:51:46 INFO - 'TMOUT': '86400', 05:51:46 INFO - 'USER': 'cltbld', 05:51:46 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309', 05:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:46 INFO - '_': '/tools/buildbot/bin/python'} 05:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:46 INFO - Downloading/unpacking jsonschema 05:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:51:48 INFO - Downloading/unpacking functools32 (from jsonschema) 05:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:48 INFO - Downloading functools32-3.2.3-2.tar.gz 05:51:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:51:48 INFO - warning: no files found matching '*.txt' 05:51:48 INFO - no previously-included directories found matching 'build' 05:51:48 INFO - no previously-included directories found matching 'dist' 05:51:48 INFO - no previously-included directories found matching '.git*' 05:51:48 INFO - Installing collected packages: jsonschema, functools32 05:51:48 INFO - Running setup.py install for functools32 05:51:48 INFO - warning: no files found matching '*.txt' 05:51:48 INFO - no previously-included directories found matching 'build' 05:51:48 INFO - no previously-included directories found matching 'dist' 05:51:48 INFO - no previously-included directories found matching '.git*' 05:51:48 INFO - Successfully installed jsonschema functools32 05:51:48 INFO - Cleaning up... 05:51:48 INFO - Return code: 0 05:51:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7e89d04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18d4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19639c0>, '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 0x19648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964d50>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309', '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 05:51:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:51:48 INFO - Using env: {'DISPLAY': ':0', 05:51:48 INFO - 'HOME': '/home/cltbld', 05:51:48 INFO - 'LANG': 'en_US.UTF-8', 05:51:48 INFO - 'LANGUAGE': 'en_US:en', 05:51:48 INFO - 'LOGNAME': 'cltbld', 05:51:48 INFO - 'MAIL': '/var/mail/cltbld', 05:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:48 INFO - 'MOZ_NO_REMOTE': '1', 05:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:48 INFO - 'NO_EM_RESTART': '1', 05:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:48 INFO - 'PWD': '/builds/slave/test', 05:51:48 INFO - 'SHELL': '/bin/bash', 05:51:48 INFO - 'SHLVL': '1', 05:51:48 INFO - 'TERM': 'linux', 05:51:48 INFO - 'TMOUT': '86400', 05:51:48 INFO - 'USER': 'cltbld', 05:51:48 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309', 05:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:48 INFO - '_': '/tools/buildbot/bin/python'} 05:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:49 INFO - Downloading/unpacking flake8 05:51:49 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 05:51:49 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 05:51:49 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 05:51:49 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 05:51:49 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 05:51:49 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 05:51:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:51:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:51:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:51:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:51:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:51:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:51:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:51:51 INFO - no previously-included directories found matching 'docs/_build' 05:51:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:51:51 INFO - Running setup.py install for pep8 05:51:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:51:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:51:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:51:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:51:51 INFO - no previously-included directories found matching 'docs/_build' 05:51:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:51:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:51:51 INFO - Cleaning up... 05:51:52 INFO - Return code: 0 05:51:52 INFO - Running post-action listener: _resource_record_post_action 05:51:52 INFO - Running post-action listener: _start_resource_monitoring 05:51:52 INFO - Starting resource monitoring. 05:51:52 INFO - ##### 05:51:52 INFO - ##### Finished create-virtualenv step (success) 05:51:52 INFO - ##### 05:51:52 INFO - ##### 05:51:52 INFO - ##### Running install step. 05:51:52 INFO - ##### 05:51:52 INFO - Running pre-action listener: _resource_record_pre_action 05:51:52 INFO - Running main action method: install 05:51:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:52 INFO - Reading from file tmpfile_stdout 05:51:52 INFO - Detecting whether we're running mozinstall >=1.0... 05:51:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:51:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:51:52 INFO - Reading from file tmpfile_stdout 05:51:52 INFO - Output received: 05:51:52 INFO - Usage: mozinstall [options] installer 05:51:52 INFO - Options: 05:51:52 INFO - -h, --help show this help message and exit 05:51:52 INFO - -d DEST, --destination=DEST 05:51:52 INFO - Directory to install application into. [default: 05:51:52 INFO - "/builds/slave/test"] 05:51:52 INFO - --app=APP Application being installed. [default: firefox] 05:51:52 INFO - mkdir: /builds/slave/test/build/application 05:51:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:51:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:52:09 INFO - Reading from file tmpfile_stdout 05:52:09 INFO - Output received: 05:52:09 INFO - /builds/slave/test/build/application/firefox/firefox 05:52:09 INFO - Running post-action listener: _resource_record_post_action 05:52:09 INFO - ##### 05:52:09 INFO - ##### Finished install step (success) 05:52:09 INFO - ##### 05:52:09 INFO - ##### 05:52:09 INFO - ##### Running run-tests step. 05:52:09 INFO - ##### 05:52:09 INFO - Running pre-action listener: _resource_record_pre_action 05:52:09 INFO - Running main action method: run_tests 05:52:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:52:09 INFO - Python 2.7.3 05:52:09 INFO - Return code: 0 05:52:09 INFO - grabbing minidump binary from tooltool 05:52:09 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')]} 05:52:09 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19639c0>, '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 0x19648c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1964d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:52:09 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 05:52:09 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 05:52:09 INFO - Calling ['/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'] with output_timeout 600 05:52:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:52:09 INFO - Return code: 0 05:52:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:52:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:52:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:52:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:52:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:52:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:52:10 INFO - Return code: 0 05:52:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 05:52:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 05:52:10 INFO - Using env: {'DISPLAY': ':0', 05:52:10 INFO - 'HOME': '/home/cltbld', 05:52:10 INFO - 'LANG': 'en_US.UTF-8', 05:52:10 INFO - 'LANGUAGE': 'en_US:en', 05:52:10 INFO - 'LOGNAME': 'cltbld', 05:52:10 INFO - 'MAIL': '/var/mail/cltbld', 05:52:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:52:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:10 INFO - 'MOZ_NO_REMOTE': '1', 05:52:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:10 INFO - 'NO_EM_RESTART': '1', 05:52:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:10 INFO - 'PWD': '/builds/slave/test', 05:52:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:52:10 INFO - 'SHELL': '/bin/bash', 05:52:10 INFO - 'SHLVL': '1', 05:52:10 INFO - 'TERM': 'linux', 05:52:10 INFO - 'TMOUT': '86400', 05:52:10 INFO - 'USER': 'cltbld', 05:52:10 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309', 05:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:10 INFO - '_': '/tools/buildbot/bin/python'} 05:52:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 05:52:10 INFO - mozversion application_buildid: 20160602030220 05:52:10 INFO - mozversion application_changeset: 34a8be4346a9231e472fc36b1d7c0531e0fbf7c5 05:52:10 INFO - mozversion application_display_name: Nightly 05:52:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:52:10 INFO - mozversion application_name: Firefox 05:52:10 INFO - mozversion application_remotingname: firefox 05:52:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:52:10 INFO - mozversion application_vendor: Mozilla 05:52:10 INFO - mozversion application_version: 49.0a1 05:52:10 INFO - mozversion platform_buildid: 20160602030220 05:52:10 INFO - mozversion platform_changeset: 34a8be4346a9231e472fc36b1d7c0531e0fbf7c5 05:52:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:52:10 INFO - mozversion platform_version: 49.0a1 05:52:10 INFO - using testdate: 1464871930 05:52:10 INFO - actual date: 1464871930 05:52:10 INFO - starting webserver on 'localhost:38062' 05:52:10 INFO - SUITE-START | Running 2 tests 05:52:10 INFO - TEST-START | dromaeo_css 05:52:10 INFO - operating with platform_type : linux_ 05:52:10 INFO - Initialising browser for dromaeo_css test... 05:52:10 INFO - TEST-INFO | started process 26336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY6C7cW/profile http://localhost:38062/getInfo.html) 05:52:15 INFO - PROCESS | 26336 | __metrics Screen width/height:1600/1200 05:52:15 INFO - PROCESS | 26336 | colorDepth:24 05:52:15 INFO - PROCESS | 26336 | Browser inner width/height: 1024/697 05:52:15 INFO - PROCESS | 26336 | __metrics 05:52:15 ERROR - PROCESS | 26336 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 05:52:16 INFO - TEST-INFO | 26336: exit 0 05:52:16 INFO - Browser initialized. 05:52:16 INFO - Running cycle 1/1 for dromaeo_css test... 05:52:16 INFO - TEST-INFO | started process 26454 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY6C7cW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:28 INFO - PROCESS | 26454 | RSS: Main: 167657472 05:52:28 INFO - PROCESS | 26454 | 05:53:18 INFO - PROCESS | 26454 | 1464871998153 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] 05:55:25 INFO - PROCESS | 26454 | Cycle 1(1): loaded http://localhost:38062/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38062/tests/dromaeo/cssquery-ext.html) 05:55:26 INFO - PROCESS | 26454 | RSS: Main: 170835968 05:55:26 INFO - PROCESS | 26454 | 05:58:28 INFO - PROCESS | 26454 | Cycle 1(1): loaded http://localhost:38062/tests/dromaeo/cssquery-ext.html (next: http://localhost:38062/tests/dromaeo/cssquery-jquery.html) 05:58:28 INFO - PROCESS | 26454 | RSS: Main: 170086400 05:58:28 INFO - PROCESS | 26454 | 06:01:30 INFO - PROCESS | 26454 | Cycle 1(1): loaded http://localhost:38062/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38062/tests/dromaeo/cssquery-mootools.html) 06:01:31 INFO - PROCESS | 26454 | RSS: Main: 170950656 06:01:31 INFO - PROCESS | 26454 | 06:04:33 INFO - PROCESS | 26454 | Cycle 1(1): loaded http://localhost:38062/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38062/tests/dromaeo/cssquery-prototype.html) 06:04:33 INFO - PROCESS | 26454 | RSS: Main: 169189376 06:04:33 INFO - PROCESS | 26454 | 06:07:36 INFO - PROCESS | 26454 | Cycle 1(1): loaded http://localhost:38062/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38062/tests/dromaeo/cssquery-yui.html) 06:07:36 INFO - PROCESS | 26454 | RSS: Main: 170782720 06:07:36 INFO - PROCESS | 26454 | 06:10:39 INFO - PROCESS | 26454 | Cycle 1(1): loaded http://localhost:38062/tests/dromaeo/cssquery-yui.html (next: http://localhost:38062/tests/dromaeo/cssquery-dojo.html) 06:10:39 INFO - PROCESS | 26454 | RSS: Main: 172470272 06:10:39 INFO - PROCESS | 26454 | 06:10:39 INFO - PROCESS | 26454 | __start_tp_report 06:10:39 INFO - PROCESS | 26454 | _x_x_mozilla_page_load 06:10:39 INFO - PROCESS | 26454 | _x_x_mozilla_page_load_details 06:10:39 INFO - PROCESS | 26454 | |i|pagename|runs| 06:10:39 INFO - PROCESS | 26454 | |0;dojo.html;3054.068509104722;3054.282243672738;3055.190374550743;3121.250899784052;3168.1129283800537;5412.918806217905;5420.783168673253;5446.809361672337;5522.392536820947;5525.861853453665;5391.433899440561;5433.8369848904595;5440.537554307879;5497.725113744316;5513.862153446166;4869.123557759611;4938.975305123469;5041.52105549974;5081.542661160494;5128.9230661540105;784.5055801963869;4828.2274836026245;4886.48691887352;4935.5804756595735;5055.090083784918;4897.412310522743;4910.0670872534465;4932.358793356877;4942.159832828428;4943.9258411123865;4958.181899986498;4959.107360675077;4968.776405061781;4971.726555039471;4988.87527811804;4908.631852611068;4945.159322915077;4985.302057711923;4992.850214493571;4998.375203099613;5414.6480478769145;5452.318460192476;5488.423715509894;5504.0643090674685;5517.724113794335;5674.319081710221;5773.913391299134;5926.170336152942;5931.851703707399;5938.435848594377;5888.29340479141;5899.203607512974;5912;5934.792282270143;5972.70136493178;5538.889222215574;5569.164625306236;5569.637973531748;5579.525740312079;5582.9950608890385;5868.853278667982;6016.2479690038745;6047.848803779941;6077.574569780073;6085.330613632497;5739.110437882135;5740.282464691913;5747.597668163188;5748.770049197985;5752.395998420189;5891.293044834561;5891.617044892154;5904.409559044061;5911.704414779244;5917.31950825652;5749.798757043483;5776.277965254343;5862.208601838783;5881.705914704247;5882.411758824083;5806.709664516758;5844.736986835603;5846.473817356458;5878.470937615635;5909.172715819789;4337.804798784062;4441;4452.910941781146;4464.285714285764;4477.552244775561;3887.980560097238;3924.293627147141;3931.0958479549863;3963.6829053675638;3973.5231772186944;5490.203920431515;5543.61194716366;5568.16477528374;5590.440955904458;5630.352509461382;5755.65466072037;5899.233099697012;5914.172015917775;5924.822255332347;5942.61373010753;5526.557875369961;5534.557235421156;5568.16477528374;5571.9721401392735;5582.7766889323975;4992.600591952635;5059.671121377099;5079;5095.286659867622;5117.2068329409;5891.764329426861;6099.4815440688035;6104.4505994460715;6110.908336374958;6123.540734444845;5953.672548009815;6043;6043.395660434097;6050.878982420239;6062.545309101747;6172.351903050115;6184.165137706352;6188.195534580475;6188.350223226496;6202.069689546604;5630.577706671934;5763.020286551213;5765.3946335634155;5900.527957763283;5925.733341999534;5941.0494320910175;5947.959107156317;5954.4938680210935;5973.462388385066;6000.5799594028;5700.258966334516;5724.198612194379;5737.139429085671;5740.1102829061565;5812.622179558315;5498.80754173618;5675.574331925205;5714.885702285847;5733.741981610921;5746.051901436216;5618.747156377891;5631.042722737063;5673.120666296731;5673.886522269614;5685.829425117253;5763.884722305615;5766.308043034863;5772.595918285848;5804.854878627899;5819.76720931158;5520.06158952987;5651.547876169979;5690.032694441872;5712.02895507773;5742.454466825645 06:10:39 INFO - PROCESS | 26454 | |1;ext.html;550.5402988504599;602.8312072619667;613.852675357914;618.9566730328876;664.7972368427628;39655;41104.588954110484;43321;43576.34635480463;43638.34542481865;44940;45302.7734861326;45464.54535454645;45481.31778023332;45508.54491455085;8772.429792063496;8820.8676869847;8937.374383793138;8945.418547794372;8963.193312601865;8737.344699147558;8907.198352148305;8930.419522731034;8946.955265223665;8951.41815781972;8936.374453788238;8946.463212207256;8963.820723585524;8998.550072496382;9012.459252444874;8819.559022048905;8834;8899.644014239455;8923.687670931551;8943.865842012376;8789;8861;8911.643534258621;8919.554022298858;8923.375363724543;40864.18271634581;41328.38007429891;41358;41477.37783933243;41480.79259603713;3353.3293341331587;3524.1365865362895;4054.331035379159;4089.7432704997696;4292.506361768405;31451.370972580648;31600.525992110135;32096.679033209602;32131.51802722961;32237;4219.767912764797;4263.744175349458;4321.659197748344;4383.561643835623;4400.823967041314;340380;343007;343365.283173585;343798;345077;56683.716581417655;57081;57186.42813571811;57253.71373143191;57554.136687949715;60405.697971509864;60860.39139608636;60964;61047.694761525905;61072.69463652742;16940.661186776197;17218.483445496404;17261.91369043172;17262.82737172612;17272.91363543174;13518.93240533791;13598.456061757617;13634;13676.247806370546;13702.177869327872;15569.766453503207;16024.919875400548;16194.75707864383;16280.26738796757;16317.918410407872;6619.834504137339;6647.268800431949;6708.563943343667;6726.39462448382;6877.939317003986;968.6948611187454;1042.9843552346722;1064.7338165458636;1121.3328069798456;1197.592818441734;31453.68546314553;31462;31557.8422107888;32248.35503289921;32769.67230327666;1126.8366086917351;1167.287954347847;1200.2438463767771;1214.1318956945827;1257.9119461637597;16661.750073748903;16721.498355049367;17139.314427422763;17169.48491545256;17208.65582688339;542151;544045;545211;546000;550317;56505.43494565084;56722;56862.43137568654;56943.430565693816;57083.71458142683;1356.2201734002988;1378.910370825913;1386.5978866128912;1388.2364699415484;1390.735760205578;30951.84524077365;31451.685483144876;31464.685353146175;31656.683433165374;32538;49580.25629615487;50208.74895625498;50344.244836326754;50355.748221260124;50359.733811979284;433585;446430;449420;449514;450340;41038.1792364157;41341.58658413377;41450.37824432576;41495.377569337084;42678.35982460328;47554.28668569905;48203.75898120487;48436;48782.75608621934;49431.25853112278;39053.80473097616;40310.19379612333;40539.39190912198;40887.1822563553;41294.1741165181;40228.1954360917;40322.59677403306;41288.58711412847;41883.58116418797;42333.5766642342;40501.39247911343;40655.39016914808;41096.589034110475;41324.58675413208;43976.7801161005;34656.65343346534;35618.821905890305;36055.27889442144;36244.637553624125;36362;27532.036378726647;28131.57802633003;28243.858780705967;28484.572731408633;28717.28206794847 06:10:39 INFO - PROCESS | 26454 | |2;jquery.html;376.8643288416171;380.3618390098705;384.15677587695;397.64808144791886;402.4245329179274;15138.470153544627;16724.749128763047;17334.393296234633;20076.89961550192;20337.389878303675;17817.287308507675;18255.54361140972;19138.71291930619;19181.232750689956;19195.13621887015;5477.589180811435;5484.424135465769;5679.460451257145;5691.51622112121;5710.77156913723;5625.324961004685;5690.943090569103;5700.087985922253;5741.885162296751;5750.597458177929;5299.920501192485;5624.606277560572;5632.267805185341;5648.6893220872835;5678.318601767773;5544.112941929292;5606.243157173811;5639.68981706006;5643.633163844337;5677.858053548653;5381.784728610851;5707.3721890592005;5718.7426565804635;5728.770849166029;5741.253637027202;13132.868671313356;13258.270795106266;13564.118332308468;13704.24626645534;13705.862941370659;2115.4394085567337;2205.9558808823895;2258.5934531784274;2258.6160352740076;2259.45773014477;9722.347200975852;9862.161716254128;9964.25268104895;10030.297879148462;10160.79678406435;1909.47489440405;1930.758655168104;1973.2304401283511;1984.811442912921;2056.270024141438;49847.75076124632;61585;76771;83503;86460.56769716111;10426.426546539862;10592.682219533426;10631.681049568526;10745.032947034648;10869.83695244572;14917.40330386794;15042.548723538312;15044.774328385083;15046.473373431878;15052.849471505364;7675;7993.880091798627;8035.879461808077;8113.472624279403;8122.796930076795;7745.380369570421;7851;7861.292483676497;7979.640916158787;8027.518348899085;4573.176828170895;4588.957913728359;4625.514320996314;4647.256438969748;4676.719396836201;1926.5280006398523;1936.9322073727633;1953.765548134233;1960;1974.7630284365969;908.2733812949614;969.6460791810938;1001.3841487485145;1041.6041904076553;1100.6092837042734;18811;18851.811481885004;19049.80950190508;19620.313289034817;20009.299674511323;984.2519685039279;1008.3848852200152;1008.9394636321845;1033.7260625934134;1065.3235195650664;10813.729656758644;11173.385463799406;11232.49453774582;11233.943830280796;11237.55049797999;442217;451048;453590;454717;455877;84499.5775021121;91496.54251728699;92391;92548.53725731328;92606.53696731474;991.2862738828032;992.6079198716467;1006.6174853555748;1008.606643409071;1013.6097602423121;17107.23017464192;17109.949834858588;17234.396796112076;17389.652206955536;17471.475855724348;37205.255894882495;39349.40975885421;41529;42067.57932420759;42354;55803.44196557983;56915.430845691015;58248.79473414517;58572.70713646575;58851.70574147102;7536.1333446654335;7790.143084260613;7837.529748215125;8317.584120793816;9002.23481004122;12874.67813304675;13168.60494185176;13288.867111328764;13368.131071480322;13514.729705406033;11110.222284440335;11261.324320540467;11433.714157146138;11810;11971.880281197076;10969.341839489656;11047.558097676003;11232.269902456641;11276.548938042386;11632.18574699763;11044.723881903017;11448.198626096093;11465.598704045651;11505.769884602094;11868.584599538975;7752.728654497066;7781.455298129076;7911;7935.40484463656;8213.79465513367;10934.398608076632;11267.492962816857;11306.94346528295;11480.483378248166;11496.425178741198 06:10:39 INFO - PROCESS | 26454 | |3;mootools.html;1501.06183635228;1544.598404414852;1689.8732595055374;1777.9288828446863;1809.6290260496608;7308.269173082689;8183.549904755236;8184.590770461476;8677.392582519218;8704.434211776237;8126.1873812618705;8318.584070796467;8386.496810191393;8386.91613083869;8417.494950302986;2362.728286247078;2365.680633114525;2376.0733314007553;2390.091765129257;2399.6040653292184;2348.518553696488;2353.2587235021;2380.809535237177;2385.439421735891;2390.3187591536416;2243.2933625907867;2284.3603790938564;2298.5517824024323;2359.339384972202;2361.9645705314433;2246.067881829039;2255.5263394687217;2258.2434884313775;2266.829987750909;2324.1981516376823;2282.589133955887;2290.7823756743082;2290.80528155107;2291.5302363015544;2293;8436.915630843674;8446.746597602081;8471.06818249992;8571.828563428759;8595.054544000155;5262.184361423985;5272.525472707474;5365.980463711921;5369.194620806871;5372.274742909735;3347.782394144373;3350.8659653613827;3421.4012547804036;3500.597431295408;3513.8243087845763;1119.2948442481265;1150.6950658075616;1183.0771997841698;1191.4876603060768;1209.3771707570609;11735.530578776925;11845.94077029618;11852.11109166816;11879.287242765462;11901.404929753564;4646.163690535668;4667.813287468532;4761.952380476151;4766.761661916959;4776.856694299107;10135.64525241613;10165.085142337226;10182.490875456198;10195.184385249162;10218.131458825934;5271.235670827785;5281.867953301121;5305.681659100389;5314.681119132864;5378.97310513445;4213.957860421357;4756.334113224151;4886.60907127429;4896;4925.655204135748;3934.8622798201927;4009.3384591542067;4041.2927737645796;4070.9185816283507;4097.385392191195;1299.27240745183;1310.6330227536305;1310.744404841066;1311.8425788905392;1333.3466601365262;1026.6868605075524;1031.896810318962;1040.765827688764;1058.7088550648634;1059.5073290919759;5928.081147422156;5953.583249172603;6035.305939816977;6076.939230607637;6169.660668663177;438.388448114878;441.84535412605976;443.8979034822009;450.26606631190947;450.5269467059574;4224.4508213931995;4254.744715317091;4298.978505107454;4299.118680670455;4303.612674859215;10032.548535315927;10118.443485608363;10206.183505319557;10301.381917084998;10312.226583006304;10107.090361867467;10123.9493802532;10129.139023182965;10148.594056237667;10154.847677284846;7654.693812247559;7895.60521973899;7970.362371010306;8128.471649342774;8129.227723366271;5872.530197584098;6061.848453788691;6132.08018797184;6133.815985520263;6169.167162433014;9715;9864.408135511892;9993.750156246151;10038.899611003797;10042.69871903844;9957;10131.493425328557;10208.846867296848;10227.107985022794;10231.539580718736;6778.830529236809;7488.063992001;7492.51298665585;7607.657655405409;7680.308772210527;8237.382196335178;8271.421000529905;8274.172582741678;8292.253697167283;8304.377171712267;7024.367806897404;7252.347288744038;7296.890546641698;7327.450441217036;7389.7413590524075;6732.663366831737;6892.551984121016;7224.711011559479;7227.421806255382;7265.491415600857;6999.860002799814;7041.260667629826;7057.294270572902;7117.75087871922;7126.536775109601;5084.567811736044;5136.075506408883;5181.689098654093;5196.064708352533;5213.687178769286;5166.3025491559665;5248;5254.133068043883;5295.920561191662;5357.571394288526 06:10:39 INFO - PROCESS | 26454 | |4;prototype.html;326.5852367493282;336.86693755966394;339.59079309432127;340.2412619857716;342.77719482336465;5585.022621041317;5632.662040277586;5643.520300774434;5656.519195868346;5659.207710920469;5556.833295001146;5563.221149039137;5577.637453565515;5581.7209139542965;5613.522850557697;4144.4819397575375;4172.123853990665;4321.697481176319;4341.39220509129;4373.125374925028;4336.154449882274;4339.783010849461;4353.869383918472;4355.433793606827;4363.930836944953;4311.82752689892;4324.762138082404;4333.306670932651;4338.2191205582985;4340.696151269412;4259.318509038554;4322.157179350028;4323.675724320657;4334.479862416499;4354.258296681322;3821.45231181372;3827.4641550182996;3830.942535861964;3831.7700937943814;3849.2493963677093;5360.490753378423;5361.329833770778;5371.865703357408;5386.434424385422;5389.299391079135;4787.736674482902;4952.380952380952;4963.305137280783;4976.328195693572;4979.253112033188;5788.623739456964;5799.681017544076;5800.332961709373;5804.796832110856;5809.419058094199;4188.769617671027;4201.6008479194425;4211.578842115795;4213.262679031157;4217.641500472463;5780.913286300709;6059.485128717821;6061.7575296987625;6072.908906366408;6092.482139018189;4142.834286628561;4143.150654115899;4149.543550209474;4150.294449943517;4151.256472281649;4207.873763787091;4220.409142720022;4224.936625950613;4226.936595951063;4248.34150706641;4744.359511465908;4888.144574699413;4898.975505122452;4905.411350637875;4916.926246106311;5857.26784151981;5865.4134586541;5884.6469211847425;5890.381509941394;5892.646441213541;1440.906341087826;1464.1434760664918;1479.823540285454;1487.4793822162374;1487.5686051045075;912.6167009855876;936.8991435063773;938.3712912348743;938.9342746007851;945.7966537194536;5007.499250074963;5057.291979122852;5061.240813877947;5111.488851114858;5124.846254612367;5315.441878602768;5332.813351532678;5399.4600539945695;5405.081136206854;5413.377461591967;5043.218301163325;5045.5459008689395;5214.530692237717;5700.37295897451;5757.942420575824;3214.6624604416666;3226.451503244454;3230.596175478065;3243.0757234188145;3257.332246889382;6109;6253.7185826637915;6263.592866463757;6302.369763023661;6321.399467050623;6191.4830866438015;6217.751289948442;6275.905861412082;6280.995040793451;6281.780137695158;6167.475764560063;6237.937620623827;6242.937570624235;6261.405166509175;6284.905726414107;5808.244928159313;6057.636541807506;6060.8181404625675;6062.848428789139;6155.045967874987;5974.75946520055;5986.191864098291;5991.281046274301;6026.608270462406;6031.668258245839;5977.326348622392;6223.408776166257;6231.875362492634;6233.937660623335;6296.937030629819;4292.635126014199;4298.183345164409;4311.633511151587;4312.568743125662;4324.740515569076;5868.598551086685;5942.494887934574;6059.666718330534;6157.84605384869;6180.505559555135;5898.852528686817;5907.232059832366;5908.556858235564;5917.408259174221;5932.902413053599;5654.519365853948;5711.543076553949;5836.883262334644;5841.883162336814;5917.437843404869;5780.450857168562;5789;5803.274590676166;5823.621464604957;5852.297724273115;5952.76188952437;5958.285005799332;5981.491573216325;5984.611000284967;5993.940060599338;5595.496405323541;5646.402654778848;5686.943130568641;5779.942200578109;5810.186573879745 06:10:39 INFO - PROCESS | 26454 | |5;yui.html;731.6926890705903;775.9408407523732;801.6112185589988;827.7806381308955;854.5470900422778;14938.626534336647;15086.170260635661;15417.306221220058;15717.214139293032;16746.74879876803;15037.323320450607;15127;15168.165750883696;15257.77113343298;15266.542003739905;789.4947233770391;814.222417591202;815.4577206157927;815.5962798414793;818.7707441916243;814.4054839966827;820.3437250199846;820.6266148902235;821.4003777242616;826.557791581504;860.9096044915287;862.5299211929482;862.6204470033197;863.9265662418702;864.4813112132701;850.698002209213;857.4255248983196;858.5835869603237;859.6948083430386;860.1785295043281;617.1082785375135;624.5784095735361;624.9906251406233;625.0592857749059;625.4464798653224;15335.769963450557;15365;15512.069275843372;15556.533304000897;15613.453529126426;14215.57353279393;14482.710345793024;14608.561743147722;14677.192754398504;14744.262786860721;12464.127511074228;12595.74808503834;12617.179883307648;12624.495020199181;12823.294718790463;3848.0038480038393;3869.9226015479535;3952.5849785772657;3979.064919743858;3994.820233089518;71286.64356678235;72259.88308040463;73032.63483682601;74366;74887.25112748858;11254.94372528132;11282;11430.542778288942;11438.656840294805;11695.12286578493;19926.20295188176;19984.90007549953;20051.197952082046;20058.498537536678;20191.596168076558;8257.876131858027;8267.503949763033;8581.356398270154;8626.698065567674;8643.567821608895;4879.731614761222;5029.446760856303;5048.343715317059;5065.316182315414;5093.388793344822;3473.3574288756663;3604.5133906922756;3625.7099432045375;3638.3450978824067;3649.799261040668;625.5089754542662;637.5855693799068;637.6269882119012;646.6443456099126;665.4343807763363;716.9211386747454;728.613834667627;731.747547096251;762.3291503476905;778.2101167315179;9340.159385655188;9420.434773913586;9487.33588648788;9712.417254964725;9795.755106122404;694.8540806430706;745.9552426854406;761.4213197969583;776.7763780311639;778.5951305321202;4463.709858859163;4585.28928016158;4592.173408786383;4612.100640375162;4667.603253723403;110668.44665776781;110731;112973.43513282381;113933.4303328478;114121;62885.68557157185;97004.51497742467;99666.5016674912;100082.4995875016;100355.49822250842;83010.58494707488;87620;88499.55750221337;88609.55695221611;88747.55626221828;7950.920490795249;8017.438779285394;8150.551719655476;8621.439606425562;8817.867731984154;51222;51738.741306293225;52136;52363;52367.73816130895;63980.24177824018;66530;73661.6316918412;75974.62012689901;76877;11168.944155279172;11393.54425822991;11436.085113191091;11646.825297620711;11781.705457363634;12759.48962041508;13166.736665266833;13319.33403329849;13346.733065338833;13409.932950335186;11376.089912807121;11482.94258528702;11499.425028748361;11685.298882066763;11840.089426958863;12542.874571254535;12602.306873122066;12674.683132921751;12877.742445151232;13328.33358332099;10698.358098514114;10950.45247737594;11874.643760687193;12018.879811201776;12086.50133354568;9620.326577139533;9914.30599858032;9999;10003.699889003341;10127.59489620407;9383.577739001625;9418.717438476857;9534.332596718163;9550.522473876417;9806.068423499755 06:10:39 INFO - PROCESS | 26454 | __end_tp_report 06:10:39 INFO - PROCESS | 26454 | __start_cc_report 06:10:39 INFO - PROCESS | 26454 | _x_x_mozilla_cycle_collect,349 06:10:39 INFO - PROCESS | 26454 | __end_cc_report 06:10:39 INFO - PROCESS | 26454 | __startTimestamp1464873039369__endTimestamp 06:10:39 INFO - PROCESS | 26454 | 06:10:39 INFO - PROCESS | 26454 | ------- Summary: start ------- 06:10:39 INFO - PROCESS | 26454 | Number of tests: 6 06:10:39 INFO - PROCESS | 26454 | 06:10:39 INFO - PROCESS | 26454 | [#0] dojo.html Cycles:165 Average:5429.28 Median:5674.32 stddev:743.75 (13.1%) stddev-sans-first:722.31 06:10:39 INFO - PROCESS | 26454 | Values: 3054.1 3054.3 3055.2 3121.3 3168.1 5412.9 5420.8 5446.8 5522.4 5525.9 5391.4 5433.8 5440.5 5497.7 5513.9 4869.1 4939.0 5041.5 5081.5 5128.9 784.5 4828.2 4886.5 4935.6 5055.1 4897.4 4910.1 4932.4 4942.2 4943.9 4958.2 4959.1 4968.8 4971.7 4988.9 4908.6 4945.2 4985.3 4992.9 4998.4 5414.6 5452.3 5488.4 5504.1 5517.7 5674.3 5773.9 5926.2 5931.9 5938.4 5888.3 5899.2 5912.0 5934.8 5972.7 5538.9 5569.2 5569.6 5579.5 5583.0 5868.9 6016.2 6047.8 6077.6 6085.3 5739.1 5740.3 5747.6 5748.8 5752.4 5891.3 5891.6 5904.4 5911.7 5917.3 5749.8 5776.3 5862.2 5881.7 5882.4 5806.7 5844.7 5846.5 5878.5 5909.2 4337.8 4441.0 4452.9 4464.3 4477.6 3888.0 3924.3 3931.1 3963.7 3973.5 5490.2 5543.6 5568.2 5590.4 5630.4 5755.7 5899.2 5914.2 5924.8 5942.6 5526.6 5534.6 5568.2 5572.0 5582.8 4992.6 5059.7 5079.0 5095.3 5117.2 5891.8 6099.5 6104.5 6110.9 6123.5 5953.7 6043.0 6043.4 6050.9 6062.5 6172.4 6184.2 6188.2 6188.4 6202.1 5630.6 5763.0 5765.4 5900.5 5925.7 5941.0 5948.0 5954.5 5973.5 6000.6 5700.3 5724.2 5737.1 5740.1 5812.6 5498.8 5675.6 5714.9 5733.7 5746.1 5618.7 5631.0 5673.1 5673.9 5685.8 5763.9 5766.3 5772.6 5804.9 5819.8 5520.1 5651.5 5690.0 5712.0 5742.5 06:10:39 INFO - PROCESS | 26454 | 06:10:39 INFO - PROCESS | 26454 | [#1] ext.html Cycles:180 Average:60795.61 Median:41689.48 stddev:119958.26 (287.7%) stddev-sans-first:120209.50 06:10:39 INFO - PROCESS | 26454 | Values: 550.5 602.8 613.9 619.0 664.8 39655.0 41104.6 43321.0 43576.3 43638.3 44940.0 45302.8 45464.5 45481.3 45508.5 8772.4 8820.9 8937.4 8945.4 8963.2 8737.3 8907.2 8930.4 8947.0 8951.4 8936.4 8946.5 8963.8 8998.6 9012.5 8819.6 8834.0 8899.6 8923.7 8943.9 8789.0 8861.0 8911.6 8919.6 8923.4 40864.2 41328.4 41358.0 41477.4 41480.8 3353.3 3524.1 4054.3 4089.7 4292.5 31451.4 31600.5 32096.7 32131.5 32237.0 4219.8 4263.7 4321.7 4383.6 4400.8 340380.0 343007.0 343365.3 343798.0 345077.0 56683.7 57081.0 57186.4 57253.7 57554.1 60405.7 60860.4 60964.0 61047.7 61072.7 16940.7 17218.5 17261.9 17262.8 17272.9 13518.9 13598.5 13634.0 13676.2 13702.2 15569.8 16024.9 16194.8 16280.3 16317.9 6619.8 6647.3 6708.6 6726.4 6877.9 968.7 1043.0 1064.7 1121.3 1197.6 31453.7 31462.0 31557.8 32248.4 32769.7 1126.8 1167.3 1200.2 1214.1 1257.9 16661.8 16721.5 17139.3 17169.5 17208.7 542151.0 544045.0 545211.0 546000.0 550317.0 56505.4 56722.0 56862.4 56943.4 57083.7 1356.2 1378.9 1386.6 1388.2 1390.7 30951.8 31451.7 31464.7 31656.7 32538.0 49580.3 50208.7 50344.2 50355.7 50359.7 433585.0 446430.0 449420.0 449514.0 450340.0 41038.2 41341.6 41450.4 41495.4 42678.4 47554.3 48203.8 48436.0 48782.8 49431.3 39053.8 40310.2 40539.4 40887.2 41294.2 40228.2 40322.6 41288.6 41883.6 42333.6 40501.4 40655.4 41096.6 41324.6 43976.8 34656.7 35618.8 36055.3 36244.6 36362.0 27532.0 28131.6 28243.9 28484.6 28717.3 06:10:39 INFO - PROCESS | 26454 | 06:10:39 INFO - PROCESS | 26454 | [#2] jquery.html Cycles:180 Average:27178.10 Median:2259.04 stddev:74564.50 (3300.7%) stddev-sans-first:74746.51 06:10:39 INFO - PROCESS | 26454 | Values: 376.9 380.4 384.2 397.6 402.4 15138.5 16724.7 17334.4 20076.9 20337.4 17817.3 18255.5 19138.7 19181.2 19195.1 5477.6 5484.4 5679.5 5691.5 5710.8 5625.3 5690.9 5700.1 5741.9 5750.6 5299.9 5624.6 5632.3 5648.7 5678.3 5544.1 5606.2 5639.7 5643.6 5677.9 5381.8 5707.4 5718.7 5728.8 5741.3 13132.9 13258.3 13564.1 13704.2 13705.9 2115.4 2206.0 2258.6 2258.6 2259.5 9722.3 9862.2 9964.3 10030.3 10160.8 1909.5 1930.8 1973.2 1984.8 2056.3 49847.8 61585.0 76771.0 83503.0 86460.6 10426.4 10592.7 10631.7 10745.0 10869.8 14917.4 15042.5 15044.8 15046.5 15052.8 7675.0 7993.9 8035.9 8113.5 8122.8 7745.4 7851.0 7861.3 7979.6 8027.5 4573.2 4589.0 4625.5 4647.3 4676.7 1926.5 1936.9 1953.8 1960.0 1974.8 908.3 969.6 1001.4 1041.6 1100.6 18811.0 18851.8 19049.8 19620.3 20009.3 984.3 1008.4 1008.9 1033.7 1065.3 10813.7 11173.4 11232.5 11233.9 11237.6 442217.0 451048.0 453590.0 454717.0 455877.0 84499.6 91496.5 92391.0 92548.5 92606.5 991.3 992.6 1006.6 1008.6 1013.6 17107.2 17109.9 17234.4 17389.7 17471.5 37205.3 39349.4 41529.0 42067.6 42354.0 55803.4 56915.4 58248.8 58572.7 58851.7 7536.1 7790.1 7837.5 8317.6 9002.2 12874.7 13168.6 13288.9 13368.1 13514.7 11110.2 11261.3 11433.7 11810.0 11971.9 10969.3 11047.6 11232.3 11276.5 11632.2 11044.7 11448.2 11465.6 11505.8 11868.6 7752.7 7781.5 7911.0 7935.4 8213.8 10934.4 11267.5 11306.9 11480.5 11496.4 06:10:39 INFO - PROCESS | 26454 | 06:10:39 INFO - PROCESS | 26454 | [#3] mootools.html Cycles:180 Average:5670.37 Median:450.40 stddev:3140.51 (697.3%) stddev-sans-first:3133.69 06:10:39 INFO - PROCESS | 26454 | Values: 1501.1 1544.6 1689.9 1777.9 1809.6 7308.3 8183.5 8184.6 8677.4 8704.4 8126.2 8318.6 8386.5 8386.9 8417.5 2362.7 2365.7 2376.1 2390.1 2399.6 2348.5 2353.3 2380.8 2385.4 2390.3 2243.3 2284.4 2298.6 2359.3 2362.0 2246.1 2255.5 2258.2 2266.8 2324.2 2282.6 2290.8 2290.8 2291.5 2293.0 8436.9 8446.7 8471.1 8571.8 8595.1 5262.2 5272.5 5366.0 5369.2 5372.3 3347.8 3350.9 3421.4 3500.6 3513.8 1119.3 1150.7 1183.1 1191.5 1209.4 11735.5 11845.9 11852.1 11879.3 11901.4 4646.2 4667.8 4762.0 4766.8 4776.9 10135.6 10165.1 10182.5 10195.2 10218.1 5271.2 5281.9 5305.7 5314.7 5379.0 4214.0 4756.3 4886.6 4896.0 4925.7 3934.9 4009.3 4041.3 4070.9 4097.4 1299.3 1310.6 1310.7 1311.8 1333.3 1026.7 1031.9 1040.8 1058.7 1059.5 5928.1 5953.6 6035.3 6076.9 6169.7 438.4 441.8 443.9 450.3 450.5 4224.5 4254.7 4299.0 4299.1 4303.6 10032.5 10118.4 10206.2 10301.4 10312.2 10107.1 10123.9 10129.1 10148.6 10154.8 7654.7 7895.6 7970.4 8128.5 8129.2 5872.5 6061.8 6132.1 6133.8 6169.2 9715.0 9864.4 9993.8 10038.9 10042.7 9957.0 10131.5 10208.8 10227.1 10231.5 6778.8 7488.1 7492.5 7607.7 7680.3 8237.4 8271.4 8274.2 8292.3 8304.4 7024.4 7252.3 7296.9 7327.5 7389.7 6732.7 6892.6 7224.7 7227.4 7265.5 6999.9 7041.3 7057.3 7117.8 7126.5 5084.6 5136.1 5181.7 5196.1 5213.7 5166.3 5248.0 5254.1 5295.9 5357.6 06:10:39 INFO - PROCESS | 26454 | 06:10:39 INFO - PROCESS | 26454 | [#4] prototype.html Cycles:180 Average:4890.13 Median:5579.68 stddev:1453.84 (26.1%) stddev-sans-first:1417.00 06:10:39 INFO - PROCESS | 26454 | Values: 326.6 336.9 339.6 340.2 342.8 5585.0 5632.7 5643.5 5656.5 5659.2 5556.8 5563.2 5577.6 5581.7 5613.5 4144.5 4172.1 4321.7 4341.4 4373.1 4336.2 4339.8 4353.9 4355.4 4363.9 4311.8 4324.8 4333.3 4338.2 4340.7 4259.3 4322.2 4323.7 4334.5 4354.3 3821.5 3827.5 3830.9 3831.8 3849.2 5360.5 5361.3 5371.9 5386.4 5389.3 4787.7 4952.4 4963.3 4976.3 4979.3 5788.6 5799.7 5800.3 5804.8 5809.4 4188.8 4201.6 4211.6 4213.3 4217.6 5780.9 6059.5 6061.8 6072.9 6092.5 4142.8 4143.2 4149.5 4150.3 4151.3 4207.9 4220.4 4224.9 4226.9 4248.3 4744.4 4888.1 4899.0 4905.4 4916.9 5857.3 5865.4 5884.6 5890.4 5892.6 1440.9 1464.1 1479.8 1487.5 1487.6 912.6 936.9 938.4 938.9 945.8 5007.5 5057.3 5061.2 5111.5 5124.8 5315.4 5332.8 5399.5 5405.1 5413.4 5043.2 5045.5 5214.5 5700.4 5757.9 3214.7 3226.5 3230.6 3243.1 3257.3 6109.0 6253.7 6263.6 6302.4 6321.4 6191.5 6217.8 6275.9 6281.0 6281.8 6167.5 6237.9 6242.9 6261.4 6284.9 5808.2 6057.6 6060.8 6062.8 6155.0 5974.8 5986.2 5991.3 6026.6 6031.7 5977.3 6223.4 6231.9 6233.9 6296.9 4292.6 4298.2 4311.6 4312.6 4324.7 5868.6 5942.5 6059.7 6157.8 6180.5 5898.9 5907.2 5908.6 5917.4 5932.9 5654.5 5711.5 5836.9 5841.9 5917.4 5780.5 5789.0 5803.3 5823.6 5852.3 5952.8 5958.3 5981.5 5984.6 5993.9 5595.5 5646.4 5686.9 5779.9 5810.2 06:10:39 INFO - PROCESS | 26454 | 06:10:39 INFO - PROCESS | 26454 | [#5] yui.html Cycles:180 Average:20100.84 Median:51937.37 stddev:29164.03 (56.2%) stddev-sans-first:29209.58 06:10:39 INFO - PROCESS | 26454 | Values: 731.7 775.9 801.6 827.8 854.5 14938.6 15086.2 15417.3 15717.2 16746.7 15037.3 15127.0 15168.2 15257.8 15266.5 789.5 814.2 815.5 815.6 818.8 814.4 820.3 820.6 821.4 826.6 860.9 862.5 862.6 863.9 864.5 850.7 857.4 858.6 859.7 860.2 617.1 624.6 625.0 625.1 625.4 15335.8 15365.0 15512.1 15556.5 15613.5 14215.6 14482.7 14608.6 14677.2 14744.3 12464.1 12595.7 12617.2 12624.5 12823.3 3848.0 3869.9 3952.6 3979.1 3994.8 71286.6 72259.9 73032.6 74366.0 74887.3 11254.9 11282.0 11430.5 11438.7 11695.1 19926.2 19984.9 20051.2 20058.5 20191.6 8257.9 8267.5 8581.4 8626.7 8643.6 4879.7 5029.4 5048.3 5065.3 5093.4 3473.4 3604.5 3625.7 3638.3 3649.8 625.5 637.6 637.6 646.6 665.4 716.9 728.6 731.7 762.3 778.2 9340.2 9420.4 9487.3 9712.4 9795.8 694.9 746.0 761.4 776.8 778.6 4463.7 4585.3 4592.2 4612.1 4667.6 110668.4 110731.0 112973.4 113933.4 114121.0 62885.7 97004.5 99666.5 100082.5 100355.5 83010.6 87620.0 88499.6 88609.6 88747.6 7950.9 8017.4 8150.6 8621.4 8817.9 51222.0 51738.7 52136.0 52363.0 52367.7 63980.2 66530.0 73661.6 75974.6 76877.0 11168.9 11393.5 11436.1 11646.8 11781.7 12759.5 13166.7 13319.3 13346.7 13409.9 11376.1 11482.9 11499.4 11685.3 11840.1 12542.9 12602.3 12674.7 12877.7 13328.3 10698.4 10950.5 11874.6 12018.9 12086.5 9620.3 9914.3 9999.0 10003.7 10127.6 9383.6 9418.7 9534.3 9550.5 9806.1 06:10:39 INFO - PROCESS | 26454 | -------- Summary: end -------- 06:10:39 INFO - PROCESS | 26454 | 06:10:40 INFO - TEST-INFO | 26454: exit 0 06:10:40 INFO - TEST-OK | dromaeo_css | took 1109731ms 06:10:40 INFO - TEST-START | kraken 06:10:40 INFO - operating with platform_type : linux_ 06:10:40 INFO - Initialising browser for kraken test... 06:10:40 INFO - TEST-INFO | started process 26689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2LMzGh/profile http://localhost:38062/getInfo.html) 06:10:44 INFO - PROCESS | 26689 | __metrics Screen width/height:1600/1200 06:10:44 INFO - PROCESS | 26689 | colorDepth:24 06:10:44 INFO - PROCESS | 26689 | Browser inner width/height: 1024/697 06:10:44 INFO - PROCESS | 26689 | __metrics 06:10:45 ERROR - PROCESS | 26689 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 06:10:46 INFO - TEST-INFO | 26689: exit 0 06:10:46 INFO - Browser initialized. 06:10:46 INFO - Running cycle 1/1 for kraken test... 06:10:46 INFO - TEST-INFO | started process 26809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2LMzGh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:10:58 INFO - PROCESS | 26809 | RSS: Main: 166486016 06:10:58 INFO - PROCESS | 26809 | 06:11:00 INFO - PROCESS | 26809 | Cycle 1(1): loaded http://localhost:38062/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38062/tests/kraken/driver.html?testName=audio-beat-detection) 06:11:01 INFO - PROCESS | 26809 | RSS: Main: 172527616 06:11:01 INFO - PROCESS | 26809 | 06:11:04 INFO - PROCESS | 26809 | Cycle 1(1): loaded http://localhost:38062/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38062/tests/kraken/driver.html?testName=audio-dft) 06:11:04 INFO - PROCESS | 26809 | RSS: Main: 171663360 06:11:04 INFO - PROCESS | 26809 | 06:11:07 INFO - PROCESS | 26809 | Cycle 1(1): loaded http://localhost:38062/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38062/tests/kraken/driver.html?testName=audio-fft) 06:11:08 INFO - PROCESS | 26809 | RSS: Main: 166629376 06:11:08 INFO - PROCESS | 26809 | 06:11:10 INFO - PROCESS | 26809 | Cycle 1(1): loaded http://localhost:38062/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38062/tests/kraken/driver.html?testName=audio-oscillator) 06:11:11 INFO - PROCESS | 26809 | RSS: Main: 168140800 06:11:11 INFO - PROCESS | 26809 | 06:11:13 INFO - PROCESS | 26809 | Cycle 1(1): loaded http://localhost:38062/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38062/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:11:14 INFO - PROCESS | 26809 | RSS: Main: 168124416 06:11:14 INFO - PROCESS | 26809 | 06:11:17 INFO - PROCESS | 26809 | Cycle 1(1): loaded http://localhost:38062/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38062/tests/kraken/driver.html?testName=imaging-darkroom) 06:11:17 INFO - PROCESS | 26809 | RSS: Main: 168718336 06:11:17 INFO - PROCESS | 26809 | 06:11:21 INFO - PROCESS | 26809 | Cycle 1(1): loaded http://localhost:38062/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38062/tests/kraken/driver.html?testName=imaging-desaturate) 06:11:22 INFO - PROCESS | 26809 | RSS: Main: 165711872 06:11:22 INFO - PROCESS | 26809 | 06:11:24 INFO - PROCESS | 26809 | Cycle 1(1): loaded http://localhost:38062/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38062/tests/kraken/driver.html?testName=json-parse-financial) 06:11:25 INFO - PROCESS | 26809 | RSS: Main: 166961152 06:11:25 INFO - PROCESS | 26809 | 06:11:27 INFO - PROCESS | 26809 | Cycle 1(1): loaded http://localhost:38062/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38062/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:11:27 INFO - PROCESS | 26809 | RSS: Main: 167460864 06:11:27 INFO - PROCESS | 26809 | 06:11:29 INFO - PROCESS | 26809 | Cycle 1(1): loaded http://localhost:38062/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38062/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:11:30 INFO - PROCESS | 26809 | RSS: Main: 167702528 06:11:30 INFO - PROCESS | 26809 | 06:11:32 INFO - PROCESS | 26809 | Cycle 1(1): loaded http://localhost:38062/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38062/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:11:32 INFO - PROCESS | 26809 | RSS: Main: 168562688 06:11:32 INFO - PROCESS | 26809 | 06:11:35 INFO - PROCESS | 26809 | Cycle 1(1): loaded http://localhost:38062/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38062/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:11:36 INFO - PROCESS | 26809 | RSS: Main: 168386560 06:11:36 INFO - PROCESS | 26809 | 06:11:38 INFO - PROCESS | 26809 | Cycle 1(1): loaded http://localhost:38062/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38062/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:11:39 INFO - PROCESS | 26809 | RSS: Main: 168460288 06:11:39 INFO - PROCESS | 26809 | 06:11:41 INFO - PROCESS | 26809 | Cycle 1(1): loaded http://localhost:38062/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38062/tests/kraken/driver.html?testName=ai-astar) 06:11:41 INFO - PROCESS | 26809 | RSS: Main: 168927232 06:11:41 INFO - PROCESS | 26809 | 06:11:41 INFO - PROCESS | 26809 | __start_tp_report 06:11:41 INFO - PROCESS | 26809 | _x_x_mozilla_page_load 06:11:41 INFO - PROCESS | 26809 | _x_x_mozilla_page_load_details 06:11:41 INFO - PROCESS | 26809 | |i|pagename|runs| 06:11:41 INFO - PROCESS | 26809 | |0;ai-astar;111;106;110;110;111;113;110;110;111;112 06:11:41 INFO - PROCESS | 26809 | |1;audio-beat-detection;154;124;150;183;127;154;151;134;185;127 06:11:41 INFO - PROCESS | 26809 | |2;audio-dft;165;164;161;162;162;165;168;162;163;163 06:11:41 INFO - PROCESS | 26809 | |3;audio-fft;76;74;75;161;76;76;75;75;170;77 06:11:41 INFO - PROCESS | 26809 | |4;audio-oscillator;83;84;136;84;84;85;142;86;83;149 06:11:41 INFO - PROCESS | 26809 | |5;imaging-gaussian-blur;118;117;117;117;118;117;118;122;118;117 06:11:41 INFO - PROCESS | 26809 | |6;imaging-darkroom;147;150;147;146;147;146;147;149;148;148 06:11:41 INFO - PROCESS | 26809 | |7;imaging-desaturate;96;96;95;97;96;95;96;96;95;95 06:11:41 INFO - PROCESS | 26809 | |8;json-parse-financial;56;57;58;57;56;57;60;56;59;57 06:11:41 INFO - PROCESS | 26809 | |9;json-stringify-tinderbox;62;61;67;61;62;62;62;62;62;62 06:11:41 INFO - PROCESS | 26809 | |10;stanford-crypto-aes;83;85;81;80;85;81;81;84;115;86 06:11:41 INFO - PROCESS | 26809 | |11;stanford-crypto-ccm;135;122;121;122;131;122;127;139;145;124 06:11:41 INFO - PROCESS | 26809 | |12;stanford-crypto-pbkdf2;169;165;167;162;172;167;169;165;165;166 06:11:41 INFO - PROCESS | 26809 | |13;stanford-crypto-sha256-iterative;68;63;63;64;64;63;63;63;64;62 06:11:41 INFO - PROCESS | 26809 | __end_tp_report 06:11:41 INFO - PROCESS | 26809 | __start_cc_report 06:11:41 INFO - PROCESS | 26809 | _x_x_mozilla_cycle_collect,859 06:11:41 INFO - PROCESS | 26809 | __end_cc_report 06:11:41 INFO - PROCESS | 26809 | __startTimestamp1464873101493__endTimestamp 06:11:41 INFO - PROCESS | 26809 | 06:11:41 INFO - PROCESS | 26809 | ------- Summary: start ------- 06:11:41 INFO - PROCESS | 26809 | Number of tests: 14 06:11:41 INFO - PROCESS | 26809 | 06:11:41 INFO - PROCESS | 26809 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:1.84 (1.7%) stddev-sans-first:1.94 06:11:41 INFO - PROCESS | 26809 | Values: 111.0 106.0 110.0 110.0 111.0 113.0 110.0 110.0 111.0 112.0 06:11:41 INFO - PROCESS | 26809 | 06:11:41 INFO - PROCESS | 26809 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:152.50 stddev:21.92 (14.4%) stddev-sans-first:23.17 06:11:41 INFO - PROCESS | 26809 | Values: 154.0 124.0 150.0 183.0 127.0 154.0 151.0 134.0 185.0 127.0 06:11:41 INFO - PROCESS | 26809 | 06:11:41 INFO - PROCESS | 26809 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:2.07 (1.3%) stddev-sans-first:2.12 06:11:41 INFO - PROCESS | 26809 | Values: 165.0 164.0 161.0 162.0 162.0 165.0 168.0 162.0 163.0 163.0 06:11:41 INFO - PROCESS | 26809 | 06:11:41 INFO - PROCESS | 26809 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.50 stddev:38.02 (50.4%) stddev-sans-first:39.79 06:11:41 INFO - PROCESS | 26809 | Values: 76.0 74.0 75.0 161.0 76.0 76.0 75.0 75.0 170.0 77.0 06:11:41 INFO - PROCESS | 26809 | 06:11:41 INFO - PROCESS | 26809 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:84.00 stddev:28.29 (33.7%) stddev-sans-first:29.19 06:11:41 INFO - PROCESS | 26809 | Values: 83.0 84.0 136.0 84.0 84.0 85.0 142.0 86.0 83.0 149.0 06:11:41 INFO - PROCESS | 26809 | 06:11:41 INFO - PROCESS | 26809 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.52 (1.3%) stddev-sans-first:1.62 06:11:41 INFO - PROCESS | 26809 | Values: 118.0 117.0 117.0 117.0 118.0 117.0 118.0 122.0 118.0 117.0 06:11:41 INFO - PROCESS | 26809 | 06:11:41 INFO - PROCESS | 26809 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:1.27 (0.9%) stddev-sans-first:1.33 06:11:41 INFO - PROCESS | 26809 | Values: 147.0 150.0 147.0 146.0 147.0 146.0 147.0 149.0 148.0 148.0 06:11:41 INFO - PROCESS | 26809 | 06:11:41 INFO - PROCESS | 26809 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 06:11:41 INFO - PROCESS | 26809 | Values: 96.0 96.0 95.0 97.0 96.0 95.0 96.0 96.0 95.0 95.0 06:11:41 INFO - PROCESS | 26809 | 06:11:41 INFO - PROCESS | 26809 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:1.34 (2.3%) stddev-sans-first:1.33 06:11:41 INFO - PROCESS | 26809 | Values: 56.0 57.0 58.0 57.0 56.0 57.0 60.0 56.0 59.0 57.0 06:11:41 INFO - PROCESS | 26809 | 06:11:41 INFO - PROCESS | 26809 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:1.70 (2.7%) stddev-sans-first:1.80 06:11:41 INFO - PROCESS | 26809 | Values: 62.0 61.0 67.0 61.0 62.0 62.0 62.0 62.0 62.0 62.0 06:11:41 INFO - PROCESS | 26809 | 06:11:41 INFO - PROCESS | 26809 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:83.50 stddev:10.37 (12.4%) stddev-sans-first:10.93 06:11:41 INFO - PROCESS | 26809 | Values: 83.0 85.0 81.0 80.0 85.0 81.0 81.0 84.0 115.0 86.0 06:11:41 INFO - PROCESS | 26809 | 06:11:41 INFO - PROCESS | 26809 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:129.00 stddev:8.40 (6.5%) stddev-sans-first:8.61 06:11:41 INFO - PROCESS | 26809 | Values: 135.0 122.0 121.0 122.0 131.0 122.0 127.0 139.0 145.0 124.0 06:11:41 INFO - PROCESS | 26809 | 06:11:41 INFO - PROCESS | 26809 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:167.00 stddev:2.79 (1.7%) stddev-sans-first:2.83 06:11:41 INFO - PROCESS | 26809 | Values: 169.0 165.0 167.0 162.0 172.0 167.0 169.0 165.0 165.0 166.0 06:11:41 INFO - PROCESS | 26809 | 06:11:41 INFO - PROCESS | 26809 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.50 stddev:1.64 (2.6%) stddev-sans-first:0.67 06:11:41 INFO - PROCESS | 26809 | Values: 68.0 63.0 63.0 64.0 64.0 63.0 63.0 63.0 64.0 62.0 06:11:41 INFO - PROCESS | 26809 | -------- Summary: end -------- 06:11:41 INFO - PROCESS | 26809 | 06:11:42 INFO - TEST-INFO | 26809: exit 0 06:11:42 INFO - TEST-OK | kraken | took 62394ms 06:11:42 INFO - SUITE-END | took 1172s 06:11:42 INFO - Completed test suite (00:19:32) 06:11:42 INFO - javascript benchmark 06:11:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7237.084012020051, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3054.068509104722, 3054.282243672738, 3055.190374550743, 3121.250899784052, 3168.1129283800537, 5412.918806217905, 5420.783168673253, 5446.809361672337, 5522.392536820947, 5525.861853453665, 5391.433899440561, 5433.8369848904595, 5440.537554307879, 5497.725113744316, 5513.862153446166, 4869.123557759611, 4938.975305123469, 5041.52105549974, 5081.542661160494, 5128.9230661540105, 784.5055801963869, 4828.2274836026245, 4886.48691887352, 4935.5804756595735, 5055.090083784918, 4897.412310522743, 4910.0670872534465, 4932.358793356877, 4942.159832828428, 4943.9258411123865, 4958.181899986498, 4959.107360675077, 4968.776405061781, 4971.726555039471, 4988.87527811804, 4908.631852611068, 4945.159322915077, 4985.302057711923, 4992.850214493571, 4998.375203099613, 5414.6480478769145, 5452.318460192476, 5488.423715509894, 5504.0643090674685, 5517.724113794335, 5674.319081710221, 5773.913391299134, 5926.170336152942, 5931.851703707399, 5938.435848594377, 5888.29340479141, 5899.203607512974, 5912.0, 5934.792282270143, 5972.70136493178, 5538.889222215574, 5569.164625306236, 5569.637973531748, 5579.525740312079, 5582.9950608890385, 5868.853278667982, 6016.2479690038745, 6047.848803779941, 6077.574569780073, 6085.330613632497, 5739.110437882135, 5740.282464691913, 5747.597668163188, 5748.770049197985, 5752.395998420189, 5891.293044834561, 5891.617044892154, 5904.409559044061, 5911.704414779244, 5917.31950825652, 5749.798757043483, 5776.277965254343, 5862.208601838783, 5881.705914704247, 5882.411758824083, 5806.709664516758, 5844.736986835603, 5846.473817356458, 5878.470937615635, 5909.172715819789, 4337.804798784062, 4441.0, 4452.910941781146, 4464.285714285764, 4477.552244775561, 3887.980560097238, 3924.293627147141, 3931.0958479549863, 3963.6829053675638, 3973.5231772186944, 5490.203920431515, 5543.61194716366, 5568.16477528374, 5590.440955904458, 5630.352509461382, 5755.65466072037, 5899.233099697012, 5914.172015917775, 5924.822255332347, 5942.61373010753, 5526.557875369961, 5534.557235421156, 5568.16477528374, 5571.9721401392735, 5582.7766889323975, 4992.600591952635, 5059.671121377099, 5079.0, 5095.286659867622, 5117.2068329409, 5891.764329426861, 6099.4815440688035, 6104.4505994460715, 6110.908336374958, 6123.540734444845, 5953.672548009815, 6043.0, 6043.395660434097, 6050.878982420239, 6062.545309101747, 6172.351903050115, 6184.165137706352, 6188.195534580475, 6188.350223226496, 6202.069689546604, 5630.577706671934, 5763.020286551213, 5765.3946335634155, 5900.527957763283, 5925.733341999534, 5941.0494320910175, 5947.959107156317, 5954.4938680210935, 5973.462388385066, 6000.5799594028, 5700.258966334516, 5724.198612194379, 5737.139429085671, 5740.1102829061565, 5812.622179558315, 5498.80754173618, 5675.574331925205, 5714.885702285847, 5733.741981610921, 5746.051901436216, 5618.747156377891, 5631.042722737063, 5673.120666296731, 5673.886522269614, 5685.829425117253, 5763.884722305615, 5766.308043034863, 5772.595918285848, 5804.854878627899, 5819.76720931158, 5520.06158952987, 5651.547876169979, 5690.032694441872, 5712.02895507773, 5742.454466825645], "value": 5377.919855213161, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.5402988504599, 602.8312072619667, 613.852675357914, 618.9566730328876, 664.7972368427628, 39655.0, 41104.588954110484, 43321.0, 43576.34635480463, 43638.34542481865, 44940.0, 45302.7734861326, 45464.54535454645, 45481.31778023332, 45508.54491455085, 8772.429792063496, 8820.8676869847, 8937.374383793138, 8945.418547794372, 8963.193312601865, 8737.344699147558, 8907.198352148305, 8930.419522731034, 8946.955265223665, 8951.41815781972, 8936.374453788238, 8946.463212207256, 8963.820723585524, 8998.550072496382, 9012.459252444874, 8819.559022048905, 8834.0, 8899.644014239455, 8923.687670931551, 8943.865842012376, 8789.0, 8861.0, 8911.643534258621, 8919.554022298858, 8923.375363724543, 40864.18271634581, 41328.38007429891, 41358.0, 41477.37783933243, 41480.79259603713, 3353.3293341331587, 3524.1365865362895, 4054.331035379159, 4089.7432704997696, 4292.506361768405, 31451.370972580648, 31600.525992110135, 32096.679033209602, 32131.51802722961, 32237.0, 4219.767912764797, 4263.744175349458, 4321.659197748344, 4383.561643835623, 4400.823967041314, 340380.0, 343007.0, 343365.283173585, 343798.0, 345077.0, 56683.716581417655, 57081.0, 57186.42813571811, 57253.71373143191, 57554.136687949715, 60405.697971509864, 60860.39139608636, 60964.0, 61047.694761525905, 61072.69463652742, 16940.661186776197, 17218.483445496404, 17261.91369043172, 17262.82737172612, 17272.91363543174, 13518.93240533791, 13598.456061757617, 13634.0, 13676.247806370546, 13702.177869327872, 15569.766453503207, 16024.919875400548, 16194.75707864383, 16280.26738796757, 16317.918410407872, 6619.834504137339, 6647.268800431949, 6708.563943343667, 6726.39462448382, 6877.939317003986, 968.6948611187454, 1042.9843552346722, 1064.7338165458636, 1121.3328069798456, 1197.592818441734, 31453.68546314553, 31462.0, 31557.8422107888, 32248.35503289921, 32769.67230327666, 1126.8366086917351, 1167.287954347847, 1200.2438463767771, 1214.1318956945827, 1257.9119461637597, 16661.750073748903, 16721.498355049367, 17139.314427422763, 17169.48491545256, 17208.65582688339, 542151.0, 544045.0, 545211.0, 546000.0, 550317.0, 56505.43494565084, 56722.0, 56862.43137568654, 56943.430565693816, 57083.71458142683, 1356.2201734002988, 1378.910370825913, 1386.5978866128912, 1388.2364699415484, 1390.735760205578, 30951.84524077365, 31451.685483144876, 31464.685353146175, 31656.683433165374, 32538.0, 49580.25629615487, 50208.74895625498, 50344.244836326754, 50355.748221260124, 50359.733811979284, 433585.0, 446430.0, 449420.0, 449514.0, 450340.0, 41038.1792364157, 41341.58658413377, 41450.37824432576, 41495.377569337084, 42678.35982460328, 47554.28668569905, 48203.75898120487, 48436.0, 48782.75608621934, 49431.25853112278, 39053.80473097616, 40310.19379612333, 40539.39190912198, 40887.1822563553, 41294.1741165181, 40228.1954360917, 40322.59677403306, 41288.58711412847, 41883.58116418797, 42333.5766642342, 40501.39247911343, 40655.39016914808, 41096.589034110475, 41324.58675413208, 43976.7801161005, 34656.65343346534, 35618.821905890305, 36055.27889442144, 36244.637553624125, 36362.0, 27532.036378726647, 28131.57802633003, 28243.858780705967, 28484.572731408633, 28717.28206794847], "value": 20355.398314392784, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.8643288416171, 380.3618390098705, 384.15677587695, 397.64808144791886, 402.4245329179274, 15138.470153544627, 16724.749128763047, 17334.393296234633, 20076.89961550192, 20337.389878303675, 17817.287308507675, 18255.54361140972, 19138.71291930619, 19181.232750689956, 19195.13621887015, 5477.589180811435, 5484.424135465769, 5679.460451257145, 5691.51622112121, 5710.77156913723, 5625.324961004685, 5690.943090569103, 5700.087985922253, 5741.885162296751, 5750.597458177929, 5299.920501192485, 5624.606277560572, 5632.267805185341, 5648.6893220872835, 5678.318601767773, 5544.112941929292, 5606.243157173811, 5639.68981706006, 5643.633163844337, 5677.858053548653, 5381.784728610851, 5707.3721890592005, 5718.7426565804635, 5728.770849166029, 5741.253637027202, 13132.868671313356, 13258.270795106266, 13564.118332308468, 13704.24626645534, 13705.862941370659, 2115.4394085567337, 2205.9558808823895, 2258.5934531784274, 2258.6160352740076, 2259.45773014477, 9722.347200975852, 9862.161716254128, 9964.25268104895, 10030.297879148462, 10160.79678406435, 1909.47489440405, 1930.758655168104, 1973.2304401283511, 1984.811442912921, 2056.270024141438, 49847.75076124632, 61585.0, 76771.0, 83503.0, 86460.56769716111, 10426.426546539862, 10592.682219533426, 10631.681049568526, 10745.032947034648, 10869.83695244572, 14917.40330386794, 15042.548723538312, 15044.774328385083, 15046.473373431878, 15052.849471505364, 7675.0, 7993.880091798627, 8035.879461808077, 8113.472624279403, 8122.796930076795, 7745.380369570421, 7851.0, 7861.292483676497, 7979.640916158787, 8027.518348899085, 4573.176828170895, 4588.957913728359, 4625.514320996314, 4647.256438969748, 4676.719396836201, 1926.5280006398523, 1936.9322073727633, 1953.765548134233, 1960.0, 1974.7630284365969, 908.2733812949614, 969.6460791810938, 1001.3841487485145, 1041.6041904076553, 1100.6092837042734, 18811.0, 18851.811481885004, 19049.80950190508, 19620.313289034817, 20009.299674511323, 984.2519685039279, 1008.3848852200152, 1008.9394636321845, 1033.7260625934134, 1065.3235195650664, 10813.729656758644, 11173.385463799406, 11232.49453774582, 11233.943830280796, 11237.55049797999, 442217.0, 451048.0, 453590.0, 454717.0, 455877.0, 84499.5775021121, 91496.54251728699, 92391.0, 92548.53725731328, 92606.53696731474, 991.2862738828032, 992.6079198716467, 1006.6174853555748, 1008.606643409071, 1013.6097602423121, 17107.23017464192, 17109.949834858588, 17234.396796112076, 17389.652206955536, 17471.475855724348, 37205.255894882495, 39349.40975885421, 41529.0, 42067.57932420759, 42354.0, 55803.44196557983, 56915.430845691015, 58248.79473414517, 58572.70713646575, 58851.70574147102, 7536.1333446654335, 7790.143084260613, 7837.529748215125, 8317.584120793816, 9002.23481004122, 12874.67813304675, 13168.60494185176, 13288.867111328764, 13368.131071480322, 13514.729705406033, 11110.222284440335, 11261.324320540467, 11433.714157146138, 11810.0, 11971.880281197076, 10969.341839489656, 11047.558097676003, 11232.269902456641, 11276.548938042386, 11632.18574699763, 11044.723881903017, 11448.198626096093, 11465.598704045651, 11505.769884602094, 11868.584599538975, 7752.728654497066, 7781.455298129076, 7911.0, 7935.40484463656, 8213.79465513367, 10934.398608076632, 11267.492962816857, 11306.94346528295, 11480.483378248166, 11496.425178741198], "value": 8893.923441920444, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1501.06183635228, 1544.598404414852, 1689.8732595055374, 1777.9288828446863, 1809.6290260496608, 7308.269173082689, 8183.549904755236, 8184.590770461476, 8677.392582519218, 8704.434211776237, 8126.1873812618705, 8318.584070796467, 8386.496810191393, 8386.91613083869, 8417.494950302986, 2362.728286247078, 2365.680633114525, 2376.0733314007553, 2390.091765129257, 2399.6040653292184, 2348.518553696488, 2353.2587235021, 2380.809535237177, 2385.439421735891, 2390.3187591536416, 2243.2933625907867, 2284.3603790938564, 2298.5517824024323, 2359.339384972202, 2361.9645705314433, 2246.067881829039, 2255.5263394687217, 2258.2434884313775, 2266.829987750909, 2324.1981516376823, 2282.589133955887, 2290.7823756743082, 2290.80528155107, 2291.5302363015544, 2293.0, 8436.915630843674, 8446.746597602081, 8471.06818249992, 8571.828563428759, 8595.054544000155, 5262.184361423985, 5272.525472707474, 5365.980463711921, 5369.194620806871, 5372.274742909735, 3347.782394144373, 3350.8659653613827, 3421.4012547804036, 3500.597431295408, 3513.8243087845763, 1119.2948442481265, 1150.6950658075616, 1183.0771997841698, 1191.4876603060768, 1209.3771707570609, 11735.530578776925, 11845.94077029618, 11852.11109166816, 11879.287242765462, 11901.404929753564, 4646.163690535668, 4667.813287468532, 4761.952380476151, 4766.761661916959, 4776.856694299107, 10135.64525241613, 10165.085142337226, 10182.490875456198, 10195.184385249162, 10218.131458825934, 5271.235670827785, 5281.867953301121, 5305.681659100389, 5314.681119132864, 5378.97310513445, 4213.957860421357, 4756.334113224151, 4886.60907127429, 4896.0, 4925.655204135748, 3934.8622798201927, 4009.3384591542067, 4041.2927737645796, 4070.9185816283507, 4097.385392191195, 1299.27240745183, 1310.6330227536305, 1310.744404841066, 1311.8425788905392, 1333.3466601365262, 1026.6868605075524, 1031.896810318962, 1040.765827688764, 1058.7088550648634, 1059.5073290919759, 5928.081147422156, 5953.583249172603, 6035.305939816977, 6076.939230607637, 6169.660668663177, 438.388448114878, 441.84535412605976, 443.8979034822009, 450.26606631190947, 450.5269467059574, 4224.4508213931995, 4254.744715317091, 4298.978505107454, 4299.118680670455, 4303.612674859215, 10032.548535315927, 10118.443485608363, 10206.183505319557, 10301.381917084998, 10312.226583006304, 10107.090361867467, 10123.9493802532, 10129.139023182965, 10148.594056237667, 10154.847677284846, 7654.693812247559, 7895.60521973899, 7970.362371010306, 8128.471649342774, 8129.227723366271, 5872.530197584098, 6061.848453788691, 6132.08018797184, 6133.815985520263, 6169.167162433014, 9715.0, 9864.408135511892, 9993.750156246151, 10038.899611003797, 10042.69871903844, 9957.0, 10131.493425328557, 10208.846867296848, 10227.107985022794, 10231.539580718736, 6778.830529236809, 7488.063992001, 7492.51298665585, 7607.657655405409, 7680.308772210527, 8237.382196335178, 8271.421000529905, 8274.172582741678, 8292.253697167283, 8304.377171712267, 7024.367806897404, 7252.347288744038, 7296.890546641698, 7327.450441217036, 7389.7413590524075, 6732.663366831737, 6892.551984121016, 7224.711011559479, 7227.421806255382, 7265.491415600857, 6999.860002799814, 7041.260667629826, 7057.294270572902, 7117.75087871922, 7126.536775109601, 5084.567811736044, 5136.075506408883, 5181.689098654093, 5196.064708352533, 5213.687178769286, 5166.3025491559665, 5248.0, 5254.133068043883, 5295.920561191662, 5357.571394288526], "value": 4521.264136864834, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.5852367493282, 336.86693755966394, 339.59079309432127, 340.2412619857716, 342.77719482336465, 5585.022621041317, 5632.662040277586, 5643.520300774434, 5656.519195868346, 5659.207710920469, 5556.833295001146, 5563.221149039137, 5577.637453565515, 5581.7209139542965, 5613.522850557697, 4144.4819397575375, 4172.123853990665, 4321.697481176319, 4341.39220509129, 4373.125374925028, 4336.154449882274, 4339.783010849461, 4353.869383918472, 4355.433793606827, 4363.930836944953, 4311.82752689892, 4324.762138082404, 4333.306670932651, 4338.2191205582985, 4340.696151269412, 4259.318509038554, 4322.157179350028, 4323.675724320657, 4334.479862416499, 4354.258296681322, 3821.45231181372, 3827.4641550182996, 3830.942535861964, 3831.7700937943814, 3849.2493963677093, 5360.490753378423, 5361.329833770778, 5371.865703357408, 5386.434424385422, 5389.299391079135, 4787.736674482902, 4952.380952380952, 4963.305137280783, 4976.328195693572, 4979.253112033188, 5788.623739456964, 5799.681017544076, 5800.332961709373, 5804.796832110856, 5809.419058094199, 4188.769617671027, 4201.6008479194425, 4211.578842115795, 4213.262679031157, 4217.641500472463, 5780.913286300709, 6059.485128717821, 6061.7575296987625, 6072.908906366408, 6092.482139018189, 4142.834286628561, 4143.150654115899, 4149.543550209474, 4150.294449943517, 4151.256472281649, 4207.873763787091, 4220.409142720022, 4224.936625950613, 4226.936595951063, 4248.34150706641, 4744.359511465908, 4888.144574699413, 4898.975505122452, 4905.411350637875, 4916.926246106311, 5857.26784151981, 5865.4134586541, 5884.6469211847425, 5890.381509941394, 5892.646441213541, 1440.906341087826, 1464.1434760664918, 1479.823540285454, 1487.4793822162374, 1487.5686051045075, 912.6167009855876, 936.8991435063773, 938.3712912348743, 938.9342746007851, 945.7966537194536, 5007.499250074963, 5057.291979122852, 5061.240813877947, 5111.488851114858, 5124.846254612367, 5315.441878602768, 5332.813351532678, 5399.4600539945695, 5405.081136206854, 5413.377461591967, 5043.218301163325, 5045.5459008689395, 5214.530692237717, 5700.37295897451, 5757.942420575824, 3214.6624604416666, 3226.451503244454, 3230.596175478065, 3243.0757234188145, 3257.332246889382, 6109.0, 6253.7185826637915, 6263.592866463757, 6302.369763023661, 6321.399467050623, 6191.4830866438015, 6217.751289948442, 6275.905861412082, 6280.995040793451, 6281.780137695158, 6167.475764560063, 6237.937620623827, 6242.937570624235, 6261.405166509175, 6284.905726414107, 5808.244928159313, 6057.636541807506, 6060.8181404625675, 6062.848428789139, 6155.045967874987, 5974.75946520055, 5986.191864098291, 5991.281046274301, 6026.608270462406, 6031.668258245839, 5977.326348622392, 6223.408776166257, 6231.875362492634, 6233.937660623335, 6296.937030629819, 4292.635126014199, 4298.183345164409, 4311.633511151587, 4312.568743125662, 4324.740515569076, 5868.598551086685, 5942.494887934574, 6059.666718330534, 6157.84605384869, 6180.505559555135, 5898.852528686817, 5907.232059832366, 5908.556858235564, 5917.408259174221, 5932.902413053599, 5654.519365853948, 5711.543076553949, 5836.883262334644, 5841.883162336814, 5917.437843404869, 5780.450857168562, 5789.0, 5803.274590676166, 5823.621464604957, 5852.297724273115, 5952.76188952437, 5958.285005799332, 5981.491573216325, 5984.611000284967, 5993.940060599338, 5595.496405323541, 5646.402654778848, 5686.943130568641, 5779.942200578109, 5810.186573879745], "value": 4420.6469321394225, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.6926890705903, 775.9408407523732, 801.6112185589988, 827.7806381308955, 854.5470900422778, 14938.626534336647, 15086.170260635661, 15417.306221220058, 15717.214139293032, 16746.74879876803, 15037.323320450607, 15127.0, 15168.165750883696, 15257.77113343298, 15266.542003739905, 789.4947233770391, 814.222417591202, 815.4577206157927, 815.5962798414793, 818.7707441916243, 814.4054839966827, 820.3437250199846, 820.6266148902235, 821.4003777242616, 826.557791581504, 860.9096044915287, 862.5299211929482, 862.6204470033197, 863.9265662418702, 864.4813112132701, 850.698002209213, 857.4255248983196, 858.5835869603237, 859.6948083430386, 860.1785295043281, 617.1082785375135, 624.5784095735361, 624.9906251406233, 625.0592857749059, 625.4464798653224, 15335.769963450557, 15365.0, 15512.069275843372, 15556.533304000897, 15613.453529126426, 14215.57353279393, 14482.710345793024, 14608.561743147722, 14677.192754398504, 14744.262786860721, 12464.127511074228, 12595.74808503834, 12617.179883307648, 12624.495020199181, 12823.294718790463, 3848.0038480038393, 3869.9226015479535, 3952.5849785772657, 3979.064919743858, 3994.820233089518, 71286.64356678235, 72259.88308040463, 73032.63483682601, 74366.0, 74887.25112748858, 11254.94372528132, 11282.0, 11430.542778288942, 11438.656840294805, 11695.12286578493, 19926.20295188176, 19984.90007549953, 20051.197952082046, 20058.498537536678, 20191.596168076558, 8257.876131858027, 8267.503949763033, 8581.356398270154, 8626.698065567674, 8643.567821608895, 4879.731614761222, 5029.446760856303, 5048.343715317059, 5065.316182315414, 5093.388793344822, 3473.3574288756663, 3604.5133906922756, 3625.7099432045375, 3638.3450978824067, 3649.799261040668, 625.5089754542662, 637.5855693799068, 637.6269882119012, 646.6443456099126, 665.4343807763363, 716.9211386747454, 728.613834667627, 731.747547096251, 762.3291503476905, 778.2101167315179, 9340.159385655188, 9420.434773913586, 9487.33588648788, 9712.417254964725, 9795.755106122404, 694.8540806430706, 745.9552426854406, 761.4213197969583, 776.7763780311639, 778.5951305321202, 4463.709858859163, 4585.28928016158, 4592.173408786383, 4612.100640375162, 4667.603253723403, 110668.44665776781, 110731.0, 112973.43513282381, 113933.4303328478, 114121.0, 62885.68557157185, 97004.51497742467, 99666.5016674912, 100082.4995875016, 100355.49822250842, 83010.58494707488, 87620.0, 88499.55750221337, 88609.55695221611, 88747.55626221828, 7950.920490795249, 8017.438779285394, 8150.551719655476, 8621.439606425562, 8817.867731984154, 51222.0, 51738.741306293225, 52136.0, 52363.0, 52367.73816130895, 63980.24177824018, 66530.0, 73661.6316918412, 75974.62012689901, 76877.0, 11168.944155279172, 11393.54425822991, 11436.085113191091, 11646.825297620711, 11781.705457363634, 12759.48962041508, 13166.736665266833, 13319.33403329849, 13346.733065338833, 13409.932950335186, 11376.089912807121, 11482.94258528702, 11499.425028748361, 11685.298882066763, 11840.089426958863, 12542.874571254535, 12602.306873122066, 12674.683132921751, 12877.742445151232, 13328.33358332099, 10698.358098514114, 10950.45247737594, 11874.643760687193, 12018.879811201776, 12086.50133354568, 9620.326577139533, 9914.30599858032, 9999.0, 10003.699889003341, 10127.59489620407, 9383.577739001625, 9418.717438476857, 9534.332596718163, 9550.522473876417, 9806.068423499755], "value": 7382.520812350167, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 110.0, 110.0, 111.0, 113.0, 110.0, 110.0, 111.0, 112.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 150.0, 183.0, 127.0, 154.0, 151.0, 134.0, 185.0, 127.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 161.0, 162.0, 162.0, 165.0, 168.0, 162.0, 163.0, 163.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 161.0, 76.0, 76.0, 75.0, 75.0, 170.0, 77.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 136.0, 84.0, 84.0, 85.0, 142.0, 86.0, 83.0, 149.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 122.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 150.0, 147.0, 146.0, 147.0, 146.0, 147.0, 149.0, 148.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 97.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 57.0, 56.0, 57.0, 60.0, 56.0, 59.0, 57.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 67.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 81.0, 80.0, 85.0, 81.0, 81.0, 84.0, 115.0, 86.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 122.0, 121.0, 122.0, 131.0, 122.0, 127.0, 139.0, 145.0, 124.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 167.0, 162.0, 172.0, 167.0, 169.0, 165.0, 165.0, 166.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 63.0, 63.0, 64.0, 64.0, 63.0, 63.0, 63.0, 64.0, 62.0], "value": 63.7, "unit": "score"}]}]} 06:11:42 INFO - Return code: 0 06:11:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:11:42 ERROR - # TBPL SUCCESS # 06:11:42 INFO - Running post-action listener: _resource_record_post_action 06:11:42 INFO - ##### 06:11:42 INFO - ##### Finished run-tests step (success) 06:11:42 INFO - ##### 06:11:42 INFO - Running post-run listener: _resource_record_post_run 06:11:42 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 543186944; Read time: 28; Write time: 483440 06:11:42 INFO - TinderboxPrint: CPU usage
13.4% 06:11:42 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 06:11:42 INFO - TinderboxPrint: I/O write bytes / time
543,186,944 / 483,440 06:11:42 INFO - TinderboxPrint: CPU idle
8,218.8 (86.6%) 06:11:42 INFO - TinderboxPrint: CPU user
1,217.1 (12.8%) 06:11:42 INFO - TinderboxPrint: Swap in / out
0 / 0 06:11:42 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 249192448; Read time: 0; Write time: 260612 06:11:42 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290082816; Read time: 28; Write time: 222036 06:11:43 INFO - Running post-run listener: _upload_blobber_files 06:11:43 INFO - Blob upload gear active. 06:11:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:11:43 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 06:11:43 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:11:43 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:11:43 INFO - (blobuploader) - INFO - Open directory for files ... 06:11:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:11:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:11:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:44 INFO - (blobuploader) - INFO - Done attempting. 06:11:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:11:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:11:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:45 INFO - (blobuploader) - INFO - Done attempting. 06:11:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:11:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:11:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:49 INFO - (blobuploader) - INFO - Done attempting. 06:11:49 INFO - (blobuploader) - INFO - Iteration through files over. 06:11:49 INFO - Return code: 0 06:11:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:11:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:11:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/089ac1b0b8cd22845dbcfecd23e285bc659170a0eba166f29683a8fd7a418973c7ee58c3c1eb02df23ecf35663ebe82bf3533bc4f87089ec470e8da33c4d91a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a3688c45745dd9445b9042c00cd4b17d52727c41b58946023c38cf4e062b59b770b697c48059b000374fb8c0f530c01574f73020f50fa40cbb6375af57b01cb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/179f2facdc657b9412e2eabbf9566421fa0e1949f6184332ac0155a14aabbef4e927eabc2bda59455287e204b4480d17964ac74dcd589d7a3bc6923efa2d5316"} 06:11:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:11:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:11:49 INFO - Contents: 06:11:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/089ac1b0b8cd22845dbcfecd23e285bc659170a0eba166f29683a8fd7a418973c7ee58c3c1eb02df23ecf35663ebe82bf3533bc4f87089ec470e8da33c4d91a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a3688c45745dd9445b9042c00cd4b17d52727c41b58946023c38cf4e062b59b770b697c48059b000374fb8c0f530c01574f73020f50fa40cbb6375af57b01cb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/179f2facdc657b9412e2eabbf9566421fa0e1949f6184332ac0155a14aabbef4e927eabc2bda59455287e204b4480d17964ac74dcd589d7a3bc6923efa2d5316"} 06:11:49 INFO - Running post-run listener: copy_logs_to_upload_dir 06:11:49 INFO - Copying logs to upload dir... 06:11:49 INFO - mkdir: /builds/slave/test/build/upload/logs 06:11:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.760439 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-02 06:11:49.513413) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 06:11:49.517034) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309 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/Firefox/sha512/089ac1b0b8cd22845dbcfecd23e285bc659170a0eba166f29683a8fd7a418973c7ee58c3c1eb02df23ecf35663ebe82bf3533bc4f87089ec470e8da33c4d91a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a3688c45745dd9445b9042c00cd4b17d52727c41b58946023c38cf4e062b59b770b697c48059b000374fb8c0f530c01574f73020f50fa40cbb6375af57b01cb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/179f2facdc657b9412e2eabbf9566421fa0e1949f6184332ac0155a14aabbef4e927eabc2bda59455287e204b4480d17964ac74dcd589d7a3bc6923efa2d5316"} build_url:https://queue.taskcluster.net/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011445 build_url: 'https://queue.taskcluster.net/v1/task/Le6rKNWxTWGJ8eU02VyMmA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/089ac1b0b8cd22845dbcfecd23e285bc659170a0eba166f29683a8fd7a418973c7ee58c3c1eb02df23ecf35663ebe82bf3533bc4f87089ec470e8da33c4d91a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5a3688c45745dd9445b9042c00cd4b17d52727c41b58946023c38cf4e062b59b770b697c48059b000374fb8c0f530c01574f73020f50fa40cbb6375af57b01cb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/179f2facdc657b9412e2eabbf9566421fa0e1949f6184332ac0155a14aabbef4e927eabc2bda59455287e204b4480d17964ac74dcd589d7a3bc6923efa2d5316"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 06:11:49.545316) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 06:11:49.545857) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1464871873.568390-2068641309 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004590 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 06:11:49.628522) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 06:11:49.628843) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 06:11:49.629144) ========= ========= Total master_lag: 0.18 =========