builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-052 starttime: 1463444948.07 results: success (0) buildid: 20160516143016 builduid: de00ff9e295c493daa2796e9ea061e37 revision: ae689711c21875e2f732c97264e35527c7f6b963 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 17:29:08.070137) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-16 17:29:08.070836) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 17:29:08.071302) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-16 17:29:08.161114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 17:29:08.161669) ========= 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=826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-16 17:29:09-- 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% 103M=0s 2016-05-16 17:29:09 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.071853 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 17:29:08.254526) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 17:29:08.255038) ========= 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=826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020645 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 17:29:08.309205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 17:29:08.309820) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ae689711c21875e2f732c97264e35527c7f6b963 --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 ae689711c21875e2f732c97264e35527c7f6b963 --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=826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-16 17:29:10,116 truncating revision to first 12 chars 2016-05-16 17:29:10,116 Setting DEBUG logging. 2016-05-16 17:29:10,116 attempt 1/10 2016-05-16 17:29:10,116 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ae689711c218?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-16 17:29:11,086 unpacking tar archive at: fx-team-ae689711c218/testing/mozharness/ program finished with exit code 0 elapsedTime=1.230053 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-16 17:29:09.556199) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 17:29:09.556842) ========= script_repo_revision: ae689711c21875e2f732c97264e35527c7f6b963 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-16 17:29:09.557440) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 17:29:09.558011) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-16 17:29:09.571393) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-16 17:29:09.571971) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:29:11 INFO - MultiFileLogger online at 20160516 17:29:11 in /builds/slave/test 17:29:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:29:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:29:11 INFO - {'append_to_log': False, 17:29:11 INFO - 'base_work_dir': '/builds/slave/test', 17:29:11 INFO - 'blob_upload_branch': 'Fx-Team', 17:29:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:29:11 INFO - 'branch': 'Fx-Team', 17:29:11 INFO - 'buildbot_json_path': 'buildprops.json', 17:29:11 INFO - 'config_files': ('talos/linux_config.py',), 17:29:11 INFO - 'default_actions': ('clobber', 17:29:11 INFO - 'read-buildbot-config', 17:29:11 INFO - 'download-and-extract', 17:29:11 INFO - 'populate-webroot', 17:29:11 INFO - 'create-virtualenv', 17:29:11 INFO - 'install', 17:29:11 INFO - 'run-tests'), 17:29:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:29:11 INFO - 'download_minidump_stackwalk': True, 17:29:11 INFO - 'download_symbols': 'ondemand', 17:29:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:29:11 INFO - 'tooltool.py': '/tools/tooltool.py', 17:29:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:29:11 INFO - '/tools/misc-python/virtualenv.py')}, 17:29:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:29:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:29:11 INFO - 'installer_path': 'installer.exe', 17:29:11 INFO - 'log_level': 'info', 17:29:11 INFO - 'log_name': 'talos', 17:29:11 INFO - 'log_to_console': True, 17:29:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:29:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:29:11 INFO - 'opt_config_files': (), 17:29:11 INFO - 'pip_index': False, 17:29:11 INFO - 'sps_profile': False, 17:29:11 INFO - 'sps_profile_interval': 0, 17:29:11 INFO - 'suite': 'dromaeojs-e10s', 17:29:11 INFO - 'system_bits': '32', 17:29:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:29:11 INFO - 'title': 'talos-linux64-ix-052', 17:29:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:29:11 INFO - 'use_talos_json': True, 17:29:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:29:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:29:11 INFO - 'work_dir': 'build'} 17:29:11 INFO - ##### 17:29:11 INFO - ##### Running clobber step. 17:29:11 INFO - ##### 17:29:11 INFO - Running pre-action listener: _resource_record_pre_action 17:29:11 INFO - Running main action method: clobber 17:29:11 INFO - rmtree: /builds/slave/test/build 17:29:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:29:12 INFO - Running post-action listener: _resource_record_post_action 17:29:12 INFO - ##### 17:29:12 INFO - ##### Finished clobber step (success) 17:29:12 INFO - ##### 17:29:12 INFO - ##### 17:29:12 INFO - ##### Running read-buildbot-config step. 17:29:12 INFO - ##### 17:29:12 INFO - Running pre-action listener: _resource_record_pre_action 17:29:12 INFO - Running main action method: read_buildbot_config 17:29:12 INFO - Using buildbot properties: 17:29:12 INFO - { 17:29:12 INFO - "project": "", 17:29:12 INFO - "product": "firefox", 17:29:12 INFO - "script_repo_revision": "production", 17:29:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:29:12 INFO - "repository": "", 17:29:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:29:12 INFO - "buildid": "20160516143016", 17:29:12 INFO - "pgo_build": "True", 17:29:12 INFO - "basedir": "/builds/slave/test", 17:29:12 INFO - "buildnumber": 751, 17:29:12 INFO - "slavename": "talos-linux64-ix-052", 17:29:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:29:12 INFO - "platform": "ubuntu64_hw", 17:29:12 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:29:12 INFO - "branch": "fx-team", 17:29:12 INFO - "repo_path": "integration/fx-team", 17:29:12 INFO - "revision": "ae689711c21875e2f732c97264e35527c7f6b963", 17:29:12 INFO - "stage_platform": "linux64-pgo", 17:29:12 INFO - "builduid": "de00ff9e295c493daa2796e9ea061e37", 17:29:12 INFO - "slavebuilddir": "test" 17:29:12 INFO - } 17:29:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:29:12 INFO - Running post-action listener: _resource_record_post_action 17:29:12 INFO - ##### 17:29:12 INFO - ##### Finished read-buildbot-config step (success) 17:29:12 INFO - ##### 17:29:12 INFO - ##### 17:29:12 INFO - ##### Running download-and-extract step. 17:29:12 INFO - ##### 17:29:12 INFO - Running pre-action listener: _resource_record_pre_action 17:29:12 INFO - Running main action method: download_and_extract 17:29:12 INFO - mkdir: /builds/slave/test/build/tests 17:29:12 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')]} 17:29:12 INFO - https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:29:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:29:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:29:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:29:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:29:13 INFO - Downloaded 1361 bytes. 17:29:13 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:29:13 INFO - Using the following test package requirements: 17:29:13 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:29:13 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:29:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:29:13 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:29:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:29:13 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:29:13 INFO - u'jsshell-linux-x86_64.zip'], 17:29:13 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:29:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:29:13 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:29:13 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:29:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:29:13 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:29:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:29:13 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:29:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:29:13 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:29:13 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:29:13 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:29: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')]} 17:29:13 INFO - https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:29:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:29:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:29:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:29:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:29:14 INFO - Downloaded 24023864 bytes. 17:29:14 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'] 17:29:14 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 17:29:15 INFO - Return code: 0 17:29:15 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 17:29:15 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')]} 17:29:15 INFO - https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:29:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:29:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:29:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:29:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:29:16 INFO - Downloaded 24023864 bytes. 17:29:16 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'] 17:29:16 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 17:29:18 INFO - Return code: 0 17:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:18 INFO - https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:29:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:29:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:29:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:29:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:29:19 INFO - Downloaded 10840194 bytes. 17:29:19 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'] 17:29:19 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 17:29:19 INFO - Return code: 0 17:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:19 INFO - https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:29:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:29:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:29:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:29:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WOe0hKRJSUayknvFhm586A/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 17:29:20 INFO - Downloaded 58412024 bytes. 17:29:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:29:20 INFO - mkdir: /builds/slave/test/properties 17:29:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:29:20 INFO - Writing to file /builds/slave/test/properties/build_url 17:29:20 INFO - Contents: 17:29:20 INFO - build_url:https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:29:21 INFO - Running post-action listener: _resource_record_post_action 17:29:21 INFO - Running post-action listener: set_extra_try_arguments 17:29:21 INFO - ##### 17:29:21 INFO - ##### Finished download-and-extract step (success) 17:29:21 INFO - ##### 17:29:21 INFO - ##### 17:29:21 INFO - ##### Running populate-webroot step. 17:29:21 INFO - ##### 17:29:21 INFO - Running pre-action listener: _resource_record_pre_action 17:29:21 INFO - Running main action method: populate_webroot 17:29:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:29:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:29:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:29:21 INFO - '--tppagecycles', 17:29:21 INFO - '7'], 17:29:21 INFO - 'tests': ['tsvgm']}}, 17:29:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:29:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:29:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:29:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:29:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:29:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:29:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:29:21 INFO - 'talos_options': ['--disable-e10s'], 17:29:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:29:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:29:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:29:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:29:21 INFO - 'talos_options': ['--disable-e10s'], 17:29:21 INFO - 'tests': ['damp', 'tps']}, 17:29:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:29:21 INFO - 'tests': ['damp', 'tps']}, 17:29:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:29:21 INFO - 'tests': ['dromaeo_dom']}, 17:29:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:29:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:29:21 INFO - 'tests': ['a11yr', 17:29:21 INFO - 'ts_paint', 17:29:21 INFO - 'tpaint', 17:29:21 INFO - 'sessionrestore', 17:29:21 INFO - 'sessionrestore_no_auto_restore', 17:29:21 INFO - 'tabpaint']}, 17:29:21 INFO - 'other-e10s': {'tests': ['a11yr', 17:29:21 INFO - 'ts_paint', 17:29:21 INFO - 'tpaint', 17:29:21 INFO - 'sessionrestore', 17:29:21 INFO - 'sessionrestore_no_auto_restore', 17:29:21 INFO - 'tabpaint']}, 17:29:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:29:21 INFO - 'ts_paint', 17:29:21 INFO - 'tpaint', 17:29:21 INFO - 'sessionrestore', 17:29:21 INFO - 'sessionrestore_no_auto_restore', 17:29:21 INFO - 'tabpaint']}, 17:29:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:29:21 INFO - 'ts_paint', 17:29:21 INFO - 'tpaint', 17:29:21 INFO - 'sessionrestore', 17:29:21 INFO - 'sessionrestore_no_auto_restore', 17:29:21 INFO - 'tabpaint']}, 17:29:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:29:21 INFO - 'tests': ['a11yr', 17:29:21 INFO - 'ts_paint', 17:29:21 INFO - 'tpaint', 17:29:21 INFO - 'sessionrestore', 17:29:21 INFO - 'sessionrestore_no_auto_restore', 17:29:21 INFO - 'tabpaint']}, 17:29:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:29:21 INFO - 'tests': ['a11yr', 17:29:21 INFO - 'ts_paint', 17:29:21 INFO - 'tpaint', 17:29:21 INFO - 'sessionrestore', 17:29:21 INFO - 'sessionrestore_no_auto_restore', 17:29:21 INFO - 'tabpaint']}, 17:29:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:29:21 INFO - 'tests': ['tsvgx', 17:29:21 INFO - 'tsvgr_opacity', 17:29:21 INFO - 'tart', 17:29:21 INFO - 'tscrollx', 17:29:21 INFO - 'cart']}, 17:29:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:29:21 INFO - 'tsvgr_opacity', 17:29:21 INFO - 'tart', 17:29:21 INFO - 'tscrollx', 17:29:21 INFO - 'cart']}, 17:29:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:29:21 INFO - 'talos_options': ['--disable-e10s'], 17:29:21 INFO - 'tests': ['tp5o']}, 17:29:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:29:21 INFO - 'tests': ['tp5o']}, 17:29:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:29:21 INFO - 'talos_options': ['--disable-e10s', 17:29:21 INFO - '--xperf_path', 17:29:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:29:21 INFO - 'tests': ['tp5n']}, 17:29:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:29:21 INFO - 'talos_options': ['--xperf_path', 17:29:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:29:21 INFO - 'tests': ['tp5n']}}, 17:29:21 INFO - 'talos.zip': {'path': '', 17:29:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:29:21 INFO - Running post-action listener: _resource_record_post_action 17:29:21 INFO - ##### 17:29:21 INFO - ##### Finished populate-webroot step (success) 17:29:21 INFO - ##### 17:29:21 INFO - ##### 17:29:21 INFO - ##### Running create-virtualenv step. 17:29:21 INFO - ##### 17:29:21 INFO - Running pre-action listener: _resource_record_pre_action 17:29:21 INFO - Running main action method: create_virtualenv 17:29:21 INFO - Creating virtualenv /builds/slave/test/build/venv 17:29:21 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 17:29:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:29:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:29:21 INFO - Using real prefix '/usr' 17:29:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:29:22 INFO - Installing distribute.............................................................................................................................................................................................done. 17:29:24 INFO - Installing pip.................done. 17:29:24 INFO - Return code: 0 17:29:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:24 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 0x7f36ea603f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, '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': '826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935', '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 17:29:24 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 17:29:24 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 17:29:24 INFO - Using env: {'DISPLAY': ':0', 17:29:24 INFO - 'HOME': '/home/cltbld', 17:29:24 INFO - 'LANG': 'en_US.UTF-8', 17:29:24 INFO - 'LANGUAGE': 'en_US:en', 17:29:24 INFO - 'LOGNAME': 'cltbld', 17:29:24 INFO - 'MAIL': '/var/mail/cltbld', 17:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:24 INFO - 'MOZ_NO_REMOTE': '1', 17:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:24 INFO - 'NO_EM_RESTART': '1', 17:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:24 INFO - 'PWD': '/builds/slave/test', 17:29:24 INFO - 'SHELL': '/bin/bash', 17:29:24 INFO - 'SHLVL': '1', 17:29:24 INFO - 'TERM': 'linux', 17:29:24 INFO - 'TMOUT': '86400', 17:29:24 INFO - 'USER': 'cltbld', 17:29:24 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935', 17:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:24 INFO - '_': '/tools/buildbot/bin/python'} 17:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:24 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 17:29:24 INFO - Cleaning up... 17:29:24 INFO - Return code: 0 17:29:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:24 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 0x7f36ea603f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, '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': '826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935', '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 17:29:24 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 17:29:24 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 17:29:24 INFO - Using env: {'DISPLAY': ':0', 17:29:24 INFO - 'HOME': '/home/cltbld', 17:29:24 INFO - 'LANG': 'en_US.UTF-8', 17:29:24 INFO - 'LANGUAGE': 'en_US:en', 17:29:24 INFO - 'LOGNAME': 'cltbld', 17:29:24 INFO - 'MAIL': '/var/mail/cltbld', 17:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:24 INFO - 'MOZ_NO_REMOTE': '1', 17:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:24 INFO - 'NO_EM_RESTART': '1', 17:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:24 INFO - 'PWD': '/builds/slave/test', 17:29:24 INFO - 'SHELL': '/bin/bash', 17:29:24 INFO - 'SHLVL': '1', 17:29:24 INFO - 'TERM': 'linux', 17:29:24 INFO - 'TMOUT': '86400', 17:29:24 INFO - 'USER': 'cltbld', 17:29:24 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935', 17:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:24 INFO - '_': '/tools/buildbot/bin/python'} 17:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:24 INFO - Downloading/unpacking psutil>=3.1.1 17:29:24 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 17:29:24 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 17:29:24 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 17:29:24 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 17:29:24 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 17:29:24 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 17:29:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:29:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:29:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:29:26 INFO - Installing collected packages: psutil 17:29:26 INFO - Running setup.py install for psutil 17:29:26 INFO - building 'psutil._psutil_linux' extension 17:29:26 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 17:29:26 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 17:29:26 INFO - building 'psutil._psutil_posix' extension 17:29:26 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 17:29:26 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 17:29:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:29:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:29:27 INFO - Successfully installed psutil 17:29:27 INFO - Cleaning up... 17:29:27 INFO - Return code: 0 17:29:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:29:27 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')]} 17:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:27 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')]} 17:29:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:27 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 0x7f36ea603f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, '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': '826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935', '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 17:29:27 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 17:29:27 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 17:29:27 INFO - Using env: {'DISPLAY': ':0', 17:29:27 INFO - 'HOME': '/home/cltbld', 17:29:27 INFO - 'LANG': 'en_US.UTF-8', 17:29:27 INFO - 'LANGUAGE': 'en_US:en', 17:29:27 INFO - 'LOGNAME': 'cltbld', 17:29:27 INFO - 'MAIL': '/var/mail/cltbld', 17:29:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:27 INFO - 'MOZ_NO_REMOTE': '1', 17:29:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:27 INFO - 'NO_EM_RESTART': '1', 17:29:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:27 INFO - 'PWD': '/builds/slave/test', 17:29:27 INFO - 'SHELL': '/bin/bash', 17:29:27 INFO - 'SHLVL': '1', 17:29:27 INFO - 'TERM': 'linux', 17:29:27 INFO - 'TMOUT': '86400', 17:29:27 INFO - 'USER': 'cltbld', 17:29:27 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935', 17:29:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:27 INFO - '_': '/tools/buildbot/bin/python'} 17:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:29:27 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 17:29:27 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 17:29:27 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 17:29:27 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 17:29:27 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 17:29:27 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 17:29:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:29:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:29:29 INFO - Installing collected packages: mozsystemmonitor 17:29:29 INFO - Running setup.py install for mozsystemmonitor 17:29:29 INFO - Successfully installed mozsystemmonitor 17:29:29 INFO - Cleaning up... 17:29:29 INFO - Return code: 0 17:29:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:29 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 0x7f36ea603f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, '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': '826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935', '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 17:29:29 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 17:29:29 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 17:29:29 INFO - Using env: {'DISPLAY': ':0', 17:29:29 INFO - 'HOME': '/home/cltbld', 17:29:29 INFO - 'LANG': 'en_US.UTF-8', 17:29:29 INFO - 'LANGUAGE': 'en_US:en', 17:29:29 INFO - 'LOGNAME': 'cltbld', 17:29:29 INFO - 'MAIL': '/var/mail/cltbld', 17:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:29 INFO - 'MOZ_NO_REMOTE': '1', 17:29:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:29 INFO - 'NO_EM_RESTART': '1', 17:29:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:29 INFO - 'PWD': '/builds/slave/test', 17:29:29 INFO - 'SHELL': '/bin/bash', 17:29:29 INFO - 'SHLVL': '1', 17:29:29 INFO - 'TERM': 'linux', 17:29:29 INFO - 'TMOUT': '86400', 17:29:29 INFO - 'USER': 'cltbld', 17:29:29 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935', 17:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:29 INFO - '_': '/tools/buildbot/bin/python'} 17:29:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:29 INFO - Downloading/unpacking blobuploader==1.2.4 17:29:29 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 17:29:29 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 17:29:29 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 17:29:29 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 17:29:29 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 17:29:29 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 17:29:31 INFO - Downloading blobuploader-1.2.4.tar.gz 17:29:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:29:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:29:31 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 17:29:31 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 17:29:31 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 17:29:31 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 17:29:31 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 17:29:31 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 17:29:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:29:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:29:32 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 17:29:32 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 17:29:32 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 17:29:32 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 17:29:32 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 17:29:32 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 17:29:32 INFO - Downloading docopt-0.6.1.tar.gz 17:29:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:29:32 INFO - Installing collected packages: blobuploader, requests, docopt 17:29:32 INFO - Running setup.py install for blobuploader 17:29:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:29:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:29:32 INFO - Running setup.py install for requests 17:29:32 INFO - Running setup.py install for docopt 17:29:32 INFO - Successfully installed blobuploader requests docopt 17:29:32 INFO - Cleaning up... 17:29:32 INFO - Return code: 0 17:29:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:29:32 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')]} 17:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:33 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 0x7f36ea603f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, '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': '826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935', '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 17:29:33 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 17:29:33 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 17:29:33 INFO - Using env: {'DISPLAY': ':0', 17:29:33 INFO - 'HOME': '/home/cltbld', 17:29:33 INFO - 'LANG': 'en_US.UTF-8', 17:29:33 INFO - 'LANGUAGE': 'en_US:en', 17:29:33 INFO - 'LOGNAME': 'cltbld', 17:29:33 INFO - 'MAIL': '/var/mail/cltbld', 17:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:33 INFO - 'MOZ_NO_REMOTE': '1', 17:29:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:33 INFO - 'NO_EM_RESTART': '1', 17:29:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:33 INFO - 'PWD': '/builds/slave/test', 17:29:33 INFO - 'SHELL': '/bin/bash', 17:29:33 INFO - 'SHLVL': '1', 17:29:33 INFO - 'TERM': 'linux', 17:29:33 INFO - 'TMOUT': '86400', 17:29:33 INFO - 'USER': 'cltbld', 17:29:33 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935', 17:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:33 INFO - '_': '/tools/buildbot/bin/python'} 17:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:29:33 INFO - Running setup.py (path:/tmp/pip-sngR7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:29:33 INFO - Running setup.py (path:/tmp/pip-YRdmS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:29:33 INFO - Running setup.py (path:/tmp/pip-Fq2F0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:29:33 INFO - Running setup.py (path:/tmp/pip-94htPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:29:33 INFO - Running setup.py (path:/tmp/pip-EKspS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:29:33 INFO - Running setup.py (path:/tmp/pip-xFwQO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:29:33 INFO - Running setup.py (path:/tmp/pip-4mqPLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:29:33 INFO - Running setup.py (path:/tmp/pip-3Lu6jJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:29:33 INFO - Running setup.py (path:/tmp/pip-a4ejvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:29:33 INFO - Running setup.py (path:/tmp/pip-2Sjfz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:29:33 INFO - Running setup.py (path:/tmp/pip-jb4SaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:29:34 INFO - Running setup.py (path:/tmp/pip-4Imppf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:29:34 INFO - Running setup.py (path:/tmp/pip-oyxniN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:29:34 INFO - Running setup.py (path:/tmp/pip-_OJmFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:29:34 INFO - Running setup.py (path:/tmp/pip-Pg8DV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:29:34 INFO - Running setup.py (path:/tmp/pip-sHHJIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:29:34 INFO - Running setup.py (path:/tmp/pip-ggdD5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:29:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:29:34 INFO - Running setup.py install for manifestparser 17:29:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:29:34 INFO - Running setup.py install for mozcrash 17:29:34 INFO - Running setup.py install for mozdebug 17:29:34 INFO - Running setup.py install for mozdevice 17:29:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:29:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:29:34 INFO - Running setup.py install for mozfile 17:29:34 INFO - Running setup.py install for mozhttpd 17:29:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:29:35 INFO - Running setup.py install for mozinfo 17:29:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:29:35 INFO - Running setup.py install for mozInstall 17:29:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:29:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:29:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:29:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:29:35 INFO - Running setup.py install for mozleak 17:29:35 INFO - Running setup.py install for mozlog 17:29:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:29:35 INFO - Running setup.py install for moznetwork 17:29:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:29:35 INFO - Running setup.py install for mozprocess 17:29:35 INFO - Running setup.py install for mozprofile 17:29:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:29:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:29:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:29:35 INFO - Running setup.py install for mozrunner 17:29:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:29:35 INFO - Running setup.py install for mozscreenshot 17:29:35 INFO - Running setup.py install for moztest 17:29:36 INFO - Running setup.py install for mozversion 17:29:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:29:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:29:36 INFO - Cleaning up... 17:29:36 INFO - Return code: 0 17:29:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:36 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 0x7f36ea603f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, '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': '826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935', '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 17:29:36 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 17:29:36 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 17:29:36 INFO - Using env: {'DISPLAY': ':0', 17:29:36 INFO - 'HOME': '/home/cltbld', 17:29:36 INFO - 'LANG': 'en_US.UTF-8', 17:29:36 INFO - 'LANGUAGE': 'en_US:en', 17:29:36 INFO - 'LOGNAME': 'cltbld', 17:29:36 INFO - 'MAIL': '/var/mail/cltbld', 17:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:36 INFO - 'MOZ_NO_REMOTE': '1', 17:29:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:36 INFO - 'NO_EM_RESTART': '1', 17:29:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:36 INFO - 'PWD': '/builds/slave/test', 17:29:36 INFO - 'SHELL': '/bin/bash', 17:29:36 INFO - 'SHLVL': '1', 17:29:36 INFO - 'TERM': 'linux', 17:29:36 INFO - 'TMOUT': '86400', 17:29:36 INFO - 'USER': 'cltbld', 17:29:36 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935', 17:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:36 INFO - '_': '/tools/buildbot/bin/python'} 17:29:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:29:36 INFO - Running setup.py (path:/tmp/pip-j0foXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:29:36 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)) 17:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:29:36 INFO - Running setup.py (path:/tmp/pip-y3AFnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:29:36 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)) 17:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:29:36 INFO - Running setup.py (path:/tmp/pip-Lp5kSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:29:36 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)) 17:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:29:36 INFO - Running setup.py (path:/tmp/pip-nPg76W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:29:36 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)) 17:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:29:36 INFO - Running setup.py (path:/tmp/pip-7ztA5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:29:36 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)) 17:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:29:36 INFO - Running setup.py (path:/tmp/pip-k6DuV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:29:36 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)) 17:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:29:36 INFO - Running setup.py (path:/tmp/pip-0fb4DI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:29:36 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)) 17:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:29:36 INFO - Running setup.py (path:/tmp/pip-SkSbrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:29:36 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)) 17:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:29:36 INFO - Running setup.py (path:/tmp/pip-xZCadr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:29:37 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)) 17:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:29:37 INFO - Running setup.py (path:/tmp/pip-Y83R2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:29:37 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)) 17:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:29:37 INFO - Running setup.py (path:/tmp/pip-rUvi3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:29:37 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)) 17:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:29:37 INFO - Running setup.py (path:/tmp/pip-W89ceg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:29:37 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)) 17:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:29:37 INFO - Running setup.py (path:/tmp/pip-pYEYcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:29:37 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)) 17:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:29:37 INFO - Running setup.py (path:/tmp/pip-4FpImA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:29:37 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)) 17:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:29:37 INFO - Running setup.py (path:/tmp/pip-Aq1xLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:29:37 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)) 17:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:29:37 INFO - Running setup.py (path:/tmp/pip-pgTmoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:29:37 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)) 17:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:29:37 INFO - Running setup.py (path:/tmp/pip-cpyEGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:29:37 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)) 17:29:37 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)) 17:29:37 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)) 17:29:37 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)) 17:29:37 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)) 17:29:37 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)) 17:29:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:29:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:29:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:29:39 INFO - Downloading blessings-1.6.tar.gz 17:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:29:39 INFO - Installing collected packages: blessings 17:29:39 INFO - Running setup.py install for blessings 17:29:39 INFO - Successfully installed blessings 17:29:39 INFO - Cleaning up... 17:29:39 INFO - Return code: 0 17:29:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:29:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:29:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:29:40 INFO - Reading from file tmpfile_stdout 17:29:40 INFO - Current package versions: 17:29:40 INFO - argparse == 1.2.1 17:29:40 INFO - blessings == 1.6 17:29:40 INFO - blobuploader == 1.2.4 17:29:40 INFO - docopt == 0.6.1 17:29:40 INFO - manifestparser == 1.1 17:29:40 INFO - mozInstall == 1.12 17:29:40 INFO - mozcrash == 0.17 17:29:40 INFO - mozdebug == 0.1 17:29:40 INFO - mozdevice == 0.48 17:29:40 INFO - mozfile == 1.2 17:29:40 INFO - mozhttpd == 0.7 17:29:40 INFO - mozinfo == 0.9 17:29:40 INFO - mozleak == 0.1 17:29:40 INFO - mozlog == 3.2 17:29:40 INFO - moznetwork == 0.27 17:29:40 INFO - mozprocess == 0.22 17:29:40 INFO - mozprofile == 0.28 17:29:40 INFO - mozrunner == 6.11 17:29:40 INFO - mozscreenshot == 0.1 17:29:40 INFO - mozsystemmonitor == 0.3 17:29:40 INFO - moztest == 0.7 17:29:40 INFO - mozversion == 1.4 17:29:40 INFO - psutil == 3.1.1 17:29:40 INFO - requests == 1.2.3 17:29:40 INFO - wsgiref == 0.1.2 17:29:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:29: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')]} 17:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29: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')]} 17:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:40 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 0x7f36ea603f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, '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': '826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935', '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 17:29:40 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 17:29:40 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 17:29:40 INFO - Using env: {'DISPLAY': ':0', 17:29:40 INFO - 'HOME': '/home/cltbld', 17:29:40 INFO - 'LANG': 'en_US.UTF-8', 17:29:40 INFO - 'LANGUAGE': 'en_US:en', 17:29:40 INFO - 'LOGNAME': 'cltbld', 17:29:40 INFO - 'MAIL': '/var/mail/cltbld', 17:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:40 INFO - 'MOZ_NO_REMOTE': '1', 17:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:40 INFO - 'NO_EM_RESTART': '1', 17:29:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:40 INFO - 'PWD': '/builds/slave/test', 17:29:40 INFO - 'SHELL': '/bin/bash', 17:29:40 INFO - 'SHLVL': '1', 17:29:40 INFO - 'TERM': 'linux', 17:29:40 INFO - 'TMOUT': '86400', 17:29:40 INFO - 'USER': 'cltbld', 17:29:40 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935', 17:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:40 INFO - '_': '/tools/buildbot/bin/python'} 17:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:40 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)) 17:29:40 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)) 17:29:40 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)) 17:29:40 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)) 17:29:40 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)) 17:29:40 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)) 17:29:40 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)) 17:29:40 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)) 17:29:40 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)) 17:29:40 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)) 17:29:40 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)) 17:29:40 INFO - Cleaning up... 17:29:40 INFO - Return code: 0 17:29:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:29: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')]} 17:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29: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')]} 17:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:40 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 0x7f36ea603f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, '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': '826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935', '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 17:29:40 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 17:29:40 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 17:29:40 INFO - Using env: {'DISPLAY': ':0', 17:29:40 INFO - 'HOME': '/home/cltbld', 17:29:40 INFO - 'LANG': 'en_US.UTF-8', 17:29:40 INFO - 'LANGUAGE': 'en_US:en', 17:29:40 INFO - 'LOGNAME': 'cltbld', 17:29:40 INFO - 'MAIL': '/var/mail/cltbld', 17:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:40 INFO - 'MOZ_NO_REMOTE': '1', 17:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:40 INFO - 'NO_EM_RESTART': '1', 17:29:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:40 INFO - 'PWD': '/builds/slave/test', 17:29:40 INFO - 'SHELL': '/bin/bash', 17:29:40 INFO - 'SHLVL': '1', 17:29:40 INFO - 'TERM': 'linux', 17:29:40 INFO - 'TMOUT': '86400', 17:29:40 INFO - 'USER': 'cltbld', 17:29:40 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935', 17:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:40 INFO - '_': '/tools/buildbot/bin/python'} 17:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:40 INFO - Downloading/unpacking jsonschema 17:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:29:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:29:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:29:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:29:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:29:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:29:42 INFO - Downloading/unpacking functools32 (from jsonschema) 17:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:29:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:29:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:29:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:29:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:29:42 INFO - Downloading functools32-3.2.3-2.tar.gz 17:29:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:29:42 INFO - warning: no files found matching '*.txt' 17:29:42 INFO - no previously-included directories found matching 'build' 17:29:42 INFO - no previously-included directories found matching 'dist' 17:29:42 INFO - no previously-included directories found matching '.git*' 17:29:42 INFO - Installing collected packages: jsonschema, functools32 17:29:42 INFO - Running setup.py install for functools32 17:29:42 INFO - warning: no files found matching '*.txt' 17:29:42 INFO - no previously-included directories found matching 'build' 17:29:42 INFO - no previously-included directories found matching 'dist' 17:29:42 INFO - no previously-included directories found matching '.git*' 17:29:42 INFO - Successfully installed jsonschema functools32 17:29:42 INFO - Cleaning up... 17:29:42 INFO - Return code: 0 17:29:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36ea603f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19b3770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, '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': '826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935', '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 17:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:29:42 INFO - Using env: {'DISPLAY': ':0', 17:29:42 INFO - 'HOME': '/home/cltbld', 17:29:42 INFO - 'LANG': 'en_US.UTF-8', 17:29:42 INFO - 'LANGUAGE': 'en_US:en', 17:29:42 INFO - 'LOGNAME': 'cltbld', 17:29:42 INFO - 'MAIL': '/var/mail/cltbld', 17:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:42 INFO - 'MOZ_NO_REMOTE': '1', 17:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:29:42 INFO - 'NO_EM_RESTART': '1', 17:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:42 INFO - 'PWD': '/builds/slave/test', 17:29:42 INFO - 'SHELL': '/bin/bash', 17:29:42 INFO - 'SHLVL': '1', 17:29:42 INFO - 'TERM': 'linux', 17:29:42 INFO - 'TMOUT': '86400', 17:29:42 INFO - 'USER': 'cltbld', 17:29:42 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935', 17:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:42 INFO - '_': '/tools/buildbot/bin/python'} 17:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:43 INFO - Downloading/unpacking flake8 17:29:43 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 17:29:43 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 17:29:43 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 17:29:43 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 17:29:43 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 17:29:43 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 17:29:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:29:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:29:45 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 17:29:45 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 17:29:45 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 17:29:45 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 17:29:45 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 17:29:45 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 17:29:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:29:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:29:45 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 17:29:45 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 17:29:45 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 17:29:45 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 17:29:45 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 17:29:45 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 17:29:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:29:45 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 17:29:45 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 17:29:45 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 17:29:45 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 17:29:45 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 17:29:45 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 17:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:29:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:29:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:29:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:29:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:29:45 INFO - no previously-included directories found matching 'docs/_build' 17:29:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:29:45 INFO - Running setup.py install for pep8 17:29:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:29:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:29:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:29:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:29:45 INFO - no previously-included directories found matching 'docs/_build' 17:29:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:29:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:29:45 INFO - Cleaning up... 17:29:46 INFO - Return code: 0 17:29:46 INFO - Running post-action listener: _resource_record_post_action 17:29:46 INFO - Running post-action listener: _start_resource_monitoring 17:29:46 INFO - Starting resource monitoring. 17:29:46 INFO - ##### 17:29:46 INFO - ##### Finished create-virtualenv step (success) 17:29:46 INFO - ##### 17:29:46 INFO - ##### 17:29:46 INFO - ##### Running install step. 17:29:46 INFO - ##### 17:29:46 INFO - Running pre-action listener: _resource_record_pre_action 17:29:46 INFO - Running main action method: install 17:29:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:29:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:29:46 INFO - Reading from file tmpfile_stdout 17:29:46 INFO - Detecting whether we're running mozinstall >=1.0... 17:29:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:29:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:29:46 INFO - Reading from file tmpfile_stdout 17:29:46 INFO - Output received: 17:29:46 INFO - Usage: mozinstall [options] installer 17:29:46 INFO - Options: 17:29:46 INFO - -h, --help show this help message and exit 17:29:46 INFO - -d DEST, --destination=DEST 17:29:46 INFO - Directory to install application into. [default: 17:29:46 INFO - "/builds/slave/test"] 17:29:46 INFO - --app=APP Application being installed. [default: firefox] 17:29:46 INFO - mkdir: /builds/slave/test/build/application 17:29:46 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'] 17:29:46 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 17:30:02 INFO - Reading from file tmpfile_stdout 17:30:02 INFO - Output received: 17:30:02 INFO - /builds/slave/test/build/application/firefox/firefox 17:30:02 INFO - Running post-action listener: _resource_record_post_action 17:30:02 INFO - ##### 17:30:02 INFO - ##### Finished install step (success) 17:30:02 INFO - ##### 17:30:02 INFO - ##### 17:30:02 INFO - ##### Running run-tests step. 17:30:02 INFO - ##### 17:30:02 INFO - Running pre-action listener: _resource_record_pre_action 17:30:02 INFO - Running main action method: run_tests 17:30:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:30:02 INFO - Python 2.7.3 17:30:02 INFO - Return code: 0 17:30:02 INFO - grabbing minidump binary from tooltool 17:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:30:02 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 0x1a429c0>, '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 0x1a438c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a43d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:30:02 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 17:30:02 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 17:30:02 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 17:30:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:30:02 INFO - Return code: 0 17:30:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:30:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:30:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:30:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:30:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:30:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:30:03 INFO - Return code: 0 17:30:03 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:30:03 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:30:03 INFO - Using env: {'DISPLAY': ':0', 17:30:03 INFO - 'HOME': '/home/cltbld', 17:30:03 INFO - 'LANG': 'en_US.UTF-8', 17:30:03 INFO - 'LANGUAGE': 'en_US:en', 17:30:03 INFO - 'LOGNAME': 'cltbld', 17:30:03 INFO - 'MAIL': '/var/mail/cltbld', 17:30:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:30:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:03 INFO - 'MOZ_NO_REMOTE': '1', 17:30:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:30:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:30:03 INFO - 'NO_EM_RESTART': '1', 17:30:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:03 INFO - 'PWD': '/builds/slave/test', 17:30:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:30:03 INFO - 'SHELL': '/bin/bash', 17:30:03 INFO - 'SHLVL': '1', 17:30:03 INFO - 'TERM': 'linux', 17:30:03 INFO - 'TMOUT': '86400', 17:30:03 INFO - 'USER': 'cltbld', 17:30:03 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935', 17:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:03 INFO - '_': '/tools/buildbot/bin/python'} 17:30:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:30:04 INFO - mozversion application_buildid: 20160516143016 17:30:04 INFO - mozversion application_changeset: ae689711c21875e2f732c97264e35527c7f6b963 17:30:04 INFO - mozversion application_display_name: Nightly 17:30:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:30:04 INFO - mozversion application_name: Firefox 17:30:04 INFO - mozversion application_remotingname: firefox 17:30:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:30:04 INFO - mozversion application_vendor: Mozilla 17:30:04 INFO - mozversion application_version: 49.0a1 17:30:04 INFO - mozversion platform_buildid: 20160516143016 17:30:04 INFO - mozversion platform_changeset: ae689711c21875e2f732c97264e35527c7f6b963 17:30:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:30:04 INFO - mozversion platform_version: 49.0a1 17:30:04 INFO - using testdate: 1463445004 17:30:04 INFO - actual date: 1463445004 17:30:04 INFO - starting webserver on 'localhost:53871' 17:30:04 INFO - SUITE-START | Running 2 tests 17:30:04 INFO - TEST-START | dromaeo_css 17:30:04 INFO - operating with platform_type : linux_ 17:30:04 INFO - Initialising browser for dromaeo_css test... 17:30:04 INFO - TEST-INFO | started process 20789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphXZTLV/profile http://localhost:53871/getInfo.html) 17:30:07 INFO - PROCESS | 20789 | 17:30:07 INFO - PROCESS | 20789 | (process:20857): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:30:08 INFO - PROCESS | 20789 | __metrics Screen width/height:1600/1200 17:30:08 INFO - PROCESS | 20789 | colorDepth:24 17:30:08 INFO - PROCESS | 20789 | Browser inner width/height: 1024/697 17:30:08 INFO - PROCESS | 20789 | __metrics 17:30:09 ERROR - PROCESS | 20789 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 17:30:09 INFO - TEST-INFO | 20789: exit 0 17:30:09 INFO - Browser initialized. 17:30:09 INFO - Running cycle 1/1 for dromaeo_css test... 17:30:09 INFO - TEST-INFO | started process 20908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphXZTLV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:30:11 INFO - PROCESS | 20908 | 17:30:11 INFO - PROCESS | 20908 | (process:20968): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:30:21 INFO - PROCESS | 20908 | RSS: Main: 163319808 17:30:21 INFO - PROCESS | 20908 | 17:31:11 INFO - PROCESS | 20908 | 1463445071377 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] 17:33:19 INFO - PROCESS | 20908 | Cycle 1(1): loaded http://localhost:53871/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53871/tests/dromaeo/cssquery-ext.html) 17:33:20 INFO - PROCESS | 20908 | RSS: Main: 166952960 17:33:20 INFO - PROCESS | 20908 | 17:36:22 INFO - PROCESS | 20908 | Cycle 1(1): loaded http://localhost:53871/tests/dromaeo/cssquery-ext.html (next: http://localhost:53871/tests/dromaeo/cssquery-jquery.html) 17:36:22 INFO - PROCESS | 20908 | RSS: Main: 166428672 17:36:22 INFO - PROCESS | 20908 | 17:39:24 INFO - PROCESS | 20908 | Cycle 1(1): loaded http://localhost:53871/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53871/tests/dromaeo/cssquery-mootools.html) 17:39:25 INFO - PROCESS | 20908 | RSS: Main: 167403520 17:39:25 INFO - PROCESS | 20908 | 17:42:26 INFO - PROCESS | 20908 | Cycle 1(1): loaded http://localhost:53871/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53871/tests/dromaeo/cssquery-prototype.html) 17:42:27 INFO - PROCESS | 20908 | RSS: Main: 165412864 17:42:27 INFO - PROCESS | 20908 | 17:45:29 INFO - PROCESS | 20908 | Cycle 1(1): loaded http://localhost:53871/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53871/tests/dromaeo/cssquery-yui.html) 17:45:30 INFO - PROCESS | 20908 | RSS: Main: 166875136 17:45:30 INFO - PROCESS | 20908 | 17:48:33 INFO - PROCESS | 20908 | Cycle 1(1): loaded http://localhost:53871/tests/dromaeo/cssquery-yui.html (next: http://localhost:53871/tests/dromaeo/cssquery-dojo.html) 17:48:33 INFO - PROCESS | 20908 | RSS: Main: 168452096 17:48:33 INFO - PROCESS | 20908 | 17:48:33 INFO - PROCESS | 20908 | __start_tp_report 17:48:33 INFO - PROCESS | 20908 | _x_x_mozilla_page_load 17:48:33 INFO - PROCESS | 20908 | _x_x_mozilla_page_load_details 17:48:33 INFO - PROCESS | 20908 | |i|pagename|runs| 17:48:33 INFO - PROCESS | 20908 | |0;dojo.html;3189.2824114574237;3196.1689960610242;3234.7573931955108;3238.449463591189;3245.350929814036;5457.836264912054;5502.367227768807;5519.31008623922;5574.968630803304;5588.972055139729;5364.785408583662;5492.47821456961;5507.366652834915;5527.088030474967;5599.216109744639;4954.653174277793;5018.924716129261;5116.795328186868;5136.460671629462;5190.584753219733;880.4740908260387;4950.975245123769;4964.230544265644;5010.824621138261;5161.612879034069;5010.774515146827;5036.445990940993;5053.747312634354;5057.115004874132;5078.7968481260705;5026.623003274769;5032.245163225509;5032.79868805251;5035.169197082477;5044.445111037783;4968.552830245295;5018.523240292203;5034.823781167678;5041.218611115283;5071.949280507221;5470.316210473691;5474.890502189974;5487.451254874521;5492.450754924515;5579.13523403873;5803.912941305884;5925.970370148165;6003.099535069731;6017;6023.548233882432;5974.044152935509;6030.216071910623;6048.123022161762;6073.544484163661;6118.265808103011;5643.492085712264;5645.633033852828;5645.661260324394;5648.181013752983;5653.462921022497;5935.584509084322;6088.238970128734;6102.72537735803;6149.2620885494025;6169.753209871555;5798.10129429939;5802.912956305659;5813.563982701315;5813.970930145322;5815.621984570989;5926.051831706906;5938.762449502058;5940.732667029994;5944.286685597756;5975.043992961106;5862.443067908542;5928.67392293428;5944.7919322824355;5952.5833191676165;5988.041913293852;5899.292084949748;5953.136795164677;5971.5222782177325;5985.850353741104;5990.161377407167;4415.801288942005;4524.366588677588;4535.9773201133785;4540.160070386923;4576.977115114403;3919.1573811630637;3976.463177471004;3984.1633257015774;4006.2187873364996;4027.496562929634;5615.775368985276;5657.9434205658235;5671.631343962629;5709.942900570941;5730.36965933747;5840.766369345263;6065.96967015171;6076.270847498328;6086.60437071589;6092.1775560299675;5640.858978525488;5668.064769313017;5669.716514174274;5672.773089076473;5691.231683722727;5051.671641343374;5088.389393272757;5090.287359769635;5095.363079615048;5153.1497302945345;5903.203067585821;6003.489703375262;6031.396860313934;6049.909251361233;6055.878882422327;5963.254593175766;6038.456538911519;6065.272167339771;6068.180795592539;6113.84715382119;6033.095035744674;6081.361457046946;6084.69576521181;6088.847778805565;6090.604110732788;5722.914156287576;5761.683107428964;5787.247657804459;5926.851828704317;5937;5956.404359564009;5958.851028724316;5959.940400595939;5962.314333851663;5999.160117583455;5741.569382296261;5760.481556659921;5769.53843692512;5804.709764511842;5810.302763668386;5674.77300907959;5750.712464376848;5761.251037365116;5768.048272035067;5786.33457152416;5637;5679.8864022720145;5687.260656114679;5687.9431205687415;5689;5804.1874137619925;5813.651180929158;5814.895169917702;5840.649561026352;5883.411658834082;5620.269364982526;5632.986062508788;5675.943240567542;5684.658920464785;5723.227364305765 17:48:33 INFO - PROCESS | 20908 | |1;ext.html;583.9591228613999;640.9615423074615;652.9053287273348;660.8942569188931;669.9598024118552;30366.240843978885;43998.780006099965;44233.557664423344;44640.3303950441;44942.77528612352;42886.14227715444;43244.56755432445;43275;46901;46939.29591056137;9052.728418147466;9116.407433516833;9129;9165.037671044543;9170.449773013606;9030.322725795559;9059.411138276024;9117.863232051524;9128.726138215865;9143.725688229364;9024.368294219406;9155.67955121571;9172.266218702522;9185.770355741093;9189.127032931861;9104.63581456741;9134.954325228398;9135.771605709844;9150;9161.312901532345;8883.51140687262;8903.55482225886;8958.148975847284;8960.820783584357;9006.324525660537;42889.78555107205;43199;43225.35161972573;43371.34942975858;43438.565614343766;3691.53855768029;3768.9434658480145;3855.865044723449;4072.3847297967277;4321.891952701176;32140;32659.346813063843;32893.17767055819;33076.338473230404;33185.502217466754;4401.2517871961845;4415.690901636886;4449.977750111261;4462.687611867171;4533.637309015304;333087;337296;337695;339063;339286;63301.68349158225;63326;63449.36550634527;63548.68225658842;63840;33715.66284337174;33803.83098084494;50524.494755052714;50638.746806265735;50992.49007509877;16542;16627.08551029681;16711.582210444834;16773.496795096165;16780.496585102468;12582.496700132075;12726.68183295425;12729.363531823372;12732.363381830872;12742.872571274354;20625.278115265894;20971;21016.684749728767;21055.157793688388;21077.683834742493;8073.478622724439;8189.8771518427275;8243.134470880592;8311.958440207882;8379.916200838035;974.4202199691173;1090.340344091829;1100.0924237503932;1148.3683973814368;1248.3820508847996;32355.676443235738;32395.67604323974;32851.50722739161;33024;33076.503852442234;1113.8384934184498;1127.503898284752;1127.503898284752;1132.2187690493533;1233.2908577567935;16655.91672041632;17016.404425845038;17146.314147433965;17382.648210917123;17396.739048914278;578113;580055;580727;581670;582753;59067.70466147642;59585;59610.70194649086;59618.70190649019;59703.40296597065;1366.5353779714944;1381.1920026784444;1393.038803225771;1397.82527184102;1428.2358937968138;30641.846790765903;30848.69151308548;31656.683433166294;31909.68090319067;32038;50967.490325096274;56610.433895662165;57787;57839;63334.68332658307;540197;543744;547775;547877;550198;45375.319370210134;45590.544094559955;45871.541284586725;46153;46479.07041859076;46265.76867115643;47729.80675483141;49762.25356619581;50359.74820125876;50773.74613126911;38552.56645485805;41122.794386027876;42391.57608424;42715.35926961036;43174.568254317055;42115.7894210527;42510;42840;42861.785691071345;42996;36456.453153203256;41365.1726965453;41525.754227373225;41682;41969.79015104905;35602;37367.252654946205;37395.81302093472;37817;38109.80945095257;28525.857370713842;28980.565291521067;29106.7089329104;29217.85391073116;29467 17:48:33 INFO - PROCESS | 20908 | |2;jquery.html;396.54397442940626;404.8704414587331;410.1059689876069;417.7368257997461;418.7131814706926;17922.103894805274;19057.142428590712;19719;19912.40262792115;19928.402147935583;18258.908705456455;18488.44534663959;18510;18596.628067438643;18772.53068673284;5638.182463542784;5699.031164702;5807.825765227029;5829.941700583004;5844.736986835603;5790.652560846363;5810.244668193129;5810.941890581083;5821.534277257831;5825.126231065353;5560.471755183271;5844.941550584483;5849.298084229898;5856.41435856413;5862.149988251701;5584.134459158837;5794.304683437993;5814.040683287252;5823.242978412801;5840.123981402781;5098.235264710286;5115.923261151086;5123.359580052494;5149.639525233235;5153.613478989053;21878.23426180076;21892.671609925863;22198.445038873997;22210;22289.77710222893;2292.908283668651;2314.884255787204;2349.201271567675;2442.303943376129;2468.2965354873777;9612.279079069098;9904.752381190456;10115.79768404635;10184.847227291597;14599.416023359054;1954.1890115602007;1982.4449154236836;2002.5394159343432;2042.1525067097136;2073.5645514441985;76821.61589192074;83500.16499834985;85562.57218713929;85663;86446.99999999937;10995.835062474069;11028.889711102947;11302.135147700701;11331;11563.595274165364;15671.529854104396;15772.132532710582;15812;15935.760963585555;16038.759418608497;8014.83970320602;8127.268545830785;8200.343972482306;8213.95893020531;8297.709580164665;7652.120006199359;7663.731769388156;7775.57234352116;7887.171846956102;7918.762437126896;4843.1524483216;4858.1012512685265;4859.392575928009;4961.107000739901;5039.622028347889;2037.4193354893785;2042.1423002339054;2084.218418093215;2095.8428117891217;2132.41358626379;963.6964356227905;984.9411882226635;986.6497393425374;1036.3056751976194;1061.6655753437642;17823.554411139565;18115;18465.7230141548;18493.260269589337;18821.15304811287;998.6005597760953;1020.9132223760915;1023.9897601024044;1050.721558786922;1063.744701271689;10475.685729428129;10574.937887112093;10662.89337106619;10686.732831679115;10779.245452818384;466110;468845;471793;476346;488548;57298.7135064322;93507.53246233726;94566;94679.52660236655;96160;1023.4319952426475;1026.4046852825343;1031.7265924529856;1060.9151267898549;1065.2862582070031;15998.360065597246;16858.915705421394;17254.309827606754;17270.222839972485;17287.049212293445;41035.38446923239;41325.586744132175;42616.36075458809;42838.143237134456;43221.351679725456;55208;56212.41438313649;57678.423215768984;58198.70900645639;58287.417125829896;8619.396642234984;8674.349423793115;9007.189352958265;9023.233025192932;9035.232005279362;12678.175918565265;13799.310034498034;13824.308784560933;13841;13926;11348.148888833535;11464.369459679798;11589.82615260755;11788.4695188715;11980.400979950793;11252.606158784403;11468.19722619442;11509.079273658255;11581.942090289494;11610.24533405326;11871;12140.696482587653;12145.939270303945;12149.635510934686;12209.206401583868;8849.823003540021;8911.50986695712;8952.23905968;9002.954985225295;9008.41445306053;9021.819563608822;12212.267263964191;12222.87777122253;12224.144309898222;12441.253524788543 17:48:33 INFO - PROCESS | 20908 | |3;mootools.html;1554.3782487005196;1572.0567659404358;1700.9829901700987;1824.151769427216;1839.8160183981595;8148.796280093001;8750.474971501715;8979.326550508706;9284.30367722421;9302.90697093029;8853.822923541542;9166.312526560501;9229.584668689908;9238.86141707875;9305.534723263843;2330.790228879405;2364.7398786133513;2365.290412876139;2371.988140059297;2374.169040835711;2330.7086614173227;2363.4918492524102;2393.6768536247646;2395.9161429349974;2398.8440751351195;2365.4559451326204;2385.5109702510945;2393.3418309964813;2400.2919138853995;2407.0612461140167;2296.0700916128994;2299.1608063056947;2301.6547517872286;2327.953440931172;2336.4509340305017;2289.977100228993;2296.1619009061574;2313.051648823991;2314.155333303349;2332.486852892361;9345.859812102824;9408.388454750419;9421.528923553795;9478.099580539838;9499;5382.165764306539;5390.865228369283;5446.809361672323;5453.072977593779;5513.062779327524;3300.4884242942144;3445.1903802606366;3454.378211921853;3456.032310952937;3513.4378499439968;1130.559081958037;1152.5217034930495;1160.5879912631062;1163.988360116405;1171.3733152763232;12711;12794.42425090873;12832.935835320857;12883.613491595268;12944.611661650166;4400.933985990213;4470.463544374696;4533.455985281787;4556.70381425213;4565.794539245676;10369.896301037044;10458.477076146315;10466.947665261625;10467.84298235527;10478;5370.221317908881;5449.1826226066405;5452.700101494376;5453.945460545423;5456.236126942231;4498.595126438636;4716.787744551503;4860.1737704590305;4872.9512704873205;4996.525330093708;3879.86420475282;3992.48097747291;4012.7191096622955;4029.174019326031;4029.9597004029583;1223.5962132496254;1226.9509219631116;1233.4572787973443;1234.493857518413;1238.6346027921784;926.0045451139916;951.8477043672979;953.4517652349926;974.8683927669815;1015.7369796703721;5721.685307308055;5768.567357448208;5890.4698577128265;5997.580169388101;6074.574779765462;423.4220289305076;443.3349975037444;463.9744814035193;464.0348076001908;472.2939205887221;3821.216650586623;3839;3868.052327179803;3903.7072219583647;3978.741381810231;11565.248258863146;11831.585894493823;11868.821967670492;11877.821832672516;11900.523979040741;11607.709807254887;11722.70693232659;11725.824112638316;11759.823602645796;11783.587574434854;8039.397045221632;8384.664613415394;8386.161383861565;8695.434796738191;8750.34372422071;6039.879202416015;6173;6216.533759968111;6230.15892854477;6245.8750824982335;10198.286119971532;10489.580416783243;10578.41818699948;10614.8407773885;10645.201609879136;10589.788204236027;10666.786664266516;10766.300190487593;10780.083692886192;10784.299020563638;7660.80847978805;7976.282134607914;8261.669533218605;8303.95848020756;8319.417640765088;8839.381243313164;8859.557022148738;8869.556522173994;8882.200601945857;8975.102489751234;7633.5419874807685;7854.842903142019;8059.476134051268;8383.119772423808;8558.78603034929;8086.797830054295;8154.347652187929;8225.670973161006;8296.792580185544;8301.750947471586;7217.855642887218;7218.061651985208;7321.963390183015;7330.816729581803;7343.7062517500835;5093.312402825572;5140;5205.765740541609;5223.582113430841;5328.520433161034;5132.3327967364;5156.871078223075;5182.974085129701;5199.4020687621405;5305 17:48:33 INFO - PROCESS | 20908 | |4;prototype.html;314.52991452991455;339.7180340317537;344.2838895098195;344.58133367957925;356.0617772170331;5566.165075238716;5570;5697.886042279152;5796.797112101072;5819.214406055181;5510.779568817253;5633.774649014044;5648.220810444717;5678.914816277759;5692.629979051369;4420.668449866257;4432.224360736875;4443.688941774077;4458.777061146946;4460.687751857355;4154.252234597771;4341.153475072362;4356;4474.709143905636;4495.954340774956;4295.463067116611;4317.589828966243;4325.502567204764;4330.480342358921;4343.891402714941;4310.547392523771;4341;4343.500497442803;4352.7823608819435;4360.934585981213;3777.867774627875;3788.6590206881515;3825.7895815730126;3833.674137698271;3849.653531182179;5379.5696344292755;5382.542483888874;5410.648307859977;5416.350037995427;5476.151196564539;4917.434495033045;4921.163402221595;4928.137575924199;4934.506549345073;4943.1102401567705;5705.144228365778;5803.736173862756;5835.562332825013;5868.501177399926;5881.588288819784;4113.465249517573;4114.115465175002;4118.382242663624;4143.150654115899;4177.895552611179;6112.633242005494;6151.692415379258;6157.384261573851;6163.229596300463;6166.136740856284;4197.97901010493;4298.978505107517;4349.13017396522;4358.498772641186;4359.060218202932;4333.674974376871;4383.539728328479;4386.385905973167;4391.890202744893;4400.251957167226;4982.177940639754;4994.500549945049;5021.171506701354;5028.673136246132;5032.6225533084435;5806.332271788799;5921.61509501881;5963.761449542057;5983.401659833982;5991.580589358703;1492.9477468288558;1494.402239104367;1498.805155329822;1504.7811272868792;1504.9924750376179;929.9395539289925;952.2715122930963;955.1976339874539;960.2605993385055;965.3918031640162;5058.645894787403;5137.12668846297;5140.249966268028;5148.382194136728;5213;5337.439568845293;5349;5351.170568561879;5361.597880159004;5364.597655175799;4889.3888263967;5131.204663277198;5132.022682421153;5137.434882162959;5143.588512918957;2875.266806964211;2893.929246178885;2901.637295338083;2917.5623656451276;2920.503514402514;5464.863378415572;5468.835934921959;5475.315585551806;5487.451254874561;5498.202760599771;5250;5410.215518749838;5446.782128714886;5474.644148130359;5482.5613950883835;5332.84019971912;5339.45155904791;5445.401005889349;5478.260434841325;5545.500904918576;5249;5272.657277276965;5314.867128321823;5345.41200467956;5399.5950303726595;5134.76893539799;5222.451642577475;5254.579633629224;5328.57371410294;5341.813036543703;5419.864503387447;5459.235707000944;5489.094299440548;5492.423295553909;5897.941020589739;4179.540250572495;4282.272013757606;4289.378040184093;4295.806688698954;4307.8492252771;5942.3955532006985;5979;5998.820035398945;6016.127661488972;6021.668808215591;5634.4365563443325;5894.204282421818;5921.437463440966;5930.191291656086;5933.169356290036;5799.9130013049;5818.505427038749;5849.473547380756;5856.531477481876;5906.995810712103;5711.371749107678;5717.542596592346;5723;5753.482186603226;5785.4214578541805;5655.9355835120705;5959.493443057216;5980.8803823924145;6005.009173486325;6028.819135425944;5847.8245652630485;5883.999720047516;5885.087346612282;5894.263217097863;5923.970380148072 17:48:33 INFO - PROCESS | 20908 | |5;yui.html;777.8910952466653;784.909735380431;851.8892543969283;857.172828220767;888.9644414223432;13707.314634268285;14294.999999999987;14320.427182912697;14329.641758956031;14383.64040898978;15174.0136891102;15645.608859778482;15680.921595392007;16084.1957902105;16150.434734784285;838.1032295443878;839.6095815445816;840.3487297344545;841.0160112668193;841.8190089130836;696.3419568507762;824.5052968219051;841.7937605286683;847.3517758914404;848.6859861851093;886.0696268917643;888.1207604471559;888.391451855481;891.1534042659499;892.5715656484858;887.1926546842343;887.6493784954971;888.4935586715575;888.6267767537618;893.2942975049735;641.3105911145537;642.5566359212175;642.8907085795425;647.9190101237346;650.1385663995226;14912.328945197492;14937.551873443814;14939.925300373538;14966.625834354229;14999.775003374958;14131.08147970389;14157.292135393189;14208.375537005357;14398.92800536001;14399.712005759931;11364.545418183263;11438.485268162953;11645.18483706141;11927.463264153133;11946.641600751991;3850.4224366344993;3881.9223615527812;3883.786391748453;3905.1799122184093;4009.4186342980397;53826.46173538254;55887.44112558863;59930.700346497986;60244;60493.395066049656;11263.211575189822;11439.942800285946;11543.4805433754;11595.76808463826;11895.286282822884;19663.60672786536;19924.402267931695;19940.70088948667;20059.59880802405;20184.19263229484;8146.796330091676;8456.577171141418;8591.613377398033;8653;8777.780555486037;4741.454732705783;4771.069641419959;4838.467768545457;4924.03981223658;4990.351254336913;3474.4788281757938;3591.6947059500235;3594.676479116892;3600.171960449059;3613.747037707335;669.9866002679919;672.2168673495323;679.9898001529981;687.8211664967044;690.7099018412279;670.3062330487921;728.7230852276101;734.9228331025272;739.3309055304958;771.221066722603;9875.604975800887;10033.949830250802;10093.495325233709;10233.74415639615;10262.384256944608;697.8778713725078;706.6184260499375;718.8813845715503;724.8006798130556;730.0290613484053;4566.840160594364;4680.702454599894;4771.33201351811;4797.328374027639;4810.11012962596;64109.358906410336;66265.66867165633;67298.66350668314;67941;68013.65993170101;58969;59259.40740592625;59281.40718592845;59402;59947;50400.24399634008;54292.72853635706;54439.18341224885;55804;59432;9179.449233046038;9737.17234035115;9965.152961998312;10240.436775977392;10354.741131471472;35613;35867.46198806968;36661.450078248316;36723.63276367202;37297.6270237305;44803.551964479935;48627.5137248623;49225.50774492209;49713;50161.49838501714;13313.267770272341;13448.26034568069;13761.655958600715;13907.096038757449;14095.577132686036;14738.55784326472;14769.882630398211;14875.553733387584;15007.924960375129;15306.923465382602;13786.172829630254;13846.238456884565;13957;14175.149491030572;14238.074525155831;12789.61631151067;13022.95816334672;13194.076414650883;14550.199739014455;14728.337224825123;12180.45187966526;13330.266835323762;13778.862211378158;14207;14426.495072672826;11674.70813229676;11797.823032654689;11845.111616628616;11862.703432414259;12282.508699651913;11165.649068199205;11350.318980861175;11550.364729939934;11924.403779810802;12050.578229761917 17:48:33 INFO - PROCESS | 20908 | __end_tp_report 17:48:33 INFO - PROCESS | 20908 | __start_cc_report 17:48:33 INFO - PROCESS | 20908 | _x_x_mozilla_cycle_collect,338 17:48:33 INFO - PROCESS | 20908 | __end_cc_report 17:48:33 INFO - PROCESS | 20908 | __startTimestamp1463446113271__endTimestamp 17:48:33 INFO - PROCESS | 20908 | 17:48:33 INFO - PROCESS | 20908 | ------- Summary: start ------- 17:48:33 INFO - PROCESS | 20908 | Number of tests: 6 17:48:33 INFO - PROCESS | 20908 | 17:48:33 INFO - PROCESS | 20908 | [#0] dojo.html Cycles:165 Average:5488.72 Median:5709.94 stddev:728.53 (12.8%) stddev-sans-first:708.08 17:48:33 INFO - PROCESS | 20908 | Values: 3189.3 3196.2 3234.8 3238.4 3245.4 5457.8 5502.4 5519.3 5575.0 5589.0 5364.8 5492.5 5507.4 5527.1 5599.2 4954.7 5018.9 5116.8 5136.5 5190.6 880.5 4951.0 4964.2 5010.8 5161.6 5010.8 5036.4 5053.7 5057.1 5078.8 5026.6 5032.2 5032.8 5035.2 5044.4 4968.6 5018.5 5034.8 5041.2 5071.9 5470.3 5474.9 5487.5 5492.5 5579.1 5803.9 5926.0 6003.1 6017.0 6023.5 5974.0 6030.2 6048.1 6073.5 6118.3 5643.5 5645.6 5645.7 5648.2 5653.5 5935.6 6088.2 6102.7 6149.3 6169.8 5798.1 5802.9 5813.6 5814.0 5815.6 5926.1 5938.8 5940.7 5944.3 5975.0 5862.4 5928.7 5944.8 5952.6 5988.0 5899.3 5953.1 5971.5 5985.9 5990.2 4415.8 4524.4 4536.0 4540.2 4577.0 3919.2 3976.5 3984.2 4006.2 4027.5 5615.8 5657.9 5671.6 5709.9 5730.4 5840.8 6066.0 6076.3 6086.6 6092.2 5640.9 5668.1 5669.7 5672.8 5691.2 5051.7 5088.4 5090.3 5095.4 5153.1 5903.2 6003.5 6031.4 6049.9 6055.9 5963.3 6038.5 6065.3 6068.2 6113.8 6033.1 6081.4 6084.7 6088.8 6090.6 5722.9 5761.7 5787.2 5926.9 5937.0 5956.4 5958.9 5959.9 5962.3 5999.2 5741.6 5760.5 5769.5 5804.7 5810.3 5674.8 5750.7 5761.3 5768.0 5786.3 5637.0 5679.9 5687.3 5687.9 5689.0 5804.2 5813.7 5814.9 5840.6 5883.4 5620.3 5633.0 5675.9 5684.7 5723.2 17:48:33 INFO - PROCESS | 20908 | 17:48:33 INFO - PROCESS | 20908 | [#1] ext.html Cycles:180 Average:64847.29 Median:43234.96 stddev:132963.13 (307.5%) stddev-sans-first:133248.58 17:48:33 INFO - PROCESS | 20908 | Values: 584.0 641.0 652.9 660.9 670.0 30366.2 43998.8 44233.6 44640.3 44942.8 42886.1 43244.6 43275.0 46901.0 46939.3 9052.7 9116.4 9129.0 9165.0 9170.4 9030.3 9059.4 9117.9 9128.7 9143.7 9024.4 9155.7 9172.3 9185.8 9189.1 9104.6 9135.0 9135.8 9150.0 9161.3 8883.5 8903.6 8958.1 8960.8 9006.3 42889.8 43199.0 43225.4 43371.3 43438.6 3691.5 3768.9 3855.9 4072.4 4321.9 32140.0 32659.3 32893.2 33076.3 33185.5 4401.3 4415.7 4450.0 4462.7 4533.6 333087.0 337296.0 337695.0 339063.0 339286.0 63301.7 63326.0 63449.4 63548.7 63840.0 33715.7 33803.8 50524.5 50638.7 50992.5 16542.0 16627.1 16711.6 16773.5 16780.5 12582.5 12726.7 12729.4 12732.4 12742.9 20625.3 20971.0 21016.7 21055.2 21077.7 8073.5 8189.9 8243.1 8312.0 8379.9 974.4 1090.3 1100.1 1148.4 1248.4 32355.7 32395.7 32851.5 33024.0 33076.5 1113.8 1127.5 1127.5 1132.2 1233.3 16655.9 17016.4 17146.3 17382.6 17396.7 578113.0 580055.0 580727.0 581670.0 582753.0 59067.7 59585.0 59610.7 59618.7 59703.4 1366.5 1381.2 1393.0 1397.8 1428.2 30641.8 30848.7 31656.7 31909.7 32038.0 50967.5 56610.4 57787.0 57839.0 63334.7 540197.0 543744.0 547775.0 547877.0 550198.0 45375.3 45590.5 45871.5 46153.0 46479.1 46265.8 47729.8 49762.3 50359.7 50773.7 38552.6 41122.8 42391.6 42715.4 43174.6 42115.8 42510.0 42840.0 42861.8 42996.0 36456.5 41365.2 41525.8 41682.0 41969.8 35602.0 37367.3 37395.8 37817.0 38109.8 28525.9 28980.6 29106.7 29217.9 29467.0 17:48:33 INFO - PROCESS | 20908 | 17:48:33 INFO - PROCESS | 20908 | [#2] jquery.html Cycles:180 Average:28490.82 Median:2395.75 stddev:78280.33 (3267.5%) stddev-sans-first:78471.51 17:48:33 INFO - PROCESS | 20908 | Values: 396.5 404.9 410.1 417.7 418.7 17922.1 19057.1 19719.0 19912.4 19928.4 18258.9 18488.4 18510.0 18596.6 18772.5 5638.2 5699.0 5807.8 5829.9 5844.7 5790.7 5810.2 5810.9 5821.5 5825.1 5560.5 5844.9 5849.3 5856.4 5862.1 5584.1 5794.3 5814.0 5823.2 5840.1 5098.2 5115.9 5123.4 5149.6 5153.6 21878.2 21892.7 22198.4 22210.0 22289.8 2292.9 2314.9 2349.2 2442.3 2468.3 9612.3 9904.8 10115.8 10184.8 14599.4 1954.2 1982.4 2002.5 2042.2 2073.6 76821.6 83500.2 85562.6 85663.0 86447.0 10995.8 11028.9 11302.1 11331.0 11563.6 15671.5 15772.1 15812.0 15935.8 16038.8 8014.8 8127.3 8200.3 8214.0 8297.7 7652.1 7663.7 7775.6 7887.2 7918.8 4843.2 4858.1 4859.4 4961.1 5039.6 2037.4 2042.1 2084.2 2095.8 2132.4 963.7 984.9 986.6 1036.3 1061.7 17823.6 18115.0 18465.7 18493.3 18821.2 998.6 1020.9 1024.0 1050.7 1063.7 10475.7 10574.9 10662.9 10686.7 10779.2 466110.0 468845.0 471793.0 476346.0 488548.0 57298.7 93507.5 94566.0 94679.5 96160.0 1023.4 1026.4 1031.7 1060.9 1065.3 15998.4 16858.9 17254.3 17270.2 17287.0 41035.4 41325.6 42616.4 42838.1 43221.4 55208.0 56212.4 57678.4 58198.7 58287.4 8619.4 8674.3 9007.2 9023.2 9035.2 12678.2 13799.3 13824.3 13841.0 13926.0 11348.1 11464.4 11589.8 11788.5 11980.4 11252.6 11468.2 11509.1 11581.9 11610.2 11871.0 12140.7 12145.9 12149.6 12209.2 8849.8 8911.5 8952.2 9003.0 9008.4 9021.8 12212.3 12222.9 12224.1 12441.3 17:48:33 INFO - PROCESS | 20908 | 17:48:33 INFO - PROCESS | 20908 | [#3] mootools.html Cycles:180 Average:5992.92 Median:4516.03 stddev:3522.41 (78.0%) stddev-sans-first:3516.50 17:48:33 INFO - PROCESS | 20908 | Values: 1554.4 1572.1 1701.0 1824.2 1839.8 8148.8 8750.5 8979.3 9284.3 9302.9 8853.8 9166.3 9229.6 9238.9 9305.5 2330.8 2364.7 2365.3 2372.0 2374.2 2330.7 2363.5 2393.7 2395.9 2398.8 2365.5 2385.5 2393.3 2400.3 2407.1 2296.1 2299.2 2301.7 2328.0 2336.5 2290.0 2296.2 2313.1 2314.2 2332.5 9345.9 9408.4 9421.5 9478.1 9499.0 5382.2 5390.9 5446.8 5453.1 5513.1 3300.5 3445.2 3454.4 3456.0 3513.4 1130.6 1152.5 1160.6 1164.0 1171.4 12711.0 12794.4 12832.9 12883.6 12944.6 4400.9 4470.5 4533.5 4556.7 4565.8 10369.9 10458.5 10466.9 10467.8 10478.0 5370.2 5449.2 5452.7 5453.9 5456.2 4498.6 4716.8 4860.2 4873.0 4996.5 3879.9 3992.5 4012.7 4029.2 4030.0 1223.6 1227.0 1233.5 1234.5 1238.6 926.0 951.8 953.5 974.9 1015.7 5721.7 5768.6 5890.5 5997.6 6074.6 423.4 443.3 464.0 464.0 472.3 3821.2 3839.0 3868.1 3903.7 3978.7 11565.2 11831.6 11868.8 11877.8 11900.5 11607.7 11722.7 11725.8 11759.8 11783.6 8039.4 8384.7 8386.2 8695.4 8750.3 6039.9 6173.0 6216.5 6230.2 6245.9 10198.3 10489.6 10578.4 10614.8 10645.2 10589.8 10666.8 10766.3 10780.1 10784.3 7660.8 7976.3 8261.7 8304.0 8319.4 8839.4 8859.6 8869.6 8882.2 8975.1 7633.5 7854.8 8059.5 8383.1 8558.8 8086.8 8154.3 8225.7 8296.8 8301.8 7217.9 7218.1 7322.0 7330.8 7343.7 5093.3 5140.0 5205.8 5223.6 5328.5 5132.3 5156.9 5183.0 5199.4 5305.0 17:48:33 INFO - PROCESS | 20908 | 17:48:33 INFO - PROCESS | 20908 | [#4] prototype.html Cycles:180 Average:4775.86 Median:5340.63 stddev:1378.25 (25.8%) stddev-sans-first:1340.83 17:48:33 INFO - PROCESS | 20908 | Values: 314.5 339.7 344.3 344.6 356.1 5566.2 5570.0 5697.9 5796.8 5819.2 5510.8 5633.8 5648.2 5678.9 5692.6 4420.7 4432.2 4443.7 4458.8 4460.7 4154.3 4341.2 4356.0 4474.7 4496.0 4295.5 4317.6 4325.5 4330.5 4343.9 4310.5 4341.0 4343.5 4352.8 4360.9 3777.9 3788.7 3825.8 3833.7 3849.7 5379.6 5382.5 5410.6 5416.4 5476.2 4917.4 4921.2 4928.1 4934.5 4943.1 5705.1 5803.7 5835.6 5868.5 5881.6 4113.5 4114.1 4118.4 4143.2 4177.9 6112.6 6151.7 6157.4 6163.2 6166.1 4198.0 4299.0 4349.1 4358.5 4359.1 4333.7 4383.5 4386.4 4391.9 4400.3 4982.2 4994.5 5021.2 5028.7 5032.6 5806.3 5921.6 5963.8 5983.4 5991.6 1492.9 1494.4 1498.8 1504.8 1505.0 929.9 952.3 955.2 960.3 965.4 5058.6 5137.1 5140.2 5148.4 5213.0 5337.4 5349.0 5351.2 5361.6 5364.6 4889.4 5131.2 5132.0 5137.4 5143.6 2875.3 2893.9 2901.6 2917.6 2920.5 5464.9 5468.8 5475.3 5487.5 5498.2 5250.0 5410.2 5446.8 5474.6 5482.6 5332.8 5339.5 5445.4 5478.3 5545.5 5249.0 5272.7 5314.9 5345.4 5399.6 5134.8 5222.5 5254.6 5328.6 5341.8 5419.9 5459.2 5489.1 5492.4 5897.9 4179.5 4282.3 4289.4 4295.8 4307.8 5942.4 5979.0 5998.8 6016.1 6021.7 5634.4 5894.2 5921.4 5930.2 5933.2 5799.9 5818.5 5849.5 5856.5 5907.0 5711.4 5717.5 5723.0 5753.5 5785.4 5655.9 5959.5 5980.9 6005.0 6028.8 5847.8 5884.0 5885.1 5894.3 5924.0 17:48:33 INFO - PROCESS | 20908 | 17:48:33 INFO - PROCESS | 20908 | [#5] yui.html Cycles:180 Average:15897.70 Median:24406.49 stddev:18398.05 (75.4%) stddev-sans-first:18414.63 17:48:33 INFO - PROCESS | 20908 | Values: 777.9 784.9 851.9 857.2 889.0 13707.3 14295.0 14320.4 14329.6 14383.6 15174.0 15645.6 15680.9 16084.2 16150.4 838.1 839.6 840.3 841.0 841.8 696.3 824.5 841.8 847.4 848.7 886.1 888.1 888.4 891.2 892.6 887.2 887.6 888.5 888.6 893.3 641.3 642.6 642.9 647.9 650.1 14912.3 14937.6 14939.9 14966.6 14999.8 14131.1 14157.3 14208.4 14398.9 14399.7 11364.5 11438.5 11645.2 11927.5 11946.6 3850.4 3881.9 3883.8 3905.2 4009.4 53826.5 55887.4 59930.7 60244.0 60493.4 11263.2 11439.9 11543.5 11595.8 11895.3 19663.6 19924.4 19940.7 20059.6 20184.2 8146.8 8456.6 8591.6 8653.0 8777.8 4741.5 4771.1 4838.5 4924.0 4990.4 3474.5 3591.7 3594.7 3600.2 3613.7 670.0 672.2 680.0 687.8 690.7 670.3 728.7 734.9 739.3 771.2 9875.6 10033.9 10093.5 10233.7 10262.4 697.9 706.6 718.9 724.8 730.0 4566.8 4680.7 4771.3 4797.3 4810.1 64109.4 66265.7 67298.7 67941.0 68013.7 58969.0 59259.4 59281.4 59402.0 59947.0 50400.2 54292.7 54439.2 55804.0 59432.0 9179.4 9737.2 9965.2 10240.4 10354.7 35613.0 35867.5 36661.5 36723.6 37297.6 44803.6 48627.5 49225.5 49713.0 50161.5 13313.3 13448.3 13761.7 13907.1 14095.6 14738.6 14769.9 14875.6 15007.9 15306.9 13786.2 13846.2 13957.0 14175.1 14238.1 12789.6 13023.0 13194.1 14550.2 14728.3 12180.5 13330.3 13778.9 14207.0 14426.5 11674.7 11797.8 11845.1 11862.7 12282.5 11165.6 11350.3 11550.4 11924.4 12050.6 17:48:33 INFO - PROCESS | 20908 | -------- Summary: end -------- 17:48:33 INFO - PROCESS | 20908 | 17:48:33 INFO - TEST-INFO | 20908: exit 0 17:48:33 INFO - TEST-OK | dromaeo_css | took 1109859ms 17:48:33 INFO - TEST-START | kraken 17:48:33 INFO - operating with platform_type : linux_ 17:48:33 INFO - Initialising browser for kraken test... 17:48:33 INFO - TEST-INFO | started process 21141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwvG8mX/profile http://localhost:53871/getInfo.html) 17:48:37 INFO - PROCESS | 21141 | 17:48:37 INFO - PROCESS | 21141 | (process:21209): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:48:38 INFO - PROCESS | 21141 | __metrics Screen width/height:1600/1200 17:48:38 INFO - PROCESS | 21141 | colorDepth:24 17:48:38 INFO - PROCESS | 21141 | Browser inner width/height: 1024/697 17:48:38 INFO - PROCESS | 21141 | __metrics 17:48:39 ERROR - PROCESS | 21141 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 17:48:39 INFO - TEST-INFO | 21141: exit 0 17:48:39 INFO - Browser initialized. 17:48:39 INFO - Running cycle 1/1 for kraken test... 17:48:39 INFO - TEST-INFO | started process 21260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwvG8mX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:48:41 INFO - PROCESS | 21260 | 17:48:41 INFO - PROCESS | 21260 | (process:21321): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:48:51 INFO - PROCESS | 21260 | RSS: Main: 163954688 17:48:51 INFO - PROCESS | 21260 | 17:48:54 INFO - PROCESS | 21260 | Cycle 1(1): loaded http://localhost:53871/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53871/tests/kraken/driver.html?testName=audio-beat-detection) 17:48:55 INFO - PROCESS | 21260 | RSS: Main: 168189952 17:48:55 INFO - PROCESS | 21260 | 17:48:57 INFO - PROCESS | 21260 | Cycle 1(1): loaded http://localhost:53871/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53871/tests/kraken/driver.html?testName=audio-dft) 17:48:58 INFO - PROCESS | 21260 | RSS: Main: 168468480 17:48:58 INFO - PROCESS | 21260 | 17:49:01 INFO - PROCESS | 21260 | Cycle 1(1): loaded http://localhost:53871/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53871/tests/kraken/driver.html?testName=audio-fft) 17:49:02 INFO - PROCESS | 21260 | RSS: Main: 163610624 17:49:02 INFO - PROCESS | 21260 | 17:49:04 INFO - PROCESS | 21260 | Cycle 1(1): loaded http://localhost:53871/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53871/tests/kraken/driver.html?testName=audio-oscillator) 17:49:04 INFO - PROCESS | 21260 | RSS: Main: 163446784 17:49:04 INFO - PROCESS | 21260 | 17:49:07 INFO - PROCESS | 21260 | Cycle 1(1): loaded http://localhost:53871/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53871/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:49:07 INFO - PROCESS | 21260 | RSS: Main: 163635200 17:49:07 INFO - PROCESS | 21260 | 17:49:10 INFO - PROCESS | 21260 | Cycle 1(1): loaded http://localhost:53871/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53871/tests/kraken/driver.html?testName=imaging-darkroom) 17:49:11 INFO - PROCESS | 21260 | RSS: Main: 163536896 17:49:11 INFO - PROCESS | 21260 | 17:49:15 INFO - PROCESS | 21260 | Cycle 1(1): loaded http://localhost:53871/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53871/tests/kraken/driver.html?testName=imaging-desaturate) 17:49:15 INFO - PROCESS | 21260 | RSS: Main: 162844672 17:49:15 INFO - PROCESS | 21260 | 17:49:18 INFO - PROCESS | 21260 | Cycle 1(1): loaded http://localhost:53871/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53871/tests/kraken/driver.html?testName=json-parse-financial) 17:49:19 INFO - PROCESS | 21260 | RSS: Main: 163053568 17:49:19 INFO - PROCESS | 21260 | 17:49:20 INFO - PROCESS | 21260 | Cycle 1(1): loaded http://localhost:53871/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53871/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:49:21 INFO - PROCESS | 21260 | RSS: Main: 163483648 17:49:21 INFO - PROCESS | 21260 | 17:49:23 INFO - PROCESS | 21260 | Cycle 1(1): loaded http://localhost:53871/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53871/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:49:23 INFO - PROCESS | 21260 | RSS: Main: 163749888 17:49:23 INFO - PROCESS | 21260 | 17:49:26 INFO - PROCESS | 21260 | Cycle 1(1): loaded http://localhost:53871/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53871/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:49:26 INFO - PROCESS | 21260 | RSS: Main: 163639296 17:49:26 INFO - PROCESS | 21260 | 17:49:29 INFO - PROCESS | 21260 | Cycle 1(1): loaded http://localhost:53871/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:49:30 INFO - PROCESS | 21260 | RSS: Main: 164044800 17:49:30 INFO - PROCESS | 21260 | 17:49:32 INFO - PROCESS | 21260 | Cycle 1(1): loaded http://localhost:53871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:49:33 INFO - PROCESS | 21260 | RSS: Main: 164081664 17:49:33 INFO - PROCESS | 21260 | 17:49:35 INFO - PROCESS | 21260 | Cycle 1(1): loaded http://localhost:53871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53871/tests/kraken/driver.html?testName=ai-astar) 17:49:35 INFO - PROCESS | 21260 | RSS: Main: 165429248 17:49:35 INFO - PROCESS | 21260 | 17:49:35 INFO - PROCESS | 21260 | __start_tp_report 17:49:35 INFO - PROCESS | 21260 | _x_x_mozilla_page_load 17:49:35 INFO - PROCESS | 21260 | _x_x_mozilla_page_load_details 17:49:35 INFO - PROCESS | 21260 | |i|pagename|runs| 17:49:35 INFO - PROCESS | 21260 | |0;ai-astar;108;109;104;111;113;112;106;110;111;111 17:49:35 INFO - PROCESS | 21260 | |1;audio-beat-detection;163;125;154;213;125;154;152;133;182;126 17:49:35 INFO - PROCESS | 21260 | |2;audio-dft;162;163;163;166;165;171;170;169;169;167 17:49:35 INFO - PROCESS | 21260 | |3;audio-fft;75;76;75;159;75;74;76;75;180;76 17:49:35 INFO - PROCESS | 21260 | |4;audio-oscillator;91;92;178;92;92;93;147;94;92;151 17:49:35 INFO - PROCESS | 21260 | |5;imaging-gaussian-blur;117;118;117;118;118;117;118;117;117;118 17:49:35 INFO - PROCESS | 21260 | |6;imaging-darkroom;146;146;148;145;146;146;147;146;145;146 17:49:35 INFO - PROCESS | 21260 | |7;imaging-desaturate;100;99;100;97;99;95;94;96;98;95 17:49:35 INFO - PROCESS | 21260 | |8;json-parse-financial;56;58;57;56;56;57;56;107;54;54 17:49:35 INFO - PROCESS | 21260 | |9;json-stringify-tinderbox;60;61;59;59;60;60;60;59;60;59 17:49:35 INFO - PROCESS | 21260 | |10;stanford-crypto-aes;78;79;80;79;79;79;80;80;80;85 17:49:35 INFO - PROCESS | 21260 | |11;stanford-crypto-ccm;132;121;138;127;121;132;118;120;197;139 17:49:35 INFO - PROCESS | 21260 | |12;stanford-crypto-pbkdf2;169;172;163;163;162;164;166;160;162;164 17:49:35 INFO - PROCESS | 21260 | |13;stanford-crypto-sha256-iterative;64;66;65;64;62;62;63;63;64;66 17:49:35 INFO - PROCESS | 21260 | __end_tp_report 17:49:35 INFO - PROCESS | 21260 | __start_cc_report 17:49:35 INFO - PROCESS | 21260 | _x_x_mozilla_cycle_collect,852 17:49:35 INFO - PROCESS | 21260 | __end_cc_report 17:49:35 INFO - PROCESS | 21260 | __startTimestamp1463446175467__endTimestamp 17:49:35 INFO - PROCESS | 21260 | 17:49:35 INFO - PROCESS | 21260 | ------- Summary: start ------- 17:49:35 INFO - PROCESS | 21260 | Number of tests: 14 17:49:35 INFO - PROCESS | 21260 | 17:49:35 INFO - PROCESS | 21260 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:2.80 (2.5%) stddev-sans-first:2.92 17:49:35 INFO - PROCESS | 21260 | Values: 108.0 109.0 104.0 111.0 113.0 112.0 106.0 110.0 111.0 111.0 17:49:35 INFO - PROCESS | 21260 | 17:49:35 INFO - PROCESS | 21260 | [#1] audio-beat-detection Cycles:10 Average:152.70 Median:154.00 stddev:28.36 (18.4%) stddev-sans-first:29.84 17:49:35 INFO - PROCESS | 21260 | Values: 163.0 125.0 154.0 213.0 125.0 154.0 152.0 133.0 182.0 126.0 17:49:35 INFO - PROCESS | 21260 | 17:49:35 INFO - PROCESS | 21260 | [#2] audio-dft Cycles:10 Average:166.50 Median:168.00 stddev:3.21 (1.9%) stddev-sans-first:2.96 17:49:35 INFO - PROCESS | 21260 | Values: 162.0 163.0 163.0 166.0 165.0 171.0 170.0 169.0 169.0 167.0 17:49:35 INFO - PROCESS | 21260 | 17:49:35 INFO - PROCESS | 21260 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.00 stddev:40.05 (53.4%) stddev-sans-first:41.88 17:49:35 INFO - PROCESS | 21260 | Values: 75.0 76.0 75.0 159.0 75.0 74.0 76.0 75.0 180.0 76.0 17:49:35 INFO - PROCESS | 21260 | 17:49:35 INFO - PROCESS | 21260 | [#4] audio-oscillator Cycles:10 Average:112.20 Median:92.00 stddev:33.04 (35.9%) stddev-sans-first:34.15 17:49:35 INFO - PROCESS | 21260 | Values: 91.0 92.0 178.0 92.0 92.0 93.0 147.0 94.0 92.0 151.0 17:49:35 INFO - PROCESS | 21260 | 17:49:35 INFO - PROCESS | 21260 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 17:49:35 INFO - PROCESS | 21260 | Values: 117.0 118.0 117.0 118.0 118.0 117.0 118.0 117.0 117.0 118.0 17:49:35 INFO - PROCESS | 21260 | 17:49:35 INFO - PROCESS | 21260 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 17:49:35 INFO - PROCESS | 21260 | Values: 146.0 146.0 148.0 145.0 146.0 146.0 147.0 146.0 145.0 146.0 17:49:35 INFO - PROCESS | 21260 | 17:49:35 INFO - PROCESS | 21260 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:96.50 stddev:2.21 (2.3%) stddev-sans-first:2.12 17:49:35 INFO - PROCESS | 21260 | Values: 100.0 99.0 100.0 97.0 99.0 95.0 94.0 96.0 98.0 95.0 17:49:35 INFO - PROCESS | 21260 | 17:49:35 INFO - PROCESS | 21260 | [#8] json-parse-financial Cycles:10 Average:61.10 Median:56.00 stddev:16.18 (28.9%) stddev-sans-first:17.05 17:49:35 INFO - PROCESS | 21260 | Values: 56.0 58.0 57.0 56.0 56.0 57.0 56.0 107.0 54.0 54.0 17:49:35 INFO - PROCESS | 21260 | 17:49:35 INFO - PROCESS | 21260 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 17:49:35 INFO - PROCESS | 21260 | Values: 60.0 61.0 59.0 59.0 60.0 60.0 60.0 59.0 60.0 59.0 17:49:35 INFO - PROCESS | 21260 | 17:49:35 INFO - PROCESS | 21260 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:80.00 stddev:1.91 (2.4%) stddev-sans-first:1.90 17:49:35 INFO - PROCESS | 21260 | Values: 78.0 79.0 80.0 79.0 79.0 79.0 80.0 80.0 80.0 85.0 17:49:35 INFO - PROCESS | 21260 | 17:49:35 INFO - PROCESS | 21260 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:132.00 stddev:23.22 (17.6%) stddev-sans-first:24.62 17:49:35 INFO - PROCESS | 21260 | Values: 132.0 121.0 138.0 127.0 121.0 132.0 118.0 120.0 197.0 139.0 17:49:35 INFO - PROCESS | 21260 | 17:49:35 INFO - PROCESS | 21260 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:164.00 stddev:3.60 (2.2%) stddev-sans-first:3.43 17:49:35 INFO - PROCESS | 21260 | Values: 169.0 172.0 163.0 163.0 162.0 164.0 166.0 160.0 162.0 164.0 17:49:35 INFO - PROCESS | 21260 | 17:49:35 INFO - PROCESS | 21260 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.45 (2.3%) stddev-sans-first:1.54 17:49:35 INFO - PROCESS | 21260 | Values: 64.0 66.0 65.0 64.0 62.0 62.0 63.0 63.0 64.0 66.0 17:49:35 INFO - PROCESS | 21260 | -------- Summary: end -------- 17:49:35 INFO - PROCESS | 21260 | 17:49:36 INFO - TEST-INFO | 21260: exit 0 17:49:36 INFO - TEST-OK | kraken | took 62410ms 17:49:36 INFO - SUITE-END | took 1172s 17:49:36 INFO - Completed test suite (00:19:32) 17:49:36 INFO - javascript benchmark 17:49:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7315.688674707132, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3189.2824114574237, 3196.1689960610242, 3234.7573931955108, 3238.449463591189, 3245.350929814036, 5457.836264912054, 5502.367227768807, 5519.31008623922, 5574.968630803304, 5588.972055139729, 5364.785408583662, 5492.47821456961, 5507.366652834915, 5527.088030474967, 5599.216109744639, 4954.653174277793, 5018.924716129261, 5116.795328186868, 5136.460671629462, 5190.584753219733, 880.4740908260387, 4950.975245123769, 4964.230544265644, 5010.824621138261, 5161.612879034069, 5010.774515146827, 5036.445990940993, 5053.747312634354, 5057.115004874132, 5078.7968481260705, 5026.623003274769, 5032.245163225509, 5032.79868805251, 5035.169197082477, 5044.445111037783, 4968.552830245295, 5018.523240292203, 5034.823781167678, 5041.218611115283, 5071.949280507221, 5470.316210473691, 5474.890502189974, 5487.451254874521, 5492.450754924515, 5579.13523403873, 5803.912941305884, 5925.970370148165, 6003.099535069731, 6017.0, 6023.548233882432, 5974.044152935509, 6030.216071910623, 6048.123022161762, 6073.544484163661, 6118.265808103011, 5643.492085712264, 5645.633033852828, 5645.661260324394, 5648.181013752983, 5653.462921022497, 5935.584509084322, 6088.238970128734, 6102.72537735803, 6149.2620885494025, 6169.753209871555, 5798.10129429939, 5802.912956305659, 5813.563982701315, 5813.970930145322, 5815.621984570989, 5926.051831706906, 5938.762449502058, 5940.732667029994, 5944.286685597756, 5975.043992961106, 5862.443067908542, 5928.67392293428, 5944.7919322824355, 5952.5833191676165, 5988.041913293852, 5899.292084949748, 5953.136795164677, 5971.5222782177325, 5985.850353741104, 5990.161377407167, 4415.801288942005, 4524.366588677588, 4535.9773201133785, 4540.160070386923, 4576.977115114403, 3919.1573811630637, 3976.463177471004, 3984.1633257015774, 4006.2187873364996, 4027.496562929634, 5615.775368985276, 5657.9434205658235, 5671.631343962629, 5709.942900570941, 5730.36965933747, 5840.766369345263, 6065.96967015171, 6076.270847498328, 6086.60437071589, 6092.1775560299675, 5640.858978525488, 5668.064769313017, 5669.716514174274, 5672.773089076473, 5691.231683722727, 5051.671641343374, 5088.389393272757, 5090.287359769635, 5095.363079615048, 5153.1497302945345, 5903.203067585821, 6003.489703375262, 6031.396860313934, 6049.909251361233, 6055.878882422327, 5963.254593175766, 6038.456538911519, 6065.272167339771, 6068.180795592539, 6113.84715382119, 6033.095035744674, 6081.361457046946, 6084.69576521181, 6088.847778805565, 6090.604110732788, 5722.914156287576, 5761.683107428964, 5787.247657804459, 5926.851828704317, 5937.0, 5956.404359564009, 5958.851028724316, 5959.940400595939, 5962.314333851663, 5999.160117583455, 5741.569382296261, 5760.481556659921, 5769.53843692512, 5804.709764511842, 5810.302763668386, 5674.77300907959, 5750.712464376848, 5761.251037365116, 5768.048272035067, 5786.33457152416, 5637.0, 5679.8864022720145, 5687.260656114679, 5687.9431205687415, 5689.0, 5804.1874137619925, 5813.651180929158, 5814.895169917702, 5840.649561026352, 5883.411658834082, 5620.269364982526, 5632.986062508788, 5675.943240567542, 5684.658920464785, 5723.227364305765], "value": 5440.658390551633, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.9591228613999, 640.9615423074615, 652.9053287273348, 660.8942569188931, 669.9598024118552, 30366.240843978885, 43998.780006099965, 44233.557664423344, 44640.3303950441, 44942.77528612352, 42886.14227715444, 43244.56755432445, 43275.0, 46901.0, 46939.29591056137, 9052.728418147466, 9116.407433516833, 9129.0, 9165.037671044543, 9170.449773013606, 9030.322725795559, 9059.411138276024, 9117.863232051524, 9128.726138215865, 9143.725688229364, 9024.368294219406, 9155.67955121571, 9172.266218702522, 9185.770355741093, 9189.127032931861, 9104.63581456741, 9134.954325228398, 9135.771605709844, 9150.0, 9161.312901532345, 8883.51140687262, 8903.55482225886, 8958.148975847284, 8960.820783584357, 9006.324525660537, 42889.78555107205, 43199.0, 43225.35161972573, 43371.34942975858, 43438.565614343766, 3691.53855768029, 3768.9434658480145, 3855.865044723449, 4072.3847297967277, 4321.891952701176, 32140.0, 32659.346813063843, 32893.17767055819, 33076.338473230404, 33185.502217466754, 4401.2517871961845, 4415.690901636886, 4449.977750111261, 4462.687611867171, 4533.637309015304, 333087.0, 337296.0, 337695.0, 339063.0, 339286.0, 63301.68349158225, 63326.0, 63449.36550634527, 63548.68225658842, 63840.0, 33715.66284337174, 33803.83098084494, 50524.494755052714, 50638.746806265735, 50992.49007509877, 16542.0, 16627.08551029681, 16711.582210444834, 16773.496795096165, 16780.496585102468, 12582.496700132075, 12726.68183295425, 12729.363531823372, 12732.363381830872, 12742.872571274354, 20625.278115265894, 20971.0, 21016.684749728767, 21055.157793688388, 21077.683834742493, 8073.478622724439, 8189.8771518427275, 8243.134470880592, 8311.958440207882, 8379.916200838035, 974.4202199691173, 1090.340344091829, 1100.0924237503932, 1148.3683973814368, 1248.3820508847996, 32355.676443235738, 32395.67604323974, 32851.50722739161, 33024.0, 33076.503852442234, 1113.8384934184498, 1127.503898284752, 1127.503898284752, 1132.2187690493533, 1233.2908577567935, 16655.91672041632, 17016.404425845038, 17146.314147433965, 17382.648210917123, 17396.739048914278, 578113.0, 580055.0, 580727.0, 581670.0, 582753.0, 59067.70466147642, 59585.0, 59610.70194649086, 59618.70190649019, 59703.40296597065, 1366.5353779714944, 1381.1920026784444, 1393.038803225771, 1397.82527184102, 1428.2358937968138, 30641.846790765903, 30848.69151308548, 31656.683433166294, 31909.68090319067, 32038.0, 50967.490325096274, 56610.433895662165, 57787.0, 57839.0, 63334.68332658307, 540197.0, 543744.0, 547775.0, 547877.0, 550198.0, 45375.319370210134, 45590.544094559955, 45871.541284586725, 46153.0, 46479.07041859076, 46265.76867115643, 47729.80675483141, 49762.25356619581, 50359.74820125876, 50773.74613126911, 38552.56645485805, 41122.794386027876, 42391.57608424, 42715.35926961036, 43174.568254317055, 42115.7894210527, 42510.0, 42840.0, 42861.785691071345, 42996.0, 36456.453153203256, 41365.1726965453, 41525.754227373225, 41682.0, 41969.79015104905, 35602.0, 37367.252654946205, 37395.81302093472, 37817.0, 38109.80945095257, 28525.857370713842, 28980.565291521067, 29106.7089329104, 29217.85391073116, 29467.0], "value": 20969.538998125136, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.54397442940626, 404.8704414587331, 410.1059689876069, 417.7368257997461, 418.7131814706926, 17922.103894805274, 19057.142428590712, 19719.0, 19912.40262792115, 19928.402147935583, 18258.908705456455, 18488.44534663959, 18510.0, 18596.628067438643, 18772.53068673284, 5638.182463542784, 5699.031164702, 5807.825765227029, 5829.941700583004, 5844.736986835603, 5790.652560846363, 5810.244668193129, 5810.941890581083, 5821.534277257831, 5825.126231065353, 5560.471755183271, 5844.941550584483, 5849.298084229898, 5856.41435856413, 5862.149988251701, 5584.134459158837, 5794.304683437993, 5814.040683287252, 5823.242978412801, 5840.123981402781, 5098.235264710286, 5115.923261151086, 5123.359580052494, 5149.639525233235, 5153.613478989053, 21878.23426180076, 21892.671609925863, 22198.445038873997, 22210.0, 22289.77710222893, 2292.908283668651, 2314.884255787204, 2349.201271567675, 2442.303943376129, 2468.2965354873777, 9612.279079069098, 9904.752381190456, 10115.79768404635, 10184.847227291597, 14599.416023359054, 1954.1890115602007, 1982.4449154236836, 2002.5394159343432, 2042.1525067097136, 2073.5645514441985, 76821.61589192074, 83500.16499834985, 85562.57218713929, 85663.0, 86446.99999999937, 10995.835062474069, 11028.889711102947, 11302.135147700701, 11331.0, 11563.595274165364, 15671.529854104396, 15772.132532710582, 15812.0, 15935.760963585555, 16038.759418608497, 8014.83970320602, 8127.268545830785, 8200.343972482306, 8213.95893020531, 8297.709580164665, 7652.120006199359, 7663.731769388156, 7775.57234352116, 7887.171846956102, 7918.762437126896, 4843.1524483216, 4858.1012512685265, 4859.392575928009, 4961.107000739901, 5039.622028347889, 2037.4193354893785, 2042.1423002339054, 2084.218418093215, 2095.8428117891217, 2132.41358626379, 963.6964356227905, 984.9411882226635, 986.6497393425374, 1036.3056751976194, 1061.6655753437642, 17823.554411139565, 18115.0, 18465.7230141548, 18493.260269589337, 18821.15304811287, 998.6005597760953, 1020.9132223760915, 1023.9897601024044, 1050.721558786922, 1063.744701271689, 10475.685729428129, 10574.937887112093, 10662.89337106619, 10686.732831679115, 10779.245452818384, 466110.0, 468845.0, 471793.0, 476346.0, 488548.0, 57298.7135064322, 93507.53246233726, 94566.0, 94679.52660236655, 96160.0, 1023.4319952426475, 1026.4046852825343, 1031.7265924529856, 1060.9151267898549, 1065.2862582070031, 15998.360065597246, 16858.915705421394, 17254.309827606754, 17270.222839972485, 17287.049212293445, 41035.38446923239, 41325.586744132175, 42616.36075458809, 42838.143237134456, 43221.351679725456, 55208.0, 56212.41438313649, 57678.423215768984, 58198.70900645639, 58287.417125829896, 8619.396642234984, 8674.349423793115, 9007.189352958265, 9023.233025192932, 9035.232005279362, 12678.175918565265, 13799.310034498034, 13824.308784560933, 13841.0, 13926.0, 11348.148888833535, 11464.369459679798, 11589.82615260755, 11788.4695188715, 11980.400979950793, 11252.606158784403, 11468.19722619442, 11509.079273658255, 11581.942090289494, 11610.24533405326, 11871.0, 12140.696482587653, 12145.939270303945, 12149.635510934686, 12209.206401583868, 8849.823003540021, 8911.50986695712, 8952.23905968, 9002.954985225295, 9008.41445306053, 9021.819563608822, 12212.267263964191, 12222.87777122253, 12224.144309898222, 12441.253524788543], "value": 9280.393654741154, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1554.3782487005196, 1572.0567659404358, 1700.9829901700987, 1824.151769427216, 1839.8160183981595, 8148.796280093001, 8750.474971501715, 8979.326550508706, 9284.30367722421, 9302.90697093029, 8853.822923541542, 9166.312526560501, 9229.584668689908, 9238.86141707875, 9305.534723263843, 2330.790228879405, 2364.7398786133513, 2365.290412876139, 2371.988140059297, 2374.169040835711, 2330.7086614173227, 2363.4918492524102, 2393.6768536247646, 2395.9161429349974, 2398.8440751351195, 2365.4559451326204, 2385.5109702510945, 2393.3418309964813, 2400.2919138853995, 2407.0612461140167, 2296.0700916128994, 2299.1608063056947, 2301.6547517872286, 2327.953440931172, 2336.4509340305017, 2289.977100228993, 2296.1619009061574, 2313.051648823991, 2314.155333303349, 2332.486852892361, 9345.859812102824, 9408.388454750419, 9421.528923553795, 9478.099580539838, 9499.0, 5382.165764306539, 5390.865228369283, 5446.809361672323, 5453.072977593779, 5513.062779327524, 3300.4884242942144, 3445.1903802606366, 3454.378211921853, 3456.032310952937, 3513.4378499439968, 1130.559081958037, 1152.5217034930495, 1160.5879912631062, 1163.988360116405, 1171.3733152763232, 12711.0, 12794.42425090873, 12832.935835320857, 12883.613491595268, 12944.611661650166, 4400.933985990213, 4470.463544374696, 4533.455985281787, 4556.70381425213, 4565.794539245676, 10369.896301037044, 10458.477076146315, 10466.947665261625, 10467.84298235527, 10478.0, 5370.221317908881, 5449.1826226066405, 5452.700101494376, 5453.945460545423, 5456.236126942231, 4498.595126438636, 4716.787744551503, 4860.1737704590305, 4872.9512704873205, 4996.525330093708, 3879.86420475282, 3992.48097747291, 4012.7191096622955, 4029.174019326031, 4029.9597004029583, 1223.5962132496254, 1226.9509219631116, 1233.4572787973443, 1234.493857518413, 1238.6346027921784, 926.0045451139916, 951.8477043672979, 953.4517652349926, 974.8683927669815, 1015.7369796703721, 5721.685307308055, 5768.567357448208, 5890.4698577128265, 5997.580169388101, 6074.574779765462, 423.4220289305076, 443.3349975037444, 463.9744814035193, 464.0348076001908, 472.2939205887221, 3821.216650586623, 3839.0, 3868.052327179803, 3903.7072219583647, 3978.741381810231, 11565.248258863146, 11831.585894493823, 11868.821967670492, 11877.821832672516, 11900.523979040741, 11607.709807254887, 11722.70693232659, 11725.824112638316, 11759.823602645796, 11783.587574434854, 8039.397045221632, 8384.664613415394, 8386.161383861565, 8695.434796738191, 8750.34372422071, 6039.879202416015, 6173.0, 6216.533759968111, 6230.15892854477, 6245.8750824982335, 10198.286119971532, 10489.580416783243, 10578.41818699948, 10614.8407773885, 10645.201609879136, 10589.788204236027, 10666.786664266516, 10766.300190487593, 10780.083692886192, 10784.299020563638, 7660.80847978805, 7976.282134607914, 8261.669533218605, 8303.95848020756, 8319.417640765088, 8839.381243313164, 8859.557022148738, 8869.556522173994, 8882.200601945857, 8975.102489751234, 7633.5419874807685, 7854.842903142019, 8059.476134051268, 8383.119772423808, 8558.78603034929, 8086.797830054295, 8154.347652187929, 8225.670973161006, 8296.792580185544, 8301.750947471586, 7217.855642887218, 7218.061651985208, 7321.963390183015, 7330.816729581803, 7343.7062517500835, 5093.312402825572, 5140.0, 5205.765740541609, 5223.582113430841, 5328.520433161034, 5132.3327967364, 5156.871078223075, 5182.974085129701, 5199.4020687621405, 5305.0], "value": 4665.099032603181, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.52991452991455, 339.7180340317537, 344.2838895098195, 344.58133367957925, 356.0617772170331, 5566.165075238716, 5570.0, 5697.886042279152, 5796.797112101072, 5819.214406055181, 5510.779568817253, 5633.774649014044, 5648.220810444717, 5678.914816277759, 5692.629979051369, 4420.668449866257, 4432.224360736875, 4443.688941774077, 4458.777061146946, 4460.687751857355, 4154.252234597771, 4341.153475072362, 4356.0, 4474.709143905636, 4495.954340774956, 4295.463067116611, 4317.589828966243, 4325.502567204764, 4330.480342358921, 4343.891402714941, 4310.547392523771, 4341.0, 4343.500497442803, 4352.7823608819435, 4360.934585981213, 3777.867774627875, 3788.6590206881515, 3825.7895815730126, 3833.674137698271, 3849.653531182179, 5379.5696344292755, 5382.542483888874, 5410.648307859977, 5416.350037995427, 5476.151196564539, 4917.434495033045, 4921.163402221595, 4928.137575924199, 4934.506549345073, 4943.1102401567705, 5705.144228365778, 5803.736173862756, 5835.562332825013, 5868.501177399926, 5881.588288819784, 4113.465249517573, 4114.115465175002, 4118.382242663624, 4143.150654115899, 4177.895552611179, 6112.633242005494, 6151.692415379258, 6157.384261573851, 6163.229596300463, 6166.136740856284, 4197.97901010493, 4298.978505107517, 4349.13017396522, 4358.498772641186, 4359.060218202932, 4333.674974376871, 4383.539728328479, 4386.385905973167, 4391.890202744893, 4400.251957167226, 4982.177940639754, 4994.500549945049, 5021.171506701354, 5028.673136246132, 5032.6225533084435, 5806.332271788799, 5921.61509501881, 5963.761449542057, 5983.401659833982, 5991.580589358703, 1492.9477468288558, 1494.402239104367, 1498.805155329822, 1504.7811272868792, 1504.9924750376179, 929.9395539289925, 952.2715122930963, 955.1976339874539, 960.2605993385055, 965.3918031640162, 5058.645894787403, 5137.12668846297, 5140.249966268028, 5148.382194136728, 5213.0, 5337.439568845293, 5349.0, 5351.170568561879, 5361.597880159004, 5364.597655175799, 4889.3888263967, 5131.204663277198, 5132.022682421153, 5137.434882162959, 5143.588512918957, 2875.266806964211, 2893.929246178885, 2901.637295338083, 2917.5623656451276, 2920.503514402514, 5464.863378415572, 5468.835934921959, 5475.315585551806, 5487.451254874561, 5498.202760599771, 5250.0, 5410.215518749838, 5446.782128714886, 5474.644148130359, 5482.5613950883835, 5332.84019971912, 5339.45155904791, 5445.401005889349, 5478.260434841325, 5545.500904918576, 5249.0, 5272.657277276965, 5314.867128321823, 5345.41200467956, 5399.5950303726595, 5134.76893539799, 5222.451642577475, 5254.579633629224, 5328.57371410294, 5341.813036543703, 5419.864503387447, 5459.235707000944, 5489.094299440548, 5492.423295553909, 5897.941020589739, 4179.540250572495, 4282.272013757606, 4289.378040184093, 4295.806688698954, 4307.8492252771, 5942.3955532006985, 5979.0, 5998.820035398945, 6016.127661488972, 6021.668808215591, 5634.4365563443325, 5894.204282421818, 5921.437463440966, 5930.191291656086, 5933.169356290036, 5799.9130013049, 5818.505427038749, 5849.473547380756, 5856.531477481876, 5906.995810712103, 5711.371749107678, 5717.542596592346, 5723.0, 5753.482186603226, 5785.4214578541805, 5655.9355835120705, 5959.493443057216, 5980.8803823924145, 6005.009173486325, 6028.819135425944, 5847.8245652630485, 5883.999720047516, 5885.087346612282, 5894.263217097863, 5923.970380148072], "value": 4335.0996470843875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.8910952466653, 784.909735380431, 851.8892543969283, 857.172828220767, 888.9644414223432, 13707.314634268285, 14294.999999999987, 14320.427182912697, 14329.641758956031, 14383.64040898978, 15174.0136891102, 15645.608859778482, 15680.921595392007, 16084.1957902105, 16150.434734784285, 838.1032295443878, 839.6095815445816, 840.3487297344545, 841.0160112668193, 841.8190089130836, 696.3419568507762, 824.5052968219051, 841.7937605286683, 847.3517758914404, 848.6859861851093, 886.0696268917643, 888.1207604471559, 888.391451855481, 891.1534042659499, 892.5715656484858, 887.1926546842343, 887.6493784954971, 888.4935586715575, 888.6267767537618, 893.2942975049735, 641.3105911145537, 642.5566359212175, 642.8907085795425, 647.9190101237346, 650.1385663995226, 14912.328945197492, 14937.551873443814, 14939.925300373538, 14966.625834354229, 14999.775003374958, 14131.08147970389, 14157.292135393189, 14208.375537005357, 14398.92800536001, 14399.712005759931, 11364.545418183263, 11438.485268162953, 11645.18483706141, 11927.463264153133, 11946.641600751991, 3850.4224366344993, 3881.9223615527812, 3883.786391748453, 3905.1799122184093, 4009.4186342980397, 53826.46173538254, 55887.44112558863, 59930.700346497986, 60244.0, 60493.395066049656, 11263.211575189822, 11439.942800285946, 11543.4805433754, 11595.76808463826, 11895.286282822884, 19663.60672786536, 19924.402267931695, 19940.70088948667, 20059.59880802405, 20184.19263229484, 8146.796330091676, 8456.577171141418, 8591.613377398033, 8653.0, 8777.780555486037, 4741.454732705783, 4771.069641419959, 4838.467768545457, 4924.03981223658, 4990.351254336913, 3474.4788281757938, 3591.6947059500235, 3594.676479116892, 3600.171960449059, 3613.747037707335, 669.9866002679919, 672.2168673495323, 679.9898001529981, 687.8211664967044, 690.7099018412279, 670.3062330487921, 728.7230852276101, 734.9228331025272, 739.3309055304958, 771.221066722603, 9875.604975800887, 10033.949830250802, 10093.495325233709, 10233.74415639615, 10262.384256944608, 697.8778713725078, 706.6184260499375, 718.8813845715503, 724.8006798130556, 730.0290613484053, 4566.840160594364, 4680.702454599894, 4771.33201351811, 4797.328374027639, 4810.11012962596, 64109.358906410336, 66265.66867165633, 67298.66350668314, 67941.0, 68013.65993170101, 58969.0, 59259.40740592625, 59281.40718592845, 59402.0, 59947.0, 50400.24399634008, 54292.72853635706, 54439.18341224885, 55804.0, 59432.0, 9179.449233046038, 9737.17234035115, 9965.152961998312, 10240.436775977392, 10354.741131471472, 35613.0, 35867.46198806968, 36661.450078248316, 36723.63276367202, 37297.6270237305, 44803.551964479935, 48627.5137248623, 49225.50774492209, 49713.0, 50161.49838501714, 13313.267770272341, 13448.26034568069, 13761.655958600715, 13907.096038757449, 14095.577132686036, 14738.55784326472, 14769.882630398211, 14875.553733387584, 15007.924960375129, 15306.923465382602, 13786.172829630254, 13846.238456884565, 13957.0, 14175.149491030572, 14238.074525155831, 12789.61631151067, 13022.95816334672, 13194.076414650883, 14550.199739014455, 14728.337224825123, 12180.45187966526, 13330.266835323762, 13778.862211378158, 14207.0, 14426.495072672826, 11674.70813229676, 11797.823032654689, 11845.111616628616, 11862.703432414259, 12282.508699651913, 11165.649068199205, 11350.318980861175, 11550.364729939934, 11924.403779810802, 12050.578229761917], "value": 7158.458735163676, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 104.0, 111.0, 113.0, 112.0, 106.0, 110.0, 111.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 125.0, 154.0, 213.0, 125.0, 154.0, 152.0, 133.0, 182.0, 126.0], "value": 152.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 166.0, 165.0, 171.0, 170.0, 169.0, 169.0, 167.0], "value": 166.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 159.0, 75.0, 74.0, 76.0, 75.0, 180.0, 76.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 178.0, 92.0, 92.0, 93.0, 147.0, 94.0, 92.0, 151.0], "value": 112.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 148.0, 145.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 99.0, 100.0, 97.0, 99.0, 95.0, 94.0, 96.0, 98.0, 95.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 57.0, 56.0, 56.0, 57.0, 56.0, 107.0, 54.0, 54.0], "value": 61.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 59.0, 59.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 80.0, 79.0, 79.0, 79.0, 80.0, 80.0, 80.0, 85.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 121.0, 138.0, 127.0, 121.0, 132.0, 118.0, 120.0, 197.0, 139.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 163.0, 163.0, 162.0, 164.0, 166.0, 160.0, 162.0, 164.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 64.0, 62.0, 62.0, 63.0, 63.0, 64.0, 66.0], "value": 63.9, "unit": "score"}]}]} 17:49:36 INFO - Return code: 0 17:49:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:49:36 ERROR - # TBPL SUCCESS # 17:49:36 INFO - Running post-action listener: _resource_record_post_action 17:49:36 INFO - ##### 17:49:36 INFO - ##### Finished run-tests step (success) 17:49:36 INFO - ##### 17:49:36 INFO - Running post-run listener: _resource_record_post_run 17:49:36 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 537833472; Read time: 0; Write time: 526936 17:49:36 INFO - TinderboxPrint: CPU usage
13.5% 17:49:36 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:49:36 INFO - TinderboxPrint: I/O write bytes / time
537,833,472 / 526,936 17:49:36 INFO - TinderboxPrint: CPU idle
8,213.9 (86.5%) 17:49:36 INFO - TinderboxPrint: CPU user
1,223.1 (12.9%) 17:49:36 INFO - TinderboxPrint: Swap in / out
0 / 0 17:49:36 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246468608; Read time: 0; Write time: 332740 17:49:36 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 291287040; Read time: 0; Write time: 194196 17:49:37 INFO - Running post-run listener: _upload_blobber_files 17:49:37 INFO - Blob upload gear active. 17:49:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:49:37 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 17:49:37 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'] 17:49:37 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 17:49:37 INFO - (blobuploader) - INFO - Open directory for files ... 17:49:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:49:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:49:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:49:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:49:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:49:38 INFO - (blobuploader) - INFO - Done attempting. 17:49:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:49:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:49:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:49:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:49:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:49:42 INFO - (blobuploader) - INFO - Done attempting. 17:49:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:49:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:49:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:49:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:49:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:49:43 INFO - (blobuploader) - INFO - Done attempting. 17:49:43 INFO - (blobuploader) - INFO - Iteration through files over. 17:49:43 INFO - Return code: 0 17:49:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:49:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:49:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb591b36d88288eb866a4e6c77db646cd798adeeec80d4fe8e3df8f98d17efda39cca7aa403fa63b7e2e9203dbeba522a2cdaf327d27c55a17c24ae17fc42e08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c30911daf6283a0e3eb506b009f0e17c0e673be1790167c21be1e8d4c99b0aa5f221917dba6de7f1c9ef7102b7b2d1c50293ca61c311413967317d13845e7021", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/005d5abf97947fb073c4dc3b192532a848b76785ec87b17b523021307cabb1bb6a132ac2094b50203110b32f61173a44d2badde121582f96814f007b97d0946a"} 17:49:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:49:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:49:43 INFO - Contents: 17:49:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb591b36d88288eb866a4e6c77db646cd798adeeec80d4fe8e3df8f98d17efda39cca7aa403fa63b7e2e9203dbeba522a2cdaf327d27c55a17c24ae17fc42e08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c30911daf6283a0e3eb506b009f0e17c0e673be1790167c21be1e8d4c99b0aa5f221917dba6de7f1c9ef7102b7b2d1c50293ca61c311413967317d13845e7021", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/005d5abf97947fb073c4dc3b192532a848b76785ec87b17b523021307cabb1bb6a132ac2094b50203110b32f61173a44d2badde121582f96814f007b97d0946a"} 17:49:43 INFO - Running post-run listener: copy_logs_to_upload_dir 17:49:43 INFO - Copying logs to upload dir... 17:49:43 INFO - mkdir: /builds/slave/test/build/upload/logs 17:49:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.279996 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-05-16 17:49:41.868441) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 17:49:41.872408) ========= 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=826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb591b36d88288eb866a4e6c77db646cd798adeeec80d4fe8e3df8f98d17efda39cca7aa403fa63b7e2e9203dbeba522a2cdaf327d27c55a17c24ae17fc42e08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c30911daf6283a0e3eb506b009f0e17c0e673be1790167c21be1e8d4c99b0aa5f221917dba6de7f1c9ef7102b7b2d1c50293ca61c311413967317d13845e7021", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/005d5abf97947fb073c4dc3b192532a848b76785ec87b17b523021307cabb1bb6a132ac2094b50203110b32f61173a44d2badde121582f96814f007b97d0946a"} build_url:https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011548 build_url: 'https://queue.taskcluster.net/v1/task/WOe0hKRJSUayknvFhm586A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb591b36d88288eb866a4e6c77db646cd798adeeec80d4fe8e3df8f98d17efda39cca7aa403fa63b7e2e9203dbeba522a2cdaf327d27c55a17c24ae17fc42e08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c30911daf6283a0e3eb506b009f0e17c0e673be1790167c21be1e8d4c99b0aa5f221917dba6de7f1c9ef7102b7b2d1c50293ca61c311413967317d13845e7021", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/005d5abf97947fb073c4dc3b192532a848b76785ec87b17b523021307cabb1bb6a132ac2094b50203110b32f61173a44d2badde121582f96814f007b97d0946a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-16 17:49:41.900132) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 17:49:41.900670) ========= 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=826874ccc97bd7bf541b4875000001d5-1463444948.967216-173186935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-16 17:49:41.986922) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 17:49:41.987418) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-16 17:49:41.987895) ========= ========= Total master_lag: 0.19 =========