builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1500197827.54 results: success (0) revision: b4e656e5a996dd385e9af43a4d9e207553377c51 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:07.540633) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:07.541139) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:07.541420) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:07.558020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:07.558438) ========= 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=32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-16 02:37:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 91.9M=0s 2017-07-16 02:37:07 (91.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.225683 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:07.800482) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:07.800887) ========= 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=32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018332 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:07.857990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:07.858409) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b4e656e5a996dd385e9af43a4d9e207553377c51 --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 b4e656e5a996dd385e9af43a4d9e207553377c51 --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=32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-16 02:37:08,050 truncating revision to first 12 chars 2017-07-16 02:37:08,050 Setting DEBUG logging. 2017-07-16 02:37:08,050 attempt 1/10 2017-07-16 02:37:08,050 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b4e656e5a996?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-16 02:37:08,418 unpacking tar archive at: mozilla-central-b4e656e5a996/testing/mozharness/ program finished with exit code 0 elapsedTime=0.761002 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:08.635364) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:08.635666) ========= script_repo_revision: b4e656e5a996dd385e9af43a4d9e207553377c51 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:08.639061) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:08.639335) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:08.649578) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-07-16 02:37:08.649974) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:37:08 INFO - MultiFileLogger online at 20170716 02:37:08 in /builds/slave/test 02:37:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 02:37:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:37:08 INFO - {'append_to_log': False, 02:37:08 INFO - 'base_work_dir': '/builds/slave/test', 02:37:08 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:37:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:37:08 INFO - 'branch': 'Firefox-Non-PGO', 02:37:08 INFO - 'buildbot_json_path': 'buildprops.json', 02:37:08 INFO - 'code_coverage': False, 02:37:08 INFO - 'config_files': ('talos/linux_config.py',), 02:37:08 INFO - 'default_actions': ('clobber', 02:37:08 INFO - 'read-buildbot-config', 02:37:08 INFO - 'download-and-extract', 02:37:08 INFO - 'populate-webroot', 02:37:08 INFO - 'create-virtualenv', 02:37:08 INFO - 'install', 02:37:08 INFO - 'setup-mitmproxy', 02:37:08 INFO - 'run-tests'), 02:37:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:37:08 INFO - 'disable_ccov_upload': False, 02:37:08 INFO - 'download_minidump_stackwalk': True, 02:37:08 INFO - 'download_symbols': 'ondemand', 02:37:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:37:08 INFO - 'tooltool.py': '/tools/tooltool.py', 02:37:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:37:08 INFO - '/tools/misc-python/virtualenv.py')}, 02:37:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:37:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:37:08 INFO - 'gecko_profile': False, 02:37:08 INFO - 'gecko_profile_interval': 0, 02:37:08 INFO - 'installer_path': 'installer.exe', 02:37:08 INFO - 'log_level': 'info', 02:37:08 INFO - 'log_name': 'talos', 02:37:08 INFO - 'log_to_console': True, 02:37:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:37:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:37:08 INFO - 'opt_config_files': (), 02:37:08 INFO - 'pip_index': False, 02:37:08 INFO - 'suite': 'dromaeojs-e10s', 02:37:08 INFO - 'system_bits': '32', 02:37:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:37:08 INFO - 'title': 'talos-linux64-ix-008', 02:37:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:37:08 INFO - 'use_talos_json': True, 02:37:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:37:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:37:08 INFO - 'work_dir': 'build'} 02:37:08 INFO - [mozharness: 2017-07-16 09:37:08.944923Z] Running clobber step. 02:37:08 INFO - Running pre-action listener: _resource_record_pre_action 02:37:08 INFO - Running main action method: clobber 02:37:08 INFO - rmtree: /builds/slave/test/build 02:37:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:37:10 INFO - Running post-action listener: _resource_record_post_action 02:37:10 INFO - [mozharness: 2017-07-16 09:37:10.473537Z] Finished clobber step (success) 02:37:10 INFO - [mozharness: 2017-07-16 09:37:10.473637Z] Running read-buildbot-config step. 02:37:10 INFO - Running pre-action listener: _resource_record_pre_action 02:37:10 INFO - Running main action method: read_buildbot_config 02:37:10 INFO - Using buildbot properties: 02:37:10 INFO - { 02:37:10 INFO - "project": "", 02:37:10 INFO - "product": "firefox", 02:37:10 INFO - "who": "archaeopteryx@coole-files.de", 02:37:10 INFO - "installer_path": "public/build/target.tar.bz2", 02:37:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:37:10 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:37:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 02:37:10 INFO - "stage_platform": "linux64", 02:37:10 INFO - "basedir": "/builds/slave/test", 02:37:10 INFO - "buildnumber": 720, 02:37:10 INFO - "platform": "ubuntu64_hw", 02:37:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:37:10 INFO - "slavebuilddir": "test", 02:37:10 INFO - "taskId": "FrkUn-qWT066Tt511ny-KQ", 02:37:10 INFO - "branch": "mozilla-central", 02:37:10 INFO - "script_repo_revision": "production", 02:37:10 INFO - "revision": "b4e656e5a996dd385e9af43a4d9e207553377c51", 02:37:10 INFO - "slavename": "talos-linux64-ix-008", 02:37:10 INFO - "repo_path": "mozilla-central" 02:37:10 INFO - } 02:37:10 INFO - Finding installer, test and symbols from parent task. 02:37:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FrkUn-qWT066Tt511ny-KQ'}, attempt #1 02:37:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FrkUn-qWT066Tt511ny-KQ'}, attempt #1 02:37:11 INFO - Task dependencies: ZGq1huidQie8517Ftoc8WQ 02:37:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ'}, attempt #1 02:37:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.tar.bz2 02:37:11 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/test_packages.json 02:37:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.crashreporter-symbols.zip 02:37:11 INFO - Running post-action listener: _resource_record_post_action 02:37:11 INFO - [mozharness: 2017-07-16 09:37:11.843308Z] Finished read-buildbot-config step (success) 02:37:11 INFO - [mozharness: 2017-07-16 09:37:11.843528Z] Running download-and-extract step. 02:37:11 INFO - Running pre-action listener: _resource_record_pre_action 02:37:11 INFO - Running main action method: download_and_extract 02:37:11 INFO - mkdir: /builds/slave/test/build/tests 02:37: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')]} 02:37:11 INFO - trying https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.test_packages.json 02:37:11 INFO - Downloading https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:37:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:37:12 INFO - Downloaded 989 bytes. 02:37:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:37:12 INFO - Using the following test package requirements: 02:37:12 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:37:12 INFO - u'common': [u'target.common.tests.zip'], 02:37:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:37:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:37:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:37:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:37:12 INFO - u'mozbase': [u'target.common.tests.zip'], 02:37:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:37:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:37:12 INFO - u'web-platform': [u'target.common.tests.zip', 02:37:12 INFO - u'target.web-platform.tests.tar.gz'], 02:37:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:37:12 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:37:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.common.tests.zip 02:37:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:37:12 INFO - Fetch https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.common.tests.zip into memory 02:37:13 INFO - Content-Length response header: 72753111 02:37:13 INFO - Bytes received: 72753111 02:37:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:37:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.common.tests.zip 02:37:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:37:24 INFO - Fetch https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.common.tests.zip into memory 02:37:25 INFO - Content-Length response header: 72753111 02:37:25 INFO - Bytes received: 72753111 02:37:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.talos.tests.zip 02:37:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:37:40 INFO - Fetch https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.talos.tests.zip into memory 02:37:41 INFO - Content-Length response header: 14495033 02:37:41 INFO - Bytes received: 14495033 02:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:41 INFO - trying https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.tar.bz2 02:37:41 INFO - Downloading https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:37:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:37:42 INFO - Downloaded 61865494 bytes. 02:37:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.tar.bz2 02:37:42 INFO - mkdir: /builds/slave/test/properties 02:37:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:37:42 INFO - Writing to file /builds/slave/test/properties/build_url 02:37:42 INFO - Contents: 02:37:42 INFO - build_url:https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.tar.bz2 02:37:42 INFO - Running post-action listener: _resource_record_post_action 02:37:42 INFO - Running post-action listener: set_extra_try_arguments 02:37:42 INFO - [mozharness: 2017-07-16 09:37:42.485899Z] Finished download-and-extract step (success) 02:37:42 INFO - [mozharness: 2017-07-16 09:37:42.485996Z] Running populate-webroot step. 02:37:42 INFO - Running pre-action listener: _resource_record_pre_action 02:37:42 INFO - Running main action method: populate_webroot 02:37:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:37:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:37:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:37:42 INFO - '--tppagecycles', 02:37:42 INFO - '7'], 02:37:42 INFO - 'tests': ['tsvgm']}}, 02:37:42 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:37:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:37:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:37:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:37:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:37:42 INFO - 'talos_options': ['--disable-e10s'], 02:37:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:37:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:37:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:37:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:37:42 INFO - 'talos_options': ['--disable-e10s'], 02:37:42 INFO - 'tests': ['damp', 'tps']}, 02:37:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:37:42 INFO - 'tests': ['damp', 'tps']}, 02:37:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:37:42 INFO - 'tests': ['dromaeo_dom']}, 02:37:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:37:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:37:42 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:37:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:37:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:37:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:37:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:37:42 INFO - 'tests': ['a11yr', 02:37:42 INFO - 'ts_paint', 02:37:42 INFO - 'tpaint', 02:37:42 INFO - 'sessionrestore', 02:37:42 INFO - 'sessionrestore_no_auto_restore', 02:37:42 INFO - 'tabpaint']}, 02:37:42 INFO - 'other-e10s': {'tests': ['a11yr', 02:37:42 INFO - 'ts_paint', 02:37:42 INFO - 'tpaint', 02:37:42 INFO - 'sessionrestore', 02:37:42 INFO - 'sessionrestore_many_windows', 02:37:42 INFO - 'sessionrestore_no_auto_restore', 02:37:42 INFO - 'tabpaint']}, 02:37:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:37:42 INFO - 'ts_paint', 02:37:42 INFO - 'tpaint', 02:37:42 INFO - 'sessionrestore', 02:37:42 INFO - 'sessionrestore_many_windows', 02:37:42 INFO - 'sessionrestore_no_auto_restore', 02:37:42 INFO - 'tabpaint']}, 02:37:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:37:42 INFO - 'ts_paint', 02:37:42 INFO - 'tpaint', 02:37:42 INFO - 'sessionrestore', 02:37:42 INFO - 'sessionrestore_many_windows', 02:37:42 INFO - 'sessionrestore_no_auto_restore', 02:37:42 INFO - 'tabpaint']}, 02:37:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:37:42 INFO - 'tests': ['a11yr', 02:37:42 INFO - 'ts_paint', 02:37:42 INFO - 'tpaint', 02:37:42 INFO - 'sessionrestore', 02:37:42 INFO - 'sessionrestore_no_auto_restore', 02:37:42 INFO - 'tabpaint']}, 02:37:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:37:42 INFO - 'tests': ['a11yr', 02:37:42 INFO - 'ts_paint', 02:37:42 INFO - 'tpaint', 02:37:42 INFO - 'sessionrestore', 02:37:42 INFO - 'sessionrestore_no_auto_restore', 02:37:42 INFO - 'tabpaint']}, 02:37:42 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 02:37:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:37:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:37:42 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:37:42 INFO - 'talos_options': ['--mitmproxy', 02:37:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:37:42 INFO - '--firstNonBlankPaint'], 02:37:42 INFO - 'tests': ['quantum_pageload_google', 02:37:42 INFO - 'quantum_pageload_youtube', 02:37:42 INFO - 'quantum_pageload_amazon', 02:37:42 INFO - 'quantum_pageload_facebook']}, 02:37:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:37:42 INFO - 'tests': ['tsvgx', 02:37:42 INFO - 'tsvgr_opacity', 02:37:42 INFO - 'tart', 02:37:42 INFO - 'tscrollx', 02:37:42 INFO - 'cart', 02:37:42 INFO - 'tsvg_static']}, 02:37:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:37:42 INFO - 'tsvgr_opacity', 02:37:42 INFO - 'tart', 02:37:42 INFO - 'tscrollx', 02:37:42 INFO - 'cart', 02:37:42 INFO - 'tsvg_static']}, 02:37:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:37:42 INFO - 'talos_options': ['--disable-e10s'], 02:37:42 INFO - 'tests': ['tp5o']}, 02:37:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:37:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:37:42 INFO - 'talos_options': ['--disable-e10s', 02:37:42 INFO - '--xperf_path', 02:37:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:37:42 INFO - 'tests': ['tp5n']}, 02:37:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:37:42 INFO - 'talos_options': ['--xperf_path', 02:37:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:37:42 INFO - 'tests': ['tp5n']}}, 02:37:42 INFO - 'talos.zip': {'path': '', 02:37:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:37:42 INFO - Running post-action listener: _resource_record_post_action 02:37:42 INFO - [mozharness: 2017-07-16 09:37:42.501358Z] Finished populate-webroot step (success) 02:37:42 INFO - [mozharness: 2017-07-16 09:37:42.501449Z] Running create-virtualenv step. 02:37:42 INFO - Running pre-action listener: _resource_record_pre_action 02:37:42 INFO - Running main action method: create_virtualenv 02:37:42 INFO - Creating virtualenv /builds/slave/test/build/venv 02:37:42 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 02:37:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:37:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:37:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:37:42 INFO - Using real prefix '/usr' 02:37:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:37:43 INFO - Installing distribute.............................................................................................................................................................................................done. 02:37:45 INFO - Installing pip.................done. 02:37:45 INFO - Return code: 0 02:37:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:37:45 INFO - Reading from file tmpfile_stdout 02:37:45 INFO - Output received: 02:37:45 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) 02:37:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:37:45 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')]} 02:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:45 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')]} 02:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:45 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 0xb501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebed10>, '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 0xebfc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec00c0>, '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': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', '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 02:37:45 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 02:37:45 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 02:37:45 INFO - Using env: {'DISPLAY': ':0', 02:37:45 INFO - 'HOME': '/home/cltbld', 02:37:45 INFO - 'LANG': 'en_US.UTF-8', 02:37:45 INFO - 'LANGUAGE': 'en_US:en', 02:37:45 INFO - 'LOGNAME': 'cltbld', 02:37:45 INFO - 'MAIL': '/var/mail/cltbld', 02:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:45 INFO - 'MOZ_NO_REMOTE': '1', 02:37:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:45 INFO - 'NO_EM_RESTART': '1', 02:37:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:45 INFO - 'PWD': '/builds/slave/test', 02:37:45 INFO - 'SHELL': '/bin/bash', 02:37:45 INFO - 'SHLVL': '1', 02:37:45 INFO - 'TERM': 'linux', 02:37:45 INFO - 'TMOUT': '86400', 02:37:45 INFO - 'USER': 'cltbld', 02:37:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', 02:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:45 INFO - '_': '/tools/buildbot/bin/python'} 02:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:45 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 02:37:45 INFO - Cleaning up... 02:37:45 INFO - Return code: 0 02:37:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:37:45 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')]} 02:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:45 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')]} 02:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:45 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 0xb501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebed10>, '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 0xebfc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec00c0>, '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': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', '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 02:37:45 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 02:37:45 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 02:37:45 INFO - Using env: {'DISPLAY': ':0', 02:37:45 INFO - 'HOME': '/home/cltbld', 02:37:45 INFO - 'LANG': 'en_US.UTF-8', 02:37:45 INFO - 'LANGUAGE': 'en_US:en', 02:37:45 INFO - 'LOGNAME': 'cltbld', 02:37:45 INFO - 'MAIL': '/var/mail/cltbld', 02:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:45 INFO - 'MOZ_NO_REMOTE': '1', 02:37:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:45 INFO - 'NO_EM_RESTART': '1', 02:37:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:45 INFO - 'PWD': '/builds/slave/test', 02:37:45 INFO - 'SHELL': '/bin/bash', 02:37:45 INFO - 'SHLVL': '1', 02:37:45 INFO - 'TERM': 'linux', 02:37:45 INFO - 'TMOUT': '86400', 02:37:45 INFO - 'USER': 'cltbld', 02:37:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', 02:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:45 INFO - '_': '/tools/buildbot/bin/python'} 02:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:45 INFO - Downloading/unpacking psutil>=3.1.1 02:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:37:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:37:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:37:46 INFO - Installing collected packages: psutil 02:37:46 INFO - Running setup.py install for psutil 02:37:47 INFO - building 'psutil._psutil_linux' extension 02:37:47 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 02:37:47 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 02:37:47 INFO - building 'psutil._psutil_posix' extension 02:37:47 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 02:37:47 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 02:37:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:37:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:37:47 INFO - Successfully installed psutil 02:37:47 INFO - Cleaning up... 02:37:47 INFO - Return code: 0 02:37:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xb501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebed10>, '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 0xebfc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec00c0>, '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': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', '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 02:37:47 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 02:37:47 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 02:37:47 INFO - Using env: {'DISPLAY': ':0', 02:37:47 INFO - 'HOME': '/home/cltbld', 02:37:47 INFO - 'LANG': 'en_US.UTF-8', 02:37:47 INFO - 'LANGUAGE': 'en_US:en', 02:37:47 INFO - 'LOGNAME': 'cltbld', 02:37:47 INFO - 'MAIL': '/var/mail/cltbld', 02:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:47 INFO - 'MOZ_NO_REMOTE': '1', 02:37:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:47 INFO - 'NO_EM_RESTART': '1', 02:37:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:47 INFO - 'PWD': '/builds/slave/test', 02:37:47 INFO - 'SHELL': '/bin/bash', 02:37:47 INFO - 'SHLVL': '1', 02:37:47 INFO - 'TERM': 'linux', 02:37:47 INFO - 'TMOUT': '86400', 02:37:47 INFO - 'USER': 'cltbld', 02:37:47 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', 02:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:47 INFO - '_': '/tools/buildbot/bin/python'} 02:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:37:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:37:48 INFO - Installing collected packages: mozsystemmonitor 02:37:48 INFO - Running setup.py install for mozsystemmonitor 02:37:48 INFO - Successfully installed mozsystemmonitor 02:37:48 INFO - Cleaning up... 02:37:49 INFO - Return code: 0 02:37:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:37:49 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')]} 02:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:49 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')]} 02:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:49 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 0xb501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebed10>, '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 0xebfc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec00c0>, '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': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', '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 02:37:49 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 02:37:49 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 02:37:49 INFO - Using env: {'DISPLAY': ':0', 02:37:49 INFO - 'HOME': '/home/cltbld', 02:37:49 INFO - 'LANG': 'en_US.UTF-8', 02:37:49 INFO - 'LANGUAGE': 'en_US:en', 02:37:49 INFO - 'LOGNAME': 'cltbld', 02:37:49 INFO - 'MAIL': '/var/mail/cltbld', 02:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:49 INFO - 'MOZ_NO_REMOTE': '1', 02:37:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:49 INFO - 'NO_EM_RESTART': '1', 02:37:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:49 INFO - 'PWD': '/builds/slave/test', 02:37:49 INFO - 'SHELL': '/bin/bash', 02:37:49 INFO - 'SHLVL': '1', 02:37:49 INFO - 'TERM': 'linux', 02:37:49 INFO - 'TMOUT': '86400', 02:37:49 INFO - 'USER': 'cltbld', 02:37:49 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', 02:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:49 INFO - '_': '/tools/buildbot/bin/python'} 02:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:49 INFO - Downloading/unpacking jsonschema==2.5.1 02:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:37:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:50 INFO - Downloading functools32-3.2.3-2.tar.gz 02:37:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:37:50 INFO - warning: no files found matching '*.txt' 02:37:50 INFO - no previously-included directories found matching 'build' 02:37:50 INFO - no previously-included directories found matching 'dist' 02:37:50 INFO - no previously-included directories found matching '.git*' 02:37:50 INFO - Installing collected packages: jsonschema, functools32 02:37:50 INFO - Running setup.py install for functools32 02:37:50 INFO - warning: no files found matching '*.txt' 02:37:50 INFO - no previously-included directories found matching 'build' 02:37:50 INFO - no previously-included directories found matching 'dist' 02:37:50 INFO - no previously-included directories found matching '.git*' 02:37:50 INFO - Successfully installed jsonschema functools32 02:37:50 INFO - Cleaning up... 02:37:50 INFO - Return code: 0 02:37:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebed10>, '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 0xebfc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec00c0>, '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': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', '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 02:37:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:37:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:37:50 INFO - Using env: {'DISPLAY': ':0', 02:37:50 INFO - 'HOME': '/home/cltbld', 02:37:50 INFO - 'LANG': 'en_US.UTF-8', 02:37:50 INFO - 'LANGUAGE': 'en_US:en', 02:37:50 INFO - 'LOGNAME': 'cltbld', 02:37:50 INFO - 'MAIL': '/var/mail/cltbld', 02:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:50 INFO - 'MOZ_NO_REMOTE': '1', 02:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:50 INFO - 'NO_EM_RESTART': '1', 02:37:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:50 INFO - 'PWD': '/builds/slave/test', 02:37:50 INFO - 'SHELL': '/bin/bash', 02:37:50 INFO - 'SHLVL': '1', 02:37:50 INFO - 'TERM': 'linux', 02:37:50 INFO - 'TMOUT': '86400', 02:37:50 INFO - 'USER': 'cltbld', 02:37:50 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', 02:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:50 INFO - '_': '/tools/buildbot/bin/python'} 02:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:37:50 INFO - Cleaning up... 02:37:50 INFO - Return code: 0 02:37:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebed10>, '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 0xebfc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec00c0>, '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': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', '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 02:37:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:37:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:37:50 INFO - Using env: {'DISPLAY': ':0', 02:37:50 INFO - 'HOME': '/home/cltbld', 02:37:50 INFO - 'LANG': 'en_US.UTF-8', 02:37:50 INFO - 'LANGUAGE': 'en_US:en', 02:37:50 INFO - 'LOGNAME': 'cltbld', 02:37:50 INFO - 'MAIL': '/var/mail/cltbld', 02:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:50 INFO - 'MOZ_NO_REMOTE': '1', 02:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:50 INFO - 'NO_EM_RESTART': '1', 02:37:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:50 INFO - 'PWD': '/builds/slave/test', 02:37:50 INFO - 'SHELL': '/bin/bash', 02:37:50 INFO - 'SHLVL': '1', 02:37:50 INFO - 'TERM': 'linux', 02:37:50 INFO - 'TMOUT': '86400', 02:37:50 INFO - 'USER': 'cltbld', 02:37:50 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', 02:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:50 INFO - '_': '/tools/buildbot/bin/python'} 02:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:51 INFO - Downloading/unpacking blobuploader==1.2.4 02:37:51 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 02:37:51 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 02:37:51 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 02:37:51 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 02:37:52 INFO - Downloading blobuploader-1.2.4.tar.gz 02:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:37:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:37:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:52 INFO - Downloading docopt-0.6.1.tar.gz 02:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:37:52 INFO - Installing collected packages: blobuploader, requests, docopt 02:37:52 INFO - Running setup.py install for blobuploader 02:37:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:37:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:37:52 INFO - Running setup.py install for requests 02:37:53 INFO - Running setup.py install for docopt 02:37:53 INFO - Successfully installed blobuploader requests docopt 02:37:53 INFO - Cleaning up... 02:37:53 INFO - Return code: 0 02:37:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:37:53 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')]} 02:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:53 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')]} 02:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:53 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 0xb501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebed10>, '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 0xebfc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec00c0>, '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': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', '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 02:37:53 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 02:37:53 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 02:37:53 INFO - Using env: {'DISPLAY': ':0', 02:37:53 INFO - 'HOME': '/home/cltbld', 02:37:53 INFO - 'LANG': 'en_US.UTF-8', 02:37:53 INFO - 'LANGUAGE': 'en_US:en', 02:37:53 INFO - 'LOGNAME': 'cltbld', 02:37:53 INFO - 'MAIL': '/var/mail/cltbld', 02:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:53 INFO - 'MOZ_NO_REMOTE': '1', 02:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:53 INFO - 'NO_EM_RESTART': '1', 02:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:53 INFO - 'PWD': '/builds/slave/test', 02:37:53 INFO - 'SHELL': '/bin/bash', 02:37:53 INFO - 'SHLVL': '1', 02:37:53 INFO - 'TERM': 'linux', 02:37:53 INFO - 'TMOUT': '86400', 02:37:53 INFO - 'USER': 'cltbld', 02:37:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', 02:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:53 INFO - '_': '/tools/buildbot/bin/python'} 02:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:37:53 INFO - Running setup.py (path:/tmp/pip-1kSsjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:37:53 INFO - Running setup.py (path:/tmp/pip-E5fKlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:37:53 INFO - Running setup.py (path:/tmp/pip-wKkEdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:37:53 INFO - Running setup.py (path:/tmp/pip-mEyGUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:37:53 INFO - Running setup.py (path:/tmp/pip-AaJ0p4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:37:53 INFO - Running setup.py (path:/tmp/pip-qqKd00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:37:54 INFO - Running setup.py (path:/tmp/pip-9ZRD2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:37:54 INFO - Running setup.py (path:/tmp/pip-nRTSIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:37:54 INFO - Running setup.py (path:/tmp/pip-ngeILO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:37:54 INFO - Running setup.py (path:/tmp/pip-acjdQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:37:54 INFO - Running setup.py (path:/tmp/pip-Cm8ier-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:37:54 INFO - Running setup.py (path:/tmp/pip-Hnwsvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:37:54 INFO - Running setup.py (path:/tmp/pip-coUeX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:37:54 INFO - Running setup.py (path:/tmp/pip-R7pMXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:37:54 INFO - Running setup.py (path:/tmp/pip-hMEMDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:37:54 INFO - Running setup.py (path:/tmp/pip-uDC7HG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:37:54 INFO - Running setup.py (path:/tmp/pip-IyQGId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:37:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:37:54 INFO - Running setup.py install for manifestparser 02:37:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:37:54 INFO - Running setup.py install for mozcrash 02:37:55 INFO - Running setup.py install for mozdebug 02:37:55 INFO - Running setup.py install for mozdevice 02:37:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:37:55 INFO - Running setup.py install for mozfile 02:37:55 INFO - Running setup.py install for mozhttpd 02:37:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:37:55 INFO - Running setup.py install for mozinfo 02:37:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:37:55 INFO - Running setup.py install for mozInstall 02:37:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:37:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:37:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:37:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:37:55 INFO - Running setup.py install for mozleak 02:37:55 INFO - Running setup.py install for mozlog 02:37:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:37:55 INFO - Running setup.py install for moznetwork 02:37:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:37:55 INFO - Running setup.py install for mozprocess 02:37:56 INFO - Running setup.py install for mozprofile 02:37:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:37:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:37:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:37:56 INFO - Running setup.py install for mozrunner 02:37:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:37:56 INFO - Running setup.py install for mozscreenshot 02:37:56 INFO - Running setup.py install for moztest 02:37:56 INFO - Running setup.py install for mozversion 02:37:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:37:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:37:56 INFO - Cleaning up... 02:37:56 INFO - Return code: 0 02:37:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:37: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')]} 02:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37: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')]} 02:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:56 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 0xb501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebed10>, '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 0xebfc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec00c0>, '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': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', '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 02:37:56 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 02:37:56 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 02:37:56 INFO - Using env: {'DISPLAY': ':0', 02:37:56 INFO - 'HOME': '/home/cltbld', 02:37:56 INFO - 'LANG': 'en_US.UTF-8', 02:37:56 INFO - 'LANGUAGE': 'en_US:en', 02:37:56 INFO - 'LOGNAME': 'cltbld', 02:37:56 INFO - 'MAIL': '/var/mail/cltbld', 02:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:56 INFO - 'MOZ_NO_REMOTE': '1', 02:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:56 INFO - 'NO_EM_RESTART': '1', 02:37:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:56 INFO - 'PWD': '/builds/slave/test', 02:37:56 INFO - 'SHELL': '/bin/bash', 02:37:56 INFO - 'SHLVL': '1', 02:37:56 INFO - 'TERM': 'linux', 02:37:56 INFO - 'TMOUT': '86400', 02:37:56 INFO - 'USER': 'cltbld', 02:37:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', 02:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:56 INFO - '_': '/tools/buildbot/bin/python'} 02:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:37:56 INFO - Running setup.py (path:/tmp/pip-0GUiL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:37:56 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)) 02:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:37:56 INFO - Running setup.py (path:/tmp/pip-pnK7Q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:37:57 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)) 02:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:37:57 INFO - Running setup.py (path:/tmp/pip-VEGj68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:37:57 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)) 02:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:37:57 INFO - Running setup.py (path:/tmp/pip-4OnHgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 02:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:37:57 INFO - Running setup.py (path:/tmp/pip-LhYuVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:37:57 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)) 02:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:37:57 INFO - Running setup.py (path:/tmp/pip-FdpXMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:37:57 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)) 02:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:37:57 INFO - Running setup.py (path:/tmp/pip-g4Sc6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 02:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:37:57 INFO - Running setup.py (path:/tmp/pip-10hruE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 02:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:37:57 INFO - Running setup.py (path:/tmp/pip-Wvgey_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:37:57 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)) 02:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:37:57 INFO - Running setup.py (path:/tmp/pip-jzpd9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 02:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:37:57 INFO - Running setup.py (path:/tmp/pip-kyVu74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:37:57 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)) 02:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:37:57 INFO - Running setup.py (path:/tmp/pip-y9VsAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:37:57 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)) 02:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:37:57 INFO - Running setup.py (path:/tmp/pip-ZMGfcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:37:57 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)) 02:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:37:57 INFO - Running setup.py (path:/tmp/pip-k78T5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:37:57 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)) 02:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:37:57 INFO - Running setup.py (path:/tmp/pip-GQ3mCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:37:57 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)) 02:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:37:57 INFO - Running setup.py (path:/tmp/pip-1SygXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:37:58 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)) 02:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:37:58 INFO - Running setup.py (path:/tmp/pip-kQEpMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:37:58 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)) 02:37:58 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)) 02:37:58 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)) 02:37:58 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)) 02:37:58 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:37:58 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:37:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:37:58 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 02:37:58 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 02:37:58 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 02:37:58 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 02:37:59 INFO - Downloading blessings-1.6.tar.gz 02:37:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:37:59 INFO - Installing collected packages: blessings 02:37:59 INFO - Running setup.py install for blessings 02:37:59 INFO - Successfully installed blessings 02:37:59 INFO - Cleaning up... 02:37:59 INFO - Return code: 0 02:37:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:37:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:37:59 INFO - Reading from file tmpfile_stdout 02:37:59 INFO - Current package versions: 02:37:59 INFO - argparse == 1.2.1 02:37:59 INFO - blessings == 1.6 02:37:59 INFO - blobuploader == 1.2.4 02:37:59 INFO - docopt == 0.6.1 02:37:59 INFO - functools32 == 3.2.3-2 02:37:59 INFO - jsonschema == 2.5.1 02:37:59 INFO - manifestparser == 1.1 02:37:59 INFO - mozInstall == 1.13 02:37:59 INFO - mozcrash == 1.0 02:37:59 INFO - mozdebug == 0.1 02:37:59 INFO - mozdevice == 0.51 02:37:59 INFO - mozfile == 1.2 02:37:59 INFO - mozhttpd == 0.7 02:37:59 INFO - mozinfo == 0.10 02:37:59 INFO - mozleak == 0.1 02:37:59 INFO - mozlog == 3.5 02:37:59 INFO - moznetwork == 0.27 02:37:59 INFO - mozprocess == 0.25 02:37:59 INFO - mozprofile == 0.28 02:37:59 INFO - mozrunner == 6.13 02:37:59 INFO - mozscreenshot == 0.1 02:37:59 INFO - mozsystemmonitor == 0.3 02:37:59 INFO - moztest == 0.8 02:37:59 INFO - mozversion == 1.4 02:37:59 INFO - psutil == 3.1.1 02:37:59 INFO - requests == 1.2.3 02:37:59 INFO - wsgiref == 0.1.2 02:37:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:37:59 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')]} 02:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:59 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')]} 02:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:59 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 0xb501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebed10>, '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 0xebfc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec00c0>, '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': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', '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 02:37:59 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 02:37:59 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 02:37:59 INFO - Using env: {'DISPLAY': ':0', 02:37:59 INFO - 'HOME': '/home/cltbld', 02:37:59 INFO - 'LANG': 'en_US.UTF-8', 02:37:59 INFO - 'LANGUAGE': 'en_US:en', 02:37:59 INFO - 'LOGNAME': 'cltbld', 02:37:59 INFO - 'MAIL': '/var/mail/cltbld', 02:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:59 INFO - 'MOZ_NO_REMOTE': '1', 02:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:59 INFO - 'NO_EM_RESTART': '1', 02:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:59 INFO - 'PWD': '/builds/slave/test', 02:37:59 INFO - 'SHELL': '/bin/bash', 02:37:59 INFO - 'SHLVL': '1', 02:37:59 INFO - 'TERM': 'linux', 02:37:59 INFO - 'TMOUT': '86400', 02:37:59 INFO - 'USER': 'cltbld', 02:37:59 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', 02:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:59 INFO - '_': '/tools/buildbot/bin/python'} 02:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:59 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)) 02:37:59 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)) 02:37:59 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)) 02:37:59 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)) 02:37:59 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)) 02:37:59 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)) 02:37:59 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)) 02:37:59 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)) 02:37:59 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)) 02:37:59 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:37:59 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 02:37:59 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 02:37:59 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 02:37:59 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 02:38:00 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:38:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:38:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 02:38:01 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 02:38:01 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 02:38:01 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 02:38:01 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 02:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:38:01 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)) 02:38:01 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)) 02:38:01 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)) 02:38:01 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)) 02:38:01 INFO - Installing collected packages: marionette-driver, simplejson 02:38:01 INFO - Running setup.py install for marionette-driver 02:38:01 INFO - Running setup.py install for simplejson 02:38:01 INFO - building 'simplejson._speedups' extension 02:38:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 02:38:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 02:38:02 INFO - Successfully installed marionette-driver simplejson 02:38:02 INFO - Cleaning up... 02:38:02 INFO - Return code: 0 02:38:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:38: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')]} 02:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38: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')]} 02:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb501f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd1ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec1b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xebed10>, '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 0xebfc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec00c0>, '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': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', '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 02:38: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', 'jsonschema'] in /builds/slave/test/build 02:38: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 jsonschema 02:38:02 INFO - Using env: {'DISPLAY': ':0', 02:38:02 INFO - 'HOME': '/home/cltbld', 02:38:02 INFO - 'LANG': 'en_US.UTF-8', 02:38:02 INFO - 'LANGUAGE': 'en_US:en', 02:38:02 INFO - 'LOGNAME': 'cltbld', 02:38:02 INFO - 'MAIL': '/var/mail/cltbld', 02:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:02 INFO - 'MOZ_NO_REMOTE': '1', 02:38:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:02 INFO - 'NO_EM_RESTART': '1', 02:38:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:02 INFO - 'PWD': '/builds/slave/test', 02:38:02 INFO - 'SHELL': '/bin/bash', 02:38:02 INFO - 'SHLVL': '1', 02:38:02 INFO - 'TERM': 'linux', 02:38:02 INFO - 'TMOUT': '86400', 02:38:02 INFO - 'USER': 'cltbld', 02:38:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', 02:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:02 INFO - '_': '/tools/buildbot/bin/python'} 02:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:38:02 INFO - Cleaning up... 02:38:02 INFO - Return code: 0 02:38:02 INFO - Running post-action listener: _resource_record_post_action 02:38:02 INFO - Running post-action listener: _start_resource_monitoring 02:38:02 INFO - Starting resource monitoring. 02:38:02 INFO - [mozharness: 2017-07-16 09:38:02.690062Z] Finished create-virtualenv step (success) 02:38:02 INFO - [mozharness: 2017-07-16 09:38:02.690576Z] Running install step. 02:38:02 INFO - Running pre-action listener: _resource_record_pre_action 02:38:02 INFO - Running main action method: install 02:38:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:38:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:38:02 INFO - Reading from file tmpfile_stdout 02:38:02 INFO - Detecting whether we're running mozinstall >=1.0... 02:38:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:38:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:38:03 INFO - Reading from file tmpfile_stdout 02:38:03 INFO - Output received: 02:38:03 INFO - Usage: mozinstall [options] installer 02:38:03 INFO - Options: 02:38:03 INFO - -h, --help show this help message and exit 02:38:03 INFO - -d DEST, --destination=DEST 02:38:03 INFO - Directory to install application into. [default: 02:38:03 INFO - "/builds/slave/test"] 02:38:03 INFO - --app=APP Application being installed. [default: firefox] 02:38:03 INFO - mkdir: /builds/slave/test/build/application 02:38:03 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'] 02:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:38:21 INFO - Reading from file tmpfile_stdout 02:38:21 INFO - Output received: 02:38:21 INFO - /builds/slave/test/build/application/firefox/firefox 02:38:21 INFO - Running post-action listener: _resource_record_post_action 02:38:21 INFO - [mozharness: 2017-07-16 09:38:21.207094Z] Finished install step (success) 02:38:21 INFO - [mozharness: 2017-07-16 09:38:21.207344Z] Running setup-mitmproxy step. 02:38:21 INFO - Running pre-action listener: _resource_record_pre_action 02:38:21 INFO - Running main action method: setup_mitmproxy 02:38:21 INFO - Skipping: mitmproxy is not required 02:38:21 INFO - Running post-action listener: _resource_record_post_action 02:38:21 INFO - [mozharness: 2017-07-16 09:38:21.208471Z] Finished setup-mitmproxy step (success) 02:38:21 INFO - [mozharness: 2017-07-16 09:38:21.208707Z] Running run-tests step. 02:38:21 INFO - Running pre-action listener: _resource_record_pre_action 02:38:21 INFO - Running pre-action listener: _set_gcov_prefix 02:38:21 INFO - Running main action method: run_tests 02:38:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:38:21 INFO - Python 2.7.3 02:38:21 INFO - Return code: 0 02:38:21 INFO - grabbing minidump binary from tooltool 02:38:21 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')]} 02:38:21 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 0xebed10>, '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 0xebfc10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec00c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:38:21 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 02:38:21 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 02:38:21 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 02:38:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:38:21 INFO - Return code: 0 02:38:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:38:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:38:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:38:21 INFO - ENV: RUST_BACKTRACE is now 1 02:38:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:38:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:38:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 02:38:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 02:38:21 INFO - Using env: {'DISPLAY': ':0', 02:38:21 INFO - 'HOME': '/home/cltbld', 02:38:21 INFO - 'LANG': 'en_US.UTF-8', 02:38:21 INFO - 'LANGUAGE': 'en_US:en', 02:38:21 INFO - 'LOGNAME': 'cltbld', 02:38:21 INFO - 'MAIL': '/var/mail/cltbld', 02:38:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:38:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:21 INFO - 'MOZ_NO_REMOTE': '1', 02:38:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:38:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:21 INFO - 'NO_EM_RESTART': '1', 02:38:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:21 INFO - 'PWD': '/builds/slave/test', 02:38:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:38:21 INFO - 'RUST_BACKTRACE': '1', 02:38:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:38:21 INFO - 'SHELL': '/bin/bash', 02:38:21 INFO - 'SHLVL': '1', 02:38:21 INFO - 'TERM': 'linux', 02:38:21 INFO - 'TMOUT': '86400', 02:38:21 INFO - 'USER': 'cltbld', 02:38:21 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958', 02:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:21 INFO - '_': '/tools/buildbot/bin/python'} 02:38:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 02:38:21 INFO - mozversion application_buildid: 20170716085807 02:38:21 INFO - mozversion application_changeset: b4e656e5a996dd385e9af43a4d9e207553377c51 02:38:21 INFO - mozversion application_display_name: Nightly 02:38:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:38:21 INFO - mozversion application_name: Firefox 02:38:21 INFO - mozversion application_remotingname: firefox 02:38:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:38:21 INFO - mozversion application_vendor: Mozilla 02:38:21 INFO - mozversion application_version: 56.0a1 02:38:21 INFO - mozversion platform_buildid: 20170716085807 02:38:21 INFO - mozversion platform_changeset: b4e656e5a996dd385e9af43a4d9e207553377c51 02:38:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:38:21 INFO - mozversion platform_version: 56.0a1 02:38:21 INFO - using testdate: 1500197901 02:38:21 INFO - actual date: 1500197901 02:38:21 INFO - starting webserver on 'localhost:53681' 02:38:21 INFO - SUITE-START | Running 2 tests 02:38:21 INFO - TEST-START | dromaeo_css 02:38:21 INFO - Initialising browser for dromaeo_css test... 02:38:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53681/getInfo.html -profile /tmp/tmpRw5mjZ/profile 02:38:21 INFO - TEST-INFO | started process 14389 (/builds/slave/test/build/application/firefox/firefox http://localhost:53681/getInfo.html) 02:38:28 INFO - TEST-INFO | 14389: exit 0 02:38:28 INFO - Browser initialized. 02:38:28 INFO - Running cycle 1/1 for dromaeo_css test... 02:38:28 INFO - TEST-INFO | started process 14597 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRw5mjZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:38:39 INFO - PID 14597 | RSS: Main: 167505920 02:38:39 INFO - PID 14597 | 02:41:37 INFO - PID 14597 | Cycle 1(1): loaded http://localhost:53681/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53681/tests/dromaeo/cssquery-ext.html) 02:41:39 INFO - PID 14597 | RSS: Main: 176697344 02:41:39 INFO - PID 14597 | 02:44:41 INFO - PID 14597 | Cycle 1(1): loaded http://localhost:53681/tests/dromaeo/cssquery-ext.html (next: http://localhost:53681/tests/dromaeo/cssquery-jquery.html) 02:44:41 INFO - PID 14597 | RSS: Main: 172646400 02:44:41 INFO - PID 14597 | 02:47:43 INFO - PID 14597 | Cycle 1(1): loaded http://localhost:53681/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53681/tests/dromaeo/cssquery-mootools.html) 02:47:43 INFO - PID 14597 | RSS: Main: 176537600 02:47:43 INFO - PID 14597 | 02:50:45 INFO - PID 14597 | Cycle 1(1): loaded http://localhost:53681/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53681/tests/dromaeo/cssquery-prototype.html) 02:50:46 INFO - PID 14597 | RSS: Main: 175017984 02:50:46 INFO - PID 14597 | 02:53:49 INFO - PID 14597 | Cycle 1(1): loaded http://localhost:53681/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53681/tests/dromaeo/cssquery-yui.html) 02:53:50 INFO - PID 14597 | RSS: Main: 174194688 02:53:50 INFO - PID 14597 | 02:56:51 INFO - PID 14597 | Cycle 1(1): loaded http://localhost:53681/tests/dromaeo/cssquery-yui.html (next: http://localhost:53681/tests/dromaeo/cssquery-dojo.html) 02:56:51 INFO - PID 14597 | RSS: Main: 177741824 02:56:51 INFO - PID 14597 | 02:56:51 INFO - PID 14597 | __start_tp_report 02:56:51 INFO - PID 14597 | _x_x_mozilla_page_load 02:56:51 INFO - PID 14597 | _x_x_mozilla_page_load_details 02:56:51 INFO - PID 14597 | |i|pagename|runs| 02:56:51 INFO - PID 14597 | |0;dojo.html;3037.498812695905;3077.569140320355;3105.037438394098;3117.37652469506;3125.2811853273747;6064.696765161741;6139.478144357729;6156.168917196188;6189.814305570829;6272.466840318567;6201.534884883629;6232.407921247485;6256.936320825459;6264.342244064376;6273.905891411621;5686.943130568703;5725.885482290351;5730.68481233533;5747.396523365049;5804.129380592903;5621.381648018714;5721.6853073080965;5731.430473247859;5735.0250457422335;5738.598298119134;5527.226188333617;5557.972210138923;5597.776088956437;5692.48767610917;5728.8854222915725;5603.2435621191025;5680.375158732536;5703.40114288002;5705.229793977802;5712.028955077605;5487.6158668893195;5597.188407680864;5637.041702910515;5663.461971112738;5664.688442135681;5987.461128498456;6012.218411606507;6081.087836824512;6089.056196289582;6089.421504957022;6497.610143391412;6581.177352830896;6609.372109649576;6614.636195009272;6627.271000189975;6532.150820393366;6543.705533251015;6546.312637173123;6561.671916404161;6570.63861487618;5998.850028749316;6060.2424696912885;6073.544484163661;6075.544334174866;6080.635161890301;6670.566413183127;6680.766173184013;6681.398674119256;6685.866282674319;6721.227058888193;6347.682615869188;6384.074309225136;6386.489080873519;6396.328385519453;6396.456301214356;6495.902561461582;6501.934980650133;6516.57642253252;6602.339766023455;6607.504437167232;6531.8693626127215;6554.836129096715;6630.237522684953;6672.899906501407;6676;6466.838329041811;6484.351564843478;6586.7035983380865;6684.2981486944145;6713.026611141455;5347.2781174541715;5347.385050719217;5358.410574836765;5378.892422151535;5410.945890541044;4524.343970124313;4573.428321459817;4595.965907670748;4640.535946405333;4683.555062269079;5658.660480371191;5660.122680984454;5723.828285151452;5729.369769325371;5735.397783232784;6531;6595.70319335631;6605.669716514251;6687.297833727486;6687.933120668828;5680.971595141998;5691.8861622768145;5705.885882282331;5725.341585717696;5726.455986681259;5786.247787787561;5808.738606762706;5838.299404071538;5845.853853653608;5884.735186916513;5436.782528698887;6354.714037868307;6372.745090196433;6429.292777794439;6502.414782669583;6633.237177724527;6643.368879956396;6648.601083934979;6715.160604924385;6744.156980377453;6310.432061114522;6419.839504012437;6425.485961123192;6427.003814408774;6490.578112422678;6473.611583305017;6486.286508483969;6498.057781621544;6498.480121590167;6510.641914694548;6646.2356828965285;6652.667366631552;6657.234418041987;6663.333666633298;6669.566478178903;6376.649284289409;6387.712552935036;6392.968035159794;6403.583767055126;6409.743610255724;5480.753366098615;6409.615423074631;6415.743370265137;6429.22849258092;6522.902156467562;6346.3019067903415;6355.904661430175;6370.554061215856;6440.774572890114;6454.451371633276;6369.7452101915405;6491.805245842632;6539.901901471387;6563.146790917151;6564.146660934048;6142.754289828356;6164.599301045418;6236.688165591611;6244.656543889948;6248.250209974832 02:56:51 INFO - PID 14597 | |1;ext.html;811.5820352518454;817.2236375443323;836.598432752279;868.2229404682811;872.0712441250072;42065.369019464735;42411;42723.78638106809;42970;43026.7848660757;37765.244695106085;42581.7870910645;43664;43806;43981.56018439815;7788.961055194716;7944.801379965489;7945.284924356807;7983.600819958979;7996.960395148622;7719.150893401721;7785.571793551352;7835.294823465887;7880.645370958292;7908.565028923407;7845.7646270611685;7864.882026769603;7933.484323518953;7935.801604959865;7947;7910.525368477881;7917.802054948644;7922.4850384724805;7927.28654421102;7936.365090792723;7714.07431108265;7740.9225907740765;7758.961205193994;7765.417593680497;7767.650455729506;39311;39613.20773584541;39674.20651586952;39677.80161099205;39719.8014009931;3574.088607405121;3599.6760291573623;3601.0277225149325;3602.0814692253307;3604.6034936157002;32023.839880800446;32212.677873221437;32240.516392254136;32350.514742278883;32460.513092303634;4650.255959046536;4902.877428064291;4943.456219815817;4970.577500912426;5064.620153488503;206166;206917;225127;232914;234586;49655.75172124116;49833.75083124634;49955.25067123996;50039.24941125886;50069.24896126561;52007.73996129995;52164.21753673698;52403.213951790756;52643.47356526462;52783;16291;16335;16396.83603163977;16516.50450486487;16750.329986800636;13256.270905100118;13304.667383315302;13323.733525329439;13365.198088114745;13367.532136375181;15075.773863392058;15098.169600671848;15278;15339.693206135815;15502.457413990456;5870.765169393177;6019.668918209541;6046.637201767908;6123.724432400552;6143;989.5744829723288;990.1979396688705;1012.4886932099242;1030.9123724483352;1030.9845352319721;22354.776452235594;22436.887815560818;22749.43126421853;22882.199123030947;22966.19618313351;1076.34343050739;1104.100158370925;1126.4930781148516;1129.158776711339;1135.0919264588297;11791.941040294743;11874.762504749857;12089.697757555956;12093;12295.262284262973;238101;239762;239959;240232;240445;57217.427825721206;57623;57745.13382299269;57784.71107644435;57928.71035644795;1488;1496.064959400353;1505.819301683805;1507.5854140111558;1510.3430007946579;22020.128289094966;22426.88786556057;22682.546349073255;22867;23154.07383704633;38678.80660596679;38714.80642596769;38762.224755505296;38894.222115556964;52515;204066;205159;206200;207084;207755;37112.81443592765;37251.813740931124;37310.813445932596;37375;37784.811075944446;48488.51511484981;48999.510004899494;49133.50866491289;49563;49750.502494974586;33149;33691.15772105717;34739.478907816905;34791.65208347884;35178.29643407066;33002.51488682967;34162;34339;34423.655763442046;34441;38881.80559097186;39159.216815662956;39274.60725392824;39285.80357098196;39383.2123357537;31843.84078079595;32679.050265711452;32801.50797738084;32902.67097328996;33681;23785.762142379048;23903.043878244676;24136.517269654156;24196.87901560481;24235.39411514726 02:56:51 INFO - PID 14597 | |2;jquery.html;562.8198976327577;572.6420986883198;579.4875375270543;590.8522869282679;591.7337198260782;22441.102355905765;23770;23792.88103559482;23815;23832.40418989526;25611.743882561168;26798.732012679866;28088;28155.155345339623;28457.715422845766;6357.713902874359;6476.838079048014;6540.215174179105;6540.4767618590395;6551.115599394092;6440.1305823713665;6485.935140648604;6513.706883190268;6523.18460192476;6531.804045878631;5970.97014514929;6320.810375688737;6473.967630161843;6508.316626754194;6520.4457621102265;6504.089427480157;6549.1158693576235;6549.377809108127;6549.377809108127;6560.507961902877;6023.307319658208;6096.268447786294;6103.084537319393;6105.084237364386;6105.786297479612;30016.84991575028;30488;30776.846115769502;31205.219869503217;31270.530942035886;1896.8672192946499;1911.5985643014983;1927.6433859735994;1927.7686677598779;1928.517870532367;19159.80840191608;19748;19762.802371976384;19778.208871645118;19834;2315.9652605210936;2341.6487526870937;2404.2426635609727;2414.360194548446;2418.4316685578874;140861;144205;144452.27773861168;144565;145041.27479362534;14350.21073840928;15304.234788260543;15441.691166176613;15484.458043968632;16028.358865645478;24606.630900536507;24620.261392158263;24622.876885615457;24653.87673061659;24687.38281542976;10274.33216840903;10434.426106564211;10556.208284378703;10576.259661823598;10601.098906592872;9784.853227201598;9788.657396991071;9880.752981175528;9913.801723965624;9938.850917236246;9167.724968250963;9301.90698093024;9548.519979403065;9593.520323983774;9676.080772326617;2491.3183601069204;2545.121932933135;2565.7177710451833;2631.9998400607647;2658.428437885864;973.6543527047796;987.9625852179215;988.5304480371766;998.770282834952;1011.9342242754344;19533.902330488258;19645;19718.35198524475;20055.699164512545;20229.898850505655;1014.878214614251;1027.8355463125863;1032.8456544908381;1073.2058276875057;1074.521837782195;10875.673729788119;11006.504707288192;11138.49876755548;11156.553737850558;11306.378149201873;457787;468437;481294;484285;494765;108964;110491.44754276177;112220.43889780498;112229;112353;1186.8157130952025;1202.1464760020483;1236.0729452910318;1241.4227384266178;1242.142921384242;16745.581360466087;17664.470065898044;17774.934143768965;18248.726269105708;18295;53161;54972.17541736957;55539.16691249554;57612.42387576238;58031;70067.64966175136;70837.29162708308;71832;71988.28011719816;72863.27136728565;14558.344874480463;14922.179280139697;14930.552083437515;14952.252387380806;14953.925230373778;21818.672719909533;22891.08435662555;23058.884705576365;23302.883485582464;23310;18570.628587428448;18587.628247435245;18623.348182813537;18714.81285187185;18942.526436838638;15445.150516721238;15918.204089795696;16500.42248521296;16708.49874503767;16730.247138878538;18414.17136228846;18608.34870779516;18935.621287574446;18955.62088758245;18971.90514047421;14729.04261223017;14752.704945901236;14756.114633122046;14760.557183284518;14795.630109246924;17738;17932.372366967094;18124.365647202285;18258.908705456386;18526.16632251579 02:56:51 INFO - PID 14597 | |3;mootools.html;1352.9458821647133;1423.864732850379;1440.920749358785;1441.1353188087148;1443.9927800360997;13665.65835854103;14095.15429074255;14165.29173541324;14167.574972750808;14187.716245675081;13699.589012329647;14120.152790832557;14128.71742565148;14164.71670566588;14180.71638567228;2566.345581876619;2638.7229340919216;2648.8410695358243;2649.350909027291;2651.098626467001;2562.6027965665353;2605.1793684989166;2606.087869245758;2624.93437664058;2635.9077432289873;2497.987510062447;2560.0527804712283;2575.214559559334;2578.471413360266;2590.080521414899;2474.8391354561986;2482.2677310193444;2487.2413913756295;2492.003198720508;2495.214007587604;2427.0291883246664;2447;2448.644946482768;2453.116877923946;2474.1587860127643;13470.932645336808;13704.52034178809;13766.724665506634;13782;13782.379792909343;7195.280471952763;7442.590657513834;7510.211427800112;7518.548887066793;7560.432967527458;4810.687305325143;4941.654084214107;4969.478204788517;5083.161278389061;5124.564412024983;1796.4700413378084;1803.8906072765285;1819.9363022294156;1849.260295881658;1853.7034074548142;21062.473438164016;21682.891585542286;22695.886520567292;22704.886475567517;23007.309780706604;5886.61736987103;6098.481629061491;6104.053871649901;6351.428371446592;6352.841178970562;15647.374105035899;15664.903456757918;15666.530004099895;15669.843301567067;15700.057996520245;7204.711811527585;7384.372328352043;7415.036045314183;7429.591372474458;7462;6923.169219693669;6954.826129346807;6958.756443524452;6992.916098004817;7026.051483049723;4817.156997525489;4900.730459824744;4932.605391568666;5061.721605311744;5095.235714642759;1493.5668656089829;1498.88008959283;1500.6323450754635;1506.6610012747044;1507.2614418934643;896.4442045931434;899.7030979776658;931.9021502742114;932.8927173375013;936.6628013914985;7218.025566548554;7229.783106506813;7300.817479563053;8455.492670439793;8800.77998050041;971.834788086013;992.6525715999343;1023.7184774187009;1024.9846252306222;1040.089921318846;4774.114224881222;4810.95189048112;5053.949460505348;5338.412774594792;5380.784768609212;17582.472525824247;18013.27946882136;18825.90587047056;18901.7164742529;18954.526136846413;18755.437336879917;19214.231430742893;19230;19254.903725481283;19277.036148192536;10663.573457061631;10699.465026748787;10963.945180274048;10983.505742241618;10983.560657573767;7263.208899678817;8409;8470.068292487944;8545.572721363782;8594.570271486276;15522.767158492406;15971.920140399223;16390.508284751475;16501.257443414834;16619.91690041542;15824.841751582337;16780.412685555948;16818.747718784474;17043.659126817147;17137.571560711083;11102.88897111051;11350.035247004098;11365.829512557153;11378.886211138113;11401.771964560829;13123.868761312264;13270.933645331712;13294.601161965156;13315.733685326046;13317.267550284827;10443.216758742972;10721.839172412576;11015.394153321644;11387;11442.656720298404;10203.438810865176;10206.336588121749;10347.84478232812;10430.322029068086;10594.417307048187;9574.617015319309;9588.904110958802;9625.855612165684;9686.951565242129;9702.85445718329;6818.93181068183;7071.82320441993;7140.428765698835;7149.785506434815;7179.317964793337;7102.14774227096;7399.445041621792;7420.5176663516695;7426.14599321085;7461.813454663677 02:56:51 INFO - PID 14597 | |4;prototype.html;493.32660917847136;496.63497329462837;521.3925776470412;528.3263838605777;529.2458246998027;6044.5546038757875;6107.1449997000345;6127.479164271032;6139.386061393859;6161.938380616192;5771.451712087355;5939.46544810968;5957.910631340523;6046.365131661179;6046.425589568984;4849.951500484985;4863.862808488523;4922.630802689795;4937.481564435737;4955.702657840541;4897.706137631753;4911.287863259825;4912.410510738717;4915.778789954443;4927.384076990376;4809.879753006167;4827.517248275162;4861.124997500448;4883.584895283905;4897.461279259279;4655.720656760605;4768.952310476886;4820.276958456225;4876.585490233334;4902.779374928136;4344.826206951718;4396.538363471854;4397.604215620578;4411.205982923073;4421.204183247014;5805.5065319447895;5857.736401861926;5872.677002764846;5896.410358964112;5952.434518720715;5558.722063896789;5583.776648934037;5589.049861523551;5593.664380137164;5692.57305702074;6364.554481186319;6406;6421.550491465599;6426.678666066725;6441.227052753699;4799.640026997954;4831.734254615994;4849.684770489906;4852.4662287148385;4857.73282469464;6727.529072964894;6732.158480189976;6770.864582708367;6806.931930680679;6858.787321635543;4902.989774192564;4908.779104940286;4912.806675660849;4918.483559226302;4926.556609905054;4924.876878078005;4975.154223781966;4978.054169707744;4992.500749924979;4999.625028122905;5502.394736578973;5532.723363831873;5542.448114527939;5554.166874968787;5592.552595792326;6317.368263173646;6325.367463253638;6426.260979987362;6462.579932304385;6492.675366231764;1742.6601812646666;1743.4072415378832;1750.492357216393;1751.9474415767547;1759.8504127149079;1104.861892263467;1181.220394539617;1192.8151136573845;1195.1514424758518;1229.5757963502576;5470.948394352118;5587.357453892773;5616.326040875121;5619.325680918234;5625.46558076982;6567.704453299518;6576.638284894377;6587.50593705474;6686.398224159849;6697.162854643169;5567.276254086943;5634.211210430543;5659.660420374791;5667.773289068391;5696.8860622787315;3482.2513159670793;3484.53288977464;3492.231709024011;3501.3697534443536;3531.823408829548;6334.271558770708;6364.331745166784;6372.330905254974;6420.711068001951;6484.1894763154605;6724.462043036546;6742.426893713991;6757.695903684346;6787.524873258824;6810.284920083419;6342.429181373698;6395.584287021329;6448.903266451007;6476.287608363171;6478.514111441661;6533.216014078341;6615.801525954229;6618.536702430783;6623.437007854386;6735.5621884579305;6387.5209359297305;6497.480201583768;6533.314002029909;6539.738410463528;6560.8359791003695;6318.652474113784;6332.810015699536;6345;6431.389018043278;6437.420632143129;4902.837669703093;4924.433690125681;4936.272304693329;4975.203967365204;4989.401271847401;6561.475081993333;6634.767783127568;6647.734090636321;6657.901446261312;6676.431038705803;6401.423871851555;6417;6423.710933008119;6434.131392261985;6444.258910225384;6410.391012853958;6472.320406357453;6492.285848556749;6524.380183882524;6525.445337146396;6149.139120523041;6295;6375.557199112427;6421.357864213728;6423.132877061724;5934.258217722785;6343.238811342484;6356.173697419306;6393.328700486568;6452.580582262138;6096.481799046954;6138.478229350555;6142.754289828356;6149.2313460817395;6175.96912015437 02:56:51 INFO - PID 14597 | |5;yui.html;895.8835351404317;898.680968256269;911.2482202183193;917.5320586500883;918.132364915155;16908.746368804463;17192.48422547324;17371.73942390865;17531.474055778315;17573.121343932817;17830.910845445756;18417.26330946764;18876.150573224204;18959.71560426591;19190.42428727137;1040.9479526023706;1041.9947900260488;1044.3994703045742;1044.9529771160296;1052.0268751404958;1043.4417586591176;1046.1160319529986;1053.2416660004822;1056.4453661827524;1056.9207309451783;994.7413672445144;1090.514720949178;1095.3756358875444;1096.7587130831205;1101.9751630983183;1079.8542196803448;1083.3012706804068;1083.8482612434266;1087.33129125588;1094.4035500652165;790.8260182759784;795.1928792275845;795.4431897671653;797.5932274539969;800.1238643685156;17746.37887673925;17778.822211777846;18095.909520452446;18125.274989000423;18216.453506394828;17983.550411239692;18215.908920455313;18471.63056738871;18508.814911850845;18515.2593896244;15051.096934183985;15051.623709407242;15115.39538418462;15121.09273443597;15157.09057456545;3380.4084285249983;3482.6343233960324;3506.5441492605796;3527.576690797095;3540.6813386795056;112937;117511;118000.40999794946;120457;121027.78972210253;14069.71860562783;14230.288485575888;14647.633809154644;14707.970442068952;14762.261886905611;26274.474510510066;26914.5962810558;26994;27612.723872761017;28117.57823632647;7816.374690024784;7863.606819658994;7904;7997.8400431992195;8019.558924259105;3853.9807300963316;3862.1696335288048;3921.980285125831;3927.509061367329;4000.4799376081505;4690.95309046912;4841.830535931296;4860.659753817199;4870.366852309177;4871.610271178297;780.7813812132612;892.9680011522255;900.4147304252289;927.6104036304769;928.6563971330651;616.3251239892311;686.1183379357502;707.1231672725886;711.4877288352378;735.5990984913235;10493.26547141708;11660.88339116615;11989.321494990709;12090.637280881587;12374.13381063335;686.7767975408012;695.8712638161957;708.3341658840674;727.0076345787961;727.9162896266891;5126.820561280338;5269.815556455583;5296.666633764047;5379.261413317707;5469.343678758574;92571;94816.52591736997;98706;100401;101185;82712.93217669606;83870.58064709637;84747.57626211953;87880;92058.53970730238;74000.25999740041;77802.61098694471;78706;78899.60550197327;79011.60494197607;11235.943820280847;11444.427778611203;11621.302721836717;11965.282083074695;12240.693982650506;33988;34576.48135277923;35807.28385432329;36079;36610.8169459151;60449.0932636002;66862.66568667126;66993;67926.32073679398;77039.61480192564;18302.908485457487;18455.630887382446;18866.24535018584;19000;19050.142743576296;20518;21029.053692584177;21500.569988600455;22026.669599955694;22118.778812211673;18647.627047458704;18691.25234990585;18901.716474252622;18952.905235473736;19065.80934190696;17060.31758729637;17931.37240196587;18006.5498362542;18441.26234950587;18609.627807443503;15983.120928348588;16334.836651633332;16413.753793692864;16567;16575.00549967006;12171.634850954486;12613.30626815534;12872.742545149233;12957.287349195885;13155.671108222372;12790.273313102613;12954.28751418681;13192.340382980621;13324.933375333061;13481.460741570227 02:56:51 INFO - PID 14597 | __end_tp_report 02:56:51 INFO - PID 14597 | __start_cc_report 02:56:51 INFO - PID 14597 | _x_x_mozilla_cycle_collect,341 02:56:51 INFO - PID 14597 | __end_cc_report 02:56:51 INFO - PID 14597 | __startTimestamp1500199011914__endTimestamp 02:56:51 INFO - PID 14597 | 02:56:51 INFO - PID 14597 | ------- Summary: start ------- 02:56:51 INFO - PID 14597 | Number of tests: 6 02:56:51 INFO - PID 14597 | 02:56:51 INFO - PID 14597 | [#0] dojo.html Cycles:165 Average:6059.80 Median:6310.43 stddev:711.45 (11.3%) stddev-sans-first:672.97 02:56:51 INFO - PID 14597 | Values: 3037.5 3077.6 3105.0 3117.4 3125.3 6064.7 6139.5 6156.2 6189.8 6272.5 6201.5 6232.4 6256.9 6264.3 6273.9 5686.9 5725.9 5730.7 5747.4 5804.1 5621.4 5721.7 5731.4 5735.0 5738.6 5527.2 5558.0 5597.8 5692.5 5728.9 5603.2 5680.4 5703.4 5705.2 5712.0 5487.6 5597.2 5637.0 5663.5 5664.7 5987.5 6012.2 6081.1 6089.1 6089.4 6497.6 6581.2 6609.4 6614.6 6627.3 6532.2 6543.7 6546.3 6561.7 6570.6 5998.9 6060.2 6073.5 6075.5 6080.6 6670.6 6680.8 6681.4 6685.9 6721.2 6347.7 6384.1 6386.5 6396.3 6396.5 6495.9 6501.9 6516.6 6602.3 6607.5 6531.9 6554.8 6630.2 6672.9 6676.0 6466.8 6484.4 6586.7 6684.3 6713.0 5347.3 5347.4 5358.4 5378.9 5410.9 4524.3 4573.4 4596.0 4640.5 4683.6 5658.7 5660.1 5723.8 5729.4 5735.4 6531.0 6595.7 6605.7 6687.3 6687.9 5681.0 5691.9 5705.9 5725.3 5726.5 5786.2 5808.7 5838.3 5845.9 5884.7 5436.8 6354.7 6372.7 6429.3 6502.4 6633.2 6643.4 6648.6 6715.2 6744.2 6310.4 6419.8 6425.5 6427.0 6490.6 6473.6 6486.3 6498.1 6498.5 6510.6 6646.2 6652.7 6657.2 6663.3 6669.6 6376.6 6387.7 6393.0 6403.6 6409.7 5480.8 6409.6 6415.7 6429.2 6522.9 6346.3 6355.9 6370.6 6440.8 6454.5 6369.7 6491.8 6539.9 6563.1 6564.1 6142.8 6164.6 6236.7 6244.7 6248.3 02:56:51 INFO - PID 14597 | 02:56:51 INFO - PID 14597 | [#1] ext.html Cycles:180 Average:39914.61 Median:37342.91 stddev:57834.73 (154.9%) stddev-sans-first:57922.44 02:56:51 INFO - PID 14597 | Values: 811.6 817.2 836.6 868.2 872.1 42065.4 42411.0 42723.8 42970.0 43026.8 37765.2 42581.8 43664.0 43806.0 43981.6 7789.0 7944.8 7945.3 7983.6 7997.0 7719.2 7785.6 7835.3 7880.6 7908.6 7845.8 7864.9 7933.5 7935.8 7947.0 7910.5 7917.8 7922.5 7927.3 7936.4 7714.1 7740.9 7759.0 7765.4 7767.7 39311.0 39613.2 39674.2 39677.8 39719.8 3574.1 3599.7 3601.0 3602.1 3604.6 32023.8 32212.7 32240.5 32350.5 32460.5 4650.3 4902.9 4943.5 4970.6 5064.6 206166.0 206917.0 225127.0 232914.0 234586.0 49655.8 49833.8 49955.3 50039.2 50069.2 52007.7 52164.2 52403.2 52643.5 52783.0 16291.0 16335.0 16396.8 16516.5 16750.3 13256.3 13304.7 13323.7 13365.2 13367.5 15075.8 15098.2 15278.0 15339.7 15502.5 5870.8 6019.7 6046.6 6123.7 6143.0 989.6 990.2 1012.5 1030.9 1031.0 22354.8 22436.9 22749.4 22882.2 22966.2 1076.3 1104.1 1126.5 1129.2 1135.1 11791.9 11874.8 12089.7 12093.0 12295.3 238101.0 239762.0 239959.0 240232.0 240445.0 57217.4 57623.0 57745.1 57784.7 57928.7 1488.0 1496.1 1505.8 1507.6 1510.3 22020.1 22426.9 22682.5 22867.0 23154.1 38678.8 38714.8 38762.2 38894.2 52515.0 204066.0 205159.0 206200.0 207084.0 207755.0 37112.8 37251.8 37310.8 37375.0 37784.8 48488.5 48999.5 49133.5 49563.0 49750.5 33149.0 33691.2 34739.5 34791.7 35178.3 33002.5 34162.0 34339.0 34423.7 34441.0 38881.8 39159.2 39274.6 39285.8 39383.2 31843.8 32679.1 32801.5 32902.7 33681.0 23785.8 23903.0 24136.5 24196.9 24235.4 02:56:51 INFO - PID 14597 | 02:56:51 INFO - PID 14597 | [#2] jquery.html Cycles:180 Average:34628.12 Median:12809.42 stddev:80713.38 (630.1%) stddev-sans-first:80899.28 02:56:51 INFO - PID 14597 | Values: 562.8 572.6 579.5 590.9 591.7 22441.1 23770.0 23792.9 23815.0 23832.4 25611.7 26798.7 28088.0 28155.2 28457.7 6357.7 6476.8 6540.2 6540.5 6551.1 6440.1 6485.9 6513.7 6523.2 6531.8 5971.0 6320.8 6474.0 6508.3 6520.4 6504.1 6549.1 6549.4 6549.4 6560.5 6023.3 6096.3 6103.1 6105.1 6105.8 30016.8 30488.0 30776.8 31205.2 31270.5 1896.9 1911.6 1927.6 1927.8 1928.5 19159.8 19748.0 19762.8 19778.2 19834.0 2316.0 2341.6 2404.2 2414.4 2418.4 140861.0 144205.0 144452.3 144565.0 145041.3 14350.2 15304.2 15441.7 15484.5 16028.4 24606.6 24620.3 24622.9 24653.9 24687.4 10274.3 10434.4 10556.2 10576.3 10601.1 9784.9 9788.7 9880.8 9913.8 9938.9 9167.7 9301.9 9548.5 9593.5 9676.1 2491.3 2545.1 2565.7 2632.0 2658.4 973.7 988.0 988.5 998.8 1011.9 19533.9 19645.0 19718.4 20055.7 20229.9 1014.9 1027.8 1032.8 1073.2 1074.5 10875.7 11006.5 11138.5 11156.6 11306.4 457787.0 468437.0 481294.0 484285.0 494765.0 108964.0 110491.4 112220.4 112229.0 112353.0 1186.8 1202.1 1236.1 1241.4 1242.1 16745.6 17664.5 17774.9 18248.7 18295.0 53161.0 54972.2 55539.2 57612.4 58031.0 70067.6 70837.3 71832.0 71988.3 72863.3 14558.3 14922.2 14930.6 14952.3 14953.9 21818.7 22891.1 23058.9 23302.9 23310.0 18570.6 18587.6 18623.3 18714.8 18942.5 15445.2 15918.2 16500.4 16708.5 16730.2 18414.2 18608.3 18935.6 18955.6 18971.9 14729.0 14752.7 14756.1 14760.6 14795.6 17738.0 17932.4 18124.4 18258.9 18526.2 02:56:51 INFO - PID 14597 | 02:56:51 INFO - PID 14597 | [#3] mootools.html Cycles:180 Average:8598.74 Median:2450.88 stddev:5795.82 (236.5%) stddev-sans-first:5786.50 02:56:51 INFO - PID 14597 | Values: 1352.9 1423.9 1440.9 1441.1 1444.0 13665.7 14095.2 14165.3 14167.6 14187.7 13699.6 14120.2 14128.7 14164.7 14180.7 2566.3 2638.7 2648.8 2649.4 2651.1 2562.6 2605.2 2606.1 2624.9 2635.9 2498.0 2560.1 2575.2 2578.5 2590.1 2474.8 2482.3 2487.2 2492.0 2495.2 2427.0 2447.0 2448.6 2453.1 2474.2 13470.9 13704.5 13766.7 13782.0 13782.4 7195.3 7442.6 7510.2 7518.5 7560.4 4810.7 4941.7 4969.5 5083.2 5124.6 1796.5 1803.9 1819.9 1849.3 1853.7 21062.5 21682.9 22695.9 22704.9 23007.3 5886.6 6098.5 6104.1 6351.4 6352.8 15647.4 15664.9 15666.5 15669.8 15700.1 7204.7 7384.4 7415.0 7429.6 7462.0 6923.2 6954.8 6958.8 6992.9 7026.1 4817.2 4900.7 4932.6 5061.7 5095.2 1493.6 1498.9 1500.6 1506.7 1507.3 896.4 899.7 931.9 932.9 936.7 7218.0 7229.8 7300.8 8455.5 8800.8 971.8 992.7 1023.7 1025.0 1040.1 4774.1 4811.0 5053.9 5338.4 5380.8 17582.5 18013.3 18825.9 18901.7 18954.5 18755.4 19214.2 19230.0 19254.9 19277.0 10663.6 10699.5 10963.9 10983.5 10983.6 7263.2 8409.0 8470.1 8545.6 8594.6 15522.8 15971.9 16390.5 16501.3 16619.9 15824.8 16780.4 16818.7 17043.7 17137.6 11102.9 11350.0 11365.8 11378.9 11401.8 13123.9 13270.9 13294.6 13315.7 13317.3 10443.2 10721.8 11015.4 11387.0 11442.7 10203.4 10206.3 10347.8 10430.3 10594.4 9574.6 9588.9 9625.9 9687.0 9702.9 6818.9 7071.8 7140.4 7149.8 7179.3 7102.1 7399.4 7420.5 7426.1 7461.8 02:56:51 INFO - PID 14597 | 02:56:51 INFO - PID 14597 | [#4] prototype.html Cycles:180 Average:5400.96 Median:5936.86 stddev:1513.45 (25.5%) stddev-sans-first:1472.18 02:56:51 INFO - PID 14597 | Values: 493.3 496.6 521.4 528.3 529.2 6044.6 6107.1 6127.5 6139.4 6161.9 5771.5 5939.5 5957.9 6046.4 6046.4 4850.0 4863.9 4922.6 4937.5 4955.7 4897.7 4911.3 4912.4 4915.8 4927.4 4809.9 4827.5 4861.1 4883.6 4897.5 4655.7 4769.0 4820.3 4876.6 4902.8 4344.8 4396.5 4397.6 4411.2 4421.2 5805.5 5857.7 5872.7 5896.4 5952.4 5558.7 5583.8 5589.0 5593.7 5692.6 6364.6 6406.0 6421.6 6426.7 6441.2 4799.6 4831.7 4849.7 4852.5 4857.7 6727.5 6732.2 6770.9 6806.9 6858.8 4903.0 4908.8 4912.8 4918.5 4926.6 4924.9 4975.2 4978.1 4992.5 4999.6 5502.4 5532.7 5542.4 5554.2 5592.6 6317.4 6325.4 6426.3 6462.6 6492.7 1742.7 1743.4 1750.5 1751.9 1759.9 1104.9 1181.2 1192.8 1195.2 1229.6 5470.9 5587.4 5616.3 5619.3 5625.5 6567.7 6576.6 6587.5 6686.4 6697.2 5567.3 5634.2 5659.7 5667.8 5696.9 3482.3 3484.5 3492.2 3501.4 3531.8 6334.3 6364.3 6372.3 6420.7 6484.2 6724.5 6742.4 6757.7 6787.5 6810.3 6342.4 6395.6 6448.9 6476.3 6478.5 6533.2 6615.8 6618.5 6623.4 6735.6 6387.5 6497.5 6533.3 6539.7 6560.8 6318.7 6332.8 6345.0 6431.4 6437.4 4902.8 4924.4 4936.3 4975.2 4989.4 6561.5 6634.8 6647.7 6657.9 6676.4 6401.4 6417.0 6423.7 6434.1 6444.3 6410.4 6472.3 6492.3 6524.4 6525.4 6149.1 6295.0 6375.6 6421.4 6423.1 5934.3 6343.2 6356.2 6393.3 6452.6 6096.5 6138.5 6142.8 6149.2 6176.0 02:56:51 INFO - PID 14597 | 02:56:51 INFO - PID 14597 | [#5] yui.html Cycles:180 Average:21895.43 Median:18956.31 stddev:29224.71 (154.2%) stddev-sans-first:29264.15 02:56:51 INFO - PID 14597 | Values: 895.9 898.7 911.2 917.5 918.1 16908.7 17192.5 17371.7 17531.5 17573.1 17830.9 18417.3 18876.2 18959.7 19190.4 1040.9 1042.0 1044.4 1045.0 1052.0 1043.4 1046.1 1053.2 1056.4 1056.9 994.7 1090.5 1095.4 1096.8 1102.0 1079.9 1083.3 1083.8 1087.3 1094.4 790.8 795.2 795.4 797.6 800.1 17746.4 17778.8 18095.9 18125.3 18216.5 17983.6 18215.9 18471.6 18508.8 18515.3 15051.1 15051.6 15115.4 15121.1 15157.1 3380.4 3482.6 3506.5 3527.6 3540.7 112937.0 117511.0 118000.4 120457.0 121027.8 14069.7 14230.3 14647.6 14708.0 14762.3 26274.5 26914.6 26994.0 27612.7 28117.6 7816.4 7863.6 7904.0 7997.8 8019.6 3854.0 3862.2 3922.0 3927.5 4000.5 4691.0 4841.8 4860.7 4870.4 4871.6 780.8 893.0 900.4 927.6 928.7 616.3 686.1 707.1 711.5 735.6 10493.3 11660.9 11989.3 12090.6 12374.1 686.8 695.9 708.3 727.0 727.9 5126.8 5269.8 5296.7 5379.3 5469.3 92571.0 94816.5 98706.0 100401.0 101185.0 82712.9 83870.6 84747.6 87880.0 92058.5 74000.3 77802.6 78706.0 78899.6 79011.6 11235.9 11444.4 11621.3 11965.3 12240.7 33988.0 34576.5 35807.3 36079.0 36610.8 60449.1 66862.7 66993.0 67926.3 77039.6 18302.9 18455.6 18866.2 19000.0 19050.1 20518.0 21029.1 21500.6 22026.7 22118.8 18647.6 18691.3 18901.7 18952.9 19065.8 17060.3 17931.4 18006.5 18441.3 18609.6 15983.1 16334.8 16413.8 16567.0 16575.0 12171.6 12613.3 12872.7 12957.3 13155.7 12790.3 12954.3 13192.3 13324.9 13481.5 02:56:51 INFO - PID 14597 | -------- Summary: end -------- 02:56:51 INFO - PID 14597 | 02:56:52 INFO - TEST-INFO | 14597: exit 0 02:56:52 INFO - TEST-OK | dromaeo_css | took 1110928ms 02:56:52 INFO - TEST-START | kraken 02:56:52 INFO - Initialising browser for kraken test... 02:56:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53681/getInfo.html -profile /tmp/tmpfoX5Hx/profile 02:56:52 INFO - TEST-INFO | started process 14998 (/builds/slave/test/build/application/firefox/firefox http://localhost:53681/getInfo.html) 02:56:58 INFO - TEST-INFO | 14998: exit 0 02:56:58 INFO - Browser initialized. 02:56:58 INFO - Running cycle 1/1 for kraken test... 02:56:58 INFO - TEST-INFO | started process 15204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfoX5Hx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:57:10 INFO - PID 15204 | RSS: Main: 167104512 02:57:10 INFO - PID 15204 | 02:57:12 INFO - PID 15204 | Cycle 1(1): loaded http://localhost:53681/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53681/tests/kraken/driver.html?testName=audio-beat-detection) 02:57:13 INFO - PID 15204 | RSS: Main: 173793280 02:57:13 INFO - PID 15204 | 02:57:16 INFO - PID 15204 | Cycle 1(1): loaded http://localhost:53681/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53681/tests/kraken/driver.html?testName=audio-dft) 02:57:16 INFO - PID 15204 | RSS: Main: 173961216 02:57:16 INFO - PID 15204 | 02:57:19 INFO - PID 15204 | Cycle 1(1): loaded http://localhost:53681/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53681/tests/kraken/driver.html?testName=audio-fft) 02:57:20 INFO - PID 15204 | RSS: Main: 168161280 02:57:20 INFO - PID 15204 | 02:57:22 INFO - PID 15204 | Cycle 1(1): loaded http://localhost:53681/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53681/tests/kraken/driver.html?testName=audio-oscillator) 02:57:23 INFO - PID 15204 | RSS: Main: 169709568 02:57:23 INFO - PID 15204 | 02:57:25 INFO - PID 15204 | Cycle 1(1): loaded http://localhost:53681/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53681/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:57:25 INFO - PID 15204 | RSS: Main: 170053632 02:57:25 INFO - PID 15204 | 02:57:28 INFO - PID 15204 | Cycle 1(1): loaded http://localhost:53681/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53681/tests/kraken/driver.html?testName=imaging-darkroom) 02:57:29 INFO - PID 15204 | RSS: Main: 173449216 02:57:29 INFO - PID 15204 | 02:57:32 INFO - PID 15204 | Cycle 1(1): loaded http://localhost:53681/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53681/tests/kraken/driver.html?testName=imaging-desaturate) 02:57:33 INFO - PID 15204 | RSS: Main: 174764032 02:57:33 INFO - PID 15204 | 02:57:36 INFO - PID 15204 | Cycle 1(1): loaded http://localhost:53681/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53681/tests/kraken/driver.html?testName=json-parse-financial) 02:57:36 INFO - PID 15204 | RSS: Main: 173293568 02:57:36 INFO - PID 15204 | 02:57:38 INFO - PID 15204 | Cycle 1(1): loaded http://localhost:53681/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53681/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:57:38 INFO - PID 15204 | RSS: Main: 173395968 02:57:38 INFO - PID 15204 | 02:57:40 INFO - PID 15204 | Cycle 1(1): loaded http://localhost:53681/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53681/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:57:41 INFO - PID 15204 | RSS: Main: 173195264 02:57:41 INFO - PID 15204 | 02:57:43 INFO - PID 15204 | Cycle 1(1): loaded http://localhost:53681/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53681/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:57:43 INFO - PID 15204 | RSS: Main: 173604864 02:57:43 INFO - PID 15204 | 02:57:46 INFO - PID 15204 | Cycle 1(1): loaded http://localhost:53681/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:57:47 INFO - PID 15204 | RSS: Main: 173924352 02:57:47 INFO - PID 15204 | 02:57:50 INFO - PID 15204 | Cycle 1(1): loaded http://localhost:53681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:57:51 INFO - PID 15204 | RSS: Main: 173760512 02:57:51 INFO - PID 15204 | 02:57:52 INFO - PID 15204 | Cycle 1(1): loaded http://localhost:53681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53681/tests/kraken/driver.html?testName=ai-astar) 02:57:53 INFO - PID 15204 | RSS: Main: 175128576 02:57:53 INFO - PID 15204 | 02:57:53 INFO - PID 15204 | __start_tp_report 02:57:53 INFO - PID 15204 | _x_x_mozilla_page_load 02:57:53 INFO - PID 15204 | _x_x_mozilla_page_load_details 02:57:53 INFO - PID 15204 | |i|pagename|runs| 02:57:53 INFO - PID 15204 | |0;ai-astar;100;108;110;107;108;112;108;109;110;109 02:57:53 INFO - PID 15204 | |1;audio-beat-detection;148;121;145;186;121;160;147;122;166;125 02:57:53 INFO - PID 15204 | |2;audio-dft;163;162;163;162;161;172;161;163;167;166 02:57:53 INFO - PID 15204 | |3;audio-fft;74;78;75;159;77;75;74;75;97;75 02:57:53 INFO - PID 15204 | |4;audio-oscillator;83;81;131;82;81;82;140;82;83;133 02:57:53 INFO - PID 15204 | |5;imaging-gaussian-blur;114;114;114;114;113;114;114;114;114;114 02:57:53 INFO - PID 15204 | |6;imaging-darkroom;149;151;149;150;149;150;150;150;149;150 02:57:53 INFO - PID 15204 | |7;imaging-desaturate;95;95;95;94;94;94;95;94;95;95 02:57:53 INFO - PID 15204 | |8;json-parse-financial;57;55;56;57;56;56;56;55;54;55 02:57:53 INFO - PID 15204 | |9;json-stringify-tinderbox;55;55;53;53;54;53;54;55;55;55 02:57:53 INFO - PID 15204 | |10;stanford-crypto-aes;85;76;85;77;77;80;75;76;85;84 02:57:53 INFO - PID 15204 | |11;stanford-crypto-ccm;136;128;127;125;127;140;130;125;128;151 02:57:53 INFO - PID 15204 | |12;stanford-crypto-pbkdf2;181;182;184;183;198;181;184;188;184;187 02:57:53 INFO - PID 15204 | |13;stanford-crypto-sha256-iterative;71;71;70;69;69;67;69;67;65;68 02:57:53 INFO - PID 15204 | __end_tp_report 02:57:53 INFO - PID 15204 | __start_cc_report 02:57:53 INFO - PID 15204 | _x_x_mozilla_cycle_collect,970 02:57:53 INFO - PID 15204 | __end_cc_report 02:57:53 INFO - PID 15204 | __startTimestamp1500199073014__endTimestamp 02:57:53 INFO - PID 15204 | 02:57:53 INFO - PID 15204 | ------- Summary: start ------- 02:57:53 INFO - PID 15204 | Number of tests: 14 02:57:53 INFO - PID 15204 | 02:57:53 INFO - PID 15204 | [#0] ai-astar Cycles:10 Average:108.10 Median:109.00 stddev:3.18 (2.9%) stddev-sans-first:1.50 02:57:53 INFO - PID 15204 | Values: 100.0 108.0 110.0 107.0 108.0 112.0 108.0 109.0 110.0 109.0 02:57:53 INFO - PID 15204 | 02:57:53 INFO - PID 15204 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:147.50 stddev:22.19 (15.0%) stddev-sans-first:23.49 02:57:53 INFO - PID 15204 | Values: 148.0 121.0 145.0 186.0 121.0 160.0 147.0 122.0 166.0 125.0 02:57:53 INFO - PID 15204 | 02:57:53 INFO - PID 15204 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:3.43 (2.1%) stddev-sans-first:3.62 02:57:53 INFO - PID 15204 | Values: 163.0 162.0 163.0 162.0 161.0 172.0 161.0 163.0 167.0 166.0 02:57:53 INFO - PID 15204 | 02:57:53 INFO - PID 15204 | [#3] audio-fft Cycles:10 Average:85.90 Median:75.00 stddev:26.60 (35.5%) stddev-sans-first:27.86 02:57:53 INFO - PID 15204 | Values: 74.0 78.0 75.0 159.0 77.0 75.0 74.0 75.0 97.0 75.0 02:57:53 INFO - PID 15204 | 02:57:53 INFO - PID 15204 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:82.00 stddev:25.55 (31.2%) stddev-sans-first:26.53 02:57:53 INFO - PID 15204 | Values: 83.0 81.0 131.0 82.0 81.0 82.0 140.0 82.0 83.0 133.0 02:57:53 INFO - PID 15204 | 02:57:53 INFO - PID 15204 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:57:53 INFO - PID 15204 | Values: 114.0 114.0 114.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 02:57:53 INFO - PID 15204 | 02:57:53 INFO - PID 15204 | [#6] imaging-darkroom Cycles:10 Average:149.70 Median:150.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 02:57:53 INFO - PID 15204 | Values: 149.0 151.0 149.0 150.0 149.0 150.0 150.0 150.0 149.0 150.0 02:57:53 INFO - PID 15204 | 02:57:53 INFO - PID 15204 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:57:53 INFO - PID 15204 | Values: 95.0 95.0 95.0 94.0 94.0 94.0 95.0 94.0 95.0 95.0 02:57:53 INFO - PID 15204 | 02:57:53 INFO - PID 15204 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:0.95 (1.7%) stddev-sans-first:0.88 02:57:53 INFO - PID 15204 | Values: 57.0 55.0 56.0 57.0 56.0 56.0 56.0 55.0 54.0 55.0 02:57:53 INFO - PID 15204 | 02:57:53 INFO - PID 15204 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:55.00 stddev:0.92 (1.7%) stddev-sans-first:0.93 02:57:53 INFO - PID 15204 | Values: 55.0 55.0 53.0 53.0 54.0 53.0 54.0 55.0 55.0 55.0 02:57:53 INFO - PID 15204 | 02:57:53 INFO - PID 15204 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:82.00 stddev:4.29 (5.2%) stddev-sans-first:4.16 02:57:53 INFO - PID 15204 | Values: 85.0 76.0 85.0 77.0 77.0 80.0 75.0 76.0 85.0 84.0 02:57:53 INFO - PID 15204 | 02:57:53 INFO - PID 15204 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:129.00 stddev:8.33 (6.5%) stddev-sans-first:8.69 02:57:53 INFO - PID 15204 | Values: 136.0 128.0 127.0 125.0 127.0 140.0 130.0 125.0 128.0 151.0 02:57:53 INFO - PID 15204 | 02:57:53 INFO - PID 15204 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.20 Median:184.00 stddev:5.05 (2.7%) stddev-sans-first:5.12 02:57:53 INFO - PID 15204 | Values: 181.0 182.0 184.0 183.0 198.0 181.0 184.0 188.0 184.0 187.0 02:57:53 INFO - PID 15204 | 02:57:53 INFO - PID 15204 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.90 (2.7%) stddev-sans-first:1.80 02:57:53 INFO - PID 15204 | Values: 71.0 71.0 70.0 69.0 69.0 67.0 69.0 67.0 65.0 68.0 02:57:53 INFO - PID 15204 | -------- Summary: end -------- 02:57:53 INFO - PID 15204 | 02:57:53 INFO - PID 15204 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 02:57:53 INFO - TEST-INFO | 15204: exit 0 02:57:53 INFO - TEST-OK | kraken | took 61290ms 02:57:53 INFO - SUITE-END | took 1172s 02:57:54 INFO - Completed test suite (00:19:32) 02:57:54 INFO - javascript benchmark 02:57:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8396.299312708761, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3037.498812695905, 3077.569140320355, 3105.037438394098, 3117.37652469506, 3125.2811853273747, 6064.696765161741, 6139.478144357729, 6156.168917196188, 6189.814305570829, 6272.466840318567, 6201.534884883629, 6232.407921247485, 6256.936320825459, 6264.342244064376, 6273.905891411621, 5686.943130568703, 5725.885482290351, 5730.68481233533, 5747.396523365049, 5804.129380592903, 5621.381648018714, 5721.6853073080965, 5731.430473247859, 5735.0250457422335, 5738.598298119134, 5527.226188333617, 5557.972210138923, 5597.776088956437, 5692.48767610917, 5728.8854222915725, 5603.2435621191025, 5680.375158732536, 5703.40114288002, 5705.229793977802, 5712.028955077605, 5487.6158668893195, 5597.188407680864, 5637.041702910515, 5663.461971112738, 5664.688442135681, 5987.461128498456, 6012.218411606507, 6081.087836824512, 6089.056196289582, 6089.421504957022, 6497.610143391412, 6581.177352830896, 6609.372109649576, 6614.636195009272, 6627.271000189975, 6532.150820393366, 6543.705533251015, 6546.312637173123, 6561.671916404161, 6570.63861487618, 5998.850028749316, 6060.2424696912885, 6073.544484163661, 6075.544334174866, 6080.635161890301, 6670.566413183127, 6680.766173184013, 6681.398674119256, 6685.866282674319, 6721.227058888193, 6347.682615869188, 6384.074309225136, 6386.489080873519, 6396.328385519453, 6396.456301214356, 6495.902561461582, 6501.934980650133, 6516.57642253252, 6602.339766023455, 6607.504437167232, 6531.8693626127215, 6554.836129096715, 6630.237522684953, 6672.899906501407, 6676.0, 6466.838329041811, 6484.351564843478, 6586.7035983380865, 6684.2981486944145, 6713.026611141455, 5347.2781174541715, 5347.385050719217, 5358.410574836765, 5378.892422151535, 5410.945890541044, 4524.343970124313, 4573.428321459817, 4595.965907670748, 4640.535946405333, 4683.555062269079, 5658.660480371191, 5660.122680984454, 5723.828285151452, 5729.369769325371, 5735.397783232784, 6531.0, 6595.70319335631, 6605.669716514251, 6687.297833727486, 6687.933120668828, 5680.971595141998, 5691.8861622768145, 5705.885882282331, 5725.341585717696, 5726.455986681259, 5786.247787787561, 5808.738606762706, 5838.299404071538, 5845.853853653608, 5884.735186916513, 5436.782528698887, 6354.714037868307, 6372.745090196433, 6429.292777794439, 6502.414782669583, 6633.237177724527, 6643.368879956396, 6648.601083934979, 6715.160604924385, 6744.156980377453, 6310.432061114522, 6419.839504012437, 6425.485961123192, 6427.003814408774, 6490.578112422678, 6473.611583305017, 6486.286508483969, 6498.057781621544, 6498.480121590167, 6510.641914694548, 6646.2356828965285, 6652.667366631552, 6657.234418041987, 6663.333666633298, 6669.566478178903, 6376.649284289409, 6387.712552935036, 6392.968035159794, 6403.583767055126, 6409.743610255724, 5480.753366098615, 6409.615423074631, 6415.743370265137, 6429.22849258092, 6522.902156467562, 6346.3019067903415, 6355.904661430175, 6370.554061215856, 6440.774572890114, 6454.451371633276, 6369.7452101915405, 6491.805245842632, 6539.901901471387, 6563.146790917151, 6564.146660934048, 6142.754289828356, 6164.599301045418, 6236.688165591611, 6244.656543889948, 6248.250209974832], "value": 6007.115494163417, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.5820352518454, 817.2236375443323, 836.598432752279, 868.2229404682811, 872.0712441250072, 42065.369019464735, 42411.0, 42723.78638106809, 42970.0, 43026.7848660757, 37765.244695106085, 42581.7870910645, 43664.0, 43806.0, 43981.56018439815, 7788.961055194716, 7944.801379965489, 7945.284924356807, 7983.600819958979, 7996.960395148622, 7719.150893401721, 7785.571793551352, 7835.294823465887, 7880.645370958292, 7908.565028923407, 7845.7646270611685, 7864.882026769603, 7933.484323518953, 7935.801604959865, 7947.0, 7910.525368477881, 7917.802054948644, 7922.4850384724805, 7927.28654421102, 7936.365090792723, 7714.07431108265, 7740.9225907740765, 7758.961205193994, 7765.417593680497, 7767.650455729506, 39311.0, 39613.20773584541, 39674.20651586952, 39677.80161099205, 39719.8014009931, 3574.088607405121, 3599.6760291573623, 3601.0277225149325, 3602.0814692253307, 3604.6034936157002, 32023.839880800446, 32212.677873221437, 32240.516392254136, 32350.514742278883, 32460.513092303634, 4650.255959046536, 4902.877428064291, 4943.456219815817, 4970.577500912426, 5064.620153488503, 206166.0, 206917.0, 225127.0, 232914.0, 234586.0, 49655.75172124116, 49833.75083124634, 49955.25067123996, 50039.24941125886, 50069.24896126561, 52007.73996129995, 52164.21753673698, 52403.213951790756, 52643.47356526462, 52783.0, 16291.0, 16335.0, 16396.83603163977, 16516.50450486487, 16750.329986800636, 13256.270905100118, 13304.667383315302, 13323.733525329439, 13365.198088114745, 13367.532136375181, 15075.773863392058, 15098.169600671848, 15278.0, 15339.693206135815, 15502.457413990456, 5870.765169393177, 6019.668918209541, 6046.637201767908, 6123.724432400552, 6143.0, 989.5744829723288, 990.1979396688705, 1012.4886932099242, 1030.9123724483352, 1030.9845352319721, 22354.776452235594, 22436.887815560818, 22749.43126421853, 22882.199123030947, 22966.19618313351, 1076.34343050739, 1104.100158370925, 1126.4930781148516, 1129.158776711339, 1135.0919264588297, 11791.941040294743, 11874.762504749857, 12089.697757555956, 12093.0, 12295.262284262973, 238101.0, 239762.0, 239959.0, 240232.0, 240445.0, 57217.427825721206, 57623.0, 57745.13382299269, 57784.71107644435, 57928.71035644795, 1488.0, 1496.064959400353, 1505.819301683805, 1507.5854140111558, 1510.3430007946579, 22020.128289094966, 22426.88786556057, 22682.546349073255, 22867.0, 23154.07383704633, 38678.80660596679, 38714.80642596769, 38762.224755505296, 38894.222115556964, 52515.0, 204066.0, 205159.0, 206200.0, 207084.0, 207755.0, 37112.81443592765, 37251.813740931124, 37310.813445932596, 37375.0, 37784.811075944446, 48488.51511484981, 48999.510004899494, 49133.50866491289, 49563.0, 49750.502494974586, 33149.0, 33691.15772105717, 34739.478907816905, 34791.65208347884, 35178.29643407066, 33002.51488682967, 34162.0, 34339.0, 34423.655763442046, 34441.0, 38881.80559097186, 39159.216815662956, 39274.60725392824, 39285.80357098196, 39383.2123357537, 31843.84078079595, 32679.050265711452, 32801.50797738084, 32902.67097328996, 33681.0, 23785.762142379048, 23903.043878244676, 24136.517269654156, 24196.87901560481, 24235.39411514726], "value": 17778.944099840905, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.8198976327577, 572.6420986883198, 579.4875375270543, 590.8522869282679, 591.7337198260782, 22441.102355905765, 23770.0, 23792.88103559482, 23815.0, 23832.40418989526, 25611.743882561168, 26798.732012679866, 28088.0, 28155.155345339623, 28457.715422845766, 6357.713902874359, 6476.838079048014, 6540.215174179105, 6540.4767618590395, 6551.115599394092, 6440.1305823713665, 6485.935140648604, 6513.706883190268, 6523.18460192476, 6531.804045878631, 5970.97014514929, 6320.810375688737, 6473.967630161843, 6508.316626754194, 6520.4457621102265, 6504.089427480157, 6549.1158693576235, 6549.377809108127, 6549.377809108127, 6560.507961902877, 6023.307319658208, 6096.268447786294, 6103.084537319393, 6105.084237364386, 6105.786297479612, 30016.84991575028, 30488.0, 30776.846115769502, 31205.219869503217, 31270.530942035886, 1896.8672192946499, 1911.5985643014983, 1927.6433859735994, 1927.7686677598779, 1928.517870532367, 19159.80840191608, 19748.0, 19762.802371976384, 19778.208871645118, 19834.0, 2315.9652605210936, 2341.6487526870937, 2404.2426635609727, 2414.360194548446, 2418.4316685578874, 140861.0, 144205.0, 144452.27773861168, 144565.0, 145041.27479362534, 14350.21073840928, 15304.234788260543, 15441.691166176613, 15484.458043968632, 16028.358865645478, 24606.630900536507, 24620.261392158263, 24622.876885615457, 24653.87673061659, 24687.38281542976, 10274.33216840903, 10434.426106564211, 10556.208284378703, 10576.259661823598, 10601.098906592872, 9784.853227201598, 9788.657396991071, 9880.752981175528, 9913.801723965624, 9938.850917236246, 9167.724968250963, 9301.90698093024, 9548.519979403065, 9593.520323983774, 9676.080772326617, 2491.3183601069204, 2545.121932933135, 2565.7177710451833, 2631.9998400607647, 2658.428437885864, 973.6543527047796, 987.9625852179215, 988.5304480371766, 998.770282834952, 1011.9342242754344, 19533.902330488258, 19645.0, 19718.35198524475, 20055.699164512545, 20229.898850505655, 1014.878214614251, 1027.8355463125863, 1032.8456544908381, 1073.2058276875057, 1074.521837782195, 10875.673729788119, 11006.504707288192, 11138.49876755548, 11156.553737850558, 11306.378149201873, 457787.0, 468437.0, 481294.0, 484285.0, 494765.0, 108964.0, 110491.44754276177, 112220.43889780498, 112229.0, 112353.0, 1186.8157130952025, 1202.1464760020483, 1236.0729452910318, 1241.4227384266178, 1242.142921384242, 16745.581360466087, 17664.470065898044, 17774.934143768965, 18248.726269105708, 18295.0, 53161.0, 54972.17541736957, 55539.16691249554, 57612.42387576238, 58031.0, 70067.64966175136, 70837.29162708308, 71832.0, 71988.28011719816, 72863.27136728565, 14558.344874480463, 14922.179280139697, 14930.552083437515, 14952.252387380806, 14953.925230373778, 21818.672719909533, 22891.08435662555, 23058.884705576365, 23302.883485582464, 23310.0, 18570.628587428448, 18587.628247435245, 18623.348182813537, 18714.81285187185, 18942.526436838638, 15445.150516721238, 15918.204089795696, 16500.42248521296, 16708.49874503767, 16730.247138878538, 18414.17136228846, 18608.34870779516, 18935.621287574446, 18955.62088758245, 18971.90514047421, 14729.04261223017, 14752.704945901236, 14756.114633122046, 14760.557183284518, 14795.630109246924, 17738.0, 17932.372366967094, 18124.365647202285, 18258.908705456386, 18526.16632251579], "value": 12051.01446654729, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.9458821647133, 1423.864732850379, 1440.920749358785, 1441.1353188087148, 1443.9927800360997, 13665.65835854103, 14095.15429074255, 14165.29173541324, 14167.574972750808, 14187.716245675081, 13699.589012329647, 14120.152790832557, 14128.71742565148, 14164.71670566588, 14180.71638567228, 2566.345581876619, 2638.7229340919216, 2648.8410695358243, 2649.350909027291, 2651.098626467001, 2562.6027965665353, 2605.1793684989166, 2606.087869245758, 2624.93437664058, 2635.9077432289873, 2497.987510062447, 2560.0527804712283, 2575.214559559334, 2578.471413360266, 2590.080521414899, 2474.8391354561986, 2482.2677310193444, 2487.2413913756295, 2492.003198720508, 2495.214007587604, 2427.0291883246664, 2447.0, 2448.644946482768, 2453.116877923946, 2474.1587860127643, 13470.932645336808, 13704.52034178809, 13766.724665506634, 13782.0, 13782.379792909343, 7195.280471952763, 7442.590657513834, 7510.211427800112, 7518.548887066793, 7560.432967527458, 4810.687305325143, 4941.654084214107, 4969.478204788517, 5083.161278389061, 5124.564412024983, 1796.4700413378084, 1803.8906072765285, 1819.9363022294156, 1849.260295881658, 1853.7034074548142, 21062.473438164016, 21682.891585542286, 22695.886520567292, 22704.886475567517, 23007.309780706604, 5886.61736987103, 6098.481629061491, 6104.053871649901, 6351.428371446592, 6352.841178970562, 15647.374105035899, 15664.903456757918, 15666.530004099895, 15669.843301567067, 15700.057996520245, 7204.711811527585, 7384.372328352043, 7415.036045314183, 7429.591372474458, 7462.0, 6923.169219693669, 6954.826129346807, 6958.756443524452, 6992.916098004817, 7026.051483049723, 4817.156997525489, 4900.730459824744, 4932.605391568666, 5061.721605311744, 5095.235714642759, 1493.5668656089829, 1498.88008959283, 1500.6323450754635, 1506.6610012747044, 1507.2614418934643, 896.4442045931434, 899.7030979776658, 931.9021502742114, 932.8927173375013, 936.6628013914985, 7218.025566548554, 7229.783106506813, 7300.817479563053, 8455.492670439793, 8800.77998050041, 971.834788086013, 992.6525715999343, 1023.7184774187009, 1024.9846252306222, 1040.089921318846, 4774.114224881222, 4810.95189048112, 5053.949460505348, 5338.412774594792, 5380.784768609212, 17582.472525824247, 18013.27946882136, 18825.90587047056, 18901.7164742529, 18954.526136846413, 18755.437336879917, 19214.231430742893, 19230.0, 19254.903725481283, 19277.036148192536, 10663.573457061631, 10699.465026748787, 10963.945180274048, 10983.505742241618, 10983.560657573767, 7263.208899678817, 8409.0, 8470.068292487944, 8545.572721363782, 8594.570271486276, 15522.767158492406, 15971.920140399223, 16390.508284751475, 16501.257443414834, 16619.91690041542, 15824.841751582337, 16780.412685555948, 16818.747718784474, 17043.659126817147, 17137.571560711083, 11102.88897111051, 11350.035247004098, 11365.829512557153, 11378.886211138113, 11401.771964560829, 13123.868761312264, 13270.933645331712, 13294.601161965156, 13315.733685326046, 13317.267550284827, 10443.216758742972, 10721.839172412576, 11015.394153321644, 11387.0, 11442.656720298404, 10203.438810865176, 10206.336588121749, 10347.84478232812, 10430.322029068086, 10594.417307048187, 9574.617015319309, 9588.904110958802, 9625.855612165684, 9686.951565242129, 9702.85445718329, 6818.93181068183, 7071.82320441993, 7140.428765698835, 7149.785506434815, 7179.317964793337, 7102.14774227096, 7399.445041621792, 7420.5176663516695, 7426.14599321085, 7461.813454663677], "value": 6307.180527452478, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.32660917847136, 496.63497329462837, 521.3925776470412, 528.3263838605777, 529.2458246998027, 6044.5546038757875, 6107.1449997000345, 6127.479164271032, 6139.386061393859, 6161.938380616192, 5771.451712087355, 5939.46544810968, 5957.910631340523, 6046.365131661179, 6046.425589568984, 4849.951500484985, 4863.862808488523, 4922.630802689795, 4937.481564435737, 4955.702657840541, 4897.706137631753, 4911.287863259825, 4912.410510738717, 4915.778789954443, 4927.384076990376, 4809.879753006167, 4827.517248275162, 4861.124997500448, 4883.584895283905, 4897.461279259279, 4655.720656760605, 4768.952310476886, 4820.276958456225, 4876.585490233334, 4902.779374928136, 4344.826206951718, 4396.538363471854, 4397.604215620578, 4411.205982923073, 4421.204183247014, 5805.5065319447895, 5857.736401861926, 5872.677002764846, 5896.410358964112, 5952.434518720715, 5558.722063896789, 5583.776648934037, 5589.049861523551, 5593.664380137164, 5692.57305702074, 6364.554481186319, 6406.0, 6421.550491465599, 6426.678666066725, 6441.227052753699, 4799.640026997954, 4831.734254615994, 4849.684770489906, 4852.4662287148385, 4857.73282469464, 6727.529072964894, 6732.158480189976, 6770.864582708367, 6806.931930680679, 6858.787321635543, 4902.989774192564, 4908.779104940286, 4912.806675660849, 4918.483559226302, 4926.556609905054, 4924.876878078005, 4975.154223781966, 4978.054169707744, 4992.500749924979, 4999.625028122905, 5502.394736578973, 5532.723363831873, 5542.448114527939, 5554.166874968787, 5592.552595792326, 6317.368263173646, 6325.367463253638, 6426.260979987362, 6462.579932304385, 6492.675366231764, 1742.6601812646666, 1743.4072415378832, 1750.492357216393, 1751.9474415767547, 1759.8504127149079, 1104.861892263467, 1181.220394539617, 1192.8151136573845, 1195.1514424758518, 1229.5757963502576, 5470.948394352118, 5587.357453892773, 5616.326040875121, 5619.325680918234, 5625.46558076982, 6567.704453299518, 6576.638284894377, 6587.50593705474, 6686.398224159849, 6697.162854643169, 5567.276254086943, 5634.211210430543, 5659.660420374791, 5667.773289068391, 5696.8860622787315, 3482.2513159670793, 3484.53288977464, 3492.231709024011, 3501.3697534443536, 3531.823408829548, 6334.271558770708, 6364.331745166784, 6372.330905254974, 6420.711068001951, 6484.1894763154605, 6724.462043036546, 6742.426893713991, 6757.695903684346, 6787.524873258824, 6810.284920083419, 6342.429181373698, 6395.584287021329, 6448.903266451007, 6476.287608363171, 6478.514111441661, 6533.216014078341, 6615.801525954229, 6618.536702430783, 6623.437007854386, 6735.5621884579305, 6387.5209359297305, 6497.480201583768, 6533.314002029909, 6539.738410463528, 6560.8359791003695, 6318.652474113784, 6332.810015699536, 6345.0, 6431.389018043278, 6437.420632143129, 4902.837669703093, 4924.433690125681, 4936.272304693329, 4975.203967365204, 4989.401271847401, 6561.475081993333, 6634.767783127568, 6647.734090636321, 6657.901446261312, 6676.431038705803, 6401.423871851555, 6417.0, 6423.710933008119, 6434.131392261985, 6444.258910225384, 6410.391012853958, 6472.320406357453, 6492.285848556749, 6524.380183882524, 6525.445337146396, 6149.139120523041, 6295.0, 6375.557199112427, 6421.357864213728, 6423.132877061724, 5934.258217722785, 6343.238811342484, 6356.173697419306, 6393.328700486568, 6452.580582262138, 6096.481799046954, 6138.478229350555, 6142.754289828356, 6149.2313460817395, 6175.96912015437], "value": 4957.973761805833, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [895.8835351404317, 898.680968256269, 911.2482202183193, 917.5320586500883, 918.132364915155, 16908.746368804463, 17192.48422547324, 17371.73942390865, 17531.474055778315, 17573.121343932817, 17830.910845445756, 18417.26330946764, 18876.150573224204, 18959.71560426591, 19190.42428727137, 1040.9479526023706, 1041.9947900260488, 1044.3994703045742, 1044.9529771160296, 1052.0268751404958, 1043.4417586591176, 1046.1160319529986, 1053.2416660004822, 1056.4453661827524, 1056.9207309451783, 994.7413672445144, 1090.514720949178, 1095.3756358875444, 1096.7587130831205, 1101.9751630983183, 1079.8542196803448, 1083.3012706804068, 1083.8482612434266, 1087.33129125588, 1094.4035500652165, 790.8260182759784, 795.1928792275845, 795.4431897671653, 797.5932274539969, 800.1238643685156, 17746.37887673925, 17778.822211777846, 18095.909520452446, 18125.274989000423, 18216.453506394828, 17983.550411239692, 18215.908920455313, 18471.63056738871, 18508.814911850845, 18515.2593896244, 15051.096934183985, 15051.623709407242, 15115.39538418462, 15121.09273443597, 15157.09057456545, 3380.4084285249983, 3482.6343233960324, 3506.5441492605796, 3527.576690797095, 3540.6813386795056, 112937.0, 117511.0, 118000.40999794946, 120457.0, 121027.78972210253, 14069.71860562783, 14230.288485575888, 14647.633809154644, 14707.970442068952, 14762.261886905611, 26274.474510510066, 26914.5962810558, 26994.0, 27612.723872761017, 28117.57823632647, 7816.374690024784, 7863.606819658994, 7904.0, 7997.8400431992195, 8019.558924259105, 3853.9807300963316, 3862.1696335288048, 3921.980285125831, 3927.509061367329, 4000.4799376081505, 4690.95309046912, 4841.830535931296, 4860.659753817199, 4870.366852309177, 4871.610271178297, 780.7813812132612, 892.9680011522255, 900.4147304252289, 927.6104036304769, 928.6563971330651, 616.3251239892311, 686.1183379357502, 707.1231672725886, 711.4877288352378, 735.5990984913235, 10493.26547141708, 11660.88339116615, 11989.321494990709, 12090.637280881587, 12374.13381063335, 686.7767975408012, 695.8712638161957, 708.3341658840674, 727.0076345787961, 727.9162896266891, 5126.820561280338, 5269.815556455583, 5296.666633764047, 5379.261413317707, 5469.343678758574, 92571.0, 94816.52591736997, 98706.0, 100401.0, 101185.0, 82712.93217669606, 83870.58064709637, 84747.57626211953, 87880.0, 92058.53970730238, 74000.25999740041, 77802.61098694471, 78706.0, 78899.60550197327, 79011.60494197607, 11235.943820280847, 11444.427778611203, 11621.302721836717, 11965.282083074695, 12240.693982650506, 33988.0, 34576.48135277923, 35807.28385432329, 36079.0, 36610.8169459151, 60449.0932636002, 66862.66568667126, 66993.0, 67926.32073679398, 77039.61480192564, 18302.908485457487, 18455.630887382446, 18866.24535018584, 19000.0, 19050.142743576296, 20518.0, 21029.053692584177, 21500.569988600455, 22026.669599955694, 22118.778812211673, 18647.627047458704, 18691.25234990585, 18901.716474252622, 18952.905235473736, 19065.80934190696, 17060.31758729637, 17931.37240196587, 18006.5498362542, 18441.26234950587, 18609.627807443503, 15983.120928348588, 16334.836651633332, 16413.753793692864, 16567.0, 16575.00549967006, 12171.634850954486, 12613.30626815534, 12872.742545149233, 12957.287349195885, 13155.671108222372, 12790.273313102613, 12954.28751418681, 13192.340382980621, 13324.933375333061, 13481.460741570227], "value": 8704.897880072424, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 108.0, 110.0, 107.0, 108.0, 112.0, 108.0, 109.0, 110.0, 109.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 121.0, 145.0, 186.0, 121.0, 160.0, 147.0, 122.0, 166.0, 125.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 162.0, 161.0, 172.0, 161.0, 163.0, 167.0, 166.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 75.0, 159.0, 77.0, 75.0, 74.0, 75.0, 97.0, 75.0], "value": 85.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 131.0, 82.0, 81.0, 82.0, 140.0, 82.0, 83.0, 133.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 149.0, 150.0, 149.0, 150.0, 150.0, 150.0, 149.0, 150.0], "value": 149.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 57.0, 56.0, 56.0, 56.0, 55.0, 54.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 53.0, 54.0, 53.0, 54.0, 55.0, 55.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 76.0, 85.0, 77.0, 77.0, 80.0, 75.0, 76.0, 85.0, 84.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 128.0, 127.0, 125.0, 127.0, 140.0, 130.0, 125.0, 128.0, 151.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 182.0, 184.0, 183.0, 198.0, 181.0, 184.0, 188.0, 184.0, 187.0], "value": 185.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 70.0, 69.0, 69.0, 67.0, 69.0, 67.0, 65.0, 68.0], "value": 68.6, "unit": "score"}]}]} 02:57:54 INFO - Return code: 0 02:57:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:57:54 INFO - # TBPL SUCCESS # 02:57:54 INFO - Running post-action listener: _package_coverage_data 02:57:54 INFO - Running post-action listener: _resource_record_post_action 02:57:54 INFO - [mozharness: 2017-07-16 09:57:54.280819Z] Finished run-tests step (success) 02:57:54 INFO - Running post-run listener: _resource_record_post_run 02:57:54 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 892928; Write bytes: 440696832; Read time: 516; Write time: 473812 02:57:54 INFO - TinderboxPrint: CPU usage
13.1% 02:57:54 INFO - TinderboxPrint: I/O read bytes / time
892,928 / 516 02:57:54 INFO - TinderboxPrint: I/O write bytes / time
440,696,832 / 473,812 02:57:54 INFO - TinderboxPrint: CPU idle
8,254.9 (86.9%) 02:57:54 INFO - TinderboxPrint: CPU user
1,195.6 (12.6%) 02:57:54 INFO - TinderboxPrint: Swap in / out
0 / 0 02:57:54 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 4096; Write bytes: 112930816; Read time: 96; Write time: 123024 02:57:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:57:54 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 884736; Write bytes: 326160384; Read time: 392; Write time: 350664 02:57:54 INFO - Running post-run listener: _upload_blobber_files 02:57:54 INFO - Blob upload gear active. 02:57:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:57:54 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 02:57:54 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:57:54 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:57:55 INFO - Traceback (most recent call last): 02:57:55 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 02:57:55 INFO - main() 02:57:55 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 02:57:55 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 02:57:55 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 02:57:55 INFO - return set(response.json().get('whitelist', [])) 02:57:55 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 02:57:55 INFO - return json.loads(self.text or self.content, **kwargs) 02:57:55 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 02:57:55 INFO - return _default_decoder.decode(s) 02:57:55 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 02:57:55 INFO - obj, end = self.raw_decode(s) 02:57:55 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 02:57:55 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 02:57:55 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 02:57:55 ERROR - Return code: 1 02:57:55 INFO - Setting buildbot property blobber_files to {} 02:57:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:57:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:57:55 INFO - Contents: 02:57:55 INFO - blobber_files:{} 02:57:55 INFO - Running post-run listener: copy_logs_to_upload_dir 02:57:55 INFO - Copying logs to upload dir... 02:57:55 INFO - mkdir: /builds/slave/test/build/upload/logs 02:57:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.626136 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-07-16 02:57:55.299792) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 02:57:55.307575) ========= 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=32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/ZGq1huidQie8517Ftoc8WQ/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 02:57:55.368063) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:57:55.368566) ========= 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=32c5991c409366f7fec8a718000001d2-1500196062.419079-839958958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004367 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:57:55.419453) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 02:57:55.419844) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 02:57:55.423236) ========= ========= Total master_lag: 0.19 =========