builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-022 starttime: 1495829475.65 results: success (0) revision: ba1a33add29df1cff5931c5bd82725b8ed4990e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 13:11:15.653832) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 13:11:15.654304) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 13:11:15.654588) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 13:11:15.738884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 13:11:15.739203) ========= 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=930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-26 13:11:15-- 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% 21.2M=0.001s 2017-05-26 13:11:15 (21.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105506 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 13:11:15.958838) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 13:11:15.959195) ========= 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=930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014617 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 13:11:16.030760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-26 13:11:16.031129) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ba1a33add29df1cff5931c5bd82725b8ed4990e5 --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 ba1a33add29df1cff5931c5bd82725b8ed4990e5 --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=930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-26 13:11:16,150 truncating revision to first 12 chars 2017-05-26 13:11:16,150 Setting DEBUG logging. 2017-05-26 13:11:16,150 attempt 1/10 2017-05-26 13:11:16,150 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ba1a33add29d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-26 13:11:17,606 unpacking tar archive at: mozilla-central-ba1a33add29d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.760113 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-26 13:11:17.808490) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 13:11:17.808837) ========= script_repo_revision: ba1a33add29df1cff5931c5bd82725b8ed4990e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 13:11:17.809300) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 13:11:17.809609) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 13:11:17.822055) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-05-26 13:11:17.822489) ========= /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=930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:11:18 INFO - MultiFileLogger online at 20170526 13:11:18 in /builds/slave/test 13:11:18 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 13:11:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:11:18 INFO - {'append_to_log': False, 13:11:18 INFO - 'base_work_dir': '/builds/slave/test', 13:11:18 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:11:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:11:18 INFO - 'branch': 'Firefox-Non-PGO', 13:11:18 INFO - 'buildbot_json_path': 'buildprops.json', 13:11:18 INFO - 'config_files': ('talos/linux_config.py',), 13:11:18 INFO - 'default_actions': ('clobber', 13:11:18 INFO - 'read-buildbot-config', 13:11:18 INFO - 'download-and-extract', 13:11:18 INFO - 'populate-webroot', 13:11:18 INFO - 'create-virtualenv', 13:11:18 INFO - 'install', 13:11:18 INFO - 'run-tests'), 13:11:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:11:18 INFO - 'download_minidump_stackwalk': True, 13:11:18 INFO - 'download_symbols': 'ondemand', 13:11:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:11:18 INFO - 'tooltool.py': '/tools/tooltool.py', 13:11:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:11:18 INFO - '/tools/misc-python/virtualenv.py')}, 13:11:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:11:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:11:18 INFO - 'gecko_profile': False, 13:11:18 INFO - 'gecko_profile_interval': 0, 13:11:18 INFO - 'installer_path': 'installer.exe', 13:11:18 INFO - 'log_level': 'info', 13:11:18 INFO - 'log_name': 'talos', 13:11:18 INFO - 'log_to_console': True, 13:11:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:11:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:11:18 INFO - 'opt_config_files': (), 13:11:18 INFO - 'pip_index': False, 13:11:18 INFO - 'suite': 'dromaeojs-e10s', 13:11:18 INFO - 'system_bits': '32', 13:11:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:11:18 INFO - 'title': 'talos-linux64-ix-022', 13:11:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:11:18 INFO - 'use_talos_json': True, 13:11:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:11:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:11:18 INFO - 'work_dir': 'build'} 13:11:18 INFO - [mozharness: 2017-05-26 20:11:18.048977Z] Running clobber step. 13:11:18 INFO - Running pre-action listener: _resource_record_pre_action 13:11:18 INFO - Running main action method: clobber 13:11:18 INFO - rmtree: /builds/slave/test/build 13:11:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:11:19 INFO - Running post-action listener: _resource_record_post_action 13:11:19 INFO - [mozharness: 2017-05-26 20:11:19.062278Z] Finished clobber step (success) 13:11:19 INFO - [mozharness: 2017-05-26 20:11:19.062379Z] Running read-buildbot-config step. 13:11:19 INFO - Running pre-action listener: _resource_record_pre_action 13:11:19 INFO - Running main action method: read_buildbot_config 13:11:19 INFO - Using buildbot properties: 13:11:19 INFO - { 13:11:19 INFO - "project": "", 13:11:19 INFO - "product": "firefox", 13:11:19 INFO - "who": "ryanvm@gmail.com", 13:11:19 INFO - "installer_path": "public/build/target.tar.bz2", 13:11:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:11:19 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 13:11:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 13:11:19 INFO - "stage_platform": "linux64", 13:11:19 INFO - "basedir": "/builds/slave/test", 13:11:19 INFO - "buildnumber": 857, 13:11:19 INFO - "platform": "ubuntu64_hw", 13:11:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:11:19 INFO - "slavebuilddir": "test", 13:11:19 INFO - "taskId": "FeFgPVQdSl2RdyD2RE3SKw", 13:11:19 INFO - "branch": "mozilla-central", 13:11:19 INFO - "script_repo_revision": "production", 13:11:19 INFO - "revision": "ba1a33add29df1cff5931c5bd82725b8ed4990e5", 13:11:19 INFO - "slavename": "talos-linux64-ix-022", 13:11:19 INFO - "repo_path": "mozilla-central" 13:11:19 INFO - } 13:11:19 INFO - Finding installer, test and symbols from parent task. 13:11:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FeFgPVQdSl2RdyD2RE3SKw'}, attempt #1 13:11:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FeFgPVQdSl2RdyD2RE3SKw'}, attempt #1 13:11:19 INFO - Task dependencies: a5Q6EXKFRRuOf_lZx3w97w 13:11:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w'}, attempt #1 13:11:20 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.tar.bz2 13:11:20 INFO - Set test_url: https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/test_packages.json 13:11:20 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.crashreporter-symbols.zip 13:11:20 INFO - Running post-action listener: _resource_record_post_action 13:11:20 INFO - [mozharness: 2017-05-26 20:11:20.456414Z] Finished read-buildbot-config step (success) 13:11:20 INFO - [mozharness: 2017-05-26 20:11:20.456636Z] Running download-and-extract step. 13:11:20 INFO - Running pre-action listener: _resource_record_pre_action 13:11:20 INFO - Running main action method: download_and_extract 13:11:20 INFO - mkdir: /builds/slave/test/build/tests 13:11:20 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')]} 13:11:20 INFO - trying https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.test_packages.json 13:11:20 INFO - Downloading https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:11:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:11:21 INFO - Downloaded 986 bytes. 13:11:21 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:11:21 INFO - Using the following test package requirements: 13:11:21 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:11:21 INFO - u'common': [u'target.common.tests.zip'], 13:11:21 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:11:21 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:11:21 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:11:21 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:11:21 INFO - u'mozbase': [u'target.common.tests.zip'], 13:11:21 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:11:21 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:11:21 INFO - u'web-platform': [u'target.common.tests.zip', 13:11:21 INFO - u'target.web-platform.tests.zip'], 13:11:21 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:11:21 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:11:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.common.tests.zip 13:11:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:11:21 INFO - Fetch https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.common.tests.zip into memory 13:11:23 INFO - Content-Length response header: 63525249 13:11:23 INFO - Bytes received: 63525249 13:11:34 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:11:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.common.tests.zip 13:11:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:11:34 INFO - Fetch https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.common.tests.zip into memory 13:11:35 INFO - Content-Length response header: 63525249 13:11:35 INFO - Bytes received: 63525249 13:11:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.talos.tests.zip 13:11:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:11:49 INFO - Fetch https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.talos.tests.zip into memory 13:11:50 INFO - Content-Length response header: 14411888 13:11:50 INFO - Bytes received: 14411888 13:11: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')]} 13:11:50 INFO - trying https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.tar.bz2 13:11:50 INFO - Downloading https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:11:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:11:51 INFO - Downloaded 54048516 bytes. 13:11:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.tar.bz2 13:11:51 INFO - mkdir: /builds/slave/test/properties 13:11:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:11:51 INFO - Writing to file /builds/slave/test/properties/build_url 13:11:51 INFO - Contents: 13:11:51 INFO - build_url:https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.tar.bz2 13:11:51 INFO - Running post-action listener: _resource_record_post_action 13:11:51 INFO - Running post-action listener: set_extra_try_arguments 13:11:51 INFO - [mozharness: 2017-05-26 20:11:51.337630Z] Finished download-and-extract step (success) 13:11:51 INFO - [mozharness: 2017-05-26 20:11:51.337727Z] Running populate-webroot step. 13:11:51 INFO - Running pre-action listener: _resource_record_pre_action 13:11:51 INFO - Running main action method: populate_webroot 13:11:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:11:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:11:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:11:51 INFO - '--tppagecycles', 13:11:51 INFO - '7'], 13:11:51 INFO - 'tests': ['tsvgm']}}, 13:11:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:11:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:11:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:11:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:11:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:11:51 INFO - 'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:11:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:11:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:11:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:11:51 INFO - 'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['damp', 'tps']}, 13:11:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:11:51 INFO - 'tests': ['damp', 'tps']}, 13:11:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['dromaeo_dom']}, 13:11:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:11:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 13:11:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:11:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:11:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:11:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['a11yr', 13:11:51 INFO - 'ts_paint', 13:11:51 INFO - 'tpaint', 13:11:51 INFO - 'sessionrestore', 13:11:51 INFO - 'sessionrestore_no_auto_restore', 13:11:51 INFO - 'tabpaint']}, 13:11:51 INFO - 'other-e10s': {'tests': ['a11yr', 13:11:51 INFO - 'ts_paint', 13:11:51 INFO - 'tpaint', 13:11:51 INFO - 'sessionrestore', 13:11:51 INFO - 'sessionrestore_no_auto_restore', 13:11:51 INFO - 'tabpaint']}, 13:11:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:11:51 INFO - 'ts_paint', 13:11:51 INFO - 'tpaint', 13:11:51 INFO - 'sessionrestore', 13:11:51 INFO - 'sessionrestore_no_auto_restore', 13:11:51 INFO - 'tabpaint']}, 13:11:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:11:51 INFO - 'ts_paint', 13:11:51 INFO - 'tpaint', 13:11:51 INFO - 'sessionrestore', 13:11:51 INFO - 'sessionrestore_no_auto_restore', 13:11:51 INFO - 'tabpaint']}, 13:11:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['a11yr', 13:11:51 INFO - 'ts_paint', 13:11:51 INFO - 'tpaint', 13:11:51 INFO - 'sessionrestore', 13:11:51 INFO - 'sessionrestore_no_auto_restore', 13:11:51 INFO - 'tabpaint']}, 13:11:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['a11yr', 13:11:51 INFO - 'ts_paint', 13:11:51 INFO - 'tpaint', 13:11:51 INFO - 'sessionrestore', 13:11:51 INFO - 'sessionrestore_no_auto_restore', 13:11:51 INFO - 'tabpaint']}, 13:11:51 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 13:11:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 13:11:51 INFO - 'bloom_basic_ref']}, 13:11:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['tsvgx', 13:11:51 INFO - 'tsvgr_opacity', 13:11:51 INFO - 'tart', 13:11:51 INFO - 'tscrollx', 13:11:51 INFO - 'cart', 13:11:51 INFO - 'tsvg_static']}, 13:11:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:11:51 INFO - 'tsvgr_opacity', 13:11:51 INFO - 'tart', 13:11:51 INFO - 'tscrollx', 13:11:51 INFO - 'cart', 13:11:51 INFO - 'tsvg_static']}, 13:11:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:11:51 INFO - 'talos_options': ['--disable-e10s'], 13:11:51 INFO - 'tests': ['tp5o']}, 13:11:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:11:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:11:51 INFO - 'talos_options': ['--disable-e10s', 13:11:51 INFO - '--xperf_path', 13:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:11:51 INFO - 'tests': ['tp5n']}, 13:11:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:11:51 INFO - 'talos_options': ['--xperf_path', 13:11:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:11:51 INFO - 'tests': ['tp5n']}}, 13:11:51 INFO - 'talos.zip': {'path': '', 13:11:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:11:51 INFO - Running post-action listener: _resource_record_post_action 13:11:51 INFO - [mozharness: 2017-05-26 20:11:51.351689Z] Finished populate-webroot step (success) 13:11:51 INFO - [mozharness: 2017-05-26 20:11:51.351778Z] Running create-virtualenv step. 13:11:51 INFO - Running pre-action listener: _resource_record_pre_action 13:11:51 INFO - Running main action method: create_virtualenv 13:11:51 INFO - Creating virtualenv /builds/slave/test/build/venv 13:11:51 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 13:11:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:11:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:11:51 INFO - Using real prefix '/usr' 13:11:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:11:51 INFO - Installing distribute.............................................................................................................................................................................................done. 13:11:53 INFO - Installing pip.................done. 13:11:53 INFO - Return code: 0 13:11:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:11:54 INFO - Reading from file tmpfile_stdout 13:11:54 INFO - Output received: 13:11:54 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) 13:11:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:11:54 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')]} 13:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:54 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')]} 13:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:54 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 0x14851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1652a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f57a0>, '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 0x17f66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6b30>, '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': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', '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 13:11:54 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 13:11:54 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 13:11:54 INFO - Using env: {'DISPLAY': ':0', 13:11:54 INFO - 'HOME': '/home/cltbld', 13:11:54 INFO - 'LANG': 'en_US.UTF-8', 13:11:54 INFO - 'LANGUAGE': 'en_US:en', 13:11:54 INFO - 'LOGNAME': 'cltbld', 13:11:54 INFO - 'MAIL': '/var/mail/cltbld', 13:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:54 INFO - 'MOZ_NO_REMOTE': '1', 13:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:54 INFO - 'NO_EM_RESTART': '1', 13:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:54 INFO - 'PWD': '/builds/slave/test', 13:11:54 INFO - 'SHELL': '/bin/bash', 13:11:54 INFO - 'SHLVL': '1', 13:11:54 INFO - 'TERM': 'linux', 13:11:54 INFO - 'TMOUT': '86400', 13:11:54 INFO - 'USER': 'cltbld', 13:11:54 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', 13:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:54 INFO - '_': '/tools/buildbot/bin/python'} 13:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:54 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 13:11:54 INFO - Cleaning up... 13:11:54 INFO - Return code: 0 13:11:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:11:54 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')]} 13:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:54 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')]} 13:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:54 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 0x14851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1652a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f57a0>, '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 0x17f66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6b30>, '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': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', '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 13:11:54 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 13:11:54 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 13:11:54 INFO - Using env: {'DISPLAY': ':0', 13:11:54 INFO - 'HOME': '/home/cltbld', 13:11:54 INFO - 'LANG': 'en_US.UTF-8', 13:11:54 INFO - 'LANGUAGE': 'en_US:en', 13:11:54 INFO - 'LOGNAME': 'cltbld', 13:11:54 INFO - 'MAIL': '/var/mail/cltbld', 13:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:54 INFO - 'MOZ_NO_REMOTE': '1', 13:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:54 INFO - 'NO_EM_RESTART': '1', 13:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:54 INFO - 'PWD': '/builds/slave/test', 13:11:54 INFO - 'SHELL': '/bin/bash', 13:11:54 INFO - 'SHLVL': '1', 13:11:54 INFO - 'TERM': 'linux', 13:11:54 INFO - 'TMOUT': '86400', 13:11:54 INFO - 'USER': 'cltbld', 13:11:54 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', 13:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:54 INFO - '_': '/tools/buildbot/bin/python'} 13:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:54 INFO - Downloading/unpacking psutil>=3.1.1 13:11:54 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 13:11:54 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 13:11:54 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 13:11:54 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 13:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:11:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:11:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:11:55 INFO - Installing collected packages: psutil 13:11:55 INFO - Running setup.py install for psutil 13:11:55 INFO - building 'psutil._psutil_linux' extension 13:11:55 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 13:11:55 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 13:11:56 INFO - building 'psutil._psutil_posix' extension 13:11:56 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 13:11:56 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 13:11:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:11:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:11:56 INFO - Successfully installed psutil 13:11:56 INFO - Cleaning up... 13:11:56 INFO - Return code: 0 13:11:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:11: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')]} 13:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11: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')]} 13:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:56 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 0x14851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1652a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f57a0>, '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 0x17f66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6b30>, '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': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', '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 13:11:56 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 13:11:56 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 13:11:56 INFO - Using env: {'DISPLAY': ':0', 13:11:56 INFO - 'HOME': '/home/cltbld', 13:11:56 INFO - 'LANG': 'en_US.UTF-8', 13:11:56 INFO - 'LANGUAGE': 'en_US:en', 13:11:56 INFO - 'LOGNAME': 'cltbld', 13:11:56 INFO - 'MAIL': '/var/mail/cltbld', 13:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:56 INFO - 'MOZ_NO_REMOTE': '1', 13:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:56 INFO - 'NO_EM_RESTART': '1', 13:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:56 INFO - 'PWD': '/builds/slave/test', 13:11:56 INFO - 'SHELL': '/bin/bash', 13:11:56 INFO - 'SHLVL': '1', 13:11:56 INFO - 'TERM': 'linux', 13:11:56 INFO - 'TMOUT': '86400', 13:11:56 INFO - 'USER': 'cltbld', 13:11:56 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', 13:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:56 INFO - '_': '/tools/buildbot/bin/python'} 13:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:11:56 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 13:11:56 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 13:11:56 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 13:11:56 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 13:11:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:11:57 INFO - Installing collected packages: mozsystemmonitor 13:11:57 INFO - Running setup.py install for mozsystemmonitor 13:11:57 INFO - Successfully installed mozsystemmonitor 13:11:57 INFO - Cleaning up... 13:11:57 INFO - Return code: 0 13:11:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:11:57 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')]} 13:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:57 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')]} 13:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:57 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 0x14851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1652a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f57a0>, '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 0x17f66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6b30>, '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': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', '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 13:11:57 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 13:11:57 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 13:11:57 INFO - Using env: {'DISPLAY': ':0', 13:11:57 INFO - 'HOME': '/home/cltbld', 13:11:57 INFO - 'LANG': 'en_US.UTF-8', 13:11:57 INFO - 'LANGUAGE': 'en_US:en', 13:11:57 INFO - 'LOGNAME': 'cltbld', 13:11:57 INFO - 'MAIL': '/var/mail/cltbld', 13:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:57 INFO - 'MOZ_NO_REMOTE': '1', 13:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:57 INFO - 'NO_EM_RESTART': '1', 13:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:57 INFO - 'PWD': '/builds/slave/test', 13:11:57 INFO - 'SHELL': '/bin/bash', 13:11:57 INFO - 'SHLVL': '1', 13:11:57 INFO - 'TERM': 'linux', 13:11:57 INFO - 'TMOUT': '86400', 13:11:57 INFO - 'USER': 'cltbld', 13:11:57 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', 13:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:57 INFO - '_': '/tools/buildbot/bin/python'} 13:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:57 INFO - Downloading/unpacking jsonschema==2.5.1 13:11:57 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 13:11:57 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 13:11:57 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 13:11:57 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 13:11:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:11:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:11: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 13:11: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 13:11: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 13:11: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 13:11:59 INFO - Downloading functools32-3.2.3-2.tar.gz 13:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:11:59 INFO - warning: no files found matching '*.txt' 13:11:59 INFO - no previously-included directories found matching 'build' 13:11:59 INFO - no previously-included directories found matching 'dist' 13:11:59 INFO - no previously-included directories found matching '.git*' 13:11:59 INFO - Installing collected packages: jsonschema, functools32 13:11:59 INFO - Running setup.py install for functools32 13:11:59 INFO - warning: no files found matching '*.txt' 13:11:59 INFO - no previously-included directories found matching 'build' 13:11:59 INFO - no previously-included directories found matching 'dist' 13:11:59 INFO - no previously-included directories found matching '.git*' 13:11:59 INFO - Successfully installed jsonschema functools32 13:11:59 INFO - Cleaning up... 13:11:59 INFO - Return code: 0 13:11:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:11: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')]} 13:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11: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')]} 13:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:59 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 0x14851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1652a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f57a0>, '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 0x17f66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6b30>, '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': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', '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 13:11:59 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 13:11:59 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 13:11:59 INFO - Using env: {'DISPLAY': ':0', 13:11:59 INFO - 'HOME': '/home/cltbld', 13:11:59 INFO - 'LANG': 'en_US.UTF-8', 13:11:59 INFO - 'LANGUAGE': 'en_US:en', 13:11:59 INFO - 'LOGNAME': 'cltbld', 13:11:59 INFO - 'MAIL': '/var/mail/cltbld', 13:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:59 INFO - 'MOZ_NO_REMOTE': '1', 13:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:59 INFO - 'NO_EM_RESTART': '1', 13:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:59 INFO - 'PWD': '/builds/slave/test', 13:11:59 INFO - 'SHELL': '/bin/bash', 13:11:59 INFO - 'SHLVL': '1', 13:11:59 INFO - 'TERM': 'linux', 13:11:59 INFO - 'TMOUT': '86400', 13:11:59 INFO - 'USER': 'cltbld', 13:11:59 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', 13:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:59 INFO - '_': '/tools/buildbot/bin/python'} 13:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:11:59 INFO - Cleaning up... 13:11:59 INFO - Return code: 0 13:11:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:11: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')]} 13:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11: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')]} 13:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:59 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 0x14851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1652a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f57a0>, '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 0x17f66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6b30>, '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': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', '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 13:11:59 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 13:11:59 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 13:11:59 INFO - Using env: {'DISPLAY': ':0', 13:11:59 INFO - 'HOME': '/home/cltbld', 13:11:59 INFO - 'LANG': 'en_US.UTF-8', 13:11:59 INFO - 'LANGUAGE': 'en_US:en', 13:11:59 INFO - 'LOGNAME': 'cltbld', 13:11:59 INFO - 'MAIL': '/var/mail/cltbld', 13:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:59 INFO - 'MOZ_NO_REMOTE': '1', 13:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:59 INFO - 'NO_EM_RESTART': '1', 13:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:59 INFO - 'PWD': '/builds/slave/test', 13:11:59 INFO - 'SHELL': '/bin/bash', 13:11:59 INFO - 'SHLVL': '1', 13:11:59 INFO - 'TERM': 'linux', 13:11:59 INFO - 'TMOUT': '86400', 13:11:59 INFO - 'USER': 'cltbld', 13:11:59 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', 13:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:59 INFO - '_': '/tools/buildbot/bin/python'} 13:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:59 INFO - Downloading/unpacking blobuploader==1.2.4 13:11: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 13:11: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 13:11: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 13:11: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 13:12:00 INFO - Downloading blobuploader-1.2.4.tar.gz 13:12:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:12:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:12: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 13:12: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 13:12: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 13:12: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 13:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:12:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:12: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 13:12: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 13:12: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 13:12: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 13:12:01 INFO - Downloading docopt-0.6.1.tar.gz 13:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:12:01 INFO - Installing collected packages: blobuploader, requests, docopt 13:12:01 INFO - Running setup.py install for blobuploader 13:12:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:12:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:12:01 INFO - Running setup.py install for requests 13:12:02 INFO - Running setup.py install for docopt 13:12:02 INFO - Successfully installed blobuploader requests docopt 13:12:02 INFO - Cleaning up... 13:12:02 INFO - Return code: 0 13:12:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:12: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')]} 13:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12: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')]} 13:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:02 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 0x14851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1652a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f57a0>, '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 0x17f66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6b30>, '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': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', '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 13:12:02 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 13:12:02 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 13:12:02 INFO - Using env: {'DISPLAY': ':0', 13:12:02 INFO - 'HOME': '/home/cltbld', 13:12:02 INFO - 'LANG': 'en_US.UTF-8', 13:12:02 INFO - 'LANGUAGE': 'en_US:en', 13:12:02 INFO - 'LOGNAME': 'cltbld', 13:12:02 INFO - 'MAIL': '/var/mail/cltbld', 13:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:02 INFO - 'MOZ_NO_REMOTE': '1', 13:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:02 INFO - 'NO_EM_RESTART': '1', 13:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:02 INFO - 'PWD': '/builds/slave/test', 13:12:02 INFO - 'SHELL': '/bin/bash', 13:12:02 INFO - 'SHLVL': '1', 13:12:02 INFO - 'TERM': 'linux', 13:12:02 INFO - 'TMOUT': '86400', 13:12:02 INFO - 'USER': 'cltbld', 13:12:02 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', 13:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:02 INFO - '_': '/tools/buildbot/bin/python'} 13:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:12:02 INFO - Running setup.py (path:/tmp/pip-aGOLlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:12:02 INFO - Running setup.py (path:/tmp/pip-FbSJuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:12:02 INFO - Running setup.py (path:/tmp/pip-i6t1Jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:12:02 INFO - Running setup.py (path:/tmp/pip-R2nlZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:12:02 INFO - Running setup.py (path:/tmp/pip-w5MRwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:12:02 INFO - Running setup.py (path:/tmp/pip-4w_YLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:12:02 INFO - Running setup.py (path:/tmp/pip-SPhrS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:12:02 INFO - Running setup.py (path:/tmp/pip-EPwc8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:12:02 INFO - Running setup.py (path:/tmp/pip-O8slvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:12:03 INFO - Running setup.py (path:/tmp/pip-zCSFfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:12:03 INFO - Running setup.py (path:/tmp/pip-F3Uipn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:12:03 INFO - Running setup.py (path:/tmp/pip-kKrSb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:12:03 INFO - Running setup.py (path:/tmp/pip-xd9juF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:12:03 INFO - Running setup.py (path:/tmp/pip-AGugXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:03 INFO - Running setup.py (path:/tmp/pip-CT2BQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:12:03 INFO - Running setup.py (path:/tmp/pip-7l9aay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:12:03 INFO - Running setup.py (path:/tmp/pip-Z2EPct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:12:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:12:03 INFO - Running setup.py install for manifestparser 13:12:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:12:03 INFO - Running setup.py install for mozcrash 13:12:03 INFO - Running setup.py install for mozdebug 13:12:03 INFO - Running setup.py install for mozdevice 13:12:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:12:04 INFO - Running setup.py install for mozfile 13:12:04 INFO - Running setup.py install for mozhttpd 13:12:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:12:04 INFO - Running setup.py install for mozinfo 13:12:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:12:04 INFO - Running setup.py install for mozInstall 13:12:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:12:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:12:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:12:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:12:04 INFO - Running setup.py install for mozleak 13:12:04 INFO - Running setup.py install for mozlog 13:12:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:12:04 INFO - Running setup.py install for moznetwork 13:12:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:12:04 INFO - Running setup.py install for mozprocess 13:12:04 INFO - Running setup.py install for mozprofile 13:12:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:12:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:12:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:12:04 INFO - Running setup.py install for mozrunner 13:12:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:12:05 INFO - Running setup.py install for mozscreenshot 13:12:05 INFO - Running setup.py install for moztest 13:12:05 INFO - Running setup.py install for mozversion 13:12:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:12:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:12:05 INFO - Cleaning up... 13:12:05 INFO - Return code: 0 13:12:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:05 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 0x14851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1652a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f57a0>, '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 0x17f66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6b30>, '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': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', '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 13:12:05 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 13:12:05 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 13:12:05 INFO - Using env: {'DISPLAY': ':0', 13:12:05 INFO - 'HOME': '/home/cltbld', 13:12:05 INFO - 'LANG': 'en_US.UTF-8', 13:12:05 INFO - 'LANGUAGE': 'en_US:en', 13:12:05 INFO - 'LOGNAME': 'cltbld', 13:12:05 INFO - 'MAIL': '/var/mail/cltbld', 13:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:05 INFO - 'MOZ_NO_REMOTE': '1', 13:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:05 INFO - 'NO_EM_RESTART': '1', 13:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:05 INFO - 'PWD': '/builds/slave/test', 13:12:05 INFO - 'SHELL': '/bin/bash', 13:12:05 INFO - 'SHLVL': '1', 13:12:05 INFO - 'TERM': 'linux', 13:12:05 INFO - 'TMOUT': '86400', 13:12:05 INFO - 'USER': 'cltbld', 13:12:05 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', 13:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:05 INFO - '_': '/tools/buildbot/bin/python'} 13:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:12:05 INFO - Running setup.py (path:/tmp/pip-WC1pZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:12:05 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)) 13:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:12:05 INFO - Running setup.py (path:/tmp/pip-EU65UQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:12:05 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)) 13:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:12:05 INFO - Running setup.py (path:/tmp/pip-hPj8Sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:12:05 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)) 13:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:12:05 INFO - Running setup.py (path:/tmp/pip-1nKytO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:12:05 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)) 13:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:12:05 INFO - Running setup.py (path:/tmp/pip-AMQNbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:12:05 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)) 13:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:12:05 INFO - Running setup.py (path:/tmp/pip-cDSEX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:12:06 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)) 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:12:06 INFO - Running setup.py (path:/tmp/pip-9KVbHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:12:06 INFO - Running setup.py (path:/tmp/pip-Uf0QPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:12:06 INFO - Running setup.py (path:/tmp/pip-jjlW1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:12:06 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)) 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:12:06 INFO - Running setup.py (path:/tmp/pip-VkmmOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:12:06 INFO - Running setup.py (path:/tmp/pip-0Ggyzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:12:06 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)) 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:12:06 INFO - Running setup.py (path:/tmp/pip-G9p8Cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:12:06 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)) 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:12:06 INFO - Running setup.py (path:/tmp/pip-OMPbnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:12:06 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)) 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:12:06 INFO - Running setup.py (path:/tmp/pip-wN6g9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:12:06 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)) 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:06 INFO - Running setup.py (path:/tmp/pip-lLXPJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:06 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)) 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:12:06 INFO - Running setup.py (path:/tmp/pip-IySHc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:12:06 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)) 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:12:06 INFO - Running setup.py (path:/tmp/pip-XXhRYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:12:06 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)) 13:12:06 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)) 13:12:06 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)) 13:12:06 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)) 13:12:06 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)) 13:12:06 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)) 13:12:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:07 INFO - Downloading blessings-1.6.tar.gz 13:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:12:08 INFO - Installing collected packages: blessings 13:12:08 INFO - Running setup.py install for blessings 13:12:08 INFO - Successfully installed blessings 13:12:08 INFO - Cleaning up... 13:12:08 INFO - Return code: 0 13:12:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:12:08 INFO - Reading from file tmpfile_stdout 13:12:08 INFO - Current package versions: 13:12:08 INFO - argparse == 1.2.1 13:12:08 INFO - blessings == 1.6 13:12:08 INFO - blobuploader == 1.2.4 13:12:08 INFO - docopt == 0.6.1 13:12:08 INFO - functools32 == 3.2.3-2 13:12:08 INFO - jsonschema == 2.5.1 13:12:08 INFO - manifestparser == 1.1 13:12:08 INFO - mozInstall == 1.12 13:12:08 INFO - mozcrash == 1.0 13:12:08 INFO - mozdebug == 0.1 13:12:08 INFO - mozdevice == 0.51 13:12:08 INFO - mozfile == 1.2 13:12:08 INFO - mozhttpd == 0.7 13:12:08 INFO - mozinfo == 0.9 13:12:08 INFO - mozleak == 0.1 13:12:08 INFO - mozlog == 3.4 13:12:08 INFO - moznetwork == 0.27 13:12:08 INFO - mozprocess == 0.25 13:12:08 INFO - mozprofile == 0.28 13:12:08 INFO - mozrunner == 6.13 13:12:08 INFO - mozscreenshot == 0.1 13:12:08 INFO - mozsystemmonitor == 0.3 13:12:08 INFO - moztest == 0.8 13:12:08 INFO - mozversion == 1.4 13:12:08 INFO - psutil == 3.1.1 13:12:08 INFO - requests == 1.2.3 13:12:08 INFO - wsgiref == 0.1.2 13:12:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:08 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 0x14851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1652a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f57a0>, '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 0x17f66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6b30>, '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': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', '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 13:12:08 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 13:12:08 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 13:12:08 INFO - Using env: {'DISPLAY': ':0', 13:12:08 INFO - 'HOME': '/home/cltbld', 13:12:08 INFO - 'LANG': 'en_US.UTF-8', 13:12:08 INFO - 'LANGUAGE': 'en_US:en', 13:12:08 INFO - 'LOGNAME': 'cltbld', 13:12:08 INFO - 'MAIL': '/var/mail/cltbld', 13:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:08 INFO - 'MOZ_NO_REMOTE': '1', 13:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:08 INFO - 'NO_EM_RESTART': '1', 13:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:08 INFO - 'PWD': '/builds/slave/test', 13:12:08 INFO - 'SHELL': '/bin/bash', 13:12:08 INFO - 'SHLVL': '1', 13:12:08 INFO - 'TERM': 'linux', 13:12:08 INFO - 'TMOUT': '86400', 13:12:08 INFO - 'USER': 'cltbld', 13:12:08 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', 13:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:08 INFO - '_': '/tools/buildbot/bin/python'} 13:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:08 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)) 13:12:08 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)) 13:12:08 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)) 13:12:08 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)) 13:12:08 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)) 13:12:08 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)) 13:12:08 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)) 13:12:08 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)) 13:12:08 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)) 13:12:08 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:12:08 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 13:12:08 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 13:12:08 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 13:12:08 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 13:12:09 INFO - Downloading marionette_driver-1.4.0.tar.gz 13:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 13:12:09 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)) 13:12:09 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)) 13:12:09 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)) 13:12:09 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)) 13:12:09 INFO - Installing collected packages: marionette-driver 13:12:09 INFO - Running setup.py install for marionette-driver 13:12:09 INFO - Successfully installed marionette-driver 13:12:09 INFO - Cleaning up... 13:12:09 INFO - Return code: 0 13:12:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:12:09 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')]} 13:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:09 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')]} 13:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:09 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 0x14851f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1652a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17f85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f57a0>, '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 0x17f66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6b30>, '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': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', '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 13:12:09 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 13:12:09 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 13:12:09 INFO - Using env: {'DISPLAY': ':0', 13:12:09 INFO - 'HOME': '/home/cltbld', 13:12:09 INFO - 'LANG': 'en_US.UTF-8', 13:12:09 INFO - 'LANGUAGE': 'en_US:en', 13:12:09 INFO - 'LOGNAME': 'cltbld', 13:12:09 INFO - 'MAIL': '/var/mail/cltbld', 13:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:09 INFO - 'MOZ_NO_REMOTE': '1', 13:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:09 INFO - 'NO_EM_RESTART': '1', 13:12:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:09 INFO - 'PWD': '/builds/slave/test', 13:12:09 INFO - 'SHELL': '/bin/bash', 13:12:09 INFO - 'SHLVL': '1', 13:12:09 INFO - 'TERM': 'linux', 13:12:09 INFO - 'TMOUT': '86400', 13:12:09 INFO - 'USER': 'cltbld', 13:12:09 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', 13:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:09 INFO - '_': '/tools/buildbot/bin/python'} 13:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:12:10 INFO - Cleaning up... 13:12:10 INFO - Return code: 0 13:12:10 INFO - Running post-action listener: _resource_record_post_action 13:12:10 INFO - Running post-action listener: _start_resource_monitoring 13:12:10 INFO - Starting resource monitoring. 13:12:10 INFO - [mozharness: 2017-05-26 20:12:10.228338Z] Finished create-virtualenv step (success) 13:12:10 INFO - [mozharness: 2017-05-26 20:12:10.228844Z] Running install step. 13:12:10 INFO - Running pre-action listener: _resource_record_pre_action 13:12:10 INFO - Running main action method: install 13:12:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:12:10 INFO - Reading from file tmpfile_stdout 13:12:10 INFO - Detecting whether we're running mozinstall >=1.0... 13:12:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:12:10 INFO - Reading from file tmpfile_stdout 13:12:10 INFO - Output received: 13:12:10 INFO - Usage: mozinstall [options] installer 13:12:10 INFO - Options: 13:12:10 INFO - -h, --help show this help message and exit 13:12:10 INFO - -d DEST, --destination=DEST 13:12:10 INFO - Directory to install application into. [default: 13:12:10 INFO - "/builds/slave/test"] 13:12:10 INFO - --app=APP Application being installed. [default: firefox] 13:12:10 INFO - mkdir: /builds/slave/test/build/application 13:12:10 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'] 13:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:12:26 INFO - Reading from file tmpfile_stdout 13:12:26 INFO - Output received: 13:12:26 INFO - /builds/slave/test/build/application/firefox/firefox 13:12:26 INFO - Running post-action listener: _resource_record_post_action 13:12:26 INFO - [mozharness: 2017-05-26 20:12:26.193002Z] Finished install step (success) 13:12:26 INFO - [mozharness: 2017-05-26 20:12:26.193340Z] Running run-tests step. 13:12:26 INFO - Running pre-action listener: _resource_record_pre_action 13:12:26 INFO - Running main action method: run_tests 13:12:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:12:26 INFO - Python 2.7.3 13:12:26 INFO - Return code: 0 13:12:26 INFO - grabbing minidump binary from tooltool 13:12:26 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')]} 13:12:26 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 0x17f57a0>, '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 0x17f66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f6b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:12:26 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 13:12:26 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 13:12:26 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 13:12:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:12:26 INFO - Return code: 0 13:12:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:12:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:12:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:12:26 INFO - ENV: RUST_BACKTRACE is now 1 13:12:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:12:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:12:26 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/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 13:12:26 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/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 13:12:26 INFO - Using env: {'DISPLAY': ':0', 13:12:26 INFO - 'HOME': '/home/cltbld', 13:12:26 INFO - 'LANG': 'en_US.UTF-8', 13:12:26 INFO - 'LANGUAGE': 'en_US:en', 13:12:26 INFO - 'LOGNAME': 'cltbld', 13:12:26 INFO - 'MAIL': '/var/mail/cltbld', 13:12:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:12:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:26 INFO - 'MOZ_NO_REMOTE': '1', 13:12:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:12:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:26 INFO - 'NO_EM_RESTART': '1', 13:12:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:26 INFO - 'PWD': '/builds/slave/test', 13:12:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:12:26 INFO - 'RUST_BACKTRACE': '1', 13:12:26 INFO - 'SHELL': '/bin/bash', 13:12:26 INFO - 'SHLVL': '1', 13:12:26 INFO - 'TERM': 'linux', 13:12:26 INFO - 'TMOUT': '86400', 13:12:26 INFO - 'USER': 'cltbld', 13:12:26 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744', 13:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:26 INFO - '_': '/tools/buildbot/bin/python'} 13:12:26 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/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 13:12:26 INFO - mozversion application_buildid: 20170526194326 13:12:26 INFO - mozversion application_changeset: ba1a33add29df1cff5931c5bd82725b8ed4990e5 13:12:26 INFO - mozversion application_display_name: Nightly 13:12:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:12:26 INFO - mozversion application_name: Firefox 13:12:26 INFO - mozversion application_remotingname: firefox 13:12:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:12:26 INFO - mozversion application_vendor: Mozilla 13:12:26 INFO - mozversion application_version: 55.0a1 13:12:26 INFO - mozversion platform_buildid: 20170526194326 13:12:26 INFO - mozversion platform_changeset: ba1a33add29df1cff5931c5bd82725b8ed4990e5 13:12:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:12:26 INFO - mozversion platform_version: 55.0a1 13:12:26 INFO - using testdate: 1495829546 13:12:26 INFO - actual date: 1495829546 13:12:26 INFO - starting webserver on 'localhost:42148' 13:12:26 INFO - SUITE-START | Running 2 tests 13:12:26 INFO - TEST-START | dromaeo_css 13:12:26 INFO - operating with platform_type : linux_ 13:12:26 INFO - Initialising browser for dromaeo_css test... 13:12:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42148/getInfo.html -profile /tmp/tmpDIPvrt/profile 13:12:26 INFO - TEST-INFO | started process 28725 (/builds/slave/test/build/application/firefox/firefox http://localhost:42148/getInfo.html) 13:13:01 INFO - TEST-INFO | 28725: killed by SIGTERM 13:13:01 INFO - Browser initialized. 13:13:01 INFO - Running cycle 1/1 for dromaeo_css test... 13:13:01 INFO - TEST-INFO | started process 28927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDIPvrt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:13:13 INFO - PID 28927 | RSS: Main: 168624128 13:13:13 INFO - PID 28927 | 13:16:18 INFO - PID 28927 | Cycle 1(1): loaded http://localhost:42148/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42148/tests/dromaeo/cssquery-ext.html) 13:16:19 INFO - PID 28927 | RSS: Main: 166473728 13:16:19 INFO - PID 28927 | 13:19:21 INFO - PID 28927 | Cycle 1(1): loaded http://localhost:42148/tests/dromaeo/cssquery-ext.html (next: http://localhost:42148/tests/dromaeo/cssquery-jquery.html) 13:19:21 INFO - PID 28927 | RSS: Main: 173142016 13:19:21 INFO - PID 28927 | 13:22:23 INFO - PID 28927 | Cycle 1(1): loaded http://localhost:42148/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42148/tests/dromaeo/cssquery-mootools.html) 13:22:24 INFO - PID 28927 | RSS: Main: 171343872 13:22:24 INFO - PID 28927 | 13:25:25 INFO - PID 28927 | Cycle 1(1): loaded http://localhost:42148/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42148/tests/dromaeo/cssquery-prototype.html) 13:25:26 INFO - PID 28927 | RSS: Main: 175235072 13:25:26 INFO - PID 28927 | 13:28:29 INFO - PID 28927 | Cycle 1(1): loaded http://localhost:42148/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42148/tests/dromaeo/cssquery-yui.html) 13:28:30 INFO - PID 28927 | RSS: Main: 174800896 13:28:30 INFO - PID 28927 | 13:31:31 INFO - PID 28927 | Cycle 1(1): loaded http://localhost:42148/tests/dromaeo/cssquery-yui.html (next: http://localhost:42148/tests/dromaeo/cssquery-dojo.html) 13:31:32 INFO - PID 28927 | RSS: Main: 172990464 13:31:32 INFO - PID 28927 | 13:31:32 INFO - PID 28927 | __start_tp_report 13:31:32 INFO - PID 28927 | _x_x_mozilla_page_load 13:31:32 INFO - PID 28927 | _x_x_mozilla_page_load_details 13:31:32 INFO - PID 28927 | |i|pagename|runs| 13:31:32 INFO - PID 28927 | |0;dojo.html;2722.809403341766;2744.807863449557;2750.931226719332;2779.6386469758936;2784.2343355577214;5219.9478005219935;5366.221897824813;5366.409694933554;5372.247885296057;5375.30121084259;5303.840884773463;5332.733363331828;5341.919871201935;5413.972930135344;5430.239766432703;4462.419885414892;4692.9431671145585;4744.97627511862;4772.7136371817805;4775.689580177294;4832;4832.17852964995;4862.270659401101;4887.951120488785;4924.433690125646;4622;4648.1168577970075;4735.573798358164;4789.401324834395;4797.640176986705;4780.593649539794;4783.856484305476;4795.664303498756;4816.277558366238;4834.395700537433;4716.50476699945;4736.455307639631;4737.147313483571;4746.596539294164;4758.833440829589;5219.217117432416;5324.254604355393;5338.839834804962;5362.544183744348;5364.839054828361;5720.570957178186;5753.884922301572;5827.038538641119;5837.890800747844;5839.9124013139835;5845.035569131088;5854.590178687494;5868.735906884158;5908.291005079418;5924.2298501195;5407.864803379947;5423.322084739408;5436.130219164915;5437.293151890229;5438.238646589481;5776.133579962955;5810.273715785527;5991.4907232884825;6001.2498437695285;6005.519558435315;5608.523275521545;5636.520895723909;5639.351474580476;5647.124695672177;5664.915026274609;5729.4843464088435;5842.620229685142;5860.794872179454;5877.118432235199;5891.116332550152;5637.210790489253;5833.154192642043;5841.591088623841;5850.444207800252;5852.209951656472;5706.087026075808;5731.426857314235;5766.163906233573;5797.652140871562;5850.034744267234;4883.389576302962;4898.338724272177;4899.632527560448;4902.994886048352;4944.728039957837;4138.813753381105;4152.6055024772595;4158.8336466540995;4162.62536371728;4200.159968006411;4718.95281047192;4810.6151507879285;4868.853934381974;4921.064997650435;4941.50584941503;5785.218995435646;5786.218860453869;5797.304323481209;5798.33319168301;5831.271091113611;4876.024795041006;4876.390451193601;4881.389826271716;4882.951170488321;4914.33656456381;5003.274525193827;5026.271190677331;5073.213651883964;5109.20807274873;5134.897302053938;5421.918671219856;5458.4814442627885;5467.343918729778;5467.4532546745;5483.122700367922;5694.487496125369;5815.621984570989;5859.44335288147;5872.911906321323;5877.059670452707;5271.973640131775;5279.577633789365;5375.892482150257;5464.726763661881;5467.781288748564;5621.747021383966;5735.8566035849435;5739.339975902658;5751.051076572318;5789.334226563999;5636.661800291996;5668.574856885833;5790.85522861915;5854.414558544111;5917.37867523921;5654.321481422256;5666.405027472056;5670.773169073191;5683;5710.000749868839;5662.178984047207;5681.403452637579;5683.488486036276;5688;5692.345380281155;5383.461653834585;5573.6098473106495;5620.4098569649595;5627.493525582717;5628;5561.360443548881;5611.775528978958;5640.407757185437;5641.182028605911;5653.180288858175;5558.972205138948;5593.412691667317;5593.664380137205;5612.85967850807;5619.9719001406365 13:31:32 INFO - PID 28927 | |1;ext.html;659.1365311442012;701.3022043067148;721.5093736259344;1066.9093127084202;1071.8124328242566;31011.534826977586;31878.840605796966;31890.20274493139;31974.20064498386;32236;33865;34231.82884085582;34442.48336274952;34480.48279275806;34509.48235776465;6588.341165883421;6715.194176698803;6971.058907047547;7055.365017148456;7058.011878337037;6671.966640166793;6728;6796.898046529306;6810.387065164135;6813.591184528919;6794.490413219004;6816.318368163194;6820.761273355433;6830.4877134214885;6871.965640171792;6763.797086087426;6771.5937043777285;6789.219239787413;6806.251312355637;6814.522983391164;6743.93256067438;6767.4924380671155;6790.151231096113;6796.864062718718;6813.488988325846;31206.063818085495;31271.530927036114;31294.687053129404;31469.37061258762;31480.842595787104;3029.5758593796886;3048.1465189746905;3051.3897220555755;3054.6487153977355;3064.5709600655928;23825.880870595534;23860.880695596585;24079.759202407928;24237.151699690603;24247.636285455734;2905.418916216765;2910.83990380529;2913.9271518212004;2937.8090424122365;2960.6003189569346;142774;143825.28087359495;144014;147765;151221.68280744666;37322.06694832651;37522;37526;37587.43618845719;37594;39851;39946.80026599907;40017.1996560073;42619.786901065294;43442;13298.268595227355;13381.732365352638;13414.463421463031;13478.932605336911;13496.325183740773;10752.731181720519;10812.243142979916;10871.565137394417;10885.836712449161;10889.945550272198;12732.872671273353;12735.235885846694;12808.615741527768;12832.422540985677;12862.614121576367;5409.756560954766;5487.368952570426;5501.889962200734;5514.91727624086;5566.081596536607;858.1375717403969;874.5889431966965;904.7201053345533;905.9954700226589;924.5100096948628;19466.8053319465;20337.18651253963;20347.593048138955;20540.281090161774;20800.375988720363;960.3277705606104;978.1392374710351;987.6049580167846;988.9505524723735;992.93545919515;10345.482725863827;10838.945805270923;10915.181361397768;10993.890061099446;11046.779064418666;176145.11927440538;176219;178000;178169.10915445338;178395.10802446163;38711.41932871009;39328.21343573112;39590;39600.60399395969;39709.40435893406;1201.501376928565;1233.648410203088;1249.4252643783962;1254.5358217459598;1256.114439320277;19408.8059119407;19596.706049408986;19674.40976770699;20325.288614898407;20731.274405396343;28836;28839.279018024718;28919.42161156723;28942.85528572428;28950.276243094093;149080.25459873065;149580;149916;150300;150317;28722.712772872004;29055.56416653794;29135;29142.085791421538;29159.708402915698;33937.49093763546;34120.317593647495;34609.65390346065;35006.47490287699;35097.47353789644;26675.333116671463;26909;27006.729932700422;27044.864775675996;28128.29679258035;26403.20790376292;26796.196114116607;27267.727322726518;27666;27692.723072769015;29044.419111618074;29688.55467167951;29768.70231297659;29779.702202977693;29815.701842982162;25508.48983020292;25640.36054730586;26064.087756928417;26818.195454136407;27100.32249193786;20862.582748344645;21805.781942180376;21855.562888741817;21873.234436794635;22065.227717029826 13:31:32 INFO - PID 28927 | |2;jquery.html;399.4137956730171;403.3888658682095;418.9643880270176;428.9356596510523;430.47912026447995;14895;15776.76334854978;17627.911860440698;18280.360187393442;18380.72428913566;18761.437156885317;18849.81150188498;18946.810531894676;19013.619727605474;19212.231510739555;5223.477652234765;5376.489233522809;5476.91784623231;5482.259894914176;5538.529225015878;5301.7084060376665;5445.754941027643;5463.31708536433;5464.12573988162;5475.4524547545325;5003.449620541737;5427.457254274561;5431.674099554019;5442.8911421771545;5453.64551304166;5249.448807875195;5329.120695085326;5336.466353364672;5375.086235340002;5381.327334083239;4956.504349565051;4983.875403114915;5013.623978201649;5028.019536190444;5028.522290382444;21925.12299508018;22086.558268834535;22447.214347497924;22530;22587.096516139336;1618.0776957134437;1618.4659062509343;1636.909969951652;1637.214137214132;1647.736362182045;14517.128972261593;14879;14974;15071.623209419742;15101.546953591409;2030.1168991488603;2033.725447064657;2090.446031801574;2093.675480300556;2115.375964090597;89742;90543.54728226317;90833.8249557543;99047;103687;17705.557361066076;17775;17817.910910445364;17904.641907161782;18224.544386390447;32914.5062824053;33091.50362744561;33097.83451082729;33155.83422082874;33372;8441.57792110392;8469.153084691605;8546.31629469641;8679.783005424915;8730.126987301346;6749.190097188369;6792.932070679329;6965.407940325129;6979.720811167598;6987.475939304572;9222.723318300461;9486.430814151174;9499.24006079512;9644.614215431304;9666.661666841626;3321.877435210894;3555.5911070227253;3658.378075727133;3756.342640038037;3829.483019792348;835.0980940584154;864.8400045991511;868.4398562926876;868.5657171414293;893.2585953658448;16623.418180363627;16884.155792210342;16990.660186796442;17066.658666826595;17629.7355539667;859.351189851658;871.2246100970142;871.2463718883247;879.6349514951223;895.6462197431978;9310.581023853807;9408.106229908148;9527.285453591008;9581.616735330508;9616.182624476858;365151;365308;371101;371449;372631;75667;76594.61702691563;76943;77357.61321193358;78459.21540784634;1016.4409574734015;1043.3218408034838;1067.7757670889046;1070.3043022035583;1070.3898777696793;14362.928185359006;14672.559823205322;14753.704925901637;14968.476103336767;15283.541493755205;38054;38142.23715525618;38333.42499862448;39367.40948885826;39742;46671.533284666715;47751;47831.282530762765;48297.5170248293;49372.75313623409;8413.87379189325;8550.700725474579;8607.913920860712;8660.870086948575;8796.252318552739;12801.487940482277;12995.415206315927;13007.414666339848;13333.133346332457;13398.598042058753;11445.42772861337;11471.770564588829;11493.48279327449;11495.286932357692;11783.941080294544;10572.154227661922;10700.30448020876;10925.399103049409;11113;11174.553017879194;11487.13846461502;11515.424228788695;11643.825342620037;11877.109216808947;11902.28586284791;8331;8376.371772117238;8414.326853851555;8458.154184581492;8789.912100879164;10872.61945831892;11152.609658661908;11333.603323883624;11485.013896386832;11628.069754419457 13:31:32 INFO - PID 28927 | |3;mootools.html;1259.244453328003;1313.5139998200661;1314.9276789776561;1318.5385115209672;1326.4097476622906;10422.895771042287;10814.891851081487;10921.5631374745;10943.28868623539;11342.376169310684;11048;11287.604933827317;11303.491342889569;11312.095032397408;11335.093192544597;2077.428707105543;2107.9789202107936;2116.740539379067;2119.713838631788;2127.5957568062095;2187.6827859960295;2225.432514708755;2234.307364716935;2237.093976939342;2249.955000899981;2138.101997161196;2172.4134483689395;2192.9232476863313;2193.9890300548477;2197.1760589778833;2151.397608669575;2152.171414005619;2160.7299087614047;2167.143978128638;2171.337741988693;2056.3830850744716;2089.498520355119;2107.546877421362;2112.2290364017176;2187.529681118567;10639;10744.892551074467;10748.570057197703;10748.946255268673;10765.784684306349;5560.86097847553;5817.0983497557945;5818.389069147721;5828.125781132821;5832.941670583282;3289.605247370307;3389.1696534349244;3483.164040630256;3483.3381657484997;3486.9825650871585;1058.5924419098626;1063.7500187455942;1069.0538873097364;1074.5218377821873;1103.271840585218;16010.119443430607;16057.678846423007;16136.919315403466;16182.75725864113;16202.35190592375;4701.271302948048;4747;4912.729799861042;4956.553910148104;4979.90040199194;11512.424378781028;11568.537258509734;11581.88418115825;11612.535498580131;11623.186376953532;5554.750036248298;5732.484076433141;5748.051571490657;5756.481916627524;5763.85590360236;5285.841424757264;5291;5349.117395629755;5362.2224777407055;5393.406725260218;3957.2876882160913;3982.2234664240773;4010.578889216649;4015.5783642717092;4063.512378514538;1145.856767904012;1157.791597512439;1169.3217933598492;1175.588544009607;1180.0795379603924;727.7052793618593;751.48523261566;752.6462562595572;762.2415696382135;763.3702195688579;5828.59199856006;6005;6005.849853753603;6413.454856337264;6523.478121750249;545.9808906688247;548.5447078924562;557.9944200558024;567.0671744979486;567.1974156568409;3750.381187104097;3827.469012395064;3968.6031396860662;4046.838126474967;4048.5748996355546;13770.173789572658;14000.579982600539;14200.011998320244;14273.714525709427;14277.92861035709;13554.118982266122;14144.929275353557;14354.569362919128;14373.568792936228;14447.85552144486;7571.129320128146;7777.222277772291;7798.298153166243;7881.935938648209;7947.84104317922;6110.663913484623;6209.751609935552;6363.331850155667;6444.709988050643;6680.565763225375;12617.242965422103;12697.4286157125;12772.169808962388;12900.935495322463;12973.416196271002;13018.218906865619;13227.404766785325;13265.270410127536;13290.20258784476;13333.20000799955;7760.223977602421;7952.244536768998;7955.403344749051;7970.681172753025;7985.041794984639;9986.151177150025;10058.54736536843;10110.241731870286;10119.898801011896;10134.493275336352;8344.123866994121;8606.78483037929;8624.016476210381;8636.17956294151;8788.07725188846;8383.496990180609;8496.872546911678;8514.31885449175;8591.44155629882;8731;7405.629718513945;7531.397488201041;7543.434242431949;7554.357879580078;7560.546367217985;5596.468335508121;5733.082706766897;5772.9711351442975;5871.559633027626;5936.970315148569;5570.442955704397;5624.268845050281;5667.40492248308;5693.886122277614;5795.39148389413 13:31:32 INFO - PID 28927 | |4;prototype.html;337.1133917796196;341.26116956788553;356.97594638400267;359.35137077574984;364.1152000638449;5614.129809879465;5641.041023026085;5646.576506761989;5651.830445086649;5663.7168141592965;5287.41838397776;5493.587980901429;5494.587905907063;5495.175723641456;5506.889862202754;4112.712110152291;4120.793960301988;4158.812853421603;4160.375943608453;4178.8328466861285;4137.503499580054;4140.461739973799;4147.523034851;4150.9584904151025;4171.833126674929;4062.9796851015703;4090.202410529948;4101.79491025449;4102.17956408718;4104.220198162355;4028.2346354192755;4093.7543747375253;4109.383592461125;4117.5618358670545;4124.370873504979;3551.786892786441;3555.1289933966086;3589.2821435712963;3590.6409359064146;3594.856205751767;5356.11624082026;5367.141257398797;5384.6769193848495;5385.165299378603;5392.973035134838;4635.235186194274;4790.365299085489;4818.807247710122;4837.984023355099;4848.418189817245;5835.533157347402;5837.241158649391;5847.210626565445;5849.6197747146725;5865.472107510344;3998.6001399860074;4005.37916622921;4005.8798236052967;4013.6554254324838;4020.8190631421658;6023.638581685069;6057.849008688335;6158.476529494998;6194;6198.814035578985;4108.4453598764385;4127.504699436087;4130.3772104713125;4134.235166494208;4145.54399016108;4158.500979882433;4174.874753757392;4189.392538081961;4202.117555313418;4211.578842115825;4717.198076327033;4835.95164048362;4856.587190088811;4871.415430148405;4884.7069175849565;5892.852678683067;5909.468147866627;5913;5919.467247947706;5937.317208521075;1424.3661570600982;1430.9499167529086;1442.3725679329525;1447.117258472331;1449.166729130754;919.7608621758391;945.2984627670166;948.184561277301;951.3911096897991;954.9761255968656;5061.924071138936;5070.391553013588;5083.339165908408;5084.313617661643;5099.59203263738;5995.370486098984;6085.413699177831;6093.6039157454625;6112.205413296243;6123.38766123393;4819.156647586658;5012.874678133076;5021.6735912165595;5022.949770502321;5028.195488721787;3179.920501987469;3208.7593430492807;3220.2271454850666;3224.193951512122;3239.5626590410466;5358.946410535923;5568.276124103841;5580.441955804468;5585.636933599303;5604.663720176803;6201.782937597162;6216.968915155486;6238.157848690459;6253.78111766086;6256.311805701369;5603.691796951125;5608.158776183605;5637.830865074055;5660.37735849048;5679.858003549779;5815.621984570989;6009.54928380382;6079.179310792986;6081.665508397081;6095.634261944298;5984.850378740566;5994.280686317496;5998.220231369894;6013.939860601338;6037.124616930609;5404.78380864761;5593.300837395325;5600.047991841316;5607.971960140173;5631.802886898939;4130.793460327031;4131.50421949368;4144.316187829095;4150;4154.459920210354;5929.733162007807;6062.848428789139;6136.637394603021;6145.324014358506;6156;5884.382139875423;5899.262592175978;5904.793332233351;5913.704314784158;5926.2295901532525;5888.735006924613;5890.617109887844;5901.881962360814;5905.52755779528;5913.793017244376;5705.288413475858;5786;5816.389279125631;5819.214406055128;5850.297964244318;5894.6757928314355;5909.5863289569315;5929.377415371324;5949.3455719871645;5957.553183511341;5640.730835561966;5712.742926568231;5739.273844923795;5750.827475175752;5805.390434004369 13:31:32 INFO - PID 28927 | |5;yui.html;747.67102474911;759.0360242492035;759.5860256160393;764.2243123229922;777.0131932445794;13619.523316683906;15135.318910649006;15243.085414875102;16886.240119194634;17520;16641.33434662612;16693.66612667746;16704.248308826103;16898.239579218935;17005.48983530493;868.3053557154283;882.8940527136753;909.1136142261308;909.1999040844048;920.2913756407562;926.5552534783308;928.03020843219;932.8880534335889;934.0892629686069;935.6818681648239;946.9147776700096;952.1716106986931;952.4761381240324;954.4750387286999;958.314804914486;954.551360860398;960.0687333286701;960.1838437328215;961.1829944547148;967.9322447428683;707.989380159298;708.3695510995218;709.4253654539839;709.9645017749092;713.4114355656604;15194.696106077816;15254.847451525453;15378;15443.382264709398;15451.690966180613;16620.33518659252;17049.403270885585;17068.146592670317;17108.657826843395;17119;12850;13230.801537976939;13290.26903520306;13317.600471985856;13335.933320333434;3039.392121575672;3046.055722725962;3068.079576127153;3076.8769249230004;3087.8764849405998;81007.5949620254;81024.59487702583;81803.59098204471;82857.58571207165;83609;12936.223826570436;13251.138675986223;13341.733165336638;13455.529056482976;13476.595702128952;24603.13889013912;24614.753852461603;24632;24640;24839.254822355357;6301.243850737941;6454.870902582016;6497.122888410098;6504.414602685781;6513.478921686348;2983.925401864927;3029.2124047747743;3033.2113650451042;3044.3150291184306;3045.893393731253;3578.248567800791;3656.232191239816;3668.3396988542318;3682.0978860179425;3686.4286035664513;701.4879138229121;772.7218201447474;800.0519384529351;805.5126648377648;809.1867672988609;593.7921727395377;601.9939800602026;605.2797171366149;623.2863371439677;627.4133685004535;10352.430616316175;10979.341239525655;11119.22165448427;11145.49845256949;11412.543498259976;589.4488653109356;595.6068994463633;601.1974014690437;608.8356143841138;616.0635833533005;4714.363560919301;4917.139500587383;4960.082384758831;5115.590752739772;5127.974360128175;75313;76478.61760691273;77625;79085.60457197677;87363;68079;69750.65124674344;75138.62430687812;75200;75654.24345756472;70966;72661.63669181726;74123.62938185383;76161.61919190368;76290.61854690692;11023.559057637605;11256.662300130682;11896.286222826659;11966.820497692368;12129.514819407124;29816.850915745283;30543.389132217675;30543.847280763453;30912.536311955788;31720.682793172695;37915;38277.23445531129;38870.41694374643;39457.40813887736;40091;15190.316435760196;15575.454859079879;15667.60830979189;15771;15897.841021589637;16643.50069497917;16815.495535133967;16917.830821692118;16998.490045298662;17144.742828857827;14509.637259068608;15518.068915865084;16116.838831611534;16119.435819746253;16286.837131629007;16662.4168154114;16746.49760507187;16759.497215083567;16878.493645190665;17008.914955425145;13907.096038757449;13912.443502260201;14041.859581404055;14095.788563171356;16850.57873553171;10605.628802991858;11342.905447527066;11530.365829879438;11610.071194304266;11856.288622682321;12746.235225886476;13145.53990610324;13398.866011339762;13431.19412835233;13431.865681343452 13:31:32 INFO - PID 28927 | __end_tp_report 13:31:32 INFO - PID 28927 | __start_cc_report 13:31:32 INFO - PID 28927 | _x_x_mozilla_cycle_collect,329 13:31:32 INFO - PID 28927 | __end_cc_report 13:31:32 INFO - PID 28927 | __startTimestamp1495830692001__endTimestamp 13:31:32 INFO - PID 28927 | 13:31:32 INFO - PID 28927 | ------- Summary: start ------- 13:31:32 INFO - PID 28927 | Number of tests: 6 13:31:32 INFO - PID 28927 | 13:31:32 INFO - PID 28927 | [#0] dojo.html Cycles:165 Average:5292.41 Median:5467.34 stddev:636.42 (11.6%) stddev-sans-first:605.60 13:31:32 INFO - PID 28927 | Values: 2722.8 2744.8 2750.9 2779.6 2784.2 5219.9 5366.2 5366.4 5372.2 5375.3 5303.8 5332.7 5341.9 5414.0 5430.2 4462.4 4692.9 4745.0 4772.7 4775.7 4832.0 4832.2 4862.3 4888.0 4924.4 4622.0 4648.1 4735.6 4789.4 4797.6 4780.6 4783.9 4795.7 4816.3 4834.4 4716.5 4736.5 4737.1 4746.6 4758.8 5219.2 5324.3 5338.8 5362.5 5364.8 5720.6 5753.9 5827.0 5837.9 5839.9 5845.0 5854.6 5868.7 5908.3 5924.2 5407.9 5423.3 5436.1 5437.3 5438.2 5776.1 5810.3 5991.5 6001.2 6005.5 5608.5 5636.5 5639.4 5647.1 5664.9 5729.5 5842.6 5860.8 5877.1 5891.1 5637.2 5833.2 5841.6 5850.4 5852.2 5706.1 5731.4 5766.2 5797.7 5850.0 4883.4 4898.3 4899.6 4903.0 4944.7 4138.8 4152.6 4158.8 4162.6 4200.2 4719.0 4810.6 4868.9 4921.1 4941.5 5785.2 5786.2 5797.3 5798.3 5831.3 4876.0 4876.4 4881.4 4883.0 4914.3 5003.3 5026.3 5073.2 5109.2 5134.9 5421.9 5458.5 5467.3 5467.5 5483.1 5694.5 5815.6 5859.4 5872.9 5877.1 5272.0 5279.6 5375.9 5464.7 5467.8 5621.7 5735.9 5739.3 5751.1 5789.3 5636.7 5668.6 5790.9 5854.4 5917.4 5654.3 5666.4 5670.8 5683.0 5710.0 5662.2 5681.4 5683.5 5688.0 5692.3 5383.5 5573.6 5620.4 5627.5 5628.0 5561.4 5611.8 5640.4 5641.2 5653.2 5559.0 5593.4 5593.7 5612.9 5620.0 13:31:32 INFO - PID 28927 | 13:31:32 INFO - PID 28927 | [#1] ext.html Cycles:180 Average:29851.72 Median:16048.76 stddev:40803.29 (254.2%) stddev-sans-first:40858.87 13:31:32 INFO - PID 28927 | Values: 659.1 701.3 721.5 1066.9 1071.8 31011.5 31878.8 31890.2 31974.2 32236.0 33865.0 34231.8 34442.5 34480.5 34509.5 6588.3 6715.2 6971.1 7055.4 7058.0 6672.0 6728.0 6796.9 6810.4 6813.6 6794.5 6816.3 6820.8 6830.5 6872.0 6763.8 6771.6 6789.2 6806.3 6814.5 6743.9 6767.5 6790.2 6796.9 6813.5 31206.1 31271.5 31294.7 31469.4 31480.8 3029.6 3048.1 3051.4 3054.6 3064.6 23825.9 23860.9 24079.8 24237.2 24247.6 2905.4 2910.8 2913.9 2937.8 2960.6 142774.0 143825.3 144014.0 147765.0 151221.7 37322.1 37522.0 37526.0 37587.4 37594.0 39851.0 39946.8 40017.2 42619.8 43442.0 13298.3 13381.7 13414.5 13478.9 13496.3 10752.7 10812.2 10871.6 10885.8 10889.9 12732.9 12735.2 12808.6 12832.4 12862.6 5409.8 5487.4 5501.9 5514.9 5566.1 858.1 874.6 904.7 906.0 924.5 19466.8 20337.2 20347.6 20540.3 20800.4 960.3 978.1 987.6 989.0 992.9 10345.5 10838.9 10915.2 10993.9 11046.8 176145.1 176219.0 178000.0 178169.1 178395.1 38711.4 39328.2 39590.0 39600.6 39709.4 1201.5 1233.6 1249.4 1254.5 1256.1 19408.8 19596.7 19674.4 20325.3 20731.3 28836.0 28839.3 28919.4 28942.9 28950.3 149080.3 149580.0 149916.0 150300.0 150317.0 28722.7 29055.6 29135.0 29142.1 29159.7 33937.5 34120.3 34609.7 35006.5 35097.5 26675.3 26909.0 27006.7 27044.9 28128.3 26403.2 26796.2 27267.7 27666.0 27692.7 29044.4 29688.6 29768.7 29779.7 29815.7 25508.5 25640.4 26064.1 26818.2 27100.3 20862.6 21805.8 21855.6 21873.2 22065.2 13:31:32 INFO - PID 28927 | 13:31:32 INFO - PID 28927 | [#2] jquery.html Cycles:180 Average:25855.22 Median:38098.12 stddev:61531.64 (161.5%) stddev-sans-first:61674.57 13:31:32 INFO - PID 28927 | Values: 399.4 403.4 419.0 428.9 430.5 14895.0 15776.8 17627.9 18280.4 18380.7 18761.4 18849.8 18946.8 19013.6 19212.2 5223.5 5376.5 5476.9 5482.3 5538.5 5301.7 5445.8 5463.3 5464.1 5475.5 5003.4 5427.5 5431.7 5442.9 5453.6 5249.4 5329.1 5336.5 5375.1 5381.3 4956.5 4983.9 5013.6 5028.0 5028.5 21925.1 22086.6 22447.2 22530.0 22587.1 1618.1 1618.5 1636.9 1637.2 1647.7 14517.1 14879.0 14974.0 15071.6 15101.5 2030.1 2033.7 2090.4 2093.7 2115.4 89742.0 90543.5 90833.8 99047.0 103687.0 17705.6 17775.0 17817.9 17904.6 18224.5 32914.5 33091.5 33097.8 33155.8 33372.0 8441.6 8469.2 8546.3 8679.8 8730.1 6749.2 6792.9 6965.4 6979.7 6987.5 9222.7 9486.4 9499.2 9644.6 9666.7 3321.9 3555.6 3658.4 3756.3 3829.5 835.1 864.8 868.4 868.6 893.3 16623.4 16884.2 16990.7 17066.7 17629.7 859.4 871.2 871.2 879.6 895.6 9310.6 9408.1 9527.3 9581.6 9616.2 365151.0 365308.0 371101.0 371449.0 372631.0 75667.0 76594.6 76943.0 77357.6 78459.2 1016.4 1043.3 1067.8 1070.3 1070.4 14362.9 14672.6 14753.7 14968.5 15283.5 38054.0 38142.2 38333.4 39367.4 39742.0 46671.5 47751.0 47831.3 48297.5 49372.8 8413.9 8550.7 8607.9 8660.9 8796.3 12801.5 12995.4 13007.4 13333.1 13398.6 11445.4 11471.8 11493.5 11495.3 11783.9 10572.2 10700.3 10925.4 11113.0 11174.6 11487.1 11515.4 11643.8 11877.1 11902.3 8331.0 8376.4 8414.3 8458.2 8789.9 10872.6 11152.6 11333.6 11485.0 11628.1 13:31:32 INFO - PID 28927 | 13:31:32 INFO - PID 28927 | [#3] mootools.html Cycles:180 Average:6610.74 Median:3436.17 stddev:4365.53 (127.0%) stddev-sans-first:4359.26 13:31:32 INFO - PID 28927 | Values: 1259.2 1313.5 1314.9 1318.5 1326.4 10422.9 10814.9 10921.6 10943.3 11342.4 11048.0 11287.6 11303.5 11312.1 11335.1 2077.4 2108.0 2116.7 2119.7 2127.6 2187.7 2225.4 2234.3 2237.1 2250.0 2138.1 2172.4 2192.9 2194.0 2197.2 2151.4 2152.2 2160.7 2167.1 2171.3 2056.4 2089.5 2107.5 2112.2 2187.5 10639.0 10744.9 10748.6 10748.9 10765.8 5560.9 5817.1 5818.4 5828.1 5832.9 3289.6 3389.2 3483.2 3483.3 3487.0 1058.6 1063.8 1069.1 1074.5 1103.3 16010.1 16057.7 16136.9 16182.8 16202.4 4701.3 4747.0 4912.7 4956.6 4979.9 11512.4 11568.5 11581.9 11612.5 11623.2 5554.8 5732.5 5748.1 5756.5 5763.9 5285.8 5291.0 5349.1 5362.2 5393.4 3957.3 3982.2 4010.6 4015.6 4063.5 1145.9 1157.8 1169.3 1175.6 1180.1 727.7 751.5 752.6 762.2 763.4 5828.6 6005.0 6005.8 6413.5 6523.5 546.0 548.5 558.0 567.1 567.2 3750.4 3827.5 3968.6 4046.8 4048.6 13770.2 14000.6 14200.0 14273.7 14277.9 13554.1 14144.9 14354.6 14373.6 14447.9 7571.1 7777.2 7798.3 7881.9 7947.8 6110.7 6209.8 6363.3 6444.7 6680.6 12617.2 12697.4 12772.2 12900.9 12973.4 13018.2 13227.4 13265.3 13290.2 13333.2 7760.2 7952.2 7955.4 7970.7 7985.0 9986.2 10058.5 10110.2 10119.9 10134.5 8344.1 8606.8 8624.0 8636.2 8788.1 8383.5 8496.9 8514.3 8591.4 8731.0 7405.6 7531.4 7543.4 7554.4 7560.5 5596.5 5733.1 5773.0 5871.6 5937.0 5570.4 5624.3 5667.4 5693.9 5795.4 13:31:32 INFO - PID 28927 | 13:31:32 INFO - PID 28927 | [#4] prototype.html Cycles:180 Average:4804.11 Median:5501.03 stddev:1448.78 (26.3%) stddev-sans-first:1413.51 13:31:32 INFO - PID 28927 | Values: 337.1 341.3 357.0 359.4 364.1 5614.1 5641.0 5646.6 5651.8 5663.7 5287.4 5493.6 5494.6 5495.2 5506.9 4112.7 4120.8 4158.8 4160.4 4178.8 4137.5 4140.5 4147.5 4151.0 4171.8 4063.0 4090.2 4101.8 4102.2 4104.2 4028.2 4093.8 4109.4 4117.6 4124.4 3551.8 3555.1 3589.3 3590.6 3594.9 5356.1 5367.1 5384.7 5385.2 5393.0 4635.2 4790.4 4818.8 4838.0 4848.4 5835.5 5837.2 5847.2 5849.6 5865.5 3998.6 4005.4 4005.9 4013.7 4020.8 6023.6 6057.8 6158.5 6194.0 6198.8 4108.4 4127.5 4130.4 4134.2 4145.5 4158.5 4174.9 4189.4 4202.1 4211.6 4717.2 4836.0 4856.6 4871.4 4884.7 5892.9 5909.5 5913.0 5919.5 5937.3 1424.4 1430.9 1442.4 1447.1 1449.2 919.8 945.3 948.2 951.4 955.0 5061.9 5070.4 5083.3 5084.3 5099.6 5995.4 6085.4 6093.6 6112.2 6123.4 4819.2 5012.9 5021.7 5022.9 5028.2 3179.9 3208.8 3220.2 3224.2 3239.6 5358.9 5568.3 5580.4 5585.6 5604.7 6201.8 6217.0 6238.2 6253.8 6256.3 5603.7 5608.2 5637.8 5660.4 5679.9 5815.6 6009.5 6079.2 6081.7 6095.6 5984.9 5994.3 5998.2 6013.9 6037.1 5404.8 5593.3 5600.0 5608.0 5631.8 4130.8 4131.5 4144.3 4150.0 4154.5 5929.7 6062.8 6136.6 6145.3 6156.0 5884.4 5899.3 5904.8 5913.7 5926.2 5888.7 5890.6 5901.9 5905.5 5913.8 5705.3 5786.0 5816.4 5819.2 5850.3 5894.7 5909.6 5929.4 5949.3 5957.6 5640.7 5712.7 5739.3 5750.8 5805.4 13:31:32 INFO - PID 28927 | 13:31:32 INFO - PID 28927 | [#5] yui.html Cycles:180 Average:18024.81 Median:3072.48 stddev:22749.78 (740.4%) stddev-sans-first:22776.61 13:31:32 INFO - PID 28927 | Values: 747.7 759.0 759.6 764.2 777.0 13619.5 15135.3 15243.1 16886.2 17520.0 16641.3 16693.7 16704.2 16898.2 17005.5 868.3 882.9 909.1 909.2 920.3 926.6 928.0 932.9 934.1 935.7 946.9 952.2 952.5 954.5 958.3 954.6 960.1 960.2 961.2 967.9 708.0 708.4 709.4 710.0 713.4 15194.7 15254.8 15378.0 15443.4 15451.7 16620.3 17049.4 17068.1 17108.7 17119.0 12850.0 13230.8 13290.3 13317.6 13335.9 3039.4 3046.1 3068.1 3076.9 3087.9 81007.6 81024.6 81803.6 82857.6 83609.0 12936.2 13251.1 13341.7 13455.5 13476.6 24603.1 24614.8 24632.0 24640.0 24839.3 6301.2 6454.9 6497.1 6504.4 6513.5 2983.9 3029.2 3033.2 3044.3 3045.9 3578.2 3656.2 3668.3 3682.1 3686.4 701.5 772.7 800.1 805.5 809.2 593.8 602.0 605.3 623.3 627.4 10352.4 10979.3 11119.2 11145.5 11412.5 589.4 595.6 601.2 608.8 616.1 4714.4 4917.1 4960.1 5115.6 5128.0 75313.0 76478.6 77625.0 79085.6 87363.0 68079.0 69750.7 75138.6 75200.0 75654.2 70966.0 72661.6 74123.6 76161.6 76290.6 11023.6 11256.7 11896.3 11966.8 12129.5 29816.9 30543.4 30543.8 30912.5 31720.7 37915.0 38277.2 38870.4 39457.4 40091.0 15190.3 15575.5 15667.6 15771.0 15897.8 16643.5 16815.5 16917.8 16998.5 17144.7 14509.6 15518.1 16116.8 16119.4 16286.8 16662.4 16746.5 16759.5 16878.5 17008.9 13907.1 13912.4 14041.9 14095.8 16850.6 10605.6 11342.9 11530.4 11610.1 11856.3 12746.2 13145.5 13398.9 13431.2 13431.9 13:31:32 INFO - PID 28927 | -------- Summary: end -------- 13:31:32 INFO - PID 28927 | 13:31:32 INFO - TEST-INFO | 28927: exit 0 13:31:32 INFO - TEST-OK | dromaeo_css | took 1146264ms 13:31:32 INFO - TEST-START | kraken 13:31:32 INFO - operating with platform_type : linux_ 13:31:32 INFO - Initialising browser for kraken test... 13:31:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42148/getInfo.html -profile /tmp/tmpDqLnd2/profile 13:31:32 INFO - TEST-INFO | started process 29327 (/builds/slave/test/build/application/firefox/firefox http://localhost:42148/getInfo.html) 13:32:07 INFO - TEST-INFO | 29327: killed by SIGTERM 13:32:07 INFO - Browser initialized. 13:32:07 INFO - Running cycle 1/1 for kraken test... 13:32:07 INFO - TEST-INFO | started process 29522 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDqLnd2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:32:19 INFO - PID 29522 | RSS: Main: 168857600 13:32:19 INFO - PID 29522 | 13:32:22 INFO - PID 29522 | Cycle 1(1): loaded http://localhost:42148/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42148/tests/kraken/driver.html?testName=audio-beat-detection) 13:32:23 INFO - PID 29522 | RSS: Main: 174686208 13:32:23 INFO - PID 29522 | 13:32:25 INFO - PID 29522 | Cycle 1(1): loaded http://localhost:42148/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42148/tests/kraken/driver.html?testName=audio-dft) 13:32:26 INFO - PID 29522 | RSS: Main: 173834240 13:32:26 INFO - PID 29522 | 13:32:29 INFO - PID 29522 | Cycle 1(1): loaded http://localhost:42148/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42148/tests/kraken/driver.html?testName=audio-fft) 13:32:30 INFO - PID 29522 | RSS: Main: 171409408 13:32:30 INFO - PID 29522 | 13:32:32 INFO - PID 29522 | Cycle 1(1): loaded http://localhost:42148/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42148/tests/kraken/driver.html?testName=audio-oscillator) 13:32:32 INFO - PID 29522 | RSS: Main: 172199936 13:32:32 INFO - PID 29522 | 13:32:34 INFO - PID 29522 | Cycle 1(1): loaded http://localhost:42148/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42148/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:32:35 INFO - PID 29522 | RSS: Main: 172158976 13:32:35 INFO - PID 29522 | 13:32:38 INFO - PID 29522 | Cycle 1(1): loaded http://localhost:42148/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42148/tests/kraken/driver.html?testName=imaging-darkroom) 13:32:39 INFO - PID 29522 | RSS: Main: 173273088 13:32:39 INFO - PID 29522 | 13:32:42 INFO - PID 29522 | Cycle 1(1): loaded http://localhost:42148/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42148/tests/kraken/driver.html?testName=imaging-desaturate) 13:32:43 INFO - PID 29522 | RSS: Main: 171909120 13:32:43 INFO - PID 29522 | 13:32:46 INFO - PID 29522 | Cycle 1(1): loaded http://localhost:42148/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42148/tests/kraken/driver.html?testName=json-parse-financial) 13:32:47 INFO - PID 29522 | RSS: Main: 172843008 13:32:47 INFO - PID 29522 | 13:32:48 INFO - PID 29522 | Cycle 1(1): loaded http://localhost:42148/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42148/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:32:49 INFO - PID 29522 | RSS: Main: 172507136 13:32:49 INFO - PID 29522 | 13:32:51 INFO - PID 29522 | Cycle 1(1): loaded http://localhost:42148/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42148/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:32:51 INFO - PID 29522 | RSS: Main: 172945408 13:32:51 INFO - PID 29522 | 13:32:53 INFO - PID 29522 | Cycle 1(1): loaded http://localhost:42148/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42148/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:32:54 INFO - PID 29522 | RSS: Main: 173137920 13:32:54 INFO - PID 29522 | 13:32:57 INFO - PID 29522 | Cycle 1(1): loaded http://localhost:42148/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:32:58 INFO - PID 29522 | RSS: Main: 173072384 13:32:58 INFO - PID 29522 | 13:33:01 INFO - PID 29522 | Cycle 1(1): loaded http://localhost:42148/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:33:01 INFO - PID 29522 | RSS: Main: 172593152 13:33:01 INFO - PID 29522 | 13:33:03 INFO - PID 29522 | Cycle 1(1): loaded http://localhost:42148/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42148/tests/kraken/driver.html?testName=ai-astar) 13:33:04 INFO - PID 29522 | RSS: Main: 174194688 13:33:04 INFO - PID 29522 | 13:33:04 INFO - PID 29522 | __start_tp_report 13:33:04 INFO - PID 29522 | _x_x_mozilla_page_load 13:33:04 INFO - PID 29522 | _x_x_mozilla_page_load_details 13:33:04 INFO - PID 29522 | |i|pagename|runs| 13:33:04 INFO - PID 29522 | |0;ai-astar;106;111;115;110;113;111;111;110;111;111 13:33:04 INFO - PID 29522 | |1;audio-beat-detection;144;124;126;170;122;124;122;121;146;123 13:33:04 INFO - PID 29522 | |2;audio-dft;165;165;163;164;166;171;165;178;163;171 13:33:04 INFO - PID 29522 | |3;audio-fft;73;75;75;121;73;74;75;75;96;74 13:33:04 INFO - PID 29522 | |4;audio-oscillator;83;85;101;86;85;86;98;90;84;104 13:33:04 INFO - PID 29522 | |5;imaging-gaussian-blur;115;120;114;114;113;114;114;114;114;114 13:33:04 INFO - PID 29522 | |6;imaging-darkroom;152;151;153;152;153;151;153;150;150;150 13:33:04 INFO - PID 29522 | |7;imaging-desaturate;94;98;94;94;97;100;94;95;94;94 13:33:04 INFO - PID 29522 | |8;json-parse-financial;58;53;54;53;54;55;56;59;57;55 13:33:04 INFO - PID 29522 | |9;json-stringify-tinderbox;56;58;56;57;56;55;56;56;55;57 13:33:04 INFO - PID 29522 | |10;stanford-crypto-aes;90;89;90;88;89;88;88;91;128;88 13:33:04 INFO - PID 29522 | |11;stanford-crypto-ccm;133;139;135;140;146;152;137;136;146;140 13:33:04 INFO - PID 29522 | |12;stanford-crypto-pbkdf2;196;196;193;196;202;212;197;197;203;201 13:33:04 INFO - PID 29522 | |13;stanford-crypto-sha256-iterative;75;72;75;75;76;75;71;75;72;74 13:33:04 INFO - PID 29522 | __end_tp_report 13:33:04 INFO - PID 29522 | __start_cc_report 13:33:04 INFO - PID 29522 | _x_x_mozilla_cycle_collect,926 13:33:04 INFO - PID 29522 | __end_cc_report 13:33:04 INFO - PID 29522 | __startTimestamp1495830784036__endTimestamp 13:33:04 INFO - PID 29522 | 13:33:04 INFO - PID 29522 | ------- Summary: start ------- 13:33:04 INFO - PID 29522 | Number of tests: 14 13:33:04 INFO - PID 29522 | 13:33:04 INFO - PID 29522 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:2.28 (2.1%) stddev-sans-first:1.59 13:33:04 INFO - PID 29522 | Values: 106.0 111.0 115.0 110.0 113.0 111.0 111.0 110.0 111.0 111.0 13:33:04 INFO - PID 29522 | 13:33:04 INFO - PID 29522 | [#1] audio-beat-detection Cycles:10 Average:132.20 Median:125.00 stddev:16.16 (12.9%) stddev-sans-first:16.56 13:33:04 INFO - PID 29522 | Values: 144.0 124.0 126.0 170.0 122.0 124.0 122.0 121.0 146.0 123.0 13:33:04 INFO - PID 29522 | 13:33:04 INFO - PID 29522 | [#2] audio-dft Cycles:10 Average:167.10 Median:165.50 stddev:4.79 (2.9%) stddev-sans-first:5.02 13:33:04 INFO - PID 29522 | Values: 165.0 165.0 163.0 164.0 166.0 171.0 165.0 178.0 163.0 171.0 13:33:04 INFO - PID 29522 | 13:33:04 INFO - PID 29522 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:15.62 (20.8%) stddev-sans-first:16.29 13:33:04 INFO - PID 29522 | Values: 73.0 75.0 75.0 121.0 73.0 74.0 75.0 75.0 96.0 74.0 13:33:04 INFO - PID 29522 | 13:33:04 INFO - PID 29522 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:85.50 stddev:7.80 (9.1%) stddev-sans-first:7.83 13:33:04 INFO - PID 29522 | Values: 83.0 85.0 101.0 86.0 85.0 86.0 98.0 90.0 84.0 104.0 13:33:04 INFO - PID 29522 | 13:33:04 INFO - PID 29522 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.00 stddev:1.96 (1.7%) stddev-sans-first:2.07 13:33:04 INFO - PID 29522 | Values: 115.0 120.0 114.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 13:33:04 INFO - PID 29522 | 13:33:04 INFO - PID 29522 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:152.00 stddev:1.27 (0.8%) stddev-sans-first:1.33 13:33:04 INFO - PID 29522 | Values: 152.0 151.0 153.0 152.0 153.0 151.0 153.0 150.0 150.0 150.0 13:33:04 INFO - PID 29522 | 13:33:04 INFO - PID 29522 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:94.00 stddev:2.17 (2.3%) stddev-sans-first:2.24 13:33:04 INFO - PID 29522 | Values: 94.0 98.0 94.0 94.0 97.0 100.0 94.0 95.0 94.0 94.0 13:33:04 INFO - PID 29522 | 13:33:04 INFO - PID 29522 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:2.07 (3.7%) stddev-sans-first:1.96 13:33:04 INFO - PID 29522 | Values: 58.0 53.0 54.0 53.0 54.0 55.0 56.0 59.0 57.0 55.0 13:33:04 INFO - PID 29522 | 13:33:04 INFO - PID 29522 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:56.00 stddev:0.92 (1.6%) stddev-sans-first:0.97 13:33:04 INFO - PID 29522 | Values: 56.0 58.0 56.0 57.0 56.0 55.0 56.0 56.0 55.0 57.0 13:33:04 INFO - PID 29522 | 13:33:04 INFO - PID 29522 | [#10] stanford-crypto-aes Cycles:10 Average:92.90 Median:89.00 stddev:12.38 (13.9%) stddev-sans-first:13.08 13:33:04 INFO - PID 29522 | Values: 90.0 89.0 90.0 88.0 89.0 88.0 88.0 91.0 128.0 88.0 13:33:04 INFO - PID 29522 | 13:33:04 INFO - PID 29522 | [#11] stanford-crypto-ccm Cycles:10 Average:140.40 Median:140.00 stddev:5.91 (4.2%) stddev-sans-first:5.63 13:33:04 INFO - PID 29522 | Values: 133.0 139.0 135.0 140.0 146.0 152.0 137.0 136.0 146.0 140.0 13:33:04 INFO - PID 29522 | 13:33:04 INFO - PID 29522 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.30 Median:199.00 stddev:5.46 (2.7%) stddev-sans-first:5.66 13:33:04 INFO - PID 29522 | Values: 196.0 196.0 193.0 196.0 202.0 212.0 197.0 197.0 203.0 201.0 13:33:04 INFO - PID 29522 | 13:33:04 INFO - PID 29522 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:75.00 stddev:1.70 (2.3%) stddev-sans-first:1.76 13:33:04 INFO - PID 29522 | Values: 75.0 72.0 75.0 75.0 76.0 75.0 71.0 75.0 72.0 74.0 13:33:04 INFO - PID 29522 | -------- Summary: end -------- 13:33:04 INFO - PID 29522 | 13:33:05 INFO - TEST-INFO | 29522: exit 0 13:33:05 INFO - TEST-OK | kraken | took 92347ms 13:33:05 INFO - SUITE-END | took 1238s 13:33:05 INFO - Completed test suite (00:20:38) 13:33:05 INFO - javascript benchmark 13:33:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6941.960125160987, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2722.809403341766, 2744.807863449557, 2750.931226719332, 2779.6386469758936, 2784.2343355577214, 5219.9478005219935, 5366.221897824813, 5366.409694933554, 5372.247885296057, 5375.30121084259, 5303.840884773463, 5332.733363331828, 5341.919871201935, 5413.972930135344, 5430.239766432703, 4462.419885414892, 4692.9431671145585, 4744.97627511862, 4772.7136371817805, 4775.689580177294, 4832.0, 4832.17852964995, 4862.270659401101, 4887.951120488785, 4924.433690125646, 4622.0, 4648.1168577970075, 4735.573798358164, 4789.401324834395, 4797.640176986705, 4780.593649539794, 4783.856484305476, 4795.664303498756, 4816.277558366238, 4834.395700537433, 4716.50476699945, 4736.455307639631, 4737.147313483571, 4746.596539294164, 4758.833440829589, 5219.217117432416, 5324.254604355393, 5338.839834804962, 5362.544183744348, 5364.839054828361, 5720.570957178186, 5753.884922301572, 5827.038538641119, 5837.890800747844, 5839.9124013139835, 5845.035569131088, 5854.590178687494, 5868.735906884158, 5908.291005079418, 5924.2298501195, 5407.864803379947, 5423.322084739408, 5436.130219164915, 5437.293151890229, 5438.238646589481, 5776.133579962955, 5810.273715785527, 5991.4907232884825, 6001.2498437695285, 6005.519558435315, 5608.523275521545, 5636.520895723909, 5639.351474580476, 5647.124695672177, 5664.915026274609, 5729.4843464088435, 5842.620229685142, 5860.794872179454, 5877.118432235199, 5891.116332550152, 5637.210790489253, 5833.154192642043, 5841.591088623841, 5850.444207800252, 5852.209951656472, 5706.087026075808, 5731.426857314235, 5766.163906233573, 5797.652140871562, 5850.034744267234, 4883.389576302962, 4898.338724272177, 4899.632527560448, 4902.994886048352, 4944.728039957837, 4138.813753381105, 4152.6055024772595, 4158.8336466540995, 4162.62536371728, 4200.159968006411, 4718.95281047192, 4810.6151507879285, 4868.853934381974, 4921.064997650435, 4941.50584941503, 5785.218995435646, 5786.218860453869, 5797.304323481209, 5798.33319168301, 5831.271091113611, 4876.024795041006, 4876.390451193601, 4881.389826271716, 4882.951170488321, 4914.33656456381, 5003.274525193827, 5026.271190677331, 5073.213651883964, 5109.20807274873, 5134.897302053938, 5421.918671219856, 5458.4814442627885, 5467.343918729778, 5467.4532546745, 5483.122700367922, 5694.487496125369, 5815.621984570989, 5859.44335288147, 5872.911906321323, 5877.059670452707, 5271.973640131775, 5279.577633789365, 5375.892482150257, 5464.726763661881, 5467.781288748564, 5621.747021383966, 5735.8566035849435, 5739.339975902658, 5751.051076572318, 5789.334226563999, 5636.661800291996, 5668.574856885833, 5790.85522861915, 5854.414558544111, 5917.37867523921, 5654.321481422256, 5666.405027472056, 5670.773169073191, 5683.0, 5710.000749868839, 5662.178984047207, 5681.403452637579, 5683.488486036276, 5688.0, 5692.345380281155, 5383.461653834585, 5573.6098473106495, 5620.4098569649595, 5627.493525582717, 5628.0, 5561.360443548881, 5611.775528978958, 5640.407757185437, 5641.182028605911, 5653.180288858175, 5558.972205138948, 5593.412691667317, 5593.664380137205, 5612.85967850807, 5619.9719001406365], "value": 5245.10622851379, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.1365311442012, 701.3022043067148, 721.5093736259344, 1066.9093127084202, 1071.8124328242566, 31011.534826977586, 31878.840605796966, 31890.20274493139, 31974.20064498386, 32236.0, 33865.0, 34231.82884085582, 34442.48336274952, 34480.48279275806, 34509.48235776465, 6588.341165883421, 6715.194176698803, 6971.058907047547, 7055.365017148456, 7058.011878337037, 6671.966640166793, 6728.0, 6796.898046529306, 6810.387065164135, 6813.591184528919, 6794.490413219004, 6816.318368163194, 6820.761273355433, 6830.4877134214885, 6871.965640171792, 6763.797086087426, 6771.5937043777285, 6789.219239787413, 6806.251312355637, 6814.522983391164, 6743.93256067438, 6767.4924380671155, 6790.151231096113, 6796.864062718718, 6813.488988325846, 31206.063818085495, 31271.530927036114, 31294.687053129404, 31469.37061258762, 31480.842595787104, 3029.5758593796886, 3048.1465189746905, 3051.3897220555755, 3054.6487153977355, 3064.5709600655928, 23825.880870595534, 23860.880695596585, 24079.759202407928, 24237.151699690603, 24247.636285455734, 2905.418916216765, 2910.83990380529, 2913.9271518212004, 2937.8090424122365, 2960.6003189569346, 142774.0, 143825.28087359495, 144014.0, 147765.0, 151221.68280744666, 37322.06694832651, 37522.0, 37526.0, 37587.43618845719, 37594.0, 39851.0, 39946.80026599907, 40017.1996560073, 42619.786901065294, 43442.0, 13298.268595227355, 13381.732365352638, 13414.463421463031, 13478.932605336911, 13496.325183740773, 10752.731181720519, 10812.243142979916, 10871.565137394417, 10885.836712449161, 10889.945550272198, 12732.872671273353, 12735.235885846694, 12808.615741527768, 12832.422540985677, 12862.614121576367, 5409.756560954766, 5487.368952570426, 5501.889962200734, 5514.91727624086, 5566.081596536607, 858.1375717403969, 874.5889431966965, 904.7201053345533, 905.9954700226589, 924.5100096948628, 19466.8053319465, 20337.18651253963, 20347.593048138955, 20540.281090161774, 20800.375988720363, 960.3277705606104, 978.1392374710351, 987.6049580167846, 988.9505524723735, 992.93545919515, 10345.482725863827, 10838.945805270923, 10915.181361397768, 10993.890061099446, 11046.779064418666, 176145.11927440538, 176219.0, 178000.0, 178169.10915445338, 178395.10802446163, 38711.41932871009, 39328.21343573112, 39590.0, 39600.60399395969, 39709.40435893406, 1201.501376928565, 1233.648410203088, 1249.4252643783962, 1254.5358217459598, 1256.114439320277, 19408.8059119407, 19596.706049408986, 19674.40976770699, 20325.288614898407, 20731.274405396343, 28836.0, 28839.279018024718, 28919.42161156723, 28942.85528572428, 28950.276243094093, 149080.25459873065, 149580.0, 149916.0, 150300.0, 150317.0, 28722.712772872004, 29055.56416653794, 29135.0, 29142.085791421538, 29159.708402915698, 33937.49093763546, 34120.317593647495, 34609.65390346065, 35006.47490287699, 35097.47353789644, 26675.333116671463, 26909.0, 27006.729932700422, 27044.864775675996, 28128.29679258035, 26403.20790376292, 26796.196114116607, 27267.727322726518, 27666.0, 27692.723072769015, 29044.419111618074, 29688.55467167951, 29768.70231297659, 29779.702202977693, 29815.701842982162, 25508.48983020292, 25640.36054730586, 26064.087756928417, 26818.195454136407, 27100.32249193786, 20862.582748344645, 21805.781942180376, 21855.562888741817, 21873.234436794635, 22065.227717029826], "value": 14285.538586445373, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.4137956730171, 403.3888658682095, 418.9643880270176, 428.9356596510523, 430.47912026447995, 14895.0, 15776.76334854978, 17627.911860440698, 18280.360187393442, 18380.72428913566, 18761.437156885317, 18849.81150188498, 18946.810531894676, 19013.619727605474, 19212.231510739555, 5223.477652234765, 5376.489233522809, 5476.91784623231, 5482.259894914176, 5538.529225015878, 5301.7084060376665, 5445.754941027643, 5463.31708536433, 5464.12573988162, 5475.4524547545325, 5003.449620541737, 5427.457254274561, 5431.674099554019, 5442.8911421771545, 5453.64551304166, 5249.448807875195, 5329.120695085326, 5336.466353364672, 5375.086235340002, 5381.327334083239, 4956.504349565051, 4983.875403114915, 5013.623978201649, 5028.019536190444, 5028.522290382444, 21925.12299508018, 22086.558268834535, 22447.214347497924, 22530.0, 22587.096516139336, 1618.0776957134437, 1618.4659062509343, 1636.909969951652, 1637.214137214132, 1647.736362182045, 14517.128972261593, 14879.0, 14974.0, 15071.623209419742, 15101.546953591409, 2030.1168991488603, 2033.725447064657, 2090.446031801574, 2093.675480300556, 2115.375964090597, 89742.0, 90543.54728226317, 90833.8249557543, 99047.0, 103687.0, 17705.557361066076, 17775.0, 17817.910910445364, 17904.641907161782, 18224.544386390447, 32914.5062824053, 33091.50362744561, 33097.83451082729, 33155.83422082874, 33372.0, 8441.57792110392, 8469.153084691605, 8546.31629469641, 8679.783005424915, 8730.126987301346, 6749.190097188369, 6792.932070679329, 6965.407940325129, 6979.720811167598, 6987.475939304572, 9222.723318300461, 9486.430814151174, 9499.24006079512, 9644.614215431304, 9666.661666841626, 3321.877435210894, 3555.5911070227253, 3658.378075727133, 3756.342640038037, 3829.483019792348, 835.0980940584154, 864.8400045991511, 868.4398562926876, 868.5657171414293, 893.2585953658448, 16623.418180363627, 16884.155792210342, 16990.660186796442, 17066.658666826595, 17629.7355539667, 859.351189851658, 871.2246100970142, 871.2463718883247, 879.6349514951223, 895.6462197431978, 9310.581023853807, 9408.106229908148, 9527.285453591008, 9581.616735330508, 9616.182624476858, 365151.0, 365308.0, 371101.0, 371449.0, 372631.0, 75667.0, 76594.61702691563, 76943.0, 77357.61321193358, 78459.21540784634, 1016.4409574734015, 1043.3218408034838, 1067.7757670889046, 1070.3043022035583, 1070.3898777696793, 14362.928185359006, 14672.559823205322, 14753.704925901637, 14968.476103336767, 15283.541493755205, 38054.0, 38142.23715525618, 38333.42499862448, 39367.40948885826, 39742.0, 46671.533284666715, 47751.0, 47831.282530762765, 48297.5170248293, 49372.75313623409, 8413.87379189325, 8550.700725474579, 8607.913920860712, 8660.870086948575, 8796.252318552739, 12801.487940482277, 12995.415206315927, 13007.414666339848, 13333.133346332457, 13398.598042058753, 11445.42772861337, 11471.770564588829, 11493.48279327449, 11495.286932357692, 11783.941080294544, 10572.154227661922, 10700.30448020876, 10925.399103049409, 11113.0, 11174.553017879194, 11487.13846461502, 11515.424228788695, 11643.825342620037, 11877.109216808947, 11902.28586284791, 8331.0, 8376.371772117238, 8414.326853851555, 8458.154184581492, 8789.912100879164, 10872.61945831892, 11152.609658661908, 11333.603323883624, 11485.013896386832, 11628.069754419457], "value": 9420.99613567399, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1259.244453328003, 1313.5139998200661, 1314.9276789776561, 1318.5385115209672, 1326.4097476622906, 10422.895771042287, 10814.891851081487, 10921.5631374745, 10943.28868623539, 11342.376169310684, 11048.0, 11287.604933827317, 11303.491342889569, 11312.095032397408, 11335.093192544597, 2077.428707105543, 2107.9789202107936, 2116.740539379067, 2119.713838631788, 2127.5957568062095, 2187.6827859960295, 2225.432514708755, 2234.307364716935, 2237.093976939342, 2249.955000899981, 2138.101997161196, 2172.4134483689395, 2192.9232476863313, 2193.9890300548477, 2197.1760589778833, 2151.397608669575, 2152.171414005619, 2160.7299087614047, 2167.143978128638, 2171.337741988693, 2056.3830850744716, 2089.498520355119, 2107.546877421362, 2112.2290364017176, 2187.529681118567, 10639.0, 10744.892551074467, 10748.570057197703, 10748.946255268673, 10765.784684306349, 5560.86097847553, 5817.0983497557945, 5818.389069147721, 5828.125781132821, 5832.941670583282, 3289.605247370307, 3389.1696534349244, 3483.164040630256, 3483.3381657484997, 3486.9825650871585, 1058.5924419098626, 1063.7500187455942, 1069.0538873097364, 1074.5218377821873, 1103.271840585218, 16010.119443430607, 16057.678846423007, 16136.919315403466, 16182.75725864113, 16202.35190592375, 4701.271302948048, 4747.0, 4912.729799861042, 4956.553910148104, 4979.90040199194, 11512.424378781028, 11568.537258509734, 11581.88418115825, 11612.535498580131, 11623.186376953532, 5554.750036248298, 5732.484076433141, 5748.051571490657, 5756.481916627524, 5763.85590360236, 5285.841424757264, 5291.0, 5349.117395629755, 5362.2224777407055, 5393.406725260218, 3957.2876882160913, 3982.2234664240773, 4010.578889216649, 4015.5783642717092, 4063.512378514538, 1145.856767904012, 1157.791597512439, 1169.3217933598492, 1175.588544009607, 1180.0795379603924, 727.7052793618593, 751.48523261566, 752.6462562595572, 762.2415696382135, 763.3702195688579, 5828.59199856006, 6005.0, 6005.849853753603, 6413.454856337264, 6523.478121750249, 545.9808906688247, 548.5447078924562, 557.9944200558024, 567.0671744979486, 567.1974156568409, 3750.381187104097, 3827.469012395064, 3968.6031396860662, 4046.838126474967, 4048.5748996355546, 13770.173789572658, 14000.579982600539, 14200.011998320244, 14273.714525709427, 14277.92861035709, 13554.118982266122, 14144.929275353557, 14354.569362919128, 14373.568792936228, 14447.85552144486, 7571.129320128146, 7777.222277772291, 7798.298153166243, 7881.935938648209, 7947.84104317922, 6110.663913484623, 6209.751609935552, 6363.331850155667, 6444.709988050643, 6680.565763225375, 12617.242965422103, 12697.4286157125, 12772.169808962388, 12900.935495322463, 12973.416196271002, 13018.218906865619, 13227.404766785325, 13265.270410127536, 13290.20258784476, 13333.20000799955, 7760.223977602421, 7952.244536768998, 7955.403344749051, 7970.681172753025, 7985.041794984639, 9986.151177150025, 10058.54736536843, 10110.241731870286, 10119.898801011896, 10134.493275336352, 8344.123866994121, 8606.78483037929, 8624.016476210381, 8636.17956294151, 8788.07725188846, 8383.496990180609, 8496.872546911678, 8514.31885449175, 8591.44155629882, 8731.0, 7405.629718513945, 7531.397488201041, 7543.434242431949, 7554.357879580078, 7560.546367217985, 5596.468335508121, 5733.082706766897, 5772.9711351442975, 5871.559633027626, 5936.970315148569, 5570.442955704397, 5624.268845050281, 5667.40492248308, 5693.886122277614, 5795.39148389413], "value": 4864.93789070187, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.1133917796196, 341.26116956788553, 356.97594638400267, 359.35137077574984, 364.1152000638449, 5614.129809879465, 5641.041023026085, 5646.576506761989, 5651.830445086649, 5663.7168141592965, 5287.41838397776, 5493.587980901429, 5494.587905907063, 5495.175723641456, 5506.889862202754, 4112.712110152291, 4120.793960301988, 4158.812853421603, 4160.375943608453, 4178.8328466861285, 4137.503499580054, 4140.461739973799, 4147.523034851, 4150.9584904151025, 4171.833126674929, 4062.9796851015703, 4090.202410529948, 4101.79491025449, 4102.17956408718, 4104.220198162355, 4028.2346354192755, 4093.7543747375253, 4109.383592461125, 4117.5618358670545, 4124.370873504979, 3551.786892786441, 3555.1289933966086, 3589.2821435712963, 3590.6409359064146, 3594.856205751767, 5356.11624082026, 5367.141257398797, 5384.6769193848495, 5385.165299378603, 5392.973035134838, 4635.235186194274, 4790.365299085489, 4818.807247710122, 4837.984023355099, 4848.418189817245, 5835.533157347402, 5837.241158649391, 5847.210626565445, 5849.6197747146725, 5865.472107510344, 3998.6001399860074, 4005.37916622921, 4005.8798236052967, 4013.6554254324838, 4020.8190631421658, 6023.638581685069, 6057.849008688335, 6158.476529494998, 6194.0, 6198.814035578985, 4108.4453598764385, 4127.504699436087, 4130.3772104713125, 4134.235166494208, 4145.54399016108, 4158.500979882433, 4174.874753757392, 4189.392538081961, 4202.117555313418, 4211.578842115825, 4717.198076327033, 4835.95164048362, 4856.587190088811, 4871.415430148405, 4884.7069175849565, 5892.852678683067, 5909.468147866627, 5913.0, 5919.467247947706, 5937.317208521075, 1424.3661570600982, 1430.9499167529086, 1442.3725679329525, 1447.117258472331, 1449.166729130754, 919.7608621758391, 945.2984627670166, 948.184561277301, 951.3911096897991, 954.9761255968656, 5061.924071138936, 5070.391553013588, 5083.339165908408, 5084.313617661643, 5099.59203263738, 5995.370486098984, 6085.413699177831, 6093.6039157454625, 6112.205413296243, 6123.38766123393, 4819.156647586658, 5012.874678133076, 5021.6735912165595, 5022.949770502321, 5028.195488721787, 3179.920501987469, 3208.7593430492807, 3220.2271454850666, 3224.193951512122, 3239.5626590410466, 5358.946410535923, 5568.276124103841, 5580.441955804468, 5585.636933599303, 5604.663720176803, 6201.782937597162, 6216.968915155486, 6238.157848690459, 6253.78111766086, 6256.311805701369, 5603.691796951125, 5608.158776183605, 5637.830865074055, 5660.37735849048, 5679.858003549779, 5815.621984570989, 6009.54928380382, 6079.179310792986, 6081.665508397081, 6095.634261944298, 5984.850378740566, 5994.280686317496, 5998.220231369894, 6013.939860601338, 6037.124616930609, 5404.78380864761, 5593.300837395325, 5600.047991841316, 5607.971960140173, 5631.802886898939, 4130.793460327031, 4131.50421949368, 4144.316187829095, 4150.0, 4154.459920210354, 5929.733162007807, 6062.848428789139, 6136.637394603021, 6145.324014358506, 6156.0, 5884.382139875423, 5899.262592175978, 5904.793332233351, 5913.704314784158, 5926.2295901532525, 5888.735006924613, 5890.617109887844, 5901.881962360814, 5905.52755779528, 5913.793017244376, 5705.288413475858, 5786.0, 5816.389279125631, 5819.214406055128, 5850.297964244318, 5894.6757928314355, 5909.5863289569315, 5929.377415371324, 5949.3455719871645, 5957.553183511341, 5640.730835561966, 5712.742926568231, 5739.273844923795, 5750.827475175752, 5805.390434004369], "value": 4345.340754143878, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.67102474911, 759.0360242492035, 759.5860256160393, 764.2243123229922, 777.0131932445794, 13619.523316683906, 15135.318910649006, 15243.085414875102, 16886.240119194634, 17520.0, 16641.33434662612, 16693.66612667746, 16704.248308826103, 16898.239579218935, 17005.48983530493, 868.3053557154283, 882.8940527136753, 909.1136142261308, 909.1999040844048, 920.2913756407562, 926.5552534783308, 928.03020843219, 932.8880534335889, 934.0892629686069, 935.6818681648239, 946.9147776700096, 952.1716106986931, 952.4761381240324, 954.4750387286999, 958.314804914486, 954.551360860398, 960.0687333286701, 960.1838437328215, 961.1829944547148, 967.9322447428683, 707.989380159298, 708.3695510995218, 709.4253654539839, 709.9645017749092, 713.4114355656604, 15194.696106077816, 15254.847451525453, 15378.0, 15443.382264709398, 15451.690966180613, 16620.33518659252, 17049.403270885585, 17068.146592670317, 17108.657826843395, 17119.0, 12850.0, 13230.801537976939, 13290.26903520306, 13317.600471985856, 13335.933320333434, 3039.392121575672, 3046.055722725962, 3068.079576127153, 3076.8769249230004, 3087.8764849405998, 81007.5949620254, 81024.59487702583, 81803.59098204471, 82857.58571207165, 83609.0, 12936.223826570436, 13251.138675986223, 13341.733165336638, 13455.529056482976, 13476.595702128952, 24603.13889013912, 24614.753852461603, 24632.0, 24640.0, 24839.254822355357, 6301.243850737941, 6454.870902582016, 6497.122888410098, 6504.414602685781, 6513.478921686348, 2983.925401864927, 3029.2124047747743, 3033.2113650451042, 3044.3150291184306, 3045.893393731253, 3578.248567800791, 3656.232191239816, 3668.3396988542318, 3682.0978860179425, 3686.4286035664513, 701.4879138229121, 772.7218201447474, 800.0519384529351, 805.5126648377648, 809.1867672988609, 593.7921727395377, 601.9939800602026, 605.2797171366149, 623.2863371439677, 627.4133685004535, 10352.430616316175, 10979.341239525655, 11119.22165448427, 11145.49845256949, 11412.543498259976, 589.4488653109356, 595.6068994463633, 601.1974014690437, 608.8356143841138, 616.0635833533005, 4714.363560919301, 4917.139500587383, 4960.082384758831, 5115.590752739772, 5127.974360128175, 75313.0, 76478.61760691273, 77625.0, 79085.60457197677, 87363.0, 68079.0, 69750.65124674344, 75138.62430687812, 75200.0, 75654.24345756472, 70966.0, 72661.63669181726, 74123.62938185383, 76161.61919190368, 76290.61854690692, 11023.559057637605, 11256.662300130682, 11896.286222826659, 11966.820497692368, 12129.514819407124, 29816.850915745283, 30543.389132217675, 30543.847280763453, 30912.536311955788, 31720.682793172695, 37915.0, 38277.23445531129, 38870.41694374643, 39457.40813887736, 40091.0, 15190.316435760196, 15575.454859079879, 15667.60830979189, 15771.0, 15897.841021589637, 16643.50069497917, 16815.495535133967, 16917.830821692118, 16998.490045298662, 17144.742828857827, 14509.637259068608, 15518.068915865084, 16116.838831611534, 16119.435819746253, 16286.837131629007, 16662.4168154114, 16746.49760507187, 16759.497215083567, 16878.493645190665, 17008.914955425145, 13907.096038757449, 13912.443502260201, 14041.859581404055, 14095.788563171356, 16850.57873553171, 10605.628802991858, 11342.905447527066, 11530.365829879438, 11610.071194304266, 11856.288622682321, 12746.235225886476, 13145.53990610324, 13398.866011339762, 13431.19412835233, 13431.865681343452], "value": 7499.162484288177, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1561.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 111.0, 115.0, 110.0, 113.0, 111.0, 111.0, 110.0, 111.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 124.0, 126.0, 170.0, 122.0, 124.0, 122.0, 121.0, 146.0, 123.0], "value": 132.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 163.0, 164.0, 166.0, 171.0, 165.0, 178.0, 163.0, 171.0], "value": 167.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 121.0, 73.0, 74.0, 75.0, 75.0, 96.0, 74.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 101.0, 86.0, 85.0, 86.0, 98.0, 90.0, 84.0, 104.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 120.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 153.0, 152.0, 153.0, 151.0, 153.0, 150.0, 150.0, 150.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 98.0, 94.0, 94.0, 97.0, 100.0, 94.0, 95.0, 94.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 54.0, 53.0, 54.0, 55.0, 56.0, 59.0, 57.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 56.0, 57.0, 56.0, 55.0, 56.0, 56.0, 55.0, 57.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 90.0, 88.0, 89.0, 88.0, 88.0, 91.0, 128.0, 88.0], "value": 92.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 139.0, 135.0, 140.0, 146.0, 152.0, 137.0, 136.0, 146.0, 140.0], "value": 140.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 196.0, 193.0, 196.0, 202.0, 212.0, 197.0, 197.0, 203.0, 201.0], "value": 199.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 75.0, 75.0, 76.0, 75.0, 71.0, 75.0, 72.0, 74.0], "value": 74.0, "unit": "score"}]}]} 13:33:05 INFO - Return code: 0 13:33:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:33:05 INFO - # TBPL SUCCESS # 13:33:05 INFO - Running post-action listener: _resource_record_post_action 13:33:05 INFO - [mozharness: 2017-05-26 20:33:05.357323Z] Finished run-tests step (success) 13:33:05 INFO - Running post-run listener: _resource_record_post_run 13:33:05 INFO - Total resource usage - Wall time: 1254s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400109568; Read time: 8; Write time: 238996 13:33:05 INFO - TinderboxPrint: CPU usage
12.6% 13:33:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 13:33:05 INFO - TinderboxPrint: I/O write bytes / time
400,109,568 / 238,996 13:33:05 INFO - TinderboxPrint: CPU idle
8,742.2 (87.3%) 13:33:05 INFO - TinderboxPrint: CPU user
1,213.5 (12.1%) 13:33:05 INFO - TinderboxPrint: Swap in / out
0 / 0 13:33:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 93687808; Read time: 0; Write time: 66352 13:33:05 INFO - run-tests - Wall time: 1239s; CPU: 13.0%; Read bytes: 4096; Write bytes: 306421760; Read time: 8; Write time: 172644 13:33:06 INFO - Running post-run listener: _upload_blobber_files 13:33:06 INFO - Blob upload gear active. 13:33:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:33:06 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 13:33:06 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'] 13:33:06 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 13:33:06 INFO - (blobuploader) - INFO - Open directory for files ... 13:33:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:33:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:33:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:33:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:33:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:33:08 INFO - (blobuploader) - INFO - Done attempting. 13:33:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:33:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:33:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:33:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:33:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:33:12 INFO - (blobuploader) - INFO - Done attempting. 13:33:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:33:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:33:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:33:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:33:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:33:13 INFO - (blobuploader) - INFO - Done attempting. 13:33:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:33:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:33:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:33:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:33:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:33:14 INFO - (blobuploader) - INFO - Done attempting. 13:33:14 INFO - (blobuploader) - INFO - Iteration through files over. 13:33:14 INFO - Return code: 0 13:33:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:33:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:33:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7f27cf3a4136fe6dc84eb03b3b79493e4bba1ad5ebe32467e6b38afe579d5e70a136317269bf60073913d5e6b8b3486ff0eb06e88bbe5411751224870b4499f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/447672cf98982aec45ef69df68364921d3adcccb772da6fd894f004d6cdbce147a9c227dc53e70af8610e97a1f0725ebaf04234729aeac7698f23cd9d0bab8f9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9fe5ad4ed32d5e5352e3dcc7170cb46d2f74bb2b638c626b0cef63fa0211f6ec95a2977d2c46b5920c6df518c640438c976f66b043a59670bb2f22001eddf3e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4275c5cb8ea31dbd0fadcecf4cb460578ba7f20ec2178a0624c5ad238002ef317e65b8efdeeb0a5cef73e455444b1a59ad8335c20d23dfe4b5b073e93df2c741"} 13:33:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:33:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:33:14 INFO - Contents: 13:33:14 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7f27cf3a4136fe6dc84eb03b3b79493e4bba1ad5ebe32467e6b38afe579d5e70a136317269bf60073913d5e6b8b3486ff0eb06e88bbe5411751224870b4499f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/447672cf98982aec45ef69df68364921d3adcccb772da6fd894f004d6cdbce147a9c227dc53e70af8610e97a1f0725ebaf04234729aeac7698f23cd9d0bab8f9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9fe5ad4ed32d5e5352e3dcc7170cb46d2f74bb2b638c626b0cef63fa0211f6ec95a2977d2c46b5920c6df518c640438c976f66b043a59670bb2f22001eddf3e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4275c5cb8ea31dbd0fadcecf4cb460578ba7f20ec2178a0624c5ad238002ef317e65b8efdeeb0a5cef73e455444b1a59ad8335c20d23dfe4b5b073e93df2c741"} 13:33:14 INFO - Running post-run listener: copy_logs_to_upload_dir 13:33:14 INFO - Copying logs to upload dir... 13:33:14 INFO - mkdir: /builds/slave/test/build/upload/logs 13:33:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1316.241513 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-05-26 13:33:14.112696) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 13:33:14.120588) ========= 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=930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7f27cf3a4136fe6dc84eb03b3b79493e4bba1ad5ebe32467e6b38afe579d5e70a136317269bf60073913d5e6b8b3486ff0eb06e88bbe5411751224870b4499f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/447672cf98982aec45ef69df68364921d3adcccb772da6fd894f004d6cdbce147a9c227dc53e70af8610e97a1f0725ebaf04234729aeac7698f23cd9d0bab8f9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9fe5ad4ed32d5e5352e3dcc7170cb46d2f74bb2b638c626b0cef63fa0211f6ec95a2977d2c46b5920c6df518c640438c976f66b043a59670bb2f22001eddf3e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4275c5cb8ea31dbd0fadcecf4cb460578ba7f20ec2178a0624c5ad238002ef317e65b8efdeeb0a5cef73e455444b1a59ad8335c20d23dfe4b5b073e93df2c741"} build_url:https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/a5Q6EXKFRRuOf_lZx3w97w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7f27cf3a4136fe6dc84eb03b3b79493e4bba1ad5ebe32467e6b38afe579d5e70a136317269bf60073913d5e6b8b3486ff0eb06e88bbe5411751224870b4499f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/447672cf98982aec45ef69df68364921d3adcccb772da6fd894f004d6cdbce147a9c227dc53e70af8610e97a1f0725ebaf04234729aeac7698f23cd9d0bab8f9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9fe5ad4ed32d5e5352e3dcc7170cb46d2f74bb2b638c626b0cef63fa0211f6ec95a2977d2c46b5920c6df518c640438c976f66b043a59670bb2f22001eddf3e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4275c5cb8ea31dbd0fadcecf4cb460578ba7f20ec2178a0624c5ad238002ef317e65b8efdeeb0a5cef73e455444b1a59ad8335c20d23dfe4b5b073e93df2c741"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 13:33:14.147114) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 13:33:14.147552) ========= 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=930c87414c89fc706ee2024c000001c6-1495829419.593597-303317744 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 13:33:14.230966) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 13:33:14.232382) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 13:33:14.232679) ========= ========= Total master_lag: 0.33 =========