builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1462987137.15 results: success (0) buildid: 20160511073009 builduid: b71ac218f8c14983badea0d4759aed2e revision: 3461f3cae78495f100a0f7d3d2e0b89292d3ec02 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 10:18:57.147037) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 10:18:57.147553) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 10:18:57.147887) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 10:18:57.157090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 10:18:57.157463) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-11 10:18:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 62.6M=0s 2016-05-11 10:18:57 (62.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130274 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 10:18:57.296428) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 10:18:57.296808) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009709 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 10:18:57.343319) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 10:18:57.343672) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3461f3cae78495f100a0f7d3d2e0b89292d3ec02 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3461f3cae78495f100a0f7d3d2e0b89292d3ec02 --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=7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-11 10:18:57,754 truncating revision to first 12 chars 2016-05-11 10:18:57,754 Setting DEBUG logging. 2016-05-11 10:18:57,754 attempt 1/10 2016-05-11 10:18:57,754 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3461f3cae784?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 10:18:58,852 unpacking tar archive at: mozilla-central-3461f3cae784/testing/mozharness/ program finished with exit code 0 elapsedTime=1.345192 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 10:18:58.696932) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 10:18:58.697258) ========= script_repo_revision: 3461f3cae78495f100a0f7d3d2e0b89292d3ec02 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 10:18:58.697653) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 10:18:58.697935) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 10:18:58.703964) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-05-11 10:18:58.704347) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:18:59 INFO - MultiFileLogger online at 20160511 10:18:59 in /builds/slave/test 10:18:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:18:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:18:59 INFO - {'append_to_log': False, 10:18:59 INFO - 'base_work_dir': '/builds/slave/test', 10:18:59 INFO - 'blob_upload_branch': 'Firefox', 10:18:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:18:59 INFO - 'branch': 'Firefox', 10:18:59 INFO - 'buildbot_json_path': 'buildprops.json', 10:18:59 INFO - 'config_files': ('talos/linux_config.py',), 10:18:59 INFO - 'default_actions': ('clobber', 10:18:59 INFO - 'read-buildbot-config', 10:18:59 INFO - 'download-and-extract', 10:18:59 INFO - 'populate-webroot', 10:18:59 INFO - 'create-virtualenv', 10:18:59 INFO - 'install', 10:18:59 INFO - 'run-tests'), 10:18:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:18:59 INFO - 'download_minidump_stackwalk': True, 10:18:59 INFO - 'download_symbols': 'ondemand', 10:18:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:18:59 INFO - 'tooltool.py': '/tools/tooltool.py', 10:18:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:18:59 INFO - '/tools/misc-python/virtualenv.py')}, 10:18:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:18:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:18:59 INFO - 'installer_path': 'installer.exe', 10:18:59 INFO - 'log_level': 'info', 10:18:59 INFO - 'log_name': 'talos', 10:18:59 INFO - 'log_to_console': True, 10:18:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:18:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:18:59 INFO - 'opt_config_files': (), 10:18:59 INFO - 'pip_index': False, 10:18:59 INFO - 'sps_profile': False, 10:18:59 INFO - 'sps_profile_interval': 0, 10:18:59 INFO - 'suite': 'dromaeojs-e10s', 10:18:59 INFO - 'system_bits': '32', 10:18:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:18:59 INFO - 'title': 'talos-linux64-ix-024', 10:18:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:18:59 INFO - 'use_talos_json': True, 10:18:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:18:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:18:59 INFO - 'work_dir': 'build'} 10:18:59 INFO - ##### 10:18:59 INFO - ##### Running clobber step. 10:18:59 INFO - ##### 10:18:59 INFO - Running pre-action listener: _resource_record_pre_action 10:18:59 INFO - Running main action method: clobber 10:18:59 INFO - rmtree: /builds/slave/test/build 10:18:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:18:59 INFO - Running post-action listener: _resource_record_post_action 10:18:59 INFO - ##### 10:18:59 INFO - ##### Finished clobber step (success) 10:18:59 INFO - ##### 10:18:59 INFO - ##### 10:18:59 INFO - ##### Running read-buildbot-config step. 10:18:59 INFO - ##### 10:18:59 INFO - Running pre-action listener: _resource_record_pre_action 10:18:59 INFO - Running main action method: read_buildbot_config 10:18:59 INFO - Using buildbot properties: 10:18:59 INFO - { 10:18:59 INFO - "project": "", 10:18:59 INFO - "product": "firefox", 10:18:59 INFO - "script_repo_revision": "production", 10:18:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:18:59 INFO - "repository": "", 10:18:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:18:59 INFO - "buildid": "20160511073009", 10:18:59 INFO - "pgo_build": "True", 10:18:59 INFO - "basedir": "/builds/slave/test", 10:18:59 INFO - "buildnumber": 731, 10:18:59 INFO - "slavename": "talos-linux64-ix-024", 10:18:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:18:59 INFO - "platform": "ubuntu64_hw", 10:18:59 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:18:59 INFO - "branch": "mozilla-central", 10:18:59 INFO - "repo_path": "mozilla-central", 10:18:59 INFO - "revision": "3461f3cae78495f100a0f7d3d2e0b89292d3ec02", 10:18:59 INFO - "stage_platform": "linux64-pgo", 10:18:59 INFO - "builduid": "b71ac218f8c14983badea0d4759aed2e", 10:18:59 INFO - "slavebuilddir": "test" 10:18:59 INFO - } 10:18:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:18:59 INFO - Running post-action listener: _resource_record_post_action 10:18:59 INFO - ##### 10:18:59 INFO - ##### Finished read-buildbot-config step (success) 10:18:59 INFO - ##### 10:18:59 INFO - ##### 10:18:59 INFO - ##### Running download-and-extract step. 10:18:59 INFO - ##### 10:18:59 INFO - Running pre-action listener: _resource_record_pre_action 10:18:59 INFO - Running main action method: download_and_extract 10:18:59 INFO - mkdir: /builds/slave/test/build/tests 10:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:59 INFO - https://queue.taskcluster.net/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:18:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:18:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:18:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/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 10:18:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/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 10:19:00 INFO - Downloaded 1361 bytes. 10:19:00 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:19:00 INFO - Using the following test package requirements: 10:19:00 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:19:00 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:19:00 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:19:00 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:00 INFO - u'jsshell-linux-x86_64.zip'], 10:19:00 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:19:00 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:19:00 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:19:00 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:19:00 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:19:00 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:19:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:19:00 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:19:00 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')]} 10:19:00 INFO - https://queue.taskcluster.net/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:19:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:19:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:19:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/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 10:19:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/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 10:19:01 INFO - Downloaded 23903248 bytes. 10:19:01 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'] 10:19:01 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 10:19:02 INFO - Return code: 0 10:19:02 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 10:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:02 INFO - https://queue.taskcluster.net/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:19:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:19:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:19:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/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 10:19:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/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 10:19:03 INFO - Downloaded 23903248 bytes. 10:19:03 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'] 10:19:03 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 10:19:05 INFO - Return code: 0 10:19:05 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')]} 10:19:05 INFO - https://queue.taskcluster.net/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:19:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:19:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:19:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/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 10:19:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/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 10:19:06 INFO - Downloaded 10840152 bytes. 10:19:06 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'] 10:19:06 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 10:19:06 INFO - Return code: 0 10:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:06 INFO - https://queue.taskcluster.net/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:19:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:19:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:19:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/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 10:19:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KhQKk_GzRS-RbsL3adoWOQ/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 10:19:07 INFO - Downloaded 58323329 bytes. 10:19:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:19:07 INFO - mkdir: /builds/slave/test/properties 10:19:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:19:07 INFO - Writing to file /builds/slave/test/properties/build_url 10:19:07 INFO - Contents: 10:19:07 INFO - build_url:https://queue.taskcluster.net/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:19:08 INFO - Running post-action listener: _resource_record_post_action 10:19:08 INFO - Running post-action listener: set_extra_try_arguments 10:19:08 INFO - ##### 10:19:08 INFO - ##### Finished download-and-extract step (success) 10:19:08 INFO - ##### 10:19:08 INFO - ##### 10:19:08 INFO - ##### Running populate-webroot step. 10:19:08 INFO - ##### 10:19:08 INFO - Running pre-action listener: _resource_record_pre_action 10:19:08 INFO - Running main action method: populate_webroot 10:19:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:19:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:19:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:19:08 INFO - '--tppagecycles', 10:19:08 INFO - '7'], 10:19:08 INFO - 'tests': ['tsvgm']}}, 10:19:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:19:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:19:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:19:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:19:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:19:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:19:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:08 INFO - 'talos_options': ['--disable-e10s'], 10:19:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:08 INFO - 'talos_options': ['--disable-e10s'], 10:19:08 INFO - 'tests': ['damp', 'tps']}, 10:19:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:08 INFO - 'tests': ['damp', 'tps']}, 10:19:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:19:08 INFO - 'tests': ['dromaeo_dom']}, 10:19:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:19:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:19:08 INFO - 'tests': ['a11yr', 10:19:08 INFO - 'ts_paint', 10:19:08 INFO - 'tpaint', 10:19:08 INFO - 'sessionrestore', 10:19:08 INFO - 'sessionrestore_no_auto_restore', 10:19:08 INFO - 'tabpaint']}, 10:19:08 INFO - 'other-e10s': {'tests': ['a11yr', 10:19:08 INFO - 'ts_paint', 10:19:08 INFO - 'tpaint', 10:19:08 INFO - 'sessionrestore', 10:19:08 INFO - 'sessionrestore_no_auto_restore', 10:19:08 INFO - 'tabpaint']}, 10:19:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:19:08 INFO - 'ts_paint', 10:19:08 INFO - 'tpaint', 10:19:08 INFO - 'sessionrestore', 10:19:08 INFO - 'sessionrestore_no_auto_restore', 10:19:08 INFO - 'tabpaint']}, 10:19:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:19:08 INFO - 'ts_paint', 10:19:08 INFO - 'tpaint', 10:19:08 INFO - 'sessionrestore', 10:19:08 INFO - 'sessionrestore_no_auto_restore', 10:19:08 INFO - 'tabpaint']}, 10:19:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:19:08 INFO - 'tests': ['a11yr', 10:19:08 INFO - 'ts_paint', 10:19:08 INFO - 'tpaint', 10:19:08 INFO - 'sessionrestore', 10:19:08 INFO - 'sessionrestore_no_auto_restore', 10:19:08 INFO - 'tabpaint']}, 10:19:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:19:08 INFO - 'tests': ['a11yr', 10:19:08 INFO - 'ts_paint', 10:19:08 INFO - 'tpaint', 10:19:08 INFO - 'sessionrestore', 10:19:08 INFO - 'sessionrestore_no_auto_restore', 10:19:08 INFO - 'tabpaint']}, 10:19:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:19:08 INFO - 'tests': ['tsvgx', 10:19:08 INFO - 'tsvgr_opacity', 10:19:08 INFO - 'tart', 10:19:08 INFO - 'tscrollx', 10:19:08 INFO - 'cart']}, 10:19:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:19:08 INFO - 'tsvgr_opacity', 10:19:08 INFO - 'tart', 10:19:08 INFO - 'tscrollx', 10:19:08 INFO - 'cart']}, 10:19:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:08 INFO - 'talos_options': ['--disable-e10s'], 10:19:08 INFO - 'tests': ['tp5o']}, 10:19:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:08 INFO - 'tests': ['tp5o']}, 10:19:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:08 INFO - 'talos_options': ['--disable-e10s', 10:19:08 INFO - '--xperf_path', 10:19:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:08 INFO - 'tests': ['tp5n']}, 10:19:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:08 INFO - 'talos_options': ['--xperf_path', 10:19:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:08 INFO - 'tests': ['tp5n']}}, 10:19:08 INFO - 'talos.zip': {'path': '', 10:19:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:19:08 INFO - Running post-action listener: _resource_record_post_action 10:19:08 INFO - ##### 10:19:08 INFO - ##### Finished populate-webroot step (success) 10:19:08 INFO - ##### 10:19:08 INFO - ##### 10:19:08 INFO - ##### Running create-virtualenv step. 10:19:08 INFO - ##### 10:19:08 INFO - Running pre-action listener: _resource_record_pre_action 10:19:08 INFO - Running main action method: create_virtualenv 10:19:08 INFO - Creating virtualenv /builds/slave/test/build/venv 10:19:08 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 10:19:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:19:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:19:08 INFO - Using real prefix '/usr' 10:19:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:19:09 INFO - Installing distribute.............................................................................................................................................................................................done. 10:19:11 INFO - Installing pip.................done. 10:19:11 INFO - Return code: 0 10:19:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:19:11 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')]} 10:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:11 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')]} 10:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:11 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 0x7f319b0a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d31770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc09c0>, '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 0x1dc18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321', '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 10:19:11 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 10:19:11 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 10:19:11 INFO - Using env: {'DISPLAY': ':0', 10:19:11 INFO - 'HOME': '/home/cltbld', 10:19:11 INFO - 'LANG': 'en_US.UTF-8', 10:19:11 INFO - 'LANGUAGE': 'en_US:en', 10:19:11 INFO - 'LOGNAME': 'cltbld', 10:19:11 INFO - 'MAIL': '/var/mail/cltbld', 10:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:11 INFO - 'MOZ_NO_REMOTE': '1', 10:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:11 INFO - 'NO_EM_RESTART': '1', 10:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:11 INFO - 'PWD': '/builds/slave/test', 10:19:11 INFO - 'SHELL': '/bin/bash', 10:19:11 INFO - 'SHLVL': '1', 10:19:11 INFO - 'TERM': 'linux', 10:19:11 INFO - 'TMOUT': '86400', 10:19:11 INFO - 'USER': 'cltbld', 10:19:11 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321', 10:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:11 INFO - '_': '/tools/buildbot/bin/python'} 10:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:11 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 10:19:11 INFO - Cleaning up... 10:19:11 INFO - Return code: 0 10:19:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:19:11 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')]} 10:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:11 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')]} 10:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:11 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f319b0a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d31770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc09c0>, '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 0x1dc18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321', '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 10:19:11 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>=0.7.1'] in /builds/slave/test/build 10:19:11 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>=0.7.1 10:19:11 INFO - Using env: {'DISPLAY': ':0', 10:19:11 INFO - 'HOME': '/home/cltbld', 10:19:11 INFO - 'LANG': 'en_US.UTF-8', 10:19:11 INFO - 'LANGUAGE': 'en_US:en', 10:19:11 INFO - 'LOGNAME': 'cltbld', 10:19:11 INFO - 'MAIL': '/var/mail/cltbld', 10:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:11 INFO - 'MOZ_NO_REMOTE': '1', 10:19:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:11 INFO - 'NO_EM_RESTART': '1', 10:19:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:11 INFO - 'PWD': '/builds/slave/test', 10:19:11 INFO - 'SHELL': '/bin/bash', 10:19:11 INFO - 'SHLVL': '1', 10:19:11 INFO - 'TERM': 'linux', 10:19:11 INFO - 'TMOUT': '86400', 10:19:11 INFO - 'USER': 'cltbld', 10:19:11 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321', 10:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:11 INFO - '_': '/tools/buildbot/bin/python'} 10:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:11 INFO - Downloading/unpacking psutil>=0.7.1 10:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:19:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:13 INFO - Installing collected packages: psutil 10:19:13 INFO - Running setup.py install for psutil 10:19:13 INFO - building 'psutil._psutil_linux' extension 10:19:13 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 10:19:13 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 10:19:13 INFO - building 'psutil._psutil_posix' extension 10:19:13 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 10:19:13 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 10:19:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:13 INFO - Successfully installed psutil 10:19:13 INFO - Cleaning up... 10:19:13 INFO - Return code: 0 10:19:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:13 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f319b0a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d31770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc09c0>, '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 0x1dc18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321', '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 10:19:13 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.0.0'] in /builds/slave/test/build 10:19:13 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.0.0 10:19:13 INFO - Using env: {'DISPLAY': ':0', 10:19:13 INFO - 'HOME': '/home/cltbld', 10:19:13 INFO - 'LANG': 'en_US.UTF-8', 10:19:13 INFO - 'LANGUAGE': 'en_US:en', 10:19:13 INFO - 'LOGNAME': 'cltbld', 10:19:13 INFO - 'MAIL': '/var/mail/cltbld', 10:19:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:13 INFO - 'MOZ_NO_REMOTE': '1', 10:19:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:13 INFO - 'NO_EM_RESTART': '1', 10:19:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:13 INFO - 'PWD': '/builds/slave/test', 10:19:13 INFO - 'SHELL': '/bin/bash', 10:19:13 INFO - 'SHLVL': '1', 10:19:13 INFO - 'TERM': 'linux', 10:19:13 INFO - 'TMOUT': '86400', 10:19:13 INFO - 'USER': 'cltbld', 10:19:13 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321', 10:19:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:13 INFO - '_': '/tools/buildbot/bin/python'} 10:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:19:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:19:16 INFO - Installing collected packages: mozsystemmonitor 10:19:16 INFO - Running setup.py install for mozsystemmonitor 10:19:16 INFO - Successfully installed mozsystemmonitor 10:19:16 INFO - Cleaning up... 10:19:16 INFO - Return code: 0 10:19:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:16 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 0x7f319b0a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d31770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc09c0>, '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 0x1dc18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321', '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 10:19:16 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 10:19:16 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 10:19:16 INFO - Using env: {'DISPLAY': ':0', 10:19:16 INFO - 'HOME': '/home/cltbld', 10:19:16 INFO - 'LANG': 'en_US.UTF-8', 10:19:16 INFO - 'LANGUAGE': 'en_US:en', 10:19:16 INFO - 'LOGNAME': 'cltbld', 10:19:16 INFO - 'MAIL': '/var/mail/cltbld', 10:19:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:16 INFO - 'MOZ_NO_REMOTE': '1', 10:19:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:16 INFO - 'NO_EM_RESTART': '1', 10:19:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:16 INFO - 'PWD': '/builds/slave/test', 10:19:16 INFO - 'SHELL': '/bin/bash', 10:19:16 INFO - 'SHLVL': '1', 10:19:16 INFO - 'TERM': 'linux', 10:19:16 INFO - 'TMOUT': '86400', 10:19:16 INFO - 'USER': 'cltbld', 10:19:16 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321', 10:19:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:16 INFO - '_': '/tools/buildbot/bin/python'} 10:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:16 INFO - Downloading/unpacking blobuploader==1.2.4 10:19:16 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 10:19:16 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 10:19:16 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 10:19:16 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 10:19:16 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 10:19:16 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 10:19:18 INFO - Downloading blobuploader-1.2.4.tar.gz 10:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:19:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:19:18 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 10:19:18 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 10:19:18 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 10:19:18 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 10:19:18 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 10:19:18 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 10:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:19:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:19:18 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 10:19:18 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 10:19:18 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 10:19:18 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 10:19:18 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 10:19:18 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 10:19:18 INFO - Downloading docopt-0.6.1.tar.gz 10:19:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:19:18 INFO - Installing collected packages: blobuploader, requests, docopt 10:19:18 INFO - Running setup.py install for blobuploader 10:19:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:19:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:19:18 INFO - Running setup.py install for requests 10:19:19 INFO - Running setup.py install for docopt 10:19:19 INFO - Successfully installed blobuploader requests docopt 10:19:19 INFO - Cleaning up... 10:19:19 INFO - Return code: 0 10:19:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:19 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 0x7f319b0a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d31770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc09c0>, '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 0x1dc18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321', '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 10:19:19 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 10:19:19 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 10:19:19 INFO - Using env: {'DISPLAY': ':0', 10:19:19 INFO - 'HOME': '/home/cltbld', 10:19:19 INFO - 'LANG': 'en_US.UTF-8', 10:19:19 INFO - 'LANGUAGE': 'en_US:en', 10:19:19 INFO - 'LOGNAME': 'cltbld', 10:19:19 INFO - 'MAIL': '/var/mail/cltbld', 10:19:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:19 INFO - 'MOZ_NO_REMOTE': '1', 10:19:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:19 INFO - 'NO_EM_RESTART': '1', 10:19:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:19 INFO - 'PWD': '/builds/slave/test', 10:19:19 INFO - 'SHELL': '/bin/bash', 10:19:19 INFO - 'SHLVL': '1', 10:19:19 INFO - 'TERM': 'linux', 10:19:19 INFO - 'TMOUT': '86400', 10:19:19 INFO - 'USER': 'cltbld', 10:19:19 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321', 10:19:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:19 INFO - '_': '/tools/buildbot/bin/python'} 10:19:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:19 INFO - Running setup.py (path:/tmp/pip-NaBIkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:19 INFO - Running setup.py (path:/tmp/pip-mYSPnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:19 INFO - Running setup.py (path:/tmp/pip-rwGb0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:19 INFO - Running setup.py (path:/tmp/pip-jS_XgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:19 INFO - Running setup.py (path:/tmp/pip-cUVliB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:19 INFO - Running setup.py (path:/tmp/pip-HX1GBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:19 INFO - Running setup.py (path:/tmp/pip-yCDQb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:20 INFO - Running setup.py (path:/tmp/pip-qHW2eI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:20 INFO - Running setup.py (path:/tmp/pip-PzCYEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:20 INFO - Running setup.py (path:/tmp/pip-XoVdkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:20 INFO - Running setup.py (path:/tmp/pip-XTjAKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:20 INFO - Running setup.py (path:/tmp/pip-VeUYju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:20 INFO - Running setup.py (path:/tmp/pip-uIF1JD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:20 INFO - Running setup.py (path:/tmp/pip-lRqH0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:20 INFO - Running setup.py (path:/tmp/pip-4ydwZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:20 INFO - Running setup.py (path:/tmp/pip-9aOfKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:20 INFO - Running setup.py (path:/tmp/pip-9EE32l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:19:20 INFO - Running setup.py install for manifestparser 10:19:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:19:20 INFO - Running setup.py install for mozcrash 10:19:20 INFO - Running setup.py install for mozdebug 10:19:20 INFO - Running setup.py install for mozdevice 10:19:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:19:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:19:20 INFO - Running setup.py install for mozfile 10:19:21 INFO - Running setup.py install for mozhttpd 10:19:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Running setup.py install for mozinfo 10:19:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Running setup.py install for mozInstall 10:19:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Running setup.py install for mozleak 10:19:21 INFO - Running setup.py install for mozlog 10:19:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Running setup.py install for moznetwork 10:19:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Running setup.py install for mozprocess 10:19:21 INFO - Running setup.py install for mozprofile 10:19:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Running setup.py install for mozrunner 10:19:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Running setup.py install for mozscreenshot 10:19:22 INFO - Running setup.py install for moztest 10:19:22 INFO - Running setup.py install for mozversion 10:19:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:19:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:19:22 INFO - Cleaning up... 10:19:22 INFO - Return code: 0 10:19:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:22 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 0x7f319b0a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d31770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc09c0>, '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 0x1dc18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321', '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 10:19:22 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 10:19:22 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 10:19:22 INFO - Using env: {'DISPLAY': ':0', 10:19:22 INFO - 'HOME': '/home/cltbld', 10:19:22 INFO - 'LANG': 'en_US.UTF-8', 10:19:22 INFO - 'LANGUAGE': 'en_US:en', 10:19:22 INFO - 'LOGNAME': 'cltbld', 10:19:22 INFO - 'MAIL': '/var/mail/cltbld', 10:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:22 INFO - 'MOZ_NO_REMOTE': '1', 10:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:22 INFO - 'NO_EM_RESTART': '1', 10:19:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:22 INFO - 'PWD': '/builds/slave/test', 10:19:22 INFO - 'SHELL': '/bin/bash', 10:19:22 INFO - 'SHLVL': '1', 10:19:22 INFO - 'TERM': 'linux', 10:19:22 INFO - 'TMOUT': '86400', 10:19:22 INFO - 'USER': 'cltbld', 10:19:22 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321', 10:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:22 INFO - '_': '/tools/buildbot/bin/python'} 10:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:22 INFO - Running setup.py (path:/tmp/pip-eftteY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:22 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)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:22 INFO - Running setup.py (path:/tmp/pip-JQwjlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:22 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)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:22 INFO - Running setup.py (path:/tmp/pip-H8BKHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:22 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)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:22 INFO - Running setup.py (path:/tmp/pip-yMHyns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:22 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)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:22 INFO - Running setup.py (path:/tmp/pip-eGC9LT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:22 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)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:22 INFO - Running setup.py (path:/tmp/pip-VBbSGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:22 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)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:22 INFO - Running setup.py (path:/tmp/pip-IkS3ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:22 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)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:22 INFO - Running setup.py (path:/tmp/pip-MhBUQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:22 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)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:22 INFO - Running setup.py (path:/tmp/pip-PhgwBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:22 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)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:22 INFO - Running setup.py (path:/tmp/pip-p2K6lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:23 INFO - Running setup.py (path:/tmp/pip-wlWlYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:23 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)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:23 INFO - Running setup.py (path:/tmp/pip-dWwqn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:23 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)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:23 INFO - Running setup.py (path:/tmp/pip-IVHOgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:23 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)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:23 INFO - Running setup.py (path:/tmp/pip-03Heva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:23 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)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:23 INFO - Running setup.py (path:/tmp/pip-EQnYnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:23 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)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:23 INFO - Running setup.py (path:/tmp/pip-fa9AAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:23 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)) 10:19:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:23 INFO - Running setup.py (path:/tmp/pip-ndqSZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:23 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)) 10:19:23 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)) 10:19:23 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)) 10:19:23 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)) 10:19:23 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)) 10:19:23 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)) 10:19:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:19:23 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 10:19:23 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 10:19:23 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 10:19:23 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 10:19:23 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 10:19:23 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 10:19:25 INFO - Downloading blessings-1.6.tar.gz 10:19:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:19:25 INFO - Installing collected packages: blessings 10:19:25 INFO - Running setup.py install for blessings 10:19:25 INFO - Successfully installed blessings 10:19:25 INFO - Cleaning up... 10:19:25 INFO - Return code: 0 10:19:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:19:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:19:25 INFO - Reading from file tmpfile_stdout 10:19:25 INFO - Current package versions: 10:19:25 INFO - argparse == 1.2.1 10:19:25 INFO - blessings == 1.6 10:19:25 INFO - blobuploader == 1.2.4 10:19:25 INFO - docopt == 0.6.1 10:19:25 INFO - manifestparser == 1.1 10:19:25 INFO - mozInstall == 1.12 10:19:25 INFO - mozcrash == 0.17 10:19:25 INFO - mozdebug == 0.1 10:19:25 INFO - mozdevice == 0.48 10:19:25 INFO - mozfile == 1.2 10:19:25 INFO - mozhttpd == 0.7 10:19:25 INFO - mozinfo == 0.9 10:19:25 INFO - mozleak == 0.1 10:19:25 INFO - mozlog == 3.1 10:19:25 INFO - moznetwork == 0.27 10:19:25 INFO - mozprocess == 0.22 10:19:25 INFO - mozprofile == 0.28 10:19:25 INFO - mozrunner == 6.11 10:19:25 INFO - mozscreenshot == 0.1 10:19:25 INFO - mozsystemmonitor == 0.0 10:19:25 INFO - moztest == 0.7 10:19:25 INFO - mozversion == 1.4 10:19:25 INFO - psutil == 3.1.1 10:19:25 INFO - requests == 1.2.3 10:19:25 INFO - wsgiref == 0.1.2 10:19:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:25 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 0x7f319b0a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d31770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc09c0>, '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 0x1dc18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321', '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 10:19:25 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 10:19:25 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 10:19:25 INFO - Using env: {'DISPLAY': ':0', 10:19:25 INFO - 'HOME': '/home/cltbld', 10:19:25 INFO - 'LANG': 'en_US.UTF-8', 10:19:25 INFO - 'LANGUAGE': 'en_US:en', 10:19:25 INFO - 'LOGNAME': 'cltbld', 10:19:25 INFO - 'MAIL': '/var/mail/cltbld', 10:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:25 INFO - 'MOZ_NO_REMOTE': '1', 10:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:25 INFO - 'NO_EM_RESTART': '1', 10:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:25 INFO - 'PWD': '/builds/slave/test', 10:19:25 INFO - 'SHELL': '/bin/bash', 10:19:25 INFO - 'SHLVL': '1', 10:19:25 INFO - 'TERM': 'linux', 10:19:25 INFO - 'TMOUT': '86400', 10:19:25 INFO - 'USER': 'cltbld', 10:19:25 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321', 10:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:25 INFO - '_': '/tools/buildbot/bin/python'} 10:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:25 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)) 10:19:25 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)) 10:19:25 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)) 10:19:25 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)) 10:19:25 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)) 10:19:25 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)) 10:19:25 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)) 10:19:25 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)) 10:19:25 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)) 10:19:25 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)) 10:19:25 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)) 10:19:25 INFO - Cleaning up... 10:19:25 INFO - Return code: 0 10:19:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:25 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 0x7f319b0a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d31770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc09c0>, '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 0x1dc18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321', '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 10:19:25 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 10:19:25 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 10:19:25 INFO - Using env: {'DISPLAY': ':0', 10:19:25 INFO - 'HOME': '/home/cltbld', 10:19:25 INFO - 'LANG': 'en_US.UTF-8', 10:19:25 INFO - 'LANGUAGE': 'en_US:en', 10:19:25 INFO - 'LOGNAME': 'cltbld', 10:19:25 INFO - 'MAIL': '/var/mail/cltbld', 10:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:25 INFO - 'MOZ_NO_REMOTE': '1', 10:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:25 INFO - 'NO_EM_RESTART': '1', 10:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:25 INFO - 'PWD': '/builds/slave/test', 10:19:25 INFO - 'SHELL': '/bin/bash', 10:19:25 INFO - 'SHLVL': '1', 10:19:25 INFO - 'TERM': 'linux', 10:19:25 INFO - 'TMOUT': '86400', 10:19:25 INFO - 'USER': 'cltbld', 10:19:25 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321', 10:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:25 INFO - '_': '/tools/buildbot/bin/python'} 10:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:26 INFO - Downloading/unpacking jsonschema 10:19:26 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 10:19:26 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 10:19:26 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 10:19:26 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 10:19:26 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 10:19:26 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 10:19:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:19:27 INFO - Downloading/unpacking functools32 (from jsonschema) 10:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:28 INFO - Downloading functools32-3.2.3-2.tar.gz 10:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:19:28 INFO - warning: no files found matching '*.txt' 10:19:28 INFO - no previously-included directories found matching 'build' 10:19:28 INFO - no previously-included directories found matching 'dist' 10:19:28 INFO - no previously-included directories found matching '.git*' 10:19:28 INFO - Installing collected packages: jsonschema, functools32 10:19:28 INFO - Running setup.py install for functools32 10:19:28 INFO - warning: no files found matching '*.txt' 10:19:28 INFO - no previously-included directories found matching 'build' 10:19:28 INFO - no previously-included directories found matching 'dist' 10:19:28 INFO - no previously-included directories found matching '.git*' 10:19:28 INFO - Successfully installed jsonschema functools32 10:19:28 INFO - Cleaning up... 10:19:28 INFO - Return code: 0 10:19:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:19:28 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')]} 10:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:28 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')]} 10:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:28 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 0x7f319b0a2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d31770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc09c0>, '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 0x1dc18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1d50>, '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': '7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321', '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 10:19:28 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 10:19:28 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 10:19:28 INFO - Using env: {'DISPLAY': ':0', 10:19:28 INFO - 'HOME': '/home/cltbld', 10:19:28 INFO - 'LANG': 'en_US.UTF-8', 10:19:28 INFO - 'LANGUAGE': 'en_US:en', 10:19:28 INFO - 'LOGNAME': 'cltbld', 10:19:28 INFO - 'MAIL': '/var/mail/cltbld', 10:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:28 INFO - 'MOZ_NO_REMOTE': '1', 10:19:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:28 INFO - 'NO_EM_RESTART': '1', 10:19:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:28 INFO - 'PWD': '/builds/slave/test', 10:19:28 INFO - 'SHELL': '/bin/bash', 10:19:28 INFO - 'SHLVL': '1', 10:19:28 INFO - 'TERM': 'linux', 10:19:28 INFO - 'TMOUT': '86400', 10:19:28 INFO - 'USER': 'cltbld', 10:19:28 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321', 10:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:28 INFO - '_': '/tools/buildbot/bin/python'} 10:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:28 INFO - Downloading/unpacking flake8 10:19:28 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 10:19:28 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 10:19:28 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 10:19:28 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 10:19:28 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 10:19:28 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 10:19:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:19:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:19:30 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 10:19:30 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 10:19:30 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 10:19:30 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 10:19:30 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 10:19:30 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 10:19:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:19:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:19:30 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 10:19:30 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 10:19:30 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 10:19:30 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 10:19:30 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 10:19:30 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 10:19:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:19:30 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 10:19:30 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 10:19:30 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 10:19:30 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 10:19:30 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 10:19:30 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 10:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:19:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:19:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:19:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:19:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:19:31 INFO - no previously-included directories found matching 'docs/_build' 10:19:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:19:31 INFO - Running setup.py install for pep8 10:19:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:19:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:19:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:19:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:19:31 INFO - no previously-included directories found matching 'docs/_build' 10:19:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:19:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:19:31 INFO - Cleaning up... 10:19:31 INFO - Return code: 0 10:19:31 INFO - Running post-action listener: _resource_record_post_action 10:19:31 INFO - Running post-action listener: _start_resource_monitoring 10:19:31 INFO - Starting resource monitoring. 10:19:31 INFO - ##### 10:19:31 INFO - ##### Finished create-virtualenv step (success) 10:19:31 INFO - ##### 10:19:31 INFO - ##### 10:19:31 INFO - ##### Running install step. 10:19:31 INFO - ##### 10:19:31 INFO - Running pre-action listener: _resource_record_pre_action 10:19:31 INFO - Running main action method: install 10:19:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:19:31 INFO - Reading from file tmpfile_stdout 10:19:31 INFO - Detecting whether we're running mozinstall >=1.0... 10:19:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:19:31 INFO - Reading from file tmpfile_stdout 10:19:31 INFO - Output received: 10:19:31 INFO - Usage: mozinstall [options] installer 10:19:31 INFO - Options: 10:19:31 INFO - -h, --help show this help message and exit 10:19:31 INFO - -d DEST, --destination=DEST 10:19:31 INFO - Directory to install application into. [default: 10:19:31 INFO - "/builds/slave/test"] 10:19:31 INFO - --app=APP Application being installed. [default: firefox] 10:19:31 INFO - mkdir: /builds/slave/test/build/application 10:19:31 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'] 10:19:31 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 10:19:48 INFO - Reading from file tmpfile_stdout 10:19:48 INFO - Output received: 10:19:48 INFO - /builds/slave/test/build/application/firefox/firefox 10:19:48 INFO - Running post-action listener: _resource_record_post_action 10:19:48 INFO - ##### 10:19:48 INFO - ##### Finished install step (success) 10:19:48 INFO - ##### 10:19:48 INFO - ##### 10:19:48 INFO - ##### Running run-tests step. 10:19:48 INFO - ##### 10:19:48 INFO - Running pre-action listener: _resource_record_pre_action 10:19:48 INFO - Running main action method: run_tests 10:19:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:19:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:19:48 INFO - Python 2.7.3 10:19:48 INFO - Return code: 0 10:19:48 INFO - grabbing minidump binary from tooltool 10:19:48 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')]} 10:19:48 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 0x1dc09c0>, '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 0x1dc18c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dc1d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:19:48 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 10:19:48 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 10:19:48 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 10:19:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:19:48 INFO - Return code: 0 10:19:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:19:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:19:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:19:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:19:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:19:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:19:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:19:49 INFO - Return code: 0 10:19:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:19:49 INFO - Using env: {'DISPLAY': ':0', 10:19:49 INFO - 'HOME': '/home/cltbld', 10:19:49 INFO - 'LANG': 'en_US.UTF-8', 10:19:49 INFO - 'LANGUAGE': 'en_US:en', 10:19:49 INFO - 'LOGNAME': 'cltbld', 10:19:49 INFO - 'MAIL': '/var/mail/cltbld', 10:19:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:19:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:49 INFO - 'MOZ_NO_REMOTE': '1', 10:19:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:49 INFO - 'NO_EM_RESTART': '1', 10:19:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:49 INFO - 'PWD': '/builds/slave/test', 10:19:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:19:49 INFO - 'SHELL': '/bin/bash', 10:19:49 INFO - 'SHLVL': '1', 10:19:49 INFO - 'TERM': 'linux', 10:19:49 INFO - 'TMOUT': '86400', 10:19:49 INFO - 'USER': 'cltbld', 10:19:49 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321', 10:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:49 INFO - '_': '/tools/buildbot/bin/python'} 10:19:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:19:49 INFO - mozversion application_buildid: 20160511073009 10:19:49 INFO - mozversion application_changeset: 3461f3cae78495f100a0f7d3d2e0b89292d3ec02 10:19:49 INFO - mozversion application_display_name: Nightly 10:19:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:19:49 INFO - mozversion application_name: Firefox 10:19:49 INFO - mozversion application_remotingname: firefox 10:19:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:19:49 INFO - mozversion application_vendor: Mozilla 10:19:49 INFO - mozversion application_version: 49.0a1 10:19:49 INFO - mozversion platform_buildid: 20160511073009 10:19:49 INFO - mozversion platform_changeset: 3461f3cae78495f100a0f7d3d2e0b89292d3ec02 10:19:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:19:49 INFO - mozversion platform_version: 49.0a1 10:19:49 INFO - using testdate: 1462987189 10:19:49 INFO - actual date: 1462987189 10:19:49 INFO - starting webserver on 'localhost:42529' 10:19:49 INFO - SUITE-START | Running 2 tests 10:19:49 INFO - TEST-START | dromaeo_css 10:19:49 INFO - operating with platform_type : linux_ 10:19:49 INFO - Initialising browser for dromaeo_css test... 10:19:49 INFO - TEST-INFO | started process 3203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9YfNNt/profile http://localhost:42529/getInfo.html) 10:19:52 INFO - PROCESS | 3203 | 10:19:52 INFO - PROCESS | 3203 | (process:3269): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:19:53 INFO - PROCESS | 3203 | __metrics Screen width/height:1600/1200 10:19:53 INFO - PROCESS | 3203 | colorDepth:24 10:19:53 INFO - PROCESS | 3203 | Browser inner width/height: 1024/697 10:19:53 INFO - PROCESS | 3203 | __metrics 10:19:53 ERROR - PROCESS | 3203 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 10:19:54 INFO - TEST-INFO | 3203: exit 0 10:19:54 INFO - Browser initialized. 10:19:54 INFO - Running cycle 1/1 for dromaeo_css test... 10:19:54 INFO - TEST-INFO | started process 3320 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9YfNNt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:19:56 INFO - PROCESS | 3320 | 10:19:56 INFO - PROCESS | 3320 | (process:3380): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:20:06 INFO - PROCESS | 3320 | RSS: Main: 162525184 10:20:06 INFO - PROCESS | 3320 | 10:20:55 INFO - PROCESS | 3320 | 1462987255679 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] 10:23:02 INFO - PROCESS | 3320 | Cycle 1(1): loaded http://localhost:42529/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42529/tests/dromaeo/cssquery-ext.html) 10:23:03 INFO - PROCESS | 3320 | RSS: Main: 165064704 10:23:03 INFO - PROCESS | 3320 | 10:26:05 INFO - PROCESS | 3320 | Cycle 1(1): loaded http://localhost:42529/tests/dromaeo/cssquery-ext.html (next: http://localhost:42529/tests/dromaeo/cssquery-jquery.html) 10:26:06 INFO - PROCESS | 3320 | RSS: Main: 165851136 10:26:06 INFO - PROCESS | 3320 | 10:29:08 INFO - PROCESS | 3320 | Cycle 1(1): loaded http://localhost:42529/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42529/tests/dromaeo/cssquery-mootools.html) 10:29:08 INFO - PROCESS | 3320 | RSS: Main: 166993920 10:29:08 INFO - PROCESS | 3320 | 10:32:10 INFO - PROCESS | 3320 | Cycle 1(1): loaded http://localhost:42529/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42529/tests/dromaeo/cssquery-prototype.html) 10:32:11 INFO - PROCESS | 3320 | RSS: Main: 164868096 10:32:11 INFO - PROCESS | 3320 | 10:35:13 INFO - PROCESS | 3320 | Cycle 1(1): loaded http://localhost:42529/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42529/tests/dromaeo/cssquery-yui.html) 10:35:14 INFO - PROCESS | 3320 | RSS: Main: 165781504 10:35:14 INFO - PROCESS | 3320 | 10:38:16 INFO - PROCESS | 3320 | Cycle 1(1): loaded http://localhost:42529/tests/dromaeo/cssquery-yui.html (next: http://localhost:42529/tests/dromaeo/cssquery-dojo.html) 10:38:16 INFO - PROCESS | 3320 | RSS: Main: 167780352 10:38:16 INFO - PROCESS | 3320 | 10:38:16 INFO - PROCESS | 3320 | __start_tp_report 10:38:16 INFO - PROCESS | 3320 | _x_x_mozilla_page_load 10:38:16 INFO - PROCESS | 3320 | _x_x_mozilla_page_load_details 10:38:16 INFO - PROCESS | 3320 | |i|pagename|runs| 10:38:16 INFO - PROCESS | 3320 | |0;dojo.html;3090.969090309097;3098.4113018526464;3124.9843750781256;3132.169974956637;3138.1213260287113;5205.583553315731;5209.8176563820225;5267.683938963665;5284.154535274357;5288.627204218921;4833.154198015342;5026.9443416882405;5133.204353325241;5185.922211166836;5224.111900976834;4642.117997580457;4717.9056418871605;4796.256580230052;4835.323054772317;4837.371141751567;873.1506184816878;4655.930161047587;4725.243960966246;4748.192807222763;4773.856784296477;4643.233866412021;4655.162070827249;4657.3246879202325;4674.69614475058;4719.221328480797;4506.977465112686;4645.187092258875;4650.209464391061;4654.650901182425;4700.1539722849875;4566.840160594364;4579.954200457986;4596.54034596541;4608.654350923694;4615.723056616614;5006.324146240284;5016.523430274118;5118.539331460149;5122.795088196468;5124.564412024945;5430.619856610039;5457.8265672880525;5462.481064298885;5481.862953426156;5484.862878428032;5540.473655002808;5542.168674698787;5542.695151766651;5544.390117087117;5549.500544950974;5089.058524173003;5161.66449180802;5205.635605507616;5208.635395522315;5245.659032162897;5382.058139825514;5569.164625306155;5591.804286850022;5628.352739435018;5634.4786907534735;5436.646617969898;5439.836804895859;5442.591805614595;5472.945270547323;5501.779928802803;5495.642783219078;5520.392756796749;5523.116301391758;5542.196381524656;5586.52514536269;5324.760385782572;5403.891922161535;5435.402105768362;5451.918221226685;5501.559875209973;5392.299001129828;5414.675119492843;5429.1856221566295;5470.124780035176;5510.641808282448;4131.50421949368;4179.958200418017;4203;4205.684573656927;4245.448091748053;3672.026912868092;3696.3900956341904;3718.0704823794053;3735.5517337919623;3744.7378683491893;5227.60792940531;5247.1866860636665;5256.448072952285;5273.050850846885;5273.630845840831;5422.6475279106735;5480.890382192413;5483.095289277225;5505.917411238835;5571.693556854331;5243.947560524422;5313.760880760375;5316.229146773696;5332.066888294533;5339.359276886798;4649.5350464953235;4665.6734028617675;4681.976590117028;4702.059588082398;4709.599684026896;5591.245181900473;5617.101263797773;5754.913676294859;5757.9424205757405;5793.275840519935;5506.944930550723;5521.089020311603;5529.944700552943;5587.664740115606;5616.017196990429;5659.292588426447;5705.486506214461;5717.7141142941855;5734.942650573441;5771.624844385102;5344.545713614386;5348.465153484776;5391.19132130168;5460.126379779216;5466.4260252674485;5449.782008719607;5455.645383050089;5458.208559758892;5464.28964234647;5466.890662186814;5311.256424100707;5342.545883599938;5345.839624811262;5352.0366334060245;5356.089464790917;5237.135872581134;5342.332208473941;5394.703291319015;5400.83797486076;5422.783088676409;5170.017696637627;5179.171332586768;5212.218167274787;5215.982883337864;5289.6297259193025;5335.706536140549;5386.326709161355;5394.1099718546;5460.672359658433;5553.222548843246;5441.020616289106;5444.373897001737;5447.237386765777;5458.263134476795;5476.041692703681 10:38:16 INFO - PROCESS | 3320 | |1;ext.html;556.3879732294474;592.8754961458094;612.2163630552891;613.5398451161627;636.1253276744476;31406.371872562537;43129.78435107824;43633.34549981753;44073;44282.33576496355;43028.13943721123;43492.3476147858;43531.56468435315;43789.34315985263;43933.78033109838;8535.78660533487;8688.826223475528;8704.477731336108;8756.781080473007;8757.51833649149;8606.956965215166;8694.826103477926;8742.606582703762;8743.519106449143;8811.559422028906;8818.470891746483;8873.157050080232;8877.556122193897;8884.378093533454;8920.8661870072;8724;8734;8819.823603527957;8842.911570884273;8901.332400069989;8696.130386961317;8749.693760718408;8770.210681038738;8783.209511143963;8815.955920220358;40507;40735.18529629391;40773.38839917404;40891.7955410224;40930.38604420936;3470.1845066409373;3559.76861504004;3582.6417358264225;3592.497050412944;3647.051766540692;30595.847020764977;30755.538666920012;31160.688393116234;31480.685193148234;31876;4077.184563087365;4256.5105012923605;4296.806643701041;4297.892552686208;4419.977900110511;290519;292012;292615;292803.53598232084;292960;30917.536236956465;31165.376692466023;31199.908003219778;31256.062318130036;55736.442635573934;36430.81784591113;36636.450453243226;36639.43523953351;36688;36691.4496282556;15738.68522629541;15747.370105195892;15806.288717007763;15819.288132034086;15917.761233581505;13186.945044396425;13435;13482.595522134352;13496.325183740773;13774.724505509834;8491.108433614505;8498.660053597787;8514.787130321667;8520.786980325418;8570.614322355508;3311.106001379614;3335.366280406715;3341.6658334166873;3351.681590248971;3370.191154122993;1146.7419830538229;1188.9346085965183;1190.2441949362217;1202.4048096192266;1249.2941488059218;30940.845295773375;31592.842035789676;31657.52513712296;32074.03777886667;32345.51481727776;1114.1254115519278;1120.78705046041;1179.8820117988132;1183.8697743248235;1256.108163204117;16636.50090497287;16681.91659041721;16840.915795420944;16866.578335541708;16918.06950617703;457346;457547;460304;462608;464435;55778.44221557733;56571;56771.716141419856;56848.715756420956;57041;1359.3882752761297;1388.0630574362265;1391.387789372693;1395.8953078519153;1401.7967394727707;29942.101736947927;30196;30796.23009424782;31067.533986990664;31190.532142017433;50669.493305067954;50687;51067.744661276454;51137.232941505164;51515.74242128765;359876;361342;361406;361629;362641.18679406436;27883.44233115286;27885.58171627468;28269.293267668472;28879.5668064975;29031.274218144714;47337.52662473331;47830.760846195546;47893.76053119712;48012.03975920532;48358.27462588134;39313.80343098266;39375.40936885892;39651.60348396595;40548.79725601353;40874.79562602287;37174.25651487009;39565.021748913015;40395.1920961585;42647.36028959506;43019.78490107529;38531;41374.37938430986;41465.58534414738;41575.7921210392;42171;33965;35747;35769.55805586435;35797;35859.82070089633;28057.43885122327;28088.578671319538;28271.434571308047;28425.573616395355;28455.715442846136 10:38:16 INFO - PROCESS | 3320 | |2;jquery.html;404.7126540156489;405.4040560376247;409.4104489535071;411.3788179848428;420.625643177572;14818.629534261649;17641.7353739694;18351.816481835176;19237.23051077955;19274.71087933682;18043;18185.818141818578;18280.542986425346;18815.529611759714;18861.962592057433;5608.270924779783;5610.709536806537;5776.826695199151;5778.191053252548;5811.418858114176;5614.326280846304;5691.943080569204;5693.829185124432;5719.170720245562;5735.2544169257935;5574.804881829137;5617.558228055956;5754.539636829065;5764.135379693059;5800.042992906166;5504.091824848895;5679.318481782192;5684.261046064026;5692.174634677948;5773.364929857712;5108.233764935289;5128.538431541142;5129.5383415492415;5146.897062058775;5164.690118592859;21115.26096586612;21546.461338466663;21756.564868702695;22864.199753008732;23241;721.7185297733888;2379.7263314718684;2449.4892734946643;2508.611165269386;2685.2481305234564;13810.102343347751;14387.496437624633;14484;14495.71008579833;14553;1904.7142928560688;1947.1724517080327;1994.0627904884682;2015.506200980769;2068.1830676882696;69532;81309.59345203236;82422.58788706078;82654;83805;10950.178736594788;11030.889691103146;11044.723881902855;11152;11164.330140191614;13792.655183620489;14130.788038179435;15491.612709682122;15565;15584.532464026097;7757.844843103219;8027.759167224993;8259.339252859756;8260.215279548433;8326.875096873551;7823.530588164728;7847;7866.881996770053;7867.6066196689935;7958.08482024563;4660.487346391894;4755.500672429414;4781.924067084948;4786.880327991758;4809.567138957511;1982.3260091568936;1999.0904138616895;2010.9095090720953;2043.1316690406518;2062.6176765835485;953.9809203816023;1008.6973907827769;1081.7944590527775;1115.6890653482126;1131.7000994736402;18324;18369.54076148107;18406.26374944987;18534.25862965493;18639.720404193948;972.0765272990687;989.223459584223;1023.4575674892319;1041.5625437316346;1075.93544387337;9169.312301577409;10283.023112804272;10409.42748148859;10514.369137851754;10581.947090264654;442518;443722;446264;457891;468718;88585.55707221423;94842.52578737063;95880;96237.51881240548;97147;988.7379844341256;992.8659630949874;1001.4041645221082;1024.666983230453;1025.733309339577;16026.679466410373;16261.024338539726;16389;16399.344026239294;16467.917660412102;26777;35683;36287.27425451529;37371;38191.618083819914;46336.30495542637;50655.49344506655;50778.49221507738;50784.74607626938;51161;8149.225823546753;8166.918330816853;8251.711190108317;8257.628406721831;8338.29124524398;9280.071992800937;12123.696907577381;12668;12791.296478693761;12975.416106275052;10703.464826758787;11088.223824332219;11136.665900023012;11154.051905587792;11217.775644486901;10845.891541084804;11121.388323642277;11236.325820450798;11281.661550153509;11354.26197297173;11451.370174640475;11467.139964502529;11478.368689721812;11487.31076135401;11556.248843825124;8179.222973817477;8195.918040819515;8256.669733210605;8303.95848020756;8594.957025214833;8472.83054338922;11025;11062.612808551663;11168.162387820783;11177.720556985814 10:38:16 INFO - PROCESS | 3320 | |3;mootools.html;1458.4385011770469;1519.4757808556049;1659.8506134447898;1841.8526517878572;1844.3452574336102;7900.960495197516;8425.789355266113;8449.112843151457;8963.59663815129;8981.326400519963;8790.472571645705;8815.515146666947;8840.160184782435;8860.113988601153;8863.157999989991;2110.4196346004856;2154.170644301947;2155.81675557577;2168.772278910715;2177.9782202177935;2223.6442169252923;2261.6607508873635;2280.099360752502;2289.816814654832;2300.4248937765474;2056.9588608227828;2060.7527096748413;2069.4102180878454;2135.6582946728527;2249.651304047867;2141.518158414352;2142.45367431304;2143.3677065265706;2152.591007708538;2156.8382371322054;2155.5150091229507;2189.3431970408815;2204.8236141108673;2208.094681180708;2209.414505156135;8764.737057888273;8795.208431241219;8804.251638610725;8829.955850220707;8923.286137109015;4863.951360486385;5142.717150556718;5149.407818100929;5164;5172.456892026321;3233.094733474631;3262.1029216965285;3360.882369117069;3383.8984830455124;3385.6783605557434;2076.3355726167633;2143.174877672092;2172.8044475997076;2232.7655596162494;2242.843000989931;11285.887141128565;11570.884291157065;11596.59411920587;11884;11979.880201197964;4349.782510874444;4464.17412778637;4472.619827314715;4513.88715282114;4515.1195516873895;8956.8656470153;9034.548272586344;9040.367174297737;9041;9061.728148155566;5030.119729047402;5056.469070747592;5079.6952182869145;5119.744012799345;5195.740212989411;4300.956990430118;4548.88627784308;4686.554777296152;4696.459907110658;4753.215719406328;3621.5473065866768;3666.816659167031;3710.313591985437;3738.2149748552565;3748.7938163401277;1078.320657985464;1079.2121751121567;1082.0640146273417;1083.2525557365393;1083.631565267797;814.8207394373347;928.3594319919234;938.6339327662217;945.2768631996528;967.7387105481621;5513.42109078549;5635.5773317001385;5674.716264186774;5842.269716285465;5878.323992740804;936.0265324062898;939.2110627073291;956.516958935733;973.7711637765119;980.4852452462515;3690.8154592270816;3775.7734535927934;3840.1551658635058;3864.8260828262796;3936.3701807710627;10398.948005259925;10872.075873550679;10882.183836212158;10885.619003334845;10968.835467467994;10790.460476976119;10869.184811139037;10904.34573925567;10990.450477476094;11013.504392302366;7769.72805951789;8152.959235203904;8160.551169685606;8300.169983001771;8329.167083291622;5538;5607.327120745536;5711.428857114255;5735.3977832327;5749.54003679713;9568.473733944422;9805.70582882486;9980.850287245843;10061.496925153566;10181.490925453549;10125.544350504098;10286.845697314697;10385.013423724735;10524.842127367943;10657.626983055556;6879.484038697017;7051.048108505492;7217.963910180415;7594.354479869273;7725;8279.089300176855;8310.376721746014;8320;8332.541710205996;8391.916080839357;7312.926870731438;7484.812879677834;7561.130469996021;7563.016807814949;7580.696772129053;7464.850702986018;7480.70077196906;7518.774436766906;7726.0342457192855;7871.803204919923;6747.190337159573;6825.692843822139;6831.9316806833285;6854.554453960476;6857.897131543131;4451.065276292015;4517.164324599959;4527.728336299832;4582.587567118975;4622.514635963175;5096.541311282002;5106.361704786902;5136.743162841918;5163.432022477449;5234.795996920653 10:38:16 INFO - PROCESS | 3320 | |4;prototype.html;334.63691894294686;342.47088248655814;342.729243897321;348.8796365253988;349.93351263259996;5359.437259087788;5381.062817385743;5477.288742072675;5504.834854954358;5512.862178445541;5383;5410.187587158297;5418.566514678826;5427.45725427458;5446.2919820423385;4014.53832809227;4073.877783666495;4177.498700155986;4211.157768446307;4231.3920710130105;4203.390508376284;4212.53662097169;4222.831086756526;4231.132617813356;4239.724417912841;4128.587141285862;4145.170965806836;4148.02521407469;4157.542670306264;4193.874183774492;4068.6338229559333;4155.8753237402925;4170.47869016373;4185.204811085884;4233.6824738144605;3683.5395575553057;3697.0757310672334;3698.0939669780805;3708.35103856824;3717.4795528626014;5135.764468384894;5159.974200129013;5180.8963820723375;5223.895522089537;5230.21546767984;4753.714777113384;4788.449328327252;4818.927716084261;4827.444843842933;4837.177679794443;5636.013697602903;5662.518685911702;5673.602847800656;5680.772769089232;5712.285964254468;4039.6368124647115;4049.5950404959563;4054.817533210983;4092.5088989321175;4094.263032654121;5566.582506312043;5807.89649966505;5832.212651292106;5879.617824841372;5929.080992446177;4117.444145040381;4119.423280740699;4123.402106694512;4164.4586203793315;4168.041350489404;4191.832326706897;4213.1784302060805;4242.7242229255;4251.4685664291965;4261.339492378686;4706.1764191267075;4829.541193586604;4831;4844.006978569455;4853.781579828917;5608.270924779753;5686.118651609007;5690.2033715279895;5719.685417302005;5749.885002300014;1432.2838580709645;1442.920639364845;1448.9710205795825;1457.8118833150947;1461.2328527523136;916.5060950650397;946.7349142240046;949.2311227905419;955.8386560329234;1013.9138173255355;5330.786768529216;5387.81142660005;5389.299391079135;5394.595405344615;5425.83722488326;5670.489655930904;5715.657060576379;5723.313202415737;5754.367019627837;5764.135379692996;5262;5336.893262134813;5459.454054594588;5537.477193771664;5629.493345598916;3094.5919606578955;3145.370925814846;3156.1478400831647;3167.904962851118;3170.4927211646027;5797.420257974169;6109;6111.388861113853;6147.125126836358;6157.815265541952;5996.190514280604;6019.819405417845;6022.440462803291;6092.7562897484495;6099.75600975956;6139.877202455926;6142.600730952563;6159.692015399212;6160.661163635953;6167.814965551041;5574.303212098488;5841.240638716939;5894.882102358015;5898.557608179318;5961.493273071837;5830.387809279964;5835.9708201458725;5842.444967728059;5889.352171261072;5927.7036148191555;5733.885322293448;6028.638281703112;6078.574499784972;6111.84720381994;6146.078088286793;4092.897677557966;4115.1975364803575;4117.8970525737095;4128.814203360916;4134.565870583546;5840.532757379315;5865.3254875689845;5890.4993075589055;5897.9115313271195;5943.64338139713;5655.123455864347;5678.716064196857;5744.368119506935;5754.741036653277;5775.884482310246;5662.292213473316;5731.653061530454;5755.683437410982;5784.553861534617;5785.334686511105;5258.632755483525;5384.792235183556;5504.339479262514;5572.804951826666;5611.607187496836;5638.323401191883;5699.7435115419075;5715.914261286167;5757.539396848326;5799.8550036249435;5624.409437009055;5658.575606829587;5660.632058916157;5662.150677398423;5683.857903552444 10:38:16 INFO - PROCESS | 3320 | |5;yui.html;654.9574277671954;677.0994577212305;742.6620887496188;760.1410406240947;763.1605234242334;13295.734085318289;14140.363683634236;14177.929110354447;14181.2200328982;14232.501862434818;13494.122882012662;13500.72998540031;13510.662233444169;13538.323083845817;13569.52506662267;658.1312667279193;786.0528063683277;798.078219656295;824.1428913929506;826.4917075998278;806.1575653442167;809.4010432280129;811.3306522119245;814.5601375257384;816.3713940265992;859.4499520306978;859.5358506406533;863.0851297624507;865.2991077227434;871.6034204436966;855.9400841941067;857.4726543175933;857.4812238595654;859.1709000814213;859.6733241368303;626.9216347956506;626.9905951410733;628.2900322635438;628.3151365012159;630.8990561510136;13350.19898806065;13385.129966552144;13448.596542103753;13522.459101635923;13568.525101621395;12595.496180152782;12712.682182945407;12715.554955576603;13044.956403487793;13455.461781528826;10498.107660848837;10597.788044239072;10713;10773.084287835543;10919.617813376493;3769.4722738816313;3809.4095415210686;3831.1379939513663;3833.137544052594;3892.4550562921213;51253.231201532006;53754.46245537534;54137.187942180506;54185.1872221917;54364.18453723197;10711.73220669474;11079.50142243585;11151.665450036511;11244.156688248415;11461.083113350913;18597.25610975573;18802.52993675169;18938.053097345353;18964.14661340243;19053.80946190548;7758.68965241384;7760.417968652261;7817.843643127106;8228.711995080144;8377.874331885027;4576.931346029813;4651.279051746985;4710.505396933273;4762.618990480753;4764.094821983812;3300.7029367357054;3411.9658803412144;3415.8292085395633;3425.9828700856833;3431.4166591679473;606.7148440233084;617.8671585609115;618.0111821086316;620.2742790934617;623.3672822085587;592.2064433658918;657.1555551116887;658.6706646676662;664.524755043802;666.1440049536322;8264.669413223524;8383.245507904317;8690.695825646071;8751.912480875237;8913.643454261757;498.6982875360427;504.23104765233313;549.5109352676121;609.8597322615734;627.0813258576208;4162.313218318944;4234.3860140279485;4238.915221695549;4270.658347332206;4362.520122786491;61900.38099619036;62486.68756656188;63664;63863;64586.677066614364;55075.17387239195;55830;56068;57282.140767888515;59516;49758.25362619491;49797.75101124471;50066.24900626494;50460.74769626055;50877;8067.354611631173;8336.249737523653;8337.166283371856;8340.958295208486;8420.536870471939;32334;33003.504947425325;33743.15642108967;33902.98291051272;33998.49002264919;40900.38649420321;41223.58776412318;42300.78849605732;42585.361219581115;43425.782871085445;11172.553097875994;11375.31748095117;11928.343941082976;12264.877351226374;12319.507219711111;12242.816357754818;12816.6795830105;12893.226406415644;13000.95992320631;13012.154209976321;12477.812832807334;12524.499020039097;12661.493540258287;12678.683032923882;13310.201387916368;12605.243685378906;12630.368481576068;12736.299503527025;12761.298128603015;12850.871491285341;12311.44598493052;12328.137030408145;12370.938145309216;12408.317542534885;12997.675058123623;9584;9727.708168754949;9845.423065792527;9898.851517227391;9969.60121595157;9719.368241064309;9979.351342162736;9996.550155243178;10046.748831279276;10057.195424365887 10:38:16 INFO - PROCESS | 3320 | __end_tp_report 10:38:16 INFO - PROCESS | 3320 | __start_cc_report 10:38:16 INFO - PROCESS | 3320 | _x_x_mozilla_cycle_collect,290 10:38:16 INFO - PROCESS | 3320 | __end_cc_report 10:38:16 INFO - PROCESS | 3320 | __startTimestamp1462988296590__endTimestamp 10:38:16 INFO - PROCESS | 3320 | 10:38:16 INFO - PROCESS | 3320 | ------- Summary: start ------- 10:38:16 INFO - PROCESS | 3320 | Number of tests: 6 10:38:16 INFO - PROCESS | 3320 | 10:38:16 INFO - PROCESS | 3320 | [#0] dojo.html Cycles:165 Average:5091.70 Median:5339.36 stddev:659.56 (12.4%) stddev-sans-first:642.64 10:38:16 INFO - PROCESS | 3320 | Values: 3091.0 3098.4 3125.0 3132.2 3138.1 5205.6 5209.8 5267.7 5284.2 5288.6 4833.2 5026.9 5133.2 5185.9 5224.1 4642.1 4717.9 4796.3 4835.3 4837.4 873.2 4655.9 4725.2 4748.2 4773.9 4643.2 4655.2 4657.3 4674.7 4719.2 4507.0 4645.2 4650.2 4654.7 4700.2 4566.8 4580.0 4596.5 4608.7 4615.7 5006.3 5016.5 5118.5 5122.8 5124.6 5430.6 5457.8 5462.5 5481.9 5484.9 5540.5 5542.2 5542.7 5544.4 5549.5 5089.1 5161.7 5205.6 5208.6 5245.7 5382.1 5569.2 5591.8 5628.4 5634.5 5436.6 5439.8 5442.6 5472.9 5501.8 5495.6 5520.4 5523.1 5542.2 5586.5 5324.8 5403.9 5435.4 5451.9 5501.6 5392.3 5414.7 5429.2 5470.1 5510.6 4131.5 4180.0 4203.0 4205.7 4245.4 3672.0 3696.4 3718.1 3735.6 3744.7 5227.6 5247.2 5256.4 5273.1 5273.6 5422.6 5480.9 5483.1 5505.9 5571.7 5243.9 5313.8 5316.2 5332.1 5339.4 4649.5 4665.7 4682.0 4702.1 4709.6 5591.2 5617.1 5754.9 5757.9 5793.3 5506.9 5521.1 5529.9 5587.7 5616.0 5659.3 5705.5 5717.7 5734.9 5771.6 5344.5 5348.5 5391.2 5460.1 5466.4 5449.8 5455.6 5458.2 5464.3 5466.9 5311.3 5342.5 5345.8 5352.0 5356.1 5237.1 5342.3 5394.7 5400.8 5422.8 5170.0 5179.2 5212.2 5216.0 5289.6 5335.7 5386.3 5394.1 5460.7 5553.2 5441.0 5444.4 5447.2 5458.3 5476.0 10:38:16 INFO - PROCESS | 3320 | 10:38:16 INFO - PROCESS | 3320 | [#1] ext.html Cycles:180 Average:52470.53 Median:37852.63 stddev:99850.04 (263.8%) stddev-sans-first:100054.07 10:38:16 INFO - PROCESS | 3320 | Values: 556.4 592.9 612.2 613.5 636.1 31406.4 43129.8 43633.3 44073.0 44282.3 43028.1 43492.3 43531.6 43789.3 43933.8 8535.8 8688.8 8704.5 8756.8 8757.5 8607.0 8694.8 8742.6 8743.5 8811.6 8818.5 8873.2 8877.6 8884.4 8920.9 8724.0 8734.0 8819.8 8842.9 8901.3 8696.1 8749.7 8770.2 8783.2 8816.0 40507.0 40735.2 40773.4 40891.8 40930.4 3470.2 3559.8 3582.6 3592.5 3647.1 30595.8 30755.5 31160.7 31480.7 31876.0 4077.2 4256.5 4296.8 4297.9 4420.0 290519.0 292012.0 292615.0 292803.5 292960.0 30917.5 31165.4 31199.9 31256.1 55736.4 36430.8 36636.5 36639.4 36688.0 36691.4 15738.7 15747.4 15806.3 15819.3 15917.8 13186.9 13435.0 13482.6 13496.3 13774.7 8491.1 8498.7 8514.8 8520.8 8570.6 3311.1 3335.4 3341.7 3351.7 3370.2 1146.7 1188.9 1190.2 1202.4 1249.3 30940.8 31592.8 31657.5 32074.0 32345.5 1114.1 1120.8 1179.9 1183.9 1256.1 16636.5 16681.9 16840.9 16866.6 16918.1 457346.0 457547.0 460304.0 462608.0 464435.0 55778.4 56571.0 56771.7 56848.7 57041.0 1359.4 1388.1 1391.4 1395.9 1401.8 29942.1 30196.0 30796.2 31067.5 31190.5 50669.5 50687.0 51067.7 51137.2 51515.7 359876.0 361342.0 361406.0 361629.0 362641.2 27883.4 27885.6 28269.3 28879.6 29031.3 47337.5 47830.8 47893.8 48012.0 48358.3 39313.8 39375.4 39651.6 40548.8 40874.8 37174.3 39565.0 40395.2 42647.4 43019.8 38531.0 41374.4 41465.6 41575.8 42171.0 33965.0 35747.0 35769.6 35797.0 35859.8 28057.4 28088.6 28271.4 28425.6 28455.7 10:38:16 INFO - PROCESS | 3320 | 10:38:16 INFO - PROCESS | 3320 | [#2] jquery.html Cycles:180 Average:27386.80 Median:14731.12 stddev:74715.47 (507.2%) stddev-sans-first:74897.60 10:38:16 INFO - PROCESS | 3320 | Values: 404.7 405.4 409.4 411.4 420.6 14818.6 17641.7 18351.8 19237.2 19274.7 18043.0 18185.8 18280.5 18815.5 18862.0 5608.3 5610.7 5776.8 5778.2 5811.4 5614.3 5691.9 5693.8 5719.2 5735.3 5574.8 5617.6 5754.5 5764.1 5800.0 5504.1 5679.3 5684.3 5692.2 5773.4 5108.2 5128.5 5129.5 5146.9 5164.7 21115.3 21546.5 21756.6 22864.2 23241.0 721.7 2379.7 2449.5 2508.6 2685.2 13810.1 14387.5 14484.0 14495.7 14553.0 1904.7 1947.2 1994.1 2015.5 2068.2 69532.0 81309.6 82422.6 82654.0 83805.0 10950.2 11030.9 11044.7 11152.0 11164.3 13792.7 14130.8 15491.6 15565.0 15584.5 7757.8 8027.8 8259.3 8260.2 8326.9 7823.5 7847.0 7866.9 7867.6 7958.1 4660.5 4755.5 4781.9 4786.9 4809.6 1982.3 1999.1 2010.9 2043.1 2062.6 954.0 1008.7 1081.8 1115.7 1131.7 18324.0 18369.5 18406.3 18534.3 18639.7 972.1 989.2 1023.5 1041.6 1075.9 9169.3 10283.0 10409.4 10514.4 10581.9 442518.0 443722.0 446264.0 457891.0 468718.0 88585.6 94842.5 95880.0 96237.5 97147.0 988.7 992.9 1001.4 1024.7 1025.7 16026.7 16261.0 16389.0 16399.3 16467.9 26777.0 35683.0 36287.3 37371.0 38191.6 46336.3 50655.5 50778.5 50784.7 51161.0 8149.2 8166.9 8251.7 8257.6 8338.3 9280.1 12123.7 12668.0 12791.3 12975.4 10703.5 11088.2 11136.7 11154.1 11217.8 10845.9 11121.4 11236.3 11281.7 11354.3 11451.4 11467.1 11478.4 11487.3 11556.2 8179.2 8195.9 8256.7 8304.0 8595.0 8472.8 11025.0 11062.6 11168.2 11177.7 10:38:16 INFO - PROCESS | 3320 | 10:38:16 INFO - PROCESS | 3320 | [#3] mootools.html Cycles:180 Average:5651.71 Median:4724.84 stddev:3203.20 (67.8%) stddev-sans-first:3196.69 10:38:16 INFO - PROCESS | 3320 | Values: 1458.4 1519.5 1659.9 1841.9 1844.3 7901.0 8425.8 8449.1 8963.6 8981.3 8790.5 8815.5 8840.2 8860.1 8863.2 2110.4 2154.2 2155.8 2168.8 2178.0 2223.6 2261.7 2280.1 2289.8 2300.4 2057.0 2060.8 2069.4 2135.7 2249.7 2141.5 2142.5 2143.4 2152.6 2156.8 2155.5 2189.3 2204.8 2208.1 2209.4 8764.7 8795.2 8804.3 8830.0 8923.3 4864.0 5142.7 5149.4 5164.0 5172.5 3233.1 3262.1 3360.9 3383.9 3385.7 2076.3 2143.2 2172.8 2232.8 2242.8 11285.9 11570.9 11596.6 11884.0 11979.9 4349.8 4464.2 4472.6 4513.9 4515.1 8956.9 9034.5 9040.4 9041.0 9061.7 5030.1 5056.5 5079.7 5119.7 5195.7 4301.0 4548.9 4686.6 4696.5 4753.2 3621.5 3666.8 3710.3 3738.2 3748.8 1078.3 1079.2 1082.1 1083.3 1083.6 814.8 928.4 938.6 945.3 967.7 5513.4 5635.6 5674.7 5842.3 5878.3 936.0 939.2 956.5 973.8 980.5 3690.8 3775.8 3840.2 3864.8 3936.4 10398.9 10872.1 10882.2 10885.6 10968.8 10790.5 10869.2 10904.3 10990.5 11013.5 7769.7 8153.0 8160.6 8300.2 8329.2 5538.0 5607.3 5711.4 5735.4 5749.5 9568.5 9805.7 9980.9 10061.5 10181.5 10125.5 10286.8 10385.0 10524.8 10657.6 6879.5 7051.0 7218.0 7594.4 7725.0 8279.1 8310.4 8320.0 8332.5 8391.9 7312.9 7484.8 7561.1 7563.0 7580.7 7464.9 7480.7 7518.8 7726.0 7871.8 6747.2 6825.7 6831.9 6854.6 6857.9 4451.1 4517.2 4527.7 4582.6 4622.5 5096.5 5106.4 5136.7 5163.4 5234.8 10:38:16 INFO - PROCESS | 3320 | 10:38:16 INFO - PROCESS | 3320 | [#4] prototype.html Cycles:180 Average:4789.11 Median:5436.87 stddev:1418.76 (26.1%) stddev-sans-first:1382.79 10:38:16 INFO - PROCESS | 3320 | Values: 334.6 342.5 342.7 348.9 349.9 5359.4 5381.1 5477.3 5504.8 5512.9 5383.0 5410.2 5418.6 5427.5 5446.3 4014.5 4073.9 4177.5 4211.2 4231.4 4203.4 4212.5 4222.8 4231.1 4239.7 4128.6 4145.2 4148.0 4157.5 4193.9 4068.6 4155.9 4170.5 4185.2 4233.7 3683.5 3697.1 3698.1 3708.4 3717.5 5135.8 5160.0 5180.9 5223.9 5230.2 4753.7 4788.4 4818.9 4827.4 4837.2 5636.0 5662.5 5673.6 5680.8 5712.3 4039.6 4049.6 4054.8 4092.5 4094.3 5566.6 5807.9 5832.2 5879.6 5929.1 4117.4 4119.4 4123.4 4164.5 4168.0 4191.8 4213.2 4242.7 4251.5 4261.3 4706.2 4829.5 4831.0 4844.0 4853.8 5608.3 5686.1 5690.2 5719.7 5749.9 1432.3 1442.9 1449.0 1457.8 1461.2 916.5 946.7 949.2 955.8 1013.9 5330.8 5387.8 5389.3 5394.6 5425.8 5670.5 5715.7 5723.3 5754.4 5764.1 5262.0 5336.9 5459.5 5537.5 5629.5 3094.6 3145.4 3156.1 3167.9 3170.5 5797.4 6109.0 6111.4 6147.1 6157.8 5996.2 6019.8 6022.4 6092.8 6099.8 6139.9 6142.6 6159.7 6160.7 6167.8 5574.3 5841.2 5894.9 5898.6 5961.5 5830.4 5836.0 5842.4 5889.4 5927.7 5733.9 6028.6 6078.6 6111.8 6146.1 4092.9 4115.2 4117.9 4128.8 4134.6 5840.5 5865.3 5890.5 5897.9 5943.6 5655.1 5678.7 5744.4 5754.7 5775.9 5662.3 5731.7 5755.7 5784.6 5785.3 5258.6 5384.8 5504.3 5572.8 5611.6 5638.3 5699.7 5715.9 5757.5 5799.9 5624.4 5658.6 5660.6 5662.2 5683.9 10:38:16 INFO - PROCESS | 3320 | 10:38:16 INFO - PROCESS | 3320 | [#5] yui.html Cycles:180 Average:14547.30 Median:4763.36 stddev:17098.07 (359.0%) stddev-sans-first:17114.21 10:38:16 INFO - PROCESS | 3320 | Values: 655.0 677.1 742.7 760.1 763.2 13295.7 14140.4 14177.9 14181.2 14232.5 13494.1 13500.7 13510.7 13538.3 13569.5 658.1 786.1 798.1 824.1 826.5 806.2 809.4 811.3 814.6 816.4 859.4 859.5 863.1 865.3 871.6 855.9 857.5 857.5 859.2 859.7 626.9 627.0 628.3 628.3 630.9 13350.2 13385.1 13448.6 13522.5 13568.5 12595.5 12712.7 12715.6 13045.0 13455.5 10498.1 10597.8 10713.0 10773.1 10919.6 3769.5 3809.4 3831.1 3833.1 3892.5 51253.2 53754.5 54137.2 54185.2 54364.2 10711.7 11079.5 11151.7 11244.2 11461.1 18597.3 18802.5 18938.1 18964.1 19053.8 7758.7 7760.4 7817.8 8228.7 8377.9 4576.9 4651.3 4710.5 4762.6 4764.1 3300.7 3412.0 3415.8 3426.0 3431.4 606.7 617.9 618.0 620.3 623.4 592.2 657.2 658.7 664.5 666.1 8264.7 8383.2 8690.7 8751.9 8913.6 498.7 504.2 549.5 609.9 627.1 4162.3 4234.4 4238.9 4270.7 4362.5 61900.4 62486.7 63664.0 63863.0 64586.7 55075.2 55830.0 56068.0 57282.1 59516.0 49758.3 49797.8 50066.2 50460.7 50877.0 8067.4 8336.2 8337.2 8341.0 8420.5 32334.0 33003.5 33743.2 33903.0 33998.5 40900.4 41223.6 42300.8 42585.4 43425.8 11172.6 11375.3 11928.3 12264.9 12319.5 12242.8 12816.7 12893.2 13001.0 13012.2 12477.8 12524.5 12661.5 12678.7 13310.2 12605.2 12630.4 12736.3 12761.3 12850.9 12311.4 12328.1 12370.9 12408.3 12997.7 9584.0 9727.7 9845.4 9898.9 9969.6 9719.4 9979.4 9996.6 10046.7 10057.2 10:38:16 INFO - PROCESS | 3320 | -------- Summary: end -------- 10:38:16 INFO - PROCESS | 3320 | 10:38:17 INFO - TEST-INFO | 3320: exit 0 10:38:17 INFO - TEST-OK | dromaeo_css | took 1107620ms 10:38:17 INFO - TEST-START | kraken 10:38:17 INFO - operating with platform_type : linux_ 10:38:17 INFO - Initialising browser for kraken test... 10:38:17 INFO - TEST-INFO | started process 3563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHd3P6o/profile http://localhost:42529/getInfo.html) 10:38:20 INFO - PROCESS | 3563 | 10:38:20 INFO - PROCESS | 3563 | (process:3629): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:38:20 INFO - PROCESS | 3563 | __metrics Screen width/height:1600/1200 10:38:20 INFO - PROCESS | 3563 | colorDepth:24 10:38:20 INFO - PROCESS | 3563 | Browser inner width/height: 1024/697 10:38:20 INFO - PROCESS | 3563 | __metrics 10:38:21 ERROR - PROCESS | 3563 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 10:38:22 INFO - TEST-INFO | 3563: exit 0 10:38:22 INFO - Browser initialized. 10:38:22 INFO - Running cycle 1/1 for kraken test... 10:38:22 INFO - TEST-INFO | started process 3680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHd3P6o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:38:23 INFO - PROCESS | 3680 | 10:38:23 INFO - PROCESS | 3680 | (process:3741): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 10:38:33 INFO - PROCESS | 3680 | RSS: Main: 161783808 10:38:33 INFO - PROCESS | 3680 | 10:38:36 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:42529/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42529/tests/kraken/driver.html?testName=audio-beat-detection) 10:38:36 INFO - PROCESS | 3680 | RSS: Main: 166785024 10:38:36 INFO - PROCESS | 3680 | 10:38:39 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:42529/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42529/tests/kraken/driver.html?testName=audio-dft) 10:38:40 INFO - PROCESS | 3680 | RSS: Main: 166789120 10:38:40 INFO - PROCESS | 3680 | 10:38:43 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:42529/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42529/tests/kraken/driver.html?testName=audio-fft) 10:38:43 INFO - PROCESS | 3680 | RSS: Main: 161533952 10:38:43 INFO - PROCESS | 3680 | 10:38:45 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:42529/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42529/tests/kraken/driver.html?testName=audio-oscillator) 10:38:46 INFO - PROCESS | 3680 | RSS: Main: 161939456 10:38:46 INFO - PROCESS | 3680 | 10:38:48 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:42529/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42529/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:38:49 INFO - PROCESS | 3680 | RSS: Main: 162201600 10:38:49 INFO - PROCESS | 3680 | 10:38:52 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:42529/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42529/tests/kraken/driver.html?testName=imaging-darkroom) 10:38:53 INFO - PROCESS | 3680 | RSS: Main: 162660352 10:38:53 INFO - PROCESS | 3680 | 10:38:56 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:42529/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42529/tests/kraken/driver.html?testName=imaging-desaturate) 10:38:57 INFO - PROCESS | 3680 | RSS: Main: 160866304 10:38:57 INFO - PROCESS | 3680 | 10:39:00 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:42529/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42529/tests/kraken/driver.html?testName=json-parse-financial) 10:39:00 INFO - PROCESS | 3680 | RSS: Main: 161636352 10:39:00 INFO - PROCESS | 3680 | 10:39:02 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:42529/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42529/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:39:03 INFO - PROCESS | 3680 | RSS: Main: 161689600 10:39:03 INFO - PROCESS | 3680 | 10:39:04 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:42529/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42529/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:39:05 INFO - PROCESS | 3680 | RSS: Main: 161714176 10:39:05 INFO - PROCESS | 3680 | 10:39:07 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:42529/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42529/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:39:08 INFO - PROCESS | 3680 | RSS: Main: 161775616 10:39:08 INFO - PROCESS | 3680 | 10:39:10 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:42529/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42529/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:39:11 INFO - PROCESS | 3680 | RSS: Main: 162697216 10:39:11 INFO - PROCESS | 3680 | 10:39:14 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:42529/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42529/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:39:14 INFO - PROCESS | 3680 | RSS: Main: 162639872 10:39:14 INFO - PROCESS | 3680 | 10:39:16 INFO - PROCESS | 3680 | Cycle 1(1): loaded http://localhost:42529/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42529/tests/kraken/driver.html?testName=ai-astar) 10:39:16 INFO - PROCESS | 3680 | RSS: Main: 163840000 10:39:16 INFO - PROCESS | 3680 | 10:39:16 INFO - PROCESS | 3680 | __start_tp_report 10:39:16 INFO - PROCESS | 3680 | _x_x_mozilla_page_load 10:39:16 INFO - PROCESS | 3680 | _x_x_mozilla_page_load_details 10:39:16 INFO - PROCESS | 3680 | |i|pagename|runs| 10:39:16 INFO - PROCESS | 3680 | |0;ai-astar;109;113;104;112;112;113;109;114;113;112 10:39:16 INFO - PROCESS | 3680 | |1;audio-beat-detection;153;132;155;210;131;159;162;140;186;132 10:39:16 INFO - PROCESS | 3680 | |2;audio-dft;161;162;163;163;163;163;167;168;172;163 10:39:16 INFO - PROCESS | 3680 | |3;audio-fft;77;77;79;169;77;76;77;76;165;76 10:39:16 INFO - PROCESS | 3680 | |4;audio-oscillator;94;95;174;93;94;93;141;97;96;137 10:39:16 INFO - PROCESS | 3680 | |5;imaging-gaussian-blur;118;120;119;118;117;117;117;118;118;118 10:39:16 INFO - PROCESS | 3680 | |6;imaging-darkroom;148;147;149;147;150;149;148;148;149;150 10:39:16 INFO - PROCESS | 3680 | |7;imaging-desaturate;98;96;95;96;96;97;97;96;97;97 10:39:16 INFO - PROCESS | 3680 | |8;json-parse-financial;57;58;58;58;59;59;56;58;60;57 10:39:16 INFO - PROCESS | 3680 | |9;json-stringify-tinderbox;61;60;60;61;60;59;60;60;61;61 10:39:16 INFO - PROCESS | 3680 | |10;stanford-crypto-aes;88;84;84;83;83;89;85;84;140;83 10:39:16 INFO - PROCESS | 3680 | |11;stanford-crypto-ccm;139;130;127;145;136;139;145;132;148;149 10:39:16 INFO - PROCESS | 3680 | |12;stanford-crypto-pbkdf2;175;174;174;170;174;174;176;180;173;169 10:39:16 INFO - PROCESS | 3680 | |13;stanford-crypto-sha256-iterative;68;67;67;65;66;67;66;67;66;65 10:39:16 INFO - PROCESS | 3680 | __end_tp_report 10:39:16 INFO - PROCESS | 3680 | __start_cc_report 10:39:16 INFO - PROCESS | 3680 | _x_x_mozilla_cycle_collect,737 10:39:16 INFO - PROCESS | 3680 | __end_cc_report 10:39:16 INFO - PROCESS | 3680 | __startTimestamp1462988356828__endTimestamp 10:39:16 INFO - PROCESS | 3680 | 10:39:16 INFO - PROCESS | 3680 | ------- Summary: start ------- 10:39:16 INFO - PROCESS | 3680 | Number of tests: 14 10:39:16 INFO - PROCESS | 3680 | 10:39:16 INFO - PROCESS | 3680 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.50 stddev:3.00 (2.7%) stddev-sans-first:3.08 10:39:16 INFO - PROCESS | 3680 | Values: 109.0 113.0 104.0 112.0 112.0 113.0 109.0 114.0 113.0 112.0 10:39:16 INFO - PROCESS | 3680 | 10:39:16 INFO - PROCESS | 3680 | [#1] audio-beat-detection Cycles:10 Average:156.00 Median:157.00 stddev:25.61 (16.3%) stddev-sans-first:27.14 10:39:16 INFO - PROCESS | 3680 | Values: 153.0 132.0 155.0 210.0 131.0 159.0 162.0 140.0 186.0 132.0 10:39:16 INFO - PROCESS | 3680 | 10:39:16 INFO - PROCESS | 3680 | [#2] audio-dft Cycles:10 Average:164.50 Median:163.00 stddev:3.41 (2.1%) stddev-sans-first:3.37 10:39:16 INFO - PROCESS | 3680 | Values: 161.0 162.0 163.0 163.0 163.0 163.0 167.0 168.0 172.0 163.0 10:39:16 INFO - PROCESS | 3680 | 10:39:16 INFO - PROCESS | 3680 | [#3] audio-fft Cycles:10 Average:94.90 Median:77.00 stddev:38.02 (49.4%) stddev-sans-first:39.77 10:39:16 INFO - PROCESS | 3680 | Values: 77.0 77.0 79.0 169.0 77.0 76.0 77.0 76.0 165.0 76.0 10:39:16 INFO - PROCESS | 3680 | 10:39:16 INFO - PROCESS | 3680 | [#4] audio-oscillator Cycles:10 Average:111.40 Median:94.00 stddev:28.76 (30.6%) stddev-sans-first:29.81 10:39:16 INFO - PROCESS | 3680 | Values: 94.0 95.0 174.0 93.0 94.0 93.0 141.0 97.0 96.0 137.0 10:39:16 INFO - PROCESS | 3680 | 10:39:16 INFO - PROCESS | 3680 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.94 (0.8%) stddev-sans-first:1.00 10:39:16 INFO - PROCESS | 3680 | Values: 118.0 120.0 119.0 118.0 117.0 117.0 117.0 118.0 118.0 118.0 10:39:16 INFO - PROCESS | 3680 | 10:39:16 INFO - PROCESS | 3680 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 10:39:16 INFO - PROCESS | 3680 | Values: 148.0 147.0 149.0 147.0 150.0 149.0 148.0 148.0 149.0 150.0 10:39:16 INFO - PROCESS | 3680 | 10:39:16 INFO - PROCESS | 3680 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.85 (0.9%) stddev-sans-first:0.71 10:39:16 INFO - PROCESS | 3680 | Values: 98.0 96.0 95.0 96.0 96.0 97.0 97.0 96.0 97.0 97.0 10:39:16 INFO - PROCESS | 3680 | 10:39:16 INFO - PROCESS | 3680 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:1.15 (2.0%) stddev-sans-first:1.17 10:39:16 INFO - PROCESS | 3680 | Values: 57.0 58.0 58.0 58.0 59.0 59.0 56.0 58.0 60.0 57.0 10:39:16 INFO - PROCESS | 3680 | 10:39:16 INFO - PROCESS | 3680 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.50 stddev:0.67 (1.1%) stddev-sans-first:0.67 10:39:16 INFO - PROCESS | 3680 | Values: 61.0 60.0 60.0 61.0 60.0 59.0 60.0 60.0 61.0 61.0 10:39:16 INFO - PROCESS | 3680 | 10:39:16 INFO - PROCESS | 3680 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:84.00 stddev:17.59 (20.9%) stddev-sans-first:18.64 10:39:16 INFO - PROCESS | 3680 | Values: 88.0 84.0 84.0 83.0 83.0 89.0 85.0 84.0 140.0 83.0 10:39:16 INFO - PROCESS | 3680 | 10:39:16 INFO - PROCESS | 3680 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:142.00 stddev:7.72 (5.4%) stddev-sans-first:8.19 10:39:16 INFO - PROCESS | 3680 | Values: 139.0 130.0 127.0 145.0 136.0 139.0 145.0 132.0 148.0 149.0 10:39:16 INFO - PROCESS | 3680 | 10:39:16 INFO - PROCESS | 3680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:174.00 stddev:3.03 (1.7%) stddev-sans-first:3.19 10:39:16 INFO - PROCESS | 3680 | Values: 175.0 174.0 174.0 170.0 174.0 174.0 176.0 180.0 173.0 169.0 10:39:16 INFO - PROCESS | 3680 | 10:39:16 INFO - PROCESS | 3680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:0.83 10:39:16 INFO - PROCESS | 3680 | Values: 68.0 67.0 67.0 65.0 66.0 67.0 66.0 67.0 66.0 65.0 10:39:16 INFO - PROCESS | 3680 | -------- Summary: end -------- 10:39:16 INFO - PROCESS | 3680 | 10:39:17 INFO - TEST-INFO | 3680: exit 0 10:39:17 INFO - TEST-OK | kraken | took 60508ms 10:39:17 INFO - SUITE-END | took 1168s 10:39:17 INFO - Completed test suite (00:19:28) 10:39:17 INFO - javascript benchmark 10:39:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.969090309097, 3098.4113018526464, 3124.9843750781256, 3132.169974956637, 3138.1213260287113, 5205.583553315731, 5209.8176563820225, 5267.683938963665, 5284.154535274357, 5288.627204218921, 4833.154198015342, 5026.9443416882405, 5133.204353325241, 5185.922211166836, 5224.111900976834, 4642.117997580457, 4717.9056418871605, 4796.256580230052, 4835.323054772317, 4837.371141751567, 873.1506184816878, 4655.930161047587, 4725.243960966246, 4748.192807222763, 4773.856784296477, 4643.233866412021, 4655.162070827249, 4657.3246879202325, 4674.69614475058, 4719.221328480797, 4506.977465112686, 4645.187092258875, 4650.209464391061, 4654.650901182425, 4700.1539722849875, 4566.840160594364, 4579.954200457986, 4596.54034596541, 4608.654350923694, 4615.723056616614, 5006.324146240284, 5016.523430274118, 5118.539331460149, 5122.795088196468, 5124.564412024945, 5430.619856610039, 5457.8265672880525, 5462.481064298885, 5481.862953426156, 5484.862878428032, 5540.473655002808, 5542.168674698787, 5542.695151766651, 5544.390117087117, 5549.500544950974, 5089.058524173003, 5161.66449180802, 5205.635605507616, 5208.635395522315, 5245.659032162897, 5382.058139825514, 5569.164625306155, 5591.804286850022, 5628.352739435018, 5634.4786907534735, 5436.646617969898, 5439.836804895859, 5442.591805614595, 5472.945270547323, 5501.779928802803, 5495.642783219078, 5520.392756796749, 5523.116301391758, 5542.196381524656, 5586.52514536269, 5324.760385782572, 5403.891922161535, 5435.402105768362, 5451.918221226685, 5501.559875209973, 5392.299001129828, 5414.675119492843, 5429.1856221566295, 5470.124780035176, 5510.641808282448, 4131.50421949368, 4179.958200418017, 4203.0, 4205.684573656927, 4245.448091748053, 3672.026912868092, 3696.3900956341904, 3718.0704823794053, 3735.5517337919623, 3744.7378683491893, 5227.60792940531, 5247.1866860636665, 5256.448072952285, 5273.050850846885, 5273.630845840831, 5422.6475279106735, 5480.890382192413, 5483.095289277225, 5505.917411238835, 5571.693556854331, 5243.947560524422, 5313.760880760375, 5316.229146773696, 5332.066888294533, 5339.359276886798, 4649.5350464953235, 4665.6734028617675, 4681.976590117028, 4702.059588082398, 4709.599684026896, 5591.245181900473, 5617.101263797773, 5754.913676294859, 5757.9424205757405, 5793.275840519935, 5506.944930550723, 5521.089020311603, 5529.944700552943, 5587.664740115606, 5616.017196990429, 5659.292588426447, 5705.486506214461, 5717.7141142941855, 5734.942650573441, 5771.624844385102, 5344.545713614386, 5348.465153484776, 5391.19132130168, 5460.126379779216, 5466.4260252674485, 5449.782008719607, 5455.645383050089, 5458.208559758892, 5464.28964234647, 5466.890662186814, 5311.256424100707, 5342.545883599938, 5345.839624811262, 5352.0366334060245, 5356.089464790917, 5237.135872581134, 5342.332208473941, 5394.703291319015, 5400.83797486076, 5422.783088676409, 5170.017696637627, 5179.171332586768, 5212.218167274787, 5215.982883337864, 5289.6297259193025, 5335.706536140549, 5386.326709161355, 5394.1099718546, 5460.672359658433, 5553.222548843246, 5441.020616289106, 5444.373897001737, 5447.237386765777, 5458.263134476795, 5476.041692703681], "value": 5050.484479420673, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.3879732294474, 592.8754961458094, 612.2163630552891, 613.5398451161627, 636.1253276744476, 31406.371872562537, 43129.78435107824, 43633.34549981753, 44073.0, 44282.33576496355, 43028.13943721123, 43492.3476147858, 43531.56468435315, 43789.34315985263, 43933.78033109838, 8535.78660533487, 8688.826223475528, 8704.477731336108, 8756.781080473007, 8757.51833649149, 8606.956965215166, 8694.826103477926, 8742.606582703762, 8743.519106449143, 8811.559422028906, 8818.470891746483, 8873.157050080232, 8877.556122193897, 8884.378093533454, 8920.8661870072, 8724.0, 8734.0, 8819.823603527957, 8842.911570884273, 8901.332400069989, 8696.130386961317, 8749.693760718408, 8770.210681038738, 8783.209511143963, 8815.955920220358, 40507.0, 40735.18529629391, 40773.38839917404, 40891.7955410224, 40930.38604420936, 3470.1845066409373, 3559.76861504004, 3582.6417358264225, 3592.497050412944, 3647.051766540692, 30595.847020764977, 30755.538666920012, 31160.688393116234, 31480.685193148234, 31876.0, 4077.184563087365, 4256.5105012923605, 4296.806643701041, 4297.892552686208, 4419.977900110511, 290519.0, 292012.0, 292615.0, 292803.53598232084, 292960.0, 30917.536236956465, 31165.376692466023, 31199.908003219778, 31256.062318130036, 55736.442635573934, 36430.81784591113, 36636.450453243226, 36639.43523953351, 36688.0, 36691.4496282556, 15738.68522629541, 15747.370105195892, 15806.288717007763, 15819.288132034086, 15917.761233581505, 13186.945044396425, 13435.0, 13482.595522134352, 13496.325183740773, 13774.724505509834, 8491.108433614505, 8498.660053597787, 8514.787130321667, 8520.786980325418, 8570.614322355508, 3311.106001379614, 3335.366280406715, 3341.6658334166873, 3351.681590248971, 3370.191154122993, 1146.7419830538229, 1188.9346085965183, 1190.2441949362217, 1202.4048096192266, 1249.2941488059218, 30940.845295773375, 31592.842035789676, 31657.52513712296, 32074.03777886667, 32345.51481727776, 1114.1254115519278, 1120.78705046041, 1179.8820117988132, 1183.8697743248235, 1256.108163204117, 16636.50090497287, 16681.91659041721, 16840.915795420944, 16866.578335541708, 16918.06950617703, 457346.0, 457547.0, 460304.0, 462608.0, 464435.0, 55778.44221557733, 56571.0, 56771.716141419856, 56848.715756420956, 57041.0, 1359.3882752761297, 1388.0630574362265, 1391.387789372693, 1395.8953078519153, 1401.7967394727707, 29942.101736947927, 30196.0, 30796.23009424782, 31067.533986990664, 31190.532142017433, 50669.493305067954, 50687.0, 51067.744661276454, 51137.232941505164, 51515.74242128765, 359876.0, 361342.0, 361406.0, 361629.0, 362641.18679406436, 27883.44233115286, 27885.58171627468, 28269.293267668472, 28879.5668064975, 29031.274218144714, 47337.52662473331, 47830.760846195546, 47893.76053119712, 48012.03975920532, 48358.27462588134, 39313.80343098266, 39375.40936885892, 39651.60348396595, 40548.79725601353, 40874.79562602287, 37174.25651487009, 39565.021748913015, 40395.1920961585, 42647.36028959506, 43019.78490107529, 38531.0, 41374.37938430986, 41465.58534414738, 41575.7921210392, 42171.0, 33965.0, 35747.0, 35769.55805586435, 35797.0, 35859.82070089633, 28057.43885122327, 28088.578671319538, 28271.434571308047, 28425.573616395355, 28455.715442846136], "value": 18416.06896892671, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.7126540156489, 405.4040560376247, 409.4104489535071, 411.3788179848428, 420.625643177572, 14818.629534261649, 17641.7353739694, 18351.816481835176, 19237.23051077955, 19274.71087933682, 18043.0, 18185.818141818578, 18280.542986425346, 18815.529611759714, 18861.962592057433, 5608.270924779783, 5610.709536806537, 5776.826695199151, 5778.191053252548, 5811.418858114176, 5614.326280846304, 5691.943080569204, 5693.829185124432, 5719.170720245562, 5735.2544169257935, 5574.804881829137, 5617.558228055956, 5754.539636829065, 5764.135379693059, 5800.042992906166, 5504.091824848895, 5679.318481782192, 5684.261046064026, 5692.174634677948, 5773.364929857712, 5108.233764935289, 5128.538431541142, 5129.5383415492415, 5146.897062058775, 5164.690118592859, 21115.26096586612, 21546.461338466663, 21756.564868702695, 22864.199753008732, 23241.0, 721.7185297733888, 2379.7263314718684, 2449.4892734946643, 2508.611165269386, 2685.2481305234564, 13810.102343347751, 14387.496437624633, 14484.0, 14495.71008579833, 14553.0, 1904.7142928560688, 1947.1724517080327, 1994.0627904884682, 2015.506200980769, 2068.1830676882696, 69532.0, 81309.59345203236, 82422.58788706078, 82654.0, 83805.0, 10950.178736594788, 11030.889691103146, 11044.723881902855, 11152.0, 11164.330140191614, 13792.655183620489, 14130.788038179435, 15491.612709682122, 15565.0, 15584.532464026097, 7757.844843103219, 8027.759167224993, 8259.339252859756, 8260.215279548433, 8326.875096873551, 7823.530588164728, 7847.0, 7866.881996770053, 7867.6066196689935, 7958.08482024563, 4660.487346391894, 4755.500672429414, 4781.924067084948, 4786.880327991758, 4809.567138957511, 1982.3260091568936, 1999.0904138616895, 2010.9095090720953, 2043.1316690406518, 2062.6176765835485, 953.9809203816023, 1008.6973907827769, 1081.7944590527775, 1115.6890653482126, 1131.7000994736402, 18324.0, 18369.54076148107, 18406.26374944987, 18534.25862965493, 18639.720404193948, 972.0765272990687, 989.223459584223, 1023.4575674892319, 1041.5625437316346, 1075.93544387337, 9169.312301577409, 10283.023112804272, 10409.42748148859, 10514.369137851754, 10581.947090264654, 442518.0, 443722.0, 446264.0, 457891.0, 468718.0, 88585.55707221423, 94842.52578737063, 95880.0, 96237.51881240548, 97147.0, 988.7379844341256, 992.8659630949874, 1001.4041645221082, 1024.666983230453, 1025.733309339577, 16026.679466410373, 16261.024338539726, 16389.0, 16399.344026239294, 16467.917660412102, 26777.0, 35683.0, 36287.27425451529, 37371.0, 38191.618083819914, 46336.30495542637, 50655.49344506655, 50778.49221507738, 50784.74607626938, 51161.0, 8149.225823546753, 8166.918330816853, 8251.711190108317, 8257.628406721831, 8338.29124524398, 9280.071992800937, 12123.696907577381, 12668.0, 12791.296478693761, 12975.416106275052, 10703.464826758787, 11088.223824332219, 11136.665900023012, 11154.051905587792, 11217.775644486901, 10845.891541084804, 11121.388323642277, 11236.325820450798, 11281.661550153509, 11354.26197297173, 11451.370174640475, 11467.139964502529, 11478.368689721812, 11487.31076135401, 11556.248843825124, 8179.222973817477, 8195.918040819515, 8256.669733210605, 8303.95848020756, 8594.957025214833, 8472.83054338922, 11025.0, 11062.612808551663, 11168.162387820783, 11177.720556985814], "value": 9021.556723109885, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.4385011770469, 1519.4757808556049, 1659.8506134447898, 1841.8526517878572, 1844.3452574336102, 7900.960495197516, 8425.789355266113, 8449.112843151457, 8963.59663815129, 8981.326400519963, 8790.472571645705, 8815.515146666947, 8840.160184782435, 8860.113988601153, 8863.157999989991, 2110.4196346004856, 2154.170644301947, 2155.81675557577, 2168.772278910715, 2177.9782202177935, 2223.6442169252923, 2261.6607508873635, 2280.099360752502, 2289.816814654832, 2300.4248937765474, 2056.9588608227828, 2060.7527096748413, 2069.4102180878454, 2135.6582946728527, 2249.651304047867, 2141.518158414352, 2142.45367431304, 2143.3677065265706, 2152.591007708538, 2156.8382371322054, 2155.5150091229507, 2189.3431970408815, 2204.8236141108673, 2208.094681180708, 2209.414505156135, 8764.737057888273, 8795.208431241219, 8804.251638610725, 8829.955850220707, 8923.286137109015, 4863.951360486385, 5142.717150556718, 5149.407818100929, 5164.0, 5172.456892026321, 3233.094733474631, 3262.1029216965285, 3360.882369117069, 3383.8984830455124, 3385.6783605557434, 2076.3355726167633, 2143.174877672092, 2172.8044475997076, 2232.7655596162494, 2242.843000989931, 11285.887141128565, 11570.884291157065, 11596.59411920587, 11884.0, 11979.880201197964, 4349.782510874444, 4464.17412778637, 4472.619827314715, 4513.88715282114, 4515.1195516873895, 8956.8656470153, 9034.548272586344, 9040.367174297737, 9041.0, 9061.728148155566, 5030.119729047402, 5056.469070747592, 5079.6952182869145, 5119.744012799345, 5195.740212989411, 4300.956990430118, 4548.88627784308, 4686.554777296152, 4696.459907110658, 4753.215719406328, 3621.5473065866768, 3666.816659167031, 3710.313591985437, 3738.2149748552565, 3748.7938163401277, 1078.320657985464, 1079.2121751121567, 1082.0640146273417, 1083.2525557365393, 1083.631565267797, 814.8207394373347, 928.3594319919234, 938.6339327662217, 945.2768631996528, 967.7387105481621, 5513.42109078549, 5635.5773317001385, 5674.716264186774, 5842.269716285465, 5878.323992740804, 936.0265324062898, 939.2110627073291, 956.516958935733, 973.7711637765119, 980.4852452462515, 3690.8154592270816, 3775.7734535927934, 3840.1551658635058, 3864.8260828262796, 3936.3701807710627, 10398.948005259925, 10872.075873550679, 10882.183836212158, 10885.619003334845, 10968.835467467994, 10790.460476976119, 10869.184811139037, 10904.34573925567, 10990.450477476094, 11013.504392302366, 7769.72805951789, 8152.959235203904, 8160.551169685606, 8300.169983001771, 8329.167083291622, 5538.0, 5607.327120745536, 5711.428857114255, 5735.3977832327, 5749.54003679713, 9568.473733944422, 9805.70582882486, 9980.850287245843, 10061.496925153566, 10181.490925453549, 10125.544350504098, 10286.845697314697, 10385.013423724735, 10524.842127367943, 10657.626983055556, 6879.484038697017, 7051.048108505492, 7217.963910180415, 7594.354479869273, 7725.0, 8279.089300176855, 8310.376721746014, 8320.0, 8332.541710205996, 8391.916080839357, 7312.926870731438, 7484.812879677834, 7561.130469996021, 7563.016807814949, 7580.696772129053, 7464.850702986018, 7480.70077196906, 7518.774436766906, 7726.0342457192855, 7871.803204919923, 6747.190337159573, 6825.692843822139, 6831.9316806833285, 6854.554453960476, 6857.897131543131, 4451.065276292015, 4517.164324599959, 4527.728336299832, 4582.587567118975, 4622.514635963175, 5096.541311282002, 5106.361704786902, 5136.743162841918, 5163.432022477449, 5234.795996920653], "value": 4558.742048072639, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.63691894294686, 342.47088248655814, 342.729243897321, 348.8796365253988, 349.93351263259996, 5359.437259087788, 5381.062817385743, 5477.288742072675, 5504.834854954358, 5512.862178445541, 5383.0, 5410.187587158297, 5418.566514678826, 5427.45725427458, 5446.2919820423385, 4014.53832809227, 4073.877783666495, 4177.498700155986, 4211.157768446307, 4231.3920710130105, 4203.390508376284, 4212.53662097169, 4222.831086756526, 4231.132617813356, 4239.724417912841, 4128.587141285862, 4145.170965806836, 4148.02521407469, 4157.542670306264, 4193.874183774492, 4068.6338229559333, 4155.8753237402925, 4170.47869016373, 4185.204811085884, 4233.6824738144605, 3683.5395575553057, 3697.0757310672334, 3698.0939669780805, 3708.35103856824, 3717.4795528626014, 5135.764468384894, 5159.974200129013, 5180.8963820723375, 5223.895522089537, 5230.21546767984, 4753.714777113384, 4788.449328327252, 4818.927716084261, 4827.444843842933, 4837.177679794443, 5636.013697602903, 5662.518685911702, 5673.602847800656, 5680.772769089232, 5712.285964254468, 4039.6368124647115, 4049.5950404959563, 4054.817533210983, 4092.5088989321175, 4094.263032654121, 5566.582506312043, 5807.89649966505, 5832.212651292106, 5879.617824841372, 5929.080992446177, 4117.444145040381, 4119.423280740699, 4123.402106694512, 4164.4586203793315, 4168.041350489404, 4191.832326706897, 4213.1784302060805, 4242.7242229255, 4251.4685664291965, 4261.339492378686, 4706.1764191267075, 4829.541193586604, 4831.0, 4844.006978569455, 4853.781579828917, 5608.270924779753, 5686.118651609007, 5690.2033715279895, 5719.685417302005, 5749.885002300014, 1432.2838580709645, 1442.920639364845, 1448.9710205795825, 1457.8118833150947, 1461.2328527523136, 916.5060950650397, 946.7349142240046, 949.2311227905419, 955.8386560329234, 1013.9138173255355, 5330.786768529216, 5387.81142660005, 5389.299391079135, 5394.595405344615, 5425.83722488326, 5670.489655930904, 5715.657060576379, 5723.313202415737, 5754.367019627837, 5764.135379692996, 5262.0, 5336.893262134813, 5459.454054594588, 5537.477193771664, 5629.493345598916, 3094.5919606578955, 3145.370925814846, 3156.1478400831647, 3167.904962851118, 3170.4927211646027, 5797.420257974169, 6109.0, 6111.388861113853, 6147.125126836358, 6157.815265541952, 5996.190514280604, 6019.819405417845, 6022.440462803291, 6092.7562897484495, 6099.75600975956, 6139.877202455926, 6142.600730952563, 6159.692015399212, 6160.661163635953, 6167.814965551041, 5574.303212098488, 5841.240638716939, 5894.882102358015, 5898.557608179318, 5961.493273071837, 5830.387809279964, 5835.9708201458725, 5842.444967728059, 5889.352171261072, 5927.7036148191555, 5733.885322293448, 6028.638281703112, 6078.574499784972, 6111.84720381994, 6146.078088286793, 4092.897677557966, 4115.1975364803575, 4117.8970525737095, 4128.814203360916, 4134.565870583546, 5840.532757379315, 5865.3254875689845, 5890.4993075589055, 5897.9115313271195, 5943.64338139713, 5655.123455864347, 5678.716064196857, 5744.368119506935, 5754.741036653277, 5775.884482310246, 5662.292213473316, 5731.653061530454, 5755.683437410982, 5784.553861534617, 5785.334686511105, 5258.632755483525, 5384.792235183556, 5504.339479262514, 5572.804951826666, 5611.607187496836, 5638.323401191883, 5699.7435115419075, 5715.914261286167, 5757.539396848326, 5799.8550036249435, 5624.409437009055, 5658.575606829587, 5660.632058916157, 5662.150677398423, 5683.857903552444], "value": 4337.791693118812, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.9574277671954, 677.0994577212305, 742.6620887496188, 760.1410406240947, 763.1605234242334, 13295.734085318289, 14140.363683634236, 14177.929110354447, 14181.2200328982, 14232.501862434818, 13494.122882012662, 13500.72998540031, 13510.662233444169, 13538.323083845817, 13569.52506662267, 658.1312667279193, 786.0528063683277, 798.078219656295, 824.1428913929506, 826.4917075998278, 806.1575653442167, 809.4010432280129, 811.3306522119245, 814.5601375257384, 816.3713940265992, 859.4499520306978, 859.5358506406533, 863.0851297624507, 865.2991077227434, 871.6034204436966, 855.9400841941067, 857.4726543175933, 857.4812238595654, 859.1709000814213, 859.6733241368303, 626.9216347956506, 626.9905951410733, 628.2900322635438, 628.3151365012159, 630.8990561510136, 13350.19898806065, 13385.129966552144, 13448.596542103753, 13522.459101635923, 13568.525101621395, 12595.496180152782, 12712.682182945407, 12715.554955576603, 13044.956403487793, 13455.461781528826, 10498.107660848837, 10597.788044239072, 10713.0, 10773.084287835543, 10919.617813376493, 3769.4722738816313, 3809.4095415210686, 3831.1379939513663, 3833.137544052594, 3892.4550562921213, 51253.231201532006, 53754.46245537534, 54137.187942180506, 54185.1872221917, 54364.18453723197, 10711.73220669474, 11079.50142243585, 11151.665450036511, 11244.156688248415, 11461.083113350913, 18597.25610975573, 18802.52993675169, 18938.053097345353, 18964.14661340243, 19053.80946190548, 7758.68965241384, 7760.417968652261, 7817.843643127106, 8228.711995080144, 8377.874331885027, 4576.931346029813, 4651.279051746985, 4710.505396933273, 4762.618990480753, 4764.094821983812, 3300.7029367357054, 3411.9658803412144, 3415.8292085395633, 3425.9828700856833, 3431.4166591679473, 606.7148440233084, 617.8671585609115, 618.0111821086316, 620.2742790934617, 623.3672822085587, 592.2064433658918, 657.1555551116887, 658.6706646676662, 664.524755043802, 666.1440049536322, 8264.669413223524, 8383.245507904317, 8690.695825646071, 8751.912480875237, 8913.643454261757, 498.6982875360427, 504.23104765233313, 549.5109352676121, 609.8597322615734, 627.0813258576208, 4162.313218318944, 4234.3860140279485, 4238.915221695549, 4270.658347332206, 4362.520122786491, 61900.38099619036, 62486.68756656188, 63664.0, 63863.0, 64586.677066614364, 55075.17387239195, 55830.0, 56068.0, 57282.140767888515, 59516.0, 49758.25362619491, 49797.75101124471, 50066.24900626494, 50460.74769626055, 50877.0, 8067.354611631173, 8336.249737523653, 8337.166283371856, 8340.958295208486, 8420.536870471939, 32334.0, 33003.504947425325, 33743.15642108967, 33902.98291051272, 33998.49002264919, 40900.38649420321, 41223.58776412318, 42300.78849605732, 42585.361219581115, 43425.782871085445, 11172.553097875994, 11375.31748095117, 11928.343941082976, 12264.877351226374, 12319.507219711111, 12242.816357754818, 12816.6795830105, 12893.226406415644, 13000.95992320631, 13012.154209976321, 12477.812832807334, 12524.499020039097, 12661.493540258287, 12678.683032923882, 13310.201387916368, 12605.243685378906, 12630.368481576068, 12736.299503527025, 12761.298128603015, 12850.871491285341, 12311.44598493052, 12328.137030408145, 12370.938145309216, 12408.317542534885, 12997.675058123623, 9584.0, 9727.708168754949, 9845.423065792527, 9898.851517227391, 9969.60121595157, 9719.368241064309, 9979.351342162736, 9996.550155243178, 10046.748831279276, 10057.195424365887], "value": 6524.863606027457, "unit": "score"}], "name": "dromaeo_css", "value": 6903.825449075155, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 104.0, 112.0, 112.0, 113.0, 109.0, 114.0, 113.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 132.0, 155.0, 210.0, 131.0, 159.0, 162.0, 140.0, 186.0, 132.0], "value": 156.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 163.0, 163.0, 163.0, 167.0, 168.0, 172.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 79.0, 169.0, 77.0, 76.0, 77.0, 76.0, 165.0, 76.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 174.0, 93.0, 94.0, 93.0, 141.0, 97.0, 96.0, 137.0], "value": 111.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 119.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 149.0, 147.0, 150.0, 149.0, 148.0, 148.0, 149.0, 150.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 95.0, 96.0, 96.0, 97.0, 97.0, 96.0, 97.0, 97.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 59.0, 59.0, 56.0, 58.0, 60.0, 57.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 61.0, 60.0, 59.0, 60.0, 60.0, 61.0, 61.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 84.0, 83.0, 83.0, 89.0, 85.0, 84.0, 140.0, 83.0], "value": 90.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 130.0, 127.0, 145.0, 136.0, 139.0, 145.0, 132.0, 148.0, 149.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 174.0, 170.0, 174.0, 174.0, 176.0, 180.0, 173.0, 169.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 65.0, 66.0, 67.0, 66.0, 67.0, 66.0, 65.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1588.8000000000002, "alertThreshold": 2.0}]} 10:39:18 INFO - Return code: 0 10:39:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:39:18 ERROR - # TBPL SUCCESS # 10:39:18 INFO - Running post-action listener: _resource_record_post_action 10:39:18 INFO - ##### 10:39:18 INFO - ##### Finished run-tests step (success) 10:39:18 INFO - ##### 10:39:18 INFO - Running post-run listener: _resource_record_post_run 10:39:19 INFO - Total resource usage - Wall time: 1186s; CPU: 26.0%; Read bytes: 0; Write bytes: 540852224; Read time: 0; Write time: 420840 10:39:19 INFO - install - Wall time: 17s; CPU: 26.0%; Read bytes: 0; Write bytes: 245084160; Read time: 0; Write time: 222280 10:39:19 INFO - run-tests - Wall time: 1170s; CPU: 26.0%; Read bytes: 0; Write bytes: 295768064; Read time: 0; Write time: 198560 10:39:19 INFO - Running post-run listener: _upload_blobber_files 10:39:19 INFO - Blob upload gear active. 10:39:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:39:19 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 10:39:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:39:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:39:19 INFO - (blobuploader) - INFO - Open directory for files ... 10:39:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:39:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:39:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:20 INFO - (blobuploader) - INFO - Done attempting. 10:39:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:39:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:39:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:21 INFO - (blobuploader) - INFO - Done attempting. 10:39:21 INFO - (blobuploader) - INFO - Iteration through files over. 10:39:21 INFO - Return code: 0 10:39:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:39:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:39:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dead132217ac109249e9e76aab4d75200675344f02c9cee5f8103886730284b5e660692fc58dfa84ca256ecdd923e129e17018206870b15c8a0f23238a0c16a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c282d59d0c4e4cafa0f19a47c601633d2366f45325910384fd24778b498957832b425c24f59e557772891cfe83a5caeb94b86503f449e43d7a54cbaf52fb480a"} 10:39:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:39:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:39:21 INFO - Contents: 10:39:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dead132217ac109249e9e76aab4d75200675344f02c9cee5f8103886730284b5e660692fc58dfa84ca256ecdd923e129e17018206870b15c8a0f23238a0c16a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c282d59d0c4e4cafa0f19a47c601633d2366f45325910384fd24778b498957832b425c24f59e557772891cfe83a5caeb94b86503f449e43d7a54cbaf52fb480a"} 10:39:21 INFO - Running post-run listener: copy_logs_to_upload_dir 10:39:21 INFO - Copying logs to upload dir... 10:39:21 INFO - mkdir: /builds/slave/test/build/upload/logs 10:39:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1222.219786 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-05-11 10:39:20.944423) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 10:39:20.948183) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dead132217ac109249e9e76aab4d75200675344f02c9cee5f8103886730284b5e660692fc58dfa84ca256ecdd923e129e17018206870b15c8a0f23238a0c16a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c282d59d0c4e4cafa0f19a47c601633d2366f45325910384fd24778b498957832b425c24f59e557772891cfe83a5caeb94b86503f449e43d7a54cbaf52fb480a"} build_url:https://queue.taskcluster.net/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005438 build_url: 'https://queue.taskcluster.net/v1/task/KhQKk_GzRS-RbsL3adoWOQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dead132217ac109249e9e76aab4d75200675344f02c9cee5f8103886730284b5e660692fc58dfa84ca256ecdd923e129e17018206870b15c8a0f23238a0c16a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c282d59d0c4e4cafa0f19a47c601633d2366f45325910384fd24778b498957832b425c24f59e557772891cfe83a5caeb94b86503f449e43d7a54cbaf52fb480a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 10:39:20.963586) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 10:39:20.963916) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462987136.631755-1469629321 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002229 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 10:39:21.044351) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 10:39:21.044696) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 10:39:21.045058) ========= ========= Total master_lag: 0.16 =========