builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-019 starttime: 1464893616.82 results: success (0) buildid: 20160601061753 builduid: 0096620e028e41ca850770a1362868eb revision: 111970c73823 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:36.819090) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:36.819531) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:36.819806) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:37.315963) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:37.316271) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 11:53:37-- 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% 89.8M=0s 2016-06-02 11:53:37 (89.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100117 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:37.429946) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:37.430280) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013757 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:37.479345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:37.479728) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 11:53:37,784 Setting DEBUG logging. 2016-06-02 11:53:37,784 attempt 1/10 2016-06-02 11:53:37,784 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:38,080 unpacking tar archive at: mozilla-central-111970c73823/testing/mozharness/ program finished with exit code 0 elapsedTime=0.627082 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:38.120138) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:38.120474) ========= script_repo_revision: 111970c73823 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:38.120862) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:38.121129) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 11:53:38.131702) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-02 11:53:38.132052) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:53:38 INFO - MultiFileLogger online at 20160602 11:53:38 in /builds/slave/test 11:53:38 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:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:53:38 INFO - {'append_to_log': False, 11:53:38 INFO - 'base_work_dir': '/builds/slave/test', 11:53:38 INFO - 'blob_upload_branch': 'Firefox', 11:53:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:53:38 INFO - 'branch': 'Firefox', 11:53:38 INFO - 'buildbot_json_path': 'buildprops.json', 11:53:38 INFO - 'config_files': ('talos/linux_config.py',), 11:53:38 INFO - 'default_actions': ('clobber', 11:53:38 INFO - 'read-buildbot-config', 11:53:38 INFO - 'download-and-extract', 11:53:38 INFO - 'populate-webroot', 11:53:38 INFO - 'create-virtualenv', 11:53:38 INFO - 'install', 11:53:38 INFO - 'run-tests'), 11:53:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:53:38 INFO - 'download_minidump_stackwalk': True, 11:53:38 INFO - 'download_symbols': 'ondemand', 11:53:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:53:38 INFO - 'tooltool.py': '/tools/tooltool.py', 11:53:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:53:38 INFO - '/tools/misc-python/virtualenv.py')}, 11:53:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:53:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:53:38 INFO - 'installer_path': 'installer.exe', 11:53:38 INFO - 'log_level': 'info', 11:53:38 INFO - 'log_name': 'talos', 11:53:38 INFO - 'log_to_console': True, 11:53:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:53:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:53:38 INFO - 'opt_config_files': (), 11:53:38 INFO - 'pip_index': False, 11:53:38 INFO - 'sps_profile': False, 11:53:38 INFO - 'sps_profile_interval': 0, 11:53:38 INFO - 'suite': 'dromaeojs-e10s', 11:53:38 INFO - 'system_bits': '32', 11:53:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:53:38 INFO - 'title': 'talos-linux64-ix-019', 11:53:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:53:38 INFO - 'use_talos_json': True, 11:53:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:53:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:53:38 INFO - 'work_dir': 'build'} 11:53:38 INFO - ##### 11:53:38 INFO - ##### Running clobber step. 11:53:38 INFO - ##### 11:53:38 INFO - Running pre-action listener: _resource_record_pre_action 11:53:38 INFO - Running main action method: clobber 11:53:38 INFO - rmtree: /builds/slave/test/build 11:53:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:53:39 INFO - Running post-action listener: _resource_record_post_action 11:53:39 INFO - ##### 11:53:39 INFO - ##### Finished clobber step (success) 11:53:39 INFO - ##### 11:53:39 INFO - ##### 11:53:39 INFO - ##### Running read-buildbot-config step. 11:53:39 INFO - ##### 11:53:39 INFO - Running pre-action listener: _resource_record_pre_action 11:53:39 INFO - Running main action method: read_buildbot_config 11:53:39 INFO - Using buildbot properties: 11:53:39 INFO - { 11:53:39 INFO - "project": "", 11:53:39 INFO - "product": "firefox", 11:53:39 INFO - "script_repo_revision": "production", 11:53:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:53:39 INFO - "repository": "", 11:53:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:53:39 INFO - "buildid": "20160601061753", 11:53:39 INFO - "stage_platform": "linux64-pgo", 11:53:39 INFO - "basedir": "/builds/slave/test", 11:53:39 INFO - "nightly_build": "True", 11:53:39 INFO - "buildnumber": 58, 11:53:39 INFO - "slavename": "talos-linux64-ix-019", 11:53:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:53:39 INFO - "platform": "ubuntu64_hw", 11:53:39 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 11:53:39 INFO - "branch": "mozilla-central", 11:53:39 INFO - "repo_path": "mozilla-central", 11:53:39 INFO - "revision": "111970c73823", 11:53:39 INFO - "pgo_build": "True", 11:53:39 INFO - "builduid": "0096620e028e41ca850770a1362868eb", 11:53:39 INFO - "slavebuilddir": "test" 11:53:39 INFO - } 11:53:39 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:39 INFO - Running post-action listener: _resource_record_post_action 11:53:39 INFO - ##### 11:53:39 INFO - ##### Finished read-buildbot-config step (success) 11:53:39 INFO - ##### 11:53:39 INFO - ##### 11:53:39 INFO - ##### Running download-and-extract step. 11:53:39 INFO - ##### 11:53:39 INFO - Running pre-action listener: _resource_record_pre_action 11:53:39 INFO - Running main action method: download_and_extract 11:53:39 INFO - mkdir: /builds/slave/test/build/tests 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 - 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:39 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:39 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:39 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:39 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:39 INFO - Downloaded 1361 bytes. 11:53:39 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:53:39 INFO - Using the following test package requirements: 11:53:39 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:53:39 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:53:39 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:53:39 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:39 INFO - u'jsshell-linux-x86_64.zip'], 11:53:39 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:53:39 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:53:39 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:53:39 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:53:39 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:53:39 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:53:39 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:53:39 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 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 - 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:39 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:39 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:39 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:39 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:40 INFO - Downloaded 24422301 bytes. 11:53:40 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:40 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:41 INFO - Return code: 0 11:53:41 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:41 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:41 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:41 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:41 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:41 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:41 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:43 INFO - Downloaded 24422301 bytes. 11:53:43 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:43 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:44 INFO - Return code: 0 11:53:44 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:44 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:44 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:44 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:44 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:44 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:45 INFO - Downloaded 10834055 bytes. 11:53:45 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:45 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:45 INFO - Return code: 0 11:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:45 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:45 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:45 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:45 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:45 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:47 INFO - Downloaded 59024865 bytes. 11:53:47 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:47 INFO - mkdir: /builds/slave/test/properties 11:53:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:53:47 INFO - Writing to file /builds/slave/test/properties/build_url 11:53:47 INFO - Contents: 11:53:47 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:48 INFO - Running post-action listener: _resource_record_post_action 11:53:48 INFO - Running post-action listener: set_extra_try_arguments 11:53:48 INFO - ##### 11:53:48 INFO - ##### Finished download-and-extract step (success) 11:53:48 INFO - ##### 11:53:48 INFO - ##### 11:53:48 INFO - ##### Running populate-webroot step. 11:53:48 INFO - ##### 11:53:48 INFO - Running pre-action listener: _resource_record_pre_action 11:53:48 INFO - Running main action method: populate_webroot 11:53:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:53:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:53:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:53:48 INFO - '--tppagecycles', 11:53:48 INFO - '7'], 11:53:48 INFO - 'tests': ['tsvgm']}}, 11:53:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:53:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:53:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:53:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:53:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:53:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:53:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:48 INFO - 'talos_options': ['--disable-e10s'], 11:53:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:53:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:53:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:48 INFO - 'talos_options': ['--disable-e10s'], 11:53:48 INFO - 'tests': ['damp', 'tps']}, 11:53:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:48 INFO - 'tests': ['damp', 'tps']}, 11:53:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:53:48 INFO - 'tests': ['dromaeo_dom']}, 11:53:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:53:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:53:48 INFO - 'tests': ['a11yr', 11:53:48 INFO - 'ts_paint', 11:53:48 INFO - 'tpaint', 11:53:48 INFO - 'sessionrestore', 11:53:48 INFO - 'sessionrestore_no_auto_restore', 11:53:48 INFO - 'tabpaint']}, 11:53:48 INFO - 'other-e10s': {'tests': ['a11yr', 11:53:48 INFO - 'ts_paint', 11:53:48 INFO - 'tpaint', 11:53:48 INFO - 'sessionrestore', 11:53:48 INFO - 'sessionrestore_no_auto_restore', 11:53:48 INFO - 'tabpaint']}, 11:53:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:53:48 INFO - 'ts_paint', 11:53:48 INFO - 'tpaint', 11:53:48 INFO - 'sessionrestore', 11:53:48 INFO - 'sessionrestore_no_auto_restore', 11:53:48 INFO - 'tabpaint']}, 11:53:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:53:48 INFO - 'ts_paint', 11:53:48 INFO - 'tpaint', 11:53:48 INFO - 'sessionrestore', 11:53:48 INFO - 'sessionrestore_no_auto_restore', 11:53:48 INFO - 'tabpaint']}, 11:53:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:53:48 INFO - 'tests': ['a11yr', 11:53:48 INFO - 'ts_paint', 11:53:48 INFO - 'tpaint', 11:53:48 INFO - 'sessionrestore', 11:53:48 INFO - 'sessionrestore_no_auto_restore', 11:53:48 INFO - 'tabpaint']}, 11:53:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:53:48 INFO - 'tests': ['a11yr', 11:53:48 INFO - 'ts_paint', 11:53:48 INFO - 'tpaint', 11:53:48 INFO - 'sessionrestore', 11:53:48 INFO - 'sessionrestore_no_auto_restore', 11:53:48 INFO - 'tabpaint']}, 11:53:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:53:48 INFO - 'tests': ['tsvgx', 11:53:48 INFO - 'tsvgr_opacity', 11:53:48 INFO - 'tart', 11:53:48 INFO - 'tscrollx', 11:53:48 INFO - 'cart']}, 11:53:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:53:48 INFO - 'tsvgr_opacity', 11:53:48 INFO - 'tart', 11:53:48 INFO - 'tscrollx', 11:53:48 INFO - 'cart']}, 11:53:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:48 INFO - 'talos_options': ['--disable-e10s'], 11:53:48 INFO - 'tests': ['tp5o']}, 11:53:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:48 INFO - 'tests': ['tp5o']}, 11:53:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:48 INFO - 'talos_options': ['--disable-e10s', 11:53:48 INFO - '--xperf_path', 11:53:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:53:48 INFO - 'tests': ['tp5n']}, 11:53:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:53:48 INFO - 'talos_options': ['--xperf_path', 11:53:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:53:48 INFO - 'tests': ['tp5n']}}, 11:53:48 INFO - 'talos.zip': {'path': '', 11:53:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:53:48 INFO - Running post-action listener: _resource_record_post_action 11:53:48 INFO - ##### 11:53:48 INFO - ##### Finished populate-webroot step (success) 11:53:48 INFO - ##### 11:53:48 INFO - ##### 11:53:48 INFO - ##### Running create-virtualenv step. 11:53:48 INFO - ##### 11:53:48 INFO - Running pre-action listener: _resource_record_pre_action 11:53:48 INFO - Running main action method: create_virtualenv 11:53:48 INFO - Creating virtualenv /builds/slave/test/build/venv 11:53:48 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:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:53:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:53:48 INFO - Using real prefix '/usr' 11:53:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:53:48 INFO - Installing distribute.............................................................................................................................................................................................done. 11:53:50 INFO - Installing pip.................done. 11:53:50 INFO - Return code: 0 11:53:50 INFO - Installing pip>=1.5 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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830b354f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2955770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e49c0>, '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 0x29e58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306', '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', 'pip>=1.5'] 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 pip>=1.5 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': '78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306', 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): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:53:50 INFO - Cleaning up... 11:53:50 INFO - Return code: 0 11:53:50 INFO - Installing psutil>=3.1.1 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', '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 0x7f830b354f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2955770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e49c0>, '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 0x29e58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306', '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', 'psutil>=3.1.1'] 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 psutil>=3.1.1 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': '78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306', 11:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:50 INFO - '_': '/tools/buildbot/bin/python'} 11:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:51 INFO - Downloading/unpacking psutil>=3.1.1 11:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:53:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:53:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:53:53 INFO - Installing collected packages: psutil 11:53:53 INFO - Running setup.py install for psutil 11:53:53 INFO - building 'psutil._psutil_linux' extension 11:53:53 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:53 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:53 INFO - building 'psutil._psutil_posix' extension 11:53:53 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:53 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:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:53:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:53:53 INFO - Successfully installed psutil 11:53:53 INFO - Cleaning up... 11:53:53 INFO - Return code: 0 11:53:53 INFO - Installing mozsystemmonitor==0.3 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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830b354f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2955770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e49c0>, '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 0x29e58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306', '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', 'mozsystemmonitor==0.3'] 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 mozsystemmonitor==0.3 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': '78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306', 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 mozsystemmonitor==0.3 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 mozsystemmonitor-0.3.tar.gz 11:53:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:53:55 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:55 INFO - Installing collected packages: mozsystemmonitor 11:53:55 INFO - Running setup.py install for mozsystemmonitor 11:53:55 INFO - Successfully installed mozsystemmonitor 11:53:55 INFO - Cleaning up... 11:53:55 INFO - Return code: 0 11:53:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f830b354f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2955770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e49c0>, '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 0x29e58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306', '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:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:53:55 INFO - Using env: {'DISPLAY': ':0', 11:53:55 INFO - 'HOME': '/home/cltbld', 11:53:55 INFO - 'LANG': 'en_US.UTF-8', 11:53:55 INFO - 'LANGUAGE': 'en_US:en', 11:53:55 INFO - 'LOGNAME': 'cltbld', 11:53:55 INFO - 'MAIL': '/var/mail/cltbld', 11:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:55 INFO - 'MOZ_NO_REMOTE': '1', 11:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:55 INFO - 'NO_EM_RESTART': '1', 11:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:55 INFO - 'PWD': '/builds/slave/test', 11:53:55 INFO - 'SHELL': '/bin/bash', 11:53:55 INFO - 'SHLVL': '1', 11:53:55 INFO - 'TERM': 'linux', 11:53:55 INFO - 'TMOUT': '86400', 11:53:55 INFO - 'USER': 'cltbld', 11:53:55 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306', 11:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:55 INFO - '_': '/tools/buildbot/bin/python'} 11:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:56 INFO - Downloading/unpacking blobuploader==1.2.4 11:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:57 INFO - Downloading blobuploader-1.2.4.tar.gz 11:53:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:53:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:53:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:53:58 INFO - Downloading docopt-0.6.1.tar.gz 11:53:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:53:58 INFO - Installing collected packages: blobuploader, requests, docopt 11:53:58 INFO - Running setup.py install for blobuploader 11:53:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:53:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:53:58 INFO - Running setup.py install for requests 11:53:59 INFO - Running setup.py install for docopt 11:53:59 INFO - Successfully installed blobuploader requests docopt 11:53:59 INFO - Cleaning up... 11:53:59 INFO - Return code: 0 11:53:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:53:59 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 0x7f830b354f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2955770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e49c0>, '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 0x29e58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306', '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:59 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:59 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:59 INFO - Using env: {'DISPLAY': ':0', 11:53:59 INFO - 'HOME': '/home/cltbld', 11:53:59 INFO - 'LANG': 'en_US.UTF-8', 11:53:59 INFO - 'LANGUAGE': 'en_US:en', 11:53:59 INFO - 'LOGNAME': 'cltbld', 11:53:59 INFO - 'MAIL': '/var/mail/cltbld', 11:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:59 INFO - 'MOZ_NO_REMOTE': '1', 11:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:53:59 INFO - 'NO_EM_RESTART': '1', 11:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:59 INFO - 'PWD': '/builds/slave/test', 11:53:59 INFO - 'SHELL': '/bin/bash', 11:53:59 INFO - 'SHLVL': '1', 11:53:59 INFO - 'TERM': 'linux', 11:53:59 INFO - 'TMOUT': '86400', 11:53:59 INFO - 'USER': 'cltbld', 11:53:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306', 11:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:59 INFO - '_': '/tools/buildbot/bin/python'} 11:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:53:59 INFO - Running setup.py (path:/tmp/pip-gmmTQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:53:59 INFO - Running setup.py (path:/tmp/pip-8kdQX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:53:59 INFO - Running setup.py (path:/tmp/pip-lXqGb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:53:59 INFO - Running setup.py (path:/tmp/pip-ibfoYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:53:59 INFO - Running setup.py (path:/tmp/pip-k6c2AX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:53:59 INFO - Running setup.py (path:/tmp/pip-PEumai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:53:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:53:59 INFO - Running setup.py (path:/tmp/pip-V2lQiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:54:00 INFO - Running setup.py (path:/tmp/pip-3N8RLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:54:00 INFO - Running setup.py (path:/tmp/pip-7RqL0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:54:00 INFO - Running setup.py (path:/tmp/pip-nWzsJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:54:00 INFO - Running setup.py (path:/tmp/pip-bYT2rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:54:00 INFO - Running setup.py (path:/tmp/pip-nQ6TpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:54:00 INFO - Running setup.py (path:/tmp/pip-lKYibD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:54:00 INFO - Running setup.py (path:/tmp/pip-c32JQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:00 INFO - Running setup.py (path:/tmp/pip-QGuZ2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:54:00 INFO - Running setup.py (path:/tmp/pip-UdOM50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:54:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:54:00 INFO - Running setup.py (path:/tmp/pip-eIX7SW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:54:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:54:00 INFO - Running setup.py install for manifestparser 11:54:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:54:00 INFO - Running setup.py install for mozcrash 11:54:00 INFO - Running setup.py install for mozdebug 11:54:01 INFO - Running setup.py install for mozdevice 11:54:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:54:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:54:01 INFO - Running setup.py install for mozfile 11:54:01 INFO - Running setup.py install for mozhttpd 11:54:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:54:01 INFO - Running setup.py install for mozinfo 11:54:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:54:01 INFO - Running setup.py install for mozInstall 11:54:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:54:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:54:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:54:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:54:01 INFO - Running setup.py install for mozleak 11:54:01 INFO - Running setup.py install for mozlog 11:54:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:54:01 INFO - Running setup.py install for moznetwork 11:54:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:54:01 INFO - Running setup.py install for mozprocess 11:54:02 INFO - Running setup.py install for mozprofile 11:54:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:54:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:54:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:54:02 INFO - Running setup.py install for mozrunner 11:54:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:54:02 INFO - Running setup.py install for mozscreenshot 11:54:02 INFO - Running setup.py install for moztest 11:54:02 INFO - Running setup.py install for mozversion 11:54:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:54:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:54:02 INFO - Cleaning up... 11:54:02 INFO - Return code: 0 11:54:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:02 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 0x7f830b354f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2955770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e49c0>, '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 0x29e58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306', '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:54:02 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:54:02 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:54:02 INFO - Using env: {'DISPLAY': ':0', 11:54:02 INFO - 'HOME': '/home/cltbld', 11:54:02 INFO - 'LANG': 'en_US.UTF-8', 11:54:02 INFO - 'LANGUAGE': 'en_US:en', 11:54:02 INFO - 'LOGNAME': 'cltbld', 11:54:02 INFO - 'MAIL': '/var/mail/cltbld', 11:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:02 INFO - 'MOZ_NO_REMOTE': '1', 11:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:02 INFO - 'NO_EM_RESTART': '1', 11:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:02 INFO - 'PWD': '/builds/slave/test', 11:54:02 INFO - 'SHELL': '/bin/bash', 11:54:02 INFO - 'SHLVL': '1', 11:54:02 INFO - 'TERM': 'linux', 11:54:02 INFO - 'TMOUT': '86400', 11:54:02 INFO - 'USER': 'cltbld', 11:54:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306', 11:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:02 INFO - '_': '/tools/buildbot/bin/python'} 11:54:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:54:02 INFO - Running setup.py (path:/tmp/pip-wZIF61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:54:02 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:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:54:02 INFO - Running setup.py (path:/tmp/pip-AvGLft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:54:02 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:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:54:02 INFO - Running setup.py (path:/tmp/pip-vTRPZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:54:02 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:54:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:54:03 INFO - Running setup.py (path:/tmp/pip-Q0OVx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:54:03 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:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:54:03 INFO - Running setup.py (path:/tmp/pip-j9mgg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:54:03 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:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:54:03 INFO - Running setup.py (path:/tmp/pip-Y7F20d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:54:03 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:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:54:03 INFO - Running setup.py (path:/tmp/pip-v1TI6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:54:03 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:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:54:03 INFO - Running setup.py (path:/tmp/pip-AO_LGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:54:03 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:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:54:03 INFO - Running setup.py (path:/tmp/pip-YbWx5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:54:03 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:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:54:03 INFO - Running setup.py (path:/tmp/pip-g3G2rX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:54:03 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:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:54:03 INFO - Running setup.py (path:/tmp/pip-XwrJdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:54:03 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:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:54:03 INFO - Running setup.py (path:/tmp/pip-SqnYc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:54:03 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:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:54:03 INFO - Running setup.py (path:/tmp/pip-KR6Tlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:54:03 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:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:54:03 INFO - Running setup.py (path:/tmp/pip-v9k_op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:54:03 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:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:03 INFO - Running setup.py (path:/tmp/pip-JSCWj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:54:03 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:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:54:03 INFO - Running setup.py (path:/tmp/pip-Qnujmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:54:03 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:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:54:03 INFO - Running setup.py (path:/tmp/pip-E_GyOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:54:04 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:54:04 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:54:04 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:54:04 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:54:04 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:54:04 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:54:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:54:05 INFO - Downloading blessings-1.6.tar.gz 11:54:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:54:05 INFO - Installing collected packages: blessings 11:54:05 INFO - Running setup.py install for blessings 11:54:06 INFO - Successfully installed blessings 11:54:06 INFO - Cleaning up... 11:54:06 INFO - Return code: 0 11:54:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:54:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:54:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:54:06 INFO - Reading from file tmpfile_stdout 11:54:06 INFO - Current package versions: 11:54:06 INFO - argparse == 1.2.1 11:54:06 INFO - blessings == 1.6 11:54:06 INFO - blobuploader == 1.2.4 11:54:06 INFO - docopt == 0.6.1 11:54:06 INFO - manifestparser == 1.1 11:54:06 INFO - mozInstall == 1.12 11:54:06 INFO - mozcrash == 0.17 11:54:06 INFO - mozdebug == 0.1 11:54:06 INFO - mozdevice == 0.48 11:54:06 INFO - mozfile == 1.2 11:54:06 INFO - mozhttpd == 0.7 11:54:06 INFO - mozinfo == 0.9 11:54:06 INFO - mozleak == 0.1 11:54:06 INFO - mozlog == 3.2 11:54:06 INFO - moznetwork == 0.27 11:54:06 INFO - mozprocess == 0.22 11:54:06 INFO - mozprofile == 0.28 11:54:06 INFO - mozrunner == 6.11 11:54:06 INFO - mozscreenshot == 0.1 11:54:06 INFO - mozsystemmonitor == 0.3 11:54:06 INFO - moztest == 0.7 11:54:06 INFO - mozversion == 1.4 11:54:06 INFO - psutil == 3.1.1 11:54:06 INFO - requests == 1.2.3 11:54:06 INFO - wsgiref == 0.1.2 11:54:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:54:06 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:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:06 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:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:06 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 0x7f830b354f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2955770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e49c0>, '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 0x29e58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306', '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:54:06 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:54:06 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:54:06 INFO - Using env: {'DISPLAY': ':0', 11:54:06 INFO - 'HOME': '/home/cltbld', 11:54:06 INFO - 'LANG': 'en_US.UTF-8', 11:54:06 INFO - 'LANGUAGE': 'en_US:en', 11:54:06 INFO - 'LOGNAME': 'cltbld', 11:54:06 INFO - 'MAIL': '/var/mail/cltbld', 11:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:06 INFO - 'MOZ_NO_REMOTE': '1', 11:54:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:06 INFO - 'NO_EM_RESTART': '1', 11:54:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:06 INFO - 'PWD': '/builds/slave/test', 11:54:06 INFO - 'SHELL': '/bin/bash', 11:54:06 INFO - 'SHLVL': '1', 11:54:06 INFO - 'TERM': 'linux', 11:54:06 INFO - 'TMOUT': '86400', 11:54:06 INFO - 'USER': 'cltbld', 11:54:06 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306', 11:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:06 INFO - '_': '/tools/buildbot/bin/python'} 11:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:06 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:54:06 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:54:06 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:54:06 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:54:06 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:54:06 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:54:06 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:54:06 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:54:06 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:54:06 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:54:06 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:54:06 INFO - Cleaning up... 11:54:06 INFO - Return code: 0 11:54:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:54:06 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:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:06 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:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:06 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 0x7f830b354f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2955770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e49c0>, '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 0x29e58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306', '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:54:06 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:54:06 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:54:06 INFO - Using env: {'DISPLAY': ':0', 11:54:06 INFO - 'HOME': '/home/cltbld', 11:54:06 INFO - 'LANG': 'en_US.UTF-8', 11:54:06 INFO - 'LANGUAGE': 'en_US:en', 11:54:06 INFO - 'LOGNAME': 'cltbld', 11:54:06 INFO - 'MAIL': '/var/mail/cltbld', 11:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:06 INFO - 'MOZ_NO_REMOTE': '1', 11:54:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:06 INFO - 'NO_EM_RESTART': '1', 11:54:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:06 INFO - 'PWD': '/builds/slave/test', 11:54:06 INFO - 'SHELL': '/bin/bash', 11:54:06 INFO - 'SHLVL': '1', 11:54:06 INFO - 'TERM': 'linux', 11:54:06 INFO - 'TMOUT': '86400', 11:54:06 INFO - 'USER': 'cltbld', 11:54:06 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306', 11:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:06 INFO - '_': '/tools/buildbot/bin/python'} 11:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:06 INFO - Downloading/unpacking jsonschema 11:54:06 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:54:06 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:54:06 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:54:06 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:54:06 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:54:06 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:54:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:54:08 INFO - Downloading/unpacking functools32 (from jsonschema) 11:54:08 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:54:08 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:54:08 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:54:08 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:54:08 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:54:08 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:54:08 INFO - Downloading functools32-3.2.3-2.tar.gz 11:54:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:54:08 INFO - warning: no files found matching '*.txt' 11:54:08 INFO - no previously-included directories found matching 'build' 11:54:08 INFO - no previously-included directories found matching 'dist' 11:54:08 INFO - no previously-included directories found matching '.git*' 11:54:08 INFO - Installing collected packages: jsonschema, functools32 11:54:09 INFO - Running setup.py install for functools32 11:54:09 INFO - warning: no files found matching '*.txt' 11:54:09 INFO - no previously-included directories found matching 'build' 11:54:09 INFO - no previously-included directories found matching 'dist' 11:54:09 INFO - no previously-included directories found matching '.git*' 11:54:09 INFO - Successfully installed jsonschema functools32 11:54:09 INFO - Cleaning up... 11:54:09 INFO - Return code: 0 11:54:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:54:09 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 0x7f830b354f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2955770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e49c0>, '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 0x29e58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e5d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306', '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:54:09 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:54:09 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:54:09 INFO - Using env: {'DISPLAY': ':0', 11:54:09 INFO - 'HOME': '/home/cltbld', 11:54:09 INFO - 'LANG': 'en_US.UTF-8', 11:54:09 INFO - 'LANGUAGE': 'en_US:en', 11:54:09 INFO - 'LOGNAME': 'cltbld', 11:54:09 INFO - 'MAIL': '/var/mail/cltbld', 11:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:09 INFO - 'MOZ_NO_REMOTE': '1', 11:54:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:09 INFO - 'NO_EM_RESTART': '1', 11:54:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:09 INFO - 'PWD': '/builds/slave/test', 11:54:09 INFO - 'SHELL': '/bin/bash', 11:54:09 INFO - 'SHLVL': '1', 11:54:09 INFO - 'TERM': 'linux', 11:54:09 INFO - 'TMOUT': '86400', 11:54:09 INFO - 'USER': 'cltbld', 11:54:09 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306', 11:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:09 INFO - '_': '/tools/buildbot/bin/python'} 11:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:54:09 INFO - Downloading/unpacking flake8 11:54:09 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:54:09 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:54:09 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:54:09 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:54:09 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:54:09 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:54:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:54:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:54:11 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:54:11 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:54:11 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:54:11 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:54:11 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:54:11 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:54:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:54:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:54:11 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:54:11 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:54:11 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:54:11 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:54:11 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:54:11 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:54:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:54:11 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:54:11 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:54:11 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:54:11 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:54:11 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:54:11 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:54:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:54:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:54:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:54:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:54:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:54:11 INFO - no previously-included directories found matching 'docs/_build' 11:54:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:54:12 INFO - Running setup.py install for pep8 11:54:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:54:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:54:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:54:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:54:12 INFO - no previously-included directories found matching 'docs/_build' 11:54:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:54:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:54:12 INFO - Cleaning up... 11:54:12 INFO - Return code: 0 11:54:12 INFO - Running post-action listener: _resource_record_post_action 11:54:12 INFO - Running post-action listener: _start_resource_monitoring 11:54:12 INFO - Starting resource monitoring. 11:54:12 INFO - ##### 11:54:12 INFO - ##### Finished create-virtualenv step (success) 11:54:12 INFO - ##### 11:54:12 INFO - ##### 11:54:12 INFO - ##### Running install step. 11:54:12 INFO - ##### 11:54:12 INFO - Running pre-action listener: _resource_record_pre_action 11:54:12 INFO - Running main action method: install 11:54:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:54:12 INFO - Reading from file tmpfile_stdout 11:54:12 INFO - Detecting whether we're running mozinstall >=1.0... 11:54:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:54:12 INFO - Reading from file tmpfile_stdout 11:54:12 INFO - Output received: 11:54:12 INFO - Usage: mozinstall [options] installer 11:54:12 INFO - Options: 11:54:12 INFO - -h, --help show this help message and exit 11:54:12 INFO - -d DEST, --destination=DEST 11:54:12 INFO - Directory to install application into. [default: 11:54:12 INFO - "/builds/slave/test"] 11:54:12 INFO - --app=APP Application being installed. [default: firefox] 11:54:12 INFO - mkdir: /builds/slave/test/build/application 11:54:12 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:54:12 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:29 INFO - Reading from file tmpfile_stdout 11:54:29 INFO - Output received: 11:54:29 INFO - /builds/slave/test/build/application/firefox/firefox 11:54:29 INFO - Running post-action listener: _resource_record_post_action 11:54:29 INFO - ##### 11:54:29 INFO - ##### Finished install step (success) 11:54:29 INFO - ##### 11:54:29 INFO - ##### 11:54:29 INFO - ##### Running run-tests step. 11:54:29 INFO - ##### 11:54:29 INFO - Running pre-action listener: _resource_record_pre_action 11:54:29 INFO - Running main action method: run_tests 11:54:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:54:29 INFO - Python 2.7.3 11:54:29 INFO - Return code: 0 11:54:29 INFO - grabbing minidump binary from tooltool 11:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:54:29 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 0x29e49c0>, '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 0x29e58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e5d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:54:29 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:29 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:29 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:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:54:29 INFO - Return code: 0 11:54:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:54:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:54:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:54:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:54:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:54:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:54:30 INFO - Return code: 0 11:54:30 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-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:54:30 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-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:54:30 INFO - Using env: {'DISPLAY': ':0', 11:54:30 INFO - 'HOME': '/home/cltbld', 11:54:30 INFO - 'LANG': 'en_US.UTF-8', 11:54:30 INFO - 'LANGUAGE': 'en_US:en', 11:54:30 INFO - 'LOGNAME': 'cltbld', 11:54:30 INFO - 'MAIL': '/var/mail/cltbld', 11:54:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:54:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:54:30 INFO - 'MOZ_NO_REMOTE': '1', 11:54:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:54:30 INFO - 'NO_EM_RESTART': '1', 11:54:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:54:30 INFO - 'PWD': '/builds/slave/test', 11:54:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:54:30 INFO - 'SHELL': '/bin/bash', 11:54:30 INFO - 'SHLVL': '1', 11:54:30 INFO - 'TERM': 'linux', 11:54:30 INFO - 'TMOUT': '86400', 11:54:30 INFO - 'USER': 'cltbld', 11:54:30 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306', 11:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:54:30 INFO - '_': '/tools/buildbot/bin/python'} 11:54:30 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-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:54:30 INFO - mozversion application_buildid: 20160601061753 11:54:30 INFO - mozversion application_changeset: 111970c738234569c8c180319155327316335deb 11:54:30 INFO - mozversion application_display_name: Nightly 11:54:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:54:30 INFO - mozversion application_name: Firefox 11:54:30 INFO - mozversion application_remotingname: firefox 11:54:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:54:30 INFO - mozversion application_vendor: Mozilla 11:54:30 INFO - mozversion application_version: 49.0a1 11:54:30 INFO - mozversion platform_buildid: 20160601061753 11:54:30 INFO - mozversion platform_changeset: 111970c738234569c8c180319155327316335deb 11:54:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:54:30 INFO - mozversion platform_version: 49.0a1 11:54:30 INFO - using testdate: 1464893670 11:54:30 INFO - actual date: 1464893670 11:54:30 INFO - starting webserver on 'localhost:42005' 11:54:30 INFO - SUITE-START | Running 2 tests 11:54:30 INFO - TEST-START | dromaeo_css 11:54:30 INFO - operating with platform_type : linux_ 11:54:30 INFO - Initialising browser for dromaeo_css test... 11:54:30 INFO - TEST-INFO | started process 21215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplBRN4d/profile http://localhost:42005/getInfo.html) 11:54:35 INFO - PROCESS | 21215 | __metrics Screen width/height:1600/1200 11:54:35 INFO - PROCESS | 21215 | colorDepth:24 11:54:35 INFO - PROCESS | 21215 | Browser inner width/height: 1024/697 11:54:35 INFO - PROCESS | 21215 | __metrics 11:54:36 ERROR - PROCESS | 21215 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 11:54:36 INFO - TEST-INFO | 21215: exit 0 11:54:36 INFO - Browser initialized. 11:54:36 INFO - Running cycle 1/1 for dromaeo_css test... 11:54:36 INFO - TEST-INFO | started process 21333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplBRN4d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:54:48 INFO - PROCESS | 21333 | RSS: Main: 167133184 11:54:48 INFO - PROCESS | 21333 | 11:55:38 INFO - PROCESS | 21333 | 1464893738410 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:45 INFO - PROCESS | 21333 | Cycle 1(1): loaded http://localhost:42005/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42005/tests/dromaeo/cssquery-ext.html) 11:57:47 INFO - PROCESS | 21333 | RSS: Main: 171040768 11:57:47 INFO - PROCESS | 21333 | 12:00:49 INFO - PROCESS | 21333 | Cycle 1(1): loaded http://localhost:42005/tests/dromaeo/cssquery-ext.html (next: http://localhost:42005/tests/dromaeo/cssquery-jquery.html) 12:00:49 INFO - PROCESS | 21333 | RSS: Main: 169508864 12:00:49 INFO - PROCESS | 21333 | 12:03:51 INFO - PROCESS | 21333 | Cycle 1(1): loaded http://localhost:42005/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42005/tests/dromaeo/cssquery-mootools.html) 12:03:52 INFO - PROCESS | 21333 | RSS: Main: 171429888 12:03:52 INFO - PROCESS | 21333 | 12:06:53 INFO - PROCESS | 21333 | Cycle 1(1): loaded http://localhost:42005/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42005/tests/dromaeo/cssquery-prototype.html) 12:06:54 INFO - PROCESS | 21333 | RSS: Main: 168804352 12:06:54 INFO - PROCESS | 21333 | 12:09:57 INFO - PROCESS | 21333 | Cycle 1(1): loaded http://localhost:42005/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42005/tests/dromaeo/cssquery-yui.html) 12:09:57 INFO - PROCESS | 21333 | RSS: Main: 170590208 12:09:57 INFO - PROCESS | 21333 | 12:13:00 INFO - PROCESS | 21333 | Cycle 1(1): loaded http://localhost:42005/tests/dromaeo/cssquery-yui.html (next: http://localhost:42005/tests/dromaeo/cssquery-dojo.html) 12:13:00 INFO - PROCESS | 21333 | RSS: Main: 171577344 12:13:00 INFO - PROCESS | 21333 | 12:13:00 INFO - PROCESS | 21333 | __start_tp_report 12:13:00 INFO - PROCESS | 21333 | _x_x_mozilla_page_load 12:13:00 INFO - PROCESS | 21333 | _x_x_mozilla_page_load_details 12:13:00 INFO - PROCESS | 21333 | |i|pagename|runs| 12:13:00 INFO - PROCESS | 21333 | |0;dojo.html;3103.472409690353;3145.4967205247167;3176.36472705459;3197.28061186233;3204.279037216625;5402.405735369106;5411.89176216476;5426.810061647843;5461.69960652165;5485.396606373296;5338.839834804952;5407.864803379917;5427.701476418795;5446.509814116729;5497.038018346793;4916.680415772963;4937.432195297551;5013.824516141935;5087.313212716273;5145.073886700411;856.5357481155843;4866.46468888422;4919.508049195088;4969.329140566014;4995.6003519718515;4933.555979961785;4935.80256789728;4946.604271658259;4991.176455884774;5015.348004759376;4973.452920178777;4978.303037574742;5001.8499445016705;5011.373578302712;5028.044671512437;4834.20235661119;4902.338184345103;4906.509349065101;4945.9258111128;4961.5038496150455;5357.7589008494715;5366.302380690524;5366.973165134149;5369.114096174127;5376.91934620981;5807.767689292423;5815.040518314473;5818.679972601505;5826.242588463515;5887.646741195499;5669.149627555899;5795.420457954213;5798;5860.677662728548;5877.67672777997;5498.120300751861;5523.502884740393;5523.834284971457;5525.834224973217;5528.640638358494;5788.247527821356;5990.64056156632;5991.610545314541;6006.189164462741;6017.729202185912;5681.176229446707;5695.288088988877;5720.742566584514;5776.826695199151;5799.101139323411;5847.678377689268;5866.442687944638;5872.500837428866;5882.499987501024;5897.911531327033;5576.97211513948;5711.257536520226;5787.8553036174435;5841.036229022248;5862.501687356537;5785.247917770663;5810.070388737866;5845.444682755132;5856.824295271149;5875.735591898375;4386.166398689735;4430.224710675619;4432.889177770581;4439.156560253541;4455.064436468378;3870.8645197417954;3885.902852428712;3934.5475270343704;3940.2907476653904;4005.819738111792;5392.083345831218;5421.2139239810795;5440.646357986719;5521.917171242435;5638.267025286768;5860.8534786629825;5875.41245875409;5881.088431293157;5884.852878678067;5900.291964964146;5398.64908780928;5501.14732216507;5540.9168862467095;5545.390007099216;5554.666719996813;5039.899202016012;5064.46823083571;5066.544011039025;5073.239014147834;5110.48895110486;6031.728572214261;6080.908786368208;6094.542909281821;6096.116063170904;6099.542534309944;5681.0626246668835;5718.599698021098;5741.282339707536;5805.94194058054;5950.672713000827;5885.764569417175;5891.528677705687;5958.046712525975;5960.284765828128;5962.880742385215;5695.658260504383;5755.424457554211;5763.94236057634;5785.218995435731;5795.130730390475;5823.330317013598;5872.207252020922;5878.911816322673;5881.088431293157;5890.587658864009;5549.472800083986;5663.065594176915;5711.685857277889;5721.685307308138;5731.856703582277;5748.137779333133;5755.884882302246;5765.625234359753;5791.594588378773;5819.505342045804;5597.3003374578175;5633.295838020247;5637.182608521659;5648.604597678123;5650.491455769001;5653.971730141488;5684.289463817023;5731.799387021434;5788.421157884178;5793.0731083028195;5679.801206957736;5687.971560142173;5697.800576979786;5698.572607054404;5729.942700572941 12:13:00 INFO - PROCESS | 21333 | |1;ext.html;552.2544564837469;603.2971588099864;621.4779585148476;642.9485641148706;653.7221680785665;37678.24643507128;42536.14927701444;42565.57434425655;42712.14575708488;42913;43068;43256;43306.78346608263;43338.783306083424;43420.34869476953;8723;8886;8918.464892106462;8926.509042002688;8929.73210803677;8767.78080547985;8817.647294108228;8835.514046727427;8872.423292486;8887.289016878667;8828.205461508463;8835.867461988075;8860.424072435304;8902.910970890272;8910.064443233465;8771.386002979794;8808.251298639623;8818.250448711868;8874.645014199425;8896.733098007071;8571.614277357534;8641.827163456695;8672.60973256205;8685.522296273703;8731.912680873173;41376.37935430971;41643.583564164575;41755;41899;41979.7901010493;3475.0269924421204;3498.632643572439;3530.452779819132;3627.3470775260444;4079.6736261099336;30405.23986900323;31733.682663173302;32936.183777968174;33916.49125263123;33966;4365.738055716667;4375;4462.687611867171;4529.09418116378;4547.795349209294;397449;401024;402841.9999999971;403947;405759;67853.66073169603;67966.66016669886;68541.65729171323;68796;68811;70007.29992700007;70270.64864675746;70340;70377;71259;17799.110044497724;18489.90755046243;18507;18518.722219166724;18631;13562.93218533901;13683.86316136826;13781.586552403443;13913;13925;21192.682109768364;21218.045187966578;21259.78740212609;21293.254736084164;21330.680039799416;7758.224177582197;7863.0957439894;7991;8027.357811375076;8130.146334634896;1036.8859425463193;1068.732816795801;1122.8203487442133;1144.5250221158292;1178.976420471603;33334.16664583356;33420;33677.32645347079;33751.71836710296;33845.83077084599;1108.2353176308322;1112.799696054718;1157.8263260510992;1162.4304090995352;1168.6143572621015;18089.909550452165;18129.433504878212;18183.909080454512;19448.4165475036;19466.31867884617;591534;599082;601580;602551;604773;61761.38238617646;62158;62395.376046239864;62763.372366275755;62969.685151574864;1379.2414172205247;1381.7720076187518;1422.4736847366335;1437.985620143806;1462.0642788615294;31857.681423185473;33821.32357352888;34245;34351;34900.301993960486;51728.741356294486;52553.7372313136;52649.210261845335;52668;52967;389175;393081;395145;396021;396761;28939.131826045254;29281.85359073191;29380.265493362836;29392.70607293985;29410.264743381587;49714.50285497099;50730.239046415074;50767.74616126896;51827.74086129545;51947;41057.1788564233;41520;41569.37645935374;42376.36435453409;42419.7879010603;42084.18634842938;42516.149677006906;42625.36061959135;42646.57353426426;42881;35921.64078359183;40889.795551022056;40928.1814363717;41777.582224178586;41932.16135677331;34818.82590587132;36829.63170368262;37477.43783843299;37497;37512.812435937645;28311.575326370534;28506.714932850406;28647.57028644614;28708.569371459027;28975.5653665191 12:13:00 INFO - PROCESS | 21333 | |2;jquery.html;380.4996429694951;389.079826211011;389.18271629577873;400.07526168289104;402.9234445455363;17747.112644367793;18886;19459.610807783836;19497.707534386995;19781.208751649952;18052.638947221047;18535;18844;18909.62180756384;18982.145803438845;5580.720963951807;5642.689652069145;5767.538596912258;5817.825465236028;5880.617759845596;5672.631278966854;5684.857878553028;5726.770929162829;5747.798827041054;5748.626339287954;5570.944290557083;5672.17753425753;5705.857353566153;5741.397153298906;5758.42415758425;5694.658320500783;5706.942930570683;5710;5731.684757338345;5735.971320143393;4946.258061290835;5092.363454568179;5160.535551800319;5164.612654050961;5171.456997015334;22067.66898496524;22160.55678886413;23195.652065219034;23197.188098416642;23225.651615225615;2226.1540614566525;2309.2841219222096;2320.860748355104;2336.217367181996;2375.8218133639875;13906.51327203553;14367.712645747131;14485.275736213147;14530.709385812224;14700.338484768212;1846.0769615192403;1913.9712904306446;1916.5400303927097;1974.2399176317078;1988.2544045982756;74924;77029.22970770333;77385.61307193484;77521;78929;10178.338408003456;10839.241253112206;11228;11454.599089031844;11506.137039722054;14235.43058277678;14343.426262949573;14354.282285885663;14403.495877644233;14423.206723630301;7900.209979002054;8186.590670466453;8218.465799722999;8287.917120828835;8418.158184181533;8013.439059265912;8061.4760040597175;8112.6349314281;8206.8358632827;8277.751667449986;6487.643179625166;6630.237522684953;6705.731770729214;6716.429103526255;6763.154605674291;1874.18472964261;1936.4190742777112;1936.7385402970701;1943.863929524948;1953.9609207815763;908.5548081440047;1011.3527342500805;1024.2778840917135;1104.4974536585835;1118.3960661242838;19230.903845480963;19433.222671092997;19772.4068277949;19805.504862378555;19969.101390437467;1022.928395012342;1042.4318746283293;1053.0417320238546;1068.316277582348;1076.806174888512;10739.83890241647;11384.089272858151;11418.885811141949;11494.310341379543;11522.596709115309;478293;479932;483476;486782;494876;81082.18917810865;89300.5534972321;89933.55033224792;91314.54342728377;92701.5364923171;1003.8243307421172;1013.5287091502339;1031.8606988056667;1034.4569101221919;1035.6427032673716;17511.912440437718;17537.736933945747;17846.28614855443;17995.550111247325;18346.174422151304;43075;43343.78328108339;43657.56342436535;43924.56075439205;44835.77582112069;59589;60715.69642151761;60851.391486086344;61551;61795;8336.166383361615;8649.56752162402;8661.393702440768;8685.565721713763;8748.343874209333;9672.75818104553;10890.509927053143;13056.934715326362;13290.468381264642;13413.463461461432;11516.30902145874;11653.126015548698;11825.704357391134;11864.82202766942;12128.530820760361;11611.825822612836;11625.36060516646;11672.941635291769;11674.241174323643;11698.649040528799;11887.28676279426;11923.880761192277;12064.336461494702;12123.515059397525;12137.878621214028;8645.308375329832;8721.825563488821;8734.082921293173;8848.867266991128;8965.282777377664;11747.47136378848;11769.234999724991;11936.701582460508;12018.218815776947;12215.75568488643 12:13:00 INFO - PROCESS | 21333 | |3;mootools.html;1478.5712143478388;1481.3482067890127;1656.3209084275443;1749.9912500437497;1820.1991123905473;7508.511946723459;7949.642266098025;8043.195680431962;8624.396292259536;8634.827303453927;8078.111407745143;8244.422890397675;8294.419390642657;8330.333573314136;8331.083580806106;2249.403907964391;2286.622707253301;2295.747467778543;2297.7357603875516;2300.309907027885;2320.5010922651627;2321;2370.7747763962398;2375.893084811179;2379.6549500322444;2307.273208939179;2339.9181028664;2345.319857241398;2358.705161854768;2375.441771183779;2252.5945329840624;2256.8194544436406;2260.0959616153505;2260.977390226093;2288.519410923708;2281.2243837095466;2285.245868863271;2298.230092918874;2304.158981971585;2322.431004403915;8358.958205208995;8381.916180838174;8416.83166336676;8430.873536896952;8440.87338689914;5017.297578339036;5189.896202075975;5191.610629202787;5194.013137503862;5196.376434827845;3309.23887505875;3333.333333333319;3436.570428696413;3442.896713098586;3463.1515278756865;1143.8398624192537;1151.3034614058458;1156.6298784388998;1175.6179241746468;1223.1254652923114;11454.656360309204;11477.253978491372;11537.48081336342;11549.307041577533;11589.304641721523;4572.748498832596;4612.7462989535225;4633.30500424939;4711.599514041276;4731.195696731564;9754.804903901882;9855.408675479493;9866.506674666238;9868.062534059252;9879;5070.670406423571;5131.692098474029;5141.871453213699;5146.279520867081;5226.660267082628;4181.51912530063;4633.814647414066;4743.739094349844;4767.237242041257;4787.42550893895;3914.099757055893;3921.411788231731;3999.34010888206;4028.657564107025;4129.876103716893;1302.1340808362334;1307.1307580458888;1314.5202001269467;1324.9006324525506;1325.1187960006487;889.9377043606885;958.7794807194384;979.4631903370305;982.6560703753772;985.7535616095976;5585.944140558542;5748.5688573357165;5756.597038207369;5856.619319744203;5906.26171728534;461.0962513473562;475.08071880910546;479.23561918739557;480.49787971569793;482.9710217386968;3764.661180493714;3833.8274777635074;3839.404892241707;3898.8050597470015;3901.96098039016;10174.745631359276;10407.68776936693;10469.476526173661;10516.15870730355;10576.41829699374;10322.019408156213;10329.276950613536;10342.844857327145;10411.635592754217;10428.895711042793;7661.961690191513;7780.183080776437;7814.726484573012;7825.060992680801;7906.486078405001;5553.861458400937;5621.775128994795;5635.182898479779;5834.533237340917;5845.386234445322;9342.579583918876;9595.28035397362;9595.47224902637;9620.13418792312;9825.526171074396;9646.614135434504;9928.851067233853;9935;10063;10116;6763.289854565397;7494.70021199146;7573.166951635206;7762.844743105219;7791.961040194763;8152.9184708154535;8192.918070819454;8210.712625058095;8219.917800821915;8220.465669731448;7284.708611655475;7542.660580273791;7579.218883562468;7624.161342252237;7704.38364930793;7221;7449.106107267163;7488.887666685113;7535.208803075599;7688.538687678757;6799.626020568719;6858.245592984668;6882.449404047764;6884.621345826027;6888.758893438706;4889.853304400874;4892.755362231803;4927.285543596086;5049.8737531562;5059.316992206005;4916.434610019894;5000.974995125001;5015.172496538176;5015.749212539431;5122 12:13:00 INFO - PROCESS | 21333 | |4;prototype.html;331.97510186736;335.31595545088015;337.46511778830546;338.7848716065299;340.9147713071732;5597.244372009777;5663.886722265557;5696.344920334162;5708.372079071304;5799.304083509975;5599.608027438081;5607.149815409672;5616.63491873029;5648.729035966905;5658.971705141479;4170.582941705828;4234.830606775725;4366.214081465335;4390.27560452525;4402.537733537981;4389.890252743691;4393.758343291118;4407.382966384709;4416.432166580866;4418.293073108303;4375.606195442409;4387.692861499696;4407.669424793137;4423.0711550574415;4437.622802061828;4300.763458009808;4300.827966881337;4316.827326906936;4317.344832927727;4331.328644060176;3784.394496880486;3799.6511238510207;3809.085819403351;3825;3828.617138286149;5407.891842163174;5410.5401040911565;5420.620556561043;5428.782848686048;5441.727913604304;4778.402699662543;4924.1875090610365;4945.455999840015;4989.476105008995;5005.974970125126;5797.565182611321;5824.30108386992;5843.707814609295;5849.4554868632285;5866.245602814202;4164.9583504165175;4184.51878034027;4225.260579398624;4232.217039847607;4250.574942505756;5932.614380065282;5970.11945230644;6093.146959425684;6102.389761023862;6103.908441373383;4224.302990006615;4245.1934132514725;4284.764337961442;4287.263658218427;4288.24955632763;4267.231898258281;4277.930517370657;4298.893542164317;4308.569143085729;4330.696851220448;4790.664653474293;4929.433115191727;4977.900441991213;4995.575376093073;4999.350084489066;5809.302883653904;5866.941330586639;5887.35239123696;5910.586258961831;5945.583809133319;1489.1511838252093;1489.5233525271808;1505.6235941014747;1518.840521745201;1526.5344070058516;950.9476978766235;985.5417230987482;988.9406635601887;996.7557948302567;1005.949702514886;5642.830715078554;5646.520045796071;5656.745446454919;5692.686902220417;5720.512666706603;5990.64056156632;6035.517158627299;6040.456358927718;6056.545759068087;6081.3614570470345;5405.243265942771;5660.405657405913;5664.470592939965;5686.289213848269;5715.371309155989;3230.466972949484;3244.432224360775;3279.3933122372437;3280.5407242986003;3289.703926646613;6124.877502449926;6266.404691554295;6274.309825919146;6276.152719382916;6284.905726414107;6155.753769849245;6234.566049808569;6236.469900058546;6271.843203919939;6280.874382512324;5930.584859059824;6064.4541991221;6130.233720784902;6196.318404975449;6273.7176827042895;5997.460228579449;6039.396060393926;6044.7279872406725;6068.362821903636;6117.724702388314;6010.098485227251;6026.668533230714;6030.939690603213;6050.394960503914;6072.544559157993;5978.355952113204;6212.596181248205;6252.686935743544;6272.341404152498;6309.684515774285;4259.446271984622;4308.590683885026;4313;4315.525292217916;4315.870523884289;5983;6139.938600613937;6154.9384506154365;6199.659018753831;6226.159468471879;5871.178035075008;5873.177755114202;5911.615744976562;5912.970435147797;5937.732802023833;5789.913151302818;5808;5828.242328497268;5843.795467158629;5863.442972917566;5177.2492988515705;5680.346760122474;5702.258706368146;5764.538836893123;5785.797497087582;5866.94133058681;5873.794417195378;5894.263217097863;5916.674582897982;5954.315253745702;5586.553075753849;5786.450287222707;5809.559984806307;5823.621464604787;5847.94152058474 12:13:00 INFO - PROCESS | 21333 | |5;yui.html;791.1929831571797;814.5845618734447;846.5851732651003;851.2041241439258;884.6638277454566;14080.859191408108;14116.435342586297;14371.568852934415;14412.207328596924;14456.710865782678;13461.057725959186;13749.518766843137;14021.509247176351;14027.08823926444;14051.859481405183;680.425040840489;807.8020884883211;812.7399232245684;820.5281962871343;831.1771346367113;817.5094943034192;817.513579420244;819.2462934100641;819.8852160697477;822.1490757066438;858.1761508951383;863.6718047142077;864.191980498233;864.5979619476942;865.1780808232173;850.685246458808;851.7061613743249;855.5465603230298;856.2293935458107;857.6312185760121;622.8007037747923;623.0467384901109;626.357983067355;627.5168120547198;628.1300398947445;14047.719045619031;14173.929130354281;14184.43262269508;14194.432222711079;14223.573292801233;14176.716465670628;14325.713485730332;14329.35517901697;14389.280535973265;14640.487582934546;11126.721831954266;11231.13795036946;11369.943150284196;11522.144324127132;11774.470148843322;4453.487848897385;4498.572635599613;4499.887502812423;4540.114677637862;4540.18276710192;58962.705186474224;59337;59352.703236483976;59517.70241148766;59526.70236648832;10648.414337211372;10698.304610200312;10811;10923.836142457869;11142.442877856074;18649.533761655795;18669.346572869883;18838.90580547116;18947.62104757897;19023.429297121107;8481.872771908425;8583.18459746323;8654.394192406471;8670.913290867136;8820.691275805317;4430.579094985971;4495.1234509271035;4628.884277893012;4683.320918466871;4709.693869898514;3225.6774322568026;3303;3315.2043509558016;3317.983410082934;3318.2699806042633;614.3426533608996;615.2739767074805;627.3632263252711;630.095812509051;630.3696303696304;640.2956747577628;754.9584772837437;772.4554189296532;778.7897267737679;785.5326080981806;9571.61713531465;9788.412695238309;9871.851922221173;9992.900070999198;10140.797184056277;728.7595093619093;729.3108012927732;736.8820988641899;737.3216640690578;746.4923851780841;4578.198815207325;4910.244966775818;4913.091078150554;4937.086638971802;4957.975210123998;69376.30623693799;70433.6478317605;71320.28679713137;71576.284237158;71598.64200678964;62984.68507657524;63632.36367636264;63863.68068159629;63923.360766392674;64521.67739161368;56293.155602666;56758.71620641871;57456.138157927664;57750;59128.11307830386;9557;9586.424814511152;9601.519924003911;9609.951950240204;9619.326647134912;36995.815020924725;37415;37843.243135137694;37857.62142378541;38282.42576361301;46039.309410358204;50965;51179.48820511896;51311.895048396786;51487.48512514827;11704.648860534198;11867.347295898808;12005;12037.699057523632;12547.811782823082;12643.93678031604;13000.414981325674;13184.736305274033;13349.599512014654;13656.317184140951;12173.391330433265;12373.566925157576;12586.87413125857;12614.684632884251;12788.488460461478;11495.195336326376;11710.882891170979;11721.355325457182;11729.941350293195;12128.393580321124;12126;12402.75194496087;12661.366931653196;12664;12997.870021299666;10373.170146388422;10688.786224275627;10882.673519794418;11123.555057797597;11399.772004560029;10815.24293299493;11426.714332141762;11510.42447877586;11675.474603643026;11750.94124529372 12:13:00 INFO - PROCESS | 21333 | __end_tp_report 12:13:00 INFO - PROCESS | 21333 | __start_cc_report 12:13:00 INFO - PROCESS | 21333 | _x_x_mozilla_cycle_collect,343 12:13:00 INFO - PROCESS | 21333 | __end_cc_report 12:13:00 INFO - PROCESS | 21333 | __startTimestamp1464894780732__endTimestamp 12:13:00 INFO - PROCESS | 21333 | 12:13:00 INFO - PROCESS | 21333 | ------- Summary: start ------- 12:13:00 INFO - PROCESS | 21333 | Number of tests: 6 12:13:00 INFO - PROCESS | 21333 | 12:13:00 INFO - PROCESS | 21333 | [#0] dojo.html Cycles:165 Average:5392.44 Median:5663.07 stddev:711.72 (12.6%) stddev-sans-first:690.88 12:13:00 INFO - PROCESS | 21333 | Values: 3103.5 3145.5 3176.4 3197.3 3204.3 5402.4 5411.9 5426.8 5461.7 5485.4 5338.8 5407.9 5427.7 5446.5 5497.0 4916.7 4937.4 5013.8 5087.3 5145.1 856.5 4866.5 4919.5 4969.3 4995.6 4933.6 4935.8 4946.6 4991.2 5015.3 4973.5 4978.3 5001.8 5011.4 5028.0 4834.2 4902.3 4906.5 4945.9 4961.5 5357.8 5366.3 5367.0 5369.1 5376.9 5807.8 5815.0 5818.7 5826.2 5887.6 5669.1 5795.4 5798.0 5860.7 5877.7 5498.1 5523.5 5523.8 5525.8 5528.6 5788.2 5990.6 5991.6 6006.2 6017.7 5681.2 5695.3 5720.7 5776.8 5799.1 5847.7 5866.4 5872.5 5882.5 5897.9 5577.0 5711.3 5787.9 5841.0 5862.5 5785.2 5810.1 5845.4 5856.8 5875.7 4386.2 4430.2 4432.9 4439.2 4455.1 3870.9 3885.9 3934.5 3940.3 4005.8 5392.1 5421.2 5440.6 5521.9 5638.3 5860.9 5875.4 5881.1 5884.9 5900.3 5398.6 5501.1 5540.9 5545.4 5554.7 5039.9 5064.5 5066.5 5073.2 5110.5 6031.7 6080.9 6094.5 6096.1 6099.5 5681.1 5718.6 5741.3 5805.9 5950.7 5885.8 5891.5 5958.0 5960.3 5962.9 5695.7 5755.4 5763.9 5785.2 5795.1 5823.3 5872.2 5878.9 5881.1 5890.6 5549.5 5663.1 5711.7 5721.7 5731.9 5748.1 5755.9 5765.6 5791.6 5819.5 5597.3 5633.3 5637.2 5648.6 5650.5 5654.0 5684.3 5731.8 5788.4 5793.1 5679.8 5688.0 5697.8 5698.6 5729.9 12:13:00 INFO - PROCESS | 21333 | 12:13:00 INFO - PROCESS | 21333 | [#1] ext.html Cycles:180 Average:63430.41 Median:41838.29 stddev:126152.85 (301.5%) stddev-sans-first:126418.40 12:13:00 INFO - PROCESS | 21333 | Values: 552.3 603.3 621.5 642.9 653.7 37678.2 42536.1 42565.6 42712.1 42913.0 43068.0 43256.0 43306.8 43338.8 43420.3 8723.0 8886.0 8918.5 8926.5 8929.7 8767.8 8817.6 8835.5 8872.4 8887.3 8828.2 8835.9 8860.4 8902.9 8910.1 8771.4 8808.3 8818.3 8874.6 8896.7 8571.6 8641.8 8672.6 8685.5 8731.9 41376.4 41643.6 41755.0 41899.0 41979.8 3475.0 3498.6 3530.5 3627.3 4079.7 30405.2 31733.7 32936.2 33916.5 33966.0 4365.7 4375.0 4462.7 4529.1 4547.8 397449.0 401024.0 402842.0 403947.0 405759.0 67853.7 67966.7 68541.7 68796.0 68811.0 70007.3 70270.6 70340.0 70377.0 71259.0 17799.1 18489.9 18507.0 18518.7 18631.0 13562.9 13683.9 13781.6 13913.0 13925.0 21192.7 21218.0 21259.8 21293.3 21330.7 7758.2 7863.1 7991.0 8027.4 8130.1 1036.9 1068.7 1122.8 1144.5 1179.0 33334.2 33420.0 33677.3 33751.7 33845.8 1108.2 1112.8 1157.8 1162.4 1168.6 18089.9 18129.4 18183.9 19448.4 19466.3 591534.0 599082.0 601580.0 602551.0 604773.0 61761.4 62158.0 62395.4 62763.4 62969.7 1379.2 1381.8 1422.5 1438.0 1462.1 31857.7 33821.3 34245.0 34351.0 34900.3 51728.7 52553.7 52649.2 52668.0 52967.0 389175.0 393081.0 395145.0 396021.0 396761.0 28939.1 29281.9 29380.3 29392.7 29410.3 49714.5 50730.2 50767.7 51827.7 51947.0 41057.2 41520.0 41569.4 42376.4 42419.8 42084.2 42516.1 42625.4 42646.6 42881.0 35921.6 40889.8 40928.2 41777.6 41932.2 34818.8 36829.6 37477.4 37497.0 37512.8 28311.6 28506.7 28647.6 28708.6 28975.6 12:13:00 INFO - PROCESS | 21333 | 12:13:00 INFO - PROCESS | 21333 | [#2] jquery.html Cycles:180 Average:28944.04 Median:2267.72 stddev:79819.68 (3519.8%) stddev-sans-first:80014.78 12:13:00 INFO - PROCESS | 21333 | Values: 380.5 389.1 389.2 400.1 402.9 17747.1 18886.0 19459.6 19497.7 19781.2 18052.6 18535.0 18844.0 18909.6 18982.1 5580.7 5642.7 5767.5 5817.8 5880.6 5672.6 5684.9 5726.8 5747.8 5748.6 5570.9 5672.2 5705.9 5741.4 5758.4 5694.7 5706.9 5710.0 5731.7 5736.0 4946.3 5092.4 5160.5 5164.6 5171.5 22067.7 22160.6 23195.7 23197.2 23225.7 2226.2 2309.3 2320.9 2336.2 2375.8 13906.5 14367.7 14485.3 14530.7 14700.3 1846.1 1914.0 1916.5 1974.2 1988.3 74924.0 77029.2 77385.6 77521.0 78929.0 10178.3 10839.2 11228.0 11454.6 11506.1 14235.4 14343.4 14354.3 14403.5 14423.2 7900.2 8186.6 8218.5 8287.9 8418.2 8013.4 8061.5 8112.6 8206.8 8277.8 6487.6 6630.2 6705.7 6716.4 6763.2 1874.2 1936.4 1936.7 1943.9 1954.0 908.6 1011.4 1024.3 1104.5 1118.4 19230.9 19433.2 19772.4 19805.5 19969.1 1022.9 1042.4 1053.0 1068.3 1076.8 10739.8 11384.1 11418.9 11494.3 11522.6 478293.0 479932.0 483476.0 486782.0 494876.0 81082.2 89300.6 89933.6 91314.5 92701.5 1003.8 1013.5 1031.9 1034.5 1035.6 17511.9 17537.7 17846.3 17995.6 18346.2 43075.0 43343.8 43657.6 43924.6 44835.8 59589.0 60715.7 60851.4 61551.0 61795.0 8336.2 8649.6 8661.4 8685.6 8748.3 9672.8 10890.5 13056.9 13290.5 13413.5 11516.3 11653.1 11825.7 11864.8 12128.5 11611.8 11625.4 11672.9 11674.2 11698.6 11887.3 11923.9 12064.3 12123.5 12137.9 8645.3 8721.8 8734.1 8848.9 8965.3 11747.5 11769.2 11936.7 12018.2 12215.8 12:13:00 INFO - PROCESS | 21333 | 12:13:00 INFO - PROCESS | 21333 | [#3] mootools.html Cycles:180 Average:5590.03 Median:4964.13 stddev:3122.81 (62.9%) stddev-sans-first:3116.29 12:13:00 INFO - PROCESS | 21333 | Values: 1478.6 1481.3 1656.3 1750.0 1820.2 7508.5 7949.6 8043.2 8624.4 8634.8 8078.1 8244.4 8294.4 8330.3 8331.1 2249.4 2286.6 2295.7 2297.7 2300.3 2320.5 2321.0 2370.8 2375.9 2379.7 2307.3 2339.9 2345.3 2358.7 2375.4 2252.6 2256.8 2260.1 2261.0 2288.5 2281.2 2285.2 2298.2 2304.2 2322.4 8359.0 8381.9 8416.8 8430.9 8440.9 5017.3 5189.9 5191.6 5194.0 5196.4 3309.2 3333.3 3436.6 3442.9 3463.2 1143.8 1151.3 1156.6 1175.6 1223.1 11454.7 11477.3 11537.5 11549.3 11589.3 4572.7 4612.7 4633.3 4711.6 4731.2 9754.8 9855.4 9866.5 9868.1 9879.0 5070.7 5131.7 5141.9 5146.3 5226.7 4181.5 4633.8 4743.7 4767.2 4787.4 3914.1 3921.4 3999.3 4028.7 4129.9 1302.1 1307.1 1314.5 1324.9 1325.1 889.9 958.8 979.5 982.7 985.8 5585.9 5748.6 5756.6 5856.6 5906.3 461.1 475.1 479.2 480.5 483.0 3764.7 3833.8 3839.4 3898.8 3902.0 10174.7 10407.7 10469.5 10516.2 10576.4 10322.0 10329.3 10342.8 10411.6 10428.9 7662.0 7780.2 7814.7 7825.1 7906.5 5553.9 5621.8 5635.2 5834.5 5845.4 9342.6 9595.3 9595.5 9620.1 9825.5 9646.6 9928.9 9935.0 10063.0 10116.0 6763.3 7494.7 7573.2 7762.8 7792.0 8152.9 8192.9 8210.7 8219.9 8220.5 7284.7 7542.7 7579.2 7624.2 7704.4 7221.0 7449.1 7488.9 7535.2 7688.5 6799.6 6858.2 6882.4 6884.6 6888.8 4889.9 4892.8 4927.3 5049.9 5059.3 4916.4 5001.0 5015.2 5015.7 5122.0 12:13:00 INFO - PROCESS | 21333 | 12:13:00 INFO - PROCESS | 21333 | [#4] prototype.html Cycles:180 Average:4949.59 Median:5672.41 stddev:1461.47 (25.8%) stddev-sans-first:1423.88 12:13:00 INFO - PROCESS | 21333 | Values: 332.0 335.3 337.5 338.8 340.9 5597.2 5663.9 5696.3 5708.4 5799.3 5599.6 5607.1 5616.6 5648.7 5659.0 4170.6 4234.8 4366.2 4390.3 4402.5 4389.9 4393.8 4407.4 4416.4 4418.3 4375.6 4387.7 4407.7 4423.1 4437.6 4300.8 4300.8 4316.8 4317.3 4331.3 3784.4 3799.7 3809.1 3825.0 3828.6 5407.9 5410.5 5420.6 5428.8 5441.7 4778.4 4924.2 4945.5 4989.5 5006.0 5797.6 5824.3 5843.7 5849.5 5866.2 4165.0 4184.5 4225.3 4232.2 4250.6 5932.6 5970.1 6093.1 6102.4 6103.9 4224.3 4245.2 4284.8 4287.3 4288.2 4267.2 4277.9 4298.9 4308.6 4330.7 4790.7 4929.4 4977.9 4995.6 4999.4 5809.3 5866.9 5887.4 5910.6 5945.6 1489.2 1489.5 1505.6 1518.8 1526.5 950.9 985.5 988.9 996.8 1005.9 5642.8 5646.5 5656.7 5692.7 5720.5 5990.6 6035.5 6040.5 6056.5 6081.4 5405.2 5660.4 5664.5 5686.3 5715.4 3230.5 3244.4 3279.4 3280.5 3289.7 6124.9 6266.4 6274.3 6276.2 6284.9 6155.8 6234.6 6236.5 6271.8 6280.9 5930.6 6064.5 6130.2 6196.3 6273.7 5997.5 6039.4 6044.7 6068.4 6117.7 6010.1 6026.7 6030.9 6050.4 6072.5 5978.4 6212.6 6252.7 6272.3 6309.7 4259.4 4308.6 4313.0 4315.5 4315.9 5983.0 6139.9 6154.9 6199.7 6226.2 5871.2 5873.2 5911.6 5913.0 5937.7 5789.9 5808.0 5828.2 5843.8 5863.4 5177.2 5680.3 5702.3 5764.5 5785.8 5866.9 5873.8 5894.3 5916.7 5954.3 5586.6 5786.5 5809.6 5823.6 5847.9 12:13:00 INFO - PROCESS | 21333 | 12:13:00 INFO - PROCESS | 21333 | [#5] yui.html Cycles:180 Average:15936.72 Median:4656.10 stddev:19411.36 (416.9%) stddev-sans-first:19432.49 12:13:00 INFO - PROCESS | 21333 | Values: 791.2 814.6 846.6 851.2 884.7 14080.9 14116.4 14371.6 14412.2 14456.7 13461.1 13749.5 14021.5 14027.1 14051.9 680.4 807.8 812.7 820.5 831.2 817.5 817.5 819.2 819.9 822.1 858.2 863.7 864.2 864.6 865.2 850.7 851.7 855.5 856.2 857.6 622.8 623.0 626.4 627.5 628.1 14047.7 14173.9 14184.4 14194.4 14223.6 14176.7 14325.7 14329.4 14389.3 14640.5 11126.7 11231.1 11369.9 11522.1 11774.5 4453.5 4498.6 4499.9 4540.1 4540.2 58962.7 59337.0 59352.7 59517.7 59526.7 10648.4 10698.3 10811.0 10923.8 11142.4 18649.5 18669.3 18838.9 18947.6 19023.4 8481.9 8583.2 8654.4 8670.9 8820.7 4430.6 4495.1 4628.9 4683.3 4709.7 3225.7 3303.0 3315.2 3318.0 3318.3 614.3 615.3 627.4 630.1 630.4 640.3 755.0 772.5 778.8 785.5 9571.6 9788.4 9871.9 9992.9 10140.8 728.8 729.3 736.9 737.3 746.5 4578.2 4910.2 4913.1 4937.1 4958.0 69376.3 70433.6 71320.3 71576.3 71598.6 62984.7 63632.4 63863.7 63923.4 64521.7 56293.2 56758.7 57456.1 57750.0 59128.1 9557.0 9586.4 9601.5 9610.0 9619.3 36995.8 37415.0 37843.2 37857.6 38282.4 46039.3 50965.0 51179.5 51311.9 51487.5 11704.6 11867.3 12005.0 12037.7 12547.8 12643.9 13000.4 13184.7 13349.6 13656.3 12173.4 12373.6 12586.9 12614.7 12788.5 11495.2 11710.9 11721.4 11729.9 12128.4 12126.0 12402.8 12661.4 12664.0 12997.9 10373.2 10688.8 10882.7 11123.6 11399.8 10815.2 11426.7 11510.4 11675.5 11750.9 12:13:00 INFO - PROCESS | 21333 | -------- Summary: end -------- 12:13:00 INFO - PROCESS | 21333 | 12:13:01 INFO - TEST-INFO | 21333: exit 0 12:13:01 INFO - TEST-OK | dromaeo_css | took 1110915ms 12:13:01 INFO - TEST-START | kraken 12:13:01 INFO - operating with platform_type : linux_ 12:13:01 INFO - Initialising browser for kraken test... 12:13:01 INFO - TEST-INFO | started process 21564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Fj_Wd/profile http://localhost:42005/getInfo.html) 12:13:06 INFO - PROCESS | 21564 | __metrics Screen width/height:1600/1200 12:13:06 INFO - PROCESS | 21564 | colorDepth:24 12:13:06 INFO - PROCESS | 21564 | Browser inner width/height: 1024/697 12:13:06 INFO - PROCESS | 21564 | __metrics 12:13:06 ERROR - PROCESS | 21564 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 12:13:07 INFO - TEST-INFO | 21564: exit 0 12:13:07 INFO - Browser initialized. 12:13:07 INFO - Running cycle 1/1 for kraken test... 12:13:07 INFO - TEST-INFO | started process 21685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Fj_Wd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:13:19 INFO - PROCESS | 21685 | RSS: Main: 166998016 12:13:19 INFO - PROCESS | 21685 | 12:13:22 INFO - PROCESS | 21685 | Cycle 1(1): loaded http://localhost:42005/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42005/tests/kraken/driver.html?testName=audio-beat-detection) 12:13:22 INFO - PROCESS | 21685 | RSS: Main: 172498944 12:13:22 INFO - PROCESS | 21685 | 12:13:25 INFO - PROCESS | 21685 | Cycle 1(1): loaded http://localhost:42005/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42005/tests/kraken/driver.html?testName=audio-dft) 12:13:26 INFO - PROCESS | 21685 | RSS: Main: 171421696 12:13:26 INFO - PROCESS | 21685 | 12:13:29 INFO - PROCESS | 21685 | Cycle 1(1): loaded http://localhost:42005/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42005/tests/kraken/driver.html?testName=audio-fft) 12:13:29 INFO - PROCESS | 21685 | RSS: Main: 166682624 12:13:29 INFO - PROCESS | 21685 | 12:13:31 INFO - PROCESS | 21685 | Cycle 1(1): loaded http://localhost:42005/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42005/tests/kraken/driver.html?testName=audio-oscillator) 12:13:32 INFO - PROCESS | 21685 | RSS: Main: 167587840 12:13:32 INFO - PROCESS | 21685 | 12:13:34 INFO - PROCESS | 21685 | Cycle 1(1): loaded http://localhost:42005/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42005/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:13:35 INFO - PROCESS | 21685 | RSS: Main: 167825408 12:13:35 INFO - PROCESS | 21685 | 12:13:38 INFO - PROCESS | 21685 | Cycle 1(1): loaded http://localhost:42005/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42005/tests/kraken/driver.html?testName=imaging-darkroom) 12:13:39 INFO - PROCESS | 21685 | RSS: Main: 167489536 12:13:39 INFO - PROCESS | 21685 | 12:13:42 INFO - PROCESS | 21685 | Cycle 1(1): loaded http://localhost:42005/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42005/tests/kraken/driver.html?testName=imaging-desaturate) 12:13:43 INFO - PROCESS | 21685 | RSS: Main: 165842944 12:13:43 INFO - PROCESS | 21685 | 12:13:45 INFO - PROCESS | 21685 | Cycle 1(1): loaded http://localhost:42005/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42005/tests/kraken/driver.html?testName=json-parse-financial) 12:13:46 INFO - PROCESS | 21685 | RSS: Main: 167022592 12:13:46 INFO - PROCESS | 21685 | 12:13:48 INFO - PROCESS | 21685 | Cycle 1(1): loaded http://localhost:42005/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42005/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:13:48 INFO - PROCESS | 21685 | RSS: Main: 167350272 12:13:48 INFO - PROCESS | 21685 | 12:13:50 INFO - PROCESS | 21685 | Cycle 1(1): loaded http://localhost:42005/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42005/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:13:51 INFO - PROCESS | 21685 | RSS: Main: 167907328 12:13:51 INFO - PROCESS | 21685 | 12:13:53 INFO - PROCESS | 21685 | Cycle 1(1): loaded http://localhost:42005/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42005/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:13:53 INFO - PROCESS | 21685 | RSS: Main: 167989248 12:13:53 INFO - PROCESS | 21685 | 12:13:56 INFO - PROCESS | 21685 | Cycle 1(1): loaded http://localhost:42005/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:13:57 INFO - PROCESS | 21685 | RSS: Main: 168185856 12:13:57 INFO - PROCESS | 21685 | 12:13:59 INFO - PROCESS | 21685 | Cycle 1(1): loaded http://localhost:42005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:14:00 INFO - PROCESS | 21685 | RSS: Main: 168038400 12:14:00 INFO - PROCESS | 21685 | 12:14:02 INFO - PROCESS | 21685 | Cycle 1(1): loaded http://localhost:42005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42005/tests/kraken/driver.html?testName=ai-astar) 12:14:02 INFO - PROCESS | 21685 | RSS: Main: 168722432 12:14:02 INFO - PROCESS | 21685 | 12:14:02 INFO - PROCESS | 21685 | __start_tp_report 12:14:02 INFO - PROCESS | 21685 | _x_x_mozilla_page_load 12:14:02 INFO - PROCESS | 21685 | _x_x_mozilla_page_load_details 12:14:02 INFO - PROCESS | 21685 | |i|pagename|runs| 12:14:02 INFO - PROCESS | 21685 | |0;ai-astar;113;105;112;111;113;112;111;111;111;111 12:14:02 INFO - PROCESS | 21685 | |1;audio-beat-detection;163;137;153;191;127;159;148;128;181;127 12:14:02 INFO - PROCESS | 21685 | |2;audio-dft;161;162;161;163;162;172;168;162;163;161 12:14:02 INFO - PROCESS | 21685 | |3;audio-fft;75;74;75;154;75;76;76;75;166;75 12:14:02 INFO - PROCESS | 21685 | |4;audio-oscillator;83;83;144;83;82;83;135;83;81;157 12:14:02 INFO - PROCESS | 21685 | |5;imaging-gaussian-blur;117;118;118;118;118;118;117;117;118;118 12:14:02 INFO - PROCESS | 21685 | |6;imaging-darkroom;146;148;146;148;148;147;147;147;147;147 12:14:02 INFO - PROCESS | 21685 | |7;imaging-desaturate;96;97;96;96;96;95;96;96;96;95 12:14:02 INFO - PROCESS | 21685 | |8;json-parse-financial;57;54;58;54;57;59;56;55;55;57 12:14:02 INFO - PROCESS | 21685 | |9;json-stringify-tinderbox;61;61;61;62;62;61;61;62;62;61 12:14:02 INFO - PROCESS | 21685 | |10;stanford-crypto-aes;79;81;79;79;82;80;87;83;117;80 12:14:02 INFO - PROCESS | 21685 | |11;stanford-crypto-ccm;140;122;128;128;119;122;126;128;144;123 12:14:02 INFO - PROCESS | 21685 | |12;stanford-crypto-pbkdf2;163;161;161;165;163;160;167;161;162;162 12:14:02 INFO - PROCESS | 21685 | |13;stanford-crypto-sha256-iterative;65;63;67;63;62;64;65;63;63;64 12:14:02 INFO - PROCESS | 21685 | __end_tp_report 12:14:02 INFO - PROCESS | 21685 | __start_cc_report 12:14:02 INFO - PROCESS | 21685 | _x_x_mozilla_cycle_collect,863 12:14:02 INFO - PROCESS | 21685 | __end_cc_report 12:14:02 INFO - PROCESS | 21685 | __startTimestamp1464894842417__endTimestamp 12:14:02 INFO - PROCESS | 21685 | 12:14:02 INFO - PROCESS | 21685 | ------- Summary: start ------- 12:14:02 INFO - PROCESS | 21685 | Number of tests: 14 12:14:02 INFO - PROCESS | 21685 | 12:14:02 INFO - PROCESS | 21685 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.50 stddev:2.26 (2.0%) stddev-sans-first:2.28 12:14:02 INFO - PROCESS | 21685 | Values: 113.0 105.0 112.0 111.0 113.0 112.0 111.0 111.0 111.0 111.0 12:14:02 INFO - PROCESS | 21685 | 12:14:02 INFO - PROCESS | 21685 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:156.00 stddev:22.60 (14.5%) stddev-sans-first:23.58 12:14:02 INFO - PROCESS | 21685 | Values: 163.0 137.0 153.0 191.0 127.0 159.0 148.0 128.0 181.0 127.0 12:14:02 INFO - PROCESS | 21685 | 12:14:02 INFO - PROCESS | 21685 | [#2] audio-dft Cycles:10 Average:163.50 Median:162.50 stddev:3.63 (2.2%) stddev-sans-first:3.73 12:14:02 INFO - PROCESS | 21685 | Values: 161.0 162.0 161.0 163.0 162.0 172.0 168.0 162.0 163.0 161.0 12:14:02 INFO - PROCESS | 21685 | 12:14:02 INFO - PROCESS | 21685 | [#3] audio-fft Cycles:10 Average:92.10 Median:75.00 stddev:35.90 (47.9%) stddev-sans-first:37.54 12:14:02 INFO - PROCESS | 21685 | Values: 75.0 74.0 75.0 154.0 75.0 76.0 76.0 75.0 166.0 75.0 12:14:02 INFO - PROCESS | 21685 | 12:14:02 INFO - PROCESS | 21685 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:83.00 stddev:30.77 (37.1%) stddev-sans-first:31.91 12:14:02 INFO - PROCESS | 21685 | Values: 83.0 83.0 144.0 83.0 82.0 83.0 135.0 83.0 81.0 157.0 12:14:02 INFO - PROCESS | 21685 | 12:14:02 INFO - PROCESS | 21685 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 12:14:02 INFO - PROCESS | 21685 | Values: 117.0 118.0 118.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 12:14:02 INFO - PROCESS | 21685 | 12:14:02 INFO - PROCESS | 21685 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 12:14:02 INFO - PROCESS | 21685 | Values: 146.0 148.0 146.0 148.0 148.0 147.0 147.0 147.0 147.0 147.0 12:14:02 INFO - PROCESS | 21685 | 12:14:02 INFO - PROCESS | 21685 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 12:14:02 INFO - PROCESS | 21685 | Values: 96.0 97.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 12:14:02 INFO - PROCESS | 21685 | 12:14:02 INFO - PROCESS | 21685 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.00 stddev:1.69 (3.0%) stddev-sans-first:1.76 12:14:02 INFO - PROCESS | 21685 | Values: 57.0 54.0 58.0 54.0 57.0 59.0 56.0 55.0 55.0 57.0 12:14:02 INFO - PROCESS | 21685 | 12:14:02 INFO - PROCESS | 21685 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 12:14:02 INFO - PROCESS | 21685 | Values: 61.0 61.0 61.0 62.0 62.0 61.0 61.0 62.0 62.0 61.0 12:14:02 INFO - PROCESS | 21685 | 12:14:02 INFO - PROCESS | 21685 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:80.50 stddev:11.61 (14.4%) stddev-sans-first:12.13 12:14:02 INFO - PROCESS | 21685 | Values: 79.0 81.0 79.0 79.0 82.0 80.0 87.0 83.0 117.0 80.0 12:14:02 INFO - PROCESS | 21685 | 12:14:02 INFO - PROCESS | 21685 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:128.00 stddev:8.04 (6.3%) stddev-sans-first:7.26 12:14:02 INFO - PROCESS | 21685 | Values: 140.0 122.0 128.0 128.0 119.0 122.0 126.0 128.0 144.0 123.0 12:14:02 INFO - PROCESS | 21685 | 12:14:02 INFO - PROCESS | 21685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:162.50 stddev:2.12 (1.3%) stddev-sans-first:2.24 12:14:02 INFO - PROCESS | 21685 | Values: 163.0 161.0 161.0 165.0 163.0 160.0 167.0 161.0 162.0 162.0 12:14:02 INFO - PROCESS | 21685 | 12:14:02 INFO - PROCESS | 21685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.45 (2.3%) stddev-sans-first:1.48 12:14:02 INFO - PROCESS | 21685 | Values: 65.0 63.0 67.0 63.0 62.0 64.0 65.0 63.0 63.0 64.0 12:14:02 INFO - PROCESS | 21685 | -------- Summary: end -------- 12:14:02 INFO - PROCESS | 21685 | 12:14:03 INFO - TEST-INFO | 21685: exit 0 12:14:03 INFO - TEST-OK | kraken | took 62035ms 12:14:03 INFO - SUITE-END | took 1172s 12:14:03 INFO - Completed test suite (00:19:33) 12:14:03 INFO - javascript benchmark 12:14:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7260.191939557598, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.472409690353, 3145.4967205247167, 3176.36472705459, 3197.28061186233, 3204.279037216625, 5402.405735369106, 5411.89176216476, 5426.810061647843, 5461.69960652165, 5485.396606373296, 5338.839834804952, 5407.864803379917, 5427.701476418795, 5446.509814116729, 5497.038018346793, 4916.680415772963, 4937.432195297551, 5013.824516141935, 5087.313212716273, 5145.073886700411, 856.5357481155843, 4866.46468888422, 4919.508049195088, 4969.329140566014, 4995.6003519718515, 4933.555979961785, 4935.80256789728, 4946.604271658259, 4991.176455884774, 5015.348004759376, 4973.452920178777, 4978.303037574742, 5001.8499445016705, 5011.373578302712, 5028.044671512437, 4834.20235661119, 4902.338184345103, 4906.509349065101, 4945.9258111128, 4961.5038496150455, 5357.7589008494715, 5366.302380690524, 5366.973165134149, 5369.114096174127, 5376.91934620981, 5807.767689292423, 5815.040518314473, 5818.679972601505, 5826.242588463515, 5887.646741195499, 5669.149627555899, 5795.420457954213, 5798.0, 5860.677662728548, 5877.67672777997, 5498.120300751861, 5523.502884740393, 5523.834284971457, 5525.834224973217, 5528.640638358494, 5788.247527821356, 5990.64056156632, 5991.610545314541, 6006.189164462741, 6017.729202185912, 5681.176229446707, 5695.288088988877, 5720.742566584514, 5776.826695199151, 5799.101139323411, 5847.678377689268, 5866.442687944638, 5872.500837428866, 5882.499987501024, 5897.911531327033, 5576.97211513948, 5711.257536520226, 5787.8553036174435, 5841.036229022248, 5862.501687356537, 5785.247917770663, 5810.070388737866, 5845.444682755132, 5856.824295271149, 5875.735591898375, 4386.166398689735, 4430.224710675619, 4432.889177770581, 4439.156560253541, 4455.064436468378, 3870.8645197417954, 3885.902852428712, 3934.5475270343704, 3940.2907476653904, 4005.819738111792, 5392.083345831218, 5421.2139239810795, 5440.646357986719, 5521.917171242435, 5638.267025286768, 5860.8534786629825, 5875.41245875409, 5881.088431293157, 5884.852878678067, 5900.291964964146, 5398.64908780928, 5501.14732216507, 5540.9168862467095, 5545.390007099216, 5554.666719996813, 5039.899202016012, 5064.46823083571, 5066.544011039025, 5073.239014147834, 5110.48895110486, 6031.728572214261, 6080.908786368208, 6094.542909281821, 6096.116063170904, 6099.542534309944, 5681.0626246668835, 5718.599698021098, 5741.282339707536, 5805.94194058054, 5950.672713000827, 5885.764569417175, 5891.528677705687, 5958.046712525975, 5960.284765828128, 5962.880742385215, 5695.658260504383, 5755.424457554211, 5763.94236057634, 5785.218995435731, 5795.130730390475, 5823.330317013598, 5872.207252020922, 5878.911816322673, 5881.088431293157, 5890.587658864009, 5549.472800083986, 5663.065594176915, 5711.685857277889, 5721.685307308138, 5731.856703582277, 5748.137779333133, 5755.884882302246, 5765.625234359753, 5791.594588378773, 5819.505342045804, 5597.3003374578175, 5633.295838020247, 5637.182608521659, 5648.604597678123, 5650.491455769001, 5653.971730141488, 5684.289463817023, 5731.799387021434, 5788.421157884178, 5793.0731083028195, 5679.801206957736, 5687.971560142173, 5697.800576979786, 5698.572607054404, 5729.942700572941], "value": 5345.846131882546, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.2544564837469, 603.2971588099864, 621.4779585148476, 642.9485641148706, 653.7221680785665, 37678.24643507128, 42536.14927701444, 42565.57434425655, 42712.14575708488, 42913.0, 43068.0, 43256.0, 43306.78346608263, 43338.783306083424, 43420.34869476953, 8723.0, 8886.0, 8918.464892106462, 8926.509042002688, 8929.73210803677, 8767.78080547985, 8817.647294108228, 8835.514046727427, 8872.423292486, 8887.289016878667, 8828.205461508463, 8835.867461988075, 8860.424072435304, 8902.910970890272, 8910.064443233465, 8771.386002979794, 8808.251298639623, 8818.250448711868, 8874.645014199425, 8896.733098007071, 8571.614277357534, 8641.827163456695, 8672.60973256205, 8685.522296273703, 8731.912680873173, 41376.37935430971, 41643.583564164575, 41755.0, 41899.0, 41979.7901010493, 3475.0269924421204, 3498.632643572439, 3530.452779819132, 3627.3470775260444, 4079.6736261099336, 30405.23986900323, 31733.682663173302, 32936.183777968174, 33916.49125263123, 33966.0, 4365.738055716667, 4375.0, 4462.687611867171, 4529.09418116378, 4547.795349209294, 397449.0, 401024.0, 402841.9999999971, 403947.0, 405759.0, 67853.66073169603, 67966.66016669886, 68541.65729171323, 68796.0, 68811.0, 70007.29992700007, 70270.64864675746, 70340.0, 70377.0, 71259.0, 17799.110044497724, 18489.90755046243, 18507.0, 18518.722219166724, 18631.0, 13562.93218533901, 13683.86316136826, 13781.586552403443, 13913.0, 13925.0, 21192.682109768364, 21218.045187966578, 21259.78740212609, 21293.254736084164, 21330.680039799416, 7758.224177582197, 7863.0957439894, 7991.0, 8027.357811375076, 8130.146334634896, 1036.8859425463193, 1068.732816795801, 1122.8203487442133, 1144.5250221158292, 1178.976420471603, 33334.16664583356, 33420.0, 33677.32645347079, 33751.71836710296, 33845.83077084599, 1108.2353176308322, 1112.799696054718, 1157.8263260510992, 1162.4304090995352, 1168.6143572621015, 18089.909550452165, 18129.433504878212, 18183.909080454512, 19448.4165475036, 19466.31867884617, 591534.0, 599082.0, 601580.0, 602551.0, 604773.0, 61761.38238617646, 62158.0, 62395.376046239864, 62763.372366275755, 62969.685151574864, 1379.2414172205247, 1381.7720076187518, 1422.4736847366335, 1437.985620143806, 1462.0642788615294, 31857.681423185473, 33821.32357352888, 34245.0, 34351.0, 34900.301993960486, 51728.741356294486, 52553.7372313136, 52649.210261845335, 52668.0, 52967.0, 389175.0, 393081.0, 395145.0, 396021.0, 396761.0, 28939.131826045254, 29281.85359073191, 29380.265493362836, 29392.70607293985, 29410.264743381587, 49714.50285497099, 50730.239046415074, 50767.74616126896, 51827.74086129545, 51947.0, 41057.1788564233, 41520.0, 41569.37645935374, 42376.36435453409, 42419.7879010603, 42084.18634842938, 42516.149677006906, 42625.36061959135, 42646.57353426426, 42881.0, 35921.64078359183, 40889.795551022056, 40928.1814363717, 41777.582224178586, 41932.16135677331, 34818.82590587132, 36829.63170368262, 37477.43783843299, 37497.0, 37512.812435937645, 28311.575326370534, 28506.714932850406, 28647.57028644614, 28708.569371459027, 28975.5653665191], "value": 20944.22422413088, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.4996429694951, 389.079826211011, 389.18271629577873, 400.07526168289104, 402.9234445455363, 17747.112644367793, 18886.0, 19459.610807783836, 19497.707534386995, 19781.208751649952, 18052.638947221047, 18535.0, 18844.0, 18909.62180756384, 18982.145803438845, 5580.720963951807, 5642.689652069145, 5767.538596912258, 5817.825465236028, 5880.617759845596, 5672.631278966854, 5684.857878553028, 5726.770929162829, 5747.798827041054, 5748.626339287954, 5570.944290557083, 5672.17753425753, 5705.857353566153, 5741.397153298906, 5758.42415758425, 5694.658320500783, 5706.942930570683, 5710.0, 5731.684757338345, 5735.971320143393, 4946.258061290835, 5092.363454568179, 5160.535551800319, 5164.612654050961, 5171.456997015334, 22067.66898496524, 22160.55678886413, 23195.652065219034, 23197.188098416642, 23225.651615225615, 2226.1540614566525, 2309.2841219222096, 2320.860748355104, 2336.217367181996, 2375.8218133639875, 13906.51327203553, 14367.712645747131, 14485.275736213147, 14530.709385812224, 14700.338484768212, 1846.0769615192403, 1913.9712904306446, 1916.5400303927097, 1974.2399176317078, 1988.2544045982756, 74924.0, 77029.22970770333, 77385.61307193484, 77521.0, 78929.0, 10178.338408003456, 10839.241253112206, 11228.0, 11454.599089031844, 11506.137039722054, 14235.43058277678, 14343.426262949573, 14354.282285885663, 14403.495877644233, 14423.206723630301, 7900.209979002054, 8186.590670466453, 8218.465799722999, 8287.917120828835, 8418.158184181533, 8013.439059265912, 8061.4760040597175, 8112.6349314281, 8206.8358632827, 8277.751667449986, 6487.643179625166, 6630.237522684953, 6705.731770729214, 6716.429103526255, 6763.154605674291, 1874.18472964261, 1936.4190742777112, 1936.7385402970701, 1943.863929524948, 1953.9609207815763, 908.5548081440047, 1011.3527342500805, 1024.2778840917135, 1104.4974536585835, 1118.3960661242838, 19230.903845480963, 19433.222671092997, 19772.4068277949, 19805.504862378555, 19969.101390437467, 1022.928395012342, 1042.4318746283293, 1053.0417320238546, 1068.316277582348, 1076.806174888512, 10739.83890241647, 11384.089272858151, 11418.885811141949, 11494.310341379543, 11522.596709115309, 478293.0, 479932.0, 483476.0, 486782.0, 494876.0, 81082.18917810865, 89300.5534972321, 89933.55033224792, 91314.54342728377, 92701.5364923171, 1003.8243307421172, 1013.5287091502339, 1031.8606988056667, 1034.4569101221919, 1035.6427032673716, 17511.912440437718, 17537.736933945747, 17846.28614855443, 17995.550111247325, 18346.174422151304, 43075.0, 43343.78328108339, 43657.56342436535, 43924.56075439205, 44835.77582112069, 59589.0, 60715.69642151761, 60851.391486086344, 61551.0, 61795.0, 8336.166383361615, 8649.56752162402, 8661.393702440768, 8685.565721713763, 8748.343874209333, 9672.75818104553, 10890.509927053143, 13056.934715326362, 13290.468381264642, 13413.463461461432, 11516.30902145874, 11653.126015548698, 11825.704357391134, 11864.82202766942, 12128.530820760361, 11611.825822612836, 11625.36060516646, 11672.941635291769, 11674.241174323643, 11698.649040528799, 11887.28676279426, 11923.880761192277, 12064.336461494702, 12123.515059397525, 12137.878621214028, 8645.308375329832, 8721.825563488821, 8734.082921293173, 8848.867266991128, 8965.282777377664, 11747.47136378848, 11769.234999724991, 11936.701582460508, 12018.218815776947, 12215.75568488643], "value": 9398.599675072239, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.5712143478388, 1481.3482067890127, 1656.3209084275443, 1749.9912500437497, 1820.1991123905473, 7508.511946723459, 7949.642266098025, 8043.195680431962, 8624.396292259536, 8634.827303453927, 8078.111407745143, 8244.422890397675, 8294.419390642657, 8330.333573314136, 8331.083580806106, 2249.403907964391, 2286.622707253301, 2295.747467778543, 2297.7357603875516, 2300.309907027885, 2320.5010922651627, 2321.0, 2370.7747763962398, 2375.893084811179, 2379.6549500322444, 2307.273208939179, 2339.9181028664, 2345.319857241398, 2358.705161854768, 2375.441771183779, 2252.5945329840624, 2256.8194544436406, 2260.0959616153505, 2260.977390226093, 2288.519410923708, 2281.2243837095466, 2285.245868863271, 2298.230092918874, 2304.158981971585, 2322.431004403915, 8358.958205208995, 8381.916180838174, 8416.83166336676, 8430.873536896952, 8440.87338689914, 5017.297578339036, 5189.896202075975, 5191.610629202787, 5194.013137503862, 5196.376434827845, 3309.23887505875, 3333.333333333319, 3436.570428696413, 3442.896713098586, 3463.1515278756865, 1143.8398624192537, 1151.3034614058458, 1156.6298784388998, 1175.6179241746468, 1223.1254652923114, 11454.656360309204, 11477.253978491372, 11537.48081336342, 11549.307041577533, 11589.304641721523, 4572.748498832596, 4612.7462989535225, 4633.30500424939, 4711.599514041276, 4731.195696731564, 9754.804903901882, 9855.408675479493, 9866.506674666238, 9868.062534059252, 9879.0, 5070.670406423571, 5131.692098474029, 5141.871453213699, 5146.279520867081, 5226.660267082628, 4181.51912530063, 4633.814647414066, 4743.739094349844, 4767.237242041257, 4787.42550893895, 3914.099757055893, 3921.411788231731, 3999.34010888206, 4028.657564107025, 4129.876103716893, 1302.1340808362334, 1307.1307580458888, 1314.5202001269467, 1324.9006324525506, 1325.1187960006487, 889.9377043606885, 958.7794807194384, 979.4631903370305, 982.6560703753772, 985.7535616095976, 5585.944140558542, 5748.5688573357165, 5756.597038207369, 5856.619319744203, 5906.26171728534, 461.0962513473562, 475.08071880910546, 479.23561918739557, 480.49787971569793, 482.9710217386968, 3764.661180493714, 3833.8274777635074, 3839.404892241707, 3898.8050597470015, 3901.96098039016, 10174.745631359276, 10407.68776936693, 10469.476526173661, 10516.15870730355, 10576.41829699374, 10322.019408156213, 10329.276950613536, 10342.844857327145, 10411.635592754217, 10428.895711042793, 7661.961690191513, 7780.183080776437, 7814.726484573012, 7825.060992680801, 7906.486078405001, 5553.861458400937, 5621.775128994795, 5635.182898479779, 5834.533237340917, 5845.386234445322, 9342.579583918876, 9595.28035397362, 9595.47224902637, 9620.13418792312, 9825.526171074396, 9646.614135434504, 9928.851067233853, 9935.0, 10063.0, 10116.0, 6763.289854565397, 7494.70021199146, 7573.166951635206, 7762.844743105219, 7791.961040194763, 8152.9184708154535, 8192.918070819454, 8210.712625058095, 8219.917800821915, 8220.465669731448, 7284.708611655475, 7542.660580273791, 7579.218883562468, 7624.161342252237, 7704.38364930793, 7221.0, 7449.106107267163, 7488.887666685113, 7535.208803075599, 7688.538687678757, 6799.626020568719, 6858.245592984668, 6882.449404047764, 6884.621345826027, 6888.758893438706, 4889.853304400874, 4892.755362231803, 4927.285543596086, 5049.8737531562, 5059.316992206005, 4916.434610019894, 5000.974995125001, 5015.172496538176, 5015.749212539431, 5122.0], "value": 4453.964618068404, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.97510186736, 335.31595545088015, 337.46511778830546, 338.7848716065299, 340.9147713071732, 5597.244372009777, 5663.886722265557, 5696.344920334162, 5708.372079071304, 5799.304083509975, 5599.608027438081, 5607.149815409672, 5616.63491873029, 5648.729035966905, 5658.971705141479, 4170.582941705828, 4234.830606775725, 4366.214081465335, 4390.27560452525, 4402.537733537981, 4389.890252743691, 4393.758343291118, 4407.382966384709, 4416.432166580866, 4418.293073108303, 4375.606195442409, 4387.692861499696, 4407.669424793137, 4423.0711550574415, 4437.622802061828, 4300.763458009808, 4300.827966881337, 4316.827326906936, 4317.344832927727, 4331.328644060176, 3784.394496880486, 3799.6511238510207, 3809.085819403351, 3825.0, 3828.617138286149, 5407.891842163174, 5410.5401040911565, 5420.620556561043, 5428.782848686048, 5441.727913604304, 4778.402699662543, 4924.1875090610365, 4945.455999840015, 4989.476105008995, 5005.974970125126, 5797.565182611321, 5824.30108386992, 5843.707814609295, 5849.4554868632285, 5866.245602814202, 4164.9583504165175, 4184.51878034027, 4225.260579398624, 4232.217039847607, 4250.574942505756, 5932.614380065282, 5970.11945230644, 6093.146959425684, 6102.389761023862, 6103.908441373383, 4224.302990006615, 4245.1934132514725, 4284.764337961442, 4287.263658218427, 4288.24955632763, 4267.231898258281, 4277.930517370657, 4298.893542164317, 4308.569143085729, 4330.696851220448, 4790.664653474293, 4929.433115191727, 4977.900441991213, 4995.575376093073, 4999.350084489066, 5809.302883653904, 5866.941330586639, 5887.35239123696, 5910.586258961831, 5945.583809133319, 1489.1511838252093, 1489.5233525271808, 1505.6235941014747, 1518.840521745201, 1526.5344070058516, 950.9476978766235, 985.5417230987482, 988.9406635601887, 996.7557948302567, 1005.949702514886, 5642.830715078554, 5646.520045796071, 5656.745446454919, 5692.686902220417, 5720.512666706603, 5990.64056156632, 6035.517158627299, 6040.456358927718, 6056.545759068087, 6081.3614570470345, 5405.243265942771, 5660.405657405913, 5664.470592939965, 5686.289213848269, 5715.371309155989, 3230.466972949484, 3244.432224360775, 3279.3933122372437, 3280.5407242986003, 3289.703926646613, 6124.877502449926, 6266.404691554295, 6274.309825919146, 6276.152719382916, 6284.905726414107, 6155.753769849245, 6234.566049808569, 6236.469900058546, 6271.843203919939, 6280.874382512324, 5930.584859059824, 6064.4541991221, 6130.233720784902, 6196.318404975449, 6273.7176827042895, 5997.460228579449, 6039.396060393926, 6044.7279872406725, 6068.362821903636, 6117.724702388314, 6010.098485227251, 6026.668533230714, 6030.939690603213, 6050.394960503914, 6072.544559157993, 5978.355952113204, 6212.596181248205, 6252.686935743544, 6272.341404152498, 6309.684515774285, 4259.446271984622, 4308.590683885026, 4313.0, 4315.525292217916, 4315.870523884289, 5983.0, 6139.938600613937, 6154.9384506154365, 6199.659018753831, 6226.159468471879, 5871.178035075008, 5873.177755114202, 5911.615744976562, 5912.970435147797, 5937.732802023833, 5789.913151302818, 5808.0, 5828.242328497268, 5843.795467158629, 5863.442972917566, 5177.2492988515705, 5680.346760122474, 5702.258706368146, 5764.538836893123, 5785.797497087582, 5866.94133058681, 5873.794417195378, 5894.263217097863, 5916.674582897982, 5954.315253745702, 5586.553075753849, 5786.450287222707, 5809.559984806307, 5823.621464604787, 5847.94152058474], "value": 4478.680831206476, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.1929831571797, 814.5845618734447, 846.5851732651003, 851.2041241439258, 884.6638277454566, 14080.859191408108, 14116.435342586297, 14371.568852934415, 14412.207328596924, 14456.710865782678, 13461.057725959186, 13749.518766843137, 14021.509247176351, 14027.08823926444, 14051.859481405183, 680.425040840489, 807.8020884883211, 812.7399232245684, 820.5281962871343, 831.1771346367113, 817.5094943034192, 817.513579420244, 819.2462934100641, 819.8852160697477, 822.1490757066438, 858.1761508951383, 863.6718047142077, 864.191980498233, 864.5979619476942, 865.1780808232173, 850.685246458808, 851.7061613743249, 855.5465603230298, 856.2293935458107, 857.6312185760121, 622.8007037747923, 623.0467384901109, 626.357983067355, 627.5168120547198, 628.1300398947445, 14047.719045619031, 14173.929130354281, 14184.43262269508, 14194.432222711079, 14223.573292801233, 14176.716465670628, 14325.713485730332, 14329.35517901697, 14389.280535973265, 14640.487582934546, 11126.721831954266, 11231.13795036946, 11369.943150284196, 11522.144324127132, 11774.470148843322, 4453.487848897385, 4498.572635599613, 4499.887502812423, 4540.114677637862, 4540.18276710192, 58962.705186474224, 59337.0, 59352.703236483976, 59517.70241148766, 59526.70236648832, 10648.414337211372, 10698.304610200312, 10811.0, 10923.836142457869, 11142.442877856074, 18649.533761655795, 18669.346572869883, 18838.90580547116, 18947.62104757897, 19023.429297121107, 8481.872771908425, 8583.18459746323, 8654.394192406471, 8670.913290867136, 8820.691275805317, 4430.579094985971, 4495.1234509271035, 4628.884277893012, 4683.320918466871, 4709.693869898514, 3225.6774322568026, 3303.0, 3315.2043509558016, 3317.983410082934, 3318.2699806042633, 614.3426533608996, 615.2739767074805, 627.3632263252711, 630.095812509051, 630.3696303696304, 640.2956747577628, 754.9584772837437, 772.4554189296532, 778.7897267737679, 785.5326080981806, 9571.61713531465, 9788.412695238309, 9871.851922221173, 9992.900070999198, 10140.797184056277, 728.7595093619093, 729.3108012927732, 736.8820988641899, 737.3216640690578, 746.4923851780841, 4578.198815207325, 4910.244966775818, 4913.091078150554, 4937.086638971802, 4957.975210123998, 69376.30623693799, 70433.6478317605, 71320.28679713137, 71576.284237158, 71598.64200678964, 62984.68507657524, 63632.36367636264, 63863.68068159629, 63923.360766392674, 64521.67739161368, 56293.155602666, 56758.71620641871, 57456.138157927664, 57750.0, 59128.11307830386, 9557.0, 9586.424814511152, 9601.519924003911, 9609.951950240204, 9619.326647134912, 36995.815020924725, 37415.0, 37843.243135137694, 37857.62142378541, 38282.42576361301, 46039.309410358204, 50965.0, 51179.48820511896, 51311.895048396786, 51487.48512514827, 11704.648860534198, 11867.347295898808, 12005.0, 12037.699057523632, 12547.811782823082, 12643.93678031604, 13000.414981325674, 13184.736305274033, 13349.599512014654, 13656.317184140951, 12173.391330433265, 12373.566925157576, 12586.87413125857, 12614.684632884251, 12788.488460461478, 11495.195336326376, 11710.882891170979, 11721.355325457182, 11729.941350293195, 12128.393580321124, 12126.0, 12402.75194496087, 12661.366931653196, 12664.0, 12997.870021299666, 10373.170146388422, 10688.786224275627, 10882.673519794418, 11123.555057797597, 11399.772004560029, 10815.24293299493, 11426.714332141762, 11510.42447877586, 11675.474603643026, 11750.94124529372], "value": 6975.9259199900625, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 112.0, 111.0, 113.0, 112.0, 111.0, 111.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 137.0, 153.0, 191.0, 127.0, 159.0, 148.0, 128.0, 181.0, 127.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 163.0, 162.0, 172.0, 168.0, 162.0, 163.0, 161.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 154.0, 75.0, 76.0, 76.0, 75.0, 166.0, 75.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 144.0, 83.0, 82.0, 83.0, 135.0, 83.0, 81.0, 157.0], "value": 101.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 58.0, 54.0, 57.0, 59.0, 56.0, 55.0, 55.0, 57.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 61.0, 62.0, 62.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 79.0, 79.0, 82.0, 80.0, 87.0, 83.0, 117.0, 80.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 122.0, 128.0, 128.0, 119.0, 122.0, 126.0, 128.0, 144.0, 123.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 165.0, 163.0, 160.0, 167.0, 161.0, 162.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 67.0, 63.0, 62.0, 64.0, 65.0, 63.0, 63.0, 64.0], "value": 63.9, "unit": "score"}]}]} 12:14:03 INFO - Return code: 0 12:14:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:14:03 ERROR - # TBPL SUCCESS # 12:14:03 INFO - Running post-action listener: _resource_record_post_action 12:14:03 INFO - ##### 12:14:03 INFO - ##### Finished run-tests step (success) 12:14:03 INFO - ##### 12:14:03 INFO - Running post-run listener: _resource_record_post_run 12:14:03 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539242496; Read time: 16; Write time: 519960 12:14:03 INFO - TinderboxPrint: CPU usage
13.5% 12:14:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 12:14:03 INFO - TinderboxPrint: I/O write bytes / time
539,242,496 / 519,960 12:14:03 INFO - TinderboxPrint: CPU idle
8,221.9 (86.5%) 12:14:03 INFO - TinderboxPrint: CPU user
1,224.9 (12.9%) 12:14:03 INFO - TinderboxPrint: Swap in / out
0 / 0 12:14:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247320576; Read time: 0; Write time: 212096 12:14:03 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283262976; Read time: 16; Write time: 306332 12:14:04 INFO - Running post-run listener: _upload_blobber_files 12:14:04 INFO - Blob upload gear active. 12:14:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:14:04 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:14:04 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:14:04 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:14:04 INFO - (blobuploader) - INFO - Open directory for files ... 12:14:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:14:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:14:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:14:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:14:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:14:05 INFO - (blobuploader) - INFO - Done attempting. 12:14:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:14:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:14:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:14:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:14:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:14:06 INFO - (blobuploader) - INFO - Done attempting. 12:14:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:14:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:14:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:14:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:14:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:14:10 INFO - (blobuploader) - INFO - Done attempting. 12:14:10 INFO - (blobuploader) - INFO - Iteration through files over. 12:14:10 INFO - Return code: 0 12:14:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:14:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:14:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c6e9e4b750023b48f409c134b2ae064bd3010ca9992e548051522454ed005f0b009eb99d1c71d558e8717ca2054f11821d132c7917648ced734f65ce0e1d20e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33af7e3a979f24ff9bb23b5997c774a6069c6b14d4af00a6cf68bbf917a830ee66f2d1670277d85d4b06eac160e339630183ef32ac7a909c34792a0e09154258", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1e5ca6b56a429ff1f833ce254ac9a6b8fb65da21456c8b3a5510ce1a5f4f05985c5efb3b222fe2196bfe4aee7b3931e197da91c51ef1cb1587c6f2b26df8f0d"} 12:14:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:14:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:14:10 INFO - Contents: 12:14:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c6e9e4b750023b48f409c134b2ae064bd3010ca9992e548051522454ed005f0b009eb99d1c71d558e8717ca2054f11821d132c7917648ced734f65ce0e1d20e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33af7e3a979f24ff9bb23b5997c774a6069c6b14d4af00a6cf68bbf917a830ee66f2d1670277d85d4b06eac160e339630183ef32ac7a909c34792a0e09154258", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1e5ca6b56a429ff1f833ce254ac9a6b8fb65da21456c8b3a5510ce1a5f4f05985c5efb3b222fe2196bfe4aee7b3931e197da91c51ef1cb1587c6f2b26df8f0d"} 12:14:10 INFO - Running post-run listener: copy_logs_to_upload_dir 12:14:10 INFO - Copying logs to upload dir... 12:14:10 INFO - mkdir: /builds/slave/test/build/upload/logs 12:14:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.150623 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-02 12:14:10.298655) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 12:14:10.301915) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306 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/5c6e9e4b750023b48f409c134b2ae064bd3010ca9992e548051522454ed005f0b009eb99d1c71d558e8717ca2054f11821d132c7917648ced734f65ce0e1d20e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33af7e3a979f24ff9bb23b5997c774a6069c6b14d4af00a6cf68bbf917a830ee66f2d1670277d85d4b06eac160e339630183ef32ac7a909c34792a0e09154258", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1e5ca6b56a429ff1f833ce254ac9a6b8fb65da21456c8b3a5510ce1a5f4f05985c5efb3b222fe2196bfe4aee7b3931e197da91c51ef1cb1587c6f2b26df8f0d"} 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.011336 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/5c6e9e4b750023b48f409c134b2ae064bd3010ca9992e548051522454ed005f0b009eb99d1c71d558e8717ca2054f11821d132c7917648ced734f65ce0e1d20e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33af7e3a979f24ff9bb23b5997c774a6069c6b14d4af00a6cf68bbf917a830ee66f2d1670277d85d4b06eac160e339630183ef32ac7a909c34792a0e09154258", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1e5ca6b56a429ff1f833ce254ac9a6b8fb65da21456c8b3a5510ce1a5f4f05985c5efb3b222fe2196bfe4aee7b3931e197da91c51ef1cb1587c6f2b26df8f0d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 12:14:10.327404) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 12:14:10.327797) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1464893615.660678-860437306 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 12:14:10.410390) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 12:14:10.410757) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 12:14:10.411072) ========= ========= Total master_lag: 0.17 =========