builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1464866298.83 results: success (0) buildid: 20160602025649 builduid: 737e7d67d9cf4557a617980c392aad5e revision: 34a8be4346a9231e472fc36b1d7c0531e0fbf7c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 04:18:18.825559) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 04:18:18.826303) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 04:18:18.826643) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 04:18:18.842282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:18:18.842712) ========= 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=eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 04:18:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 82.0K=0.1s 2016-06-02 04:18:19 (82.0 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.281195 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:18:19.138055) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:18:19.138421) ========= 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=eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015340 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:18:19.197101) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:18:19.197467) ========= 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=eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 04:18:19,754 truncating revision to first 12 chars 2016-06-02 04:18:19,754 Setting DEBUG logging. 2016-06-02 04:18:19,754 attempt 1/10 2016-06-02 04:18:19,754 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 04:18:20,079 unpacking tar archive at: mozilla-central-34a8be4346a9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669495 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:18:19.880670) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 04:18:19.881016) ========= script_repo_revision: 34a8be4346a9231e472fc36b1d7c0531e0fbf7c5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 04:18:19.881478) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 04:18:19.881790) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 04:18:19.892356) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-02 04:18:19.892669) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:18:20 INFO - MultiFileLogger online at 20160602 04:18:20 in /builds/slave/test 04:18:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:18:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:18:20 INFO - {'append_to_log': False, 04:18:20 INFO - 'base_work_dir': '/builds/slave/test', 04:18:20 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:18:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:18:20 INFO - 'branch': 'Firefox-Non-PGO', 04:18:20 INFO - 'buildbot_json_path': 'buildprops.json', 04:18:20 INFO - 'config_files': ('talos/linux_config.py',), 04:18:20 INFO - 'default_actions': ('clobber', 04:18:20 INFO - 'read-buildbot-config', 04:18:20 INFO - 'download-and-extract', 04:18:20 INFO - 'populate-webroot', 04:18:20 INFO - 'create-virtualenv', 04:18:20 INFO - 'install', 04:18:20 INFO - 'run-tests'), 04:18:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:18:20 INFO - 'download_minidump_stackwalk': True, 04:18:20 INFO - 'download_symbols': 'ondemand', 04:18:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:18:20 INFO - 'tooltool.py': '/tools/tooltool.py', 04:18:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:18:20 INFO - '/tools/misc-python/virtualenv.py')}, 04:18:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:18:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:18:20 INFO - 'installer_path': 'installer.exe', 04:18:20 INFO - 'log_level': 'info', 04:18:20 INFO - 'log_name': 'talos', 04:18:20 INFO - 'log_to_console': True, 04:18:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:18:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:18:20 INFO - 'opt_config_files': (), 04:18:20 INFO - 'pip_index': False, 04:18:20 INFO - 'sps_profile': False, 04:18:20 INFO - 'sps_profile_interval': 0, 04:18:20 INFO - 'suite': 'dromaeojs-e10s', 04:18:20 INFO - 'system_bits': '32', 04:18:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:18:20 INFO - 'title': 'talos-linux64-ix-010', 04:18:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:18:20 INFO - 'use_talos_json': True, 04:18:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:18:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:18:20 INFO - 'work_dir': 'build'} 04:18:20 INFO - ##### 04:18:20 INFO - ##### Running clobber step. 04:18:20 INFO - ##### 04:18:20 INFO - Running pre-action listener: _resource_record_pre_action 04:18:20 INFO - Running main action method: clobber 04:18:20 INFO - rmtree: /builds/slave/test/build 04:18:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:18:21 INFO - Running post-action listener: _resource_record_post_action 04:18:21 INFO - ##### 04:18:21 INFO - ##### Finished clobber step (success) 04:18:21 INFO - ##### 04:18:21 INFO - ##### 04:18:21 INFO - ##### Running read-buildbot-config step. 04:18:21 INFO - ##### 04:18:21 INFO - Running pre-action listener: _resource_record_pre_action 04:18:21 INFO - Running main action method: read_buildbot_config 04:18:21 INFO - Using buildbot properties: 04:18:21 INFO - { 04:18:21 INFO - "project": "", 04:18:21 INFO - "product": "firefox", 04:18:21 INFO - "script_repo_revision": "production", 04:18:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:18:21 INFO - "repository": "", 04:18:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:18:21 INFO - "buildid": "20160602025649", 04:18:21 INFO - "pgo_build": "False", 04:18:21 INFO - "basedir": "/builds/slave/test", 04:18:21 INFO - "buildnumber": 333, 04:18:21 INFO - "slavename": "talos-linux64-ix-010", 04:18:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:18:21 INFO - "platform": "ubuntu64_hw", 04:18:21 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:18:21 INFO - "branch": "mozilla-central", 04:18:21 INFO - "repo_path": "mozilla-central", 04:18:21 INFO - "revision": "34a8be4346a9231e472fc36b1d7c0531e0fbf7c5", 04:18:21 INFO - "stage_platform": "linux64", 04:18:21 INFO - "builduid": "737e7d67d9cf4557a617980c392aad5e", 04:18:21 INFO - "slavebuilddir": "test" 04:18:21 INFO - } 04:18:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:18:21 INFO - Running post-action listener: _resource_record_post_action 04:18:21 INFO - ##### 04:18:21 INFO - ##### Finished read-buildbot-config step (success) 04:18:21 INFO - ##### 04:18:21 INFO - ##### 04:18:21 INFO - ##### Running download-and-extract step. 04:18:21 INFO - ##### 04:18:21 INFO - Running pre-action listener: _resource_record_pre_action 04:18:21 INFO - Running main action method: download_and_extract 04:18:21 INFO - mkdir: /builds/slave/test/build/tests 04:18: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')]} 04:18:21 INFO - https://queue.taskcluster.net/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:18:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:18:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:18:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/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 04:18:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/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 04:18:21 INFO - Downloaded 1361 bytes. 04:18:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:18:21 INFO - Using the following test package requirements: 04:18:21 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:18:21 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:18:21 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:18:21 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:21 INFO - u'jsshell-linux-x86_64.zip'], 04:18:21 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:18:21 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:18:21 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:18:21 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:18:21 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:18:21 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:18:21 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:18:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:18: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')]} 04:18:21 INFO - https://queue.taskcluster.net/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:18:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:18:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:18:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/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 04:18:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/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 04:18:23 INFO - Downloaded 22850457 bytes. 04:18:23 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'] 04:18:23 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 04:18:24 INFO - Return code: 0 04:18:24 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 04:18: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')]} 04:18:24 INFO - https://queue.taskcluster.net/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:18:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:18:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:18:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/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 04:18:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/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 04:18:26 INFO - Downloaded 22850457 bytes. 04:18:26 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'] 04:18:26 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 04:18:28 INFO - Return code: 0 04:18:28 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')]} 04:18:28 INFO - https://queue.taskcluster.net/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:18:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:18:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:18:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/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 04:18:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/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 04:18:30 INFO - Downloaded 10834055 bytes. 04:18:30 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'] 04:18:30 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 04:18:30 INFO - Return code: 0 04:18: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')]} 04:18:30 INFO - https://queue.taskcluster.net/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:18:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:18:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:18:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/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 04:18:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OhWcFBPSSoGAZx2bt15vlw/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 04:18:33 INFO - Downloaded 55084572 bytes. 04:18:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:18:33 INFO - mkdir: /builds/slave/test/properties 04:18:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:18:33 INFO - Writing to file /builds/slave/test/properties/build_url 04:18:33 INFO - Contents: 04:18:33 INFO - build_url:https://queue.taskcluster.net/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:18:34 INFO - Running post-action listener: _resource_record_post_action 04:18:34 INFO - Running post-action listener: set_extra_try_arguments 04:18:34 INFO - ##### 04:18:34 INFO - ##### Finished download-and-extract step (success) 04:18:34 INFO - ##### 04:18:34 INFO - ##### 04:18:34 INFO - ##### Running populate-webroot step. 04:18:34 INFO - ##### 04:18:34 INFO - Running pre-action listener: _resource_record_pre_action 04:18:34 INFO - Running main action method: populate_webroot 04:18:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:18:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:18:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:18:34 INFO - '--tppagecycles', 04:18:34 INFO - '7'], 04:18:34 INFO - 'tests': ['tsvgm']}}, 04:18:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:18:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:18:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:18:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:18:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:18:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:18:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:34 INFO - 'talos_options': ['--disable-e10s'], 04:18:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:18:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:18:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:34 INFO - 'talos_options': ['--disable-e10s'], 04:18:34 INFO - 'tests': ['damp', 'tps']}, 04:18:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:34 INFO - 'tests': ['damp', 'tps']}, 04:18:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:18:34 INFO - 'tests': ['dromaeo_dom']}, 04:18:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:18:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:18:34 INFO - 'tests': ['a11yr', 04:18:34 INFO - 'ts_paint', 04:18:34 INFO - 'tpaint', 04:18:34 INFO - 'sessionrestore', 04:18:34 INFO - 'sessionrestore_no_auto_restore', 04:18:34 INFO - 'tabpaint']}, 04:18:34 INFO - 'other-e10s': {'tests': ['a11yr', 04:18:34 INFO - 'ts_paint', 04:18:34 INFO - 'tpaint', 04:18:34 INFO - 'sessionrestore', 04:18:34 INFO - 'sessionrestore_no_auto_restore', 04:18:34 INFO - 'tabpaint']}, 04:18:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:18:34 INFO - 'ts_paint', 04:18:34 INFO - 'tpaint', 04:18:34 INFO - 'sessionrestore', 04:18:34 INFO - 'sessionrestore_no_auto_restore', 04:18:34 INFO - 'tabpaint']}, 04:18:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:18:34 INFO - 'ts_paint', 04:18:34 INFO - 'tpaint', 04:18:34 INFO - 'sessionrestore', 04:18:34 INFO - 'sessionrestore_no_auto_restore', 04:18:34 INFO - 'tabpaint']}, 04:18:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:18:34 INFO - 'tests': ['a11yr', 04:18:34 INFO - 'ts_paint', 04:18:34 INFO - 'tpaint', 04:18:34 INFO - 'sessionrestore', 04:18:34 INFO - 'sessionrestore_no_auto_restore', 04:18:34 INFO - 'tabpaint']}, 04:18:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:18:34 INFO - 'tests': ['a11yr', 04:18:34 INFO - 'ts_paint', 04:18:34 INFO - 'tpaint', 04:18:34 INFO - 'sessionrestore', 04:18:34 INFO - 'sessionrestore_no_auto_restore', 04:18:34 INFO - 'tabpaint']}, 04:18:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:18:34 INFO - 'tests': ['tsvgx', 04:18:34 INFO - 'tsvgr_opacity', 04:18:34 INFO - 'tart', 04:18:34 INFO - 'tscrollx', 04:18:34 INFO - 'cart']}, 04:18:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:18:34 INFO - 'tsvgr_opacity', 04:18:34 INFO - 'tart', 04:18:34 INFO - 'tscrollx', 04:18:34 INFO - 'cart']}, 04:18:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:34 INFO - 'talos_options': ['--disable-e10s'], 04:18:34 INFO - 'tests': ['tp5o']}, 04:18:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:34 INFO - 'tests': ['tp5o']}, 04:18:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:34 INFO - 'talos_options': ['--disable-e10s', 04:18:34 INFO - '--xperf_path', 04:18:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:18:34 INFO - 'tests': ['tp5n']}, 04:18:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:18:34 INFO - 'talos_options': ['--xperf_path', 04:18:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:18:34 INFO - 'tests': ['tp5n']}}, 04:18:34 INFO - 'talos.zip': {'path': '', 04:18:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:18:34 INFO - Running post-action listener: _resource_record_post_action 04:18:34 INFO - ##### 04:18:34 INFO - ##### Finished populate-webroot step (success) 04:18:34 INFO - ##### 04:18:34 INFO - ##### 04:18:34 INFO - ##### Running create-virtualenv step. 04:18:34 INFO - ##### 04:18:34 INFO - Running pre-action listener: _resource_record_pre_action 04:18:34 INFO - Running main action method: create_virtualenv 04:18:34 INFO - Creating virtualenv /builds/slave/test/build/venv 04:18:34 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 04:18:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:18:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:18:34 INFO - Using real prefix '/usr' 04:18:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:18:34 INFO - Installing distribute.............................................................................................................................................................................................done. 04:18:36 INFO - Installing pip.................done. 04:18:36 INFO - Return code: 0 04:18:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:18:36 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')]} 04:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:36 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')]} 04:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:36 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 0x7f79afb98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d659c0>, '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 0x1d668c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66d50>, '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': 'eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620', '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 04:18:36 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 04:18:36 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 04:18:36 INFO - Using env: {'DISPLAY': ':0', 04:18:36 INFO - 'HOME': '/home/cltbld', 04:18:36 INFO - 'LANG': 'en_US.UTF-8', 04:18:36 INFO - 'LANGUAGE': 'en_US:en', 04:18:36 INFO - 'LOGNAME': 'cltbld', 04:18:36 INFO - 'MAIL': '/var/mail/cltbld', 04:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:36 INFO - 'MOZ_NO_REMOTE': '1', 04:18:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:36 INFO - 'NO_EM_RESTART': '1', 04:18:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:36 INFO - 'PWD': '/builds/slave/test', 04:18:36 INFO - 'SHELL': '/bin/bash', 04:18:36 INFO - 'SHLVL': '1', 04:18:36 INFO - 'TERM': 'linux', 04:18:36 INFO - 'TMOUT': '86400', 04:18:36 INFO - 'USER': 'cltbld', 04:18:36 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620', 04:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:36 INFO - '_': '/tools/buildbot/bin/python'} 04:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:37 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 04:18:37 INFO - Cleaning up... 04:18:37 INFO - Return code: 0 04:18:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f79afb98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d659c0>, '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 0x1d668c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66d50>, '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': 'eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620', '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 04:18:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:18:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:18:37 INFO - Using env: {'DISPLAY': ':0', 04:18:37 INFO - 'HOME': '/home/cltbld', 04:18:37 INFO - 'LANG': 'en_US.UTF-8', 04:18:37 INFO - 'LANGUAGE': 'en_US:en', 04:18:37 INFO - 'LOGNAME': 'cltbld', 04:18:37 INFO - 'MAIL': '/var/mail/cltbld', 04:18:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:37 INFO - 'MOZ_NO_REMOTE': '1', 04:18:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:37 INFO - 'NO_EM_RESTART': '1', 04:18:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:37 INFO - 'PWD': '/builds/slave/test', 04:18:37 INFO - 'SHELL': '/bin/bash', 04:18:37 INFO - 'SHLVL': '1', 04:18:37 INFO - 'TERM': 'linux', 04:18:37 INFO - 'TMOUT': '86400', 04:18:37 INFO - 'USER': 'cltbld', 04:18:37 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620', 04:18:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:37 INFO - '_': '/tools/buildbot/bin/python'} 04:18:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:37 INFO - Downloading/unpacking psutil>=3.1.1 04:18: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 04:18: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 04:18: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 04:18: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 04:18: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 04:18: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 04:18:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:18:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:18:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:18:39 INFO - Installing collected packages: psutil 04:18:39 INFO - Running setup.py install for psutil 04:18:39 INFO - building 'psutil._psutil_linux' extension 04:18:39 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 04:18:39 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 04:18:39 INFO - building 'psutil._psutil_posix' extension 04:18:39 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 04:18:39 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 04:18:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:18:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:18:39 INFO - Successfully installed psutil 04:18:39 INFO - Cleaning up... 04:18:39 INFO - Return code: 0 04:18:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:18: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')]} 04:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18: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')]} 04:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f79afb98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d659c0>, '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 0x1d668c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66d50>, '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': 'eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620', '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 04:18:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:18:39 INFO - Using env: {'DISPLAY': ':0', 04:18:39 INFO - 'HOME': '/home/cltbld', 04:18:39 INFO - 'LANG': 'en_US.UTF-8', 04:18:39 INFO - 'LANGUAGE': 'en_US:en', 04:18:39 INFO - 'LOGNAME': 'cltbld', 04:18:39 INFO - 'MAIL': '/var/mail/cltbld', 04:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:39 INFO - 'MOZ_NO_REMOTE': '1', 04:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:39 INFO - 'NO_EM_RESTART': '1', 04:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:39 INFO - 'PWD': '/builds/slave/test', 04:18:39 INFO - 'SHELL': '/bin/bash', 04:18:39 INFO - 'SHLVL': '1', 04:18:39 INFO - 'TERM': 'linux', 04:18:39 INFO - 'TMOUT': '86400', 04:18:39 INFO - 'USER': 'cltbld', 04:18:39 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620', 04:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:39 INFO - '_': '/tools/buildbot/bin/python'} 04:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:18:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:18:41 INFO - Installing collected packages: mozsystemmonitor 04:18:41 INFO - Running setup.py install for mozsystemmonitor 04:18:42 INFO - Successfully installed mozsystemmonitor 04:18:42 INFO - Cleaning up... 04:18:42 INFO - Return code: 0 04:18:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:18: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')]} 04:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18: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')]} 04:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f79afb98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d659c0>, '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 0x1d668c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66d50>, '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': 'eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620', '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 04:18:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:18:42 INFO - Using env: {'DISPLAY': ':0', 04:18:42 INFO - 'HOME': '/home/cltbld', 04:18:42 INFO - 'LANG': 'en_US.UTF-8', 04:18:42 INFO - 'LANGUAGE': 'en_US:en', 04:18:42 INFO - 'LOGNAME': 'cltbld', 04:18:42 INFO - 'MAIL': '/var/mail/cltbld', 04:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:42 INFO - 'MOZ_NO_REMOTE': '1', 04:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:42 INFO - 'NO_EM_RESTART': '1', 04:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:42 INFO - 'PWD': '/builds/slave/test', 04:18:42 INFO - 'SHELL': '/bin/bash', 04:18:42 INFO - 'SHLVL': '1', 04:18:42 INFO - 'TERM': 'linux', 04:18:42 INFO - 'TMOUT': '86400', 04:18:42 INFO - 'USER': 'cltbld', 04:18:42 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620', 04:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:42 INFO - '_': '/tools/buildbot/bin/python'} 04:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:42 INFO - Downloading/unpacking blobuploader==1.2.4 04:18:42 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 04:18:42 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 04:18:42 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 04:18:42 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 04:18:42 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 04:18:42 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 04:18:44 INFO - Downloading blobuploader-1.2.4.tar.gz 04:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:18:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:18:44 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 04:18:44 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 04:18:44 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 04:18:44 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 04:18:44 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 04:18:44 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 04:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:18:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:18:44 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 04:18:44 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 04:18:44 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 04:18:44 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 04:18:44 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 04:18:44 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 04:18:44 INFO - Downloading docopt-0.6.1.tar.gz 04:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:18:44 INFO - Installing collected packages: blobuploader, requests, docopt 04:18:44 INFO - Running setup.py install for blobuploader 04:18:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:18:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:18:45 INFO - Running setup.py install for requests 04:18:45 INFO - Running setup.py install for docopt 04:18:45 INFO - Successfully installed blobuploader requests docopt 04:18:45 INFO - Cleaning up... 04:18:45 INFO - Return code: 0 04:18:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:45 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 0x7f79afb98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d659c0>, '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 0x1d668c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66d50>, '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': 'eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620', '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 04:18:45 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 04:18:45 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 04:18:45 INFO - Using env: {'DISPLAY': ':0', 04:18:45 INFO - 'HOME': '/home/cltbld', 04:18:45 INFO - 'LANG': 'en_US.UTF-8', 04:18:45 INFO - 'LANGUAGE': 'en_US:en', 04:18:45 INFO - 'LOGNAME': 'cltbld', 04:18:45 INFO - 'MAIL': '/var/mail/cltbld', 04:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:45 INFO - 'MOZ_NO_REMOTE': '1', 04:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:45 INFO - 'NO_EM_RESTART': '1', 04:18:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:45 INFO - 'PWD': '/builds/slave/test', 04:18:45 INFO - 'SHELL': '/bin/bash', 04:18:45 INFO - 'SHLVL': '1', 04:18:45 INFO - 'TERM': 'linux', 04:18:45 INFO - 'TMOUT': '86400', 04:18:45 INFO - 'USER': 'cltbld', 04:18:45 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620', 04:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:45 INFO - '_': '/tools/buildbot/bin/python'} 04:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:18:45 INFO - Running setup.py (path:/tmp/pip-WEpiBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:18:45 INFO - Running setup.py (path:/tmp/pip-ZNpzx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:18:45 INFO - Running setup.py (path:/tmp/pip-PK7xYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:18:46 INFO - Running setup.py (path:/tmp/pip-Kpd7ZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:18:46 INFO - Running setup.py (path:/tmp/pip-_ZENiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:18:46 INFO - Running setup.py (path:/tmp/pip-oxM6aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:18:46 INFO - Running setup.py (path:/tmp/pip-qJ38T0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:18:46 INFO - Running setup.py (path:/tmp/pip-b6Y90d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:18:46 INFO - Running setup.py (path:/tmp/pip-ZD_718-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:18:46 INFO - Running setup.py (path:/tmp/pip-ACL25U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:18:46 INFO - Running setup.py (path:/tmp/pip-wtcrCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:18:46 INFO - Running setup.py (path:/tmp/pip-ndtR27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:18:46 INFO - Running setup.py (path:/tmp/pip-HVSPgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:18:46 INFO - Running setup.py (path:/tmp/pip-2RXJiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:46 INFO - Running setup.py (path:/tmp/pip-67C7A4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:18:46 INFO - Running setup.py (path:/tmp/pip-wxj6kC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:18:46 INFO - Running setup.py (path:/tmp/pip-iFI_XZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:18:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:18:46 INFO - Running setup.py install for manifestparser 04:18:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:18:47 INFO - Running setup.py install for mozcrash 04:18:47 INFO - Running setup.py install for mozdebug 04:18:47 INFO - Running setup.py install for mozdevice 04:18:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:18:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:18:47 INFO - Running setup.py install for mozfile 04:18:47 INFO - Running setup.py install for mozhttpd 04:18:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:18:47 INFO - Running setup.py install for mozinfo 04:18:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:18:47 INFO - Running setup.py install for mozInstall 04:18:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:18:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:18:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:18:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:18:47 INFO - Running setup.py install for mozleak 04:18:47 INFO - Running setup.py install for mozlog 04:18:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:18:48 INFO - Running setup.py install for moznetwork 04:18:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:18:48 INFO - Running setup.py install for mozprocess 04:18:48 INFO - Running setup.py install for mozprofile 04:18:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:18:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:18:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:18:48 INFO - Running setup.py install for mozrunner 04:18:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:18:48 INFO - Running setup.py install for mozscreenshot 04:18:48 INFO - Running setup.py install for moztest 04:18:48 INFO - Running setup.py install for mozversion 04:18:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:18:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:18:48 INFO - Cleaning up... 04:18:48 INFO - Return code: 0 04:18:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18: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')]} 04:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18: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')]} 04:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:48 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 0x7f79afb98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d659c0>, '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 0x1d668c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66d50>, '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': 'eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620', '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 04:18:48 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 04:18:48 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 04:18:48 INFO - Using env: {'DISPLAY': ':0', 04:18:48 INFO - 'HOME': '/home/cltbld', 04:18:48 INFO - 'LANG': 'en_US.UTF-8', 04:18:48 INFO - 'LANGUAGE': 'en_US:en', 04:18:48 INFO - 'LOGNAME': 'cltbld', 04:18:48 INFO - 'MAIL': '/var/mail/cltbld', 04:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:48 INFO - 'MOZ_NO_REMOTE': '1', 04:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:48 INFO - 'NO_EM_RESTART': '1', 04:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:48 INFO - 'PWD': '/builds/slave/test', 04:18:48 INFO - 'SHELL': '/bin/bash', 04:18:48 INFO - 'SHLVL': '1', 04:18:48 INFO - 'TERM': 'linux', 04:18:48 INFO - 'TMOUT': '86400', 04:18:48 INFO - 'USER': 'cltbld', 04:18:48 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620', 04:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:48 INFO - '_': '/tools/buildbot/bin/python'} 04:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:18:49 INFO - Running setup.py (path:/tmp/pip-CYIstM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:18:49 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)) 04:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:18:49 INFO - Running setup.py (path:/tmp/pip-e2MYU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:18:49 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)) 04:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:18:49 INFO - Running setup.py (path:/tmp/pip-MM4P0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:18:49 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)) 04:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:18:49 INFO - Running setup.py (path:/tmp/pip-6DjUIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:18:49 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)) 04:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:18:49 INFO - Running setup.py (path:/tmp/pip-FVakZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:18:49 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)) 04:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:18:49 INFO - Running setup.py (path:/tmp/pip-AOmxt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:18:49 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)) 04:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:18:49 INFO - Running setup.py (path:/tmp/pip-qGlA_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:18:49 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)) 04:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:18:49 INFO - Running setup.py (path:/tmp/pip-3q1uGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:18:49 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)) 04:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:18:49 INFO - Running setup.py (path:/tmp/pip-TEMNQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:18:49 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)) 04:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:18:49 INFO - Running setup.py (path:/tmp/pip-_DiARh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:18:49 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)) 04:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:18:49 INFO - Running setup.py (path:/tmp/pip-H8XQiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:18:49 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)) 04:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:18:49 INFO - Running setup.py (path:/tmp/pip-azQ_MX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:18:49 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)) 04:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:18:49 INFO - Running setup.py (path:/tmp/pip-n7EDZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:18:49 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)) 04:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:18:49 INFO - Running setup.py (path:/tmp/pip-qKh3ZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:18:50 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)) 04:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:50 INFO - Running setup.py (path:/tmp/pip-gijXd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:18:50 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)) 04:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:18:50 INFO - Running setup.py (path:/tmp/pip-bFcBu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:18:50 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)) 04:18:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:18:50 INFO - Running setup.py (path:/tmp/pip-6aVKIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:18:50 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)) 04:18:50 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)) 04:18:50 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)) 04:18:50 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)) 04:18:50 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)) 04:18:50 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)) 04:18:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:52 INFO - Downloading blessings-1.6.tar.gz 04:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:18:52 INFO - Installing collected packages: blessings 04:18:52 INFO - Running setup.py install for blessings 04:18:52 INFO - Successfully installed blessings 04:18:52 INFO - Cleaning up... 04:18:52 INFO - Return code: 0 04:18:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:18:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:18:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:18:52 INFO - Reading from file tmpfile_stdout 04:18:52 INFO - Current package versions: 04:18:52 INFO - argparse == 1.2.1 04:18:52 INFO - blessings == 1.6 04:18:52 INFO - blobuploader == 1.2.4 04:18:52 INFO - docopt == 0.6.1 04:18:52 INFO - manifestparser == 1.1 04:18:52 INFO - mozInstall == 1.12 04:18:52 INFO - mozcrash == 0.17 04:18:52 INFO - mozdebug == 0.1 04:18:52 INFO - mozdevice == 0.48 04:18:52 INFO - mozfile == 1.2 04:18:52 INFO - mozhttpd == 0.7 04:18:52 INFO - mozinfo == 0.9 04:18:52 INFO - mozleak == 0.1 04:18:52 INFO - mozlog == 3.2 04:18:52 INFO - moznetwork == 0.27 04:18:52 INFO - mozprocess == 0.22 04:18:52 INFO - mozprofile == 0.28 04:18:52 INFO - mozrunner == 6.11 04:18:52 INFO - mozscreenshot == 0.1 04:18:52 INFO - mozsystemmonitor == 0.3 04:18:52 INFO - moztest == 0.7 04:18:52 INFO - mozversion == 1.4 04:18:52 INFO - psutil == 3.1.1 04:18:52 INFO - requests == 1.2.3 04:18:52 INFO - wsgiref == 0.1.2 04:18:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:52 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 0x7f79afb98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d659c0>, '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 0x1d668c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66d50>, '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': 'eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620', '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 04:18:52 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 04:18:52 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 04:18:52 INFO - Using env: {'DISPLAY': ':0', 04:18:52 INFO - 'HOME': '/home/cltbld', 04:18:52 INFO - 'LANG': 'en_US.UTF-8', 04:18:52 INFO - 'LANGUAGE': 'en_US:en', 04:18:52 INFO - 'LOGNAME': 'cltbld', 04:18:52 INFO - 'MAIL': '/var/mail/cltbld', 04:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:52 INFO - 'MOZ_NO_REMOTE': '1', 04:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:52 INFO - 'NO_EM_RESTART': '1', 04:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:52 INFO - 'PWD': '/builds/slave/test', 04:18:52 INFO - 'SHELL': '/bin/bash', 04:18:52 INFO - 'SHLVL': '1', 04:18:52 INFO - 'TERM': 'linux', 04:18:52 INFO - 'TMOUT': '86400', 04:18:52 INFO - 'USER': 'cltbld', 04:18:52 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620', 04:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:52 INFO - '_': '/tools/buildbot/bin/python'} 04:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:52 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)) 04:18:52 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)) 04:18:52 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)) 04:18:52 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)) 04:18:52 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)) 04:18:52 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)) 04:18:52 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)) 04:18:52 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)) 04:18:52 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)) 04:18:52 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)) 04:18:52 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)) 04:18:52 INFO - Cleaning up... 04:18:52 INFO - Return code: 0 04:18:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:52 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 0x7f79afb98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d659c0>, '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 0x1d668c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66d50>, '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': 'eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620', '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 04:18:52 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 04:18:52 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 04:18:52 INFO - Using env: {'DISPLAY': ':0', 04:18:52 INFO - 'HOME': '/home/cltbld', 04:18:52 INFO - 'LANG': 'en_US.UTF-8', 04:18:52 INFO - 'LANGUAGE': 'en_US:en', 04:18:52 INFO - 'LOGNAME': 'cltbld', 04:18:52 INFO - 'MAIL': '/var/mail/cltbld', 04:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:52 INFO - 'MOZ_NO_REMOTE': '1', 04:18:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:52 INFO - 'NO_EM_RESTART': '1', 04:18:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:52 INFO - 'PWD': '/builds/slave/test', 04:18:52 INFO - 'SHELL': '/bin/bash', 04:18:52 INFO - 'SHLVL': '1', 04:18:52 INFO - 'TERM': 'linux', 04:18:52 INFO - 'TMOUT': '86400', 04:18:52 INFO - 'USER': 'cltbld', 04:18:52 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620', 04:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:52 INFO - '_': '/tools/buildbot/bin/python'} 04:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:53 INFO - Downloading/unpacking jsonschema 04:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:18:54 INFO - Downloading/unpacking functools32 (from jsonschema) 04:18:54 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 04:18:54 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 04:18:54 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 04:18:54 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 04:18:54 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 04:18:54 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 04:18:55 INFO - Downloading functools32-3.2.3-2.tar.gz 04:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:18:55 INFO - warning: no files found matching '*.txt' 04:18:55 INFO - no previously-included directories found matching 'build' 04:18:55 INFO - no previously-included directories found matching 'dist' 04:18:55 INFO - no previously-included directories found matching '.git*' 04:18:55 INFO - Installing collected packages: jsonschema, functools32 04:18:55 INFO - Running setup.py install for functools32 04:18:55 INFO - warning: no files found matching '*.txt' 04:18:55 INFO - no previously-included directories found matching 'build' 04:18:55 INFO - no previously-included directories found matching 'dist' 04:18:55 INFO - no previously-included directories found matching '.git*' 04:18:55 INFO - Successfully installed jsonschema functools32 04:18:55 INFO - Cleaning up... 04:18:55 INFO - Return code: 0 04:18:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:18:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f79afb98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cd6770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d659c0>, '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 0x1d668c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66d50>, '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': 'eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620', '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 04:18:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:18:55 INFO - Using env: {'DISPLAY': ':0', 04:18:55 INFO - 'HOME': '/home/cltbld', 04:18:55 INFO - 'LANG': 'en_US.UTF-8', 04:18:55 INFO - 'LANGUAGE': 'en_US:en', 04:18:55 INFO - 'LOGNAME': 'cltbld', 04:18:55 INFO - 'MAIL': '/var/mail/cltbld', 04:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:55 INFO - 'MOZ_NO_REMOTE': '1', 04:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:18:55 INFO - 'NO_EM_RESTART': '1', 04:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:55 INFO - 'PWD': '/builds/slave/test', 04:18:55 INFO - 'SHELL': '/bin/bash', 04:18:55 INFO - 'SHLVL': '1', 04:18:55 INFO - 'TERM': 'linux', 04:18:55 INFO - 'TMOUT': '86400', 04:18:55 INFO - 'USER': 'cltbld', 04:18:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620', 04:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:55 INFO - '_': '/tools/buildbot/bin/python'} 04:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:18:55 INFO - Downloading/unpacking flake8 04:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:18:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:18:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:18:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:18:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:18:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:18:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:18:58 INFO - no previously-included directories found matching 'docs/_build' 04:18:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:18:58 INFO - Running setup.py install for pep8 04:18:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:18:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:18:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:18:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:18:58 INFO - no previously-included directories found matching 'docs/_build' 04:18:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:18:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:18:58 INFO - Cleaning up... 04:18:58 INFO - Return code: 0 04:18:58 INFO - Running post-action listener: _resource_record_post_action 04:18:58 INFO - Running post-action listener: _start_resource_monitoring 04:18:58 INFO - Starting resource monitoring. 04:18:58 INFO - ##### 04:18:58 INFO - ##### Finished create-virtualenv step (success) 04:18:58 INFO - ##### 04:18:58 INFO - ##### 04:18:58 INFO - ##### Running install step. 04:18:58 INFO - ##### 04:18:58 INFO - Running pre-action listener: _resource_record_pre_action 04:18:58 INFO - Running main action method: install 04:18:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:18:58 INFO - Reading from file tmpfile_stdout 04:18:58 INFO - Detecting whether we're running mozinstall >=1.0... 04:18:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:18:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:18:58 INFO - Reading from file tmpfile_stdout 04:18:58 INFO - Output received: 04:18:58 INFO - Usage: mozinstall [options] installer 04:18:58 INFO - Options: 04:18:58 INFO - -h, --help show this help message and exit 04:18:58 INFO - -d DEST, --destination=DEST 04:18:58 INFO - Directory to install application into. [default: 04:18:58 INFO - "/builds/slave/test"] 04:18:58 INFO - --app=APP Application being installed. [default: firefox] 04:18:58 INFO - mkdir: /builds/slave/test/build/application 04:18:58 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'] 04:18:58 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 04:19:14 INFO - Reading from file tmpfile_stdout 04:19:14 INFO - Output received: 04:19:14 INFO - /builds/slave/test/build/application/firefox/firefox 04:19:14 INFO - Running post-action listener: _resource_record_post_action 04:19:14 INFO - ##### 04:19:14 INFO - ##### Finished install step (success) 04:19:14 INFO - ##### 04:19:14 INFO - ##### 04:19:14 INFO - ##### Running run-tests step. 04:19:14 INFO - ##### 04:19:14 INFO - Running pre-action listener: _resource_record_pre_action 04:19:14 INFO - Running main action method: run_tests 04:19:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:19:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:19:14 INFO - Python 2.7.3 04:19:14 INFO - Return code: 0 04:19:14 INFO - grabbing minidump binary from tooltool 04:19:14 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')]} 04:19:14 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 0x1d659c0>, '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 0x1d668c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d66d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:19:14 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 04:19:14 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 04:19:14 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 04:19:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:19:14 INFO - Return code: 0 04:19:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:19:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:19:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:19:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:19:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:19:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:19:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:19:15 INFO - Return code: 0 04:19:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 04:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 04:19:15 INFO - Using env: {'DISPLAY': ':0', 04:19:15 INFO - 'HOME': '/home/cltbld', 04:19:15 INFO - 'LANG': 'en_US.UTF-8', 04:19:15 INFO - 'LANGUAGE': 'en_US:en', 04:19:15 INFO - 'LOGNAME': 'cltbld', 04:19:15 INFO - 'MAIL': '/var/mail/cltbld', 04:19:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:19:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:15 INFO - 'MOZ_NO_REMOTE': '1', 04:19:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:15 INFO - 'NO_EM_RESTART': '1', 04:19:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:15 INFO - 'PWD': '/builds/slave/test', 04:19:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:19:15 INFO - 'SHELL': '/bin/bash', 04:19:15 INFO - 'SHLVL': '1', 04:19:15 INFO - 'TERM': 'linux', 04:19:15 INFO - 'TMOUT': '86400', 04:19:15 INFO - 'USER': 'cltbld', 04:19:15 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620', 04:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:15 INFO - '_': '/tools/buildbot/bin/python'} 04:19:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 04:19:15 INFO - mozversion application_buildid: 20160602025649 04:19:15 INFO - mozversion application_changeset: 34a8be4346a9231e472fc36b1d7c0531e0fbf7c5 04:19:15 INFO - mozversion application_display_name: Nightly 04:19:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:19:15 INFO - mozversion application_name: Firefox 04:19:15 INFO - mozversion application_remotingname: firefox 04:19:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:19:15 INFO - mozversion application_vendor: Mozilla 04:19:15 INFO - mozversion application_version: 49.0a1 04:19:15 INFO - mozversion platform_buildid: 20160602025649 04:19:15 INFO - mozversion platform_changeset: 34a8be4346a9231e472fc36b1d7c0531e0fbf7c5 04:19:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:19:15 INFO - mozversion platform_version: 49.0a1 04:19:15 INFO - using testdate: 1464866355 04:19:15 INFO - actual date: 1464866355 04:19:15 INFO - starting webserver on 'localhost:50565' 04:19:15 INFO - SUITE-START | Running 2 tests 04:19:15 INFO - TEST-START | dromaeo_css 04:19:15 INFO - operating with platform_type : linux_ 04:19:15 INFO - Initialising browser for dromaeo_css test... 04:19:15 INFO - TEST-INFO | started process 16304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFNc7Eh/profile http://localhost:50565/getInfo.html) 04:19:21 INFO - PROCESS | 16304 | __metrics Screen width/height:1600/1200 04:19:21 INFO - PROCESS | 16304 | colorDepth:24 04:19:21 INFO - PROCESS | 16304 | Browser inner width/height: 1024/697 04:19:21 INFO - PROCESS | 16304 | __metrics 04:19:21 ERROR - PROCESS | 16304 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:19:22 INFO - TEST-INFO | 16304: exit 0 04:19:22 INFO - Browser initialized. 04:19:22 INFO - Running cycle 1/1 for dromaeo_css test... 04:19:22 INFO - TEST-INFO | started process 16426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFNc7Eh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:19:34 INFO - PROCESS | 16426 | RSS: Main: 168226816 04:19:34 INFO - PROCESS | 16426 | 04:20:24 INFO - PROCESS | 16426 | 1464866424509 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] 04:22:35 INFO - PROCESS | 16426 | Cycle 1(1): loaded http://localhost:50565/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50565/tests/dromaeo/cssquery-ext.html) 04:22:36 INFO - PROCESS | 16426 | RSS: Main: 171024384 04:22:36 INFO - PROCESS | 16426 | 04:25:38 INFO - PROCESS | 16426 | Cycle 1(1): loaded http://localhost:50565/tests/dromaeo/cssquery-ext.html (next: http://localhost:50565/tests/dromaeo/cssquery-jquery.html) 04:25:39 INFO - PROCESS | 16426 | RSS: Main: 169304064 04:25:39 INFO - PROCESS | 16426 | 04:28:41 INFO - PROCESS | 16426 | Cycle 1(1): loaded http://localhost:50565/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50565/tests/dromaeo/cssquery-mootools.html) 04:28:42 INFO - PROCESS | 16426 | RSS: Main: 170078208 04:28:42 INFO - PROCESS | 16426 | 04:31:44 INFO - PROCESS | 16426 | Cycle 1(1): loaded http://localhost:50565/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50565/tests/dromaeo/cssquery-prototype.html) 04:31:44 INFO - PROCESS | 16426 | RSS: Main: 167968768 04:31:44 INFO - PROCESS | 16426 | 04:34:47 INFO - PROCESS | 16426 | Cycle 1(1): loaded http://localhost:50565/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50565/tests/dromaeo/cssquery-yui.html) 04:34:48 INFO - PROCESS | 16426 | RSS: Main: 170651648 04:34:48 INFO - PROCESS | 16426 | 04:37:50 INFO - PROCESS | 16426 | Cycle 1(1): loaded http://localhost:50565/tests/dromaeo/cssquery-yui.html (next: http://localhost:50565/tests/dromaeo/cssquery-dojo.html) 04:37:51 INFO - PROCESS | 16426 | RSS: Main: 172216320 04:37:51 INFO - PROCESS | 16426 | 04:37:51 INFO - PROCESS | 16426 | __start_tp_report 04:37:51 INFO - PROCESS | 16426 | _x_x_mozilla_page_load 04:37:51 INFO - PROCESS | 16426 | _x_x_mozilla_page_load_details 04:37:51 INFO - PROCESS | 16426 | |i|pagename|runs| 04:37:51 INFO - PROCESS | 16426 | |0;dojo.html;2622.344413896526;2667.746564076412;2677.6519052523167;2683.51696694595;2691.7442842929927;4628.398308219931;4660.044690838375;4672.906541869165;4739.90520189596;4779.90440191196;4632.791524381402;4669.6731228814;4690.57784799368;4693.155232058228;4694.976525117369;4265.829366825331;4336.3278691802825;4359.978200108995;4376.496702879162;4380.605745482906;676.12053881319;4273.803335066186;4284.100338928829;4315.374270730742;4347.108842687241;4338.696291259613;4365.323374876899;4398.824047038114;4406.405135306724;4452.599266066037;4309.82760689572;4364.127174565068;4414.55854414556;4418.182636212311;4426.579474949875;4296.785160741982;4329.523752387235;4331.7184383015;4384.408104905829;4385.232584297735;4664.440267167927;4696.342512048316;4715.1512727709;4720.3863497745415;4733.83431579893;4830.468648448667;5010.599152067826;5037.319961805146;5073.822416215452;5083.21210212414;4978.950210497885;5075.213341932006;5076.06092872816;5077.289179514871;5121.897562048738;4688.7186768793645;4692.859214223578;4695.084458530622;4739.431268247832;4807.807687692488;5046.394432668103;5138.614603904647;5160.870978225575;5163.342957876471;5231.0584094862525;4941.75291235444;4963.726995015237;4977.253411988231;4978.950210497848;5007.899842003139;5055.317532133115;5057;5062.316587260672;5067;5111.923321150186;4880.438749543848;5011.223260394645;5058.114829904752;5062.898742025139;5077.619178561623;5058.645894787403;5071.4928507149725;5082.949170508247;5094.49055094495;5117.334746482933;4277.721948073366;4290.742555446684;4291.806868690916;4295.591918767712;4340.327249276304;3638.290533345972;3663.19409729859;3704.4258139988347;3724.7020238381406;3763.9623603764157;4369.737815731066;4397.2085024695225;4404.493483249404;4452.5992660660695;4484;5093.847184584469;5105.055564720538;5107.591392688576;5107.97446012775;5108.591312694975;4329.480462344539;4419.955800442019;4455.821767129343;4458.598726114666;4476.798544065525;4548.522405147478;4556.066006468666;4556.11155824611;4611.239145541015;4612.907741845144;4702.788374523223;4837.95162048375;4845.6123510119105;4847.175980083394;4848.393950756155;5061.9493805061475;5119.283300337881;5130.153524668388;5150.6137039721425;5152.536271735562;4815.518448155157;4828.589569886459;4851.102546028996;4853.150698627796;4874.439439464365;4912.901741965212;5006.249062640633;5050.444451110448;5069.340985671839;5098.668586541863;5104.719240441811;5156.04613146569;5180.48195180479;5183.481651834786;5236.816711415082;5009.474005229544;5010.323606313101;5012.649114561946;5029.622778291569;5072.112380333353;4861.611071114373;4918.631102667243;4951.900961980812;5020.548150666457;5034.572061374824;4887.731174785279;4903;4915.1644220481885;4928.975355123202;4941.258811178352;5044.747762611928;5048.293238946624;5049.495050494921;5055.924161137659;5063.1645778446145;4744.881377965578;4768.61851051922;4778.04439112172;4805.543473370024;4957.950420495893 04:37:51 INFO - PROCESS | 16426 | |1;ext.html;533.5437449510606;588.2646691635456;590.3801008940613;595.7706283081014;615.3692465223148;35198.472022919676;39528;39549.209015819666;39605.80197099014;39630.80184599073;40355.79822100885;40810.795946020306;40928.795356023176;41087.383689244685;41104.38343424851;7681.7695469136015;7866.724664636738;7925.722599709012;7926;7947.602619868983;7721.922780772176;7804.570748608824;7814.921850781477;7844.921550784505;7845.490043147177;7802.804929876742;7843.33331666809;7844.921550784505;7874.212578742108;7878.212178782133;7750.069991601016;7811.687532498693;7812.375009999215;7814.804629884242;7839.96080019602;7682.0781506219055;7830.530168189927;7832.451728379016;7843.647035883342;7848.058233012018;30100.8494957526;36775;37005.629943700485;37119.4432083519;37228.25543489142;2891.8577162020883;3051.2219384056925;3089.938201235963;3286.424875646776;3489.1974845785358;27981.44037119246;28263;28362.71637283642;28480.287992800346;28734.281642959093;3188.4260833050043;3226.9838650806596;3317.1872891141584;3361.1765117546115;3368.562086928708;273463;273545;275097;276068;276268;55879.441205588235;56782.71608642013;57009.14486282709;57110;57167.71416142893;33852.32295354128;34816.30367392638;35066.12334691653;60343.39656603378;60562;13294.20234785916;13419.127756695783;13446.260455674836;13467.932660336635;13536.796948045787;11907.106966977339;12082.456289466994;12120.27278363301;12122.09084318662;12123.45444454984;19095.90452047731;19136.61726765485;19187.616247675247;19212.8078719211;19241.711374329396;7036.753713620101;7147.3210045045635;7261.989227433054;7272.163701174327;7385.335319821242;886.2821114896955;906.1889608800219;960.1214888377197;985.9507024648739;994.915542059159;27660.308492287855;29282;29429.411411772075;30419.543706844415;31061.378772424425;955.8422860228123;1006.7030226083323;1027.034587487774;1031.1029404418055;1073.968989769814;14919.40322387114;14952.177630230442;15218.315175817115;15319;15427.5371738848;384016;384098;384645;387735;389629;51347.48652513502;51864.22203666948;51895.74052129715;51945.220821687704;51949.22076168861;1227.2391117507025;1263.9368031598383;1274.955376561816;1276.3554405025588;1277.482619539088;27454.725452745217;28688.569671455363;28773.856130719214;28847.423051538433;29034.564481533216;44591.55408445874;44906.326405104606;45315.32027019531;45340.77329613331;45368.09263814771;356115;358501;359999;360767;361012;25238.873805630854;25485.23544293674;26478.338041549116;26608.866955665097;27674;41927.37108943307;42155.789221053696;42540.36189457223;43050;43633.56366436422;36541.634583654886;36551.665846298034;36672.63327366799;36806;37029.44455833219;34885.65114348824;36734.8163259182;36815.81592092022;36826.26347473089;37128;35237.64762352344;35641.46537801987;35998;36263.63736362708;36631.08422289464;31249.8437507811;32738.181545461553;32778.18054548655;33289.334213316084;33390.499142512395;25288.62067069032;25566.61650075213;25753.742462575883;25828.35429114287;25903.0933917312 04:37:51 INFO - PROCESS | 16426 | |2;jquery.html;379.5786676788764;381.0701887394757;381.7041145311667;393.22730833911356;395.42663138449257;15420.228988550569;16991.57521061974;17074.573135671613;17597.824021759778;17630.911845440773;16940.871472729094;16954.745678814827;17024.148792560354;17447.91276043618;17491.125443727826;4728.929066064012;4869.4887036861155;4884.340614017097;4888.169011268093;4889.437714662824;3624.4925710400566;5617.606767526275;5955.076963070731;5960.910586341209;6038.818835434922;5717.742701578439;5933.7242492864025;5949.85125371867;5970.044792833148;5989.6406215626985;5822.214001109838;5867.413258674141;5880.411958804107;5911.674857882815;5917.053271476565;5049.141645920203;5064.012517559077;5129.281900533928;5167.715775632339;5177.948220517822;20004.099815508336;20442.182312707475;20687.896560517253;20772.48068798277;20804.271850485162;1981.5937732764748;1988.125224901039;2109.8312135029314;2211.9336419907427;2568.488072052108;11470.598529051444;13240.470381184741;13394.129381590166;13767.518136865161;13811.17132972025;1695.652391259801;1695.9152042397832;1699.728043513032;1751.0894334945883;1756.6398888227882;64396;65806.3419365805;68253.65873170651;68421;69168.6541567294;10189.847152292721;10198.898011019943;10363.11913487347;10404.68785936423;11190.720231994264;13980.231087290296;14059;14071.929640351733;14170.929145354206;14171.945067965293;7439.218882017419;7643;7680.731174408869;7736.381089512825;7784.766457006299;7246.565206087546;7326.816829579303;7494.40044796415;7507.061617297838;7540.302385663193;4398.912021759611;4439.511653718088;4454.153710794939;4481.910361792746;4484.2376795944765;1746.1531157388656;1798.5233913013062;1891.1300801631128;1904.7809202447818;1943.2712732725229;796.1361922314238;918.0039656972126;956.6651671914774;961.9230461563059;983.0709979069853;16436;16461.34154633825;16483.83516164847;16848.64119023338;17152.742708859376;902.4630344944748;916.3036092569695;917.5228880981851;936.5270538378076;978.7748817771952;9383;9521.381110227812;10197.592096316064;10279.897201027894;10290.485475726184;360224;365656;367529;372272;372458;46614.300785488245;48098.5190148101;76791.61604192056;77353;78154.60922695464;956.0821611253136;974.6247694637616;983.9508024598885;994.5176589354157;999.7800483893532;15699.293531791325;15701.214939253221;15706.842931570538;15749.29128189257;16000.599985000468;28248.71751282461;32452.864149754645;35594.46608300826;38133.237335253696;38133.427998579486;49783.751081244365;50476;52031.73984130055;52260.21609675782;52677.473225267255;7419.962900185465;7465.701371945279;7534.133574638987;7710.383169346551;7713.4600577959;10029.849552256868;10752.462376881282;10937.945310273715;11092.280696492056;11213.887861121611;6115.990861507979;9235.15296940628;9482.146606805421;9842.557084931339;9987.25095617817;9835.131325048218;9889.950550247202;9950.601975920883;10253.538590763583;10402.635907743193;9958.601655933682;9961.651342203279;10035;10144.543495542866;10344.120749736056;7398.704051838082;7423.591702456417;7658.885116723365;7701.229877012254;7830.491018083806;7710.267524585155;9917.30578859473;9962.452065136196;10153.64462243818;10231.744206394602 04:37:51 INFO - PROCESS | 16426 | |3;mootools.html;1194.528161376256;1234.839470868787;1326.8076128961297;1739.4781565530338;1762.903040332781;6709.329067093288;7248.7825365239;7324.890126648098;7825;7825.765227043191;7465.813354666136;7638.12161601416;7653.464257501977;7692.423068269874;7740.419468539868;2047.9897600512013;2073.554185850042;2079.9584008319825;2080.625487412265;2081.458820706612;2126.245847176075;2136.807687308142;2146.37755051035;2156.708844306022;2165.545235500547;2188.1356864038776;2203.3389983005113;2211.181862710799;2214.059024914413;2236.206146817881;2114.4713821544537;2127.393692797553;2129.5208578069964;2130.4780328819384;2138.6791981202787;2058.053295484079;2108.95782084359;2110;2131.4245153808383;2151.279321427324;7339.88990165148;7348;7378.188399276075;7405.7778266652085;7407.444441666897;4342;4408.316710909814;4431.290993441034;4434.977825110854;4458.175237581057;2802.8738706758245;2852.458032973728;2977.1812751493294;2987.6564195117403;3006.9248268793453;914.2457472585078;915.1763412928351;954.3605784124653;958.7746879483316;988.8121256961155;9791.020897910223;9812.067853553901;9817.410955342702;9832.213422926148;9845.80308393828;4033.213523362916;4080.2247572961637;4180.456540649696;4190.601892820177;4198.6641068714425;8568.357373197035;8582;8590.14098590136;8615.91384086151;8630;4406.911861762746;4462.910741785211;4474.440694913136;4554.886127846764;4559.658025648089;3719.6466335698065;3945.921081578352;4099.938500922489;4117.547069822317;4128.050548373891;3634.127809325743;3639.909002274964;3722.2555488901785;3764.849406023783;3852.2295540891932;1184.5794742866158;1217.7747116783423;1229.280870690638;1229.4283158331418;1235.0736947289533;831.8461084699229;861.9094995025432;864.7016779211162;892.4645212872225;903.7108125399941;5231.24146998683;5297.708626025528;5338.97330513345;5345.412004679482;5549;865.8138500222483;868.6091258933506;884.5356188001351;917.9862302065475;924.7364501117149;3681.171736359298;3699.7780133192095;3756.7558108722847;3808;3825.617438256152;9084.364094513452;9276.582553785096;9365.859512107187;9369.531523423802;9377.624895004259;9166.129217724305;9232.907670923205;9244.306676999251;9250.444973301623;9285.535723213812;7070;7198.100237470317;7210.459215558749;7216.314450127229;7233.132024157029;5270;5368.785248590013;5428.430014848384;5497.230387745799;5506.972465137809;8302.460340078118;8760.342974276828;8761.91238087611;8771;8806.779830504032;8608.956955215184;8655.91344086551;8667.82664346697;8679.869801953102;8895.822083558163;6040.244969378828;6489.772857949949;6566.2120545532935;6579.374959378852;6813.931860681329;7278.798998165244;7285.7814265572115;7292.453066019963;7301.196868344372;7324.633768311456;6277.403646653561;6526.314736952551;6532.640704761284;6563.573367731082;6619.238787539494;6424.196975378078;6460.3862633049785;6491.0851298866;6542.934570654423;6567.540272180901;6257.374262573706;6311.684415779285;6323.873522529616;6346.936530634634;6367.172267605181;4505.684602077823;4551.817927282872;4621.79201935907;4653.1856925038655;4655.580997710223;4652.837150699709;4653.60444362233;4659.534046595313;4706.482286948364;4718.882027949328 04:37:51 INFO - PROCESS | 16426 | |4;prototype.html;295.954127110298;302.5401389887371;305.1029971882664;307.3760266658684;308.70518654684776;4814.9759251203695;4982.775775090121;5056.19100943849;5080.745962701869;5138.588912886969;4914.213725803863;4938.629602779797;4951;4971.353724015873;4986.950130498694;3867.2652196082795;3882.281777871103;3889.6499315061637;3891.630295121973;3911.223031647534;3665.395209790395;3893.5133108361456;3898.5126859142606;3902.570717221103;3904.93038689495;3766.284405962872;3824.2542704172697;3828.7365169494137;3845.6346647068485;3849.9230015399676;3776.848926042955;3784.5080139581955;3793.829277682497;3813.3326667833016;3826.8469261229516;3350.782199157047;3352.3798097351823;3358.9496157557655;3366.562346894888;3382.2728113455723;4699.342092107107;4779.402574678165;4786.080490900548;4812.566868981773;4827.155247831615;4390.253656878306;4395.692301538894;4403.735775853459;4413.889652758675;4415.20526305265;5175.955497578436;5199.272101905736;5201.505856943584;5218.66078704883;5248.71132087735;3587.94618080729;3681.1901381695984;3693.9815300923324;3696.981515092434;3701.5373078365205;5409.459054094598;5423;5431.701256430894;5443.510084092451;5460.672359658393;3699.4635777812605;3704.6110158433517;3709.888703338904;3732.2162345907122;3743.5882052974152;3808.447775072654;3809.9047523811573;3812;3813.218290250492;3823.5220597425323;4259.339802330582;4351.695381323277;4367.737935723867;4369.934450983238;4382.167388196232;5116.232565115262;5152.510511501401;5164.354455693038;5188.403333616682;5219.608529360313;1197.5748609243767;1298.2016060122955;1321.7752981993085;1325;1325.4101924643442;823.472977294532;829.2660995019452;844.3371953016853;849.405416208644;850.2347886901838;4079.4900637420324;4126.958730412657;4137.317342638491;4144.772037537904;4206.57934206583;4761.595264402565;4792.976035119802;4802.639802014863;4851.466338702739;4855.441624213261;4149.709520333608;4163.354680024601;4171.541130475706;4179.393987871742;4230.377166157003;2447.547203767309;2548.9107881224068;2561.551728447514;2563.551378508791;2570.807189460798;4511.639068874482;4558.475775285819;4566.5615331170575;4570.748608826547;4587.79354929029;4847.636427267969;4913.975430122898;4921.26181072842;4939.925901111486;4954.950450495449;4340.088581397878;4344.545219977883;4499.280115181556;4528.366028756042;4547;4769.73766442849;4782;4795.889808484256;4805.57318554128;4841.232949973164;4652.837150699709;4717.113154738132;4723.45680246776;4728.446638815139;4742.620590352694;4257.084312059647;4522.909541809079;4522.932156017597;4525.8189672414055;4599.839005634787;3474.5135681005186;3487.9302413952087;3489.808060556694;3496.2483066140903;3503.1783472594616;4854.441739200037;4903.53416425439;4903.828366007173;4912.877178070434;5229.47705229474;5197.142471492161;5268.550124192269;5275.208718692227;5284.154535274338;5285.68285902847;5157.252198431132;5174.534291913746;5196.53231209193;5199.76601052946;5238.0833354162105;4910.92633610489;5155.407128180157;5162.5869930406225;5167.741612919414;5194.35070616173;5314.574834013192;5316.707581082923;5321.813736519203;5338.145896656516;5361.624686271924;5153.3043039190725;5177.508136727005;5204.323437953042;5209.609279303992;5219.817306394258 04:37:51 INFO - PROCESS | 16426 | |5;yui.html;648.8929326661101;680.8638272345529;718.8526352097821;735.8675438421085;765.0933643632297;12601.810972835403;13590.456381744718;13594.320283985799;13647.727045459098;13654.112482688643;13307.467701291936;13484.93257533711;13511.662208444794;13520.32398380082;13536.661583460418;618.5917294585574;779.7076096463826;798.3732769775727;815.042325267811;817.1950628630794;795.741384050186;796.55791035975;798.0822054637184;800.8038030682491;803.4255507312271;846.2172490446343;846.9280111190557;849.4775712936562;852.3309202276214;853.9615717292737;841.7979684875617;843.8101427178897;845.9365547583956;847.4322204123253;847.8643417053241;613.2089604410305;613.714622700442;615.8614311779859;617.9320274769772;618.245740196959;11997.220180688228;12012.339321337324;12029.09781766371;12039.699007524794;12079.456424460832;13716.451341946311;13888.722225555533;13919.652008699763;13931.860681393258;14021.789673154912;10655.893441065646;10692.358458492516;10722.892771072267;10786.676399708022;10850.565977360897;3327.1183136468853;3335.8832440864453;3360.8655653774063;3366.73066154707;3441.638627944055;55929.72035139839;56003.159952600334;56303.43696563023;58512.99999999957;58808.705956470374;10496.422696751752;10499.47502624881;10655.57377704883;10701.678949631523;10748.408837514013;19015.1443185057;19135.13891874869;19206.519837004187;19238.71141932872;19472.70790938137;6444.581102228341;6580.76967306142;6709.5303328767495;6728.259891411941;6773.322667733188;3654.524911761454;3731.981340093282;3757.49273848027;3858.864939727096;3893.766374017568;2995.9101226963226;3328.2012317043736;3495.8288973194267;3501.352249833738;3545.166885781839;596.0969131765379;596.7821745063108;597.3638075449633;600.8287638023143;609.8170548835332;505.50965563404174;510.8518529626441;519.64664028461;537.7042626555457;544.9918251226235;8013.625761079686;8072.878906816402;8170.632321545426;8406.957965210135;8451.577421128919;555.4362322242927;576.1300436341155;579.9507041901486;606.7481994972126;611.5382885921101;3970.2059588082498;3988.222296652125;4033.270013837686;4147.564505726916;4164.292070348048;91889;97007.51496242615;97732;98065.50967245118;100265;54689;58461;87343.56328218318;88428.5578572103;89172;75696.24303757002;75936.62031689916;77788;78446.6077669608;78852;7759.379249660126;7793.2596403341595;7852.803679908048;7898.2101789822855;7900.881486777588;46491.070178596914;46980;47573.28640070333;47959;48690.75654621846;59962.40037599743;60575.394246056974;67415;67496.66251668907;67987.66006169938;10020.248481364073;10185.74535636615;10472.68581942543;10478.109360704426;10638.680839574825;11156.553737850396;11372.919572640585;11512.539498420305;11526.538938442369;11857.703557411134;11192.776144476902;11851.644450666494;11891.46488408041;12055.095867810125;12812.963916366314;12304.26174429537;12422.937885310515;12643.114981951543;12906.548270810477;13170.539031133865;12292.139550231755;12664.936675316565;12674.176178548365;12881.227126372447;13130;10186.49067546605;10267;10419.531121099417;10613.893861061291;10626.681199564026;10408.791824163625;10624;10716.571337146426;10720.517576709222;10770.730731731455 04:37:51 INFO - PROCESS | 16426 | __end_tp_report 04:37:51 INFO - PROCESS | 16426 | __start_cc_report 04:37:51 INFO - PROCESS | 16426 | _x_x_mozilla_cycle_collect,376 04:37:51 INFO - PROCESS | 16426 | __end_cc_report 04:37:51 INFO - PROCESS | 16426 | __startTimestamp1464867471174__endTimestamp 04:37:51 INFO - PROCESS | 16426 | 04:37:51 INFO - PROCESS | 16426 | ------- Summary: start ------- 04:37:51 INFO - PROCESS | 16426 | Number of tests: 6 04:37:51 INFO - PROCESS | 16426 | 04:37:51 INFO - PROCESS | 16426 | [#0] dojo.html Cycles:165 Average:4671.64 Median:4837.95 stddev:585.84 (12.1%) stddev-sans-first:565.14 04:37:51 INFO - PROCESS | 16426 | Values: 2622.3 2667.7 2677.7 2683.5 2691.7 4628.4 4660.0 4672.9 4739.9 4779.9 4632.8 4669.7 4690.6 4693.2 4695.0 4265.8 4336.3 4360.0 4376.5 4380.6 676.1 4273.8 4284.1 4315.4 4347.1 4338.7 4365.3 4398.8 4406.4 4452.6 4309.8 4364.1 4414.6 4418.2 4426.6 4296.8 4329.5 4331.7 4384.4 4385.2 4664.4 4696.3 4715.2 4720.4 4733.8 4830.5 5010.6 5037.3 5073.8 5083.2 4979.0 5075.2 5076.1 5077.3 5121.9 4688.7 4692.9 4695.1 4739.4 4807.8 5046.4 5138.6 5160.9 5163.3 5231.1 4941.8 4963.7 4977.3 4979.0 5007.9 5055.3 5057.0 5062.3 5067.0 5111.9 4880.4 5011.2 5058.1 5062.9 5077.6 5058.6 5071.5 5082.9 5094.5 5117.3 4277.7 4290.7 4291.8 4295.6 4340.3 3638.3 3663.2 3704.4 3724.7 3764.0 4369.7 4397.2 4404.5 4452.6 4484.0 5093.8 5105.1 5107.6 5108.0 5108.6 4329.5 4420.0 4455.8 4458.6 4476.8 4548.5 4556.1 4556.1 4611.2 4612.9 4702.8 4838.0 4845.6 4847.2 4848.4 5061.9 5119.3 5130.2 5150.6 5152.5 4815.5 4828.6 4851.1 4853.2 4874.4 4912.9 5006.2 5050.4 5069.3 5098.7 5104.7 5156.0 5180.5 5183.5 5236.8 5009.5 5010.3 5012.6 5029.6 5072.1 4861.6 4918.6 4951.9 5020.5 5034.6 4887.7 4903.0 4915.2 4929.0 4941.3 5044.7 5048.3 5049.5 5055.9 5063.2 4744.9 4768.6 4778.0 4805.5 4958.0 04:37:51 INFO - PROCESS | 16426 | 04:37:51 INFO - PROCESS | 16426 | [#1] ext.html Cycles:180 Average:49262.67 Median:36591.38 stddev:90450.85 (247.2%) stddev-sans-first:90630.59 04:37:51 INFO - PROCESS | 16426 | Values: 533.5 588.3 590.4 595.8 615.4 35198.5 39528.0 39549.2 39605.8 39630.8 40355.8 40810.8 40928.8 41087.4 41104.4 7681.8 7866.7 7925.7 7926.0 7947.6 7721.9 7804.6 7814.9 7844.9 7845.5 7802.8 7843.3 7844.9 7874.2 7878.2 7750.1 7811.7 7812.4 7814.8 7840.0 7682.1 7830.5 7832.5 7843.6 7848.1 30100.8 36775.0 37005.6 37119.4 37228.3 2891.9 3051.2 3089.9 3286.4 3489.2 27981.4 28263.0 28362.7 28480.3 28734.3 3188.4 3227.0 3317.2 3361.2 3368.6 273463.0 273545.0 275097.0 276068.0 276268.0 55879.4 56782.7 57009.1 57110.0 57167.7 33852.3 34816.3 35066.1 60343.4 60562.0 13294.2 13419.1 13446.3 13467.9 13536.8 11907.1 12082.5 12120.3 12122.1 12123.5 19095.9 19136.6 19187.6 19212.8 19241.7 7036.8 7147.3 7262.0 7272.2 7385.3 886.3 906.2 960.1 986.0 994.9 27660.3 29282.0 29429.4 30419.5 31061.4 955.8 1006.7 1027.0 1031.1 1074.0 14919.4 14952.2 15218.3 15319.0 15427.5 384016.0 384098.0 384645.0 387735.0 389629.0 51347.5 51864.2 51895.7 51945.2 51949.2 1227.2 1263.9 1275.0 1276.4 1277.5 27454.7 28688.6 28773.9 28847.4 29034.6 44591.6 44906.3 45315.3 45340.8 45368.1 356115.0 358501.0 359999.0 360767.0 361012.0 25238.9 25485.2 26478.3 26608.9 27674.0 41927.4 42155.8 42540.4 43050.0 43633.6 36541.6 36551.7 36672.6 36806.0 37029.4 34885.7 36734.8 36815.8 36826.3 37128.0 35237.6 35641.5 35998.0 36263.6 36631.1 31249.8 32738.2 32778.2 33289.3 33390.5 25288.6 25566.6 25753.7 25828.4 25903.1 04:37:51 INFO - PROCESS | 16426 | 04:37:51 INFO - PROCESS | 16426 | [#2] jquery.html Cycles:180 Average:23369.34 Median:25549.27 stddev:60583.38 (237.1%) stddev-sans-first:60728.74 04:37:51 INFO - PROCESS | 16426 | Values: 379.6 381.1 381.7 393.2 395.4 15420.2 16991.6 17074.6 17597.8 17630.9 16940.9 16954.7 17024.1 17447.9 17491.1 4728.9 4869.5 4884.3 4888.2 4889.4 3624.5 5617.6 5955.1 5960.9 6038.8 5717.7 5933.7 5949.9 5970.0 5989.6 5822.2 5867.4 5880.4 5911.7 5917.1 5049.1 5064.0 5129.3 5167.7 5177.9 20004.1 20442.2 20687.9 20772.5 20804.3 1981.6 1988.1 2109.8 2211.9 2568.5 11470.6 13240.5 13394.1 13767.5 13811.2 1695.7 1695.9 1699.7 1751.1 1756.6 64396.0 65806.3 68253.7 68421.0 69168.7 10189.8 10198.9 10363.1 10404.7 11190.7 13980.2 14059.0 14071.9 14170.9 14171.9 7439.2 7643.0 7680.7 7736.4 7784.8 7246.6 7326.8 7494.4 7507.1 7540.3 4398.9 4439.5 4454.2 4481.9 4484.2 1746.2 1798.5 1891.1 1904.8 1943.3 796.1 918.0 956.7 961.9 983.1 16436.0 16461.3 16483.8 16848.6 17152.7 902.5 916.3 917.5 936.5 978.8 9383.0 9521.4 10197.6 10279.9 10290.5 360224.0 365656.0 367529.0 372272.0 372458.0 46614.3 48098.5 76791.6 77353.0 78154.6 956.1 974.6 984.0 994.5 999.8 15699.3 15701.2 15706.8 15749.3 16000.6 28248.7 32452.9 35594.5 38133.2 38133.4 49783.8 50476.0 52031.7 52260.2 52677.5 7420.0 7465.7 7534.1 7710.4 7713.5 10029.8 10752.5 10937.9 11092.3 11213.9 6116.0 9235.2 9482.1 9842.6 9987.3 9835.1 9890.0 9950.6 10253.5 10402.6 9958.6 9961.7 10035.0 10144.5 10344.1 7398.7 7423.6 7658.9 7701.2 7830.5 7710.3 9917.3 9962.5 10153.6 10231.7 04:37:51 INFO - PROCESS | 16426 | 04:37:51 INFO - PROCESS | 16426 | [#3] mootools.html Cycles:180 Average:5015.94 Median:6148.81 stddev:2724.92 (44.3%) stddev-sans-first:2717.43 04:37:51 INFO - PROCESS | 16426 | Values: 1194.5 1234.8 1326.8 1739.5 1762.9 6709.3 7248.8 7324.9 7825.0 7825.8 7465.8 7638.1 7653.5 7692.4 7740.4 2048.0 2073.6 2080.0 2080.6 2081.5 2126.2 2136.8 2146.4 2156.7 2165.5 2188.1 2203.3 2211.2 2214.1 2236.2 2114.5 2127.4 2129.5 2130.5 2138.7 2058.1 2109.0 2110.0 2131.4 2151.3 7339.9 7348.0 7378.2 7405.8 7407.4 4342.0 4408.3 4431.3 4435.0 4458.2 2802.9 2852.5 2977.2 2987.7 3006.9 914.2 915.2 954.4 958.8 988.8 9791.0 9812.1 9817.4 9832.2 9845.8 4033.2 4080.2 4180.5 4190.6 4198.7 8568.4 8582.0 8590.1 8615.9 8630.0 4406.9 4462.9 4474.4 4554.9 4559.7 3719.6 3945.9 4099.9 4117.5 4128.1 3634.1 3639.9 3722.3 3764.8 3852.2 1184.6 1217.8 1229.3 1229.4 1235.1 831.8 861.9 864.7 892.5 903.7 5231.2 5297.7 5339.0 5345.4 5549.0 865.8 868.6 884.5 918.0 924.7 3681.2 3699.8 3756.8 3808.0 3825.6 9084.4 9276.6 9365.9 9369.5 9377.6 9166.1 9232.9 9244.3 9250.4 9285.5 7070.0 7198.1 7210.5 7216.3 7233.1 5270.0 5368.8 5428.4 5497.2 5507.0 8302.5 8760.3 8761.9 8771.0 8806.8 8609.0 8655.9 8667.8 8679.9 8895.8 6040.2 6489.8 6566.2 6579.4 6813.9 7278.8 7285.8 7292.5 7301.2 7324.6 6277.4 6526.3 6532.6 6563.6 6619.2 6424.2 6460.4 6491.1 6542.9 6567.5 6257.4 6311.7 6323.9 6346.9 6367.2 4505.7 4551.8 4621.8 4653.2 4655.6 4652.8 4653.6 4659.5 4706.5 4718.9 04:37:51 INFO - PROCESS | 16426 | 04:37:51 INFO - PROCESS | 16426 | [#4] prototype.html Cycles:180 Average:4161.56 Median:4562.52 stddev:1214.53 (26.6%) stddev-sans-first:1182.77 04:37:51 INFO - PROCESS | 16426 | Values: 296.0 302.5 305.1 307.4 308.7 4815.0 4982.8 5056.2 5080.7 5138.6 4914.2 4938.6 4951.0 4971.4 4987.0 3867.3 3882.3 3889.6 3891.6 3911.2 3665.4 3893.5 3898.5 3902.6 3904.9 3766.3 3824.3 3828.7 3845.6 3849.9 3776.8 3784.5 3793.8 3813.3 3826.8 3350.8 3352.4 3358.9 3366.6 3382.3 4699.3 4779.4 4786.1 4812.6 4827.2 4390.3 4395.7 4403.7 4413.9 4415.2 5176.0 5199.3 5201.5 5218.7 5248.7 3587.9 3681.2 3694.0 3697.0 3701.5 5409.5 5423.0 5431.7 5443.5 5460.7 3699.5 3704.6 3709.9 3732.2 3743.6 3808.4 3809.9 3812.0 3813.2 3823.5 4259.3 4351.7 4367.7 4369.9 4382.2 5116.2 5152.5 5164.4 5188.4 5219.6 1197.6 1298.2 1321.8 1325.0 1325.4 823.5 829.3 844.3 849.4 850.2 4079.5 4127.0 4137.3 4144.8 4206.6 4761.6 4793.0 4802.6 4851.5 4855.4 4149.7 4163.4 4171.5 4179.4 4230.4 2447.5 2548.9 2561.6 2563.6 2570.8 4511.6 4558.5 4566.6 4570.7 4587.8 4847.6 4914.0 4921.3 4939.9 4955.0 4340.1 4344.5 4499.3 4528.4 4547.0 4769.7 4782.0 4795.9 4805.6 4841.2 4652.8 4717.1 4723.5 4728.4 4742.6 4257.1 4522.9 4522.9 4525.8 4599.8 3474.5 3487.9 3489.8 3496.2 3503.2 4854.4 4903.5 4903.8 4912.9 5229.5 5197.1 5268.6 5275.2 5284.2 5285.7 5157.3 5174.5 5196.5 5199.8 5238.1 4910.9 5155.4 5162.6 5167.7 5194.4 5314.6 5316.7 5321.8 5338.1 5361.6 5153.3 5177.5 5204.3 5209.6 5219.8 04:37:51 INFO - PROCESS | 16426 | 04:37:51 INFO - PROCESS | 16426 | [#5] yui.html Cycles:180 Average:17682.38 Median:25327.68 stddev:24948.17 (98.5%) stddev-sans-first:24985.37 04:37:51 INFO - PROCESS | 16426 | Values: 648.9 680.9 718.9 735.9 765.1 12601.8 13590.5 13594.3 13647.7 13654.1 13307.5 13484.9 13511.7 13520.3 13536.7 618.6 779.7 798.4 815.0 817.2 795.7 796.6 798.1 800.8 803.4 846.2 846.9 849.5 852.3 854.0 841.8 843.8 845.9 847.4 847.9 613.2 613.7 615.9 617.9 618.2 11997.2 12012.3 12029.1 12039.7 12079.5 13716.5 13888.7 13919.7 13931.9 14021.8 10655.9 10692.4 10722.9 10786.7 10850.6 3327.1 3335.9 3360.9 3366.7 3441.6 55929.7 56003.2 56303.4 58513.0 58808.7 10496.4 10499.5 10655.6 10701.7 10748.4 19015.1 19135.1 19206.5 19238.7 19472.7 6444.6 6580.8 6709.5 6728.3 6773.3 3654.5 3732.0 3757.5 3858.9 3893.8 2995.9 3328.2 3495.8 3501.4 3545.2 596.1 596.8 597.4 600.8 609.8 505.5 510.9 519.6 537.7 545.0 8013.6 8072.9 8170.6 8407.0 8451.6 555.4 576.1 580.0 606.7 611.5 3970.2 3988.2 4033.3 4147.6 4164.3 91889.0 97007.5 97732.0 98065.5 100265.0 54689.0 58461.0 87343.6 88428.6 89172.0 75696.2 75936.6 77788.0 78446.6 78852.0 7759.4 7793.3 7852.8 7898.2 7900.9 46491.1 46980.0 47573.3 47959.0 48690.8 59962.4 60575.4 67415.0 67496.7 67987.7 10020.2 10185.7 10472.7 10478.1 10638.7 11156.6 11372.9 11512.5 11526.5 11857.7 11192.8 11851.6 11891.5 12055.1 12813.0 12304.3 12422.9 12643.1 12906.5 13170.5 12292.1 12664.9 12674.2 12881.2 13130.0 10186.5 10267.0 10419.5 10613.9 10626.7 10408.8 10624.0 10716.6 10720.5 10770.7 04:37:51 INFO - PROCESS | 16426 | -------- Summary: end -------- 04:37:51 INFO - PROCESS | 16426 | 04:37:51 INFO - TEST-INFO | 16426: exit 0 04:37:51 INFO - TEST-OK | dromaeo_css | took 1116002ms 04:37:51 INFO - TEST-START | kraken 04:37:51 INFO - operating with platform_type : linux_ 04:37:51 INFO - Initialising browser for kraken test... 04:37:51 INFO - TEST-INFO | started process 16656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpChv3Uq/profile http://localhost:50565/getInfo.html) 04:37:57 INFO - PROCESS | 16656 | __metrics Screen width/height:1600/1200 04:37:57 INFO - PROCESS | 16656 | colorDepth:24 04:37:57 INFO - PROCESS | 16656 | Browser inner width/height: 1024/697 04:37:57 INFO - PROCESS | 16656 | __metrics 04:37:57 ERROR - PROCESS | 16656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:37:58 INFO - TEST-INFO | 16656: exit 0 04:37:58 INFO - Browser initialized. 04:37:58 INFO - Running cycle 1/1 for kraken test... 04:37:58 INFO - TEST-INFO | started process 16777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpChv3Uq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:38:10 INFO - PROCESS | 16777 | RSS: Main: 168570880 04:38:10 INFO - PROCESS | 16777 | 04:38:13 INFO - PROCESS | 16777 | Cycle 1(1): loaded http://localhost:50565/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50565/tests/kraken/driver.html?testName=audio-beat-detection) 04:38:14 INFO - PROCESS | 16777 | RSS: Main: 172744704 04:38:14 INFO - PROCESS | 16777 | 04:38:17 INFO - PROCESS | 16777 | Cycle 1(1): loaded http://localhost:50565/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50565/tests/kraken/driver.html?testName=audio-dft) 04:38:17 INFO - PROCESS | 16777 | RSS: Main: 172204032 04:38:17 INFO - PROCESS | 16777 | 04:38:20 INFO - PROCESS | 16777 | Cycle 1(1): loaded http://localhost:50565/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50565/tests/kraken/driver.html?testName=audio-fft) 04:38:21 INFO - PROCESS | 16777 | RSS: Main: 168337408 04:38:21 INFO - PROCESS | 16777 | 04:38:23 INFO - PROCESS | 16777 | Cycle 1(1): loaded http://localhost:50565/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50565/tests/kraken/driver.html?testName=audio-oscillator) 04:38:24 INFO - PROCESS | 16777 | RSS: Main: 168783872 04:38:24 INFO - PROCESS | 16777 | 04:38:26 INFO - PROCESS | 16777 | Cycle 1(1): loaded http://localhost:50565/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50565/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:38:27 INFO - PROCESS | 16777 | RSS: Main: 168919040 04:38:27 INFO - PROCESS | 16777 | 04:38:30 INFO - PROCESS | 16777 | Cycle 1(1): loaded http://localhost:50565/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50565/tests/kraken/driver.html?testName=imaging-darkroom) 04:38:30 INFO - PROCESS | 16777 | RSS: Main: 169451520 04:38:30 INFO - PROCESS | 16777 | 04:38:34 INFO - PROCESS | 16777 | Cycle 1(1): loaded http://localhost:50565/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50565/tests/kraken/driver.html?testName=imaging-desaturate) 04:38:35 INFO - PROCESS | 16777 | RSS: Main: 166875136 04:38:35 INFO - PROCESS | 16777 | 04:38:38 INFO - PROCESS | 16777 | Cycle 1(1): loaded http://localhost:50565/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50565/tests/kraken/driver.html?testName=json-parse-financial) 04:38:38 INFO - PROCESS | 16777 | RSS: Main: 168083456 04:38:38 INFO - PROCESS | 16777 | 04:38:40 INFO - PROCESS | 16777 | Cycle 1(1): loaded http://localhost:50565/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50565/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:38:40 INFO - PROCESS | 16777 | RSS: Main: 168599552 04:38:40 INFO - PROCESS | 16777 | 04:38:42 INFO - PROCESS | 16777 | Cycle 1(1): loaded http://localhost:50565/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50565/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:38:43 INFO - PROCESS | 16777 | RSS: Main: 168648704 04:38:43 INFO - PROCESS | 16777 | 04:38:45 INFO - PROCESS | 16777 | Cycle 1(1): loaded http://localhost:50565/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50565/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:38:46 INFO - PROCESS | 16777 | RSS: Main: 168992768 04:38:46 INFO - PROCESS | 16777 | 04:38:49 INFO - PROCESS | 16777 | Cycle 1(1): loaded http://localhost:50565/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:38:49 INFO - PROCESS | 16777 | RSS: Main: 169234432 04:38:49 INFO - PROCESS | 16777 | 04:38:52 INFO - PROCESS | 16777 | Cycle 1(1): loaded http://localhost:50565/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:38:53 INFO - PROCESS | 16777 | RSS: Main: 168726528 04:38:53 INFO - PROCESS | 16777 | 04:38:55 INFO - PROCESS | 16777 | Cycle 1(1): loaded http://localhost:50565/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50565/tests/kraken/driver.html?testName=ai-astar) 04:38:55 INFO - PROCESS | 16777 | RSS: Main: 169213952 04:38:55 INFO - PROCESS | 16777 | 04:38:55 INFO - PROCESS | 16777 | __start_tp_report 04:38:55 INFO - PROCESS | 16777 | _x_x_mozilla_page_load 04:38:55 INFO - PROCESS | 16777 | _x_x_mozilla_page_load_details 04:38:55 INFO - PROCESS | 16777 | |i|pagename|runs| 04:38:55 INFO - PROCESS | 16777 | |0;ai-astar;120;111;117;117;118;117;117;118;117;117 04:38:55 INFO - PROCESS | 16777 | |1;audio-beat-detection;153;132;167;180;136;165;161;141;184;138 04:38:55 INFO - PROCESS | 16777 | |2;audio-dft;163;164;165;184;164;164;163;164;164;162 04:38:55 INFO - PROCESS | 16777 | |3;audio-fft;77;78;78;167;76;77;77;79;156;79 04:38:55 INFO - PROCESS | 16777 | |4;audio-oscillator;86;86;136;86;85;84;145;87;85;140 04:38:55 INFO - PROCESS | 16777 | |5;imaging-gaussian-blur;118;117;118;118;118;117;118;118;118;117 04:38:55 INFO - PROCESS | 16777 | |6;imaging-darkroom;152;149;146;147;148;147;147;148;148;147 04:38:55 INFO - PROCESS | 16777 | |7;imaging-desaturate;96;96;96;96;96;96;96;95;95;95 04:38:55 INFO - PROCESS | 16777 | |8;json-parse-financial;64;65;67;64;66;64;66;66;65;65 04:38:55 INFO - PROCESS | 16777 | |9;json-stringify-tinderbox;65;65;65;65;65;66;65;65;65;65 04:38:55 INFO - PROCESS | 16777 | |10;stanford-crypto-aes;84;86;85;84;89;90;90;85;121;85 04:38:55 INFO - PROCESS | 16777 | |11;stanford-crypto-ccm;134;145;129;136;142;139;133;134;138;150 04:38:55 INFO - PROCESS | 16777 | |12;stanford-crypto-pbkdf2;171;173;170;173;175;176;167;175;169;168 04:38:55 INFO - PROCESS | 16777 | |13;stanford-crypto-sha256-iterative;67;72;68;69;67;66;67;70;66;68 04:38:55 INFO - PROCESS | 16777 | __end_tp_report 04:38:55 INFO - PROCESS | 16777 | __start_cc_report 04:38:55 INFO - PROCESS | 16777 | _x_x_mozilla_cycle_collect,986 04:38:55 INFO - PROCESS | 16777 | __end_cc_report 04:38:55 INFO - PROCESS | 16777 | __startTimestamp1464867535427__endTimestamp 04:38:55 INFO - PROCESS | 16777 | 04:38:55 INFO - PROCESS | 16777 | ------- Summary: start ------- 04:38:55 INFO - PROCESS | 16777 | Number of tests: 14 04:38:55 INFO - PROCESS | 16777 | 04:38:55 INFO - PROCESS | 16777 | [#0] ai-astar Cycles:10 Average:116.90 Median:117.00 stddev:2.28 (2.0%) stddev-sans-first:2.13 04:38:55 INFO - PROCESS | 16777 | Values: 120.0 111.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 04:38:55 INFO - PROCESS | 16777 | 04:38:55 INFO - PROCESS | 16777 | [#1] audio-beat-detection Cycles:10 Average:155.70 Median:163.00 stddev:18.62 (11.4%) stddev-sans-first:19.72 04:38:55 INFO - PROCESS | 16777 | Values: 153.0 132.0 167.0 180.0 136.0 165.0 161.0 141.0 184.0 138.0 04:38:55 INFO - PROCESS | 16777 | 04:38:55 INFO - PROCESS | 16777 | [#2] audio-dft Cycles:10 Average:165.70 Median:164.00 stddev:6.48 (4.0%) stddev-sans-first:6.80 04:38:55 INFO - PROCESS | 16777 | Values: 163.0 164.0 165.0 184.0 164.0 164.0 163.0 164.0 164.0 162.0 04:38:55 INFO - PROCESS | 16777 | 04:38:55 INFO - PROCESS | 16777 | [#3] audio-fft Cycles:10 Average:94.40 Median:77.50 stddev:35.47 (45.8%) stddev-sans-first:37.06 04:38:55 INFO - PROCESS | 16777 | Values: 77.0 78.0 78.0 167.0 76.0 77.0 77.0 79.0 156.0 79.0 04:38:55 INFO - PROCESS | 16777 | 04:38:55 INFO - PROCESS | 16777 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:85.50 stddev:26.55 (31.1%) stddev-sans-first:27.52 04:38:55 INFO - PROCESS | 16777 | Values: 86.0 86.0 136.0 86.0 85.0 84.0 145.0 87.0 85.0 140.0 04:38:55 INFO - PROCESS | 16777 | 04:38:55 INFO - PROCESS | 16777 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:38:55 INFO - PROCESS | 16777 | Values: 118.0 117.0 118.0 118.0 118.0 117.0 118.0 118.0 118.0 117.0 04:38:55 INFO - PROCESS | 16777 | 04:38:55 INFO - PROCESS | 16777 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:1.66 (1.1%) stddev-sans-first:0.88 04:38:55 INFO - PROCESS | 16777 | Values: 152.0 149.0 146.0 147.0 148.0 147.0 147.0 148.0 148.0 147.0 04:38:55 INFO - PROCESS | 16777 | 04:38:55 INFO - PROCESS | 16777 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:38:55 INFO - PROCESS | 16777 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 04:38:55 INFO - PROCESS | 16777 | 04:38:55 INFO - PROCESS | 16777 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.50 stddev:1.03 (1.6%) stddev-sans-first:1.00 04:38:55 INFO - PROCESS | 16777 | Values: 64.0 65.0 67.0 64.0 66.0 64.0 66.0 66.0 65.0 65.0 04:38:55 INFO - PROCESS | 16777 | 04:38:55 INFO - PROCESS | 16777 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 04:38:55 INFO - PROCESS | 16777 | Values: 65.0 65.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 65.0 04:38:55 INFO - PROCESS | 16777 | 04:38:55 INFO - PROCESS | 16777 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:85.50 stddev:11.18 (13.1%) stddev-sans-first:11.65 04:38:55 INFO - PROCESS | 16777 | Values: 84.0 86.0 85.0 84.0 89.0 90.0 90.0 85.0 121.0 85.0 04:38:55 INFO - PROCESS | 16777 | 04:38:55 INFO - PROCESS | 16777 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:138.50 stddev:6.25 (4.5%) stddev-sans-first:6.46 04:38:55 INFO - PROCESS | 16777 | Values: 134.0 145.0 129.0 136.0 142.0 139.0 133.0 134.0 138.0 150.0 04:38:55 INFO - PROCESS | 16777 | 04:38:55 INFO - PROCESS | 16777 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:173.00 stddev:3.16 (1.8%) stddev-sans-first:3.35 04:38:55 INFO - PROCESS | 16777 | Values: 171.0 173.0 170.0 173.0 175.0 176.0 167.0 175.0 169.0 168.0 04:38:55 INFO - PROCESS | 16777 | 04:38:55 INFO - PROCESS | 16777 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.89 (2.8%) stddev-sans-first:1.96 04:38:55 INFO - PROCESS | 16777 | Values: 67.0 72.0 68.0 69.0 67.0 66.0 67.0 70.0 66.0 68.0 04:38:55 INFO - PROCESS | 16777 | -------- Summary: end -------- 04:38:55 INFO - PROCESS | 16777 | 04:38:56 INFO - TEST-INFO | 16777: exit 0 04:38:56 INFO - TEST-OK | kraken | took 64557ms 04:38:56 INFO - SUITE-END | took 1180s 04:38:56 INFO - Completed test suite (00:19:40) 04:38:56 INFO - javascript benchmark 04:38:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6427.296371637839, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2622.344413896526, 2667.746564076412, 2677.6519052523167, 2683.51696694595, 2691.7442842929927, 4628.398308219931, 4660.044690838375, 4672.906541869165, 4739.90520189596, 4779.90440191196, 4632.791524381402, 4669.6731228814, 4690.57784799368, 4693.155232058228, 4694.976525117369, 4265.829366825331, 4336.3278691802825, 4359.978200108995, 4376.496702879162, 4380.605745482906, 676.12053881319, 4273.803335066186, 4284.100338928829, 4315.374270730742, 4347.108842687241, 4338.696291259613, 4365.323374876899, 4398.824047038114, 4406.405135306724, 4452.599266066037, 4309.82760689572, 4364.127174565068, 4414.55854414556, 4418.182636212311, 4426.579474949875, 4296.785160741982, 4329.523752387235, 4331.7184383015, 4384.408104905829, 4385.232584297735, 4664.440267167927, 4696.342512048316, 4715.1512727709, 4720.3863497745415, 4733.83431579893, 4830.468648448667, 5010.599152067826, 5037.319961805146, 5073.822416215452, 5083.21210212414, 4978.950210497885, 5075.213341932006, 5076.06092872816, 5077.289179514871, 5121.897562048738, 4688.7186768793645, 4692.859214223578, 4695.084458530622, 4739.431268247832, 4807.807687692488, 5046.394432668103, 5138.614603904647, 5160.870978225575, 5163.342957876471, 5231.0584094862525, 4941.75291235444, 4963.726995015237, 4977.253411988231, 4978.950210497848, 5007.899842003139, 5055.317532133115, 5057.0, 5062.316587260672, 5067.0, 5111.923321150186, 4880.438749543848, 5011.223260394645, 5058.114829904752, 5062.898742025139, 5077.619178561623, 5058.645894787403, 5071.4928507149725, 5082.949170508247, 5094.49055094495, 5117.334746482933, 4277.721948073366, 4290.742555446684, 4291.806868690916, 4295.591918767712, 4340.327249276304, 3638.290533345972, 3663.19409729859, 3704.4258139988347, 3724.7020238381406, 3763.9623603764157, 4369.737815731066, 4397.2085024695225, 4404.493483249404, 4452.5992660660695, 4484.0, 5093.847184584469, 5105.055564720538, 5107.591392688576, 5107.97446012775, 5108.591312694975, 4329.480462344539, 4419.955800442019, 4455.821767129343, 4458.598726114666, 4476.798544065525, 4548.522405147478, 4556.066006468666, 4556.11155824611, 4611.239145541015, 4612.907741845144, 4702.788374523223, 4837.95162048375, 4845.6123510119105, 4847.175980083394, 4848.393950756155, 5061.9493805061475, 5119.283300337881, 5130.153524668388, 5150.6137039721425, 5152.536271735562, 4815.518448155157, 4828.589569886459, 4851.102546028996, 4853.150698627796, 4874.439439464365, 4912.901741965212, 5006.249062640633, 5050.444451110448, 5069.340985671839, 5098.668586541863, 5104.719240441811, 5156.04613146569, 5180.48195180479, 5183.481651834786, 5236.816711415082, 5009.474005229544, 5010.323606313101, 5012.649114561946, 5029.622778291569, 5072.112380333353, 4861.611071114373, 4918.631102667243, 4951.900961980812, 5020.548150666457, 5034.572061374824, 4887.731174785279, 4903.0, 4915.1644220481885, 4928.975355123202, 4941.258811178352, 5044.747762611928, 5048.293238946624, 5049.495050494921, 5055.924161137659, 5063.1645778446145, 4744.881377965578, 4768.61851051922, 4778.04439112172, 4805.543473370024, 4957.950420495893], "value": 4635.821650301187, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.5437449510606, 588.2646691635456, 590.3801008940613, 595.7706283081014, 615.3692465223148, 35198.472022919676, 39528.0, 39549.209015819666, 39605.80197099014, 39630.80184599073, 40355.79822100885, 40810.795946020306, 40928.795356023176, 41087.383689244685, 41104.38343424851, 7681.7695469136015, 7866.724664636738, 7925.722599709012, 7926.0, 7947.602619868983, 7721.922780772176, 7804.570748608824, 7814.921850781477, 7844.921550784505, 7845.490043147177, 7802.804929876742, 7843.33331666809, 7844.921550784505, 7874.212578742108, 7878.212178782133, 7750.069991601016, 7811.687532498693, 7812.375009999215, 7814.804629884242, 7839.96080019602, 7682.0781506219055, 7830.530168189927, 7832.451728379016, 7843.647035883342, 7848.058233012018, 30100.8494957526, 36775.0, 37005.629943700485, 37119.4432083519, 37228.25543489142, 2891.8577162020883, 3051.2219384056925, 3089.938201235963, 3286.424875646776, 3489.1974845785358, 27981.44037119246, 28263.0, 28362.71637283642, 28480.287992800346, 28734.281642959093, 3188.4260833050043, 3226.9838650806596, 3317.1872891141584, 3361.1765117546115, 3368.562086928708, 273463.0, 273545.0, 275097.0, 276068.0, 276268.0, 55879.441205588235, 56782.71608642013, 57009.14486282709, 57110.0, 57167.71416142893, 33852.32295354128, 34816.30367392638, 35066.12334691653, 60343.39656603378, 60562.0, 13294.20234785916, 13419.127756695783, 13446.260455674836, 13467.932660336635, 13536.796948045787, 11907.106966977339, 12082.456289466994, 12120.27278363301, 12122.09084318662, 12123.45444454984, 19095.90452047731, 19136.61726765485, 19187.616247675247, 19212.8078719211, 19241.711374329396, 7036.753713620101, 7147.3210045045635, 7261.989227433054, 7272.163701174327, 7385.335319821242, 886.2821114896955, 906.1889608800219, 960.1214888377197, 985.9507024648739, 994.915542059159, 27660.308492287855, 29282.0, 29429.411411772075, 30419.543706844415, 31061.378772424425, 955.8422860228123, 1006.7030226083323, 1027.034587487774, 1031.1029404418055, 1073.968989769814, 14919.40322387114, 14952.177630230442, 15218.315175817115, 15319.0, 15427.5371738848, 384016.0, 384098.0, 384645.0, 387735.0, 389629.0, 51347.48652513502, 51864.22203666948, 51895.74052129715, 51945.220821687704, 51949.22076168861, 1227.2391117507025, 1263.9368031598383, 1274.955376561816, 1276.3554405025588, 1277.482619539088, 27454.725452745217, 28688.569671455363, 28773.856130719214, 28847.423051538433, 29034.564481533216, 44591.55408445874, 44906.326405104606, 45315.32027019531, 45340.77329613331, 45368.09263814771, 356115.0, 358501.0, 359999.0, 360767.0, 361012.0, 25238.873805630854, 25485.23544293674, 26478.338041549116, 26608.866955665097, 27674.0, 41927.37108943307, 42155.789221053696, 42540.36189457223, 43050.0, 43633.56366436422, 36541.634583654886, 36551.665846298034, 36672.63327366799, 36806.0, 37029.44455833219, 34885.65114348824, 36734.8163259182, 36815.81592092022, 36826.26347473089, 37128.0, 35237.64762352344, 35641.46537801987, 35998.0, 36263.63736362708, 36631.08422289464, 31249.8437507811, 32738.181545461553, 32778.18054548655, 33289.334213316084, 33390.499142512395, 25288.62067069032, 25566.61650075213, 25753.742462575883, 25828.35429114287, 25903.0933917312], "value": 17801.130636863985, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.5786676788764, 381.0701887394757, 381.7041145311667, 393.22730833911356, 395.42663138449257, 15420.228988550569, 16991.57521061974, 17074.573135671613, 17597.824021759778, 17630.911845440773, 16940.871472729094, 16954.745678814827, 17024.148792560354, 17447.91276043618, 17491.125443727826, 4728.929066064012, 4869.4887036861155, 4884.340614017097, 4888.169011268093, 4889.437714662824, 3624.4925710400566, 5617.606767526275, 5955.076963070731, 5960.910586341209, 6038.818835434922, 5717.742701578439, 5933.7242492864025, 5949.85125371867, 5970.044792833148, 5989.6406215626985, 5822.214001109838, 5867.413258674141, 5880.411958804107, 5911.674857882815, 5917.053271476565, 5049.141645920203, 5064.012517559077, 5129.281900533928, 5167.715775632339, 5177.948220517822, 20004.099815508336, 20442.182312707475, 20687.896560517253, 20772.48068798277, 20804.271850485162, 1981.5937732764748, 1988.125224901039, 2109.8312135029314, 2211.9336419907427, 2568.488072052108, 11470.598529051444, 13240.470381184741, 13394.129381590166, 13767.518136865161, 13811.17132972025, 1695.652391259801, 1695.9152042397832, 1699.728043513032, 1751.0894334945883, 1756.6398888227882, 64396.0, 65806.3419365805, 68253.65873170651, 68421.0, 69168.6541567294, 10189.847152292721, 10198.898011019943, 10363.11913487347, 10404.68785936423, 11190.720231994264, 13980.231087290296, 14059.0, 14071.929640351733, 14170.929145354206, 14171.945067965293, 7439.218882017419, 7643.0, 7680.731174408869, 7736.381089512825, 7784.766457006299, 7246.565206087546, 7326.816829579303, 7494.40044796415, 7507.061617297838, 7540.302385663193, 4398.912021759611, 4439.511653718088, 4454.153710794939, 4481.910361792746, 4484.2376795944765, 1746.1531157388656, 1798.5233913013062, 1891.1300801631128, 1904.7809202447818, 1943.2712732725229, 796.1361922314238, 918.0039656972126, 956.6651671914774, 961.9230461563059, 983.0709979069853, 16436.0, 16461.34154633825, 16483.83516164847, 16848.64119023338, 17152.742708859376, 902.4630344944748, 916.3036092569695, 917.5228880981851, 936.5270538378076, 978.7748817771952, 9383.0, 9521.381110227812, 10197.592096316064, 10279.897201027894, 10290.485475726184, 360224.0, 365656.0, 367529.0, 372272.0, 372458.0, 46614.300785488245, 48098.5190148101, 76791.61604192056, 77353.0, 78154.60922695464, 956.0821611253136, 974.6247694637616, 983.9508024598885, 994.5176589354157, 999.7800483893532, 15699.293531791325, 15701.214939253221, 15706.842931570538, 15749.29128189257, 16000.599985000468, 28248.71751282461, 32452.864149754645, 35594.46608300826, 38133.237335253696, 38133.427998579486, 49783.751081244365, 50476.0, 52031.73984130055, 52260.21609675782, 52677.473225267255, 7419.962900185465, 7465.701371945279, 7534.133574638987, 7710.383169346551, 7713.4600577959, 10029.849552256868, 10752.462376881282, 10937.945310273715, 11092.280696492056, 11213.887861121611, 6115.990861507979, 9235.15296940628, 9482.146606805421, 9842.557084931339, 9987.25095617817, 9835.131325048218, 9889.950550247202, 9950.601975920883, 10253.538590763583, 10402.635907743193, 9958.601655933682, 9961.651342203279, 10035.0, 10144.543495542866, 10344.120749736056, 7398.704051838082, 7423.591702456417, 7658.885116723365, 7701.229877012254, 7830.491018083806, 7710.267524585155, 9917.30578859473, 9962.452065136196, 10153.64462243818, 10231.744206394602], "value": 8308.734736684552, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1194.528161376256, 1234.839470868787, 1326.8076128961297, 1739.4781565530338, 1762.903040332781, 6709.329067093288, 7248.7825365239, 7324.890126648098, 7825.0, 7825.765227043191, 7465.813354666136, 7638.12161601416, 7653.464257501977, 7692.423068269874, 7740.419468539868, 2047.9897600512013, 2073.554185850042, 2079.9584008319825, 2080.625487412265, 2081.458820706612, 2126.245847176075, 2136.807687308142, 2146.37755051035, 2156.708844306022, 2165.545235500547, 2188.1356864038776, 2203.3389983005113, 2211.181862710799, 2214.059024914413, 2236.206146817881, 2114.4713821544537, 2127.393692797553, 2129.5208578069964, 2130.4780328819384, 2138.6791981202787, 2058.053295484079, 2108.95782084359, 2110.0, 2131.4245153808383, 2151.279321427324, 7339.88990165148, 7348.0, 7378.188399276075, 7405.7778266652085, 7407.444441666897, 4342.0, 4408.316710909814, 4431.290993441034, 4434.977825110854, 4458.175237581057, 2802.8738706758245, 2852.458032973728, 2977.1812751493294, 2987.6564195117403, 3006.9248268793453, 914.2457472585078, 915.1763412928351, 954.3605784124653, 958.7746879483316, 988.8121256961155, 9791.020897910223, 9812.067853553901, 9817.410955342702, 9832.213422926148, 9845.80308393828, 4033.213523362916, 4080.2247572961637, 4180.456540649696, 4190.601892820177, 4198.6641068714425, 8568.357373197035, 8582.0, 8590.14098590136, 8615.91384086151, 8630.0, 4406.911861762746, 4462.910741785211, 4474.440694913136, 4554.886127846764, 4559.658025648089, 3719.6466335698065, 3945.921081578352, 4099.938500922489, 4117.547069822317, 4128.050548373891, 3634.127809325743, 3639.909002274964, 3722.2555488901785, 3764.849406023783, 3852.2295540891932, 1184.5794742866158, 1217.7747116783423, 1229.280870690638, 1229.4283158331418, 1235.0736947289533, 831.8461084699229, 861.9094995025432, 864.7016779211162, 892.4645212872225, 903.7108125399941, 5231.24146998683, 5297.708626025528, 5338.97330513345, 5345.412004679482, 5549.0, 865.8138500222483, 868.6091258933506, 884.5356188001351, 917.9862302065475, 924.7364501117149, 3681.171736359298, 3699.7780133192095, 3756.7558108722847, 3808.0, 3825.617438256152, 9084.364094513452, 9276.582553785096, 9365.859512107187, 9369.531523423802, 9377.624895004259, 9166.129217724305, 9232.907670923205, 9244.306676999251, 9250.444973301623, 9285.535723213812, 7070.0, 7198.100237470317, 7210.459215558749, 7216.314450127229, 7233.132024157029, 5270.0, 5368.785248590013, 5428.430014848384, 5497.230387745799, 5506.972465137809, 8302.460340078118, 8760.342974276828, 8761.91238087611, 8771.0, 8806.779830504032, 8608.956955215184, 8655.91344086551, 8667.82664346697, 8679.869801953102, 8895.822083558163, 6040.244969378828, 6489.772857949949, 6566.2120545532935, 6579.374959378852, 6813.931860681329, 7278.798998165244, 7285.7814265572115, 7292.453066019963, 7301.196868344372, 7324.633768311456, 6277.403646653561, 6526.314736952551, 6532.640704761284, 6563.573367731082, 6619.238787539494, 6424.196975378078, 6460.3862633049785, 6491.0851298866, 6542.934570654423, 6567.540272180901, 6257.374262573706, 6311.684415779285, 6323.873522529616, 6346.936530634634, 6367.172267605181, 4505.684602077823, 4551.817927282872, 4621.79201935907, 4653.1856925038655, 4655.580997710223, 4652.837150699709, 4653.60444362233, 4659.534046595313, 4706.482286948364, 4718.882027949328], "value": 4084.343942698453, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.954127110298, 302.5401389887371, 305.1029971882664, 307.3760266658684, 308.70518654684776, 4814.9759251203695, 4982.775775090121, 5056.19100943849, 5080.745962701869, 5138.588912886969, 4914.213725803863, 4938.629602779797, 4951.0, 4971.353724015873, 4986.950130498694, 3867.2652196082795, 3882.281777871103, 3889.6499315061637, 3891.630295121973, 3911.223031647534, 3665.395209790395, 3893.5133108361456, 3898.5126859142606, 3902.570717221103, 3904.93038689495, 3766.284405962872, 3824.2542704172697, 3828.7365169494137, 3845.6346647068485, 3849.9230015399676, 3776.848926042955, 3784.5080139581955, 3793.829277682497, 3813.3326667833016, 3826.8469261229516, 3350.782199157047, 3352.3798097351823, 3358.9496157557655, 3366.562346894888, 3382.2728113455723, 4699.342092107107, 4779.402574678165, 4786.080490900548, 4812.566868981773, 4827.155247831615, 4390.253656878306, 4395.692301538894, 4403.735775853459, 4413.889652758675, 4415.20526305265, 5175.955497578436, 5199.272101905736, 5201.505856943584, 5218.66078704883, 5248.71132087735, 3587.94618080729, 3681.1901381695984, 3693.9815300923324, 3696.981515092434, 3701.5373078365205, 5409.459054094598, 5423.0, 5431.701256430894, 5443.510084092451, 5460.672359658393, 3699.4635777812605, 3704.6110158433517, 3709.888703338904, 3732.2162345907122, 3743.5882052974152, 3808.447775072654, 3809.9047523811573, 3812.0, 3813.218290250492, 3823.5220597425323, 4259.339802330582, 4351.695381323277, 4367.737935723867, 4369.934450983238, 4382.167388196232, 5116.232565115262, 5152.510511501401, 5164.354455693038, 5188.403333616682, 5219.608529360313, 1197.5748609243767, 1298.2016060122955, 1321.7752981993085, 1325.0, 1325.4101924643442, 823.472977294532, 829.2660995019452, 844.3371953016853, 849.405416208644, 850.2347886901838, 4079.4900637420324, 4126.958730412657, 4137.317342638491, 4144.772037537904, 4206.57934206583, 4761.595264402565, 4792.976035119802, 4802.639802014863, 4851.466338702739, 4855.441624213261, 4149.709520333608, 4163.354680024601, 4171.541130475706, 4179.393987871742, 4230.377166157003, 2447.547203767309, 2548.9107881224068, 2561.551728447514, 2563.551378508791, 2570.807189460798, 4511.639068874482, 4558.475775285819, 4566.5615331170575, 4570.748608826547, 4587.79354929029, 4847.636427267969, 4913.975430122898, 4921.26181072842, 4939.925901111486, 4954.950450495449, 4340.088581397878, 4344.545219977883, 4499.280115181556, 4528.366028756042, 4547.0, 4769.73766442849, 4782.0, 4795.889808484256, 4805.57318554128, 4841.232949973164, 4652.837150699709, 4717.113154738132, 4723.45680246776, 4728.446638815139, 4742.620590352694, 4257.084312059647, 4522.909541809079, 4522.932156017597, 4525.8189672414055, 4599.839005634787, 3474.5135681005186, 3487.9302413952087, 3489.808060556694, 3496.2483066140903, 3503.1783472594616, 4854.441739200037, 4903.53416425439, 4903.828366007173, 4912.877178070434, 5229.47705229474, 5197.142471492161, 5268.550124192269, 5275.208718692227, 5284.154535274338, 5285.68285902847, 5157.252198431132, 5174.534291913746, 5196.53231209193, 5199.76601052946, 5238.0833354162105, 4910.92633610489, 5155.407128180157, 5162.5869930406225, 5167.741612919414, 5194.35070616173, 5314.574834013192, 5316.707581082923, 5321.813736519203, 5338.145896656516, 5361.624686271924, 5153.3043039190725, 5177.508136727005, 5204.323437953042, 5209.609279303992, 5219.817306394258], "value": 3777.4043407512486, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.8929326661101, 680.8638272345529, 718.8526352097821, 735.8675438421085, 765.0933643632297, 12601.810972835403, 13590.456381744718, 13594.320283985799, 13647.727045459098, 13654.112482688643, 13307.467701291936, 13484.93257533711, 13511.662208444794, 13520.32398380082, 13536.661583460418, 618.5917294585574, 779.7076096463826, 798.3732769775727, 815.042325267811, 817.1950628630794, 795.741384050186, 796.55791035975, 798.0822054637184, 800.8038030682491, 803.4255507312271, 846.2172490446343, 846.9280111190557, 849.4775712936562, 852.3309202276214, 853.9615717292737, 841.7979684875617, 843.8101427178897, 845.9365547583956, 847.4322204123253, 847.8643417053241, 613.2089604410305, 613.714622700442, 615.8614311779859, 617.9320274769772, 618.245740196959, 11997.220180688228, 12012.339321337324, 12029.09781766371, 12039.699007524794, 12079.456424460832, 13716.451341946311, 13888.722225555533, 13919.652008699763, 13931.860681393258, 14021.789673154912, 10655.893441065646, 10692.358458492516, 10722.892771072267, 10786.676399708022, 10850.565977360897, 3327.1183136468853, 3335.8832440864453, 3360.8655653774063, 3366.73066154707, 3441.638627944055, 55929.72035139839, 56003.159952600334, 56303.43696563023, 58512.99999999957, 58808.705956470374, 10496.422696751752, 10499.47502624881, 10655.57377704883, 10701.678949631523, 10748.408837514013, 19015.1443185057, 19135.13891874869, 19206.519837004187, 19238.71141932872, 19472.70790938137, 6444.581102228341, 6580.76967306142, 6709.5303328767495, 6728.259891411941, 6773.322667733188, 3654.524911761454, 3731.981340093282, 3757.49273848027, 3858.864939727096, 3893.766374017568, 2995.9101226963226, 3328.2012317043736, 3495.8288973194267, 3501.352249833738, 3545.166885781839, 596.0969131765379, 596.7821745063108, 597.3638075449633, 600.8287638023143, 609.8170548835332, 505.50965563404174, 510.8518529626441, 519.64664028461, 537.7042626555457, 544.9918251226235, 8013.625761079686, 8072.878906816402, 8170.632321545426, 8406.957965210135, 8451.577421128919, 555.4362322242927, 576.1300436341155, 579.9507041901486, 606.7481994972126, 611.5382885921101, 3970.2059588082498, 3988.222296652125, 4033.270013837686, 4147.564505726916, 4164.292070348048, 91889.0, 97007.51496242615, 97732.0, 98065.50967245118, 100265.0, 54689.0, 58461.0, 87343.56328218318, 88428.5578572103, 89172.0, 75696.24303757002, 75936.62031689916, 77788.0, 78446.6077669608, 78852.0, 7759.379249660126, 7793.2596403341595, 7852.803679908048, 7898.2101789822855, 7900.881486777588, 46491.070178596914, 46980.0, 47573.28640070333, 47959.0, 48690.75654621846, 59962.40037599743, 60575.394246056974, 67415.0, 67496.66251668907, 67987.66006169938, 10020.248481364073, 10185.74535636615, 10472.68581942543, 10478.109360704426, 10638.680839574825, 11156.553737850396, 11372.919572640585, 11512.539498420305, 11526.538938442369, 11857.703557411134, 11192.776144476902, 11851.644450666494, 11891.46488408041, 12055.095867810125, 12812.963916366314, 12304.26174429537, 12422.937885310515, 12643.114981951543, 12906.548270810477, 13170.539031133865, 12292.139550231755, 12664.936675316565, 12674.176178548365, 12881.227126372447, 13130.0, 10186.49067546605, 10267.0, 10419.531121099417, 10613.893861061291, 10626.681199564026, 10408.791824163625, 10624.0, 10716.571337146426, 10720.517576709222, 10770.730731731455], "value": 6663.364703021909, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1593.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 111.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 132.0, 167.0, 180.0, 136.0, 165.0, 161.0, 141.0, 184.0, 138.0], "value": 155.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 165.0, 184.0, 164.0, 164.0, 163.0, 164.0, 164.0, 162.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 167.0, 76.0, 77.0, 77.0, 79.0, 156.0, 79.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 136.0, 86.0, 85.0, 84.0, 145.0, 87.0, 85.0, 140.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 149.0, 146.0, 147.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 67.0, 64.0, 66.0, 64.0, 66.0, 66.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 85.0, 84.0, 89.0, 90.0, 90.0, 85.0, 121.0, 85.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 145.0, 129.0, 136.0, 142.0, 139.0, 133.0, 134.0, 138.0, 150.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 170.0, 173.0, 175.0, 176.0, 167.0, 175.0, 169.0, 168.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 68.0, 69.0, 67.0, 66.0, 67.0, 70.0, 66.0, 68.0], "value": 68.0, "unit": "score"}]}]} 04:38:56 INFO - Return code: 0 04:38:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:38:56 ERROR - # TBPL SUCCESS # 04:38:56 INFO - Running post-action listener: _resource_record_post_action 04:38:56 INFO - ##### 04:38:56 INFO - ##### Finished run-tests step (success) 04:38:56 INFO - ##### 04:38:56 INFO - Running post-run listener: _resource_record_post_run 04:38:56 INFO - Total resource usage - Wall time: 1198s; CPU: 14.0%; Read bytes: 4096; Write bytes: 540012544; Read time: 16; Write time: 546600 04:38:56 INFO - TinderboxPrint: CPU usage
13.6% 04:38:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:38:56 INFO - TinderboxPrint: I/O write bytes / time
540,012,544 / 546,600 04:38:56 INFO - TinderboxPrint: CPU idle
8,261.9 (86.4%) 04:38:56 INFO - TinderboxPrint: CPU user
1,238.0 (12.9%) 04:38:56 INFO - TinderboxPrint: Swap in / out
0 / 0 04:38:56 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 221687808; Read time: 0; Write time: 264796 04:38:56 INFO - run-tests - Wall time: 1182s; CPU: 14.0%; Read bytes: 4096; Write bytes: 295657472; Read time: 16; Write time: 278284 04:38:57 INFO - Running post-run listener: _upload_blobber_files 04:38:57 INFO - Blob upload gear active. 04:38:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:38:57 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 04:38:57 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:38:57 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:38:57 INFO - (blobuploader) - INFO - Open directory for files ... 04:38:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:38:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:38:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:39:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:02 INFO - (blobuploader) - INFO - Done attempting. 04:39:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:39:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:39:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:03 INFO - (blobuploader) - INFO - Done attempting. 04:39:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:39:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:39:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:03 INFO - (blobuploader) - INFO - Done attempting. 04:39:03 INFO - (blobuploader) - INFO - Iteration through files over. 04:39:03 INFO - Return code: 0 04:39:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:39:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:39:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ff540dec8dd58e74f5a920546f1e8c4c2defedfe8783b1b31d94b33904293e081b4262259f6ec53a5a0d2335afc9a836f86d98df82bbfc6997da3b8f9667817", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a26740e23032f21eab9b83df0998beb538c0ddd955c81d1c28f20843a185920d4388c85ef1a0c1de4217a0fdf7e4b1329be3aed7a46317b7d1e2851db0b78e9e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ee4861d2ce5a6bcab9436a0cc9c6f37965523963a0455eceb861b09524e28ff94d209cd443f735dca22b81f67fbbeff24725b09ef67e39650cf4e352640f5a6"} 04:39:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:39:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:39:03 INFO - Contents: 04:39:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4ff540dec8dd58e74f5a920546f1e8c4c2defedfe8783b1b31d94b33904293e081b4262259f6ec53a5a0d2335afc9a836f86d98df82bbfc6997da3b8f9667817", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a26740e23032f21eab9b83df0998beb538c0ddd955c81d1c28f20843a185920d4388c85ef1a0c1de4217a0fdf7e4b1329be3aed7a46317b7d1e2851db0b78e9e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ee4861d2ce5a6bcab9436a0cc9c6f37965523963a0455eceb861b09524e28ff94d209cd443f735dca22b81f67fbbeff24725b09ef67e39650cf4e352640f5a6"} 04:39:03 INFO - Running post-run listener: copy_logs_to_upload_dir 04:39:03 INFO - Copying logs to upload dir... 04:39:03 INFO - mkdir: /builds/slave/test/build/upload/logs 04:39:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.561230 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-02 04:39:03.466538) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 04:39:03.469997) ========= 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=eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620 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-Non-PGO/sha512/4ff540dec8dd58e74f5a920546f1e8c4c2defedfe8783b1b31d94b33904293e081b4262259f6ec53a5a0d2335afc9a836f86d98df82bbfc6997da3b8f9667817", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a26740e23032f21eab9b83df0998beb538c0ddd955c81d1c28f20843a185920d4388c85ef1a0c1de4217a0fdf7e4b1329be3aed7a46317b7d1e2851db0b78e9e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ee4861d2ce5a6bcab9436a0cc9c6f37965523963a0455eceb861b09524e28ff94d209cd443f735dca22b81f67fbbeff24725b09ef67e39650cf4e352640f5a6"} build_url:https://queue.taskcluster.net/v1/task/OhWcFBPSSoGAZx2bt15vlw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.012109 build_url: 'https://queue.taskcluster.net/v1/task/OhWcFBPSSoGAZx2bt15vlw/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-Non-PGO/sha512/4ff540dec8dd58e74f5a920546f1e8c4c2defedfe8783b1b31d94b33904293e081b4262259f6ec53a5a0d2335afc9a836f86d98df82bbfc6997da3b8f9667817", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a26740e23032f21eab9b83df0998beb538c0ddd955c81d1c28f20843a185920d4388c85ef1a0c1de4217a0fdf7e4b1329be3aed7a46317b7d1e2851db0b78e9e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9ee4861d2ce5a6bcab9436a0cc9c6f37965523963a0455eceb861b09524e28ff94d209cd443f735dca22b81f67fbbeff24725b09ef67e39650cf4e352640f5a6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 04:39:03.496707) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:39:03.497062) ========= 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=eca2ab57546de7b41f256b19000001ef-1464866206.401085-1133007620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 04:39:03.581501) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 04:39:03.581829) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 04:39:03.582124) ========= ========= Total master_lag: 0.18 =========