builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-089 starttime: 1500391653.05 results: success (0) revision: 8ff4f17b266db9a780efe06f7fbdae629e49f5bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:33.054139) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:33.054605) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:33.054896) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:33.089645) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:33.089961) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-18 08:27:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 54.9K=0.2s 2017-07-18 08:27:34 (54.9 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.324608 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:33.428332) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:33.428727) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022940 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:33.478306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:33.478651) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8ff4f17b266db9a780efe06f7fbdae629e49f5bc --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 8ff4f17b266db9a780efe06f7fbdae629e49f5bc --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=8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-18 08:27:34,130 truncating revision to first 12 chars 2017-07-18 08:27:34,130 Setting DEBUG logging. 2017-07-18 08:27:34,131 attempt 1/10 2017-07-18 08:27:34,131 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8ff4f17b266d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-18 08:27:34,462 unpacking tar archive at: mozilla-central-8ff4f17b266d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685239 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:34.176501) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:34.176895) ========= script_repo_revision: 8ff4f17b266db9a780efe06f7fbdae629e49f5bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:34.177296) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:34.177594) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:34.187859) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-07-18 08:27:34.188156) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:27:34 INFO - MultiFileLogger online at 20170718 08:27:34 in /builds/slave/test 08:27:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:27:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:27:34 INFO - {'append_to_log': False, 08:27:34 INFO - 'base_work_dir': '/builds/slave/test', 08:27:34 INFO - 'blob_upload_branch': 'Firefox', 08:27:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:27:34 INFO - 'branch': 'Firefox', 08:27:34 INFO - 'buildbot_json_path': 'buildprops.json', 08:27:34 INFO - 'code_coverage': False, 08:27:34 INFO - 'config_files': ('talos/linux_config.py',), 08:27:34 INFO - 'default_actions': ('clobber', 08:27:34 INFO - 'read-buildbot-config', 08:27:34 INFO - 'download-and-extract', 08:27:34 INFO - 'populate-webroot', 08:27:34 INFO - 'create-virtualenv', 08:27:34 INFO - 'install', 08:27:34 INFO - 'setup-mitmproxy', 08:27:34 INFO - 'run-tests'), 08:27:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:27:34 INFO - 'disable_ccov_upload': False, 08:27:34 INFO - 'download_minidump_stackwalk': True, 08:27:34 INFO - 'download_symbols': 'ondemand', 08:27:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:27:34 INFO - 'tooltool.py': '/tools/tooltool.py', 08:27:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:27:34 INFO - '/tools/misc-python/virtualenv.py')}, 08:27:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:27:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:27:34 INFO - 'gecko_profile': False, 08:27:34 INFO - 'gecko_profile_interval': 0, 08:27:34 INFO - 'installer_path': 'installer.exe', 08:27:34 INFO - 'log_level': 'info', 08:27:34 INFO - 'log_name': 'talos', 08:27:34 INFO - 'log_to_console': True, 08:27:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:27:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:27:34 INFO - 'opt_config_files': (), 08:27:34 INFO - 'pip_index': False, 08:27:34 INFO - 'suite': 'dromaeojs-e10s', 08:27:34 INFO - 'system_bits': '32', 08:27:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:27:34 INFO - 'title': 'talos-linux64-ix-089', 08:27:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:27:34 INFO - 'use_talos_json': True, 08:27:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:27:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:27:34 INFO - 'work_dir': 'build'} 08:27:34 INFO - [mozharness: 2017-07-18 15:27:34.947101Z] Running clobber step. 08:27:34 INFO - Running pre-action listener: _resource_record_pre_action 08:27:34 INFO - Running main action method: clobber 08:27:34 INFO - rmtree: /builds/slave/test/build 08:27:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:27:36 INFO - Running post-action listener: _resource_record_post_action 08:27:36 INFO - [mozharness: 2017-07-18 15:27:36.519080Z] Finished clobber step (success) 08:27:36 INFO - [mozharness: 2017-07-18 15:27:36.519182Z] Running read-buildbot-config step. 08:27:36 INFO - Running pre-action listener: _resource_record_pre_action 08:27:36 INFO - Running main action method: read_buildbot_config 08:27:36 INFO - Using buildbot properties: 08:27:36 INFO - { 08:27:36 INFO - "project": "", 08:27:36 INFO - "product": "firefox", 08:27:36 INFO - "who": "ryanvm@gmail.com", 08:27:36 INFO - "installer_path": "public/build/target.tar.bz2", 08:27:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 08:27:36 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:27:36 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 08:27:36 INFO - "stage_platform": "linux64-stylo", 08:27:36 INFO - "basedir": "/builds/slave/test", 08:27:36 INFO - "buildnumber": 218, 08:27:36 INFO - "platform": "ubuntu64_hw_stylo", 08:27:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:27:36 INFO - "slavebuilddir": "test", 08:27:36 INFO - "taskId": "M8G2n68QRWGHA8btpgpkQQ", 08:27:36 INFO - "branch": "mozilla-central", 08:27:36 INFO - "script_repo_revision": "production", 08:27:36 INFO - "revision": "8ff4f17b266db9a780efe06f7fbdae629e49f5bc", 08:27:36 INFO - "slavename": "talos-linux64-ix-089", 08:27:36 INFO - "repo_path": "mozilla-central" 08:27:36 INFO - } 08:27:36 INFO - Finding installer, test and symbols from parent task. 08:27:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M8G2n68QRWGHA8btpgpkQQ'}, attempt #1 08:27:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M8G2n68QRWGHA8btpgpkQQ'}, attempt #1 08:27:37 INFO - Task dependencies: WK1fGb1kSi6ucctxSGRFLQ 08:27:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ'}, attempt #1 08:27:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.tar.bz2 08:27:37 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/test_packages.json 08:27:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.crashreporter-symbols.zip 08:27:37 INFO - Running post-action listener: _resource_record_post_action 08:27:37 INFO - [mozharness: 2017-07-18 15:27:37.969685Z] Finished read-buildbot-config step (success) 08:27:37 INFO - [mozharness: 2017-07-18 15:27:37.969905Z] Running download-and-extract step. 08:27:37 INFO - Running pre-action listener: _resource_record_pre_action 08:27:37 INFO - Running main action method: download_and_extract 08:27:37 INFO - mkdir: /builds/slave/test/build/tests 08:27:37 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')]} 08:27:37 INFO - trying https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.test_packages.json 08:27:37 INFO - Downloading https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:27:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:27:38 INFO - Downloaded 989 bytes. 08:27:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:27:38 INFO - Using the following test package requirements: 08:27:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:27:38 INFO - u'common': [u'target.common.tests.zip'], 08:27:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:27:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:27:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:27:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:27:38 INFO - u'mozbase': [u'target.common.tests.zip'], 08:27:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:27:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:27:38 INFO - u'web-platform': [u'target.common.tests.zip', 08:27:38 INFO - u'target.web-platform.tests.tar.gz'], 08:27:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:27:38 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:27:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.common.tests.zip 08:27:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:27:38 INFO - Fetch https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.common.tests.zip into memory 08:27:40 INFO - Content-Length response header: 72776747 08:27:40 INFO - Bytes received: 72776747 08:27:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:27:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.common.tests.zip 08:27:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:27:51 INFO - Fetch https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.common.tests.zip into memory 08:27:53 INFO - Content-Length response header: 72776747 08:27:53 INFO - Bytes received: 72776747 08:28:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.talos.tests.zip 08:28:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:28:06 INFO - Fetch https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.talos.tests.zip into memory 08:28:06 INFO - Content-Length response header: 14495033 08:28:06 INFO - Bytes received: 14495033 08:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:07 INFO - trying https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.tar.bz2 08:28:07 INFO - Downloading https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:28:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:28:09 INFO - Downloaded 61718404 bytes. 08:28:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.tar.bz2 08:28:09 INFO - mkdir: /builds/slave/test/properties 08:28:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:28:09 INFO - Writing to file /builds/slave/test/properties/build_url 08:28:09 INFO - Contents: 08:28:09 INFO - build_url:https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.tar.bz2 08:28:09 INFO - Running post-action listener: _resource_record_post_action 08:28:09 INFO - Running post-action listener: set_extra_try_arguments 08:28:09 INFO - [mozharness: 2017-07-18 15:28:09.582931Z] Finished download-and-extract step (success) 08:28:09 INFO - [mozharness: 2017-07-18 15:28:09.583162Z] Running populate-webroot step. 08:28:09 INFO - Running pre-action listener: _resource_record_pre_action 08:28:09 INFO - Running main action method: populate_webroot 08:28:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:28:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:28:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:28:09 INFO - '--tppagecycles', 08:28:09 INFO - '7'], 08:28:09 INFO - 'tests': ['tsvgm']}}, 08:28:09 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:28:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:28:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:28:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:28:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:28:09 INFO - 'talos_options': ['--disable-e10s'], 08:28:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:28:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:28:09 INFO - 'talos_options': ['--disable-e10s'], 08:28:09 INFO - 'tests': ['damp', 'tps']}, 08:28:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:28:09 INFO - 'tests': ['damp', 'tps']}, 08:28:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:28:09 INFO - 'tests': ['dromaeo_dom']}, 08:28:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:28:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:28:09 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:28:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:28:09 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:28:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:28:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:28:09 INFO - 'tests': ['a11yr', 08:28:09 INFO - 'ts_paint', 08:28:09 INFO - 'tpaint', 08:28:09 INFO - 'sessionrestore', 08:28:09 INFO - 'sessionrestore_no_auto_restore', 08:28:09 INFO - 'tabpaint']}, 08:28:09 INFO - 'other-e10s': {'tests': ['a11yr', 08:28:09 INFO - 'ts_paint', 08:28:09 INFO - 'tpaint', 08:28:09 INFO - 'sessionrestore', 08:28:09 INFO - 'sessionrestore_many_windows', 08:28:09 INFO - 'sessionrestore_no_auto_restore', 08:28:09 INFO - 'tabpaint']}, 08:28:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:28:09 INFO - 'ts_paint', 08:28:09 INFO - 'tpaint', 08:28:09 INFO - 'sessionrestore', 08:28:09 INFO - 'sessionrestore_many_windows', 08:28:09 INFO - 'sessionrestore_no_auto_restore', 08:28:09 INFO - 'tabpaint']}, 08:28:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:28:09 INFO - 'ts_paint', 08:28:09 INFO - 'tpaint', 08:28:09 INFO - 'sessionrestore', 08:28:09 INFO - 'sessionrestore_many_windows', 08:28:09 INFO - 'sessionrestore_no_auto_restore', 08:28:09 INFO - 'tabpaint']}, 08:28:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:28:09 INFO - 'tests': ['a11yr', 08:28:09 INFO - 'ts_paint', 08:28:09 INFO - 'tpaint', 08:28:09 INFO - 'sessionrestore', 08:28:09 INFO - 'sessionrestore_no_auto_restore', 08:28:09 INFO - 'tabpaint']}, 08:28:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:28:09 INFO - 'tests': ['a11yr', 08:28:09 INFO - 'ts_paint', 08:28:09 INFO - 'tpaint', 08:28:09 INFO - 'sessionrestore', 08:28:09 INFO - 'sessionrestore_no_auto_restore', 08:28:09 INFO - 'tabpaint']}, 08:28:09 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 08:28:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:28:09 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:28:09 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:28:09 INFO - 'talos_options': ['--mitmproxy', 08:28:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:28:09 INFO - '--firstNonBlankPaint'], 08:28:09 INFO - 'tests': ['quantum_pageload_google', 08:28:09 INFO - 'quantum_pageload_youtube', 08:28:09 INFO - 'quantum_pageload_amazon', 08:28:09 INFO - 'quantum_pageload_facebook']}, 08:28:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:28:09 INFO - 'tests': ['tsvgx', 08:28:09 INFO - 'tsvgr_opacity', 08:28:09 INFO - 'tart', 08:28:09 INFO - 'tscrollx', 08:28:09 INFO - 'cart', 08:28:09 INFO - 'tsvg_static']}, 08:28:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:28:09 INFO - 'tsvgr_opacity', 08:28:09 INFO - 'tart', 08:28:09 INFO - 'tscrollx', 08:28:09 INFO - 'cart', 08:28:09 INFO - 'tsvg_static']}, 08:28:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:28:09 INFO - 'talos_options': ['--disable-e10s'], 08:28:09 INFO - 'tests': ['tp5o']}, 08:28:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:28:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:28:09 INFO - 'talos_options': ['--disable-e10s', 08:28:09 INFO - '--xperf_path', 08:28:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:09 INFO - 'tests': ['tp5n']}, 08:28:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:28:09 INFO - 'talos_options': ['--xperf_path', 08:28:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:09 INFO - 'tests': ['tp5n']}}, 08:28:09 INFO - 'talos.zip': {'path': '', 08:28:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:28:09 INFO - Running post-action listener: _resource_record_post_action 08:28:09 INFO - [mozharness: 2017-07-18 15:28:09.602312Z] Finished populate-webroot step (success) 08:28:09 INFO - [mozharness: 2017-07-18 15:28:09.602403Z] Running create-virtualenv step. 08:28:09 INFO - Running pre-action listener: _resource_record_pre_action 08:28:09 INFO - Running main action method: create_virtualenv 08:28:09 INFO - Creating virtualenv /builds/slave/test/build/venv 08:28:09 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 08:28:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:28:09 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:28:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:28:09 INFO - Using real prefix '/usr' 08:28:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:28:10 INFO - Installing distribute.............................................................................................................................................................................................done. 08:28:12 INFO - Installing pip.................done. 08:28:12 INFO - Return code: 0 08:28:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:28:12 INFO - Reading from file tmpfile_stdout 08:28:12 INFO - Output received: 08:28:12 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) 08:28:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:28:12 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')]} 08:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:12 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')]} 08:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:12 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 0xa9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ad00>, '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 0xe0bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0c090>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', '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 08:28:12 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 08:28:12 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 08:28:12 INFO - Using env: {'DISPLAY': ':0', 08:28:12 INFO - 'HOME': '/home/cltbld', 08:28:12 INFO - 'LANG': 'en_US.UTF-8', 08:28:12 INFO - 'LANGUAGE': 'en_US:en', 08:28:12 INFO - 'LOGNAME': 'cltbld', 08:28:12 INFO - 'MAIL': '/var/mail/cltbld', 08:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:12 INFO - 'MOZ_NO_REMOTE': '1', 08:28:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:12 INFO - 'NO_EM_RESTART': '1', 08:28:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:12 INFO - 'PWD': '/builds/slave/test', 08:28:12 INFO - 'SHELL': '/bin/bash', 08:28:12 INFO - 'SHLVL': '1', 08:28:12 INFO - 'TERM': 'linux', 08:28:12 INFO - 'TMOUT': '86400', 08:28:12 INFO - 'USER': 'cltbld', 08:28:12 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', 08:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:12 INFO - '_': '/tools/buildbot/bin/python'} 08:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:12 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 08:28:12 INFO - Cleaning up... 08:28:12 INFO - Return code: 0 08:28:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:28:12 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')]} 08:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:12 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')]} 08:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:12 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 0xa9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ad00>, '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 0xe0bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0c090>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', '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 08:28:12 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 08:28:12 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 08:28:12 INFO - Using env: {'DISPLAY': ':0', 08:28:12 INFO - 'HOME': '/home/cltbld', 08:28:12 INFO - 'LANG': 'en_US.UTF-8', 08:28:12 INFO - 'LANGUAGE': 'en_US:en', 08:28:12 INFO - 'LOGNAME': 'cltbld', 08:28:12 INFO - 'MAIL': '/var/mail/cltbld', 08:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:12 INFO - 'MOZ_NO_REMOTE': '1', 08:28:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:12 INFO - 'NO_EM_RESTART': '1', 08:28:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:12 INFO - 'PWD': '/builds/slave/test', 08:28:12 INFO - 'SHELL': '/bin/bash', 08:28:12 INFO - 'SHLVL': '1', 08:28:12 INFO - 'TERM': 'linux', 08:28:12 INFO - 'TMOUT': '86400', 08:28:12 INFO - 'USER': 'cltbld', 08:28:12 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', 08:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:12 INFO - '_': '/tools/buildbot/bin/python'} 08:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:12 INFO - Downloading/unpacking psutil>=3.1.1 08:28:12 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 08:28:12 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 08:28:12 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 08:28:12 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 08:28:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:28:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:14 INFO - Installing collected packages: psutil 08:28:14 INFO - Running setup.py install for psutil 08:28:14 INFO - building 'psutil._psutil_linux' extension 08:28:14 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 08:28:14 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 08:28:14 INFO - building 'psutil._psutil_posix' extension 08:28:14 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 08:28:14 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 08:28:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:14 INFO - Successfully installed psutil 08:28:14 INFO - Cleaning up... 08:28:14 INFO - Return code: 0 08:28:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:14 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 0xa9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ad00>, '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 0xe0bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0c090>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', '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 08:28:14 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 08:28:14 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 08:28:14 INFO - Using env: {'DISPLAY': ':0', 08:28:14 INFO - 'HOME': '/home/cltbld', 08:28:14 INFO - 'LANG': 'en_US.UTF-8', 08:28:14 INFO - 'LANGUAGE': 'en_US:en', 08:28:14 INFO - 'LOGNAME': 'cltbld', 08:28:14 INFO - 'MAIL': '/var/mail/cltbld', 08:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:14 INFO - 'MOZ_NO_REMOTE': '1', 08:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:14 INFO - 'NO_EM_RESTART': '1', 08:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:14 INFO - 'PWD': '/builds/slave/test', 08:28:14 INFO - 'SHELL': '/bin/bash', 08:28:14 INFO - 'SHLVL': '1', 08:28:14 INFO - 'TERM': 'linux', 08:28:14 INFO - 'TMOUT': '86400', 08:28:14 INFO - 'USER': 'cltbld', 08:28:14 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', 08:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:14 INFO - '_': '/tools/buildbot/bin/python'} 08:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:28:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:28:15 INFO - Installing collected packages: mozsystemmonitor 08:28:15 INFO - Running setup.py install for mozsystemmonitor 08:28:16 INFO - Successfully installed mozsystemmonitor 08:28:16 INFO - Cleaning up... 08:28:16 INFO - Return code: 0 08:28:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ad00>, '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 0xe0bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0c090>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', '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 08:28:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:28:16 INFO - Using env: {'DISPLAY': ':0', 08:28:16 INFO - 'HOME': '/home/cltbld', 08:28:16 INFO - 'LANG': 'en_US.UTF-8', 08:28:16 INFO - 'LANGUAGE': 'en_US:en', 08:28:16 INFO - 'LOGNAME': 'cltbld', 08:28:16 INFO - 'MAIL': '/var/mail/cltbld', 08:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:16 INFO - 'MOZ_NO_REMOTE': '1', 08:28:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:16 INFO - 'NO_EM_RESTART': '1', 08:28:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:16 INFO - 'PWD': '/builds/slave/test', 08:28:16 INFO - 'SHELL': '/bin/bash', 08:28:16 INFO - 'SHLVL': '1', 08:28:16 INFO - 'TERM': 'linux', 08:28:16 INFO - 'TMOUT': '86400', 08:28:16 INFO - 'USER': 'cltbld', 08:28:16 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', 08:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:16 INFO - '_': '/tools/buildbot/bin/python'} 08:28:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:16 INFO - Downloading/unpacking jsonschema==2.5.1 08:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:28:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:28:17 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 08:28:17 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 08:28:17 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 08:28:17 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 08:28:17 INFO - Downloading functools32-3.2.3-2.tar.gz 08:28:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:28:17 INFO - warning: no files found matching '*.txt' 08:28:17 INFO - no previously-included directories found matching 'build' 08:28:17 INFO - no previously-included directories found matching 'dist' 08:28:17 INFO - no previously-included directories found matching '.git*' 08:28:17 INFO - Installing collected packages: jsonschema, functools32 08:28:17 INFO - Running setup.py install for functools32 08:28:17 INFO - warning: no files found matching '*.txt' 08:28:17 INFO - no previously-included directories found matching 'build' 08:28:17 INFO - no previously-included directories found matching 'dist' 08:28:17 INFO - no previously-included directories found matching '.git*' 08:28:17 INFO - Successfully installed jsonschema functools32 08:28:17 INFO - Cleaning up... 08:28:17 INFO - Return code: 0 08:28:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:28:17 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')]} 08:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:17 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')]} 08:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:17 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 0xa9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ad00>, '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 0xe0bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0c090>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', '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 08:28:17 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 08:28:17 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 08:28:17 INFO - Using env: {'DISPLAY': ':0', 08:28:17 INFO - 'HOME': '/home/cltbld', 08:28:17 INFO - 'LANG': 'en_US.UTF-8', 08:28:17 INFO - 'LANGUAGE': 'en_US:en', 08:28:17 INFO - 'LOGNAME': 'cltbld', 08:28:17 INFO - 'MAIL': '/var/mail/cltbld', 08:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:17 INFO - 'MOZ_NO_REMOTE': '1', 08:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:17 INFO - 'NO_EM_RESTART': '1', 08:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:17 INFO - 'PWD': '/builds/slave/test', 08:28:17 INFO - 'SHELL': '/bin/bash', 08:28:17 INFO - 'SHLVL': '1', 08:28:17 INFO - 'TERM': 'linux', 08:28:17 INFO - 'TMOUT': '86400', 08:28:17 INFO - 'USER': 'cltbld', 08:28:17 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', 08:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:17 INFO - '_': '/tools/buildbot/bin/python'} 08:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:28:17 INFO - Cleaning up... 08:28:17 INFO - Return code: 0 08:28:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:28:17 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')]} 08:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:17 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')]} 08:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:17 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 0xa9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ad00>, '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 0xe0bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0c090>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', '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 08:28:17 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 08:28:17 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 08:28:17 INFO - Using env: {'DISPLAY': ':0', 08:28:17 INFO - 'HOME': '/home/cltbld', 08:28:17 INFO - 'LANG': 'en_US.UTF-8', 08:28:17 INFO - 'LANGUAGE': 'en_US:en', 08:28:17 INFO - 'LOGNAME': 'cltbld', 08:28:17 INFO - 'MAIL': '/var/mail/cltbld', 08:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:17 INFO - 'MOZ_NO_REMOTE': '1', 08:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:17 INFO - 'NO_EM_RESTART': '1', 08:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:17 INFO - 'PWD': '/builds/slave/test', 08:28:17 INFO - 'SHELL': '/bin/bash', 08:28:17 INFO - 'SHLVL': '1', 08:28:17 INFO - 'TERM': 'linux', 08:28:17 INFO - 'TMOUT': '86400', 08:28:17 INFO - 'USER': 'cltbld', 08:28:17 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', 08:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:17 INFO - '_': '/tools/buildbot/bin/python'} 08:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:18 INFO - Downloading/unpacking blobuploader==1.2.4 08:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:19 INFO - Downloading blobuploader-1.2.4.tar.gz 08:28:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:28:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:28:19 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 08:28:19 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 08:28:19 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 08:28:19 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 08:28:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:28:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:28:19 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 08:28:19 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 08:28:19 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 08:28:19 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 08:28:19 INFO - Downloading docopt-0.6.1.tar.gz 08:28:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:28:19 INFO - Installing collected packages: blobuploader, requests, docopt 08:28:19 INFO - Running setup.py install for blobuploader 08:28:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:28:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:28:19 INFO - Running setup.py install for requests 08:28:20 INFO - Running setup.py install for docopt 08:28:20 INFO - Successfully installed blobuploader requests docopt 08:28:20 INFO - Cleaning up... 08:28:20 INFO - Return code: 0 08:28:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28: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')]} 08:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28: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')]} 08:28:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:20 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 0xa9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ad00>, '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 0xe0bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0c090>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', '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 08:28:20 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 08:28:20 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 08:28:20 INFO - Using env: {'DISPLAY': ':0', 08:28:20 INFO - 'HOME': '/home/cltbld', 08:28:20 INFO - 'LANG': 'en_US.UTF-8', 08:28:20 INFO - 'LANGUAGE': 'en_US:en', 08:28:20 INFO - 'LOGNAME': 'cltbld', 08:28:20 INFO - 'MAIL': '/var/mail/cltbld', 08:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:20 INFO - 'MOZ_NO_REMOTE': '1', 08:28:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:20 INFO - 'NO_EM_RESTART': '1', 08:28:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:20 INFO - 'PWD': '/builds/slave/test', 08:28:20 INFO - 'SHELL': '/bin/bash', 08:28:20 INFO - 'SHLVL': '1', 08:28:20 INFO - 'TERM': 'linux', 08:28:20 INFO - 'TMOUT': '86400', 08:28:20 INFO - 'USER': 'cltbld', 08:28:20 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', 08:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:20 INFO - '_': '/tools/buildbot/bin/python'} 08:28:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:28:20 INFO - Running setup.py (path:/tmp/pip-57r9Kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:28:20 INFO - Running setup.py (path:/tmp/pip-18x3cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:28:20 INFO - Running setup.py (path:/tmp/pip-Q5ouTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:28:20 INFO - Running setup.py (path:/tmp/pip-0s6W8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:28:20 INFO - Running setup.py (path:/tmp/pip-2cZic9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:28:20 INFO - Running setup.py (path:/tmp/pip-qBl74n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:28:21 INFO - Running setup.py (path:/tmp/pip-spq7Em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:28:21 INFO - Running setup.py (path:/tmp/pip-bm5TQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:28:21 INFO - Running setup.py (path:/tmp/pip-1x16Qd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:28:21 INFO - Running setup.py (path:/tmp/pip-5Qy3rZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:28:21 INFO - Running setup.py (path:/tmp/pip-ukVJ_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:28:21 INFO - Running setup.py (path:/tmp/pip-Nxc7YD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:28:21 INFO - Running setup.py (path:/tmp/pip-de_56k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:28:21 INFO - Running setup.py (path:/tmp/pip-Fd35AH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:21 INFO - Running setup.py (path:/tmp/pip-skhOM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:28:21 INFO - Running setup.py (path:/tmp/pip-x_UTCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:28:21 INFO - Running setup.py (path:/tmp/pip-9x5M4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:28:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:28:21 INFO - Running setup.py install for manifestparser 08:28:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:28:21 INFO - Running setup.py install for mozcrash 08:28:22 INFO - Running setup.py install for mozdebug 08:28:22 INFO - Running setup.py install for mozdevice 08:28:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:28:22 INFO - Running setup.py install for mozfile 08:28:22 INFO - Running setup.py install for mozhttpd 08:28:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:28:22 INFO - Running setup.py install for mozinfo 08:28:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:28:22 INFO - Running setup.py install for mozInstall 08:28:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:28:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:28:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:28:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:28:22 INFO - Running setup.py install for mozleak 08:28:22 INFO - Running setup.py install for mozlog 08:28:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:28:22 INFO - Running setup.py install for moznetwork 08:28:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:28:22 INFO - Running setup.py install for mozprocess 08:28:23 INFO - Running setup.py install for mozprofile 08:28:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:28:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:28:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:28:23 INFO - Running setup.py install for mozrunner 08:28:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:28:23 INFO - Running setup.py install for mozscreenshot 08:28:23 INFO - Running setup.py install for moztest 08:28:23 INFO - Running setup.py install for mozversion 08:28:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:28:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:28:23 INFO - Cleaning up... 08:28:23 INFO - Return code: 0 08:28:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28:23 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')]} 08:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:23 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')]} 08:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:23 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 0xa9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ad00>, '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 0xe0bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0c090>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', '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 08:28:23 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 08:28:23 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 08:28:23 INFO - Using env: {'DISPLAY': ':0', 08:28:23 INFO - 'HOME': '/home/cltbld', 08:28:23 INFO - 'LANG': 'en_US.UTF-8', 08:28:23 INFO - 'LANGUAGE': 'en_US:en', 08:28:23 INFO - 'LOGNAME': 'cltbld', 08:28:23 INFO - 'MAIL': '/var/mail/cltbld', 08:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:23 INFO - 'MOZ_NO_REMOTE': '1', 08:28:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:23 INFO - 'NO_EM_RESTART': '1', 08:28:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:23 INFO - 'PWD': '/builds/slave/test', 08:28:23 INFO - 'SHELL': '/bin/bash', 08:28:23 INFO - 'SHLVL': '1', 08:28:23 INFO - 'TERM': 'linux', 08:28:23 INFO - 'TMOUT': '86400', 08:28:23 INFO - 'USER': 'cltbld', 08:28:23 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', 08:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:23 INFO - '_': '/tools/buildbot/bin/python'} 08:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:28:23 INFO - Running setup.py (path:/tmp/pip-s8HRp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:28:23 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)) 08:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:28:23 INFO - Running setup.py (path:/tmp/pip-0j5oy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:28:23 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)) 08:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:28:23 INFO - Running setup.py (path:/tmp/pip-alIVgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:28:24 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)) 08:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:28:24 INFO - Running setup.py (path:/tmp/pip-VHNxTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:28:24 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)) 08:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:28:24 INFO - Running setup.py (path:/tmp/pip-4uG5nJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:28:24 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)) 08:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:28:24 INFO - Running setup.py (path:/tmp/pip-k8YzNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:28:24 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)) 08:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:28:24 INFO - Running setup.py (path:/tmp/pip-yZzaDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:28:24 INFO - Running setup.py (path:/tmp/pip-1dnE_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:28:24 INFO - Running setup.py (path:/tmp/pip-ALqXhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:28:24 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)) 08:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:28:24 INFO - Running setup.py (path:/tmp/pip-_woZ8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:28:24 INFO - Running setup.py (path:/tmp/pip-cJRDg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:28:24 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)) 08:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:28:24 INFO - Running setup.py (path:/tmp/pip-3HGM6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:28:24 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)) 08:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:28:24 INFO - Running setup.py (path:/tmp/pip-nxEBpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:28:24 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)) 08:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:28:24 INFO - Running setup.py (path:/tmp/pip-lWVEzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:28:24 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)) 08:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:24 INFO - Running setup.py (path:/tmp/pip-S0z4oX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:24 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)) 08:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:28:24 INFO - Running setup.py (path:/tmp/pip-FCxAxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:28:25 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)) 08:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:28:25 INFO - Running setup.py (path:/tmp/pip-wAZjkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:28:25 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)) 08:28:25 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)) 08:28:25 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)) 08:28:25 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)) 08:28:25 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)) 08:28:25 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)) 08:28:25 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:28:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:28:25 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 08:28:25 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 08:28:25 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 08:28:25 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 08:28:26 INFO - Downloading blessings-1.6.tar.gz 08:28:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:28:26 INFO - Installing collected packages: blessings 08:28:26 INFO - Running setup.py install for blessings 08:28:26 INFO - Successfully installed blessings 08:28:26 INFO - Cleaning up... 08:28:26 INFO - Return code: 0 08:28:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:28:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:28:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:28:26 INFO - Reading from file tmpfile_stdout 08:28:26 INFO - Current package versions: 08:28:26 INFO - argparse == 1.2.1 08:28:26 INFO - blessings == 1.6 08:28:26 INFO - blobuploader == 1.2.4 08:28:26 INFO - docopt == 0.6.1 08:28:26 INFO - functools32 == 3.2.3-2 08:28:26 INFO - jsonschema == 2.5.1 08:28:26 INFO - manifestparser == 1.1 08:28:26 INFO - mozInstall == 1.13 08:28:26 INFO - mozcrash == 1.0 08:28:26 INFO - mozdebug == 0.1 08:28:26 INFO - mozdevice == 0.51 08:28:26 INFO - mozfile == 1.2 08:28:26 INFO - mozhttpd == 0.7 08:28:26 INFO - mozinfo == 0.10 08:28:26 INFO - mozleak == 0.1 08:28:26 INFO - mozlog == 3.5 08:28:26 INFO - moznetwork == 0.27 08:28:26 INFO - mozprocess == 0.25 08:28:26 INFO - mozprofile == 0.28 08:28:26 INFO - mozrunner == 6.13 08:28:26 INFO - mozscreenshot == 0.1 08:28:26 INFO - mozsystemmonitor == 0.3 08:28:26 INFO - moztest == 0.8 08:28:26 INFO - mozversion == 1.4 08:28:26 INFO - psutil == 3.1.1 08:28:26 INFO - requests == 1.2.3 08:28:26 INFO - wsgiref == 0.1.2 08:28:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28: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')]} 08:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28: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')]} 08:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:26 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 0xa9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ad00>, '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 0xe0bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0c090>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', '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 08:28:26 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 08:28:26 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 08:28:26 INFO - Using env: {'DISPLAY': ':0', 08:28:26 INFO - 'HOME': '/home/cltbld', 08:28:26 INFO - 'LANG': 'en_US.UTF-8', 08:28:26 INFO - 'LANGUAGE': 'en_US:en', 08:28:26 INFO - 'LOGNAME': 'cltbld', 08:28:26 INFO - 'MAIL': '/var/mail/cltbld', 08:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:26 INFO - 'MOZ_NO_REMOTE': '1', 08:28:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:26 INFO - 'NO_EM_RESTART': '1', 08:28:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:26 INFO - 'PWD': '/builds/slave/test', 08:28:26 INFO - 'SHELL': '/bin/bash', 08:28:26 INFO - 'SHLVL': '1', 08:28:26 INFO - 'TERM': 'linux', 08:28:26 INFO - 'TMOUT': '86400', 08:28:26 INFO - 'USER': 'cltbld', 08:28:26 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', 08:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:26 INFO - '_': '/tools/buildbot/bin/python'} 08:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:26 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)) 08:28:26 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)) 08:28:26 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)) 08:28:26 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)) 08:28:26 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)) 08:28:26 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)) 08:28:26 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)) 08:28:26 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)) 08:28:26 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)) 08:28:26 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:27 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:28:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:28:27 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 08:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:28:28 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)) 08:28:28 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)) 08:28:28 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)) 08:28:28 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)) 08:28:28 INFO - Installing collected packages: marionette-driver, simplejson 08:28:28 INFO - Running setup.py install for marionette-driver 08:28:28 INFO - Running setup.py install for simplejson 08:28:28 INFO - building 'simplejson._speedups' extension 08:28:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 08:28:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 08:28:29 INFO - Successfully installed marionette-driver simplejson 08:28:29 INFO - Cleaning up... 08:28:29 INFO - Return code: 0 08:28:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:29 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 0xa9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe0db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0ad00>, '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 0xe0bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0c090>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', '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 08:28:29 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 08:28:29 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 08:28:29 INFO - Using env: {'DISPLAY': ':0', 08:28:29 INFO - 'HOME': '/home/cltbld', 08:28:29 INFO - 'LANG': 'en_US.UTF-8', 08:28:29 INFO - 'LANGUAGE': 'en_US:en', 08:28:29 INFO - 'LOGNAME': 'cltbld', 08:28:29 INFO - 'MAIL': '/var/mail/cltbld', 08:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:29 INFO - 'MOZ_NO_REMOTE': '1', 08:28:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:29 INFO - 'NO_EM_RESTART': '1', 08:28:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:29 INFO - 'PWD': '/builds/slave/test', 08:28:29 INFO - 'SHELL': '/bin/bash', 08:28:29 INFO - 'SHLVL': '1', 08:28:29 INFO - 'TERM': 'linux', 08:28:29 INFO - 'TMOUT': '86400', 08:28:29 INFO - 'USER': 'cltbld', 08:28:29 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', 08:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:29 INFO - '_': '/tools/buildbot/bin/python'} 08:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:28:29 INFO - Cleaning up... 08:28:29 INFO - Return code: 0 08:28:29 INFO - Running post-action listener: _resource_record_post_action 08:28:29 INFO - Running post-action listener: _start_resource_monitoring 08:28:29 INFO - Starting resource monitoring. 08:28:29 INFO - [mozharness: 2017-07-18 15:28:29.635148Z] Finished create-virtualenv step (success) 08:28:29 INFO - [mozharness: 2017-07-18 15:28:29.635660Z] Running install step. 08:28:29 INFO - Running pre-action listener: _resource_record_pre_action 08:28:29 INFO - Running main action method: install 08:28:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:28:29 INFO - Reading from file tmpfile_stdout 08:28:29 INFO - Detecting whether we're running mozinstall >=1.0... 08:28:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:28:29 INFO - Reading from file tmpfile_stdout 08:28:29 INFO - Output received: 08:28:29 INFO - Usage: mozinstall [options] installer 08:28:29 INFO - Options: 08:28:29 INFO - -h, --help show this help message and exit 08:28:29 INFO - -d DEST, --destination=DEST 08:28:29 INFO - Directory to install application into. [default: 08:28:29 INFO - "/builds/slave/test"] 08:28:29 INFO - --app=APP Application being installed. [default: firefox] 08:28:30 INFO - mkdir: /builds/slave/test/build/application 08:28:30 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'] 08:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:28:47 INFO - Reading from file tmpfile_stdout 08:28:47 INFO - Output received: 08:28:47 INFO - /builds/slave/test/build/application/firefox/firefox 08:28:47 INFO - Running post-action listener: _resource_record_post_action 08:28:47 INFO - [mozharness: 2017-07-18 15:28:47.840502Z] Finished install step (success) 08:28:47 INFO - [mozharness: 2017-07-18 15:28:47.840757Z] Running setup-mitmproxy step. 08:28:47 INFO - Running pre-action listener: _resource_record_pre_action 08:28:47 INFO - Running main action method: setup_mitmproxy 08:28:47 INFO - Skipping: mitmproxy is not required 08:28:47 INFO - Running post-action listener: _resource_record_post_action 08:28:47 INFO - [mozharness: 2017-07-18 15:28:47.841945Z] Finished setup-mitmproxy step (success) 08:28:47 INFO - [mozharness: 2017-07-18 15:28:47.842183Z] Running run-tests step. 08:28:47 INFO - Running pre-action listener: _resource_record_pre_action 08:28:47 INFO - Running pre-action listener: _set_gcov_prefix 08:28:47 INFO - Running main action method: run_tests 08:28:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:28:47 INFO - Python 2.7.3 08:28:47 INFO - Return code: 0 08:28:47 INFO - grabbing minidump binary from tooltool 08:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:47 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 0xe0ad00>, '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 0xe0bc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe0c090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:28:47 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 08:28:47 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 08:28:47 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 08:28:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:28:47 INFO - Return code: 0 08:28:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:28:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:28:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:28:47 INFO - ENV: RUST_BACKTRACE is now 1 08:28:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:28:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:28:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 08:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-089 --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 08:28:47 INFO - Using env: {'DISPLAY': ':0', 08:28:47 INFO - 'HOME': '/home/cltbld', 08:28:47 INFO - 'LANG': 'en_US.UTF-8', 08:28:47 INFO - 'LANGUAGE': 'en_US:en', 08:28:47 INFO - 'LOGNAME': 'cltbld', 08:28:47 INFO - 'MAIL': '/var/mail/cltbld', 08:28:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:28:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:47 INFO - 'MOZ_NO_REMOTE': '1', 08:28:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:47 INFO - 'NO_EM_RESTART': '1', 08:28:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:47 INFO - 'PWD': '/builds/slave/test', 08:28:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:28:47 INFO - 'RUST_BACKTRACE': '1', 08:28:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:28:47 INFO - 'SHELL': '/bin/bash', 08:28:47 INFO - 'SHLVL': '1', 08:28:47 INFO - 'TERM': 'linux', 08:28:47 INFO - 'TMOUT': '86400', 08:28:47 INFO - 'USER': 'cltbld', 08:28:47 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751', 08:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:47 INFO - '_': '/tools/buildbot/bin/python'} 08:28:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 08:28:48 INFO - mozversion application_buildid: 20170718144642 08:28:48 INFO - mozversion application_changeset: 8ff4f17b266db9a780efe06f7fbdae629e49f5bc 08:28:48 INFO - mozversion application_display_name: Nightly 08:28:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:28:48 INFO - mozversion application_name: Firefox 08:28:48 INFO - mozversion application_remotingname: firefox 08:28:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:28:48 INFO - mozversion application_vendor: Mozilla 08:28:48 INFO - mozversion application_version: 56.0a1 08:28:48 INFO - mozversion platform_buildid: 20170718144642 08:28:48 INFO - mozversion platform_changeset: 8ff4f17b266db9a780efe06f7fbdae629e49f5bc 08:28:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:28:48 INFO - mozversion platform_version: 56.0a1 08:28:48 INFO - using testdate: 1500391728 08:28:48 INFO - actual date: 1500391728 08:28:48 INFO - starting webserver on 'localhost:44701' 08:28:48 INFO - SUITE-START | Running 2 tests 08:28:48 INFO - TEST-START | dromaeo_css 08:28:48 INFO - Initialising browser for dromaeo_css test... 08:28:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44701/getInfo.html -profile /tmp/tmpXa9y6Z/profile 08:28:48 INFO - TEST-INFO | started process 28268 (/builds/slave/test/build/application/firefox/firefox http://localhost:44701/getInfo.html) 08:28:55 INFO - TEST-INFO | 28268: exit 0 08:28:55 INFO - Browser initialized. 08:28:55 INFO - Running cycle 1/1 for dromaeo_css test... 08:28:55 INFO - TEST-INFO | started process 28535 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXa9y6Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:06 INFO - PID 28535 | RSS: Main: 175865856 08:29:06 INFO - PID 28535 | 08:32:05 INFO - PID 28535 | Cycle 1(1): loaded http://localhost:44701/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44701/tests/dromaeo/cssquery-ext.html) 08:32:06 INFO - PID 28535 | RSS: Main: 180703232 08:32:06 INFO - PID 28535 | 08:35:08 INFO - PID 28535 | Cycle 1(1): loaded http://localhost:44701/tests/dromaeo/cssquery-ext.html (next: http://localhost:44701/tests/dromaeo/cssquery-jquery.html) 08:35:08 INFO - PID 28535 | RSS: Main: 177324032 08:35:08 INFO - PID 28535 | 08:38:10 INFO - PID 28535 | Cycle 1(1): loaded http://localhost:44701/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44701/tests/dromaeo/cssquery-mootools.html) 08:38:11 INFO - PID 28535 | RSS: Main: 180707328 08:38:11 INFO - PID 28535 | 08:41:12 INFO - PID 28535 | Cycle 1(1): loaded http://localhost:44701/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44701/tests/dromaeo/cssquery-prototype.html) 08:41:13 INFO - PID 28535 | RSS: Main: 178556928 08:41:13 INFO - PID 28535 | 08:44:16 INFO - PID 28535 | Cycle 1(1): loaded http://localhost:44701/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44701/tests/dromaeo/cssquery-yui.html) 08:44:17 INFO - PID 28535 | RSS: Main: 180830208 08:44:17 INFO - PID 28535 | 08:47:18 INFO - PID 28535 | Cycle 1(1): loaded http://localhost:44701/tests/dromaeo/cssquery-yui.html (next: http://localhost:44701/tests/dromaeo/cssquery-dojo.html) 08:47:19 INFO - PID 28535 | RSS: Main: 181985280 08:47:19 INFO - PID 28535 | 08:47:19 INFO - PID 28535 | __start_tp_report 08:47:19 INFO - PID 28535 | _x_x_mozilla_page_load 08:47:19 INFO - PID 28535 | _x_x_mozilla_page_load_details 08:47:19 INFO - PID 28535 | |i|pagename|runs| 08:47:19 INFO - PID 28535 | |0;dojo.html;3082.0599717086307;3153.0856051744995;3157.7947433416825;3167.366526694662;3178.2213357727346;5949.583529152961;5969.432903874131;6009.969950150254;6018.1875446814665;6026.789062382817;6028.849278768033;6033.1855199548045;6036.69816509175;6040;6046.576739628228;5522.116461366182;5539.307586551681;5559.555235581164;5564.387917329091;5591.217229587861;5581.7209139543065;5587.3015873015875;5593.888122237553;5604.271444712182;5619.5785316101255;5577.274954255961;5582.525485333752;5594.9720251398885;5596.944030559683;5611.186377975191;5568.3596386415675;5590.804321848756;5594.9720251398885;5624.55003599711;5624.718764061801;5470.206820011116;5534.446555344473;5546.112621980504;5587.05020146576;5686.1755045518585;6053.667048312341;6086.939130608682;6099.634021958696;6129.019356902919;6188.412100850412;6444.516661250378;6527.967360163168;6561.179852518435;6601;6612.504062195307;6383.744650213986;6484.675766211671;6495.837604059889;6502.642354670491;6506.479481641457;6028.09578563219;6031.457168854824;6036.96981515094;6037.969810150921;6043.425874541911;6592.208934927791;6621.172353455818;6739.898901516482;6773.153355830521;6820.863582728417;6356.523260755462;6406.647634380154;6414.230292364946;6480.935190648128;6520.413162815369;6368.936310636927;6497.610143391412;6564.67176641166;6601.174853143357;6638.0374845648075;6008.849778755566;6376.808695739135;6412.422881940648;6459.870802583922;6480.546361754632;5827.88344233113;6362;6419.069234960904;6426.0360945857565;6436.485081193493;5138.845834624893;5193.169092945111;5216.165413533892;5222.660527065728;5225.869353266199;4388.034632380871;4444.555544445594;4447.310666846644;4455.287154055336;4461.397711308931;5613.10190369547;5618.325800903917;5627.774889004394;5627.803026894039;5649.12438572022;6385.329540398284;6471.320511346241;6479.935200648028;6482.1573195485225;6482.837929051717;5584.91622625661;5624.3813180550105;5631.7747290108755;5639.210510528529;5640.633358831663;5647.971760141173;5706.429357064343;5707.058335374617;5717.885642287131;5720.056190728566;6272.059191121277;6316.778912738124;6330.873382532323;6399.648019358887;6469.482441404676;6479.254885688206;6490.740370385131;6504.991726282434;6617.172853393326;6622.735090596322;6297.4647154992335;6338.271098823694;6396.26442959047;6418.261899881387;6424.967875160594;6332.905006424815;6404.263509696445;6406.814739273249;6423.389777971085;6502.642354670538;5676.262085928968;6426.871462570816;6492.513061520499;6502.252240992158;6676.49926255523;6323.620582765049;6351.745930162741;6423.9036414452885;6441.516886233645;6459.935400645933;6297.4647154992335;6317.336679648754;6326.177596912372;6411.8717625646295;6413.7113829876835;6049.727762250621;6196.938030619636;6278.937210628018;6369.9681501592195;6372.07604897278;6311.495080393649;6313.46335561464;6337.556371053982;6358.682065896779;6374.107624932606;6034.275886893601;6163.907541386793;6176.104464852661;6230.376962303733;6311.779087731908 08:47:19 INFO - PID 28535 | |1;ext.html;760.9391248700105;800.2677550041712;828.5070383122044;836.6444261188997;1176.6764139861543;29075.418491630182;29579.260518487048;29665.703342966564;35893.82053089731;36570;40162;40589.59410405895;40617.18765624686;40628.79685601575;40635.390469142985;7546.358559522447;7740.148583655793;7742.574158421285;7751.689932402697;7752.689892404297;7601.505902116372;7704.576248306341;7708.807279818021;7709.614519274042;7717.2668596483245;5716.1711551825165;5940.287165540141;5969.671668058255;7698.692052317929;7748.5350878947165;7533.924660753404;7696.7306144284685;7709.1134519530415;7724;7741.303282704555;7456.739014134533;7525.548467091992;7533.886991695129;7540.245975402416;7553.093628764528;36203.63796362029;36580;36643.26713465742;36653;36655.63344366549;3549.2901419715904;3563.6436356364416;3581.982090089533;3609.5127157833617;3609.657082577151;29040.12879613615;29084.563731544044;29151.41697166045;29271.2682182945;29275.560866587017;4864.6108311335365;4872.06344456084;4879.63402744792;4889.119958407486;4990;211425;213206;213903;215357;216246;46775.766121169174;47214.763926180836;47234.76382618133;47265.291020634715;47275.527244727804;47535.286970695466;47851;47966;48138.51861481411;48499.757501212975;15829.841701583067;16067.758983615255;16194.352225910832;16470.75293870593;16518.6696266074;13589.184648921097;13664.93167534156;13669.726605467835;13684.863151368558;13705.931470342784;13683.11059781111;13722.725545489235;13741.106828056145;13940.790888136686;13993.090449120775;4929.186684197139;5698.572607054488;5729.255196824386;5774.711264436845;5855.414458554195;970.9951450242703;976.3458482816388;988.4464699768153;993.5181437003048;1012.0537297626743;22201;22202.444938876335;22222.222222222146;22253.22113726012;22647.320580382613;1077.3247599981946;1083.47992963378;1120.199057673751;1127.6391554702416;1128.8871112888646;11394.202405831678;11675.76648467026;11814.232074915102;11874.168808183344;11922.761544769057;222379;224037;225642;226262;226474;49145;49793.50206497961;49820.50179498231;49844.50155498399;49887.75056124696;1382.930853457323;1479.2160155117804;1479.5931118942376;1487.4719474586366;1497.1690711655135;20667.68998464994;21635.675464868353;21698.566028679023;22132.668009980185;22432.214872479384;34407;34579.65420345764;34581.13547161341;34675.826620866734;34764.47853282152;189015;189283;189818;190156;190793;31362.686373135977;32363.35273294474;32388.676113238565;32594.348113038082;32789.508157378135;38547.229055418175;41239.1752164949;41404.1719165621;41557.168856623306;42001.36997944972;29472.263193420335;29996.400071998873;30342.84828575843;30403.087907362813;30859.382812344076;29697.406051879272;30048.3990320188;30449.695503045572;32674.673253267163;33426.66573334236;35313.82343088268;36563.817180913924;36799.63200367962;37115;37233;30438;31626.051218463483;31704.841475792473;31706.365872681956;32071.679283207803;22791.544169116856;23681.289561313188;23720.40698982539;23793.16723914724;23819.404514886573 08:47:19 INFO - PID 28535 | |2;jquery.html;561.3600495435204;564.6358099026128;566.7308028686372;568.8549419897926;589.125149153507;21206.36380908573;22043.448913777145;22052.11791528339;22185.44536386591;22561.09755609778;24525;26271.211863644072;26323;26506;26552.203433896964;6406.647634380107;6593.901091483632;6604.933950660504;6608.504362172832;6626.5030122740745;6231.034189700604;6514.478841692677;6531.150950376445;6560.475161987029;6566.770163044294;6201.844953876144;6473;6494.902576461357;6497.155369801919;6505.902411463808;6489.415952564268;6502.479801615883;6504.902426463606;6509.739610415578;6511.088447617313;6020.548458865603;6025.096235564656;6029.487493563052;6062;6062.42406971337;27837.582436263474;28913.42173156546;29333.26666833325;29334.119976400743;29347.55978660322;1932.5361913140885;1954.9609007819906;1958.4222654317011;1959.2848610257297;1969.1237399357292;18350.174242159133;18942.905285473622;19007.61984760311;19018;19070.61858762831;2299.7470278269375;2349.835511514195;2384.9761502384927;2394.461246219604;2406.5307265083316;128178.99999999907;131120;134268;134896.32551837276;134963;14188.665663569052;14914.4779932704;14944.327505262288;15011.174385408689;15424.5372638821;23234.07063717466;23430.882845586006;23478;23533.76466235316;23547;9685.951570242245;9708.563114659857;9741.951290243645;9870.703878883645;9959.502024898871;8933.419327743675;8951.865722014176;9042.954785226031;9145.451272923647;9147.496887671243;9143.3599648024;9210.81578368429;9211.953940230256;9305.906940930505;9392.29557783169;2608.6782763340643;2647.1264482720658;2651.973480265173;2661.680598328213;2739.205630367171;945.1493655709916;948.0898337595847;950.7432993091827;972.9805403891883;984.3847595252967;19660;19890.508211884167;20481.590368192552;23452.061917523108;24879.875600622243;1034.9586016559253;1060.5863713151878;1062.134360496193;1066.568039943824;1069.2194697870598;11334.829977550344;11491.655250342503;11497.195196336343;11577.247478913843;11686;496740;507979;508080;512025;522665;116521;118987;121090.07103519926;121254;121980.39009804894;1264.089855304198;1279.4178648714812;1293.1723696833847;1294.766941950458;1299.110109574944;17276.049817260173;18077.909610451865;18183.818161818213;18573.164207610418;18774.812251877855;51719;55012.72493637506;56396.15405768835;57689.71155144365;59749.10376344271;67168.6641566789;69701.65149174222;69959.65020174866;70557.29442705507;70970.64514677394;14028.22844743549;14415.855841441451;14540.49108281205;14546.781798272823;14586.635334116732;23319.067237310996;23419.882900585388;23430;23459.296221113393;23480.178193763135;16197.67604647924;16387.852850300365;16553.917230413772;18621.81378186255;18698;16217.67564648724;16440.506784796475;16453.177341132658;16930;17069.743953840454;17552.297908083532;17633.118344082486;17648.294068237126;17834.10829458548;17835.643287133924;14117.858821412065;14191.07757995727;14221.928890355483;14228.50200243028;14257.64355891111;17772.46682599524;19260.8073919259;19377.806221938165;19386.515337116685;19414.61170776548 08:47:19 INFO - PID 28535 | |3;mootools.html;1375.539194369886;1419.708959663269;1428.2715814934386;1443.5380678182983;1455.0105927968978;12945.935270323647;13416;13587.45650173993;13597.52408665697;13629.114107583013;13081.542146024867;13978.930105349458;14076.296185190751;14086.366113524891;14097.718045639107;2464.9876750616268;2505.1983365323103;2514.0823599386185;2526.381036646015;2526.6967963844363;2425.9150929717375;2463.8275320727557;2464.8397854139425;2465.580851255282;2475.4553998120473;2311.537692461506;2353.9058437662475;2355.9764402356013;2360.0323867214447;2373.95252094958;2320.2459200759654;2335.054303007285;2342.906283748648;2344.882755862209;2356.4108972756812;2240.6751021102014;2279.1453205048106;2281.3498153026308;2284.4174735442357;2286.9542609147725;12821.743565128738;13232.338383080807;13236.13965092266;13243.536476223286;13245;6898.827529311808;7153.6780844862105;7161.140663120459;7170.677319520634;7171.820704482378;4414.293713005904;4463.218936686067;4538.568835960578;4562.954370456286;4577.267637178035;1774.4055741326672;1808.8462480689025;1834.110456428631;1881.444973732752;1892.0728842866897;21271;21349;21395.358139255848;21474.785252147434;21583.784162158492;5810.331811841692;5870.295564532284;5882.882342353129;5938.634114153769;5979.790707325223;15112.244387780787;15116;15119.697606048037;15132.470363537223;15139.924300378427;6791.592504449749;6933.826654333682;6934.133233345832;6940.895886561605;6986.580805151707;5689.146628005832;5981.7607295707685;6443.420092191725;6714.060031595581;6718.731250750013;4332.610065094093;4395.120975804852;4412.757298348622;4428.4243048403505;4475.753833539122;1224.3205021213312;1229.4836168809122;1236.8701286364983;1247.8502579690314;1250.3435696259355;879.134052957836;881.9911800882037;907.5915837872983;919.4345477531404;920.3557509743207;7193.424526037905;7290.635468226674;8043.477173983672;8361.540115293596;8818.162274583905;969.4328817641617;970.6069042037985;981.8919918808925;1021.3769600543662;1027.9229057820694;5121.359830021247;5355.839324820262;5373.032854086302;5383.327084114486;5505.311836020497;17572.472825815246;18344.724829127576;18416.17127229278;18422.171002304927;18607;17840.55398615045;18225.81774182241;18360.54098647518;18368.448946531626;18407.263709451472;9932.205423566098;9945.651902183388;10437.582496700199;10462.686119416581;10616.628418005334;7839.137694853675;8140.308073813792;8259.256666900008;8348.749537513884;8488.363372746946;15002.774958375852;15914.920425397799;16001;16101.033937963759;16162.111083890499;15955.760663589823;16579.336826526804;16614.418495352606;16686.833131669013;16803.91598042002;11429;11762.176647634584;11827.881721183023;12292.201006934878;12654.493820247088;11694.88305116972;11752;11835.585754498552;12333.62999110028;12808.423620936894;10017.198624110199;10209.369301138824;10362.637307694195;10464.581416743245;10472.790544188922;9534.61861525559;9889.456079915673;9929.304948653526;10037.34757240777;10107.797844043225;8508.574571271536;8657.437266577652;8658.870116948125;8659.783505412415;8674.869876951978;7139.535930164523;7262.164851041986;7286.96356518214;7320.707171713285;7348.448866335153;7299.306565876233;7348.632568371453;7362;7405;7406.296401841816 08:47:19 INFO - PID 28535 | |4;prototype.html;472.13363478017834;485.3350909254322;500.7421178093285;505.19925917420875;512.9461406552311;5939.1388248703915;6014.075495841333;6065.818025459238;6102.2677278726505;6113.205283313174;5643.238162848014;5845.357010728816;5859.209006784083;5881.794137205198;5912.586118971673;4819.397575303095;4851.878703032435;4867.3915760529935;4871.610271178315;4880.389951256093;4733.668643194977;4770.7357550249035;4808.471068182497;4818.156822556056;4832.879178020543;4766.213574760161;4775.331453596499;4788.449328327235;4795.89694370295;4847.660663753539;4647.465541462741;4674.298855171717;4773.618110551148;4819.5782244238035;4821.37322148122;4277.636400905927;4287.3846953358425;4309.439772829513;4337.980574564975;4339.1104823511105;5726.141078838166;5735.541156707453;5822.534197264209;5825;5834.5915785895;5409.404965453797;5429.728513574345;5467.726613669301;5473.124300111963;5477.808276710336;6260.718267677966;6269.3730626937395;6306.527010474233;6328.272248691414;6343.619382837044;4688.718676879398;4697.412823397075;4699.107169637758;4706.835260765891;4708.152532544141;6552.3775241352;6553.574017688883;6591.93408065918;6658.300878407795;6711.865762684768;4801.975990120027;4808.927866082012;4835.274708793639;4840.152079097126;4861.586765125004;4873.4882837301575;4908.993656300449;4910.484399138039;4928.6057115431395;4948.455669876311;5376.596755243372;5427.0773968425465;5444.618876678674;5501.4223506532035;5535.391106978229;6251.78118765841;6275.215598050244;6278.15244941927;6282.403171698681;6383.170187875639;1689.7803285572797;1710.837470440306;1712.1011468978886;1720.6128621060411;1725.3098760495652;1102.9393383363831;1175.905927525796;1184.117832214988;1189.1616410430627;1212.2060050666828;5354.759035843396;5468.589855760833;5514.338279406497;5557.221988921554;5564.721763911869;6382.425581697669;6432;6457.677116144174;6491.241222480427;6530.379613936669;5598.860028499239;5644.74598643062;5655.660660360391;5668.9716551417805;5669.659820410789;3417.1457135716073;3428.262923471416;3443.5867695876655;3462.5844898612327;3480.190301043443;6258;6294.748210071546;6304.730297093043;6323.375799043438;6385.627090175634;6524.836879078061;6525.445337146396;6556.377144171296;6620.9006864897065;6674.299198584079;6216.689165541705;6243.906341404973;6291.559590828598;6318.210223722035;6319.8104056878365;6415.903761443676;6423.261324947504;6425.775097871552;6473.935260647521;6487.967560162169;6315.778947736807;6358.427741503287;6360.9822428411235;6404.711787969646;6437.903431448625;6189.81430557084;6200.100985357189;6223.253209614875;6268.749250029948;6271.804868296243;4816.277558366133;4818.68678535894;4847.248676455155;4848.151573474698;4892.143874821821;6517.348265173445;6552.770653027121;6563.573367731082;6592.406683398517;6607.240167380621;6334.714937827901;6347.5556711029785;6349.746010159542;6354.23749150105;6386.233651961795;6299.401556852092;6305;6325;6331.430171284606;6353.4599559038;6105.542084343603;6171.47542458896;6204.689765511796;6219.32078338855;6225.533085018732;5990.950856881272;6301.905471418024;6325.557210995186;6332.606826498163;6351.9047214290895;5991.281046274475;6046.697665116814;6139.2325959255095;6141.477974372228;6181.289151747606 08:47:19 INFO - PID 28535 | |5;yui.html;882.9514376709283;910.6266430763386;912.5118061836919;914.1544071733645;926.5506229478698;18139.183736731844;18559.628807423862;18880;18947.715784263248;18999;15171.165585892772;15297.158656273901;16356.100414477229;16415.671686566293;16471.423500177498;1017.8676772019645;1031.783325501642;1036;1038.1227862456212;1039.6361273554232;1021.2493817044466;1027.4195079779938;1029.7168278723336;1031.5100327344526;1037.082182268694;1110.666799960013;1111.2776695148139;1111.4998250787178;1113.1540029577538;1113.7549739057395;999.0209594597335;1107.7396811749231;1107.7562936154034;1108.3017698849753;1114.57646094484;728.1226122522401;776.3905334312594;779.0106564662904;779.2207792207793;780.3094261578487;19874.701879471675;20205.8989705052;20208.595828083504;20232.79767202324;20235.696464552897;19530.609387812307;20592.691109633368;20650.27724029667;20708.171673133056;20925.476863078544;15863.762043569355;16397.508074757778;16554;16624.916875415667;16735;3491.4762785582366;3553.822308884571;3599.8200089995394;3613.4218525035867;3630.509881166035;98051.50974245154;115321.4233928825;119288.40355798253;125386;131325.34337328348;13596.144809590096;13667.111637743714;15854.286557104959;16494.34022639081;16804.495865124067;28419.857900710365;28962.71037289642;29259.707402926124;29390.265243369086;29406.558901616492;8608.612612432331;8883.911160888438;9001;9046.366754327133;9100.544972751335;4196.601322874322;4258.233517966796;4276.401303817468;4291.2275790358035;4317.0934103838545;4622.399088118523;4645.163870503275;4695.765211739399;4710.411198600175;4768.356271903249;988.3526290279879;1009.7324209084599;1016.4663551635302;1017.0388982411698;1020.1023099672241;681.8090934538337;688.6659969914588;688.8725585766649;711.1501755402245;719.8704233238068;11457.427128643534;11817.172797904064;12136.696582585506;12175.33035683046;12634.494620215271;673.7305077968754;692.8314376003078;698.5948150072945;710.982225444368;712.134756271133;5260.658057226268;5274.876689897592;5323.281357016831;5352.732363381815;5516.200150978166;102129;106395;108425;109431.45284273528;109899;88586;89455;91927;92360;96052.51973740087;78138;78236;80950.59524702339;80995;81769;10554.366737995744;10576.312539684895;10697.465126743477;10758.40828754426;10933.726656833644;35024.474632881036;35461.1134721634;35760.463593045606;35768.46347304845;37658;44302;46981.765091174326;47146.52853471421;47625.76187119181;48158.277625836345;16582.25379857885;18699.626007480045;18716.625667486845;18823.34118305853;19012.809871901103;19568.510787230432;20529.692054618892;20603.58792824105;20734.17063317511;20823.583528329047;18325.908370458063;18400.079996000415;18408.35570755071;18466.630667386846;18656.067196639844;17926.731099033786;18371.173297201392;18967.14647840878;19188.904055479634;19249.61500769949;17871.821281787015;18137.546561336072;18534.72197917005;18587.163577638767;18590.349337773114;13040.282784446947;13292.534761283308;13641.249731264876;13848.238346891017;13872.306384680927;13611.931940340235;13697.246651434267;13893.235872027135;13904.304784760923;13922.930385348009 08:47:19 INFO - PID 28535 | __end_tp_report 08:47:19 INFO - PID 28535 | __start_cc_report 08:47:19 INFO - PID 28535 | _x_x_mozilla_cycle_collect,367 08:47:19 INFO - PID 28535 | __end_cc_report 08:47:19 INFO - PID 28535 | __startTimestamp1500392839226__endTimestamp 08:47:19 INFO - PID 28535 | 08:47:19 INFO - PID 28535 | ------- Summary: start ------- 08:47:19 INFO - PID 28535 | Number of tests: 6 08:47:19 INFO - PID 28535 | 08:47:19 INFO - PID 28535 | [#0] dojo.html Cycles:165 Average:5975.97 Median:6196.94 stddev:699.04 (11.3%) stddev-sans-first:663.30 08:47:19 INFO - PID 28535 | Values: 3082.1 3153.1 3157.8 3167.4 3178.2 5949.6 5969.4 6010.0 6018.2 6026.8 6028.8 6033.2 6036.7 6040.0 6046.6 5522.1 5539.3 5559.6 5564.4 5591.2 5581.7 5587.3 5593.9 5604.3 5619.6 5577.3 5582.5 5595.0 5596.9 5611.2 5568.4 5590.8 5595.0 5624.6 5624.7 5470.2 5534.4 5546.1 5587.1 5686.2 6053.7 6086.9 6099.6 6129.0 6188.4 6444.5 6528.0 6561.2 6601.0 6612.5 6383.7 6484.7 6495.8 6502.6 6506.5 6028.1 6031.5 6037.0 6038.0 6043.4 6592.2 6621.2 6739.9 6773.2 6820.9 6356.5 6406.6 6414.2 6480.9 6520.4 6368.9 6497.6 6564.7 6601.2 6638.0 6008.8 6376.8 6412.4 6459.9 6480.5 5827.9 6362.0 6419.1 6426.0 6436.5 5138.8 5193.2 5216.2 5222.7 5225.9 4388.0 4444.6 4447.3 4455.3 4461.4 5613.1 5618.3 5627.8 5627.8 5649.1 6385.3 6471.3 6479.9 6482.2 6482.8 5584.9 5624.4 5631.8 5639.2 5640.6 5648.0 5706.4 5707.1 5717.9 5720.1 6272.1 6316.8 6330.9 6399.6 6469.5 6479.3 6490.7 6505.0 6617.2 6622.7 6297.5 6338.3 6396.3 6418.3 6425.0 6332.9 6404.3 6406.8 6423.4 6502.6 5676.3 6426.9 6492.5 6502.3 6676.5 6323.6 6351.7 6423.9 6441.5 6459.9 6297.5 6317.3 6326.2 6411.9 6413.7 6049.7 6196.9 6278.9 6370.0 6372.1 6311.5 6313.5 6337.6 6358.7 6374.1 6034.3 6163.9 6176.1 6230.4 6311.8 08:47:19 INFO - PID 28535 | 08:47:19 INFO - PID 28535 | [#1] ext.html Cycles:180 Average:36895.24 Median:34493.33 stddev:54443.67 (157.8%) stddev-sans-first:54528.80 08:47:19 INFO - PID 28535 | Values: 760.9 800.3 828.5 836.6 1176.7 29075.4 29579.3 29665.7 35893.8 36570.0 40162.0 40589.6 40617.2 40628.8 40635.4 7546.4 7740.1 7742.6 7751.7 7752.7 7601.5 7704.6 7708.8 7709.6 7717.3 5716.2 5940.3 5969.7 7698.7 7748.5 7533.9 7696.7 7709.1 7724.0 7741.3 7456.7 7525.5 7533.9 7540.2 7553.1 36203.6 36580.0 36643.3 36653.0 36655.6 3549.3 3563.6 3582.0 3609.5 3609.7 29040.1 29084.6 29151.4 29271.3 29275.6 4864.6 4872.1 4879.6 4889.1 4990.0 211425.0 213206.0 213903.0 215357.0 216246.0 46775.8 47214.8 47234.8 47265.3 47275.5 47535.3 47851.0 47966.0 48138.5 48499.8 15829.8 16067.8 16194.4 16470.8 16518.7 13589.2 13664.9 13669.7 13684.9 13705.9 13683.1 13722.7 13741.1 13940.8 13993.1 4929.2 5698.6 5729.3 5774.7 5855.4 971.0 976.3 988.4 993.5 1012.1 22201.0 22202.4 22222.2 22253.2 22647.3 1077.3 1083.5 1120.2 1127.6 1128.9 11394.2 11675.8 11814.2 11874.2 11922.8 222379.0 224037.0 225642.0 226262.0 226474.0 49145.0 49793.5 49820.5 49844.5 49887.8 1382.9 1479.2 1479.6 1487.5 1497.2 20667.7 21635.7 21698.6 22132.7 22432.2 34407.0 34579.7 34581.1 34675.8 34764.5 189015.0 189283.0 189818.0 190156.0 190793.0 31362.7 32363.4 32388.7 32594.3 32789.5 38547.2 41239.2 41404.2 41557.2 42001.4 29472.3 29996.4 30342.8 30403.1 30859.4 29697.4 30048.4 30449.7 32674.7 33426.7 35313.8 36563.8 36799.6 37115.0 37233.0 30438.0 31626.1 31704.8 31706.4 32071.7 22791.5 23681.3 23720.4 23793.2 23819.4 08:47:19 INFO - PID 28535 | 08:47:19 INFO - PID 28535 | [#2] jquery.html Cycles:180 Average:35200.04 Median:23468.65 stddev:85521.74 (364.4%) stddev-sans-first:85722.10 08:47:19 INFO - PID 28535 | Values: 561.4 564.6 566.7 568.9 589.1 21206.4 22043.4 22052.1 22185.4 22561.1 24525.0 26271.2 26323.0 26506.0 26552.2 6406.6 6593.9 6604.9 6608.5 6626.5 6231.0 6514.5 6531.2 6560.5 6566.8 6201.8 6473.0 6494.9 6497.2 6505.9 6489.4 6502.5 6504.9 6509.7 6511.1 6020.5 6025.1 6029.5 6062.0 6062.4 27837.6 28913.4 29333.3 29334.1 29347.6 1932.5 1955.0 1958.4 1959.3 1969.1 18350.2 18942.9 19007.6 19018.0 19070.6 2299.7 2349.8 2385.0 2394.5 2406.5 128179.0 131120.0 134268.0 134896.3 134963.0 14188.7 14914.5 14944.3 15011.2 15424.5 23234.1 23430.9 23478.0 23533.8 23547.0 9686.0 9708.6 9742.0 9870.7 9959.5 8933.4 8951.9 9043.0 9145.5 9147.5 9143.4 9210.8 9212.0 9305.9 9392.3 2608.7 2647.1 2652.0 2661.7 2739.2 945.1 948.1 950.7 973.0 984.4 19660.0 19890.5 20481.6 23452.1 24879.9 1035.0 1060.6 1062.1 1066.6 1069.2 11334.8 11491.7 11497.2 11577.2 11686.0 496740.0 507979.0 508080.0 512025.0 522665.0 116521.0 118987.0 121090.1 121254.0 121980.4 1264.1 1279.4 1293.2 1294.8 1299.1 17276.0 18077.9 18183.8 18573.2 18774.8 51719.0 55012.7 56396.2 57689.7 59749.1 67168.7 69701.7 69959.7 70557.3 70970.6 14028.2 14415.9 14540.5 14546.8 14586.6 23319.1 23419.9 23430.0 23459.3 23480.2 16197.7 16387.9 16553.9 18621.8 18698.0 16217.7 16440.5 16453.2 16930.0 17069.7 17552.3 17633.1 17648.3 17834.1 17835.6 14117.9 14191.1 14221.9 14228.5 14257.6 17772.5 19260.8 19377.8 19386.5 19414.6 08:47:19 INFO - PID 28535 | 08:47:19 INFO - PID 28535 | [#3] mootools.html Cycles:180 Average:8296.91 Median:2343.89 stddev:5637.89 (240.5%) stddev-sans-first:5629.72 08:47:19 INFO - PID 28535 | Values: 1375.5 1419.7 1428.3 1443.5 1455.0 12945.9 13416.0 13587.5 13597.5 13629.1 13081.5 13978.9 14076.3 14086.4 14097.7 2465.0 2505.2 2514.1 2526.4 2526.7 2425.9 2463.8 2464.8 2465.6 2475.5 2311.5 2353.9 2356.0 2360.0 2374.0 2320.2 2335.1 2342.9 2344.9 2356.4 2240.7 2279.1 2281.3 2284.4 2287.0 12821.7 13232.3 13236.1 13243.5 13245.0 6898.8 7153.7 7161.1 7170.7 7171.8 4414.3 4463.2 4538.6 4563.0 4577.3 1774.4 1808.8 1834.1 1881.4 1892.1 21271.0 21349.0 21395.4 21474.8 21583.8 5810.3 5870.3 5882.9 5938.6 5979.8 15112.2 15116.0 15119.7 15132.5 15139.9 6791.6 6933.8 6934.1 6940.9 6986.6 5689.1 5981.8 6443.4 6714.1 6718.7 4332.6 4395.1 4412.8 4428.4 4475.8 1224.3 1229.5 1236.9 1247.9 1250.3 879.1 882.0 907.6 919.4 920.4 7193.4 7290.6 8043.5 8361.5 8818.2 969.4 970.6 981.9 1021.4 1027.9 5121.4 5355.8 5373.0 5383.3 5505.3 17572.5 18344.7 18416.2 18422.2 18607.0 17840.6 18225.8 18360.5 18368.4 18407.3 9932.2 9945.7 10437.6 10462.7 10616.6 7839.1 8140.3 8259.3 8348.7 8488.4 15002.8 15914.9 16001.0 16101.0 16162.1 15955.8 16579.3 16614.4 16686.8 16803.9 11429.0 11762.2 11827.9 12292.2 12654.5 11694.9 11752.0 11835.6 12333.6 12808.4 10017.2 10209.4 10362.6 10464.6 10472.8 9534.6 9889.5 9929.3 10037.3 10107.8 8508.6 8657.4 8658.9 8659.8 8674.9 7139.5 7262.2 7287.0 7320.7 7348.4 7299.3 7348.6 7362.0 7405.0 7406.3 08:47:19 INFO - PID 28535 | 08:47:19 INFO - PID 28535 | [#4] prototype.html Cycles:180 Average:5305.87 Median:5839.97 stddev:1484.12 (25.4%) stddev-sans-first:1443.26 08:47:19 INFO - PID 28535 | Values: 472.1 485.3 500.7 505.2 512.9 5939.1 6014.1 6065.8 6102.3 6113.2 5643.2 5845.4 5859.2 5881.8 5912.6 4819.4 4851.9 4867.4 4871.6 4880.4 4733.7 4770.7 4808.5 4818.2 4832.9 4766.2 4775.3 4788.4 4795.9 4847.7 4647.5 4674.3 4773.6 4819.6 4821.4 4277.6 4287.4 4309.4 4338.0 4339.1 5726.1 5735.5 5822.5 5825.0 5834.6 5409.4 5429.7 5467.7 5473.1 5477.8 6260.7 6269.4 6306.5 6328.3 6343.6 4688.7 4697.4 4699.1 4706.8 4708.2 6552.4 6553.6 6591.9 6658.3 6711.9 4802.0 4808.9 4835.3 4840.2 4861.6 4873.5 4909.0 4910.5 4928.6 4948.5 5376.6 5427.1 5444.6 5501.4 5535.4 6251.8 6275.2 6278.2 6282.4 6383.2 1689.8 1710.8 1712.1 1720.6 1725.3 1102.9 1175.9 1184.1 1189.2 1212.2 5354.8 5468.6 5514.3 5557.2 5564.7 6382.4 6432.0 6457.7 6491.2 6530.4 5598.9 5644.7 5655.7 5669.0 5669.7 3417.1 3428.3 3443.6 3462.6 3480.2 6258.0 6294.7 6304.7 6323.4 6385.6 6524.8 6525.4 6556.4 6620.9 6674.3 6216.7 6243.9 6291.6 6318.2 6319.8 6415.9 6423.3 6425.8 6473.9 6488.0 6315.8 6358.4 6361.0 6404.7 6437.9 6189.8 6200.1 6223.3 6268.7 6271.8 4816.3 4818.7 4847.2 4848.2 4892.1 6517.3 6552.8 6563.6 6592.4 6607.2 6334.7 6347.6 6349.7 6354.2 6386.2 6299.4 6305.0 6325.0 6331.4 6353.5 6105.5 6171.5 6204.7 6219.3 6225.5 5991.0 6301.9 6325.6 6332.6 6351.9 5991.3 6046.7 6139.2 6141.5 6181.3 08:47:19 INFO - PID 28535 | 08:47:19 INFO - PID 28535 | [#5] yui.html Cycles:180 Average:22091.39 Median:19219.26 stddev:29728.83 (154.7%) stddev-sans-first:29769.57 08:47:19 INFO - PID 28535 | Values: 883.0 910.6 912.5 914.2 926.6 18139.2 18559.6 18880.0 18947.7 18999.0 15171.2 15297.2 16356.1 16415.7 16471.4 1017.9 1031.8 1036.0 1038.1 1039.6 1021.2 1027.4 1029.7 1031.5 1037.1 1110.7 1111.3 1111.5 1113.2 1113.8 999.0 1107.7 1107.8 1108.3 1114.6 728.1 776.4 779.0 779.2 780.3 19874.7 20205.9 20208.6 20232.8 20235.7 19530.6 20592.7 20650.3 20708.2 20925.5 15863.8 16397.5 16554.0 16624.9 16735.0 3491.5 3553.8 3599.8 3613.4 3630.5 98051.5 115321.4 119288.4 125386.0 131325.3 13596.1 13667.1 15854.3 16494.3 16804.5 28419.9 28962.7 29259.7 29390.3 29406.6 8608.6 8883.9 9001.0 9046.4 9100.5 4196.6 4258.2 4276.4 4291.2 4317.1 4622.4 4645.2 4695.8 4710.4 4768.4 988.4 1009.7 1016.5 1017.0 1020.1 681.8 688.7 688.9 711.2 719.9 11457.4 11817.2 12136.7 12175.3 12634.5 673.7 692.8 698.6 711.0 712.1 5260.7 5274.9 5323.3 5352.7 5516.2 102129.0 106395.0 108425.0 109431.5 109899.0 88586.0 89455.0 91927.0 92360.0 96052.5 78138.0 78236.0 80950.6 80995.0 81769.0 10554.4 10576.3 10697.5 10758.4 10933.7 35024.5 35461.1 35760.5 35768.5 37658.0 44302.0 46981.8 47146.5 47625.8 48158.3 16582.3 18699.6 18716.6 18823.3 19012.8 19568.5 20529.7 20603.6 20734.2 20823.6 18325.9 18400.1 18408.4 18466.6 18656.1 17926.7 18371.2 18967.1 19188.9 19249.6 17871.8 18137.5 18534.7 18587.2 18590.3 13040.3 13292.5 13641.2 13848.2 13872.3 13611.9 13697.2 13893.2 13904.3 13922.9 08:47:19 INFO - PID 28535 | -------- Summary: end -------- 08:47:19 INFO - PID 28535 | 08:47:20 INFO - TEST-INFO | 28535: exit 0 08:47:20 INFO - TEST-OK | dromaeo_css | took 1111809ms 08:47:20 INFO - TEST-START | kraken 08:47:20 INFO - Initialising browser for kraken test... 08:47:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44701/getInfo.html -profile /tmp/tmpyJKfK8/profile 08:47:20 INFO - TEST-INFO | started process 28936 (/builds/slave/test/build/application/firefox/firefox http://localhost:44701/getInfo.html) 08:47:26 INFO - TEST-INFO | 28936: exit 0 08:47:26 INFO - Browser initialized. 08:47:26 INFO - Running cycle 1/1 for kraken test... 08:47:26 INFO - TEST-INFO | started process 29204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyJKfK8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:47:38 INFO - PID 29204 | RSS: Main: 175620096 08:47:38 INFO - PID 29204 | 08:47:40 INFO - PID 29204 | Cycle 1(1): loaded http://localhost:44701/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44701/tests/kraken/driver.html?testName=audio-beat-detection) 08:47:41 INFO - PID 29204 | RSS: Main: 180015104 08:47:41 INFO - PID 29204 | 08:47:44 INFO - PID 29204 | Cycle 1(1): loaded http://localhost:44701/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44701/tests/kraken/driver.html?testName=audio-dft) 08:47:44 INFO - PID 29204 | RSS: Main: 180264960 08:47:44 INFO - PID 29204 | 08:47:47 INFO - PID 29204 | Cycle 1(1): loaded http://localhost:44701/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44701/tests/kraken/driver.html?testName=audio-fft) 08:47:48 INFO - PID 29204 | RSS: Main: 174665728 08:47:48 INFO - PID 29204 | 08:47:50 INFO - PID 29204 | Cycle 1(1): loaded http://localhost:44701/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44701/tests/kraken/driver.html?testName=audio-oscillator) 08:47:50 INFO - PID 29204 | RSS: Main: 175300608 08:47:50 INFO - PID 29204 | 08:47:53 INFO - PID 29204 | Cycle 1(1): loaded http://localhost:44701/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44701/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:47:53 INFO - PID 29204 | RSS: Main: 175071232 08:47:53 INFO - PID 29204 | 08:47:56 INFO - PID 29204 | Cycle 1(1): loaded http://localhost:44701/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44701/tests/kraken/driver.html?testName=imaging-darkroom) 08:47:57 INFO - PID 29204 | RSS: Main: 178974720 08:47:57 INFO - PID 29204 | 08:48:00 INFO - PID 29204 | Cycle 1(1): loaded http://localhost:44701/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44701/tests/kraken/driver.html?testName=imaging-desaturate) 08:48:01 INFO - PID 29204 | RSS: Main: 179863552 08:48:01 INFO - PID 29204 | 08:48:04 INFO - PID 29204 | Cycle 1(1): loaded http://localhost:44701/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44701/tests/kraken/driver.html?testName=json-parse-financial) 08:48:04 INFO - PID 29204 | RSS: Main: 178417664 08:48:04 INFO - PID 29204 | 08:48:06 INFO - PID 29204 | Cycle 1(1): loaded http://localhost:44701/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44701/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:48:07 INFO - PID 29204 | RSS: Main: 178536448 08:48:07 INFO - PID 29204 | 08:48:08 INFO - PID 29204 | Cycle 1(1): loaded http://localhost:44701/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44701/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:48:09 INFO - PID 29204 | RSS: Main: 178753536 08:48:09 INFO - PID 29204 | 08:48:11 INFO - PID 29204 | Cycle 1(1): loaded http://localhost:44701/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44701/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:48:12 INFO - PID 29204 | RSS: Main: 179257344 08:48:12 INFO - PID 29204 | 08:48:14 INFO - PID 29204 | Cycle 1(1): loaded http://localhost:44701/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:48:15 INFO - PID 29204 | RSS: Main: 178864128 08:48:15 INFO - PID 29204 | 08:48:18 INFO - PID 29204 | Cycle 1(1): loaded http://localhost:44701/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:48:19 INFO - PID 29204 | RSS: Main: 179634176 08:48:19 INFO - PID 29204 | 08:48:20 INFO - PID 29204 | Cycle 1(1): loaded http://localhost:44701/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44701/tests/kraken/driver.html?testName=ai-astar) 08:48:21 INFO - PID 29204 | RSS: Main: 180502528 08:48:21 INFO - PID 29204 | 08:48:21 INFO - PID 29204 | __start_tp_report 08:48:21 INFO - PID 29204 | _x_x_mozilla_page_load 08:48:21 INFO - PID 29204 | _x_x_mozilla_page_load_details 08:48:21 INFO - PID 29204 | |i|pagename|runs| 08:48:21 INFO - PID 29204 | |0;ai-astar;98;110;102;109;108;109;110;100;112;111 08:48:21 INFO - PID 29204 | |1;audio-beat-detection;150;119;158;166;122;145;156;120;171;122 08:48:21 INFO - PID 29204 | |2;audio-dft;163;161;162;164;162;162;163;167;182;163 08:48:21 INFO - PID 29204 | |3;audio-fft;75;78;74;167;75;75;75;75;97;74 08:48:21 INFO - PID 29204 | |4;audio-oscillator;81;83;134;82;81;82;130;81;81;135 08:48:21 INFO - PID 29204 | |5;imaging-gaussian-blur;114;114;113;114;114;114;114;113;113;115 08:48:21 INFO - PID 29204 | |6;imaging-darkroom;150;151;151;151;151;153;151;150;149;150 08:48:21 INFO - PID 29204 | |7;imaging-desaturate;95;95;95;94;93;94;94;94;93;94 08:48:21 INFO - PID 29204 | |8;json-parse-financial;53;54;56;53;54;55;56;56;53;53 08:48:21 INFO - PID 29204 | |9;json-stringify-tinderbox;54;54;55;54;54;53;55;55;54;54 08:48:21 INFO - PID 29204 | |10;stanford-crypto-aes;79;80;81;85;77;78;77;76;77;77 08:48:21 INFO - PID 29204 | |11;stanford-crypto-ccm;135;134;126;136;130;126;125;130;124;176 08:48:21 INFO - PID 29204 | |12;stanford-crypto-pbkdf2;191;180;191;178;181;182;189;184;187;181 08:48:21 INFO - PID 29204 | |13;stanford-crypto-sha256-iterative;70;68;71;70;68;72;68;71;66;67 08:48:21 INFO - PID 29204 | __end_tp_report 08:48:21 INFO - PID 29204 | __start_cc_report 08:48:21 INFO - PID 29204 | _x_x_mozilla_cycle_collect,963 08:48:21 INFO - PID 29204 | __end_cc_report 08:48:21 INFO - PID 29204 | __startTimestamp1500392901152__endTimestamp 08:48:21 INFO - PID 29204 | 08:48:21 INFO - PID 29204 | ------- Summary: start ------- 08:48:21 INFO - PID 29204 | Number of tests: 14 08:48:21 INFO - PID 29204 | 08:48:21 INFO - PID 29204 | [#0] ai-astar Cycles:10 Average:106.90 Median:110.00 stddev:4.98 (4.5%) stddev-sans-first:4.11 08:48:21 INFO - PID 29204 | Values: 98.0 110.0 102.0 109.0 108.0 109.0 110.0 100.0 112.0 111.0 08:48:21 INFO - PID 29204 | 08:48:21 INFO - PID 29204 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:153.00 stddev:20.40 (13.3%) stddev-sans-first:21.48 08:48:21 INFO - PID 29204 | Values: 150.0 119.0 158.0 166.0 122.0 145.0 156.0 120.0 171.0 122.0 08:48:21 INFO - PID 29204 | 08:48:21 INFO - PID 29204 | [#2] audio-dft Cycles:10 Average:164.90 Median:163.00 stddev:6.23 (3.8%) stddev-sans-first:6.57 08:48:21 INFO - PID 29204 | Values: 163.0 161.0 162.0 164.0 162.0 162.0 163.0 167.0 182.0 163.0 08:48:21 INFO - PID 29204 | 08:48:21 INFO - PID 29204 | [#3] audio-fft Cycles:10 Average:86.50 Median:75.00 stddev:29.13 (38.8%) stddev-sans-first:30.60 08:48:21 INFO - PID 29204 | Values: 75.0 78.0 74.0 167.0 75.0 75.0 75.0 75.0 97.0 74.0 08:48:21 INFO - PID 29204 | 08:48:21 INFO - PID 29204 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:81.00 stddev:24.88 (30.7%) stddev-sans-first:25.71 08:48:21 INFO - PID 29204 | Values: 81.0 83.0 134.0 82.0 81.0 82.0 130.0 81.0 81.0 135.0 08:48:21 INFO - PID 29204 | 08:48:21 INFO - PID 29204 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 08:48:21 INFO - PID 29204 | Values: 114.0 114.0 113.0 114.0 114.0 114.0 114.0 113.0 113.0 115.0 08:48:21 INFO - PID 29204 | 08:48:21 INFO - PID 29204 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 08:48:21 INFO - PID 29204 | Values: 150.0 151.0 151.0 151.0 151.0 153.0 151.0 150.0 149.0 150.0 08:48:21 INFO - PID 29204 | 08:48:21 INFO - PID 29204 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 08:48:21 INFO - PID 29204 | Values: 95.0 95.0 95.0 94.0 93.0 94.0 94.0 94.0 93.0 94.0 08:48:21 INFO - PID 29204 | 08:48:21 INFO - PID 29204 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:1.34 (2.5%) stddev-sans-first:1.33 08:48:21 INFO - PID 29204 | Values: 53.0 54.0 56.0 53.0 54.0 55.0 56.0 56.0 53.0 53.0 08:48:21 INFO - PID 29204 | 08:48:21 INFO - PID 29204 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 08:48:21 INFO - PID 29204 | Values: 54.0 54.0 55.0 54.0 54.0 53.0 55.0 55.0 54.0 54.0 08:48:21 INFO - PID 29204 | 08:48:21 INFO - PID 29204 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.50 stddev:2.71 (3.5%) stddev-sans-first:2.87 08:48:21 INFO - PID 29204 | Values: 79.0 80.0 81.0 85.0 77.0 78.0 77.0 76.0 77.0 77.0 08:48:21 INFO - PID 29204 | 08:48:21 INFO - PID 29204 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:132.00 stddev:15.31 (11.6%) stddev-sans-first:16.24 08:48:21 INFO - PID 29204 | Values: 135.0 134.0 126.0 136.0 130.0 126.0 125.0 130.0 124.0 176.0 08:48:21 INFO - PID 29204 | 08:48:21 INFO - PID 29204 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.40 Median:185.50 stddev:4.77 (2.6%) stddev-sans-first:4.42 08:48:21 INFO - PID 29204 | Values: 191.0 180.0 191.0 178.0 181.0 182.0 189.0 184.0 187.0 181.0 08:48:21 INFO - PID 29204 | 08:48:21 INFO - PID 29204 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:70.00 stddev:1.97 (2.8%) stddev-sans-first:2.06 08:48:21 INFO - PID 29204 | Values: 70.0 68.0 71.0 70.0 68.0 72.0 68.0 71.0 66.0 67.0 08:48:21 INFO - PID 29204 | -------- Summary: end -------- 08:48:21 INFO - PID 29204 | 08:48:21 INFO - PID 29204 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:48:21 INFO - TEST-INFO | 29204: exit 0 08:48:21 INFO - TEST-OK | kraken | took 61867ms 08:48:21 INFO - SUITE-END | took 1173s 08:48:22 INFO - Completed test suite (00:19:34) 08:48:22 INFO - javascript benchmark 08:48:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8213.561390698622, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.0599717086307, 3153.0856051744995, 3157.7947433416825, 3167.366526694662, 3178.2213357727346, 5949.583529152961, 5969.432903874131, 6009.969950150254, 6018.1875446814665, 6026.789062382817, 6028.849278768033, 6033.1855199548045, 6036.69816509175, 6040.0, 6046.576739628228, 5522.116461366182, 5539.307586551681, 5559.555235581164, 5564.387917329091, 5591.217229587861, 5581.7209139543065, 5587.3015873015875, 5593.888122237553, 5604.271444712182, 5619.5785316101255, 5577.274954255961, 5582.525485333752, 5594.9720251398885, 5596.944030559683, 5611.186377975191, 5568.3596386415675, 5590.804321848756, 5594.9720251398885, 5624.55003599711, 5624.718764061801, 5470.206820011116, 5534.446555344473, 5546.112621980504, 5587.05020146576, 5686.1755045518585, 6053.667048312341, 6086.939130608682, 6099.634021958696, 6129.019356902919, 6188.412100850412, 6444.516661250378, 6527.967360163168, 6561.179852518435, 6601.0, 6612.504062195307, 6383.744650213986, 6484.675766211671, 6495.837604059889, 6502.642354670491, 6506.479481641457, 6028.09578563219, 6031.457168854824, 6036.96981515094, 6037.969810150921, 6043.425874541911, 6592.208934927791, 6621.172353455818, 6739.898901516482, 6773.153355830521, 6820.863582728417, 6356.523260755462, 6406.647634380154, 6414.230292364946, 6480.935190648128, 6520.413162815369, 6368.936310636927, 6497.610143391412, 6564.67176641166, 6601.174853143357, 6638.0374845648075, 6008.849778755566, 6376.808695739135, 6412.422881940648, 6459.870802583922, 6480.546361754632, 5827.88344233113, 6362.0, 6419.069234960904, 6426.0360945857565, 6436.485081193493, 5138.845834624893, 5193.169092945111, 5216.165413533892, 5222.660527065728, 5225.869353266199, 4388.034632380871, 4444.555544445594, 4447.310666846644, 4455.287154055336, 4461.397711308931, 5613.10190369547, 5618.325800903917, 5627.774889004394, 5627.803026894039, 5649.12438572022, 6385.329540398284, 6471.320511346241, 6479.935200648028, 6482.1573195485225, 6482.837929051717, 5584.91622625661, 5624.3813180550105, 5631.7747290108755, 5639.210510528529, 5640.633358831663, 5647.971760141173, 5706.429357064343, 5707.058335374617, 5717.885642287131, 5720.056190728566, 6272.059191121277, 6316.778912738124, 6330.873382532323, 6399.648019358887, 6469.482441404676, 6479.254885688206, 6490.740370385131, 6504.991726282434, 6617.172853393326, 6622.735090596322, 6297.4647154992335, 6338.271098823694, 6396.26442959047, 6418.261899881387, 6424.967875160594, 6332.905006424815, 6404.263509696445, 6406.814739273249, 6423.389777971085, 6502.642354670538, 5676.262085928968, 6426.871462570816, 6492.513061520499, 6502.252240992158, 6676.49926255523, 6323.620582765049, 6351.745930162741, 6423.9036414452885, 6441.516886233645, 6459.935400645933, 6297.4647154992335, 6317.336679648754, 6326.177596912372, 6411.8717625646295, 6413.7113829876835, 6049.727762250621, 6196.938030619636, 6278.937210628018, 6369.9681501592195, 6372.07604897278, 6311.495080393649, 6313.46335561464, 6337.556371053982, 6358.682065896779, 6374.107624932606, 6034.275886893601, 6163.907541386793, 6176.104464852661, 6230.376962303733, 6311.779087731908], "value": 5925.133761318793, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.9391248700105, 800.2677550041712, 828.5070383122044, 836.6444261188997, 1176.6764139861543, 29075.418491630182, 29579.260518487048, 29665.703342966564, 35893.82053089731, 36570.0, 40162.0, 40589.59410405895, 40617.18765624686, 40628.79685601575, 40635.390469142985, 7546.358559522447, 7740.148583655793, 7742.574158421285, 7751.689932402697, 7752.689892404297, 7601.505902116372, 7704.576248306341, 7708.807279818021, 7709.614519274042, 7717.2668596483245, 5716.1711551825165, 5940.287165540141, 5969.671668058255, 7698.692052317929, 7748.5350878947165, 7533.924660753404, 7696.7306144284685, 7709.1134519530415, 7724.0, 7741.303282704555, 7456.739014134533, 7525.548467091992, 7533.886991695129, 7540.245975402416, 7553.093628764528, 36203.63796362029, 36580.0, 36643.26713465742, 36653.0, 36655.63344366549, 3549.2901419715904, 3563.6436356364416, 3581.982090089533, 3609.5127157833617, 3609.657082577151, 29040.12879613615, 29084.563731544044, 29151.41697166045, 29271.2682182945, 29275.560866587017, 4864.6108311335365, 4872.06344456084, 4879.63402744792, 4889.119958407486, 4990.0, 211425.0, 213206.0, 213903.0, 215357.0, 216246.0, 46775.766121169174, 47214.763926180836, 47234.76382618133, 47265.291020634715, 47275.527244727804, 47535.286970695466, 47851.0, 47966.0, 48138.51861481411, 48499.757501212975, 15829.841701583067, 16067.758983615255, 16194.352225910832, 16470.75293870593, 16518.6696266074, 13589.184648921097, 13664.93167534156, 13669.726605467835, 13684.863151368558, 13705.931470342784, 13683.11059781111, 13722.725545489235, 13741.106828056145, 13940.790888136686, 13993.090449120775, 4929.186684197139, 5698.572607054488, 5729.255196824386, 5774.711264436845, 5855.414458554195, 970.9951450242703, 976.3458482816388, 988.4464699768153, 993.5181437003048, 1012.0537297626743, 22201.0, 22202.444938876335, 22222.222222222146, 22253.22113726012, 22647.320580382613, 1077.3247599981946, 1083.47992963378, 1120.199057673751, 1127.6391554702416, 1128.8871112888646, 11394.202405831678, 11675.76648467026, 11814.232074915102, 11874.168808183344, 11922.761544769057, 222379.0, 224037.0, 225642.0, 226262.0, 226474.0, 49145.0, 49793.50206497961, 49820.50179498231, 49844.50155498399, 49887.75056124696, 1382.930853457323, 1479.2160155117804, 1479.5931118942376, 1487.4719474586366, 1497.1690711655135, 20667.68998464994, 21635.675464868353, 21698.566028679023, 22132.668009980185, 22432.214872479384, 34407.0, 34579.65420345764, 34581.13547161341, 34675.826620866734, 34764.47853282152, 189015.0, 189283.0, 189818.0, 190156.0, 190793.0, 31362.686373135977, 32363.35273294474, 32388.676113238565, 32594.348113038082, 32789.508157378135, 38547.229055418175, 41239.1752164949, 41404.1719165621, 41557.168856623306, 42001.36997944972, 29472.263193420335, 29996.400071998873, 30342.84828575843, 30403.087907362813, 30859.382812344076, 29697.406051879272, 30048.3990320188, 30449.695503045572, 32674.673253267163, 33426.66573334236, 35313.82343088268, 36563.817180913924, 36799.63200367962, 37115.0, 37233.0, 30438.0, 31626.051218463483, 31704.841475792473, 31706.365872681956, 32071.679283207803, 22791.544169116856, 23681.289561313188, 23720.40698982539, 23793.16723914724, 23819.404514886573], "value": 16642.635854074753, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.3600495435204, 564.6358099026128, 566.7308028686372, 568.8549419897926, 589.125149153507, 21206.36380908573, 22043.448913777145, 22052.11791528339, 22185.44536386591, 22561.09755609778, 24525.0, 26271.211863644072, 26323.0, 26506.0, 26552.203433896964, 6406.647634380107, 6593.901091483632, 6604.933950660504, 6608.504362172832, 6626.5030122740745, 6231.034189700604, 6514.478841692677, 6531.150950376445, 6560.475161987029, 6566.770163044294, 6201.844953876144, 6473.0, 6494.902576461357, 6497.155369801919, 6505.902411463808, 6489.415952564268, 6502.479801615883, 6504.902426463606, 6509.739610415578, 6511.088447617313, 6020.548458865603, 6025.096235564656, 6029.487493563052, 6062.0, 6062.42406971337, 27837.582436263474, 28913.42173156546, 29333.26666833325, 29334.119976400743, 29347.55978660322, 1932.5361913140885, 1954.9609007819906, 1958.4222654317011, 1959.2848610257297, 1969.1237399357292, 18350.174242159133, 18942.905285473622, 19007.61984760311, 19018.0, 19070.61858762831, 2299.7470278269375, 2349.835511514195, 2384.9761502384927, 2394.461246219604, 2406.5307265083316, 128178.99999999907, 131120.0, 134268.0, 134896.32551837276, 134963.0, 14188.665663569052, 14914.4779932704, 14944.327505262288, 15011.174385408689, 15424.5372638821, 23234.07063717466, 23430.882845586006, 23478.0, 23533.76466235316, 23547.0, 9685.951570242245, 9708.563114659857, 9741.951290243645, 9870.703878883645, 9959.502024898871, 8933.419327743675, 8951.865722014176, 9042.954785226031, 9145.451272923647, 9147.496887671243, 9143.3599648024, 9210.81578368429, 9211.953940230256, 9305.906940930505, 9392.29557783169, 2608.6782763340643, 2647.1264482720658, 2651.973480265173, 2661.680598328213, 2739.205630367171, 945.1493655709916, 948.0898337595847, 950.7432993091827, 972.9805403891883, 984.3847595252967, 19660.0, 19890.508211884167, 20481.590368192552, 23452.061917523108, 24879.875600622243, 1034.9586016559253, 1060.5863713151878, 1062.134360496193, 1066.568039943824, 1069.2194697870598, 11334.829977550344, 11491.655250342503, 11497.195196336343, 11577.247478913843, 11686.0, 496740.0, 507979.0, 508080.0, 512025.0, 522665.0, 116521.0, 118987.0, 121090.07103519926, 121254.0, 121980.39009804894, 1264.089855304198, 1279.4178648714812, 1293.1723696833847, 1294.766941950458, 1299.110109574944, 17276.049817260173, 18077.909610451865, 18183.818161818213, 18573.164207610418, 18774.812251877855, 51719.0, 55012.72493637506, 56396.15405768835, 57689.71155144365, 59749.10376344271, 67168.6641566789, 69701.65149174222, 69959.65020174866, 70557.29442705507, 70970.64514677394, 14028.22844743549, 14415.855841441451, 14540.49108281205, 14546.781798272823, 14586.635334116732, 23319.067237310996, 23419.882900585388, 23430.0, 23459.296221113393, 23480.178193763135, 16197.67604647924, 16387.852850300365, 16553.917230413772, 18621.81378186255, 18698.0, 16217.67564648724, 16440.506784796475, 16453.177341132658, 16930.0, 17069.743953840454, 17552.297908083532, 17633.118344082486, 17648.294068237126, 17834.10829458548, 17835.643287133924, 14117.858821412065, 14191.07757995727, 14221.928890355483, 14228.50200243028, 14257.64355891111, 17772.46682599524, 19260.8073919259, 19377.806221938165, 19386.515337116685, 19414.61170776548], "value": 11941.86858635803, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1375.539194369886, 1419.708959663269, 1428.2715814934386, 1443.5380678182983, 1455.0105927968978, 12945.935270323647, 13416.0, 13587.45650173993, 13597.52408665697, 13629.114107583013, 13081.542146024867, 13978.930105349458, 14076.296185190751, 14086.366113524891, 14097.718045639107, 2464.9876750616268, 2505.1983365323103, 2514.0823599386185, 2526.381036646015, 2526.6967963844363, 2425.9150929717375, 2463.8275320727557, 2464.8397854139425, 2465.580851255282, 2475.4553998120473, 2311.537692461506, 2353.9058437662475, 2355.9764402356013, 2360.0323867214447, 2373.95252094958, 2320.2459200759654, 2335.054303007285, 2342.906283748648, 2344.882755862209, 2356.4108972756812, 2240.6751021102014, 2279.1453205048106, 2281.3498153026308, 2284.4174735442357, 2286.9542609147725, 12821.743565128738, 13232.338383080807, 13236.13965092266, 13243.536476223286, 13245.0, 6898.827529311808, 7153.6780844862105, 7161.140663120459, 7170.677319520634, 7171.820704482378, 4414.293713005904, 4463.218936686067, 4538.568835960578, 4562.954370456286, 4577.267637178035, 1774.4055741326672, 1808.8462480689025, 1834.110456428631, 1881.444973732752, 1892.0728842866897, 21271.0, 21349.0, 21395.358139255848, 21474.785252147434, 21583.784162158492, 5810.331811841692, 5870.295564532284, 5882.882342353129, 5938.634114153769, 5979.790707325223, 15112.244387780787, 15116.0, 15119.697606048037, 15132.470363537223, 15139.924300378427, 6791.592504449749, 6933.826654333682, 6934.133233345832, 6940.895886561605, 6986.580805151707, 5689.146628005832, 5981.7607295707685, 6443.420092191725, 6714.060031595581, 6718.731250750013, 4332.610065094093, 4395.120975804852, 4412.757298348622, 4428.4243048403505, 4475.753833539122, 1224.3205021213312, 1229.4836168809122, 1236.8701286364983, 1247.8502579690314, 1250.3435696259355, 879.134052957836, 881.9911800882037, 907.5915837872983, 919.4345477531404, 920.3557509743207, 7193.424526037905, 7290.635468226674, 8043.477173983672, 8361.540115293596, 8818.162274583905, 969.4328817641617, 970.6069042037985, 981.8919918808925, 1021.3769600543662, 1027.9229057820694, 5121.359830021247, 5355.839324820262, 5373.032854086302, 5383.327084114486, 5505.311836020497, 17572.472825815246, 18344.724829127576, 18416.17127229278, 18422.171002304927, 18607.0, 17840.55398615045, 18225.81774182241, 18360.54098647518, 18368.448946531626, 18407.263709451472, 9932.205423566098, 9945.651902183388, 10437.582496700199, 10462.686119416581, 10616.628418005334, 7839.137694853675, 8140.308073813792, 8259.256666900008, 8348.749537513884, 8488.363372746946, 15002.774958375852, 15914.920425397799, 16001.0, 16101.033937963759, 16162.111083890499, 15955.760663589823, 16579.336826526804, 16614.418495352606, 16686.833131669013, 16803.91598042002, 11429.0, 11762.176647634584, 11827.881721183023, 12292.201006934878, 12654.493820247088, 11694.88305116972, 11752.0, 11835.585754498552, 12333.62999110028, 12808.423620936894, 10017.198624110199, 10209.369301138824, 10362.637307694195, 10464.581416743245, 10472.790544188922, 9534.61861525559, 9889.456079915673, 9929.304948653526, 10037.34757240777, 10107.797844043225, 8508.574571271536, 8657.437266577652, 8658.870116948125, 8659.783505412415, 8674.869876951978, 7139.535930164523, 7262.164851041986, 7286.96356518214, 7320.707171713285, 7348.448866335153, 7299.306565876233, 7348.632568371453, 7362.0, 7405.0, 7406.296401841816], "value": 6049.846581411027, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.13363478017834, 485.3350909254322, 500.7421178093285, 505.19925917420875, 512.9461406552311, 5939.1388248703915, 6014.075495841333, 6065.818025459238, 6102.2677278726505, 6113.205283313174, 5643.238162848014, 5845.357010728816, 5859.209006784083, 5881.794137205198, 5912.586118971673, 4819.397575303095, 4851.878703032435, 4867.3915760529935, 4871.610271178315, 4880.389951256093, 4733.668643194977, 4770.7357550249035, 4808.471068182497, 4818.156822556056, 4832.879178020543, 4766.213574760161, 4775.331453596499, 4788.449328327235, 4795.89694370295, 4847.660663753539, 4647.465541462741, 4674.298855171717, 4773.618110551148, 4819.5782244238035, 4821.37322148122, 4277.636400905927, 4287.3846953358425, 4309.439772829513, 4337.980574564975, 4339.1104823511105, 5726.141078838166, 5735.541156707453, 5822.534197264209, 5825.0, 5834.5915785895, 5409.404965453797, 5429.728513574345, 5467.726613669301, 5473.124300111963, 5477.808276710336, 6260.718267677966, 6269.3730626937395, 6306.527010474233, 6328.272248691414, 6343.619382837044, 4688.718676879398, 4697.412823397075, 4699.107169637758, 4706.835260765891, 4708.152532544141, 6552.3775241352, 6553.574017688883, 6591.93408065918, 6658.300878407795, 6711.865762684768, 4801.975990120027, 4808.927866082012, 4835.274708793639, 4840.152079097126, 4861.586765125004, 4873.4882837301575, 4908.993656300449, 4910.484399138039, 4928.6057115431395, 4948.455669876311, 5376.596755243372, 5427.0773968425465, 5444.618876678674, 5501.4223506532035, 5535.391106978229, 6251.78118765841, 6275.215598050244, 6278.15244941927, 6282.403171698681, 6383.170187875639, 1689.7803285572797, 1710.837470440306, 1712.1011468978886, 1720.6128621060411, 1725.3098760495652, 1102.9393383363831, 1175.905927525796, 1184.117832214988, 1189.1616410430627, 1212.2060050666828, 5354.759035843396, 5468.589855760833, 5514.338279406497, 5557.221988921554, 5564.721763911869, 6382.425581697669, 6432.0, 6457.677116144174, 6491.241222480427, 6530.379613936669, 5598.860028499239, 5644.74598643062, 5655.660660360391, 5668.9716551417805, 5669.659820410789, 3417.1457135716073, 3428.262923471416, 3443.5867695876655, 3462.5844898612327, 3480.190301043443, 6258.0, 6294.748210071546, 6304.730297093043, 6323.375799043438, 6385.627090175634, 6524.836879078061, 6525.445337146396, 6556.377144171296, 6620.9006864897065, 6674.299198584079, 6216.689165541705, 6243.906341404973, 6291.559590828598, 6318.210223722035, 6319.8104056878365, 6415.903761443676, 6423.261324947504, 6425.775097871552, 6473.935260647521, 6487.967560162169, 6315.778947736807, 6358.427741503287, 6360.9822428411235, 6404.711787969646, 6437.903431448625, 6189.81430557084, 6200.100985357189, 6223.253209614875, 6268.749250029948, 6271.804868296243, 4816.277558366133, 4818.68678535894, 4847.248676455155, 4848.151573474698, 4892.143874821821, 6517.348265173445, 6552.770653027121, 6563.573367731082, 6592.406683398517, 6607.240167380621, 6334.714937827901, 6347.5556711029785, 6349.746010159542, 6354.23749150105, 6386.233651961795, 6299.401556852092, 6305.0, 6325.0, 6331.430171284606, 6353.4599559038, 6105.542084343603, 6171.47542458896, 6204.689765511796, 6219.32078338855, 6225.533085018732, 5990.950856881272, 6301.905471418024, 6325.557210995186, 6332.606826498163, 6351.9047214290895, 5991.281046274475, 6046.697665116814, 6139.2325959255095, 6141.477974372228, 6181.289151747606], "value": 4869.744105202248, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [882.9514376709283, 910.6266430763386, 912.5118061836919, 914.1544071733645, 926.5506229478698, 18139.183736731844, 18559.628807423862, 18880.0, 18947.715784263248, 18999.0, 15171.165585892772, 15297.158656273901, 16356.100414477229, 16415.671686566293, 16471.423500177498, 1017.8676772019645, 1031.783325501642, 1036.0, 1038.1227862456212, 1039.6361273554232, 1021.2493817044466, 1027.4195079779938, 1029.7168278723336, 1031.5100327344526, 1037.082182268694, 1110.666799960013, 1111.2776695148139, 1111.4998250787178, 1113.1540029577538, 1113.7549739057395, 999.0209594597335, 1107.7396811749231, 1107.7562936154034, 1108.3017698849753, 1114.57646094484, 728.1226122522401, 776.3905334312594, 779.0106564662904, 779.2207792207793, 780.3094261578487, 19874.701879471675, 20205.8989705052, 20208.595828083504, 20232.79767202324, 20235.696464552897, 19530.609387812307, 20592.691109633368, 20650.27724029667, 20708.171673133056, 20925.476863078544, 15863.762043569355, 16397.508074757778, 16554.0, 16624.916875415667, 16735.0, 3491.4762785582366, 3553.822308884571, 3599.8200089995394, 3613.4218525035867, 3630.509881166035, 98051.50974245154, 115321.4233928825, 119288.40355798253, 125386.0, 131325.34337328348, 13596.144809590096, 13667.111637743714, 15854.286557104959, 16494.34022639081, 16804.495865124067, 28419.857900710365, 28962.71037289642, 29259.707402926124, 29390.265243369086, 29406.558901616492, 8608.612612432331, 8883.911160888438, 9001.0, 9046.366754327133, 9100.544972751335, 4196.601322874322, 4258.233517966796, 4276.401303817468, 4291.2275790358035, 4317.0934103838545, 4622.399088118523, 4645.163870503275, 4695.765211739399, 4710.411198600175, 4768.356271903249, 988.3526290279879, 1009.7324209084599, 1016.4663551635302, 1017.0388982411698, 1020.1023099672241, 681.8090934538337, 688.6659969914588, 688.8725585766649, 711.1501755402245, 719.8704233238068, 11457.427128643534, 11817.172797904064, 12136.696582585506, 12175.33035683046, 12634.494620215271, 673.7305077968754, 692.8314376003078, 698.5948150072945, 710.982225444368, 712.134756271133, 5260.658057226268, 5274.876689897592, 5323.281357016831, 5352.732363381815, 5516.200150978166, 102129.0, 106395.0, 108425.0, 109431.45284273528, 109899.0, 88586.0, 89455.0, 91927.0, 92360.0, 96052.51973740087, 78138.0, 78236.0, 80950.59524702339, 80995.0, 81769.0, 10554.366737995744, 10576.312539684895, 10697.465126743477, 10758.40828754426, 10933.726656833644, 35024.474632881036, 35461.1134721634, 35760.463593045606, 35768.46347304845, 37658.0, 44302.0, 46981.765091174326, 47146.52853471421, 47625.76187119181, 48158.277625836345, 16582.25379857885, 18699.626007480045, 18716.625667486845, 18823.34118305853, 19012.809871901103, 19568.510787230432, 20529.692054618892, 20603.58792824105, 20734.17063317511, 20823.583528329047, 18325.908370458063, 18400.079996000415, 18408.35570755071, 18466.630667386846, 18656.067196639844, 17926.731099033786, 18371.173297201392, 18967.14647840878, 19188.904055479634, 19249.61500769949, 17871.821281787015, 18137.546561336072, 18534.72197917005, 18587.163577638767, 18590.349337773114, 13040.282784446947, 13292.534761283308, 13641.249731264876, 13848.238346891017, 13872.306384680927, 13611.931940340235, 13697.246651434267, 13893.235872027135, 13904.304784760923, 13922.930385348009], "value": 8849.473657021965, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 110.0, 102.0, 109.0, 108.0, 109.0, 110.0, 100.0, 112.0, 111.0], "value": 106.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 119.0, 158.0, 166.0, 122.0, 145.0, 156.0, 120.0, 171.0, 122.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 164.0, 162.0, 162.0, 163.0, 167.0, 182.0, 163.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 74.0, 167.0, 75.0, 75.0, 75.0, 75.0, 97.0, 74.0], "value": 86.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 134.0, 82.0, 81.0, 82.0, 130.0, 81.0, 81.0, 135.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 151.0, 151.0, 153.0, 151.0, 150.0, 149.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 93.0, 94.0, 94.0, 94.0, 93.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 56.0, 53.0, 54.0, 55.0, 56.0, 56.0, 53.0, 53.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 54.0, 53.0, 55.0, 55.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 81.0, 85.0, 77.0, 78.0, 77.0, 76.0, 77.0, 77.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 126.0, 136.0, 130.0, 126.0, 125.0, 130.0, 124.0, 176.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 180.0, 191.0, 178.0, 181.0, 182.0, 189.0, 184.0, 187.0, 181.0], "value": 184.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 71.0, 70.0, 68.0, 72.0, 68.0, 71.0, 66.0, 67.0], "value": 69.1, "unit": "score"}]}]} 08:48:22 INFO - Return code: 0 08:48:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:48:22 INFO - # TBPL SUCCESS # 08:48:22 INFO - Running post-action listener: _package_coverage_data 08:48:22 INFO - Running post-action listener: _resource_record_post_action 08:48:22 INFO - [mozharness: 2017-07-18 15:48:22.405840Z] Finished run-tests step (success) 08:48:22 INFO - Running post-run listener: _resource_record_post_run 08:48:22 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 12288; Write bytes: 433987584; Read time: 204; Write time: 338644 08:48:22 INFO - TinderboxPrint: CPU usage
13.1% 08:48:22 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 204 08:48:22 INFO - TinderboxPrint: I/O write bytes / time
433,987,584 / 338,644 08:48:22 INFO - TinderboxPrint: CPU idle
8,260.1 (86.9%) 08:48:22 INFO - TinderboxPrint: CPU user
1,197.9 (12.6%) 08:48:22 INFO - TinderboxPrint: Swap in / out
0 / 0 08:48:22 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106627072; Read time: 0; Write time: 72356 08:48:22 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:48:22 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 327360512; Read time: 196; Write time: 266288 08:48:23 INFO - Running post-run listener: _upload_blobber_files 08:48:23 INFO - Blob upload gear active. 08:48:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:48:23 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 08:48:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:48:23 INFO - Traceback (most recent call last): 08:48:23 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 08:48:23 INFO - main() 08:48:23 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 08:48:23 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 08:48:23 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 08:48:23 INFO - return set(response.json().get('whitelist', [])) 08:48:23 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 08:48:23 INFO - return json.loads(self.text or self.content, **kwargs) 08:48:23 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 08:48:23 INFO - return _default_decoder.decode(s) 08:48:23 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 08:48:23 INFO - obj, end = self.raw_decode(s) 08:48:23 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 08:48:23 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 08:48:23 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 08:48:23 ERROR - Return code: 1 08:48:23 INFO - Setting buildbot property blobber_files to {} 08:48:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:48:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:48:23 INFO - Contents: 08:48:23 INFO - blobber_files:{} 08:48:23 INFO - Running post-run listener: copy_logs_to_upload_dir 08:48:23 INFO - Copying logs to upload dir... 08:48:23 INFO - mkdir: /builds/slave/test/build/upload/logs 08:48:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.702321 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-07-18 08:48:22.919365) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-18 08:48:22.924014) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-18 08:48:22.974704) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 08:48:22.975086) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1500390324.349418-849818751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004729 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 08:48:23.025276) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-18 08:48:23.025601) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-18 08:48:23.025919) ========= ========= Total master_lag: 0.17 =========