builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1464893595.88 results: success (0) buildid: 20160601061753 builduid: 0096620e028e41ca850770a1362868eb revision: 111970c73823 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:15.884458) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:15.884917) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:15.885200) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:15.915742) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:15.916122) ========= 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=232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 11:53:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 70.4M=0s 2016-06-02 11:53:16 (70.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121197 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:16.051593) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:16.051928) ========= 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=232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014167 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:16.101539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 11:53:16.101907) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 111970c73823 --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 111970c73823 --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=232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 11:53:16,496 Setting DEBUG logging. 2016-06-02 11:53:16,496 attempt 1/10 2016-06-02 11:53:16,496 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/111970c73823?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 11:53:17,916 unpacking tar archive at: mozilla-central-111970c73823/testing/mozharness/ program finished with exit code 0 elapsedTime=1.770467 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 11:53:17.885708) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:17.886038) ========= script_repo_revision: 111970c73823 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:17.886432) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:17.886744) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:17.896388) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-02 11:53:17.896719) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:53:18 INFO - MultiFileLogger online at 20160602 11:53:18 in /builds/slave/test 11:53:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:53:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:53:18 INFO - {'append_to_log': False, 11:53:18 INFO - 'base_work_dir': '/builds/slave/test', 11:53:18 INFO - 'blob_upload_branch': 'Firefox', 11:53:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:53:18 INFO - 'branch': 'Firefox', 11:53:18 INFO - 'buildbot_json_path': 'buildprops.json', 11:53:18 INFO - 'config_files': ('talos/linux_config.py',), 11:53:18 INFO - 'default_actions': ('clobber', 11:53:18 INFO - 'read-buildbot-config', 11:53:18 INFO - 'download-and-extract', 11:53:18 INFO - 'populate-webroot', 11:53:18 INFO - 'create-virtualenv', 11:53:18 INFO - 'install', 11:53:18 INFO - 'run-tests'), 11:53:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:53:18 INFO - 'download_minidump_stackwalk': True, 11:53:18 INFO - 'download_symbols': 'ondemand', 11:53:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:53:18 INFO - 'tooltool.py': '/tools/tooltool.py', 11:53:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:53:18 INFO - '/tools/misc-python/virtualenv.py')}, 11:53:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:53:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:53:18 INFO - 'installer_path': 'installer.exe', 11:53:18 INFO - 'log_level': 'info', 11:53:18 INFO - 'log_name': 'talos', 11:53:18 INFO - 'log_to_console': True, 11:53:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:53:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:53:18 INFO - 'opt_config_files': (), 11:53:18 INFO - 'pip_index': False, 11:53:18 INFO - 'sps_profile': False, 11:53:18 INFO - 'sps_profile_interval': 0, 11:53:18 INFO - 'suite': 'dromaeojs-e10s', 11:53:18 INFO - 'system_bits': '32', 11:53:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:53:18 INFO - 'title': 'talos-linux64-ix-025', 11:53:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:53:18 INFO - 'use_talos_json': True, 11:53:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:53:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:53:18 INFO - 'work_dir': 'build'} 11:53:18 INFO - ##### 11:53:18 INFO - ##### Running clobber step. 11:53:18 INFO - ##### 11:53:18 INFO - Running pre-action listener: _resource_record_pre_action 11:53:18 INFO - Running main action method: clobber 11:53:18 INFO - rmtree: /builds/slave/test/build 11:53:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:53:18 INFO - Running post-action listener: _resource_record_post_action 11:53:18 INFO - ##### 11:53:18 INFO - ##### Finished clobber step (success) 11:53:18 INFO - ##### 11:53:18 INFO - ##### 11:53:18 INFO - ##### Running read-buildbot-config step. 11:53:18 INFO - ##### 11:53:18 INFO - Running pre-action listener: _resource_record_pre_action 11:53:18 INFO - Running main action method: read_buildbot_config 11:53:18 INFO - Using buildbot properties: 11:53:18 INFO - { 11:53:18 INFO - "project": "", 11:53:18 INFO - "product": "firefox", 11:53:18 INFO - "script_repo_revision": "production", 11:53:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:53:18 INFO - "repository": "", 11:53:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:53:18 INFO - "buildid": "20160601061753", 11:53:18 INFO - "stage_platform": "linux64-pgo", 11:53:18 INFO - "basedir": "/builds/slave/test", 11:53:18 INFO - "nightly_build": "True", 11:53:18 INFO - "buildnumber": 233, 11:53:18 INFO - "slavename": "talos-linux64-ix-025", 11:53:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:53:18 INFO - "platform": "ubuntu64_hw", 11:53:18 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 11:53:18 INFO - "branch": "mozilla-central", 11:53:18 INFO - "repo_path": "mozilla-central", 11:53:18 INFO - "revision": "111970c73823", 11:53:18 INFO - "pgo_build": "True", 11:53:18 INFO - "builduid": "0096620e028e41ca850770a1362868eb", 11:53:18 INFO - "slavebuilddir": "test" 11:53:18 INFO - } 11:53:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:53:18 INFO - Running post-action listener: _resource_record_post_action 11:53:18 INFO - ##### 11:53:18 INFO - ##### Finished read-buildbot-config step (success) 11:53:18 INFO - ##### 11:53:18 INFO - ##### 11:53:18 INFO - ##### Running download-and-extract step. 11:53:18 INFO - ##### 11:53:18 INFO - Running pre-action listener: _resource_record_pre_action 11:53:18 INFO - Running main action method: download_and_extract 11:53:18 INFO - mkdir: /builds/slave/test/build/tests 11:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:18 INFO - https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:53:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:53:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:53:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/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 11:53:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/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 11:53:19 INFO - Downloaded 1361 bytes. 11:53:19 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:53:19 INFO - Using the following test package requirements: 11:53:19 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:53:19 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:53:19 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:53:19 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:19 INFO - u'jsshell-linux-x86_64.zip'], 11:53:19 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:53:19 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:53:19 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:53:19 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:53:19 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:53:19 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:53:19 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:53:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:19 INFO - https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:53:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:53:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:53:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/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 11:53:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/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 11:53:20 INFO - Downloaded 24422301 bytes. 11:53:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:53:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:53:22 INFO - Return code: 0 11:53:22 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 11:53:22 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')]} 11:53:22 INFO - https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:53:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:53:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:53:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/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 11:53:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/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 11:53:23 INFO - Downloaded 24422301 bytes. 11:53: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'] 11:53: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 11:53:24 INFO - Return code: 0 11:53: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')]} 11:53:24 INFO - https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:53:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:53:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:53:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/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 11:53:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/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 11:53:25 INFO - Downloaded 10834055 bytes. 11:53:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:53:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:53:25 INFO - Return code: 0 11:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:25 INFO - https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:53:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:53:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:53:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/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 11:53:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NfYdbYkiRBa3aw0gSllbIA/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 11:53:31 INFO - Downloaded 59024865 bytes. 11:53:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:53:31 INFO - mkdir: /builds/slave/test/properties 11:53:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:53:31 INFO - Writing to file /builds/slave/test/properties/build_url 11:53:31 INFO - Contents: 11:53:31 INFO - build_url:https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:53:32 INFO - Running post-action listener: _resource_record_post_action 11:53:32 INFO - Running post-action listener: set_extra_try_arguments 11:53:32 INFO - ##### 11:53:32 INFO - ##### Finished download-and-extract step (success) 11:53:32 INFO - ##### 11:53:32 INFO - ##### 11:53:32 INFO - ##### Running populate-webroot step. 11:53:32 INFO - ##### 11:53:32 INFO - Running pre-action listener: _resource_record_pre_action 11:53:32 INFO - Running main action method: populate_webroot 11:53:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:53:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:53:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:53:32 INFO - '--tppagecycles', 11:53:32 INFO - '7'], 11:53:32 INFO - 'tests': ['tsvgm']}}, 11:53:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:53:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:53:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:53:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:53:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:53:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:53:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:32 INFO - 'talos_options': ['--disable-e10s'], 11:53:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:53:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:53:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:32 INFO - 'talos_options': ['--disable-e10s'], 11:53:32 INFO - 'tests': ['damp', 'tps']}, 11:53:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:32 INFO - 'tests': ['damp', 'tps']}, 11:53:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:53:32 INFO - 'tests': ['dromaeo_dom']}, 11:53:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:53:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:53:32 INFO - 'tests': ['a11yr', 11:53:32 INFO - 'ts_paint', 11:53:32 INFO - 'tpaint', 11:53:32 INFO - 'sessionrestore', 11:53:32 INFO - 'sessionrestore_no_auto_restore', 11:53:32 INFO - 'tabpaint']}, 11:53:32 INFO - 'other-e10s': {'tests': ['a11yr', 11:53:32 INFO - 'ts_paint', 11:53:32 INFO - 'tpaint', 11:53:32 INFO - 'sessionrestore', 11:53:32 INFO - 'sessionrestore_no_auto_restore', 11:53:32 INFO - 'tabpaint']}, 11:53:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:53:32 INFO - 'ts_paint', 11:53:32 INFO - 'tpaint', 11:53:32 INFO - 'sessionrestore', 11:53:32 INFO - 'sessionrestore_no_auto_restore', 11:53:32 INFO - 'tabpaint']}, 11:53:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:53:32 INFO - 'ts_paint', 11:53:32 INFO - 'tpaint', 11:53:32 INFO - 'sessionrestore', 11:53:32 INFO - 'sessionrestore_no_auto_restore', 11:53:32 INFO - 'tabpaint']}, 11:53:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:53:32 INFO - 'tests': ['a11yr', 11:53:32 INFO - 'ts_paint', 11:53:32 INFO - 'tpaint', 11:53:32 INFO - 'sessionrestore', 11:53:32 INFO - 'sessionrestore_no_auto_restore', 11:53:32 INFO - 'tabpaint']}, 11:53:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:53:32 INFO - 'tests': ['a11yr', 11:53:32 INFO - 'ts_paint', 11:53:32 INFO - 'tpaint', 11:53:32 INFO - 'sessionrestore', 11:53:32 INFO - 'sessionrestore_no_auto_restore', 11:53:32 INFO - 'tabpaint']}, 11:53:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:53:32 INFO - 'tests': ['tsvgx', 11:53:32 INFO - 'tsvgr_opacity', 11:53:32 INFO - 'tart', 11:53:32 INFO - 'tscrollx', 11:53:32 INFO - 'cart']}, 11:53:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:53:32 INFO - 'tsvgr_opacity', 11:53:32 INFO - 'tart', 11:53:32 INFO - 'tscrollx', 11:53:32 INFO - 'cart']}, 11:53:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:32 INFO - 'talos_options': ['--disable-e10s'], 11:53:32 INFO - 'tests': ['tp5o']}, 11:53:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:32 INFO - 'tests': ['tp5o']}, 11:53:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:32 INFO - 'talos_options': ['--disable-e10s', 11:53:32 INFO - '--xperf_path', 11:53:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:53:32 INFO - 'tests': ['tp5n']}, 11:53:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:32 INFO - 'talos_options': ['--xperf_path', 11:53:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:53:32 INFO - 'tests': ['tp5n']}}, 11:53:32 INFO - 'talos.zip': {'path': '', 11:53:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:53:32 INFO - Running post-action listener: _resource_record_post_action 11:53:32 INFO - ##### 11:53:32 INFO - ##### Finished populate-webroot step (success) 11:53:32 INFO - ##### 11:53:32 INFO - ##### 11:53:32 INFO - ##### Running create-virtualenv step. 11:53:32 INFO - ##### 11:53:32 INFO - Running pre-action listener: _resource_record_pre_action 11:53:32 INFO - Running main action method: create_virtualenv 11:53:32 INFO - Creating virtualenv /builds/slave/test/build/venv 11:53:32 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 11:53:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:53:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:53:32 INFO - Using real prefix '/usr' 11:53:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:53:32 INFO - Installing distribute.............................................................................................................................................................................................done. 11:53:34 INFO - Installing pip.................done. 11:53:34 INFO - Return code: 0 11:53:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:34 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 0x7f2c059e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c9c0>, '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 0x2c1d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1dd50>, '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': '232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999', '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 11:53:34 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 11:53:34 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 11:53:34 INFO - Using env: {'DISPLAY': ':0', 11:53:34 INFO - 'HOME': '/home/cltbld', 11:53:34 INFO - 'LANG': 'en_US.UTF-8', 11:53:34 INFO - 'LANGUAGE': 'en_US:en', 11:53:34 INFO - 'LOGNAME': 'cltbld', 11:53:34 INFO - 'MAIL': '/var/mail/cltbld', 11:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:34 INFO - 'MOZ_NO_REMOTE': '1', 11:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:34 INFO - 'NO_EM_RESTART': '1', 11:53:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:34 INFO - 'PWD': '/builds/slave/test', 11:53:34 INFO - 'SHELL': '/bin/bash', 11:53:34 INFO - 'SHLVL': '1', 11:53:34 INFO - 'TERM': 'linux', 11:53:34 INFO - 'TMOUT': '86400', 11:53:34 INFO - 'USER': 'cltbld', 11:53:34 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999', 11:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:34 INFO - '_': '/tools/buildbot/bin/python'} 11:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:34 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 11:53:34 INFO - Cleaning up... 11:53:34 INFO - Return code: 0 11:53:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:34 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 0x7f2c059e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c9c0>, '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 0x2c1d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1dd50>, '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': '232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999', '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 11:53:34 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 11:53:34 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 11:53:34 INFO - Using env: {'DISPLAY': ':0', 11:53:34 INFO - 'HOME': '/home/cltbld', 11:53:34 INFO - 'LANG': 'en_US.UTF-8', 11:53:34 INFO - 'LANGUAGE': 'en_US:en', 11:53:34 INFO - 'LOGNAME': 'cltbld', 11:53:34 INFO - 'MAIL': '/var/mail/cltbld', 11:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:34 INFO - 'MOZ_NO_REMOTE': '1', 11:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:34 INFO - 'NO_EM_RESTART': '1', 11:53:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:34 INFO - 'PWD': '/builds/slave/test', 11:53:34 INFO - 'SHELL': '/bin/bash', 11:53:34 INFO - 'SHLVL': '1', 11:53:34 INFO - 'TERM': 'linux', 11:53:34 INFO - 'TMOUT': '86400', 11:53:34 INFO - 'USER': 'cltbld', 11:53:34 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999', 11:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:34 INFO - '_': '/tools/buildbot/bin/python'} 11:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:35 INFO - Downloading/unpacking psutil>=3.1.1 11:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:53:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:53:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:53:37 INFO - Installing collected packages: psutil 11:53:37 INFO - Running setup.py install for psutil 11:53:37 INFO - building 'psutil._psutil_linux' extension 11:53:37 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 11:53:37 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 11:53:37 INFO - building 'psutil._psutil_posix' extension 11:53:37 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 11:53:37 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 11:53:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:53:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:53:37 INFO - Successfully installed psutil 11:53:37 INFO - Cleaning up... 11:53:37 INFO - Return code: 0 11:53:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:53: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')]} 11:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53: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')]} 11:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c059e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c9c0>, '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 0x2c1d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1dd50>, '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': '232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999', '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 11:53: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:53: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 mozsystemmonitor==0.3 11:53:37 INFO - Using env: {'DISPLAY': ':0', 11:53:37 INFO - 'HOME': '/home/cltbld', 11:53:37 INFO - 'LANG': 'en_US.UTF-8', 11:53:37 INFO - 'LANGUAGE': 'en_US:en', 11:53:37 INFO - 'LOGNAME': 'cltbld', 11:53:37 INFO - 'MAIL': '/var/mail/cltbld', 11:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:37 INFO - 'MOZ_NO_REMOTE': '1', 11:53:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:37 INFO - 'NO_EM_RESTART': '1', 11:53:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:37 INFO - 'PWD': '/builds/slave/test', 11:53:37 INFO - 'SHELL': '/bin/bash', 11:53:37 INFO - 'SHLVL': '1', 11:53:37 INFO - 'TERM': 'linux', 11:53:37 INFO - 'TMOUT': '86400', 11:53:37 INFO - 'USER': 'cltbld', 11:53:37 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999', 11:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:37 INFO - '_': '/tools/buildbot/bin/python'} 11:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:53:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:53:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:53:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:53:39 INFO - Installing collected packages: mozsystemmonitor 11:53:39 INFO - Running setup.py install for mozsystemmonitor 11:53:39 INFO - Successfully installed mozsystemmonitor 11:53:39 INFO - Cleaning up... 11:53:39 INFO - Return code: 0 11:53:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:53: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')]} 11:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53: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')]} 11:53:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53: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', '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 0x7f2c059e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c9c0>, '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 0x2c1d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1dd50>, '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': '232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999', '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 11:53: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:53: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 blobuploader==1.2.4 11:53:39 INFO - Using env: {'DISPLAY': ':0', 11:53:39 INFO - 'HOME': '/home/cltbld', 11:53:39 INFO - 'LANG': 'en_US.UTF-8', 11:53:39 INFO - 'LANGUAGE': 'en_US:en', 11:53:39 INFO - 'LOGNAME': 'cltbld', 11:53:39 INFO - 'MAIL': '/var/mail/cltbld', 11:53:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:39 INFO - 'MOZ_NO_REMOTE': '1', 11:53:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:39 INFO - 'NO_EM_RESTART': '1', 11:53:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:39 INFO - 'PWD': '/builds/slave/test', 11:53:39 INFO - 'SHELL': '/bin/bash', 11:53:39 INFO - 'SHLVL': '1', 11:53:39 INFO - 'TERM': 'linux', 11:53:39 INFO - 'TMOUT': '86400', 11:53:39 INFO - 'USER': 'cltbld', 11:53:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999', 11:53:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:39 INFO - '_': '/tools/buildbot/bin/python'} 11:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:40 INFO - Downloading/unpacking blobuploader==1.2.4 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:53:41 INFO - Downloading blobuploader-1.2.4.tar.gz 11:53:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:53:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:53:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:53:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:53:42 INFO - Downloading docopt-0.6.1.tar.gz 11:53:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:53:42 INFO - Installing collected packages: blobuploader, requests, docopt 11:53:42 INFO - Running setup.py install for blobuploader 11:53:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:53:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:53:42 INFO - Running setup.py install for requests 11:53:43 INFO - Running setup.py install for docopt 11:53:43 INFO - Successfully installed blobuploader requests docopt 11:53:43 INFO - Cleaning up... 11:53:43 INFO - Return code: 0 11:53:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:53:43 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')]} 11:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:43 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')]} 11:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:43 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 0x7f2c059e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c9c0>, '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 0x2c1d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1dd50>, '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': '232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999', '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 11:53:43 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 11:53:43 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 11:53:43 INFO - Using env: {'DISPLAY': ':0', 11:53:43 INFO - 'HOME': '/home/cltbld', 11:53:43 INFO - 'LANG': 'en_US.UTF-8', 11:53:43 INFO - 'LANGUAGE': 'en_US:en', 11:53:43 INFO - 'LOGNAME': 'cltbld', 11:53:43 INFO - 'MAIL': '/var/mail/cltbld', 11:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:43 INFO - 'MOZ_NO_REMOTE': '1', 11:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:43 INFO - 'NO_EM_RESTART': '1', 11:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:43 INFO - 'PWD': '/builds/slave/test', 11:53:43 INFO - 'SHELL': '/bin/bash', 11:53:43 INFO - 'SHLVL': '1', 11:53:43 INFO - 'TERM': 'linux', 11:53:43 INFO - 'TMOUT': '86400', 11:53:43 INFO - 'USER': 'cltbld', 11:53:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999', 11:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:43 INFO - '_': '/tools/buildbot/bin/python'} 11:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:53:43 INFO - Running setup.py (path:/tmp/pip-GvRNtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:53:43 INFO - Running setup.py (path:/tmp/pip-uy7cBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:53:43 INFO - Running setup.py (path:/tmp/pip-Vh1s56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:53:43 INFO - Running setup.py (path:/tmp/pip-X2TIxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:53:43 INFO - Running setup.py (path:/tmp/pip-H6Bhe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:53:43 INFO - Running setup.py (path:/tmp/pip-XkheXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:53:43 INFO - Running setup.py (path:/tmp/pip-dujYMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:53:44 INFO - Running setup.py (path:/tmp/pip-Av8JqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:53:44 INFO - Running setup.py (path:/tmp/pip-0_H5kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:53:44 INFO - Running setup.py (path:/tmp/pip-67gKeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:53:44 INFO - Running setup.py (path:/tmp/pip-h3txTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:53:44 INFO - Running setup.py (path:/tmp/pip-g7sJ0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:53:44 INFO - Running setup.py (path:/tmp/pip-xoiDlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:53:44 INFO - Running setup.py (path:/tmp/pip-7WxDl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:53:44 INFO - Running setup.py (path:/tmp/pip-dnW21p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:53:44 INFO - Running setup.py (path:/tmp/pip-A4u8vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:53:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:53:44 INFO - Running setup.py (path:/tmp/pip-6yg318-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:53:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:53:44 INFO - Running setup.py install for manifestparser 11:53:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:53:44 INFO - Running setup.py install for mozcrash 11:53:44 INFO - Running setup.py install for mozdebug 11:53:45 INFO - Running setup.py install for mozdevice 11:53:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:53:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:53:45 INFO - Running setup.py install for mozfile 11:53:45 INFO - Running setup.py install for mozhttpd 11:53:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:53:45 INFO - Running setup.py install for mozinfo 11:53:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:53:45 INFO - Running setup.py install for mozInstall 11:53:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:53:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:53:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:53:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:53:45 INFO - Running setup.py install for mozleak 11:53:45 INFO - Running setup.py install for mozlog 11:53:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:53:45 INFO - Running setup.py install for moznetwork 11:53:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:53:45 INFO - Running setup.py install for mozprocess 11:53:46 INFO - Running setup.py install for mozprofile 11:53:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:53:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:53:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:53:46 INFO - Running setup.py install for mozrunner 11:53:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:53:46 INFO - Running setup.py install for mozscreenshot 11:53:46 INFO - Running setup.py install for moztest 11:53:46 INFO - Running setup.py install for mozversion 11:53:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:53:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:53:46 INFO - Cleaning up... 11:53:46 INFO - Return code: 0 11:53:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:46 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 0x7f2c059e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c9c0>, '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 0x2c1d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1dd50>, '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': '232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999', '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 11:53:46 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 11:53:46 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 11:53:46 INFO - Using env: {'DISPLAY': ':0', 11:53:46 INFO - 'HOME': '/home/cltbld', 11:53:46 INFO - 'LANG': 'en_US.UTF-8', 11:53:46 INFO - 'LANGUAGE': 'en_US:en', 11:53:46 INFO - 'LOGNAME': 'cltbld', 11:53:46 INFO - 'MAIL': '/var/mail/cltbld', 11:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:46 INFO - 'MOZ_NO_REMOTE': '1', 11:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:46 INFO - 'NO_EM_RESTART': '1', 11:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:46 INFO - 'PWD': '/builds/slave/test', 11:53:46 INFO - 'SHELL': '/bin/bash', 11:53:46 INFO - 'SHLVL': '1', 11:53:46 INFO - 'TERM': 'linux', 11:53:46 INFO - 'TMOUT': '86400', 11:53:46 INFO - 'USER': 'cltbld', 11:53:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999', 11:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:46 INFO - '_': '/tools/buildbot/bin/python'} 11:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:53:46 INFO - Running setup.py (path:/tmp/pip-rM1zcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:53:46 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)) 11:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:53:46 INFO - Running setup.py (path:/tmp/pip-a4UZMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:53:46 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)) 11:53:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:53:46 INFO - Running setup.py (path:/tmp/pip-nRFN3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:53:47 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)) 11:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:53:47 INFO - Running setup.py (path:/tmp/pip-uDInvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:53:47 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)) 11:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:53:47 INFO - Running setup.py (path:/tmp/pip-HeqMx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:53:47 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)) 11:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:53:47 INFO - Running setup.py (path:/tmp/pip-Asu4ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:53:47 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)) 11:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:53:47 INFO - Running setup.py (path:/tmp/pip-qJRI53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:53:47 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)) 11:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:53:47 INFO - Running setup.py (path:/tmp/pip-AypRFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:53:47 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)) 11:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:53:47 INFO - Running setup.py (path:/tmp/pip-Z1YXlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:53:47 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)) 11:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:53:47 INFO - Running setup.py (path:/tmp/pip-_4gHFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:53:47 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)) 11:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:53:47 INFO - Running setup.py (path:/tmp/pip-tEP59i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:53:47 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)) 11:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:53:47 INFO - Running setup.py (path:/tmp/pip-HGo4FG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:53:47 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)) 11:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:53:47 INFO - Running setup.py (path:/tmp/pip-sczv3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:53:47 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)) 11:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:53:47 INFO - Running setup.py (path:/tmp/pip-Cksvz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:53:47 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)) 11:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:53:47 INFO - Running setup.py (path:/tmp/pip-cwLluq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:53:47 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)) 11:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:53:47 INFO - Running setup.py (path:/tmp/pip-tS9DkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:53:47 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)) 11:53:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:53:47 INFO - Running setup.py (path:/tmp/pip-3DfwiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:53:48 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)) 11:53:48 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)) 11:53:48 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)) 11:53:48 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)) 11:53:48 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)) 11:53:48 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)) 11:53:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:49 INFO - Downloading blessings-1.6.tar.gz 11:53:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:53:50 INFO - Installing collected packages: blessings 11:53:50 INFO - Running setup.py install for blessings 11:53:50 INFO - Successfully installed blessings 11:53:50 INFO - Cleaning up... 11:53:50 INFO - Return code: 0 11:53:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:53:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:53:50 INFO - Reading from file tmpfile_stdout 11:53:50 INFO - Current package versions: 11:53:50 INFO - argparse == 1.2.1 11:53:50 INFO - blessings == 1.6 11:53:50 INFO - blobuploader == 1.2.4 11:53:50 INFO - docopt == 0.6.1 11:53:50 INFO - manifestparser == 1.1 11:53:50 INFO - mozInstall == 1.12 11:53:50 INFO - mozcrash == 0.17 11:53:50 INFO - mozdebug == 0.1 11:53:50 INFO - mozdevice == 0.48 11:53:50 INFO - mozfile == 1.2 11:53:50 INFO - mozhttpd == 0.7 11:53:50 INFO - mozinfo == 0.9 11:53:50 INFO - mozleak == 0.1 11:53:50 INFO - mozlog == 3.2 11:53:50 INFO - moznetwork == 0.27 11:53:50 INFO - mozprocess == 0.22 11:53:50 INFO - mozprofile == 0.28 11:53:50 INFO - mozrunner == 6.11 11:53:50 INFO - mozscreenshot == 0.1 11:53:50 INFO - mozsystemmonitor == 0.3 11:53:50 INFO - moztest == 0.7 11:53:50 INFO - mozversion == 1.4 11:53:50 INFO - psutil == 3.1.1 11:53:50 INFO - requests == 1.2.3 11:53:50 INFO - wsgiref == 0.1.2 11:53:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:50 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 0x7f2c059e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c9c0>, '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 0x2c1d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1dd50>, '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': '232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999', '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 11:53:50 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 11:53:50 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 11:53:50 INFO - Using env: {'DISPLAY': ':0', 11:53:50 INFO - 'HOME': '/home/cltbld', 11:53:50 INFO - 'LANG': 'en_US.UTF-8', 11:53:50 INFO - 'LANGUAGE': 'en_US:en', 11:53:50 INFO - 'LOGNAME': 'cltbld', 11:53:50 INFO - 'MAIL': '/var/mail/cltbld', 11:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:50 INFO - 'MOZ_NO_REMOTE': '1', 11:53:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:50 INFO - 'NO_EM_RESTART': '1', 11:53:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:50 INFO - 'PWD': '/builds/slave/test', 11:53:50 INFO - 'SHELL': '/bin/bash', 11:53:50 INFO - 'SHLVL': '1', 11:53:50 INFO - 'TERM': 'linux', 11:53:50 INFO - 'TMOUT': '86400', 11:53:50 INFO - 'USER': 'cltbld', 11:53:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999', 11:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:50 INFO - '_': '/tools/buildbot/bin/python'} 11:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:50 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)) 11:53:50 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)) 11:53:50 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)) 11:53:50 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)) 11:53:50 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)) 11:53:50 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)) 11:53:50 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)) 11:53:50 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)) 11:53:50 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)) 11:53:50 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)) 11:53:50 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)) 11:53:50 INFO - Cleaning up... 11:53:50 INFO - Return code: 0 11:53:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:50 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 0x7f2c059e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c9c0>, '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 0x2c1d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1dd50>, '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': '232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999', '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 11:53:50 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 11:53:50 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 11:53:50 INFO - Using env: {'DISPLAY': ':0', 11:53:50 INFO - 'HOME': '/home/cltbld', 11:53:50 INFO - 'LANG': 'en_US.UTF-8', 11:53:50 INFO - 'LANGUAGE': 'en_US:en', 11:53:50 INFO - 'LOGNAME': 'cltbld', 11:53:50 INFO - 'MAIL': '/var/mail/cltbld', 11:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:50 INFO - 'MOZ_NO_REMOTE': '1', 11:53:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:50 INFO - 'NO_EM_RESTART': '1', 11:53:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:50 INFO - 'PWD': '/builds/slave/test', 11:53:50 INFO - 'SHELL': '/bin/bash', 11:53:50 INFO - 'SHLVL': '1', 11:53:50 INFO - 'TERM': 'linux', 11:53:50 INFO - 'TMOUT': '86400', 11:53:50 INFO - 'USER': 'cltbld', 11:53:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999', 11:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:50 INFO - '_': '/tools/buildbot/bin/python'} 11:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:50 INFO - Downloading/unpacking jsonschema 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:53:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:53:52 INFO - Downloading/unpacking functools32 (from jsonschema) 11:53:52 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 11:53:52 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 11:53:52 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 11:53:52 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 11:53:52 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 11:53:52 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 11:53:52 INFO - Downloading functools32-3.2.3-2.tar.gz 11:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:53:53 INFO - warning: no files found matching '*.txt' 11:53:53 INFO - no previously-included directories found matching 'build' 11:53:53 INFO - no previously-included directories found matching 'dist' 11:53:53 INFO - no previously-included directories found matching '.git*' 11:53:53 INFO - Installing collected packages: jsonschema, functools32 11:53:53 INFO - Running setup.py install for functools32 11:53:53 INFO - warning: no files found matching '*.txt' 11:53:53 INFO - no previously-included directories found matching 'build' 11:53:53 INFO - no previously-included directories found matching 'dist' 11:53:53 INFO - no previously-included directories found matching '.git*' 11:53:53 INFO - Successfully installed jsonschema functools32 11:53:53 INFO - Cleaning up... 11:53:53 INFO - Return code: 0 11:53:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:53:53 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')]} 11:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:53 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')]} 11:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:53 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 0x7f2c059e2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c1c9c0>, '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 0x2c1d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1dd50>, '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': '232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999', '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 11:53:53 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 11:53:53 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 11:53:53 INFO - Using env: {'DISPLAY': ':0', 11:53:53 INFO - 'HOME': '/home/cltbld', 11:53:53 INFO - 'LANG': 'en_US.UTF-8', 11:53:53 INFO - 'LANGUAGE': 'en_US:en', 11:53:53 INFO - 'LOGNAME': 'cltbld', 11:53:53 INFO - 'MAIL': '/var/mail/cltbld', 11:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:53 INFO - 'MOZ_NO_REMOTE': '1', 11:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:53 INFO - 'NO_EM_RESTART': '1', 11:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:53 INFO - 'PWD': '/builds/slave/test', 11:53:53 INFO - 'SHELL': '/bin/bash', 11:53:53 INFO - 'SHLVL': '1', 11:53:53 INFO - 'TERM': 'linux', 11:53:53 INFO - 'TMOUT': '86400', 11:53:53 INFO - 'USER': 'cltbld', 11:53:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999', 11:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:53 INFO - '_': '/tools/buildbot/bin/python'} 11:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:53 INFO - Downloading/unpacking flake8 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:53:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:53:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:53:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:53:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:53:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:53: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 11:53:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:53:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:53:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:53:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:53:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:53:55 INFO - no previously-included directories found matching 'docs/_build' 11:53:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:53:56 INFO - Running setup.py install for pep8 11:53:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:53:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:53:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:53:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:53:56 INFO - no previously-included directories found matching 'docs/_build' 11:53:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:53:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:53:56 INFO - Cleaning up... 11:53:56 INFO - Return code: 0 11:53:56 INFO - Running post-action listener: _resource_record_post_action 11:53:56 INFO - Running post-action listener: _start_resource_monitoring 11:53:56 INFO - Starting resource monitoring. 11:53:56 INFO - ##### 11:53:56 INFO - ##### Finished create-virtualenv step (success) 11:53:56 INFO - ##### 11:53:56 INFO - ##### 11:53:56 INFO - ##### Running install step. 11:53:56 INFO - ##### 11:53:56 INFO - Running pre-action listener: _resource_record_pre_action 11:53:56 INFO - Running main action method: install 11:53:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:53:56 INFO - Reading from file tmpfile_stdout 11:53:56 INFO - Detecting whether we're running mozinstall >=1.0... 11:53:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:53:56 INFO - Reading from file tmpfile_stdout 11:53:56 INFO - Output received: 11:53:56 INFO - Usage: mozinstall [options] installer 11:53:56 INFO - Options: 11:53:56 INFO - -h, --help show this help message and exit 11:53:56 INFO - -d DEST, --destination=DEST 11:53:56 INFO - Directory to install application into. [default: 11:53:56 INFO - "/builds/slave/test"] 11:53:56 INFO - --app=APP Application being installed. [default: firefox] 11:53:56 INFO - mkdir: /builds/slave/test/build/application 11:53:56 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'] 11:53:56 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 11:54:13 INFO - Reading from file tmpfile_stdout 11:54:13 INFO - Output received: 11:54:13 INFO - /builds/slave/test/build/application/firefox/firefox 11:54:13 INFO - Running post-action listener: _resource_record_post_action 11:54:13 INFO - ##### 11:54:13 INFO - ##### Finished install step (success) 11:54:13 INFO - ##### 11:54:13 INFO - ##### 11:54:13 INFO - ##### Running run-tests step. 11:54:13 INFO - ##### 11:54:13 INFO - Running pre-action listener: _resource_record_pre_action 11:54:13 INFO - Running main action method: run_tests 11:54:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:54:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:54:13 INFO - Python 2.7.3 11:54:13 INFO - Return code: 0 11:54:13 INFO - grabbing minidump binary from tooltool 11:54:13 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')]} 11:54:13 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 0x2c1c9c0>, '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 0x2c1d8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c1dd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:54:13 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 11:54:13 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 11:54:13 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 11:54:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:54:13 INFO - Return code: 0 11:54:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:54:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:54:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:54:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:54:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:54:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:54:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:54:14 INFO - Return code: 0 11:54:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 11:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 11:54:14 INFO - Using env: {'DISPLAY': ':0', 11:54:14 INFO - 'HOME': '/home/cltbld', 11:54:14 INFO - 'LANG': 'en_US.UTF-8', 11:54:14 INFO - 'LANGUAGE': 'en_US:en', 11:54:14 INFO - 'LOGNAME': 'cltbld', 11:54:14 INFO - 'MAIL': '/var/mail/cltbld', 11:54:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:54:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:14 INFO - 'MOZ_NO_REMOTE': '1', 11:54:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:54:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:14 INFO - 'NO_EM_RESTART': '1', 11:54:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:14 INFO - 'PWD': '/builds/slave/test', 11:54:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:54:14 INFO - 'SHELL': '/bin/bash', 11:54:14 INFO - 'SHLVL': '1', 11:54:14 INFO - 'TERM': 'linux', 11:54:14 INFO - 'TMOUT': '86400', 11:54:14 INFO - 'USER': 'cltbld', 11:54:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999', 11:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:14 INFO - '_': '/tools/buildbot/bin/python'} 11:54:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 11:54:14 INFO - mozversion application_buildid: 20160601061753 11:54:14 INFO - mozversion application_changeset: 111970c738234569c8c180319155327316335deb 11:54:14 INFO - mozversion application_display_name: Nightly 11:54:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:54:14 INFO - mozversion application_name: Firefox 11:54:14 INFO - mozversion application_remotingname: firefox 11:54:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:54:14 INFO - mozversion application_vendor: Mozilla 11:54:14 INFO - mozversion application_version: 49.0a1 11:54:14 INFO - mozversion platform_buildid: 20160601061753 11:54:14 INFO - mozversion platform_changeset: 111970c738234569c8c180319155327316335deb 11:54:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:54:14 INFO - mozversion platform_version: 49.0a1 11:54:14 INFO - using testdate: 1464893654 11:54:14 INFO - actual date: 1464893654 11:54:14 INFO - starting webserver on 'localhost:49384' 11:54:14 INFO - SUITE-START | Running 2 tests 11:54:14 INFO - TEST-START | dromaeo_css 11:54:14 INFO - operating with platform_type : linux_ 11:54:14 INFO - Initialising browser for dromaeo_css test... 11:54:14 INFO - TEST-INFO | started process 20699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAuyTPl/profile http://localhost:49384/getInfo.html) 11:54:19 INFO - PROCESS | 20699 | __metrics Screen width/height:1600/1200 11:54:19 INFO - PROCESS | 20699 | colorDepth:24 11:54:19 INFO - PROCESS | 20699 | Browser inner width/height: 1024/697 11:54:19 INFO - PROCESS | 20699 | __metrics 11:54:19 ERROR - PROCESS | 20699 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 11:54:20 INFO - TEST-INFO | 20699: exit 0 11:54:20 INFO - Browser initialized. 11:54:20 INFO - Running cycle 1/1 for dromaeo_css test... 11:54:20 INFO - TEST-INFO | started process 20817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAuyTPl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:54:32 INFO - PROCESS | 20817 | RSS: Main: 166604800 11:54:32 INFO - PROCESS | 20817 | 11:55:22 INFO - PROCESS | 20817 | 1464893722082 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] 11:57:29 INFO - PROCESS | 20817 | Cycle 1(1): loaded http://localhost:49384/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49384/tests/dromaeo/cssquery-ext.html) 11:57:30 INFO - PROCESS | 20817 | RSS: Main: 171307008 11:57:30 INFO - PROCESS | 20817 | 12:00:32 INFO - PROCESS | 20817 | Cycle 1(1): loaded http://localhost:49384/tests/dromaeo/cssquery-ext.html (next: http://localhost:49384/tests/dromaeo/cssquery-jquery.html) 12:00:33 INFO - PROCESS | 20817 | RSS: Main: 169603072 12:00:33 INFO - PROCESS | 20817 | 12:03:35 INFO - PROCESS | 20817 | Cycle 1(1): loaded http://localhost:49384/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49384/tests/dromaeo/cssquery-mootools.html) 12:03:35 INFO - PROCESS | 20817 | RSS: Main: 170872832 12:03:35 INFO - PROCESS | 20817 | 12:06:37 INFO - PROCESS | 20817 | Cycle 1(1): loaded http://localhost:49384/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49384/tests/dromaeo/cssquery-prototype.html) 12:06:38 INFO - PROCESS | 20817 | RSS: Main: 168353792 12:06:38 INFO - PROCESS | 20817 | 12:09:40 INFO - PROCESS | 20817 | Cycle 1(1): loaded http://localhost:49384/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49384/tests/dromaeo/cssquery-yui.html) 12:09:41 INFO - PROCESS | 20817 | RSS: Main: 170291200 12:09:41 INFO - PROCESS | 20817 | 12:12:43 INFO - PROCESS | 20817 | Cycle 1(1): loaded http://localhost:49384/tests/dromaeo/cssquery-yui.html (next: http://localhost:49384/tests/dromaeo/cssquery-dojo.html) 12:12:44 INFO - PROCESS | 20817 | RSS: Main: 171663360 12:12:44 INFO - PROCESS | 20817 | 12:12:44 INFO - PROCESS | 20817 | __start_tp_report 12:12:44 INFO - PROCESS | 20817 | _x_x_mozilla_page_load 12:12:44 INFO - PROCESS | 20817 | _x_x_mozilla_page_load_details 12:12:44 INFO - PROCESS | 20817 | |i|pagename|runs| 12:12:44 INFO - PROCESS | 20817 | |0;dojo.html;3151.8108913465185;3169.524571314304;3190.377876314118;3221.8066915985028;3230.8384580770958;5426.077566813647;5455.481729235721;5464.972675136623;5486.670799752008;5552.361478429982;5333.38666053404;5424.321959755031;5430.67415955042;5467.289252397193;5477.397486276506;4930.679505832119;4968.975155124219;5061.924071138936;5107.540321371076;5145.382554093514;885.2927518446584;4872.585830204419;4941.678790878599;4984.601231901439;5051.419086805009;4967.677100988424;4987.5511203991455;5013.774380152902;5020.824271150511;5050.823221187259;5024.221245706921;5031.295618613397;5042.924356134661;5049.394072711299;5060.74696265189;4957.405111386621;4972.453030166679;4982.078315511642;4991.700497970097;5002.19964805633;5350.250964864922;5381.730913454312;5410.810621628263;5414.593905457067;5438.428964958702;5703.828885133453;5707.086866101404;5859.1797148399255;5890.911636325459;5891.204687367193;5778.566607504454;5815.912761308541;5837.387074357174;5852;5937.346891841894;5456.290682211326;5482.80810171642;5487;5499.587530935196;5503.972480137613;5790;5956.7319470623925;5988.820335389858;5992.940070599326;6005.189299444606;5674.801381951612;5699.316082070178;5704.0588302929555;5704.600677952587;5706.629069110494;5879.029960056543;5881.882362352729;5888.146218798251;5889.969255380377;5890.440408161217;5858.414158584107;5882.441168089024;5890.145928840294;5910.143029260733;5954.434328738763;5853.9414605854245;5863.765449382062;5888.5289176865745;5892.410758924073;5896.941030589725;4320.308750599889;4439.200943830077;4439.42287502629;4465.0623369092855;4490.685652004394;3896.162325100117;3940.6059394060367;3956.782376969237;3982.5818289079807;4001.8599349023225;5491.807786727445;5493.615446918758;5531.612787104945;5623.493885550321;5625.774969001276;5762.164486149485;5914.733836977346;5953.553483488756;5954.136650185699;5957.4638282553915;5449.782008719607;5480.314960629921;5510.366307874566;5531.170324451365;5546.251256080458;4971;5024.57291130258;5045.8738531537;5050.217216331474;5081.110805609003;5787.623804452782;6012.128241405059;6016.639001659914;6038.758449661965;6049.788257411057;5891.9705401473575;5948.315943666361;5961.374055724086;5973.223480947449;5974.641521508724;6111.938880611137;6127.938720612737;6134.079888016833;6136.693165341804;6138.815835524942;5620;5748.798792042258;5758.2514273144225;5845.503132233808;5849.298084229919;5948.910766338422;5965.164876917148;5966.105084237399;5987.43119403656;5996.5502587307;5726.828195154152;5785.508231800176;5790.884182316246;5796.565257605781;5798.82603521895;5580.35825880029;5650.491455768836;5711.685857277889;5728.083506638918;5745.339285981999;5609.971950140386;5678.176664383724;5678.346990096192;5680.4319568042865;5687.857803554944;5746.971265143815;5755.280589926259;5776.220210271727;5776.971115144565;5836.9493491172;5539.9169012464035;5588.441155884541;5641.661500309994;5675.829725108253;5718.170865224436 12:12:44 INFO - PROCESS | 20817 | |1;ext.html;573.541167066347;595.3926994465645;615.8521954730865;624.0825985800872;656.950728695348;41203.17593648125;44510.77744611276;45104;45354.09291814166;45527.089458210816;45931.77034114833;46072.07855842881;46525.30212046822;46577;46677;8743.825123497527;8886.822263554724;8950.776230594254;8956.373053886231;8958.32812539059;8762.824743505125;8825.646974121028;8853.645854165825;8905.643774249022;8915.375923685344;8881.067487913773;8970.282377409792;8975.326850486206;8982.05688402718;8985.775355616097;8819.691310804123;8919.197272245498;8919.464832110029;8919.598618062138;8925.375223734374;8670.609822557937;8742.475451472932;8754.168354006359;8796.296296296281;8816.691415800417;44585.77707111444;44987.550124498994;45062;45157;45214.54785452136;2847.8718457669456;3338.565986421774;3387.204007058364;3457.7060949819297;3886.378179491296;29365.41269174626;29613.40773184546;32021.8398908004;32097.83951080253;33076.6692333076;4148.958510414887;4149.668026557868;4163.3130533461945;4231.640310573574;4261.275583150872;298575;298841;299328;300026;300740;35593.82203088968;35863.4620480693;35972.82013589915;35996;36006.8199659;36081.27837443237;36439.27121457556;36921.26157476835;37010.8149459251;38786;17394.21726022332;17622.559436014202;17638.735418968725;17661.7350739739;17702.822971770118;13542.187468751907;13601.931990339985;13658.590242292747;13669;13676.179429234278;20163.39509814708;20458.693119603216;20471.181152753725;20538.38384848457;20574.177032918815;7279.41764658826;7416.147143078507;7448.776536703799;7488.251174882468;7697.653605587762;1014.4065721552827;1050.6427814543092;1054.852320675106;1122.9831552526718;1130.112861403794;32212.677873220968;32826.50760238598;32894.835525822215;32947;34157.48763768545;1098.6045023791428;1201.2312120243053;1207.3782002268838;1209.3469526455615;1264.367816091954;17415.912920435316;17605.559861003578;17787;17805.130461301636;17922.28310867577;600434;610292;614627;617880;619766;58987.41012589905;60296.39703602908;60315.39684603098;60607;61354;1338.6720253537947;1371.2115533568237;1373.7664597018531;1386.681063355434;1392.1438315435935;31158.22104447407;32865;33185.170370740925;33316;33483.330333393686;53902.460975389746;53940.730296348265;54397.45602544082;54466;54635;472376;475107;477568;478675;479943;28367.148985530468;28552.57171142393;28906.7109328904;28989.420211596072;29050.564241535973;49500;50402;50935;51193.48806511887;51894.22158667548;43179.78410107929;43333;43403.78298108489;44051.77974110109;44681.77659111684;41685.58314416938;43158.784206080025;43233.3514997269;43603;43948.56051439573;41270.793646031576;42774;43934;44078;44174.570398628384;36198.819005905854;37739;38047.89161995686;39126.60873391343;39157.60842391539;27968;29408.55887161737;29685.109446716633;29739.40521189521;30043.69956300409 12:12:44 INFO - PROCESS | 20817 | |2;jquery.html;387.2680633602492;391.94316824060513;395.98614048508307;399.3072020045219;414.0580180090296;18611.906940465295;18692.15885285162;19305.903470482644;19330.226790928362;19566.804331956675;18007;18184.54538636535;18189.18148683309;19198.52003699908;19206.711899321486;5446.346438427394;5457.399686034533;5611.635243709166;5781;5831.183634291203;5699.316082070137;5757.884842303151;5774;5782.219400380936;5785.797497087603;5569.916451253214;5665.490105890469;5666.914996275059;5694.6867922264255;5707.543396528268;5641.18202860587;5653.943460565424;5674.120511320752;5680;5704.629199102066;4932.334134891779;5154.639175257734;5159.916417552318;5160.690358578498;5174.2238664200295;22619.773802262094;22812.31563053111;23409.88295058531;23737.762622373728;23737.7626223739;2273.3407311879537;2325.6511523271474;2391.3782416571644;2415.698037745282;2514.911978080758;14111.294435278298;14213.78679319811;14560;14561;14779;1901.2014953719472;1924.538110853399;1964.8696068266956;1977.3672424824063;1996.5807180492113;67559;73252;75205.62397188034;76089.99999999945;87032;10495.422751748727;10506.212034097472;11050.447477626087;11242.718932026764;11293.774124517628;15442.845571544365;15563.299651515708;15577.688446231012;15587.844121558866;15602.375904963901;8086.393520485987;8373.576491996375;8405.621747021398;8485.95757021211;8550.914490855137;8037.196280371916;8100.756977290691;8145.266925976691;8153.510789352657;8204.589770511451;4717.9292310615365;4728;4737.692050016738;4749.097671442415;4889.242167464049;1929.2379510093435;1994.9301774437824;2017.6872584749094;2033.085111699741;2042.4077017665008;974.7823701080099;978.2418625565101;1023.3450591621369;1037.227265687068;1071.6838532632737;17323;18677.605936750053;18979.90510047441;19308.8069119307;19718.605627887362;979.6277414582413;993.2649839119;1015.4212099103588;1078.5685725709623;1135.3471753741633;10387.84418233727;10769.407682577377;10791.622293219856;10799.892001080047;10855.891441085647;464529;469142;474970;476938;484320;67373;80684.59657701674;86008.56995715106;92314.53842730743;93887;990.8696302948717;997.7505623594102;1014.4876837197315;1027.4605831938143;1030.4899074957793;17521.299148033937;17568.912155439142;17954.19206135753;18032.459026229233;18044.458666240032;41321.380179297936;41534;41614.791926040176;42009;42406.39545638532;58062.4193758057;58729.70635146797;58820.41179588321;59230;60013;8443.240108390275;8538.78653033679;8715.128487151234;8715.172058654418;8763.737087887373;11908.52365905354;13220.40508177115;13306.467741290628;13507;13562.186268823507;11698.35659038761;11885.28688278706;11921.284722916653;11981.460834262654;12044.819327710267;11552.768944621228;11701.824472633087;11724.179307448398;11923.940380298043;11938.64184074479;11594.304341739522;11872.821907671565;11922.701932451759;12112.45493952792;12372.81440778371;8644.827103458021;8665.523396213017;8698.826023479369;8813.823723525622;8864.468131911848;9058.411203271766;11222.719432014264;11886.227395219283;11928.642140735792;12137.696557585778 12:12:44 INFO - PROCESS | 20817 | |3;mootools.html;1488.8362280149186;1514.9999999999998;1666.3917670050428;1820.080859166121;1826.8721189516739;7543.396528277738;8065.798355041127;8160.91839081609;8661.437006594575;8684.348673849463;7947.562884041376;8100.91899081009;8103.554304513249;8179.91820081799;8212.91787082129;2312.5143719818857;2347.3779448446176;2347.9647805282934;2356.1400088967575;2360.327306717586;2284.303287497313;2321.94195145121;2328.8253380996407;2329.23135365329;2329.871857047862;2324.790768830805;2328.976710232893;2343.8124950003958;2359.4101474631343;2368.1356304948654;2265.048679554591;2265.105283413051;2275.6358982562792;2286.314105768271;2295.059025799431;2254.661800729887;2260.2654137405243;2263.7170353705787;2264.320703788857;2266.626006708891;8203.220694034057;8331.083580806106;8340.249377556049;8372.916270837275;8374.120717324715;5087.56755675768;5184.274201611777;5184.507471790174;5206.427292997767;5207.6875387476875;3329.8501567429525;3449.9295626891835;3470.826458677056;3471.913202169966;3472.4270495368232;1189.1378750405886;1190.6844686158174;1194.2774621354129;1196.8503937007874;1239.4422509870594;11598.362090085042;11651.825222621668;11654.30074195551;11684.415779211091;11708.648740537797;4487.910241795146;4569.383133277031;4622.953770462253;4693.20215563355;4700.153972284953;9818;9900.752481188028;9923.503824808731;9924;9933.15568176713;5104.846854594368;5117.923231151536;5136.614753893473;5159.019786240602;5162.277281180638;4283.357496375506;4610.838620648328;4745.406824146981;4750.358701575243;4762.309465127606;3949.361015178669;3978.8806335809973;4061.472008638917;4104;4108.055147316134;1285.2995117660898;1288.1755676367131;1306.196689036236;1309.2013871538354;1319;882.2368651116866;981.2297346582898;996.4270544436832;1005.1958433253368;1017.6641708236265;5451.809186678447;5589.74846131925;5651.8304450866535;5703.657780533182;5763.8559036024435;927.8840144981878;954.5036580977992;962.4610218277787;995.6664517386612;998.7852611688522;3962.3462128748433;3979.1245925896255;4032;4036.3138266494766;4062.898427539276;10134.949325253327;10293.691189264335;10493.685189444328;10505.107065899332;10515.94742026285;10233.74415639615;10305.74235644115;10348.22388320879;10374.896251037393;10374.948125259476;7401.555906645618;7687.846243075107;7708.03649543807;7780.844383112306;7822.726204582812;5666.34836993751;5689.857753556194;5765.308163020464;5781.653100813965;5808.477237048686;9430.339876208875;9652.27607929394;9887.653932112342;9894.356866803635;9908.306418550632;9885.258605604464;9997.950010249902;10075.445850478001;10080.445575493419;10081.647142349982;7117.928820711727;7297.671604777692;7349.522281051714;7403.629818508945;7531.623418829146;8059.073206581318;8122.065962414398;8124.55314957683;8127.2279133482225;8164.469309494863;7077.752278670222;7319.377852882351;7444.664990075568;7519.135299440415;7675.309222170032;7266.527675701062;7288.3076107769675;7358.852822943618;7410.740624078131;7449.329560339595;6453.16108905858;6572.441342485942;6598.637074960923;6623.834404139935;6627.602343859384;4630.884227894195;4902.044101400193;4910.116179087799;4916.729579873141;4957.97521012407;4868.80524779019;4876.609871210366;4880.267959806058;4900.901981960412;4993.875153121201 12:12:44 INFO - PROCESS | 20817 | |4;prototype.html;319.25931838135506;331.2596347164088;332.1563229397331;334.84764432183357;339.5229702268314;5535.778568857246;5649.802256921009;5659.037963546197;5694.202811606378;5721.885562288751;5589.434958211707;5595.468430499096;5602.579806514507;5650.773969041234;5652;4405.471343438784;4441.244988351972;4449.66627502937;4452.532484089173;4470.396496472983;4255.680823938202;4394.560543945612;4406.625436837872;4427.601515863572;4458.127586413698;4332.653387728974;4343.826246950118;4356.215881141393;4380.737155770664;4386.881345256955;4359.3025115981445;4379.189849877783;4403.590850927704;4413.183561041217;4444.311191729022;3809.314323421783;3864.787436690981;3887.2031233597045;3911.6675082618012;3923.941140882889;5410.187587158307;5410.756515956791;5430.91853622196;5450.373207081197;5474.835754927359;4957.305977163164;5002.624803139779;5023.924641130386;5044.470330615306;5049.419316778581;5598.188262701926;5807.353544135585;5814.680192589406;5837.402355951604;5844.912326315109;4210.431591735107;4222.662187025031;4232.809523571446;4238.364245363189;4288.52826189119;5816.302043754734;5916.615419997686;6132.448079672807;6154.569180157346;6161.19904412428;4322;4323.437953066082;4328.134373125387;4344.478662560513;4367.58507941745;4412.713173643703;4435.157320109169;4435.822567097344;4437.844675436409;4466.196084704784;4923.409190897044;4945.703257804544;4999.875003124951;5020.723860187652;5047.343845300087;5861.919018748368;5866.2960444746905;5888.146218798251;5893.351731309553;5896.528277737771;1516.5829396915935;1518.127076930747;1518.6507103366066;1520.1639098495782;1533.66259422929;928.0904713380925;954.9590945869036;967.4969016111583;975.1861537540169;983.5033308179467;4948.802047918115;5026.648134630614;5038.748062596929;5091.796328146833;5092.770825312869;5317.361916569959;5325.653832500875;5333.280007198979;5342.893142137135;5390.520360634074;4911.287863259879;5092.701361152882;5101.438841727407;5106.4893510648635;5142.948570514247;2912.645619786809;2920.5473151661527;2923.38608892135;2935.60369350135;2937.3390987027747;5312;5458.134479398348;5557.41647127054;5582.09730939909;5604.822987172658;5026.472220416877;5372.334576281365;5383.838484845461;5387.757550910218;5461.781528738886;5445.346558413015;5474.124140137638;5532.5573954083575;5551.111822108443;5605.82277721683;5116.974415128049;5246.79323755546;5283.998701720159;5330.907164031287;5340.305760251143;5229.764660590206;5258.447862974485;5264.605154613343;5292.788288468418;5301.310829592283;6043.697815109315;6230.43926046658;6243.469305109116;6273.090401891609;6313.747450102128;4297.978510107429;4346.217680817484;4363.869083927487;4371.30059190528;4372.781360932005;5879.676617786063;6093.786717464867;6157.692115394302;6182;6187.969060154671;5804.651720896591;5899.528037757055;5930.63595373058;5931.555133364928;5977.7310021050025;5890.4993075587345;5937.881242375042;5953.345132035559;6010.549208809444;6031.517478601789;5582;5850.2102216200265;5851.707414629337;5852.385499522659;5878.94121058801;5987.820365389045;5991.64050156992;6025.367336429787;6035.818925432244;6081.817545473643;5719.57103217252;5846.853828654318;5868.911966320423;5908.852278693067;5925.822225333247 12:12:44 INFO - PROCESS | 20817 | |5;yui.html;725.5429079679801;733.5598640815509;782.3858271257064;813.1827513349083;837.5602808525523;14734.852651473482;15261.923690381547;15306.69386612267;15385.538433847003;15488.148151851658;14136.929315353409;14150.575482735509;14177.432902683906;14180.574582762509;14194.645133871658;671.1208317104584;773.5049568276307;782.077148964222;800.5276886636883;808.4138999225573;803.9517628942282;804.0431886055575;805.2913436176157;809.6356639512213;812.2567850416862;853.4324674091753;856.3791251342789;857.8370109679141;858.841114393836;859.96130174142;851.535912927453;852.1904191018496;855.3200205836375;857.5712143928037;860.3504354212561;620.7330847735471;621.1242148570539;624.3756243756244;624.6626821516376;624.8656538844125;14147.787783183261;14181.290935453186;14183.929080354636;14188.21964791936;14201.360938757678;14076.788848167285;14122.92938535311;14146.504872329419;14297.213653249068;14331.641708957255;11539.653810385702;11682.532698692043;11683.240589361749;11705.239159454608;11866.288022718578;3797.2025874566375;3872.5546562145432;3880.2821478026653;3975.6819454443867;4062.451569038172;54870.72564637191;55648.72175639096;55861.44138558643;57544.13683794788;57610.42389576093;11107.666769996913;11144.442777861075;11174.832377514344;11231.887681123084;11332.206745527734;20269.08789104494;20358.592828143355;20478.897605511876;20487.8975605124;20497.897510512652;8110.756677299691;8112.310453611509;8207;8210.958945205355;8390.454620449651;4657.441107067174;4675.345451636706;4676.205045142334;4681.344611754357;4861.4895435978715;3365.6466071062678;3468;3472.062543113396;3474.7567670263343;3476.774009689362;602.7739597650881;606.9211002569638;614.5390956782413;616.4852348289229;628.1457218183267;692.8752824491539;735.9043324367798;737.8782500887294;744.4900243333334;754.6302311867146;9584.76038099053;9756.12194902448;9798.412095274307;9905.603775848886;9933.65232216869;629.6883042893797;736.7089999450187;738.918718940916;751.8646643604094;756.0964647246487;4273.230818452646;4424.778761061934;4436.866893993185;4474.747927849809;4550.772461376918;63415.365846340945;64037;66090;66448.33551664422;67798;56687.14969275464;57141.42858571361;57265;57971.4202857966;58613.706931465924;51586.48413515892;51842.74078629583;52016;52387.21419178639;53671;8565.95717021411;8889.511076890574;8893.288536916902;8915.465072095694;9131.543422828965;35671.28657426889;35674.64325356817;35842.28315433729;35870.10324741902;37026.25947481089;45998;48179.75910120427;48266.5173348262;48363.27455088247;48550;11761.235519691192;11953.760924781282;12130.575429859913;12275.877241227474;12967;12759.681007974876;12993;13242.933785331012;13619.114757541125;13837.723245534831;11823;11989.82015269789;12090.15368924202;12407.689807754878;12480.625581232578;12051.252568377711;12420;12506.124571280287;12569.560065397667;12574.371281436075;11148.609798657008;11473.311601303949;11787.882121178678;12287.385630718249;12482.875171248172;9972.950135249277;10041.397516149054;10252.743681408025;10417.843732344172;10791.298565593212;10228.232882533692;10936.289141205796;10972.177086718688;11446;11774.823377649513 12:12:44 INFO - PROCESS | 20817 | __end_tp_report 12:12:44 INFO - PROCESS | 20817 | __start_cc_report 12:12:44 INFO - PROCESS | 20817 | _x_x_mozilla_cycle_collect,338 12:12:44 INFO - PROCESS | 20817 | __end_cc_report 12:12:44 INFO - PROCESS | 20817 | __startTimestamp1464894764233__endTimestamp 12:12:44 INFO - PROCESS | 20817 | 12:12:44 INFO - PROCESS | 20817 | ------- Summary: start ------- 12:12:44 INFO - PROCESS | 20817 | Number of tests: 6 12:12:44 INFO - PROCESS | 20817 | 12:12:44 INFO - PROCESS | 20817 | [#0] dojo.html Cycles:165 Average:5420.96 Median:5675.83 stddev:715.94 (12.6%) stddev-sans-first:695.65 12:12:44 INFO - PROCESS | 20817 | Values: 3151.8 3169.5 3190.4 3221.8 3230.8 5426.1 5455.5 5465.0 5486.7 5552.4 5333.4 5424.3 5430.7 5467.3 5477.4 4930.7 4969.0 5061.9 5107.5 5145.4 885.3 4872.6 4941.7 4984.6 5051.4 4967.7 4987.6 5013.8 5020.8 5050.8 5024.2 5031.3 5042.9 5049.4 5060.7 4957.4 4972.5 4982.1 4991.7 5002.2 5350.3 5381.7 5410.8 5414.6 5438.4 5703.8 5707.1 5859.2 5890.9 5891.2 5778.6 5815.9 5837.4 5852.0 5937.3 5456.3 5482.8 5487.0 5499.6 5504.0 5790.0 5956.7 5988.8 5992.9 6005.2 5674.8 5699.3 5704.1 5704.6 5706.6 5879.0 5881.9 5888.1 5890.0 5890.4 5858.4 5882.4 5890.1 5910.1 5954.4 5853.9 5863.8 5888.5 5892.4 5896.9 4320.3 4439.2 4439.4 4465.1 4490.7 3896.2 3940.6 3956.8 3982.6 4001.9 5491.8 5493.6 5531.6 5623.5 5625.8 5762.2 5914.7 5953.6 5954.1 5957.5 5449.8 5480.3 5510.4 5531.2 5546.3 4971.0 5024.6 5045.9 5050.2 5081.1 5787.6 6012.1 6016.6 6038.8 6049.8 5892.0 5948.3 5961.4 5973.2 5974.6 6111.9 6127.9 6134.1 6136.7 6138.8 5620.0 5748.8 5758.3 5845.5 5849.3 5948.9 5965.2 5966.1 5987.4 5996.6 5726.8 5785.5 5790.9 5796.6 5798.8 5580.4 5650.5 5711.7 5728.1 5745.3 5610.0 5678.2 5678.3 5680.4 5687.9 5747.0 5755.3 5776.2 5777.0 5836.9 5539.9 5588.4 5641.7 5675.8 5718.2 12:12:44 INFO - PROCESS | 20817 | 12:12:44 INFO - PROCESS | 20817 | [#1] ext.html Cycles:180 Average:61645.06 Median:22958.61 stddev:128061.74 (557.8%) stddev-sans-first:128338.90 12:12:44 INFO - PROCESS | 20817 | Values: 573.5 595.4 615.9 624.1 657.0 41203.2 44510.8 45104.0 45354.1 45527.1 45931.8 46072.1 46525.3 46577.0 46677.0 8743.8 8886.8 8950.8 8956.4 8958.3 8762.8 8825.6 8853.6 8905.6 8915.4 8881.1 8970.3 8975.3 8982.1 8985.8 8819.7 8919.2 8919.5 8919.6 8925.4 8670.6 8742.5 8754.2 8796.3 8816.7 44585.8 44987.6 45062.0 45157.0 45214.5 2847.9 3338.6 3387.2 3457.7 3886.4 29365.4 29613.4 32021.8 32097.8 33076.7 4149.0 4149.7 4163.3 4231.6 4261.3 298575.0 298841.0 299328.0 300026.0 300740.0 35593.8 35863.5 35972.8 35996.0 36006.8 36081.3 36439.3 36921.3 37010.8 38786.0 17394.2 17622.6 17638.7 17661.7 17702.8 13542.2 13601.9 13658.6 13669.0 13676.2 20163.4 20458.7 20471.2 20538.4 20574.2 7279.4 7416.1 7448.8 7488.3 7697.7 1014.4 1050.6 1054.9 1123.0 1130.1 32212.7 32826.5 32894.8 32947.0 34157.5 1098.6 1201.2 1207.4 1209.3 1264.4 17415.9 17605.6 17787.0 17805.1 17922.3 600434.0 610292.0 614627.0 617880.0 619766.0 58987.4 60296.4 60315.4 60607.0 61354.0 1338.7 1371.2 1373.8 1386.7 1392.1 31158.2 32865.0 33185.2 33316.0 33483.3 53902.5 53940.7 54397.5 54466.0 54635.0 472376.0 475107.0 477568.0 478675.0 479943.0 28367.1 28552.6 28906.7 28989.4 29050.6 49500.0 50402.0 50935.0 51193.5 51894.2 43179.8 43333.0 43403.8 44051.8 44681.8 41685.6 43158.8 43233.4 43603.0 43948.6 41270.8 42774.0 43934.0 44078.0 44174.6 36198.8 37739.0 38047.9 39126.6 39157.6 27968.0 29408.6 29685.1 29739.4 30043.7 12:12:44 INFO - PROCESS | 20817 | 12:12:44 INFO - PROCESS | 20817 | [#2] jquery.html Cycles:180 Average:28335.56 Median:2403.54 stddev:77995.47 (3245.0%) stddev-sans-first:78186.04 12:12:44 INFO - PROCESS | 20817 | Values: 387.3 391.9 396.0 399.3 414.1 18611.9 18692.2 19305.9 19330.2 19566.8 18007.0 18184.5 18189.2 19198.5 19206.7 5446.3 5457.4 5611.6 5781.0 5831.2 5699.3 5757.9 5774.0 5782.2 5785.8 5569.9 5665.5 5666.9 5694.7 5707.5 5641.2 5653.9 5674.1 5680.0 5704.6 4932.3 5154.6 5159.9 5160.7 5174.2 22619.8 22812.3 23409.9 23737.8 23737.8 2273.3 2325.7 2391.4 2415.7 2514.9 14111.3 14213.8 14560.0 14561.0 14779.0 1901.2 1924.5 1964.9 1977.4 1996.6 67559.0 73252.0 75205.6 76090.0 87032.0 10495.4 10506.2 11050.4 11242.7 11293.8 15442.8 15563.3 15577.7 15587.8 15602.4 8086.4 8373.6 8405.6 8486.0 8550.9 8037.2 8100.8 8145.3 8153.5 8204.6 4717.9 4728.0 4737.7 4749.1 4889.2 1929.2 1994.9 2017.7 2033.1 2042.4 974.8 978.2 1023.3 1037.2 1071.7 17323.0 18677.6 18979.9 19308.8 19718.6 979.6 993.3 1015.4 1078.6 1135.3 10387.8 10769.4 10791.6 10799.9 10855.9 464529.0 469142.0 474970.0 476938.0 484320.0 67373.0 80684.6 86008.6 92314.5 93887.0 990.9 997.8 1014.5 1027.5 1030.5 17521.3 17568.9 17954.2 18032.5 18044.5 41321.4 41534.0 41614.8 42009.0 42406.4 58062.4 58729.7 58820.4 59230.0 60013.0 8443.2 8538.8 8715.1 8715.2 8763.7 11908.5 13220.4 13306.5 13507.0 13562.2 11698.4 11885.3 11921.3 11981.5 12044.8 11552.8 11701.8 11724.2 11923.9 11938.6 11594.3 11872.8 11922.7 12112.5 12372.8 8644.8 8665.5 8698.8 8813.8 8864.5 9058.4 11222.7 11886.2 11928.6 12137.7 12:12:44 INFO - PROCESS | 20817 | 12:12:44 INFO - PROCESS | 20817 | [#3] mootools.html Cycles:180 Average:5584.41 Median:4906.08 stddev:3093.63 (63.1%) stddev-sans-first:3087.00 12:12:44 INFO - PROCESS | 20817 | Values: 1488.8 1515.0 1666.4 1820.1 1826.9 7543.4 8065.8 8160.9 8661.4 8684.3 7947.6 8100.9 8103.6 8179.9 8212.9 2312.5 2347.4 2348.0 2356.1 2360.3 2284.3 2321.9 2328.8 2329.2 2329.9 2324.8 2329.0 2343.8 2359.4 2368.1 2265.0 2265.1 2275.6 2286.3 2295.1 2254.7 2260.3 2263.7 2264.3 2266.6 8203.2 8331.1 8340.2 8372.9 8374.1 5087.6 5184.3 5184.5 5206.4 5207.7 3329.9 3449.9 3470.8 3471.9 3472.4 1189.1 1190.7 1194.3 1196.9 1239.4 11598.4 11651.8 11654.3 11684.4 11708.6 4487.9 4569.4 4623.0 4693.2 4700.2 9818.0 9900.8 9923.5 9924.0 9933.2 5104.8 5117.9 5136.6 5159.0 5162.3 4283.4 4610.8 4745.4 4750.4 4762.3 3949.4 3978.9 4061.5 4104.0 4108.1 1285.3 1288.2 1306.2 1309.2 1319.0 882.2 981.2 996.4 1005.2 1017.7 5451.8 5589.7 5651.8 5703.7 5763.9 927.9 954.5 962.5 995.7 998.8 3962.3 3979.1 4032.0 4036.3 4062.9 10134.9 10293.7 10493.7 10505.1 10515.9 10233.7 10305.7 10348.2 10374.9 10374.9 7401.6 7687.8 7708.0 7780.8 7822.7 5666.3 5689.9 5765.3 5781.7 5808.5 9430.3 9652.3 9887.7 9894.4 9908.3 9885.3 9998.0 10075.4 10080.4 10081.6 7117.9 7297.7 7349.5 7403.6 7531.6 8059.1 8122.1 8124.6 8127.2 8164.5 7077.8 7319.4 7444.7 7519.1 7675.3 7266.5 7288.3 7358.9 7410.7 7449.3 6453.2 6572.4 6598.6 6623.8 6627.6 4630.9 4902.0 4910.1 4916.7 4958.0 4868.8 4876.6 4880.3 4900.9 4993.9 12:12:44 INFO - PROCESS | 20817 | 12:12:44 INFO - PROCESS | 20817 | [#4] prototype.html Cycles:180 Average:4810.99 Median:5321.51 stddev:1389.02 (26.1%) stddev-sans-first:1351.38 12:12:44 INFO - PROCESS | 20817 | Values: 319.3 331.3 332.2 334.8 339.5 5535.8 5649.8 5659.0 5694.2 5721.9 5589.4 5595.5 5602.6 5650.8 5652.0 4405.5 4441.2 4449.7 4452.5 4470.4 4255.7 4394.6 4406.6 4427.6 4458.1 4332.7 4343.8 4356.2 4380.7 4386.9 4359.3 4379.2 4403.6 4413.2 4444.3 3809.3 3864.8 3887.2 3911.7 3923.9 5410.2 5410.8 5430.9 5450.4 5474.8 4957.3 5002.6 5023.9 5044.5 5049.4 5598.2 5807.4 5814.7 5837.4 5844.9 4210.4 4222.7 4232.8 4238.4 4288.5 5816.3 5916.6 6132.4 6154.6 6161.2 4322.0 4323.4 4328.1 4344.5 4367.6 4412.7 4435.2 4435.8 4437.8 4466.2 4923.4 4945.7 4999.9 5020.7 5047.3 5861.9 5866.3 5888.1 5893.4 5896.5 1516.6 1518.1 1518.7 1520.2 1533.7 928.1 955.0 967.5 975.2 983.5 4948.8 5026.6 5038.7 5091.8 5092.8 5317.4 5325.7 5333.3 5342.9 5390.5 4911.3 5092.7 5101.4 5106.5 5142.9 2912.6 2920.5 2923.4 2935.6 2937.3 5312.0 5458.1 5557.4 5582.1 5604.8 5026.5 5372.3 5383.8 5387.8 5461.8 5445.3 5474.1 5532.6 5551.1 5605.8 5117.0 5246.8 5284.0 5330.9 5340.3 5229.8 5258.4 5264.6 5292.8 5301.3 6043.7 6230.4 6243.5 6273.1 6313.7 4298.0 4346.2 4363.9 4371.3 4372.8 5879.7 6093.8 6157.7 6182.0 6188.0 5804.7 5899.5 5930.6 5931.6 5977.7 5890.5 5937.9 5953.3 6010.5 6031.5 5582.0 5850.2 5851.7 5852.4 5878.9 5987.8 5991.6 6025.4 6035.8 6081.8 5719.6 5846.9 5868.9 5908.9 5925.8 12:12:44 INFO - PROCESS | 20817 | 12:12:44 INFO - PROCESS | 20817 | [#5] yui.html Cycles:180 Average:15281.25 Median:4666.39 stddev:17947.12 (384.6%) stddev-sans-first:17964.18 12:12:44 INFO - PROCESS | 20817 | Values: 725.5 733.6 782.4 813.2 837.6 14734.9 15261.9 15306.7 15385.5 15488.1 14136.9 14150.6 14177.4 14180.6 14194.6 671.1 773.5 782.1 800.5 808.4 804.0 804.0 805.3 809.6 812.3 853.4 856.4 857.8 858.8 860.0 851.5 852.2 855.3 857.6 860.4 620.7 621.1 624.4 624.7 624.9 14147.8 14181.3 14183.9 14188.2 14201.4 14076.8 14122.9 14146.5 14297.2 14331.6 11539.7 11682.5 11683.2 11705.2 11866.3 3797.2 3872.6 3880.3 3975.7 4062.5 54870.7 55648.7 55861.4 57544.1 57610.4 11107.7 11144.4 11174.8 11231.9 11332.2 20269.1 20358.6 20478.9 20487.9 20497.9 8110.8 8112.3 8207.0 8211.0 8390.5 4657.4 4675.3 4676.2 4681.3 4861.5 3365.6 3468.0 3472.1 3474.8 3476.8 602.8 606.9 614.5 616.5 628.1 692.9 735.9 737.9 744.5 754.6 9584.8 9756.1 9798.4 9905.6 9933.7 629.7 736.7 738.9 751.9 756.1 4273.2 4424.8 4436.9 4474.7 4550.8 63415.4 64037.0 66090.0 66448.3 67798.0 56687.1 57141.4 57265.0 57971.4 58613.7 51586.5 51842.7 52016.0 52387.2 53671.0 8566.0 8889.5 8893.3 8915.5 9131.5 35671.3 35674.6 35842.3 35870.1 37026.3 45998.0 48179.8 48266.5 48363.3 48550.0 11761.2 11953.8 12130.6 12275.9 12967.0 12759.7 12993.0 13242.9 13619.1 13837.7 11823.0 11989.8 12090.2 12407.7 12480.6 12051.3 12420.0 12506.1 12569.6 12574.4 11148.6 11473.3 11787.9 12287.4 12482.9 9973.0 10041.4 10252.7 10417.8 10791.3 10228.2 10936.3 10972.2 11446.0 11774.8 12:12:44 INFO - PROCESS | 20817 | -------- Summary: end -------- 12:12:44 INFO - PROCESS | 20817 | 12:12:44 INFO - TEST-INFO | 20817: exit 0 12:12:44 INFO - TEST-OK | dromaeo_css | took 1110426ms 12:12:44 INFO - TEST-START | kraken 12:12:44 INFO - operating with platform_type : linux_ 12:12:44 INFO - Initialising browser for kraken test... 12:12:44 INFO - TEST-INFO | started process 21052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8qBqFs/profile http://localhost:49384/getInfo.html) 12:12:49 INFO - PROCESS | 21052 | __metrics Screen width/height:1600/1200 12:12:49 INFO - PROCESS | 21052 | colorDepth:24 12:12:49 INFO - PROCESS | 21052 | Browser inner width/height: 1024/697 12:12:49 INFO - PROCESS | 21052 | __metrics 12:12:49 ERROR - PROCESS | 21052 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 12:12:50 INFO - TEST-INFO | 21052: exit 0 12:12:50 INFO - Browser initialized. 12:12:50 INFO - Running cycle 1/1 for kraken test... 12:12:50 INFO - TEST-INFO | started process 21174 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8qBqFs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:13:02 INFO - PROCESS | 21174 | RSS: Main: 167346176 12:13:02 INFO - PROCESS | 21174 | 12:13:05 INFO - PROCESS | 21174 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49384/tests/kraken/driver.html?testName=audio-beat-detection) 12:13:06 INFO - PROCESS | 21174 | RSS: Main: 172527616 12:13:06 INFO - PROCESS | 21174 | 12:13:08 INFO - PROCESS | 21174 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49384/tests/kraken/driver.html?testName=audio-dft) 12:13:09 INFO - PROCESS | 21174 | RSS: Main: 172261376 12:13:09 INFO - PROCESS | 21174 | 12:13:12 INFO - PROCESS | 21174 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49384/tests/kraken/driver.html?testName=audio-fft) 12:13:12 INFO - PROCESS | 21174 | RSS: Main: 166912000 12:13:12 INFO - PROCESS | 21174 | 12:13:15 INFO - PROCESS | 21174 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49384/tests/kraken/driver.html?testName=audio-oscillator) 12:13:15 INFO - PROCESS | 21174 | RSS: Main: 167452672 12:13:15 INFO - PROCESS | 21174 | 12:13:17 INFO - PROCESS | 21174 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49384/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:13:18 INFO - PROCESS | 21174 | RSS: Main: 167866368 12:13:18 INFO - PROCESS | 21174 | 12:13:21 INFO - PROCESS | 21174 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49384/tests/kraken/driver.html?testName=imaging-darkroom) 12:13:22 INFO - PROCESS | 21174 | RSS: Main: 167981056 12:13:22 INFO - PROCESS | 21174 | 12:13:25 INFO - PROCESS | 21174 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49384/tests/kraken/driver.html?testName=imaging-desaturate) 12:13:26 INFO - PROCESS | 21174 | RSS: Main: 168697856 12:13:26 INFO - PROCESS | 21174 | 12:13:29 INFO - PROCESS | 21174 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49384/tests/kraken/driver.html?testName=json-parse-financial) 12:13:29 INFO - PROCESS | 21174 | RSS: Main: 168546304 12:13:29 INFO - PROCESS | 21174 | 12:13:31 INFO - PROCESS | 21174 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49384/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:13:31 INFO - PROCESS | 21174 | RSS: Main: 168857600 12:13:31 INFO - PROCESS | 21174 | 12:13:33 INFO - PROCESS | 21174 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49384/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:13:34 INFO - PROCESS | 21174 | RSS: Main: 168452096 12:13:34 INFO - PROCESS | 21174 | 12:13:36 INFO - PROCESS | 21174 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49384/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:13:37 INFO - PROCESS | 21174 | RSS: Main: 168914944 12:13:37 INFO - PROCESS | 21174 | 12:13:39 INFO - PROCESS | 21174 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49384/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:13:40 INFO - PROCESS | 21174 | RSS: Main: 169066496 12:13:40 INFO - PROCESS | 21174 | 12:13:43 INFO - PROCESS | 21174 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49384/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:13:43 INFO - PROCESS | 21174 | RSS: Main: 168906752 12:13:43 INFO - PROCESS | 21174 | 12:13:45 INFO - PROCESS | 21174 | Cycle 1(1): loaded http://localhost:49384/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49384/tests/kraken/driver.html?testName=ai-astar) 12:13:45 INFO - PROCESS | 21174 | RSS: Main: 169398272 12:13:45 INFO - PROCESS | 21174 | 12:13:45 INFO - PROCESS | 21174 | __start_tp_report 12:13:45 INFO - PROCESS | 21174 | _x_x_mozilla_page_load 12:13:45 INFO - PROCESS | 21174 | _x_x_mozilla_page_load_details 12:13:45 INFO - PROCESS | 21174 | |i|pagename|runs| 12:13:45 INFO - PROCESS | 21174 | |0;ai-astar;112;106;112;110;111;113;112;114;112;113 12:13:45 INFO - PROCESS | 21174 | |1;audio-beat-detection;155;127;158;187;127;159;155;127;185;131 12:13:45 INFO - PROCESS | 21174 | |2;audio-dft;165;162;164;161;165;176;163;162;162;163 12:13:45 INFO - PROCESS | 21174 | |3;audio-fft;76;77;75;165;77;76;73;75;166;74 12:13:45 INFO - PROCESS | 21174 | |4;audio-oscillator;83;82;142;84;83;82;139;82;82;134 12:13:45 INFO - PROCESS | 21174 | |5;imaging-gaussian-blur;118;117;117;117;119;117;117;117;118;118 12:13:45 INFO - PROCESS | 21174 | |6;imaging-darkroom;147;147;147;147;148;146;146;147;148;147 12:13:45 INFO - PROCESS | 21174 | |7;imaging-desaturate;95;96;96;96;96;95;96;96;95;96 12:13:45 INFO - PROCESS | 21174 | |8;json-parse-financial;54;54;55;53;55;56;54;54;55;54 12:13:45 INFO - PROCESS | 21174 | |9;json-stringify-tinderbox;62;62;61;62;61;61;62;63;62;62 12:13:45 INFO - PROCESS | 21174 | |10;stanford-crypto-aes;81;83;80;80;81;81;82;80;111;86 12:13:45 INFO - PROCESS | 21174 | |11;stanford-crypto-ccm;126;137;125;134;140;131;127;139;125;133 12:13:45 INFO - PROCESS | 21174 | |12;stanford-crypto-pbkdf2;165;159;160;159;158;157;157;167;158;166 12:13:45 INFO - PROCESS | 21174 | |13;stanford-crypto-sha256-iterative;78;63;65;63;63;65;64;62;64;64 12:13:45 INFO - PROCESS | 21174 | __end_tp_report 12:13:45 INFO - PROCESS | 21174 | __start_cc_report 12:13:45 INFO - PROCESS | 21174 | _x_x_mozilla_cycle_collect,897 12:13:45 INFO - PROCESS | 21174 | __end_cc_report 12:13:45 INFO - PROCESS | 21174 | __startTimestamp1464894825615__endTimestamp 12:13:45 INFO - PROCESS | 21174 | 12:13:45 INFO - PROCESS | 21174 | ------- Summary: start ------- 12:13:45 INFO - PROCESS | 21174 | Number of tests: 14 12:13:45 INFO - PROCESS | 21174 | 12:13:45 INFO - PROCESS | 21174 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:2.22 (2.0%) stddev-sans-first:2.35 12:13:45 INFO - PROCESS | 21174 | Values: 112.0 106.0 112.0 110.0 111.0 113.0 112.0 114.0 112.0 113.0 12:13:45 INFO - PROCESS | 21174 | 12:13:45 INFO - PROCESS | 21174 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:156.50 stddev:22.91 (14.6%) stddev-sans-first:24.26 12:13:45 INFO - PROCESS | 21174 | Values: 155.0 127.0 158.0 187.0 127.0 159.0 155.0 127.0 185.0 131.0 12:13:45 INFO - PROCESS | 21174 | 12:13:45 INFO - PROCESS | 21174 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:4.32 (2.6%) stddev-sans-first:4.58 12:13:45 INFO - PROCESS | 21174 | Values: 165.0 162.0 164.0 161.0 165.0 176.0 163.0 162.0 162.0 163.0 12:13:45 INFO - PROCESS | 21174 | 12:13:45 INFO - PROCESS | 21174 | [#3] audio-fft Cycles:10 Average:93.40 Median:75.50 stddev:38.02 (50.4%) stddev-sans-first:39.80 12:13:45 INFO - PROCESS | 21174 | Values: 76.0 77.0 75.0 165.0 77.0 76.0 73.0 75.0 166.0 74.0 12:13:45 INFO - PROCESS | 21174 | 12:13:45 INFO - PROCESS | 21174 | [#4] audio-oscillator Cycles:10 Average:99.30 Median:82.00 stddev:27.01 (32.9%) stddev-sans-first:28.00 12:13:45 INFO - PROCESS | 21174 | Values: 83.0 82.0 142.0 84.0 83.0 82.0 139.0 82.0 82.0 134.0 12:13:45 INFO - PROCESS | 21174 | 12:13:45 INFO - PROCESS | 21174 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 12:13:45 INFO - PROCESS | 21174 | Values: 118.0 117.0 117.0 117.0 119.0 117.0 117.0 117.0 118.0 118.0 12:13:45 INFO - PROCESS | 21174 | 12:13:45 INFO - PROCESS | 21174 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 12:13:45 INFO - PROCESS | 21174 | Values: 147.0 147.0 147.0 147.0 148.0 146.0 146.0 147.0 148.0 147.0 12:13:45 INFO - PROCESS | 21174 | 12:13:45 INFO - PROCESS | 21174 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 12:13:45 INFO - PROCESS | 21174 | Values: 95.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 12:13:45 INFO - PROCESS | 21174 | 12:13:45 INFO - PROCESS | 21174 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:0.84 (1.5%) stddev-sans-first:0.88 12:13:45 INFO - PROCESS | 21174 | Values: 54.0 54.0 55.0 53.0 55.0 56.0 54.0 54.0 55.0 54.0 12:13:45 INFO - PROCESS | 21174 | 12:13:45 INFO - PROCESS | 21174 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 12:13:45 INFO - PROCESS | 21174 | Values: 62.0 62.0 61.0 62.0 61.0 61.0 62.0 63.0 62.0 62.0 12:13:45 INFO - PROCESS | 21174 | 12:13:45 INFO - PROCESS | 21174 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:81.00 stddev:9.49 (11.7%) stddev-sans-first:9.98 12:13:45 INFO - PROCESS | 21174 | Values: 81.0 83.0 80.0 80.0 81.0 81.0 82.0 80.0 111.0 86.0 12:13:45 INFO - PROCESS | 21174 | 12:13:45 INFO - PROCESS | 21174 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:133.50 stddev:5.79 (4.3%) stddev-sans-first:5.77 12:13:45 INFO - PROCESS | 21174 | Values: 126.0 137.0 125.0 134.0 140.0 131.0 127.0 139.0 125.0 133.0 12:13:45 INFO - PROCESS | 21174 | 12:13:45 INFO - PROCESS | 21174 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:159.50 stddev:3.86 (2.4%) stddev-sans-first:3.76 12:13:45 INFO - PROCESS | 21174 | Values: 165.0 159.0 160.0 159.0 158.0 157.0 157.0 167.0 158.0 166.0 12:13:45 INFO - PROCESS | 21174 | 12:13:45 INFO - PROCESS | 21174 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:64.00 stddev:4.63 (7.2%) stddev-sans-first:1.00 12:13:45 INFO - PROCESS | 21174 | Values: 78.0 63.0 65.0 63.0 63.0 65.0 64.0 62.0 64.0 64.0 12:13:45 INFO - PROCESS | 21174 | -------- Summary: end -------- 12:13:45 INFO - PROCESS | 21174 | 12:13:46 INFO - TEST-INFO | 21174: exit 0 12:13:46 INFO - TEST-OK | kraken | took 61631ms 12:13:46 INFO - SUITE-END | took 1172s 12:13:46 INFO - Completed test suite (00:19:32) 12:13:46 INFO - javascript benchmark 12:13:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7169.311830038909, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3151.8108913465185, 3169.524571314304, 3190.377876314118, 3221.8066915985028, 3230.8384580770958, 5426.077566813647, 5455.481729235721, 5464.972675136623, 5486.670799752008, 5552.361478429982, 5333.38666053404, 5424.321959755031, 5430.67415955042, 5467.289252397193, 5477.397486276506, 4930.679505832119, 4968.975155124219, 5061.924071138936, 5107.540321371076, 5145.382554093514, 885.2927518446584, 4872.585830204419, 4941.678790878599, 4984.601231901439, 5051.419086805009, 4967.677100988424, 4987.5511203991455, 5013.774380152902, 5020.824271150511, 5050.823221187259, 5024.221245706921, 5031.295618613397, 5042.924356134661, 5049.394072711299, 5060.74696265189, 4957.405111386621, 4972.453030166679, 4982.078315511642, 4991.700497970097, 5002.19964805633, 5350.250964864922, 5381.730913454312, 5410.810621628263, 5414.593905457067, 5438.428964958702, 5703.828885133453, 5707.086866101404, 5859.1797148399255, 5890.911636325459, 5891.204687367193, 5778.566607504454, 5815.912761308541, 5837.387074357174, 5852.0, 5937.346891841894, 5456.290682211326, 5482.80810171642, 5487.0, 5499.587530935196, 5503.972480137613, 5790.0, 5956.7319470623925, 5988.820335389858, 5992.940070599326, 6005.189299444606, 5674.801381951612, 5699.316082070178, 5704.0588302929555, 5704.600677952587, 5706.629069110494, 5879.029960056543, 5881.882362352729, 5888.146218798251, 5889.969255380377, 5890.440408161217, 5858.414158584107, 5882.441168089024, 5890.145928840294, 5910.143029260733, 5954.434328738763, 5853.9414605854245, 5863.765449382062, 5888.5289176865745, 5892.410758924073, 5896.941030589725, 4320.308750599889, 4439.200943830077, 4439.42287502629, 4465.0623369092855, 4490.685652004394, 3896.162325100117, 3940.6059394060367, 3956.782376969237, 3982.5818289079807, 4001.8599349023225, 5491.807786727445, 5493.615446918758, 5531.612787104945, 5623.493885550321, 5625.774969001276, 5762.164486149485, 5914.733836977346, 5953.553483488756, 5954.136650185699, 5957.4638282553915, 5449.782008719607, 5480.314960629921, 5510.366307874566, 5531.170324451365, 5546.251256080458, 4971.0, 5024.57291130258, 5045.8738531537, 5050.217216331474, 5081.110805609003, 5787.623804452782, 6012.128241405059, 6016.639001659914, 6038.758449661965, 6049.788257411057, 5891.9705401473575, 5948.315943666361, 5961.374055724086, 5973.223480947449, 5974.641521508724, 6111.938880611137, 6127.938720612737, 6134.079888016833, 6136.693165341804, 6138.815835524942, 5620.0, 5748.798792042258, 5758.2514273144225, 5845.503132233808, 5849.298084229919, 5948.910766338422, 5965.164876917148, 5966.105084237399, 5987.43119403656, 5996.5502587307, 5726.828195154152, 5785.508231800176, 5790.884182316246, 5796.565257605781, 5798.82603521895, 5580.35825880029, 5650.491455768836, 5711.685857277889, 5728.083506638918, 5745.339285981999, 5609.971950140386, 5678.176664383724, 5678.346990096192, 5680.4319568042865, 5687.857803554944, 5746.971265143815, 5755.280589926259, 5776.220210271727, 5776.971115144565, 5836.9493491172, 5539.9169012464035, 5588.441155884541, 5641.661500309994, 5675.829725108253, 5718.170865224436], "value": 5374.10684057024, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.541167066347, 595.3926994465645, 615.8521954730865, 624.0825985800872, 656.950728695348, 41203.17593648125, 44510.77744611276, 45104.0, 45354.09291814166, 45527.089458210816, 45931.77034114833, 46072.07855842881, 46525.30212046822, 46577.0, 46677.0, 8743.825123497527, 8886.822263554724, 8950.776230594254, 8956.373053886231, 8958.32812539059, 8762.824743505125, 8825.646974121028, 8853.645854165825, 8905.643774249022, 8915.375923685344, 8881.067487913773, 8970.282377409792, 8975.326850486206, 8982.05688402718, 8985.775355616097, 8819.691310804123, 8919.197272245498, 8919.464832110029, 8919.598618062138, 8925.375223734374, 8670.609822557937, 8742.475451472932, 8754.168354006359, 8796.296296296281, 8816.691415800417, 44585.77707111444, 44987.550124498994, 45062.0, 45157.0, 45214.54785452136, 2847.8718457669456, 3338.565986421774, 3387.204007058364, 3457.7060949819297, 3886.378179491296, 29365.41269174626, 29613.40773184546, 32021.8398908004, 32097.83951080253, 33076.6692333076, 4148.958510414887, 4149.668026557868, 4163.3130533461945, 4231.640310573574, 4261.275583150872, 298575.0, 298841.0, 299328.0, 300026.0, 300740.0, 35593.82203088968, 35863.4620480693, 35972.82013589915, 35996.0, 36006.8199659, 36081.27837443237, 36439.27121457556, 36921.26157476835, 37010.8149459251, 38786.0, 17394.21726022332, 17622.559436014202, 17638.735418968725, 17661.7350739739, 17702.822971770118, 13542.187468751907, 13601.931990339985, 13658.590242292747, 13669.0, 13676.179429234278, 20163.39509814708, 20458.693119603216, 20471.181152753725, 20538.38384848457, 20574.177032918815, 7279.41764658826, 7416.147143078507, 7448.776536703799, 7488.251174882468, 7697.653605587762, 1014.4065721552827, 1050.6427814543092, 1054.852320675106, 1122.9831552526718, 1130.112861403794, 32212.677873220968, 32826.50760238598, 32894.835525822215, 32947.0, 34157.48763768545, 1098.6045023791428, 1201.2312120243053, 1207.3782002268838, 1209.3469526455615, 1264.367816091954, 17415.912920435316, 17605.559861003578, 17787.0, 17805.130461301636, 17922.28310867577, 600434.0, 610292.0, 614627.0, 617880.0, 619766.0, 58987.41012589905, 60296.39703602908, 60315.39684603098, 60607.0, 61354.0, 1338.6720253537947, 1371.2115533568237, 1373.7664597018531, 1386.681063355434, 1392.1438315435935, 31158.22104447407, 32865.0, 33185.170370740925, 33316.0, 33483.330333393686, 53902.460975389746, 53940.730296348265, 54397.45602544082, 54466.0, 54635.0, 472376.0, 475107.0, 477568.0, 478675.0, 479943.0, 28367.148985530468, 28552.57171142393, 28906.7109328904, 28989.420211596072, 29050.564241535973, 49500.0, 50402.0, 50935.0, 51193.48806511887, 51894.22158667548, 43179.78410107929, 43333.0, 43403.78298108489, 44051.77974110109, 44681.77659111684, 41685.58314416938, 43158.784206080025, 43233.3514997269, 43603.0, 43948.56051439573, 41270.793646031576, 42774.0, 43934.0, 44078.0, 44174.570398628384, 36198.819005905854, 37739.0, 38047.89161995686, 39126.60873391343, 39157.60842391539, 27968.0, 29408.55887161737, 29685.109446716633, 29739.40521189521, 30043.69956300409], "value": 20132.3108121159, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.2680633602492, 391.94316824060513, 395.98614048508307, 399.3072020045219, 414.0580180090296, 18611.906940465295, 18692.15885285162, 19305.903470482644, 19330.226790928362, 19566.804331956675, 18007.0, 18184.54538636535, 18189.18148683309, 19198.52003699908, 19206.711899321486, 5446.346438427394, 5457.399686034533, 5611.635243709166, 5781.0, 5831.183634291203, 5699.316082070137, 5757.884842303151, 5774.0, 5782.219400380936, 5785.797497087603, 5569.916451253214, 5665.490105890469, 5666.914996275059, 5694.6867922264255, 5707.543396528268, 5641.18202860587, 5653.943460565424, 5674.120511320752, 5680.0, 5704.629199102066, 4932.334134891779, 5154.639175257734, 5159.916417552318, 5160.690358578498, 5174.2238664200295, 22619.773802262094, 22812.31563053111, 23409.88295058531, 23737.762622373728, 23737.7626223739, 2273.3407311879537, 2325.6511523271474, 2391.3782416571644, 2415.698037745282, 2514.911978080758, 14111.294435278298, 14213.78679319811, 14560.0, 14561.0, 14779.0, 1901.2014953719472, 1924.538110853399, 1964.8696068266956, 1977.3672424824063, 1996.5807180492113, 67559.0, 73252.0, 75205.62397188034, 76089.99999999945, 87032.0, 10495.422751748727, 10506.212034097472, 11050.447477626087, 11242.718932026764, 11293.774124517628, 15442.845571544365, 15563.299651515708, 15577.688446231012, 15587.844121558866, 15602.375904963901, 8086.393520485987, 8373.576491996375, 8405.621747021398, 8485.95757021211, 8550.914490855137, 8037.196280371916, 8100.756977290691, 8145.266925976691, 8153.510789352657, 8204.589770511451, 4717.9292310615365, 4728.0, 4737.692050016738, 4749.097671442415, 4889.242167464049, 1929.2379510093435, 1994.9301774437824, 2017.6872584749094, 2033.085111699741, 2042.4077017665008, 974.7823701080099, 978.2418625565101, 1023.3450591621369, 1037.227265687068, 1071.6838532632737, 17323.0, 18677.605936750053, 18979.90510047441, 19308.8069119307, 19718.605627887362, 979.6277414582413, 993.2649839119, 1015.4212099103588, 1078.5685725709623, 1135.3471753741633, 10387.84418233727, 10769.407682577377, 10791.622293219856, 10799.892001080047, 10855.891441085647, 464529.0, 469142.0, 474970.0, 476938.0, 484320.0, 67373.0, 80684.59657701674, 86008.56995715106, 92314.53842730743, 93887.0, 990.8696302948717, 997.7505623594102, 1014.4876837197315, 1027.4605831938143, 1030.4899074957793, 17521.299148033937, 17568.912155439142, 17954.19206135753, 18032.459026229233, 18044.458666240032, 41321.380179297936, 41534.0, 41614.791926040176, 42009.0, 42406.39545638532, 58062.4193758057, 58729.70635146797, 58820.41179588321, 59230.0, 60013.0, 8443.240108390275, 8538.78653033679, 8715.128487151234, 8715.172058654418, 8763.737087887373, 11908.52365905354, 13220.40508177115, 13306.467741290628, 13507.0, 13562.186268823507, 11698.35659038761, 11885.28688278706, 11921.284722916653, 11981.460834262654, 12044.819327710267, 11552.768944621228, 11701.824472633087, 11724.179307448398, 11923.940380298043, 11938.64184074479, 11594.304341739522, 11872.821907671565, 11922.701932451759, 12112.45493952792, 12372.81440778371, 8644.827103458021, 8665.523396213017, 8698.826023479369, 8813.823723525622, 8864.468131911848, 9058.411203271766, 11222.719432014264, 11886.227395219283, 11928.642140735792, 12137.696557585778], "value": 9286.62140528985, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1488.8362280149186, 1514.9999999999998, 1666.3917670050428, 1820.080859166121, 1826.8721189516739, 7543.396528277738, 8065.798355041127, 8160.91839081609, 8661.437006594575, 8684.348673849463, 7947.562884041376, 8100.91899081009, 8103.554304513249, 8179.91820081799, 8212.91787082129, 2312.5143719818857, 2347.3779448446176, 2347.9647805282934, 2356.1400088967575, 2360.327306717586, 2284.303287497313, 2321.94195145121, 2328.8253380996407, 2329.23135365329, 2329.871857047862, 2324.790768830805, 2328.976710232893, 2343.8124950003958, 2359.4101474631343, 2368.1356304948654, 2265.048679554591, 2265.105283413051, 2275.6358982562792, 2286.314105768271, 2295.059025799431, 2254.661800729887, 2260.2654137405243, 2263.7170353705787, 2264.320703788857, 2266.626006708891, 8203.220694034057, 8331.083580806106, 8340.249377556049, 8372.916270837275, 8374.120717324715, 5087.56755675768, 5184.274201611777, 5184.507471790174, 5206.427292997767, 5207.6875387476875, 3329.8501567429525, 3449.9295626891835, 3470.826458677056, 3471.913202169966, 3472.4270495368232, 1189.1378750405886, 1190.6844686158174, 1194.2774621354129, 1196.8503937007874, 1239.4422509870594, 11598.362090085042, 11651.825222621668, 11654.30074195551, 11684.415779211091, 11708.648740537797, 4487.910241795146, 4569.383133277031, 4622.953770462253, 4693.20215563355, 4700.153972284953, 9818.0, 9900.752481188028, 9923.503824808731, 9924.0, 9933.15568176713, 5104.846854594368, 5117.923231151536, 5136.614753893473, 5159.019786240602, 5162.277281180638, 4283.357496375506, 4610.838620648328, 4745.406824146981, 4750.358701575243, 4762.309465127606, 3949.361015178669, 3978.8806335809973, 4061.472008638917, 4104.0, 4108.055147316134, 1285.2995117660898, 1288.1755676367131, 1306.196689036236, 1309.2013871538354, 1319.0, 882.2368651116866, 981.2297346582898, 996.4270544436832, 1005.1958433253368, 1017.6641708236265, 5451.809186678447, 5589.74846131925, 5651.8304450866535, 5703.657780533182, 5763.8559036024435, 927.8840144981878, 954.5036580977992, 962.4610218277787, 995.6664517386612, 998.7852611688522, 3962.3462128748433, 3979.1245925896255, 4032.0, 4036.3138266494766, 4062.898427539276, 10134.949325253327, 10293.691189264335, 10493.685189444328, 10505.107065899332, 10515.94742026285, 10233.74415639615, 10305.74235644115, 10348.22388320879, 10374.896251037393, 10374.948125259476, 7401.555906645618, 7687.846243075107, 7708.03649543807, 7780.844383112306, 7822.726204582812, 5666.34836993751, 5689.857753556194, 5765.308163020464, 5781.653100813965, 5808.477237048686, 9430.339876208875, 9652.27607929394, 9887.653932112342, 9894.356866803635, 9908.306418550632, 9885.258605604464, 9997.950010249902, 10075.445850478001, 10080.445575493419, 10081.647142349982, 7117.928820711727, 7297.671604777692, 7349.522281051714, 7403.629818508945, 7531.623418829146, 8059.073206581318, 8122.065962414398, 8124.55314957683, 8127.2279133482225, 8164.469309494863, 7077.752278670222, 7319.377852882351, 7444.664990075568, 7519.135299440415, 7675.309222170032, 7266.527675701062, 7288.3076107769675, 7358.852822943618, 7410.740624078131, 7449.329560339595, 6453.16108905858, 6572.441342485942, 6598.637074960923, 6623.834404139935, 6627.602343859384, 4630.884227894195, 4902.044101400193, 4910.116179087799, 4916.729579873141, 4957.97521012407, 4868.80524779019, 4876.609871210366, 4880.267959806058, 4900.901981960412, 4993.875153121201], "value": 4535.851637847623, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.25931838135506, 331.2596347164088, 332.1563229397331, 334.84764432183357, 339.5229702268314, 5535.778568857246, 5649.802256921009, 5659.037963546197, 5694.202811606378, 5721.885562288751, 5589.434958211707, 5595.468430499096, 5602.579806514507, 5650.773969041234, 5652.0, 4405.471343438784, 4441.244988351972, 4449.66627502937, 4452.532484089173, 4470.396496472983, 4255.680823938202, 4394.560543945612, 4406.625436837872, 4427.601515863572, 4458.127586413698, 4332.653387728974, 4343.826246950118, 4356.215881141393, 4380.737155770664, 4386.881345256955, 4359.3025115981445, 4379.189849877783, 4403.590850927704, 4413.183561041217, 4444.311191729022, 3809.314323421783, 3864.787436690981, 3887.2031233597045, 3911.6675082618012, 3923.941140882889, 5410.187587158307, 5410.756515956791, 5430.91853622196, 5450.373207081197, 5474.835754927359, 4957.305977163164, 5002.624803139779, 5023.924641130386, 5044.470330615306, 5049.419316778581, 5598.188262701926, 5807.353544135585, 5814.680192589406, 5837.402355951604, 5844.912326315109, 4210.431591735107, 4222.662187025031, 4232.809523571446, 4238.364245363189, 4288.52826189119, 5816.302043754734, 5916.615419997686, 6132.448079672807, 6154.569180157346, 6161.19904412428, 4322.0, 4323.437953066082, 4328.134373125387, 4344.478662560513, 4367.58507941745, 4412.713173643703, 4435.157320109169, 4435.822567097344, 4437.844675436409, 4466.196084704784, 4923.409190897044, 4945.703257804544, 4999.875003124951, 5020.723860187652, 5047.343845300087, 5861.919018748368, 5866.2960444746905, 5888.146218798251, 5893.351731309553, 5896.528277737771, 1516.5829396915935, 1518.127076930747, 1518.6507103366066, 1520.1639098495782, 1533.66259422929, 928.0904713380925, 954.9590945869036, 967.4969016111583, 975.1861537540169, 983.5033308179467, 4948.802047918115, 5026.648134630614, 5038.748062596929, 5091.796328146833, 5092.770825312869, 5317.361916569959, 5325.653832500875, 5333.280007198979, 5342.893142137135, 5390.520360634074, 4911.287863259879, 5092.701361152882, 5101.438841727407, 5106.4893510648635, 5142.948570514247, 2912.645619786809, 2920.5473151661527, 2923.38608892135, 2935.60369350135, 2937.3390987027747, 5312.0, 5458.134479398348, 5557.41647127054, 5582.09730939909, 5604.822987172658, 5026.472220416877, 5372.334576281365, 5383.838484845461, 5387.757550910218, 5461.781528738886, 5445.346558413015, 5474.124140137638, 5532.5573954083575, 5551.111822108443, 5605.82277721683, 5116.974415128049, 5246.79323755546, 5283.998701720159, 5330.907164031287, 5340.305760251143, 5229.764660590206, 5258.447862974485, 5264.605154613343, 5292.788288468418, 5301.310829592283, 6043.697815109315, 6230.43926046658, 6243.469305109116, 6273.090401891609, 6313.747450102128, 4297.978510107429, 4346.217680817484, 4363.869083927487, 4371.30059190528, 4372.781360932005, 5879.676617786063, 6093.786717464867, 6157.692115394302, 6182.0, 6187.969060154671, 5804.651720896591, 5899.528037757055, 5930.63595373058, 5931.555133364928, 5977.7310021050025, 5890.4993075587345, 5937.881242375042, 5953.345132035559, 6010.549208809444, 6031.517478601789, 5582.0, 5850.2102216200265, 5851.707414629337, 5852.385499522659, 5878.94121058801, 5987.820365389045, 5991.64050156992, 6025.367336429787, 6035.818925432244, 6081.817545473643, 5719.57103217252, 5846.853828654318, 5868.911966320423, 5908.852278693067, 5925.822225333247], "value": 4364.400544819595, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.5429079679801, 733.5598640815509, 782.3858271257064, 813.1827513349083, 837.5602808525523, 14734.852651473482, 15261.923690381547, 15306.69386612267, 15385.538433847003, 15488.148151851658, 14136.929315353409, 14150.575482735509, 14177.432902683906, 14180.574582762509, 14194.645133871658, 671.1208317104584, 773.5049568276307, 782.077148964222, 800.5276886636883, 808.4138999225573, 803.9517628942282, 804.0431886055575, 805.2913436176157, 809.6356639512213, 812.2567850416862, 853.4324674091753, 856.3791251342789, 857.8370109679141, 858.841114393836, 859.96130174142, 851.535912927453, 852.1904191018496, 855.3200205836375, 857.5712143928037, 860.3504354212561, 620.7330847735471, 621.1242148570539, 624.3756243756244, 624.6626821516376, 624.8656538844125, 14147.787783183261, 14181.290935453186, 14183.929080354636, 14188.21964791936, 14201.360938757678, 14076.788848167285, 14122.92938535311, 14146.504872329419, 14297.213653249068, 14331.641708957255, 11539.653810385702, 11682.532698692043, 11683.240589361749, 11705.239159454608, 11866.288022718578, 3797.2025874566375, 3872.5546562145432, 3880.2821478026653, 3975.6819454443867, 4062.451569038172, 54870.72564637191, 55648.72175639096, 55861.44138558643, 57544.13683794788, 57610.42389576093, 11107.666769996913, 11144.442777861075, 11174.832377514344, 11231.887681123084, 11332.206745527734, 20269.08789104494, 20358.592828143355, 20478.897605511876, 20487.8975605124, 20497.897510512652, 8110.756677299691, 8112.310453611509, 8207.0, 8210.958945205355, 8390.454620449651, 4657.441107067174, 4675.345451636706, 4676.205045142334, 4681.344611754357, 4861.4895435978715, 3365.6466071062678, 3468.0, 3472.062543113396, 3474.7567670263343, 3476.774009689362, 602.7739597650881, 606.9211002569638, 614.5390956782413, 616.4852348289229, 628.1457218183267, 692.8752824491539, 735.9043324367798, 737.8782500887294, 744.4900243333334, 754.6302311867146, 9584.76038099053, 9756.12194902448, 9798.412095274307, 9905.603775848886, 9933.65232216869, 629.6883042893797, 736.7089999450187, 738.918718940916, 751.8646643604094, 756.0964647246487, 4273.230818452646, 4424.778761061934, 4436.866893993185, 4474.747927849809, 4550.772461376918, 63415.365846340945, 64037.0, 66090.0, 66448.33551664422, 67798.0, 56687.14969275464, 57141.42858571361, 57265.0, 57971.4202857966, 58613.706931465924, 51586.48413515892, 51842.74078629583, 52016.0, 52387.21419178639, 53671.0, 8565.95717021411, 8889.511076890574, 8893.288536916902, 8915.465072095694, 9131.543422828965, 35671.28657426889, 35674.64325356817, 35842.28315433729, 35870.10324741902, 37026.25947481089, 45998.0, 48179.75910120427, 48266.5173348262, 48363.27455088247, 48550.0, 11761.235519691192, 11953.760924781282, 12130.575429859913, 12275.877241227474, 12967.0, 12759.681007974876, 12993.0, 13242.933785331012, 13619.114757541125, 13837.723245534831, 11823.0, 11989.82015269789, 12090.15368924202, 12407.689807754878, 12480.625581232578, 12051.252568377711, 12420.0, 12506.124571280287, 12569.560065397667, 12574.371281436075, 11148.609798657008, 11473.311601303949, 11787.882121178678, 12287.385630718249, 12482.875171248172, 9972.950135249277, 10041.397516149054, 10252.743681408025, 10417.843732344172, 10791.298565593212, 10228.232882533692, 10936.289141205796, 10972.177086718688, 11446.0, 11774.823377649513], "value": 6826.202430104592, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 112.0, 110.0, 111.0, 113.0, 112.0, 114.0, 112.0, 113.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 158.0, 187.0, 127.0, 159.0, 155.0, 127.0, 185.0, 131.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 164.0, 161.0, 165.0, 176.0, 163.0, 162.0, 162.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 165.0, 77.0, 76.0, 73.0, 75.0, 166.0, 74.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 142.0, 84.0, 83.0, 82.0, 139.0, 82.0, 82.0, 134.0], "value": 99.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 148.0, 146.0, 146.0, 147.0, 148.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 53.0, 55.0, 56.0, 54.0, 54.0, 55.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 61.0, 61.0, 62.0, 63.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 80.0, 80.0, 81.0, 81.0, 82.0, 80.0, 111.0, 86.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 137.0, 125.0, 134.0, 140.0, 131.0, 127.0, 139.0, 125.0, 133.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 159.0, 160.0, 159.0, 158.0, 157.0, 157.0, 167.0, 158.0, 166.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 63.0, 65.0, 63.0, 63.0, 65.0, 64.0, 62.0, 64.0, 64.0], "value": 65.1, "unit": "score"}]}]} 12:13:46 INFO - Return code: 0 12:13:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:13:46 ERROR - # TBPL SUCCESS # 12:13:46 INFO - Running post-action listener: _resource_record_post_action 12:13:46 INFO - ##### 12:13:46 INFO - ##### Finished run-tests step (success) 12:13:46 INFO - ##### 12:13:46 INFO - Running post-run listener: _resource_record_post_run 12:13:47 INFO - Total resource usage - Wall time: 1190s; CPU: 14.0%; Read bytes: 0; Write bytes: 541876224; Read time: 0; Write time: 601968 12:13:47 INFO - TinderboxPrint: CPU usage
13.6% 12:13:47 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:13:47 INFO - TinderboxPrint: I/O write bytes / time
541,876,224 / 601,968 12:13:47 INFO - TinderboxPrint: CPU idle
8,206.8 (86.4%) 12:13:47 INFO - TinderboxPrint: CPU user
1,230.3 (13.0%) 12:13:47 INFO - TinderboxPrint: Swap in / out
0 / 0 12:13:47 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 253218816; Read time: 0; Write time: 338428 12:13:47 INFO - run-tests - Wall time: 1174s; CPU: 14.0%; Read bytes: 0; Write bytes: 288657408; Read time: 0; Write time: 263540 12:13:47 INFO - Running post-run listener: _upload_blobber_files 12:13:47 INFO - Blob upload gear active. 12:13:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:13:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:13:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:13:48 INFO - (blobuploader) - INFO - Open directory for files ... 12:13:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:13:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:13:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:13:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:13:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:13:52 INFO - (blobuploader) - INFO - Done attempting. 12:13:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:13:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:13:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:13:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:13:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:13:53 INFO - (blobuploader) - INFO - Done attempting. 12:13:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:13:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:13:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:13:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:13:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:13:54 INFO - (blobuploader) - INFO - Done attempting. 12:13:54 INFO - (blobuploader) - INFO - Iteration through files over. 12:13:54 INFO - Return code: 0 12:13:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:13:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:13:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a5cebb9acf59f6e1d932a2f2346b2f730e79b43b209801baf0db0d8df28f42aedd9e3251ef6bb041e5fdf4dd3b06ab638a92434f44528d86134cd75cbdce743", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c9198eaf5b2ac4cb92bc4c157447a06b6a3feb93d25003cdeb060400dba27102f9f322b2f3e29f0bf75fd843561e344a3255ad949af66ded841a21146acaf9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8a94ab817b9e3d945cbabee3030359c19faac4ce8a727481903f898a695c8b5ef42d4a4553e6a1839bede80cc6da205ce33024361d039e93910ee2ecd203727"} 12:13:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:13:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:13:54 INFO - Contents: 12:13:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a5cebb9acf59f6e1d932a2f2346b2f730e79b43b209801baf0db0d8df28f42aedd9e3251ef6bb041e5fdf4dd3b06ab638a92434f44528d86134cd75cbdce743", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c9198eaf5b2ac4cb92bc4c157447a06b6a3feb93d25003cdeb060400dba27102f9f322b2f3e29f0bf75fd843561e344a3255ad949af66ded841a21146acaf9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8a94ab817b9e3d945cbabee3030359c19faac4ce8a727481903f898a695c8b5ef42d4a4553e6a1839bede80cc6da205ce33024361d039e93910ee2ecd203727"} 12:13:54 INFO - Running post-run listener: copy_logs_to_upload_dir 12:13:54 INFO - Copying logs to upload dir... 12:13:54 INFO - mkdir: /builds/slave/test/build/upload/logs 12:13:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.883289 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-02 12:13:53.782527) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 12:13:53.786084) ========= 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=232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a5cebb9acf59f6e1d932a2f2346b2f730e79b43b209801baf0db0d8df28f42aedd9e3251ef6bb041e5fdf4dd3b06ab638a92434f44528d86134cd75cbdce743", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c9198eaf5b2ac4cb92bc4c157447a06b6a3feb93d25003cdeb060400dba27102f9f322b2f3e29f0bf75fd843561e344a3255ad949af66ded841a21146acaf9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8a94ab817b9e3d945cbabee3030359c19faac4ce8a727481903f898a695c8b5ef42d4a4553e6a1839bede80cc6da205ce33024361d039e93910ee2ecd203727"} build_url:https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011589 build_url: 'https://queue.taskcluster.net/v1/task/NfYdbYkiRBa3aw0gSllbIA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a5cebb9acf59f6e1d932a2f2346b2f730e79b43b209801baf0db0d8df28f42aedd9e3251ef6bb041e5fdf4dd3b06ab638a92434f44528d86134cd75cbdce743", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c9198eaf5b2ac4cb92bc4c157447a06b6a3feb93d25003cdeb060400dba27102f9f322b2f3e29f0bf75fd843561e344a3255ad949af66ded841a21146acaf9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c8a94ab817b9e3d945cbabee3030359c19faac4ce8a727481903f898a695c8b5ef42d4a4553e6a1839bede80cc6da205ce33024361d039e93910ee2ecd203727"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 12:13:53.811348) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 12:13:53.811752) ========= 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=232498196343f89f466a4a9a000001c8-1464893595.125104-1685625999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004381 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 12:13:53.894539) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 12:13:53.894907) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 12:13:53.895221) ========= ========= Total master_lag: 0.16 =========