builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1464062139.03 results: success (0) buildid: 20160523173011 builduid: 816fbf4866184d05a46348247583ed08 revision: b3835efbf422b78ea753a5072d3e25986b7df180 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 20:55:39.029265) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 20:55:39.029760) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 20:55:39.030052) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 20:55:39.046421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:55:39.046804) ========= 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=ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 20:55:39-- 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% 38.2M=0s 2016-05-23 20:55:39 (38.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118632 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:55:39.178980) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:55:39.179330) ========= 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=ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013672 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:55:39.229965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:55:39.230327) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b3835efbf422b78ea753a5072d3e25986b7df180 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b3835efbf422b78ea753a5072d3e25986b7df180 --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=ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 20:55:39,597 truncating revision to first 12 chars 2016-05-23 20:55:39,597 Setting DEBUG logging. 2016-05-23 20:55:39,597 attempt 1/10 2016-05-23 20:55:39,597 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b3835efbf422?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 20:55:40,012 unpacking tar archive at: fx-team-b3835efbf422/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658934 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 20:55:39.902589) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 20:55:39.902929) ========= script_repo_revision: b3835efbf422b78ea753a5072d3e25986b7df180 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 20:55:39.903335) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 20:55:39.903625) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 20:55:39.912598) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-23 20:55:39.912996) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:55:40 INFO - MultiFileLogger online at 20160523 20:55:40 in /builds/slave/test 20:55:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:55:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:55:40 INFO - {'append_to_log': False, 20:55:40 INFO - 'base_work_dir': '/builds/slave/test', 20:55:40 INFO - 'blob_upload_branch': 'Fx-Team', 20:55:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:55:40 INFO - 'branch': 'Fx-Team', 20:55:40 INFO - 'buildbot_json_path': 'buildprops.json', 20:55:40 INFO - 'config_files': ('talos/linux_config.py',), 20:55:40 INFO - 'default_actions': ('clobber', 20:55:40 INFO - 'read-buildbot-config', 20:55:40 INFO - 'download-and-extract', 20:55:40 INFO - 'populate-webroot', 20:55:40 INFO - 'create-virtualenv', 20:55:40 INFO - 'install', 20:55:40 INFO - 'run-tests'), 20:55:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:55:40 INFO - 'download_minidump_stackwalk': True, 20:55:40 INFO - 'download_symbols': 'ondemand', 20:55:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:55:40 INFO - 'tooltool.py': '/tools/tooltool.py', 20:55:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:55:40 INFO - '/tools/misc-python/virtualenv.py')}, 20:55:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:55:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:55:40 INFO - 'installer_path': 'installer.exe', 20:55:40 INFO - 'log_level': 'info', 20:55:40 INFO - 'log_name': 'talos', 20:55:40 INFO - 'log_to_console': True, 20:55:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:55:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:55:40 INFO - 'opt_config_files': (), 20:55:40 INFO - 'pip_index': False, 20:55:40 INFO - 'sps_profile': False, 20:55:40 INFO - 'sps_profile_interval': 0, 20:55:40 INFO - 'suite': 'dromaeojs', 20:55:40 INFO - 'system_bits': '32', 20:55:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:55:40 INFO - 'title': 'talos-linux64-ix-035', 20:55:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:55:40 INFO - 'use_talos_json': True, 20:55:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:55:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:55:40 INFO - 'work_dir': 'build'} 20:55:40 INFO - ##### 20:55:40 INFO - ##### Running clobber step. 20:55:40 INFO - ##### 20:55:40 INFO - Running pre-action listener: _resource_record_pre_action 20:55:40 INFO - Running main action method: clobber 20:55:40 INFO - rmtree: /builds/slave/test/build 20:55:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:55:40 INFO - Running post-action listener: _resource_record_post_action 20:55:40 INFO - ##### 20:55:40 INFO - ##### Finished clobber step (success) 20:55:40 INFO - ##### 20:55:40 INFO - ##### 20:55:40 INFO - ##### Running read-buildbot-config step. 20:55:40 INFO - ##### 20:55:40 INFO - Running pre-action listener: _resource_record_pre_action 20:55:40 INFO - Running main action method: read_buildbot_config 20:55:40 INFO - Using buildbot properties: 20:55:40 INFO - { 20:55:40 INFO - "project": "", 20:55:40 INFO - "product": "firefox", 20:55:40 INFO - "script_repo_revision": "production", 20:55:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:55:40 INFO - "repository": "", 20:55:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:55:40 INFO - "buildid": "20160523173011", 20:55:40 INFO - "pgo_build": "True", 20:55:40 INFO - "basedir": "/builds/slave/test", 20:55:40 INFO - "buildnumber": 119, 20:55:40 INFO - "slavename": "talos-linux64-ix-035", 20:55:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:55:40 INFO - "platform": "ubuntu64_hw", 20:55:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:55:40 INFO - "branch": "fx-team", 20:55:40 INFO - "repo_path": "integration/fx-team", 20:55:40 INFO - "revision": "b3835efbf422b78ea753a5072d3e25986b7df180", 20:55:40 INFO - "stage_platform": "linux64-pgo", 20:55:40 INFO - "builduid": "816fbf4866184d05a46348247583ed08", 20:55:40 INFO - "slavebuilddir": "test" 20:55:40 INFO - } 20:55:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:55:40 INFO - Running post-action listener: _resource_record_post_action 20:55:40 INFO - ##### 20:55:40 INFO - ##### Finished read-buildbot-config step (success) 20:55:40 INFO - ##### 20:55:40 INFO - ##### 20:55:40 INFO - ##### Running download-and-extract step. 20:55:40 INFO - ##### 20:55:40 INFO - Running pre-action listener: _resource_record_pre_action 20:55:40 INFO - Running main action method: download_and_extract 20:55:40 INFO - mkdir: /builds/slave/test/build/tests 20:55:40 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')]} 20:55:40 INFO - https://queue.taskcluster.net/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:55:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:55:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:55:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/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 20:55:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/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 20:55:41 INFO - Downloaded 1361 bytes. 20:55:41 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:55:41 INFO - Using the following test package requirements: 20:55:41 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:55:41 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:55:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:55:41 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:55:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:55:41 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:55:41 INFO - u'jsshell-linux-x86_64.zip'], 20:55:41 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:55:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:55:41 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:55:41 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:55:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:55:41 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:55:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:55:41 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:55:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:55:41 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:55:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:55:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:55:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:41 INFO - https://queue.taskcluster.net/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:55:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:55:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:55:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/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 20:55:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/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 20:55:44 INFO - Downloaded 24388635 bytes. 20:55:44 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'] 20:55:44 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 20:55:45 INFO - Return code: 0 20:55:45 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 20:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:45 INFO - https://queue.taskcluster.net/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:55:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:55:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:55:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/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 20:55:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/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 20:55:48 INFO - Downloaded 24388635 bytes. 20:55:48 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'] 20:55:48 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 20:55:49 INFO - Return code: 0 20:55:49 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')]} 20:55:49 INFO - https://queue.taskcluster.net/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:55:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:55:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:55:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/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 20:55:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/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 20:55:50 INFO - Downloaded 10840359 bytes. 20:55:50 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'] 20:55:50 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 20:55:50 INFO - Return code: 0 20:55:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:55:50 INFO - https://queue.taskcluster.net/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:55:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:55:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:55:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/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 20:55:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OCTGIPLLShigOQEdrJGDIQ/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 20:55:58 INFO - Downloaded 58593981 bytes. 20:55:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:55:58 INFO - mkdir: /builds/slave/test/properties 20:55:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:55:58 INFO - Writing to file /builds/slave/test/properties/build_url 20:55:58 INFO - Contents: 20:55:58 INFO - build_url:https://queue.taskcluster.net/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:55:58 INFO - Running post-action listener: _resource_record_post_action 20:55:58 INFO - Running post-action listener: set_extra_try_arguments 20:55:58 INFO - ##### 20:55:58 INFO - ##### Finished download-and-extract step (success) 20:55:58 INFO - ##### 20:55:58 INFO - ##### 20:55:58 INFO - ##### Running populate-webroot step. 20:55:58 INFO - ##### 20:55:58 INFO - Running pre-action listener: _resource_record_pre_action 20:55:58 INFO - Running main action method: populate_webroot 20:55:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:55:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:55:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:55:58 INFO - '--tppagecycles', 20:55:58 INFO - '7'], 20:55:58 INFO - 'tests': ['tsvgm']}}, 20:55:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:55:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:55:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:55:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:55:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:55:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:55:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:58 INFO - 'talos_options': ['--disable-e10s'], 20:55:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:55:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:55:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:58 INFO - 'talos_options': ['--disable-e10s'], 20:55:58 INFO - 'tests': ['damp', 'tps']}, 20:55:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:58 INFO - 'tests': ['damp', 'tps']}, 20:55:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:55:58 INFO - 'tests': ['dromaeo_dom']}, 20:55:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:55:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:55:58 INFO - 'tests': ['a11yr', 20:55:58 INFO - 'ts_paint', 20:55:58 INFO - 'tpaint', 20:55:58 INFO - 'sessionrestore', 20:55:58 INFO - 'sessionrestore_no_auto_restore', 20:55:58 INFO - 'tabpaint']}, 20:55:58 INFO - 'other-e10s': {'tests': ['a11yr', 20:55:58 INFO - 'ts_paint', 20:55:58 INFO - 'tpaint', 20:55:58 INFO - 'sessionrestore', 20:55:58 INFO - 'sessionrestore_no_auto_restore', 20:55:58 INFO - 'tabpaint']}, 20:55:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:55:58 INFO - 'ts_paint', 20:55:58 INFO - 'tpaint', 20:55:58 INFO - 'sessionrestore', 20:55:58 INFO - 'sessionrestore_no_auto_restore', 20:55:58 INFO - 'tabpaint']}, 20:55:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:55:58 INFO - 'ts_paint', 20:55:58 INFO - 'tpaint', 20:55:58 INFO - 'sessionrestore', 20:55:58 INFO - 'sessionrestore_no_auto_restore', 20:55:58 INFO - 'tabpaint']}, 20:55:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:55:58 INFO - 'tests': ['a11yr', 20:55:58 INFO - 'ts_paint', 20:55:58 INFO - 'tpaint', 20:55:58 INFO - 'sessionrestore', 20:55:58 INFO - 'sessionrestore_no_auto_restore', 20:55:58 INFO - 'tabpaint']}, 20:55:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:55:58 INFO - 'tests': ['a11yr', 20:55:58 INFO - 'ts_paint', 20:55:58 INFO - 'tpaint', 20:55:58 INFO - 'sessionrestore', 20:55:58 INFO - 'sessionrestore_no_auto_restore', 20:55:58 INFO - 'tabpaint']}, 20:55:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:55:58 INFO - 'tests': ['tsvgx', 20:55:58 INFO - 'tsvgr_opacity', 20:55:58 INFO - 'tart', 20:55:58 INFO - 'tscrollx', 20:55:58 INFO - 'cart']}, 20:55:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:55:58 INFO - 'tsvgr_opacity', 20:55:58 INFO - 'tart', 20:55:58 INFO - 'tscrollx', 20:55:58 INFO - 'cart']}, 20:55:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:58 INFO - 'talos_options': ['--disable-e10s'], 20:55:58 INFO - 'tests': ['tp5o']}, 20:55:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:58 INFO - 'tests': ['tp5o']}, 20:55:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:58 INFO - 'talos_options': ['--disable-e10s', 20:55:58 INFO - '--xperf_path', 20:55:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:55:58 INFO - 'tests': ['tp5n']}, 20:55:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:55:58 INFO - 'talos_options': ['--xperf_path', 20:55:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:55:58 INFO - 'tests': ['tp5n']}}, 20:55:58 INFO - 'talos.zip': {'path': '', 20:55:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:55:58 INFO - Running post-action listener: _resource_record_post_action 20:55:58 INFO - ##### 20:55:58 INFO - ##### Finished populate-webroot step (success) 20:55:58 INFO - ##### 20:55:58 INFO - ##### 20:55:58 INFO - ##### Running create-virtualenv step. 20:55:58 INFO - ##### 20:55:58 INFO - Running pre-action listener: _resource_record_pre_action 20:55:58 INFO - Running main action method: create_virtualenv 20:55:58 INFO - Creating virtualenv /builds/slave/test/build/venv 20:55:58 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 20:55:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:55:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:55:59 INFO - Using real prefix '/usr' 20:55:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:55:59 INFO - Installing distribute.............................................................................................................................................................................................done. 20:56:01 INFO - Installing pip.................done. 20:56:01 INFO - Return code: 0 20:56:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:56:01 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')]} 20:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:01 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')]} 20:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:01 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 0x7fb53a119f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2160770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ef9c0>, '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 0x21f08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f0d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821', '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 20:56:01 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 20:56:01 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 20:56:01 INFO - Using env: {'DISPLAY': ':0', 20:56:01 INFO - 'HOME': '/home/cltbld', 20:56:01 INFO - 'LANG': 'en_US.UTF-8', 20:56:01 INFO - 'LANGUAGE': 'en_US:en', 20:56:01 INFO - 'LOGNAME': 'cltbld', 20:56:01 INFO - 'MAIL': '/var/mail/cltbld', 20:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:01 INFO - 'MOZ_NO_REMOTE': '1', 20:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:01 INFO - 'NO_EM_RESTART': '1', 20:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:01 INFO - 'PWD': '/builds/slave/test', 20:56:01 INFO - 'SHELL': '/bin/bash', 20:56:01 INFO - 'SHLVL': '1', 20:56:01 INFO - 'TERM': 'linux', 20:56:01 INFO - 'TMOUT': '86400', 20:56:01 INFO - 'USER': 'cltbld', 20:56:01 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821', 20:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:01 INFO - '_': '/tools/buildbot/bin/python'} 20:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:01 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 20:56:01 INFO - Cleaning up... 20:56:01 INFO - Return code: 0 20:56:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:56:01 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')]} 20:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:01 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')]} 20:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:01 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 0x7fb53a119f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2160770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ef9c0>, '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 0x21f08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f0d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821', '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 20:56:01 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 20:56:01 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 20:56:01 INFO - Using env: {'DISPLAY': ':0', 20:56:01 INFO - 'HOME': '/home/cltbld', 20:56:01 INFO - 'LANG': 'en_US.UTF-8', 20:56:01 INFO - 'LANGUAGE': 'en_US:en', 20:56:01 INFO - 'LOGNAME': 'cltbld', 20:56:01 INFO - 'MAIL': '/var/mail/cltbld', 20:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:01 INFO - 'MOZ_NO_REMOTE': '1', 20:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:01 INFO - 'NO_EM_RESTART': '1', 20:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:01 INFO - 'PWD': '/builds/slave/test', 20:56:01 INFO - 'SHELL': '/bin/bash', 20:56:01 INFO - 'SHLVL': '1', 20:56:01 INFO - 'TERM': 'linux', 20:56:01 INFO - 'TMOUT': '86400', 20:56:01 INFO - 'USER': 'cltbld', 20:56:01 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821', 20:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:01 INFO - '_': '/tools/buildbot/bin/python'} 20:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:01 INFO - Downloading/unpacking psutil>=3.1.1 20:56:01 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 20:56:01 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 20:56:01 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 20:56:01 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 20:56:01 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 20:56:01 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 20:56:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:56:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:56:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:56:04 INFO - Installing collected packages: psutil 20:56:04 INFO - Running setup.py install for psutil 20:56:04 INFO - building 'psutil._psutil_linux' extension 20:56:04 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 20:56:04 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 20:56:04 INFO - building 'psutil._psutil_posix' extension 20:56:04 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 20:56:04 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 20:56:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:56:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:56:04 INFO - Successfully installed psutil 20:56:04 INFO - Cleaning up... 20:56:04 INFO - Return code: 0 20:56:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:56:04 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')]} 20:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:04 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')]} 20:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:04 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 0x7fb53a119f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2160770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ef9c0>, '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 0x21f08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f0d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821', '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 20:56:04 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 20:56:04 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 20:56:04 INFO - Using env: {'DISPLAY': ':0', 20:56:04 INFO - 'HOME': '/home/cltbld', 20:56:04 INFO - 'LANG': 'en_US.UTF-8', 20:56:04 INFO - 'LANGUAGE': 'en_US:en', 20:56:04 INFO - 'LOGNAME': 'cltbld', 20:56:04 INFO - 'MAIL': '/var/mail/cltbld', 20:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:04 INFO - 'MOZ_NO_REMOTE': '1', 20:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:04 INFO - 'NO_EM_RESTART': '1', 20:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:04 INFO - 'PWD': '/builds/slave/test', 20:56:04 INFO - 'SHELL': '/bin/bash', 20:56:04 INFO - 'SHLVL': '1', 20:56:04 INFO - 'TERM': 'linux', 20:56:04 INFO - 'TMOUT': '86400', 20:56:04 INFO - 'USER': 'cltbld', 20:56:04 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821', 20:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:04 INFO - '_': '/tools/buildbot/bin/python'} 20:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:56:06 INFO - Installing collected packages: mozsystemmonitor 20:56:06 INFO - Running setup.py install for mozsystemmonitor 20:56:06 INFO - Successfully installed mozsystemmonitor 20:56:06 INFO - Cleaning up... 20:56:06 INFO - Return code: 0 20:56:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb53a119f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2160770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ef9c0>, '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 0x21f08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f0d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821', '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 20:56:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:56:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:56:06 INFO - Using env: {'DISPLAY': ':0', 20:56:06 INFO - 'HOME': '/home/cltbld', 20:56:06 INFO - 'LANG': 'en_US.UTF-8', 20:56:06 INFO - 'LANGUAGE': 'en_US:en', 20:56:06 INFO - 'LOGNAME': 'cltbld', 20:56:06 INFO - 'MAIL': '/var/mail/cltbld', 20:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:06 INFO - 'MOZ_NO_REMOTE': '1', 20:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:06 INFO - 'NO_EM_RESTART': '1', 20:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:06 INFO - 'PWD': '/builds/slave/test', 20:56:06 INFO - 'SHELL': '/bin/bash', 20:56:06 INFO - 'SHLVL': '1', 20:56:06 INFO - 'TERM': 'linux', 20:56:06 INFO - 'TMOUT': '86400', 20:56:06 INFO - 'USER': 'cltbld', 20:56:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821', 20:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:06 INFO - '_': '/tools/buildbot/bin/python'} 20:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:07 INFO - Downloading/unpacking blobuploader==1.2.4 20:56:07 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 20:56:07 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 20:56:07 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 20:56:07 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 20:56:07 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 20:56:07 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 20:56:08 INFO - Downloading blobuploader-1.2.4.tar.gz 20:56:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:56:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:56:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:09 INFO - Downloading docopt-0.6.1.tar.gz 20:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:56:09 INFO - Installing collected packages: blobuploader, requests, docopt 20:56:09 INFO - Running setup.py install for blobuploader 20:56:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:56:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:56:09 INFO - Running setup.py install for requests 20:56:10 INFO - Running setup.py install for docopt 20:56:10 INFO - Successfully installed blobuploader requests docopt 20:56:10 INFO - Cleaning up... 20:56:10 INFO - Return code: 0 20:56:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:56:10 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')]} 20:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:10 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')]} 20:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:10 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 0x7fb53a119f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2160770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ef9c0>, '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 0x21f08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f0d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821', '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 20:56:10 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 20:56:10 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 20:56:10 INFO - Using env: {'DISPLAY': ':0', 20:56:10 INFO - 'HOME': '/home/cltbld', 20:56:10 INFO - 'LANG': 'en_US.UTF-8', 20:56:10 INFO - 'LANGUAGE': 'en_US:en', 20:56:10 INFO - 'LOGNAME': 'cltbld', 20:56:10 INFO - 'MAIL': '/var/mail/cltbld', 20:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:10 INFO - 'MOZ_NO_REMOTE': '1', 20:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:10 INFO - 'NO_EM_RESTART': '1', 20:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:10 INFO - 'PWD': '/builds/slave/test', 20:56:10 INFO - 'SHELL': '/bin/bash', 20:56:10 INFO - 'SHLVL': '1', 20:56:10 INFO - 'TERM': 'linux', 20:56:10 INFO - 'TMOUT': '86400', 20:56:10 INFO - 'USER': 'cltbld', 20:56:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821', 20:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:10 INFO - '_': '/tools/buildbot/bin/python'} 20:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:56:10 INFO - Running setup.py (path:/tmp/pip-WIbwnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:56:10 INFO - Running setup.py (path:/tmp/pip-LGBUUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:56:10 INFO - Running setup.py (path:/tmp/pip-dEjOHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:56:10 INFO - Running setup.py (path:/tmp/pip-b0p2lR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:56:10 INFO - Running setup.py (path:/tmp/pip-NjxEFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:56:10 INFO - Running setup.py (path:/tmp/pip-OJIjXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:56:10 INFO - Running setup.py (path:/tmp/pip-AT1QJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:56:11 INFO - Running setup.py (path:/tmp/pip-2dG9Wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:56:11 INFO - Running setup.py (path:/tmp/pip-ASZ4ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:56:11 INFO - Running setup.py (path:/tmp/pip-zK4LEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:56:11 INFO - Running setup.py (path:/tmp/pip-ezbf_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:56:11 INFO - Running setup.py (path:/tmp/pip-vdb_Ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:56:11 INFO - Running setup.py (path:/tmp/pip-wUVTUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:56:11 INFO - Running setup.py (path:/tmp/pip-40ZSHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:11 INFO - Running setup.py (path:/tmp/pip-Q5PL78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:56:11 INFO - Running setup.py (path:/tmp/pip-xyGt0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:56:11 INFO - Running setup.py (path:/tmp/pip-6MjyzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:56:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:56:11 INFO - Running setup.py install for manifestparser 20:56:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:56:11 INFO - Running setup.py install for mozcrash 20:56:11 INFO - Running setup.py install for mozdebug 20:56:12 INFO - Running setup.py install for mozdevice 20:56:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:56:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:56:12 INFO - Running setup.py install for mozfile 20:56:12 INFO - Running setup.py install for mozhttpd 20:56:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:56:12 INFO - Running setup.py install for mozinfo 20:56:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:56:12 INFO - Running setup.py install for mozInstall 20:56:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:56:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:56:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:56:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:56:12 INFO - Running setup.py install for mozleak 20:56:12 INFO - Running setup.py install for mozlog 20:56:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:56:12 INFO - Running setup.py install for moznetwork 20:56:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:56:12 INFO - Running setup.py install for mozprocess 20:56:12 INFO - Running setup.py install for mozprofile 20:56:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:56:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:56:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:56:13 INFO - Running setup.py install for mozrunner 20:56:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:56:13 INFO - Running setup.py install for mozscreenshot 20:56:13 INFO - Running setup.py install for moztest 20:56:13 INFO - Running setup.py install for mozversion 20:56:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:56:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:56:13 INFO - Cleaning up... 20:56:13 INFO - Return code: 0 20:56:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:13 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 0x7fb53a119f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2160770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ef9c0>, '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 0x21f08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f0d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821', '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 20:56:13 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 20:56:13 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 20:56:13 INFO - Using env: {'DISPLAY': ':0', 20:56:13 INFO - 'HOME': '/home/cltbld', 20:56:13 INFO - 'LANG': 'en_US.UTF-8', 20:56:13 INFO - 'LANGUAGE': 'en_US:en', 20:56:13 INFO - 'LOGNAME': 'cltbld', 20:56:13 INFO - 'MAIL': '/var/mail/cltbld', 20:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:13 INFO - 'MOZ_NO_REMOTE': '1', 20:56:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:13 INFO - 'NO_EM_RESTART': '1', 20:56:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:13 INFO - 'PWD': '/builds/slave/test', 20:56:13 INFO - 'SHELL': '/bin/bash', 20:56:13 INFO - 'SHLVL': '1', 20:56:13 INFO - 'TERM': 'linux', 20:56:13 INFO - 'TMOUT': '86400', 20:56:13 INFO - 'USER': 'cltbld', 20:56:13 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821', 20:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:13 INFO - '_': '/tools/buildbot/bin/python'} 20:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:56:13 INFO - Running setup.py (path:/tmp/pip-KqIcKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:56:13 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)) 20:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:56:13 INFO - Running setup.py (path:/tmp/pip-fg9JGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:56:13 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)) 20:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:56:13 INFO - Running setup.py (path:/tmp/pip-MqTpyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:56:13 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)) 20:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:56:13 INFO - Running setup.py (path:/tmp/pip-GJ7a0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:56:14 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)) 20:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:56:14 INFO - Running setup.py (path:/tmp/pip-044X6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:56:14 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)) 20:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:56:14 INFO - Running setup.py (path:/tmp/pip-R17BIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:56:14 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)) 20:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:56:14 INFO - Running setup.py (path:/tmp/pip-O46AJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:56:14 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)) 20:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:56:14 INFO - Running setup.py (path:/tmp/pip-s2Zy6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:56:14 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)) 20:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:56:14 INFO - Running setup.py (path:/tmp/pip-pDH5M4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:56:14 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)) 20:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:56:14 INFO - Running setup.py (path:/tmp/pip-bJnG98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:56:14 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)) 20:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:56:14 INFO - Running setup.py (path:/tmp/pip-JfTtTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:56:14 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)) 20:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:56:14 INFO - Running setup.py (path:/tmp/pip-gDVhV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:56:14 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)) 20:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:56:14 INFO - Running setup.py (path:/tmp/pip-VoinyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:56:14 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)) 20:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:56:14 INFO - Running setup.py (path:/tmp/pip-P2qGK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:56:14 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)) 20:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:14 INFO - Running setup.py (path:/tmp/pip-3KiAI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:14 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)) 20:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:56:14 INFO - Running setup.py (path:/tmp/pip-6FzrCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:56:14 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)) 20:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:56:14 INFO - Running setup.py (path:/tmp/pip-KwcPyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:56:14 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)) 20:56:14 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)) 20:56:14 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)) 20:56:14 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)) 20:56:14 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)) 20:56:14 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)) 20:56:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:56:14 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 20:56:14 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 20:56:14 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 20:56:14 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 20:56:14 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 20:56:14 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 20:56:16 INFO - Downloading blessings-1.6.tar.gz 20:56:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:56:16 INFO - Installing collected packages: blessings 20:56:16 INFO - Running setup.py install for blessings 20:56:17 INFO - Successfully installed blessings 20:56:17 INFO - Cleaning up... 20:56:17 INFO - Return code: 0 20:56:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:56:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:56:17 INFO - Reading from file tmpfile_stdout 20:56:17 INFO - Current package versions: 20:56:17 INFO - argparse == 1.2.1 20:56:17 INFO - blessings == 1.6 20:56:17 INFO - blobuploader == 1.2.4 20:56:17 INFO - docopt == 0.6.1 20:56:17 INFO - manifestparser == 1.1 20:56:17 INFO - mozInstall == 1.12 20:56:17 INFO - mozcrash == 0.17 20:56:17 INFO - mozdebug == 0.1 20:56:17 INFO - mozdevice == 0.48 20:56:17 INFO - mozfile == 1.2 20:56:17 INFO - mozhttpd == 0.7 20:56:17 INFO - mozinfo == 0.9 20:56:17 INFO - mozleak == 0.1 20:56:17 INFO - mozlog == 3.2 20:56:17 INFO - moznetwork == 0.27 20:56:17 INFO - mozprocess == 0.22 20:56:17 INFO - mozprofile == 0.28 20:56:17 INFO - mozrunner == 6.11 20:56:17 INFO - mozscreenshot == 0.1 20:56:17 INFO - mozsystemmonitor == 0.3 20:56:17 INFO - moztest == 0.7 20:56:17 INFO - mozversion == 1.4 20:56:17 INFO - psutil == 3.1.1 20:56:17 INFO - requests == 1.2.3 20:56:17 INFO - wsgiref == 0.1.2 20:56:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:56:17 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')]} 20:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:17 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')]} 20:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:17 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 0x7fb53a119f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2160770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ef9c0>, '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 0x21f08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f0d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821', '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 20:56:17 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 20:56:17 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 20:56:17 INFO - Using env: {'DISPLAY': ':0', 20:56:17 INFO - 'HOME': '/home/cltbld', 20:56:17 INFO - 'LANG': 'en_US.UTF-8', 20:56:17 INFO - 'LANGUAGE': 'en_US:en', 20:56:17 INFO - 'LOGNAME': 'cltbld', 20:56:17 INFO - 'MAIL': '/var/mail/cltbld', 20:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:17 INFO - 'MOZ_NO_REMOTE': '1', 20:56:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:17 INFO - 'NO_EM_RESTART': '1', 20:56:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:17 INFO - 'PWD': '/builds/slave/test', 20:56:17 INFO - 'SHELL': '/bin/bash', 20:56:17 INFO - 'SHLVL': '1', 20:56:17 INFO - 'TERM': 'linux', 20:56:17 INFO - 'TMOUT': '86400', 20:56:17 INFO - 'USER': 'cltbld', 20:56:17 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821', 20:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:17 INFO - '_': '/tools/buildbot/bin/python'} 20:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:17 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)) 20:56:17 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)) 20:56:17 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)) 20:56:17 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)) 20:56:17 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)) 20:56:17 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)) 20:56:17 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)) 20:56:17 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)) 20:56:17 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)) 20:56:17 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)) 20:56:17 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)) 20:56:17 INFO - Cleaning up... 20:56:17 INFO - Return code: 0 20:56:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:56:17 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')]} 20:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:17 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')]} 20:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:17 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 0x7fb53a119f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2160770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ef9c0>, '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 0x21f08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f0d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821', '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 20:56:17 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 20:56:17 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 20:56:17 INFO - Using env: {'DISPLAY': ':0', 20:56:17 INFO - 'HOME': '/home/cltbld', 20:56:17 INFO - 'LANG': 'en_US.UTF-8', 20:56:17 INFO - 'LANGUAGE': 'en_US:en', 20:56:17 INFO - 'LOGNAME': 'cltbld', 20:56:17 INFO - 'MAIL': '/var/mail/cltbld', 20:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:17 INFO - 'MOZ_NO_REMOTE': '1', 20:56:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:17 INFO - 'NO_EM_RESTART': '1', 20:56:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:17 INFO - 'PWD': '/builds/slave/test', 20:56:17 INFO - 'SHELL': '/bin/bash', 20:56:17 INFO - 'SHLVL': '1', 20:56:17 INFO - 'TERM': 'linux', 20:56:17 INFO - 'TMOUT': '86400', 20:56:17 INFO - 'USER': 'cltbld', 20:56:17 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821', 20:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:17 INFO - '_': '/tools/buildbot/bin/python'} 20:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:17 INFO - Downloading/unpacking jsonschema 20:56:17 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 20:56:17 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 20:56:17 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 20:56:17 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 20:56:17 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 20:56:17 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 20:56:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:56:19 INFO - Downloading/unpacking functools32 (from jsonschema) 20:56:19 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 20:56:19 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 20:56:19 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 20:56:19 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 20:56:19 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 20:56:19 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 20:56:19 INFO - Downloading functools32-3.2.3-2.tar.gz 20:56:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:56:19 INFO - warning: no files found matching '*.txt' 20:56:19 INFO - no previously-included directories found matching 'build' 20:56:19 INFO - no previously-included directories found matching 'dist' 20:56:19 INFO - no previously-included directories found matching '.git*' 20:56:20 INFO - Installing collected packages: jsonschema, functools32 20:56:20 INFO - Running setup.py install for functools32 20:56:20 INFO - warning: no files found matching '*.txt' 20:56:20 INFO - no previously-included directories found matching 'build' 20:56:20 INFO - no previously-included directories found matching 'dist' 20:56:20 INFO - no previously-included directories found matching '.git*' 20:56:20 INFO - Successfully installed jsonschema functools32 20:56:20 INFO - Cleaning up... 20:56:20 INFO - Return code: 0 20:56:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:56:20 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')]} 20:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:20 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')]} 20:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:20 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 0x7fb53a119f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2160770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21ef9c0>, '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 0x21f08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f0d50>, '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': 'ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821', '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 20:56:20 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 20:56:20 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 20:56:20 INFO - Using env: {'DISPLAY': ':0', 20:56:20 INFO - 'HOME': '/home/cltbld', 20:56:20 INFO - 'LANG': 'en_US.UTF-8', 20:56:20 INFO - 'LANGUAGE': 'en_US:en', 20:56:20 INFO - 'LOGNAME': 'cltbld', 20:56:20 INFO - 'MAIL': '/var/mail/cltbld', 20:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:20 INFO - 'MOZ_NO_REMOTE': '1', 20:56:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:20 INFO - 'NO_EM_RESTART': '1', 20:56:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:20 INFO - 'PWD': '/builds/slave/test', 20:56:20 INFO - 'SHELL': '/bin/bash', 20:56:20 INFO - 'SHLVL': '1', 20:56:20 INFO - 'TERM': 'linux', 20:56:20 INFO - 'TMOUT': '86400', 20:56:20 INFO - 'USER': 'cltbld', 20:56:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821', 20:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:20 INFO - '_': '/tools/buildbot/bin/python'} 20:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:20 INFO - Downloading/unpacking flake8 20:56:20 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 20:56:20 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 20:56:20 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 20:56:20 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 20:56:20 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 20:56:20 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 20:56:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:56:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:56:22 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 20:56:22 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 20:56:22 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 20:56:22 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 20:56:22 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 20:56:22 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 20:56:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:56:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:56:22 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 20:56:22 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 20:56:22 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 20:56:22 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 20:56:22 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 20:56:22 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 20:56:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:56:22 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 20:56:22 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 20:56:22 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 20:56:22 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 20:56:22 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 20:56:22 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 20:56:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:56:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:56:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:56:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:56:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:56:23 INFO - no previously-included directories found matching 'docs/_build' 20:56:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:56:23 INFO - Running setup.py install for pep8 20:56:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:56:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:56:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:56:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:56:23 INFO - no previously-included directories found matching 'docs/_build' 20:56:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:56:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:56:23 INFO - Cleaning up... 20:56:23 INFO - Return code: 0 20:56:23 INFO - Running post-action listener: _resource_record_post_action 20:56:23 INFO - Running post-action listener: _start_resource_monitoring 20:56:23 INFO - Starting resource monitoring. 20:56:23 INFO - ##### 20:56:23 INFO - ##### Finished create-virtualenv step (success) 20:56:23 INFO - ##### 20:56:23 INFO - ##### 20:56:23 INFO - ##### Running install step. 20:56:23 INFO - ##### 20:56:23 INFO - Running pre-action listener: _resource_record_pre_action 20:56:23 INFO - Running main action method: install 20:56:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:56:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:56:23 INFO - Reading from file tmpfile_stdout 20:56:23 INFO - Detecting whether we're running mozinstall >=1.0... 20:56:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:56:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:56:23 INFO - Reading from file tmpfile_stdout 20:56:23 INFO - Output received: 20:56:23 INFO - Usage: mozinstall [options] installer 20:56:23 INFO - Options: 20:56:23 INFO - -h, --help show this help message and exit 20:56:23 INFO - -d DEST, --destination=DEST 20:56:23 INFO - Directory to install application into. [default: 20:56:23 INFO - "/builds/slave/test"] 20:56:23 INFO - --app=APP Application being installed. [default: firefox] 20:56:23 INFO - mkdir: /builds/slave/test/build/application 20:56:23 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'] 20:56:23 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 20:56:40 INFO - Reading from file tmpfile_stdout 20:56:40 INFO - Output received: 20:56:40 INFO - /builds/slave/test/build/application/firefox/firefox 20:56:40 INFO - Running post-action listener: _resource_record_post_action 20:56:40 INFO - ##### 20:56:40 INFO - ##### Finished install step (success) 20:56:40 INFO - ##### 20:56:40 INFO - ##### 20:56:40 INFO - ##### Running run-tests step. 20:56:40 INFO - ##### 20:56:40 INFO - Running pre-action listener: _resource_record_pre_action 20:56:40 INFO - Running main action method: run_tests 20:56:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:56:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:56:40 INFO - Python 2.7.3 20:56:40 INFO - Return code: 0 20:56:40 INFO - grabbing minidump binary from tooltool 20:56:40 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')]} 20:56:40 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 0x21ef9c0>, '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 0x21f08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f0d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:56:40 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 20:56:40 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 20:56:40 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 20:56:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:56:40 INFO - Return code: 0 20:56:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:56:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:56:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:56:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:56:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:56:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:56:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:56:41 INFO - Return code: 0 20:56:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 20:56:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 20:56:41 INFO - Using env: {'DISPLAY': ':0', 20:56:41 INFO - 'HOME': '/home/cltbld', 20:56:41 INFO - 'LANG': 'en_US.UTF-8', 20:56:41 INFO - 'LANGUAGE': 'en_US:en', 20:56:41 INFO - 'LOGNAME': 'cltbld', 20:56:41 INFO - 'MAIL': '/var/mail/cltbld', 20:56:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:56:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:41 INFO - 'MOZ_NO_REMOTE': '1', 20:56:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:56:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:41 INFO - 'NO_EM_RESTART': '1', 20:56:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:41 INFO - 'PWD': '/builds/slave/test', 20:56:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:56:41 INFO - 'SHELL': '/bin/bash', 20:56:41 INFO - 'SHLVL': '1', 20:56:41 INFO - 'TERM': 'linux', 20:56:41 INFO - 'TMOUT': '86400', 20:56:41 INFO - 'USER': 'cltbld', 20:56:41 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821', 20:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:41 INFO - '_': '/tools/buildbot/bin/python'} 20:56:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 20:56:41 INFO - mozversion application_buildid: 20160523173011 20:56:41 INFO - mozversion application_changeset: b3835efbf422b78ea753a5072d3e25986b7df180 20:56:41 INFO - mozversion application_display_name: Nightly 20:56:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:56:41 INFO - mozversion application_name: Firefox 20:56:41 INFO - mozversion application_remotingname: firefox 20:56:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:56:41 INFO - mozversion application_vendor: Mozilla 20:56:41 INFO - mozversion application_version: 49.0a1 20:56:41 INFO - mozversion platform_buildid: 20160523173011 20:56:41 INFO - mozversion platform_changeset: b3835efbf422b78ea753a5072d3e25986b7df180 20:56:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:56:41 INFO - mozversion platform_version: 49.0a1 20:56:41 INFO - using testdate: 1464062201 20:56:41 INFO - actual date: 1464062201 20:56:41 INFO - starting webserver on 'localhost:58927' 20:56:41 INFO - SUITE-START | Running 2 tests 20:56:41 INFO - TEST-START | dromaeo_css 20:56:41 INFO - operating with platform_type : linux_ 20:56:41 INFO - Initialising browser for dromaeo_css test... 20:56:41 INFO - TEST-INFO | started process 20247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVVux_7/profile http://localhost:58927/getInfo.html) 20:56:45 INFO - PROCESS | 20247 | __metrics Screen width/height:1600/1200 20:56:45 INFO - PROCESS | 20247 | colorDepth:24 20:56:45 INFO - PROCESS | 20247 | Browser inner width/height: 1024/697 20:56:45 INFO - PROCESS | 20247 | __metrics 20:56:46 ERROR - PROCESS | 20247 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 20:56:47 INFO - TEST-INFO | 20247: exit 0 20:56:47 INFO - Browser initialized. 20:56:47 INFO - Running cycle 1/1 for dromaeo_css test... 20:56:47 INFO - TEST-INFO | started process 20332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVVux_7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:56:59 INFO - PROCESS | 20332 | RSS: Main: 153456640 20:56:59 INFO - PROCESS | 20332 | 20:57:50 INFO - PROCESS | 20332 | 1464062270125 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] 20:59:57 INFO - PROCESS | 20332 | Cycle 1(1): loaded http://localhost:58927/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58927/tests/dromaeo/cssquery-ext.html) 20:59:58 INFO - PROCESS | 20332 | RSS: Main: 254738432 20:59:58 INFO - PROCESS | 20332 | 21:03:01 INFO - PROCESS | 20332 | Cycle 1(1): loaded http://localhost:58927/tests/dromaeo/cssquery-ext.html (next: http://localhost:58927/tests/dromaeo/cssquery-jquery.html) 21:03:01 INFO - PROCESS | 20332 | RSS: Main: 236290048 21:03:01 INFO - PROCESS | 20332 | 21:06:03 INFO - PROCESS | 20332 | Cycle 1(1): loaded http://localhost:58927/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58927/tests/dromaeo/cssquery-mootools.html) 21:06:04 INFO - PROCESS | 20332 | RSS: Main: 240435200 21:06:04 INFO - PROCESS | 20332 | 21:09:06 INFO - PROCESS | 20332 | Cycle 1(1): loaded http://localhost:58927/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58927/tests/dromaeo/cssquery-prototype.html) 21:09:06 INFO - PROCESS | 20332 | RSS: Main: 227762176 21:09:06 INFO - PROCESS | 20332 | 21:12:09 INFO - PROCESS | 20332 | Cycle 1(1): loaded http://localhost:58927/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58927/tests/dromaeo/cssquery-yui.html) 21:12:10 INFO - PROCESS | 20332 | RSS: Main: 217735168 21:12:10 INFO - PROCESS | 20332 | 21:15:12 INFO - PROCESS | 20332 | Cycle 1(1): loaded http://localhost:58927/tests/dromaeo/cssquery-yui.html (next: http://localhost:58927/tests/dromaeo/cssquery-dojo.html) 21:15:13 INFO - PROCESS | 20332 | RSS: Main: 274673664 21:15:13 INFO - PROCESS | 20332 | 21:15:13 INFO - PROCESS | 20332 | __start_tp_report 21:15:13 INFO - PROCESS | 20332 | _x_x_mozilla_page_load 21:15:13 INFO - PROCESS | 20332 | _x_x_mozilla_page_load_details 21:15:13 INFO - PROCESS | 20332 | |i|pagename|runs| 21:15:13 INFO - PROCESS | 20332 | |0;dojo.html;3094.798838075525;3100.720935115839;3116.2520994961214;3136.654967953526;3154.4164329599025;5291.126964050932;5354.491323324288;5382.6232163748555;5431;5440.3743569489525;5280.445553216915;5292.206169074631;5306.70813105279;5383.219433182187;5440.6735595864175;4835.854924352275;4877.804887804484;4888.73111978841;4891.975540122295;5081.796728130888;4974.726390048546;4994.750262486879;5025.321581586476;5040.36995375578;5043.949560504403;4795.448523419799;4855.223164293714;4869;4875.8781030474165;4917.262410638415;4865.270209468573;4876.683015603974;4919.950800491985;4930.383702037246;4969.850904472872;4768.2847572864;4888.657793954425;4906.460289368167;4916.852494425173;4944.777485013183;5247.055530004598;5311.070562651521;5311.707856067915;5379.67721936685;5393.460653934575;5816.854578635525;5821.941780582225;5842.211301474289;5845.941540584582;5848.707564621752;5608.831735047955;5736.7992120276;5788.710564471759;5864.1203819427;5916.911246331309;5418.539424148991;5451.100568406208;5466.535344495723;5466.890662186774;5469.234307196995;5953.196318497034;5970.611910225822;5970.970145149333;5975.19334889793;5976.432238937294;5451.127819548853;5611.9438805612235;5650.067738823048;5671.51792097668;5763.394843541451;5809.099589563624;5842.1820945066875;5844.327902291291;5846.269216347957;5849.122631605208;5768.077107662753;5776.480116789509;5780.566457515703;5784.797532086441;5790.160426738099;5464.398916119224;5698.3162020556965;5729.512991395778;5761.769529218868;5807.186993820868;4412.492563355255;4412.889677758018;4421;4424.756638384855;4456.6211871991245;3834.9424758628643;3922.2743792398496;3929.3713005918917;3937.1338305572726;3954.9209015819524;5384.434634363413;5423.484768946943;5428.185772134211;5478.616496845262;5488.533474654699;5790.826275211751;5806.1581070744505;5834.912476312858;5836.358000619928;5890.734916928748;5446.101393270066;5458.536024437888;5462.508374246337;5463.043967305705;5463.863403414946;4725.314829349725;4755.167845627001;4763.4522029967;4800.711957282574;4829.758512074382;5944.286685597756;5950.464458198783;5953.3451320354725;5956.0768080946655;5957.880842383128;5642.125470552071;5731.856703582361;5739.799107031401;5743.195952566561;5746.195532625352;5915.58590898633;5950.851228719317;5977.46202841729;6026.186464827368;6033;5674.375818659862;5684.658920464785;5695.715214239354;5697.4302569742695;5699.800506982236;5635.0702134147405;5694.800681976111;5794.971025144847;5807.94192058074;5811.302643682785;5563.805266815642;5637.5489960802215;5640;5642.322921249476;5694.4590263924865;5577.832665020056;5624.409437009219;5630.5214056805635;5633.380328163817;5640.520555752807;5358.571314294925;5462.617616766788;5514.117741161395;5528.834134975958;5540.806071787468;5697.259356283656;5722.828315150552;5729.255196824386;5730.1977723119635;5740.483356497935;5558.722063896708;5564.137558678412;5565.55475561946;5566.276384070207;5567.109262517978 21:15:13 INFO - PROCESS | 20332 | |1;ext.html;602.5149754447668;625.2621906150741;634.4258446106276;638.2946843737669;652;34008.82995585022;45677.31484027738;45812.312815307756;45941.31088033682;46074.30888536674;46357.53642463574;46758;46822.53177468224;46866.29700554486;46929.29606055912;8102.837943241132;8712.215900568948;8877.112288771135;8878.955605221965;10498.947505262464;10210.438425886574;10644.840327395095;10664.360138391683;10669.466526673636;10671.893281067167;10623.681289561326;10627.309224900395;10669.946650266738;10673.946630266877;10678.893211067907;10568.365898046104;10591.576336946513;10608.57565697375;10613.57545698171;10619.150467962545;10463.68608941733;10561.155107591374;10563.683089507327;10566.630167944086;10568.52441640128;42154;42942.57057429417;42952.35571466431;42958.35562466565;42965.570344296466;3567.625399333059;3611.8916432507067;3662.468942003421;3686.318031164243;3874.2057878134915;33156.1710957228;33383.16542086443;33690.83154584211;33704.49443258353;34143.829280853686;4284.850030248957;4314.80583373749;4377;4418.4256046714045;4600.861974140781;247757;248103;248474;248882;249032;35102.824485877914;36097.8195109028;59842.70078649579;60350.69824650849;60599.394006059374;37827.62172378296;37860.242795143946;38003.429948550795;38048.23903521914;38105;13893.930530347283;14011.299435028412;14014.929925350512;14030.579082627333;14037.876969842593;10631.84052239217;10717.946410268054;10737.302075365076;11030.724231894266;11129;8569;8573.485590864568;8574.27118694918;8598.914010859937;8610.956945215234;3107.300857307088;3304.3556506481004;3321.7674762766856;3324.734021278292;3325.446504337762;1014.3761586624321;1086.2613422872364;1149.8620165580185;1185.9110566707532;1193.886580774825;32690.509642355384;33129.50305745416;33344.3331133376;33411.83294083514;33641.663583364345;1086.5002099034532;1105.850710154135;1116.8827273136367;1169.479581586186;1288.7937929931354;17399.652006960045;17503.82496175022;17576.38482653101;17588.296468141387;17732.645347092985;574992;580393;583127;583242;583936;60700;61249;61293.69353153206;61336.69331653313;61406;1286.8584455709865;1358.3344161360862;1398.5035312463929;1405.1639274631577;1415.0778642104228;33185;34292.48561271633;34344;34439;34623.65376346305;51253.231201531264;51721;51844;52019;52045;358589;364474;365481;365911;366087;25774.226773196835;28141.859290703414;28641.28396790097;28775.568366474938;30563.2359191022;49047;49770.25344619906;49832;50391.74804125956;50480.24279635735;41479.7926010368;41799.37300940549;42017.36973945332;43024.78487607542;43434.34848477212;40518.18963620652;42418.57581424146;42632;42866.14267714566;43082;41597;42476.362854557825;43107.78446107749;43284;45126.32310515411;36579.81710091539;38099.23801523899;38538.421923671725;38931.221375572895;38980.41529377005;28189.295267618472;28770;29369.265768355963;29441.263968400963;29473.410531789672 21:15:13 INFO - PROCESS | 20332 | |2;jquery.html;401.64454457804845;410.82950575511165;410.96301332880046;412.4658567155535;417.8892593462731;12797.488100475994;17813.55466113346;18853.340133095346;19583.510412239684;19603.215871365148;14403.385326969448;17411.651766964653;18239.088045597735;18574.721379179322;18951.431457056275;5641.18202860586;5768.711564421783;5803.390643982384;5825.155352473888;5837.299524057119;5753.165790960308;5795.971020144893;5803.274590676166;5804.564657650672;5804.854878628047;4125.793710314488;6179.3202747697715;6446.323136070715;6455.386738259858;6583.637899915503;6141.754329826802;6356.110144579762;6527.086207930894;6541.345865413445;6566;5682.687452190128;5703.3441154267375;5723.141528770676;5725.198472213893;5725.799597014126;21620.567588648297;21827.67258491124;22816.54366912669;22905.19831805879;22929.31212063641;2306.7347255065715;2378.203301893868;2402.447437089479;2564.0769323043687;2714.1993112031996;14057.78913316301;14387.712245755027;14698.11811291326;14892.255387230703;14898.329575169035;1930.362980216525;2007.909644066006;2013.222350551594;2053.0966374795044;2076.781937896529;69003.65498172477;73175;75435.24564754337;76013;77525.61237193778;9652;10296.588136474456;10989.285696429706;11211.383373914514;11345.432728363548;15374.769378459332;15447.227638618024;15452.845471545366;15481.148536830357;15505;7511.924880751232;7739.883901741478;7825.726099586487;7943.563104029334;7959.562224077731;7166.677499512534;7244.348008679244;7269.346688458674;7362.8587568926905;7374.963125184339;4301.397804307399;4410.272305069691;4703.365045718852;4797.496262892416;4797.592204662573;1980.3068925876116;2019.7677267114177;2038.9184432622826;2092.6337890869036;2101.2750601042617;945.5366870233673;988.8071825993862;1032.1897310611134;1043.5773511727762;1079.7030816525362;18173.7273940891;18220.262731689858;18805.435836924913;18957.336493222672;18993.715094273597;1004.5529739266102;1010.3584224017802;1017.5573625472942;1041.1930753665818;1069.0752499088233;10249.795004099877;10599.576016959236;10600.787984240273;10646.574137034431;10670.519826607666;363397;364288;364373;456138;463215;90606.54696726475;96266;97061.51469242609;97418;97733;976.3165783951263;1044.1959691037857;1046.04809623244;1054.8154073037188;1062.4528367890543;16744.581385465463;16907.154642268084;17293.308267669152;17396.73904891453;17613;34674.826625866706;41213.58786412217;42082;43129.13741725085;43464.91337716456;55363.72318138384;56143.71928140333;56423;56743.432565675466;58387.124193137985;8311.335093192409;8456.788580285542;8574.27118694918;8591.613377398156;8670.263027642468;9013.544288625426;12261.754764904474;12598.244105353708;12618.747625047265;12639.747205056032;6272.40412160844;7452.770292901828;10483.266171367932;10912.78174436491;10984.780304394028;10617.1506279499;10745.409002504937;10762.784744305227;10811.945940270249;10963.397013164353;10624.893751062391;10820.32284995827;10904.236703430684;11017.44912754343;11022.724431889266;8224.506529608243;8282.130376310643;8401.075881653136;8586.570671466277;8661.826763464822;10753;10901.236913415985;10928.398938058483;10995.450227488753;11177.72055698614 21:15:13 INFO - PROCESS | 20332 | |3;mootools.html;1382.412474698253;1519.620094976256;1563.9296231669573;1695.6523912597918;1818.7271909213625;8763.868541971868;9209.815803683923;9217.677381291656;9218.953905230474;9228.67699630513;8935.821283574325;9122.635094596208;9129.224015958634;9135.406198597086;9145.359824812265;2090.153487837428;2295.735990361105;2390.2112302940077;2401.7598240175976;2435.683361163055;2382.0471811275456;2414.7343792182846;2437.7440368761204;2440.0605766779827;2441.4506735984437;2377.940551486218;2408.4460574067975;2413.7706917842866;2421.8910149043336;2422.769836865495;2014.9597008059902;2287.4167087392775;2328.7205535335697;2331.114176612893;2334.031376978552;2365.775251351119;2418.8669623170717;2432.6472661464168;2443.0960544598433;2447.0334217983973;8961.820763584692;8969.775755606097;9010.053944335816;9024.503652299121;9036.909630903738;5300.072487314705;5364.865878353073;5394.056040192951;5394.514493695547;5409.161579955114;3368.4610462326154;3433.725301975836;3452.585689717225;3599.9460008099636;3610.277944411102;1133.0538999935063;1147.7933971885057;1171.3616079236751;1193.2840295822523;1205.9276443413423;12522.186057906207;12738.235705857678;12738.999999999907;12742.936285318514;12755.17091389066;4877;4939.110960027229;4945.505449455098;4953.356063711694;5022.924656130161;10842.295250808673;10872.78254434907;10874.891251087387;10879.456027198608;10890.237683362247;5540.2243685884005;5591.6365436246515;5607.831765047055;5611.2144299798065;5613.971930140405;4406.074724307931;4991.201407774739;5090.872728181825;5113.51421614946;5189.40321862983;4167.270727622654;4181.644560212355;4232.132412855419;4267.402563641031;4272.6795490338345;1320.7754681704134;1357.4638017983038;1365.7951307303786;1370.2258224103548;1376.0986553807272;1001.1990407673832;1036.6682661548382;1041.9218558608134;1043.0456132638703;1045.8692663417073;6002.849928751729;6111.419415155553;6161.4146656067605;6165.198524191826;6284.591501552384;480.6779457763307;481.5112660649444;482.826182574273;483.808895486288;505.73448939307156;3931.1744533647684;4060.7563546187325;4105.7331273467125;4109.178164367138;4146.543880173179;10874.565017399216;11192.888071119185;11323.943380283046;11355.148363872742;11365.147613928822;11242;11285.153613479022;11339.716507087223;11348.205625606128;11352.545898164146;7984.600769961478;8356.791080222922;8370.958145209235;8373;8494.447860889022;5999.370066142992;6160.260768707783;6189.84525386869;6227.128202051807;6273.71768270438;10123.797524049625;10356.844647330145;10513.737156570842;10527.94736026315;10551.630692925712;10028.24788140907;10453;10727.40999245049;10747.838782418426;10766.46167691628;7085.539439936388;7682.577458239851;7841.451098423056;8127.83744325122;8310.916890831015;8958.68644597436;8969.730908072768;8984.23633991118;9023.052579479061;9048.90951090507;7874;8055.516668999879;8058.637361318872;8118.472299300763;8130.75607731769;7512.924870751441;7537.510061845963;7874.21257874208;8035.879461808195;8044.034715833904;7149.249328820399;7190.856182876418;7217.422606191597;7231.566106033655;7236.927630723625;5160.277561141518;5290.497402746733;5300.204969254489;5301.204819277139;5345.893082138413;5313.149896016619;5324.8136315228785;5332.866678333073;5485.917711234414;5522.088855338824 21:15:13 INFO - PROCESS | 20332 | |4;prototype.html;329.88454041085606;332.11656992400214;335.2607500461482;336.9898903032907;337.35733427820014;5261.8947621047555;5301.3108295921575;5323.627346085776;5338.359396872376;5348.288547664749;5259.237410575473;5267.52592266696;5270.736463176845;5277.182036784305;5281.155015197569;3961.544422391426;4011.7191796574252;4092.9386059209137;4108.137291168858;4150.522689890671;4086.366613174963;4117.897052573695;4121.381792731085;4130.545639979599;4145.813438395279;3936.822842972073;4079.2657321682086;4117.567655396185;4119.320312148492;4124.278251306025;4025.335819589764;4102.815373308208;4114.423980642712;4118.258713431596;4129.710920235585;3601.351756683796;3614.8192590370377;3618.7696183297544;3627.619099994489;3655.574326012857;5013.774380152865;5017.67385119966;5029.497050294978;5038.949610503922;5054.570361519275;4510.481294651091;4672.15901137795;4684.407301517466;4691.741954192518;4709.458412282597;5379.704116273603;5406.729663516809;5420.647657902224;5446.474987003646;5450.836474905759;4014.879553613396;4016.9397459038137;4018;4018.598140185987;4025.3156963316014;5408.810691625774;5684.687342196177;5726.169705392736;5738.913916291259;5746.569007324426;3998.4402183694306;4009.2182024505523;4013.9397909031386;4015.598440155961;4023.2355852387955;4067.4171900843176;4072.9796351018053;4078;4114.6091121343425;4126.690498212646;4491.46102467706;4704.1767690654;4722.574968252874;4726.291056341576;4730.053989202173;5538.224648549206;5571.303587051619;5574.358948720868;5583.664980101207;5585.413531579207;1361.7140400516003;1386.3207028556137;1398.7202559488144;1398.7271582859548;1401.5515035188641;900.9549522523847;910.9498977556166;914.9908500915038;915.7939463620633;960.5389413081621;5267.71027593486;5290.550303224269;5292.44429334922;5295.364556253197;5320.547753441001;5570.777168913198;5582.7766889324785;5585.413531579125;5594.86012849682;5600.4399560044485;5104.9744751276;5274.551663108678;5282.339707536558;5302.655327403706;5360.839174824761;2946.985265073704;2978.22566132807;2990.8654110565076;3022.259546411143;3023.727864492162;5868.383819698955;5926.911096333559;5934.1692163097205;5949.315828679671;5957.821265362046;5569.303837020372;5770.855728606734;5788.913166302509;5822.534197264209;5829.59192856496;5872.765089396462;5876.5612270907095;5886.970565147147;5889.263842019747;5891.027980383189;5379.246905433164;5652.604317697722;5663.603547751618;5663.7451314690115;5669.744861481326;5668.489835914623;5687.857803554944;5689.374168841507;5704.033902370827;5711.485966263056;5893.852653683693;5898.144769008384;5926.614770039933;5932.228810254639;5934.6142500737315;3902.9609703902597;4025.3961905714377;4044.373122166069;4049.4128351389472;4073.6130067643526;5597.356304025089;5692.747595528977;5701.144828275792;5710.2862142232225;5730.598858079894;5355.116405793001;5376.623636345575;5527;5547.611667183259;5586.329640443173;5498.230247765236;5500.58745594074;5530.419305972815;5568.749406276646;5602.803901863415;5327.706976116351;5488.835334939959;5493.862653433696;5497.505224529811;5525.834224973257;5558.277423934863;5565.55475561946;5575.498205161555;5629.718514074362;5632.901584191043;5450.972745136249;5454.100073487989;5459.754311056092;5468.589855760913;5480.945190548044 21:15:13 INFO - PROCESS | 20332 | |5;yui.html;769.6498093367518;779.1157036763274;819.4345901328084;860.896692396912;865.9826803463927;13835.308234588269;15200.847991520068;15416.691666166684;16127;16191.919040404782;14792.408303667868;14877.107373557566;14899.32953017114;14965.551033469013;14993.77509337358;685.5715178013742;801.3348920396057;829.9460535065232;841.6507149532937;850.6427300533791;828.7430896422098;834.8831163637095;835.7116794705847;838.4089217101958;838.7567605394428;878.3587980774039;879.0374539878823;880.0143838900441;880.1330689271063;880.2078129683305;715.1668306423011;848.8514509960763;883.6067949762358;888.258304315897;888.3692578269437;636.8567072408717;637.2639601260552;638.1162090504638;638.2213699286909;638.4413638066692;14427.78358324626;14429.85570144306;14449.422023119063;14484;14487.56537303872;13850.376733047036;14127.71744565103;14152.92923535386;14214.644633884132;14432.350544225535;11555.595554155565;11868.347240901747;11960.940195298968;11976.640700778904;12195.268283902995;4393.51671316155;4397.142557201347;4398.230309695822;4453.465584129925;4554.453465584118;56518.71740641312;56586;57822.71088644614;58097;58177;10727.409992450333;10910.854360292215;11078.390688512209;11463.254888432226;11495.54017839277;19552.608947820965;19810.40568782939;19838.20647174097;19840.107195176253;19931.701024484646;8116.188381161836;8184.099749027602;8207.630656620348;8297.211764882448;8480.024797148284;4558.247889098328;4601.148787474261;4665;4685.0395668887795;4802.903941921212;3361.3613413451367;3447;3453.4647129694936;3460.567429071366;3470.514128022079;623.9719212635442;631.4443289904855;637.7831537277256;644.8710257948429;655.8262060553957;661.497262080822;684.1926526698444;719.5215181903975;767.1944458318743;767.3362541401648;9199.816003679889;9472.194863436547;9590.856137157949;9635.277354198462;9707;617.962922224668;650.1905128115432;732.5494820685346;765.8200322924108;767.8502691975011;4423.73457592539;4447.799849006802;4534.77326133692;4535.705179163409;4566.3781992266595;65473.34526654768;68472;68479.31520684829;68500.6574967122;68500.6574967122;59365.40634593599;61391;61659.691701541204;61755.38244617496;62438.68780656068;56356.43643563594;57052.71473642688;57742.7112864433;57755.711221444464;57953.42046579564;9474.573644186166;9596.66411675588;9612.252676807906;9642.903570964201;10078.899211007796;36686.816565917;36695.449568255965;36941;37099.62900370962;37771.62228377681;47752;49146.508534914195;49259;49702;50243.74878125586;12644.367781611067;12669.556565520163;12678.936605316914;12879.1038550917;13241.404136813673;14127.89483627853;14193.29033548339;14931.253437328307;14941.626459338604;15067.698646026798;13193.934030329787;13439.664008399868;13542.526011589547;14067.296635168404;14399.56801295921;12728.68178295513;12922;12961.935190324366;13361.66595835112;13408.396622151831;12325.568605098779;12663.93668031654;12738.872611274139;13053.608391748263;13159.802602961156;10303.330283531546;10660.111517477166;11155.665330040112;11209;11589.942050289694;10421.114205292635;10853.945730271298;10891.564337426415;10932.453377330943;10969.616063437741 21:15:13 INFO - PROCESS | 20332 | __end_tp_report 21:15:13 INFO - PROCESS | 20332 | __start_cc_report 21:15:13 INFO - PROCESS | 20332 | _x_x_mozilla_cycle_collect,894 21:15:13 INFO - PROCESS | 20332 | __end_cc_report 21:15:13 INFO - PROCESS | 20332 | __startTimestamp1464063313006__endTimestamp 21:15:13 INFO - PROCESS | 20332 | 21:15:13 INFO - PROCESS | 20332 | ------- Summary: start ------- 21:15:13 INFO - PROCESS | 20332 | Number of tests: 6 21:15:13 INFO - PROCESS | 20332 | 21:15:13 INFO - PROCESS | 20332 | [#0] dojo.html Cycles:165 Average:5354.83 Median:5558.72 stddev:616.40 (11.1%) stddev-sans-first:592.24 21:15:13 INFO - PROCESS | 20332 | Values: 3094.8 3100.7 3116.3 3136.7 3154.4 5291.1 5354.5 5382.6 5431.0 5440.4 5280.4 5292.2 5306.7 5383.2 5440.7 4835.9 4877.8 4888.7 4892.0 5081.8 4974.7 4994.8 5025.3 5040.4 5043.9 4795.4 4855.2 4869.0 4875.9 4917.3 4865.3 4876.7 4920.0 4930.4 4969.9 4768.3 4888.7 4906.5 4916.9 4944.8 5247.1 5311.1 5311.7 5379.7 5393.5 5816.9 5821.9 5842.2 5845.9 5848.7 5608.8 5736.8 5788.7 5864.1 5916.9 5418.5 5451.1 5466.5 5466.9 5469.2 5953.2 5970.6 5971.0 5975.2 5976.4 5451.1 5611.9 5650.1 5671.5 5763.4 5809.1 5842.2 5844.3 5846.3 5849.1 5768.1 5776.5 5780.6 5784.8 5790.2 5464.4 5698.3 5729.5 5761.8 5807.2 4412.5 4412.9 4421.0 4424.8 4456.6 3834.9 3922.3 3929.4 3937.1 3954.9 5384.4 5423.5 5428.2 5478.6 5488.5 5790.8 5806.2 5834.9 5836.4 5890.7 5446.1 5458.5 5462.5 5463.0 5463.9 4725.3 4755.2 4763.5 4800.7 4829.8 5944.3 5950.5 5953.3 5956.1 5957.9 5642.1 5731.9 5739.8 5743.2 5746.2 5915.6 5950.9 5977.5 6026.2 6033.0 5674.4 5684.7 5695.7 5697.4 5699.8 5635.1 5694.8 5795.0 5807.9 5811.3 5563.8 5637.5 5640.0 5642.3 5694.5 5577.8 5624.4 5630.5 5633.4 5640.5 5358.6 5462.6 5514.1 5528.8 5540.8 5697.3 5722.8 5729.3 5730.2 5740.5 5558.7 5564.1 5565.6 5566.3 5567.1 21:15:13 INFO - PROCESS | 20332 | 21:15:13 INFO - PROCESS | 20332 | [#1] ext.html Cycles:180 Average:56124.05 Median:19854.86 stddev:112222.34 (565.2%) stddev-sans-first:112459.73 21:15:13 INFO - PROCESS | 20332 | Values: 602.5 625.3 634.4 638.3 652.0 34008.8 45677.3 45812.3 45941.3 46074.3 46357.5 46758.0 46822.5 46866.3 46929.3 8102.8 8712.2 8877.1 8879.0 10498.9 10210.4 10644.8 10664.4 10669.5 10671.9 10623.7 10627.3 10669.9 10673.9 10678.9 10568.4 10591.6 10608.6 10613.6 10619.2 10463.7 10561.2 10563.7 10566.6 10568.5 42154.0 42942.6 42952.4 42958.4 42965.6 3567.6 3611.9 3662.5 3686.3 3874.2 33156.2 33383.2 33690.8 33704.5 34143.8 4284.9 4314.8 4377.0 4418.4 4600.9 247757.0 248103.0 248474.0 248882.0 249032.0 35102.8 36097.8 59842.7 60350.7 60599.4 37827.6 37860.2 38003.4 38048.2 38105.0 13893.9 14011.3 14014.9 14030.6 14037.9 10631.8 10717.9 10737.3 11030.7 11129.0 8569.0 8573.5 8574.3 8598.9 8611.0 3107.3 3304.4 3321.8 3324.7 3325.4 1014.4 1086.3 1149.9 1185.9 1193.9 32690.5 33129.5 33344.3 33411.8 33641.7 1086.5 1105.9 1116.9 1169.5 1288.8 17399.7 17503.8 17576.4 17588.3 17732.6 574992.0 580393.0 583127.0 583242.0 583936.0 60700.0 61249.0 61293.7 61336.7 61406.0 1286.9 1358.3 1398.5 1405.2 1415.1 33185.0 34292.5 34344.0 34439.0 34623.7 51253.2 51721.0 51844.0 52019.0 52045.0 358589.0 364474.0 365481.0 365911.0 366087.0 25774.2 28141.9 28641.3 28775.6 30563.2 49047.0 49770.3 49832.0 50391.7 50480.2 41479.8 41799.4 42017.4 43024.8 43434.3 40518.2 42418.6 42632.0 42866.1 43082.0 41597.0 42476.4 43107.8 43284.0 45126.3 36579.8 38099.2 38538.4 38931.2 38980.4 28189.3 28770.0 29369.3 29441.3 29473.4 21:15:13 INFO - PROCESS | 20332 | 21:15:13 INFO - PROCESS | 20332 | [#2] jquery.html Cycles:180 Average:26239.40 Median:2483.26 stddev:67343.06 (2711.9%) stddev-sans-first:67504.04 21:15:13 INFO - PROCESS | 20332 | Values: 401.6 410.8 411.0 412.5 417.9 12797.5 17813.6 18853.3 19583.5 19603.2 14403.4 17411.7 18239.1 18574.7 18951.4 5641.2 5768.7 5803.4 5825.2 5837.3 5753.2 5796.0 5803.3 5804.6 5804.9 4125.8 6179.3 6446.3 6455.4 6583.6 6141.8 6356.1 6527.1 6541.3 6566.0 5682.7 5703.3 5723.1 5725.2 5725.8 21620.6 21827.7 22816.5 22905.2 22929.3 2306.7 2378.2 2402.4 2564.1 2714.2 14057.8 14387.7 14698.1 14892.3 14898.3 1930.4 2007.9 2013.2 2053.1 2076.8 69003.7 73175.0 75435.2 76013.0 77525.6 9652.0 10296.6 10989.3 11211.4 11345.4 15374.8 15447.2 15452.8 15481.1 15505.0 7511.9 7739.9 7825.7 7943.6 7959.6 7166.7 7244.3 7269.3 7362.9 7375.0 4301.4 4410.3 4703.4 4797.5 4797.6 1980.3 2019.8 2038.9 2092.6 2101.3 945.5 988.8 1032.2 1043.6 1079.7 18173.7 18220.3 18805.4 18957.3 18993.7 1004.6 1010.4 1017.6 1041.2 1069.1 10249.8 10599.6 10600.8 10646.6 10670.5 363397.0 364288.0 364373.0 456138.0 463215.0 90606.5 96266.0 97061.5 97418.0 97733.0 976.3 1044.2 1046.0 1054.8 1062.5 16744.6 16907.2 17293.3 17396.7 17613.0 34674.8 41213.6 42082.0 43129.1 43464.9 55363.7 56143.7 56423.0 56743.4 58387.1 8311.3 8456.8 8574.3 8591.6 8670.3 9013.5 12261.8 12598.2 12618.7 12639.7 6272.4 7452.8 10483.3 10912.8 10984.8 10617.2 10745.4 10762.8 10811.9 10963.4 10624.9 10820.3 10904.2 11017.4 11022.7 8224.5 8282.1 8401.1 8586.6 8661.8 10753.0 10901.2 10928.4 10995.5 11177.7 21:15:13 INFO - PROCESS | 20332 | 21:15:13 INFO - PROCESS | 20332 | [#3] mootools.html Cycles:180 Average:5988.76 Median:2443.38 stddev:3433.18 (140.5%) stddev-sans-first:3425.36 21:15:13 INFO - PROCESS | 20332 | Values: 1382.4 1519.6 1563.9 1695.7 1818.7 8763.9 9209.8 9217.7 9219.0 9228.7 8935.8 9122.6 9129.2 9135.4 9145.4 2090.2 2295.7 2390.2 2401.8 2435.7 2382.0 2414.7 2437.7 2440.1 2441.5 2377.9 2408.4 2413.8 2421.9 2422.8 2015.0 2287.4 2328.7 2331.1 2334.0 2365.8 2418.9 2432.6 2443.1 2447.0 8961.8 8969.8 9010.1 9024.5 9036.9 5300.1 5364.9 5394.1 5394.5 5409.2 3368.5 3433.7 3452.6 3599.9 3610.3 1133.1 1147.8 1171.4 1193.3 1205.9 12522.2 12738.2 12739.0 12742.9 12755.2 4877.0 4939.1 4945.5 4953.4 5022.9 10842.3 10872.8 10874.9 10879.5 10890.2 5540.2 5591.6 5607.8 5611.2 5614.0 4406.1 4991.2 5090.9 5113.5 5189.4 4167.3 4181.6 4232.1 4267.4 4272.7 1320.8 1357.5 1365.8 1370.2 1376.1 1001.2 1036.7 1041.9 1043.0 1045.9 6002.8 6111.4 6161.4 6165.2 6284.6 480.7 481.5 482.8 483.8 505.7 3931.2 4060.8 4105.7 4109.2 4146.5 10874.6 11192.9 11323.9 11355.1 11365.1 11242.0 11285.2 11339.7 11348.2 11352.5 7984.6 8356.8 8371.0 8373.0 8494.4 5999.4 6160.3 6189.8 6227.1 6273.7 10123.8 10356.8 10513.7 10527.9 10551.6 10028.2 10453.0 10727.4 10747.8 10766.5 7085.5 7682.6 7841.5 8127.8 8310.9 8958.7 8969.7 8984.2 9023.1 9048.9 7874.0 8055.5 8058.6 8118.5 8130.8 7512.9 7537.5 7874.2 8035.9 8044.0 7149.2 7190.9 7217.4 7231.6 7236.9 5160.3 5290.5 5300.2 5301.2 5345.9 5313.1 5324.8 5332.9 5485.9 5522.1 21:15:13 INFO - PROCESS | 20332 | 21:15:13 INFO - PROCESS | 20332 | [#4] prototype.html Cycles:180 Average:4653.15 Median:5322.09 stddev:1375.11 (25.8%) stddev-sans-first:1340.14 21:15:13 INFO - PROCESS | 20332 | Values: 329.9 332.1 335.3 337.0 337.4 5261.9 5301.3 5323.6 5338.4 5348.3 5259.2 5267.5 5270.7 5277.2 5281.2 3961.5 4011.7 4092.9 4108.1 4150.5 4086.4 4117.9 4121.4 4130.5 4145.8 3936.8 4079.3 4117.6 4119.3 4124.3 4025.3 4102.8 4114.4 4118.3 4129.7 3601.4 3614.8 3618.8 3627.6 3655.6 5013.8 5017.7 5029.5 5038.9 5054.6 4510.5 4672.2 4684.4 4691.7 4709.5 5379.7 5406.7 5420.6 5446.5 5450.8 4014.9 4016.9 4018.0 4018.6 4025.3 5408.8 5684.7 5726.2 5738.9 5746.6 3998.4 4009.2 4013.9 4015.6 4023.2 4067.4 4073.0 4078.0 4114.6 4126.7 4491.5 4704.2 4722.6 4726.3 4730.1 5538.2 5571.3 5574.4 5583.7 5585.4 1361.7 1386.3 1398.7 1398.7 1401.6 901.0 910.9 915.0 915.8 960.5 5267.7 5290.6 5292.4 5295.4 5320.5 5570.8 5582.8 5585.4 5594.9 5600.4 5105.0 5274.6 5282.3 5302.7 5360.8 2947.0 2978.2 2990.9 3022.3 3023.7 5868.4 5926.9 5934.2 5949.3 5957.8 5569.3 5770.9 5788.9 5822.5 5829.6 5872.8 5876.6 5887.0 5889.3 5891.0 5379.2 5652.6 5663.6 5663.7 5669.7 5668.5 5687.9 5689.4 5704.0 5711.5 5893.9 5898.1 5926.6 5932.2 5934.6 3903.0 4025.4 4044.4 4049.4 4073.6 5597.4 5692.7 5701.1 5710.3 5730.6 5355.1 5376.6 5527.0 5547.6 5586.3 5498.2 5500.6 5530.4 5568.7 5602.8 5327.7 5488.8 5493.9 5497.5 5525.8 5558.3 5565.6 5575.5 5629.7 5632.9 5451.0 5454.1 5459.8 5468.6 5480.9 21:15:13 INFO - PROCESS | 20332 | 21:15:13 INFO - PROCESS | 20332 | [#5] yui.html Cycles:180 Average:15895.63 Median:4562.31 stddev:18805.35 (412.2%) stddev-sans-first:18823.80 21:15:13 INFO - PROCESS | 20332 | Values: 769.6 779.1 819.4 860.9 866.0 13835.3 15200.8 15416.7 16127.0 16191.9 14792.4 14877.1 14899.3 14965.6 14993.8 685.6 801.3 829.9 841.7 850.6 828.7 834.9 835.7 838.4 838.8 878.4 879.0 880.0 880.1 880.2 715.2 848.9 883.6 888.3 888.4 636.9 637.3 638.1 638.2 638.4 14427.8 14429.9 14449.4 14484.0 14487.6 13850.4 14127.7 14152.9 14214.6 14432.4 11555.6 11868.3 11960.9 11976.6 12195.3 4393.5 4397.1 4398.2 4453.5 4554.5 56518.7 56586.0 57822.7 58097.0 58177.0 10727.4 10910.9 11078.4 11463.3 11495.5 19552.6 19810.4 19838.2 19840.1 19931.7 8116.2 8184.1 8207.6 8297.2 8480.0 4558.2 4601.1 4665.0 4685.0 4802.9 3361.4 3447.0 3453.5 3460.6 3470.5 624.0 631.4 637.8 644.9 655.8 661.5 684.2 719.5 767.2 767.3 9199.8 9472.2 9590.9 9635.3 9707.0 618.0 650.2 732.5 765.8 767.9 4423.7 4447.8 4534.8 4535.7 4566.4 65473.3 68472.0 68479.3 68500.7 68500.7 59365.4 61391.0 61659.7 61755.4 62438.7 56356.4 57052.7 57742.7 57755.7 57953.4 9474.6 9596.7 9612.3 9642.9 10078.9 36686.8 36695.4 36941.0 37099.6 37771.6 47752.0 49146.5 49259.0 49702.0 50243.7 12644.4 12669.6 12678.9 12879.1 13241.4 14127.9 14193.3 14931.3 14941.6 15067.7 13193.9 13439.7 13542.5 14067.3 14399.6 12728.7 12922.0 12961.9 13361.7 13408.4 12325.6 12663.9 12738.9 13053.6 13159.8 10303.3 10660.1 11155.7 11209.0 11589.9 10421.1 10853.9 10891.6 10932.5 10969.6 21:15:13 INFO - PROCESS | 20332 | -------- Summary: end -------- 21:15:13 INFO - PROCESS | 20332 | 21:15:13 INFO - TEST-INFO | 20332: exit 0 21:15:13 INFO - TEST-OK | dromaeo_css | took 1112131ms 21:15:13 INFO - TEST-START | kraken 21:15:13 INFO - operating with platform_type : linux_ 21:15:13 INFO - Initialising browser for kraken test... 21:15:13 INFO - TEST-INFO | started process 20518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmBt32f/profile http://localhost:58927/getInfo.html) 21:15:17 INFO - PROCESS | 20518 | __metrics Screen width/height:1600/1200 21:15:17 INFO - PROCESS | 20518 | colorDepth:24 21:15:17 INFO - PROCESS | 20518 | Browser inner width/height: 1024/697 21:15:17 INFO - PROCESS | 20518 | __metrics 21:15:18 ERROR - PROCESS | 20518 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:15:19 INFO - TEST-INFO | 20518: exit 0 21:15:19 INFO - Browser initialized. 21:15:19 INFO - Running cycle 1/1 for kraken test... 21:15:19 INFO - TEST-INFO | started process 20599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmBt32f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:15:30 INFO - PROCESS | 20599 | RSS: Main: 153395200 21:15:30 INFO - PROCESS | 20599 | 21:15:33 INFO - PROCESS | 20599 | Cycle 1(1): loaded http://localhost:58927/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58927/tests/kraken/driver.html?testName=audio-beat-detection) 21:15:34 INFO - PROCESS | 20599 | RSS: Main: 208019456 21:15:34 INFO - PROCESS | 20599 | 21:15:37 INFO - PROCESS | 20599 | Cycle 1(1): loaded http://localhost:58927/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58927/tests/kraken/driver.html?testName=audio-dft) 21:15:37 INFO - PROCESS | 20599 | RSS: Main: 195710976 21:15:37 INFO - PROCESS | 20599 | 21:15:40 INFO - PROCESS | 20599 | Cycle 1(1): loaded http://localhost:58927/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58927/tests/kraken/driver.html?testName=audio-fft) 21:15:41 INFO - PROCESS | 20599 | RSS: Main: 266305536 21:15:41 INFO - PROCESS | 20599 | 21:15:43 INFO - PROCESS | 20599 | Cycle 1(1): loaded http://localhost:58927/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58927/tests/kraken/driver.html?testName=audio-oscillator) 21:15:44 INFO - PROCESS | 20599 | RSS: Main: 174034944 21:15:44 INFO - PROCESS | 20599 | 21:15:46 INFO - PROCESS | 20599 | Cycle 1(1): loaded http://localhost:58927/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58927/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:15:47 INFO - PROCESS | 20599 | RSS: Main: 179273728 21:15:47 INFO - PROCESS | 20599 | 21:15:50 INFO - PROCESS | 20599 | Cycle 1(1): loaded http://localhost:58927/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58927/tests/kraken/driver.html?testName=imaging-darkroom) 21:15:51 INFO - PROCESS | 20599 | RSS: Main: 215425024 21:15:51 INFO - PROCESS | 20599 | 21:15:54 INFO - PROCESS | 20599 | Cycle 1(1): loaded http://localhost:58927/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58927/tests/kraken/driver.html?testName=imaging-desaturate) 21:15:55 INFO - PROCESS | 20599 | RSS: Main: 213463040 21:15:55 INFO - PROCESS | 20599 | 21:15:58 INFO - PROCESS | 20599 | Cycle 1(1): loaded http://localhost:58927/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58927/tests/kraken/driver.html?testName=json-parse-financial) 21:15:58 INFO - PROCESS | 20599 | RSS: Main: 214519808 21:15:58 INFO - PROCESS | 20599 | 21:16:00 INFO - PROCESS | 20599 | Cycle 1(1): loaded http://localhost:58927/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58927/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:16:01 INFO - PROCESS | 20599 | RSS: Main: 204312576 21:16:01 INFO - PROCESS | 20599 | 21:16:02 INFO - PROCESS | 20599 | Cycle 1(1): loaded http://localhost:58927/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58927/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:16:03 INFO - PROCESS | 20599 | RSS: Main: 207958016 21:16:03 INFO - PROCESS | 20599 | 21:16:05 INFO - PROCESS | 20599 | Cycle 1(1): loaded http://localhost:58927/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58927/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:16:06 INFO - PROCESS | 20599 | RSS: Main: 217092096 21:16:06 INFO - PROCESS | 20599 | 21:16:08 INFO - PROCESS | 20599 | Cycle 1(1): loaded http://localhost:58927/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:16:09 INFO - PROCESS | 20599 | RSS: Main: 224980992 21:16:09 INFO - PROCESS | 20599 | 21:16:12 INFO - PROCESS | 20599 | Cycle 1(1): loaded http://localhost:58927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:16:12 INFO - PROCESS | 20599 | RSS: Main: 221868032 21:16:12 INFO - PROCESS | 20599 | 21:16:14 INFO - PROCESS | 20599 | Cycle 1(1): loaded http://localhost:58927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58927/tests/kraken/driver.html?testName=ai-astar) 21:16:14 INFO - PROCESS | 20599 | RSS: Main: 268906496 21:16:14 INFO - PROCESS | 20599 | 21:16:14 INFO - PROCESS | 20599 | __start_tp_report 21:16:14 INFO - PROCESS | 20599 | _x_x_mozilla_page_load 21:16:14 INFO - PROCESS | 20599 | _x_x_mozilla_page_load_details 21:16:14 INFO - PROCESS | 20599 | |i|pagename|runs| 21:16:14 INFO - PROCESS | 20599 | |0;ai-astar;112;107;110;111;110;112;110;110;110;110 21:16:14 INFO - PROCESS | 20599 | |1;audio-beat-detection;149;131;129;202;125;126;153;125;155;124 21:16:14 INFO - PROCESS | 20599 | |2;audio-dft;160;160;161;160;161;161;161;163;162;161 21:16:14 INFO - PROCESS | 20599 | |3;audio-fft;75;75;74;136;76;76;74;75;114;74 21:16:14 INFO - PROCESS | 20599 | |4;audio-oscillator;97;92;157;92;92;93;121;92;93;135 21:16:14 INFO - PROCESS | 20599 | |5;imaging-gaussian-blur;116;116;116;116;117;116;117;117;117;118 21:16:14 INFO - PROCESS | 20599 | |6;imaging-darkroom;146;145;146;146;146;145;145;146;145;145 21:16:14 INFO - PROCESS | 20599 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;94 21:16:14 INFO - PROCESS | 20599 | |8;json-parse-financial;58;57;58;57;58;60;58;112;55;55 21:16:14 INFO - PROCESS | 20599 | |9;json-stringify-tinderbox;61;62;62;62;61;61;61;62;61;63 21:16:14 INFO - PROCESS | 20599 | |10;stanford-crypto-aes;84;80;78;83;78;78;80;78;80;78 21:16:14 INFO - PROCESS | 20599 | |11;stanford-crypto-ccm;122;124;128;120;124;116;120;128;185;127 21:16:14 INFO - PROCESS | 20599 | |12;stanford-crypto-pbkdf2;159;157;159;166;162;158;157;159;158;157 21:16:14 INFO - PROCESS | 20599 | |13;stanford-crypto-sha256-iterative;62;64;62;62;63;60;63;60;60;62 21:16:14 INFO - PROCESS | 20599 | __end_tp_report 21:16:14 INFO - PROCESS | 20599 | __start_cc_report 21:16:14 INFO - PROCESS | 20599 | _x_x_mozilla_cycle_collect,1861 21:16:14 INFO - PROCESS | 20599 | __end_cc_report 21:16:14 INFO - PROCESS | 20599 | __startTimestamp1464063374803__endTimestamp 21:16:14 INFO - PROCESS | 20599 | 21:16:14 INFO - PROCESS | 20599 | ------- Summary: start ------- 21:16:14 INFO - PROCESS | 20599 | Number of tests: 14 21:16:14 INFO - PROCESS | 20599 | 21:16:14 INFO - PROCESS | 20599 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.00 stddev:1.40 (1.3%) stddev-sans-first:1.32 21:16:14 INFO - PROCESS | 20599 | Values: 112.0 107.0 110.0 111.0 110.0 112.0 110.0 110.0 110.0 110.0 21:16:14 INFO - PROCESS | 20599 | 21:16:14 INFO - PROCESS | 20599 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:140.00 stddev:24.47 (17.5%) stddev-sans-first:25.81 21:16:14 INFO - PROCESS | 20599 | Values: 149.0 131.0 129.0 202.0 125.0 126.0 153.0 125.0 155.0 124.0 21:16:14 INFO - PROCESS | 20599 | 21:16:14 INFO - PROCESS | 20599 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 21:16:14 INFO - PROCESS | 20599 | Values: 160.0 160.0 161.0 160.0 161.0 161.0 161.0 163.0 162.0 161.0 21:16:14 INFO - PROCESS | 20599 | 21:16:14 INFO - PROCESS | 20599 | [#3] audio-fft Cycles:10 Average:84.90 Median:75.00 stddev:21.77 (29.0%) stddev-sans-first:22.80 21:16:14 INFO - PROCESS | 20599 | Values: 75.0 75.0 74.0 136.0 76.0 76.0 74.0 75.0 114.0 74.0 21:16:14 INFO - PROCESS | 20599 | 21:16:14 INFO - PROCESS | 20599 | [#4] audio-oscillator Cycles:10 Average:106.40 Median:92.00 stddev:23.26 (25.3%) stddev-sans-first:24.42 21:16:14 INFO - PROCESS | 20599 | Values: 97.0 92.0 157.0 92.0 92.0 93.0 121.0 92.0 93.0 135.0 21:16:14 INFO - PROCESS | 20599 | 21:16:14 INFO - PROCESS | 20599 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 21:16:14 INFO - PROCESS | 20599 | Values: 116.0 116.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 118.0 21:16:14 INFO - PROCESS | 20599 | 21:16:14 INFO - PROCESS | 20599 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 21:16:14 INFO - PROCESS | 20599 | Values: 146.0 145.0 146.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 21:16:14 INFO - PROCESS | 20599 | 21:16:14 INFO - PROCESS | 20599 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:16:14 INFO - PROCESS | 20599 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 21:16:14 INFO - PROCESS | 20599 | 21:16:14 INFO - PROCESS | 20599 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:58.00 stddev:17.35 (29.9%) stddev-sans-first:18.32 21:16:14 INFO - PROCESS | 20599 | Values: 58.0 57.0 58.0 57.0 58.0 60.0 58.0 112.0 55.0 55.0 21:16:14 INFO - PROCESS | 20599 | 21:16:14 INFO - PROCESS | 20599 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 21:16:14 INFO - PROCESS | 20599 | Values: 61.0 62.0 62.0 62.0 61.0 61.0 61.0 62.0 61.0 63.0 21:16:14 INFO - PROCESS | 20599 | 21:16:14 INFO - PROCESS | 20599 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:2.21 (2.8%) stddev-sans-first:1.72 21:16:14 INFO - PROCESS | 20599 | Values: 84.0 80.0 78.0 83.0 78.0 78.0 80.0 78.0 80.0 78.0 21:16:14 INFO - PROCESS | 20599 | 21:16:14 INFO - PROCESS | 20599 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:125.50 stddev:19.92 (15.9%) stddev-sans-first:20.95 21:16:14 INFO - PROCESS | 20599 | Values: 122.0 124.0 128.0 120.0 124.0 116.0 120.0 128.0 185.0 127.0 21:16:14 INFO - PROCESS | 20599 | 21:16:14 INFO - PROCESS | 20599 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:159.00 stddev:2.82 (1.8%) stddev-sans-first:2.99 21:16:14 INFO - PROCESS | 20599 | Values: 159.0 157.0 159.0 166.0 162.0 158.0 157.0 159.0 158.0 157.0 21:16:14 INFO - PROCESS | 20599 | 21:16:14 INFO - PROCESS | 20599 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:1.40 (2.3%) stddev-sans-first:1.48 21:16:14 INFO - PROCESS | 20599 | Values: 62.0 64.0 62.0 62.0 63.0 60.0 63.0 60.0 60.0 62.0 21:16:14 INFO - PROCESS | 20599 | -------- Summary: end -------- 21:16:14 INFO - PROCESS | 20599 | 21:16:15 INFO - TEST-INFO | 20599: exit 0 21:16:15 INFO - TEST-OK | kraken | took 62101ms 21:16:15 INFO - SUITE-END | took 1174s 21:16:15 INFO - Completed test suite (00:19:34) 21:16:15 INFO - javascript benchmark 21:16:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.798838075525, 3100.720935115839, 3116.2520994961214, 3136.654967953526, 3154.4164329599025, 5291.126964050932, 5354.491323324288, 5382.6232163748555, 5431.0, 5440.3743569489525, 5280.445553216915, 5292.206169074631, 5306.70813105279, 5383.219433182187, 5440.6735595864175, 4835.854924352275, 4877.804887804484, 4888.73111978841, 4891.975540122295, 5081.796728130888, 4974.726390048546, 4994.750262486879, 5025.321581586476, 5040.36995375578, 5043.949560504403, 4795.448523419799, 4855.223164293714, 4869.0, 4875.8781030474165, 4917.262410638415, 4865.270209468573, 4876.683015603974, 4919.950800491985, 4930.383702037246, 4969.850904472872, 4768.2847572864, 4888.657793954425, 4906.460289368167, 4916.852494425173, 4944.777485013183, 5247.055530004598, 5311.070562651521, 5311.707856067915, 5379.67721936685, 5393.460653934575, 5816.854578635525, 5821.941780582225, 5842.211301474289, 5845.941540584582, 5848.707564621752, 5608.831735047955, 5736.7992120276, 5788.710564471759, 5864.1203819427, 5916.911246331309, 5418.539424148991, 5451.100568406208, 5466.535344495723, 5466.890662186774, 5469.234307196995, 5953.196318497034, 5970.611910225822, 5970.970145149333, 5975.19334889793, 5976.432238937294, 5451.127819548853, 5611.9438805612235, 5650.067738823048, 5671.51792097668, 5763.394843541451, 5809.099589563624, 5842.1820945066875, 5844.327902291291, 5846.269216347957, 5849.122631605208, 5768.077107662753, 5776.480116789509, 5780.566457515703, 5784.797532086441, 5790.160426738099, 5464.398916119224, 5698.3162020556965, 5729.512991395778, 5761.769529218868, 5807.186993820868, 4412.492563355255, 4412.889677758018, 4421.0, 4424.756638384855, 4456.6211871991245, 3834.9424758628643, 3922.2743792398496, 3929.3713005918917, 3937.1338305572726, 3954.9209015819524, 5384.434634363413, 5423.484768946943, 5428.185772134211, 5478.616496845262, 5488.533474654699, 5790.826275211751, 5806.1581070744505, 5834.912476312858, 5836.358000619928, 5890.734916928748, 5446.101393270066, 5458.536024437888, 5462.508374246337, 5463.043967305705, 5463.863403414946, 4725.314829349725, 4755.167845627001, 4763.4522029967, 4800.711957282574, 4829.758512074382, 5944.286685597756, 5950.464458198783, 5953.3451320354725, 5956.0768080946655, 5957.880842383128, 5642.125470552071, 5731.856703582361, 5739.799107031401, 5743.195952566561, 5746.195532625352, 5915.58590898633, 5950.851228719317, 5977.46202841729, 6026.186464827368, 6033.0, 5674.375818659862, 5684.658920464785, 5695.715214239354, 5697.4302569742695, 5699.800506982236, 5635.0702134147405, 5694.800681976111, 5794.971025144847, 5807.94192058074, 5811.302643682785, 5563.805266815642, 5637.5489960802215, 5640.0, 5642.322921249476, 5694.4590263924865, 5577.832665020056, 5624.409437009219, 5630.5214056805635, 5633.380328163817, 5640.520555752807, 5358.571314294925, 5462.617616766788, 5514.117741161395, 5528.834134975958, 5540.806071787468, 5697.259356283656, 5722.828315150552, 5729.255196824386, 5730.1977723119635, 5740.483356497935, 5558.722063896708, 5564.137558678412, 5565.55475561946, 5566.276384070207, 5567.109262517978], "value": 5312.795435363916, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.5149754447668, 625.2621906150741, 634.4258446106276, 638.2946843737669, 652.0, 34008.82995585022, 45677.31484027738, 45812.312815307756, 45941.31088033682, 46074.30888536674, 46357.53642463574, 46758.0, 46822.53177468224, 46866.29700554486, 46929.29606055912, 8102.837943241132, 8712.215900568948, 8877.112288771135, 8878.955605221965, 10498.947505262464, 10210.438425886574, 10644.840327395095, 10664.360138391683, 10669.466526673636, 10671.893281067167, 10623.681289561326, 10627.309224900395, 10669.946650266738, 10673.946630266877, 10678.893211067907, 10568.365898046104, 10591.576336946513, 10608.57565697375, 10613.57545698171, 10619.150467962545, 10463.68608941733, 10561.155107591374, 10563.683089507327, 10566.630167944086, 10568.52441640128, 42154.0, 42942.57057429417, 42952.35571466431, 42958.35562466565, 42965.570344296466, 3567.625399333059, 3611.8916432507067, 3662.468942003421, 3686.318031164243, 3874.2057878134915, 33156.1710957228, 33383.16542086443, 33690.83154584211, 33704.49443258353, 34143.829280853686, 4284.850030248957, 4314.80583373749, 4377.0, 4418.4256046714045, 4600.861974140781, 247757.0, 248103.0, 248474.0, 248882.0, 249032.0, 35102.824485877914, 36097.8195109028, 59842.70078649579, 60350.69824650849, 60599.394006059374, 37827.62172378296, 37860.242795143946, 38003.429948550795, 38048.23903521914, 38105.0, 13893.930530347283, 14011.299435028412, 14014.929925350512, 14030.579082627333, 14037.876969842593, 10631.84052239217, 10717.946410268054, 10737.302075365076, 11030.724231894266, 11129.0, 8569.0, 8573.485590864568, 8574.27118694918, 8598.914010859937, 8610.956945215234, 3107.300857307088, 3304.3556506481004, 3321.7674762766856, 3324.734021278292, 3325.446504337762, 1014.3761586624321, 1086.2613422872364, 1149.8620165580185, 1185.9110566707532, 1193.886580774825, 32690.509642355384, 33129.50305745416, 33344.3331133376, 33411.83294083514, 33641.663583364345, 1086.5002099034532, 1105.850710154135, 1116.8827273136367, 1169.479581586186, 1288.7937929931354, 17399.652006960045, 17503.82496175022, 17576.38482653101, 17588.296468141387, 17732.645347092985, 574992.0, 580393.0, 583127.0, 583242.0, 583936.0, 60700.0, 61249.0, 61293.69353153206, 61336.69331653313, 61406.0, 1286.8584455709865, 1358.3344161360862, 1398.5035312463929, 1405.1639274631577, 1415.0778642104228, 33185.0, 34292.48561271633, 34344.0, 34439.0, 34623.65376346305, 51253.231201531264, 51721.0, 51844.0, 52019.0, 52045.0, 358589.0, 364474.0, 365481.0, 365911.0, 366087.0, 25774.226773196835, 28141.859290703414, 28641.28396790097, 28775.568366474938, 30563.2359191022, 49047.0, 49770.25344619906, 49832.0, 50391.74804125956, 50480.24279635735, 41479.7926010368, 41799.37300940549, 42017.36973945332, 43024.78487607542, 43434.34848477212, 40518.18963620652, 42418.57581424146, 42632.0, 42866.14267714566, 43082.0, 41597.0, 42476.362854557825, 43107.78446107749, 43284.0, 45126.32310515411, 36579.81710091539, 38099.23801523899, 38538.421923671725, 38931.221375572895, 38980.41529377005, 28189.295267618472, 28770.0, 29369.265768355963, 29441.263968400963, 29473.410531789672], "value": 19326.833966584258, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.64454457804845, 410.82950575511165, 410.96301332880046, 412.4658567155535, 417.8892593462731, 12797.488100475994, 17813.55466113346, 18853.340133095346, 19583.510412239684, 19603.215871365148, 14403.385326969448, 17411.651766964653, 18239.088045597735, 18574.721379179322, 18951.431457056275, 5641.18202860586, 5768.711564421783, 5803.390643982384, 5825.155352473888, 5837.299524057119, 5753.165790960308, 5795.971020144893, 5803.274590676166, 5804.564657650672, 5804.854878628047, 4125.793710314488, 6179.3202747697715, 6446.323136070715, 6455.386738259858, 6583.637899915503, 6141.754329826802, 6356.110144579762, 6527.086207930894, 6541.345865413445, 6566.0, 5682.687452190128, 5703.3441154267375, 5723.141528770676, 5725.198472213893, 5725.799597014126, 21620.567588648297, 21827.67258491124, 22816.54366912669, 22905.19831805879, 22929.31212063641, 2306.7347255065715, 2378.203301893868, 2402.447437089479, 2564.0769323043687, 2714.1993112031996, 14057.78913316301, 14387.712245755027, 14698.11811291326, 14892.255387230703, 14898.329575169035, 1930.362980216525, 2007.909644066006, 2013.222350551594, 2053.0966374795044, 2076.781937896529, 69003.65498172477, 73175.0, 75435.24564754337, 76013.0, 77525.61237193778, 9652.0, 10296.588136474456, 10989.285696429706, 11211.383373914514, 11345.432728363548, 15374.769378459332, 15447.227638618024, 15452.845471545366, 15481.148536830357, 15505.0, 7511.924880751232, 7739.883901741478, 7825.726099586487, 7943.563104029334, 7959.562224077731, 7166.677499512534, 7244.348008679244, 7269.346688458674, 7362.8587568926905, 7374.963125184339, 4301.397804307399, 4410.272305069691, 4703.365045718852, 4797.496262892416, 4797.592204662573, 1980.3068925876116, 2019.7677267114177, 2038.9184432622826, 2092.6337890869036, 2101.2750601042617, 945.5366870233673, 988.8071825993862, 1032.1897310611134, 1043.5773511727762, 1079.7030816525362, 18173.7273940891, 18220.262731689858, 18805.435836924913, 18957.336493222672, 18993.715094273597, 1004.5529739266102, 1010.3584224017802, 1017.5573625472942, 1041.1930753665818, 1069.0752499088233, 10249.795004099877, 10599.576016959236, 10600.787984240273, 10646.574137034431, 10670.519826607666, 363397.0, 364288.0, 364373.0, 456138.0, 463215.0, 90606.54696726475, 96266.0, 97061.51469242609, 97418.0, 97733.0, 976.3165783951263, 1044.1959691037857, 1046.04809623244, 1054.8154073037188, 1062.4528367890543, 16744.581385465463, 16907.154642268084, 17293.308267669152, 17396.73904891453, 17613.0, 34674.826625866706, 41213.58786412217, 42082.0, 43129.13741725085, 43464.91337716456, 55363.72318138384, 56143.71928140333, 56423.0, 56743.432565675466, 58387.124193137985, 8311.335093192409, 8456.788580285542, 8574.27118694918, 8591.613377398156, 8670.263027642468, 9013.544288625426, 12261.754764904474, 12598.244105353708, 12618.747625047265, 12639.747205056032, 6272.40412160844, 7452.770292901828, 10483.266171367932, 10912.78174436491, 10984.780304394028, 10617.1506279499, 10745.409002504937, 10762.784744305227, 10811.945940270249, 10963.397013164353, 10624.893751062391, 10820.32284995827, 10904.236703430684, 11017.44912754343, 11022.724431889266, 8224.506529608243, 8282.130376310643, 8401.075881653136, 8586.570671466277, 8661.826763464822, 10753.0, 10901.236913415985, 10928.398938058483, 10995.450227488753, 11177.72055698614], "value": 9096.716125579755, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1382.412474698253, 1519.620094976256, 1563.9296231669573, 1695.6523912597918, 1818.7271909213625, 8763.868541971868, 9209.815803683923, 9217.677381291656, 9218.953905230474, 9228.67699630513, 8935.821283574325, 9122.635094596208, 9129.224015958634, 9135.406198597086, 9145.359824812265, 2090.153487837428, 2295.735990361105, 2390.2112302940077, 2401.7598240175976, 2435.683361163055, 2382.0471811275456, 2414.7343792182846, 2437.7440368761204, 2440.0605766779827, 2441.4506735984437, 2377.940551486218, 2408.4460574067975, 2413.7706917842866, 2421.8910149043336, 2422.769836865495, 2014.9597008059902, 2287.4167087392775, 2328.7205535335697, 2331.114176612893, 2334.031376978552, 2365.775251351119, 2418.8669623170717, 2432.6472661464168, 2443.0960544598433, 2447.0334217983973, 8961.820763584692, 8969.775755606097, 9010.053944335816, 9024.503652299121, 9036.909630903738, 5300.072487314705, 5364.865878353073, 5394.056040192951, 5394.514493695547, 5409.161579955114, 3368.4610462326154, 3433.725301975836, 3452.585689717225, 3599.9460008099636, 3610.277944411102, 1133.0538999935063, 1147.7933971885057, 1171.3616079236751, 1193.2840295822523, 1205.9276443413423, 12522.186057906207, 12738.235705857678, 12738.999999999907, 12742.936285318514, 12755.17091389066, 4877.0, 4939.110960027229, 4945.505449455098, 4953.356063711694, 5022.924656130161, 10842.295250808673, 10872.78254434907, 10874.891251087387, 10879.456027198608, 10890.237683362247, 5540.2243685884005, 5591.6365436246515, 5607.831765047055, 5611.2144299798065, 5613.971930140405, 4406.074724307931, 4991.201407774739, 5090.872728181825, 5113.51421614946, 5189.40321862983, 4167.270727622654, 4181.644560212355, 4232.132412855419, 4267.402563641031, 4272.6795490338345, 1320.7754681704134, 1357.4638017983038, 1365.7951307303786, 1370.2258224103548, 1376.0986553807272, 1001.1990407673832, 1036.6682661548382, 1041.9218558608134, 1043.0456132638703, 1045.8692663417073, 6002.849928751729, 6111.419415155553, 6161.4146656067605, 6165.198524191826, 6284.591501552384, 480.6779457763307, 481.5112660649444, 482.826182574273, 483.808895486288, 505.73448939307156, 3931.1744533647684, 4060.7563546187325, 4105.7331273467125, 4109.178164367138, 4146.543880173179, 10874.565017399216, 11192.888071119185, 11323.943380283046, 11355.148363872742, 11365.147613928822, 11242.0, 11285.153613479022, 11339.716507087223, 11348.205625606128, 11352.545898164146, 7984.600769961478, 8356.791080222922, 8370.958145209235, 8373.0, 8494.447860889022, 5999.370066142992, 6160.260768707783, 6189.84525386869, 6227.128202051807, 6273.71768270438, 10123.797524049625, 10356.844647330145, 10513.737156570842, 10527.94736026315, 10551.630692925712, 10028.24788140907, 10453.0, 10727.40999245049, 10747.838782418426, 10766.46167691628, 7085.539439936388, 7682.577458239851, 7841.451098423056, 8127.83744325122, 8310.916890831015, 8958.68644597436, 8969.730908072768, 8984.23633991118, 9023.052579479061, 9048.90951090507, 7874.0, 8055.516668999879, 8058.637361318872, 8118.472299300763, 8130.75607731769, 7512.924870751441, 7537.510061845963, 7874.21257874208, 8035.879461808195, 8044.034715833904, 7149.249328820399, 7190.856182876418, 7217.422606191597, 7231.566106033655, 7236.927630723625, 5160.277561141518, 5290.497402746733, 5300.204969254489, 5301.204819277139, 5345.893082138413, 5313.149896016619, 5324.8136315228785, 5332.866678333073, 5485.917711234414, 5522.088855338824], "value": 4712.632199051119, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.88454041085606, 332.11656992400214, 335.2607500461482, 336.9898903032907, 337.35733427820014, 5261.8947621047555, 5301.3108295921575, 5323.627346085776, 5338.359396872376, 5348.288547664749, 5259.237410575473, 5267.52592266696, 5270.736463176845, 5277.182036784305, 5281.155015197569, 3961.544422391426, 4011.7191796574252, 4092.9386059209137, 4108.137291168858, 4150.522689890671, 4086.366613174963, 4117.897052573695, 4121.381792731085, 4130.545639979599, 4145.813438395279, 3936.822842972073, 4079.2657321682086, 4117.567655396185, 4119.320312148492, 4124.278251306025, 4025.335819589764, 4102.815373308208, 4114.423980642712, 4118.258713431596, 4129.710920235585, 3601.351756683796, 3614.8192590370377, 3618.7696183297544, 3627.619099994489, 3655.574326012857, 5013.774380152865, 5017.67385119966, 5029.497050294978, 5038.949610503922, 5054.570361519275, 4510.481294651091, 4672.15901137795, 4684.407301517466, 4691.741954192518, 4709.458412282597, 5379.704116273603, 5406.729663516809, 5420.647657902224, 5446.474987003646, 5450.836474905759, 4014.879553613396, 4016.9397459038137, 4018.0, 4018.598140185987, 4025.3156963316014, 5408.810691625774, 5684.687342196177, 5726.169705392736, 5738.913916291259, 5746.569007324426, 3998.4402183694306, 4009.2182024505523, 4013.9397909031386, 4015.598440155961, 4023.2355852387955, 4067.4171900843176, 4072.9796351018053, 4078.0, 4114.6091121343425, 4126.690498212646, 4491.46102467706, 4704.1767690654, 4722.574968252874, 4726.291056341576, 4730.053989202173, 5538.224648549206, 5571.303587051619, 5574.358948720868, 5583.664980101207, 5585.413531579207, 1361.7140400516003, 1386.3207028556137, 1398.7202559488144, 1398.7271582859548, 1401.5515035188641, 900.9549522523847, 910.9498977556166, 914.9908500915038, 915.7939463620633, 960.5389413081621, 5267.71027593486, 5290.550303224269, 5292.44429334922, 5295.364556253197, 5320.547753441001, 5570.777168913198, 5582.7766889324785, 5585.413531579125, 5594.86012849682, 5600.4399560044485, 5104.9744751276, 5274.551663108678, 5282.339707536558, 5302.655327403706, 5360.839174824761, 2946.985265073704, 2978.22566132807, 2990.8654110565076, 3022.259546411143, 3023.727864492162, 5868.383819698955, 5926.911096333559, 5934.1692163097205, 5949.315828679671, 5957.821265362046, 5569.303837020372, 5770.855728606734, 5788.913166302509, 5822.534197264209, 5829.59192856496, 5872.765089396462, 5876.5612270907095, 5886.970565147147, 5889.263842019747, 5891.027980383189, 5379.246905433164, 5652.604317697722, 5663.603547751618, 5663.7451314690115, 5669.744861481326, 5668.489835914623, 5687.857803554944, 5689.374168841507, 5704.033902370827, 5711.485966263056, 5893.852653683693, 5898.144769008384, 5926.614770039933, 5932.228810254639, 5934.6142500737315, 3902.9609703902597, 4025.3961905714377, 4044.373122166069, 4049.4128351389472, 4073.6130067643526, 5597.356304025089, 5692.747595528977, 5701.144828275792, 5710.2862142232225, 5730.598858079894, 5355.116405793001, 5376.623636345575, 5527.0, 5547.611667183259, 5586.329640443173, 5498.230247765236, 5500.58745594074, 5530.419305972815, 5568.749406276646, 5602.803901863415, 5327.706976116351, 5488.835334939959, 5493.862653433696, 5497.505224529811, 5525.834224973257, 5558.277423934863, 5565.55475561946, 5575.498205161555, 5629.718514074362, 5632.901584191043, 5450.972745136249, 5454.100073487989, 5459.754311056092, 5468.589855760913, 5480.945190548044], "value": 4213.741390841241, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.6498093367518, 779.1157036763274, 819.4345901328084, 860.896692396912, 865.9826803463927, 13835.308234588269, 15200.847991520068, 15416.691666166684, 16127.0, 16191.919040404782, 14792.408303667868, 14877.107373557566, 14899.32953017114, 14965.551033469013, 14993.77509337358, 685.5715178013742, 801.3348920396057, 829.9460535065232, 841.6507149532937, 850.6427300533791, 828.7430896422098, 834.8831163637095, 835.7116794705847, 838.4089217101958, 838.7567605394428, 878.3587980774039, 879.0374539878823, 880.0143838900441, 880.1330689271063, 880.2078129683305, 715.1668306423011, 848.8514509960763, 883.6067949762358, 888.258304315897, 888.3692578269437, 636.8567072408717, 637.2639601260552, 638.1162090504638, 638.2213699286909, 638.4413638066692, 14427.78358324626, 14429.85570144306, 14449.422023119063, 14484.0, 14487.56537303872, 13850.376733047036, 14127.71744565103, 14152.92923535386, 14214.644633884132, 14432.350544225535, 11555.595554155565, 11868.347240901747, 11960.940195298968, 11976.640700778904, 12195.268283902995, 4393.51671316155, 4397.142557201347, 4398.230309695822, 4453.465584129925, 4554.453465584118, 56518.71740641312, 56586.0, 57822.71088644614, 58097.0, 58177.0, 10727.409992450333, 10910.854360292215, 11078.390688512209, 11463.254888432226, 11495.54017839277, 19552.608947820965, 19810.40568782939, 19838.20647174097, 19840.107195176253, 19931.701024484646, 8116.188381161836, 8184.099749027602, 8207.630656620348, 8297.211764882448, 8480.024797148284, 4558.247889098328, 4601.148787474261, 4665.0, 4685.0395668887795, 4802.903941921212, 3361.3613413451367, 3447.0, 3453.4647129694936, 3460.567429071366, 3470.514128022079, 623.9719212635442, 631.4443289904855, 637.7831537277256, 644.8710257948429, 655.8262060553957, 661.497262080822, 684.1926526698444, 719.5215181903975, 767.1944458318743, 767.3362541401648, 9199.816003679889, 9472.194863436547, 9590.856137157949, 9635.277354198462, 9707.0, 617.962922224668, 650.1905128115432, 732.5494820685346, 765.8200322924108, 767.8502691975011, 4423.73457592539, 4447.799849006802, 4534.77326133692, 4535.705179163409, 4566.3781992266595, 65473.34526654768, 68472.0, 68479.31520684829, 68500.6574967122, 68500.6574967122, 59365.40634593599, 61391.0, 61659.691701541204, 61755.38244617496, 62438.68780656068, 56356.43643563594, 57052.71473642688, 57742.7112864433, 57755.711221444464, 57953.42046579564, 9474.573644186166, 9596.66411675588, 9612.252676807906, 9642.903570964201, 10078.899211007796, 36686.816565917, 36695.449568255965, 36941.0, 37099.62900370962, 37771.62228377681, 47752.0, 49146.508534914195, 49259.0, 49702.0, 50243.74878125586, 12644.367781611067, 12669.556565520163, 12678.936605316914, 12879.1038550917, 13241.404136813673, 14127.89483627853, 14193.29033548339, 14931.253437328307, 14941.626459338604, 15067.698646026798, 13193.934030329787, 13439.664008399868, 13542.526011589547, 14067.296635168404, 14399.56801295921, 12728.68178295513, 12922.0, 12961.935190324366, 13361.66595835112, 13408.396622151831, 12325.568605098779, 12663.93668031654, 12738.872611274139, 13053.608391748263, 13159.802602961156, 10303.330283531546, 10660.111517477166, 11155.665330040112, 11209.0, 11589.942050289694, 10421.114205292635, 10853.945730271298, 10891.564337426415, 10932.453377330943, 10969.616063437741], "value": 7041.28520079269, "unit": "score"}], "name": "dromaeo_css", "value": 7123.046935639256, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 110.0, 111.0, 110.0, 112.0, 110.0, 110.0, 110.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 131.0, 129.0, 202.0, 125.0, 126.0, 153.0, 125.0, 155.0, 124.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 160.0, 161.0, 161.0, 161.0, 163.0, 162.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 136.0, 76.0, 76.0, 74.0, 75.0, 114.0, 74.0], "value": 84.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 92.0, 157.0, 92.0, 92.0, 93.0, 121.0, 92.0, 93.0, 135.0], "value": 106.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 58.0, 57.0, 58.0, 60.0, 58.0, 112.0, 55.0, 55.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 61.0, 61.0, 61.0, 62.0, 61.0, 63.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 78.0, 83.0, 78.0, 78.0, 80.0, 78.0, 80.0, 78.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 124.0, 128.0, 120.0, 124.0, 116.0, 120.0, 128.0, 185.0, 127.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 159.0, 166.0, 162.0, 158.0, 157.0, 159.0, 158.0, 157.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 62.0, 62.0, 63.0, 60.0, 63.0, 60.0, 60.0, 62.0], "value": 61.8, "unit": "score"}], "name": "kraken", "value": 1515.8, "alertThreshold": 2.0}]} 21:16:16 INFO - Return code: 0 21:16:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:16:16 ERROR - # TBPL SUCCESS # 21:16:16 INFO - Running post-action listener: _resource_record_post_action 21:16:16 INFO - ##### 21:16:16 INFO - ##### Finished run-tests step (success) 21:16:16 INFO - ##### 21:16:16 INFO - Running post-run listener: _resource_record_post_run 21:16:16 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 493629440; Read time: 8; Write time: 384520 21:16:16 INFO - TinderboxPrint: CPU usage
13.1% 21:16:16 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 21:16:16 INFO - TinderboxPrint: I/O write bytes / time
493,629,440 / 384,520 21:16:16 INFO - TinderboxPrint: CPU idle
8,269.8 (86.9%) 21:16:16 INFO - TinderboxPrint: CPU user
1,202.5 (12.6%) 21:16:16 INFO - TinderboxPrint: Swap in / out
0 / 0 21:16:16 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 148713472; Read time: 0; Write time: 202452 21:16:16 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290414592; Read time: 8; Write time: 165716 21:16:16 INFO - Running post-run listener: _upload_blobber_files 21:16:16 INFO - Blob upload gear active. 21:16:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:16:16 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 21:16:16 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:16:16 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:16:17 INFO - (blobuploader) - INFO - Open directory for files ... 21:16:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:16:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:16:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:16:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:16:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:16:17 INFO - (blobuploader) - INFO - Done attempting. 21:16:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:16:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:16:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:16:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:16:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:16:23 INFO - (blobuploader) - INFO - Done attempting. 21:16:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:16:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:16:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:16:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:16:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:16:24 INFO - (blobuploader) - INFO - Done attempting. 21:16:24 INFO - (blobuploader) - INFO - Iteration through files over. 21:16:24 INFO - Return code: 0 21:16:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:16:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:16:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e54609ae95e036b23a67e008c91243da9bd1f9b6e4ffce3ce533a3d343b31b1cf8418b9f701f8fb6a32f351349d7de6a484bc932a89613bb69689315a498481", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6493c726300744173b3388c4f1946a8ec908364f9950bf3cd22082cd7042611cf370378bea67fe0278466ce7694011bb843b30cc448dc85e0bc855d7dbb48ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe1984bb8e91688e631f5646f28d7e4954dbe256ac323c5d148d16bddd4a3149a2a14211ea22607b13c287e8b978ef10fff6f6a3e86691d76af9d4618c937784"} 21:16:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:16:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:16:24 INFO - Contents: 21:16:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e54609ae95e036b23a67e008c91243da9bd1f9b6e4ffce3ce533a3d343b31b1cf8418b9f701f8fb6a32f351349d7de6a484bc932a89613bb69689315a498481", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6493c726300744173b3388c4f1946a8ec908364f9950bf3cd22082cd7042611cf370378bea67fe0278466ce7694011bb843b30cc448dc85e0bc855d7dbb48ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe1984bb8e91688e631f5646f28d7e4954dbe256ac323c5d148d16bddd4a3149a2a14211ea22607b13c287e8b978ef10fff6f6a3e86691d76af9d4618c937784"} 21:16:24 INFO - Running post-run listener: copy_logs_to_upload_dir 21:16:24 INFO - Copying logs to upload dir... 21:16:24 INFO - mkdir: /builds/slave/test/build/upload/logs 21:16:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.443715 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-23 21:16:24.365882) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 21:16:24.370913) ========= 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=ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3e54609ae95e036b23a67e008c91243da9bd1f9b6e4ffce3ce533a3d343b31b1cf8418b9f701f8fb6a32f351349d7de6a484bc932a89613bb69689315a498481", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6493c726300744173b3388c4f1946a8ec908364f9950bf3cd22082cd7042611cf370378bea67fe0278466ce7694011bb843b30cc448dc85e0bc855d7dbb48ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe1984bb8e91688e631f5646f28d7e4954dbe256ac323c5d148d16bddd4a3149a2a14211ea22607b13c287e8b978ef10fff6f6a3e86691d76af9d4618c937784"} build_url:https://queue.taskcluster.net/v1/task/OCTGIPLLShigOQEdrJGDIQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011424 build_url: 'https://queue.taskcluster.net/v1/task/OCTGIPLLShigOQEdrJGDIQ/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/Fx-Team/sha512/3e54609ae95e036b23a67e008c91243da9bd1f9b6e4ffce3ce533a3d343b31b1cf8418b9f701f8fb6a32f351349d7de6a484bc932a89613bb69689315a498481", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6493c726300744173b3388c4f1946a8ec908364f9950bf3cd22082cd7042611cf370378bea67fe0278466ce7694011bb843b30cc448dc85e0bc855d7dbb48ad", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fe1984bb8e91688e631f5646f28d7e4954dbe256ac323c5d148d16bddd4a3149a2a14211ea22607b13c287e8b978ef10fff6f6a3e86691d76af9d4618c937784"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 21:16:24.396080) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 21:16:24.396409) ========= 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=ed14279e38b05397cf4aa391000001a4-1464062138.555082-705811821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 21:16:24.480381) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 21:16:24.480714) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 21:16:24.481018) ========= ========= Total master_lag: 0.17 =========