builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-025 starttime: 1463658197.79 results: success (0) buildid: 20160519020348 builduid: 6b4d8fa7f6724ada8193ea6f1c5e6910 revision: 7ab87e09f57b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 04:43:17.789312) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 04:43:17.789828) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 04:43:17.790169) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 04:43:17.806452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 04:43:17.806810) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1463658084.333527-615993172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-19 04:43:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 26.8M=0s 2016-05-19 04:43:18 (26.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.341367 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 04:43:18.161607) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 04:43:18.161927) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1463658084.333527-615993172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017627 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 04:43:18.211483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 04:43:18.211980) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7ab87e09f57b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7ab87e09f57b --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1463658084.333527-615993172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-19 04:43:18,623 Setting DEBUG logging. 2016-05-19 04:43:18,623 attempt 1/10 2016-05-19 04:43:18,623 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7ab87e09f57b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 04:43:18,922 unpacking tar archive at: mozilla-inbound-7ab87e09f57b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585689 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 04:43:18.812286) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 04:43:18.812633) ========= script_repo_revision: 7ab87e09f57b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 04:43:18.813059) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 04:43:18.813332) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 04:43:18.823246) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-19 04:43:18.823652) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1463658084.333527-615993172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:43:19 INFO - MultiFileLogger online at 20160519 04:43:19 in /builds/slave/test 04:43:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:43:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:43:19 INFO - {'append_to_log': False, 04:43:19 INFO - 'base_work_dir': '/builds/slave/test', 04:43:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:43:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:43:19 INFO - 'branch': 'Mozilla-Inbound', 04:43:19 INFO - 'buildbot_json_path': 'buildprops.json', 04:43:19 INFO - 'config_files': ('talos/linux_config.py',), 04:43:19 INFO - 'default_actions': ('clobber', 04:43:19 INFO - 'read-buildbot-config', 04:43:19 INFO - 'download-and-extract', 04:43:19 INFO - 'populate-webroot', 04:43:19 INFO - 'create-virtualenv', 04:43:19 INFO - 'install', 04:43:19 INFO - 'run-tests'), 04:43:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:43:19 INFO - 'download_minidump_stackwalk': True, 04:43:19 INFO - 'download_symbols': 'ondemand', 04:43:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:43:19 INFO - 'tooltool.py': '/tools/tooltool.py', 04:43:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:43:19 INFO - '/tools/misc-python/virtualenv.py')}, 04:43:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:43:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:43:19 INFO - 'installer_path': 'installer.exe', 04:43:19 INFO - 'log_level': 'info', 04:43:19 INFO - 'log_name': 'talos', 04:43:19 INFO - 'log_to_console': True, 04:43:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:43:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:43:19 INFO - 'opt_config_files': (), 04:43:19 INFO - 'pip_index': False, 04:43:19 INFO - 'sps_profile': False, 04:43:19 INFO - 'sps_profile_interval': 0, 04:43:19 INFO - 'suite': 'dromaeojs', 04:43:19 INFO - 'system_bits': '32', 04:43:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:43:19 INFO - 'title': 'talos-linux64-ix-025', 04:43:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:43:19 INFO - 'use_talos_json': True, 04:43:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:43:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:43:19 INFO - 'work_dir': 'build'} 04:43:19 INFO - ##### 04:43:19 INFO - ##### Running clobber step. 04:43:19 INFO - ##### 04:43:19 INFO - Running pre-action listener: _resource_record_pre_action 04:43:19 INFO - Running main action method: clobber 04:43:19 INFO - rmtree: /builds/slave/test/build 04:43:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:43:19 INFO - Running post-action listener: _resource_record_post_action 04:43:19 INFO - ##### 04:43:19 INFO - ##### Finished clobber step (success) 04:43:19 INFO - ##### 04:43:19 INFO - ##### 04:43:19 INFO - ##### Running read-buildbot-config step. 04:43:19 INFO - ##### 04:43:19 INFO - Running pre-action listener: _resource_record_pre_action 04:43:19 INFO - Running main action method: read_buildbot_config 04:43:19 INFO - Using buildbot properties: 04:43:19 INFO - { 04:43:19 INFO - "project": "", 04:43:19 INFO - "product": "firefox", 04:43:19 INFO - "script_repo_revision": "production", 04:43:19 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:43:19 INFO - "repository": "", 04:43:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:43:19 INFO - "buildid": "20160519020348", 04:43:19 INFO - "pgo_build": "True", 04:43:19 INFO - "basedir": "/builds/slave/test", 04:43:19 INFO - "buildnumber": 944, 04:43:19 INFO - "slavename": "talos-linux64-ix-025", 04:43:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:43:19 INFO - "platform": "ubuntu64_hw", 04:43:19 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:43:19 INFO - "branch": "mozilla-inbound", 04:43:19 INFO - "repo_path": "integration/mozilla-inbound", 04:43:19 INFO - "revision": "7ab87e09f57b", 04:43:19 INFO - "stage_platform": "linux64-pgo", 04:43:19 INFO - "builduid": "6b4d8fa7f6724ada8193ea6f1c5e6910", 04:43:19 INFO - "slavebuilddir": "test" 04:43:19 INFO - } 04:43:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:43:19 INFO - Running post-action listener: _resource_record_post_action 04:43:19 INFO - ##### 04:43:19 INFO - ##### Finished read-buildbot-config step (success) 04:43:19 INFO - ##### 04:43:19 INFO - ##### 04:43:19 INFO - ##### Running download-and-extract step. 04:43:19 INFO - ##### 04:43:19 INFO - Running pre-action listener: _resource_record_pre_action 04:43:19 INFO - Running main action method: download_and_extract 04:43:19 INFO - mkdir: /builds/slave/test/build/tests 04:43: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')]} 04:43:19 INFO - https://queue.taskcluster.net/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:43:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:43:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:43:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/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 04:43:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/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 04:43:20 INFO - Downloaded 1361 bytes. 04:43:20 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:43:20 INFO - Using the following test package requirements: 04:43:20 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:43:20 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:43:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:43:20 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:43:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:43:20 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:43:20 INFO - u'jsshell-linux-x86_64.zip'], 04:43:20 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:43:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:43:20 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:43:20 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:43:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:43:20 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:43:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:43:20 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:43:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:43:20 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:43:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:43:20 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:20 INFO - https://queue.taskcluster.net/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:43:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:43:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:43:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/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 04:43:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/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 04:43:21 INFO - Downloaded 24386725 bytes. 04:43:21 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'] 04:43:21 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 04:43:23 INFO - Return code: 0 04:43:23 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 04:43:23 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')]} 04:43:23 INFO - https://queue.taskcluster.net/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:43:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:43:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:43:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/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 04:43:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/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 04:43:24 INFO - Downloaded 24386725 bytes. 04:43:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:43:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:43:25 INFO - Return code: 0 04:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:25 INFO - https://queue.taskcluster.net/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:43:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:43:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:43:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/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 04:43:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/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 04:43:26 INFO - Downloaded 10840359 bytes. 04:43:26 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'] 04:43:26 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 04:43:26 INFO - Return code: 0 04:43:26 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')]} 04:43:26 INFO - https://queue.taskcluster.net/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:43:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:43:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:43:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/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 04:43:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUp0INAZSpObh6UU-VvKrA/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 04:43:28 INFO - Downloaded 58572131 bytes. 04:43:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:43:28 INFO - mkdir: /builds/slave/test/properties 04:43:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:43:28 INFO - Writing to file /builds/slave/test/properties/build_url 04:43:28 INFO - Contents: 04:43:28 INFO - build_url:https://queue.taskcluster.net/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:43:29 INFO - Running post-action listener: _resource_record_post_action 04:43:29 INFO - Running post-action listener: set_extra_try_arguments 04:43:29 INFO - ##### 04:43:29 INFO - ##### Finished download-and-extract step (success) 04:43:29 INFO - ##### 04:43:29 INFO - ##### 04:43:29 INFO - ##### Running populate-webroot step. 04:43:29 INFO - ##### 04:43:29 INFO - Running pre-action listener: _resource_record_pre_action 04:43:29 INFO - Running main action method: populate_webroot 04:43:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:43:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:43:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:43:29 INFO - '--tppagecycles', 04:43:29 INFO - '7'], 04:43:29 INFO - 'tests': ['tsvgm']}}, 04:43:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:43:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:43:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:43:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:43:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:43:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:43:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:43:29 INFO - 'talos_options': ['--disable-e10s'], 04:43:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:43:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:43:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:43:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:43:29 INFO - 'talos_options': ['--disable-e10s'], 04:43:29 INFO - 'tests': ['damp', 'tps']}, 04:43:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:43:29 INFO - 'tests': ['damp', 'tps']}, 04:43:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:43:29 INFO - 'tests': ['dromaeo_dom']}, 04:43:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:43:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:43:29 INFO - 'tests': ['a11yr', 04:43:29 INFO - 'ts_paint', 04:43:29 INFO - 'tpaint', 04:43:29 INFO - 'sessionrestore', 04:43:29 INFO - 'sessionrestore_no_auto_restore', 04:43:29 INFO - 'tabpaint']}, 04:43:29 INFO - 'other-e10s': {'tests': ['a11yr', 04:43:29 INFO - 'ts_paint', 04:43:29 INFO - 'tpaint', 04:43:29 INFO - 'sessionrestore', 04:43:29 INFO - 'sessionrestore_no_auto_restore', 04:43:29 INFO - 'tabpaint']}, 04:43:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:43:29 INFO - 'ts_paint', 04:43:29 INFO - 'tpaint', 04:43:29 INFO - 'sessionrestore', 04:43:29 INFO - 'sessionrestore_no_auto_restore', 04:43:29 INFO - 'tabpaint']}, 04:43:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:43:29 INFO - 'ts_paint', 04:43:29 INFO - 'tpaint', 04:43:29 INFO - 'sessionrestore', 04:43:29 INFO - 'sessionrestore_no_auto_restore', 04:43:29 INFO - 'tabpaint']}, 04:43:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:43:29 INFO - 'tests': ['a11yr', 04:43:29 INFO - 'ts_paint', 04:43:29 INFO - 'tpaint', 04:43:29 INFO - 'sessionrestore', 04:43:29 INFO - 'sessionrestore_no_auto_restore', 04:43:29 INFO - 'tabpaint']}, 04:43:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:43:29 INFO - 'tests': ['a11yr', 04:43:29 INFO - 'ts_paint', 04:43:29 INFO - 'tpaint', 04:43:29 INFO - 'sessionrestore', 04:43:29 INFO - 'sessionrestore_no_auto_restore', 04:43:29 INFO - 'tabpaint']}, 04:43:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:43:29 INFO - 'tests': ['tsvgx', 04:43:29 INFO - 'tsvgr_opacity', 04:43:29 INFO - 'tart', 04:43:29 INFO - 'tscrollx', 04:43:29 INFO - 'cart']}, 04:43:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:43:29 INFO - 'tsvgr_opacity', 04:43:29 INFO - 'tart', 04:43:29 INFO - 'tscrollx', 04:43:29 INFO - 'cart']}, 04:43:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:43:29 INFO - 'talos_options': ['--disable-e10s'], 04:43:29 INFO - 'tests': ['tp5o']}, 04:43:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:43:29 INFO - 'tests': ['tp5o']}, 04:43:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:43:29 INFO - 'talos_options': ['--disable-e10s', 04:43:29 INFO - '--xperf_path', 04:43:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:43:29 INFO - 'tests': ['tp5n']}, 04:43:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:43:29 INFO - 'talos_options': ['--xperf_path', 04:43:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:43:29 INFO - 'tests': ['tp5n']}}, 04:43:29 INFO - 'talos.zip': {'path': '', 04:43:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:43:29 INFO - Running post-action listener: _resource_record_post_action 04:43:29 INFO - ##### 04:43:29 INFO - ##### Finished populate-webroot step (success) 04:43:29 INFO - ##### 04:43:29 INFO - ##### 04:43:29 INFO - ##### Running create-virtualenv step. 04:43:29 INFO - ##### 04:43:29 INFO - Running pre-action listener: _resource_record_pre_action 04:43:29 INFO - Running main action method: create_virtualenv 04:43:29 INFO - Creating virtualenv /builds/slave/test/build/venv 04:43:29 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 04:43:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:43:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:43:29 INFO - Using real prefix '/usr' 04:43:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:43:29 INFO - Installing distribute.............................................................................................................................................................................................done. 04:43:31 INFO - Installing pip.................done. 04:43:31 INFO - Return code: 0 04:43:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:43:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:31 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 0x7fae7e0b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c419c0>, '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 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463658084.333527-615993172', '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 04:43:31 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 04:43:31 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 04:43:31 INFO - Using env: {'DISPLAY': ':0', 04:43:31 INFO - 'HOME': '/home/cltbld', 04:43:31 INFO - 'LANG': 'en_US.UTF-8', 04:43:31 INFO - 'LANGUAGE': 'en_US:en', 04:43:31 INFO - 'LOGNAME': 'cltbld', 04:43:31 INFO - 'MAIL': '/var/mail/cltbld', 04:43:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:31 INFO - 'MOZ_NO_REMOTE': '1', 04:43:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:43:31 INFO - 'NO_EM_RESTART': '1', 04:43:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:43:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:31 INFO - 'PWD': '/builds/slave/test', 04:43:31 INFO - 'SHELL': '/bin/bash', 04:43:31 INFO - 'SHLVL': '1', 04:43:31 INFO - 'TERM': 'linux', 04:43:31 INFO - 'TMOUT': '86400', 04:43:31 INFO - 'USER': 'cltbld', 04:43:31 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463658084.333527-615993172', 04:43:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:31 INFO - '_': '/tools/buildbot/bin/python'} 04:43:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:31 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 04:43:31 INFO - Cleaning up... 04:43:31 INFO - Return code: 0 04:43:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:43:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:31 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 0x7fae7e0b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c419c0>, '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 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463658084.333527-615993172', '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 04:43:31 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 04:43:31 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 04:43:31 INFO - Using env: {'DISPLAY': ':0', 04:43:31 INFO - 'HOME': '/home/cltbld', 04:43:31 INFO - 'LANG': 'en_US.UTF-8', 04:43:31 INFO - 'LANGUAGE': 'en_US:en', 04:43:31 INFO - 'LOGNAME': 'cltbld', 04:43:31 INFO - 'MAIL': '/var/mail/cltbld', 04:43:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:31 INFO - 'MOZ_NO_REMOTE': '1', 04:43:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:43:31 INFO - 'NO_EM_RESTART': '1', 04:43:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:43:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:31 INFO - 'PWD': '/builds/slave/test', 04:43:31 INFO - 'SHELL': '/bin/bash', 04:43:31 INFO - 'SHLVL': '1', 04:43:31 INFO - 'TERM': 'linux', 04:43:31 INFO - 'TMOUT': '86400', 04:43:31 INFO - 'USER': 'cltbld', 04:43:31 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463658084.333527-615993172', 04:43:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:31 INFO - '_': '/tools/buildbot/bin/python'} 04:43:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:32 INFO - Downloading/unpacking psutil>=3.1.1 04:43: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 04:43: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 04:43: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 04:43: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 04:43: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 04:43: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 04:43:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:43:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:43:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:43:34 INFO - Installing collected packages: psutil 04:43:34 INFO - Running setup.py install for psutil 04:43:34 INFO - building 'psutil._psutil_linux' extension 04:43:34 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 04:43:34 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 04:43:34 INFO - building 'psutil._psutil_posix' extension 04:43:34 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 04:43:34 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 04:43:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:43:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:43:34 INFO - Successfully installed psutil 04:43:34 INFO - Cleaning up... 04:43:34 INFO - Return code: 0 04:43:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:43:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae7e0b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c419c0>, '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 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463658084.333527-615993172', '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 04:43:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:43:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:43:34 INFO - Using env: {'DISPLAY': ':0', 04:43:34 INFO - 'HOME': '/home/cltbld', 04:43:34 INFO - 'LANG': 'en_US.UTF-8', 04:43:34 INFO - 'LANGUAGE': 'en_US:en', 04:43:34 INFO - 'LOGNAME': 'cltbld', 04:43:34 INFO - 'MAIL': '/var/mail/cltbld', 04:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:34 INFO - 'MOZ_NO_REMOTE': '1', 04:43:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:43:34 INFO - 'NO_EM_RESTART': '1', 04:43:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:34 INFO - 'PWD': '/builds/slave/test', 04:43:34 INFO - 'SHELL': '/bin/bash', 04:43:34 INFO - 'SHLVL': '1', 04:43:34 INFO - 'TERM': 'linux', 04:43:34 INFO - 'TMOUT': '86400', 04:43:34 INFO - 'USER': 'cltbld', 04:43:34 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463658084.333527-615993172', 04:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:34 INFO - '_': '/tools/buildbot/bin/python'} 04:43:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:43:34 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 04:43:34 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 04:43:34 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 04:43:34 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 04:43:34 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 04:43:34 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 04:43:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:43:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:43:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:43:36 INFO - Installing collected packages: mozsystemmonitor 04:43:36 INFO - Running setup.py install for mozsystemmonitor 04:43:36 INFO - Successfully installed mozsystemmonitor 04:43:36 INFO - Cleaning up... 04:43:36 INFO - Return code: 0 04:43:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:43: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')]} 04:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43: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')]} 04:43:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:36 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 0x7fae7e0b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c419c0>, '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 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463658084.333527-615993172', '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 04:43:36 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 04:43:36 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 04:43:36 INFO - Using env: {'DISPLAY': ':0', 04:43:36 INFO - 'HOME': '/home/cltbld', 04:43:36 INFO - 'LANG': 'en_US.UTF-8', 04:43:36 INFO - 'LANGUAGE': 'en_US:en', 04:43:36 INFO - 'LOGNAME': 'cltbld', 04:43:36 INFO - 'MAIL': '/var/mail/cltbld', 04:43:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:36 INFO - 'MOZ_NO_REMOTE': '1', 04:43:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:43:36 INFO - 'NO_EM_RESTART': '1', 04:43:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:43:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:36 INFO - 'PWD': '/builds/slave/test', 04:43:36 INFO - 'SHELL': '/bin/bash', 04:43:36 INFO - 'SHLVL': '1', 04:43:36 INFO - 'TERM': 'linux', 04:43:36 INFO - 'TMOUT': '86400', 04:43:36 INFO - 'USER': 'cltbld', 04:43:36 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463658084.333527-615993172', 04:43:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:36 INFO - '_': '/tools/buildbot/bin/python'} 04:43:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:37 INFO - Downloading/unpacking blobuploader==1.2.4 04:43: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 04:43: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 04:43: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 04:43: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 04:43: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 04:43: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 04:43:38 INFO - Downloading blobuploader-1.2.4.tar.gz 04:43:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:43:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:43:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:39 INFO - Downloading docopt-0.6.1.tar.gz 04:43:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:43:39 INFO - Installing collected packages: blobuploader, requests, docopt 04:43:39 INFO - Running setup.py install for blobuploader 04:43:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:43:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:43:39 INFO - Running setup.py install for requests 04:43:40 INFO - Running setup.py install for docopt 04:43:40 INFO - Successfully installed blobuploader requests docopt 04:43:40 INFO - Cleaning up... 04:43:40 INFO - Return code: 0 04:43:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43: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')]} 04:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43: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')]} 04:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:40 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 0x7fae7e0b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c419c0>, '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 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463658084.333527-615993172', '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 04:43:40 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 04:43:40 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 04:43:40 INFO - Using env: {'DISPLAY': ':0', 04:43:40 INFO - 'HOME': '/home/cltbld', 04:43:40 INFO - 'LANG': 'en_US.UTF-8', 04:43:40 INFO - 'LANGUAGE': 'en_US:en', 04:43:40 INFO - 'LOGNAME': 'cltbld', 04:43:40 INFO - 'MAIL': '/var/mail/cltbld', 04:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:40 INFO - 'MOZ_NO_REMOTE': '1', 04:43:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:43:40 INFO - 'NO_EM_RESTART': '1', 04:43:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:40 INFO - 'PWD': '/builds/slave/test', 04:43:40 INFO - 'SHELL': '/bin/bash', 04:43:40 INFO - 'SHLVL': '1', 04:43:40 INFO - 'TERM': 'linux', 04:43:40 INFO - 'TMOUT': '86400', 04:43:40 INFO - 'USER': 'cltbld', 04:43:40 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463658084.333527-615993172', 04:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:40 INFO - '_': '/tools/buildbot/bin/python'} 04:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:43:40 INFO - Running setup.py (path:/tmp/pip-wXeZ9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:43:40 INFO - Running setup.py (path:/tmp/pip-jiiH_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:43:40 INFO - Running setup.py (path:/tmp/pip-Vw2XFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:43:40 INFO - Running setup.py (path:/tmp/pip-ZVQ5al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:43:40 INFO - Running setup.py (path:/tmp/pip-tazpKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:43:40 INFO - Running setup.py (path:/tmp/pip-i5yrEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:43:41 INFO - Running setup.py (path:/tmp/pip-0Ihp50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:43:41 INFO - Running setup.py (path:/tmp/pip-b5E4Sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:43:41 INFO - Running setup.py (path:/tmp/pip-FCdnfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:43:41 INFO - Running setup.py (path:/tmp/pip-83WUBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:43:41 INFO - Running setup.py (path:/tmp/pip-VcU0fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:43:41 INFO - Running setup.py (path:/tmp/pip-DH_GQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:43:41 INFO - Running setup.py (path:/tmp/pip-aVWmvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:43:41 INFO - Running setup.py (path:/tmp/pip-WXD5eD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:41 INFO - Running setup.py (path:/tmp/pip-1Uaca6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:43:41 INFO - Running setup.py (path:/tmp/pip-h_IQAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:43:41 INFO - Running setup.py (path:/tmp/pip-soboCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:43:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:43:41 INFO - Running setup.py install for manifestparser 04:43:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:43:41 INFO - Running setup.py install for mozcrash 04:43:42 INFO - Running setup.py install for mozdebug 04:43:42 INFO - Running setup.py install for mozdevice 04:43:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:43:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:43:42 INFO - Running setup.py install for mozfile 04:43:42 INFO - Running setup.py install for mozhttpd 04:43:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:43:42 INFO - Running setup.py install for mozinfo 04:43:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:43:42 INFO - Running setup.py install for mozInstall 04:43:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:43:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:43:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:43:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:43:42 INFO - Running setup.py install for mozleak 04:43:42 INFO - Running setup.py install for mozlog 04:43:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:43:42 INFO - Running setup.py install for moznetwork 04:43:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:43:42 INFO - Running setup.py install for mozprocess 04:43:43 INFO - Running setup.py install for mozprofile 04:43:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:43:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:43:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:43:43 INFO - Running setup.py install for mozrunner 04:43:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:43:43 INFO - Running setup.py install for mozscreenshot 04:43:43 INFO - Running setup.py install for moztest 04:43:43 INFO - Running setup.py install for mozversion 04:43:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:43:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:43:43 INFO - Cleaning up... 04:43:43 INFO - Return code: 0 04:43:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:43 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 0x7fae7e0b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c419c0>, '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 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463658084.333527-615993172', '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 04:43:43 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 04:43:43 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 04:43:43 INFO - Using env: {'DISPLAY': ':0', 04:43:43 INFO - 'HOME': '/home/cltbld', 04:43:43 INFO - 'LANG': 'en_US.UTF-8', 04:43:43 INFO - 'LANGUAGE': 'en_US:en', 04:43:43 INFO - 'LOGNAME': 'cltbld', 04:43:43 INFO - 'MAIL': '/var/mail/cltbld', 04:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:43 INFO - 'MOZ_NO_REMOTE': '1', 04:43:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:43:43 INFO - 'NO_EM_RESTART': '1', 04:43:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:43 INFO - 'PWD': '/builds/slave/test', 04:43:43 INFO - 'SHELL': '/bin/bash', 04:43:43 INFO - 'SHLVL': '1', 04:43:43 INFO - 'TERM': 'linux', 04:43:43 INFO - 'TMOUT': '86400', 04:43:43 INFO - 'USER': 'cltbld', 04:43:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463658084.333527-615993172', 04:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:43 INFO - '_': '/tools/buildbot/bin/python'} 04:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:43:43 INFO - Running setup.py (path:/tmp/pip-7hi6Ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:43:43 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)) 04:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:43:43 INFO - Running setup.py (path:/tmp/pip-APaSkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:43:43 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)) 04:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:43:43 INFO - Running setup.py (path:/tmp/pip-P8appT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:43:44 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)) 04:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:43:44 INFO - Running setup.py (path:/tmp/pip-NsmFPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:43:44 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)) 04:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:43:44 INFO - Running setup.py (path:/tmp/pip-o_idUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:43:44 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)) 04:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:43:44 INFO - Running setup.py (path:/tmp/pip-vMptB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:43:44 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)) 04:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:43:44 INFO - Running setup.py (path:/tmp/pip-y7PA__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:43:44 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)) 04:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:43:44 INFO - Running setup.py (path:/tmp/pip-YcA4wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:43:44 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)) 04:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:43:44 INFO - Running setup.py (path:/tmp/pip-_rRvTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:43:44 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)) 04:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:43:44 INFO - Running setup.py (path:/tmp/pip-EUamOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:43:44 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)) 04:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:43:44 INFO - Running setup.py (path:/tmp/pip-zcdy0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:43:44 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)) 04:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:43:44 INFO - Running setup.py (path:/tmp/pip-8NF03v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:43:44 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)) 04:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:43:44 INFO - Running setup.py (path:/tmp/pip-amLwaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:43:44 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)) 04:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:43:44 INFO - Running setup.py (path:/tmp/pip-WLjiRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:43:44 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)) 04:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:44 INFO - Running setup.py (path:/tmp/pip-8z4ZSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:43:44 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)) 04:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:43:44 INFO - Running setup.py (path:/tmp/pip-Pdq4HB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:43:44 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)) 04:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:43:44 INFO - Running setup.py (path:/tmp/pip-D7ohTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:43:45 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)) 04:43:45 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)) 04:43:45 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)) 04:43:45 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)) 04:43:45 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)) 04:43:45 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)) 04:43:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:43: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 04:43: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 04:43: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 04:43: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 04:43: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 04:43: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 04:43:46 INFO - Downloading blessings-1.6.tar.gz 04:43:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:43:47 INFO - Installing collected packages: blessings 04:43:47 INFO - Running setup.py install for blessings 04:43:47 INFO - Successfully installed blessings 04:43:47 INFO - Cleaning up... 04:43:47 INFO - Return code: 0 04:43:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:43:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:43:47 INFO - Reading from file tmpfile_stdout 04:43:47 INFO - Current package versions: 04:43:47 INFO - argparse == 1.2.1 04:43:47 INFO - blessings == 1.6 04:43:47 INFO - blobuploader == 1.2.4 04:43:47 INFO - docopt == 0.6.1 04:43:47 INFO - manifestparser == 1.1 04:43:47 INFO - mozInstall == 1.12 04:43:47 INFO - mozcrash == 0.17 04:43:47 INFO - mozdebug == 0.1 04:43:47 INFO - mozdevice == 0.48 04:43:47 INFO - mozfile == 1.2 04:43:47 INFO - mozhttpd == 0.7 04:43:47 INFO - mozinfo == 0.9 04:43:47 INFO - mozleak == 0.1 04:43:47 INFO - mozlog == 3.2 04:43:47 INFO - moznetwork == 0.27 04:43:47 INFO - mozprocess == 0.22 04:43:47 INFO - mozprofile == 0.28 04:43:47 INFO - mozrunner == 6.11 04:43:47 INFO - mozscreenshot == 0.1 04:43:47 INFO - mozsystemmonitor == 0.3 04:43:47 INFO - moztest == 0.7 04:43:47 INFO - mozversion == 1.4 04:43:47 INFO - psutil == 3.1.1 04:43:47 INFO - requests == 1.2.3 04:43:47 INFO - wsgiref == 0.1.2 04:43:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:47 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 0x7fae7e0b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c419c0>, '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 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463658084.333527-615993172', '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 04:43:47 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 04:43:47 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 04:43:47 INFO - Using env: {'DISPLAY': ':0', 04:43:47 INFO - 'HOME': '/home/cltbld', 04:43:47 INFO - 'LANG': 'en_US.UTF-8', 04:43:47 INFO - 'LANGUAGE': 'en_US:en', 04:43:47 INFO - 'LOGNAME': 'cltbld', 04:43:47 INFO - 'MAIL': '/var/mail/cltbld', 04:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:47 INFO - 'MOZ_NO_REMOTE': '1', 04:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:43:47 INFO - 'NO_EM_RESTART': '1', 04:43:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:47 INFO - 'PWD': '/builds/slave/test', 04:43:47 INFO - 'SHELL': '/bin/bash', 04:43:47 INFO - 'SHLVL': '1', 04:43:47 INFO - 'TERM': 'linux', 04:43:47 INFO - 'TMOUT': '86400', 04:43:47 INFO - 'USER': 'cltbld', 04:43:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463658084.333527-615993172', 04:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:47 INFO - '_': '/tools/buildbot/bin/python'} 04:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:47 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)) 04:43:47 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)) 04:43:47 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)) 04:43:47 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)) 04:43:47 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)) 04:43:47 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)) 04:43:47 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)) 04:43:47 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)) 04:43:47 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)) 04:43:47 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)) 04:43:47 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)) 04:43:47 INFO - Cleaning up... 04:43:47 INFO - Return code: 0 04:43:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:47 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 0x7fae7e0b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c419c0>, '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 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463658084.333527-615993172', '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 04:43:47 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 04:43:47 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 04:43:47 INFO - Using env: {'DISPLAY': ':0', 04:43:47 INFO - 'HOME': '/home/cltbld', 04:43:47 INFO - 'LANG': 'en_US.UTF-8', 04:43:47 INFO - 'LANGUAGE': 'en_US:en', 04:43:47 INFO - 'LOGNAME': 'cltbld', 04:43:47 INFO - 'MAIL': '/var/mail/cltbld', 04:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:47 INFO - 'MOZ_NO_REMOTE': '1', 04:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:43:47 INFO - 'NO_EM_RESTART': '1', 04:43:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:47 INFO - 'PWD': '/builds/slave/test', 04:43:47 INFO - 'SHELL': '/bin/bash', 04:43:47 INFO - 'SHLVL': '1', 04:43:47 INFO - 'TERM': 'linux', 04:43:47 INFO - 'TMOUT': '86400', 04:43:47 INFO - 'USER': 'cltbld', 04:43:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463658084.333527-615993172', 04:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:47 INFO - '_': '/tools/buildbot/bin/python'} 04:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:47 INFO - Downloading/unpacking jsonschema 04:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:43:49 INFO - Downloading/unpacking functools32 (from jsonschema) 04:43:49 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 04:43:49 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 04:43:49 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 04:43:49 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 04:43:49 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 04:43:49 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 04:43:49 INFO - Downloading functools32-3.2.3-2.tar.gz 04:43:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:43:49 INFO - warning: no files found matching '*.txt' 04:43:49 INFO - no previously-included directories found matching 'build' 04:43:49 INFO - no previously-included directories found matching 'dist' 04:43:49 INFO - no previously-included directories found matching '.git*' 04:43:49 INFO - Installing collected packages: jsonschema, functools32 04:43:50 INFO - Running setup.py install for functools32 04:43:50 INFO - warning: no files found matching '*.txt' 04:43:50 INFO - no previously-included directories found matching 'build' 04:43:50 INFO - no previously-included directories found matching 'dist' 04:43:50 INFO - no previously-included directories found matching '.git*' 04:43:50 INFO - Successfully installed jsonschema functools32 04:43:50 INFO - Cleaning up... 04:43:50 INFO - Return code: 0 04:43:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:43:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:43:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:43:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:43:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae7e0b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb2770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c419c0>, '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 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463658084.333527-615993172', '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 04:43:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:43:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:43:50 INFO - Using env: {'DISPLAY': ':0', 04:43:50 INFO - 'HOME': '/home/cltbld', 04:43:50 INFO - 'LANG': 'en_US.UTF-8', 04:43:50 INFO - 'LANGUAGE': 'en_US:en', 04:43:50 INFO - 'LOGNAME': 'cltbld', 04:43:50 INFO - 'MAIL': '/var/mail/cltbld', 04:43:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:50 INFO - 'MOZ_NO_REMOTE': '1', 04:43:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:43:50 INFO - 'NO_EM_RESTART': '1', 04:43:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:43:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:50 INFO - 'PWD': '/builds/slave/test', 04:43:50 INFO - 'SHELL': '/bin/bash', 04:43:50 INFO - 'SHLVL': '1', 04:43:50 INFO - 'TERM': 'linux', 04:43:50 INFO - 'TMOUT': '86400', 04:43:50 INFO - 'USER': 'cltbld', 04:43:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463658084.333527-615993172', 04:43:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:50 INFO - '_': '/tools/buildbot/bin/python'} 04:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:43:50 INFO - Downloading/unpacking flake8 04:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:43:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:43:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:43:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:43:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:43:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:43:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:43:53 INFO - no previously-included directories found matching 'docs/_build' 04:43:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:43:53 INFO - Running setup.py install for pep8 04:43:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:43:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:43:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:43:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:43:53 INFO - no previously-included directories found matching 'docs/_build' 04:43:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:43:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:43:53 INFO - Cleaning up... 04:43:53 INFO - Return code: 0 04:43:53 INFO - Running post-action listener: _resource_record_post_action 04:43:53 INFO - Running post-action listener: _start_resource_monitoring 04:43:53 INFO - Starting resource monitoring. 04:43:53 INFO - ##### 04:43:53 INFO - ##### Finished create-virtualenv step (success) 04:43:53 INFO - ##### 04:43:53 INFO - ##### 04:43:53 INFO - ##### Running install step. 04:43:53 INFO - ##### 04:43:53 INFO - Running pre-action listener: _resource_record_pre_action 04:43:53 INFO - Running main action method: install 04:43:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:43:53 INFO - Reading from file tmpfile_stdout 04:43:53 INFO - Detecting whether we're running mozinstall >=1.0... 04:43:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:43:53 INFO - Reading from file tmpfile_stdout 04:43:53 INFO - Output received: 04:43:53 INFO - Usage: mozinstall [options] installer 04:43:53 INFO - Options: 04:43:53 INFO - -h, --help show this help message and exit 04:43:53 INFO - -d DEST, --destination=DEST 04:43:53 INFO - Directory to install application into. [default: 04:43:53 INFO - "/builds/slave/test"] 04:43:53 INFO - --app=APP Application being installed. [default: firefox] 04:43:53 INFO - mkdir: /builds/slave/test/build/application 04:43:53 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'] 04:43:53 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 04:44:10 INFO - Reading from file tmpfile_stdout 04:44:10 INFO - Output received: 04:44:10 INFO - /builds/slave/test/build/application/firefox/firefox 04:44:10 INFO - Running post-action listener: _resource_record_post_action 04:44:10 INFO - ##### 04:44:10 INFO - ##### Finished install step (success) 04:44:10 INFO - ##### 04:44:10 INFO - ##### 04:44:10 INFO - ##### Running run-tests step. 04:44:10 INFO - ##### 04:44:10 INFO - Running pre-action listener: _resource_record_pre_action 04:44:10 INFO - Running main action method: run_tests 04:44:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:44:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:44:10 INFO - Python 2.7.3 04:44:10 INFO - Return code: 0 04:44:10 INFO - grabbing minidump binary from tooltool 04:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:44:10 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 0x2c419c0>, '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 0x2c428c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:44:10 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 04:44:10 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 04:44:10 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 04:44:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:44:10 INFO - Return code: 0 04:44:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:44:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:44:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:44:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:44:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:44:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:44:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:44:11 INFO - Return code: 0 04:44:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:44:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:44:11 INFO - Using env: {'DISPLAY': ':0', 04:44:11 INFO - 'HOME': '/home/cltbld', 04:44:11 INFO - 'LANG': 'en_US.UTF-8', 04:44:11 INFO - 'LANGUAGE': 'en_US:en', 04:44:11 INFO - 'LOGNAME': 'cltbld', 04:44:11 INFO - 'MAIL': '/var/mail/cltbld', 04:44:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:44:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:44:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:11 INFO - 'MOZ_NO_REMOTE': '1', 04:44:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:44:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:44:11 INFO - 'NO_EM_RESTART': '1', 04:44:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:44:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:11 INFO - 'PWD': '/builds/slave/test', 04:44:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:44:11 INFO - 'SHELL': '/bin/bash', 04:44:11 INFO - 'SHLVL': '1', 04:44:11 INFO - 'TERM': 'linux', 04:44:11 INFO - 'TMOUT': '86400', 04:44:11 INFO - 'USER': 'cltbld', 04:44:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1463658084.333527-615993172', 04:44:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:11 INFO - '_': '/tools/buildbot/bin/python'} 04:44:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:44:11 INFO - mozversion application_buildid: 20160519020348 04:44:11 INFO - mozversion application_changeset: 7ab87e09f57b97da66c986b70f539b0289aba3cf 04:44:11 INFO - mozversion application_display_name: Nightly 04:44:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:44:11 INFO - mozversion application_name: Firefox 04:44:11 INFO - mozversion application_remotingname: firefox 04:44:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:44:11 INFO - mozversion application_vendor: Mozilla 04:44:11 INFO - mozversion application_version: 49.0a1 04:44:11 INFO - mozversion platform_buildid: 20160519020348 04:44:11 INFO - mozversion platform_changeset: 7ab87e09f57b97da66c986b70f539b0289aba3cf 04:44:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:44:11 INFO - mozversion platform_version: 49.0a1 04:44:11 INFO - using testdate: 1463658251 04:44:11 INFO - actual date: 1463658251 04:44:11 INFO - starting webserver on 'localhost:33758' 04:44:11 INFO - SUITE-START | Running 2 tests 04:44:11 INFO - TEST-START | dromaeo_css 04:44:11 INFO - operating with platform_type : linux_ 04:44:11 INFO - Initialising browser for dromaeo_css test... 04:44:11 INFO - TEST-INFO | started process 3164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxIUPFZ/profile http://localhost:33758/getInfo.html) 04:44:15 INFO - PROCESS | 3164 | __metrics Screen width/height:1600/1200 04:44:15 INFO - PROCESS | 3164 | colorDepth:24 04:44:15 INFO - PROCESS | 3164 | Browser inner width/height: 1024/697 04:44:15 INFO - PROCESS | 3164 | __metrics 04:44:16 ERROR - PROCESS | 3164 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:44:17 INFO - TEST-INFO | 3164: exit 0 04:44:17 INFO - Browser initialized. 04:44:17 INFO - Running cycle 1/1 for dromaeo_css test... 04:44:17 INFO - TEST-INFO | started process 3246 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxIUPFZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:44:29 INFO - PROCESS | 3246 | RSS: Main: 153034752 04:44:29 INFO - PROCESS | 3246 | 04:45:20 INFO - PROCESS | 3246 | 1463658320160 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] 04:47:28 INFO - PROCESS | 3246 | Cycle 1(1): loaded http://localhost:33758/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33758/tests/dromaeo/cssquery-ext.html) 04:47:29 INFO - PROCESS | 3246 | RSS: Main: 259190784 04:47:29 INFO - PROCESS | 3246 | 04:50:31 INFO - PROCESS | 3246 | Cycle 1(1): loaded http://localhost:33758/tests/dromaeo/cssquery-ext.html (next: http://localhost:33758/tests/dromaeo/cssquery-jquery.html) 04:50:32 INFO - PROCESS | 3246 | RSS: Main: 237654016 04:50:32 INFO - PROCESS | 3246 | 04:53:33 INFO - PROCESS | 3246 | Cycle 1(1): loaded http://localhost:33758/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33758/tests/dromaeo/cssquery-mootools.html) 04:53:34 INFO - PROCESS | 3246 | RSS: Main: 237477888 04:53:34 INFO - PROCESS | 3246 | 04:56:36 INFO - PROCESS | 3246 | Cycle 1(1): loaded http://localhost:33758/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33758/tests/dromaeo/cssquery-prototype.html) 04:56:37 INFO - PROCESS | 3246 | RSS: Main: 237539328 04:56:37 INFO - PROCESS | 3246 | 04:59:39 INFO - PROCESS | 3246 | Cycle 1(1): loaded http://localhost:33758/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33758/tests/dromaeo/cssquery-yui.html) 04:59:40 INFO - PROCESS | 3246 | RSS: Main: 223477760 04:59:40 INFO - PROCESS | 3246 | 05:02:42 INFO - PROCESS | 3246 | Cycle 1(1): loaded http://localhost:33758/tests/dromaeo/cssquery-yui.html (next: http://localhost:33758/tests/dromaeo/cssquery-dojo.html) 05:02:42 INFO - PROCESS | 3246 | RSS: Main: 271798272 05:02:42 INFO - PROCESS | 3246 | 05:02:42 INFO - PROCESS | 3246 | __start_tp_report 05:02:42 INFO - PROCESS | 3246 | _x_x_mozilla_page_load 05:02:42 INFO - PROCESS | 3246 | _x_x_mozilla_page_load_details 05:02:42 INFO - PROCESS | 3246 | |i|pagename|runs| 05:02:42 INFO - PROCESS | 3246 | |0;dojo.html;3206.35872825435;3207.534907438423;3216.6783321667835;3252.8536215870286;3261.135799013262;5159.845204643857;5187.714675692835;5430.72846357682;5552.389237183912;5570.8607284817845;5459.727013649322;5471.671699698021;5503.3395992480955;5535.225068490405;5549.1676248562635;4928.901421971558;4961;5097.643164978453;5146.639735218536;5188.0920838853235;5077.695338279696;5093.541581257686;5099.133147364938;5149.613778966574;5153.665011774241;4780.737059461728;4949.084419382426;4972.229304457815;5010.223415370605;5025.748712564357;5013.874653133665;5041.899162016776;5042.899142017176;5060.190369540893;5085.516875896821;4762.595179409755;5002.574781143607;5021.096202683516;5030.270610761419;5037.848864534069;5483.561315094823;5525.143602741581;5571.359293681238;5583.218349431083;5586.944130558683;5896.115582662592;5951.047832346847;5955.791547295824;5957.136215248808;5960.523158147338;5696.77212911483;5880.470757631833;5906.616069955439;5950;6017.157597936292;5618.7190640468225;5622.269105016404;5624.803131890364;5638.069718496443;5645.717714114319;6092.1775560299675;6094.924532418307;6100.816975490742;6102.996776376;6114.388561143939;5570.554355651539;5769.85575360611;5784.971075144597;5817.912731308949;5873.412658734178;5942.524598032147;5950.107483877453;5955.196048533479;6007.399260074045;6023.728932198062;5870.236869206976;5891.941080589139;5937.050071988548;5942.821715348547;5959.642421454727;5592.664440133605;5698.4871361576825;5720.771169153188;5744.913826292609;5753.971230143822;4319.935200971988;4329.523752387235;4329.761863097497;4346.630536404441;4370.366296886998;3823.866164684223;3868.0909986153233;3874.8256328465286;3938.5273767148124;3941.8226179821977;5400.513953744182;5486.588505862076;5518.19986102021;5534.52956498694;5550.916736248879;5841.094630332305;5865.589408741347;5871.442212989759;5887.058070708752;5889.911651325234;5378.2470454136455;5540.750666220029;5549.195366671891;5551.3893471718075;5553.055980483327;4939.407271127416;4959.057779022047;4978.551930326288;4987.875303117378;4995.575376093;6166.1983942087245;6166.352532984062;6167.136600875881;6173.259208894871;6178.69106544671;5616;5859.179714839841;5967.731452084667;5975.611585246945;5979.312379076462;6080.300765412034;6131.651934473353;6143.235544005126;6143.450468055707;6145.8156255312415;5800.332961709458;5811.476967072984;5851.882962340815;5859.5019423349495;5887.322957859901;5540.750666219949;5882.117682347682;5924;5939.376365481735;5951.940480595139;5800.970995144998;5811.680357580373;5815.244018277597;5836.824895253149;5874.823755287348;5800.56495762811;5811.186433899173;5819.883602327845;5821.301443826768;5826.0387036140255;5402.783888644411;5625.156226566048;5642.153676948491;5692.231548740867;5702.800401985911;5846.269216347957;5851.531877449709;5911.822645320647;5914.822555323347;5923.644581325134;5702.315722113373;5751.424857514216;5751.424857514383;5756.597038207286;5787.768489260382 05:02:42 INFO - PROCESS | 3246 | |1;ext.html;598.3298705449897;642.8649983503464;649.5875119299244;656.1896058367914;666.3569655282652;31841.203969900766;44362.556374436244;44970.55029449704;45086.323705144365;45128.999999999956;46463.30305045427;47180;47290.76354618231;47446.762766186206;47453.52546474534;8700.173483519087;8933.330000250007;8943.105689431037;8950.597223124942;8955.059718729537;8744.34417418693;8879.245264152523;8910.064443233465;8912.777180570472;8915.95542022289;8887.333449991243;8932.10678932105;8944.373893827435;8953.955230223872;8955.238804701608;8748.781280467976;8791.340649451316;8802.73591792244;8881.378303518757;8886;8746;8864.955675221583;8868.15752503511;8879.556022198929;8883.42257753244;42509.57490425087;42975.57024429747;42998.78500607508;43082.35376469355;43093.784531077144;3543.344481270947;3609.458581212813;3616.439451884936;3658.213484100931;3683.355412802749;32870.835645821615;33082.17294567631;33535.16162095943;33626.49560256598;33788.83105584457;4116.320807066831;4204.978975105105;4222.5566315536735;4259.254630439661;4300.442413873932;245061;249193;250333;251111;251328;54021.45978540243;59092.40907590955;59525.70237148787;59562.404375956554;59613.403865961656;60522.69738651279;61619;61742.38257617456;66617.33382666208;66665.33334666688;17405.738913916302;17507.912460437616;17573.297068117387;17573.648527029643;17589.824101759074;11638.76722465546;13346.666333341549;13815.102018368774;13917.930410347883;13944.790828137586;16545.420910268083;17127.65744685124;17177.79755417134;17193.57016074608;17199.398021069203;6590.604563726191;6681.966590167018;6859.176898772179;6864.450843932474;6895;981.916537094355;1042.1089968077185;1097.373329573171;1101.3171833463305;1208.5407545132794;32579.62436198048;33161.83419082889;33197.50203746946;33439.66560334414;33468.3521543909;1134.3477500437116;1141.7944769941491;1153.9153195995736;1168.4274705394296;1217.598192596441;17219.56951076208;17286.654266914593;17468.5632859177;17487.825121748872;17516.91241543784;511019;514615;515041;515829;519858;59608;60438.39561604328;60511;60587;60635.69682151561;1285.4858056777177;1319.0634649398842;1344.6638340414897;1406.374163497234;1424.1241636393543;31487.37025259528;33686.326273473904;33697.66302336945;33912.491312629834;33989.32021359608;49447;49563;50044.49955500398;50152.749236253585;50235.24647130369;400747;405114;405401;406798;406896;35863.46204806878;40544.75641948578;41632;41638.37542436805;44077.77961110174;48634.513654862996;49140.262896057306;49349.506504935925;49423.25865111954;50465;40396.19207615773;41087.38368924528;41350.79324603358;41705.95735106646;42395.7880210597;41400.58599414088;42114.36828447637;42203.788981056125;42462.78768606137;42660;40961.385579216934;41392.172156556095;41597.79201103975;42150.57849421589;42831.35752963646;36217.27565448729;36952.445713313784;37145;37157.46492810673;37616.80257178061;28199.99202742559;28219.97465271754;28345.149645510668;28644.856775715987;28790.280242994093 05:02:42 INFO - PROCESS | 3246 | |2;jquery.html;398.5496389080339;401.90756126091;403.6851256020303;409.41044895350694;428.3788506665334;13562;18179;19744.70382944255;19752.90123549382;19790;15572.61068473286;18033.458996230132;18336.541586460346;18568.814311856877;18742.437726868182;5613.522850557697;5762.942370576283;5785.913211301813;5791.739371728282;5804.767809287623;5573.386927437979;5623.437656234364;5702.885942281173;5722;5726.971365143168;5873.177755114288;5916.201312822778;5945.464908158265;5974.074018527113;5978.940210597903;5932.139839723238;5942.405759424067;6044.818655440322;6518.674066296666;6537.378948999885;5641.605087643867;5761;5767.538596912237;5774.624649397818;5798.9130163047585;13737.931310343485;14225.217613031278;14334.068285561405;14336.354864031144;14484.637884052878;2363.279199844047;2381.4879800842727;2432.7323994360604;2631.052820984444;2654.6283520307175;10048.296619236657;10088.49557522121;10172;10536.315139515908;10737.033666969932;1809.348634491582;1932.2657390191778;1973.4277059652827;1979.3171355882198;1998.9700154497693;83381.58309208475;85456.57271713665;87248;87254;87518.12481875163;11191.944040279746;11221.887781122085;11320.377379244055;11328.773424531464;11448.141389395829;15888.841111588967;15972.520824375288;16039.919800400923;16100.275487602852;16105.516834494983;7997.840043199103;8104.8379032419025;8135.877961830577;8352.624131914079;8370.162983701703;7758.844823103506;7761.7671469855995;7845;7925.247101525346;7943.324817390587;4371.715838470489;4578.587927086578;4808.591269742111;4881;4881.243407271879;1910.4077735901915;1986.9403917882487;2014.8388128949941;2024.9898750506154;2094.2670065477264;992.4293531219578;1024.6823484719762;1044.216837371971;1086.1745073743853;1091.8034753744244;19404.514887127934;19874.50313742168;19895.10472028762;20120.49698757543;20141.17881818874;959.52023988006;997.5560875410373;1009.1573536097441;1012.367270455965;1014.60937539048;10504.107150892107;10929.195400012939;10950.835737463944;11010.119190464744;11029.83455248172;513720;518328;522644;526527;527744;95368.52315738377;97559.02440975499;98883;99442.5027874856;99629;1022.897710228986;1030.5156576409227;1042.7966546523508;1045.7594753206804;1052.4898117988653;17168.095764492566;17329.48011559655;17554.473365798534;17654.64690706153;17792.644147117244;33153.66846331506;39642.405363920145;40578.958652221285;41578;44346.55653443424;57031.2968703143;57142.7142864283;60511.69744151251;60574.394256056876;60588.394116058276;8791.956040219759;8871.201591856763;8928.910710892807;8937.374383793333;9151.725448236564;10072.345297555636;12553;13510.594682159552;13887.722245555235;14004.859951400764;12041.81937270924;12099.81850272229;12183.208091474025;12238.326892020668;12465.252084874937;12310.26138431697;12399.814002790146;12424.130310878152;12516.624501264976;12534.435950382072;12190.329531875832;12375.319357435068;12518.937405312916;12534.937325313314;12557.43491542901;7797.454178207471;8030.5181689098845;8914.108589141035;9019.368644194843;9130.726078217664;12003.459844307201;12048;12138.150329476852;12144.878551214728;12205.450754715881 05:02:42 INFO - PROCESS | 3246 | |3;mootools.html;1374.278503785512;1533.631928337199;1547.8142622885252;1751.6584266068114;1843.7234414837774;8517.659293628256;8945;8958.731238062852;9194.31042671799;9199.080091990798;8972.057933916944;9166;9170.862437063433;9177.174054335108;9185.402948808323;2103.8001389867936;2345.7419683834764;2422;2434.2818868433856;2466.2477944227094;2451.6199989001643;2478.1450399612195;2484.3043947694673;2484.8012159027326;2489.477209785938;2425.3451568076607;2447.4493239021167;2456.250843492734;2457.4347899983013;2462.1997850698594;2097.276439628326;2335.708036495438;2396.59257926153;2398.6282126270457;2422.7213870404953;2343.2970108967243;2343.5781559319316;2351.6119840226343;2353.8587684738973;2369.360272726354;9159.404638698463;9259.675911343138;9261.259099272042;9264.768380790534;9284.582193801296;5489.451054894518;5613.887722245573;5620.91568626471;5620.971895140539;5644.01229784786;3504.036389992747;3519.208178159919;3525.858965641397;3541.9114522136897;3552.129728216578;1069.2782371899016;1090.4493230918415;1120.882307357724;1127.689885281554;1134.2230572058083;13137.27744974026;13142.671433214246;13154.144980576231;13156.736865262737;13168.73662526744;4878.878028049327;4904.092742842586;4970.826021089245;4981.128302547112;4998.350214472095;10807.78384432307;10838.458077096113;10838.945805270923;10843.620473283398;10843.891561084445;4954.876128096755;5427.3758517770175;5437.728113594305;5440.972795135999;5441.7279136043835;4873.829415970495;4998.375203099613;5005.599552035828;5059.392872855207;5066.493350664978;4070.2673518766906;4169.499660040815;4192.685548583869;4216.7680777557525;4241.660667146621;1297.5264028629672;1311.1280998136324;1325.1121748428577;1345.8990575706862;1350.0617071135466;894.4141587260355;989.6437282578266;1025.4206373399154;1036.7704600170414;1039.417925961464;6366.076918846741;6369.426751592379;6381.457576106083;6423.261324947691;6439.484841212692;476.75923658552904;481.66524265635746;485.81296200962885;489.3174022239028;498.93264409305004;4213.136307057046;4302.677299202573;4322.524522302544;4345.152695224401;4412.205802955435;11151.776964460827;11579.13156513265;11661.067114630809;11680.824787628193;11695.473703683354;11122.110231181487;11451.656450306504;11527.250728702607;11543.07655387567;11599.130065245141;8242.093369729326;8522;8556.74329770108;8568.657253709782;8651.610677519528;6358.554901156875;6368.235811702625;6369.9681501592195;6429.4856411486035;6486.54594178403;10035.49822508857;10721.142308615448;10738.194635402533;10767.676969690921;10872.075873550837;10716.73208169802;10722.73193170177;10828.566857325619;10839.837402439127;10872.728181795519;7087.82280442993;7611.124720657195;7969.402294827795;8032.116467188488;8208.712695055645;8904.910950890408;8926.598303076247;8997.055309192441;9001.90998090037;9010.32422568323;7475.439342049477;7614.238576142563;7795.103563090317;7858.685652573833;8050.436469447082;7456.701731930662;7495.587742673987;7507.474476786572;7572.091349038151;7664.501807382502;6417.807465776034;6446.355364463516;6464.321246269262;6474.223093228843;6481.189851268591;5089.134847075932;5177;5215.374155101412;5234.371875374979;5373.623846330719;5334.119870221525;5371.435999220182;5500.147477141049;5502.771377592082;5510.834674959758 05:02:42 INFO - PROCESS | 3246 | |4;prototype.html;340.5198669875475;344.698388909704;346.87165748672993;348.383361450233;350.47603832270744;5332.893342133155;5409.864753381167;5409.9188512172295;5440.2927619409475;5455.463209607532;5293.867653308669;5295.894082118355;5311.282976798131;5312.946870531294;5367.865803354918;4052.9797351013276;4098.774567398792;4198.6850986176005;4207.978960105195;4225.450691410112;4178.164367126572;4202.747835129902;4203.663706903456;4219.556946520617;4222.648752399218;4000.4798176692816;4190.323870451828;4203.915921681564;4229.619334259916;4256.851010214643;4065.329220678599;4189.79051047448;4194.643455306303;4204.495460544754;4207.642350400189;3721.4603882437164;3735.495708079429;3748.5126933498746;3753;3758.8308526116116;5137.3064636274;5170.638055336128;5194.480551944813;5200.531952124327;5212.739363031833;4626.838060667894;4751.857444276678;4768.499307572724;4777;4782.521747825224;5583.6928968906695;5588.692621905793;5594.13290939905;5596.468335508121;5602.299712535933;4016.2770701273757;4033.878983630496;4043.555208927016;4047.736897101679;4097.364908439196;5597.048501754712;5810.593258471867;5838.941610583882;5860.560457965627;5869.618474799167;4120.402541631447;4131.07050913542;4159.313713237342;4164.354525048622;4185;4219.915601687949;4224.281872081753;4228.809703563347;4231.386448964883;4236.78816059202;4695.154872122982;4767.404074490689;4769.42766867978;4788.414256301558;4802.303665968485;5546.833594992157;5548.195511650788;5597.468240517144;5636.689982051026;5670.404607516234;1434.956951291463;1442.8601404890228;1445.9927700361432;1464.6265202373327;1472.1314424489387;947.7867479817124;953.6376177052814;979.6032606794117;985.9408435493893;988.7478692933399;5362.490563396471;5387.0841956867425;5391.946080539223;5394.91907621386;5444.945550544444;5641.238432811518;5680.125558565664;5680.233168522197;5682.659040457585;5756.1653560233535;5231.607629427808;5370.288004557751;5486.561075114061;5527.917081243784;5551.001639409809;3010.7440867526066;3041.9353226370595;3043.3456806786203;3044.421559903611;3070.3398769264268;5723.77104915807;5944.791932282349;5969.194158788595;6025.78909738157;6027.427394397525;5891.617044892068;5908.3205431375945;5912.822615321547;5921.200637913913;5944.6730429826775;6035.6076855004285;6065.302490213682;6068.241469816273;6076.696165191723;6081.179040829431;5702.8289151325525;5722.399148089391;5816.709164541671;5832.250324902428;5837.328707198726;5750.884982300414;5753.884922301614;5761.39505351932;5773.3072031356505;5788.884222315614;5741.339745929272;5958.582899197015;5961.165436838933;5993.400659933972;6027.487663548647;3970.642642162219;4016.377461493473;4031.2945234584417;4033.3949907514107;4049.838006479708;5598.160275958476;5646.830595082154;5790.710464476675;5812.68030258323;5828.76684932598;5596.300462442195;5598.440155984369;5598.916016259678;5624.790670005968;5624.943750562442;5594.300712410949;5600.747966341606;5627.943720562742;5696.458836410535;5697.401772813961;5269.841904742864;5555.194561767523;5559.6664200148125;5574.693391863487;5599.160125981135;5657.434256574475;5671.234383358359;5684.687342196219;5692.544596432358;5714.3999880012;5335.786568537215;5551.167324901297;5576.832695019156;5577.135543990688;5603.691796951207 05:02:42 INFO - PROCESS | 3246 | |5;yui.html;768.2432803688363;815.8857759913612;871.3639043498246;872.3588162700416;876.2726936642588;14964.176970266632;15224.847751522495;15386.538403847902;15407.845921540782;15469.149196794171;14182.219977901212;14221.573352799433;14226.644333891658;14227.21750303733;14236.359363828627;676.5162908520407;806.4959400374765;815.0586073085581;831.9084900660922;835.031363618203;818.0347190315425;827.7185756842672;830.3689196210863;830.3730683334074;830.6054624053587;852.377764232111;855.5764896376303;856.4347530629785;856.546030603781;856.7001549457702;720.5892641194495;848.0840692052599;856.5117882806802;878.1306506558461;879.4239772948729;640.6220330005273;641.6887809412431;642.0048924167568;642.1010585180737;642.5566359212129;13227.933860330733;13254.46982120714;13348;13371.33143342829;13571.52499662507;13625.386857591433;13824.239666818321;13839.515616953358;13932.303384830819;14002.159870407808;12220.450079746344;12304.384780760925;12438.19151755133;12444.440000200013;12471.189372690746;4419.11617676466;4444.400005999181;4463;4496.5278645742055;4583.633309335279;56252.71873640606;56337.71831140818;57863.99999999958;58233.41766582365;58373;10856.72858178536;10928.672139835817;10986.230963832455;11096.722581935515;11213.60752373663;19066.237350505824;19115.71326430105;19341.51646208856;19351.51621209481;19571.21715131407;8123.350131989427;8304.377171712025;8326.70856520019;8347.4156809024;8751.037385887546;4815.741865133482;4837.37114175155;4961.3798275215595;5048.495150484922;5143;3342.8328583570724;3477;3477.1307173206696;3480.8781692640637;3484.494748261488;612.3631423319787;624.9719211896496;626.2109741725459;638.7381173718846;640.1422094393535;684.4797953555334;714.257172540552;714.9061935239092;716.8673795347877;733.6588486353871;9238.491882946368;9659.130678238993;9775.315727898978;9795.608175673036;9812.165965892978;604.6039843902252;677.2076076948217;722.9783106506708;730.7004128307368;732.4653003307616;4490.348899409567;4532.320151977164;4586.839460618862;4633.096546173531;4698.389209402756;65622.34377656163;65835;66619.33380666228;66677;67255.66372168205;58965;59475.70262148661;60198.39801601928;60927.69536152291;61414;54967;55524.72237638786;55790.72104639451;55798.44201557933;56208.999999999185;8458.577071146296;8703.1296870315;8728.738137855875;8863.822723545363;9098.454092754457;36598;36939.44590831086;37638;38029.61970380371;38047;48725.512744872096;49214;50267.49732502775;50599.49400505948;50658.49341506538;11073.944630276797;11319.773604528027;11408.372539510407;11475.311481310815;11820.995215406787;12492.188007779465;12525.498980040697;12780.36098195068;12795.57286492048;13234.536791212262;11689.240199387013;11721.472533736172;11804.17370784037;11870.584529541424;11927.46326415296;11376.943115284701;11608.825867611824;11628;11652.766944661229;11921.582744603897;10917.617883374043;11153.647283430195;11608.129390295593;11903.82144267854;11955.282683039046;9681.564329605044;9854.507274636382;9934.453605051502;10080.143187829117;10140.594376224868;9923.950380248052;10186.236032297755;10196.745081372728;10240.129588984722;10245.948770256102 05:02:42 INFO - PROCESS | 3246 | __end_tp_report 05:02:42 INFO - PROCESS | 3246 | __start_cc_report 05:02:42 INFO - PROCESS | 3246 | _x_x_mozilla_cycle_collect,841 05:02:42 INFO - PROCESS | 3246 | __end_cc_report 05:02:42 INFO - PROCESS | 3246 | __startTimestamp1463659362956__endTimestamp 05:02:42 INFO - PROCESS | 3246 | 05:02:42 INFO - PROCESS | 3246 | ------- Summary: start ------- 05:02:42 INFO - PROCESS | 3246 | Number of tests: 6 05:02:42 INFO - PROCESS | 3246 | 05:02:42 INFO - PROCESS | 3246 | [#0] dojo.html Cycles:165 Average:5472.30 Median:5692.23 stddev:646.27 (11.4%) stddev-sans-first:623.33 05:02:42 INFO - PROCESS | 3246 | Values: 3206.4 3207.5 3216.7 3252.9 3261.1 5159.8 5187.7 5430.7 5552.4 5570.9 5459.7 5471.7 5503.3 5535.2 5549.2 4928.9 4961.0 5097.6 5146.6 5188.1 5077.7 5093.5 5099.1 5149.6 5153.7 4780.7 4949.1 4972.2 5010.2 5025.7 5013.9 5041.9 5042.9 5060.2 5085.5 4762.6 5002.6 5021.1 5030.3 5037.8 5483.6 5525.1 5571.4 5583.2 5586.9 5896.1 5951.0 5955.8 5957.1 5960.5 5696.8 5880.5 5906.6 5950.0 6017.2 5618.7 5622.3 5624.8 5638.1 5645.7 6092.2 6094.9 6100.8 6103.0 6114.4 5570.6 5769.9 5785.0 5817.9 5873.4 5942.5 5950.1 5955.2 6007.4 6023.7 5870.2 5891.9 5937.1 5942.8 5959.6 5592.7 5698.5 5720.8 5744.9 5754.0 4319.9 4329.5 4329.8 4346.6 4370.4 3823.9 3868.1 3874.8 3938.5 3941.8 5400.5 5486.6 5518.2 5534.5 5550.9 5841.1 5865.6 5871.4 5887.1 5889.9 5378.2 5540.8 5549.2 5551.4 5553.1 4939.4 4959.1 4978.6 4987.9 4995.6 6166.2 6166.4 6167.1 6173.3 6178.7 5616.0 5859.2 5967.7 5975.6 5979.3 6080.3 6131.7 6143.2 6143.5 6145.8 5800.3 5811.5 5851.9 5859.5 5887.3 5540.8 5882.1 5924.0 5939.4 5951.9 5801.0 5811.7 5815.2 5836.8 5874.8 5800.6 5811.2 5819.9 5821.3 5826.0 5402.8 5625.2 5642.2 5692.2 5702.8 5846.3 5851.5 5911.8 5914.8 5923.6 5702.3 5751.4 5751.4 5756.6 5787.8 05:02:42 INFO - PROCESS | 3246 | 05:02:42 INFO - PROCESS | 3246 | [#1] ext.html Cycles:180 Average:56763.77 Median:42177.18 stddev:107226.88 (254.2%) stddev-sans-first:107444.76 05:02:42 INFO - PROCESS | 3246 | Values: 598.3 642.9 649.6 656.2 666.4 31841.2 44362.6 44970.6 45086.3 45129.0 46463.3 47180.0 47290.8 47446.8 47453.5 8700.2 8933.3 8943.1 8950.6 8955.1 8744.3 8879.2 8910.1 8912.8 8916.0 8887.3 8932.1 8944.4 8954.0 8955.2 8748.8 8791.3 8802.7 8881.4 8886.0 8746.0 8865.0 8868.2 8879.6 8883.4 42509.6 42975.6 42998.8 43082.4 43093.8 3543.3 3609.5 3616.4 3658.2 3683.4 32870.8 33082.2 33535.2 33626.5 33788.8 4116.3 4205.0 4222.6 4259.3 4300.4 245061.0 249193.0 250333.0 251111.0 251328.0 54021.5 59092.4 59525.7 59562.4 59613.4 60522.7 61619.0 61742.4 66617.3 66665.3 17405.7 17507.9 17573.3 17573.6 17589.8 11638.8 13346.7 13815.1 13917.9 13944.8 16545.4 17127.7 17177.8 17193.6 17199.4 6590.6 6682.0 6859.2 6864.5 6895.0 981.9 1042.1 1097.4 1101.3 1208.5 32579.6 33161.8 33197.5 33439.7 33468.4 1134.3 1141.8 1153.9 1168.4 1217.6 17219.6 17286.7 17468.6 17487.8 17516.9 511019.0 514615.0 515041.0 515829.0 519858.0 59608.0 60438.4 60511.0 60587.0 60635.7 1285.5 1319.1 1344.7 1406.4 1424.1 31487.4 33686.3 33697.7 33912.5 33989.3 49447.0 49563.0 50044.5 50152.7 50235.2 400747.0 405114.0 405401.0 406798.0 406896.0 35863.5 40544.8 41632.0 41638.4 44077.8 48634.5 49140.3 49349.5 49423.3 50465.0 40396.2 41087.4 41350.8 41706.0 42395.8 41400.6 42114.4 42203.8 42462.8 42660.0 40961.4 41392.2 41597.8 42150.6 42831.4 36217.3 36952.4 37145.0 37157.5 37616.8 28200.0 28220.0 28345.1 28644.9 28790.3 05:02:42 INFO - PROCESS | 3246 | 05:02:42 INFO - PROCESS | 3246 | [#2] jquery.html Cycles:180 Average:30023.51 Median:2059.63 stddev:86110.15 (4180.9%) stddev-sans-first:86322.98 05:02:42 INFO - PROCESS | 3246 | Values: 398.5 401.9 403.7 409.4 428.4 13562.0 18179.0 19744.7 19752.9 19790.0 15572.6 18033.5 18336.5 18568.8 18742.4 5613.5 5762.9 5785.9 5791.7 5804.8 5573.4 5623.4 5702.9 5722.0 5727.0 5873.2 5916.2 5945.5 5974.1 5978.9 5932.1 5942.4 6044.8 6518.7 6537.4 5641.6 5761.0 5767.5 5774.6 5798.9 13737.9 14225.2 14334.1 14336.4 14484.6 2363.3 2381.5 2432.7 2631.1 2654.6 10048.3 10088.5 10172.0 10536.3 10737.0 1809.3 1932.3 1973.4 1979.3 1999.0 83381.6 85456.6 87248.0 87254.0 87518.1 11191.9 11221.9 11320.4 11328.8 11448.1 15888.8 15972.5 16039.9 16100.3 16105.5 7997.8 8104.8 8135.9 8352.6 8370.2 7758.8 7761.8 7845.0 7925.2 7943.3 4371.7 4578.6 4808.6 4881.0 4881.2 1910.4 1986.9 2014.8 2025.0 2094.3 992.4 1024.7 1044.2 1086.2 1091.8 19404.5 19874.5 19895.1 20120.5 20141.2 959.5 997.6 1009.2 1012.4 1014.6 10504.1 10929.2 10950.8 11010.1 11029.8 513720.0 518328.0 522644.0 526527.0 527744.0 95368.5 97559.0 98883.0 99442.5 99629.0 1022.9 1030.5 1042.8 1045.8 1052.5 17168.1 17329.5 17554.5 17654.6 17792.6 33153.7 39642.4 40579.0 41578.0 44346.6 57031.3 57142.7 60511.7 60574.4 60588.4 8792.0 8871.2 8928.9 8937.4 9151.7 10072.3 12553.0 13510.6 13887.7 14004.9 12041.8 12099.8 12183.2 12238.3 12465.3 12310.3 12399.8 12424.1 12516.6 12534.4 12190.3 12375.3 12518.9 12534.9 12557.4 7797.5 8030.5 8914.1 9019.4 9130.7 12003.5 12048.0 12138.2 12144.9 12205.5 05:02:42 INFO - PROCESS | 3246 | 05:02:42 INFO - PROCESS | 3246 | [#3] mootools.html Cycles:180 Average:6017.57 Median:2679.82 stddev:3485.32 (130.1%) stddev-sans-first:3477.63 05:02:42 INFO - PROCESS | 3246 | Values: 1374.3 1533.6 1547.8 1751.7 1843.7 8517.7 8945.0 8958.7 9194.3 9199.1 8972.1 9166.0 9170.9 9177.2 9185.4 2103.8 2345.7 2422.0 2434.3 2466.2 2451.6 2478.1 2484.3 2484.8 2489.5 2425.3 2447.4 2456.3 2457.4 2462.2 2097.3 2335.7 2396.6 2398.6 2422.7 2343.3 2343.6 2351.6 2353.9 2369.4 9159.4 9259.7 9261.3 9264.8 9284.6 5489.5 5613.9 5620.9 5621.0 5644.0 3504.0 3519.2 3525.9 3541.9 3552.1 1069.3 1090.4 1120.9 1127.7 1134.2 13137.3 13142.7 13154.1 13156.7 13168.7 4878.9 4904.1 4970.8 4981.1 4998.4 10807.8 10838.5 10838.9 10843.6 10843.9 4954.9 5427.4 5437.7 5441.0 5441.7 4873.8 4998.4 5005.6 5059.4 5066.5 4070.3 4169.5 4192.7 4216.8 4241.7 1297.5 1311.1 1325.1 1345.9 1350.1 894.4 989.6 1025.4 1036.8 1039.4 6366.1 6369.4 6381.5 6423.3 6439.5 476.8 481.7 485.8 489.3 498.9 4213.1 4302.7 4322.5 4345.2 4412.2 11151.8 11579.1 11661.1 11680.8 11695.5 11122.1 11451.7 11527.3 11543.1 11599.1 8242.1 8522.0 8556.7 8568.7 8651.6 6358.6 6368.2 6370.0 6429.5 6486.5 10035.5 10721.1 10738.2 10767.7 10872.1 10716.7 10722.7 10828.6 10839.8 10872.7 7087.8 7611.1 7969.4 8032.1 8208.7 8904.9 8926.6 8997.1 9001.9 9010.3 7475.4 7614.2 7795.1 7858.7 8050.4 7456.7 7495.6 7507.5 7572.1 7664.5 6417.8 6446.4 6464.3 6474.2 6481.2 5089.1 5177.0 5215.4 5234.4 5373.6 5334.1 5371.4 5500.1 5502.8 5510.8 05:02:42 INFO - PROCESS | 3246 | 05:02:42 INFO - PROCESS | 3246 | [#4] prototype.html Cycles:180 Average:4743.09 Median:5425.11 stddev:1392.01 (25.7%) stddev-sans-first:1356.12 05:02:42 INFO - PROCESS | 3246 | Values: 340.5 344.7 346.9 348.4 350.5 5332.9 5409.9 5409.9 5440.3 5455.5 5293.9 5295.9 5311.3 5312.9 5367.9 4053.0 4098.8 4198.7 4208.0 4225.5 4178.2 4202.7 4203.7 4219.6 4222.6 4000.5 4190.3 4203.9 4229.6 4256.9 4065.3 4189.8 4194.6 4204.5 4207.6 3721.5 3735.5 3748.5 3753.0 3758.8 5137.3 5170.6 5194.5 5200.5 5212.7 4626.8 4751.9 4768.5 4777.0 4782.5 5583.7 5588.7 5594.1 5596.5 5602.3 4016.3 4033.9 4043.6 4047.7 4097.4 5597.0 5810.6 5838.9 5860.6 5869.6 4120.4 4131.1 4159.3 4164.4 4185.0 4219.9 4224.3 4228.8 4231.4 4236.8 4695.2 4767.4 4769.4 4788.4 4802.3 5546.8 5548.2 5597.5 5636.7 5670.4 1435.0 1442.9 1446.0 1464.6 1472.1 947.8 953.6 979.6 985.9 988.7 5362.5 5387.1 5391.9 5394.9 5444.9 5641.2 5680.1 5680.2 5682.7 5756.2 5231.6 5370.3 5486.6 5527.9 5551.0 3010.7 3041.9 3043.3 3044.4 3070.3 5723.8 5944.8 5969.2 6025.8 6027.4 5891.6 5908.3 5912.8 5921.2 5944.7 6035.6 6065.3 6068.2 6076.7 6081.2 5702.8 5722.4 5816.7 5832.3 5837.3 5750.9 5753.9 5761.4 5773.3 5788.9 5741.3 5958.6 5961.2 5993.4 6027.5 3970.6 4016.4 4031.3 4033.4 4049.8 5598.2 5646.8 5790.7 5812.7 5828.8 5596.3 5598.4 5598.9 5624.8 5624.9 5594.3 5600.7 5627.9 5696.5 5697.4 5269.8 5555.2 5559.7 5574.7 5599.2 5657.4 5671.2 5684.7 5692.5 5714.4 5335.8 5551.2 5576.8 5577.1 5603.7 05:02:42 INFO - PROCESS | 3246 | 05:02:42 INFO - PROCESS | 3246 | [#5] yui.html Cycles:180 Average:15465.06 Median:27614.44 stddev:18603.93 (67.4%) stddev-sans-first:18623.38 05:02:42 INFO - PROCESS | 3246 | Values: 768.2 815.9 871.4 872.4 876.3 14964.2 15224.8 15386.5 15407.8 15469.1 14182.2 14221.6 14226.6 14227.2 14236.4 676.5 806.5 815.1 831.9 835.0 818.0 827.7 830.4 830.4 830.6 852.4 855.6 856.4 856.5 856.7 720.6 848.1 856.5 878.1 879.4 640.6 641.7 642.0 642.1 642.6 13227.9 13254.5 13348.0 13371.3 13571.5 13625.4 13824.2 13839.5 13932.3 14002.2 12220.5 12304.4 12438.2 12444.4 12471.2 4419.1 4444.4 4463.0 4496.5 4583.6 56252.7 56337.7 57864.0 58233.4 58373.0 10856.7 10928.7 10986.2 11096.7 11213.6 19066.2 19115.7 19341.5 19351.5 19571.2 8123.4 8304.4 8326.7 8347.4 8751.0 4815.7 4837.4 4961.4 5048.5 5143.0 3342.8 3477.0 3477.1 3480.9 3484.5 612.4 625.0 626.2 638.7 640.1 684.5 714.3 714.9 716.9 733.7 9238.5 9659.1 9775.3 9795.6 9812.2 604.6 677.2 723.0 730.7 732.5 4490.3 4532.3 4586.8 4633.1 4698.4 65622.3 65835.0 66619.3 66677.0 67255.7 58965.0 59475.7 60198.4 60927.7 61414.0 54967.0 55524.7 55790.7 55798.4 56209.0 8458.6 8703.1 8728.7 8863.8 9098.5 36598.0 36939.4 37638.0 38029.6 38047.0 48725.5 49214.0 50267.5 50599.5 50658.5 11073.9 11319.8 11408.4 11475.3 11821.0 12492.2 12525.5 12780.4 12795.6 13234.5 11689.2 11721.5 11804.2 11870.6 11927.5 11376.9 11608.8 11628.0 11652.8 11921.6 10917.6 11153.6 11608.1 11903.8 11955.3 9681.6 9854.5 9934.5 10080.1 10140.6 9924.0 10186.2 10196.7 10240.1 10245.9 05:02:42 INFO - PROCESS | 3246 | -------- Summary: end -------- 05:02:42 INFO - PROCESS | 3246 | 05:02:43 INFO - TEST-INFO | 3246: exit 0 05:02:43 INFO - TEST-OK | dromaeo_css | took 1112257ms 05:02:43 INFO - TEST-START | kraken 05:02:43 INFO - operating with platform_type : linux_ 05:02:43 INFO - Initialising browser for kraken test... 05:02:43 INFO - TEST-INFO | started process 3426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoqIRQ9/profile http://localhost:33758/getInfo.html) 05:02:47 INFO - PROCESS | 3426 | __metrics Screen width/height:1600/1200 05:02:47 INFO - PROCESS | 3426 | colorDepth:24 05:02:47 INFO - PROCESS | 3426 | Browser inner width/height: 1024/697 05:02:47 INFO - PROCESS | 3426 | __metrics 05:02:48 ERROR - PROCESS | 3426 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:02:49 INFO - TEST-INFO | 3426: exit 0 05:02:49 INFO - Browser initialized. 05:02:49 INFO - Running cycle 1/1 for kraken test... 05:02:49 INFO - TEST-INFO | started process 3507 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoqIRQ9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:03:01 INFO - PROCESS | 3507 | RSS: Main: 153231360 05:03:01 INFO - PROCESS | 3507 | 05:03:03 INFO - PROCESS | 3507 | Cycle 1(1): loaded http://localhost:33758/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33758/tests/kraken/driver.html?testName=audio-beat-detection) 05:03:04 INFO - PROCESS | 3507 | RSS: Main: 208977920 05:03:04 INFO - PROCESS | 3507 | 05:03:07 INFO - PROCESS | 3507 | Cycle 1(1): loaded http://localhost:33758/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33758/tests/kraken/driver.html?testName=audio-dft) 05:03:08 INFO - PROCESS | 3507 | RSS: Main: 198721536 05:03:08 INFO - PROCESS | 3507 | 05:03:11 INFO - PROCESS | 3507 | Cycle 1(1): loaded http://localhost:33758/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33758/tests/kraken/driver.html?testName=audio-fft) 05:03:11 INFO - PROCESS | 3507 | RSS: Main: 266027008 05:03:11 INFO - PROCESS | 3507 | 05:03:13 INFO - PROCESS | 3507 | Cycle 1(1): loaded http://localhost:33758/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33758/tests/kraken/driver.html?testName=audio-oscillator) 05:03:14 INFO - PROCESS | 3507 | RSS: Main: 175579136 05:03:14 INFO - PROCESS | 3507 | 05:03:16 INFO - PROCESS | 3507 | Cycle 1(1): loaded http://localhost:33758/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33758/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:03:17 INFO - PROCESS | 3507 | RSS: Main: 179089408 05:03:17 INFO - PROCESS | 3507 | 05:03:20 INFO - PROCESS | 3507 | Cycle 1(1): loaded http://localhost:33758/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33758/tests/kraken/driver.html?testName=imaging-darkroom) 05:03:21 INFO - PROCESS | 3507 | RSS: Main: 215158784 05:03:21 INFO - PROCESS | 3507 | 05:03:24 INFO - PROCESS | 3507 | Cycle 1(1): loaded http://localhost:33758/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33758/tests/kraken/driver.html?testName=imaging-desaturate) 05:03:25 INFO - PROCESS | 3507 | RSS: Main: 213180416 05:03:25 INFO - PROCESS | 3507 | 05:03:28 INFO - PROCESS | 3507 | Cycle 1(1): loaded http://localhost:33758/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33758/tests/kraken/driver.html?testName=json-parse-financial) 05:03:29 INFO - PROCESS | 3507 | RSS: Main: 214298624 05:03:29 INFO - PROCESS | 3507 | 05:03:30 INFO - PROCESS | 3507 | Cycle 1(1): loaded http://localhost:33758/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33758/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:03:31 INFO - PROCESS | 3507 | RSS: Main: 202686464 05:03:31 INFO - PROCESS | 3507 | 05:03:33 INFO - PROCESS | 3507 | Cycle 1(1): loaded http://localhost:33758/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33758/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:03:33 INFO - PROCESS | 3507 | RSS: Main: 207523840 05:03:33 INFO - PROCESS | 3507 | 05:03:35 INFO - PROCESS | 3507 | Cycle 1(1): loaded http://localhost:33758/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33758/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:03:36 INFO - PROCESS | 3507 | RSS: Main: 217468928 05:03:36 INFO - PROCESS | 3507 | 05:03:39 INFO - PROCESS | 3507 | Cycle 1(1): loaded http://localhost:33758/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33758/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:03:39 INFO - PROCESS | 3507 | RSS: Main: 223838208 05:03:39 INFO - PROCESS | 3507 | 05:03:42 INFO - PROCESS | 3507 | Cycle 1(1): loaded http://localhost:33758/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33758/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:03:43 INFO - PROCESS | 3507 | RSS: Main: 220094464 05:03:43 INFO - PROCESS | 3507 | 05:03:44 INFO - PROCESS | 3507 | Cycle 1(1): loaded http://localhost:33758/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33758/tests/kraken/driver.html?testName=ai-astar) 05:03:45 INFO - PROCESS | 3507 | RSS: Main: 266579968 05:03:45 INFO - PROCESS | 3507 | 05:03:45 INFO - PROCESS | 3507 | __start_tp_report 05:03:45 INFO - PROCESS | 3507 | _x_x_mozilla_page_load 05:03:45 INFO - PROCESS | 3507 | _x_x_mozilla_page_load_details 05:03:45 INFO - PROCESS | 3507 | |i|pagename|runs| 05:03:45 INFO - PROCESS | 3507 | |0;ai-astar;116;106;111;111;110;110;111;111;111;111 05:03:45 INFO - PROCESS | 3507 | |1;audio-beat-detection;150;124;162;208;127;159;156;126;173;126 05:03:45 INFO - PROCESS | 3507 | |2;audio-dft;163;162;161;162;162;160;160;161;161;160 05:03:45 INFO - PROCESS | 3507 | |3;audio-fft;75;75;76;145;78;75;74;75;131;74 05:03:45 INFO - PROCESS | 3507 | |4;audio-oscillator;91;92;155;92;91;92;130;92;93;128 05:03:45 INFO - PROCESS | 3507 | |5;imaging-gaussian-blur;116;117;116;116;117;117;116;116;117;116 05:03:45 INFO - PROCESS | 3507 | |6;imaging-darkroom;145;147;147;146;146;146;146;147;145;146 05:03:45 INFO - PROCESS | 3507 | |7;imaging-desaturate;95;94;94;95;94;95;95;95;95;96 05:03:45 INFO - PROCESS | 3507 | |8;json-parse-financial;54;55;56;55;56;55;55;106;52;53 05:03:45 INFO - PROCESS | 3507 | |9;json-stringify-tinderbox;60;60;60;60;61;60;60;60;60;61 05:03:45 INFO - PROCESS | 3507 | |10;stanford-crypto-aes;80;84;79;84;78;79;79;79;78;81 05:03:45 INFO - PROCESS | 3507 | |11;stanford-crypto-ccm;123;119;135;120;129;116;117;122;188;137 05:03:45 INFO - PROCESS | 3507 | |12;stanford-crypto-pbkdf2;160;165;162;161;159;159;164;157;158;158 05:03:45 INFO - PROCESS | 3507 | |13;stanford-crypto-sha256-iterative;64;64;69;63;65;61;62;61;60;61 05:03:45 INFO - PROCESS | 3507 | __end_tp_report 05:03:45 INFO - PROCESS | 3507 | __start_cc_report 05:03:45 INFO - PROCESS | 3507 | _x_x_mozilla_cycle_collect,1836 05:03:45 INFO - PROCESS | 3507 | __end_cc_report 05:03:45 INFO - PROCESS | 3507 | __startTimestamp1463659425039__endTimestamp 05:03:45 INFO - PROCESS | 3507 | 05:03:45 INFO - PROCESS | 3507 | ------- Summary: start ------- 05:03:45 INFO - PROCESS | 3507 | Number of tests: 14 05:03:45 INFO - PROCESS | 3507 | 05:03:45 INFO - PROCESS | 3507 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:2.39 (2.2%) stddev-sans-first:1.64 05:03:45 INFO - PROCESS | 3507 | Values: 116.0 106.0 111.0 111.0 110.0 110.0 111.0 111.0 111.0 111.0 05:03:45 INFO - PROCESS | 3507 | 05:03:45 INFO - PROCESS | 3507 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:157.50 stddev:26.87 (17.1%) stddev-sans-first:28.50 05:03:45 INFO - PROCESS | 3507 | Values: 150.0 124.0 162.0 208.0 127.0 159.0 156.0 126.0 173.0 126.0 05:03:45 INFO - PROCESS | 3507 | 05:03:45 INFO - PROCESS | 3507 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:0.87 05:03:45 INFO - PROCESS | 3507 | Values: 163.0 162.0 161.0 162.0 162.0 160.0 160.0 161.0 161.0 160.0 05:03:45 INFO - PROCESS | 3507 | 05:03:45 INFO - PROCESS | 3507 | [#3] audio-fft Cycles:10 Average:87.80 Median:75.00 stddev:26.69 (35.6%) stddev-sans-first:27.90 05:03:45 INFO - PROCESS | 3507 | Values: 75.0 75.0 76.0 145.0 78.0 75.0 74.0 75.0 131.0 74.0 05:03:45 INFO - PROCESS | 3507 | 05:03:45 INFO - PROCESS | 3507 | [#4] audio-oscillator Cycles:10 Average:105.60 Median:92.00 stddev:23.24 (25.3%) stddev-sans-first:24.05 05:03:45 INFO - PROCESS | 3507 | Values: 91.0 92.0 155.0 92.0 91.0 92.0 130.0 92.0 93.0 128.0 05:03:45 INFO - PROCESS | 3507 | 05:03:45 INFO - PROCESS | 3507 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 05:03:45 INFO - PROCESS | 3507 | Values: 116.0 117.0 116.0 116.0 117.0 117.0 116.0 116.0 117.0 116.0 05:03:45 INFO - PROCESS | 3507 | 05:03:45 INFO - PROCESS | 3507 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 05:03:45 INFO - PROCESS | 3507 | Values: 145.0 147.0 147.0 146.0 146.0 146.0 146.0 147.0 145.0 146.0 05:03:45 INFO - PROCESS | 3507 | 05:03:45 INFO - PROCESS | 3507 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 05:03:45 INFO - PROCESS | 3507 | Values: 95.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 96.0 05:03:45 INFO - PROCESS | 3507 | 05:03:45 INFO - PROCESS | 3507 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:55.00 stddev:16.32 (29.7%) stddev-sans-first:17.18 05:03:45 INFO - PROCESS | 3507 | Values: 54.0 55.0 56.0 55.0 56.0 55.0 55.0 106.0 52.0 53.0 05:03:45 INFO - PROCESS | 3507 | 05:03:45 INFO - PROCESS | 3507 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 05:03:45 INFO - PROCESS | 3507 | Values: 60.0 60.0 60.0 60.0 61.0 60.0 60.0 60.0 60.0 61.0 05:03:45 INFO - PROCESS | 3507 | 05:03:45 INFO - PROCESS | 3507 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.50 stddev:2.23 (2.8%) stddev-sans-first:2.37 05:03:45 INFO - PROCESS | 3507 | Values: 80.0 84.0 79.0 84.0 78.0 79.0 79.0 79.0 78.0 81.0 05:03:45 INFO - PROCESS | 3507 | 05:03:45 INFO - PROCESS | 3507 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:126.00 stddev:21.43 (17.0%) stddev-sans-first:22.56 05:03:45 INFO - PROCESS | 3507 | Values: 123.0 119.0 135.0 120.0 129.0 116.0 117.0 122.0 188.0 137.0 05:03:45 INFO - PROCESS | 3507 | 05:03:45 INFO - PROCESS | 3507 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:160.50 stddev:2.67 (1.7%) stddev-sans-first:2.83 05:03:45 INFO - PROCESS | 3507 | Values: 160.0 165.0 162.0 161.0 159.0 159.0 164.0 157.0 158.0 158.0 05:03:45 INFO - PROCESS | 3507 | 05:03:45 INFO - PROCESS | 3507 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.50 stddev:2.67 (4.2%) stddev-sans-first:2.80 05:03:45 INFO - PROCESS | 3507 | Values: 64.0 64.0 69.0 63.0 65.0 61.0 62.0 61.0 60.0 61.0 05:03:45 INFO - PROCESS | 3507 | -------- Summary: end -------- 05:03:45 INFO - PROCESS | 3507 | 05:03:45 INFO - TEST-INFO | 3507: exit 0 05:03:45 INFO - TEST-OK | kraken | took 62288ms 05:03:45 INFO - SUITE-END | took 1174s 05:03:46 INFO - Completed test suite (00:19:34) 05:03:46 INFO - javascript benchmark 05:03:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3206.35872825435, 3207.534907438423, 3216.6783321667835, 3252.8536215870286, 3261.135799013262, 5159.845204643857, 5187.714675692835, 5430.72846357682, 5552.389237183912, 5570.8607284817845, 5459.727013649322, 5471.671699698021, 5503.3395992480955, 5535.225068490405, 5549.1676248562635, 4928.901421971558, 4961.0, 5097.643164978453, 5146.639735218536, 5188.0920838853235, 5077.695338279696, 5093.541581257686, 5099.133147364938, 5149.613778966574, 5153.665011774241, 4780.737059461728, 4949.084419382426, 4972.229304457815, 5010.223415370605, 5025.748712564357, 5013.874653133665, 5041.899162016776, 5042.899142017176, 5060.190369540893, 5085.516875896821, 4762.595179409755, 5002.574781143607, 5021.096202683516, 5030.270610761419, 5037.848864534069, 5483.561315094823, 5525.143602741581, 5571.359293681238, 5583.218349431083, 5586.944130558683, 5896.115582662592, 5951.047832346847, 5955.791547295824, 5957.136215248808, 5960.523158147338, 5696.77212911483, 5880.470757631833, 5906.616069955439, 5950.0, 6017.157597936292, 5618.7190640468225, 5622.269105016404, 5624.803131890364, 5638.069718496443, 5645.717714114319, 6092.1775560299675, 6094.924532418307, 6100.816975490742, 6102.996776376, 6114.388561143939, 5570.554355651539, 5769.85575360611, 5784.971075144597, 5817.912731308949, 5873.412658734178, 5942.524598032147, 5950.107483877453, 5955.196048533479, 6007.399260074045, 6023.728932198062, 5870.236869206976, 5891.941080589139, 5937.050071988548, 5942.821715348547, 5959.642421454727, 5592.664440133605, 5698.4871361576825, 5720.771169153188, 5744.913826292609, 5753.971230143822, 4319.935200971988, 4329.523752387235, 4329.761863097497, 4346.630536404441, 4370.366296886998, 3823.866164684223, 3868.0909986153233, 3874.8256328465286, 3938.5273767148124, 3941.8226179821977, 5400.513953744182, 5486.588505862076, 5518.19986102021, 5534.52956498694, 5550.916736248879, 5841.094630332305, 5865.589408741347, 5871.442212989759, 5887.058070708752, 5889.911651325234, 5378.2470454136455, 5540.750666220029, 5549.195366671891, 5551.3893471718075, 5553.055980483327, 4939.407271127416, 4959.057779022047, 4978.551930326288, 4987.875303117378, 4995.575376093, 6166.1983942087245, 6166.352532984062, 6167.136600875881, 6173.259208894871, 6178.69106544671, 5616.0, 5859.179714839841, 5967.731452084667, 5975.611585246945, 5979.312379076462, 6080.300765412034, 6131.651934473353, 6143.235544005126, 6143.450468055707, 6145.8156255312415, 5800.332961709458, 5811.476967072984, 5851.882962340815, 5859.5019423349495, 5887.322957859901, 5540.750666219949, 5882.117682347682, 5924.0, 5939.376365481735, 5951.940480595139, 5800.970995144998, 5811.680357580373, 5815.244018277597, 5836.824895253149, 5874.823755287348, 5800.56495762811, 5811.186433899173, 5819.883602327845, 5821.301443826768, 5826.0387036140255, 5402.783888644411, 5625.156226566048, 5642.153676948491, 5692.231548740867, 5702.800401985911, 5846.269216347957, 5851.531877449709, 5911.822645320647, 5914.822555323347, 5923.644581325134, 5702.315722113373, 5751.424857514216, 5751.424857514383, 5756.597038207286, 5787.768489260382], "value": 5427.479238184168, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.3298705449897, 642.8649983503464, 649.5875119299244, 656.1896058367914, 666.3569655282652, 31841.203969900766, 44362.556374436244, 44970.55029449704, 45086.323705144365, 45128.999999999956, 46463.30305045427, 47180.0, 47290.76354618231, 47446.762766186206, 47453.52546474534, 8700.173483519087, 8933.330000250007, 8943.105689431037, 8950.597223124942, 8955.059718729537, 8744.34417418693, 8879.245264152523, 8910.064443233465, 8912.777180570472, 8915.95542022289, 8887.333449991243, 8932.10678932105, 8944.373893827435, 8953.955230223872, 8955.238804701608, 8748.781280467976, 8791.340649451316, 8802.73591792244, 8881.378303518757, 8886.0, 8746.0, 8864.955675221583, 8868.15752503511, 8879.556022198929, 8883.42257753244, 42509.57490425087, 42975.57024429747, 42998.78500607508, 43082.35376469355, 43093.784531077144, 3543.344481270947, 3609.458581212813, 3616.439451884936, 3658.213484100931, 3683.355412802749, 32870.835645821615, 33082.17294567631, 33535.16162095943, 33626.49560256598, 33788.83105584457, 4116.320807066831, 4204.978975105105, 4222.5566315536735, 4259.254630439661, 4300.442413873932, 245061.0, 249193.0, 250333.0, 251111.0, 251328.0, 54021.45978540243, 59092.40907590955, 59525.70237148787, 59562.404375956554, 59613.403865961656, 60522.69738651279, 61619.0, 61742.38257617456, 66617.33382666208, 66665.33334666688, 17405.738913916302, 17507.912460437616, 17573.297068117387, 17573.648527029643, 17589.824101759074, 11638.76722465546, 13346.666333341549, 13815.102018368774, 13917.930410347883, 13944.790828137586, 16545.420910268083, 17127.65744685124, 17177.79755417134, 17193.57016074608, 17199.398021069203, 6590.604563726191, 6681.966590167018, 6859.176898772179, 6864.450843932474, 6895.0, 981.916537094355, 1042.1089968077185, 1097.373329573171, 1101.3171833463305, 1208.5407545132794, 32579.62436198048, 33161.83419082889, 33197.50203746946, 33439.66560334414, 33468.3521543909, 1134.3477500437116, 1141.7944769941491, 1153.9153195995736, 1168.4274705394296, 1217.598192596441, 17219.56951076208, 17286.654266914593, 17468.5632859177, 17487.825121748872, 17516.91241543784, 511019.0, 514615.0, 515041.0, 515829.0, 519858.0, 59608.0, 60438.39561604328, 60511.0, 60587.0, 60635.69682151561, 1285.4858056777177, 1319.0634649398842, 1344.6638340414897, 1406.374163497234, 1424.1241636393543, 31487.37025259528, 33686.326273473904, 33697.66302336945, 33912.491312629834, 33989.32021359608, 49447.0, 49563.0, 50044.49955500398, 50152.749236253585, 50235.24647130369, 400747.0, 405114.0, 405401.0, 406798.0, 406896.0, 35863.46204806878, 40544.75641948578, 41632.0, 41638.37542436805, 44077.77961110174, 48634.513654862996, 49140.262896057306, 49349.506504935925, 49423.25865111954, 50465.0, 40396.19207615773, 41087.38368924528, 41350.79324603358, 41705.95735106646, 42395.7880210597, 41400.58599414088, 42114.36828447637, 42203.788981056125, 42462.78768606137, 42660.0, 40961.385579216934, 41392.172156556095, 41597.79201103975, 42150.57849421589, 42831.35752963646, 36217.27565448729, 36952.445713313784, 37145.0, 37157.46492810673, 37616.80257178061, 28199.99202742559, 28219.97465271754, 28345.149645510668, 28644.856775715987, 28790.280242994093], "value": 20330.494945114042, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.5496389080339, 401.90756126091, 403.6851256020303, 409.41044895350694, 428.3788506665334, 13562.0, 18179.0, 19744.70382944255, 19752.90123549382, 19790.0, 15572.61068473286, 18033.458996230132, 18336.541586460346, 18568.814311856877, 18742.437726868182, 5613.522850557697, 5762.942370576283, 5785.913211301813, 5791.739371728282, 5804.767809287623, 5573.386927437979, 5623.437656234364, 5702.885942281173, 5722.0, 5726.971365143168, 5873.177755114288, 5916.201312822778, 5945.464908158265, 5974.074018527113, 5978.940210597903, 5932.139839723238, 5942.405759424067, 6044.818655440322, 6518.674066296666, 6537.378948999885, 5641.605087643867, 5761.0, 5767.538596912237, 5774.624649397818, 5798.9130163047585, 13737.931310343485, 14225.217613031278, 14334.068285561405, 14336.354864031144, 14484.637884052878, 2363.279199844047, 2381.4879800842727, 2432.7323994360604, 2631.052820984444, 2654.6283520307175, 10048.296619236657, 10088.49557522121, 10172.0, 10536.315139515908, 10737.033666969932, 1809.348634491582, 1932.2657390191778, 1973.4277059652827, 1979.3171355882198, 1998.9700154497693, 83381.58309208475, 85456.57271713665, 87248.0, 87254.0, 87518.12481875163, 11191.944040279746, 11221.887781122085, 11320.377379244055, 11328.773424531464, 11448.141389395829, 15888.841111588967, 15972.520824375288, 16039.919800400923, 16100.275487602852, 16105.516834494983, 7997.840043199103, 8104.8379032419025, 8135.877961830577, 8352.624131914079, 8370.162983701703, 7758.844823103506, 7761.7671469855995, 7845.0, 7925.247101525346, 7943.324817390587, 4371.715838470489, 4578.587927086578, 4808.591269742111, 4881.0, 4881.243407271879, 1910.4077735901915, 1986.9403917882487, 2014.8388128949941, 2024.9898750506154, 2094.2670065477264, 992.4293531219578, 1024.6823484719762, 1044.216837371971, 1086.1745073743853, 1091.8034753744244, 19404.514887127934, 19874.50313742168, 19895.10472028762, 20120.49698757543, 20141.17881818874, 959.52023988006, 997.5560875410373, 1009.1573536097441, 1012.367270455965, 1014.60937539048, 10504.107150892107, 10929.195400012939, 10950.835737463944, 11010.119190464744, 11029.83455248172, 513720.0, 518328.0, 522644.0, 526527.0, 527744.0, 95368.52315738377, 97559.02440975499, 98883.0, 99442.5027874856, 99629.0, 1022.897710228986, 1030.5156576409227, 1042.7966546523508, 1045.7594753206804, 1052.4898117988653, 17168.095764492566, 17329.48011559655, 17554.473365798534, 17654.64690706153, 17792.644147117244, 33153.66846331506, 39642.405363920145, 40578.958652221285, 41578.0, 44346.55653443424, 57031.2968703143, 57142.7142864283, 60511.69744151251, 60574.394256056876, 60588.394116058276, 8791.956040219759, 8871.201591856763, 8928.910710892807, 8937.374383793333, 9151.725448236564, 10072.345297555636, 12553.0, 13510.594682159552, 13887.722245555235, 14004.859951400764, 12041.81937270924, 12099.81850272229, 12183.208091474025, 12238.326892020668, 12465.252084874937, 12310.26138431697, 12399.814002790146, 12424.130310878152, 12516.624501264976, 12534.435950382072, 12190.329531875832, 12375.319357435068, 12518.937405312916, 12534.937325313314, 12557.43491542901, 7797.454178207471, 8030.5181689098845, 8914.108589141035, 9019.368644194843, 9130.726078217664, 12003.459844307201, 12048.0, 12138.150329476852, 12144.878551214728, 12205.450754715881], "value": 9284.12716468684, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.278503785512, 1533.631928337199, 1547.8142622885252, 1751.6584266068114, 1843.7234414837774, 8517.659293628256, 8945.0, 8958.731238062852, 9194.31042671799, 9199.080091990798, 8972.057933916944, 9166.0, 9170.862437063433, 9177.174054335108, 9185.402948808323, 2103.8001389867936, 2345.7419683834764, 2422.0, 2434.2818868433856, 2466.2477944227094, 2451.6199989001643, 2478.1450399612195, 2484.3043947694673, 2484.8012159027326, 2489.477209785938, 2425.3451568076607, 2447.4493239021167, 2456.250843492734, 2457.4347899983013, 2462.1997850698594, 2097.276439628326, 2335.708036495438, 2396.59257926153, 2398.6282126270457, 2422.7213870404953, 2343.2970108967243, 2343.5781559319316, 2351.6119840226343, 2353.8587684738973, 2369.360272726354, 9159.404638698463, 9259.675911343138, 9261.259099272042, 9264.768380790534, 9284.582193801296, 5489.451054894518, 5613.887722245573, 5620.91568626471, 5620.971895140539, 5644.01229784786, 3504.036389992747, 3519.208178159919, 3525.858965641397, 3541.9114522136897, 3552.129728216578, 1069.2782371899016, 1090.4493230918415, 1120.882307357724, 1127.689885281554, 1134.2230572058083, 13137.27744974026, 13142.671433214246, 13154.144980576231, 13156.736865262737, 13168.73662526744, 4878.878028049327, 4904.092742842586, 4970.826021089245, 4981.128302547112, 4998.350214472095, 10807.78384432307, 10838.458077096113, 10838.945805270923, 10843.620473283398, 10843.891561084445, 4954.876128096755, 5427.3758517770175, 5437.728113594305, 5440.972795135999, 5441.7279136043835, 4873.829415970495, 4998.375203099613, 5005.599552035828, 5059.392872855207, 5066.493350664978, 4070.2673518766906, 4169.499660040815, 4192.685548583869, 4216.7680777557525, 4241.660667146621, 1297.5264028629672, 1311.1280998136324, 1325.1121748428577, 1345.8990575706862, 1350.0617071135466, 894.4141587260355, 989.6437282578266, 1025.4206373399154, 1036.7704600170414, 1039.417925961464, 6366.076918846741, 6369.426751592379, 6381.457576106083, 6423.261324947691, 6439.484841212692, 476.75923658552904, 481.66524265635746, 485.81296200962885, 489.3174022239028, 498.93264409305004, 4213.136307057046, 4302.677299202573, 4322.524522302544, 4345.152695224401, 4412.205802955435, 11151.776964460827, 11579.13156513265, 11661.067114630809, 11680.824787628193, 11695.473703683354, 11122.110231181487, 11451.656450306504, 11527.250728702607, 11543.07655387567, 11599.130065245141, 8242.093369729326, 8522.0, 8556.74329770108, 8568.657253709782, 8651.610677519528, 6358.554901156875, 6368.235811702625, 6369.9681501592195, 6429.4856411486035, 6486.54594178403, 10035.49822508857, 10721.142308615448, 10738.194635402533, 10767.676969690921, 10872.075873550837, 10716.73208169802, 10722.73193170177, 10828.566857325619, 10839.837402439127, 10872.728181795519, 7087.82280442993, 7611.124720657195, 7969.402294827795, 8032.116467188488, 8208.712695055645, 8904.910950890408, 8926.598303076247, 8997.055309192441, 9001.90998090037, 9010.32422568323, 7475.439342049477, 7614.238576142563, 7795.103563090317, 7858.685652573833, 8050.436469447082, 7456.701731930662, 7495.587742673987, 7507.474476786572, 7572.091349038151, 7664.501807382502, 6417.807465776034, 6446.355364463516, 6464.321246269262, 6474.223093228843, 6481.189851268591, 5089.134847075932, 5177.0, 5215.374155101412, 5234.371875374979, 5373.623846330719, 5334.119870221525, 5371.435999220182, 5500.147477141049, 5502.771377592082, 5510.834674959758], "value": 4719.087558629947, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.5198669875475, 344.698388909704, 346.87165748672993, 348.383361450233, 350.47603832270744, 5332.893342133155, 5409.864753381167, 5409.9188512172295, 5440.2927619409475, 5455.463209607532, 5293.867653308669, 5295.894082118355, 5311.282976798131, 5312.946870531294, 5367.865803354918, 4052.9797351013276, 4098.774567398792, 4198.6850986176005, 4207.978960105195, 4225.450691410112, 4178.164367126572, 4202.747835129902, 4203.663706903456, 4219.556946520617, 4222.648752399218, 4000.4798176692816, 4190.323870451828, 4203.915921681564, 4229.619334259916, 4256.851010214643, 4065.329220678599, 4189.79051047448, 4194.643455306303, 4204.495460544754, 4207.642350400189, 3721.4603882437164, 3735.495708079429, 3748.5126933498746, 3753.0, 3758.8308526116116, 5137.3064636274, 5170.638055336128, 5194.480551944813, 5200.531952124327, 5212.739363031833, 4626.838060667894, 4751.857444276678, 4768.499307572724, 4777.0, 4782.521747825224, 5583.6928968906695, 5588.692621905793, 5594.13290939905, 5596.468335508121, 5602.299712535933, 4016.2770701273757, 4033.878983630496, 4043.555208927016, 4047.736897101679, 4097.364908439196, 5597.048501754712, 5810.593258471867, 5838.941610583882, 5860.560457965627, 5869.618474799167, 4120.402541631447, 4131.07050913542, 4159.313713237342, 4164.354525048622, 4185.0, 4219.915601687949, 4224.281872081753, 4228.809703563347, 4231.386448964883, 4236.78816059202, 4695.154872122982, 4767.404074490689, 4769.42766867978, 4788.414256301558, 4802.303665968485, 5546.833594992157, 5548.195511650788, 5597.468240517144, 5636.689982051026, 5670.404607516234, 1434.956951291463, 1442.8601404890228, 1445.9927700361432, 1464.6265202373327, 1472.1314424489387, 947.7867479817124, 953.6376177052814, 979.6032606794117, 985.9408435493893, 988.7478692933399, 5362.490563396471, 5387.0841956867425, 5391.946080539223, 5394.91907621386, 5444.945550544444, 5641.238432811518, 5680.125558565664, 5680.233168522197, 5682.659040457585, 5756.1653560233535, 5231.607629427808, 5370.288004557751, 5486.561075114061, 5527.917081243784, 5551.001639409809, 3010.7440867526066, 3041.9353226370595, 3043.3456806786203, 3044.421559903611, 3070.3398769264268, 5723.77104915807, 5944.791932282349, 5969.194158788595, 6025.78909738157, 6027.427394397525, 5891.617044892068, 5908.3205431375945, 5912.822615321547, 5921.200637913913, 5944.6730429826775, 6035.6076855004285, 6065.302490213682, 6068.241469816273, 6076.696165191723, 6081.179040829431, 5702.8289151325525, 5722.399148089391, 5816.709164541671, 5832.250324902428, 5837.328707198726, 5750.884982300414, 5753.884922301614, 5761.39505351932, 5773.3072031356505, 5788.884222315614, 5741.339745929272, 5958.582899197015, 5961.165436838933, 5993.400659933972, 6027.487663548647, 3970.642642162219, 4016.377461493473, 4031.2945234584417, 4033.3949907514107, 4049.838006479708, 5598.160275958476, 5646.830595082154, 5790.710464476675, 5812.68030258323, 5828.76684932598, 5596.300462442195, 5598.440155984369, 5598.916016259678, 5624.790670005968, 5624.943750562442, 5594.300712410949, 5600.747966341606, 5627.943720562742, 5696.458836410535, 5697.401772813961, 5269.841904742864, 5555.194561767523, 5559.6664200148125, 5574.693391863487, 5599.160125981135, 5657.434256574475, 5671.234383358359, 5684.687342196219, 5692.544596432358, 5714.3999880012, 5335.786568537215, 5551.167324901297, 5576.832695019156, 5577.135543990688, 5603.691796951207], "value": 4303.294226236967, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.2432803688363, 815.8857759913612, 871.3639043498246, 872.3588162700416, 876.2726936642588, 14964.176970266632, 15224.847751522495, 15386.538403847902, 15407.845921540782, 15469.149196794171, 14182.219977901212, 14221.573352799433, 14226.644333891658, 14227.21750303733, 14236.359363828627, 676.5162908520407, 806.4959400374765, 815.0586073085581, 831.9084900660922, 835.031363618203, 818.0347190315425, 827.7185756842672, 830.3689196210863, 830.3730683334074, 830.6054624053587, 852.377764232111, 855.5764896376303, 856.4347530629785, 856.546030603781, 856.7001549457702, 720.5892641194495, 848.0840692052599, 856.5117882806802, 878.1306506558461, 879.4239772948729, 640.6220330005273, 641.6887809412431, 642.0048924167568, 642.1010585180737, 642.5566359212129, 13227.933860330733, 13254.46982120714, 13348.0, 13371.33143342829, 13571.52499662507, 13625.386857591433, 13824.239666818321, 13839.515616953358, 13932.303384830819, 14002.159870407808, 12220.450079746344, 12304.384780760925, 12438.19151755133, 12444.440000200013, 12471.189372690746, 4419.11617676466, 4444.400005999181, 4463.0, 4496.5278645742055, 4583.633309335279, 56252.71873640606, 56337.71831140818, 57863.99999999958, 58233.41766582365, 58373.0, 10856.72858178536, 10928.672139835817, 10986.230963832455, 11096.722581935515, 11213.60752373663, 19066.237350505824, 19115.71326430105, 19341.51646208856, 19351.51621209481, 19571.21715131407, 8123.350131989427, 8304.377171712025, 8326.70856520019, 8347.4156809024, 8751.037385887546, 4815.741865133482, 4837.37114175155, 4961.3798275215595, 5048.495150484922, 5143.0, 3342.8328583570724, 3477.0, 3477.1307173206696, 3480.8781692640637, 3484.494748261488, 612.3631423319787, 624.9719211896496, 626.2109741725459, 638.7381173718846, 640.1422094393535, 684.4797953555334, 714.257172540552, 714.9061935239092, 716.8673795347877, 733.6588486353871, 9238.491882946368, 9659.130678238993, 9775.315727898978, 9795.608175673036, 9812.165965892978, 604.6039843902252, 677.2076076948217, 722.9783106506708, 730.7004128307368, 732.4653003307616, 4490.348899409567, 4532.320151977164, 4586.839460618862, 4633.096546173531, 4698.389209402756, 65622.34377656163, 65835.0, 66619.33380666228, 66677.0, 67255.66372168205, 58965.0, 59475.70262148661, 60198.39801601928, 60927.69536152291, 61414.0, 54967.0, 55524.72237638786, 55790.72104639451, 55798.44201557933, 56208.999999999185, 8458.577071146296, 8703.1296870315, 8728.738137855875, 8863.822723545363, 9098.454092754457, 36598.0, 36939.44590831086, 37638.0, 38029.61970380371, 38047.0, 48725.512744872096, 49214.0, 50267.49732502775, 50599.49400505948, 50658.49341506538, 11073.944630276797, 11319.773604528027, 11408.372539510407, 11475.311481310815, 11820.995215406787, 12492.188007779465, 12525.498980040697, 12780.36098195068, 12795.57286492048, 13234.536791212262, 11689.240199387013, 11721.472533736172, 11804.17370784037, 11870.584529541424, 11927.46326415296, 11376.943115284701, 11608.825867611824, 11628.0, 11652.766944661229, 11921.582744603897, 10917.617883374043, 11153.647283430195, 11608.129390295593, 11903.82144267854, 11955.282683039046, 9681.564329605044, 9854.507274636382, 9934.453605051502, 10080.143187829117, 10140.594376224868, 9923.950380248052, 10186.236032297755, 10196.745081372728, 10240.129588984722, 10245.948770256102], "value": 6841.811826457324, "unit": "score"}], "name": "dromaeo_css", "value": 7225.926848807199, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 106.0, 111.0, 111.0, 110.0, 110.0, 111.0, 111.0, 111.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 162.0, 208.0, 127.0, 159.0, 156.0, 126.0, 173.0, 126.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 162.0, 162.0, 160.0, 160.0, 161.0, 161.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 145.0, 78.0, 75.0, 74.0, 75.0, 131.0, 74.0], "value": 87.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 155.0, 92.0, 91.0, 92.0, 130.0, 92.0, 93.0, 128.0], "value": 105.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 55.0, 56.0, 55.0, 55.0, 106.0, 52.0, 53.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 61.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 79.0, 84.0, 78.0, 79.0, 79.0, 79.0, 78.0, 81.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 119.0, 135.0, 120.0, 129.0, 116.0, 117.0, 122.0, 188.0, 137.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 165.0, 162.0, 161.0, 159.0, 159.0, 164.0, 157.0, 158.0, 158.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 69.0, 63.0, 65.0, 61.0, 62.0, 61.0, 60.0, 61.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1527.6999999999998, "alertThreshold": 2.0}]} 05:03:46 INFO - Return code: 0 05:03:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:03:46 ERROR - # TBPL SUCCESS # 05:03:46 INFO - Running post-action listener: _resource_record_post_action 05:03:46 INFO - ##### 05:03:46 INFO - ##### Finished run-tests step (success) 05:03:46 INFO - ##### 05:03:46 INFO - Running post-run listener: _resource_record_post_run 05:03:46 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537530368; Read time: 16; Write time: 511356 05:03:46 INFO - TinderboxPrint: CPU usage
13.1% 05:03:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 05:03:46 INFO - TinderboxPrint: I/O write bytes / time
537,530,368 / 511,356 05:03:46 INFO - TinderboxPrint: CPU idle
8,270.2 (86.9%) 05:03:46 INFO - TinderboxPrint: CPU user
1,199.7 (12.6%) 05:03:46 INFO - TinderboxPrint: Swap in / out
0 / 0 05:03:46 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247128064; Read time: 0; Write time: 332116 05:03:46 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288157696; Read time: 16; Write time: 179160 05:03:46 INFO - Running post-run listener: _upload_blobber_files 05:03:46 INFO - Blob upload gear active. 05:03:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:03:46 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 05:03:46 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:03:46 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:03:47 INFO - (blobuploader) - INFO - Open directory for files ... 05:03:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:03:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:03:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:48 INFO - (blobuploader) - INFO - Done attempting. 05:03:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:03:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:03:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:51 INFO - (blobuploader) - INFO - Done attempting. 05:03:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:03:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:03:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:03:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:52 INFO - (blobuploader) - INFO - Done attempting. 05:03:52 INFO - (blobuploader) - INFO - Iteration through files over. 05:03:52 INFO - Return code: 0 05:03:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:03:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:03:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3ec9634eab210391f033fefbcfbe102efba8ff6436b432a5064e84acb9b4ed041ded458bd5c7f0a4b4418125246ac2f99d8bd112ff901cf5a7f1dddc9e61bebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d4af9941a2a12d1e027b04fe7d9e075cab7107ea1f644530f481550d329f54900caf55cc34852c907f22822ef89715c28e01ef248f19a8b167517660674de606", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cfebe288cfe0aa5ae295ced908b41b7b72a696e0037e9484407ddd6a1b6dcc2438be224385f958bfb60c4018614d9f491238d8a85e093bbfa2feab197bfe49ca"} 05:03:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:03:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:03:52 INFO - Contents: 05:03:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3ec9634eab210391f033fefbcfbe102efba8ff6436b432a5064e84acb9b4ed041ded458bd5c7f0a4b4418125246ac2f99d8bd112ff901cf5a7f1dddc9e61bebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d4af9941a2a12d1e027b04fe7d9e075cab7107ea1f644530f481550d329f54900caf55cc34852c907f22822ef89715c28e01ef248f19a8b167517660674de606", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cfebe288cfe0aa5ae295ced908b41b7b72a696e0037e9484407ddd6a1b6dcc2438be224385f958bfb60c4018614d9f491238d8a85e093bbfa2feab197bfe49ca"} 05:03:52 INFO - Running post-run listener: copy_logs_to_upload_dir 05:03:52 INFO - Copying logs to upload dir... 05:03:52 INFO - mkdir: /builds/slave/test/build/upload/logs 05:03:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.026374 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-19 05:03:51.855150) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 05:03:51.858982) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1463658084.333527-615993172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3ec9634eab210391f033fefbcfbe102efba8ff6436b432a5064e84acb9b4ed041ded458bd5c7f0a4b4418125246ac2f99d8bd112ff901cf5a7f1dddc9e61bebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d4af9941a2a12d1e027b04fe7d9e075cab7107ea1f644530f481550d329f54900caf55cc34852c907f22822ef89715c28e01ef248f19a8b167517660674de606", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cfebe288cfe0aa5ae295ced908b41b7b72a696e0037e9484407ddd6a1b6dcc2438be224385f958bfb60c4018614d9f491238d8a85e093bbfa2feab197bfe49ca"} build_url:https://queue.taskcluster.net/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011077 build_url: 'https://queue.taskcluster.net/v1/task/GUp0INAZSpObh6UU-VvKrA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3ec9634eab210391f033fefbcfbe102efba8ff6436b432a5064e84acb9b4ed041ded458bd5c7f0a4b4418125246ac2f99d8bd112ff901cf5a7f1dddc9e61bebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d4af9941a2a12d1e027b04fe7d9e075cab7107ea1f644530f481550d329f54900caf55cc34852c907f22822ef89715c28e01ef248f19a8b167517660674de606", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cfebe288cfe0aa5ae295ced908b41b7b72a696e0037e9484407ddd6a1b6dcc2438be224385f958bfb60c4018614d9f491238d8a85e093bbfa2feab197bfe49ca"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 05:03:51.883369) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 05:03:51.883736) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1463658084.333527-615993172 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004356 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 05:03:51.967058) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 05:03:51.967424) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 05:03:51.967765) ========= ========= Total master_lag: 0.16 =========