builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1500391652.29 results: success (0) revision: 8ff4f17b266db9a780efe06f7fbdae629e49f5bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:32.290906) ========= 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:32.291405) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:32.291757) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:32.309378) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:32.309793) ========= 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=41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-18 08:27:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-07-18 08:27:32 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131674 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:32.457842) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:32.458226) ========= 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=41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020764 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:32.508323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:32.508688) ========= 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=41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-18 08:27:32,856 truncating revision to first 12 chars 2017-07-18 08:27:32,856 Setting DEBUG logging. 2017-07-18 08:27:32,856 attempt 1/10 2017-07-18 08:27:32,856 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:33,286 unpacking tar archive at: mozilla-central-8ff4f17b266d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.752745 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:33.279007) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:33.279329) ========= script_repo_revision: 8ff4f17b266db9a780efe06f7fbdae629e49f5bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:33.279844) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:33.280161) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-18 08:27:33.290478) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-07-18 08:27:33.290855) ========= /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=41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:27:33 INFO - MultiFileLogger online at 20170718 08:27:33 in /builds/slave/test 08:27:33 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:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:27:33 INFO - {'append_to_log': False, 08:27:33 INFO - 'base_work_dir': '/builds/slave/test', 08:27:33 INFO - 'blob_upload_branch': 'Firefox', 08:27:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:27:33 INFO - 'branch': 'Firefox', 08:27:33 INFO - 'buildbot_json_path': 'buildprops.json', 08:27:33 INFO - 'code_coverage': False, 08:27:33 INFO - 'config_files': ('talos/linux_config.py',), 08:27:33 INFO - 'default_actions': ('clobber', 08:27:33 INFO - 'read-buildbot-config', 08:27:33 INFO - 'download-and-extract', 08:27:33 INFO - 'populate-webroot', 08:27:33 INFO - 'create-virtualenv', 08:27:33 INFO - 'install', 08:27:33 INFO - 'setup-mitmproxy', 08:27:33 INFO - 'run-tests'), 08:27:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:27:33 INFO - 'disable_ccov_upload': False, 08:27:33 INFO - 'download_minidump_stackwalk': True, 08:27:33 INFO - 'download_symbols': 'ondemand', 08:27:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:27:33 INFO - 'tooltool.py': '/tools/tooltool.py', 08:27:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:27:33 INFO - '/tools/misc-python/virtualenv.py')}, 08:27:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:27:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:27:33 INFO - 'gecko_profile': False, 08:27:33 INFO - 'gecko_profile_interval': 0, 08:27:33 INFO - 'installer_path': 'installer.exe', 08:27:33 INFO - 'log_level': 'info', 08:27:33 INFO - 'log_name': 'talos', 08:27:33 INFO - 'log_to_console': True, 08:27:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:27:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:27:33 INFO - 'opt_config_files': (), 08:27:33 INFO - 'pip_index': False, 08:27:33 INFO - 'suite': 'dromaeojs-e10s', 08:27:33 INFO - 'system_bits': '32', 08:27:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:27:33 INFO - 'title': 'talos-linux64-ix-026', 08:27:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:27:33 INFO - 'use_talos_json': True, 08:27:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:27:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:27:33 INFO - 'work_dir': 'build'} 08:27:33 INFO - [mozharness: 2017-07-18 15:27:33.746254Z] Running clobber step. 08:27:33 INFO - Running pre-action listener: _resource_record_pre_action 08:27:33 INFO - Running main action method: clobber 08:27:33 INFO - rmtree: /builds/slave/test/build 08:27:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:27:34 INFO - Running post-action listener: _resource_record_post_action 08:27:34 INFO - [mozharness: 2017-07-18 15:27:34.776371Z] Finished clobber step (success) 08:27:34 INFO - [mozharness: 2017-07-18 15:27:34.776474Z] Running read-buildbot-config step. 08:27:34 INFO - Running pre-action listener: _resource_record_pre_action 08:27:34 INFO - Running main action method: read_buildbot_config 08:27:34 INFO - Using buildbot properties: 08:27:34 INFO - { 08:27:34 INFO - "project": "", 08:27:34 INFO - "product": "firefox", 08:27:34 INFO - "who": "ryanvm@gmail.com", 08:27:34 INFO - "installer_path": "public/build/target.tar.bz2", 08:27:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 08:27:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:27:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 08:27:34 INFO - "stage_platform": "linux64-stylosequential", 08:27:34 INFO - "basedir": "/builds/slave/test", 08:27:34 INFO - "buildnumber": 128, 08:27:34 INFO - "platform": "ubuntu64_hw_styloseq", 08:27:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:27:34 INFO - "slavebuilddir": "test", 08:27:34 INFO - "taskId": "csZK6LLAR0uc4WvJxxxmUA", 08:27:34 INFO - "branch": "mozilla-central", 08:27:34 INFO - "script_repo_revision": "production", 08:27:34 INFO - "revision": "8ff4f17b266db9a780efe06f7fbdae629e49f5bc", 08:27:34 INFO - "slavename": "talos-linux64-ix-026", 08:27:34 INFO - "repo_path": "mozilla-central" 08:27:34 INFO - } 08:27:34 INFO - Finding installer, test and symbols from parent task. 08:27:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/csZK6LLAR0uc4WvJxxxmUA'}, attempt #1 08:27:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/csZK6LLAR0uc4WvJxxxmUA'}, attempt #1 08:27:35 INFO - Task dependencies: WK1fGb1kSi6ucctxSGRFLQ 08:27:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ'}, attempt #1 08:27:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.tar.bz2 08:27:36 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/test_packages.json 08:27:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.crashreporter-symbols.zip 08:27:36 INFO - Running post-action listener: _resource_record_post_action 08:27:36 INFO - [mozharness: 2017-07-18 15:27:36.128622Z] Finished read-buildbot-config step (success) 08:27:36 INFO - [mozharness: 2017-07-18 15:27:36.128841Z] Running download-and-extract step. 08:27:36 INFO - Running pre-action listener: _resource_record_pre_action 08:27:36 INFO - Running main action method: download_and_extract 08:27:36 INFO - mkdir: /builds/slave/test/build/tests 08:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:27:36 INFO - trying https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.test_packages.json 08:27:36 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:36 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:36 INFO - Downloaded 989 bytes. 08:27:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:27:36 INFO - Using the following test package requirements: 08:27:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:27:36 INFO - u'common': [u'target.common.tests.zip'], 08:27:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:27:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:27:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:27:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:27:36 INFO - u'mozbase': [u'target.common.tests.zip'], 08:27:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:27:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:27:36 INFO - u'web-platform': [u'target.common.tests.zip', 08:27:36 INFO - u'target.web-platform.tests.tar.gz'], 08:27:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:27:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:27:36 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:36 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:36 INFO - Fetch https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.common.tests.zip into memory 08:27:39 INFO - Content-Length response header: 72776747 08:27:39 INFO - Bytes received: 72776747 08:27:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:27:50 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:50 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:50 INFO - Fetch https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.common.tests.zip into memory 08:27:52 INFO - Content-Length response header: 72776747 08:27:52 INFO - Bytes received: 72776747 08:28:04 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:04 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:04 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:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:06 INFO - trying https://queue.taskcluster.net/v1/task/WK1fGb1kSi6ucctxSGRFLQ/artifacts/public/build/target.tar.bz2 08:28:06 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:06 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.279360Z] Finished download-and-extract step (success) 08:28:09 INFO - [mozharness: 2017-07-18 15:28:09.279590Z] 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.300928Z] Finished populate-webroot step (success) 08:28:09 INFO - [mozharness: 2017-07-18 15:28:09.301019Z] 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:09 INFO - Installing distribute.............................................................................................................................................................................................done. 08:28:11 INFO - Installing pip.................done. 08:28:11 INFO - Return code: 0 08:28:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:28:11 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 0xdb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1126b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123d00>, '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 0x1124c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125090>, '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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', '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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', 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 0xdb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1126b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123d00>, '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 0x1124c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125090>, '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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', '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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', 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:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:13 INFO - Installing collected packages: psutil 08:28:13 INFO - Running setup.py install for psutil 08:28:13 INFO - building 'psutil._psutil_linux' extension 08:28:13 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:13 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:13 INFO - building 'psutil._psutil_posix' extension 08:28:13 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 0xdb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1126b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123d00>, '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 0x1124c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125090>, '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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', '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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', 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:15 INFO - Successfully installed mozsystemmonitor 08:28:15 INFO - Cleaning up... 08:28:15 INFO - Return code: 0 08:28:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:28:15 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:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:15 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:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:15 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 0xdb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1126b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123d00>, '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 0x1124c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125090>, '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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', '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:15 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:15 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:15 INFO - Using env: {'DISPLAY': ':0', 08:28:15 INFO - 'HOME': '/home/cltbld', 08:28:15 INFO - 'LANG': 'en_US.UTF-8', 08:28:15 INFO - 'LANGUAGE': 'en_US:en', 08:28:15 INFO - 'LOGNAME': 'cltbld', 08:28:15 INFO - 'MAIL': '/var/mail/cltbld', 08:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:15 INFO - 'MOZ_NO_REMOTE': '1', 08:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:15 INFO - 'NO_EM_RESTART': '1', 08:28:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:15 INFO - 'PWD': '/builds/slave/test', 08:28:15 INFO - 'SHELL': '/bin/bash', 08:28:15 INFO - 'SHLVL': '1', 08:28:15 INFO - 'TERM': 'linux', 08:28:15 INFO - 'TMOUT': '86400', 08:28:15 INFO - 'USER': 'cltbld', 08:28:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', 08:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:15 INFO - '_': '/tools/buildbot/bin/python'} 08:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:15 INFO - Downloading/unpacking jsonschema==2.5.1 08:28:15 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:15 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 - 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:15 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 0xdb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1126b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123d00>, '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 0x1124c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125090>, '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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', '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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', 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 0xdb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1126b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123d00>, '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 0x1124c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125090>, '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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', '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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', 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 - Downloading/unpacking blobuploader==1.2.4 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:18 INFO - Downloading blobuploader-1.2.4.tar.gz 08:28:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:28:18 INFO - Downloading/unpacking requests==1.2.3. (from 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 - 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:19 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 0xdb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1126b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123d00>, '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 0x1124c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125090>, '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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', '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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', 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-IENCJG-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-QN6KIg-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-y6mRNn-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-vKuXGk-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-O0vFDA-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-kueL9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:28:20 INFO - Running setup.py (path:/tmp/pip-eep_kT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:28:20 INFO - Running setup.py (path:/tmp/pip-wsTiaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:28:20 INFO - Running setup.py (path:/tmp/pip-WdlVqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:28:20 INFO - Running setup.py (path:/tmp/pip-d9Nav8-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-Dlx7q2-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-zkHGe4-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-FkArzM-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-VPdD1J-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-KhXAVf-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-ZlL9CK-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-561T1z-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:21 INFO - Running setup.py install for mozdebug 08:28:21 INFO - Running setup.py install for mozdevice 08:28:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:28:21 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:22 INFO - Running setup.py install for mozprofile 08:28:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:28:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:28:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:28:22 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 0xdb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1126b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123d00>, '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 0x1124c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125090>, '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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', '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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', 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-bHii08-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-7am1M2-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-02tdSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:28:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:28:23 INFO - Running setup.py (path:/tmp/pip-QU40BJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:28:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:28:23 INFO - Running setup.py (path:/tmp/pip-c8StQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:28:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:28:23 INFO - Running setup.py (path:/tmp/pip-jT07pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:28:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:28:23 INFO - Running setup.py (path:/tmp/pip-M7oxtt-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-TGu_49-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-W6zVpP-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-f5GfEh-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-pWOkRq-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-1aHpPx-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-BNi2vq-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-eTiZBM-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-TCCcJJ-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-1nqtXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:28:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:28:24 INFO - Running setup.py (path:/tmp/pip-uScKuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:28:24 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:24 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:24 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:24 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:24 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:24 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:24 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:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:28:24 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:24 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:24 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:24 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 - Downloading blessings-1.6.tar.gz 08:28:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:28:25 INFO - Installing collected packages: blessings 08:28:25 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 0xdb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1126b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123d00>, '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 0x1124c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125090>, '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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', '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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', 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:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:28:27 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:27 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:27 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:27 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:27 INFO - Installing collected packages: marionette-driver, simplejson 08:28:27 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:28 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 0xdb51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf81a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1126b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1123d00>, '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 0x1124c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125090>, '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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', '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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', 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.388756Z] Finished create-virtualenv step (success) 08:28:29 INFO - [mozharness: 2017-07-18 15:28:29.389334Z] 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:29 INFO - mkdir: /builds/slave/test/build/application 08:28:29 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:29 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.603923Z] Finished install step (success) 08:28:47 INFO - [mozharness: 2017-07-18 15:28:47.604071Z] 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.604614Z] Finished setup-mitmproxy step (success) 08:28:47 INFO - [mozharness: 2017-07-18 15:28:47.604718Z] 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 0x1123d00>, '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 0x1124c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1125090>, '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-026', '--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-026 --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': '41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290', 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-026', '--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:46089' 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:46089/getInfo.html -profile /tmp/tmpDlh6_y/profile 08:28:48 INFO - TEST-INFO | started process 12313 (/builds/slave/test/build/application/firefox/firefox http://localhost:46089/getInfo.html) 08:28:54 INFO - TEST-INFO | 12313: exit 0 08:28:54 INFO - Browser initialized. 08:28:54 INFO - Running cycle 1/1 for dromaeo_css test... 08:28:54 INFO - TEST-INFO | started process 12582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDlh6_y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:05 INFO - PID 12582 | RSS: Main: 175452160 08:29:05 INFO - PID 12582 | 08:32:03 INFO - PID 12582 | Cycle 1(1): loaded http://localhost:46089/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46089/tests/dromaeo/cssquery-ext.html) 08:32:05 INFO - PID 12582 | RSS: Main: 180584448 08:32:05 INFO - PID 12582 | 08:35:07 INFO - PID 12582 | Cycle 1(1): loaded http://localhost:46089/tests/dromaeo/cssquery-ext.html (next: http://localhost:46089/tests/dromaeo/cssquery-jquery.html) 08:35:07 INFO - PID 12582 | RSS: Main: 179007488 08:35:07 INFO - PID 12582 | 08:38:09 INFO - PID 12582 | Cycle 1(1): loaded http://localhost:46089/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46089/tests/dromaeo/cssquery-mootools.html) 08:38:09 INFO - PID 12582 | RSS: Main: 180174848 08:38:09 INFO - PID 12582 | 08:41:11 INFO - PID 12582 | Cycle 1(1): loaded http://localhost:46089/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46089/tests/dromaeo/cssquery-prototype.html) 08:41:12 INFO - PID 12582 | RSS: Main: 178741248 08:41:12 INFO - PID 12582 | 08:44:15 INFO - PID 12582 | Cycle 1(1): loaded http://localhost:46089/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46089/tests/dromaeo/cssquery-yui.html) 08:44:16 INFO - PID 12582 | RSS: Main: 180461568 08:44:16 INFO - PID 12582 | 08:47:17 INFO - PID 12582 | Cycle 1(1): loaded http://localhost:46089/tests/dromaeo/cssquery-yui.html (next: http://localhost:46089/tests/dromaeo/cssquery-dojo.html) 08:47:17 INFO - PID 12582 | RSS: Main: 181096448 08:47:17 INFO - PID 12582 | 08:47:17 INFO - PID 12582 | __start_tp_report 08:47:17 INFO - PID 12582 | _x_x_mozilla_page_load 08:47:17 INFO - PID 12582 | _x_x_mozilla_page_load_details 08:47:17 INFO - PID 12582 | |i|pagename|runs| 08:47:17 INFO - PID 12582 | |0;dojo.html;3086.706762857528;3139.4035133324664;3156.1005113542637;3165.79422337548;3178.3643271345736;5958.374370691075;6041.728122234499;6073.908891366622;6110.083487476875;6167.907481387782;5917.497012753921;6037.698115094238;6038.124471951564;6050.878982420349;6051.183090282811;5471.997129444144;5501.559875209973;5503.422140675231;5518.862028449281;5567.47109024644;5496.670199788005;5551.1673249012565;5553.972230138844;5554.028045092093;5564.777408903639;5554.888902221953;5560;5561.555075593943;5561.805336813212;5578.804741834037;5535.335759708841;5537.889242215173;5540.085885828834;5544.0575102232515;5559.527440167551;5501.312335958005;5515.889682206373;5602.411746766612;5608.579356548275;5708.571857110692;6008.429199226067;6012.18835457212;6037.4566289033755;6059.18201042858;6094.299155597118;6262.405071518244;6471.0940468334475;6483.643399613019;6532.281449040602;6543.312952140004;5690.411770892084;6435.163428754278;6454.967725161391;6457.967710161419;6467.83830404239;6054.031354983182;6067.908981365283;6096.908546371852;6150.600210986317;6183.319834818167;6681;6698.0488335525315;6778.423833974168;6797.830054248584;6814.046033555306;6214.005759078616;6363;6431.807045788634;6486.05952136947;6546.770863019771;6409.102725618417;6419.390157934989;6438.484921206292;6460.935390646034;6467.482601391877;6360.618362898241;6367.395097465734;6367.968160159169;6397.776077837253;6442.291347951722;5551.528120109836;6487.091807147003;6500.512461565401;6533.150690410312;6616.27221005689;5245.449227831099;5248.9737551312;5300.787968481218;5312.973435132877;5316.946830531722;4494.752788596593;4549.772511374418;4562.087582483517;4569.817207311737;4570.382998295254;5480.890382192334;5598.832035038955;5601.047821870292;5630.380658127685;5692.6299790513485;6431.356864313531;6439.259485159267;6448.290688024314;6451.548391612542;6464.515161362917;5583.106702927512;5590.97204513983;5600.355959064678;5606.859828504238;5607.607467477319;5613.354464236665;5642.830715078554;5651.547876169897;5666.9716651416475;5672.659640421588;6316.873662526816;6347.238331400262;6356.777512787123;6449.32282110381;6449.742010319628;6518.250401203827;6525.3800888915475;6575.276719560845;6621.900671489835;6636.767713130017;6140.754369825157;6258.43674069336;6365.045243213555;6408.58344207625;6429.58207716497;6440.323766004502;6468.514861385509;6524.98862676267;6557.2131344239;6590.670466476561;6467.288598254282;6482;6567.507436942153;6577.80266592003;6579.736810527716;6324.6521441321165;6331.588446750947;6427.3251308611925;6428.003659432796;6438.967805160944;6263.404976527223;6286.654234017173;6350.04749287592;6364.522660800366;6425;6174.722137503913;6179.0422484514975;6233.314335423191;6237.126802247598;6246.469050130608;6199.318075011655;6257.906131407942;6267.185265915402;6287.402696743802;6322.747090116344;5229.080422345311;6033.456988870847;6111.327753947151;6117;6166.630002199882 08:47:17 INFO - PID 12582 | |1;ext.html;775.9806004849881;788.7160622176016;820.5733018830208;852.1733918099442;857.4555157475002;39484.605153948454;40530.36552624077;40552.188956220896;40796.79601601995;40899.386509202384;35320;35542;35546.46680299791;35722.8213858931;35969.820150899206;6700.664966751668;6800.047993280945;6810.523263371541;6836;6846.760363387282;6780.084688567054;6857;6871;6874.140732408449;6878.55289406187;6820.965895170542;6824.761133360334;6831.351021652935;6843.589384636913;6857.279985601514;6765;6781.6609169541325;6803.65981700913;6809.3190680932;6811.863762724767;6100.389961003909;6109.083637454373;6134.2332208473945;6143.047827586731;6153.292371377304;32251.354972900644;32301.676983230103;32313.1921701957;32353.838230808695;32379;3281.5898012748407;3305.636379998198;3306.2560923792194;3315.7181639560667;3331.3503866745996;25825.354366140808;25881.611775823378;26138.86930565335;26142;26193.869030654725;4050.1494686115952;4201.411802347674;4203.7057405981595;4222.556631553704;4261.509926358477;176176;176494;181215;181863.09068454572;182828;48059.27911081337;48076.27885581719;48450.5154948446;48616;48712.51287487151;49982.25026624603;50187.24719129216;50344.496555033984;50517;50672.74663626658;14337.6415589609;14414.639634009234;14475.565733028026;14574.63563410902;14591.197484138262;12006.579769708018;12058.819117713241;13342.19946803195;13398.263095529644;13574.93212533931;14189.85810141906;14193.219372934382;14257.429702811978;14341.498047568284;14415.207163606103;5775.220345253421;5821.243238379068;5874.618149820248;5903.881922361615;5913.46778789911;1002.6791426743372;1009.6516701737888;1024.2215915903967;1049.222797927455;1057.1014637558014;22118.447038824157;22458.55082898333;22680.886595566917;23050;23133.074677013068;1083.8676225707711;1103.569607852938;1138.510440510572;1142.2175809570472;1150.097173718627;11785.941070294764;11937;12339.272501849748;15428.460003900034;15972.20138993069;224436;226211;226697;226711;227208;54691;55188.72405637946;55355;55408;55467.445325547036;1412.3573773932835;1484.5843163913905;1492.3955797901867;1500.4298366620833;1504.5110339139824;25888.741112588632;26277;26738.19785406441;27123.728762712908;27153.185404437107;37219.441708374936;37312.44031339478;37438.8128059358;37470;37494;199858;201128;201216;201321;202078;29621.111366659035;30084.398312034074;30197.547036794906;30928.53607195849;31751.84124079365;40061.79969100136;41167.382489263284;41683.583164169184;42106.7894660537;42419.7879010603;30601.846990764905;31195.376092478476;31304.686953130178;31675.20811979719;32979;32161.678383216804;32748.50877236891;33016.174595635304;33146.5028024575;33408.1647958803;34778;36710;37059.81470092632;37200.62799371972;37255.627443725214;31347;31480.37039259248;32066.839665801523;32099.67900320967;32820.179495511846;23721.52556948886;24923.75076249214;25227.35903739693;25391.61912571276;25522.361940951625 08:47:17 INFO - PID 12582 | |2;jquery.html;561.8174093419638;564.4271064869158;565.9009673307175;570.4837122404223;590.3329237961103;21069;22051.448713782163;22078.11687532501;22096.88951555244;22233;23602.173923912665;25868.870655646744;25911.352216194606;25911.611325830127;25978.870105649494;6475.061116138158;6605.537612367112;6612.669366531678;6621.470282377422;6642.435392991577;4926.778294976717;6440.25937017242;6487.805365839033;6523.478121750272;6526.934730652704;3878.9806050969705;5393.919091213635;6475.255345635242;6496.9025464617835;6505.9349406506035;6502.5448218624715;6512.055751915993;6516.152900122977;6523.151990241262;6529.902051469232;6030.427109424598;6037.788677396314;6044.818655440344;6054.666993315366;6064.63612183266;27530.724692753218;28489.28776780597;28830.567541486893;28861;28990.13029609094;1941.0973897137899;1950.7854136045023;1971.2706298669584;1979.0995097230868;1985.1166231027198;18335;18892.244310227576;19065.42803715891;19099.713504297448;19146.80853191464;2314.710661167354;2372.9644055339186;2393.664886915833;2415.3478560788662;2421.2131057406414;134091;134115.999999999;137168;138289.3085534566;139466.302668487;13724.93137534326;14453.85546144546;14554.781678274834;14659;14719.92640036793;23540;23607.409814754425;23670.88164559166;23688;23710.7628923712;10375.118114960313;10400.167986561208;10513.421761803022;10622.46887655614;10645.574177032986;9740.464274464972;9852.655157069468;9891.950540247397;10053.296269261082;10059.346142500714;8948.418352807046;9001.279897608176;9112.8633070504;9163.908360916439;9266.28573713865;2640.2079376187066;2646.1532309661106;2664.1474728087214;2700.4734076854825;2721;952.7618095476131;959.9232061435068;971.1259866120548;1004.6282875336026;1011.145581983223;19287.614247714966;19460.708089378386;19713.802861971195;20245.797542024393;20332.390028299174;1005.7988402319565;1024.1704219582161;1061.0927656853435;1066.6746642274181;1076.6985244131656;10716.892831071746;10725;10798.298110622783;10832.945835270773;11169.218154729091;451485;456341;457643;461883;461988;110119.44940275248;110273;110512;110665;110925;1247.8065899785547;1260.9810852837215;1264.5763669170747;1268.2390565660714;1277.3102524636593;16570.58573535671;17323.56691082733;17429.47711568655;17762;18088.09559522045;51380.74309628428;51942.22086668627;53978.46021539735;54011.18983215334;55820;64172.67913660402;65470;66548.66725666534;66819;67663.66168169127;14346.354414051184;14697.485588004369;14697.92651036738;14721.116732996055;14724;22323.888380557994;23177;23298.767012330336;23457.648135277643;23517.647235291828;17399.47801565955;18219.180136894138;18582.163802629184;18592.814071859648;18600.06999650039;15111.395544178109;15992.92003539975;16165;16703.164841758105;17291.70312226563;18355.449336519927;19744.703829442282;19834;19999.700004499653;20017.899910500353;14749.778753318924;14844.62888427798;14855.554333369584;14885.25573721288;14914.179720115499;16275.59311017234;18462.81537184611;19021.904890476013;19108.426747197605;19235.615287694447 08:47:17 INFO - PID 12582 | |3;mootools.html;1349.5613925474222;1399.825021872266;1419.9219042952636;1420.3466405453491;1424.18821271875;12790.744185116291;13285.070045096823;13391;13405.530806421777;13464.59606211814;13102.213867167977;14024.298785060757;14048.64878378041;14062.929685351559;14074.859251407483;2514.6730924979774;2574.7940164786864;2583.573710337792;2591.1449221756775;2592.1057235253807;2502.711103781554;2574.9227523174336;2585.31489155374;2588.7670109690125;2589.249117755858;2523.8485690858515;2548.847069175846;2559.436923876744;2560.9487810243786;2562.7693507584313;2404.0504000919627;2413.8913748881255;2425.6846609940594;2431;2438.792702620279;2418.6372044193336;2418.9395265118337;2431.8297719159664;2440.3533063738123;2443.816713746476;12833;13112.934435327857;13125.146865453715;13157.86842131576;13166;7122.358987691133;7363.447741419415;7375.078115235596;7390.778276651709;7408.59252741099;4462.910741785178;4589.0821835633005;4627.768611569408;4631.4673812511655;4664.300354946751;1780;1781.9643607127784;1802.7656404667441;1840.3006857394105;1871.0364162456347;21599.568008639897;21876;21930.232441864457;21962.560748785094;21975.120995160174;5951.880962380728;5999.940000599938;6041.6375017499095;6146.846328841725;6160.58306589478;14790.482333118505;14821.851781482263;14920;14924.925375373054;14931.92534037323;6981.2669669684965;7133.607651579109;7168.641567921583;7178.28217178278;7180.8922866157045;5743.310802703619;6246.875062498724;6629.569078009914;6802.659867006729;6881.380675739108;4626.097910907408;4628.884277893079;4709;4822.397200349957;4830;1339.7923321885123;1355.5662188099911;1362.9454821807215;1378.7311474262422;1387.4450219912117;859.3855393393753;866.467122719523;886.6320477002101;899.6581299106298;910.9524047345474;6974.407175390149;6993.405560527311;7018.543794653331;7038.577685338896;7441.367483763833;720.4783258594917;729.8102493351766;741.8775901976113;748.4311922938497;750.313463181194;4235.576442355739;4576.771161441915;4588.518205588432;4735;4926.3842019747535;17174;18052;18083.09584520769;18172.45482635523;18218.544536386697;17313.3074677014;17379;17780.644387112443;17812.198451069733;17828;10067.59729610822;10235.232357573062;10238.232132590085;10240.590376385011;10260.948695256477;7187.425005999612;7519.962400188183;7655.349295309961;7661.961690191736;7665.578393188205;15358.923205383902;15364.308606112529;15481;15748.842511574738;16591.751123733397;15342.846571534143;16039.759403609189;16361.918190408971;16435.753463697816;16736.163191840602;11049;11316;11368.147388945697;12646.367681615699;13027.609171724864;13165.341732913124;13389.062765606313;13405.195688258736;13455.058145929692;13469.663258418617;9750.85373719409;10356.689299321033;10449.16406687448;10593.947030264799;10960;9496.667616633385;9664.9033509664;9775.755606109904;10082.243831712503;10385.376877387078;8549.829003420022;8725.956370218108;8729.825403492021;8761.25529330014;8795.25240354577;6837.9316206839285;6845.4865885057825;6891.689873955584;6893.620850853251;6966.059581956371;6802.183737951477;6817.965910170417;6820.283870193558;6882.483813714091;6950.992106144682 08:47:17 INFO - PID 12582 | |4;prototype.html;483.5237291268098;495.87107352088447;503.59460634189475;509.42689474341364;510.82121257559857;5721.942780572193;5924.466797988181;5998.820035398934;6067.9696601516935;6078.20983272174;5729.911316849795;5836.5914385993;5840.386759390267;5864.266966629171;5923.200367950325;4808.605504403737;4809.855704328858;4810.97594512027;4825.638077144211;4839.782209800567;4853;4864.221724524077;4870.123377791996;4879.609631229493;4883.8779030524165;4704.529547045302;4789.185838407479;4794.280857871312;4813.56677898989;4857.805687772485;4639.53604639535;4764.976175119103;4780.904381912343;4808.158572249842;4837.395325584302;4242.469691288589;4312.417823593806;4333.111712099012;4341.39220509129;4360.367746676746;5752.8849423011725;5761.423857614247;5783.566232532577;5798.739056742456;5890.793822216245;5460.372057213432;5462.126059830408;5500.834974950758;5525.254090697785;5579.103104944298;6335.271443783978;6418.839529011765;6431.356864313578;6460.257070436913;6492.396719820497;4731.888006318512;4753.33453316536;4778.4265888093305;4792.856214313576;4795.832145874912;6641.369069938348;6721.311475409875;6781.72873085076;6807.183138023469;6811.863762724718;4910.361652985161;4919.212925931905;4927.655064145475;4936.3829521309835;4953.356063711694;4891.706497610155;4966.864248373162;4967.801287948441;4986.401631804207;4991.925121123186;5487.6158668893595;5501.579305105741;5509.256250406143;5530.834074977757;5541.445855414427;6375.936240637627;6381.329960354189;6404.263509696351;6408.391202835724;6417.197850268716;1717.4332470284776;1728.5160155156577;1728.720746647497;1731.9480415587552;1740.990225669109;1104.5913012185383;1132.660201939415;1171.9589814356457;1180.504188240941;1217.9817302740466;5576.27135587969;5617.073182924772;5627;5647.181158731961;5722.77108915647;6451.709673064724;6517.446017088506;6526.825171469181;6566.901496477557;6578.27638959714;5642.351129620146;5682.431756824284;5689.573282003784;5695.889301586151;5737.598368114275;3376;3436.347094052122;3447.172678557178;3468.5837699476224;3488.302339532104;6315.5894866833505;6327.588706734047;6327.987521996551;6351.17434733491;6373.267074286424;6578.506612004119;6607.174103237096;6620.2386725527185;6656.134702488645;6743;6356.523260755369;6357.968210159012;6365;6433.140115930498;6445.677716114175;6501.301959686677;6516.315786842313;6600.669966501751;6607.735690572324;6617.2721000688925;6459.257185423548;6470.320616335217;6508.9349106508325;6524.184476940382;6551.312112228338;6323.683815809283;6326.272478665012;6353.745850165941;6402.167718196604;6406.263279722892;4792.083166733195;4915.483874193301;4918.1884988977845;4922.680025798311;4926.556609905126;6486.351364863476;6492.707828147651;6544.149260596092;6556.868862622626;6568.704408301543;6223.408776166257;6305.716242769178;6310.463610593151;6332.398422149889;6364.522660800551;6200.286966998672;6213.875722485615;6287.673560782539;6308;6374.394432528902;6155.169052177898;6202.503799695924;6210.733082424973;6225.097360882556;6288.8427789303805;6257.624542527463;6317.7157027932935;6373.171487706754;6430.839229019125;6431.517636177212;5842.883142337215;6101.267847858286;6173.81478555644;6205.906911396423;6226.813195604139 08:47:17 INFO - PID 12582 | |5;yui.html;923.8244733500634;925.8009527951491;934.3879758758015;948.5921053946801;959.1607343574375;18140.637187256263;18842.81157188428;18852.151653175606;18865.717014244798;19049.619007619858;19019.714704279413;20688.793112068914;21424.571508569818;21440.785592144075;21690.132394704193;1026.563710423071;1039.7192757955347;1051.1013083813343;1053.7260312318776;1054.7204990677476;1045.1638689048768;1048.7797562511882;1053.9736506587358;1054.9367037977709;1058.5448257249418;996.9551370188323;1032.4837581209395;1098.5111625326733;1099.3294090604725;1110.7722916802077;1080.8108580998332;1085.3813326403954;1087.2932593814085;1090.5038207615555;1092.852464917238;778.8014056415577;779.1701837542998;782.792559971608;783.3459061683444;783.7217787685347;17077.487675369757;17404.30382784687;17469.47591572255;17600.735988960176;19614;20516.38450846477;20826;20926.37220883376;21054.368368948955;21160.047797849133;15342.156181410019;15433.228338583138;15591.844081559153;15633.765493517607;15692;3514.2620049789575;3514.38498262803;3517.173464235928;3532.6643968822923;3552.1119720069983;123966;124331.3783431086;124642.37678811548;128168.99999999907;135766;15199.392024319124;15954.28205730745;15996.120213388143;16055;16113.436029738903;29613.259668508028;29770;29810.254743631584;29812.403751925274;29993.400131997238;7893.407994400328;7969.362451003905;8004.559749213733;8020.639071241808;8041.195880411912;4044.656204222674;4107.691923105779;4128.772917489507;4133.731307465006;4148.605882441163;5152.3044389007755;5237.869053273623;5252.264682944391;5263.289455923478;5338.386085600206;886.9689560865339;928.9256859451363;930.6230976454547;942.8585712143233;959.4387283439127;683.9692213850388;701.2426579294452;707.275043080836;710.1549156503744;717.0320067908282;11836.408179591159;11992.520299188109;12531.561395351302;12680.80978785319;12729.172603780724;684.3327755438407;702.1153346782988;703.539181835888;721.8520203358299;729.9525530840478;5278.366596008504;5315.787368505294;5347.465253474699;5465.754041068161;5478.835634930959;104867;105708.47145764223;107179.46410268055;107603;112047;91762;92142;92701;93981;96308.51845740866;81138.59430702809;81213.59393203114;83246;84189.57905210558;86638.133618663;10629.627963021258;10821.621243256448;10874.728131796452;10972.970000549923;11267.098632109248;34953.825230873685;36913.63086369102;37708;38476.2304753909;38565.42151867668;67627.39040319134;68042.65978670273;69095.65452172908;70666.29333706597;71843.64078179785;18839.529011774815;18999.145038473027;19109;19435.222591096765;19644.90177549103;20568.280110196072;21410.57178856445;21434.892825536397;21839.672404914258;22320.21879234219;16346.754798678267;16370.672586547964;17452.650946981244;19744.901275493532;20135.295264665667;18268.90865545664;18287.725684115016;19940.50148746293;20236.494087647927;20575.897120514303;18638.440846774618;19369.225230990603;19501.122449490093;19533.902330488258;19545.21819127219;12108;12713.682157946125;13409.932950335577;13542.187468751907;13872.098313609584;14620.634484137981;15149.848501515286;15301.005434646713;15545.611359716098;15779.368825246862 08:47:17 INFO - PID 12582 | __end_tp_report 08:47:17 INFO - PID 12582 | __start_cc_report 08:47:17 INFO - PID 12582 | _x_x_mozilla_cycle_collect,378 08:47:17 INFO - PID 12582 | __end_cc_report 08:47:17 INFO - PID 12582 | __startTimestamp1500392837942__endTimestamp 08:47:17 INFO - PID 12582 | 08:47:17 INFO - PID 12582 | ------- Summary: start ------- 08:47:17 INFO - PID 12582 | Number of tests: 6 08:47:17 INFO - PID 12582 | 08:47:17 INFO - PID 12582 | [#0] dojo.html Cycles:165 Average:5964.42 Median:6174.72 stddev:695.73 (11.3%) stddev-sans-first:660.22 08:47:17 INFO - PID 12582 | Values: 3086.7 3139.4 3156.1 3165.8 3178.4 5958.4 6041.7 6073.9 6110.1 6167.9 5917.5 6037.7 6038.1 6050.9 6051.2 5472.0 5501.6 5503.4 5518.9 5567.5 5496.7 5551.2 5554.0 5554.0 5564.8 5554.9 5560.0 5561.6 5561.8 5578.8 5535.3 5537.9 5540.1 5544.1 5559.5 5501.3 5515.9 5602.4 5608.6 5708.6 6008.4 6012.2 6037.5 6059.2 6094.3 6262.4 6471.1 6483.6 6532.3 6543.3 5690.4 6435.2 6455.0 6458.0 6467.8 6054.0 6067.9 6096.9 6150.6 6183.3 6681.0 6698.0 6778.4 6797.8 6814.0 6214.0 6363.0 6431.8 6486.1 6546.8 6409.1 6419.4 6438.5 6460.9 6467.5 6360.6 6367.4 6368.0 6397.8 6442.3 5551.5 6487.1 6500.5 6533.2 6616.3 5245.4 5249.0 5300.8 5313.0 5316.9 4494.8 4549.8 4562.1 4569.8 4570.4 5480.9 5598.8 5601.0 5630.4 5692.6 6431.4 6439.3 6448.3 6451.5 6464.5 5583.1 5591.0 5600.4 5606.9 5607.6 5613.4 5642.8 5651.5 5667.0 5672.7 6316.9 6347.2 6356.8 6449.3 6449.7 6518.3 6525.4 6575.3 6621.9 6636.8 6140.8 6258.4 6365.0 6408.6 6429.6 6440.3 6468.5 6525.0 6557.2 6590.7 6467.3 6482.0 6567.5 6577.8 6579.7 6324.7 6331.6 6427.3 6428.0 6439.0 6263.4 6286.7 6350.0 6364.5 6425.0 6174.7 6179.0 6233.3 6237.1 6246.5 6199.3 6257.9 6267.2 6287.4 6322.7 5229.1 6033.5 6111.3 6117.0 6166.6 08:47:17 INFO - PID 12582 | 08:47:17 INFO - PID 12582 | [#1] ext.html Cycles:180 Average:36624.62 Median:18050.88 stddev:52747.76 (292.2%) stddev-sans-first:52827.04 08:47:17 INFO - PID 12582 | Values: 776.0 788.7 820.6 852.2 857.5 39484.6 40530.4 40552.2 40796.8 40899.4 35320.0 35542.0 35546.5 35722.8 35969.8 6700.7 6800.0 6810.5 6836.0 6846.8 6780.1 6857.0 6871.0 6874.1 6878.6 6821.0 6824.8 6831.4 6843.6 6857.3 6765.0 6781.7 6803.7 6809.3 6811.9 6100.4 6109.1 6134.2 6143.0 6153.3 32251.4 32301.7 32313.2 32353.8 32379.0 3281.6 3305.6 3306.3 3315.7 3331.4 25825.4 25881.6 26138.9 26142.0 26193.9 4050.1 4201.4 4203.7 4222.6 4261.5 176176.0 176494.0 181215.0 181863.1 182828.0 48059.3 48076.3 48450.5 48616.0 48712.5 49982.3 50187.2 50344.5 50517.0 50672.7 14337.6 14414.6 14475.6 14574.6 14591.2 12006.6 12058.8 13342.2 13398.3 13574.9 14189.9 14193.2 14257.4 14341.5 14415.2 5775.2 5821.2 5874.6 5903.9 5913.5 1002.7 1009.7 1024.2 1049.2 1057.1 22118.4 22458.6 22680.9 23050.0 23133.1 1083.9 1103.6 1138.5 1142.2 1150.1 11785.9 11937.0 12339.3 15428.5 15972.2 224436.0 226211.0 226697.0 226711.0 227208.0 54691.0 55188.7 55355.0 55408.0 55467.4 1412.4 1484.6 1492.4 1500.4 1504.5 25888.7 26277.0 26738.2 27123.7 27153.2 37219.4 37312.4 37438.8 37470.0 37494.0 199858.0 201128.0 201216.0 201321.0 202078.0 29621.1 30084.4 30197.5 30928.5 31751.8 40061.8 41167.4 41683.6 42106.8 42419.8 30601.8 31195.4 31304.7 31675.2 32979.0 32161.7 32748.5 33016.2 33146.5 33408.2 34778.0 36710.0 37059.8 37200.6 37255.6 31347.0 31480.4 32066.8 32099.7 32820.2 23721.5 24923.8 25227.4 25391.6 25522.4 08:47:17 INFO - PID 12582 | 08:47:17 INFO - PID 12582 | [#2] jquery.html Cycles:180 Average:33394.58 Median:22064.78 stddev:77371.33 (350.7%) stddev-sans-first:77549.10 08:47:17 INFO - PID 12582 | Values: 561.8 564.4 565.9 570.5 590.3 21069.0 22051.4 22078.1 22096.9 22233.0 23602.2 25868.9 25911.4 25911.6 25978.9 6475.1 6605.5 6612.7 6621.5 6642.4 4926.8 6440.3 6487.8 6523.5 6526.9 3879.0 5393.9 6475.3 6496.9 6505.9 6502.5 6512.1 6516.2 6523.2 6529.9 6030.4 6037.8 6044.8 6054.7 6064.6 27530.7 28489.3 28830.6 28861.0 28990.1 1941.1 1950.8 1971.3 1979.1 1985.1 18335.0 18892.2 19065.4 19099.7 19146.8 2314.7 2373.0 2393.7 2415.3 2421.2 134091.0 134116.0 137168.0 138289.3 139466.3 13724.9 14453.9 14554.8 14659.0 14719.9 23540.0 23607.4 23670.9 23688.0 23710.8 10375.1 10400.2 10513.4 10622.5 10645.6 9740.5 9852.7 9892.0 10053.3 10059.3 8948.4 9001.3 9112.9 9163.9 9266.3 2640.2 2646.2 2664.1 2700.5 2721.0 952.8 959.9 971.1 1004.6 1011.1 19287.6 19460.7 19713.8 20245.8 20332.4 1005.8 1024.2 1061.1 1066.7 1076.7 10716.9 10725.0 10798.3 10832.9 11169.2 451485.0 456341.0 457643.0 461883.0 461988.0 110119.4 110273.0 110512.0 110665.0 110925.0 1247.8 1261.0 1264.6 1268.2 1277.3 16570.6 17323.6 17429.5 17762.0 18088.1 51380.7 51942.2 53978.5 54011.2 55820.0 64172.7 65470.0 66548.7 66819.0 67663.7 14346.4 14697.5 14697.9 14721.1 14724.0 22323.9 23177.0 23298.8 23457.6 23517.6 17399.5 18219.2 18582.2 18592.8 18600.1 15111.4 15992.9 16165.0 16703.2 17291.7 18355.4 19744.7 19834.0 19999.7 20017.9 14749.8 14844.6 14855.6 14885.3 14914.2 16275.6 18462.8 19021.9 19108.4 19235.6 08:47:17 INFO - PID 12582 | 08:47:17 INFO - PID 12582 | [#3] mootools.html Cycles:180 Average:8248.00 Median:2473.26 stddev:5615.03 (227.0%) stddev-sans-first:5606.86 08:47:17 INFO - PID 12582 | Values: 1349.6 1399.8 1419.9 1420.3 1424.2 12790.7 13285.1 13391.0 13405.5 13464.6 13102.2 14024.3 14048.6 14062.9 14074.9 2514.7 2574.8 2583.6 2591.1 2592.1 2502.7 2574.9 2585.3 2588.8 2589.2 2523.8 2548.8 2559.4 2560.9 2562.8 2404.1 2413.9 2425.7 2431.0 2438.8 2418.6 2418.9 2431.8 2440.4 2443.8 12833.0 13112.9 13125.1 13157.9 13166.0 7122.4 7363.4 7375.1 7390.8 7408.6 4462.9 4589.1 4627.8 4631.5 4664.3 1780.0 1782.0 1802.8 1840.3 1871.0 21599.6 21876.0 21930.2 21962.6 21975.1 5951.9 5999.9 6041.6 6146.8 6160.6 14790.5 14821.9 14920.0 14924.9 14931.9 6981.3 7133.6 7168.6 7178.3 7180.9 5743.3 6246.9 6629.6 6802.7 6881.4 4626.1 4628.9 4709.0 4822.4 4830.0 1339.8 1355.6 1362.9 1378.7 1387.4 859.4 866.5 886.6 899.7 911.0 6974.4 6993.4 7018.5 7038.6 7441.4 720.5 729.8 741.9 748.4 750.3 4235.6 4576.8 4588.5 4735.0 4926.4 17174.0 18052.0 18083.1 18172.5 18218.5 17313.3 17379.0 17780.6 17812.2 17828.0 10067.6 10235.2 10238.2 10240.6 10260.9 7187.4 7520.0 7655.3 7662.0 7665.6 15358.9 15364.3 15481.0 15748.8 16591.8 15342.8 16039.8 16361.9 16435.8 16736.2 11049.0 11316.0 11368.1 12646.4 13027.6 13165.3 13389.1 13405.2 13455.1 13469.7 9750.9 10356.7 10449.2 10593.9 10960.0 9496.7 9664.9 9775.8 10082.2 10385.4 8549.8 8726.0 8729.8 8761.3 8795.3 6837.9 6845.5 6891.7 6893.6 6966.1 6802.2 6818.0 6820.3 6882.5 6951.0 08:47:17 INFO - PID 12582 | 08:47:17 INFO - PID 12582 | [#4] prototype.html Cycles:180 Average:5350.34 Median:5817.67 stddev:1502.00 (25.8%) stddev-sans-first:1461.12 08:47:17 INFO - PID 12582 | Values: 483.5 495.9 503.6 509.4 510.8 5721.9 5924.5 5998.8 6068.0 6078.2 5729.9 5836.6 5840.4 5864.3 5923.2 4808.6 4809.9 4811.0 4825.6 4839.8 4853.0 4864.2 4870.1 4879.6 4883.9 4704.5 4789.2 4794.3 4813.6 4857.8 4639.5 4765.0 4780.9 4808.2 4837.4 4242.5 4312.4 4333.1 4341.4 4360.4 5752.9 5761.4 5783.6 5798.7 5890.8 5460.4 5462.1 5500.8 5525.3 5579.1 6335.3 6418.8 6431.4 6460.3 6492.4 4731.9 4753.3 4778.4 4792.9 4795.8 6641.4 6721.3 6781.7 6807.2 6811.9 4910.4 4919.2 4927.7 4936.4 4953.4 4891.7 4966.9 4967.8 4986.4 4991.9 5487.6 5501.6 5509.3 5530.8 5541.4 6375.9 6381.3 6404.3 6408.4 6417.2 1717.4 1728.5 1728.7 1731.9 1741.0 1104.6 1132.7 1172.0 1180.5 1218.0 5576.3 5617.1 5627.0 5647.2 5722.8 6451.7 6517.4 6526.8 6566.9 6578.3 5642.4 5682.4 5689.6 5695.9 5737.6 3376.0 3436.3 3447.2 3468.6 3488.3 6315.6 6327.6 6328.0 6351.2 6373.3 6578.5 6607.2 6620.2 6656.1 6743.0 6356.5 6358.0 6365.0 6433.1 6445.7 6501.3 6516.3 6600.7 6607.7 6617.3 6459.3 6470.3 6508.9 6524.2 6551.3 6323.7 6326.3 6353.7 6402.2 6406.3 4792.1 4915.5 4918.2 4922.7 4926.6 6486.4 6492.7 6544.1 6556.9 6568.7 6223.4 6305.7 6310.5 6332.4 6364.5 6200.3 6213.9 6287.7 6308.0 6374.4 6155.2 6202.5 6210.7 6225.1 6288.8 6257.6 6317.7 6373.2 6430.8 6431.5 5842.9 6101.3 6173.8 6205.9 6226.8 08:47:17 INFO - PID 12582 | 08:47:17 INFO - PID 12582 | [#5] yui.html Cycles:180 Average:23377.34 Median:20572.09 stddev:31572.02 (153.5%) stddev-sans-first:31615.57 08:47:17 INFO - PID 12582 | Values: 923.8 925.8 934.4 948.6 959.2 18140.6 18842.8 18852.2 18865.7 19049.6 19019.7 20688.8 21424.6 21440.8 21690.1 1026.6 1039.7 1051.1 1053.7 1054.7 1045.2 1048.8 1054.0 1054.9 1058.5 997.0 1032.5 1098.5 1099.3 1110.8 1080.8 1085.4 1087.3 1090.5 1092.9 778.8 779.2 782.8 783.3 783.7 17077.5 17404.3 17469.5 17600.7 19614.0 20516.4 20826.0 20926.4 21054.4 21160.0 15342.2 15433.2 15591.8 15633.8 15692.0 3514.3 3514.4 3517.2 3532.7 3552.1 123966.0 124331.4 124642.4 128169.0 135766.0 15199.4 15954.3 15996.1 16055.0 16113.4 29613.3 29770.0 29810.3 29812.4 29993.4 7893.4 7969.4 8004.6 8020.6 8041.2 4044.7 4107.7 4128.8 4133.7 4148.6 5152.3 5237.9 5252.3 5263.3 5338.4 887.0 928.9 930.6 942.9 959.4 684.0 701.2 707.3 710.2 717.0 11836.4 11992.5 12531.6 12680.8 12729.2 684.3 702.1 703.5 721.9 730.0 5278.4 5315.8 5347.5 5465.8 5478.8 104867.0 105708.5 107179.5 107603.0 112047.0 91762.0 92142.0 92701.0 93981.0 96308.5 81138.6 81213.6 83246.0 84189.6 86638.1 10629.6 10821.6 10874.7 10973.0 11267.1 34953.8 36913.6 37708.0 38476.2 38565.4 67627.4 68042.7 69095.7 70666.3 71843.6 18839.5 18999.1 19109.0 19435.2 19644.9 20568.3 21410.6 21434.9 21839.7 22320.2 16346.8 16370.7 17452.7 19744.9 20135.3 18268.9 18287.7 19940.5 20236.5 20575.9 18638.4 19369.2 19501.1 19533.9 19545.2 12108.0 12713.7 13409.9 13542.2 13872.1 14620.6 15149.8 15301.0 15545.6 15779.4 08:47:17 INFO - PID 12582 | -------- Summary: end -------- 08:47:17 INFO - PID 12582 | 08:47:18 INFO - TEST-INFO | 12582: exit 0 08:47:18 INFO - TEST-OK | dromaeo_css | took 1110532ms 08:47:18 INFO - TEST-START | kraken 08:47:18 INFO - Initialising browser for kraken test... 08:47:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46089/getInfo.html -profile /tmp/tmpBDWvfq/profile 08:47:18 INFO - TEST-INFO | started process 12987 (/builds/slave/test/build/application/firefox/firefox http://localhost:46089/getInfo.html) 08:47:24 INFO - TEST-INFO | 12987: exit 0 08:47:24 INFO - Browser initialized. 08:47:24 INFO - Running cycle 1/1 for kraken test... 08:47:24 INFO - TEST-INFO | started process 13253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBDWvfq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:47:36 INFO - PID 13253 | RSS: Main: 176115712 08:47:36 INFO - PID 13253 | 08:47:38 INFO - PID 13253 | Cycle 1(1): loaded http://localhost:46089/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46089/tests/kraken/driver.html?testName=audio-beat-detection) 08:47:39 INFO - PID 13253 | RSS: Main: 180035584 08:47:39 INFO - PID 13253 | 08:47:42 INFO - PID 13253 | Cycle 1(1): loaded http://localhost:46089/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46089/tests/kraken/driver.html?testName=audio-dft) 08:47:42 INFO - PID 13253 | RSS: Main: 180125696 08:47:42 INFO - PID 13253 | 08:47:45 INFO - PID 13253 | Cycle 1(1): loaded http://localhost:46089/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46089/tests/kraken/driver.html?testName=audio-fft) 08:47:46 INFO - PID 13253 | RSS: Main: 174362624 08:47:46 INFO - PID 13253 | 08:47:48 INFO - PID 13253 | Cycle 1(1): loaded http://localhost:46089/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46089/tests/kraken/driver.html?testName=audio-oscillator) 08:47:49 INFO - PID 13253 | RSS: Main: 175308800 08:47:49 INFO - PID 13253 | 08:47:51 INFO - PID 13253 | Cycle 1(1): loaded http://localhost:46089/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46089/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:47:51 INFO - PID 13253 | RSS: Main: 174915584 08:47:51 INFO - PID 13253 | 08:47:54 INFO - PID 13253 | Cycle 1(1): loaded http://localhost:46089/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46089/tests/kraken/driver.html?testName=imaging-darkroom) 08:47:55 INFO - PID 13253 | RSS: Main: 179159040 08:47:55 INFO - PID 13253 | 08:47:58 INFO - PID 13253 | Cycle 1(1): loaded http://localhost:46089/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46089/tests/kraken/driver.html?testName=imaging-desaturate) 08:47:59 INFO - PID 13253 | RSS: Main: 179601408 08:47:59 INFO - PID 13253 | 08:48:02 INFO - PID 13253 | Cycle 1(1): loaded http://localhost:46089/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46089/tests/kraken/driver.html?testName=json-parse-financial) 08:48:02 INFO - PID 13253 | RSS: Main: 179732480 08:48:02 INFO - PID 13253 | 08:48:04 INFO - PID 13253 | Cycle 1(1): loaded http://localhost:46089/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46089/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:48:05 INFO - PID 13253 | RSS: Main: 178262016 08:48:05 INFO - PID 13253 | 08:48:06 INFO - PID 13253 | Cycle 1(1): loaded http://localhost:46089/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46089/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:48:07 INFO - PID 13253 | RSS: Main: 178196480 08:48:07 INFO - PID 13253 | 08:48:09 INFO - PID 13253 | Cycle 1(1): loaded http://localhost:46089/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46089/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:48:10 INFO - PID 13253 | RSS: Main: 178524160 08:48:10 INFO - PID 13253 | 08:48:12 INFO - PID 13253 | Cycle 1(1): loaded http://localhost:46089/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46089/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:48:13 INFO - PID 13253 | RSS: Main: 178577408 08:48:13 INFO - PID 13253 | 08:48:16 INFO - PID 13253 | Cycle 1(1): loaded http://localhost:46089/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46089/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:48:17 INFO - PID 13253 | RSS: Main: 178814976 08:48:17 INFO - PID 13253 | 08:48:19 INFO - PID 13253 | Cycle 1(1): loaded http://localhost:46089/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46089/tests/kraken/driver.html?testName=ai-astar) 08:48:19 INFO - PID 13253 | RSS: Main: 180465664 08:48:19 INFO - PID 13253 | 08:48:19 INFO - PID 13253 | __start_tp_report 08:48:19 INFO - PID 13253 | _x_x_mozilla_page_load 08:48:19 INFO - PID 13253 | _x_x_mozilla_page_load_details 08:48:19 INFO - PID 13253 | |i|pagename|runs| 08:48:19 INFO - PID 13253 | |0;ai-astar;99;109;102;108;108;112;109;101;110;112 08:48:19 INFO - PID 13253 | |1;audio-beat-detection;162;123;152;166;121;148;149;124;164;120 08:48:19 INFO - PID 13253 | |2;audio-dft;163;163;162;163;163;163;163;167;172;167 08:48:19 INFO - PID 13253 | |3;audio-fft;75;75;76;171;76;76;74;73;99;75 08:48:19 INFO - PID 13253 | |4;audio-oscillator;82;83;133;80;81;82;141;83;82;127 08:48:19 INFO - PID 13253 | |5;imaging-gaussian-blur;114;114;113;114;114;113;114;113;113;113 08:48:19 INFO - PID 13253 | |6;imaging-darkroom;150;151;151;150;151;153;151;150;150;150 08:48:19 INFO - PID 13253 | |7;imaging-desaturate;94;94;94;93;94;94;94;94;94;94 08:48:19 INFO - PID 13253 | |8;json-parse-financial;54;55;61;53;57;57;54;56;54;53 08:48:19 INFO - PID 13253 | |9;json-stringify-tinderbox;54;54;55;55;55;54;54;55;56;55 08:48:19 INFO - PID 13253 | |10;stanford-crypto-aes;77;78;80;77;79;80;77;77;82;77 08:48:19 INFO - PID 13253 | |11;stanford-crypto-ccm;128;130;129;128;128;130;124;133;127;152 08:48:19 INFO - PID 13253 | |12;stanford-crypto-pbkdf2;179;197;186;183;182;189;185;181;194;204 08:48:19 INFO - PID 13253 | |13;stanford-crypto-sha256-iterative;70;70;69;67;72;71;70;71;69;70 08:48:19 INFO - PID 13253 | __end_tp_report 08:48:19 INFO - PID 13253 | __start_cc_report 08:48:19 INFO - PID 13253 | _x_x_mozilla_cycle_collect,925 08:48:19 INFO - PID 13253 | __end_cc_report 08:48:19 INFO - PID 13253 | __startTimestamp1500392899280__endTimestamp 08:48:19 INFO - PID 13253 | 08:48:19 INFO - PID 13253 | ------- Summary: start ------- 08:48:19 INFO - PID 13253 | Number of tests: 14 08:48:19 INFO - PID 13253 | 08:48:19 INFO - PID 13253 | [#0] ai-astar Cycles:10 Average:107.00 Median:109.50 stddev:4.64 (4.2%) stddev-sans-first:3.92 08:48:19 INFO - PID 13253 | Values: 99.0 109.0 102.0 108.0 108.0 112.0 109.0 101.0 110.0 112.0 08:48:19 INFO - PID 13253 | 08:48:19 INFO - PID 13253 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:150.50 stddev:18.99 (12.6%) stddev-sans-first:18.85 08:48:19 INFO - PID 13253 | Values: 162.0 123.0 152.0 166.0 121.0 148.0 149.0 124.0 164.0 120.0 08:48:19 INFO - PID 13253 | 08:48:19 INFO - PID 13253 | [#2] audio-dft Cycles:10 Average:164.60 Median:163.00 stddev:3.13 (1.9%) stddev-sans-first:3.27 08:48:19 INFO - PID 13253 | Values: 163.0 163.0 162.0 163.0 163.0 163.0 163.0 167.0 172.0 167.0 08:48:19 INFO - PID 13253 | 08:48:19 INFO - PID 13253 | [#3] audio-fft Cycles:10 Average:87.00 Median:75.50 stddev:30.48 (40.4%) stddev-sans-first:32.02 08:48:19 INFO - PID 13253 | Values: 75.0 75.0 76.0 171.0 76.0 76.0 74.0 73.0 99.0 75.0 08:48:19 INFO - PID 13253 | 08:48:19 INFO - PID 13253 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:82.00 stddev:25.26 (30.8%) stddev-sans-first:26.17 08:48:19 INFO - PID 13253 | Values: 82.0 83.0 133.0 80.0 81.0 82.0 141.0 83.0 82.0 127.0 08:48:19 INFO - PID 13253 | 08:48:19 INFO - PID 13253 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:48:19 INFO - PID 13253 | Values: 114.0 114.0 113.0 114.0 114.0 113.0 114.0 113.0 113.0 113.0 08:48:19 INFO - PID 13253 | 08:48:19 INFO - PID 13253 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 08:48:19 INFO - PID 13253 | Values: 150.0 151.0 151.0 150.0 151.0 153.0 151.0 150.0 150.0 150.0 08:48:19 INFO - PID 13253 | 08:48:19 INFO - PID 13253 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:48:19 INFO - PID 13253 | Values: 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 08:48:19 INFO - PID 13253 | 08:48:19 INFO - PID 13253 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:2.46 (4.4%) stddev-sans-first:2.55 08:48:19 INFO - PID 13253 | Values: 54.0 55.0 61.0 53.0 57.0 57.0 54.0 56.0 54.0 53.0 08:48:19 INFO - PID 13253 | 08:48:19 INFO - PID 13253 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:55.00 stddev:0.67 (1.2%) stddev-sans-first:0.67 08:48:19 INFO - PID 13253 | Values: 54.0 54.0 55.0 55.0 55.0 54.0 54.0 55.0 56.0 55.0 08:48:19 INFO - PID 13253 | 08:48:19 INFO - PID 13253 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.50 stddev:1.78 (2.3%) stddev-sans-first:1.81 08:48:19 INFO - PID 13253 | Values: 77.0 78.0 80.0 77.0 79.0 80.0 77.0 77.0 82.0 77.0 08:48:19 INFO - PID 13253 | 08:48:19 INFO - PID 13253 | [#11] stanford-crypto-ccm Cycles:10 Average:130.90 Median:129.50 stddev:7.77 (6.0%) stddev-sans-first:8.17 08:48:19 INFO - PID 13253 | Values: 128.0 130.0 129.0 128.0 128.0 130.0 124.0 133.0 127.0 152.0 08:48:19 INFO - PID 13253 | 08:48:19 INFO - PID 13253 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.00 Median:187.50 stddev:8.01 (4.3%) stddev-sans-first:7.81 08:48:19 INFO - PID 13253 | Values: 179.0 197.0 186.0 183.0 182.0 189.0 185.0 181.0 194.0 204.0 08:48:19 INFO - PID 13253 | 08:48:19 INFO - PID 13253 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.37 (2.0%) stddev-sans-first:1.45 08:48:19 INFO - PID 13253 | Values: 70.0 70.0 69.0 67.0 72.0 71.0 70.0 71.0 69.0 70.0 08:48:19 INFO - PID 13253 | -------- Summary: end -------- 08:48:19 INFO - PID 13253 | 08:48:19 INFO - PID 13253 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:48:19 INFO - TEST-INFO | 13253: exit 0 08:48:20 INFO - TEST-OK | kraken | took 61402ms 08:48:20 INFO - SUITE-END | took 1171s 08:48:20 INFO - Completed test suite (00:19:32) 08:48:20 INFO - javascript benchmark 08:48:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8219.93236980506, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3086.706762857528, 3139.4035133324664, 3156.1005113542637, 3165.79422337548, 3178.3643271345736, 5958.374370691075, 6041.728122234499, 6073.908891366622, 6110.083487476875, 6167.907481387782, 5917.497012753921, 6037.698115094238, 6038.124471951564, 6050.878982420349, 6051.183090282811, 5471.997129444144, 5501.559875209973, 5503.422140675231, 5518.862028449281, 5567.47109024644, 5496.670199788005, 5551.1673249012565, 5553.972230138844, 5554.028045092093, 5564.777408903639, 5554.888902221953, 5560.0, 5561.555075593943, 5561.805336813212, 5578.804741834037, 5535.335759708841, 5537.889242215173, 5540.085885828834, 5544.0575102232515, 5559.527440167551, 5501.312335958005, 5515.889682206373, 5602.411746766612, 5608.579356548275, 5708.571857110692, 6008.429199226067, 6012.18835457212, 6037.4566289033755, 6059.18201042858, 6094.299155597118, 6262.405071518244, 6471.0940468334475, 6483.643399613019, 6532.281449040602, 6543.312952140004, 5690.411770892084, 6435.163428754278, 6454.967725161391, 6457.967710161419, 6467.83830404239, 6054.031354983182, 6067.908981365283, 6096.908546371852, 6150.600210986317, 6183.319834818167, 6681.0, 6698.0488335525315, 6778.423833974168, 6797.830054248584, 6814.046033555306, 6214.005759078616, 6363.0, 6431.807045788634, 6486.05952136947, 6546.770863019771, 6409.102725618417, 6419.390157934989, 6438.484921206292, 6460.935390646034, 6467.482601391877, 6360.618362898241, 6367.395097465734, 6367.968160159169, 6397.776077837253, 6442.291347951722, 5551.528120109836, 6487.091807147003, 6500.512461565401, 6533.150690410312, 6616.27221005689, 5245.449227831099, 5248.9737551312, 5300.787968481218, 5312.973435132877, 5316.946830531722, 4494.752788596593, 4549.772511374418, 4562.087582483517, 4569.817207311737, 4570.382998295254, 5480.890382192334, 5598.832035038955, 5601.047821870292, 5630.380658127685, 5692.6299790513485, 6431.356864313531, 6439.259485159267, 6448.290688024314, 6451.548391612542, 6464.515161362917, 5583.106702927512, 5590.97204513983, 5600.355959064678, 5606.859828504238, 5607.607467477319, 5613.354464236665, 5642.830715078554, 5651.547876169897, 5666.9716651416475, 5672.659640421588, 6316.873662526816, 6347.238331400262, 6356.777512787123, 6449.32282110381, 6449.742010319628, 6518.250401203827, 6525.3800888915475, 6575.276719560845, 6621.900671489835, 6636.767713130017, 6140.754369825157, 6258.43674069336, 6365.045243213555, 6408.58344207625, 6429.58207716497, 6440.323766004502, 6468.514861385509, 6524.98862676267, 6557.2131344239, 6590.670466476561, 6467.288598254282, 6482.0, 6567.507436942153, 6577.80266592003, 6579.736810527716, 6324.6521441321165, 6331.588446750947, 6427.3251308611925, 6428.003659432796, 6438.967805160944, 6263.404976527223, 6286.654234017173, 6350.04749287592, 6364.522660800366, 6425.0, 6174.722137503913, 6179.0422484514975, 6233.314335423191, 6237.126802247598, 6246.469050130608, 6199.318075011655, 6257.906131407942, 6267.185265915402, 6287.402696743802, 6322.747090116344, 5229.080422345311, 6033.456988870847, 6111.327753947151, 6117.0, 6166.630002199882], "value": 5914.729913659167, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.9806004849881, 788.7160622176016, 820.5733018830208, 852.1733918099442, 857.4555157475002, 39484.605153948454, 40530.36552624077, 40552.188956220896, 40796.79601601995, 40899.386509202384, 35320.0, 35542.0, 35546.46680299791, 35722.8213858931, 35969.820150899206, 6700.664966751668, 6800.047993280945, 6810.523263371541, 6836.0, 6846.760363387282, 6780.084688567054, 6857.0, 6871.0, 6874.140732408449, 6878.55289406187, 6820.965895170542, 6824.761133360334, 6831.351021652935, 6843.589384636913, 6857.279985601514, 6765.0, 6781.6609169541325, 6803.65981700913, 6809.3190680932, 6811.863762724767, 6100.389961003909, 6109.083637454373, 6134.2332208473945, 6143.047827586731, 6153.292371377304, 32251.354972900644, 32301.676983230103, 32313.1921701957, 32353.838230808695, 32379.0, 3281.5898012748407, 3305.636379998198, 3306.2560923792194, 3315.7181639560667, 3331.3503866745996, 25825.354366140808, 25881.611775823378, 26138.86930565335, 26142.0, 26193.869030654725, 4050.1494686115952, 4201.411802347674, 4203.7057405981595, 4222.556631553704, 4261.509926358477, 176176.0, 176494.0, 181215.0, 181863.09068454572, 182828.0, 48059.27911081337, 48076.27885581719, 48450.5154948446, 48616.0, 48712.51287487151, 49982.25026624603, 50187.24719129216, 50344.496555033984, 50517.0, 50672.74663626658, 14337.6415589609, 14414.639634009234, 14475.565733028026, 14574.63563410902, 14591.197484138262, 12006.579769708018, 12058.819117713241, 13342.19946803195, 13398.263095529644, 13574.93212533931, 14189.85810141906, 14193.219372934382, 14257.429702811978, 14341.498047568284, 14415.207163606103, 5775.220345253421, 5821.243238379068, 5874.618149820248, 5903.881922361615, 5913.46778789911, 1002.6791426743372, 1009.6516701737888, 1024.2215915903967, 1049.222797927455, 1057.1014637558014, 22118.447038824157, 22458.55082898333, 22680.886595566917, 23050.0, 23133.074677013068, 1083.8676225707711, 1103.569607852938, 1138.510440510572, 1142.2175809570472, 1150.097173718627, 11785.941070294764, 11937.0, 12339.272501849748, 15428.460003900034, 15972.20138993069, 224436.0, 226211.0, 226697.0, 226711.0, 227208.0, 54691.0, 55188.72405637946, 55355.0, 55408.0, 55467.445325547036, 1412.3573773932835, 1484.5843163913905, 1492.3955797901867, 1500.4298366620833, 1504.5110339139824, 25888.741112588632, 26277.0, 26738.19785406441, 27123.728762712908, 27153.185404437107, 37219.441708374936, 37312.44031339478, 37438.8128059358, 37470.0, 37494.0, 199858.0, 201128.0, 201216.0, 201321.0, 202078.0, 29621.111366659035, 30084.398312034074, 30197.547036794906, 30928.53607195849, 31751.84124079365, 40061.79969100136, 41167.382489263284, 41683.583164169184, 42106.7894660537, 42419.7879010603, 30601.846990764905, 31195.376092478476, 31304.686953130178, 31675.20811979719, 32979.0, 32161.678383216804, 32748.50877236891, 33016.174595635304, 33146.5028024575, 33408.1647958803, 34778.0, 36710.0, 37059.81470092632, 37200.62799371972, 37255.627443725214, 31347.0, 31480.37039259248, 32066.839665801523, 32099.67900320967, 32820.179495511846, 23721.52556948886, 24923.75076249214, 25227.35903739693, 25391.61912571276, 25522.361940951625], "value": 16466.71970028314, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.8174093419638, 564.4271064869158, 565.9009673307175, 570.4837122404223, 590.3329237961103, 21069.0, 22051.448713782163, 22078.11687532501, 22096.88951555244, 22233.0, 23602.173923912665, 25868.870655646744, 25911.352216194606, 25911.611325830127, 25978.870105649494, 6475.061116138158, 6605.537612367112, 6612.669366531678, 6621.470282377422, 6642.435392991577, 4926.778294976717, 6440.25937017242, 6487.805365839033, 6523.478121750272, 6526.934730652704, 3878.9806050969705, 5393.919091213635, 6475.255345635242, 6496.9025464617835, 6505.9349406506035, 6502.5448218624715, 6512.055751915993, 6516.152900122977, 6523.151990241262, 6529.902051469232, 6030.427109424598, 6037.788677396314, 6044.818655440344, 6054.666993315366, 6064.63612183266, 27530.724692753218, 28489.28776780597, 28830.567541486893, 28861.0, 28990.13029609094, 1941.0973897137899, 1950.7854136045023, 1971.2706298669584, 1979.0995097230868, 1985.1166231027198, 18335.0, 18892.244310227576, 19065.42803715891, 19099.713504297448, 19146.80853191464, 2314.710661167354, 2372.9644055339186, 2393.664886915833, 2415.3478560788662, 2421.2131057406414, 134091.0, 134115.999999999, 137168.0, 138289.3085534566, 139466.302668487, 13724.93137534326, 14453.85546144546, 14554.781678274834, 14659.0, 14719.92640036793, 23540.0, 23607.409814754425, 23670.88164559166, 23688.0, 23710.7628923712, 10375.118114960313, 10400.167986561208, 10513.421761803022, 10622.46887655614, 10645.574177032986, 9740.464274464972, 9852.655157069468, 9891.950540247397, 10053.296269261082, 10059.346142500714, 8948.418352807046, 9001.279897608176, 9112.8633070504, 9163.908360916439, 9266.28573713865, 2640.2079376187066, 2646.1532309661106, 2664.1474728087214, 2700.4734076854825, 2721.0, 952.7618095476131, 959.9232061435068, 971.1259866120548, 1004.6282875336026, 1011.145581983223, 19287.614247714966, 19460.708089378386, 19713.802861971195, 20245.797542024393, 20332.390028299174, 1005.7988402319565, 1024.1704219582161, 1061.0927656853435, 1066.6746642274181, 1076.6985244131656, 10716.892831071746, 10725.0, 10798.298110622783, 10832.945835270773, 11169.218154729091, 451485.0, 456341.0, 457643.0, 461883.0, 461988.0, 110119.44940275248, 110273.0, 110512.0, 110665.0, 110925.0, 1247.8065899785547, 1260.9810852837215, 1264.5763669170747, 1268.2390565660714, 1277.3102524636593, 16570.58573535671, 17323.56691082733, 17429.47711568655, 17762.0, 18088.09559522045, 51380.74309628428, 51942.22086668627, 53978.46021539735, 54011.18983215334, 55820.0, 64172.67913660402, 65470.0, 66548.66725666534, 66819.0, 67663.66168169127, 14346.354414051184, 14697.485588004369, 14697.92651036738, 14721.116732996055, 14724.0, 22323.888380557994, 23177.0, 23298.767012330336, 23457.648135277643, 23517.647235291828, 17399.47801565955, 18219.180136894138, 18582.163802629184, 18592.814071859648, 18600.06999650039, 15111.395544178109, 15992.92003539975, 16165.0, 16703.164841758105, 17291.70312226563, 18355.449336519927, 19744.703829442282, 19834.0, 19999.700004499653, 20017.899910500353, 14749.778753318924, 14844.62888427798, 14855.554333369584, 14885.25573721288, 14914.179720115499, 16275.59311017234, 18462.81537184611, 19021.904890476013, 19108.426747197605, 19235.615287694447], "value": 11821.462941194039, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.5613925474222, 1399.825021872266, 1419.9219042952636, 1420.3466405453491, 1424.18821271875, 12790.744185116291, 13285.070045096823, 13391.0, 13405.530806421777, 13464.59606211814, 13102.213867167977, 14024.298785060757, 14048.64878378041, 14062.929685351559, 14074.859251407483, 2514.6730924979774, 2574.7940164786864, 2583.573710337792, 2591.1449221756775, 2592.1057235253807, 2502.711103781554, 2574.9227523174336, 2585.31489155374, 2588.7670109690125, 2589.249117755858, 2523.8485690858515, 2548.847069175846, 2559.436923876744, 2560.9487810243786, 2562.7693507584313, 2404.0504000919627, 2413.8913748881255, 2425.6846609940594, 2431.0, 2438.792702620279, 2418.6372044193336, 2418.9395265118337, 2431.8297719159664, 2440.3533063738123, 2443.816713746476, 12833.0, 13112.934435327857, 13125.146865453715, 13157.86842131576, 13166.0, 7122.358987691133, 7363.447741419415, 7375.078115235596, 7390.778276651709, 7408.59252741099, 4462.910741785178, 4589.0821835633005, 4627.768611569408, 4631.4673812511655, 4664.300354946751, 1780.0, 1781.9643607127784, 1802.7656404667441, 1840.3006857394105, 1871.0364162456347, 21599.568008639897, 21876.0, 21930.232441864457, 21962.560748785094, 21975.120995160174, 5951.880962380728, 5999.940000599938, 6041.6375017499095, 6146.846328841725, 6160.58306589478, 14790.482333118505, 14821.851781482263, 14920.0, 14924.925375373054, 14931.92534037323, 6981.2669669684965, 7133.607651579109, 7168.641567921583, 7178.28217178278, 7180.8922866157045, 5743.310802703619, 6246.875062498724, 6629.569078009914, 6802.659867006729, 6881.380675739108, 4626.097910907408, 4628.884277893079, 4709.0, 4822.397200349957, 4830.0, 1339.7923321885123, 1355.5662188099911, 1362.9454821807215, 1378.7311474262422, 1387.4450219912117, 859.3855393393753, 866.467122719523, 886.6320477002101, 899.6581299106298, 910.9524047345474, 6974.407175390149, 6993.405560527311, 7018.543794653331, 7038.577685338896, 7441.367483763833, 720.4783258594917, 729.8102493351766, 741.8775901976113, 748.4311922938497, 750.313463181194, 4235.576442355739, 4576.771161441915, 4588.518205588432, 4735.0, 4926.3842019747535, 17174.0, 18052.0, 18083.09584520769, 18172.45482635523, 18218.544536386697, 17313.3074677014, 17379.0, 17780.644387112443, 17812.198451069733, 17828.0, 10067.59729610822, 10235.232357573062, 10238.232132590085, 10240.590376385011, 10260.948695256477, 7187.425005999612, 7519.962400188183, 7655.349295309961, 7661.961690191736, 7665.578393188205, 15358.923205383902, 15364.308606112529, 15481.0, 15748.842511574738, 16591.751123733397, 15342.846571534143, 16039.759403609189, 16361.918190408971, 16435.753463697816, 16736.163191840602, 11049.0, 11316.0, 11368.147388945697, 12646.367681615699, 13027.609171724864, 13165.341732913124, 13389.062765606313, 13405.195688258736, 13455.058145929692, 13469.663258418617, 9750.85373719409, 10356.689299321033, 10449.16406687448, 10593.947030264799, 10960.0, 9496.667616633385, 9664.9033509664, 9775.755606109904, 10082.243831712503, 10385.376877387078, 8549.829003420022, 8725.956370218108, 8729.825403492021, 8761.25529330014, 8795.25240354577, 6837.9316206839285, 6845.4865885057825, 6891.689873955584, 6893.620850853251, 6966.059581956371, 6802.183737951477, 6817.965910170417, 6820.283870193558, 6882.483813714091, 6950.992106144682], "value": 6006.093277634443, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.5237291268098, 495.87107352088447, 503.59460634189475, 509.42689474341364, 510.82121257559857, 5721.942780572193, 5924.466797988181, 5998.820035398934, 6067.9696601516935, 6078.20983272174, 5729.911316849795, 5836.5914385993, 5840.386759390267, 5864.266966629171, 5923.200367950325, 4808.605504403737, 4809.855704328858, 4810.97594512027, 4825.638077144211, 4839.782209800567, 4853.0, 4864.221724524077, 4870.123377791996, 4879.609631229493, 4883.8779030524165, 4704.529547045302, 4789.185838407479, 4794.280857871312, 4813.56677898989, 4857.805687772485, 4639.53604639535, 4764.976175119103, 4780.904381912343, 4808.158572249842, 4837.395325584302, 4242.469691288589, 4312.417823593806, 4333.111712099012, 4341.39220509129, 4360.367746676746, 5752.8849423011725, 5761.423857614247, 5783.566232532577, 5798.739056742456, 5890.793822216245, 5460.372057213432, 5462.126059830408, 5500.834974950758, 5525.254090697785, 5579.103104944298, 6335.271443783978, 6418.839529011765, 6431.356864313578, 6460.257070436913, 6492.396719820497, 4731.888006318512, 4753.33453316536, 4778.4265888093305, 4792.856214313576, 4795.832145874912, 6641.369069938348, 6721.311475409875, 6781.72873085076, 6807.183138023469, 6811.863762724718, 4910.361652985161, 4919.212925931905, 4927.655064145475, 4936.3829521309835, 4953.356063711694, 4891.706497610155, 4966.864248373162, 4967.801287948441, 4986.401631804207, 4991.925121123186, 5487.6158668893595, 5501.579305105741, 5509.256250406143, 5530.834074977757, 5541.445855414427, 6375.936240637627, 6381.329960354189, 6404.263509696351, 6408.391202835724, 6417.197850268716, 1717.4332470284776, 1728.5160155156577, 1728.720746647497, 1731.9480415587552, 1740.990225669109, 1104.5913012185383, 1132.660201939415, 1171.9589814356457, 1180.504188240941, 1217.9817302740466, 5576.27135587969, 5617.073182924772, 5627.0, 5647.181158731961, 5722.77108915647, 6451.709673064724, 6517.446017088506, 6526.825171469181, 6566.901496477557, 6578.27638959714, 5642.351129620146, 5682.431756824284, 5689.573282003784, 5695.889301586151, 5737.598368114275, 3376.0, 3436.347094052122, 3447.172678557178, 3468.5837699476224, 3488.302339532104, 6315.5894866833505, 6327.588706734047, 6327.987521996551, 6351.17434733491, 6373.267074286424, 6578.506612004119, 6607.174103237096, 6620.2386725527185, 6656.134702488645, 6743.0, 6356.523260755369, 6357.968210159012, 6365.0, 6433.140115930498, 6445.677716114175, 6501.301959686677, 6516.315786842313, 6600.669966501751, 6607.735690572324, 6617.2721000688925, 6459.257185423548, 6470.320616335217, 6508.9349106508325, 6524.184476940382, 6551.312112228338, 6323.683815809283, 6326.272478665012, 6353.745850165941, 6402.167718196604, 6406.263279722892, 4792.083166733195, 4915.483874193301, 4918.1884988977845, 4922.680025798311, 4926.556609905126, 6486.351364863476, 6492.707828147651, 6544.149260596092, 6556.868862622626, 6568.704408301543, 6223.408776166257, 6305.716242769178, 6310.463610593151, 6332.398422149889, 6364.522660800551, 6200.286966998672, 6213.875722485615, 6287.673560782539, 6308.0, 6374.394432528902, 6155.169052177898, 6202.503799695924, 6210.733082424973, 6225.097360882556, 6288.8427789303805, 6257.624542527463, 6317.7157027932935, 6373.171487706754, 6430.839229019125, 6431.517636177212, 5842.883142337215, 6101.267847858286, 6173.81478555644, 6205.906911396423, 6226.813195604139], "value": 4908.048264360986, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [923.8244733500634, 925.8009527951491, 934.3879758758015, 948.5921053946801, 959.1607343574375, 18140.637187256263, 18842.81157188428, 18852.151653175606, 18865.717014244798, 19049.619007619858, 19019.714704279413, 20688.793112068914, 21424.571508569818, 21440.785592144075, 21690.132394704193, 1026.563710423071, 1039.7192757955347, 1051.1013083813343, 1053.7260312318776, 1054.7204990677476, 1045.1638689048768, 1048.7797562511882, 1053.9736506587358, 1054.9367037977709, 1058.5448257249418, 996.9551370188323, 1032.4837581209395, 1098.5111625326733, 1099.3294090604725, 1110.7722916802077, 1080.8108580998332, 1085.3813326403954, 1087.2932593814085, 1090.5038207615555, 1092.852464917238, 778.8014056415577, 779.1701837542998, 782.792559971608, 783.3459061683444, 783.7217787685347, 17077.487675369757, 17404.30382784687, 17469.47591572255, 17600.735988960176, 19614.0, 20516.38450846477, 20826.0, 20926.37220883376, 21054.368368948955, 21160.047797849133, 15342.156181410019, 15433.228338583138, 15591.844081559153, 15633.765493517607, 15692.0, 3514.2620049789575, 3514.38498262803, 3517.173464235928, 3532.6643968822923, 3552.1119720069983, 123966.0, 124331.3783431086, 124642.37678811548, 128168.99999999907, 135766.0, 15199.392024319124, 15954.28205730745, 15996.120213388143, 16055.0, 16113.436029738903, 29613.259668508028, 29770.0, 29810.254743631584, 29812.403751925274, 29993.400131997238, 7893.407994400328, 7969.362451003905, 8004.559749213733, 8020.639071241808, 8041.195880411912, 4044.656204222674, 4107.691923105779, 4128.772917489507, 4133.731307465006, 4148.605882441163, 5152.3044389007755, 5237.869053273623, 5252.264682944391, 5263.289455923478, 5338.386085600206, 886.9689560865339, 928.9256859451363, 930.6230976454547, 942.8585712143233, 959.4387283439127, 683.9692213850388, 701.2426579294452, 707.275043080836, 710.1549156503744, 717.0320067908282, 11836.408179591159, 11992.520299188109, 12531.561395351302, 12680.80978785319, 12729.172603780724, 684.3327755438407, 702.1153346782988, 703.539181835888, 721.8520203358299, 729.9525530840478, 5278.366596008504, 5315.787368505294, 5347.465253474699, 5465.754041068161, 5478.835634930959, 104867.0, 105708.47145764223, 107179.46410268055, 107603.0, 112047.0, 91762.0, 92142.0, 92701.0, 93981.0, 96308.51845740866, 81138.59430702809, 81213.59393203114, 83246.0, 84189.57905210558, 86638.133618663, 10629.627963021258, 10821.621243256448, 10874.728131796452, 10972.970000549923, 11267.098632109248, 34953.825230873685, 36913.63086369102, 37708.0, 38476.2304753909, 38565.42151867668, 67627.39040319134, 68042.65978670273, 69095.65452172908, 70666.29333706597, 71843.64078179785, 18839.529011774815, 18999.145038473027, 19109.0, 19435.222591096765, 19644.90177549103, 20568.280110196072, 21410.57178856445, 21434.892825536397, 21839.672404914258, 22320.21879234219, 16346.754798678267, 16370.672586547964, 17452.650946981244, 19744.901275493532, 20135.295264665667, 18268.90865545664, 18287.725684115016, 19940.50148746293, 20236.494087647927, 20575.897120514303, 18638.440846774618, 19369.225230990603, 19501.122449490093, 19533.902330488258, 19545.21819127219, 12108.0, 12713.682157946125, 13409.932950335577, 13542.187468751907, 13872.098313609584, 14620.634484137981, 15149.848501515286, 15301.005434646713, 15545.611359716098, 15779.368825246862], "value": 9087.977111635926, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 109.0, 102.0, 108.0, 108.0, 112.0, 109.0, 101.0, 110.0, 112.0], "value": 107.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 123.0, 152.0, 166.0, 121.0, 148.0, 149.0, 124.0, 164.0, 120.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 163.0, 163.0, 163.0, 163.0, 167.0, 172.0, 167.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 171.0, 76.0, 76.0, 74.0, 73.0, 99.0, 75.0], "value": 87.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 133.0, 80.0, 81.0, 82.0, 141.0, 83.0, 82.0, 127.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 114.0, 113.0, 114.0, 113.0, 113.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 150.0, 151.0, 153.0, 151.0, 150.0, 150.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 61.0, 53.0, 57.0, 57.0, 54.0, 56.0, 54.0, 53.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 55.0, 55.0, 54.0, 54.0, 55.0, 56.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 80.0, 77.0, 79.0, 80.0, 77.0, 77.0, 82.0, 77.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 130.0, 129.0, 128.0, 128.0, 130.0, 124.0, 133.0, 127.0, 152.0], "value": 130.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 197.0, 186.0, 183.0, 182.0, 189.0, 185.0, 181.0, 194.0, 204.0], "value": 188.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 67.0, 72.0, 71.0, 70.0, 71.0, 69.0, 70.0], "value": 69.9, "unit": "score"}]}]} 08:48:20 INFO - Return code: 0 08:48:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:48:20 INFO - # TBPL SUCCESS # 08:48:20 INFO - Running post-action listener: _package_coverage_data 08:48:20 INFO - Running post-action listener: _resource_record_post_action 08:48:20 INFO - [mozharness: 2017-07-18 15:48:20.585168Z] Finished run-tests step (success) 08:48:20 INFO - Running post-run listener: _resource_record_post_run 08:48:20 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 437387264; Read time: 16; Write time: 269212 08:48:20 INFO - TinderboxPrint: CPU usage
13.1% 08:48:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:48:20 INFO - TinderboxPrint: I/O write bytes / time
437,387,264 / 269,212 08:48:20 INFO - TinderboxPrint: CPU idle
8,252.6 (86.9%) 08:48:20 INFO - TinderboxPrint: CPU user
1,197.8 (12.6%) 08:48:20 INFO - TinderboxPrint: Swap in / out
0 / 0 08:48:20 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106643456; Read time: 0; Write time: 58540 08:48:20 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:20 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 327991296; Read time: 0; Write time: 206416 08:48:21 INFO - Running post-run listener: _upload_blobber_files 08:48:21 INFO - Blob upload gear active. 08:48:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:48:21 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:21 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:21 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:21 INFO - Traceback (most recent call last): 08:48:21 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 08:48:21 INFO - main() 08:48:21 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 08:48:21 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 08:48:21 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 08:48:21 INFO - return set(response.json().get('whitelist', [])) 08:48:21 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 08:48:21 INFO - return json.loads(self.text or self.content, **kwargs) 08:48:21 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 08:48:21 INFO - return _default_decoder.decode(s) 08:48:21 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 08:48:21 INFO - obj, end = self.raw_decode(s) 08:48:21 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 08:48:21 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 08:48:21 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 08:48:21 ERROR - Return code: 1 08:48:21 INFO - Setting buildbot property blobber_files to {} 08:48:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:48:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:48:21 INFO - Contents: 08:48:21 INFO - blobber_files:{} 08:48:21 INFO - Running post-run listener: copy_logs_to_upload_dir 08:48:21 INFO - Copying logs to upload dir... 08:48:21 INFO - mkdir: /builds/slave/test/build/upload/logs 08:48:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.201133 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-07-18 08:48:21.508501) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-18 08:48:21.512101) ========= 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=41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290 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.011276 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:21.562859) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 08:48:21.563189) ========= 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=41bf3e9aed84707956354da8000001c5-1500390905.193191-1755101290 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004387 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 08:48:21.613738) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-18 08:48:21.614073) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-18 08:48:21.614393) ========= ========= Total master_lag: 0.17 =========