builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-066 starttime: 1495660164.59 results: success (0) revision: 934ff2cb74b00bb92a7ab4f39aeaa014a9075a67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 14:09:24.595216) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 14:09:24.595721) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 14:09:24.596001) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 14:09:24.666459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 14:09:24.666888) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-24 14:09:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2017-05-24 14:09:25 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.153821 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 14:09:24.838343) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 14:09:24.838627) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017811 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 14:09:24.889512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-24 14:09:24.889865) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 934ff2cb74b00bb92a7ab4f39aeaa014a9075a67 --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 934ff2cb74b00bb92a7ab4f39aeaa014a9075a67 --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=82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-24 14:09:25,547 truncating revision to first 12 chars 2017-05-24 14:09:25,547 Setting DEBUG logging. 2017-05-24 14:09:25,548 attempt 1/10 2017-05-24 14:09:25,548 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/934ff2cb74b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-24 14:09:26,620 unpacking tar archive at: mozilla-central-934ff2cb74b0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.391119 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-24 14:09:26.318850) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 14:09:26.319173) ========= script_repo_revision: 934ff2cb74b00bb92a7ab4f39aeaa014a9075a67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 14:09:26.319559) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 14:09:26.319823) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 14:09:26.327952) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-24 14:09:26.328363) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:09:27 INFO - MultiFileLogger online at 20170524 14:09:27 in /builds/slave/test 14:09:27 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 14:09:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:09:27 INFO - {'append_to_log': False, 14:09:27 INFO - 'base_work_dir': '/builds/slave/test', 14:09:27 INFO - 'blob_upload_branch': 'Firefox', 14:09:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:09:27 INFO - 'branch': 'Firefox', 14:09:27 INFO - 'buildbot_json_path': 'buildprops.json', 14:09:27 INFO - 'config_files': ('talos/linux_config.py',), 14:09:27 INFO - 'default_actions': ('clobber', 14:09:27 INFO - 'read-buildbot-config', 14:09:27 INFO - 'download-and-extract', 14:09:27 INFO - 'populate-webroot', 14:09:27 INFO - 'create-virtualenv', 14:09:27 INFO - 'install', 14:09:27 INFO - 'run-tests'), 14:09:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:09:27 INFO - 'download_minidump_stackwalk': True, 14:09:27 INFO - 'download_symbols': 'ondemand', 14:09:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:09:27 INFO - 'tooltool.py': '/tools/tooltool.py', 14:09:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:09:27 INFO - '/tools/misc-python/virtualenv.py')}, 14:09:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:09:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:09:27 INFO - 'gecko_profile': False, 14:09:27 INFO - 'gecko_profile_interval': 0, 14:09:27 INFO - 'installer_path': 'installer.exe', 14:09:27 INFO - 'log_level': 'info', 14:09:27 INFO - 'log_name': 'talos', 14:09:27 INFO - 'log_to_console': True, 14:09:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:09:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:09:27 INFO - 'opt_config_files': (), 14:09:27 INFO - 'pip_index': False, 14:09:27 INFO - 'suite': 'dromaeojs-e10s', 14:09:27 INFO - 'system_bits': '32', 14:09:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:09:27 INFO - 'title': 'talos-linux64-ix-066', 14:09:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:09:27 INFO - 'use_talos_json': True, 14:09:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:09:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:09:27 INFO - 'work_dir': 'build'} 14:09:27 INFO - [mozharness: 2017-05-24 21:09:27.062555Z] Running clobber step. 14:09:27 INFO - Running pre-action listener: _resource_record_pre_action 14:09:27 INFO - Running main action method: clobber 14:09:27 INFO - rmtree: /builds/slave/test/build 14:09:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:09:28 INFO - Running post-action listener: _resource_record_post_action 14:09:28 INFO - [mozharness: 2017-05-24 21:09:28.102094Z] Finished clobber step (success) 14:09:28 INFO - [mozharness: 2017-05-24 21:09:28.102195Z] Running read-buildbot-config step. 14:09:28 INFO - Running pre-action listener: _resource_record_pre_action 14:09:28 INFO - Running main action method: read_buildbot_config 14:09:28 INFO - Using buildbot properties: 14:09:28 INFO - { 14:09:28 INFO - "project": "", 14:09:28 INFO - "product": "firefox", 14:09:28 INFO - "who": "ryanvm@gmail.com", 14:09:28 INFO - "installer_path": "public/build/target.tar.bz2", 14:09:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 14:09:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 14:09:28 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 14:09:28 INFO - "stage_platform": "linux64-stylo", 14:09:28 INFO - "basedir": "/builds/slave/test", 14:09:28 INFO - "buildnumber": 105, 14:09:28 INFO - "platform": "ubuntu64_hw_stylo", 14:09:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:09:28 INFO - "slavebuilddir": "test", 14:09:28 INFO - "taskId": "RxJBjXpoQUuuhpXrBkERZw", 14:09:28 INFO - "branch": "mozilla-central", 14:09:28 INFO - "script_repo_revision": "production", 14:09:28 INFO - "revision": "934ff2cb74b00bb92a7ab4f39aeaa014a9075a67", 14:09:28 INFO - "slavename": "talos-linux64-ix-066", 14:09:28 INFO - "repo_path": "mozilla-central" 14:09:28 INFO - } 14:09:28 INFO - Finding installer, test and symbols from parent task. 14:09:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RxJBjXpoQUuuhpXrBkERZw'}, attempt #1 14:09:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RxJBjXpoQUuuhpXrBkERZw'}, attempt #1 14:09:29 INFO - Task dependencies: JmBs3QxxRH6KDJ6RQMBolw 14:09:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw'}, attempt #1 14:09:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.tar.bz2 14:09:29 INFO - Set test_url: https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/test_packages.json 14:09:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.crashreporter-symbols.zip 14:09:29 INFO - Running post-action listener: _resource_record_post_action 14:09:29 INFO - [mozharness: 2017-05-24 21:09:29.536144Z] Finished read-buildbot-config step (success) 14:09:29 INFO - [mozharness: 2017-05-24 21:09:29.536365Z] Running download-and-extract step. 14:09:29 INFO - Running pre-action listener: _resource_record_pre_action 14:09:29 INFO - Running main action method: download_and_extract 14:09:29 INFO - mkdir: /builds/slave/test/build/tests 14:09:29 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')]} 14:09:29 INFO - trying https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.test_packages.json 14:09:29 INFO - Downloading https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:09:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:09:30 INFO - Downloaded 986 bytes. 14:09:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:09:30 INFO - Using the following test package requirements: 14:09:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:09:30 INFO - u'common': [u'target.common.tests.zip'], 14:09:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:09:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:09:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:09:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:09:30 INFO - u'mozbase': [u'target.common.tests.zip'], 14:09:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:09:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:09:30 INFO - u'web-platform': [u'target.common.tests.zip', 14:09:30 INFO - u'target.web-platform.tests.zip'], 14:09:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:09:30 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:09:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.common.tests.zip 14:09:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:09:30 INFO - Fetch https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.common.tests.zip into memory 14:09:31 INFO - Content-Length response header: 63523878 14:09:31 INFO - Bytes received: 63523878 14:09:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:09:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.common.tests.zip 14:09:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:09:42 INFO - Fetch https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.common.tests.zip into memory 14:09:43 INFO - Content-Length response header: 63523878 14:09:43 INFO - Bytes received: 63523878 14:09:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.talos.tests.zip 14:09:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:09:55 INFO - Fetch https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.talos.tests.zip into memory 14:09:55 INFO - Content-Length response header: 14411859 14:09:55 INFO - Bytes received: 14411859 14:09:56 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')]} 14:09:56 INFO - trying https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.tar.bz2 14:09:56 INFO - Downloading https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:09:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:09:57 INFO - Downloaded 56485764 bytes. 14:09:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.tar.bz2 14:09:57 INFO - mkdir: /builds/slave/test/properties 14:09:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:09:57 INFO - Writing to file /builds/slave/test/properties/build_url 14:09:57 INFO - Contents: 14:09:57 INFO - build_url:https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.tar.bz2 14:09:57 INFO - Running post-action listener: _resource_record_post_action 14:09:57 INFO - Running post-action listener: set_extra_try_arguments 14:09:57 INFO - [mozharness: 2017-05-24 21:09:57.408929Z] Finished download-and-extract step (success) 14:09:57 INFO - [mozharness: 2017-05-24 21:09:57.409135Z] Running populate-webroot step. 14:09:57 INFO - Running pre-action listener: _resource_record_pre_action 14:09:57 INFO - Running main action method: populate_webroot 14:09:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:09:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:09:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:09:57 INFO - '--tppagecycles', 14:09:57 INFO - '7'], 14:09:57 INFO - 'tests': ['tsvgm']}}, 14:09:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:09:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:09:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:09:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:09:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:09:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:09:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:09:57 INFO - 'talos_options': ['--disable-e10s'], 14:09:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:09:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:09:57 INFO - 'talos_options': ['--disable-e10s'], 14:09:57 INFO - 'tests': ['damp', 'tps']}, 14:09:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:09:57 INFO - 'tests': ['damp', 'tps']}, 14:09:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:09:57 INFO - 'tests': ['dromaeo_dom']}, 14:09:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:09:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:09:57 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:09:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:09:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:09:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:09:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:09:57 INFO - 'tests': ['a11yr', 14:09:57 INFO - 'ts_paint', 14:09:57 INFO - 'tpaint', 14:09:57 INFO - 'sessionrestore', 14:09:57 INFO - 'sessionrestore_no_auto_restore', 14:09:57 INFO - 'tabpaint']}, 14:09:57 INFO - 'other-e10s': {'tests': ['a11yr', 14:09:57 INFO - 'ts_paint', 14:09:57 INFO - 'tpaint', 14:09:57 INFO - 'sessionrestore', 14:09:57 INFO - 'sessionrestore_no_auto_restore', 14:09:57 INFO - 'tabpaint']}, 14:09:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:09:57 INFO - 'ts_paint', 14:09:57 INFO - 'tpaint', 14:09:57 INFO - 'sessionrestore', 14:09:57 INFO - 'sessionrestore_no_auto_restore', 14:09:57 INFO - 'tabpaint']}, 14:09:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:09:57 INFO - 'ts_paint', 14:09:57 INFO - 'tpaint', 14:09:57 INFO - 'sessionrestore', 14:09:57 INFO - 'sessionrestore_no_auto_restore', 14:09:57 INFO - 'tabpaint']}, 14:09:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:09:57 INFO - 'tests': ['a11yr', 14:09:57 INFO - 'ts_paint', 14:09:57 INFO - 'tpaint', 14:09:57 INFO - 'sessionrestore', 14:09:57 INFO - 'sessionrestore_no_auto_restore', 14:09:57 INFO - 'tabpaint']}, 14:09:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:09:57 INFO - 'tests': ['a11yr', 14:09:57 INFO - 'ts_paint', 14:09:57 INFO - 'tpaint', 14:09:57 INFO - 'sessionrestore', 14:09:57 INFO - 'sessionrestore_no_auto_restore', 14:09:57 INFO - 'tabpaint']}, 14:09:57 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:09:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:09:57 INFO - 'bloom_basic_ref']}, 14:09:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:09:57 INFO - 'tests': ['tsvgx', 14:09:57 INFO - 'tsvgr_opacity', 14:09:57 INFO - 'tart', 14:09:57 INFO - 'tscrollx', 14:09:57 INFO - 'cart', 14:09:57 INFO - 'tsvg_static']}, 14:09:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:09:57 INFO - 'tsvgr_opacity', 14:09:57 INFO - 'tart', 14:09:57 INFO - 'tscrollx', 14:09:57 INFO - 'cart', 14:09:57 INFO - 'tsvg_static']}, 14:09:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:09:57 INFO - 'talos_options': ['--disable-e10s'], 14:09:57 INFO - 'tests': ['tp5o']}, 14:09:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:09:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:09:57 INFO - 'talos_options': ['--disable-e10s', 14:09:57 INFO - '--xperf_path', 14:09:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:57 INFO - 'tests': ['tp5n']}, 14:09:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:09:57 INFO - 'talos_options': ['--xperf_path', 14:09:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:57 INFO - 'tests': ['tp5n']}}, 14:09:57 INFO - 'talos.zip': {'path': '', 14:09:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:09:57 INFO - Running post-action listener: _resource_record_post_action 14:09:57 INFO - [mozharness: 2017-05-24 21:09:57.424007Z] Finished populate-webroot step (success) 14:09:57 INFO - [mozharness: 2017-05-24 21:09:57.424096Z] Running create-virtualenv step. 14:09:57 INFO - Running pre-action listener: _resource_record_pre_action 14:09:57 INFO - Running main action method: create_virtualenv 14:09:57 INFO - Creating virtualenv /builds/slave/test/build/venv 14:09:57 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 14:09:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:09:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:09:57 INFO - Using real prefix '/usr' 14:09:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:09:58 INFO - Installing distribute.............................................................................................................................................................................................done. 14:09:59 INFO - Installing pip.................done. 14:09:59 INFO - Return code: 0 14:09:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:10:00 INFO - Reading from file tmpfile_stdout 14:10:00 INFO - Output received: 14:10:00 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) 14:10:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:10:00 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')]} 14:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:00 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')]} 14:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:00 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 0xee61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12595c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12567a0>, '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 0x12576a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1257b30>, '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': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', '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 14:10:00 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 14:10:00 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 14:10:00 INFO - Using env: {'DISPLAY': ':0', 14:10:00 INFO - 'HOME': '/home/cltbld', 14:10:00 INFO - 'LANG': 'en_US.UTF-8', 14:10:00 INFO - 'LANGUAGE': 'en_US:en', 14:10:00 INFO - 'LOGNAME': 'cltbld', 14:10:00 INFO - 'MAIL': '/var/mail/cltbld', 14:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:00 INFO - 'MOZ_NO_REMOTE': '1', 14:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:00 INFO - 'NO_EM_RESTART': '1', 14:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:00 INFO - 'PWD': '/builds/slave/test', 14:10:00 INFO - 'SHELL': '/bin/bash', 14:10:00 INFO - 'SHLVL': '1', 14:10:00 INFO - 'TERM': 'linux', 14:10:00 INFO - 'TMOUT': '86400', 14:10:00 INFO - 'USER': 'cltbld', 14:10:00 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', 14:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:00 INFO - '_': '/tools/buildbot/bin/python'} 14:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:00 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 14:10:00 INFO - Cleaning up... 14:10:00 INFO - Return code: 0 14:10:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:10:00 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')]} 14:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:00 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')]} 14:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:00 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 0xee61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12595c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12567a0>, '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 0x12576a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1257b30>, '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': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', '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 14:10:00 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 14:10:00 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 14:10:00 INFO - Using env: {'DISPLAY': ':0', 14:10:00 INFO - 'HOME': '/home/cltbld', 14:10:00 INFO - 'LANG': 'en_US.UTF-8', 14:10:00 INFO - 'LANGUAGE': 'en_US:en', 14:10:00 INFO - 'LOGNAME': 'cltbld', 14:10:00 INFO - 'MAIL': '/var/mail/cltbld', 14:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:00 INFO - 'MOZ_NO_REMOTE': '1', 14:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:00 INFO - 'NO_EM_RESTART': '1', 14:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:00 INFO - 'PWD': '/builds/slave/test', 14:10:00 INFO - 'SHELL': '/bin/bash', 14:10:00 INFO - 'SHLVL': '1', 14:10:00 INFO - 'TERM': 'linux', 14:10:00 INFO - 'TMOUT': '86400', 14:10:00 INFO - 'USER': 'cltbld', 14:10:00 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', 14:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:00 INFO - '_': '/tools/buildbot/bin/python'} 14:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:00 INFO - Downloading/unpacking psutil>=3.1.1 14:10:00 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 14:10:00 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 14:10:00 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 14:10:00 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 14:10:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:10:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:01 INFO - Installing collected packages: psutil 14:10:01 INFO - Running setup.py install for psutil 14:10:01 INFO - building 'psutil._psutil_linux' extension 14:10:01 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 14:10:02 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 14:10:02 INFO - building 'psutil._psutil_posix' extension 14:10:02 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 14:10:02 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 14:10:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:02 INFO - Successfully installed psutil 14:10:02 INFO - Cleaning up... 14:10:02 INFO - Return code: 0 14:10:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:10:02 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')]} 14:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:02 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')]} 14:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:02 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 0xee61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12595c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12567a0>, '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 0x12576a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1257b30>, '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': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', '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 14:10:02 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 14:10:02 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 14:10:02 INFO - Using env: {'DISPLAY': ':0', 14:10:02 INFO - 'HOME': '/home/cltbld', 14:10:02 INFO - 'LANG': 'en_US.UTF-8', 14:10:02 INFO - 'LANGUAGE': 'en_US:en', 14:10:02 INFO - 'LOGNAME': 'cltbld', 14:10:02 INFO - 'MAIL': '/var/mail/cltbld', 14:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:02 INFO - 'MOZ_NO_REMOTE': '1', 14:10:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:02 INFO - 'NO_EM_RESTART': '1', 14:10:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:02 INFO - 'PWD': '/builds/slave/test', 14:10:02 INFO - 'SHELL': '/bin/bash', 14:10:02 INFO - 'SHLVL': '1', 14:10:02 INFO - 'TERM': 'linux', 14:10:02 INFO - 'TMOUT': '86400', 14:10:02 INFO - 'USER': 'cltbld', 14:10:02 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', 14:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:02 INFO - '_': '/tools/buildbot/bin/python'} 14:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:10:02 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 14:10:02 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 14:10:02 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 14:10:02 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 14:10:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:10:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:10:03 INFO - Installing collected packages: mozsystemmonitor 14:10:03 INFO - Running setup.py install for mozsystemmonitor 14:10:03 INFO - Successfully installed mozsystemmonitor 14:10:03 INFO - Cleaning up... 14:10:03 INFO - Return code: 0 14:10:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:10:03 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')]} 14:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:03 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')]} 14:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:03 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 0xee61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12595c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12567a0>, '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 0x12576a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1257b30>, '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': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', '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 14:10:03 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 14:10:03 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 14:10:03 INFO - Using env: {'DISPLAY': ':0', 14:10:03 INFO - 'HOME': '/home/cltbld', 14:10:03 INFO - 'LANG': 'en_US.UTF-8', 14:10:03 INFO - 'LANGUAGE': 'en_US:en', 14:10:03 INFO - 'LOGNAME': 'cltbld', 14:10:03 INFO - 'MAIL': '/var/mail/cltbld', 14:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:03 INFO - 'MOZ_NO_REMOTE': '1', 14:10:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:03 INFO - 'NO_EM_RESTART': '1', 14:10:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:03 INFO - 'PWD': '/builds/slave/test', 14:10:03 INFO - 'SHELL': '/bin/bash', 14:10:03 INFO - 'SHLVL': '1', 14:10:03 INFO - 'TERM': 'linux', 14:10:03 INFO - 'TMOUT': '86400', 14:10:03 INFO - 'USER': 'cltbld', 14:10:03 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', 14:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:03 INFO - '_': '/tools/buildbot/bin/python'} 14:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:04 INFO - Downloading/unpacking jsonschema==2.5.1 14:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:10:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:10:05 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 14:10:05 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 14:10:05 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 14:10:05 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 14:10:05 INFO - Downloading functools32-3.2.3-2.tar.gz 14:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:10:05 INFO - warning: no files found matching '*.txt' 14:10:05 INFO - no previously-included directories found matching 'build' 14:10:05 INFO - no previously-included directories found matching 'dist' 14:10:05 INFO - no previously-included directories found matching '.git*' 14:10:05 INFO - Installing collected packages: jsonschema, functools32 14:10:05 INFO - Running setup.py install for functools32 14:10:05 INFO - warning: no files found matching '*.txt' 14:10:05 INFO - no previously-included directories found matching 'build' 14:10:05 INFO - no previously-included directories found matching 'dist' 14:10:05 INFO - no previously-included directories found matching '.git*' 14:10:05 INFO - Successfully installed jsonschema functools32 14:10:05 INFO - Cleaning up... 14:10:05 INFO - Return code: 0 14:10:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:10:05 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')]} 14:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:05 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')]} 14:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:05 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 0xee61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12595c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12567a0>, '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 0x12576a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1257b30>, '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': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', '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 14:10:05 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 14:10:05 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 14:10:05 INFO - Using env: {'DISPLAY': ':0', 14:10:05 INFO - 'HOME': '/home/cltbld', 14:10:05 INFO - 'LANG': 'en_US.UTF-8', 14:10:05 INFO - 'LANGUAGE': 'en_US:en', 14:10:05 INFO - 'LOGNAME': 'cltbld', 14:10:05 INFO - 'MAIL': '/var/mail/cltbld', 14:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:05 INFO - 'MOZ_NO_REMOTE': '1', 14:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:05 INFO - 'NO_EM_RESTART': '1', 14:10:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:05 INFO - 'PWD': '/builds/slave/test', 14:10:05 INFO - 'SHELL': '/bin/bash', 14:10:05 INFO - 'SHLVL': '1', 14:10:05 INFO - 'TERM': 'linux', 14:10:05 INFO - 'TMOUT': '86400', 14:10:05 INFO - 'USER': 'cltbld', 14:10:05 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', 14:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:05 INFO - '_': '/tools/buildbot/bin/python'} 14:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:10:05 INFO - Cleaning up... 14:10:05 INFO - Return code: 0 14:10:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:10:05 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')]} 14:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:05 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')]} 14:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:05 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 0xee61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12595c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12567a0>, '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 0x12576a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1257b30>, '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': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', '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 14:10:05 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 14:10:05 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 14:10:05 INFO - Using env: {'DISPLAY': ':0', 14:10:05 INFO - 'HOME': '/home/cltbld', 14:10:05 INFO - 'LANG': 'en_US.UTF-8', 14:10:05 INFO - 'LANGUAGE': 'en_US:en', 14:10:05 INFO - 'LOGNAME': 'cltbld', 14:10:05 INFO - 'MAIL': '/var/mail/cltbld', 14:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:05 INFO - 'MOZ_NO_REMOTE': '1', 14:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:05 INFO - 'NO_EM_RESTART': '1', 14:10:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:06 INFO - 'PWD': '/builds/slave/test', 14:10:06 INFO - 'SHELL': '/bin/bash', 14:10:06 INFO - 'SHLVL': '1', 14:10:06 INFO - 'TERM': 'linux', 14:10:06 INFO - 'TMOUT': '86400', 14:10:06 INFO - 'USER': 'cltbld', 14:10:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', 14:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:06 INFO - '_': '/tools/buildbot/bin/python'} 14:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:06 INFO - Downloading/unpacking blobuploader==1.2.4 14:10:06 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 14:10:06 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 14:10:06 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 14:10:06 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 14:10:07 INFO - Downloading blobuploader-1.2.4.tar.gz 14:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:10:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:10:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:07 INFO - Downloading docopt-0.6.1.tar.gz 14:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:10:07 INFO - Installing collected packages: blobuploader, requests, docopt 14:10:07 INFO - Running setup.py install for blobuploader 14:10:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:10:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:10:08 INFO - Running setup.py install for requests 14:10:08 INFO - Running setup.py install for docopt 14:10:08 INFO - Successfully installed blobuploader requests docopt 14:10:08 INFO - Cleaning up... 14:10:08 INFO - Return code: 0 14:10:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:08 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')]} 14:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:08 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')]} 14:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:08 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 0xee61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12595c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12567a0>, '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 0x12576a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1257b30>, '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': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', '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 14:10:08 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 14:10:08 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 14:10:08 INFO - Using env: {'DISPLAY': ':0', 14:10:08 INFO - 'HOME': '/home/cltbld', 14:10:08 INFO - 'LANG': 'en_US.UTF-8', 14:10:08 INFO - 'LANGUAGE': 'en_US:en', 14:10:08 INFO - 'LOGNAME': 'cltbld', 14:10:08 INFO - 'MAIL': '/var/mail/cltbld', 14:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:08 INFO - 'MOZ_NO_REMOTE': '1', 14:10:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:08 INFO - 'NO_EM_RESTART': '1', 14:10:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:08 INFO - 'PWD': '/builds/slave/test', 14:10:08 INFO - 'SHELL': '/bin/bash', 14:10:08 INFO - 'SHLVL': '1', 14:10:08 INFO - 'TERM': 'linux', 14:10:08 INFO - 'TMOUT': '86400', 14:10:08 INFO - 'USER': 'cltbld', 14:10:08 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', 14:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:08 INFO - '_': '/tools/buildbot/bin/python'} 14:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:08 INFO - Running setup.py (path:/tmp/pip-MSvNhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:08 INFO - Running setup.py (path:/tmp/pip-XoLnNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:08 INFO - Running setup.py (path:/tmp/pip-jxoWxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:08 INFO - Running setup.py (path:/tmp/pip-wuNpfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:09 INFO - Running setup.py (path:/tmp/pip-SG0cfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:09 INFO - Running setup.py (path:/tmp/pip-6ENEQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:09 INFO - Running setup.py (path:/tmp/pip-g6WgIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:09 INFO - Running setup.py (path:/tmp/pip-W04oOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:09 INFO - Running setup.py (path:/tmp/pip-1KoLT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:09 INFO - Running setup.py (path:/tmp/pip-Kmlb6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:09 INFO - Running setup.py (path:/tmp/pip-lzp_RR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:09 INFO - Running setup.py (path:/tmp/pip-mzdYHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:09 INFO - Running setup.py (path:/tmp/pip-vfqTzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:09 INFO - Running setup.py (path:/tmp/pip-DAAi8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:09 INFO - Running setup.py (path:/tmp/pip-rh_3e5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:09 INFO - Running setup.py (path:/tmp/pip-x4N_ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:09 INFO - Running setup.py (path:/tmp/pip-j7O375-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:10:09 INFO - Running setup.py install for manifestparser 14:10:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:10:10 INFO - Running setup.py install for mozcrash 14:10:10 INFO - Running setup.py install for mozdebug 14:10:10 INFO - Running setup.py install for mozdevice 14:10:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:10:10 INFO - Running setup.py install for mozfile 14:10:10 INFO - Running setup.py install for mozhttpd 14:10:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:10:10 INFO - Running setup.py install for mozinfo 14:10:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:10:10 INFO - Running setup.py install for mozInstall 14:10:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:10:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:10:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:10:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:10:10 INFO - Running setup.py install for mozleak 14:10:10 INFO - Running setup.py install for mozlog 14:10:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:10:10 INFO - Running setup.py install for moznetwork 14:10:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:10:11 INFO - Running setup.py install for mozprocess 14:10:11 INFO - Running setup.py install for mozprofile 14:10:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:10:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:10:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:10:11 INFO - Running setup.py install for mozrunner 14:10:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:10:11 INFO - Running setup.py install for mozscreenshot 14:10:11 INFO - Running setup.py install for moztest 14:10:11 INFO - Running setup.py install for mozversion 14:10:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:10:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:10:11 INFO - Cleaning up... 14:10:11 INFO - Return code: 0 14:10:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:11 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')]} 14:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:11 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')]} 14:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:11 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 0xee61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12595c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12567a0>, '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 0x12576a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1257b30>, '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': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', '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 14:10:11 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 14:10:11 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 14:10:11 INFO - Using env: {'DISPLAY': ':0', 14:10:11 INFO - 'HOME': '/home/cltbld', 14:10:11 INFO - 'LANG': 'en_US.UTF-8', 14:10:11 INFO - 'LANGUAGE': 'en_US:en', 14:10:11 INFO - 'LOGNAME': 'cltbld', 14:10:11 INFO - 'MAIL': '/var/mail/cltbld', 14:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:11 INFO - 'MOZ_NO_REMOTE': '1', 14:10:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:11 INFO - 'NO_EM_RESTART': '1', 14:10:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:11 INFO - 'PWD': '/builds/slave/test', 14:10:11 INFO - 'SHELL': '/bin/bash', 14:10:11 INFO - 'SHLVL': '1', 14:10:11 INFO - 'TERM': 'linux', 14:10:11 INFO - 'TMOUT': '86400', 14:10:11 INFO - 'USER': 'cltbld', 14:10:11 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', 14:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:11 INFO - '_': '/tools/buildbot/bin/python'} 14:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:11 INFO - Running setup.py (path:/tmp/pip-A6avKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10:12 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)) 14:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:12 INFO - Running setup.py (path:/tmp/pip-wmOJnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10:12 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)) 14:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:12 INFO - Running setup.py (path:/tmp/pip-XXfZfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10:12 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)) 14:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:12 INFO - Running setup.py (path:/tmp/pip-Du_sJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10:12 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)) 14:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:12 INFO - Running setup.py (path:/tmp/pip-qrY9lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10:12 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)) 14:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:12 INFO - Running setup.py (path:/tmp/pip-CpR0GC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10:12 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)) 14:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:12 INFO - Running setup.py (path:/tmp/pip-O7fJSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10:12 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)) 14:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:12 INFO - Running setup.py (path:/tmp/pip-ix_CmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10:12 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)) 14:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:12 INFO - Running setup.py (path:/tmp/pip-q5NG5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10:12 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)) 14:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:12 INFO - Running setup.py (path:/tmp/pip-QALjcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10:12 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)) 14:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:12 INFO - Running setup.py (path:/tmp/pip-Kce2YG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10:12 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)) 14:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:12 INFO - Running setup.py (path:/tmp/pip-fb9_Ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10:12 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)) 14:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:12 INFO - Running setup.py (path:/tmp/pip-8ad9mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10:12 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)) 14:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:12 INFO - Running setup.py (path:/tmp/pip-_8vNjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10:12 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)) 14:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:12 INFO - Running setup.py (path:/tmp/pip-jD2hwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:13 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)) 14:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:13 INFO - Running setup.py (path:/tmp/pip-e5Q9BA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10:13 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)) 14:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:13 INFO - Running setup.py (path:/tmp/pip-BM5xbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10:13 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)) 14:10:13 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)) 14:10:13 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)) 14:10:13 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)) 14:10:13 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)) 14:10:13 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)) 14:10:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:10:13 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 14:10:13 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 14:10:13 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 14:10:13 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 14:10:14 INFO - Downloading blessings-1.6.tar.gz 14:10:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:10:14 INFO - Installing collected packages: blessings 14:10:14 INFO - Running setup.py install for blessings 14:10:14 INFO - Successfully installed blessings 14:10:14 INFO - Cleaning up... 14:10:14 INFO - Return code: 0 14:10:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:10:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:10:14 INFO - Reading from file tmpfile_stdout 14:10:14 INFO - Current package versions: 14:10:14 INFO - argparse == 1.2.1 14:10:14 INFO - blessings == 1.6 14:10:14 INFO - blobuploader == 1.2.4 14:10:14 INFO - docopt == 0.6.1 14:10:14 INFO - functools32 == 3.2.3-2 14:10:14 INFO - jsonschema == 2.5.1 14:10:14 INFO - manifestparser == 1.1 14:10:14 INFO - mozInstall == 1.12 14:10:14 INFO - mozcrash == 1.0 14:10:14 INFO - mozdebug == 0.1 14:10:14 INFO - mozdevice == 0.50 14:10:14 INFO - mozfile == 1.2 14:10:14 INFO - mozhttpd == 0.7 14:10:14 INFO - mozinfo == 0.9 14:10:14 INFO - mozleak == 0.1 14:10:14 INFO - mozlog == 3.4 14:10:14 INFO - moznetwork == 0.27 14:10:14 INFO - mozprocess == 0.25 14:10:14 INFO - mozprofile == 0.28 14:10:14 INFO - mozrunner == 6.13 14:10:14 INFO - mozscreenshot == 0.1 14:10:14 INFO - mozsystemmonitor == 0.3 14:10:14 INFO - moztest == 0.8 14:10:14 INFO - mozversion == 1.4 14:10:14 INFO - psutil == 3.1.1 14:10:14 INFO - requests == 1.2.3 14:10:14 INFO - wsgiref == 0.1.2 14:10:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:14 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')]} 14:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:14 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')]} 14:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:14 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 0xee61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12595c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12567a0>, '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 0x12576a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1257b30>, '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': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', '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 14:10:14 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 14:10:14 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 14:10:14 INFO - Using env: {'DISPLAY': ':0', 14:10:14 INFO - 'HOME': '/home/cltbld', 14:10:14 INFO - 'LANG': 'en_US.UTF-8', 14:10:14 INFO - 'LANGUAGE': 'en_US:en', 14:10:14 INFO - 'LOGNAME': 'cltbld', 14:10:14 INFO - 'MAIL': '/var/mail/cltbld', 14:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:14 INFO - 'MOZ_NO_REMOTE': '1', 14:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:14 INFO - 'NO_EM_RESTART': '1', 14:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:14 INFO - 'PWD': '/builds/slave/test', 14:10:14 INFO - 'SHELL': '/bin/bash', 14:10:14 INFO - 'SHLVL': '1', 14:10:14 INFO - 'TERM': 'linux', 14:10:14 INFO - 'TMOUT': '86400', 14:10:14 INFO - 'USER': 'cltbld', 14:10:14 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', 14:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:14 INFO - '_': '/tools/buildbot/bin/python'} 14:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:14 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)) 14:10:14 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)) 14:10:14 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)) 14:10:14 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)) 14:10:14 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)) 14:10:14 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)) 14:10:14 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)) 14:10:14 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)) 14:10:14 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)) 14:10:14 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:16 INFO - Downloading marionette_driver-1.4.0.tar.gz 14:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 14:10:16 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)) 14:10:16 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)) 14:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:10:16 INFO - Installing collected packages: marionette-driver 14:10:16 INFO - Running setup.py install for marionette-driver 14:10:16 INFO - Successfully installed marionette-driver 14:10:16 INFO - Cleaning up... 14:10:16 INFO - Return code: 0 14:10:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:10:16 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')]} 14:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:16 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')]} 14:10:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xee61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12595c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12567a0>, '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 0x12576a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1257b30>, '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': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', '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 14:10:16 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 14:10:16 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 14:10:16 INFO - Using env: {'DISPLAY': ':0', 14:10:16 INFO - 'HOME': '/home/cltbld', 14:10:16 INFO - 'LANG': 'en_US.UTF-8', 14:10:16 INFO - 'LANGUAGE': 'en_US:en', 14:10:16 INFO - 'LOGNAME': 'cltbld', 14:10:16 INFO - 'MAIL': '/var/mail/cltbld', 14:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:16 INFO - 'MOZ_NO_REMOTE': '1', 14:10:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:16 INFO - 'NO_EM_RESTART': '1', 14:10:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:16 INFO - 'PWD': '/builds/slave/test', 14:10:16 INFO - 'SHELL': '/bin/bash', 14:10:16 INFO - 'SHLVL': '1', 14:10:16 INFO - 'TERM': 'linux', 14:10:16 INFO - 'TMOUT': '86400', 14:10:16 INFO - 'USER': 'cltbld', 14:10:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', 14:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:16 INFO - '_': '/tools/buildbot/bin/python'} 14:10:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:10:16 INFO - Cleaning up... 14:10:16 INFO - Return code: 0 14:10:16 INFO - Running post-action listener: _resource_record_post_action 14:10:16 INFO - Running post-action listener: _start_resource_monitoring 14:10:16 INFO - Starting resource monitoring. 14:10:16 INFO - [mozharness: 2017-05-24 21:10:16.530506Z] Finished create-virtualenv step (success) 14:10:16 INFO - [mozharness: 2017-05-24 21:10:16.531089Z] Running install step. 14:10:16 INFO - Running pre-action listener: _resource_record_pre_action 14:10:16 INFO - Running main action method: install 14:10:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:10:16 INFO - Reading from file tmpfile_stdout 14:10:16 INFO - Detecting whether we're running mozinstall >=1.0... 14:10:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:10:16 INFO - Reading from file tmpfile_stdout 14:10:16 INFO - Output received: 14:10:16 INFO - Usage: mozinstall [options] installer 14:10:16 INFO - Options: 14:10:16 INFO - -h, --help show this help message and exit 14:10:16 INFO - -d DEST, --destination=DEST 14:10:16 INFO - Directory to install application into. [default: 14:10:16 INFO - "/builds/slave/test"] 14:10:16 INFO - --app=APP Application being installed. [default: firefox] 14:10:16 INFO - mkdir: /builds/slave/test/build/application 14:10:16 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'] 14:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:10:32 INFO - Reading from file tmpfile_stdout 14:10:32 INFO - Output received: 14:10:32 INFO - /builds/slave/test/build/application/firefox/firefox 14:10:32 INFO - Running post-action listener: _resource_record_post_action 14:10:32 INFO - [mozharness: 2017-05-24 21:10:32.967819Z] Finished install step (success) 14:10:32 INFO - [mozharness: 2017-05-24 21:10:32.968095Z] Running run-tests step. 14:10:32 INFO - Running pre-action listener: _resource_record_pre_action 14:10:32 INFO - Running main action method: run_tests 14:10:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:10:32 INFO - Python 2.7.3 14:10:32 INFO - Return code: 0 14:10:32 INFO - grabbing minidump binary from tooltool 14:10: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')]} 14:10:32 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 0x12567a0>, '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 0x12576a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1257b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:10:32 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 14:10:32 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 14:10:32 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 14:10:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:10:33 INFO - Return code: 0 14:10:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:10:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:10:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:10:33 INFO - ENV: RUST_BACKTRACE is now 1 14:10:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:10:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:10:33 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/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 14:10:33 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/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 14:10:33 INFO - Using env: {'DISPLAY': ':0', 14:10:33 INFO - 'HOME': '/home/cltbld', 14:10:33 INFO - 'LANG': 'en_US.UTF-8', 14:10:33 INFO - 'LANGUAGE': 'en_US:en', 14:10:33 INFO - 'LOGNAME': 'cltbld', 14:10:33 INFO - 'MAIL': '/var/mail/cltbld', 14:10:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:10:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:33 INFO - 'MOZ_NO_REMOTE': '1', 14:10:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:33 INFO - 'NO_EM_RESTART': '1', 14:10:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:33 INFO - 'PWD': '/builds/slave/test', 14:10:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:10:33 INFO - 'RUST_BACKTRACE': '1', 14:10:33 INFO - 'SHELL': '/bin/bash', 14:10:33 INFO - 'SHLVL': '1', 14:10:33 INFO - 'TERM': 'linux', 14:10:33 INFO - 'TMOUT': '86400', 14:10:33 INFO - 'USER': 'cltbld', 14:10:33 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362', 14:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:33 INFO - '_': '/tools/buildbot/bin/python'} 14:10:33 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/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 14:10:33 INFO - mozversion application_buildid: 20170524203251 14:10:33 INFO - mozversion application_changeset: 934ff2cb74b00bb92a7ab4f39aeaa014a9075a67 14:10:33 INFO - mozversion application_display_name: Nightly 14:10:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:10:33 INFO - mozversion application_name: Firefox 14:10:33 INFO - mozversion application_remotingname: firefox 14:10:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:10:33 INFO - mozversion application_vendor: Mozilla 14:10:33 INFO - mozversion application_version: 55.0a1 14:10:33 INFO - mozversion platform_buildid: 20170524203251 14:10:33 INFO - mozversion platform_changeset: 934ff2cb74b00bb92a7ab4f39aeaa014a9075a67 14:10:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:10:33 INFO - mozversion platform_version: 55.0a1 14:10:33 INFO - using testdate: 1495660233 14:10:33 INFO - actual date: 1495660233 14:10:33 INFO - starting webserver on 'localhost:44381' 14:10:33 INFO - SUITE-START | Running 2 tests 14:10:33 INFO - TEST-START | dromaeo_css 14:10:33 INFO - operating with platform_type : linux_ 14:10:33 INFO - Initialising browser for dromaeo_css test... 14:10:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44381/getInfo.html -profile /tmp/tmpcnWf6x/profile 14:10:33 INFO - TEST-INFO | started process 26635 (/builds/slave/test/build/application/firefox/firefox http://localhost:44381/getInfo.html) 14:11:08 INFO - TEST-INFO | 26635: killed by SIGTERM 14:11:08 INFO - Browser initialized. 14:11:08 INFO - Running cycle 1/1 for dromaeo_css test... 14:11:08 INFO - TEST-INFO | started process 26858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcnWf6x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:20 INFO - PID 26858 | RSS: Main: 175517696 14:11:20 INFO - PID 26858 | 14:14:25 INFO - PID 26858 | Cycle 1(1): loaded http://localhost:44381/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44381/tests/dromaeo/cssquery-ext.html) 14:14:27 INFO - PID 26858 | RSS: Main: 173305856 14:14:27 INFO - PID 26858 | 14:17:29 INFO - PID 26858 | Cycle 1(1): loaded http://localhost:44381/tests/dromaeo/cssquery-ext.html (next: http://localhost:44381/tests/dromaeo/cssquery-jquery.html) 14:17:29 INFO - PID 26858 | RSS: Main: 178913280 14:17:29 INFO - PID 26858 | 14:20:31 INFO - PID 26858 | Cycle 1(1): loaded http://localhost:44381/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44381/tests/dromaeo/cssquery-mootools.html) 14:20:32 INFO - PID 26858 | RSS: Main: 179888128 14:20:32 INFO - PID 26858 | 14:23:34 INFO - PID 26858 | Cycle 1(1): loaded http://localhost:44381/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44381/tests/dromaeo/cssquery-prototype.html) 14:23:34 INFO - PID 26858 | RSS: Main: 181174272 14:23:34 INFO - PID 26858 | 14:26:37 INFO - PID 26858 | Cycle 1(1): loaded http://localhost:44381/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44381/tests/dromaeo/cssquery-yui.html) 14:26:38 INFO - PID 26858 | RSS: Main: 180248576 14:26:38 INFO - PID 26858 | 14:29:39 INFO - PID 26858 | Cycle 1(1): loaded http://localhost:44381/tests/dromaeo/cssquery-yui.html (next: http://localhost:44381/tests/dromaeo/cssquery-dojo.html) 14:29:40 INFO - PID 26858 | RSS: Main: 177909760 14:29:40 INFO - PID 26858 | 14:29:40 INFO - PID 26858 | __start_tp_report 14:29:40 INFO - PID 26858 | _x_x_mozilla_page_load 14:29:40 INFO - PID 26858 | _x_x_mozilla_page_load_details 14:29:40 INFO - PID 26858 | |i|pagename|runs| 14:29:40 INFO - PID 26858 | |0;dojo.html;2716.0358072884114;2721.1972468121908;2747.2857057165143;2754.779617630589;2759.6688397392318;5313.654612450188;5333;5348.866278343038;5377.65045272058;5414.242006119146;5274.235235890803;5324.1215199492035;5353.625246232756;5373.220882971977;5402.243685883979;4762.952370476286;4790.904181916359;4810.350602668647;4833.202521583935;4866.46468888422;4760.90478190436;4815.157347464197;4826.420829500447;4843.782029808667;4874.951250487486;4662.836800711959;4725.834595789165;4786.688865223749;4797.352357431737;4849.515048495157;4651.88370290742;4664.953350466486;4703.482616912137;4727.290906364073;4741.57325840676;4692.178868697998;4692.6245900327895;4699.976500117477;4724.055188962221;4756.809727610891;5272.472752724697;5283.313169288006;5294.894102117974;5305.575553955674;5329.120695085307;5689.374168841424;5704.600677952545;5750.511206547449;5776.826695199151;5797.942020579782;5867.178594996704;5885.705714714247;5901.616394934315;5908.231929849135;5912.615679980788;5412.296401467824;5415.864603384868;5421.241026256327;5423.29497165366;5428.701421421781;5923.526117910556;5930.970345148333;5958.970205149033;5965.105234214902;5967.880642387128;5624.353199382042;5646.435356464321;5739.713014349266;5743.023685973395;5751.338596061507;5772.3938986406665;5800.100984347433;5811.622244554091;5818.127280907897;5818.854528636818;5632.802851900164;5771.884562308815;5775.104858746901;5775.855603609859;5775.88448231033;5647.971760141173;5702.771889124471;5713.628614140068;5772.538196944234;5807.216025836458;4842.685225460334;4843.854684359475;4852.975735121302;4884.340614017134;4903.01939612079;4149.958500415018;4153.314703074019;4153.709240353207;4184.14225083857;4239.130978149472;4811.374521312207;4872.6589138760655;4881.8535443936735;4905.484924082992;4917.311576379309;5697.088465845528;5808.041673123887;5817.127430885316;5834.474897259182;5890.204822349014;4860.052289803525;4864.075825593126;4869.70781753096;4881.121398148367;4938.23457364102;5023.09584274834;5138.409082955508;5139.640225184276;5147.330846989942;5153.51041651035;5296.390915044819;5346.0644387231305;5427.13165893471;5427.538659213853;5432.375276843056;5701.401352858056;5791.652500849794;5795.565332599987;5820.854478638068;5852.853678658068;5292.9206061908335;5381.811636592701;5407.324084489439;5433.755481003285;5434.972825135849;5671.206031155559;5772.9711351442975;5786.247787787729;5792.391798861059;5807.970960145172;5759.395263497272;5879.235699359056;5880.176775251553;5893.764249429974;5925.970370148121;5607.299087614048;5693.914591281217;5718.8848174605555;5724.484796368347;5735.856603584777;5597.80407685729;5600.719964001865;5602.523785478117;5607.607467477401;5633.915491267716;5499.450054994629;5522.282103326542;5523.226748255328;5525.502704756591;5527.723613819373;5571.247881535941;5643.604947653789;5679.034564124191;5713.257276554022;5714.857128571819;5551.028570000153;5604.159376093456;5605.383407825055;5629.634073785191;5640.605157638925 14:29:40 INFO - PID 26858 | |1;ext.html;628.9119523266744;691.6196092149319;706.2161001288571;1192.1118766518944;1206.294317824074;33981.830090849544;34657.30685386294;34704.479432808526;34707;34834.129146771345;32250.838745806297;32515.837420812863;32559.348813023724;32566.185845353877;32592.511112333275;6458.741650333981;6696.564723292995;6818.659067046628;6819.727210911557;6821.863562728742;6703.061571380011;6730.528862979593;6773.661316934158;6803.693833777467;6821.283765204656;6773.830654233634;6783.796486105425;6824.078749368821;6849.349311815369;6854.383105520502;6725.697343619524;6751.527393082486;6777.085093512362;6777.999999999975;6789.626570538619;6750.62871542065;6814.1482314710665;6816.863662726767;6838.111045564045;6844.041834143224;31646.367072658417;31706.682933170836;31775;31860.203494912814;32056;3071;3103;3113.3306339137193;3117.516784898344;3122.594062771848;24375.512489750105;24402.877985610136;24509.63235551468;24541.877290613433;24551.508969820683;2744.7118052604587;2763.3367991681853;2772.5979732938613;2774.7641450476735;2793.2737488252997;139984.30007849896;140218.2989085048;140818;151199;154013;37506.43740343897;37512.43731344032;37691.81154094212;37758.81120594379;37942.051448714;39526.60473395229;39564.2087158261;39626.60373396287;39656.405153922715;43080.78459607682;12939.353032348345;12977.221366718028;12999;13022.413991370222;13032.739345213042;10446.529906154241;10461.110805581611;10477.423741694127;10488;10558.31370960885;12628.179168354027;12674.176178548365;12678.429470673842;12759.872401276054;12800.359982000862;5332.5467335276935;5392.272043274186;5394.649347792381;5404.243405923174;5496.230527726121;861;910.6175406329226;915.0712027292303;922.9169374756304;939.0937745075898;20133.295334663217;20932.37202883916;21004;21242.893785530974;21355.46611334729;980.2648013989508;983.439439519467;984.960601575929;990.5344488090586;1009.0978505517153;10739.301945373525;10773.569057237622;11067;11148;11217.887821121847;167758;168708.15645921693;168709;168750;168871;38712.80643596764;39532.20935581272;39606;39781.40327895084;39875.40186897199;1190.119311709329;1245.3897590180745;1248.8751124887438;1249.8625151233357;1262.2426544073483;18943.71584426207;19481.415557533295;20295.188192472728;20373.59252814965;20431;28733.712662873102;35940.28119437649;36402.635973639924;36524.26951461009;36576.26847463089;160754;161448;163018;163289;163636.18181909015;28740.42519149647;29078.27304317409;29112.27219319534;29496.705032949394;29571.964981225552;34560.135996600286;35800.82099589486;36250.63749362472;36572.45141322829;36939.26121477502;26604;27014.864925675247;27348.589771153846;27544.586831197146;28194.71805282003;26608.20175394741;26919;27423;27762.167134985175;28685.856570717013;30347.393052139276;30390;30801.691983079883;30803.383932321678;32232.677673223905;26127.477450450504;26989.325266868484;27257.591136132578;27491.450170996068;27593.86203069052;18337.449876503193;20756.169753209702;20804;20863.374098776454;20897.58204835925 14:29:40 INFO - PID 26858 | |2;jquery.html;404.5630718823669;417.6157934700076;420.58362221400813;429.7622846202937;430.96767742419314;14237.71524569508;14790.482333118343;17365.305387784472;18029.008404537744;18058.46503047241;18367.54081147972;18709.532261693465;18737.625247495074;18853.905730471328;19087.713684294748;5277.182036784305;5388.649737767042;5503.147012213093;5550.389457159709;5558.527525160346;5276.683398996072;5417.83746487606;5425.701586412746;5439.238506609078;5443.292371991635;4828.830990915319;5322.787088516455;5353.197020446944;5363.168708850135;5374.7850085996515;5309.30978972733;5324.7071411072375;5347.331583552075;5348.91976620351;5365.731713414314;4706.670533062687;4837.782299796518;4850.5877000455;4877.487863774323;4879.658423910328;22348.88825555878;22399.44001399978;22554.88722556377;22658.66012009821;22712.091516339326;1594.7288960876679;1610.822809490955;1650.6863695897741;1653.3386645341839;1657.3619156624666;14567.198804065772;14685.77971330431;15100.54698359051;15121.092734435859;15266.694666106616;2057.146284292017;2098.6956891250684;2142;2142.6893100500342;2147.860389074705;86822.56588717079;87148;89212;91566;93479.53260233655;10745.355278683304;10984.890151098387;11031.889681103086;11035.917238084838;11242.437878106062;15491.612709682347;15548.533543993699;15610.76583851243;15612.141332226609;15612.76580851288;7287.089113860768;7462.776116716507;7481.5511069334925;7556;7581.090269167735;6688.431483323972;6689;6833.555818871758;6876.277990810993;6930.653467326613;6799.3200679931615;6954.965225173842;6969;7049.224585295613;7093.290670932865;2057.331367305632;2064.876107433559;2074.844386671006;2121.1833444123813;2185.1368709359713;831.5218749219223;858.9613467393982;865.9090795466385;877.4384393987725;904;16524.834751652328;16733.581660458585;17105.572360691083;17550.736738948926;17682.734758978626;850.6469815026694;874.3660845886682;880.264978742757;893.066745251214;894.4901406198404;8971.730848074569;9216.447013179231;9490.90509094914;9500.42997420157;9694.951525242328;345680;346813;351776;355888;358426;75249.49501009949;75587.62206188934;75665;80369;83480.16519834845;1029.1715169288645;1041.8853926068127;1078.0513148429488;1078.6440474643505;1078.719532921446;16044.358225670843;16642;16776.32894684199;16792.32830686759;17305.04822234789;37487.25025499529;39175.41236881506;39645.80177099096;39706.40440393339;39879.202415952095;49924;50104.498955009985;52110.21834672559;52347.738261309976;53196.46803531915;7672.80817979555;7861.174576669596;7868.921310786819;7991.560464174294;8220.17798220197;11416.885831141582;11581.478833452684;11757.118216133653;11880.287182769061;11983.801619837946;9676.612935482503;9708.223342132753;9754.853677194706;10220.080192782685;10412;9423.858642120511;9519.666811661558;9558.56986435598;9600.567974441026;9661;9845.310828241954;9864.5560949756;9892.406455612398;10065.647702330383;10256.43589602579;7490.4007679386605;7667.11828139771;7684.8463030740195;7772.339351155215;7809.570473623778;9851.211903047883;9856.753581160528;9958.900410995797;10196.796064078826;10231.181505479693 14:29:40 INFO - PID 26858 | |3;mootools.html;1288.5940928607488;1308.6989992301776;1314.664760486076;1318.6769241535826;1345.7644912140377;10168.44073575953;10531.947340263288;10677.572897084106;10688.839667404985;10883.83674244885;10658.147348212144;10950.233483656128;10973.067289280421;10982.176336774733;11011.229213955006;2244.4052326133587;2271.681964524968;2273.6816845641624;2279.225063478417;2289.5878741826464;2119.862208956413;2160.5894879972834;2167.7615462299136;2174.8803815790125;2175.8150557202657;2096.329174664108;2107.4309936317186;2129.190907455165;2131.041031535807;2135.1566131378095;2124.129107066111;2125.2242931330106;2130.382189165148;2135.4981579328846;2144.946376340604;1984.8015198480182;2021.3935819254166;2053.938381848547;2059.7116403703494;2222.9333120006427;10433.79132417355;10557.683269501927;10558.683239502827;10568;10570.260081794277;5421.539169170625;5623.522000629951;5642.238297829782;5645.407232240596;5647.43525647436;3159.162821852211;3296;3343.866245350183;3350.095474221971;3359.6976272135626;997.8353571660667;1002.4636819301711;1012.205418746288;1017.9338343007681;1039.9220058495644;15753;15878.603034924105;15901.204939752966;15917.840821591868;15969.680606387923;4643.582077612963;4722.433308003062;4915.68048076881;4935.950640493549;4943;11186.608468703718;11202.495887685074;11210.327380357041;11216.887831121747;11228.270162439416;5424.349078110573;5496.065668836228;5506.504414602625;5514.228008078872;5520.613557051048;5044.2937988681615;5068.56917162038;5097.770600322994;5099.87250318745;5108.821191258288;3673.430618254175;3729.384651532521;3767.6232376762105;3784.962150378461;3823.2735780201674;1050.1598721023151;1052.3790963331671;1064.7444613292755;1086.6088208245026;1089.6186334782922;701.4423533291045;733.9486235963432;734.0750654175777;737.6164394514823;751.4514404484756;5611.9438805612235;5646.943530564642;5694.5159661428415;5722.799702010493;5837.474627283565;540.7458494507654;560.3723829311198;566.8724536979229;568.4145330309788;569.6781318555086;3719.34911390511;4012.378081397388;4026.456428382131;4054.8378064877666;4199.559046300094;13668.384922678504;13753.518626848012;13870.861291387158;13882.583522494342;13907.79138312926;13303.534376296782;13739.24434156131;13804.309784510935;13810.240436776074;13816.447342106405;7637.2362763724295;7733.265339792711;7846.882296765553;7869.213078692085;7873;5991.490723288569;5992.370801065826;6059.33347331802;6067;6259.624422534663;12014.339211343111;12185.69535761613;12194.51221951112;12369.93815030919;12494.625161245178;12314.692132696397;12593.874061259638;12618.17981831178;12795.61613151607;12813.8077928833;8494.575271236537;8640.092790256933;8648.78378040554;8692.956535217283;8777.210051095431;9521.904780952102;9575.712728618153;9596.520173991412;9660;9665;8472.661093556435;8554.957225213833;8563.914360856312;8856.335774817044;8926.241269492166;8273.172682731678;8357.582120894052;8374.330053595575;8490.575471226537;8553.401261911606;7499.1750907399055;7606.809829754079;7615.885761713689;7626.771196863881;7627.161012288755;4780.330753694416;4979.502049794992;5004.974975125101;5047.596192304533;5287.52412282881;5469.179623056414;5487.670739755627;5489.34127904654;5609.775608975595;5626.240457538343 14:29:40 INFO - PID 26858 | |4;prototype.html;343.4916323840716;353.2775474155352;363.271640361076;365.1000284299202;366.1249613423917;5503.834884953458;5579.038882393505;5625.099984002565;5659.858503537408;5662.235598194247;5349.8127565535215;5467.1411720015185;5480.561555075595;5492.313460817398;5495.917561236584;4082.3468245080644;4103.630673239408;4110;4120.25835349637;4121.072758629314;4006.3389540725743;4111.835526578933;4114.341705327149;4115.32097203961;4132.8966775830695;4056.3509838425857;4070.3690927906073;4084.89787755307;4091.672666186713;4098.97950510247;4038.071243613985;4049.7367671101283;4060.4112403701592;4067.0849058961644;4075.1442197138635;3507.333606614735;3520.7359448041243;3529.1530032792202;3536.974277459534;3548.982255088734;5263.763130659129;5355.250264962909;5358.517733403974;5402.729863506848;5403.972980135113;4746.691465054761;4769.427668679746;4777.116233496814;4782.545658162469;4796;5643.391633384465;5775.740091695884;5789.710514474259;5791.623544469596;5826.796062137847;4373.834951698929;4392.604665580113;4396.20868243716;4401.097774956126;4415.183191109655;5910.940890591082;6121.775644870999;6133.907991380132;6185.381461853779;6224.937750622481;4234.343676730112;4249.915001699948;4252.894247495611;4254.893727630838;4255.319148936155;4306.956930430718;4309.741415515016;4313.352997050405;4327.588879056485;4352.760598167131;4945.579625731853;4949.406071271471;4956.677815941952;5085.7202853842655;5115.693058416507;5907.645541267538;5908.763649454059;5926.318473375531;5944.256967879015;5946;1571.1515781478101;1590.3479573374862;1598.9840101599068;1600.2718762962825;1600.3998500562288;1105.950232239551;1134.9886501135047;1138.4706111658118;1143.6226045404997;1147.925384849982;4987.152184128707;5028.949710502921;5030.8239211627415;5034.773435195425;5066.290719299227;6023.397660233942;6056.788642271564;6070.423309785563;6075.2405949256345;6121.234845644294;4927.063857866994;4986.526280003394;4998.5751211146735;5010.423801262901;5028.79884804611;3166.4300425923093;3220.806751594912;3224.935501289961;3226.8709251630144;3231.7253033492416;5479.917801232985;5554.611177217636;5561.916571251434;5596.468335508202;5636.2391077204875;6171.228596425447;6192.628442293477;6228.4463370018075;6245.937540624626;6259.186305780219;5545.916811247835;5547.889042219133;5603.411641777636;5609.775608975677;5620.325560932714;5876.118582212703;5998.700064996646;6037.63774173551;6043.697815109315;6064.241969753781;5775.855603609775;5935.317438494629;5938.762449501972;5941;5949.434803693643;5558.610897237155;5574.136008918624;5616.157576363578;5619.915701264403;5633.774649013993;4017.4777278953547;4032.1129351542613;4038.454808600919;4045.3931910213705;4082.652974497201;5983.826418179851;6082;6104.4505994460715;6120.540959427972;6142.938570614237;5903.4686878179455;5915.37888521699;5918.585699001029;5920.763169473173;5931.792387266425;5762.827115186551;5803.83923215367;5835.358110607915;5835.649861008353;5845.152452894392;5786.971065144648;5793.652380857162;5794.855128621818;5808.186853840551;5817.214676018683;5789.79735709265;5816.534677225896;5830.387809279964;5837.102941543931;5852.7416605430035;5635.943640563706;5643.3792282848035;5660.688662123623;5721.370649228498;5734.254546908875 14:29:40 INFO - PID 26858 | |5;yui.html;740.5926740292845;758.3099379564594;760.2967255288858;771.0901136658744;777.1218523068933;12910.612681619556;13718.931405342984;13763.724725505497;15584.766228506582;16026.83973160271;16671.749923751122;16899.662006759856;16946.661066778655;16981.83018169818;17027.91486042568;862.8533149364623;872.9170728780756;887.0552861202831;887.4586502233632;889.4752096263203;895.1809094678395;909.2771246858763;916.3539704508339;916.6196028648103;916.8578870275085;951.8001219743862;953.5851904421564;956.3735753081708;956.4500412262942;957.5260246178152;935.9110884465965;936.8173206224789;937.7655586103474;939.5912777941583;943.1935694980762;703.1105651351045;703.7466512055656;704.17259719829;705.7353492440335;706.8727629026773;13813.171209727449;14329.283535823271;14396.136231826124;14431;14476.927615361856;15397.538073857802;15895.443659471863;16053.759193611988;16081.035137891764;16093.678126437406;12417.813732794015;12838.293893835835;12850.100492965496;12862.871371286261;12873.806892896613;3071.6006919100373;3088.042706760889;3096.6438859531218;3100.1319630503494;3111.9066428006968;79436.20563794347;80240;80838.19161808366;80872.59563702202;81401;12675.17611355259;13113.213207207598;13140;13253.536126235536;13335.066545341733;23268.767312327;23981.681007544405;24196.637050444257;24292.51414971726;24331.87834060854;5787.623804452697;5829.300483941955;5838.649681019152;5863.501602363762;6084.361142080106;2868.727470890262;2956.4234974179826;2980.463516567039;2985.0597061925423;2997.505411607104;3760.4547340636;3861.903452413656;3862.8990737639638;3871.109644781716;3882.4176373544196;747.6784982457486;760.8021914302321;773.5474747272796;773.6325245508451;774.5004472115454;553.7374785489092;599.8140576421237;605.7879742090321;628.6636649392553;635.8982562790023;10189.847152292721;10624.256302058782;10792.78414431707;11052.944735276273;11276.830847537294;586.0564491169214;586.7330364684059;591.4499515450586;595.4908553187049;612.7640858269509;4441.822327106945;4733.857984260478;4756.548127927841;4772.761361931959;4920.6801557898625;90274;91888.54055729679;93062.53468732613;94139.52930235442;94172.52913735388;75467.24532754603;76705;77679.61160194276;78163.60918195373;81586;60772.39227607667;61035.694821525605;61627;61933.38066619366;70429;10135.39187648714;10569.63006294776;10585.735356616146;10784.975427334391;10947.945260273647;27423.177304680892;27568.58647120335;27735.722642773315;28204.71795282021;28762.424751504434;51626.74186629043;52906.735466322425;53432.73283633557;54153;54749;14602.634934126732;15178.772318415453;15667.843321567094;15691.529254122395;15771.44799931997;17139.228734707216;17415.651686966445;18009.459716208534;18044.458666240032;18390.908045459688;14534.273286335852;15945.123018234108;16013.199340033185;16074.678506429573;16185.10981896007;15709.135997520247;16154.434594789125;16350.34598616042;16464.83535164633;16776.832231678014;14896.478623248135;15262.694746104793;15945.521634350987;16170.919145404197;16440.342386304415;9745.707628771148;9889.258305626963;10112.191024718151;10286.537105830404;10444;11615.245009074382;12645.557405490763;12658.177218481138;12706.682332941751;12718.491260349852 14:29:40 INFO - PID 26858 | __end_tp_report 14:29:40 INFO - PID 26858 | __start_cc_report 14:29:40 INFO - PID 26858 | _x_x_mozilla_cycle_collect,357 14:29:40 INFO - PID 26858 | __end_cc_report 14:29:40 INFO - PID 26858 | __startTimestamp1495661380189__endTimestamp 14:29:40 INFO - PID 26858 | 14:29:40 INFO - PID 26858 | ------- Summary: start ------- 14:29:40 INFO - PID 26858 | Number of tests: 6 14:29:40 INFO - PID 26858 | 14:29:40 INFO - PID 26858 | [#0] dojo.html Cycles:165 Average:5290.00 Median:5432.38 stddev:636.19 (11.7%) stddev-sans-first:605.25 14:29:40 INFO - PID 26858 | Values: 2716.0 2721.2 2747.3 2754.8 2759.7 5313.7 5333.0 5348.9 5377.7 5414.2 5274.2 5324.1 5353.6 5373.2 5402.2 4763.0 4790.9 4810.4 4833.2 4866.5 4760.9 4815.2 4826.4 4843.8 4875.0 4662.8 4725.8 4786.7 4797.4 4849.5 4651.9 4665.0 4703.5 4727.3 4741.6 4692.2 4692.6 4700.0 4724.1 4756.8 5272.5 5283.3 5294.9 5305.6 5329.1 5689.4 5704.6 5750.5 5776.8 5797.9 5867.2 5885.7 5901.6 5908.2 5912.6 5412.3 5415.9 5421.2 5423.3 5428.7 5923.5 5931.0 5959.0 5965.1 5967.9 5624.4 5646.4 5739.7 5743.0 5751.3 5772.4 5800.1 5811.6 5818.1 5818.9 5632.8 5771.9 5775.1 5775.9 5775.9 5648.0 5702.8 5713.6 5772.5 5807.2 4842.7 4843.9 4853.0 4884.3 4903.0 4150.0 4153.3 4153.7 4184.1 4239.1 4811.4 4872.7 4881.9 4905.5 4917.3 5697.1 5808.0 5817.1 5834.5 5890.2 4860.1 4864.1 4869.7 4881.1 4938.2 5023.1 5138.4 5139.6 5147.3 5153.5 5296.4 5346.1 5427.1 5427.5 5432.4 5701.4 5791.7 5795.6 5820.9 5852.9 5292.9 5381.8 5407.3 5433.8 5435.0 5671.2 5773.0 5786.2 5792.4 5808.0 5759.4 5879.2 5880.2 5893.8 5926.0 5607.3 5693.9 5718.9 5724.5 5735.9 5597.8 5600.7 5602.5 5607.6 5633.9 5499.5 5522.3 5523.2 5525.5 5527.7 5571.2 5643.6 5679.0 5713.3 5714.9 5551.0 5604.2 5605.4 5629.6 5640.6 14:29:40 INFO - PID 26858 | 14:29:40 INFO - PID 26858 | [#1] ext.html Cycles:180 Average:30208.09 Median:16730.50 stddev:41009.13 (245.1%) stddev-sans-first:41064.02 14:29:40 INFO - PID 26858 | Values: 628.9 691.6 706.2 1192.1 1206.3 33981.8 34657.3 34704.5 34707.0 34834.1 32250.8 32515.8 32559.3 32566.2 32592.5 6458.7 6696.6 6818.7 6819.7 6821.9 6703.1 6730.5 6773.7 6803.7 6821.3 6773.8 6783.8 6824.1 6849.3 6854.4 6725.7 6751.5 6777.1 6778.0 6789.6 6750.6 6814.1 6816.9 6838.1 6844.0 31646.4 31706.7 31775.0 31860.2 32056.0 3071.0 3103.0 3113.3 3117.5 3122.6 24375.5 24402.9 24509.6 24541.9 24551.5 2744.7 2763.3 2772.6 2774.8 2793.3 139984.3 140218.3 140818.0 151199.0 154013.0 37506.4 37512.4 37691.8 37758.8 37942.1 39526.6 39564.2 39626.6 39656.4 43080.8 12939.4 12977.2 12999.0 13022.4 13032.7 10446.5 10461.1 10477.4 10488.0 10558.3 12628.2 12674.2 12678.4 12759.9 12800.4 5332.5 5392.3 5394.6 5404.2 5496.2 861.0 910.6 915.1 922.9 939.1 20133.3 20932.4 21004.0 21242.9 21355.5 980.3 983.4 985.0 990.5 1009.1 10739.3 10773.6 11067.0 11148.0 11217.9 167758.0 168708.2 168709.0 168750.0 168871.0 38712.8 39532.2 39606.0 39781.4 39875.4 1190.1 1245.4 1248.9 1249.9 1262.2 18943.7 19481.4 20295.2 20373.6 20431.0 28733.7 35940.3 36402.6 36524.3 36576.3 160754.0 161448.0 163018.0 163289.0 163636.2 28740.4 29078.3 29112.3 29496.7 29572.0 34560.1 35800.8 36250.6 36572.5 36939.3 26604.0 27014.9 27348.6 27544.6 28194.7 26608.2 26919.0 27423.0 27762.2 28685.9 30347.4 30390.0 30801.7 30803.4 32232.7 26127.5 26989.3 27257.6 27491.5 27593.9 18337.4 20756.2 20804.0 20863.4 20897.6 14:29:40 INFO - PID 26858 | 14:29:40 INFO - PID 26858 | [#2] jquery.html Cycles:180 Average:24336.54 Median:4878.57 stddev:58873.41 (1206.8%) stddev-sans-first:59011.14 14:29:40 INFO - PID 26858 | Values: 404.6 417.6 420.6 429.8 431.0 14237.7 14790.5 17365.3 18029.0 18058.5 18367.5 18709.5 18737.6 18853.9 19087.7 5277.2 5388.6 5503.1 5550.4 5558.5 5276.7 5417.8 5425.7 5439.2 5443.3 4828.8 5322.8 5353.2 5363.2 5374.8 5309.3 5324.7 5347.3 5348.9 5365.7 4706.7 4837.8 4850.6 4877.5 4879.7 22348.9 22399.4 22554.9 22658.7 22712.1 1594.7 1610.8 1650.7 1653.3 1657.4 14567.2 14685.8 15100.5 15121.1 15266.7 2057.1 2098.7 2142.0 2142.7 2147.9 86822.6 87148.0 89212.0 91566.0 93479.5 10745.4 10984.9 11031.9 11035.9 11242.4 15491.6 15548.5 15610.8 15612.1 15612.8 7287.1 7462.8 7481.6 7556.0 7581.1 6688.4 6689.0 6833.6 6876.3 6930.7 6799.3 6955.0 6969.0 7049.2 7093.3 2057.3 2064.9 2074.8 2121.2 2185.1 831.5 859.0 865.9 877.4 904.0 16524.8 16733.6 17105.6 17550.7 17682.7 850.6 874.4 880.3 893.1 894.5 8971.7 9216.4 9490.9 9500.4 9695.0 345680.0 346813.0 351776.0 355888.0 358426.0 75249.5 75587.6 75665.0 80369.0 83480.2 1029.2 1041.9 1078.1 1078.6 1078.7 16044.4 16642.0 16776.3 16792.3 17305.0 37487.3 39175.4 39645.8 39706.4 39879.2 49924.0 50104.5 52110.2 52347.7 53196.5 7672.8 7861.2 7868.9 7991.6 8220.2 11416.9 11581.5 11757.1 11880.3 11983.8 9676.6 9708.2 9754.9 10220.1 10412.0 9423.9 9519.7 9558.6 9600.6 9661.0 9845.3 9864.6 9892.4 10065.6 10256.4 7490.4 7667.1 7684.8 7772.3 7809.6 9851.2 9856.8 9958.9 10196.8 10231.2 14:29:40 INFO - PID 26858 | 14:29:40 INFO - PID 26858 | [#3] mootools.html Cycles:180 Average:6447.02 Median:3724.37 stddev:4256.59 (114.3%) stddev-sans-first:4250.88 14:29:40 INFO - PID 26858 | Values: 1288.6 1308.7 1314.7 1318.7 1345.8 10168.4 10531.9 10677.6 10688.8 10883.8 10658.1 10950.2 10973.1 10982.2 11011.2 2244.4 2271.7 2273.7 2279.2 2289.6 2119.9 2160.6 2167.8 2174.9 2175.8 2096.3 2107.4 2129.2 2131.0 2135.2 2124.1 2125.2 2130.4 2135.5 2144.9 1984.8 2021.4 2053.9 2059.7 2222.9 10433.8 10557.7 10558.7 10568.0 10570.3 5421.5 5623.5 5642.2 5645.4 5647.4 3159.2 3296.0 3343.9 3350.1 3359.7 997.8 1002.5 1012.2 1017.9 1039.9 15753.0 15878.6 15901.2 15917.8 15969.7 4643.6 4722.4 4915.7 4936.0 4943.0 11186.6 11202.5 11210.3 11216.9 11228.3 5424.3 5496.1 5506.5 5514.2 5520.6 5044.3 5068.6 5097.8 5099.9 5108.8 3673.4 3729.4 3767.6 3785.0 3823.3 1050.2 1052.4 1064.7 1086.6 1089.6 701.4 733.9 734.1 737.6 751.5 5611.9 5646.9 5694.5 5722.8 5837.5 540.7 560.4 566.9 568.4 569.7 3719.3 4012.4 4026.5 4054.8 4199.6 13668.4 13753.5 13870.9 13882.6 13907.8 13303.5 13739.2 13804.3 13810.2 13816.4 7637.2 7733.3 7846.9 7869.2 7873.0 5991.5 5992.4 6059.3 6067.0 6259.6 12014.3 12185.7 12194.5 12369.9 12494.6 12314.7 12593.9 12618.2 12795.6 12813.8 8494.6 8640.1 8648.8 8693.0 8777.2 9521.9 9575.7 9596.5 9660.0 9665.0 8472.7 8555.0 8563.9 8856.3 8926.2 8273.2 8357.6 8374.3 8490.6 8553.4 7499.2 7606.8 7615.9 7626.8 7627.2 4780.3 4979.5 5005.0 5047.6 5287.5 5469.2 5487.7 5489.3 5609.8 5626.2 14:29:40 INFO - PID 26858 | 14:29:40 INFO - PID 26858 | [#4] prototype.html Cycles:180 Average:4813.65 Median:5435.56 stddev:1411.45 (26.0%) stddev-sans-first:1374.96 14:29:40 INFO - PID 26858 | Values: 343.5 353.3 363.3 365.1 366.1 5503.8 5579.0 5625.1 5659.9 5662.2 5349.8 5467.1 5480.6 5492.3 5495.9 4082.3 4103.6 4110.0 4120.3 4121.1 4006.3 4111.8 4114.3 4115.3 4132.9 4056.4 4070.4 4084.9 4091.7 4099.0 4038.1 4049.7 4060.4 4067.1 4075.1 3507.3 3520.7 3529.2 3537.0 3549.0 5263.8 5355.3 5358.5 5402.7 5404.0 4746.7 4769.4 4777.1 4782.5 4796.0 5643.4 5775.7 5789.7 5791.6 5826.8 4373.8 4392.6 4396.2 4401.1 4415.2 5910.9 6121.8 6133.9 6185.4 6224.9 4234.3 4249.9 4252.9 4254.9 4255.3 4307.0 4309.7 4313.4 4327.6 4352.8 4945.6 4949.4 4956.7 5085.7 5115.7 5907.6 5908.8 5926.3 5944.3 5946.0 1571.2 1590.3 1599.0 1600.3 1600.4 1106.0 1135.0 1138.5 1143.6 1147.9 4987.2 5028.9 5030.8 5034.8 5066.3 6023.4 6056.8 6070.4 6075.2 6121.2 4927.1 4986.5 4998.6 5010.4 5028.8 3166.4 3220.8 3224.9 3226.9 3231.7 5479.9 5554.6 5561.9 5596.5 5636.2 6171.2 6192.6 6228.4 6245.9 6259.2 5545.9 5547.9 5603.4 5609.8 5620.3 5876.1 5998.7 6037.6 6043.7 6064.2 5775.9 5935.3 5938.8 5941.0 5949.4 5558.6 5574.1 5616.2 5619.9 5633.8 4017.5 4032.1 4038.5 4045.4 4082.7 5983.8 6082.0 6104.5 6120.5 6142.9 5903.5 5915.4 5918.6 5920.8 5931.8 5762.8 5803.8 5835.4 5835.6 5845.2 5787.0 5793.7 5794.9 5808.2 5817.2 5789.8 5816.5 5830.4 5837.1 5852.7 5635.9 5643.4 5660.7 5721.4 5734.3 14:29:40 INFO - PID 26858 | 14:29:40 INFO - PID 26858 | [#5] yui.html Cycles:180 Average:18321.90 Median:3098.39 stddev:23913.85 (771.8%) stddev-sans-first:23944.49 14:29:40 INFO - PID 26858 | Values: 740.6 758.3 760.3 771.1 777.1 12910.6 13718.9 13763.7 15584.8 16026.8 16671.7 16899.7 16946.7 16981.8 17027.9 862.9 872.9 887.1 887.5 889.5 895.2 909.3 916.4 916.6 916.9 951.8 953.6 956.4 956.5 957.5 935.9 936.8 937.8 939.6 943.2 703.1 703.7 704.2 705.7 706.9 13813.2 14329.3 14396.1 14431.0 14476.9 15397.5 15895.4 16053.8 16081.0 16093.7 12417.8 12838.3 12850.1 12862.9 12873.8 3071.6 3088.0 3096.6 3100.1 3111.9 79436.2 80240.0 80838.2 80872.6 81401.0 12675.2 13113.2 13140.0 13253.5 13335.1 23268.8 23981.7 24196.6 24292.5 24331.9 5787.6 5829.3 5838.6 5863.5 6084.4 2868.7 2956.4 2980.5 2985.1 2997.5 3760.5 3861.9 3862.9 3871.1 3882.4 747.7 760.8 773.5 773.6 774.5 553.7 599.8 605.8 628.7 635.9 10189.8 10624.3 10792.8 11052.9 11276.8 586.1 586.7 591.4 595.5 612.8 4441.8 4733.9 4756.5 4772.8 4920.7 90274.0 91888.5 93062.5 94139.5 94172.5 75467.2 76705.0 77679.6 78163.6 81586.0 60772.4 61035.7 61627.0 61933.4 70429.0 10135.4 10569.6 10585.7 10785.0 10947.9 27423.2 27568.6 27735.7 28204.7 28762.4 51626.7 52906.7 53432.7 54153.0 54749.0 14602.6 15178.8 15667.8 15691.5 15771.4 17139.2 17415.7 18009.5 18044.5 18390.9 14534.3 15945.1 16013.2 16074.7 16185.1 15709.1 16154.4 16350.3 16464.8 16776.8 14896.5 15262.7 15945.5 16170.9 16440.3 9745.7 9889.3 10112.2 10286.5 10444.0 11615.2 12645.6 12658.2 12706.7 12718.5 14:29:40 INFO - PID 26858 | -------- Summary: end -------- 14:29:40 INFO - PID 26858 | 14:29:40 INFO - TEST-INFO | 26858: exit 0 14:29:40 INFO - TEST-OK | dromaeo_css | took 1147663ms 14:29:40 INFO - TEST-START | kraken 14:29:40 INFO - operating with platform_type : linux_ 14:29:40 INFO - Initialising browser for kraken test... 14:29:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44381/getInfo.html -profile /tmp/tmpo76jpd/profile 14:29:40 INFO - TEST-INFO | started process 27278 (/builds/slave/test/build/application/firefox/firefox http://localhost:44381/getInfo.html) 14:30:15 INFO - TEST-INFO | 27278: killed by SIGTERM 14:30:16 INFO - Browser initialized. 14:30:16 INFO - Running cycle 1/1 for kraken test... 14:30:16 INFO - TEST-INFO | started process 27501 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo76jpd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:30:28 INFO - PID 27501 | RSS: Main: 176246784 14:30:28 INFO - PID 27501 | 14:30:30 INFO - PID 27501 | Cycle 1(1): loaded http://localhost:44381/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44381/tests/kraken/driver.html?testName=audio-beat-detection) 14:30:31 INFO - PID 27501 | RSS: Main: 181653504 14:30:31 INFO - PID 27501 | 14:30:34 INFO - PID 27501 | Cycle 1(1): loaded http://localhost:44381/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44381/tests/kraken/driver.html?testName=audio-dft) 14:30:35 INFO - PID 27501 | RSS: Main: 181108736 14:30:35 INFO - PID 27501 | 14:30:38 INFO - PID 27501 | Cycle 1(1): loaded http://localhost:44381/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44381/tests/kraken/driver.html?testName=audio-fft) 14:30:38 INFO - PID 27501 | RSS: Main: 178573312 14:30:38 INFO - PID 27501 | 14:30:40 INFO - PID 27501 | Cycle 1(1): loaded http://localhost:44381/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44381/tests/kraken/driver.html?testName=audio-oscillator) 14:30:41 INFO - PID 27501 | RSS: Main: 178749440 14:30:41 INFO - PID 27501 | 14:30:43 INFO - PID 27501 | Cycle 1(1): loaded http://localhost:44381/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44381/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:30:44 INFO - PID 27501 | RSS: Main: 178909184 14:30:44 INFO - PID 27501 | 14:30:47 INFO - PID 27501 | Cycle 1(1): loaded http://localhost:44381/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44381/tests/kraken/driver.html?testName=imaging-darkroom) 14:30:48 INFO - PID 27501 | RSS: Main: 183451648 14:30:48 INFO - PID 27501 | 14:30:51 INFO - PID 27501 | Cycle 1(1): loaded http://localhost:44381/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44381/tests/kraken/driver.html?testName=imaging-desaturate) 14:30:52 INFO - PID 27501 | RSS: Main: 179662848 14:30:52 INFO - PID 27501 | 14:30:55 INFO - PID 27501 | Cycle 1(1): loaded http://localhost:44381/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44381/tests/kraken/driver.html?testName=json-parse-financial) 14:30:55 INFO - PID 27501 | RSS: Main: 180015104 14:30:55 INFO - PID 27501 | 14:30:57 INFO - PID 27501 | Cycle 1(1): loaded http://localhost:44381/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44381/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:30:58 INFO - PID 27501 | RSS: Main: 180453376 14:30:58 INFO - PID 27501 | 14:30:59 INFO - PID 27501 | Cycle 1(1): loaded http://localhost:44381/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44381/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:31:00 INFO - PID 27501 | RSS: Main: 180375552 14:31:00 INFO - PID 27501 | 14:31:02 INFO - PID 27501 | Cycle 1(1): loaded http://localhost:44381/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44381/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:31:03 INFO - PID 27501 | RSS: Main: 180015104 14:31:03 INFO - PID 27501 | 14:31:06 INFO - PID 27501 | Cycle 1(1): loaded http://localhost:44381/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:31:07 INFO - PID 27501 | RSS: Main: 179978240 14:31:07 INFO - PID 27501 | 14:31:10 INFO - PID 27501 | Cycle 1(1): loaded http://localhost:44381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:31:10 INFO - PID 27501 | RSS: Main: 179789824 14:31:10 INFO - PID 27501 | 14:31:12 INFO - PID 27501 | Cycle 1(1): loaded http://localhost:44381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44381/tests/kraken/driver.html?testName=ai-astar) 14:31:12 INFO - PID 27501 | RSS: Main: 181354496 14:31:12 INFO - PID 27501 | 14:31:12 INFO - PID 27501 | __start_tp_report 14:31:12 INFO - PID 27501 | _x_x_mozilla_page_load 14:31:12 INFO - PID 27501 | _x_x_mozilla_page_load_details 14:31:12 INFO - PID 27501 | |i|pagename|runs| 14:31:12 INFO - PID 27501 | |0;ai-astar;103;113;114;113;112;114;112;111;110;111 14:31:12 INFO - PID 27501 | |1;audio-beat-detection;153;126;131;175;126;131;131;126;151;128 14:31:12 INFO - PID 27501 | |2;audio-dft;165;165;164;166;168;169;168;163;165;163 14:31:12 INFO - PID 27501 | |3;audio-fft;74;74;74;108;74;74;76;76;95;74 14:31:12 INFO - PID 27501 | |4;audio-oscillator;84;84;106;83;84;85;96;83;82;114 14:31:12 INFO - PID 27501 | |5;imaging-gaussian-blur;113;115;115;113;114;114;115;114;114;118 14:31:12 INFO - PID 27501 | |6;imaging-darkroom;152;149;151;150;150;150;150;150;150;149 14:31:12 INFO - PID 27501 | |7;imaging-desaturate;95;95;96;94;95;94;95;94;95;94 14:31:12 INFO - PID 27501 | |8;json-parse-financial;55;54;53;56;57;56;55;63;59;59 14:31:12 INFO - PID 27501 | |9;json-stringify-tinderbox;58;59;58;59;58;57;57;57;58;57 14:31:12 INFO - PID 27501 | |10;stanford-crypto-aes;87;88;88;85;86;86;89;89;118;85 14:31:12 INFO - PID 27501 | |11;stanford-crypto-ccm;137;146;139;147;136;142;132;136;137;136 14:31:12 INFO - PID 27501 | |12;stanford-crypto-pbkdf2;189;196;195;188;188;201;195;187;206;199 14:31:12 INFO - PID 27501 | |13;stanford-crypto-sha256-iterative;73;74;74;76;72;78;80;72;70;74 14:31:12 INFO - PID 27501 | __end_tp_report 14:31:12 INFO - PID 27501 | __start_cc_report 14:31:12 INFO - PID 27501 | _x_x_mozilla_cycle_collect,925 14:31:12 INFO - PID 27501 | __end_cc_report 14:31:12 INFO - PID 27501 | __startTimestamp1495661472922__endTimestamp 14:31:12 INFO - PID 27501 | 14:31:12 INFO - PID 27501 | ------- Summary: start ------- 14:31:12 INFO - PID 27501 | Number of tests: 14 14:31:12 INFO - PID 27501 | 14:31:12 INFO - PID 27501 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.50 stddev:3.20 (2.8%) stddev-sans-first:1.39 14:31:12 INFO - PID 27501 | Values: 103.0 113.0 114.0 113.0 112.0 114.0 112.0 111.0 110.0 111.0 14:31:12 INFO - PID 27501 | 14:31:12 INFO - PID 27501 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:131.00 stddev:16.47 (12.6%) stddev-sans-first:16.53 14:31:12 INFO - PID 27501 | Values: 153.0 126.0 131.0 175.0 126.0 131.0 131.0 126.0 151.0 128.0 14:31:12 INFO - PID 27501 | 14:31:12 INFO - PID 27501 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.50 stddev:2.12 (1.3%) stddev-sans-first:2.24 14:31:12 INFO - PID 27501 | Values: 165.0 165.0 164.0 166.0 168.0 169.0 168.0 163.0 165.0 163.0 14:31:12 INFO - PID 27501 | 14:31:12 INFO - PID 27501 | [#3] audio-fft Cycles:10 Average:79.90 Median:74.00 stddev:11.82 (16.0%) stddev-sans-first:12.34 14:31:12 INFO - PID 27501 | Values: 74.0 74.0 74.0 108.0 74.0 74.0 76.0 76.0 95.0 74.0 14:31:12 INFO - PID 27501 | 14:31:12 INFO - PID 27501 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:84.00 stddev:11.37 (13.5%) stddev-sans-first:11.84 14:31:12 INFO - PID 27501 | Values: 84.0 84.0 106.0 83.0 84.0 85.0 96.0 83.0 82.0 114.0 14:31:12 INFO - PID 27501 | 14:31:12 INFO - PID 27501 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.50 stddev:1.43 (1.3%) stddev-sans-first:1.41 14:31:12 INFO - PID 27501 | Values: 113.0 115.0 115.0 113.0 114.0 114.0 115.0 114.0 114.0 118.0 14:31:12 INFO - PID 27501 | 14:31:12 INFO - PID 27501 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:0.88 (0.6%) stddev-sans-first:0.60 14:31:12 INFO - PID 27501 | Values: 152.0 149.0 151.0 150.0 150.0 150.0 150.0 150.0 150.0 149.0 14:31:12 INFO - PID 27501 | 14:31:12 INFO - PID 27501 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 14:31:12 INFO - PID 27501 | Values: 95.0 95.0 96.0 94.0 95.0 94.0 95.0 94.0 95.0 94.0 14:31:12 INFO - PID 27501 | 14:31:12 INFO - PID 27501 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.50 stddev:2.95 (5.2%) stddev-sans-first:3.06 14:31:12 INFO - PID 27501 | Values: 55.0 54.0 53.0 56.0 57.0 56.0 55.0 63.0 59.0 59.0 14:31:12 INFO - PID 27501 | 14:31:12 INFO - PID 27501 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.79 (1.4%) stddev-sans-first:0.83 14:31:12 INFO - PID 27501 | Values: 58.0 59.0 58.0 59.0 58.0 57.0 57.0 57.0 58.0 57.0 14:31:12 INFO - PID 27501 | 14:31:12 INFO - PID 27501 | [#10] stanford-crypto-aes Cycles:10 Average:90.10 Median:87.50 stddev:9.92 (11.3%) stddev-sans-first:10.45 14:31:12 INFO - PID 27501 | Values: 87.0 88.0 88.0 85.0 86.0 86.0 89.0 89.0 118.0 85.0 14:31:12 INFO - PID 27501 | 14:31:12 INFO - PID 27501 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:138.00 stddev:4.78 (3.5%) stddev-sans-first:5.02 14:31:12 INFO - PID 27501 | Values: 137.0 146.0 139.0 147.0 136.0 142.0 132.0 136.0 137.0 136.0 14:31:12 INFO - PID 27501 | 14:31:12 INFO - PID 27501 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.40 Median:195.50 stddev:6.40 (3.3%) stddev-sans-first:6.48 14:31:12 INFO - PID 27501 | Values: 189.0 196.0 195.0 188.0 188.0 201.0 195.0 187.0 206.0 199.0 14:31:12 INFO - PID 27501 | 14:31:12 INFO - PID 27501 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:74.00 stddev:2.98 (4.0%) stddev-sans-first:3.13 14:31:12 INFO - PID 27501 | Values: 73.0 74.0 74.0 76.0 72.0 78.0 80.0 72.0 70.0 74.0 14:31:12 INFO - PID 27501 | -------- Summary: end -------- 14:31:12 INFO - PID 27501 | 14:31:13 INFO - TEST-INFO | 27501: exit 0 14:31:14 INFO - TEST-OK | kraken | took 93087ms 14:31:14 INFO - SUITE-END | took 1240s 14:31:14 INFO - Completed test suite (00:20:40) 14:31:14 INFO - javascript benchmark 14:31:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6822.515694748816, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2716.0358072884114, 2721.1972468121908, 2747.2857057165143, 2754.779617630589, 2759.6688397392318, 5313.654612450188, 5333.0, 5348.866278343038, 5377.65045272058, 5414.242006119146, 5274.235235890803, 5324.1215199492035, 5353.625246232756, 5373.220882971977, 5402.243685883979, 4762.952370476286, 4790.904181916359, 4810.350602668647, 4833.202521583935, 4866.46468888422, 4760.90478190436, 4815.157347464197, 4826.420829500447, 4843.782029808667, 4874.951250487486, 4662.836800711959, 4725.834595789165, 4786.688865223749, 4797.352357431737, 4849.515048495157, 4651.88370290742, 4664.953350466486, 4703.482616912137, 4727.290906364073, 4741.57325840676, 4692.178868697998, 4692.6245900327895, 4699.976500117477, 4724.055188962221, 4756.809727610891, 5272.472752724697, 5283.313169288006, 5294.894102117974, 5305.575553955674, 5329.120695085307, 5689.374168841424, 5704.600677952545, 5750.511206547449, 5776.826695199151, 5797.942020579782, 5867.178594996704, 5885.705714714247, 5901.616394934315, 5908.231929849135, 5912.615679980788, 5412.296401467824, 5415.864603384868, 5421.241026256327, 5423.29497165366, 5428.701421421781, 5923.526117910556, 5930.970345148333, 5958.970205149033, 5965.105234214902, 5967.880642387128, 5624.353199382042, 5646.435356464321, 5739.713014349266, 5743.023685973395, 5751.338596061507, 5772.3938986406665, 5800.100984347433, 5811.622244554091, 5818.127280907897, 5818.854528636818, 5632.802851900164, 5771.884562308815, 5775.104858746901, 5775.855603609859, 5775.88448231033, 5647.971760141173, 5702.771889124471, 5713.628614140068, 5772.538196944234, 5807.216025836458, 4842.685225460334, 4843.854684359475, 4852.975735121302, 4884.340614017134, 4903.01939612079, 4149.958500415018, 4153.314703074019, 4153.709240353207, 4184.14225083857, 4239.130978149472, 4811.374521312207, 4872.6589138760655, 4881.8535443936735, 4905.484924082992, 4917.311576379309, 5697.088465845528, 5808.041673123887, 5817.127430885316, 5834.474897259182, 5890.204822349014, 4860.052289803525, 4864.075825593126, 4869.70781753096, 4881.121398148367, 4938.23457364102, 5023.09584274834, 5138.409082955508, 5139.640225184276, 5147.330846989942, 5153.51041651035, 5296.390915044819, 5346.0644387231305, 5427.13165893471, 5427.538659213853, 5432.375276843056, 5701.401352858056, 5791.652500849794, 5795.565332599987, 5820.854478638068, 5852.853678658068, 5292.9206061908335, 5381.811636592701, 5407.324084489439, 5433.755481003285, 5434.972825135849, 5671.206031155559, 5772.9711351442975, 5786.247787787729, 5792.391798861059, 5807.970960145172, 5759.395263497272, 5879.235699359056, 5880.176775251553, 5893.764249429974, 5925.970370148121, 5607.299087614048, 5693.914591281217, 5718.8848174605555, 5724.484796368347, 5735.856603584777, 5597.80407685729, 5600.719964001865, 5602.523785478117, 5607.607467477401, 5633.915491267716, 5499.450054994629, 5522.282103326542, 5523.226748255328, 5525.502704756591, 5527.723613819373, 5571.247881535941, 5643.604947653789, 5679.034564124191, 5713.257276554022, 5714.857128571819, 5551.028570000153, 5604.159376093456, 5605.383407825055, 5629.634073785191, 5640.605157638925], "value": 5242.41174248316, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.9119523266744, 691.6196092149319, 706.2161001288571, 1192.1118766518944, 1206.294317824074, 33981.830090849544, 34657.30685386294, 34704.479432808526, 34707.0, 34834.129146771345, 32250.838745806297, 32515.837420812863, 32559.348813023724, 32566.185845353877, 32592.511112333275, 6458.741650333981, 6696.564723292995, 6818.659067046628, 6819.727210911557, 6821.863562728742, 6703.061571380011, 6730.528862979593, 6773.661316934158, 6803.693833777467, 6821.283765204656, 6773.830654233634, 6783.796486105425, 6824.078749368821, 6849.349311815369, 6854.383105520502, 6725.697343619524, 6751.527393082486, 6777.085093512362, 6777.999999999975, 6789.626570538619, 6750.62871542065, 6814.1482314710665, 6816.863662726767, 6838.111045564045, 6844.041834143224, 31646.367072658417, 31706.682933170836, 31775.0, 31860.203494912814, 32056.0, 3071.0, 3103.0, 3113.3306339137193, 3117.516784898344, 3122.594062771848, 24375.512489750105, 24402.877985610136, 24509.63235551468, 24541.877290613433, 24551.508969820683, 2744.7118052604587, 2763.3367991681853, 2772.5979732938613, 2774.7641450476735, 2793.2737488252997, 139984.30007849896, 140218.2989085048, 140818.0, 151199.0, 154013.0, 37506.43740343897, 37512.43731344032, 37691.81154094212, 37758.81120594379, 37942.051448714, 39526.60473395229, 39564.2087158261, 39626.60373396287, 39656.405153922715, 43080.78459607682, 12939.353032348345, 12977.221366718028, 12999.0, 13022.413991370222, 13032.739345213042, 10446.529906154241, 10461.110805581611, 10477.423741694127, 10488.0, 10558.31370960885, 12628.179168354027, 12674.176178548365, 12678.429470673842, 12759.872401276054, 12800.359982000862, 5332.5467335276935, 5392.272043274186, 5394.649347792381, 5404.243405923174, 5496.230527726121, 861.0, 910.6175406329226, 915.0712027292303, 922.9169374756304, 939.0937745075898, 20133.295334663217, 20932.37202883916, 21004.0, 21242.893785530974, 21355.46611334729, 980.2648013989508, 983.439439519467, 984.960601575929, 990.5344488090586, 1009.0978505517153, 10739.301945373525, 10773.569057237622, 11067.0, 11148.0, 11217.887821121847, 167758.0, 168708.15645921693, 168709.0, 168750.0, 168871.0, 38712.80643596764, 39532.20935581272, 39606.0, 39781.40327895084, 39875.40186897199, 1190.119311709329, 1245.3897590180745, 1248.8751124887438, 1249.8625151233357, 1262.2426544073483, 18943.71584426207, 19481.415557533295, 20295.188192472728, 20373.59252814965, 20431.0, 28733.712662873102, 35940.28119437649, 36402.635973639924, 36524.26951461009, 36576.26847463089, 160754.0, 161448.0, 163018.0, 163289.0, 163636.18181909015, 28740.42519149647, 29078.27304317409, 29112.27219319534, 29496.705032949394, 29571.964981225552, 34560.135996600286, 35800.82099589486, 36250.63749362472, 36572.45141322829, 36939.26121477502, 26604.0, 27014.864925675247, 27348.589771153846, 27544.586831197146, 28194.71805282003, 26608.20175394741, 26919.0, 27423.0, 27762.167134985175, 28685.856570717013, 30347.393052139276, 30390.0, 30801.691983079883, 30803.383932321678, 32232.677673223905, 26127.477450450504, 26989.325266868484, 27257.591136132578, 27491.450170996068, 27593.86203069052, 18337.449876503193, 20756.169753209702, 20804.0, 20863.374098776454, 20897.58204835925], "value": 14406.704016605196, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.5630718823669, 417.6157934700076, 420.58362221400813, 429.7622846202937, 430.96767742419314, 14237.71524569508, 14790.482333118343, 17365.305387784472, 18029.008404537744, 18058.46503047241, 18367.54081147972, 18709.532261693465, 18737.625247495074, 18853.905730471328, 19087.713684294748, 5277.182036784305, 5388.649737767042, 5503.147012213093, 5550.389457159709, 5558.527525160346, 5276.683398996072, 5417.83746487606, 5425.701586412746, 5439.238506609078, 5443.292371991635, 4828.830990915319, 5322.787088516455, 5353.197020446944, 5363.168708850135, 5374.7850085996515, 5309.30978972733, 5324.7071411072375, 5347.331583552075, 5348.91976620351, 5365.731713414314, 4706.670533062687, 4837.782299796518, 4850.5877000455, 4877.487863774323, 4879.658423910328, 22348.88825555878, 22399.44001399978, 22554.88722556377, 22658.66012009821, 22712.091516339326, 1594.7288960876679, 1610.822809490955, 1650.6863695897741, 1653.3386645341839, 1657.3619156624666, 14567.198804065772, 14685.77971330431, 15100.54698359051, 15121.092734435859, 15266.694666106616, 2057.146284292017, 2098.6956891250684, 2142.0, 2142.6893100500342, 2147.860389074705, 86822.56588717079, 87148.0, 89212.0, 91566.0, 93479.53260233655, 10745.355278683304, 10984.890151098387, 11031.889681103086, 11035.917238084838, 11242.437878106062, 15491.612709682347, 15548.533543993699, 15610.76583851243, 15612.141332226609, 15612.76580851288, 7287.089113860768, 7462.776116716507, 7481.5511069334925, 7556.0, 7581.090269167735, 6688.431483323972, 6689.0, 6833.555818871758, 6876.277990810993, 6930.653467326613, 6799.3200679931615, 6954.965225173842, 6969.0, 7049.224585295613, 7093.290670932865, 2057.331367305632, 2064.876107433559, 2074.844386671006, 2121.1833444123813, 2185.1368709359713, 831.5218749219223, 858.9613467393982, 865.9090795466385, 877.4384393987725, 904.0, 16524.834751652328, 16733.581660458585, 17105.572360691083, 17550.736738948926, 17682.734758978626, 850.6469815026694, 874.3660845886682, 880.264978742757, 893.066745251214, 894.4901406198404, 8971.730848074569, 9216.447013179231, 9490.90509094914, 9500.42997420157, 9694.951525242328, 345680.0, 346813.0, 351776.0, 355888.0, 358426.0, 75249.49501009949, 75587.62206188934, 75665.0, 80369.0, 83480.16519834845, 1029.1715169288645, 1041.8853926068127, 1078.0513148429488, 1078.6440474643505, 1078.719532921446, 16044.358225670843, 16642.0, 16776.32894684199, 16792.32830686759, 17305.04822234789, 37487.25025499529, 39175.41236881506, 39645.80177099096, 39706.40440393339, 39879.202415952095, 49924.0, 50104.498955009985, 52110.21834672559, 52347.738261309976, 53196.46803531915, 7672.80817979555, 7861.174576669596, 7868.921310786819, 7991.560464174294, 8220.17798220197, 11416.885831141582, 11581.478833452684, 11757.118216133653, 11880.287182769061, 11983.801619837946, 9676.612935482503, 9708.223342132753, 9754.853677194706, 10220.080192782685, 10412.0, 9423.858642120511, 9519.666811661558, 9558.56986435598, 9600.567974441026, 9661.0, 9845.310828241954, 9864.5560949756, 9892.406455612398, 10065.647702330383, 10256.43589602579, 7490.4007679386605, 7667.11828139771, 7684.8463030740195, 7772.339351155215, 7809.570473623778, 9851.211903047883, 9856.753581160528, 9958.900410995797, 10196.796064078826, 10231.181505479693], "value": 8662.393385526715, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1288.5940928607488, 1308.6989992301776, 1314.664760486076, 1318.6769241535826, 1345.7644912140377, 10168.44073575953, 10531.947340263288, 10677.572897084106, 10688.839667404985, 10883.83674244885, 10658.147348212144, 10950.233483656128, 10973.067289280421, 10982.176336774733, 11011.229213955006, 2244.4052326133587, 2271.681964524968, 2273.6816845641624, 2279.225063478417, 2289.5878741826464, 2119.862208956413, 2160.5894879972834, 2167.7615462299136, 2174.8803815790125, 2175.8150557202657, 2096.329174664108, 2107.4309936317186, 2129.190907455165, 2131.041031535807, 2135.1566131378095, 2124.129107066111, 2125.2242931330106, 2130.382189165148, 2135.4981579328846, 2144.946376340604, 1984.8015198480182, 2021.3935819254166, 2053.938381848547, 2059.7116403703494, 2222.9333120006427, 10433.79132417355, 10557.683269501927, 10558.683239502827, 10568.0, 10570.260081794277, 5421.539169170625, 5623.522000629951, 5642.238297829782, 5645.407232240596, 5647.43525647436, 3159.162821852211, 3296.0, 3343.866245350183, 3350.095474221971, 3359.6976272135626, 997.8353571660667, 1002.4636819301711, 1012.205418746288, 1017.9338343007681, 1039.9220058495644, 15753.0, 15878.603034924105, 15901.204939752966, 15917.840821591868, 15969.680606387923, 4643.582077612963, 4722.433308003062, 4915.68048076881, 4935.950640493549, 4943.0, 11186.608468703718, 11202.495887685074, 11210.327380357041, 11216.887831121747, 11228.270162439416, 5424.349078110573, 5496.065668836228, 5506.504414602625, 5514.228008078872, 5520.613557051048, 5044.2937988681615, 5068.56917162038, 5097.770600322994, 5099.87250318745, 5108.821191258288, 3673.430618254175, 3729.384651532521, 3767.6232376762105, 3784.962150378461, 3823.2735780201674, 1050.1598721023151, 1052.3790963331671, 1064.7444613292755, 1086.6088208245026, 1089.6186334782922, 701.4423533291045, 733.9486235963432, 734.0750654175777, 737.6164394514823, 751.4514404484756, 5611.9438805612235, 5646.943530564642, 5694.5159661428415, 5722.799702010493, 5837.474627283565, 540.7458494507654, 560.3723829311198, 566.8724536979229, 568.4145330309788, 569.6781318555086, 3719.34911390511, 4012.378081397388, 4026.456428382131, 4054.8378064877666, 4199.559046300094, 13668.384922678504, 13753.518626848012, 13870.861291387158, 13882.583522494342, 13907.79138312926, 13303.534376296782, 13739.24434156131, 13804.309784510935, 13810.240436776074, 13816.447342106405, 7637.2362763724295, 7733.265339792711, 7846.882296765553, 7869.213078692085, 7873.0, 5991.490723288569, 5992.370801065826, 6059.33347331802, 6067.0, 6259.624422534663, 12014.339211343111, 12185.69535761613, 12194.51221951112, 12369.93815030919, 12494.625161245178, 12314.692132696397, 12593.874061259638, 12618.17981831178, 12795.61613151607, 12813.8077928833, 8494.575271236537, 8640.092790256933, 8648.78378040554, 8692.956535217283, 8777.210051095431, 9521.904780952102, 9575.712728618153, 9596.520173991412, 9660.0, 9665.0, 8472.661093556435, 8554.957225213833, 8563.914360856312, 8856.335774817044, 8926.241269492166, 8273.172682731678, 8357.582120894052, 8374.330053595575, 8490.575471226537, 8553.401261911606, 7499.1750907399055, 7606.809829754079, 7615.885761713689, 7626.771196863881, 7627.161012288755, 4780.330753694416, 4979.502049794992, 5004.974975125101, 5047.596192304533, 5287.52412282881, 5469.179623056414, 5487.670739755627, 5489.34127904654, 5609.775608975595, 5626.240457538343], "value": 4745.282385188551, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.4916323840716, 353.2775474155352, 363.271640361076, 365.1000284299202, 366.1249613423917, 5503.834884953458, 5579.038882393505, 5625.099984002565, 5659.858503537408, 5662.235598194247, 5349.8127565535215, 5467.1411720015185, 5480.561555075595, 5492.313460817398, 5495.917561236584, 4082.3468245080644, 4103.630673239408, 4110.0, 4120.25835349637, 4121.072758629314, 4006.3389540725743, 4111.835526578933, 4114.341705327149, 4115.32097203961, 4132.8966775830695, 4056.3509838425857, 4070.3690927906073, 4084.89787755307, 4091.672666186713, 4098.97950510247, 4038.071243613985, 4049.7367671101283, 4060.4112403701592, 4067.0849058961644, 4075.1442197138635, 3507.333606614735, 3520.7359448041243, 3529.1530032792202, 3536.974277459534, 3548.982255088734, 5263.763130659129, 5355.250264962909, 5358.517733403974, 5402.729863506848, 5403.972980135113, 4746.691465054761, 4769.427668679746, 4777.116233496814, 4782.545658162469, 4796.0, 5643.391633384465, 5775.740091695884, 5789.710514474259, 5791.623544469596, 5826.796062137847, 4373.834951698929, 4392.604665580113, 4396.20868243716, 4401.097774956126, 4415.183191109655, 5910.940890591082, 6121.775644870999, 6133.907991380132, 6185.381461853779, 6224.937750622481, 4234.343676730112, 4249.915001699948, 4252.894247495611, 4254.893727630838, 4255.319148936155, 4306.956930430718, 4309.741415515016, 4313.352997050405, 4327.588879056485, 4352.760598167131, 4945.579625731853, 4949.406071271471, 4956.677815941952, 5085.7202853842655, 5115.693058416507, 5907.645541267538, 5908.763649454059, 5926.318473375531, 5944.256967879015, 5946.0, 1571.1515781478101, 1590.3479573374862, 1598.9840101599068, 1600.2718762962825, 1600.3998500562288, 1105.950232239551, 1134.9886501135047, 1138.4706111658118, 1143.6226045404997, 1147.925384849982, 4987.152184128707, 5028.949710502921, 5030.8239211627415, 5034.773435195425, 5066.290719299227, 6023.397660233942, 6056.788642271564, 6070.423309785563, 6075.2405949256345, 6121.234845644294, 4927.063857866994, 4986.526280003394, 4998.5751211146735, 5010.423801262901, 5028.79884804611, 3166.4300425923093, 3220.806751594912, 3224.935501289961, 3226.8709251630144, 3231.7253033492416, 5479.917801232985, 5554.611177217636, 5561.916571251434, 5596.468335508202, 5636.2391077204875, 6171.228596425447, 6192.628442293477, 6228.4463370018075, 6245.937540624626, 6259.186305780219, 5545.916811247835, 5547.889042219133, 5603.411641777636, 5609.775608975677, 5620.325560932714, 5876.118582212703, 5998.700064996646, 6037.63774173551, 6043.697815109315, 6064.241969753781, 5775.855603609775, 5935.317438494629, 5938.762449501972, 5941.0, 5949.434803693643, 5558.610897237155, 5574.136008918624, 5616.157576363578, 5619.915701264403, 5633.774649013993, 4017.4777278953547, 4032.1129351542613, 4038.454808600919, 4045.3931910213705, 4082.652974497201, 5983.826418179851, 6082.0, 6104.4505994460715, 6120.540959427972, 6142.938570614237, 5903.4686878179455, 5915.37888521699, 5918.585699001029, 5920.763169473173, 5931.792387266425, 5762.827115186551, 5803.83923215367, 5835.358110607915, 5835.649861008353, 5845.152452894392, 5786.971065144648, 5793.652380857162, 5794.855128621818, 5808.186853840551, 5817.214676018683, 5789.79735709265, 5816.534677225896, 5830.387809279964, 5837.102941543931, 5852.7416605430035, 5635.943640563706, 5643.3792282848035, 5660.688662123623, 5721.370649228498, 5734.254546908875], "value": 4384.866747578031, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.5926740292845, 758.3099379564594, 760.2967255288858, 771.0901136658744, 777.1218523068933, 12910.612681619556, 13718.931405342984, 13763.724725505497, 15584.766228506582, 16026.83973160271, 16671.749923751122, 16899.662006759856, 16946.661066778655, 16981.83018169818, 17027.91486042568, 862.8533149364623, 872.9170728780756, 887.0552861202831, 887.4586502233632, 889.4752096263203, 895.1809094678395, 909.2771246858763, 916.3539704508339, 916.6196028648103, 916.8578870275085, 951.8001219743862, 953.5851904421564, 956.3735753081708, 956.4500412262942, 957.5260246178152, 935.9110884465965, 936.8173206224789, 937.7655586103474, 939.5912777941583, 943.1935694980762, 703.1105651351045, 703.7466512055656, 704.17259719829, 705.7353492440335, 706.8727629026773, 13813.171209727449, 14329.283535823271, 14396.136231826124, 14431.0, 14476.927615361856, 15397.538073857802, 15895.443659471863, 16053.759193611988, 16081.035137891764, 16093.678126437406, 12417.813732794015, 12838.293893835835, 12850.100492965496, 12862.871371286261, 12873.806892896613, 3071.6006919100373, 3088.042706760889, 3096.6438859531218, 3100.1319630503494, 3111.9066428006968, 79436.20563794347, 80240.0, 80838.19161808366, 80872.59563702202, 81401.0, 12675.17611355259, 13113.213207207598, 13140.0, 13253.536126235536, 13335.066545341733, 23268.767312327, 23981.681007544405, 24196.637050444257, 24292.51414971726, 24331.87834060854, 5787.623804452697, 5829.300483941955, 5838.649681019152, 5863.501602363762, 6084.361142080106, 2868.727470890262, 2956.4234974179826, 2980.463516567039, 2985.0597061925423, 2997.505411607104, 3760.4547340636, 3861.903452413656, 3862.8990737639638, 3871.109644781716, 3882.4176373544196, 747.6784982457486, 760.8021914302321, 773.5474747272796, 773.6325245508451, 774.5004472115454, 553.7374785489092, 599.8140576421237, 605.7879742090321, 628.6636649392553, 635.8982562790023, 10189.847152292721, 10624.256302058782, 10792.78414431707, 11052.944735276273, 11276.830847537294, 586.0564491169214, 586.7330364684059, 591.4499515450586, 595.4908553187049, 612.7640858269509, 4441.822327106945, 4733.857984260478, 4756.548127927841, 4772.761361931959, 4920.6801557898625, 90274.0, 91888.54055729679, 93062.53468732613, 94139.52930235442, 94172.52913735388, 75467.24532754603, 76705.0, 77679.61160194276, 78163.60918195373, 81586.0, 60772.39227607667, 61035.694821525605, 61627.0, 61933.38066619366, 70429.0, 10135.39187648714, 10569.63006294776, 10585.735356616146, 10784.975427334391, 10947.945260273647, 27423.177304680892, 27568.58647120335, 27735.722642773315, 28204.71795282021, 28762.424751504434, 51626.74186629043, 52906.735466322425, 53432.73283633557, 54153.0, 54749.0, 14602.634934126732, 15178.772318415453, 15667.843321567094, 15691.529254122395, 15771.44799931997, 17139.228734707216, 17415.651686966445, 18009.459716208534, 18044.458666240032, 18390.908045459688, 14534.273286335852, 15945.123018234108, 16013.199340033185, 16074.678506429573, 16185.10981896007, 15709.135997520247, 16154.434594789125, 16350.34598616042, 16464.83535164633, 16776.832231678014, 14896.478623248135, 15262.694746104793, 15945.521634350987, 16170.919145404197, 16440.342386304415, 9745.707628771148, 9889.258305626963, 10112.191024718151, 10286.537105830404, 10444.0, 11615.245009074382, 12645.557405490763, 12658.177218481138, 12706.682332941751, 12718.491260349852], "value": 7407.723504969876, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 114.0, 113.0, 112.0, 114.0, 112.0, 111.0, 110.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 131.0, 175.0, 126.0, 131.0, 131.0, 126.0, 151.0, 128.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 164.0, 166.0, 168.0, 169.0, 168.0, 163.0, 165.0, 163.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 108.0, 74.0, 74.0, 76.0, 76.0, 95.0, 74.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 106.0, 83.0, 84.0, 85.0, 96.0, 83.0, 82.0, 114.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 115.0, 113.0, 114.0, 114.0, 115.0, 114.0, 114.0, 118.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 149.0, 151.0, 150.0, 150.0, 150.0, 150.0, 150.0, 150.0, 149.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 56.0, 57.0, 56.0, 55.0, 63.0, 59.0, 59.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 59.0, 58.0, 57.0, 57.0, 57.0, 58.0, 57.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 88.0, 85.0, 86.0, 86.0, 89.0, 89.0, 118.0, 85.0], "value": 90.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 146.0, 139.0, 147.0, 136.0, 142.0, 132.0, 136.0, 137.0, 136.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 196.0, 195.0, 188.0, 188.0, 201.0, 195.0, 187.0, 206.0, 199.0], "value": 194.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 76.0, 72.0, 78.0, 80.0, 72.0, 70.0, 74.0], "value": 74.3, "unit": "score"}]}]} 14:31:14 INFO - Return code: 0 14:31:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:31:14 INFO - # TBPL SUCCESS # 14:31:14 INFO - Running post-action listener: _resource_record_post_action 14:31:14 INFO - [mozharness: 2017-05-24 21:31:14.227011Z] Finished run-tests step (success) 14:31:14 INFO - Running post-run listener: _resource_record_post_run 14:31:14 INFO - Total resource usage - Wall time: 1257s; CPU: 13.0%; Read bytes: 8192; Write bytes: 408895488; Read time: 180; Write time: 353288 14:31:14 INFO - TinderboxPrint: CPU usage
12.8% 14:31:14 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 180 14:31:14 INFO - TinderboxPrint: I/O write bytes / time
408,895,488 / 353,288 14:31:14 INFO - TinderboxPrint: CPU idle
8,745.9 (87.1%) 14:31:14 INFO - TinderboxPrint: CPU user
1,231.3 (12.3%) 14:31:14 INFO - TinderboxPrint: Swap in / out
0 / 0 14:31:14 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99979264; Read time: 0; Write time: 136600 14:31:14 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 4096; Write bytes: 308916224; Read time: 164; Write time: 216688 14:31:14 INFO - Running post-run listener: _upload_blobber_files 14:31:14 INFO - Blob upload gear active. 14:31:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:31:14 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 14:31:14 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'] 14:31:14 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 14:31:15 INFO - (blobuploader) - INFO - Open directory for files ... 14:31:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:31:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:31:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:16 INFO - (blobuploader) - INFO - Done attempting. 14:31:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:31:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:31:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:17 INFO - (blobuploader) - INFO - Done attempting. 14:31:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:31:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:31:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:23 INFO - (blobuploader) - INFO - Done attempting. 14:31:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:31:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:31:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:24 INFO - (blobuploader) - INFO - Done attempting. 14:31:24 INFO - (blobuploader) - INFO - Iteration through files over. 14:31:24 INFO - Return code: 0 14:31:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:31:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:31:24 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f60db5504e840f0be062ea37f17e260614a80eb5424797ce3b68565d8240a370e633f1c605067245ba2e5e9a576bda8518f7426389707320a1ddc996d2c24d38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75e249a24c6da0e76492d32a2bd99cc6f3226cf2845a898573ffce7c25c341a5b36e5cb808e1d48be1bacb4c909029173d37ea8917221342f75c703da07a4c8d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05cb9779b004a259ae95cb0c07e3ad3ecfb552a47e0fa0b5a30923ff6fe62e7a96158f45812186174d6600c2b43069ed8ecd002574651d02aa99d97d83fd1155", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da8119cbe69cd630e1e15e5c89dbb0732916bca27687f1a56db64ded2bf6565a44c4d2e55518a2eabf2a0f0c47d61eb19e53402f11b8453624ff0ad437def69c"} 14:31:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:31:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:31:24 INFO - Contents: 14:31:24 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f60db5504e840f0be062ea37f17e260614a80eb5424797ce3b68565d8240a370e633f1c605067245ba2e5e9a576bda8518f7426389707320a1ddc996d2c24d38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75e249a24c6da0e76492d32a2bd99cc6f3226cf2845a898573ffce7c25c341a5b36e5cb808e1d48be1bacb4c909029173d37ea8917221342f75c703da07a4c8d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05cb9779b004a259ae95cb0c07e3ad3ecfb552a47e0fa0b5a30923ff6fe62e7a96158f45812186174d6600c2b43069ed8ecd002574651d02aa99d97d83fd1155", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da8119cbe69cd630e1e15e5c89dbb0732916bca27687f1a56db64ded2bf6565a44c4d2e55518a2eabf2a0f0c47d61eb19e53402f11b8453624ff0ad437def69c"} 14:31:24 INFO - Running post-run listener: copy_logs_to_upload_dir 14:31:24 INFO - Copying logs to upload dir... 14:31:24 INFO - mkdir: /builds/slave/test/build/upload/logs 14:31:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1317.188400 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-24 14:31:23.515214) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 14:31:23.518958) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362 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/f60db5504e840f0be062ea37f17e260614a80eb5424797ce3b68565d8240a370e633f1c605067245ba2e5e9a576bda8518f7426389707320a1ddc996d2c24d38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75e249a24c6da0e76492d32a2bd99cc6f3226cf2845a898573ffce7c25c341a5b36e5cb808e1d48be1bacb4c909029173d37ea8917221342f75c703da07a4c8d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05cb9779b004a259ae95cb0c07e3ad3ecfb552a47e0fa0b5a30923ff6fe62e7a96158f45812186174d6600c2b43069ed8ecd002574651d02aa99d97d83fd1155", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da8119cbe69cd630e1e15e5c89dbb0732916bca27687f1a56db64ded2bf6565a44c4d2e55518a2eabf2a0f0c47d61eb19e53402f11b8453624ff0ad437def69c"} build_url:https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011450 build_url: 'https://queue.taskcluster.net/v1/task/JmBs3QxxRH6KDJ6RQMBolw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f60db5504e840f0be062ea37f17e260614a80eb5424797ce3b68565d8240a370e633f1c605067245ba2e5e9a576bda8518f7426389707320a1ddc996d2c24d38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75e249a24c6da0e76492d32a2bd99cc6f3226cf2845a898573ffce7c25c341a5b36e5cb808e1d48be1bacb4c909029173d37ea8917221342f75c703da07a4c8d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05cb9779b004a259ae95cb0c07e3ad3ecfb552a47e0fa0b5a30923ff6fe62e7a96158f45812186174d6600c2b43069ed8ecd002574651d02aa99d97d83fd1155", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da8119cbe69cd630e1e15e5c89dbb0732916bca27687f1a56db64ded2bf6565a44c4d2e55518a2eabf2a0f0c47d61eb19e53402f11b8453624ff0ad437def69c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 14:31:23.546094) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 14:31:23.546629) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1495659926.861672-527044362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 14:31:23.628563) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 14:31:23.629057) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 14:31:23.629573) ========= ========= Total master_lag: 0.18 =========