builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1494933602.16 results: success (0) revision: 49365d675cbb2a8368cda3e4858a2a0d0634c249 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-16 04:20:02.164305) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-16 04:20:02.164763) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-16 04:20:02.165039) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-16 04:20:02.180208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:20:02.180559) ========= 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=8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-16 04:20:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-05-16 04:20:02 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081459 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:20:02.276967) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:20:02.277337) ========= 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=8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018227 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:20:02.327418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-16 04:20:02.327850) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 49365d675cbb2a8368cda3e4858a2a0d0634c249 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 49365d675cbb2a8368cda3e4858a2a0d0634c249 --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=8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-16 04:20:02,470 truncating revision to first 12 chars 2017-05-16 04:20:02,470 Setting DEBUG logging. 2017-05-16 04:20:02,470 attempt 1/10 2017-05-16 04:20:02,470 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/49365d675cbb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-16 04:20:03,434 unpacking tar archive at: mozilla-central-49365d675cbb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.265160 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-16 04:20:03.606471) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-16 04:20:03.606802) ========= script_repo_revision: 49365d675cbb2a8368cda3e4858a2a0d0634c249 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-16 04:20:03.607158) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-16 04:20:03.607434) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-16 04:20:03.617153) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-16 04:20:03.617609) ========= /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=8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:20:03 INFO - MultiFileLogger online at 20170516 04:20:03 in /builds/slave/test 04:20:03 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 04:20:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:20:03 INFO - {'append_to_log': False, 04:20:03 INFO - 'base_work_dir': '/builds/slave/test', 04:20:03 INFO - 'blob_upload_branch': 'Firefox', 04:20:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:20:03 INFO - 'branch': 'Firefox', 04:20:03 INFO - 'buildbot_json_path': 'buildprops.json', 04:20:03 INFO - 'config_files': ('talos/linux_config.py',), 04:20:03 INFO - 'default_actions': ('clobber', 04:20:03 INFO - 'read-buildbot-config', 04:20:03 INFO - 'download-and-extract', 04:20:03 INFO - 'populate-webroot', 04:20:03 INFO - 'create-virtualenv', 04:20:03 INFO - 'install', 04:20:03 INFO - 'run-tests'), 04:20:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:20:03 INFO - 'download_minidump_stackwalk': True, 04:20:03 INFO - 'download_symbols': 'ondemand', 04:20:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:20:03 INFO - 'tooltool.py': '/tools/tooltool.py', 04:20:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:20:03 INFO - '/tools/misc-python/virtualenv.py')}, 04:20:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:20:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:20:03 INFO - 'gecko_profile': False, 04:20:03 INFO - 'gecko_profile_interval': 0, 04:20:03 INFO - 'installer_path': 'installer.exe', 04:20:03 INFO - 'log_level': 'info', 04:20:03 INFO - 'log_name': 'talos', 04:20:03 INFO - 'log_to_console': True, 04:20:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:20:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:20:03 INFO - 'opt_config_files': (), 04:20:03 INFO - 'pip_index': False, 04:20:03 INFO - 'suite': 'dromaeojs-e10s', 04:20:03 INFO - 'system_bits': '32', 04:20:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:20:03 INFO - 'title': 'talos-linux64-ix-001', 04:20:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:20:03 INFO - 'use_talos_json': True, 04:20:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:20:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:20:03 INFO - 'work_dir': 'build'} 04:20:03 INFO - [mozharness: 2017-05-16 11:20:03.864416Z] Running clobber step. 04:20:03 INFO - Running pre-action listener: _resource_record_pre_action 04:20:03 INFO - Running main action method: clobber 04:20:03 INFO - rmtree: /builds/slave/test/build 04:20:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:20:04 INFO - Running post-action listener: _resource_record_post_action 04:20:04 INFO - [mozharness: 2017-05-16 11:20:04.875335Z] Finished clobber step (success) 04:20:04 INFO - [mozharness: 2017-05-16 11:20:04.875437Z] Running read-buildbot-config step. 04:20:04 INFO - Running pre-action listener: _resource_record_pre_action 04:20:04 INFO - Running main action method: read_buildbot_config 04:20:04 INFO - Using buildbot properties: 04:20:04 INFO - { 04:20:04 INFO - "project": "", 04:20:04 INFO - "product": "firefox", 04:20:04 INFO - "who": "cbook@mozilla.com", 04:20:04 INFO - "installer_path": "public/build/target.tar.bz2", 04:20:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 04:20:04 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:20:04 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 04:20:04 INFO - "stage_platform": "linux64-stylo", 04:20:04 INFO - "basedir": "/builds/slave/test", 04:20:04 INFO - "buildnumber": 90, 04:20:04 INFO - "platform": "ubuntu64_hw_stylo", 04:20:04 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:20:04 INFO - "slavebuilddir": "test", 04:20:04 INFO - "taskId": "TbsJIGu8TkWw1vAZS4ltaQ", 04:20:04 INFO - "branch": "mozilla-central", 04:20:04 INFO - "script_repo_revision": "production", 04:20:04 INFO - "revision": "49365d675cbb2a8368cda3e4858a2a0d0634c249", 04:20:04 INFO - "slavename": "talos-linux64-ix-001", 04:20:04 INFO - "repo_path": "mozilla-central" 04:20:04 INFO - } 04:20:04 INFO - Finding installer, test and symbols from parent task. 04:20:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TbsJIGu8TkWw1vAZS4ltaQ'}, attempt #1 04:20:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TbsJIGu8TkWw1vAZS4ltaQ'}, attempt #1 04:20:05 INFO - Task dependencies: Y9d5ZEd2RamAy9r3IxOe8A 04:20:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A'}, attempt #1 04:20:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.tar.bz2 04:20:06 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/test_packages.json 04:20:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.crashreporter-symbols.zip 04:20:06 INFO - Running post-action listener: _resource_record_post_action 04:20:06 INFO - [mozharness: 2017-05-16 11:20:06.242830Z] Finished read-buildbot-config step (success) 04:20:06 INFO - [mozharness: 2017-05-16 11:20:06.243049Z] Running download-and-extract step. 04:20:06 INFO - Running pre-action listener: _resource_record_pre_action 04:20:06 INFO - Running main action method: download_and_extract 04:20:06 INFO - mkdir: /builds/slave/test/build/tests 04:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:06 INFO - trying https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.test_packages.json 04:20:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:20:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:20:06 INFO - Downloaded 986 bytes. 04:20:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:20:06 INFO - Using the following test package requirements: 04:20:06 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:20:06 INFO - u'common': [u'target.common.tests.zip'], 04:20:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:20:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:20:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:20:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:20:06 INFO - u'mozbase': [u'target.common.tests.zip'], 04:20:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:20:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:20:06 INFO - u'web-platform': [u'target.common.tests.zip', 04:20:06 INFO - u'target.web-platform.tests.zip'], 04:20:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:20:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:20:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.common.tests.zip 04:20:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:20:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.common.tests.zip into memory 04:20:07 INFO - Content-Length response header: 62450019 04:20:07 INFO - Bytes received: 62450019 04:20:18 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:20:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.common.tests.zip 04:20:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:20:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.common.tests.zip into memory 04:20:19 INFO - Content-Length response header: 62450019 04:20:19 INFO - Bytes received: 62450019 04:20:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.talos.tests.zip 04:20:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:20:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.talos.tests.zip into memory 04:20:32 INFO - Content-Length response header: 14410018 04:20:32 INFO - Bytes received: 14410018 04:20:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:32 INFO - trying https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.tar.bz2 04:20:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:20:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:20:33 INFO - Downloaded 65165658 bytes. 04:20:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.tar.bz2 04:20:33 INFO - mkdir: /builds/slave/test/properties 04:20:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:20:33 INFO - Writing to file /builds/slave/test/properties/build_url 04:20:33 INFO - Contents: 04:20:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.tar.bz2 04:20:33 INFO - Running post-action listener: _resource_record_post_action 04:20:33 INFO - Running post-action listener: set_extra_try_arguments 04:20:33 INFO - [mozharness: 2017-05-16 11:20:33.618097Z] Finished download-and-extract step (success) 04:20:33 INFO - [mozharness: 2017-05-16 11:20:33.618215Z] Running populate-webroot step. 04:20:33 INFO - Running pre-action listener: _resource_record_pre_action 04:20:33 INFO - Running main action method: populate_webroot 04:20:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:20:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:20:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:20:33 INFO - '--tppagecycles', 04:20:33 INFO - '7'], 04:20:33 INFO - 'tests': ['tsvgm']}}, 04:20:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:20:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:20:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:20:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:20:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:20:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:20:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:20:33 INFO - 'talos_options': ['--disable-e10s'], 04:20:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:20:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:20:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:20:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:20:33 INFO - 'talos_options': ['--disable-e10s'], 04:20:33 INFO - 'tests': ['damp', 'tps']}, 04:20:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:20:33 INFO - 'tests': ['damp', 'tps']}, 04:20:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:20:33 INFO - 'tests': ['dromaeo_dom']}, 04:20:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:20:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:20:33 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:20:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:20:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:20:33 INFO - 'tests': ['a11yr', 04:20:33 INFO - 'ts_paint', 04:20:33 INFO - 'tpaint', 04:20:33 INFO - 'sessionrestore', 04:20:33 INFO - 'sessionrestore_no_auto_restore', 04:20:33 INFO - 'tabpaint']}, 04:20:33 INFO - 'other-e10s': {'tests': ['a11yr', 04:20:33 INFO - 'ts_paint', 04:20:33 INFO - 'tpaint', 04:20:33 INFO - 'sessionrestore', 04:20:33 INFO - 'sessionrestore_no_auto_restore', 04:20:33 INFO - 'tabpaint']}, 04:20:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:20:33 INFO - 'ts_paint', 04:20:33 INFO - 'tpaint', 04:20:33 INFO - 'sessionrestore', 04:20:33 INFO - 'sessionrestore_no_auto_restore', 04:20:33 INFO - 'tabpaint']}, 04:20:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:20:33 INFO - 'ts_paint', 04:20:33 INFO - 'tpaint', 04:20:33 INFO - 'sessionrestore', 04:20:33 INFO - 'sessionrestore_no_auto_restore', 04:20:33 INFO - 'tabpaint']}, 04:20:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:20:33 INFO - 'tests': ['a11yr', 04:20:33 INFO - 'ts_paint', 04:20:33 INFO - 'tpaint', 04:20:33 INFO - 'sessionrestore', 04:20:33 INFO - 'sessionrestore_no_auto_restore', 04:20:33 INFO - 'tabpaint']}, 04:20:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:20:33 INFO - 'tests': ['a11yr', 04:20:33 INFO - 'ts_paint', 04:20:33 INFO - 'tpaint', 04:20:33 INFO - 'sessionrestore', 04:20:33 INFO - 'sessionrestore_no_auto_restore', 04:20:33 INFO - 'tabpaint']}, 04:20:33 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:20:33 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:20:33 INFO - 'bloom_basic_ref']}, 04:20:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:20:33 INFO - 'tests': ['tsvgx', 04:20:33 INFO - 'tsvgr_opacity', 04:20:33 INFO - 'tart', 04:20:33 INFO - 'tscrollx', 04:20:33 INFO - 'cart', 04:20:33 INFO - 'tsvg_static']}, 04:20:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:20:33 INFO - 'tsvgr_opacity', 04:20:33 INFO - 'tart', 04:20:33 INFO - 'tscrollx', 04:20:33 INFO - 'cart', 04:20:33 INFO - 'tsvg_static']}, 04:20:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:20:33 INFO - 'talos_options': ['--disable-e10s'], 04:20:33 INFO - 'tests': ['tp5o']}, 04:20:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:20:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:20:33 INFO - 'talos_options': ['--disable-e10s', 04:20:33 INFO - '--xperf_path', 04:20:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:20:33 INFO - 'tests': ['tp5n']}, 04:20:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:20:33 INFO - 'talos_options': ['--xperf_path', 04:20:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:20:33 INFO - 'tests': ['tp5n']}}, 04:20:33 INFO - 'talos.zip': {'path': '', 04:20:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:20:33 INFO - Running post-action listener: _resource_record_post_action 04:20:33 INFO - [mozharness: 2017-05-16 11:20:33.632378Z] Finished populate-webroot step (success) 04:20:33 INFO - [mozharness: 2017-05-16 11:20:33.632466Z] Running create-virtualenv step. 04:20:33 INFO - Running pre-action listener: _resource_record_pre_action 04:20:33 INFO - Running main action method: create_virtualenv 04:20:33 INFO - Creating virtualenv /builds/slave/test/build/venv 04:20:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:20:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:20:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:20:33 INFO - Using real prefix '/usr' 04:20:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:20:34 INFO - Installing distribute.............................................................................................................................................................................................done. 04:20:36 INFO - Installing pip.................done. 04:20:36 INFO - Return code: 0 04:20:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:20:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:20:36 INFO - Reading from file tmpfile_stdout 04:20:36 INFO - Output received: 04:20:36 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:20:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1e231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21965c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21937a0>, '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 0x21946a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:20:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:20:36 INFO - Using env: {'DISPLAY': ':0', 04:20:36 INFO - 'HOME': '/home/cltbld', 04:20:36 INFO - 'LANG': 'en_US.UTF-8', 04:20:36 INFO - 'LANGUAGE': 'en_US:en', 04:20:36 INFO - 'LOGNAME': 'cltbld', 04:20:36 INFO - 'MAIL': '/var/mail/cltbld', 04:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:36 INFO - 'MOZ_NO_REMOTE': '1', 04:20:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:36 INFO - 'NO_EM_RESTART': '1', 04:20:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:36 INFO - 'PWD': '/builds/slave/test', 04:20:36 INFO - 'SHELL': '/bin/bash', 04:20:36 INFO - 'SHLVL': '1', 04:20:36 INFO - 'TERM': 'linux', 04:20:36 INFO - 'TMOUT': '86400', 04:20:36 INFO - 'USER': 'cltbld', 04:20:36 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 04:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:36 INFO - '_': '/tools/buildbot/bin/python'} 04:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:20:36 INFO - Cleaning up... 04:20:36 INFO - Return code: 0 04:20:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21965c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21937a0>, '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 0x21946a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:20:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:20:36 INFO - Using env: {'DISPLAY': ':0', 04:20:36 INFO - 'HOME': '/home/cltbld', 04:20:36 INFO - 'LANG': 'en_US.UTF-8', 04:20:36 INFO - 'LANGUAGE': 'en_US:en', 04:20:36 INFO - 'LOGNAME': 'cltbld', 04:20:36 INFO - 'MAIL': '/var/mail/cltbld', 04:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:36 INFO - 'MOZ_NO_REMOTE': '1', 04:20:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:36 INFO - 'NO_EM_RESTART': '1', 04:20:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:36 INFO - 'PWD': '/builds/slave/test', 04:20:36 INFO - 'SHELL': '/bin/bash', 04:20:36 INFO - 'SHLVL': '1', 04:20:36 INFO - 'TERM': 'linux', 04:20:36 INFO - 'TMOUT': '86400', 04:20:36 INFO - 'USER': 'cltbld', 04:20:36 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 04:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:36 INFO - '_': '/tools/buildbot/bin/python'} 04:20:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:36 INFO - Downloading/unpacking psutil>=3.1.1 04:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:20:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:38 INFO - Installing collected packages: psutil 04:20:38 INFO - Running setup.py install for psutil 04:20:38 INFO - building 'psutil._psutil_linux' extension 04:20:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:20:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:20:38 INFO - building 'psutil._psutil_posix' extension 04:20:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:20:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:20:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:38 INFO - Successfully installed psutil 04:20:38 INFO - Cleaning up... 04:20:38 INFO - Return code: 0 04:20:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21965c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21937a0>, '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 0x21946a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:20:38 INFO - Using env: {'DISPLAY': ':0', 04:20:38 INFO - 'HOME': '/home/cltbld', 04:20:38 INFO - 'LANG': 'en_US.UTF-8', 04:20:38 INFO - 'LANGUAGE': 'en_US:en', 04:20:38 INFO - 'LOGNAME': 'cltbld', 04:20:38 INFO - 'MAIL': '/var/mail/cltbld', 04:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:38 INFO - 'MOZ_NO_REMOTE': '1', 04:20:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:38 INFO - 'NO_EM_RESTART': '1', 04:20:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:38 INFO - 'PWD': '/builds/slave/test', 04:20:38 INFO - 'SHELL': '/bin/bash', 04:20:38 INFO - 'SHLVL': '1', 04:20:38 INFO - 'TERM': 'linux', 04:20:38 INFO - 'TMOUT': '86400', 04:20:38 INFO - 'USER': 'cltbld', 04:20:38 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 04:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:38 INFO - '_': '/tools/buildbot/bin/python'} 04:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:20:39 INFO - Installing collected packages: mozsystemmonitor 04:20:39 INFO - Running setup.py install for mozsystemmonitor 04:20:40 INFO - Successfully installed mozsystemmonitor 04:20:40 INFO - Cleaning up... 04:20:40 INFO - Return code: 0 04:20:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21965c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21937a0>, '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 0x21946a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:20:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:20:40 INFO - Using env: {'DISPLAY': ':0', 04:20:40 INFO - 'HOME': '/home/cltbld', 04:20:40 INFO - 'LANG': 'en_US.UTF-8', 04:20:40 INFO - 'LANGUAGE': 'en_US:en', 04:20:40 INFO - 'LOGNAME': 'cltbld', 04:20:40 INFO - 'MAIL': '/var/mail/cltbld', 04:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:40 INFO - 'MOZ_NO_REMOTE': '1', 04:20:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:40 INFO - 'NO_EM_RESTART': '1', 04:20:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:40 INFO - 'PWD': '/builds/slave/test', 04:20:40 INFO - 'SHELL': '/bin/bash', 04:20:40 INFO - 'SHLVL': '1', 04:20:40 INFO - 'TERM': 'linux', 04:20:40 INFO - 'TMOUT': '86400', 04:20:40 INFO - 'USER': 'cltbld', 04:20:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 04:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:40 INFO - '_': '/tools/buildbot/bin/python'} 04:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:40 INFO - Downloading/unpacking jsonschema==2.5.1 04:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:20:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:41 INFO - Downloading functools32-3.2.3-2.tar.gz 04:20:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:20:41 INFO - warning: no files found matching '*.txt' 04:20:41 INFO - no previously-included directories found matching 'build' 04:20:41 INFO - no previously-included directories found matching 'dist' 04:20:41 INFO - no previously-included directories found matching '.git*' 04:20:41 INFO - Installing collected packages: jsonschema, functools32 04:20:41 INFO - Running setup.py install for functools32 04:20:41 INFO - warning: no files found matching '*.txt' 04:20:41 INFO - no previously-included directories found matching 'build' 04:20:41 INFO - no previously-included directories found matching 'dist' 04:20:41 INFO - no previously-included directories found matching '.git*' 04:20:41 INFO - Successfully installed jsonschema functools32 04:20:41 INFO - Cleaning up... 04:20:41 INFO - Return code: 0 04:20:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:41 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21965c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21937a0>, '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 0x21946a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:20:41 INFO - Using env: {'DISPLAY': ':0', 04:20:41 INFO - 'HOME': '/home/cltbld', 04:20:41 INFO - 'LANG': 'en_US.UTF-8', 04:20:41 INFO - 'LANGUAGE': 'en_US:en', 04:20:41 INFO - 'LOGNAME': 'cltbld', 04:20:41 INFO - 'MAIL': '/var/mail/cltbld', 04:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:41 INFO - 'MOZ_NO_REMOTE': '1', 04:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:41 INFO - 'NO_EM_RESTART': '1', 04:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:41 INFO - 'PWD': '/builds/slave/test', 04:20:41 INFO - 'SHELL': '/bin/bash', 04:20:41 INFO - 'SHLVL': '1', 04:20:41 INFO - 'TERM': 'linux', 04:20:41 INFO - 'TMOUT': '86400', 04:20:41 INFO - 'USER': 'cltbld', 04:20:41 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 04:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:41 INFO - '_': '/tools/buildbot/bin/python'} 04:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:20:41 INFO - Cleaning up... 04:20:41 INFO - Return code: 0 04:20:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:41 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/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 0x1e231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21965c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21937a0>, '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 0x21946a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:20:41 INFO - Using env: {'DISPLAY': ':0', 04:20:41 INFO - 'HOME': '/home/cltbld', 04:20:41 INFO - 'LANG': 'en_US.UTF-8', 04:20:41 INFO - 'LANGUAGE': 'en_US:en', 04:20:41 INFO - 'LOGNAME': 'cltbld', 04:20:41 INFO - 'MAIL': '/var/mail/cltbld', 04:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:41 INFO - 'MOZ_NO_REMOTE': '1', 04:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:41 INFO - 'NO_EM_RESTART': '1', 04:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:41 INFO - 'PWD': '/builds/slave/test', 04:20:41 INFO - 'SHELL': '/bin/bash', 04:20:41 INFO - 'SHLVL': '1', 04:20:41 INFO - 'TERM': 'linux', 04:20:41 INFO - 'TMOUT': '86400', 04:20:41 INFO - 'USER': 'cltbld', 04:20:41 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 04:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:41 INFO - '_': '/tools/buildbot/bin/python'} 04:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:42 INFO - Downloading/unpacking blobuploader==1.2.4 04:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:43 INFO - Downloading blobuploader-1.2.4.tar.gz 04:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:20:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:20:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:43 INFO - Downloading docopt-0.6.1.tar.gz 04:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:20:43 INFO - Installing collected packages: blobuploader, requests, docopt 04:20:43 INFO - Running setup.py install for blobuploader 04:20:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:20:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:20:43 INFO - Running setup.py install for requests 04:20:44 INFO - Running setup.py install for docopt 04:20:44 INFO - Successfully installed blobuploader requests docopt 04:20:44 INFO - Cleaning up... 04:20:44 INFO - Return code: 0 04:20:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:44 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/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 0x1e231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21965c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21937a0>, '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 0x21946a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:44 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:20:44 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:44 INFO - Using env: {'DISPLAY': ':0', 04:20:44 INFO - 'HOME': '/home/cltbld', 04:20:44 INFO - 'LANG': 'en_US.UTF-8', 04:20:44 INFO - 'LANGUAGE': 'en_US:en', 04:20:44 INFO - 'LOGNAME': 'cltbld', 04:20:44 INFO - 'MAIL': '/var/mail/cltbld', 04:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:44 INFO - 'MOZ_NO_REMOTE': '1', 04:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:44 INFO - 'NO_EM_RESTART': '1', 04:20:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:44 INFO - 'PWD': '/builds/slave/test', 04:20:44 INFO - 'SHELL': '/bin/bash', 04:20:44 INFO - 'SHLVL': '1', 04:20:44 INFO - 'TERM': 'linux', 04:20:44 INFO - 'TMOUT': '86400', 04:20:44 INFO - 'USER': 'cltbld', 04:20:44 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 04:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:44 INFO - '_': '/tools/buildbot/bin/python'} 04:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:44 INFO - Running setup.py (path:/tmp/pip-NBn1Kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:44 INFO - Running setup.py (path:/tmp/pip-V7yERZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:44 INFO - Running setup.py (path:/tmp/pip-vVTf78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:44 INFO - Running setup.py (path:/tmp/pip-Kk7LZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:44 INFO - Running setup.py (path:/tmp/pip-pBM4iW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:45 INFO - Running setup.py (path:/tmp/pip-e57hpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:45 INFO - Running setup.py (path:/tmp/pip-4e3PcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:45 INFO - Running setup.py (path:/tmp/pip-H3HGY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:45 INFO - Running setup.py (path:/tmp/pip-HDeuCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:45 INFO - Running setup.py (path:/tmp/pip-yKqrut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:45 INFO - Running setup.py (path:/tmp/pip-K6bvdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:45 INFO - Running setup.py (path:/tmp/pip-bJU6g_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:45 INFO - Running setup.py (path:/tmp/pip-Mi_ELo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:45 INFO - Running setup.py (path:/tmp/pip-vEmVfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:45 INFO - Running setup.py (path:/tmp/pip-S10XJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:45 INFO - Running setup.py (path:/tmp/pip-mbaPm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:45 INFO - Running setup.py (path:/tmp/pip-B0rqzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:20:45 INFO - Running setup.py install for manifestparser 04:20:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:20:46 INFO - Running setup.py install for mozcrash 04:20:46 INFO - Running setup.py install for mozdebug 04:20:46 INFO - Running setup.py install for mozdevice 04:20:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:20:46 INFO - Running setup.py install for mozfile 04:20:46 INFO - Running setup.py install for mozhttpd 04:20:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:20:46 INFO - Running setup.py install for mozinfo 04:20:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:20:46 INFO - Running setup.py install for mozInstall 04:20:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:20:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:20:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:20:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:20:46 INFO - Running setup.py install for mozleak 04:20:46 INFO - Running setup.py install for mozlog 04:20:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:20:46 INFO - Running setup.py install for moznetwork 04:20:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:20:47 INFO - Running setup.py install for mozprocess 04:20:47 INFO - Running setup.py install for mozprofile 04:20:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:20:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:20:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:20:47 INFO - Running setup.py install for mozrunner 04:20:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:20:47 INFO - Running setup.py install for mozscreenshot 04:20:47 INFO - Running setup.py install for moztest 04:20:47 INFO - Running setup.py install for mozversion 04:20:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:20:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:20:47 INFO - Cleaning up... 04:20:47 INFO - Return code: 0 04:20:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:47 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/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 0x1e231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21965c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21937a0>, '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 0x21946a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:47 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:20:47 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:47 INFO - Using env: {'DISPLAY': ':0', 04:20:47 INFO - 'HOME': '/home/cltbld', 04:20:47 INFO - 'LANG': 'en_US.UTF-8', 04:20:47 INFO - 'LANGUAGE': 'en_US:en', 04:20:47 INFO - 'LOGNAME': 'cltbld', 04:20:47 INFO - 'MAIL': '/var/mail/cltbld', 04:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:47 INFO - 'MOZ_NO_REMOTE': '1', 04:20:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:47 INFO - 'NO_EM_RESTART': '1', 04:20:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:47 INFO - 'PWD': '/builds/slave/test', 04:20:47 INFO - 'SHELL': '/bin/bash', 04:20:47 INFO - 'SHLVL': '1', 04:20:47 INFO - 'TERM': 'linux', 04:20:47 INFO - 'TMOUT': '86400', 04:20:47 INFO - 'USER': 'cltbld', 04:20:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 04:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:47 INFO - '_': '/tools/buildbot/bin/python'} 04:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:47 INFO - Running setup.py (path:/tmp/pip-3PRGAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:47 INFO - Running setup.py (path:/tmp/pip-VXU79l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:48 INFO - Running setup.py (path:/tmp/pip-Hvotk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:48 INFO - Running setup.py (path:/tmp/pip-7MHSnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:48 INFO - Running setup.py (path:/tmp/pip-OMmrpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:48 INFO - Running setup.py (path:/tmp/pip-DMlUyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:48 INFO - Running setup.py (path:/tmp/pip-gWhZ4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:48 INFO - Running setup.py (path:/tmp/pip-YuC3el-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:48 INFO - Running setup.py (path:/tmp/pip-_iqa2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:48 INFO - Running setup.py (path:/tmp/pip-Lgik3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:48 INFO - Running setup.py (path:/tmp/pip-0uu7Rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:48 INFO - Running setup.py (path:/tmp/pip-_EXBnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:48 INFO - Running setup.py (path:/tmp/pip-xjwpEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:48 INFO - Running setup.py (path:/tmp/pip-W_BPfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:48 INFO - Running setup.py (path:/tmp/pip-NOg4EE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:49 INFO - Running setup.py (path:/tmp/pip-31HC4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:49 INFO - Running setup.py (path:/tmp/pip-mCW7aY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:20:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:20:49 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:49 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:50 INFO - Downloading blessings-1.6.tar.gz 04:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:20:50 INFO - Installing collected packages: blessings 04:20:50 INFO - Running setup.py install for blessings 04:20:50 INFO - Successfully installed blessings 04:20:50 INFO - Cleaning up... 04:20:50 INFO - Return code: 0 04:20:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:20:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:50 INFO - Reading from file tmpfile_stdout 04:20:50 INFO - Current package versions: 04:20:50 INFO - argparse == 1.2.1 04:20:50 INFO - blessings == 1.6 04:20:50 INFO - blobuploader == 1.2.4 04:20:50 INFO - docopt == 0.6.1 04:20:50 INFO - functools32 == 3.2.3-2 04:20:50 INFO - jsonschema == 2.5.1 04:20:50 INFO - manifestparser == 1.1 04:20:50 INFO - mozInstall == 1.12 04:20:50 INFO - mozcrash == 1.0 04:20:50 INFO - mozdebug == 0.1 04:20:50 INFO - mozdevice == 0.50 04:20:50 INFO - mozfile == 1.2 04:20:50 INFO - mozhttpd == 0.7 04:20:50 INFO - mozinfo == 0.9 04:20:50 INFO - mozleak == 0.1 04:20:50 INFO - mozlog == 3.4 04:20:50 INFO - moznetwork == 0.27 04:20:50 INFO - mozprocess == 0.25 04:20:50 INFO - mozprofile == 0.28 04:20:50 INFO - mozrunner == 6.13 04:20:50 INFO - mozscreenshot == 0.1 04:20:50 INFO - mozsystemmonitor == 0.3 04:20:50 INFO - moztest == 0.8 04:20:50 INFO - mozversion == 1.4 04:20:50 INFO - psutil == 3.1.1 04:20:50 INFO - requests == 1.2.3 04:20:50 INFO - wsgiref == 0.1.2 04:20:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:50 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/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 0x1e231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21965c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21937a0>, '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 0x21946a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:50 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:20:50 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:50 INFO - Using env: {'DISPLAY': ':0', 04:20:50 INFO - 'HOME': '/home/cltbld', 04:20:50 INFO - 'LANG': 'en_US.UTF-8', 04:20:50 INFO - 'LANGUAGE': 'en_US:en', 04:20:50 INFO - 'LOGNAME': 'cltbld', 04:20:50 INFO - 'MAIL': '/var/mail/cltbld', 04:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:50 INFO - 'MOZ_NO_REMOTE': '1', 04:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:50 INFO - 'NO_EM_RESTART': '1', 04:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:50 INFO - 'PWD': '/builds/slave/test', 04:20:50 INFO - 'SHELL': '/bin/bash', 04:20:50 INFO - 'SHLVL': '1', 04:20:50 INFO - 'TERM': 'linux', 04:20:50 INFO - 'TMOUT': '86400', 04:20:50 INFO - 'USER': 'cltbld', 04:20:50 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 04:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:50 INFO - '_': '/tools/buildbot/bin/python'} 04:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:20:50 INFO - Cleaning up... 04:20:50 INFO - Return code: 0 04:20:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1e231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21965c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21937a0>, '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 0x21946a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:20:50 INFO - Using env: {'DISPLAY': ':0', 04:20:50 INFO - 'HOME': '/home/cltbld', 04:20:50 INFO - 'LANG': 'en_US.UTF-8', 04:20:50 INFO - 'LANGUAGE': 'en_US:en', 04:20:50 INFO - 'LOGNAME': 'cltbld', 04:20:50 INFO - 'MAIL': '/var/mail/cltbld', 04:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:50 INFO - 'MOZ_NO_REMOTE': '1', 04:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:50 INFO - 'NO_EM_RESTART': '1', 04:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:50 INFO - 'PWD': '/builds/slave/test', 04:20:50 INFO - 'SHELL': '/bin/bash', 04:20:50 INFO - 'SHLVL': '1', 04:20:50 INFO - 'TERM': 'linux', 04:20:50 INFO - 'TMOUT': '86400', 04:20:50 INFO - 'USER': 'cltbld', 04:20:50 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 04:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:50 INFO - '_': '/tools/buildbot/bin/python'} 04:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:20:51 INFO - Cleaning up... 04:20:51 INFO - Return code: 0 04:20:51 INFO - Running post-action listener: _resource_record_post_action 04:20:51 INFO - Running post-action listener: _start_resource_monitoring 04:20:51 INFO - Starting resource monitoring. 04:20:51 INFO - [mozharness: 2017-05-16 11:20:51.171000Z] Finished create-virtualenv step (success) 04:20:51 INFO - [mozharness: 2017-05-16 11:20:51.171460Z] Running install step. 04:20:51 INFO - Running pre-action listener: _resource_record_pre_action 04:20:51 INFO - Running main action method: install 04:20:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:51 INFO - Reading from file tmpfile_stdout 04:20:51 INFO - Detecting whether we're running mozinstall >=1.0... 04:20:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:20:51 INFO - Reading from file tmpfile_stdout 04:20:51 INFO - Output received: 04:20:51 INFO - Usage: mozinstall [options] installer 04:20:51 INFO - Options: 04:20:51 INFO - -h, --help show this help message and exit 04:20:51 INFO - -d DEST, --destination=DEST 04:20:51 INFO - Directory to install application into. [default: 04:20:51 INFO - "/builds/slave/test"] 04:20:51 INFO - --app=APP Application being installed. [default: firefox] 04:20:51 INFO - mkdir: /builds/slave/test/build/application 04:20:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:21:07 INFO - Reading from file tmpfile_stdout 04:21:07 INFO - Output received: 04:21:07 INFO - /builds/slave/test/build/application/firefox/firefox 04:21:07 INFO - Running post-action listener: _resource_record_post_action 04:21:07 INFO - [mozharness: 2017-05-16 11:21:07.850156Z] Finished install step (success) 04:21:07 INFO - [mozharness: 2017-05-16 11:21:07.850434Z] Running run-tests step. 04:21:07 INFO - Running pre-action listener: _resource_record_pre_action 04:21:07 INFO - Running main action method: run_tests 04:21:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:21:07 INFO - Python 2.7.3 04:21:07 INFO - Return code: 0 04:21:07 INFO - grabbing minidump binary from tooltool 04:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:07 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 0x21937a0>, '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 0x21946a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2194b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:21:07 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:21:07 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:21:07 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:21:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:21:07 INFO - Return code: 0 04:21:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:21:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:21:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:21:07 INFO - ENV: RUST_BACKTRACE is now 1 04:21:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:21:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:21:07 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/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 04:21:07 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/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 04:21:07 INFO - Using env: {'DISPLAY': ':0', 04:21:07 INFO - 'HOME': '/home/cltbld', 04:21:07 INFO - 'LANG': 'en_US.UTF-8', 04:21:07 INFO - 'LANGUAGE': 'en_US:en', 04:21:07 INFO - 'LOGNAME': 'cltbld', 04:21:07 INFO - 'MAIL': '/var/mail/cltbld', 04:21:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:21:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:07 INFO - 'MOZ_NO_REMOTE': '1', 04:21:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:07 INFO - 'NO_EM_RESTART': '1', 04:21:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:07 INFO - 'PWD': '/builds/slave/test', 04:21:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:21:07 INFO - 'RUST_BACKTRACE': '1', 04:21:07 INFO - 'SHELL': '/bin/bash', 04:21:07 INFO - 'SHLVL': '1', 04:21:07 INFO - 'TERM': 'linux', 04:21:07 INFO - 'TMOUT': '86400', 04:21:07 INFO - 'USER': 'cltbld', 04:21:07 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149', 04:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:07 INFO - '_': '/tools/buildbot/bin/python'} 04:21:07 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/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 04:21:08 INFO - mozversion application_buildid: 20170516103419 04:21:08 INFO - mozversion application_changeset: 49365d675cbb2a8368cda3e4858a2a0d0634c249 04:21:08 INFO - mozversion application_display_name: Nightly 04:21:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:21:08 INFO - mozversion application_name: Firefox 04:21:08 INFO - mozversion application_remotingname: firefox 04:21:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:21:08 INFO - mozversion application_vendor: Mozilla 04:21:08 INFO - mozversion application_version: 55.0a1 04:21:08 INFO - mozversion platform_buildid: 20170516103419 04:21:08 INFO - mozversion platform_changeset: 49365d675cbb2a8368cda3e4858a2a0d0634c249 04:21:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:21:08 INFO - mozversion platform_version: 55.0a1 04:21:08 INFO - using testdate: 1494933668 04:21:08 INFO - actual date: 1494933668 04:21:08 INFO - starting webserver on 'localhost:40500' 04:21:08 INFO - SUITE-START | Running 2 tests 04:21:08 INFO - TEST-START | dromaeo_css 04:21:08 INFO - operating with platform_type : linux_ 04:21:08 INFO - Initialising browser for dromaeo_css test... 04:21:08 INFO - TEST-INFO | started process 7430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk3apMI/profile http://localhost:40500/getInfo.html) 04:21:08 INFO - PID 7430 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2932: String.localeCompare is deprecated; use String.prototype.localeCompare instead 04:21:12 INFO - PID 7430 | __metrics Screen width/height:1600/1200 04:21:12 INFO - PID 7430 | colorDepth:24 04:21:12 INFO - PID 7430 | Browser inner width/height: 1024/695 04:21:12 INFO - PID 7430 | __metrics 04:21:14 INFO - TEST-INFO | 7430: exit 0 04:21:14 INFO - Browser initialized. 04:21:14 INFO - Running cycle 1/1 for dromaeo_css test... 04:21:14 INFO - TEST-INFO | started process 7615 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk3apMI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:25 INFO - PID 7615 | RSS: Main: 165777408 04:21:25 INFO - PID 7615 | 04:24:32 INFO - PID 7615 | Cycle 1(1): loaded http://localhost:40500/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40500/tests/dromaeo/cssquery-ext.html) 04:24:33 INFO - PID 7615 | RSS: Main: 171667456 04:24:33 INFO - PID 7615 | 04:27:35 INFO - PID 7615 | Cycle 1(1): loaded http://localhost:40500/tests/dromaeo/cssquery-ext.html (next: http://localhost:40500/tests/dromaeo/cssquery-jquery.html) 04:27:36 INFO - PID 7615 | RSS: Main: 170803200 04:27:36 INFO - PID 7615 | 04:30:38 INFO - PID 7615 | Cycle 1(1): loaded http://localhost:40500/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40500/tests/dromaeo/cssquery-mootools.html) 04:30:39 INFO - PID 7615 | RSS: Main: 174473216 04:30:39 INFO - PID 7615 | 04:33:40 INFO - PID 7615 | Cycle 1(1): loaded http://localhost:40500/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40500/tests/dromaeo/cssquery-prototype.html) 04:33:41 INFO - PID 7615 | RSS: Main: 170803200 04:33:41 INFO - PID 7615 | 04:36:44 INFO - PID 7615 | Cycle 1(1): loaded http://localhost:40500/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40500/tests/dromaeo/cssquery-yui.html) 04:36:45 INFO - PID 7615 | RSS: Main: 171286528 04:36:45 INFO - PID 7615 | 04:39:47 INFO - PID 7615 | Cycle 1(1): loaded http://localhost:40500/tests/dromaeo/cssquery-yui.html (next: http://localhost:40500/tests/dromaeo/cssquery-dojo.html) 04:39:47 INFO - PID 7615 | RSS: Main: 177405952 04:39:47 INFO - PID 7615 | 04:39:47 INFO - PID 7615 | __start_tp_report 04:39:47 INFO - PID 7615 | _x_x_mozilla_page_load 04:39:47 INFO - PID 7615 | _x_x_mozilla_page_load_details 04:39:47 INFO - PID 7615 | |i|pagename|runs| 04:39:47 INFO - PID 7615 | |0;dojo.html;2722.537168681324;2728.959065614015;2742.835429874208;2758.7517123458897;2780.165950214935;5189.792408303663;5263.894722105556;5288.576913846892;5294.258803767476;5345.224942383357;5298.258243845865;5319.574434045277;5332.733363331838;5392.56859451244;5400.648957817739;4432.3573081903105;4696.788644510988;4714.387129673138;4714.834980775673;4745.406824146981;4752.453467851189;4782.28265760137;4785.856424307276;4815.518448155174;4819.927701084486;4635.142498637729;4704.294355846616;4706.552877476634;4716.669833111683;4727.76361181943;4710.31700403443;4723.574878260939;4731.952680473186;4732.479427262998;4735.076660051292;4644.164050470914;4668.089722504113;4675.742834144121;4679.27471241958;4682.321063445781;5210.843674689765;5299.894002119974;5302.655327403706;5303.5226829585135;5309.469053094698;5710.514606258473;5716.942830571724;5718.771249150029;5732.996725573008;5748.626339287933;5758.568107391962;5760;5771.855703607402;5777.682227477487;5778;5323.813666521653;5348.893022139574;5357.732113394315;5358.973205134027;5367.221752845893;5904.940950590525;5921.911171332434;5938.049912014057;5942.435468630473;5948.405159484104;5519.972400137974;5596.720163991784;5624.21261023457;5648.237487939158;5648.463395977457;5652.7738890443925;5695.743691533891;5760.107183386582;5764.596478246566;5771.480566749013;5652.123920792202;5661.264035675335;5663.093904975184;5670.5463562914865;5677.063284558084;5592.832215033555;5655.066913959233;5663.773449061991;5683.630564013409;5684.715764211773;4755.83354582588;4763.809447622126;4831.589314908272;4842.080004799077;4869.099216644932;4081.795910204478;4083.89790255246;4107.363358679409;4108.856190033334;4136.751794892256;4847.854564363075;4849.878753031132;4853.781579828846;4853.95146048535;4902.681325713817;5686.77252909879;5692.943070569241;5705;5712;5741.368449470555;4766.332713420124;4788.808447662124;4790.233562629963;4798.352222449995;4825.252085926687;5067.87330316745;5079.847604571869;5081.364829396325;5091.821786237464;5092.363454568179;5267.420583735862;5267.473252674702;5267.578593712417;5273.44628813969;5275.973620131798;5718.714064296852;5752.309722833287;5813.912791308218;5831.475167234969;5872.823815285548;5211.530962213419;5287.180487024518;5331.733413329395;5343.893122137613;5353.411124776349;5631.1271752878365;5674.574406919415;5681.289838770153;5688.886222275449;5728.140778883201;5571.415001424792;5574.331080270232;5672.03575392176;5713.485786279255;5760.8271751847515;5520.7515661796115;5577.693226872561;5604.971975140262;5618.831435056954;5652.689102099424;5571.470710282517;5571.7492712828835;5575.330960284792;5597.44025597437;5602.907433050516;5422.186671999074;5490.945090549203;5517.924004819182;5520.033994051106;5588;5524.281843360337;5597.496225339576;5625.943740562706;5644.576656750678;5692.345380281321;5439.945600543944;5442.156465747816;5449.618526703092;5454.018276710071;5471.261379713687 04:39:47 INFO - PID 7615 | |1;ext.html;675.6013951768457;698.8846840271356;1002.3284399452366;1022.718752343106;1112.8775834658181;32830.34339313212;33646;33665.15837104071;33736.83131584342;33856.830715846445;31704.20739481514;31759.04722858318;32041.35917281653;32117;32125.839370803114;6361.8409539761415;6493.902591461132;6801.761938332159;6966.024756534064;7001.404880585156;6901.378875901168;6911.48163887708;6998.335158159992;7003.859922801541;7009.82475438113;6968.860622787542;7022.929770702304;7030.13701369135;7044.084269045043;7046.85906281874;6919.827004324882;6954.478414118961;6985.441164706836;6987.37113659768;7006.684699188523;6840.657967101625;6893.655317234168;6904.654767261667;6905.827354316132;6917.031615573824;31090.53364199539;31268.843655781802;31304.8434757827;31313;31551.684483155102;3056.0678992907156;3082.1370016395445;3082.1678146900213;3092.103290045884;3097.984510077458;24060.39849003789;24320;24357.26928192157;24372.512549748906;24383.26850194497;3120.0951724000015;3120.1419609607315;3128.4994400895976;3132.7023932726356;3159.7472202223767;143669.28165359105;145239.27380363137;145304.273478633;145564;145699;37603.24793504169;39478.60521394749;39512.802435987636;39789.40315895264;39848.60151398449;41396;41434.58565414367;41435;41457;41476.585234147875;12082.818757718642;12121.939390302992;12164.209326393757;12178.330191839357;12215.755684886253;9518.90481095194;9534.809303813885;9556.761080972892;9564.61741530331;9661.661841835503;12605;12688.6827829305;12712.555060572835;12795.168314059556;12869.356532173353;5238.292830467838;5280.9471905281225;5309.778750887241;5311.628186026941;5390.4879036491475;889.3063410539789;918.5820451694462;919.1268295119663;926.1248120526038;947.7962238118838;19940.20239190445;20407.8979605101;21356;21459.89270053671;21604.56790864174;981.7692842182081;990.7523119220195;998.5855869814092;1008.6620981971122;1014.5130337438071;10938.56245750161;11239.462382694306;11476.713082172846;11480.253783504046;11545.268209768601;182646;183547;183988;184000;185199;40131.19737605232;40336.1932761349;40418.79790601087;40428.79785601112;40573.594264057574;1212.5695378140808;1258.4840215511597;1263.0274688489994;1264.8735126487277;1267.6830792301926;19586.8041319585;19822.306219282254;20323.59352812906;20774.376768696962;21212.57574848525;28952.565711514766;28983.7101628981;29043.12870613885;29098.709012910447;29101.12696619105;148998;149046;149067;149280;149297.25351373173;28719.569206462336;28945.276368090123;29176;31072.22319442032;31316.060518183578;37114.25771484609;37194.256114878095;37512;37656.623433765315;37699.62300376961;26290.21129366122;27133.1860044199;27601.44576144994;27694.861525692242;27843.860780696778;26552.601710973966;27036.864815675795;27475.725242747318;27544.17367478979;28637.570436443886;30895.536566951065;30955.523558115747;31003.689963100984;31011.224719382197;31042;26562.86718566395;26730.19809405721;27171.1848644541;27635.585466218425;28347.43305133927;21600.459988500414;22563.661545077164;22905.31284061481;22984.540309193388;23040.193593224158 04:39:47 INFO - PID 7615 | |2;jquery.html;415.9272127377708;422.5689796407663;429.32613008868606;437.56243756243754;439.1809275700815;17203.741943870835;17426.47720568382;17740.822591774064;17923.82076179238;18066.63866722665;17357.264273572637;17671.293148274053;17773.200205990728;17862.374816881413;17965.19156637951;5252.579793616502;5293.86765330866;5420.07858664028;5436.374816896048;5439.265699130626;5334.866628334304;5360.678359298455;5429.4027656957705;5542.057850165482;5591.133374326986;5494.752736126864;5532.2531458253225;5542.057850165462;5549.6115271930985;5551.528120109775;5435.945640543583;5464.890702185974;5483.424240454735;5498.725063746797;5521.116621340586;4959;4972.279019542182;5013.874653133665;5016.648834581581;5026.421961474441;21621.135154593954;21653.35039948804;21924.561508769893;21954.4511387215;22186;1626.715324818152;1643.909584972826;1648.0606054548912;1648.9505314840574;1652.4051341517045;14292.213928233943;14466.27668616565;14532.782008269778;14722.263886805724;14826.33281502335;2051.2666796556887;2080.823130033949;2083;2085.384811480617;2091.602595506864;88883.55558222167;99276.50361748217;101150.49424752829;101211.99999999926;102682.48658756659;10872.18458615607;11078.224524283223;11093.611723589796;11167.497462614201;11368.772624547462;15560.688786224438;15605.921970390302;15629.452969146025;15662;15667.921660391854;6908.812563273127;7008.369246767816;7083.18543367509;7087.787366379017;7099;6189.938100619026;6217.129601855744;6323;6344.238691356974;6383.265924418658;6908.447324214051;6926.376626103674;7062.858742825115;7100;7111.573305601681;2037.9184832606827;2046.92835750748;2107.5258066934816;2117.1319758898776;2188.8796116213443;836.7113345895656;857.2456238510072;862.7886167888907;879.2218886285683;892.0900681305033;16593.170341482877;16706.83293167077;16949.06780127105;17098.14509274531;17426.47720568385;851.5827244650077;858.7380848841163;861.6510313323114;874.0691163910415;892.3708785306344;9263.76840578991;9499.952500237592;9581.568829402693;9599.760005999766;9702.95148524267;335672;337329;354186;355201;355656;74687.62656186793;75189.6240518794;75477;75812.62093689496;75927;991.2020823237219;1002.7894142230067;1029.433811403725;1030.3199888073834;1034.943078130695;14062.507812226522;14241.64395890111;14345.497907573184;14463.204523751294;15084.472043478425;36373;36518;37137.25725485529;37243.81378093092;37537.812310939364;45651;46142;46389.76805115953;46995;47034.29448558343;8277.089520152898;8320.625571849403;8514.063453020286;8540.44487108336;8732.170443808081;13051.543195988095;13157.473701051851;13212.735745285232;13296.800547991981;13438;10747.838782418114;10934.125269978224;10979.83530247031;11031.83452248233;11050.889491105308;10263.948680256552;10381.9480902595;10438.895611043792;10465.476726163814;10530.947345263225;10950.561977521129;10966.287191332538;10981;10990.505427255634;11094.778104438028;8105.959470202612;8434.665218712513;8493.532855692996;8613.65545378178;8927.419717718327;11187.384693841592;11289.71775705614;11390.54437822511;11394.430278485877;11456.3698996556 04:39:47 INFO - PID 7615 | |3;mootools.html;1250.468550865882;1313.7635225659383;1318.2646009530226;1328.4752522753515;1332.7534406134866;10160.898391016088;10610.257281990263;10672.78654426912;10679.946600266998;10903.781924361509;10741.140708743302;10823.783524329509;10985.363512756941;11001.284916480423;11019.228653994223;2213.4245096275004;2253.8422310438277;2258.9096436142536;2271.8409711320214;2279.168103642167;2085.947851303722;2149.7420309562876;2151.4191168384527;2166.144372972675;2169.663702126165;2168;2176.173054239395;2220.245116660335;2229.15292188968;2229.732432108149;2128.1912873108276;2162.2648299578063;2164.8701077935216;2165.5127596290945;2170.1536400803698;1878.6430578190236;1893.8579606529427;2068.069368784053;2179.683945827862;2185.4754858833926;10489.527971241312;10521.421321827296;10552.419616921066;10585.629502967437;10592.205584581186;5573.08044172711;5798.768049278066;5834.154047663065;5838.124281357788;5838.7080645967535;3366.8148251846137;3595.209054008114;3660.963390366089;3662.5421822272215;3667.9083022924374;1105.209775010871;1117.9161562882816;1148.328227986629;1159.4376727287258;1165.626999360205;15469.922650386789;15539.456119035893;15591.532254032398;15600.29798659063;15610.019445041555;4620.214563524209;4763.404574428197;4784;4865.95134048655;5002.399712034579;10603.621529201155;10672.573097076185;10681.198910081775;10735.087517560938;10750.139988800876;5403.729813509387;5426.213199086111;5433.891322173614;5453.618246722771;5453.945460545423;4936.802527898843;5022.447530771612;5081.2632168335385;5142.331496905378;5165.845024649267;3827.2154208387215;3941.1329507508303;3993.520777506718;4019.5176578810147;4045.19096180765;1147.4262868565718;1150.0626989003936;1158.6466127831093;1162.6279590530949;1179.1392283632997;666.0508774995612;694.1808665774333;696.5472442912147;711.3597762014228;715.9427245820322;5207.921881171786;5330.9733451332495;5363.865903352447;5434.561468800397;5458.879618593548;543.8341305901658;545.3156288857538;549.2420459765577;553.6318348298418;563.4140493886313;3362.9327413451592;3478.252175782219;3530.6645868642436;3599.2981368632863;3710.7588006779474;13007;13634.795478067837;13758.243296618582;13786.310684465736;13810.861891380957;13200.669983250496;13402.329883505981;13484.258365789976;13683.863161368457;13717.794233086512;7581.50720203196;7664.080310362792;7666.348360389429;7666.655000524878;7680.500767450098;5570.136628822539;5573.414791446839;5590.329160500766;5662.8301150965535;5739.282589676291;12054.75890482168;12094.516219351128;12189.573364932185;12215;12269.815952760895;12089.274643521418;12554.309512976508;12673.429695663533;12714;12734.872651273368;7976.322012628992;8168.918310817054;8285.295749861329;8375.916240837514;8376.078631350669;9932.106110450095;9933.751656208653;10045.49772511386;10048.748781280527;10067.194624429882;8240.876386854321;8358.205970432798;8428.325733941147;8487.36344774132;8635.784105397415;8051.35589152878;8185.836283274182;8238.876416853633;8286.502809831429;8492.023417306842;7624.313811756747;7708.8072798178255;7759.107702614046;7767.495112817649;7772.57250851186;5067.543921047123;5119.74401279942;5198.4801519847715;5207.140821764518;5290.153575427913;5201.557867581298;5322.54758345545;5330.413654498079;5377.833125778331;5382.865428364165 04:39:47 INFO - PID 7615 | |4;prototype.html;362.21760996248094;362.65004270878603;366.6736604422063;371.7323527060517;377.79787813519766;5417.6207665463335;5517.36550296716;5531.197976293435;5544.722763861801;5575.8884822303635;5349.251104845315;5390.811321603745;5415.864603384917;5420.268263784388;5436.3476382834015;3937.9212415751667;4054.2702313583545;4066.4916885389325;4072.617518751534;4075.7758323292205;4040.1717647882115;4057.452243947059;4065.4918135233097;4068.4304197412384;4074.9592504075026;4017.1563971566006;4025.7987100644996;4035.6367926886574;4039.899002524946;4042.4542686737354;3893.649571538575;4029.194161167778;4038.8586399475876;4042.4946881639794;4050.7164498485267;3493.755437119403;3497.8251087445524;3500.2474467989505;3502.3345564342694;3511.4908338290807;5323.840284791462;5324.8136315228785;5349.732513374354;5350.411454739976;5354.785808567653;4697.6241900647865;4753.5959443447;4764.213904705719;4773.140834649762;4778.665493415462;5681.23303354046;5709.486146246858;5754.971225143848;5757.280339957505;5775.971120144414;3899.78551179685;3921.7646941183334;3925.3130702127014;3928.7446315989655;3941.960580394217;5638.532302633851;6000.729967151445;6033.3754816654455;6109.175261339707;6129.264488261392;3987.6809855211513;4008.3987401889367;4034.374671925856;4036.6880763751897;4056.6146216109423;4082.9183416331507;4086.693497987603;4088.1210539733506;4105.91788164241;4106.589341065869;4755.167845627001;4755.476897541268;4761.309610106585;4766.332713420124;4771.141194585008;5542.91685624716;5747.959474386616;5788.27646544182;5820.330661973842;5830.183774271605;1385.9307034648227;1399.2793711238721;1400.0479673821899;1403.2282244765338;1404.1294397473632;896.4531635702347;938.7277689470113;942.2697409507687;948.9240860731124;953.3517208298424;4997.175466048134;5004.974975125174;5015.22264049073;5025.969676216367;5033.345665063592;6028.487578555872;6050.606710563799;6057.3336932937345;6061.333253342129;6070.3019152797115;4878.585320247818;4983.227599722049;4986.626003049786;4998.175301075355;5007.899842003139;3171.1120886151916;3191.6010498687665;3198.1524895902603;3209.4543927532377;3229.01515037911;5448.455154484599;5511.8149597836655;5569.721513924287;5581.386047534768;5590.832275031756;5960.731767070492;6094.329623741385;6131.294901086432;6135;6188.381161883775;5563.304586926634;5565.554755619541;5581.581381396411;5594.384617692051;5622.8313150605545;5939.1982082420045;6006.87986240264;6013;6019.187409699634;6022.45797878193;5919.934411805916;5958.910616340845;5975.521958243417;5976.312724036791;6000.969995149996;5587.1339942309005;5591.832245032656;5616.494515493625;5618.634788738719;5637;4013.4381186634478;4034.8789536313957;4058.2086493133556;4083.4079058535754;4085.407615895619;6061.363556826646;6065.302490213682;6070.028795392716;6076.361981991828;6089.208402907594;5859.326177489473;5863.882722345444;5868.9504242072835;5871.853203669943;5916.142159386951;5738.713064346849;5830.219220239363;5850.414958504286;5860.736266868086;5886.028805247086;5749.425057494217;5781.190633311256;5784.566157538117;5795.797147099831;5810.389909059488;5723.771049157987;5858.794942177004;5895.764169433174;5912.645241285537;5919.467247947706;5744.971275143597;5750.539956803362;5763.94236057634;5768.971155144198;5771.480566749013 04:39:47 INFO - PID 7615 | |5;yui.html;743.6393349225629;757.5189754505889;763.9923600763991;769.7844603511015;775.7013549783334;13228.206307621538;14039.859601403983;14130;16166;17573.472795816113;16090.919545402287;16269.83730162698;16277.918610406961;16339.754903676454;16794.32822687094;901.2789768185442;912.1562554636968;916.5737931861682;916.9816603667923;917.7017469322464;877.627008521379;907.7004588485784;917.3532659475054;921.7741653294952;922.921551668109;962.3263715399214;968.1335204991528;969.4764826993451;969.92725545584;970.175350951689;950.0404591362774;954.2127744610724;955.9378640388353;958.6117622362954;960.0351646595198;710.8294009437749;713.1086142322098;713.2724620886667;713.7644577289534;715.0382735221119;13266.535671251557;13304.467821287137;13362.933185334108;13447.260400677958;13710.108842925178;15338.769918451233;15593.37626494939;15607.531774046796;15817;15900;12775;12909.225446473241;13039.282839443827;13056.673583160402;13105.737885242243;3077.9076627701206;3091.938161236763;3113.828739419331;3113.937721245585;3118.189270789611;64515.03227451639;67607.66196169036;69466;69897.65051174762;71108.28891711068;12821.35893205336;13112.541061062817;13162.341882905816;13234;13307.401166947511;22572.54854902893;22732.545349092925;22789.772102279097;22838.200662976717;23254.418639533807;6032.517398608188;6198.690065496708;6203.2245969253845;6205.906911396332;6266.185395898504;2989.6412430508044;3063.6323641162758;3068.202267410489;3073.339232065117;3075.969550200663;3681.0613293610495;3729.8321575529167;3788.6021967693546;3798.525184351956;3853.2871418787613;738.3391864281438;740.3189066059239;761.9466637335444;763.1033535595653;764.453415807689;551.6386766667839;565.8585353661584;569.4277251362354;579;589.9882002360015;8990.775230619287;9029.63881444735;9128.634854605874;9532.142107210384;9590.472524011246;533.4585395823243;545.2693390856272;545.312905738772;552.7733629212004;557.3785229469113;4067.6949228807957;4205.201011807747;4305.720128191658;4379.386885835986;4389.341598760211;62911.37088629055;63172.36827631757;63431.6828415855;65574.83590043455;66162;56364.71817640885;57318.713406432704;57825.71087144537;58740.412595874346;61169.38830611726;51469.536917146805;52233.47766522362;53118.468815312124;54286.72856635691;55076.72461637746;8773.956130219309;8844.778880528038;8919;9225.308101892251;9228;24821.62767558524;25406.491870162863;25668.614970775827;26082.478350433266;26344;31608.36783264368;32030.679693203703;32034.35931281408;32582;32672;11443.198976071595;11527.942360288145;11712.355820429959;11814.409279536161;11859.762804744028;13123.868761312646;13207.537736179187;13228;13319.800202996768;13724.382402791698;10791.730206744895;10832.891671083189;11018.1185505161;11063.059639930374;11253.043491303004;12362.505499779909;12480.812787808009;12626.053046021769;13776.517821876187;14366.13803171813;14743;14761.114333140045;14861.256937153315;14926.402943882124;15012.849871501145;10874.075703565286;10895.56417743313;10902.18233632465;11088.895109369389;11252.774944501229;10987.121030317396;11101.561452056045;11781.175317727677;11828.881711182778;11859.288442693465 04:39:47 INFO - PID 7615 | __end_tp_report 04:39:47 INFO - PID 7615 | __start_cc_report 04:39:47 INFO - PID 7615 | _x_x_mozilla_cycle_collect,290 04:39:47 INFO - PID 7615 | __end_cc_report 04:39:47 INFO - PID 7615 | __startTimestamp1494934787390__endTimestamp 04:39:47 INFO - PID 7615 | 04:39:47 INFO - PID 7615 | ------- Summary: start ------- 04:39:47 INFO - PID 7615 | Number of tests: 6 04:39:47 INFO - PID 7615 | 04:39:47 INFO - PID 7615 | [#0] dojo.html Cycles:165 Average:5226.30 Median:5367.22 stddev:621.72 (11.6%) stddev-sans-first:591.79 04:39:47 INFO - PID 7615 | Values: 2722.5 2729.0 2742.8 2758.8 2780.2 5189.8 5263.9 5288.6 5294.3 5345.2 5298.3 5319.6 5332.7 5392.6 5400.6 4432.4 4696.8 4714.4 4714.8 4745.4 4752.5 4782.3 4785.9 4815.5 4819.9 4635.1 4704.3 4706.6 4716.7 4727.8 4710.3 4723.6 4732.0 4732.5 4735.1 4644.2 4668.1 4675.7 4679.3 4682.3 5210.8 5299.9 5302.7 5303.5 5309.5 5710.5 5716.9 5718.8 5733.0 5748.6 5758.6 5760.0 5771.9 5777.7 5778.0 5323.8 5348.9 5357.7 5359.0 5367.2 5904.9 5921.9 5938.0 5942.4 5948.4 5520.0 5596.7 5624.2 5648.2 5648.5 5652.8 5695.7 5760.1 5764.6 5771.5 5652.1 5661.3 5663.1 5670.5 5677.1 5592.8 5655.1 5663.8 5683.6 5684.7 4755.8 4763.8 4831.6 4842.1 4869.1 4081.8 4083.9 4107.4 4108.9 4136.8 4847.9 4849.9 4853.8 4854.0 4902.7 5686.8 5692.9 5705.0 5712.0 5741.4 4766.3 4788.8 4790.2 4798.4 4825.3 5067.9 5079.8 5081.4 5091.8 5092.4 5267.4 5267.5 5267.6 5273.4 5276.0 5718.7 5752.3 5813.9 5831.5 5872.8 5211.5 5287.2 5331.7 5343.9 5353.4 5631.1 5674.6 5681.3 5688.9 5728.1 5571.4 5574.3 5672.0 5713.5 5760.8 5520.8 5577.7 5605.0 5618.8 5652.7 5571.5 5571.7 5575.3 5597.4 5602.9 5422.2 5490.9 5517.9 5520.0 5588.0 5524.3 5597.5 5625.9 5644.6 5692.3 5439.9 5442.2 5449.6 5454.0 5471.3 04:39:47 INFO - PID 7615 | 04:39:47 INFO - PID 7615 | [#1] ext.html Cycles:180 Average:30263.94 Median:31007.46 stddev:41368.85 (133.4%) stddev-sans-first:41425.23 04:39:47 INFO - PID 7615 | Values: 675.6 698.9 1002.3 1022.7 1112.9 32830.3 33646.0 33665.2 33736.8 33856.8 31704.2 31759.0 32041.4 32117.0 32125.8 6361.8 6493.9 6801.8 6966.0 7001.4 6901.4 6911.5 6998.3 7003.9 7009.8 6968.9 7022.9 7030.1 7044.1 7046.9 6919.8 6954.5 6985.4 6987.4 7006.7 6840.7 6893.7 6904.7 6905.8 6917.0 31090.5 31268.8 31304.8 31313.0 31551.7 3056.1 3082.1 3082.2 3092.1 3098.0 24060.4 24320.0 24357.3 24372.5 24383.3 3120.1 3120.1 3128.5 3132.7 3159.7 143669.3 145239.3 145304.3 145564.0 145699.0 37603.2 39478.6 39512.8 39789.4 39848.6 41396.0 41434.6 41435.0 41457.0 41476.6 12082.8 12121.9 12164.2 12178.3 12215.8 9518.9 9534.8 9556.8 9564.6 9661.7 12605.0 12688.7 12712.6 12795.2 12869.4 5238.3 5280.9 5309.8 5311.6 5390.5 889.3 918.6 919.1 926.1 947.8 19940.2 20407.9 21356.0 21459.9 21604.6 981.8 990.8 998.6 1008.7 1014.5 10938.6 11239.5 11476.7 11480.3 11545.3 182646.0 183547.0 183988.0 184000.0 185199.0 40131.2 40336.2 40418.8 40428.8 40573.6 1212.6 1258.5 1263.0 1264.9 1267.7 19586.8 19822.3 20323.6 20774.4 21212.6 28952.6 28983.7 29043.1 29098.7 29101.1 148998.0 149046.0 149067.0 149280.0 149297.3 28719.6 28945.3 29176.0 31072.2 31316.1 37114.3 37194.3 37512.0 37656.6 37699.6 26290.2 27133.2 27601.4 27694.9 27843.9 26552.6 27036.9 27475.7 27544.2 28637.6 30895.5 30955.5 31003.7 31011.2 31042.0 26562.9 26730.2 27171.2 27635.6 28347.4 21600.5 22563.7 22905.3 22984.5 23040.2 04:39:47 INFO - PID 7615 | 04:39:47 INFO - PID 7615 | [#2] jquery.html Cycles:180 Average:24296.84 Median:355428.50 stddev:58375.49 (16.4%) stddev-sans-first:58511.71 04:39:47 INFO - PID 7615 | Values: 415.9 422.6 429.3 437.6 439.2 17203.7 17426.5 17740.8 17923.8 18066.6 17357.3 17671.3 17773.2 17862.4 17965.2 5252.6 5293.9 5420.1 5436.4 5439.3 5334.9 5360.7 5429.4 5542.1 5591.1 5494.8 5532.3 5542.1 5549.6 5551.5 5435.9 5464.9 5483.4 5498.7 5521.1 4959.0 4972.3 5013.9 5016.6 5026.4 21621.1 21653.4 21924.6 21954.5 22186.0 1626.7 1643.9 1648.1 1649.0 1652.4 14292.2 14466.3 14532.8 14722.3 14826.3 2051.3 2080.8 2083.0 2085.4 2091.6 88883.6 99276.5 101150.5 101212.0 102682.5 10872.2 11078.2 11093.6 11167.5 11368.8 15560.7 15605.9 15629.5 15662.0 15667.9 6908.8 7008.4 7083.2 7087.8 7099.0 6189.9 6217.1 6323.0 6344.2 6383.3 6908.4 6926.4 7062.9 7100.0 7111.6 2037.9 2046.9 2107.5 2117.1 2188.9 836.7 857.2 862.8 879.2 892.1 16593.2 16706.8 16949.1 17098.1 17426.5 851.6 858.7 861.7 874.1 892.4 9263.8 9500.0 9581.6 9599.8 9703.0 335672.0 337329.0 354186.0 355201.0 355656.0 74687.6 75189.6 75477.0 75812.6 75927.0 991.2 1002.8 1029.4 1030.3 1034.9 14062.5 14241.6 14345.5 14463.2 15084.5 36373.0 36518.0 37137.3 37243.8 37537.8 45651.0 46142.0 46389.8 46995.0 47034.3 8277.1 8320.6 8514.1 8540.4 8732.2 13051.5 13157.5 13212.7 13296.8 13438.0 10747.8 10934.1 10979.8 11031.8 11050.9 10263.9 10381.9 10438.9 10465.5 10530.9 10950.6 10966.3 10981.0 10990.5 11094.8 8106.0 8434.7 8493.5 8613.7 8927.4 11187.4 11289.7 11390.5 11394.4 11456.4 04:39:47 INFO - PID 7615 | 04:39:47 INFO - PID 7615 | [#3] mootools.html Cycles:180 Average:6382.25 Median:3504.46 stddev:4189.16 (119.5%) stddev-sans-first:4183.17 04:39:47 INFO - PID 7615 | Values: 1250.5 1313.8 1318.3 1328.5 1332.8 10160.9 10610.3 10672.8 10679.9 10903.8 10741.1 10823.8 10985.4 11001.3 11019.2 2213.4 2253.8 2258.9 2271.8 2279.2 2085.9 2149.7 2151.4 2166.1 2169.7 2168.0 2176.2 2220.2 2229.2 2229.7 2128.2 2162.3 2164.9 2165.5 2170.2 1878.6 1893.9 2068.1 2179.7 2185.5 10489.5 10521.4 10552.4 10585.6 10592.2 5573.1 5798.8 5834.2 5838.1 5838.7 3366.8 3595.2 3661.0 3662.5 3667.9 1105.2 1117.9 1148.3 1159.4 1165.6 15469.9 15539.5 15591.5 15600.3 15610.0 4620.2 4763.4 4784.0 4866.0 5002.4 10603.6 10672.6 10681.2 10735.1 10750.1 5403.7 5426.2 5433.9 5453.6 5453.9 4936.8 5022.4 5081.3 5142.3 5165.8 3827.2 3941.1 3993.5 4019.5 4045.2 1147.4 1150.1 1158.6 1162.6 1179.1 666.1 694.2 696.5 711.4 715.9 5207.9 5331.0 5363.9 5434.6 5458.9 543.8 545.3 549.2 553.6 563.4 3362.9 3478.3 3530.7 3599.3 3710.8 13007.0 13634.8 13758.2 13786.3 13810.9 13200.7 13402.3 13484.3 13683.9 13717.8 7581.5 7664.1 7666.3 7666.7 7680.5 5570.1 5573.4 5590.3 5662.8 5739.3 12054.8 12094.5 12189.6 12215.0 12269.8 12089.3 12554.3 12673.4 12714.0 12734.9 7976.3 8168.9 8285.3 8375.9 8376.1 9932.1 9933.8 10045.5 10048.7 10067.2 8240.9 8358.2 8428.3 8487.4 8635.8 8051.4 8185.8 8238.9 8286.5 8492.0 7624.3 7708.8 7759.1 7767.5 7772.6 5067.5 5119.7 5198.5 5207.1 5290.2 5201.6 5322.5 5330.4 5377.8 5382.9 04:39:47 INFO - PID 7615 | 04:39:47 INFO - PID 7615 | [#4] prototype.html Cycles:180 Average:4747.76 Median:5442.40 stddev:1440.60 (26.5%) stddev-sans-first:1406.53 04:39:47 INFO - PID 7615 | Values: 362.2 362.7 366.7 371.7 377.8 5417.6 5517.4 5531.2 5544.7 5575.9 5349.3 5390.8 5415.9 5420.3 5436.3 3937.9 4054.3 4066.5 4072.6 4075.8 4040.2 4057.5 4065.5 4068.4 4075.0 4017.2 4025.8 4035.6 4039.9 4042.5 3893.6 4029.2 4038.9 4042.5 4050.7 3493.8 3497.8 3500.2 3502.3 3511.5 5323.8 5324.8 5349.7 5350.4 5354.8 4697.6 4753.6 4764.2 4773.1 4778.7 5681.2 5709.5 5755.0 5757.3 5776.0 3899.8 3921.8 3925.3 3928.7 3942.0 5638.5 6000.7 6033.4 6109.2 6129.3 3987.7 4008.4 4034.4 4036.7 4056.6 4082.9 4086.7 4088.1 4105.9 4106.6 4755.2 4755.5 4761.3 4766.3 4771.1 5542.9 5748.0 5788.3 5820.3 5830.2 1385.9 1399.3 1400.0 1403.2 1404.1 896.5 938.7 942.3 948.9 953.4 4997.2 5005.0 5015.2 5026.0 5033.3 6028.5 6050.6 6057.3 6061.3 6070.3 4878.6 4983.2 4986.6 4998.2 5007.9 3171.1 3191.6 3198.2 3209.5 3229.0 5448.5 5511.8 5569.7 5581.4 5590.8 5960.7 6094.3 6131.3 6135.0 6188.4 5563.3 5565.6 5581.6 5594.4 5622.8 5939.2 6006.9 6013.0 6019.2 6022.5 5919.9 5958.9 5975.5 5976.3 6001.0 5587.1 5591.8 5616.5 5618.6 5637.0 4013.4 4034.9 4058.2 4083.4 4085.4 6061.4 6065.3 6070.0 6076.4 6089.2 5859.3 5863.9 5869.0 5871.9 5916.1 5738.7 5830.2 5850.4 5860.7 5886.0 5749.4 5781.2 5784.6 5795.8 5810.4 5723.8 5858.8 5895.8 5912.6 5919.5 5745.0 5750.5 5763.9 5769.0 5771.5 04:39:47 INFO - PID 7615 | 04:39:47 INFO - PID 7615 | [#5] yui.html Cycles:180 Average:15103.89 Median:3705.45 stddev:18059.18 (487.4%) stddev-sans-first:18077.64 04:39:47 INFO - PID 7615 | Values: 743.6 757.5 764.0 769.8 775.7 13228.2 14039.9 14130.0 16166.0 17573.5 16090.9 16269.8 16277.9 16339.8 16794.3 901.3 912.2 916.6 917.0 917.7 877.6 907.7 917.4 921.8 922.9 962.3 968.1 969.5 969.9 970.2 950.0 954.2 955.9 958.6 960.0 710.8 713.1 713.3 713.8 715.0 13266.5 13304.5 13362.9 13447.3 13710.1 15338.8 15593.4 15607.5 15817.0 15900.0 12775.0 12909.2 13039.3 13056.7 13105.7 3077.9 3091.9 3113.8 3113.9 3118.2 64515.0 67607.7 69466.0 69897.7 71108.3 12821.4 13112.5 13162.3 13234.0 13307.4 22572.5 22732.5 22789.8 22838.2 23254.4 6032.5 6198.7 6203.2 6205.9 6266.2 2989.6 3063.6 3068.2 3073.3 3076.0 3681.1 3729.8 3788.6 3798.5 3853.3 738.3 740.3 761.9 763.1 764.5 551.6 565.9 569.4 579.0 590.0 8990.8 9029.6 9128.6 9532.1 9590.5 533.5 545.3 545.3 552.8 557.4 4067.7 4205.2 4305.7 4379.4 4389.3 62911.4 63172.4 63431.7 65574.8 66162.0 56364.7 57318.7 57825.7 58740.4 61169.4 51469.5 52233.5 53118.5 54286.7 55076.7 8774.0 8844.8 8919.0 9225.3 9228.0 24821.6 25406.5 25668.6 26082.5 26344.0 31608.4 32030.7 32034.4 32582.0 32672.0 11443.2 11527.9 11712.4 11814.4 11859.8 13123.9 13207.5 13228.0 13319.8 13724.4 10791.7 10832.9 11018.1 11063.1 11253.0 12362.5 12480.8 12626.1 13776.5 14366.1 14743.0 14761.1 14861.3 14926.4 15012.8 10874.1 10895.6 10902.2 11088.9 11252.8 10987.1 11101.6 11781.2 11828.9 11859.3 04:39:47 INFO - PID 7615 | -------- Summary: end -------- 04:39:47 INFO - PID 7615 | 04:39:48 INFO - TEST-INFO | 7615: exit 0 04:39:48 INFO - TEST-OK | dromaeo_css | took 1120058ms 04:39:48 INFO - TEST-START | kraken 04:39:48 INFO - operating with platform_type : linux_ 04:39:48 INFO - Initialising browser for kraken test... 04:39:48 INFO - TEST-INFO | started process 8047 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7addog/profile http://localhost:40500/getInfo.html) 04:39:48 INFO - PID 8047 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2932: String.localeCompare is deprecated; use String.prototype.localeCompare instead 04:39:52 INFO - PID 8047 | __metrics Screen width/height:1600/1200 04:39:52 INFO - PID 8047 | colorDepth:24 04:39:52 INFO - PID 8047 | Browser inner width/height: 1024/695 04:39:52 INFO - PID 8047 | __metrics 04:39:54 INFO - TEST-INFO | 8047: exit 0 04:39:54 INFO - Browser initialized. 04:39:54 INFO - Running cycle 1/1 for kraken test... 04:39:54 INFO - TEST-INFO | started process 8235 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7addog/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:05 INFO - PID 8235 | RSS: Main: 165707776 04:40:05 INFO - PID 8235 | 04:40:08 INFO - PID 8235 | Cycle 1(1): loaded http://localhost:40500/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40500/tests/kraken/driver.html?testName=audio-beat-detection) 04:40:09 INFO - PID 8235 | RSS: Main: 170708992 04:40:09 INFO - PID 8235 | 04:40:12 INFO - PID 8235 | Cycle 1(1): loaded http://localhost:40500/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40500/tests/kraken/driver.html?testName=audio-dft) 04:40:12 INFO - PID 8235 | RSS: Main: 170487808 04:40:12 INFO - PID 8235 | 04:40:15 INFO - PID 8235 | Cycle 1(1): loaded http://localhost:40500/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40500/tests/kraken/driver.html?testName=audio-fft) 04:40:16 INFO - PID 8235 | RSS: Main: 165707776 04:40:16 INFO - PID 8235 | 04:40:18 INFO - PID 8235 | Cycle 1(1): loaded http://localhost:40500/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40500/tests/kraken/driver.html?testName=audio-oscillator) 04:40:19 INFO - PID 8235 | RSS: Main: 166133760 04:40:19 INFO - PID 8235 | 04:40:21 INFO - PID 8235 | Cycle 1(1): loaded http://localhost:40500/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40500/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:40:21 INFO - PID 8235 | RSS: Main: 166477824 04:40:21 INFO - PID 8235 | 04:40:24 INFO - PID 8235 | Cycle 1(1): loaded http://localhost:40500/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40500/tests/kraken/driver.html?testName=imaging-darkroom) 04:40:25 INFO - PID 8235 | RSS: Main: 170483712 04:40:25 INFO - PID 8235 | 04:40:29 INFO - PID 8235 | Cycle 1(1): loaded http://localhost:40500/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40500/tests/kraken/driver.html?testName=imaging-desaturate) 04:40:29 INFO - PID 8235 | RSS: Main: 168542208 04:40:29 INFO - PID 8235 | 04:40:32 INFO - PID 8235 | Cycle 1(1): loaded http://localhost:40500/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40500/tests/kraken/driver.html?testName=json-parse-financial) 04:40:33 INFO - PID 8235 | RSS: Main: 169066496 04:40:33 INFO - PID 8235 | 04:40:34 INFO - PID 8235 | Cycle 1(1): loaded http://localhost:40500/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40500/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:40:35 INFO - PID 8235 | RSS: Main: 169627648 04:40:35 INFO - PID 8235 | 04:40:37 INFO - PID 8235 | Cycle 1(1): loaded http://localhost:40500/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40500/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:40:37 INFO - PID 8235 | RSS: Main: 169345024 04:40:37 INFO - PID 8235 | 04:40:40 INFO - PID 8235 | Cycle 1(1): loaded http://localhost:40500/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40500/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:40:40 INFO - PID 8235 | RSS: Main: 168820736 04:40:40 INFO - PID 8235 | 04:40:43 INFO - PID 8235 | Cycle 1(1): loaded http://localhost:40500/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:40:44 INFO - PID 8235 | RSS: Main: 169226240 04:40:44 INFO - PID 8235 | 04:40:47 INFO - PID 8235 | Cycle 1(1): loaded http://localhost:40500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:40:48 INFO - PID 8235 | RSS: Main: 169115648 04:40:48 INFO - PID 8235 | 04:40:50 INFO - PID 8235 | Cycle 1(1): loaded http://localhost:40500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40500/tests/kraken/driver.html?testName=ai-astar) 04:40:50 INFO - PID 8235 | RSS: Main: 170340352 04:40:50 INFO - PID 8235 | 04:40:50 INFO - PID 8235 | __start_tp_report 04:40:50 INFO - PID 8235 | _x_x_mozilla_page_load 04:40:50 INFO - PID 8235 | _x_x_mozilla_page_load_details 04:40:50 INFO - PID 8235 | |i|pagename|runs| 04:40:50 INFO - PID 8235 | |0;ai-astar;103;112;111;112;110;110;110;111;110;111 04:40:50 INFO - PID 8235 | |1;audio-beat-detection;157;125;124;185;125;125;125;125;151;127 04:40:50 INFO - PID 8235 | |2;audio-dft;163;166;163;162;162;165;168;173;167;167 04:40:50 INFO - PID 8235 | |3;audio-fft;76;76;76;108;76;79;77;74;97;76 04:40:50 INFO - PID 8235 | |4;audio-oscillator;84;83;108;84;83;83;97;86;83;102 04:40:50 INFO - PID 8235 | |5;imaging-gaussian-blur;118;115;114;114;115;117;114;114;117;114 04:40:50 INFO - PID 8235 | |6;imaging-darkroom;151;151;153;149;152;150;152;152;151;149 04:40:50 INFO - PID 8235 | |7;imaging-desaturate;95;95;94;95;94;95;95;95;95;94 04:40:50 INFO - PID 8235 | |8;json-parse-financial;57;54;53;55;55;55;56;57;54;56 04:40:50 INFO - PID 8235 | |9;json-stringify-tinderbox;55;55;56;56;55;56;56;56;55;55 04:40:50 INFO - PID 8235 | |10;stanford-crypto-aes;86;94;86;84;84;82;83;91;85;85 04:40:50 INFO - PID 8235 | |11;stanford-crypto-ccm;140;141;136;134;136;135;141;132;183;136 04:40:50 INFO - PID 8235 | |12;stanford-crypto-pbkdf2;192;206;201;190;187;205;205;200;212;196 04:40:50 INFO - PID 8235 | |13;stanford-crypto-sha256-iterative;76;78;75;77;75;77;73;75;73;77 04:40:50 INFO - PID 8235 | __end_tp_report 04:40:50 INFO - PID 8235 | __start_cc_report 04:40:50 INFO - PID 8235 | _x_x_mozilla_cycle_collect,788 04:40:50 INFO - PID 8235 | __end_cc_report 04:40:50 INFO - PID 8235 | __startTimestamp1494934850274__endTimestamp 04:40:50 INFO - PID 8235 | 04:40:50 INFO - PID 8235 | ------- Summary: start ------- 04:40:50 INFO - PID 8235 | Number of tests: 14 04:40:50 INFO - PID 8235 | 04:40:50 INFO - PID 8235 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.58 (2.3%) stddev-sans-first:0.83 04:40:50 INFO - PID 8235 | Values: 103.0 112.0 111.0 112.0 110.0 110.0 110.0 111.0 110.0 111.0 04:40:50 INFO - PID 8235 | 04:40:50 INFO - PID 8235 | [#1] audio-beat-detection Cycles:10 Average:136.90 Median:126.00 stddev:20.79 (16.5%) stddev-sans-first:20.74 04:40:50 INFO - PID 8235 | Values: 157.0 125.0 124.0 185.0 125.0 125.0 125.0 125.0 151.0 127.0 04:40:50 INFO - PID 8235 | 04:40:50 INFO - PID 8235 | [#2] audio-dft Cycles:10 Average:165.60 Median:166.50 stddev:3.41 (2.0%) stddev-sans-first:3.48 04:40:50 INFO - PID 8235 | Values: 163.0 166.0 163.0 162.0 162.0 165.0 168.0 173.0 167.0 167.0 04:40:50 INFO - PID 8235 | 04:40:50 INFO - PID 8235 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:11.43 (15.0%) stddev-sans-first:11.95 04:40:50 INFO - PID 8235 | Values: 76.0 76.0 76.0 108.0 76.0 79.0 77.0 74.0 97.0 76.0 04:40:50 INFO - PID 8235 | 04:40:50 INFO - PID 8235 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:83.50 stddev:9.41 (11.3%) stddev-sans-first:9.78 04:40:50 INFO - PID 8235 | Values: 84.0 83.0 108.0 84.0 83.0 83.0 97.0 86.0 83.0 102.0 04:40:50 INFO - PID 8235 | 04:40:50 INFO - PID 8235 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:1.55 (1.3%) stddev-sans-first:1.27 04:40:50 INFO - PID 8235 | Values: 118.0 115.0 114.0 114.0 115.0 117.0 114.0 114.0 117.0 114.0 04:40:50 INFO - PID 8235 | 04:40:50 INFO - PID 8235 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.50 stddev:1.33 (0.9%) stddev-sans-first:1.41 04:40:50 INFO - PID 8235 | Values: 151.0 151.0 153.0 149.0 152.0 150.0 152.0 152.0 151.0 149.0 04:40:50 INFO - PID 8235 | 04:40:50 INFO - PID 8235 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:40:50 INFO - PID 8235 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 04:40:50 INFO - PID 8235 | 04:40:50 INFO - PID 8235 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:1.32 (2.4%) stddev-sans-first:1.22 04:40:50 INFO - PID 8235 | Values: 57.0 54.0 53.0 55.0 55.0 55.0 56.0 57.0 54.0 56.0 04:40:50 INFO - PID 8235 | 04:40:50 INFO - PID 8235 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:56.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 04:40:50 INFO - PID 8235 | Values: 55.0 55.0 56.0 56.0 55.0 56.0 56.0 56.0 55.0 55.0 04:40:50 INFO - PID 8235 | 04:40:50 INFO - PID 8235 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:85.50 stddev:3.71 (4.3%) stddev-sans-first:3.94 04:40:50 INFO - PID 8235 | Values: 86.0 94.0 86.0 84.0 84.0 82.0 83.0 91.0 85.0 85.0 04:40:50 INFO - PID 8235 | 04:40:50 INFO - PID 8235 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:138.00 stddev:14.92 (10.8%) stddev-sans-first:15.82 04:40:50 INFO - PID 8235 | Values: 140.0 141.0 136.0 134.0 136.0 135.0 141.0 132.0 183.0 136.0 04:40:50 INFO - PID 8235 | 04:40:50 INFO - PID 8235 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.40 Median:203.00 stddev:8.00 (3.9%) stddev-sans-first:8.03 04:40:50 INFO - PID 8235 | Values: 192.0 206.0 201.0 190.0 187.0 205.0 205.0 200.0 212.0 196.0 04:40:50 INFO - PID 8235 | 04:40:50 INFO - PID 8235 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.60 Median:76.50 stddev:1.71 (2.2%) stddev-sans-first:1.81 04:40:50 INFO - PID 8235 | Values: 76.0 78.0 75.0 77.0 75.0 77.0 73.0 75.0 73.0 77.0 04:40:50 INFO - PID 8235 | -------- Summary: end -------- 04:40:50 INFO - PID 8235 | 04:40:51 INFO - TEST-INFO | 8235: exit 0 04:40:51 INFO - TEST-OK | kraken | took 63173ms 04:40:51 INFO - SUITE-END | took 1183s 04:40:51 INFO - Completed test suite (00:19:43) 04:40:51 INFO - javascript benchmark 04:40:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6694.15212145705, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2722.537168681324, 2728.959065614015, 2742.835429874208, 2758.7517123458897, 2780.165950214935, 5189.792408303663, 5263.894722105556, 5288.576913846892, 5294.258803767476, 5345.224942383357, 5298.258243845865, 5319.574434045277, 5332.733363331838, 5392.56859451244, 5400.648957817739, 4432.3573081903105, 4696.788644510988, 4714.387129673138, 4714.834980775673, 4745.406824146981, 4752.453467851189, 4782.28265760137, 4785.856424307276, 4815.518448155174, 4819.927701084486, 4635.142498637729, 4704.294355846616, 4706.552877476634, 4716.669833111683, 4727.76361181943, 4710.31700403443, 4723.574878260939, 4731.952680473186, 4732.479427262998, 4735.076660051292, 4644.164050470914, 4668.089722504113, 4675.742834144121, 4679.27471241958, 4682.321063445781, 5210.843674689765, 5299.894002119974, 5302.655327403706, 5303.5226829585135, 5309.469053094698, 5710.514606258473, 5716.942830571724, 5718.771249150029, 5732.996725573008, 5748.626339287933, 5758.568107391962, 5760.0, 5771.855703607402, 5777.682227477487, 5778.0, 5323.813666521653, 5348.893022139574, 5357.732113394315, 5358.973205134027, 5367.221752845893, 5904.940950590525, 5921.911171332434, 5938.049912014057, 5942.435468630473, 5948.405159484104, 5519.972400137974, 5596.720163991784, 5624.21261023457, 5648.237487939158, 5648.463395977457, 5652.7738890443925, 5695.743691533891, 5760.107183386582, 5764.596478246566, 5771.480566749013, 5652.123920792202, 5661.264035675335, 5663.093904975184, 5670.5463562914865, 5677.063284558084, 5592.832215033555, 5655.066913959233, 5663.773449061991, 5683.630564013409, 5684.715764211773, 4755.83354582588, 4763.809447622126, 4831.589314908272, 4842.080004799077, 4869.099216644932, 4081.795910204478, 4083.89790255246, 4107.363358679409, 4108.856190033334, 4136.751794892256, 4847.854564363075, 4849.878753031132, 4853.781579828846, 4853.95146048535, 4902.681325713817, 5686.77252909879, 5692.943070569241, 5705.0, 5712.0, 5741.368449470555, 4766.332713420124, 4788.808447662124, 4790.233562629963, 4798.352222449995, 4825.252085926687, 5067.87330316745, 5079.847604571869, 5081.364829396325, 5091.821786237464, 5092.363454568179, 5267.420583735862, 5267.473252674702, 5267.578593712417, 5273.44628813969, 5275.973620131798, 5718.714064296852, 5752.309722833287, 5813.912791308218, 5831.475167234969, 5872.823815285548, 5211.530962213419, 5287.180487024518, 5331.733413329395, 5343.893122137613, 5353.411124776349, 5631.1271752878365, 5674.574406919415, 5681.289838770153, 5688.886222275449, 5728.140778883201, 5571.415001424792, 5574.331080270232, 5672.03575392176, 5713.485786279255, 5760.8271751847515, 5520.7515661796115, 5577.693226872561, 5604.971975140262, 5618.831435056954, 5652.689102099424, 5571.470710282517, 5571.7492712828835, 5575.330960284792, 5597.44025597437, 5602.907433050516, 5422.186671999074, 5490.945090549203, 5517.924004819182, 5520.033994051106, 5588.0, 5524.281843360337, 5597.496225339576, 5625.943740562706, 5644.576656750678, 5692.345380281321, 5439.945600543944, 5442.156465747816, 5449.618526703092, 5454.018276710071, 5471.261379713687], "value": 5180.5728208393, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.6013951768457, 698.8846840271356, 1002.3284399452366, 1022.718752343106, 1112.8775834658181, 32830.34339313212, 33646.0, 33665.15837104071, 33736.83131584342, 33856.830715846445, 31704.20739481514, 31759.04722858318, 32041.35917281653, 32117.0, 32125.839370803114, 6361.8409539761415, 6493.902591461132, 6801.761938332159, 6966.024756534064, 7001.404880585156, 6901.378875901168, 6911.48163887708, 6998.335158159992, 7003.859922801541, 7009.82475438113, 6968.860622787542, 7022.929770702304, 7030.13701369135, 7044.084269045043, 7046.85906281874, 6919.827004324882, 6954.478414118961, 6985.441164706836, 6987.37113659768, 7006.684699188523, 6840.657967101625, 6893.655317234168, 6904.654767261667, 6905.827354316132, 6917.031615573824, 31090.53364199539, 31268.843655781802, 31304.8434757827, 31313.0, 31551.684483155102, 3056.0678992907156, 3082.1370016395445, 3082.1678146900213, 3092.103290045884, 3097.984510077458, 24060.39849003789, 24320.0, 24357.26928192157, 24372.512549748906, 24383.26850194497, 3120.0951724000015, 3120.1419609607315, 3128.4994400895976, 3132.7023932726356, 3159.7472202223767, 143669.28165359105, 145239.27380363137, 145304.273478633, 145564.0, 145699.0, 37603.24793504169, 39478.60521394749, 39512.802435987636, 39789.40315895264, 39848.60151398449, 41396.0, 41434.58565414367, 41435.0, 41457.0, 41476.585234147875, 12082.818757718642, 12121.939390302992, 12164.209326393757, 12178.330191839357, 12215.755684886253, 9518.90481095194, 9534.809303813885, 9556.761080972892, 9564.61741530331, 9661.661841835503, 12605.0, 12688.6827829305, 12712.555060572835, 12795.168314059556, 12869.356532173353, 5238.292830467838, 5280.9471905281225, 5309.778750887241, 5311.628186026941, 5390.4879036491475, 889.3063410539789, 918.5820451694462, 919.1268295119663, 926.1248120526038, 947.7962238118838, 19940.20239190445, 20407.8979605101, 21356.0, 21459.89270053671, 21604.56790864174, 981.7692842182081, 990.7523119220195, 998.5855869814092, 1008.6620981971122, 1014.5130337438071, 10938.56245750161, 11239.462382694306, 11476.713082172846, 11480.253783504046, 11545.268209768601, 182646.0, 183547.0, 183988.0, 184000.0, 185199.0, 40131.19737605232, 40336.1932761349, 40418.79790601087, 40428.79785601112, 40573.594264057574, 1212.5695378140808, 1258.4840215511597, 1263.0274688489994, 1264.8735126487277, 1267.6830792301926, 19586.8041319585, 19822.306219282254, 20323.59352812906, 20774.376768696962, 21212.57574848525, 28952.565711514766, 28983.7101628981, 29043.12870613885, 29098.709012910447, 29101.12696619105, 148998.0, 149046.0, 149067.0, 149280.0, 149297.25351373173, 28719.569206462336, 28945.276368090123, 29176.0, 31072.22319442032, 31316.060518183578, 37114.25771484609, 37194.256114878095, 37512.0, 37656.623433765315, 37699.62300376961, 26290.21129366122, 27133.1860044199, 27601.44576144994, 27694.861525692242, 27843.860780696778, 26552.601710973966, 27036.864815675795, 27475.725242747318, 27544.17367478979, 28637.570436443886, 30895.536566951065, 30955.523558115747, 31003.689963100984, 31011.224719382197, 31042.0, 26562.86718566395, 26730.19809405721, 27171.1848644541, 27635.585466218425, 28347.43305133927, 21600.459988500414, 22563.661545077164, 22905.31284061481, 22984.540309193388, 23040.193593224158], "value": 14470.564156018087, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.9272127377708, 422.5689796407663, 429.32613008868606, 437.56243756243754, 439.1809275700815, 17203.741943870835, 17426.47720568382, 17740.822591774064, 17923.82076179238, 18066.63866722665, 17357.264273572637, 17671.293148274053, 17773.200205990728, 17862.374816881413, 17965.19156637951, 5252.579793616502, 5293.86765330866, 5420.07858664028, 5436.374816896048, 5439.265699130626, 5334.866628334304, 5360.678359298455, 5429.4027656957705, 5542.057850165482, 5591.133374326986, 5494.752736126864, 5532.2531458253225, 5542.057850165462, 5549.6115271930985, 5551.528120109775, 5435.945640543583, 5464.890702185974, 5483.424240454735, 5498.725063746797, 5521.116621340586, 4959.0, 4972.279019542182, 5013.874653133665, 5016.648834581581, 5026.421961474441, 21621.135154593954, 21653.35039948804, 21924.561508769893, 21954.4511387215, 22186.0, 1626.715324818152, 1643.909584972826, 1648.0606054548912, 1648.9505314840574, 1652.4051341517045, 14292.213928233943, 14466.27668616565, 14532.782008269778, 14722.263886805724, 14826.33281502335, 2051.2666796556887, 2080.823130033949, 2083.0, 2085.384811480617, 2091.602595506864, 88883.55558222167, 99276.50361748217, 101150.49424752829, 101211.99999999926, 102682.48658756659, 10872.18458615607, 11078.224524283223, 11093.611723589796, 11167.497462614201, 11368.772624547462, 15560.688786224438, 15605.921970390302, 15629.452969146025, 15662.0, 15667.921660391854, 6908.812563273127, 7008.369246767816, 7083.18543367509, 7087.787366379017, 7099.0, 6189.938100619026, 6217.129601855744, 6323.0, 6344.238691356974, 6383.265924418658, 6908.447324214051, 6926.376626103674, 7062.858742825115, 7100.0, 7111.573305601681, 2037.9184832606827, 2046.92835750748, 2107.5258066934816, 2117.1319758898776, 2188.8796116213443, 836.7113345895656, 857.2456238510072, 862.7886167888907, 879.2218886285683, 892.0900681305033, 16593.170341482877, 16706.83293167077, 16949.06780127105, 17098.14509274531, 17426.47720568385, 851.5827244650077, 858.7380848841163, 861.6510313323114, 874.0691163910415, 892.3708785306344, 9263.76840578991, 9499.952500237592, 9581.568829402693, 9599.760005999766, 9702.95148524267, 335672.0, 337329.0, 354186.0, 355201.0, 355656.0, 74687.62656186793, 75189.6240518794, 75477.0, 75812.62093689496, 75927.0, 991.2020823237219, 1002.7894142230067, 1029.433811403725, 1030.3199888073834, 1034.943078130695, 14062.507812226522, 14241.64395890111, 14345.497907573184, 14463.204523751294, 15084.472043478425, 36373.0, 36518.0, 37137.25725485529, 37243.81378093092, 37537.812310939364, 45651.0, 46142.0, 46389.76805115953, 46995.0, 47034.29448558343, 8277.089520152898, 8320.625571849403, 8514.063453020286, 8540.44487108336, 8732.170443808081, 13051.543195988095, 13157.473701051851, 13212.735745285232, 13296.800547991981, 13438.0, 10747.838782418114, 10934.125269978224, 10979.83530247031, 11031.83452248233, 11050.889491105308, 10263.948680256552, 10381.9480902595, 10438.895611043792, 10465.476726163814, 10530.947345263225, 10950.561977521129, 10966.287191332538, 10981.0, 10990.505427255634, 11094.778104438028, 8105.959470202612, 8434.665218712513, 8493.532855692996, 8613.65545378178, 8927.419717718327, 11187.384693841592, 11289.71775705614, 11390.54437822511, 11394.430278485877, 11456.3698996556], "value": 8743.609731775994, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1250.468550865882, 1313.7635225659383, 1318.2646009530226, 1328.4752522753515, 1332.7534406134866, 10160.898391016088, 10610.257281990263, 10672.78654426912, 10679.946600266998, 10903.781924361509, 10741.140708743302, 10823.783524329509, 10985.363512756941, 11001.284916480423, 11019.228653994223, 2213.4245096275004, 2253.8422310438277, 2258.9096436142536, 2271.8409711320214, 2279.168103642167, 2085.947851303722, 2149.7420309562876, 2151.4191168384527, 2166.144372972675, 2169.663702126165, 2168.0, 2176.173054239395, 2220.245116660335, 2229.15292188968, 2229.732432108149, 2128.1912873108276, 2162.2648299578063, 2164.8701077935216, 2165.5127596290945, 2170.1536400803698, 1878.6430578190236, 1893.8579606529427, 2068.069368784053, 2179.683945827862, 2185.4754858833926, 10489.527971241312, 10521.421321827296, 10552.419616921066, 10585.629502967437, 10592.205584581186, 5573.08044172711, 5798.768049278066, 5834.154047663065, 5838.124281357788, 5838.7080645967535, 3366.8148251846137, 3595.209054008114, 3660.963390366089, 3662.5421822272215, 3667.9083022924374, 1105.209775010871, 1117.9161562882816, 1148.328227986629, 1159.4376727287258, 1165.626999360205, 15469.922650386789, 15539.456119035893, 15591.532254032398, 15600.29798659063, 15610.019445041555, 4620.214563524209, 4763.404574428197, 4784.0, 4865.95134048655, 5002.399712034579, 10603.621529201155, 10672.573097076185, 10681.198910081775, 10735.087517560938, 10750.139988800876, 5403.729813509387, 5426.213199086111, 5433.891322173614, 5453.618246722771, 5453.945460545423, 4936.802527898843, 5022.447530771612, 5081.2632168335385, 5142.331496905378, 5165.845024649267, 3827.2154208387215, 3941.1329507508303, 3993.520777506718, 4019.5176578810147, 4045.19096180765, 1147.4262868565718, 1150.0626989003936, 1158.6466127831093, 1162.6279590530949, 1179.1392283632997, 666.0508774995612, 694.1808665774333, 696.5472442912147, 711.3597762014228, 715.9427245820322, 5207.921881171786, 5330.9733451332495, 5363.865903352447, 5434.561468800397, 5458.879618593548, 543.8341305901658, 545.3156288857538, 549.2420459765577, 553.6318348298418, 563.4140493886313, 3362.9327413451592, 3478.252175782219, 3530.6645868642436, 3599.2981368632863, 3710.7588006779474, 13007.0, 13634.795478067837, 13758.243296618582, 13786.310684465736, 13810.861891380957, 13200.669983250496, 13402.329883505981, 13484.258365789976, 13683.863161368457, 13717.794233086512, 7581.50720203196, 7664.080310362792, 7666.348360389429, 7666.655000524878, 7680.500767450098, 5570.136628822539, 5573.414791446839, 5590.329160500766, 5662.8301150965535, 5739.282589676291, 12054.75890482168, 12094.516219351128, 12189.573364932185, 12215.0, 12269.815952760895, 12089.274643521418, 12554.309512976508, 12673.429695663533, 12714.0, 12734.872651273368, 7976.322012628992, 8168.918310817054, 8285.295749861329, 8375.916240837514, 8376.078631350669, 9932.106110450095, 9933.751656208653, 10045.49772511386, 10048.748781280527, 10067.194624429882, 8240.876386854321, 8358.205970432798, 8428.325733941147, 8487.36344774132, 8635.784105397415, 8051.35589152878, 8185.836283274182, 8238.876416853633, 8286.502809831429, 8492.023417306842, 7624.313811756747, 7708.8072798178255, 7759.107702614046, 7767.495112817649, 7772.57250851186, 5067.543921047123, 5119.74401279942, 5198.4801519847715, 5207.140821764518, 5290.153575427913, 5201.557867581298, 5322.54758345545, 5330.413654498079, 5377.833125778331, 5382.865428364165], "value": 4727.445687349593, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.21760996248094, 362.65004270878603, 366.6736604422063, 371.7323527060517, 377.79787813519766, 5417.6207665463335, 5517.36550296716, 5531.197976293435, 5544.722763861801, 5575.8884822303635, 5349.251104845315, 5390.811321603745, 5415.864603384917, 5420.268263784388, 5436.3476382834015, 3937.9212415751667, 4054.2702313583545, 4066.4916885389325, 4072.617518751534, 4075.7758323292205, 4040.1717647882115, 4057.452243947059, 4065.4918135233097, 4068.4304197412384, 4074.9592504075026, 4017.1563971566006, 4025.7987100644996, 4035.6367926886574, 4039.899002524946, 4042.4542686737354, 3893.649571538575, 4029.194161167778, 4038.8586399475876, 4042.4946881639794, 4050.7164498485267, 3493.755437119403, 3497.8251087445524, 3500.2474467989505, 3502.3345564342694, 3511.4908338290807, 5323.840284791462, 5324.8136315228785, 5349.732513374354, 5350.411454739976, 5354.785808567653, 4697.6241900647865, 4753.5959443447, 4764.213904705719, 4773.140834649762, 4778.665493415462, 5681.23303354046, 5709.486146246858, 5754.971225143848, 5757.280339957505, 5775.971120144414, 3899.78551179685, 3921.7646941183334, 3925.3130702127014, 3928.7446315989655, 3941.960580394217, 5638.532302633851, 6000.729967151445, 6033.3754816654455, 6109.175261339707, 6129.264488261392, 3987.6809855211513, 4008.3987401889367, 4034.374671925856, 4036.6880763751897, 4056.6146216109423, 4082.9183416331507, 4086.693497987603, 4088.1210539733506, 4105.91788164241, 4106.589341065869, 4755.167845627001, 4755.476897541268, 4761.309610106585, 4766.332713420124, 4771.141194585008, 5542.91685624716, 5747.959474386616, 5788.27646544182, 5820.330661973842, 5830.183774271605, 1385.9307034648227, 1399.2793711238721, 1400.0479673821899, 1403.2282244765338, 1404.1294397473632, 896.4531635702347, 938.7277689470113, 942.2697409507687, 948.9240860731124, 953.3517208298424, 4997.175466048134, 5004.974975125174, 5015.22264049073, 5025.969676216367, 5033.345665063592, 6028.487578555872, 6050.606710563799, 6057.3336932937345, 6061.333253342129, 6070.3019152797115, 4878.585320247818, 4983.227599722049, 4986.626003049786, 4998.175301075355, 5007.899842003139, 3171.1120886151916, 3191.6010498687665, 3198.1524895902603, 3209.4543927532377, 3229.01515037911, 5448.455154484599, 5511.8149597836655, 5569.721513924287, 5581.386047534768, 5590.832275031756, 5960.731767070492, 6094.329623741385, 6131.294901086432, 6135.0, 6188.381161883775, 5563.304586926634, 5565.554755619541, 5581.581381396411, 5594.384617692051, 5622.8313150605545, 5939.1982082420045, 6006.87986240264, 6013.0, 6019.187409699634, 6022.45797878193, 5919.934411805916, 5958.910616340845, 5975.521958243417, 5976.312724036791, 6000.969995149996, 5587.1339942309005, 5591.832245032656, 5616.494515493625, 5618.634788738719, 5637.0, 4013.4381186634478, 4034.8789536313957, 4058.2086493133556, 4083.4079058535754, 4085.407615895619, 6061.363556826646, 6065.302490213682, 6070.028795392716, 6076.361981991828, 6089.208402907594, 5859.326177489473, 5863.882722345444, 5868.9504242072835, 5871.853203669943, 5916.142159386951, 5738.713064346849, 5830.219220239363, 5850.414958504286, 5860.736266868086, 5886.028805247086, 5749.425057494217, 5781.190633311256, 5784.566157538117, 5795.797147099831, 5810.389909059488, 5723.771049157987, 5858.794942177004, 5895.764169433174, 5912.645241285537, 5919.467247947706, 5744.971275143597, 5750.539956803362, 5763.94236057634, 5768.971155144198, 5771.480566749013], "value": 4297.129636910901, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.6393349225629, 757.5189754505889, 763.9923600763991, 769.7844603511015, 775.7013549783334, 13228.206307621538, 14039.859601403983, 14130.0, 16166.0, 17573.472795816113, 16090.919545402287, 16269.83730162698, 16277.918610406961, 16339.754903676454, 16794.32822687094, 901.2789768185442, 912.1562554636968, 916.5737931861682, 916.9816603667923, 917.7017469322464, 877.627008521379, 907.7004588485784, 917.3532659475054, 921.7741653294952, 922.921551668109, 962.3263715399214, 968.1335204991528, 969.4764826993451, 969.92725545584, 970.175350951689, 950.0404591362774, 954.2127744610724, 955.9378640388353, 958.6117622362954, 960.0351646595198, 710.8294009437749, 713.1086142322098, 713.2724620886667, 713.7644577289534, 715.0382735221119, 13266.535671251557, 13304.467821287137, 13362.933185334108, 13447.260400677958, 13710.108842925178, 15338.769918451233, 15593.37626494939, 15607.531774046796, 15817.0, 15900.0, 12775.0, 12909.225446473241, 13039.282839443827, 13056.673583160402, 13105.737885242243, 3077.9076627701206, 3091.938161236763, 3113.828739419331, 3113.937721245585, 3118.189270789611, 64515.03227451639, 67607.66196169036, 69466.0, 69897.65051174762, 71108.28891711068, 12821.35893205336, 13112.541061062817, 13162.341882905816, 13234.0, 13307.401166947511, 22572.54854902893, 22732.545349092925, 22789.772102279097, 22838.200662976717, 23254.418639533807, 6032.517398608188, 6198.690065496708, 6203.2245969253845, 6205.906911396332, 6266.185395898504, 2989.6412430508044, 3063.6323641162758, 3068.202267410489, 3073.339232065117, 3075.969550200663, 3681.0613293610495, 3729.8321575529167, 3788.6021967693546, 3798.525184351956, 3853.2871418787613, 738.3391864281438, 740.3189066059239, 761.9466637335444, 763.1033535595653, 764.453415807689, 551.6386766667839, 565.8585353661584, 569.4277251362354, 579.0, 589.9882002360015, 8990.775230619287, 9029.63881444735, 9128.634854605874, 9532.142107210384, 9590.472524011246, 533.4585395823243, 545.2693390856272, 545.312905738772, 552.7733629212004, 557.3785229469113, 4067.6949228807957, 4205.201011807747, 4305.720128191658, 4379.386885835986, 4389.341598760211, 62911.37088629055, 63172.36827631757, 63431.6828415855, 65574.83590043455, 66162.0, 56364.71817640885, 57318.713406432704, 57825.71087144537, 58740.412595874346, 61169.38830611726, 51469.536917146805, 52233.47766522362, 53118.468815312124, 54286.72856635691, 55076.72461637746, 8773.956130219309, 8844.778880528038, 8919.0, 9225.308101892251, 9228.0, 24821.62767558524, 25406.491870162863, 25668.614970775827, 26082.478350433266, 26344.0, 31608.36783264368, 32030.679693203703, 32034.35931281408, 32582.0, 32672.0, 11443.198976071595, 11527.942360288145, 11712.355820429959, 11814.409279536161, 11859.762804744028, 13123.868761312646, 13207.537736179187, 13228.0, 13319.800202996768, 13724.382402791698, 10791.730206744895, 10832.891671083189, 11018.1185505161, 11063.059639930374, 11253.043491303004, 12362.505499779909, 12480.812787808009, 12626.053046021769, 13776.517821876187, 14366.13803171813, 14743.0, 14761.114333140045, 14861.256937153315, 14926.402943882124, 15012.849871501145, 10874.075703565286, 10895.56417743313, 10902.18233632465, 11088.895109369389, 11252.774944501229, 10987.121030317396, 11101.561452056045, 11781.175317727677, 11828.881711182778, 11859.288442693465], "value": 6757.4525248807395, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 111.0, 112.0, 110.0, 110.0, 110.0, 111.0, 110.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 124.0, 185.0, 125.0, 125.0, 125.0, 125.0, 151.0, 127.0], "value": 136.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 163.0, 162.0, 162.0, 165.0, 168.0, 173.0, 167.0, 167.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 108.0, 76.0, 79.0, 77.0, 74.0, 97.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 108.0, 84.0, 83.0, 83.0, 97.0, 86.0, 83.0, 102.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 114.0, 114.0, 115.0, 117.0, 114.0, 114.0, 117.0, 114.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 153.0, 149.0, 152.0, 150.0, 152.0, 152.0, 151.0, 149.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 53.0, 55.0, 55.0, 55.0, 56.0, 57.0, 54.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 56.0, 55.0, 56.0, 56.0, 56.0, 55.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 94.0, 86.0, 84.0, 84.0, 82.0, 83.0, 91.0, 85.0, 85.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 141.0, 136.0, 134.0, 136.0, 135.0, 141.0, 132.0, 183.0, 136.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 206.0, 201.0, 190.0, 187.0, 205.0, 205.0, 200.0, 212.0, 196.0], "value": 199.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 75.0, 77.0, 75.0, 77.0, 73.0, 75.0, 73.0, 77.0], "value": 75.6, "unit": "score"}]}]} 04:40:51 INFO - Return code: 0 04:40:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:40:51 INFO - # TBPL SUCCESS # 04:40:51 INFO - Running post-action listener: _resource_record_post_action 04:40:51 INFO - [mozharness: 2017-05-16 11:40:51.586833Z] Finished run-tests step (success) 04:40:51 INFO - Running post-run listener: _resource_record_post_run 04:40:51 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 81920; Write bytes: 396963840; Read time: 172; Write time: 224964 04:40:51 INFO - TinderboxPrint: CPU usage
13.3% 04:40:51 INFO - TinderboxPrint: I/O read bytes / time
81,920 / 172 04:40:51 INFO - TinderboxPrint: I/O write bytes / time
396,963,840 / 224,964 04:40:51 INFO - TinderboxPrint: CPU idle
8,299.6 (86.7%) 04:40:51 INFO - TinderboxPrint: CPU user
1,221.0 (12.7%) 04:40:51 INFO - TinderboxPrint: Swap in / out
0 / 0 04:40:51 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 113319936; Read time: 0; Write time: 94248 04:40:51 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 77824; Write bytes: 283643904; Read time: 160; Write time: 130716 04:40:52 INFO - Running post-run listener: _upload_blobber_files 04:40:52 INFO - Blob upload gear active. 04:40:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:40:52 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 04:40:52 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'] 04:40:52 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 04:40:52 INFO - (blobuploader) - INFO - Open directory for files ... 04:40:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:40:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:40:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:56 INFO - (blobuploader) - INFO - Done attempting. 04:40:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:40:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:40:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:56 INFO - (blobuploader) - INFO - Done attempting. 04:40:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:40:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:40:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:57 INFO - (blobuploader) - INFO - Done attempting. 04:40:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:40:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:40:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:58 INFO - (blobuploader) - INFO - Done attempting. 04:40:58 INFO - (blobuploader) - INFO - Iteration through files over. 04:40:58 INFO - Return code: 0 04:40:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:40:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:40:58 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb8ac844c8e884ed629262d0ff804ebe482b44b3f5bc0531642c32f932cd3f847a5664c18a0ac5e1b186abd204bba898b00cc3ee19191605fee57e89138c1093", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db436460025a1e981c38d59acf7a494ad5e5c222c6cb87cae394db558f71b1d2833aff4be10a9a4b34a6efcb1cae99ea07c4defdcbe6a93ca0820b9c58292fdd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c2100fa8c5a84862232656252d0aa27f4244b1cc1681da1b1d411a08a638f15c075054e061071d4ca5492575f621ff5cded9d49b9810b0d530b68c1b15e2aa1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5caca21705e2d5cb51d49a7706eb13429993a82ddb5c53b85a74423ec6b45fdc70cc2e4b5d06187f0d24638cfee27a5e2d2f706d395b928237f65598c6a8311d"} 04:40:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:40:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:40:58 INFO - Contents: 04:40:58 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb8ac844c8e884ed629262d0ff804ebe482b44b3f5bc0531642c32f932cd3f847a5664c18a0ac5e1b186abd204bba898b00cc3ee19191605fee57e89138c1093", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db436460025a1e981c38d59acf7a494ad5e5c222c6cb87cae394db558f71b1d2833aff4be10a9a4b34a6efcb1cae99ea07c4defdcbe6a93ca0820b9c58292fdd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c2100fa8c5a84862232656252d0aa27f4244b1cc1681da1b1d411a08a638f15c075054e061071d4ca5492575f621ff5cded9d49b9810b0d530b68c1b15e2aa1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5caca21705e2d5cb51d49a7706eb13429993a82ddb5c53b85a74423ec6b45fdc70cc2e4b5d06187f0d24638cfee27a5e2d2f706d395b928237f65598c6a8311d"} 04:40:58 INFO - Running post-run listener: copy_logs_to_upload_dir 04:40:58 INFO - Copying logs to upload dir... 04:40:58 INFO - mkdir: /builds/slave/test/build/upload/logs 04:40:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.650088 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-16 04:40:58.285184) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-16 04:40:58.290695) ========= 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=8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb8ac844c8e884ed629262d0ff804ebe482b44b3f5bc0531642c32f932cd3f847a5664c18a0ac5e1b186abd204bba898b00cc3ee19191605fee57e89138c1093", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db436460025a1e981c38d59acf7a494ad5e5c222c6cb87cae394db558f71b1d2833aff4be10a9a4b34a6efcb1cae99ea07c4defdcbe6a93ca0820b9c58292fdd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c2100fa8c5a84862232656252d0aa27f4244b1cc1681da1b1d411a08a638f15c075054e061071d4ca5492575f621ff5cded9d49b9810b0d530b68c1b15e2aa1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5caca21705e2d5cb51d49a7706eb13429993a82ddb5c53b85a74423ec6b45fdc70cc2e4b5d06187f0d24638cfee27a5e2d2f706d395b928237f65598c6a8311d"} build_url:https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011445 build_url: 'https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb8ac844c8e884ed629262d0ff804ebe482b44b3f5bc0531642c32f932cd3f847a5664c18a0ac5e1b186abd204bba898b00cc3ee19191605fee57e89138c1093", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db436460025a1e981c38d59acf7a494ad5e5c222c6cb87cae394db558f71b1d2833aff4be10a9a4b34a6efcb1cae99ea07c4defdcbe6a93ca0820b9c58292fdd", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c2100fa8c5a84862232656252d0aa27f4244b1cc1681da1b1d411a08a638f15c075054e061071d4ca5492575f621ff5cded9d49b9810b0d530b68c1b15e2aa1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5caca21705e2d5cb51d49a7706eb13429993a82ddb5c53b85a74423ec6b45fdc70cc2e4b5d06187f0d24638cfee27a5e2d2f706d395b928237f65598c6a8311d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-16 04:40:58.316790) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:40:58.317155) ========= 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=8887e36bb8e381bfd44124ac000001a8-1494933601.642066-134592149 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:40:58.400533) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-16 04:40:58.400922) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-16 04:40:58.401262) ========= ========= Total master_lag: 0.17 =========