builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1464280697.9 results: success (0) buildid: 20160526082142 builduid: d102a8dbda374354bc0ab82f4f781b07 revision: b0096c5c727749ad3e79cbdf20d2e96bd179c213 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 09:38:17.896713) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 09:38:17.897396) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 09:38:17.897698) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 09:38:17.970331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:38:17.970632) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 09:38:18-- 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% 36.8M=0s 2016-05-26 09:38:18 (36.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089691 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:38:18.077522) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:38:18.077875) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017253 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:38:18.168763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:38:18.169104) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b0096c5c727749ad3e79cbdf20d2e96bd179c213 --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 b0096c5c727749ad3e79cbdf20d2e96bd179c213 --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=9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 09:38:18,299 truncating revision to first 12 chars 2016-05-26 09:38:18,299 Setting DEBUG logging. 2016-05-26 09:38:18,299 attempt 1/10 2016-05-26 09:38:18,299 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b0096c5c7277?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 09:38:18,676 unpacking tar archive at: mozilla-central-b0096c5c7277/testing/mozharness/ program finished with exit code 0 elapsedTime=0.723868 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:38:18.907567) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 09:38:18.907883) ========= script_repo_revision: b0096c5c727749ad3e79cbdf20d2e96bd179c213 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 09:38:18.908283) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 09:38:18.908573) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 09:38:18.919144) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-05-26 09:38:18.919637) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:38:19 INFO - MultiFileLogger online at 20160526 09:38:19 in /builds/slave/test 09:38:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:38:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:38:19 INFO - {'append_to_log': False, 09:38:19 INFO - 'base_work_dir': '/builds/slave/test', 09:38:19 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:38:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:38:19 INFO - 'branch': 'Firefox-Non-PGO', 09:38:19 INFO - 'buildbot_json_path': 'buildprops.json', 09:38:19 INFO - 'config_files': ('talos/linux_config.py',), 09:38:19 INFO - 'default_actions': ('clobber', 09:38:19 INFO - 'read-buildbot-config', 09:38:19 INFO - 'download-and-extract', 09:38:19 INFO - 'populate-webroot', 09:38:19 INFO - 'create-virtualenv', 09:38:19 INFO - 'install', 09:38:19 INFO - 'run-tests'), 09:38:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:38:19 INFO - 'download_minidump_stackwalk': True, 09:38:19 INFO - 'download_symbols': 'ondemand', 09:38:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:38:19 INFO - 'tooltool.py': '/tools/tooltool.py', 09:38:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:38:19 INFO - '/tools/misc-python/virtualenv.py')}, 09:38:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:38:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:38:19 INFO - 'installer_path': 'installer.exe', 09:38:19 INFO - 'log_level': 'info', 09:38:19 INFO - 'log_name': 'talos', 09:38:19 INFO - 'log_to_console': True, 09:38:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:38:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:38:19 INFO - 'opt_config_files': (), 09:38:19 INFO - 'pip_index': False, 09:38:19 INFO - 'sps_profile': False, 09:38:19 INFO - 'sps_profile_interval': 0, 09:38:19 INFO - 'suite': 'dromaeojs', 09:38:19 INFO - 'system_bits': '32', 09:38:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:38:19 INFO - 'title': 'talos-linux64-ix-013', 09:38:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:38:19 INFO - 'use_talos_json': True, 09:38:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:38:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:38:19 INFO - 'work_dir': 'build'} 09:38:19 INFO - ##### 09:38:19 INFO - ##### Running clobber step. 09:38:19 INFO - ##### 09:38:19 INFO - Running pre-action listener: _resource_record_pre_action 09:38:19 INFO - Running main action method: clobber 09:38:19 INFO - rmtree: /builds/slave/test/build 09:38:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:38:19 INFO - Running post-action listener: _resource_record_post_action 09:38:19 INFO - ##### 09:38:19 INFO - ##### Finished clobber step (success) 09:38:19 INFO - ##### 09:38:19 INFO - ##### 09:38:19 INFO - ##### Running read-buildbot-config step. 09:38:19 INFO - ##### 09:38:19 INFO - Running pre-action listener: _resource_record_pre_action 09:38:19 INFO - Running main action method: read_buildbot_config 09:38:19 INFO - Using buildbot properties: 09:38:19 INFO - { 09:38:19 INFO - "project": "", 09:38:19 INFO - "product": "firefox", 09:38:19 INFO - "script_repo_revision": "production", 09:38:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:38:19 INFO - "repository": "", 09:38:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:38:19 INFO - "buildid": "20160526082142", 09:38:19 INFO - "pgo_build": "False", 09:38:19 INFO - "basedir": "/builds/slave/test", 09:38:19 INFO - "buildnumber": 100, 09:38:19 INFO - "slavename": "talos-linux64-ix-013", 09:38:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:38:19 INFO - "platform": "ubuntu64_hw", 09:38:19 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:38:19 INFO - "branch": "mozilla-central", 09:38:19 INFO - "repo_path": "mozilla-central", 09:38:19 INFO - "revision": "b0096c5c727749ad3e79cbdf20d2e96bd179c213", 09:38:19 INFO - "stage_platform": "linux64", 09:38:19 INFO - "builduid": "d102a8dbda374354bc0ab82f4f781b07", 09:38:19 INFO - "slavebuilddir": "test" 09:38:19 INFO - } 09:38:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 09:38:19 INFO - Running post-action listener: _resource_record_post_action 09:38:19 INFO - ##### 09:38:19 INFO - ##### Finished read-buildbot-config step (success) 09:38:19 INFO - ##### 09:38:19 INFO - ##### 09:38:19 INFO - ##### Running download-and-extract step. 09:38:19 INFO - ##### 09:38:19 INFO - Running pre-action listener: _resource_record_pre_action 09:38:19 INFO - Running main action method: download_and_extract 09:38:19 INFO - mkdir: /builds/slave/test/build/tests 09:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:19 INFO - https://queue.taskcluster.net/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:38:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:38:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:38:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/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 09:38:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/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 09:38:22 INFO - Downloaded 1361 bytes. 09:38:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:38:22 INFO - Using the following test package requirements: 09:38:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:38:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:38:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:38:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:38:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:38:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:38:22 INFO - u'jsshell-linux-x86_64.zip'], 09:38:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:38:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:38:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:38:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:38:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:38:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:38:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:38:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:38:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:38:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:38:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:38:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:38:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:22 INFO - https://queue.taskcluster.net/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:38:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:38:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:38:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/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 09:38:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/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 09:38:24 INFO - Downloaded 22835565 bytes. 09:38:24 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'] 09:38:24 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 09:38:25 INFO - Return code: 0 09:38:25 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 09:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:25 INFO - https://queue.taskcluster.net/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:38:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:38:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:38:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/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 09:38:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/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 09:38:30 INFO - Downloaded 22835565 bytes. 09:38:30 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'] 09:38:30 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 09:38:31 INFO - Return code: 0 09:38:31 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')]} 09:38:31 INFO - https://queue.taskcluster.net/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:38:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:38:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:38:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/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 09:38:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/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 09:38:33 INFO - Downloaded 10834034 bytes. 09:38:33 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'] 09:38:33 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 09:38:33 INFO - Return code: 0 09:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:33 INFO - https://queue.taskcluster.net/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:38:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:38:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:38:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/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 09:38:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/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 09:38:35 INFO - Downloaded 54826809 bytes. 09:38:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:38:35 INFO - mkdir: /builds/slave/test/properties 09:38:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:38:35 INFO - Writing to file /builds/slave/test/properties/build_url 09:38:35 INFO - Contents: 09:38:35 INFO - build_url:https://queue.taskcluster.net/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:38:36 INFO - Running post-action listener: _resource_record_post_action 09:38:36 INFO - Running post-action listener: set_extra_try_arguments 09:38:36 INFO - ##### 09:38:36 INFO - ##### Finished download-and-extract step (success) 09:38:36 INFO - ##### 09:38:36 INFO - ##### 09:38:36 INFO - ##### Running populate-webroot step. 09:38:36 INFO - ##### 09:38:36 INFO - Running pre-action listener: _resource_record_pre_action 09:38:36 INFO - Running main action method: populate_webroot 09:38:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:38:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:38:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:38:36 INFO - '--tppagecycles', 09:38:36 INFO - '7'], 09:38:36 INFO - 'tests': ['tsvgm']}}, 09:38:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:38:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:38:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:38:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:38:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:38:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:38:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:36 INFO - 'talos_options': ['--disable-e10s'], 09:38:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:38:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:38:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:36 INFO - 'talos_options': ['--disable-e10s'], 09:38:36 INFO - 'tests': ['damp', 'tps']}, 09:38:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:36 INFO - 'tests': ['damp', 'tps']}, 09:38:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:38:36 INFO - 'tests': ['dromaeo_dom']}, 09:38:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:38:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:38:36 INFO - 'tests': ['a11yr', 09:38:36 INFO - 'ts_paint', 09:38:36 INFO - 'tpaint', 09:38:36 INFO - 'sessionrestore', 09:38:36 INFO - 'sessionrestore_no_auto_restore', 09:38:36 INFO - 'tabpaint']}, 09:38:36 INFO - 'other-e10s': {'tests': ['a11yr', 09:38:36 INFO - 'ts_paint', 09:38:36 INFO - 'tpaint', 09:38:36 INFO - 'sessionrestore', 09:38:36 INFO - 'sessionrestore_no_auto_restore', 09:38:36 INFO - 'tabpaint']}, 09:38:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:38:36 INFO - 'ts_paint', 09:38:36 INFO - 'tpaint', 09:38:36 INFO - 'sessionrestore', 09:38:36 INFO - 'sessionrestore_no_auto_restore', 09:38:36 INFO - 'tabpaint']}, 09:38:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:38:36 INFO - 'ts_paint', 09:38:36 INFO - 'tpaint', 09:38:36 INFO - 'sessionrestore', 09:38:36 INFO - 'sessionrestore_no_auto_restore', 09:38:36 INFO - 'tabpaint']}, 09:38:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:38:36 INFO - 'tests': ['a11yr', 09:38:36 INFO - 'ts_paint', 09:38:36 INFO - 'tpaint', 09:38:36 INFO - 'sessionrestore', 09:38:36 INFO - 'sessionrestore_no_auto_restore', 09:38:36 INFO - 'tabpaint']}, 09:38:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:38:36 INFO - 'tests': ['a11yr', 09:38:36 INFO - 'ts_paint', 09:38:36 INFO - 'tpaint', 09:38:36 INFO - 'sessionrestore', 09:38:36 INFO - 'sessionrestore_no_auto_restore', 09:38:36 INFO - 'tabpaint']}, 09:38:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:38:36 INFO - 'tests': ['tsvgx', 09:38:36 INFO - 'tsvgr_opacity', 09:38:36 INFO - 'tart', 09:38:36 INFO - 'tscrollx', 09:38:36 INFO - 'cart']}, 09:38:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:38:36 INFO - 'tsvgr_opacity', 09:38:36 INFO - 'tart', 09:38:36 INFO - 'tscrollx', 09:38:36 INFO - 'cart']}, 09:38:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:36 INFO - 'talos_options': ['--disable-e10s'], 09:38:36 INFO - 'tests': ['tp5o']}, 09:38:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:36 INFO - 'tests': ['tp5o']}, 09:38:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:36 INFO - 'talos_options': ['--disable-e10s', 09:38:36 INFO - '--xperf_path', 09:38:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:38:36 INFO - 'tests': ['tp5n']}, 09:38:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:36 INFO - 'talos_options': ['--xperf_path', 09:38:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:38:36 INFO - 'tests': ['tp5n']}}, 09:38:36 INFO - 'talos.zip': {'path': '', 09:38:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:38:36 INFO - Running post-action listener: _resource_record_post_action 09:38:36 INFO - ##### 09:38:36 INFO - ##### Finished populate-webroot step (success) 09:38:36 INFO - ##### 09:38:36 INFO - ##### 09:38:36 INFO - ##### Running create-virtualenv step. 09:38:36 INFO - ##### 09:38:36 INFO - Running pre-action listener: _resource_record_pre_action 09:38:36 INFO - Running main action method: create_virtualenv 09:38:36 INFO - Creating virtualenv /builds/slave/test/build/venv 09:38:36 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 09:38:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:38:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:38:36 INFO - Using real prefix '/usr' 09:38:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:38:36 INFO - Installing distribute.............................................................................................................................................................................................done. 09:38:38 INFO - Installing pip.................done. 09:38:38 INFO - Return code: 0 09:38:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:38:38 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')]} 09:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:38 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')]} 09:38:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:38 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 0x7eff73aedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2716770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a59c0>, '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 0x27a68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6d50>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896', '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 09:38:38 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 09:38:38 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 09:38:38 INFO - Using env: {'DISPLAY': ':0', 09:38:38 INFO - 'HOME': '/home/cltbld', 09:38:38 INFO - 'LANG': 'en_US.UTF-8', 09:38:38 INFO - 'LANGUAGE': 'en_US:en', 09:38:38 INFO - 'LOGNAME': 'cltbld', 09:38:38 INFO - 'MAIL': '/var/mail/cltbld', 09:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:38 INFO - 'MOZ_NO_REMOTE': '1', 09:38:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:38 INFO - 'NO_EM_RESTART': '1', 09:38:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:38 INFO - 'PWD': '/builds/slave/test', 09:38:38 INFO - 'SHELL': '/bin/bash', 09:38:38 INFO - 'SHLVL': '1', 09:38:38 INFO - 'TERM': 'linux', 09:38:38 INFO - 'TMOUT': '86400', 09:38:38 INFO - 'USER': 'cltbld', 09:38:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896', 09:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:38 INFO - '_': '/tools/buildbot/bin/python'} 09:38:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:39 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 09:38:39 INFO - Cleaning up... 09:38:39 INFO - Return code: 0 09:38:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:38: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')]} 09:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38: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')]} 09:38:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7eff73aedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2716770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a59c0>, '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 0x27a68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6d50>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896', '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 09:38:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:38:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:38:39 INFO - Using env: {'DISPLAY': ':0', 09:38:39 INFO - 'HOME': '/home/cltbld', 09:38:39 INFO - 'LANG': 'en_US.UTF-8', 09:38:39 INFO - 'LANGUAGE': 'en_US:en', 09:38:39 INFO - 'LOGNAME': 'cltbld', 09:38:39 INFO - 'MAIL': '/var/mail/cltbld', 09:38:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:39 INFO - 'MOZ_NO_REMOTE': '1', 09:38:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:39 INFO - 'NO_EM_RESTART': '1', 09:38:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:39 INFO - 'PWD': '/builds/slave/test', 09:38:39 INFO - 'SHELL': '/bin/bash', 09:38:39 INFO - 'SHLVL': '1', 09:38:39 INFO - 'TERM': 'linux', 09:38:39 INFO - 'TMOUT': '86400', 09:38:39 INFO - 'USER': 'cltbld', 09:38:39 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896', 09:38:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:39 INFO - '_': '/tools/buildbot/bin/python'} 09:38:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:39 INFO - Downloading/unpacking psutil>=3.1.1 09:38:39 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 09:38:39 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 09:38:39 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 09:38:39 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 09:38:39 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 09:38:39 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 09:38:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:38:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:38:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:38:41 INFO - Installing collected packages: psutil 09:38:41 INFO - Running setup.py install for psutil 09:38:41 INFO - building 'psutil._psutil_linux' extension 09:38:41 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 09:38:41 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 09:38:41 INFO - building 'psutil._psutil_posix' extension 09:38:41 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 09:38:41 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 09:38:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:38:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:38:42 INFO - Successfully installed psutil 09:38:42 INFO - Cleaning up... 09:38:42 INFO - Return code: 0 09:38:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7eff73aedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2716770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a59c0>, '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 0x27a68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6d50>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896', '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 09:38:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:38:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:38:42 INFO - Using env: {'DISPLAY': ':0', 09:38:42 INFO - 'HOME': '/home/cltbld', 09:38:42 INFO - 'LANG': 'en_US.UTF-8', 09:38:42 INFO - 'LANGUAGE': 'en_US:en', 09:38:42 INFO - 'LOGNAME': 'cltbld', 09:38:42 INFO - 'MAIL': '/var/mail/cltbld', 09:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:42 INFO - 'MOZ_NO_REMOTE': '1', 09:38:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:42 INFO - 'NO_EM_RESTART': '1', 09:38:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:42 INFO - 'PWD': '/builds/slave/test', 09:38:42 INFO - 'SHELL': '/bin/bash', 09:38:42 INFO - 'SHLVL': '1', 09:38:42 INFO - 'TERM': 'linux', 09:38:42 INFO - 'TMOUT': '86400', 09:38:42 INFO - 'USER': 'cltbld', 09:38:42 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896', 09:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:42 INFO - '_': '/tools/buildbot/bin/python'} 09:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:38:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:38:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:38:44 INFO - Installing collected packages: mozsystemmonitor 09:38:44 INFO - Running setup.py install for mozsystemmonitor 09:38:44 INFO - Successfully installed mozsystemmonitor 09:38:44 INFO - Cleaning up... 09:38:44 INFO - Return code: 0 09:38:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:38: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')]} 09:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38: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')]} 09:38:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:44 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 0x7eff73aedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2716770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a59c0>, '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 0x27a68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6d50>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896', '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 09:38:44 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 09:38:44 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 09:38:44 INFO - Using env: {'DISPLAY': ':0', 09:38:44 INFO - 'HOME': '/home/cltbld', 09:38:44 INFO - 'LANG': 'en_US.UTF-8', 09:38:44 INFO - 'LANGUAGE': 'en_US:en', 09:38:44 INFO - 'LOGNAME': 'cltbld', 09:38:44 INFO - 'MAIL': '/var/mail/cltbld', 09:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:44 INFO - 'MOZ_NO_REMOTE': '1', 09:38:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:44 INFO - 'NO_EM_RESTART': '1', 09:38:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:44 INFO - 'PWD': '/builds/slave/test', 09:38:44 INFO - 'SHELL': '/bin/bash', 09:38:44 INFO - 'SHLVL': '1', 09:38:44 INFO - 'TERM': 'linux', 09:38:44 INFO - 'TMOUT': '86400', 09:38:44 INFO - 'USER': 'cltbld', 09:38:44 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896', 09:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:44 INFO - '_': '/tools/buildbot/bin/python'} 09:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:44 INFO - Downloading/unpacking blobuploader==1.2.4 09:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:46 INFO - Downloading blobuploader-1.2.4.tar.gz 09:38:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:38:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:38:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:47 INFO - Downloading docopt-0.6.1.tar.gz 09:38:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:38:47 INFO - Installing collected packages: blobuploader, requests, docopt 09:38:47 INFO - Running setup.py install for blobuploader 09:38:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:38:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:38:47 INFO - Running setup.py install for requests 09:38:47 INFO - Running setup.py install for docopt 09:38:47 INFO - Successfully installed blobuploader requests docopt 09:38:47 INFO - Cleaning up... 09:38:47 INFO - Return code: 0 09:38:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38:47 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')]} 09:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:47 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')]} 09:38:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:47 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 0x7eff73aedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2716770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a59c0>, '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 0x27a68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6d50>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896', '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 09:38:47 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 09:38:47 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 09:38:47 INFO - Using env: {'DISPLAY': ':0', 09:38:47 INFO - 'HOME': '/home/cltbld', 09:38:47 INFO - 'LANG': 'en_US.UTF-8', 09:38:47 INFO - 'LANGUAGE': 'en_US:en', 09:38:47 INFO - 'LOGNAME': 'cltbld', 09:38:47 INFO - 'MAIL': '/var/mail/cltbld', 09:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:47 INFO - 'MOZ_NO_REMOTE': '1', 09:38:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:47 INFO - 'NO_EM_RESTART': '1', 09:38:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:47 INFO - 'PWD': '/builds/slave/test', 09:38:47 INFO - 'SHELL': '/bin/bash', 09:38:47 INFO - 'SHLVL': '1', 09:38:47 INFO - 'TERM': 'linux', 09:38:47 INFO - 'TMOUT': '86400', 09:38:47 INFO - 'USER': 'cltbld', 09:38:47 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896', 09:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:47 INFO - '_': '/tools/buildbot/bin/python'} 09:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:38:48 INFO - Running setup.py (path:/tmp/pip-b22NE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:38:48 INFO - Running setup.py (path:/tmp/pip-rUtT1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:38:48 INFO - Running setup.py (path:/tmp/pip-o4l1ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:38:48 INFO - Running setup.py (path:/tmp/pip-XNQ8jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:38:48 INFO - Running setup.py (path:/tmp/pip-KGbYkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:38:48 INFO - Running setup.py (path:/tmp/pip-yHm4Ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:38:48 INFO - Running setup.py (path:/tmp/pip-NKVBrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:38:48 INFO - Running setup.py (path:/tmp/pip-6l_HT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:38:48 INFO - Running setup.py (path:/tmp/pip-MDLC8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:38:48 INFO - Running setup.py (path:/tmp/pip-QSRKxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:38:48 INFO - Running setup.py (path:/tmp/pip-TphLCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:38:48 INFO - Running setup.py (path:/tmp/pip-LDpur1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:38:49 INFO - Running setup.py (path:/tmp/pip-eADq6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:38:49 INFO - Running setup.py (path:/tmp/pip-s95Cyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:49 INFO - Running setup.py (path:/tmp/pip-vjLKt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:38:49 INFO - Running setup.py (path:/tmp/pip-L3qOtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:38:49 INFO - Running setup.py (path:/tmp/pip-elpjE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:38:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:38:49 INFO - Running setup.py install for manifestparser 09:38:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:38:49 INFO - Running setup.py install for mozcrash 09:38:49 INFO - Running setup.py install for mozdebug 09:38:49 INFO - Running setup.py install for mozdevice 09:38:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:38:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:38:49 INFO - Running setup.py install for mozfile 09:38:49 INFO - Running setup.py install for mozhttpd 09:38:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:38:50 INFO - Running setup.py install for mozinfo 09:38:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:38:50 INFO - Running setup.py install for mozInstall 09:38:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:38:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:38:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:38:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:38:50 INFO - Running setup.py install for mozleak 09:38:50 INFO - Running setup.py install for mozlog 09:38:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:38:50 INFO - Running setup.py install for moznetwork 09:38:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:38:50 INFO - Running setup.py install for mozprocess 09:38:50 INFO - Running setup.py install for mozprofile 09:38:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:38:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:38:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:38:50 INFO - Running setup.py install for mozrunner 09:38:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:38:50 INFO - Running setup.py install for mozscreenshot 09:38:50 INFO - Running setup.py install for moztest 09:38:51 INFO - Running setup.py install for mozversion 09:38:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:38:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:38:51 INFO - Cleaning up... 09:38:51 INFO - Return code: 0 09:38:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7eff73aedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2716770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a59c0>, '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 0x27a68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6d50>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896', '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 09:38:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:38:51 INFO - Using env: {'DISPLAY': ':0', 09:38:51 INFO - 'HOME': '/home/cltbld', 09:38:51 INFO - 'LANG': 'en_US.UTF-8', 09:38:51 INFO - 'LANGUAGE': 'en_US:en', 09:38:51 INFO - 'LOGNAME': 'cltbld', 09:38:51 INFO - 'MAIL': '/var/mail/cltbld', 09:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:51 INFO - 'MOZ_NO_REMOTE': '1', 09:38:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:51 INFO - 'NO_EM_RESTART': '1', 09:38:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:51 INFO - 'PWD': '/builds/slave/test', 09:38:51 INFO - 'SHELL': '/bin/bash', 09:38:51 INFO - 'SHLVL': '1', 09:38:51 INFO - 'TERM': 'linux', 09:38:51 INFO - 'TMOUT': '86400', 09:38:51 INFO - 'USER': 'cltbld', 09:38:51 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896', 09:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:51 INFO - '_': '/tools/buildbot/bin/python'} 09:38:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:38:51 INFO - Running setup.py (path:/tmp/pip-UKBogJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:38:51 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)) 09:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:38:51 INFO - Running setup.py (path:/tmp/pip-SgmOl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:38:51 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)) 09:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:38:51 INFO - Running setup.py (path:/tmp/pip-SZlR8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:38:51 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)) 09:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:38:51 INFO - Running setup.py (path:/tmp/pip-GAmds1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:38:51 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)) 09:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:38:51 INFO - Running setup.py (path:/tmp/pip-qU0pqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:38:51 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)) 09:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:38:51 INFO - Running setup.py (path:/tmp/pip-fSSnvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:38:51 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)) 09:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:38:51 INFO - Running setup.py (path:/tmp/pip-Yanclb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:38:51 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)) 09:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:38:51 INFO - Running setup.py (path:/tmp/pip-0tcAX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:38:51 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)) 09:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:38:51 INFO - Running setup.py (path:/tmp/pip-m7aUMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:38:52 INFO - Running setup.py (path:/tmp/pip-S6Rid4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:38:52 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)) 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:38:52 INFO - Running setup.py (path:/tmp/pip-DHEJCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:38:52 INFO - Running setup.py (path:/tmp/pip-eZt5u_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:38:52 INFO - Running setup.py (path:/tmp/pip-BWuYPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:38:52 INFO - Running setup.py (path:/tmp/pip-yarXWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:38:52 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)) 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:52 INFO - Running setup.py (path:/tmp/pip-OYf64k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:38:52 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)) 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:38:52 INFO - Running setup.py (path:/tmp/pip-mZ4BJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:38:52 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)) 09:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:38:52 INFO - Running setup.py (path:/tmp/pip-z1LiCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:38:52 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)) 09:38:52 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)) 09:38:52 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)) 09:38:52 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)) 09:38:52 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)) 09:38:52 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)) 09:38:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:54 INFO - Downloading blessings-1.6.tar.gz 09:38:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:38:54 INFO - Installing collected packages: blessings 09:38:54 INFO - Running setup.py install for blessings 09:38:54 INFO - Successfully installed blessings 09:38:54 INFO - Cleaning up... 09:38:54 INFO - Return code: 0 09:38:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:38:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:38:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:38:54 INFO - Reading from file tmpfile_stdout 09:38:54 INFO - Current package versions: 09:38:54 INFO - argparse == 1.2.1 09:38:54 INFO - blessings == 1.6 09:38:54 INFO - blobuploader == 1.2.4 09:38:54 INFO - docopt == 0.6.1 09:38:54 INFO - manifestparser == 1.1 09:38:54 INFO - mozInstall == 1.12 09:38:54 INFO - mozcrash == 0.17 09:38:54 INFO - mozdebug == 0.1 09:38:54 INFO - mozdevice == 0.48 09:38:54 INFO - mozfile == 1.2 09:38:54 INFO - mozhttpd == 0.7 09:38:54 INFO - mozinfo == 0.9 09:38:54 INFO - mozleak == 0.1 09:38:54 INFO - mozlog == 3.2 09:38:54 INFO - moznetwork == 0.27 09:38:54 INFO - mozprocess == 0.22 09:38:54 INFO - mozprofile == 0.28 09:38:54 INFO - mozrunner == 6.11 09:38:54 INFO - mozscreenshot == 0.1 09:38:54 INFO - mozsystemmonitor == 0.3 09:38:54 INFO - moztest == 0.7 09:38:54 INFO - mozversion == 1.4 09:38:54 INFO - psutil == 3.1.1 09:38:54 INFO - requests == 1.2.3 09:38:54 INFO - wsgiref == 0.1.2 09:38:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38:54 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')]} 09:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:54 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')]} 09:38:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:54 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 0x7eff73aedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2716770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a59c0>, '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 0x27a68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6d50>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896', '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 09:38:54 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 09:38:54 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 09:38:54 INFO - Using env: {'DISPLAY': ':0', 09:38:54 INFO - 'HOME': '/home/cltbld', 09:38:54 INFO - 'LANG': 'en_US.UTF-8', 09:38:54 INFO - 'LANGUAGE': 'en_US:en', 09:38:54 INFO - 'LOGNAME': 'cltbld', 09:38:54 INFO - 'MAIL': '/var/mail/cltbld', 09:38:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:54 INFO - 'MOZ_NO_REMOTE': '1', 09:38:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:54 INFO - 'NO_EM_RESTART': '1', 09:38:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:54 INFO - 'PWD': '/builds/slave/test', 09:38:54 INFO - 'SHELL': '/bin/bash', 09:38:54 INFO - 'SHLVL': '1', 09:38:54 INFO - 'TERM': 'linux', 09:38:54 INFO - 'TMOUT': '86400', 09:38:54 INFO - 'USER': 'cltbld', 09:38:54 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896', 09:38:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:54 INFO - '_': '/tools/buildbot/bin/python'} 09:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:38:55 INFO - Cleaning up... 09:38:55 INFO - Return code: 0 09:38:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:38: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')]} 09:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38: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')]} 09:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7eff73aedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2716770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a59c0>, '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 0x27a68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6d50>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896', '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 09:38:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:38:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:38:55 INFO - Using env: {'DISPLAY': ':0', 09:38:55 INFO - 'HOME': '/home/cltbld', 09:38:55 INFO - 'LANG': 'en_US.UTF-8', 09:38:55 INFO - 'LANGUAGE': 'en_US:en', 09:38:55 INFO - 'LOGNAME': 'cltbld', 09:38:55 INFO - 'MAIL': '/var/mail/cltbld', 09:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:55 INFO - 'MOZ_NO_REMOTE': '1', 09:38:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:55 INFO - 'NO_EM_RESTART': '1', 09:38:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:55 INFO - 'PWD': '/builds/slave/test', 09:38:55 INFO - 'SHELL': '/bin/bash', 09:38:55 INFO - 'SHLVL': '1', 09:38:55 INFO - 'TERM': 'linux', 09:38:55 INFO - 'TMOUT': '86400', 09:38:55 INFO - 'USER': 'cltbld', 09:38:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896', 09:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:55 INFO - '_': '/tools/buildbot/bin/python'} 09:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:55 INFO - Downloading/unpacking jsonschema 09:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:38:57 INFO - Downloading/unpacking functools32 (from jsonschema) 09:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:57 INFO - Downloading functools32-3.2.3-2.tar.gz 09:38:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:38:57 INFO - warning: no files found matching '*.txt' 09:38:57 INFO - no previously-included directories found matching 'build' 09:38:57 INFO - no previously-included directories found matching 'dist' 09:38:57 INFO - no previously-included directories found matching '.git*' 09:38:57 INFO - Installing collected packages: jsonschema, functools32 09:38:57 INFO - Running setup.py install for functools32 09:38:57 INFO - warning: no files found matching '*.txt' 09:38:57 INFO - no previously-included directories found matching 'build' 09:38:57 INFO - no previously-included directories found matching 'dist' 09:38:57 INFO - no previously-included directories found matching '.git*' 09:38:57 INFO - Successfully installed jsonschema functools32 09:38:57 INFO - Cleaning up... 09:38:57 INFO - Return code: 0 09:38:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:38:57 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')]} 09:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:57 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')]} 09:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:57 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 0x7eff73aedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2716770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a59c0>, '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 0x27a68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6d50>, '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': '9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896', '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 09:38:57 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 09:38:57 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 09:38:57 INFO - Using env: {'DISPLAY': ':0', 09:38:57 INFO - 'HOME': '/home/cltbld', 09:38:57 INFO - 'LANG': 'en_US.UTF-8', 09:38:57 INFO - 'LANGUAGE': 'en_US:en', 09:38:57 INFO - 'LOGNAME': 'cltbld', 09:38:57 INFO - 'MAIL': '/var/mail/cltbld', 09:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:57 INFO - 'MOZ_NO_REMOTE': '1', 09:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:57 INFO - 'NO_EM_RESTART': '1', 09:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:57 INFO - 'PWD': '/builds/slave/test', 09:38:57 INFO - 'SHELL': '/bin/bash', 09:38:57 INFO - 'SHLVL': '1', 09:38:57 INFO - 'TERM': 'linux', 09:38:57 INFO - 'TMOUT': '86400', 09:38:57 INFO - 'USER': 'cltbld', 09:38:57 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896', 09:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:57 INFO - '_': '/tools/buildbot/bin/python'} 09:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:57 INFO - Downloading/unpacking flake8 09:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:38:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:38:59 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 09:38:59 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 09:38:59 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 09:38:59 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 09:38:59 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 09:38:59 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 09:39:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:39:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:39:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:39:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:39:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:39:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:39:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:39:00 INFO - no previously-included directories found matching 'docs/_build' 09:39:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:39:00 INFO - Running setup.py install for pep8 09:39:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:39:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:39:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:39:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:39:00 INFO - no previously-included directories found matching 'docs/_build' 09:39:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:39:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:39:00 INFO - Cleaning up... 09:39:00 INFO - Return code: 0 09:39:00 INFO - Running post-action listener: _resource_record_post_action 09:39:00 INFO - Running post-action listener: _start_resource_monitoring 09:39:00 INFO - Starting resource monitoring. 09:39:00 INFO - ##### 09:39:00 INFO - ##### Finished create-virtualenv step (success) 09:39:00 INFO - ##### 09:39:00 INFO - ##### 09:39:00 INFO - ##### Running install step. 09:39:00 INFO - ##### 09:39:00 INFO - Running pre-action listener: _resource_record_pre_action 09:39:00 INFO - Running main action method: install 09:39:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:39:01 INFO - Reading from file tmpfile_stdout 09:39:01 INFO - Detecting whether we're running mozinstall >=1.0... 09:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:39:01 INFO - Reading from file tmpfile_stdout 09:39:01 INFO - Output received: 09:39:01 INFO - Usage: mozinstall [options] installer 09:39:01 INFO - Options: 09:39:01 INFO - -h, --help show this help message and exit 09:39:01 INFO - -d DEST, --destination=DEST 09:39:01 INFO - Directory to install application into. [default: 09:39:01 INFO - "/builds/slave/test"] 09:39:01 INFO - --app=APP Application being installed. [default: firefox] 09:39:01 INFO - mkdir: /builds/slave/test/build/application 09:39:01 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'] 09:39:01 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 09:39:16 INFO - Reading from file tmpfile_stdout 09:39:16 INFO - Output received: 09:39:16 INFO - /builds/slave/test/build/application/firefox/firefox 09:39:16 INFO - Running post-action listener: _resource_record_post_action 09:39:16 INFO - ##### 09:39:16 INFO - ##### Finished install step (success) 09:39:16 INFO - ##### 09:39:16 INFO - ##### 09:39:16 INFO - ##### Running run-tests step. 09:39:16 INFO - ##### 09:39:16 INFO - Running pre-action listener: _resource_record_pre_action 09:39:16 INFO - Running main action method: run_tests 09:39:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:39:16 INFO - Python 2.7.3 09:39:16 INFO - Return code: 0 09:39:16 INFO - grabbing minidump binary from tooltool 09:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:16 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 0x27a59c0>, '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 0x27a68c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a6d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:39:16 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 09:39:16 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 09:39:16 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 09:39:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:39:17 INFO - Return code: 0 09:39:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:39:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:39:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:39:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:39:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:39:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:39:17 INFO - Return code: 0 09:39:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:39:17 INFO - Using env: {'DISPLAY': ':0', 09:39:17 INFO - 'HOME': '/home/cltbld', 09:39:17 INFO - 'LANG': 'en_US.UTF-8', 09:39:17 INFO - 'LANGUAGE': 'en_US:en', 09:39:17 INFO - 'LOGNAME': 'cltbld', 09:39:17 INFO - 'MAIL': '/var/mail/cltbld', 09:39:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:39:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:17 INFO - 'MOZ_NO_REMOTE': '1', 09:39:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:17 INFO - 'NO_EM_RESTART': '1', 09:39:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:17 INFO - 'PWD': '/builds/slave/test', 09:39:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:39:17 INFO - 'SHELL': '/bin/bash', 09:39:17 INFO - 'SHLVL': '1', 09:39:17 INFO - 'TERM': 'linux', 09:39:17 INFO - 'TMOUT': '86400', 09:39:17 INFO - 'USER': 'cltbld', 09:39:17 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896', 09:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:17 INFO - '_': '/tools/buildbot/bin/python'} 09:39:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:39:18 INFO - mozversion application_buildid: 20160526082142 09:39:18 INFO - mozversion application_changeset: b0096c5c727749ad3e79cbdf20d2e96bd179c213 09:39:18 INFO - mozversion application_display_name: Nightly 09:39:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:39:18 INFO - mozversion application_name: Firefox 09:39:18 INFO - mozversion application_remotingname: firefox 09:39:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:39:18 INFO - mozversion application_vendor: Mozilla 09:39:18 INFO - mozversion application_version: 49.0a1 09:39:18 INFO - mozversion platform_buildid: 20160526082142 09:39:18 INFO - mozversion platform_changeset: b0096c5c727749ad3e79cbdf20d2e96bd179c213 09:39:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:39:18 INFO - mozversion platform_version: 49.0a1 09:39:18 INFO - using testdate: 1464280758 09:39:18 INFO - actual date: 1464280758 09:39:18 INFO - starting webserver on 'localhost:40142' 09:39:18 INFO - SUITE-START | Running 2 tests 09:39:18 INFO - TEST-START | dromaeo_css 09:39:18 INFO - operating with platform_type : linux_ 09:39:18 INFO - Initialising browser for dromaeo_css test... 09:39:18 INFO - TEST-INFO | started process 3602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd1X87p/profile http://localhost:40142/getInfo.html) 09:39:22 INFO - PROCESS | 3602 | __metrics Screen width/height:1600/1200 09:39:22 INFO - PROCESS | 3602 | colorDepth:24 09:39:22 INFO - PROCESS | 3602 | Browser inner width/height: 1024/697 09:39:22 INFO - PROCESS | 3602 | __metrics 09:39:23 ERROR - PROCESS | 3602 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:39:24 INFO - TEST-INFO | 3602: exit 0 09:39:24 INFO - Browser initialized. 09:39:24 INFO - Running cycle 1/1 for dromaeo_css test... 09:39:24 INFO - TEST-INFO | started process 3684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd1X87p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:39:36 INFO - PROCESS | 3684 | RSS: Main: 156856320 09:39:36 INFO - PROCESS | 3684 | 09:40:28 INFO - PROCESS | 3684 | 1464280828052 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] 09:42:39 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:40142/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40142/tests/dromaeo/cssquery-ext.html) 09:42:40 INFO - PROCESS | 3684 | RSS: Main: 244834304 09:42:40 INFO - PROCESS | 3684 | 09:45:43 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:40142/tests/dromaeo/cssquery-ext.html (next: http://localhost:40142/tests/dromaeo/cssquery-jquery.html) 09:45:44 INFO - PROCESS | 3684 | RSS: Main: 239845376 09:45:44 INFO - PROCESS | 3684 | 09:48:46 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:40142/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40142/tests/dromaeo/cssquery-mootools.html) 09:48:46 INFO - PROCESS | 3684 | RSS: Main: 245661696 09:48:46 INFO - PROCESS | 3684 | 09:51:49 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:40142/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40142/tests/dromaeo/cssquery-prototype.html) 09:51:49 INFO - PROCESS | 3684 | RSS: Main: 234180608 09:51:49 INFO - PROCESS | 3684 | 09:54:52 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:40142/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40142/tests/dromaeo/cssquery-yui.html) 09:54:53 INFO - PROCESS | 3684 | RSS: Main: 213446656 09:54:53 INFO - PROCESS | 3684 | 09:57:55 INFO - PROCESS | 3684 | Cycle 1(1): loaded http://localhost:40142/tests/dromaeo/cssquery-yui.html (next: http://localhost:40142/tests/dromaeo/cssquery-dojo.html) 09:57:56 INFO - PROCESS | 3684 | RSS: Main: 272261120 09:57:56 INFO - PROCESS | 3684 | 09:57:56 INFO - PROCESS | 3684 | __start_tp_report 09:57:56 INFO - PROCESS | 3684 | _x_x_mozilla_page_load 09:57:56 INFO - PROCESS | 3684 | _x_x_mozilla_page_load_details 09:57:56 INFO - PROCESS | 3684 | |i|pagename|runs| 09:57:56 INFO - PROCESS | 3684 | |0;dojo.html;2695.2318589202077;2711.1324376199623;2736.0423851651917;2737.7672897803686;2771.6951135375116;4693.272542755878;4775.832845850396;4785.449673287569;4878.658493905428;4911.993041426508;4754.9286760698615;4816.710997340162;4817.277408388743;4818.855434336975;4845;4419.49175844778;4483.730976141425;4513.954860451403;4528.343390208418;4568.908621827562;4460.732356058631;4502.167099086663;4518.277075667894;4523.525029871866;4551;4328.177646247234;4368.213721530124;4395.055063161436;4410.051838854662;4411.404460397837;4433.024734558392;4447.688661793676;4455.309427038814;4510.8421205257655;4510.977445112786;4461.241588929857;4485.663575231871;4486.394336764528;4531.161735078988;4536.138133754576;4674.415698037746;4734.668573199878;4775.976120119377;4798.304245884327;4806.423229212517;5284.4187139414635;5299.046171689094;5303.814366497193;5303.973480132613;5308.601854860863;5296.205569164617;5317.760700768475;5332.33345831771;5334.146536554172;5338.332708411449;4757.666963312569;4895.143349913822;4973.378327709036;4979.850604481871;4982.128127577659;5427.565794736412;5468.808591699271;5469.644473109235;5471.616986810965;5473.507384335349;5218.843434696965;5234.685918844805;5237.319148510669;5240.764165612557;5244;5106.234064890222;5192.844214673566;5232;5251.8161864335325;5254.369475662945;5230.503102205284;5251;5261.789528418897;5263.578913686896;5267.209918512177;5171.3277273954145;5198.532132108053;5212.40057393397;5214.374275087014;5233.738313084331;4337.392765012901;4381.78091095444;4382.868513944587;4384.364267181305;4440.822367105344;3900.258950799339;3947.9013024674614;3948.3485224937563;3950.229705207457;3952.782596957195;4467.173572889026;4479.888002799956;4513.842015529441;4530.207213737583;4538.364628951949;5273.815416460406;5283.1546952487415;5288.65623734456;5297.761600727977;5348.090824559834;4392.275274579659;4530.365748795171;4536.455625324916;4538.773061346919;4577.3362862384765;4612.561806628365;4710.905781884343;4727.4327080749845;4742.952570474251;4748.833790817304;4866.902661946741;4877.439094504178;4881.072596206709;4888.340074089952;4925.4335751388335;5038.722870242025;5172.405173405106;5173.0688476074665;5232.712200828991;5273.472652734696;4825.541573550507;4829.710217386968;4883.3651625288485;4888.340074089952;4971.204607262821;5169.198774190007;5174.249733788655;5174.663646862942;5177.508136727005;5222.712750798591;5060.443351231288;5243.108671525926;5253.894922101613;5255.737213139404;5256.894862102813;5026.421961474477;5072.771725272298;5109.156989096906;5186.6369354144845;5196.662216955886;5087.720175390389;5105.770240339268;5126.7180305083575;5138.460461651623;5143.305653736697;4822.397200349957;4989.9251511228085;5044.747762611928;5115.207142892708;5161.354830646169;5134.9486505135965;5149.768260428365;5165.819196328111;5172;5213.478652134756;5033.320501732219;5035.647504674784;5039.47085556026;5042.596592272683;5093.668911520739 09:57:56 INFO - PROCESS | 3684 | |1;ext.html;574.2190620755772;594.4590422715327;597.9461848433641;603.1423216493201;604.5677340701397;29179.708202917966;31982.20044498886;43271.78364108179;44180.558194418045;44222.55777442225;41871.790641046755;42141.36787948183;42432.36351454731;42473.78763106188;42531.36202956951;7726.72956446523;7898.526088434713;7899.131095579482;7901.802454938644;7905.169957154502;7667.693292268331;7826.334761545247;7831.29518343349;7832.412569057315;7837.373010159202;7822.335101516378;7868.72459463916;7875.684972601089;7879.803004924894;7886.093099293597;7809.062912450514;7857.489263197874;7864.4888082274465;7864.882026769632;7871.8032049198655;7758.573278469682;7837.882431763528;7840.215978402114;7845;7847.195145116598;38345.80827095846;38668.22663546713;38700.225995480214;38766;38838;3134.420132275536;3228.677132286776;3371.814550199738;3533.4346504559403;3863.555691095504;29352.119436416942;29367.706322936923;29381.26546836325;29626.555601665994;30436.39127217443;3460.1349662584353;3475.270193259393;3505.141240396094;3522.964770352289;3611.1694310308512;235886;236652;236730;237823;238057.99999999825;31687.366252674816;32653.346933061683;52340.73829630828;52443.73778131161;52762;32722.836385818395;32757.34485310328;32786.18034549156;32794.67205327964;32836.67163328384;12544.74910501803;12626.621201363974;12636.305003224727;12658.303793291274;12665.49338026487;10143.746406339753;10177.694669159937;10212.897871021343;10215.080642742189;10220.131288840383;7858.724944627025;7870.370370370357;7897.091834438998;7933.682652693943;7990.04119505663;3012.457757603652;3076.523138913472;3098.194469437917;3104.689531046877;3112.2375018120706;863.8315528472014;892.054422312351;894.7136916186757;942.2885721280527;1059.4967390489455;27815.272842765724;28144.85927570349;28624;28748.712512875023;28853.422931541252;789.2935822438885;968.1093394077466;980.3284749946309;987.0770829274651;988.8961659025842;13996.32044154708;14678.779818302733;14746.852531474762;14864.331105100297;14956.850431495763;365375;367576;368416;369026;369523;49213.753931230116;50427;50436.24345634819;50438.74780626073;50561.24158137631;1085.1210519479089;1199.3943058755274;1199.550168686725;1214.4292182674128;1232.2483285196024;27622.861885690443;27986.580201297405;28504.429911402072;29093;29435;49013.509864900894;49061;49738.25392619186;49744;49768.75115624399;337192;337427;337720;337846;340795;32578.348433031682;37978;39105;39171.41242881302;41487.095903287685;42479.1504169921;42732.35901461419;43012.35481467718;43573;43622;35836;36738.448923265634;36774.63225367819;36990.63009369872;37219.44170837385;35076.29847402986;36001.27997440089;36504.26991460209;36709;37104.443433349064;36127.63872361243;36653.26693466169;36706.8164659175;37085.443718343704;37185.07037324089;32559.41081172398;32682.509762353107;33265.667343326255;33489.665103348656;33799.15502112467;25478;25558.23325300244;25767.484650307262;25974;26142.607860882483 09:57:56 INFO - PROCESS | 3684 | |2;jquery.html;356.3994668982765;357.09476477130477;361.1332801276937;368.3608938491718;380.7905651891459;15657.3737050518;16894.493165205033;17001.2349444275;17219.74170387442;17470.650586988268;16109.275082621281;16442.42451514197;17201.397951071714;17220.741688874677;17231;5044.495550444963;5210.192420174879;5216.139337009389;5235.345581802275;5250.501202385786;3753.2305877295225;3828.55971563271;5165.7158856262895;5732.5127364174095;6032.728527216286;6077.969610151943;6090.817275481721;6096.268447786249;6111.908321375183;6111.938880611181;5830.941690583103;6076.787312444066;6078.939210607881;6080.027195648697;6085.9391406085815;3414.23179784549;4966.950330496685;5226.346706661668;5249.921251181236;5274.077036518594;19799.80200197994;20630.27794027202;20637;20644.38066857997;20714.171433142656;1993.6710442776925;2114.06980928391;2246.629306164481;2552.515022145805;2555.8083143764106;12965.611031669065;13088.607341779762;13173.407196676173;13311.800322995163;13371.799423008662;1741.051127135714;1745.3629425259817;1750.2497502497502;1756.4116021132936;1837.660032893919;67342.33228659704;67551;67883;68490.9999999995;68834.65582672105;8913.242374398249;9015.008349081596;9248.16766491019;9320.8601870972;9342.346035777431;12396.81404778929;12403.379831008413;12415.379231038412;12424.627261182179;12467.563635272722;6942.409895158968;6980.162380514371;7064.964675176591;7088;7146.92853071473;6798.320167983162;6808.761693340709;6899.75850845218;6908.447324214051;6939.063226464363;5833.883322333614;5915.881682366415;5933.139694744238;6052.878942421127;6066.605670631483;1488.2930607961348;1597.27324067549;1629.3156874112901;1680.840320169582;1705.9744103838452;870.9520976346236;917.3257655623112;934.4019827310527;953.828310904044;1014.9188064954786;16752.916235418747;16779.91610041942;16856.578585535215;17203.483895483154;17211.62330443625;858.6479543387306;896.3367108339781;911.2026976395654;943.5376665433888;955.9187469065207;9464.810703785886;9671.177949874198;9723.805523889483;9930.453825039547;10053.346532475365;379858;389226;394605;396412;397187;41071.383929241085;54449;66678.66660666665;67092.66453667798;67397;917.1653795046476;917.8118485710413;930.851063829784;937.9249660027182;939.2157548447124;15044.097354158786;15179.620509487351;15281.159536225614;15372.846271537588;15566.688666226839;30675.693243067282;32174.83912580422;32517.999999999054;32906.341873162884;34030.149246268054;41791;45217;45307.773461132485;45352.77323613361;45639.087218256114;6910.101686780687;7002.719891204295;7137.500374973702;7193.496455248292;7200.351968322876;10657.840132398176;10755.247132700635;10779.51492182838;10916.454177291262;11080.501377437873;8770.868436973324;8899.644014239617;8962.32782541299;9207.631694732136;9421.528923553658;9338.579763910504;9415.764605884908;9426.858597121185;9521.666741664008;9572.425654460754;9313.25493960468;9390.577424016072;9412.15290623847;9608.519574021131;9745.512724363894;7051.858962820817;7153.570785752871;7155.534890232118;7162.677679504539;7170.354668079689;9074.45553266806;9075.228605568336;9129.315301352557;9176.6788162414;9264.583093760662 09:57:56 INFO - PROCESS | 3684 | |3;mootools.html;1304.9347532623367;1332.666833291677;1407.0010292692189;1412.315027211802;1696.7454881767742;6627.304133066025;7789.104253010905;8048.275655191032;8074.39442041847;8297.834043319144;7941.523508589475;8200.38497112716;8212.83574328513;8215.014198296198;8216.671333146682;1867.46777168507;2162.740471143465;2229.6209644360456;2234.8100411465043;2266.0935625749667;2287.736910255317;2301.689271948282;2302.5740238056014;2306.7116610423695;2312.09828167015;2241.316398498457;2244.5286489837154;2282.338121944634;2283.3264187064774;2288.896999635012;1820.6995845685447;2098.5068508900395;2155.795199456049;2162.4377661807885;2175.7389113306344;2158.6330323844986;2173.3262688566438;2175.445261458334;2175.4670105824016;2178.096090122597;8018.398620103458;8023.197680231989;8053.879191812069;8087.231712987315;8088.555129467877;4554.180247555439;4662.114198302312;4670.509596492388;4674.2053850845095;4676.392069031038;2867.225849020753;2911.3595009097967;3056.9082927511986;3081.815091094519;3094.4894092474715;975.2782940623958;977.9511024448749;994.3238597753525;1001.0940099210227;1013.893541178173;11159.38623375714;11160.776784464266;11162.162837787198;11168.385738784364;11176.27354221973;4109.794510274474;4202.915941681149;4251.829926802893;4268.658507319407;4303.419038429772;9454.95995440501;9459.668911588198;9474.242060635133;9499.952500237454;9513.381630194015;4662.137504561667;4667.813287468532;4668.906621867543;4669.276262179367;4671.229247174246;3513.8594456221977;4003.4395184674167;4149.937750933738;4154.626083652486;4195.748255104703;3739.85040598373;3749.4563288323584;3852.9229415411537;3867.6325749053794;3961.841526338972;1224.8836360545733;1227.6501197158946;1245.9190152640049;1248.3633346992917;1258.0688642933053;825.4510750351069;837.4389159263308;839.8740188971581;866.6749968761715;873.0309356614154;4904.950950490449;5146.661867914369;5204.609654275869;5208.661437006583;5262.605304602093;418.38497408809;427.4357847641084;429.0903285035744;430.5479246790857;430.86427775250695;3530.2233508628574;3606.2246616977477;3626.727995400303;3638.690711289517;3684.171061511192;9423.481708506099;9627;9738.853917191247;9741.512924353754;9745.171660408945;9651.420914745138;9654.565544550513;9655.324127311022;9657.32398732082;9670.854937175947;7237.421006319481;7305.598192099379;7442.66508007141;7444.478886478003;7450.627468626439;4881.170201065756;4999.625028122832;5003.299538064601;5046.949530504795;5062.746862656779;8749.906261717286;8801.603927823135;9072.455652660861;9118.179363857285;9130.680426185052;9110.681126160553;9196.494192819458;9207.355485115977;9212.723618291462;9326.020767819553;5837.503812176013;5983.072623743326;5986.341502434641;6778.525503214728;6864;6856.965715171592;7375.631218438949;7602.961985190039;7609.6575654094595;7839.568823714751;6885.1049363582415;6963.4777391694815;6986.126734158231;7066.505344626033;7107.147142342952;6688.632125233159;6764.4588432924265;6827.351401616838;6833.2483426824;6941.895871561829;6435.324290949383;6440.420362167428;6511;6588.374104460068;6589.604623722592;4639.8144074238;4653.744044077608;4686.507916668837;4695.295705644044;4754.833580824655;4536.228841097088;4579.221532339444;4590.288505281686;4605.83879564227;4613.746243956614 09:57:56 INFO - PROCESS | 3684 | |4;prototype.html;298.7714398485158;302.3605075265813;310.64741518376644;311.4565083928545;316.12275934282366;4816.20532612119;4850.393700787402;4876.487968763282;4901.509849015097;4914.640972333278;4541.182587134314;4786.664933454659;4791.377120974268;4793.832215872445;4797.592204662608;3725.9441108383394;3731.141837377398;3732.2535492901393;3751.261579047297;3755.4742336072973;3696.464012718154;3709.536307961505;3711.1278849470355;3715.792367480566;3744.5319335083113;3538.716902647782;3691.778493290411;3718.9442158367647;3733.3466643337442;3734.88795336139;3652.1782598915297;3666.9083272918124;3682.963170368289;3690.1697118148472;3695.2240029593954;3228.386606544749;3228.499582564706;3241.594800649919;3253.918652033718;3255.886043988473;4625.8149674013;4635.096156249533;4640.976795116037;4643.698159619614;4657;4122.175564887035;4210.978945105286;4221.704480686353;4230.534641189497;4262.445882035316;4988.6757360771435;4991.176455884774;4994.300797888299;5021.171506701427;5023.472535383768;3504.2816222674546;3521.1725244567506;3521.806300653463;3523.3305671922253;3543.5039094526787;4474.798634061475;4803.543663351976;5304.151335786256;5335.759890804923;5338.439463856278;3650.8682308484454;3656.104254457675;3660.084978755311;3667.8166091695307;3669.834857431422;3725.3294407006997;3730.6082861299174;3737.8691745788765;3738.3084129436143;3743.8689645862264;4041.0907545802547;4129.8967525812095;4239.427677263591;4241.809118589671;4308.827646894089;5034.144195486776;5045.596352291808;5050.116229659795;5053.722045287471;5056.873578160502;1240.1566934484638;1244.1710685292605;1244.8630650628425;1250.8936740376987;1255.7551277500982;793.2820797178447;814.9511029338258;830.9281027474611;836.4730219961507;836.7531578184451;4042.4946881639794;4064.9390259146135;4076.979615101965;4078.938815917764;4105.651019663362;4590.265557510782;4606.470255920545;4644.698094623906;4655.4878963314;4682.812687492462;4077.8193009452675;4079.5104587449696;4085.162541678949;4102.2821006323775;4116.938245926313;2513.341194811452;2577.3685447065213;2751.2709132080013;2753.20157154423;2764.2951047483166;4883.169861123618;4900.656954013256;4916.188828843272;4917.680350777188;4929.728864912464;5074.23886417033;5282.947170528246;5304.283921670525;5337.279467271868;5342.358916929916;4494.865154045384;4864.246041863516;4881.194602890554;4975.900481990412;4987.825426110068;5228.477152284741;5269.104252277046;5280.155175171954;5282.8943421132135;5286;4948.851534453972;5170.224466330081;5180.953523358327;5182.585393168612;5185.688858668492;4879.146149423907;4922.803087876445;4939.777710002986;4942.233953737176;4979.232372507708;3750.381187104206;3752.080740218664;3786.848526058927;3795.127120762185;3838;5270.209468579744;5293.523582877559;5304.753382955079;5305.143199880165;5321.680699158062;4788.545088216614;5013.899722005466;5036.219385995177;5047.671901326402;5091.905240373338;5009.974950125226;5022.961108529434;5028.572571331331;5076.619253555924;5117.948820511747;4854.902901942012;5000.374953130859;5014.52362025607;5019.84940451787;5021.221710634857;5039.193729003342;5051.722155281494;5053.823116190915;5079.492050795039;5085.237214417867;4917.778699958582;4930.950690493192;4948.455669876383;4970.931249781314;5016.749162541785 09:57:56 INFO - PROCESS | 3684 | |5;yui.html;743.2715938380387;751.2562563062563;751.9774406767799;757.2162811490109;781.5701364249661;14071.296435178252;14467.421303147874;14475.276236188201;14867.10797352157;15022.399104035825;14297.78553321701;14321.283935803194;14338.354774035168;14406.495772647959;14422.062565933207;629.6945981199115;807.5154907055763;815.0667485728867;815.4658698552428;815.514768712615;799.0172088331356;827.5986146718836;830.2361827119065;831.4055450352996;831.4429332347312;857.5969294431607;859.2224037246302;861.8060936289347;862.0948004595182;863.2791618998144;657.1260223902246;817.1420008990536;857.9785505362354;858.1804376820153;858.2833334165979;620.2340109964191;622.844288927768;622.9408206220402;623.2738859228992;623.8253289079065;12749.17130386522;12784;12809.743805123846;12820;12824.422900969479;11779.88220117805;12029.917307442372;12071.818922716166;12228.877711222864;12421.068419868547;11637.592684256011;11639.825402618968;11675.29948203102;11709.707257318636;11760.235584686969;3943.940840887389;4022.1754540319166;4039.4748682671357;4048.838046478137;4094.324436467979;51573.96852062938;51848;51855.222171667454;51944;51958;9558.665446709332;10056.949715251378;10247.436390998566;10250.487475626189;10253.128484078938;16957.406490772762;16980;17050.31798728037;17925.46223613294;17969.910150449425;6164.845878852975;6181.227346581677;6513.446357059703;6552.410283074546;6595.967020164869;3745.7377983541437;3765.3975363941636;3770.7171962102952;3777.0934975605655;3803.581606023335;2666.7599916007266;2752.477029364414;2752.573351130578;2753.0777189641294;2753.5869619556825;496.54318027414865;500.50700060440437;507.19609419071185;511.19997204375034;515.5746509129983;503.4713550771675;516.6460974232663;522.0524747583124;524.1194792748144;527.2355085126505;6584.995403493283;6619.768308109289;6829.965850170816;6831.521793474409;7017.61403122823;470.4002396943924;477.6369958831313;525.7397588193869;554.9345257106365;572.3189404608503;3368.7305015598695;3564.6613571710645;3605.7295702822394;3607.7294202934886;3638.7634803737674;52550;53839.461605384226;54814.72592637011;54883.17675234874;55101.72449137809;47650.5234947653;48497;48589.271160932614;49337.259941100914;49542.50457495379;45539.861503462016;45949;46431.98192117569;46661.30008049882;46891.531084688715;6726.6636668167375;6757.45940324763;6893.931060689329;6894.1147194226705;6974.651267436507;31770;31894.202644933135;32163.35673286568;32419.675803242608;32735.67264327326;41260.58739412567;41262.38106428466;41794.79102604467;41921;41995.58004420039;8887.73336799897;9057.592408341508;9147.0852914708;9250.583723732583;9434.339596228197;9315.953420233127;9963;10059.647912323033;10232.59069637206;10506.21203409732;8611.181937715906;8946.194842464209;9019.233365164035;9220.44677319363;9276.397034192756;9324.300677449353;9417.623295068395;9434.150926416656;9567.186789123003;9763.707088787347;8750.124987501198;8797.340199485192;8826.955865220632;8927.419717718327;9034.27725781949;7701.6534255957495;7927.960360198162;8103.797405064921;8496.660133594587;8557.272631826365;7903.725474620737;7944;7963.641636126273;8152.633131509215;8188.631511582113 09:57:56 INFO - PROCESS | 3684 | __end_tp_report 09:57:56 INFO - PROCESS | 3684 | __start_cc_report 09:57:56 INFO - PROCESS | 3684 | _x_x_mozilla_cycle_collect,880 09:57:56 INFO - PROCESS | 3684 | __end_cc_report 09:57:56 INFO - PROCESS | 3684 | __startTimestamp1464281876137__endTimestamp 09:57:56 INFO - PROCESS | 3684 | 09:57:56 INFO - PROCESS | 3684 | ------- Summary: start ------- 09:57:56 INFO - PROCESS | 3684 | Number of tests: 6 09:57:56 INFO - PROCESS | 3684 | 09:57:56 INFO - PROCESS | 3684 | [#0] dojo.html Cycles:165 Average:4835.19 Median:4971.20 stddev:518.82 (10.4%) stddev-sans-first:492.50 09:57:56 INFO - PROCESS | 3684 | Values: 2695.2 2711.1 2736.0 2737.8 2771.7 4693.3 4775.8 4785.4 4878.7 4912.0 4754.9 4816.7 4817.3 4818.9 4845.0 4419.5 4483.7 4514.0 4528.3 4568.9 4460.7 4502.2 4518.3 4523.5 4551.0 4328.2 4368.2 4395.1 4410.1 4411.4 4433.0 4447.7 4455.3 4510.8 4511.0 4461.2 4485.7 4486.4 4531.2 4536.1 4674.4 4734.7 4776.0 4798.3 4806.4 5284.4 5299.0 5303.8 5304.0 5308.6 5296.2 5317.8 5332.3 5334.1 5338.3 4757.7 4895.1 4973.4 4979.9 4982.1 5427.6 5468.8 5469.6 5471.6 5473.5 5218.8 5234.7 5237.3 5240.8 5244.0 5106.2 5192.8 5232.0 5251.8 5254.4 5230.5 5251.0 5261.8 5263.6 5267.2 5171.3 5198.5 5212.4 5214.4 5233.7 4337.4 4381.8 4382.9 4384.4 4440.8 3900.3 3947.9 3948.3 3950.2 3952.8 4467.2 4479.9 4513.8 4530.2 4538.4 5273.8 5283.2 5288.7 5297.8 5348.1 4392.3 4530.4 4536.5 4538.8 4577.3 4612.6 4710.9 4727.4 4743.0 4748.8 4866.9 4877.4 4881.1 4888.3 4925.4 5038.7 5172.4 5173.1 5232.7 5273.5 4825.5 4829.7 4883.4 4888.3 4971.2 5169.2 5174.2 5174.7 5177.5 5222.7 5060.4 5243.1 5253.9 5255.7 5256.9 5026.4 5072.8 5109.2 5186.6 5196.7 5087.7 5105.8 5126.7 5138.5 5143.3 4822.4 4989.9 5044.7 5115.2 5161.4 5134.9 5149.8 5165.8 5172.0 5213.5 5033.3 5035.6 5039.5 5042.6 5093.7 09:57:56 INFO - PROCESS | 3684 | 09:57:56 INFO - PROCESS | 3684 | [#1] ext.html Cycles:180 Average:46507.39 Median:202175.32 stddev:84151.59 (41.6%) stddev-sans-first:84316.99 09:57:56 INFO - PROCESS | 3684 | Values: 574.2 594.5 597.9 603.1 604.6 29179.7 31982.2 43271.8 44180.6 44222.6 41871.8 42141.4 42432.4 42473.8 42531.4 7726.7 7898.5 7899.1 7901.8 7905.2 7667.7 7826.3 7831.3 7832.4 7837.4 7822.3 7868.7 7875.7 7879.8 7886.1 7809.1 7857.5 7864.5 7864.9 7871.8 7758.6 7837.9 7840.2 7845.0 7847.2 38345.8 38668.2 38700.2 38766.0 38838.0 3134.4 3228.7 3371.8 3533.4 3863.6 29352.1 29367.7 29381.3 29626.6 30436.4 3460.1 3475.3 3505.1 3523.0 3611.2 235886.0 236652.0 236730.0 237823.0 238058.0 31687.4 32653.3 52340.7 52443.7 52762.0 32722.8 32757.3 32786.2 32794.7 32836.7 12544.7 12626.6 12636.3 12658.3 12665.5 10143.7 10177.7 10212.9 10215.1 10220.1 7858.7 7870.4 7897.1 7933.7 7990.0 3012.5 3076.5 3098.2 3104.7 3112.2 863.8 892.1 894.7 942.3 1059.5 27815.3 28144.9 28624.0 28748.7 28853.4 789.3 968.1 980.3 987.1 988.9 13996.3 14678.8 14746.9 14864.3 14956.9 365375.0 367576.0 368416.0 369026.0 369523.0 49213.8 50427.0 50436.2 50438.7 50561.2 1085.1 1199.4 1199.6 1214.4 1232.2 27622.9 27986.6 28504.4 29093.0 29435.0 49013.5 49061.0 49738.3 49744.0 49768.8 337192.0 337427.0 337720.0 337846.0 340795.0 32578.3 37978.0 39105.0 39171.4 41487.1 42479.2 42732.4 43012.4 43573.0 43622.0 35836.0 36738.4 36774.6 36990.6 37219.4 35076.3 36001.3 36504.3 36709.0 37104.4 36127.6 36653.3 36706.8 37085.4 37185.1 32559.4 32682.5 33265.7 33489.7 33799.2 25478.0 25558.2 25767.5 25974.0 26142.6 09:57:56 INFO - PROCESS | 3684 | 09:57:56 INFO - PROCESS | 3684 | [#2] jquery.html Cycles:180 Average:23468.40 Median:29861.54 stddev:64217.72 (215.1%) stddev-sans-first:64374.42 09:57:56 INFO - PROCESS | 3684 | Values: 356.4 357.1 361.1 368.4 380.8 15657.4 16894.5 17001.2 17219.7 17470.7 16109.3 16442.4 17201.4 17220.7 17231.0 5044.5 5210.2 5216.1 5235.3 5250.5 3753.2 3828.6 5165.7 5732.5 6032.7 6078.0 6090.8 6096.3 6111.9 6111.9 5830.9 6076.8 6078.9 6080.0 6085.9 3414.2 4967.0 5226.3 5249.9 5274.1 19799.8 20630.3 20637.0 20644.4 20714.2 1993.7 2114.1 2246.6 2552.5 2555.8 12965.6 13088.6 13173.4 13311.8 13371.8 1741.1 1745.4 1750.2 1756.4 1837.7 67342.3 67551.0 67883.0 68491.0 68834.7 8913.2 9015.0 9248.2 9320.9 9342.3 12396.8 12403.4 12415.4 12424.6 12467.6 6942.4 6980.2 7065.0 7088.0 7146.9 6798.3 6808.8 6899.8 6908.4 6939.1 5833.9 5915.9 5933.1 6052.9 6066.6 1488.3 1597.3 1629.3 1680.8 1706.0 871.0 917.3 934.4 953.8 1014.9 16752.9 16779.9 16856.6 17203.5 17211.6 858.6 896.3 911.2 943.5 955.9 9464.8 9671.2 9723.8 9930.5 10053.3 379858.0 389226.0 394605.0 396412.0 397187.0 41071.4 54449.0 66678.7 67092.7 67397.0 917.2 917.8 930.9 937.9 939.2 15044.1 15179.6 15281.2 15372.8 15566.7 30675.7 32174.8 32518.0 32906.3 34030.1 41791.0 45217.0 45307.8 45352.8 45639.1 6910.1 7002.7 7137.5 7193.5 7200.4 10657.8 10755.2 10779.5 10916.5 11080.5 8770.9 8899.6 8962.3 9207.6 9421.5 9338.6 9415.8 9426.9 9521.7 9572.4 9313.3 9390.6 9412.2 9608.5 9745.5 7051.9 7153.6 7155.5 7162.7 7170.4 9074.5 9075.2 9129.3 9176.7 9264.6 09:57:56 INFO - PROCESS | 3684 | 09:57:56 INFO - PROCESS | 3684 | [#3] mootools.html Cycles:180 Average:5191.79 Median:4725.06 stddev:2962.79 (62.7%) stddev-sans-first:2956.70 09:57:56 INFO - PROCESS | 3684 | Values: 1304.9 1332.7 1407.0 1412.3 1696.7 6627.3 7789.1 8048.3 8074.4 8297.8 7941.5 8200.4 8212.8 8215.0 8216.7 1867.5 2162.7 2229.6 2234.8 2266.1 2287.7 2301.7 2302.6 2306.7 2312.1 2241.3 2244.5 2282.3 2283.3 2288.9 1820.7 2098.5 2155.8 2162.4 2175.7 2158.6 2173.3 2175.4 2175.5 2178.1 8018.4 8023.2 8053.9 8087.2 8088.6 4554.2 4662.1 4670.5 4674.2 4676.4 2867.2 2911.4 3056.9 3081.8 3094.5 975.3 978.0 994.3 1001.1 1013.9 11159.4 11160.8 11162.2 11168.4 11176.3 4109.8 4202.9 4251.8 4268.7 4303.4 9455.0 9459.7 9474.2 9500.0 9513.4 4662.1 4667.8 4668.9 4669.3 4671.2 3513.9 4003.4 4149.9 4154.6 4195.7 3739.9 3749.5 3852.9 3867.6 3961.8 1224.9 1227.7 1245.9 1248.4 1258.1 825.5 837.4 839.9 866.7 873.0 4905.0 5146.7 5204.6 5208.7 5262.6 418.4 427.4 429.1 430.5 430.9 3530.2 3606.2 3626.7 3638.7 3684.2 9423.5 9627.0 9738.9 9741.5 9745.2 9651.4 9654.6 9655.3 9657.3 9670.9 7237.4 7305.6 7442.7 7444.5 7450.6 4881.2 4999.6 5003.3 5046.9 5062.7 8749.9 8801.6 9072.5 9118.2 9130.7 9110.7 9196.5 9207.4 9212.7 9326.0 5837.5 5983.1 5986.3 6778.5 6864.0 6857.0 7375.6 7603.0 7609.7 7839.6 6885.1 6963.5 6986.1 7066.5 7107.1 6688.6 6764.5 6827.4 6833.2 6941.9 6435.3 6440.4 6511.0 6588.4 6589.6 4639.8 4653.7 4686.5 4695.3 4754.8 4536.2 4579.2 4590.3 4605.8 4613.7 09:57:56 INFO - PROCESS | 3684 | 09:57:56 INFO - PROCESS | 3684 | [#4] prototype.html Cycles:180 Average:4140.91 Median:4656.24 stddev:1218.05 (26.2%) stddev-sans-first:1186.84 09:57:56 INFO - PROCESS | 3684 | Values: 298.8 302.4 310.6 311.5 316.1 4816.2 4850.4 4876.5 4901.5 4914.6 4541.2 4786.7 4791.4 4793.8 4797.6 3725.9 3731.1 3732.3 3751.3 3755.5 3696.5 3709.5 3711.1 3715.8 3744.5 3538.7 3691.8 3718.9 3733.3 3734.9 3652.2 3666.9 3683.0 3690.2 3695.2 3228.4 3228.5 3241.6 3253.9 3255.9 4625.8 4635.1 4641.0 4643.7 4657.0 4122.2 4211.0 4221.7 4230.5 4262.4 4988.7 4991.2 4994.3 5021.2 5023.5 3504.3 3521.2 3521.8 3523.3 3543.5 4474.8 4803.5 5304.2 5335.8 5338.4 3650.9 3656.1 3660.1 3667.8 3669.8 3725.3 3730.6 3737.9 3738.3 3743.9 4041.1 4129.9 4239.4 4241.8 4308.8 5034.1 5045.6 5050.1 5053.7 5056.9 1240.2 1244.2 1244.9 1250.9 1255.8 793.3 815.0 830.9 836.5 836.8 4042.5 4064.9 4077.0 4078.9 4105.7 4590.3 4606.5 4644.7 4655.5 4682.8 4077.8 4079.5 4085.2 4102.3 4116.9 2513.3 2577.4 2751.3 2753.2 2764.3 4883.2 4900.7 4916.2 4917.7 4929.7 5074.2 5282.9 5304.3 5337.3 5342.4 4494.9 4864.2 4881.2 4975.9 4987.8 5228.5 5269.1 5280.2 5282.9 5286.0 4948.9 5170.2 5181.0 5182.6 5185.7 4879.1 4922.8 4939.8 4942.2 4979.2 3750.4 3752.1 3786.8 3795.1 3838.0 5270.2 5293.5 5304.8 5305.1 5321.7 4788.5 5013.9 5036.2 5047.7 5091.9 5010.0 5023.0 5028.6 5076.6 5117.9 4854.9 5000.4 5014.5 5019.8 5021.2 5039.2 5051.7 5053.8 5079.5 5085.2 4917.8 4931.0 4948.5 4970.9 5016.7 09:57:56 INFO - PROCESS | 3684 | 09:57:56 INFO - PROCESS | 3684 | [#5] yui.html Cycles:180 Average:13082.56 Median:26240.03 stddev:15661.76 (59.7%) stddev-sans-first:15678.29 09:57:56 INFO - PROCESS | 3684 | Values: 743.3 751.3 752.0 757.2 781.6 14071.3 14467.4 14475.3 14867.1 15022.4 14297.8 14321.3 14338.4 14406.5 14422.1 629.7 807.5 815.1 815.5 815.5 799.0 827.6 830.2 831.4 831.4 857.6 859.2 861.8 862.1 863.3 657.1 817.1 858.0 858.2 858.3 620.2 622.8 622.9 623.3 623.8 12749.2 12784.0 12809.7 12820.0 12824.4 11779.9 12029.9 12071.8 12228.9 12421.1 11637.6 11639.8 11675.3 11709.7 11760.2 3943.9 4022.2 4039.5 4048.8 4094.3 51574.0 51848.0 51855.2 51944.0 51958.0 9558.7 10056.9 10247.4 10250.5 10253.1 16957.4 16980.0 17050.3 17925.5 17969.9 6164.8 6181.2 6513.4 6552.4 6596.0 3745.7 3765.4 3770.7 3777.1 3803.6 2666.8 2752.5 2752.6 2753.1 2753.6 496.5 500.5 507.2 511.2 515.6 503.5 516.6 522.1 524.1 527.2 6585.0 6619.8 6830.0 6831.5 7017.6 470.4 477.6 525.7 554.9 572.3 3368.7 3564.7 3605.7 3607.7 3638.8 52550.0 53839.5 54814.7 54883.2 55101.7 47650.5 48497.0 48589.3 49337.3 49542.5 45539.9 45949.0 46432.0 46661.3 46891.5 6726.7 6757.5 6893.9 6894.1 6974.7 31770.0 31894.2 32163.4 32419.7 32735.7 41260.6 41262.4 41794.8 41921.0 41995.6 8887.7 9057.6 9147.1 9250.6 9434.3 9316.0 9963.0 10059.6 10232.6 10506.2 8611.2 8946.2 9019.2 9220.4 9276.4 9324.3 9417.6 9434.2 9567.2 9763.7 8750.1 8797.3 8827.0 8927.4 9034.3 7701.7 7928.0 8103.8 8496.7 8557.3 7903.7 7944.0 7963.6 8152.6 8188.6 09:57:56 INFO - PROCESS | 3684 | -------- Summary: end -------- 09:57:56 INFO - PROCESS | 3684 | 09:57:56 INFO - TEST-INFO | 3684: exit 0 09:57:56 INFO - TEST-OK | dromaeo_css | took 1118688ms 09:57:56 INFO - TEST-START | kraken 09:57:56 INFO - operating with platform_type : linux_ 09:57:56 INFO - Initialising browser for kraken test... 09:57:56 INFO - TEST-INFO | started process 3859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEreDzg/profile http://localhost:40142/getInfo.html) 09:58:01 INFO - PROCESS | 3859 | __metrics Screen width/height:1600/1200 09:58:01 INFO - PROCESS | 3859 | colorDepth:24 09:58:01 INFO - PROCESS | 3859 | Browser inner width/height: 1024/697 09:58:01 INFO - PROCESS | 3859 | __metrics 09:58:02 ERROR - PROCESS | 3859 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:58:02 INFO - TEST-INFO | 3859: exit 0 09:58:02 INFO - Browser initialized. 09:58:02 INFO - Running cycle 1/1 for kraken test... 09:58:03 INFO - TEST-INFO | started process 3937 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEreDzg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:14 INFO - PROCESS | 3937 | RSS: Main: 156532736 09:58:14 INFO - PROCESS | 3937 | 09:58:17 INFO - PROCESS | 3937 | Cycle 1(1): loaded http://localhost:40142/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40142/tests/kraken/driver.html?testName=audio-beat-detection) 09:58:18 INFO - PROCESS | 3937 | RSS: Main: 212381696 09:58:18 INFO - PROCESS | 3937 | 09:58:21 INFO - PROCESS | 3937 | Cycle 1(1): loaded http://localhost:40142/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40142/tests/kraken/driver.html?testName=audio-dft) 09:58:21 INFO - PROCESS | 3937 | RSS: Main: 200679424 09:58:21 INFO - PROCESS | 3937 | 09:58:25 INFO - PROCESS | 3937 | Cycle 1(1): loaded http://localhost:40142/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40142/tests/kraken/driver.html?testName=audio-fft) 09:58:25 INFO - PROCESS | 3937 | RSS: Main: 269426688 09:58:25 INFO - PROCESS | 3937 | 09:58:27 INFO - PROCESS | 3937 | Cycle 1(1): loaded http://localhost:40142/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40142/tests/kraken/driver.html?testName=audio-oscillator) 09:58:28 INFO - PROCESS | 3937 | RSS: Main: 178053120 09:58:28 INFO - PROCESS | 3937 | 09:58:30 INFO - PROCESS | 3937 | Cycle 1(1): loaded http://localhost:40142/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40142/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:58:31 INFO - PROCESS | 3937 | RSS: Main: 182726656 09:58:31 INFO - PROCESS | 3937 | 09:58:34 INFO - PROCESS | 3937 | Cycle 1(1): loaded http://localhost:40142/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40142/tests/kraken/driver.html?testName=imaging-darkroom) 09:58:35 INFO - PROCESS | 3937 | RSS: Main: 218517504 09:58:35 INFO - PROCESS | 3937 | 09:58:38 INFO - PROCESS | 3937 | Cycle 1(1): loaded http://localhost:40142/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40142/tests/kraken/driver.html?testName=imaging-desaturate) 09:58:39 INFO - PROCESS | 3937 | RSS: Main: 216211456 09:58:39 INFO - PROCESS | 3937 | 09:58:42 INFO - PROCESS | 3937 | Cycle 1(1): loaded http://localhost:40142/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40142/tests/kraken/driver.html?testName=json-parse-financial) 09:58:42 INFO - PROCESS | 3937 | RSS: Main: 217038848 09:58:42 INFO - PROCESS | 3937 | 09:58:44 INFO - PROCESS | 3937 | Cycle 1(1): loaded http://localhost:40142/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40142/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:58:44 INFO - PROCESS | 3937 | RSS: Main: 204374016 09:58:44 INFO - PROCESS | 3937 | 09:58:46 INFO - PROCESS | 3937 | Cycle 1(1): loaded http://localhost:40142/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40142/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:58:47 INFO - PROCESS | 3937 | RSS: Main: 209035264 09:58:47 INFO - PROCESS | 3937 | 09:58:49 INFO - PROCESS | 3937 | Cycle 1(1): loaded http://localhost:40142/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40142/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:58:50 INFO - PROCESS | 3937 | RSS: Main: 218959872 09:58:50 INFO - PROCESS | 3937 | 09:58:53 INFO - PROCESS | 3937 | Cycle 1(1): loaded http://localhost:40142/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:58:53 INFO - PROCESS | 3937 | RSS: Main: 228343808 09:58:53 INFO - PROCESS | 3937 | 09:58:56 INFO - PROCESS | 3937 | Cycle 1(1): loaded http://localhost:40142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:58:57 INFO - PROCESS | 3937 | RSS: Main: 224956416 09:58:57 INFO - PROCESS | 3937 | 09:58:58 INFO - PROCESS | 3937 | Cycle 1(1): loaded http://localhost:40142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40142/tests/kraken/driver.html?testName=ai-astar) 09:58:59 INFO - PROCESS | 3937 | RSS: Main: 270905344 09:58:59 INFO - PROCESS | 3937 | 09:58:59 INFO - PROCESS | 3937 | __start_tp_report 09:58:59 INFO - PROCESS | 3937 | _x_x_mozilla_page_load 09:58:59 INFO - PROCESS | 3937 | _x_x_mozilla_page_load_details 09:58:59 INFO - PROCESS | 3937 | |i|pagename|runs| 09:58:59 INFO - PROCESS | 3937 | |0;ai-astar;113;106;112;113;112;114;112;113;112;114 09:58:59 INFO - PROCESS | 3937 | |1;audio-beat-detection;162;130;133;188;128;130;153;135;186;135 09:58:59 INFO - PROCESS | 3937 | |2;audio-dft;160;159;159;162;161;161;164;161;162;163 09:58:59 INFO - PROCESS | 3937 | |3;audio-fft;75;75;75;110;75;76;76;75;110;76 09:58:59 INFO - PROCESS | 3937 | |4;audio-oscillator;85;84;123;84;84;84;124;84;84;118 09:58:59 INFO - PROCESS | 3937 | |5;imaging-gaussian-blur;116;116;117;117;120;117;116;117;116;117 09:58:59 INFO - PROCESS | 3937 | |6;imaging-darkroom;147;147;146;146;147;146;147;147;146;146 09:58:59 INFO - PROCESS | 3937 | |7;imaging-desaturate;94;95;94;95;96;95;95;95;95;96 09:58:59 INFO - PROCESS | 3937 | |8;json-parse-financial;64;63;64;64;63;64;64;81;63;61 09:58:59 INFO - PROCESS | 3937 | |9;json-stringify-tinderbox;64;69;64;64;64;63;64;70;65;65 09:58:59 INFO - PROCESS | 3937 | |10;stanford-crypto-aes;85;89;82;82;83;88;84;90;84;83 09:58:59 INFO - PROCESS | 3937 | |11;stanford-crypto-ccm;131;130;129;138;127;132;136;139;171;133 09:58:59 INFO - PROCESS | 3937 | |12;stanford-crypto-pbkdf2;174;171;167;168;169;169;167;171;168;174 09:58:59 INFO - PROCESS | 3937 | |13;stanford-crypto-sha256-iterative;71;71;67;67;66;66;67;64;66;65 09:58:59 INFO - PROCESS | 3937 | __end_tp_report 09:58:59 INFO - PROCESS | 3937 | __start_cc_report 09:58:59 INFO - PROCESS | 3937 | _x_x_mozilla_cycle_collect,1878 09:58:59 INFO - PROCESS | 3937 | __end_cc_report 09:58:59 INFO - PROCESS | 3937 | __startTimestamp1464281939163__endTimestamp 09:58:59 INFO - PROCESS | 3937 | 09:58:59 INFO - PROCESS | 3937 | ------- Summary: start ------- 09:58:59 INFO - PROCESS | 3937 | Number of tests: 14 09:58:59 INFO - PROCESS | 3937 | 09:58:59 INFO - PROCESS | 3937 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:2.28 (2.0%) stddev-sans-first:2.40 09:58:59 INFO - PROCESS | 3937 | Values: 113.0 106.0 112.0 113.0 112.0 114.0 112.0 113.0 112.0 114.0 09:58:59 INFO - PROCESS | 3937 | 09:58:59 INFO - PROCESS | 3937 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:144.00 stddev:23.28 (16.2%) stddev-sans-first:24.13 09:58:59 INFO - PROCESS | 3937 | Values: 162.0 130.0 133.0 188.0 128.0 130.0 153.0 135.0 186.0 135.0 09:58:59 INFO - PROCESS | 3937 | 09:58:59 INFO - PROCESS | 3937 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.62 (1.0%) stddev-sans-first:1.66 09:58:59 INFO - PROCESS | 3937 | Values: 160.0 159.0 159.0 162.0 161.0 161.0 164.0 161.0 162.0 163.0 09:58:59 INFO - PROCESS | 3937 | 09:58:59 INFO - PROCESS | 3937 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.00 stddev:14.61 (19.5%) stddev-sans-first:15.25 09:58:59 INFO - PROCESS | 3937 | Values: 75.0 75.0 75.0 110.0 75.0 76.0 76.0 75.0 110.0 76.0 09:58:59 INFO - PROCESS | 3937 | 09:58:59 INFO - PROCESS | 3937 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:84.00 stddev:18.19 (21.7%) stddev-sans-first:18.90 09:58:59 INFO - PROCESS | 3937 | Values: 85.0 84.0 123.0 84.0 84.0 84.0 124.0 84.0 84.0 118.0 09:58:59 INFO - PROCESS | 3937 | 09:58:59 INFO - PROCESS | 3937 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:1.20 (1.0%) stddev-sans-first:1.22 09:58:59 INFO - PROCESS | 3937 | Values: 116.0 116.0 117.0 117.0 120.0 117.0 116.0 117.0 116.0 117.0 09:58:59 INFO - PROCESS | 3937 | 09:58:59 INFO - PROCESS | 3937 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 09:58:59 INFO - PROCESS | 3937 | Values: 147.0 147.0 146.0 146.0 147.0 146.0 147.0 147.0 146.0 146.0 09:58:59 INFO - PROCESS | 3937 | 09:58:59 INFO - PROCESS | 3937 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 09:58:59 INFO - PROCESS | 3937 | Values: 94.0 95.0 94.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 09:58:59 INFO - PROCESS | 3937 | 09:58:59 INFO - PROCESS | 3937 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:64.00 stddev:5.67 (8.9%) stddev-sans-first:6.00 09:58:59 INFO - PROCESS | 3937 | Values: 64.0 63.0 64.0 64.0 63.0 64.0 64.0 81.0 63.0 61.0 09:58:59 INFO - PROCESS | 3937 | 09:58:59 INFO - PROCESS | 3937 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:64.50 stddev:2.35 (3.6%) stddev-sans-first:2.45 09:58:59 INFO - PROCESS | 3937 | Values: 64.0 69.0 64.0 64.0 64.0 63.0 64.0 70.0 65.0 65.0 09:58:59 INFO - PROCESS | 3937 | 09:58:59 INFO - PROCESS | 3937 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.50 stddev:2.94 (3.5%) stddev-sans-first:3.12 09:58:59 INFO - PROCESS | 3937 | Values: 85.0 89.0 82.0 82.0 83.0 88.0 84.0 90.0 84.0 83.0 09:58:59 INFO - PROCESS | 3937 | 09:58:59 INFO - PROCESS | 3937 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:134.50 stddev:12.69 (9.4%) stddev-sans-first:13.30 09:58:59 INFO - PROCESS | 3937 | Values: 131.0 130.0 129.0 138.0 127.0 132.0 136.0 139.0 171.0 133.0 09:58:59 INFO - PROCESS | 3937 | 09:58:59 INFO - PROCESS | 3937 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:170.00 stddev:2.62 (1.5%) stddev-sans-first:2.29 09:58:59 INFO - PROCESS | 3937 | Values: 174.0 171.0 167.0 168.0 169.0 169.0 167.0 171.0 168.0 174.0 09:58:59 INFO - PROCESS | 3937 | 09:58:59 INFO - PROCESS | 3937 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:2.31 (3.4%) stddev-sans-first:1.94 09:58:59 INFO - PROCESS | 3937 | Values: 71.0 71.0 67.0 67.0 66.0 66.0 67.0 64.0 66.0 65.0 09:58:59 INFO - PROCESS | 3937 | -------- Summary: end -------- 09:58:59 INFO - PROCESS | 3937 | 09:59:00 INFO - TEST-INFO | 3937: exit 0 09:59:00 INFO - TEST-OK | kraken | took 63290ms 09:59:00 INFO - SUITE-END | took 1181s 09:59:00 INFO - Completed test suite (00:19:42) 09:59:00 INFO - javascript benchmark 09:59:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2695.2318589202077, 2711.1324376199623, 2736.0423851651917, 2737.7672897803686, 2771.6951135375116, 4693.272542755878, 4775.832845850396, 4785.449673287569, 4878.658493905428, 4911.993041426508, 4754.9286760698615, 4816.710997340162, 4817.277408388743, 4818.855434336975, 4845.0, 4419.49175844778, 4483.730976141425, 4513.954860451403, 4528.343390208418, 4568.908621827562, 4460.732356058631, 4502.167099086663, 4518.277075667894, 4523.525029871866, 4551.0, 4328.177646247234, 4368.213721530124, 4395.055063161436, 4410.051838854662, 4411.404460397837, 4433.024734558392, 4447.688661793676, 4455.309427038814, 4510.8421205257655, 4510.977445112786, 4461.241588929857, 4485.663575231871, 4486.394336764528, 4531.161735078988, 4536.138133754576, 4674.415698037746, 4734.668573199878, 4775.976120119377, 4798.304245884327, 4806.423229212517, 5284.4187139414635, 5299.046171689094, 5303.814366497193, 5303.973480132613, 5308.601854860863, 5296.205569164617, 5317.760700768475, 5332.33345831771, 5334.146536554172, 5338.332708411449, 4757.666963312569, 4895.143349913822, 4973.378327709036, 4979.850604481871, 4982.128127577659, 5427.565794736412, 5468.808591699271, 5469.644473109235, 5471.616986810965, 5473.507384335349, 5218.843434696965, 5234.685918844805, 5237.319148510669, 5240.764165612557, 5244.0, 5106.234064890222, 5192.844214673566, 5232.0, 5251.8161864335325, 5254.369475662945, 5230.503102205284, 5251.0, 5261.789528418897, 5263.578913686896, 5267.209918512177, 5171.3277273954145, 5198.532132108053, 5212.40057393397, 5214.374275087014, 5233.738313084331, 4337.392765012901, 4381.78091095444, 4382.868513944587, 4384.364267181305, 4440.822367105344, 3900.258950799339, 3947.9013024674614, 3948.3485224937563, 3950.229705207457, 3952.782596957195, 4467.173572889026, 4479.888002799956, 4513.842015529441, 4530.207213737583, 4538.364628951949, 5273.815416460406, 5283.1546952487415, 5288.65623734456, 5297.761600727977, 5348.090824559834, 4392.275274579659, 4530.365748795171, 4536.455625324916, 4538.773061346919, 4577.3362862384765, 4612.561806628365, 4710.905781884343, 4727.4327080749845, 4742.952570474251, 4748.833790817304, 4866.902661946741, 4877.439094504178, 4881.072596206709, 4888.340074089952, 4925.4335751388335, 5038.722870242025, 5172.405173405106, 5173.0688476074665, 5232.712200828991, 5273.472652734696, 4825.541573550507, 4829.710217386968, 4883.3651625288485, 4888.340074089952, 4971.204607262821, 5169.198774190007, 5174.249733788655, 5174.663646862942, 5177.508136727005, 5222.712750798591, 5060.443351231288, 5243.108671525926, 5253.894922101613, 5255.737213139404, 5256.894862102813, 5026.421961474477, 5072.771725272298, 5109.156989096906, 5186.6369354144845, 5196.662216955886, 5087.720175390389, 5105.770240339268, 5126.7180305083575, 5138.460461651623, 5143.305653736697, 4822.397200349957, 4989.9251511228085, 5044.747762611928, 5115.207142892708, 5161.354830646169, 5134.9486505135965, 5149.768260428365, 5165.819196328111, 5172.0, 5213.478652134756, 5033.320501732219, 5035.647504674784, 5039.47085556026, 5042.596592272683, 5093.668911520739], "value": 4801.678148694076, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.2190620755772, 594.4590422715327, 597.9461848433641, 603.1423216493201, 604.5677340701397, 29179.708202917966, 31982.20044498886, 43271.78364108179, 44180.558194418045, 44222.55777442225, 41871.790641046755, 42141.36787948183, 42432.36351454731, 42473.78763106188, 42531.36202956951, 7726.72956446523, 7898.526088434713, 7899.131095579482, 7901.802454938644, 7905.169957154502, 7667.693292268331, 7826.334761545247, 7831.29518343349, 7832.412569057315, 7837.373010159202, 7822.335101516378, 7868.72459463916, 7875.684972601089, 7879.803004924894, 7886.093099293597, 7809.062912450514, 7857.489263197874, 7864.4888082274465, 7864.882026769632, 7871.8032049198655, 7758.573278469682, 7837.882431763528, 7840.215978402114, 7845.0, 7847.195145116598, 38345.80827095846, 38668.22663546713, 38700.225995480214, 38766.0, 38838.0, 3134.420132275536, 3228.677132286776, 3371.814550199738, 3533.4346504559403, 3863.555691095504, 29352.119436416942, 29367.706322936923, 29381.26546836325, 29626.555601665994, 30436.39127217443, 3460.1349662584353, 3475.270193259393, 3505.141240396094, 3522.964770352289, 3611.1694310308512, 235886.0, 236652.0, 236730.0, 237823.0, 238057.99999999825, 31687.366252674816, 32653.346933061683, 52340.73829630828, 52443.73778131161, 52762.0, 32722.836385818395, 32757.34485310328, 32786.18034549156, 32794.67205327964, 32836.67163328384, 12544.74910501803, 12626.621201363974, 12636.305003224727, 12658.303793291274, 12665.49338026487, 10143.746406339753, 10177.694669159937, 10212.897871021343, 10215.080642742189, 10220.131288840383, 7858.724944627025, 7870.370370370357, 7897.091834438998, 7933.682652693943, 7990.04119505663, 3012.457757603652, 3076.523138913472, 3098.194469437917, 3104.689531046877, 3112.2375018120706, 863.8315528472014, 892.054422312351, 894.7136916186757, 942.2885721280527, 1059.4967390489455, 27815.272842765724, 28144.85927570349, 28624.0, 28748.712512875023, 28853.422931541252, 789.2935822438885, 968.1093394077466, 980.3284749946309, 987.0770829274651, 988.8961659025842, 13996.32044154708, 14678.779818302733, 14746.852531474762, 14864.331105100297, 14956.850431495763, 365375.0, 367576.0, 368416.0, 369026.0, 369523.0, 49213.753931230116, 50427.0, 50436.24345634819, 50438.74780626073, 50561.24158137631, 1085.1210519479089, 1199.3943058755274, 1199.550168686725, 1214.4292182674128, 1232.2483285196024, 27622.861885690443, 27986.580201297405, 28504.429911402072, 29093.0, 29435.0, 49013.509864900894, 49061.0, 49738.25392619186, 49744.0, 49768.75115624399, 337192.0, 337427.0, 337720.0, 337846.0, 340795.0, 32578.348433031682, 37978.0, 39105.0, 39171.41242881302, 41487.095903287685, 42479.1504169921, 42732.35901461419, 43012.35481467718, 43573.0, 43622.0, 35836.0, 36738.448923265634, 36774.63225367819, 36990.63009369872, 37219.44170837385, 35076.29847402986, 36001.27997440089, 36504.26991460209, 36709.0, 37104.443433349064, 36127.63872361243, 36653.26693466169, 36706.8164659175, 37085.443718343704, 37185.07037324089, 32559.41081172398, 32682.509762353107, 33265.667343326255, 33489.665103348656, 33799.15502112467, 25478.0, 25558.23325300244, 25767.484650307262, 25974.0, 26142.607860882483], "value": 16738.61335762835, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.3994668982765, 357.09476477130477, 361.1332801276937, 368.3608938491718, 380.7905651891459, 15657.3737050518, 16894.493165205033, 17001.2349444275, 17219.74170387442, 17470.650586988268, 16109.275082621281, 16442.42451514197, 17201.397951071714, 17220.741688874677, 17231.0, 5044.495550444963, 5210.192420174879, 5216.139337009389, 5235.345581802275, 5250.501202385786, 3753.2305877295225, 3828.55971563271, 5165.7158856262895, 5732.5127364174095, 6032.728527216286, 6077.969610151943, 6090.817275481721, 6096.268447786249, 6111.908321375183, 6111.938880611181, 5830.941690583103, 6076.787312444066, 6078.939210607881, 6080.027195648697, 6085.9391406085815, 3414.23179784549, 4966.950330496685, 5226.346706661668, 5249.921251181236, 5274.077036518594, 19799.80200197994, 20630.27794027202, 20637.0, 20644.38066857997, 20714.171433142656, 1993.6710442776925, 2114.06980928391, 2246.629306164481, 2552.515022145805, 2555.8083143764106, 12965.611031669065, 13088.607341779762, 13173.407196676173, 13311.800322995163, 13371.799423008662, 1741.051127135714, 1745.3629425259817, 1750.2497502497502, 1756.4116021132936, 1837.660032893919, 67342.33228659704, 67551.0, 67883.0, 68490.9999999995, 68834.65582672105, 8913.242374398249, 9015.008349081596, 9248.16766491019, 9320.8601870972, 9342.346035777431, 12396.81404778929, 12403.379831008413, 12415.379231038412, 12424.627261182179, 12467.563635272722, 6942.409895158968, 6980.162380514371, 7064.964675176591, 7088.0, 7146.92853071473, 6798.320167983162, 6808.761693340709, 6899.75850845218, 6908.447324214051, 6939.063226464363, 5833.883322333614, 5915.881682366415, 5933.139694744238, 6052.878942421127, 6066.605670631483, 1488.2930607961348, 1597.27324067549, 1629.3156874112901, 1680.840320169582, 1705.9744103838452, 870.9520976346236, 917.3257655623112, 934.4019827310527, 953.828310904044, 1014.9188064954786, 16752.916235418747, 16779.91610041942, 16856.578585535215, 17203.483895483154, 17211.62330443625, 858.6479543387306, 896.3367108339781, 911.2026976395654, 943.5376665433888, 955.9187469065207, 9464.810703785886, 9671.177949874198, 9723.805523889483, 9930.453825039547, 10053.346532475365, 379858.0, 389226.0, 394605.0, 396412.0, 397187.0, 41071.383929241085, 54449.0, 66678.66660666665, 67092.66453667798, 67397.0, 917.1653795046476, 917.8118485710413, 930.851063829784, 937.9249660027182, 939.2157548447124, 15044.097354158786, 15179.620509487351, 15281.159536225614, 15372.846271537588, 15566.688666226839, 30675.693243067282, 32174.83912580422, 32517.999999999054, 32906.341873162884, 34030.149246268054, 41791.0, 45217.0, 45307.773461132485, 45352.77323613361, 45639.087218256114, 6910.101686780687, 7002.719891204295, 7137.500374973702, 7193.496455248292, 7200.351968322876, 10657.840132398176, 10755.247132700635, 10779.51492182838, 10916.454177291262, 11080.501377437873, 8770.868436973324, 8899.644014239617, 8962.32782541299, 9207.631694732136, 9421.528923553658, 9338.579763910504, 9415.764605884908, 9426.858597121185, 9521.666741664008, 9572.425654460754, 9313.25493960468, 9390.577424016072, 9412.15290623847, 9608.519574021131, 9745.512724363894, 7051.858962820817, 7153.570785752871, 7155.534890232118, 7162.677679504539, 7170.354668079689, 9074.45553266806, 9075.228605568336, 9129.315301352557, 9176.6788162414, 9264.583093760662], "value": 8103.314965564559, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.9347532623367, 1332.666833291677, 1407.0010292692189, 1412.315027211802, 1696.7454881767742, 6627.304133066025, 7789.104253010905, 8048.275655191032, 8074.39442041847, 8297.834043319144, 7941.523508589475, 8200.38497112716, 8212.83574328513, 8215.014198296198, 8216.671333146682, 1867.46777168507, 2162.740471143465, 2229.6209644360456, 2234.8100411465043, 2266.0935625749667, 2287.736910255317, 2301.689271948282, 2302.5740238056014, 2306.7116610423695, 2312.09828167015, 2241.316398498457, 2244.5286489837154, 2282.338121944634, 2283.3264187064774, 2288.896999635012, 1820.6995845685447, 2098.5068508900395, 2155.795199456049, 2162.4377661807885, 2175.7389113306344, 2158.6330323844986, 2173.3262688566438, 2175.445261458334, 2175.4670105824016, 2178.096090122597, 8018.398620103458, 8023.197680231989, 8053.879191812069, 8087.231712987315, 8088.555129467877, 4554.180247555439, 4662.114198302312, 4670.509596492388, 4674.2053850845095, 4676.392069031038, 2867.225849020753, 2911.3595009097967, 3056.9082927511986, 3081.815091094519, 3094.4894092474715, 975.2782940623958, 977.9511024448749, 994.3238597753525, 1001.0940099210227, 1013.893541178173, 11159.38623375714, 11160.776784464266, 11162.162837787198, 11168.385738784364, 11176.27354221973, 4109.794510274474, 4202.915941681149, 4251.829926802893, 4268.658507319407, 4303.419038429772, 9454.95995440501, 9459.668911588198, 9474.242060635133, 9499.952500237454, 9513.381630194015, 4662.137504561667, 4667.813287468532, 4668.906621867543, 4669.276262179367, 4671.229247174246, 3513.8594456221977, 4003.4395184674167, 4149.937750933738, 4154.626083652486, 4195.748255104703, 3739.85040598373, 3749.4563288323584, 3852.9229415411537, 3867.6325749053794, 3961.841526338972, 1224.8836360545733, 1227.6501197158946, 1245.9190152640049, 1248.3633346992917, 1258.0688642933053, 825.4510750351069, 837.4389159263308, 839.8740188971581, 866.6749968761715, 873.0309356614154, 4904.950950490449, 5146.661867914369, 5204.609654275869, 5208.661437006583, 5262.605304602093, 418.38497408809, 427.4357847641084, 429.0903285035744, 430.5479246790857, 430.86427775250695, 3530.2233508628574, 3606.2246616977477, 3626.727995400303, 3638.690711289517, 3684.171061511192, 9423.481708506099, 9627.0, 9738.853917191247, 9741.512924353754, 9745.171660408945, 9651.420914745138, 9654.565544550513, 9655.324127311022, 9657.32398732082, 9670.854937175947, 7237.421006319481, 7305.598192099379, 7442.66508007141, 7444.478886478003, 7450.627468626439, 4881.170201065756, 4999.625028122832, 5003.299538064601, 5046.949530504795, 5062.746862656779, 8749.906261717286, 8801.603927823135, 9072.455652660861, 9118.179363857285, 9130.680426185052, 9110.681126160553, 9196.494192819458, 9207.355485115977, 9212.723618291462, 9326.020767819553, 5837.503812176013, 5983.072623743326, 5986.341502434641, 6778.525503214728, 6864.0, 6856.965715171592, 7375.631218438949, 7602.961985190039, 7609.6575654094595, 7839.568823714751, 6885.1049363582415, 6963.4777391694815, 6986.126734158231, 7066.505344626033, 7107.147142342952, 6688.632125233159, 6764.4588432924265, 6827.351401616838, 6833.2483426824, 6941.895871561829, 6435.324290949383, 6440.420362167428, 6511.0, 6588.374104460068, 6589.604623722592, 4639.8144074238, 4653.744044077608, 4686.507916668837, 4695.295705644044, 4754.833580824655, 4536.228841097088, 4579.221532339444, 4590.288505281686, 4605.83879564227, 4613.746243956614], "value": 4108.045602173421, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.7714398485158, 302.3605075265813, 310.64741518376644, 311.4565083928545, 316.12275934282366, 4816.20532612119, 4850.393700787402, 4876.487968763282, 4901.509849015097, 4914.640972333278, 4541.182587134314, 4786.664933454659, 4791.377120974268, 4793.832215872445, 4797.592204662608, 3725.9441108383394, 3731.141837377398, 3732.2535492901393, 3751.261579047297, 3755.4742336072973, 3696.464012718154, 3709.536307961505, 3711.1278849470355, 3715.792367480566, 3744.5319335083113, 3538.716902647782, 3691.778493290411, 3718.9442158367647, 3733.3466643337442, 3734.88795336139, 3652.1782598915297, 3666.9083272918124, 3682.963170368289, 3690.1697118148472, 3695.2240029593954, 3228.386606544749, 3228.499582564706, 3241.594800649919, 3253.918652033718, 3255.886043988473, 4625.8149674013, 4635.096156249533, 4640.976795116037, 4643.698159619614, 4657.0, 4122.175564887035, 4210.978945105286, 4221.704480686353, 4230.534641189497, 4262.445882035316, 4988.6757360771435, 4991.176455884774, 4994.300797888299, 5021.171506701427, 5023.472535383768, 3504.2816222674546, 3521.1725244567506, 3521.806300653463, 3523.3305671922253, 3543.5039094526787, 4474.798634061475, 4803.543663351976, 5304.151335786256, 5335.759890804923, 5338.439463856278, 3650.8682308484454, 3656.104254457675, 3660.084978755311, 3667.8166091695307, 3669.834857431422, 3725.3294407006997, 3730.6082861299174, 3737.8691745788765, 3738.3084129436143, 3743.8689645862264, 4041.0907545802547, 4129.8967525812095, 4239.427677263591, 4241.809118589671, 4308.827646894089, 5034.144195486776, 5045.596352291808, 5050.116229659795, 5053.722045287471, 5056.873578160502, 1240.1566934484638, 1244.1710685292605, 1244.8630650628425, 1250.8936740376987, 1255.7551277500982, 793.2820797178447, 814.9511029338258, 830.9281027474611, 836.4730219961507, 836.7531578184451, 4042.4946881639794, 4064.9390259146135, 4076.979615101965, 4078.938815917764, 4105.651019663362, 4590.265557510782, 4606.470255920545, 4644.698094623906, 4655.4878963314, 4682.812687492462, 4077.8193009452675, 4079.5104587449696, 4085.162541678949, 4102.2821006323775, 4116.938245926313, 2513.341194811452, 2577.3685447065213, 2751.2709132080013, 2753.20157154423, 2764.2951047483166, 4883.169861123618, 4900.656954013256, 4916.188828843272, 4917.680350777188, 4929.728864912464, 5074.23886417033, 5282.947170528246, 5304.283921670525, 5337.279467271868, 5342.358916929916, 4494.865154045384, 4864.246041863516, 4881.194602890554, 4975.900481990412, 4987.825426110068, 5228.477152284741, 5269.104252277046, 5280.155175171954, 5282.8943421132135, 5286.0, 4948.851534453972, 5170.224466330081, 5180.953523358327, 5182.585393168612, 5185.688858668492, 4879.146149423907, 4922.803087876445, 4939.777710002986, 4942.233953737176, 4979.232372507708, 3750.381187104206, 3752.080740218664, 3786.848526058927, 3795.127120762185, 3838.0, 5270.209468579744, 5293.523582877559, 5304.753382955079, 5305.143199880165, 5321.680699158062, 4788.545088216614, 5013.899722005466, 5036.219385995177, 5047.671901326402, 5091.905240373338, 5009.974950125226, 5022.961108529434, 5028.572571331331, 5076.619253555924, 5117.948820511747, 4854.902901942012, 5000.374953130859, 5014.52362025607, 5019.84940451787, 5021.221710634857, 5039.193729003342, 5051.722155281494, 5053.823116190915, 5079.492050795039, 5085.237214417867, 4917.778699958582, 4930.950690493192, 4948.455669876383, 4970.931249781314, 5016.749162541785], "value": 3756.1459150176593, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.2715938380387, 751.2562563062563, 751.9774406767799, 757.2162811490109, 781.5701364249661, 14071.296435178252, 14467.421303147874, 14475.276236188201, 14867.10797352157, 15022.399104035825, 14297.78553321701, 14321.283935803194, 14338.354774035168, 14406.495772647959, 14422.062565933207, 629.6945981199115, 807.5154907055763, 815.0667485728867, 815.4658698552428, 815.514768712615, 799.0172088331356, 827.5986146718836, 830.2361827119065, 831.4055450352996, 831.4429332347312, 857.5969294431607, 859.2224037246302, 861.8060936289347, 862.0948004595182, 863.2791618998144, 657.1260223902246, 817.1420008990536, 857.9785505362354, 858.1804376820153, 858.2833334165979, 620.2340109964191, 622.844288927768, 622.9408206220402, 623.2738859228992, 623.8253289079065, 12749.17130386522, 12784.0, 12809.743805123846, 12820.0, 12824.422900969479, 11779.88220117805, 12029.917307442372, 12071.818922716166, 12228.877711222864, 12421.068419868547, 11637.592684256011, 11639.825402618968, 11675.29948203102, 11709.707257318636, 11760.235584686969, 3943.940840887389, 4022.1754540319166, 4039.4748682671357, 4048.838046478137, 4094.324436467979, 51573.96852062938, 51848.0, 51855.222171667454, 51944.0, 51958.0, 9558.665446709332, 10056.949715251378, 10247.436390998566, 10250.487475626189, 10253.128484078938, 16957.406490772762, 16980.0, 17050.31798728037, 17925.46223613294, 17969.910150449425, 6164.845878852975, 6181.227346581677, 6513.446357059703, 6552.410283074546, 6595.967020164869, 3745.7377983541437, 3765.3975363941636, 3770.7171962102952, 3777.0934975605655, 3803.581606023335, 2666.7599916007266, 2752.477029364414, 2752.573351130578, 2753.0777189641294, 2753.5869619556825, 496.54318027414865, 500.50700060440437, 507.19609419071185, 511.19997204375034, 515.5746509129983, 503.4713550771675, 516.6460974232663, 522.0524747583124, 524.1194792748144, 527.2355085126505, 6584.995403493283, 6619.768308109289, 6829.965850170816, 6831.521793474409, 7017.61403122823, 470.4002396943924, 477.6369958831313, 525.7397588193869, 554.9345257106365, 572.3189404608503, 3368.7305015598695, 3564.6613571710645, 3605.7295702822394, 3607.7294202934886, 3638.7634803737674, 52550.0, 53839.461605384226, 54814.72592637011, 54883.17675234874, 55101.72449137809, 47650.5234947653, 48497.0, 48589.271160932614, 49337.259941100914, 49542.50457495379, 45539.861503462016, 45949.0, 46431.98192117569, 46661.30008049882, 46891.531084688715, 6726.6636668167375, 6757.45940324763, 6893.931060689329, 6894.1147194226705, 6974.651267436507, 31770.0, 31894.202644933135, 32163.35673286568, 32419.675803242608, 32735.67264327326, 41260.58739412567, 41262.38106428466, 41794.79102604467, 41921.0, 41995.58004420039, 8887.73336799897, 9057.592408341508, 9147.0852914708, 9250.583723732583, 9434.339596228197, 9315.953420233127, 9963.0, 10059.647912323033, 10232.59069637206, 10506.21203409732, 8611.181937715906, 8946.194842464209, 9019.233365164035, 9220.44677319363, 9276.397034192756, 9324.300677449353, 9417.623295068395, 9434.150926416656, 9567.186789123003, 9763.707088787347, 8750.124987501198, 8797.340199485192, 8826.955865220632, 8927.419717718327, 9034.27725781949, 7701.6534255957495, 7927.960360198162, 8103.797405064921, 8496.660133594587, 8557.272631826365, 7903.725474620737, 7944.0, 7963.641636126273, 8152.633131509215, 8188.631511582113], "value": 5812.197839977428, "unit": "score"}], "name": "dromaeo_css", "value": 6229.074269155453, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 112.0, 113.0, 112.0, 114.0, 112.0, 113.0, 112.0, 114.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 130.0, 133.0, 188.0, 128.0, 130.0, 153.0, 135.0, 186.0, 135.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 159.0, 162.0, 161.0, 161.0, 164.0, 161.0, 162.0, 163.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 110.0, 75.0, 76.0, 76.0, 75.0, 110.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 123.0, 84.0, 84.0, 84.0, 124.0, 84.0, 84.0, 118.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 120.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 81.0, 63.0, 61.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 64.0, 64.0, 64.0, 63.0, 64.0, 70.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 82.0, 82.0, 83.0, 88.0, 84.0, 90.0, 84.0, 83.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 130.0, 129.0, 138.0, 127.0, 132.0, 136.0, 139.0, 171.0, 133.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 171.0, 167.0, 168.0, 169.0, 169.0, 167.0, 171.0, 168.0, 174.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 67.0, 67.0, 66.0, 66.0, 67.0, 64.0, 66.0, 65.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1546.1, "alertThreshold": 2.0}]} 09:59:00 INFO - Return code: 0 09:59:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:59:00 ERROR - # TBPL SUCCESS # 09:59:00 INFO - Running post-action listener: _resource_record_post_action 09:59:00 INFO - ##### 09:59:00 INFO - ##### Finished run-tests step (success) 09:59:00 INFO - ##### 09:59:00 INFO - Running post-run listener: _resource_record_post_run 09:59:00 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520671232; Read time: 12; Write time: 515524 09:59:00 INFO - TinderboxPrint: CPU usage
13.1% 09:59:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:59:00 INFO - TinderboxPrint: I/O write bytes / time
520,671,232 / 515,524 09:59:00 INFO - TinderboxPrint: CPU idle
8,316.7 (86.9%) 09:59:00 INFO - TinderboxPrint: CPU user
1,210.7 (12.6%) 09:59:00 INFO - TinderboxPrint: Swap in / out
0 / 0 09:59:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 236797952; Read time: 0; Write time: 224104 09:59:00 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283873280; Read time: 12; Write time: 291420 09:59:01 INFO - Running post-run listener: _upload_blobber_files 09:59:01 INFO - Blob upload gear active. 09:59:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:59:01 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 09:59:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:59:01 INFO - (blobuploader) - INFO - Open directory for files ... 09:59:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:59:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:59:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:02 INFO - (blobuploader) - INFO - Done attempting. 09:59:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:59:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:59:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:06 INFO - (blobuploader) - INFO - Done attempting. 09:59:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:59:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:59:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:07 INFO - (blobuploader) - INFO - Done attempting. 09:59:07 INFO - (blobuploader) - INFO - Iteration through files over. 09:59:07 INFO - Return code: 0 09:59:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:59:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:59:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6bbe10625d426a7a598671d35ae7138696de974ed225f76c0ac8a075fc1b5296635670af334f5d5f9e51d6fbb5d53c84ab558a677ee47ed3ecc15f7f12fbccb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3c58c1983175c9d17ea9936a7d95b3acdb97d496cfb9edfe8cb706a79568b6335bca2fc8e9c84f3ded3f5a23ee65e74bfadddab7f07c45e01cfd669676241bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/083aa36e8e28d202c9e101d62b321dd9398e17b725758ee06eed335e7809c7ed140bae36bf08509a5a68931113f73fb07e441441cfb75f5e206543069647e09f"} 09:59:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:59:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:59:07 INFO - Contents: 09:59:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6bbe10625d426a7a598671d35ae7138696de974ed225f76c0ac8a075fc1b5296635670af334f5d5f9e51d6fbb5d53c84ab558a677ee47ed3ecc15f7f12fbccb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3c58c1983175c9d17ea9936a7d95b3acdb97d496cfb9edfe8cb706a79568b6335bca2fc8e9c84f3ded3f5a23ee65e74bfadddab7f07c45e01cfd669676241bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/083aa36e8e28d202c9e101d62b321dd9398e17b725758ee06eed335e7809c7ed140bae36bf08509a5a68931113f73fb07e441441cfb75f5e206543069647e09f"} 09:59:07 INFO - Running post-run listener: copy_logs_to_upload_dir 09:59:07 INFO - Copying logs to upload dir... 09:59:07 INFO - mkdir: /builds/slave/test/build/upload/logs 09:59:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.541927 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-05-26 09:59:07.496868) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 09:59:07.503991) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6bbe10625d426a7a598671d35ae7138696de974ed225f76c0ac8a075fc1b5296635670af334f5d5f9e51d6fbb5d53c84ab558a677ee47ed3ecc15f7f12fbccb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3c58c1983175c9d17ea9936a7d95b3acdb97d496cfb9edfe8cb706a79568b6335bca2fc8e9c84f3ded3f5a23ee65e74bfadddab7f07c45e01cfd669676241bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/083aa36e8e28d202c9e101d62b321dd9398e17b725758ee06eed335e7809c7ed140bae36bf08509a5a68931113f73fb07e441441cfb75f5e206543069647e09f"} build_url:https://queue.taskcluster.net/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011480 build_url: 'https://queue.taskcluster.net/v1/task/ZnpcuDM5RBWjFjV8pkIJsQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6bbe10625d426a7a598671d35ae7138696de974ed225f76c0ac8a075fc1b5296635670af334f5d5f9e51d6fbb5d53c84ab558a677ee47ed3ecc15f7f12fbccb7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3c58c1983175c9d17ea9936a7d95b3acdb97d496cfb9edfe8cb706a79568b6335bca2fc8e9c84f3ded3f5a23ee65e74bfadddab7f07c45e01cfd669676241bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/083aa36e8e28d202c9e101d62b321dd9398e17b725758ee06eed335e7809c7ed140bae36bf08509a5a68931113f73fb07e441441cfb75f5e206543069647e09f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 09:59:07.532063) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:59:07.532445) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1464280488.599636-1149060896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 09:59:07.613310) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 09:59:07.616708) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 09:59:07.617060) ========= ========= Total master_lag: 0.23 =========