builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1500224340.42 results: success (0) revision: 5f44d10bacca2d693413b529e0caadc73e634e1e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 09:59:00.417797) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 09:59:00.418191) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 09:59:00.418468) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 09:59:00.473841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 09:59:00.474132) ========= 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=20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-16 09:59:00-- 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% 33.2M=0s 2017-07-16 09:59:00 (33.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100596 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 09:59:00.617794) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 09:59:00.618076) ========= 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=20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021811 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 09:59:00.675603) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-16 09:59:00.675960) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5f44d10bacca2d693413b529e0caadc73e634e1e --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 5f44d10bacca2d693413b529e0caadc73e634e1e --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=20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-16 09:59:00,998 truncating revision to first 12 chars 2017-07-16 09:59:00,998 Setting DEBUG logging. 2017-07-16 09:59:00,998 attempt 1/10 2017-07-16 09:59:00,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5f44d10bacca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-16 09:59:02,223 unpacking tar archive at: mozilla-central-5f44d10bacca/testing/mozharness/ program finished with exit code 0 elapsedTime=1.555047 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-16 09:59:02.243299) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 09:59:02.246597) ========= script_repo_revision: 5f44d10bacca2d693413b529e0caadc73e634e1e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 09:59:02.246963) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 09:59:02.247253) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 09:59:02.255676) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-07-16 09:59:02.255941) ========= /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=20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:59:02 INFO - MultiFileLogger online at 20170716 09:59:02 in /builds/slave/test 09:59:02 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 09:59:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:59:02 INFO - {'append_to_log': False, 09:59:02 INFO - 'base_work_dir': '/builds/slave/test', 09:59:02 INFO - 'blob_upload_branch': 'Firefox', 09:59:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:59:02 INFO - 'branch': 'Firefox', 09:59:02 INFO - 'buildbot_json_path': 'buildprops.json', 09:59:02 INFO - 'code_coverage': False, 09:59:02 INFO - 'config_files': ('talos/linux_config.py',), 09:59:02 INFO - 'default_actions': ('clobber', 09:59:02 INFO - 'read-buildbot-config', 09:59:02 INFO - 'download-and-extract', 09:59:02 INFO - 'populate-webroot', 09:59:02 INFO - 'create-virtualenv', 09:59:02 INFO - 'install', 09:59:02 INFO - 'setup-mitmproxy', 09:59:02 INFO - 'run-tests'), 09:59:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:59:02 INFO - 'disable_ccov_upload': False, 09:59:02 INFO - 'download_minidump_stackwalk': True, 09:59:02 INFO - 'download_symbols': 'ondemand', 09:59:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:59:02 INFO - 'tooltool.py': '/tools/tooltool.py', 09:59:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:59:02 INFO - '/tools/misc-python/virtualenv.py')}, 09:59:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:59:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:59:02 INFO - 'gecko_profile': False, 09:59:02 INFO - 'gecko_profile_interval': 0, 09:59:02 INFO - 'installer_path': 'installer.exe', 09:59:02 INFO - 'log_level': 'info', 09:59:02 INFO - 'log_name': 'talos', 09:59:02 INFO - 'log_to_console': True, 09:59:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:59:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:59:02 INFO - 'opt_config_files': (), 09:59:02 INFO - 'pip_index': False, 09:59:02 INFO - 'suite': 'dromaeojs-e10s', 09:59:02 INFO - 'system_bits': '32', 09:59:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:59:02 INFO - 'title': 'talos-linux64-ix-015', 09:59:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:59:02 INFO - 'use_talos_json': True, 09:59:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:59:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:59:02 INFO - 'work_dir': 'build'} 09:59:02 INFO - [mozharness: 2017-07-16 16:59:02.682569Z] Running clobber step. 09:59:02 INFO - Running pre-action listener: _resource_record_pre_action 09:59:02 INFO - Running main action method: clobber 09:59:02 INFO - rmtree: /builds/slave/test/build 09:59:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:59:03 INFO - Running post-action listener: _resource_record_post_action 09:59:03 INFO - [mozharness: 2017-07-16 16:59:03.711115Z] Finished clobber step (success) 09:59:03 INFO - [mozharness: 2017-07-16 16:59:03.711218Z] Running read-buildbot-config step. 09:59:03 INFO - Running pre-action listener: _resource_record_pre_action 09:59:03 INFO - Running main action method: read_buildbot_config 09:59:03 INFO - Using buildbot properties: 09:59:03 INFO - { 09:59:03 INFO - "project": "", 09:59:03 INFO - "product": "firefox", 09:59:03 INFO - "who": "ffxbld@noreply.mozilla.org", 09:59:03 INFO - "installer_path": "public/build/target.tar.bz2", 09:59:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 09:59:03 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:59:03 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 09:59:03 INFO - "stage_platform": "linux64-stylosequential", 09:59:03 INFO - "basedir": "/builds/slave/test", 09:59:03 INFO - "buildnumber": 105, 09:59:03 INFO - "platform": "ubuntu64_hw_styloseq", 09:59:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:59:03 INFO - "slavebuilddir": "test", 09:59:03 INFO - "taskId": "PkfRMJJwScWoimVaXFlDDw", 09:59:03 INFO - "branch": "mozilla-central", 09:59:03 INFO - "script_repo_revision": "production", 09:59:03 INFO - "revision": "5f44d10bacca2d693413b529e0caadc73e634e1e", 09:59:03 INFO - "slavename": "talos-linux64-ix-015", 09:59:03 INFO - "repo_path": "mozilla-central" 09:59:03 INFO - } 09:59:03 INFO - Finding installer, test and symbols from parent task. 09:59:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PkfRMJJwScWoimVaXFlDDw'}, attempt #1 09:59:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PkfRMJJwScWoimVaXFlDDw'}, attempt #1 09:59:04 INFO - Task dependencies: BQEDOoXIQH6z0T86mY66Ow 09:59:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow'}, attempt #1 09:59:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.tar.bz2 09:59:05 INFO - Set test_url: https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/test_packages.json 09:59:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.crashreporter-symbols.zip 09:59:05 INFO - Running post-action listener: _resource_record_post_action 09:59:05 INFO - [mozharness: 2017-07-16 16:59:05.056505Z] Finished read-buildbot-config step (success) 09:59:05 INFO - [mozharness: 2017-07-16 16:59:05.056730Z] Running download-and-extract step. 09:59:05 INFO - Running pre-action listener: _resource_record_pre_action 09:59:05 INFO - Running main action method: download_and_extract 09:59:05 INFO - mkdir: /builds/slave/test/build/tests 09:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:05 INFO - trying https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.test_packages.json 09:59:05 INFO - Downloading https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:59:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:59:05 INFO - Downloaded 989 bytes. 09:59:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:59:05 INFO - Using the following test package requirements: 09:59:05 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:59:05 INFO - u'common': [u'target.common.tests.zip'], 09:59:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:59:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:59:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:59:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:59:05 INFO - u'mozbase': [u'target.common.tests.zip'], 09:59:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:59:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:59:05 INFO - u'web-platform': [u'target.common.tests.zip', 09:59:05 INFO - u'target.web-platform.tests.tar.gz'], 09:59:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:59:05 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:59:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.common.tests.zip 09:59:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:59:05 INFO - Fetch https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.common.tests.zip into memory 09:59:08 INFO - Content-Length response header: 72757742 09:59:08 INFO - Bytes received: 72757742 09:59:20 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:59:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.common.tests.zip 09:59:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:59:20 INFO - Fetch https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.common.tests.zip into memory 09:59:22 INFO - Content-Length response header: 72757742 09:59:22 INFO - Bytes received: 72757742 09:59:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.talos.tests.zip 09:59:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:59:35 INFO - Fetch https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.talos.tests.zip into memory 09:59:35 INFO - Content-Length response header: 14495033 09:59:35 INFO - Bytes received: 14495033 09:59: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')]} 09:59:36 INFO - trying https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.tar.bz2 09:59:36 INFO - Downloading https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:59:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:59:39 INFO - Downloaded 61890864 bytes. 09:59:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.tar.bz2 09:59:39 INFO - mkdir: /builds/slave/test/properties 09:59:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:59:39 INFO - Writing to file /builds/slave/test/properties/build_url 09:59:39 INFO - Contents: 09:59:39 INFO - build_url:https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.tar.bz2 09:59:39 INFO - Running post-action listener: _resource_record_post_action 09:59:39 INFO - Running post-action listener: set_extra_try_arguments 09:59:39 INFO - [mozharness: 2017-07-16 16:59:39.647678Z] Finished download-and-extract step (success) 09:59:39 INFO - [mozharness: 2017-07-16 16:59:39.647908Z] Running populate-webroot step. 09:59:39 INFO - Running pre-action listener: _resource_record_pre_action 09:59:39 INFO - Running main action method: populate_webroot 09:59:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:59:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:59:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:59:39 INFO - '--tppagecycles', 09:59:39 INFO - '7'], 09:59:39 INFO - 'tests': ['tsvgm']}}, 09:59:39 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:59:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:59:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:59:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:59:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:59:39 INFO - 'talos_options': ['--disable-e10s'], 09:59:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:59:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:59:39 INFO - 'talos_options': ['--disable-e10s'], 09:59:39 INFO - 'tests': ['damp', 'tps']}, 09:59:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:59:39 INFO - 'tests': ['damp', 'tps']}, 09:59:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:59:39 INFO - 'tests': ['dromaeo_dom']}, 09:59:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:59:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:59:39 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:59:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:59:39 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:59:39 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:59:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:59:39 INFO - 'tests': ['a11yr', 09:59:39 INFO - 'ts_paint', 09:59:39 INFO - 'tpaint', 09:59:39 INFO - 'sessionrestore', 09:59:39 INFO - 'sessionrestore_no_auto_restore', 09:59:39 INFO - 'tabpaint']}, 09:59:39 INFO - 'other-e10s': {'tests': ['a11yr', 09:59:39 INFO - 'ts_paint', 09:59:39 INFO - 'tpaint', 09:59:39 INFO - 'sessionrestore', 09:59:39 INFO - 'sessionrestore_many_windows', 09:59:39 INFO - 'sessionrestore_no_auto_restore', 09:59:39 INFO - 'tabpaint']}, 09:59:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:59:39 INFO - 'ts_paint', 09:59:39 INFO - 'tpaint', 09:59:39 INFO - 'sessionrestore', 09:59:39 INFO - 'sessionrestore_many_windows', 09:59:39 INFO - 'sessionrestore_no_auto_restore', 09:59:39 INFO - 'tabpaint']}, 09:59:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:59:39 INFO - 'ts_paint', 09:59:39 INFO - 'tpaint', 09:59:39 INFO - 'sessionrestore', 09:59:39 INFO - 'sessionrestore_many_windows', 09:59:39 INFO - 'sessionrestore_no_auto_restore', 09:59:39 INFO - 'tabpaint']}, 09:59:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:59:39 INFO - 'tests': ['a11yr', 09:59:39 INFO - 'ts_paint', 09:59:39 INFO - 'tpaint', 09:59:39 INFO - 'sessionrestore', 09:59:39 INFO - 'sessionrestore_no_auto_restore', 09:59:39 INFO - 'tabpaint']}, 09:59:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:59:39 INFO - 'tests': ['a11yr', 09:59:39 INFO - 'ts_paint', 09:59:39 INFO - 'tpaint', 09:59:39 INFO - 'sessionrestore', 09:59:39 INFO - 'sessionrestore_no_auto_restore', 09:59:39 INFO - 'tabpaint']}, 09:59:39 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 09:59:39 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 09:59:39 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 09:59:39 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:59:39 INFO - 'talos_options': ['--mitmproxy', 09:59:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:59:39 INFO - '--firstNonBlankPaint'], 09:59:39 INFO - 'tests': ['quantum_pageload_google', 09:59:39 INFO - 'quantum_pageload_youtube', 09:59:39 INFO - 'quantum_pageload_amazon', 09:59:39 INFO - 'quantum_pageload_facebook']}, 09:59:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:59:39 INFO - 'tests': ['tsvgx', 09:59:39 INFO - 'tsvgr_opacity', 09:59:39 INFO - 'tart', 09:59:39 INFO - 'tscrollx', 09:59:39 INFO - 'cart', 09:59:39 INFO - 'tsvg_static']}, 09:59:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:59:39 INFO - 'tsvgr_opacity', 09:59:39 INFO - 'tart', 09:59:39 INFO - 'tscrollx', 09:59:39 INFO - 'cart', 09:59:39 INFO - 'tsvg_static']}, 09:59:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:59:39 INFO - 'talos_options': ['--disable-e10s'], 09:59:39 INFO - 'tests': ['tp5o']}, 09:59:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:59:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:59:39 INFO - 'talos_options': ['--disable-e10s', 09:59:39 INFO - '--xperf_path', 09:59:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:39 INFO - 'tests': ['tp5n']}, 09:59:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:59:39 INFO - 'talos_options': ['--xperf_path', 09:59:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:39 INFO - 'tests': ['tp5n']}}, 09:59:39 INFO - 'talos.zip': {'path': '', 09:59:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:59:39 INFO - Running post-action listener: _resource_record_post_action 09:59:39 INFO - [mozharness: 2017-07-16 16:59:39.671684Z] Finished populate-webroot step (success) 09:59:39 INFO - [mozharness: 2017-07-16 16:59:39.671775Z] Running create-virtualenv step. 09:59:39 INFO - Running pre-action listener: _resource_record_pre_action 09:59:39 INFO - Running main action method: create_virtualenv 09:59:39 INFO - Creating virtualenv /builds/slave/test/build/venv 09:59:39 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 09:59:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:59:39 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:59:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:59:39 INFO - Using real prefix '/usr' 09:59:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:59:40 INFO - Installing distribute.............................................................................................................................................................................................done. 09:59:42 INFO - Installing pip.................done. 09:59:42 INFO - Return code: 0 09:59:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:59:42 INFO - Reading from file tmpfile_stdout 09:59:42 INFO - Output received: 09:59:42 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) 09:59:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:59:42 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')]} 09:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:42 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')]} 09:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:42 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 0x21be1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252cd00>, '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 0x252dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e090>, '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': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', '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 09:59:42 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 09:59:42 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 09:59:42 INFO - Using env: {'DISPLAY': ':0', 09:59:42 INFO - 'HOME': '/home/cltbld', 09:59:42 INFO - 'LANG': 'en_US.UTF-8', 09:59:42 INFO - 'LANGUAGE': 'en_US:en', 09:59:42 INFO - 'LOGNAME': 'cltbld', 09:59:42 INFO - 'MAIL': '/var/mail/cltbld', 09:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:42 INFO - 'MOZ_NO_REMOTE': '1', 09:59:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:42 INFO - 'NO_EM_RESTART': '1', 09:59:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:42 INFO - 'PWD': '/builds/slave/test', 09:59:42 INFO - 'SHELL': '/bin/bash', 09:59:42 INFO - 'SHLVL': '1', 09:59:42 INFO - 'TERM': 'linux', 09:59:42 INFO - 'TMOUT': '86400', 09:59:42 INFO - 'USER': 'cltbld', 09:59:42 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', 09:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:42 INFO - '_': '/tools/buildbot/bin/python'} 09:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:42 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 09:59:42 INFO - Cleaning up... 09:59:42 INFO - Return code: 0 09:59:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:59:42 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')]} 09:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:42 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')]} 09:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:42 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 0x21be1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252cd00>, '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 0x252dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e090>, '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': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', '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 09:59:42 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 09:59:42 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 09:59:42 INFO - Using env: {'DISPLAY': ':0', 09:59:42 INFO - 'HOME': '/home/cltbld', 09:59:42 INFO - 'LANG': 'en_US.UTF-8', 09:59:42 INFO - 'LANGUAGE': 'en_US:en', 09:59:42 INFO - 'LOGNAME': 'cltbld', 09:59:42 INFO - 'MAIL': '/var/mail/cltbld', 09:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:42 INFO - 'MOZ_NO_REMOTE': '1', 09:59:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:42 INFO - 'NO_EM_RESTART': '1', 09:59:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:42 INFO - 'PWD': '/builds/slave/test', 09:59:42 INFO - 'SHELL': '/bin/bash', 09:59:42 INFO - 'SHLVL': '1', 09:59:42 INFO - 'TERM': 'linux', 09:59:42 INFO - 'TMOUT': '86400', 09:59:42 INFO - 'USER': 'cltbld', 09:59:42 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', 09:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:42 INFO - '_': '/tools/buildbot/bin/python'} 09:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:42 INFO - Downloading/unpacking psutil>=3.1.1 09:59:42 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 09:59:42 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 09:59:42 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 09:59:42 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 09:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:59:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:44 INFO - Installing collected packages: psutil 09:59:44 INFO - Running setup.py install for psutil 09:59:44 INFO - building 'psutil._psutil_linux' extension 09:59:44 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 09:59:44 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 09:59:44 INFO - building 'psutil._psutil_posix' extension 09:59:44 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 09:59:44 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 09:59:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:44 INFO - Successfully installed psutil 09:59:44 INFO - Cleaning up... 09:59:44 INFO - Return code: 0 09:59:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:59:44 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')]} 09:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:44 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')]} 09:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:44 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 0x21be1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252cd00>, '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 0x252dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e090>, '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': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', '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 09:59:44 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 09:59:44 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 09:59:44 INFO - Using env: {'DISPLAY': ':0', 09:59:44 INFO - 'HOME': '/home/cltbld', 09:59:44 INFO - 'LANG': 'en_US.UTF-8', 09:59:44 INFO - 'LANGUAGE': 'en_US:en', 09:59:44 INFO - 'LOGNAME': 'cltbld', 09:59:44 INFO - 'MAIL': '/var/mail/cltbld', 09:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:44 INFO - 'MOZ_NO_REMOTE': '1', 09:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:44 INFO - 'NO_EM_RESTART': '1', 09:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:44 INFO - 'PWD': '/builds/slave/test', 09:59:44 INFO - 'SHELL': '/bin/bash', 09:59:44 INFO - 'SHLVL': '1', 09:59:44 INFO - 'TERM': 'linux', 09:59:44 INFO - 'TMOUT': '86400', 09:59:44 INFO - 'USER': 'cltbld', 09:59:44 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', 09:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:44 INFO - '_': '/tools/buildbot/bin/python'} 09:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:59:44 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 09:59:44 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 09:59:44 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 09:59:44 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 09:59:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:59:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:59:45 INFO - Installing collected packages: mozsystemmonitor 09:59:45 INFO - Running setup.py install for mozsystemmonitor 09:59:46 INFO - Successfully installed mozsystemmonitor 09:59:46 INFO - Cleaning up... 09:59:46 INFO - Return code: 0 09:59:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:59:46 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')]} 09:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:46 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')]} 09:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:46 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 0x21be1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252cd00>, '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 0x252dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e090>, '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': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', '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 09:59:46 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 09:59:46 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 09:59:46 INFO - Using env: {'DISPLAY': ':0', 09:59:46 INFO - 'HOME': '/home/cltbld', 09:59:46 INFO - 'LANG': 'en_US.UTF-8', 09:59:46 INFO - 'LANGUAGE': 'en_US:en', 09:59:46 INFO - 'LOGNAME': 'cltbld', 09:59:46 INFO - 'MAIL': '/var/mail/cltbld', 09:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:46 INFO - 'MOZ_NO_REMOTE': '1', 09:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:46 INFO - 'NO_EM_RESTART': '1', 09:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:46 INFO - 'PWD': '/builds/slave/test', 09:59:46 INFO - 'SHELL': '/bin/bash', 09:59:46 INFO - 'SHLVL': '1', 09:59:46 INFO - 'TERM': 'linux', 09:59:46 INFO - 'TMOUT': '86400', 09:59:46 INFO - 'USER': 'cltbld', 09:59:46 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', 09:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:46 INFO - '_': '/tools/buildbot/bin/python'} 09:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:46 INFO - Downloading/unpacking jsonschema==2.5.1 09:59:46 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 09:59:46 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 09:59:46 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 09:59:46 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 09:59:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:59:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:47 INFO - Downloading functools32-3.2.3-2.tar.gz 09:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:59:47 INFO - warning: no files found matching '*.txt' 09:59:47 INFO - no previously-included directories found matching 'build' 09:59:47 INFO - no previously-included directories found matching 'dist' 09:59:47 INFO - no previously-included directories found matching '.git*' 09:59:47 INFO - Installing collected packages: jsonschema, functools32 09:59:47 INFO - Running setup.py install for functools32 09:59:47 INFO - warning: no files found matching '*.txt' 09:59:47 INFO - no previously-included directories found matching 'build' 09:59:47 INFO - no previously-included directories found matching 'dist' 09:59:47 INFO - no previously-included directories found matching '.git*' 09:59:47 INFO - Successfully installed jsonschema functools32 09:59:47 INFO - Cleaning up... 09:59:48 INFO - Return code: 0 09:59:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:59:48 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')]} 09:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:48 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')]} 09:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:48 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 0x21be1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252cd00>, '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 0x252dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e090>, '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': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', '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 09:59:48 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 09:59:48 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 09:59:48 INFO - Using env: {'DISPLAY': ':0', 09:59:48 INFO - 'HOME': '/home/cltbld', 09:59:48 INFO - 'LANG': 'en_US.UTF-8', 09:59:48 INFO - 'LANGUAGE': 'en_US:en', 09:59:48 INFO - 'LOGNAME': 'cltbld', 09:59:48 INFO - 'MAIL': '/var/mail/cltbld', 09:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:48 INFO - 'MOZ_NO_REMOTE': '1', 09:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:48 INFO - 'NO_EM_RESTART': '1', 09:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:48 INFO - 'PWD': '/builds/slave/test', 09:59:48 INFO - 'SHELL': '/bin/bash', 09:59:48 INFO - 'SHLVL': '1', 09:59:48 INFO - 'TERM': 'linux', 09:59:48 INFO - 'TMOUT': '86400', 09:59:48 INFO - 'USER': 'cltbld', 09:59:48 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', 09:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:48 INFO - '_': '/tools/buildbot/bin/python'} 09:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:59:48 INFO - Cleaning up... 09:59:48 INFO - Return code: 0 09:59:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:59:48 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')]} 09:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:48 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')]} 09:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:48 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 0x21be1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252cd00>, '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 0x252dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e090>, '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': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', '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 09:59:48 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 09:59:48 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 09:59:48 INFO - Using env: {'DISPLAY': ':0', 09:59:48 INFO - 'HOME': '/home/cltbld', 09:59:48 INFO - 'LANG': 'en_US.UTF-8', 09:59:48 INFO - 'LANGUAGE': 'en_US:en', 09:59:48 INFO - 'LOGNAME': 'cltbld', 09:59:48 INFO - 'MAIL': '/var/mail/cltbld', 09:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:48 INFO - 'MOZ_NO_REMOTE': '1', 09:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:48 INFO - 'NO_EM_RESTART': '1', 09:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:48 INFO - 'PWD': '/builds/slave/test', 09:59:48 INFO - 'SHELL': '/bin/bash', 09:59:48 INFO - 'SHLVL': '1', 09:59:48 INFO - 'TERM': 'linux', 09:59:48 INFO - 'TMOUT': '86400', 09:59:48 INFO - 'USER': 'cltbld', 09:59:48 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', 09:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:48 INFO - '_': '/tools/buildbot/bin/python'} 09:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:48 INFO - Downloading/unpacking blobuploader==1.2.4 09:59:48 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 09:59:48 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 09:59:48 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 09:59:48 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 09:59:49 INFO - Downloading blobuploader-1.2.4.tar.gz 09:59:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:59:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:59:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:50 INFO - Downloading docopt-0.6.1.tar.gz 09:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:59:50 INFO - Installing collected packages: blobuploader, requests, docopt 09:59:50 INFO - Running setup.py install for blobuploader 09:59:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:59:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:59:50 INFO - Running setup.py install for requests 09:59:50 INFO - Running setup.py install for docopt 09:59:50 INFO - Successfully installed blobuploader requests docopt 09:59:50 INFO - Cleaning up... 09:59:50 INFO - Return code: 0 09:59:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:50 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 0x21be1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252cd00>, '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 0x252dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e090>, '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': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', '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 09:59:50 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 09:59:50 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 09:59:50 INFO - Using env: {'DISPLAY': ':0', 09:59:50 INFO - 'HOME': '/home/cltbld', 09:59:50 INFO - 'LANG': 'en_US.UTF-8', 09:59:50 INFO - 'LANGUAGE': 'en_US:en', 09:59:50 INFO - 'LOGNAME': 'cltbld', 09:59:50 INFO - 'MAIL': '/var/mail/cltbld', 09:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:50 INFO - 'MOZ_NO_REMOTE': '1', 09:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:50 INFO - 'NO_EM_RESTART': '1', 09:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:50 INFO - 'PWD': '/builds/slave/test', 09:59:50 INFO - 'SHELL': '/bin/bash', 09:59:50 INFO - 'SHLVL': '1', 09:59:50 INFO - 'TERM': 'linux', 09:59:50 INFO - 'TMOUT': '86400', 09:59:50 INFO - 'USER': 'cltbld', 09:59:50 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', 09:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:50 INFO - '_': '/tools/buildbot/bin/python'} 09:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:51 INFO - Running setup.py (path:/tmp/pip-RBPpwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:59:51 INFO - Running setup.py (path:/tmp/pip-F_qu7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:59:51 INFO - Running setup.py (path:/tmp/pip-kP9CVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:59:51 INFO - Running setup.py (path:/tmp/pip-8VoeK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:59:51 INFO - Running setup.py (path:/tmp/pip-l9Af46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:59:51 INFO - Running setup.py (path:/tmp/pip-7bZn19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:59:51 INFO - Running setup.py (path:/tmp/pip-ss_u5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:59:51 INFO - Running setup.py (path:/tmp/pip-99V8jU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:59:51 INFO - Running setup.py (path:/tmp/pip-NBX3Le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:59:51 INFO - Running setup.py (path:/tmp/pip-OsoJmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:59:51 INFO - Running setup.py (path:/tmp/pip-vnyTOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:59:51 INFO - Running setup.py (path:/tmp/pip-0acCNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:59:51 INFO - Running setup.py (path:/tmp/pip-pMdY4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:59:51 INFO - Running setup.py (path:/tmp/pip-szaGEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:52 INFO - Running setup.py (path:/tmp/pip-41fFJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:59:52 INFO - Running setup.py (path:/tmp/pip-Y0v3W5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:59:52 INFO - Running setup.py (path:/tmp/pip-96L48R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:59:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:59:52 INFO - Running setup.py install for manifestparser 09:59:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:59:52 INFO - Running setup.py install for mozcrash 09:59:52 INFO - Running setup.py install for mozdebug 09:59:52 INFO - Running setup.py install for mozdevice 09:59:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:59:52 INFO - Running setup.py install for mozfile 09:59:52 INFO - Running setup.py install for mozhttpd 09:59:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:59:52 INFO - Running setup.py install for mozinfo 09:59:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:59:52 INFO - Running setup.py install for mozInstall 09:59:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:59:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:59:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:59:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:59:53 INFO - Running setup.py install for mozleak 09:59:53 INFO - Running setup.py install for mozlog 09:59:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:59:53 INFO - Running setup.py install for moznetwork 09:59:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:59:53 INFO - Running setup.py install for mozprocess 09:59:53 INFO - Running setup.py install for mozprofile 09:59:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:59:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:59:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:59:53 INFO - Running setup.py install for mozrunner 09:59:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:59:53 INFO - Running setup.py install for mozscreenshot 09:59:53 INFO - Running setup.py install for moztest 09:59:53 INFO - Running setup.py install for mozversion 09:59:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:59:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:59:53 INFO - Cleaning up... 09:59:53 INFO - Return code: 0 09:59:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:54 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 0x21be1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252cd00>, '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 0x252dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e090>, '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': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', '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 09:59:54 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 09:59:54 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 09:59:54 INFO - Using env: {'DISPLAY': ':0', 09:59:54 INFO - 'HOME': '/home/cltbld', 09:59:54 INFO - 'LANG': 'en_US.UTF-8', 09:59:54 INFO - 'LANGUAGE': 'en_US:en', 09:59:54 INFO - 'LOGNAME': 'cltbld', 09:59:54 INFO - 'MAIL': '/var/mail/cltbld', 09:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:54 INFO - 'MOZ_NO_REMOTE': '1', 09:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:54 INFO - 'NO_EM_RESTART': '1', 09:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:54 INFO - 'PWD': '/builds/slave/test', 09:59:54 INFO - 'SHELL': '/bin/bash', 09:59:54 INFO - 'SHLVL': '1', 09:59:54 INFO - 'TERM': 'linux', 09:59:54 INFO - 'TMOUT': '86400', 09:59:54 INFO - 'USER': 'cltbld', 09:59:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', 09:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:54 INFO - '_': '/tools/buildbot/bin/python'} 09:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:54 INFO - Running setup.py (path:/tmp/pip-KNp78G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:59:54 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)) 09:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:59:54 INFO - Running setup.py (path:/tmp/pip-wG8k8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:59:54 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)) 09:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:59:54 INFO - Running setup.py (path:/tmp/pip-kqYuKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:59:54 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)) 09:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:59:54 INFO - Running setup.py (path:/tmp/pip-ul_mIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:59:54 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)) 09:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:59:54 INFO - Running setup.py (path:/tmp/pip-KqwqUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:59:54 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)) 09:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:59:54 INFO - Running setup.py (path:/tmp/pip-EVv7Dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:59:54 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)) 09:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:59:54 INFO - Running setup.py (path:/tmp/pip-8UxJAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:59:54 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)) 09:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:59:54 INFO - Running setup.py (path:/tmp/pip-5t8VT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:59:54 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)) 09:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:59:54 INFO - Running setup.py (path:/tmp/pip-ip6ZjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:59:54 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)) 09:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:59:54 INFO - Running setup.py (path:/tmp/pip-352qbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:59:54 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)) 09:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:59:54 INFO - Running setup.py (path:/tmp/pip-iPIpMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:59:55 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)) 09:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:59:55 INFO - Running setup.py (path:/tmp/pip-a37wsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:59:55 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)) 09:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:59:55 INFO - Running setup.py (path:/tmp/pip-o2kAul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:59:55 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)) 09:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:59:55 INFO - Running setup.py (path:/tmp/pip-KgCnyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:59:55 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)) 09:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:55 INFO - Running setup.py (path:/tmp/pip-Ty22TF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:55 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)) 09:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:59:55 INFO - Running setup.py (path:/tmp/pip-F7u0xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:59:55 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)) 09:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:59:55 INFO - Running setup.py (path:/tmp/pip-f9igqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:59:55 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)) 09:59:55 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)) 09:59:55 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)) 09:59:55 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)) 09:59:55 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)) 09:59:55 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)) 09:59:55 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)) 09:59:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:59:55 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 09:59:55 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 09:59:55 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 09:59:55 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 09:59:56 INFO - Downloading blessings-1.6.tar.gz 09:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:59:56 INFO - Installing collected packages: blessings 09:59:56 INFO - Running setup.py install for blessings 09:59:56 INFO - Successfully installed blessings 09:59:56 INFO - Cleaning up... 09:59:56 INFO - Return code: 0 09:59:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:59:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:59:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:59:57 INFO - Reading from file tmpfile_stdout 09:59:57 INFO - Current package versions: 09:59:57 INFO - argparse == 1.2.1 09:59:57 INFO - blessings == 1.6 09:59:57 INFO - blobuploader == 1.2.4 09:59:57 INFO - docopt == 0.6.1 09:59:57 INFO - functools32 == 3.2.3-2 09:59:57 INFO - jsonschema == 2.5.1 09:59:57 INFO - manifestparser == 1.1 09:59:57 INFO - mozInstall == 1.13 09:59:57 INFO - mozcrash == 1.0 09:59:57 INFO - mozdebug == 0.1 09:59:57 INFO - mozdevice == 0.51 09:59:57 INFO - mozfile == 1.2 09:59:57 INFO - mozhttpd == 0.7 09:59:57 INFO - mozinfo == 0.10 09:59:57 INFO - mozleak == 0.1 09:59:57 INFO - mozlog == 3.5 09:59:57 INFO - moznetwork == 0.27 09:59:57 INFO - mozprocess == 0.25 09:59:57 INFO - mozprofile == 0.28 09:59:57 INFO - mozrunner == 6.13 09:59:57 INFO - mozscreenshot == 0.1 09:59:57 INFO - mozsystemmonitor == 0.3 09:59:57 INFO - moztest == 0.8 09:59:57 INFO - mozversion == 1.4 09:59:57 INFO - psutil == 3.1.1 09:59:57 INFO - requests == 1.2.3 09:59:57 INFO - wsgiref == 0.1.2 09:59:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:57 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 0x21be1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252cd00>, '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 0x252dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e090>, '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': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', '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 09:59:57 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 09:59:57 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 09:59:57 INFO - Using env: {'DISPLAY': ':0', 09:59:57 INFO - 'HOME': '/home/cltbld', 09:59:57 INFO - 'LANG': 'en_US.UTF-8', 09:59:57 INFO - 'LANGUAGE': 'en_US:en', 09:59:57 INFO - 'LOGNAME': 'cltbld', 09:59:57 INFO - 'MAIL': '/var/mail/cltbld', 09:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:57 INFO - 'MOZ_NO_REMOTE': '1', 09:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:57 INFO - 'NO_EM_RESTART': '1', 09:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:57 INFO - 'PWD': '/builds/slave/test', 09:59:57 INFO - 'SHELL': '/bin/bash', 09:59:57 INFO - 'SHLVL': '1', 09:59:57 INFO - 'TERM': 'linux', 09:59:57 INFO - 'TMOUT': '86400', 09:59:57 INFO - 'USER': 'cltbld', 09:59:57 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', 09:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:57 INFO - '_': '/tools/buildbot/bin/python'} 09:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:57 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)) 09:59:57 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)) 09:59:57 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)) 09:59:57 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)) 09:59:57 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)) 09:59:57 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)) 09:59:57 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)) 09:59:57 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)) 09:59:57 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)) 09:59:57 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:58 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:59:58 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 09:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:59:58 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)) 09:59:58 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)) 09:59:58 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)) 09:59:58 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)) 09:59:58 INFO - Installing collected packages: marionette-driver, simplejson 09:59:58 INFO - Running setup.py install for marionette-driver 09:59:58 INFO - Running setup.py install for simplejson 09:59:58 INFO - building 'simplejson._speedups' extension 09:59:58 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 09:59:59 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 09:59:59 INFO - Successfully installed marionette-driver simplejson 09:59:59 INFO - Cleaning up... 09:59:59 INFO - Return code: 0 09:59:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21be1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x252fb60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x252cd00>, '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 0x252dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e090>, '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': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', '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 09:59:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:59:59 INFO - Using env: {'DISPLAY': ':0', 09:59:59 INFO - 'HOME': '/home/cltbld', 09:59:59 INFO - 'LANG': 'en_US.UTF-8', 09:59:59 INFO - 'LANGUAGE': 'en_US:en', 09:59:59 INFO - 'LOGNAME': 'cltbld', 09:59:59 INFO - 'MAIL': '/var/mail/cltbld', 09:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:59 INFO - 'MOZ_NO_REMOTE': '1', 09:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:59:59 INFO - 'NO_EM_RESTART': '1', 09:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:59 INFO - 'PWD': '/builds/slave/test', 09:59:59 INFO - 'SHELL': '/bin/bash', 09:59:59 INFO - 'SHLVL': '1', 09:59:59 INFO - 'TERM': 'linux', 09:59:59 INFO - 'TMOUT': '86400', 09:59:59 INFO - 'USER': 'cltbld', 09:59:59 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', 09:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:59 INFO - '_': '/tools/buildbot/bin/python'} 10:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:00:00 INFO - Cleaning up... 10:00:00 INFO - Return code: 0 10:00:00 INFO - Running post-action listener: _resource_record_post_action 10:00:00 INFO - Running post-action listener: _start_resource_monitoring 10:00:00 INFO - Starting resource monitoring. 10:00:00 INFO - [mozharness: 2017-07-16 17:00:00.099996Z] Finished create-virtualenv step (success) 10:00:00 INFO - [mozharness: 2017-07-16 17:00:00.100506Z] Running install step. 10:00:00 INFO - Running pre-action listener: _resource_record_pre_action 10:00:00 INFO - Running main action method: install 10:00:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:00 INFO - Reading from file tmpfile_stdout 10:00:00 INFO - Detecting whether we're running mozinstall >=1.0... 10:00:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:00:00 INFO - Reading from file tmpfile_stdout 10:00:00 INFO - Output received: 10:00:00 INFO - Usage: mozinstall [options] installer 10:00:00 INFO - Options: 10:00:00 INFO - -h, --help show this help message and exit 10:00:00 INFO - -d DEST, --destination=DEST 10:00:00 INFO - Directory to install application into. [default: 10:00:00 INFO - "/builds/slave/test"] 10:00:00 INFO - --app=APP Application being installed. [default: firefox] 10:00:00 INFO - mkdir: /builds/slave/test/build/application 10:00:00 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'] 10:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:00:18 INFO - Reading from file tmpfile_stdout 10:00:18 INFO - Output received: 10:00:18 INFO - /builds/slave/test/build/application/firefox/firefox 10:00:18 INFO - Running post-action listener: _resource_record_post_action 10:00:18 INFO - [mozharness: 2017-07-16 17:00:18.927137Z] Finished install step (success) 10:00:18 INFO - [mozharness: 2017-07-16 17:00:18.927391Z] Running setup-mitmproxy step. 10:00:18 INFO - Running pre-action listener: _resource_record_pre_action 10:00:18 INFO - Running main action method: setup_mitmproxy 10:00:18 INFO - Skipping: mitmproxy is not required 10:00:18 INFO - Running post-action listener: _resource_record_post_action 10:00:18 INFO - [mozharness: 2017-07-16 17:00:18.928540Z] Finished setup-mitmproxy step (success) 10:00:18 INFO - [mozharness: 2017-07-16 17:00:18.928764Z] Running run-tests step. 10:00:18 INFO - Running pre-action listener: _resource_record_pre_action 10:00:18 INFO - Running pre-action listener: _set_gcov_prefix 10:00:18 INFO - Running main action method: run_tests 10:00:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:00:18 INFO - Python 2.7.3 10:00:18 INFO - Return code: 0 10:00:18 INFO - grabbing minidump binary from tooltool 10:00:18 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')]} 10:00:18 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 0x252cd00>, '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 0x252dc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x252e090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:00:18 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 10:00:18 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 10:00:18 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 10:00:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:00:19 INFO - Return code: 0 10:00:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:00:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:00:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:00:19 INFO - ENV: RUST_BACKTRACE is now 1 10:00:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:00:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:00:19 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/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 10:00:19 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/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 10:00:19 INFO - Using env: {'DISPLAY': ':0', 10:00:19 INFO - 'HOME': '/home/cltbld', 10:00:19 INFO - 'LANG': 'en_US.UTF-8', 10:00:19 INFO - 'LANGUAGE': 'en_US:en', 10:00:19 INFO - 'LOGNAME': 'cltbld', 10:00:19 INFO - 'MAIL': '/var/mail/cltbld', 10:00:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:00:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:19 INFO - 'MOZ_NO_REMOTE': '1', 10:00:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:19 INFO - 'NO_EM_RESTART': '1', 10:00:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:19 INFO - 'PWD': '/builds/slave/test', 10:00:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:00:19 INFO - 'RUST_BACKTRACE': '1', 10:00:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:00:19 INFO - 'SHELL': '/bin/bash', 10:00:19 INFO - 'SHLVL': '1', 10:00:19 INFO - 'TERM': 'linux', 10:00:19 INFO - 'TMOUT': '86400', 10:00:19 INFO - 'USER': 'cltbld', 10:00:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727', 10:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:19 INFO - '_': '/tools/buildbot/bin/python'} 10:00:19 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/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 10:00:19 INFO - mozversion application_buildid: 20170716161811 10:00:19 INFO - mozversion application_changeset: 5f44d10bacca2d693413b529e0caadc73e634e1e 10:00:19 INFO - mozversion application_display_name: Nightly 10:00:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:00:19 INFO - mozversion application_name: Firefox 10:00:19 INFO - mozversion application_remotingname: firefox 10:00:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:00:19 INFO - mozversion application_vendor: Mozilla 10:00:19 INFO - mozversion application_version: 56.0a1 10:00:19 INFO - mozversion platform_buildid: 20170716161811 10:00:19 INFO - mozversion platform_changeset: 5f44d10bacca2d693413b529e0caadc73e634e1e 10:00:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:00:19 INFO - mozversion platform_version: 56.0a1 10:00:19 INFO - using testdate: 1500224419 10:00:19 INFO - actual date: 1500224419 10:00:19 INFO - starting webserver on 'localhost:34244' 10:00:19 INFO - SUITE-START | Running 2 tests 10:00:19 INFO - TEST-START | dromaeo_css 10:00:19 INFO - Initialising browser for dromaeo_css test... 10:00:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34244/getInfo.html -profile /tmp/tmpmlU0Lr/profile 10:00:19 INFO - TEST-INFO | started process 20785 (/builds/slave/test/build/application/firefox/firefox http://localhost:34244/getInfo.html) 10:00:25 INFO - TEST-INFO | 20785: exit 0 10:00:25 INFO - Browser initialized. 10:00:25 INFO - Running cycle 1/1 for dromaeo_css test... 10:00:25 INFO - TEST-INFO | started process 21007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmlU0Lr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:00:36 INFO - PID 21007 | RSS: Main: 169762816 10:00:36 INFO - PID 21007 | 10:03:34 INFO - PID 21007 | Cycle 1(1): loaded http://localhost:34244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34244/tests/dromaeo/cssquery-ext.html) 10:03:36 INFO - PID 21007 | RSS: Main: 177430528 10:03:36 INFO - PID 21007 | 10:06:38 INFO - PID 21007 | Cycle 1(1): loaded http://localhost:34244/tests/dromaeo/cssquery-ext.html (next: http://localhost:34244/tests/dromaeo/cssquery-jquery.html) 10:06:38 INFO - PID 21007 | RSS: Main: 175919104 10:06:38 INFO - PID 21007 | 10:09:40 INFO - PID 21007 | Cycle 1(1): loaded http://localhost:34244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34244/tests/dromaeo/cssquery-mootools.html) 10:09:41 INFO - PID 21007 | RSS: Main: 178720768 10:09:41 INFO - PID 21007 | 10:12:42 INFO - PID 21007 | Cycle 1(1): loaded http://localhost:34244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34244/tests/dromaeo/cssquery-prototype.html) 10:12:43 INFO - PID 21007 | RSS: Main: 175534080 10:12:43 INFO - PID 21007 | 10:15:46 INFO - PID 21007 | Cycle 1(1): loaded http://localhost:34244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34244/tests/dromaeo/cssquery-yui.html) 10:15:47 INFO - PID 21007 | RSS: Main: 177025024 10:15:47 INFO - PID 21007 | 10:18:49 INFO - PID 21007 | Cycle 1(1): loaded http://localhost:34244/tests/dromaeo/cssquery-yui.html (next: http://localhost:34244/tests/dromaeo/cssquery-dojo.html) 10:18:49 INFO - PID 21007 | RSS: Main: 180166656 10:18:49 INFO - PID 21007 | 10:18:49 INFO - PID 21007 | __start_tp_report 10:18:49 INFO - PID 21007 | _x_x_mozilla_page_load 10:18:49 INFO - PID 21007 | _x_x_mozilla_page_load_details 10:18:49 INFO - PID 21007 | |i|pagename|runs| 10:18:49 INFO - PID 21007 | |0;dojo.html;3003.3993201359735;3036.073997430784;3065.632124145103;3065.8773649054033;3109.098361475171;5827.796027139046;5880.794172203963;5932.110183472481;5950.404959504048;5959.195508606337;5925.377835327293;5939.376365481617;5972.6117802342815;5975;5976.910346344808;5487.890242195173;5497.890042199154;5505.174223866422;5513.807016754415;5536.861578460531;5491.093969495028;5492.258545096421;5502.202180683798;5505.119180931052;5508.91736623951;5492.203630473579;5513.09034009388;5515.834524964257;5518.392976772552;5521.089020311644;5507.118860982244;5509.641873278224;5511.3937466878615;5532.474414930595;5535.418781028015;5470.890582188334;5499.422560631157;5514.283143191399;5536.667799932017;5545.223668686387;5987.37132601075;5989.3711160327975;6047.606905551125;6057.575969682124;6074.362191969868;6186.072089186613;6323.083152942843;6388.872222555523;6406.263279722845;6465.094886715863;6395.648239346834;6408.67956602168;6418.518611104139;6437.259715132726;6458.2895881453005;5938.138969849348;5940.435658612425;5942.346341902387;5943.3462319144855;5949.405059494059;5564.582656300794;6474.902876456904;6529.575577587441;6556.147700798961;6637.634930078795;6210.441060304594;6245.313015568284;6363.490920726424;6374.043893415932;6383.329750376237;6175.44421002103;6349.55553111287;6361.840953976188;6425.036244563353;6434.517411194179;6083.11794789753;6150.169727086875;6155.96922015396;6417.935820641827;6423.100765892778;6259.593126446857;6289.182406287245;6304.527160462983;6308.369163083655;6349.015902535114;5075;5107.233914912793;5162.251473536317;5188.195829646411;5208.348956380452;4372.978135109368;4385.846495372711;4402.273624851863;4402.515723270438;4404.66964977628;5476.452354764491;5496.945030549723;5510.393856675762;5514.28314319144;5516.613837031369;6333.493320534346;6339.207599050119;6356.523260755462;6368.936310636927;6383.744650214032;5458.590605704509;5478.534324582375;5478.561715062785;5530.225768392428;5599.216109744639;5603.7478313475995;5619.100943848965;5694.572907031989;5694.743736531783;5700.087985922232;6039.969800150971;6112.51099912006;6125.601835880653;6143.047827586731;6170.753169873245;6212.751489940351;6274.780382686584;6278.497720182283;6291.056341548804;6300.684965751786;6033.155358249936;6088.360722124113;6101.237345331833;6103.23709536308;6103.42017508336;5192.350956130484;6283.7800676976085;6379.043143528508;6380.87238255223;6385.68071596409;6388.520860935541;6431.196100487439;6450.8064758057335;6501.44737697301;6515.087887695631;6116.235470566179;6228.56400051992;6296.653684047421;6316.652584107735;6337.683115844282;6189.7833575826435;6194.628322300677;6208.689565521616;6222.408871157233;6226.813195604139;6120.816375508742;6133.110698948538;6133.754649813957;6158.04550294705;6167.784127555514;6198.163247961467;6218.782342617987;6241;6280.937190628035;6374.4900407966325;6071.544634152545;6086.939130608637;6131.019036954066;6148.1085242640465;6153.84615384619 10:18:49 INFO - PID 21007 | |1;ext.html;843.1399972028531;892.4422236102438;1146.6445401925403;1167.078008373385;1173.4953969792984;30682.846585767067;37509.624903750955;38089.42865857014;41887.79056104723;42244.36633450501;42940.57059429405;43336.783316083456;43364.56635433645;43445;43600.56399436005;7572.053493313336;7646.235376462365;7648.0822301323915;7665.118511371208;7696.615169241543;7581.317681408672;7680.884786728176;7682.577458239794;7689.615519224017;7696;7575.583342916138;7645.388368930472;7712.5372477651235;7748.41886858485;7748.922510774876;7583.658735356922;7704.26809453101;7709.614519274014;7716.074071111502;7716.189800070996;7514.286142816423;7532.284432978859;7552.5846078465665;7606.619669016527;7613.0483689538805;39090.21819563621;39289.41065884014;39354.21291574181;39367.60632393668;39393.212135757414;3586.1214002569277;3621.89134325968;3625.4380571011534;3626.3110009098186;3628.8911332660064;30531.69468305333;30810.53784193239;30875.073747787603;30892.382152356826;30948;4859.88222708779;4884.633652476078;4926.2364333528;4927.457979622239;5024.522670346311;216785;219399;219500.9024954865;220005;220030;49219;49410.258846117336;49840;49847.50152498501;49903;44151.77924110359;45117;45134.09731805346;50631;50646;14157.221352825487;15909.284082216329;16152.515424537283;16300.10349430769;16341.428050018192;13498.055136140376;13538.390772415265;13544.390502427414;13550.254735989418;13558.050936434553;14133.858661413255;14279.57161285163;14471.710565788626;14514.927425362806;14533.34599943005;5673.886522269614;5757.553039958001;5770.13447982806;5781.161731548986;5895.67573783446;984.9064338887795;997.7954519323521;1002.2433063037506;1022.7136401807505;1039.594558122333;22712.41013129065;23080.19219327349;23114.075436982333;23698.526029479657;24195.879020604785;1072.3565860483802;1099.8075336816025;1101.1081024370285;1115.9274647147909;1124.0726400719275;12378.938105309597;12442.129050966345;12506.81239781404;12521.37393130358;12591.24452532851;227335;227462;227689;229412;230291;54523;54634.726826365615;54638.72680636651;54701.45298547043;54863.72568137134;1419.8722115009698;1467.530390275123;1491.6270932266934;1497.101738956639;1498.7452133137392;23050.308490745305;23071.307860764206;23674.053037878293;27165.320866978484;27838.86080569584;52474.47525524696;52939.470605293456;52996.4700353007;53133.734331328094;53472.197917032056;200448;200853;203105;204445;205264;32031;36312.63687363092;36469.635303646624;36588;36842.263154737295;45383.7730811357;47155;48318.27522587234;48483.75758121187;49205.50794492009;33454.83272583621;33529.83235083809;34239.315213696085;34523.30953380968;34615.30769384649;33256.334873301916;33600.49599255964;33861.49207761935;33911.660883391836;34105.829470852485;36799.264014720095;38011.42982855204;38194.23611527698;38483.230335392574;39070.4139437903;32431;32632.184195395304;32836.83581582077;32905;33377.16557085995;23156;23986.640200397356;24490.285680002227;24508.26475205747;24630.753692462848 10:18:49 INFO - PID 21007 | |2;jquery.html;561.6209058885252;567.6026781253124;573.8278516445065;575.8099827057072;588.6232811000958;20852.061657225422;21801;22046.559068818653;22072.558548829013;22202;18703.719444208313;19583.216671333128;19692.409227723154;19737.11182996765;20030.29893953712;3904.414337849317;4003.219372222418;6374.840628984266;6381.617102973813;6385.553011289212;6261.092141639459;6374.872502549946;6379.585326953733;6402.775902843401;6415.422611964922;6329.303776584572;6354.396332348442;6359.20509936258;6361.4274715275615;6363.204599425072;6331.145295385133;6332.208473940757;6335.144755458024;6340.746370145189;6342.143810585558;5358.383785864637;5669.858253543694;5897.4692277694785;5918.526517878559;5922.466977972003;28112.718872811216;28605.427891442054;28666.283342916384;28670;28705.856470717514;1895.3176856331709;1915.6456055629753;1923.6729755941383;1923.7595300587286;1925.7881633020356;16932.746008809878;17790.110494475226;18078.367257145936;18098;18194.545136371566;2242.39455347057;2291.0606651272897;2315.455867871049;2316.0388438797877;2318.374039009458;118686.40656796747;125429;125654.48691026129;127935;141961;18957.1990660887;20359.69460458094;20629.58740825175;21607.891960540095;21740.239091632033;43242.56757432449;43425;43544.34683479751;43686.344704829455;43704.81475926255;11472.713182170513;11489.253198542068;11594.942025289989;11638.534458621729;11688.415579221006;9578.616855325708;9584.233261339075;9608.75978100539;9793.853092203623;9826.771653543306;10849.403282819363;11156;11273.605423810128;11404.429778511041;11440.370779607036;3555.4133567961;4096.549379568245;4118.979405103015;4152.854650087233;4205.810738516774;916.6699988004314;932.1098351074708;955.7706150523964;965.1410244882061;988.4069558264983;19029.333973311146;19270.32553860608;19272.80727192738;19284.939328336797;19412.417627470917;996.7159359582485;1003.3929472669076;1031.8400647899587;1037.1339931157418;1048.8688913885765;10397.53211105487;10657.57369705203;10663;10788.08301294383;10803.513841877135;454077;457825;470845;473587;473944;100095.49952250192;101345;102270;102446;103289;1110.3448965110463;1132.0603898764007;1148.3970915269383;1193.9999999999827;1230.2065167966612;19166.945817980144;19391.612167756284;19468.48081440866;19714.60570788605;20121;55571;56457;56916.71541642265;57455.42544574668;58016.41983580279;70367;70616.29383706098;71942.28057719565;72493.637531812;73124;19857.801421985594;20082.19671213135;20090.59818803645;20207.59584808325;20352.18591256333;21957.121715131216;22405.439864002878;22422.439439014157;22557.887210563844;22660.206892758673;17498.475045748648;17532.474025779247;17778.733318999966;17843.464696059138;17847.286108555512;14054.929725351309;15167.848321516643;15310.540683779505;15500.84499154994;16023.919880400523;18077.27690892402;18480.445586632424;19519.316823911096;19528.31650892212;19600.411987640393;14439.133651980916;14714.337854796346;14716.411343546139;14728.042677226375;14755.631109222355;17283;18306;18362.72455913189;18473.53816154553;18565.44303670892 10:18:49 INFO - PID 21007 | |3;mootools.html;1325.0790700463178;1367.0703921333488;1374.7319272741806;1379.910305830121;1380.6065271397654;13073.477060917563;13645.522406715767;13673.453061877526;13703.862961370383;13732.038757286993;13224.603261902133;13715.108517946326;13780.173189608631;13830.23933683647;13890.305484725774;2524.9999999999955;2545.9490810183784;2571.742825717432;2577.265479338389;2580.716121226673;2353.9293821185306;2382.475855311837;2410.192585483865;2413.5655581995234;2414.95170096598;2215.4350640586626;2405.482821193443;2438.4391589934326;2500.274920273119;2502.9749702503013;2294.4493321602777;2299.2642354446584;2509.4855554611263;2600.0509813917974;2607.5827867541293;2586.4697736963876;2587.3660953066433;2596.260065881215;2607.282997175773;2608.4000679843552;13539.11995720275;13699.109557878706;13706.52027179044;13717.45130194791;13754.862451375458;7137.571745695275;7474.327310542078;7496.175420703718;7538.509996850242;7539.321461068475;4988.226824842155;5232;5359.410464848864;5368.70472124033;5381.13901775714;1807.2138619700472;1844;1876.3245231716571;1910.0449775112443;1913.4642300155979;22013;22061.779382206132;22140.778592213872;22213.111475540958;22239.666405003936;6090.847728806815;6207.875842483125;6228.377162283736;6380.84047898797;6384.904226436607;15555.688886222211;15585.142817145166;15687.215639217993;15692.92153539225;15735.921320393554;7132.500724949204;7309.378702810214;7326.706931722778;7326.853462930818;7327.267273272737;6671.466282697373;6690.397864192246;6781.559198652072;6808.523403361816;6880.552764070319;4650.9767451162525;4808.134535783523;4822.879428014257;4855.975720121377;4954.108260513142;1364.5087768403366;1366.8154799102192;1382.5690410425161;1386.0574809129687;1393.5819254223693;881.8633111867671;883.2492381475822;916.5508900638639;922.1193759959223;928.3919033033374;6956.339147780953;7095.716171353088;7102.715891364391;7110.680019399036;7117.4306055515435;720.4488566246825;722.4545468171602;731.2979539641897;734.3904559215838;736.9520981136209;4348.195583816941;4756.7145971241835;4965.702057876467;4991.800327986913;5110.642255042186;17361.82638173602;18136.183871725803;18319.084045797656;18370;18385.08074596265;16837.747433788503;17997.910010449865;18095.63808723818;18225.362112326005;18329.90835045816;9493.810123797486;9773.560189791477;9797.706068817946;9801.803963920682;9837.704868854089;7269.818254543467;7680.654370553227;7719.884201736866;7772.45592808498;7944.523328600302;15366.154861482726;15521.922390387976;15712.29294681765;16013.439529616408;16884.746728799324;15899.761503577687;16163;16709;16897.746533801757;17282.481525554253;11156.721081972692;11359.602413915472;11414.372209528223;11414.885851141382;11421.428928553705;12808.423620937267;12914.67713307175;12993.935030324788;13098.345082745634;13167.341632918124;10354.792904141725;10368.533415996148;10431.68704938853;10672.252942293964;10743.516541755484;9193.402428842104;9778.9022109778;9864.408135511892;9913.355631883904;10265.178785697275;8777.42946708462;8983.281337492854;9120.589573469342;9198.862017069616;9283.350165488351;6855.211650660238;6936.895946560705;7105.32499412555;7121.8575628486105;7163.928360716326;6846.938724497711;7022.297770222936;7056.894146587908;7171.99592057102;7195.064641596559 10:18:49 INFO - PID 21007 | |4;prototype.html;489.6963784904279;500.5534006720576;512.3288492075379;520.378148113005;529.2881074954186;6102.664353460558;6104.114903339018;6109.938900610992;6136.693165341726;6173.166622505966;5862.912056319148;6040.1241819936195;6062.636241825494;6065.454109130177;6072.180255665484;4849.321095046696;4864.805407783684;4903.975480122604;4914.827981020665;4943.382077240345;4851.684640498374;4857.927131093036;4867.269909513584;4868.732219727914;4898.534639209287;4842.539958703936;4904.435989861176;4906.950930490685;4911.287863259825;4916.582090522292;4602.516735742733;4618.930716039245;4839.951600483985;4844.619283504219;4859.149648811479;4342.242675900794;4367.67242456817;4384.934225986613;4386.342048692722;4418.182636212311;5923.911141332884;5939.0104315054505;5952.226210592638;5973.850653733648;5985.281766188042;5559.583031272671;5578.330600327946;5582.8325150245555;5585.329760428734;5592.161175823619;6370.299267080617;6413.230412350501;6415.935840641627;6430.903536446957;6447.742090316382;4802.735849528274;4816.61467082636;4820.228763397875;4839.564439200489;4847.51524847516;6684.665766711645;6750.527463077587;6761.932380676229;6767.796966091025;6819.896946889154;4946.678465899705;4946.802127914843;4955;4956.653034287565;4957;4999.800007999639;5005.774740136702;5011.5489605935645;5015.172496538104;5018.824341148043;5532.585056120807;5558.360788509373;5562.638428502134;5576.414476479992;5584.692841893653;6379;6391.936080639227;6395.360463953661;6433.228012638513;6440.452561532322;1717.2444124585143;1734.1415999080536;1740.5387572293353;1740.5561581796815;1744.6336269383319;1114.8439218509416;1208.3293771956473;1217.4947396830216;1224.9693757655953;1232.5069972011268;5448.237246785453;5479;5514.834554963358;5581.916271255935;5611.382747897728;6538.248101468392;6576.487407896115;6601.392449982231;6601.834954126185;6609.570377925419;5534.418886016911;5598.412166722435;5623.2408624835125;5630;5656.179853921159;3465.3415850988736;3478.1652403422995;3479.530263414407;3504.807235602066;3505.94741078884;6336.58812177207;6373.681315934277;6376.162607639649;6376.39424254695;6399.552031357854;6758.628275444898;6765.661716914135;6766.966165169241;6787;6813.797515167863;6310.968445157745;6408.4232419080645;6424.3254458282145;6424.646644434601;6446.903296450557;6556.508791477853;6603.9009414859775;6633.535652504278;6634.635095069818;6660.766873159416;6402.967985160044;6443.260319713745;6496.447801936888;6543.672816359258;6546;6288.968555157195;6369.363063693593;6379.202599675041;6416.48726542569;6420.807375778734;4864.902701946012;4875.68308059975;4877.6585639004925;4893.926591101207;4905.926411103765;6531.477481801349;6544.312847151171;6609.339066093352;6624.138861947916;6631.137952066393;6273.309935906956;6358.364163583789;6425.678716064272;6428.132202152649;6438.229486891142;6299.212598425197;6334.809955701337;6375.74497020114;6424.293327734039;6445.742170313135;6213.347598502273;6302.180716507009;6318.368163183645;6328.493720502441;6341.451230173598;5860.890079571436;6291.339409361951;6294.5593808434805;6330.841728956813;6364.872702546016;6033.8535678221;6040.731446396306;6074;6115.327313995368;6171.797343669583 10:18:49 INFO - PID 21007 | |5;yui.html;911.8130783189445;928.262031684811;938.0525669074233;943.4433684126373;944.3153713557667;17378.391756288533;17574.82425175748;17596.64806703865;17597;18464.353747618836;18139.183736731844;18925.148368323426;19500.41498755036;19612.215511379527;19676.9016154919;1037.974050648736;1048.6172547020321;1053.7049626104665;1053.7365658585354;1053.9947300263489;1024.6772266735954;1026.4611079183414;1029.5933106422958;1032.6179313653959;1061.522314958268;1102.9613963511279;1110.2505808579217;1110.5835311758092;1113.4265853085667;1114.921955463118;1060.5280650110703;1064.239069065614;1064.8136576099153;1067.1729409707461;1070.5022164693455;779.0378882080626;780.1613265739296;783.5533745764916;792.8097256658418;816.6978218059356;17066.146692665316;17217.139143042798;17400.390986315546;17437.7384339235;17520.474385768448;19584;19953.900230498755;20039.89980050105;20105.195792168295;20241.190352385885;15865.52403427899;15879.920600396925;15948.2823272953;15957;16017.599560010976;3476.9304613907834;3503.474478828196;3611.4402267648557;3639.290338384016;3645;110504;110655.44672276668;113741.86258137395;114469.42765286204;115844.42077789558;16204.67590648204;16514.58713532171;16551.420700275434;16588.170591470378;16679.583010424838;27338;28805.27986800347;29202.707972919998;29355;29511.55732664012;8596.699115530926;8607.526586037828;8642.697505587274;8680.609372578248;8727.258183054384;3969.761814291094;3977.6817854572146;4095.6313931746286;4106.2198182345255;4149.481314835645;4909.828156014522;4981.178105612606;4996.475370086161;5004.699718016931;5027.421846487628;1009.8687170667913;1019.836826107834;1042.635077722791;1051.6844946516014;1066.7546464313252;584.9500147235638;661.4708233413251;670.7752902777527;680.4862328941716;698.3784431855653;11392.943035284936;11576.826347604792;11962.265471506584;12187.573434929735;12438.440270187863;657.3262406033854;669.5146019136088;680.0581195044898;684.94177994871;701.487913822902;4835.8065677373215;4968.378952630921;4989.05645669057;5021.6735912165595;5125.641205115606;104015;105603;107214.46392767986;107643;109396.453017736;92597.07402925885;93479;93666;95424.52287738517;96744;77661.61169194117;79136;81274;81457.59271203606;81461;10368.274220804471;10386.376817390981;10520.947905209723;10566.101881340172;10829.133669306595;35770.64229357673;36628.81685591555;37145.44281835721;37654.2469150621;38105;47015;47929.86534921938;48669.756651216514;49392.753036234586;49754.751226243636;15058.322375493348;15526.534203973899;15644.92177539105;15760.975536590086;15919.840801591836;14720.38206747808;15454.690906181588;15526.301316440562;15535.922320388325;15835.208239588204;15395;15474.84525154734;15666.451674191349;15915.363385464452;19984;17950.461486155436;18514.907425462785;18674.06629668484;18681.06594670234;20904.37286881396;17519.47441576755;18521.72217416767;18743.625127497646;19444.805551944864;19489.220431182595;13161.210327380388;13347.733045339233;13493;13653.795193071914;13994.000865546908;13369.26469044212;13617.31913404306;13803.861961380258;13916.721665566834;13928.442862285396 10:18:49 INFO - PID 21007 | __end_tp_report 10:18:49 INFO - PID 21007 | __start_cc_report 10:18:49 INFO - PID 21007 | _x_x_mozilla_cycle_collect,351 10:18:49 INFO - PID 21007 | __end_cc_report 10:18:49 INFO - PID 21007 | __startTimestamp1500225529319__endTimestamp 10:18:49 INFO - PID 21007 | 10:18:49 INFO - PID 21007 | ------- Summary: start ------- 10:18:49 INFO - PID 21007 | Number of tests: 6 10:18:49 INFO - PID 21007 | 10:18:49 INFO - PID 21007 | [#0] dojo.html Cycles:165 Average:5861.07 Median:6088.36 stddev:677.76 (11.1%) stddev-sans-first:641.70 10:18:49 INFO - PID 21007 | Values: 3003.4 3036.1 3065.6 3065.9 3109.1 5827.8 5880.8 5932.1 5950.4 5959.2 5925.4 5939.4 5972.6 5975.0 5976.9 5487.9 5497.9 5505.2 5513.8 5536.9 5491.1 5492.3 5502.2 5505.1 5508.9 5492.2 5513.1 5515.8 5518.4 5521.1 5507.1 5509.6 5511.4 5532.5 5535.4 5470.9 5499.4 5514.3 5536.7 5545.2 5987.4 5989.4 6047.6 6057.6 6074.4 6186.1 6323.1 6388.9 6406.3 6465.1 6395.6 6408.7 6418.5 6437.3 6458.3 5938.1 5940.4 5942.3 5943.3 5949.4 5564.6 6474.9 6529.6 6556.1 6637.6 6210.4 6245.3 6363.5 6374.0 6383.3 6175.4 6349.6 6361.8 6425.0 6434.5 6083.1 6150.2 6156.0 6417.9 6423.1 6259.6 6289.2 6304.5 6308.4 6349.0 5075.0 5107.2 5162.3 5188.2 5208.3 4373.0 4385.8 4402.3 4402.5 4404.7 5476.5 5496.9 5510.4 5514.3 5516.6 6333.5 6339.2 6356.5 6368.9 6383.7 5458.6 5478.5 5478.6 5530.2 5599.2 5603.7 5619.1 5694.6 5694.7 5700.1 6040.0 6112.5 6125.6 6143.0 6170.8 6212.8 6274.8 6278.5 6291.1 6300.7 6033.2 6088.4 6101.2 6103.2 6103.4 5192.4 6283.8 6379.0 6380.9 6385.7 6388.5 6431.2 6450.8 6501.4 6515.1 6116.2 6228.6 6296.7 6316.7 6337.7 6189.8 6194.6 6208.7 6222.4 6226.8 6120.8 6133.1 6133.8 6158.0 6167.8 6198.2 6218.8 6241.0 6280.9 6374.5 6071.5 6086.9 6131.0 6148.1 6153.8 10:18:49 INFO - PID 21007 | 10:18:49 INFO - PID 21007 | [#1] ext.html Cycles:180 Average:39288.15 Median:3625.87 stddev:56286.77 (1552.4%) stddev-sans-first:56370.65 10:18:49 INFO - PID 21007 | Values: 843.1 892.4 1146.6 1167.1 1173.5 30682.8 37509.6 38089.4 41887.8 42244.4 42940.6 43336.8 43364.6 43445.0 43600.6 7572.1 7646.2 7648.1 7665.1 7696.6 7581.3 7680.9 7682.6 7689.6 7696.0 7575.6 7645.4 7712.5 7748.4 7748.9 7583.7 7704.3 7709.6 7716.1 7716.2 7514.3 7532.3 7552.6 7606.6 7613.0 39090.2 39289.4 39354.2 39367.6 39393.2 3586.1 3621.9 3625.4 3626.3 3628.9 30531.7 30810.5 30875.1 30892.4 30948.0 4859.9 4884.6 4926.2 4927.5 5024.5 216785.0 219399.0 219500.9 220005.0 220030.0 49219.0 49410.3 49840.0 49847.5 49903.0 44151.8 45117.0 45134.1 50631.0 50646.0 14157.2 15909.3 16152.5 16300.1 16341.4 13498.1 13538.4 13544.4 13550.3 13558.1 14133.9 14279.6 14471.7 14514.9 14533.3 5673.9 5757.6 5770.1 5781.2 5895.7 984.9 997.8 1002.2 1022.7 1039.6 22712.4 23080.2 23114.1 23698.5 24195.9 1072.4 1099.8 1101.1 1115.9 1124.1 12378.9 12442.1 12506.8 12521.4 12591.2 227335.0 227462.0 227689.0 229412.0 230291.0 54523.0 54634.7 54638.7 54701.5 54863.7 1419.9 1467.5 1491.6 1497.1 1498.7 23050.3 23071.3 23674.1 27165.3 27838.9 52474.5 52939.5 52996.5 53133.7 53472.2 200448.0 200853.0 203105.0 204445.0 205264.0 32031.0 36312.6 36469.6 36588.0 36842.3 45383.8 47155.0 48318.3 48483.8 49205.5 33454.8 33529.8 34239.3 34523.3 34615.3 33256.3 33600.5 33861.5 33911.7 34105.8 36799.3 38011.4 38194.2 38483.2 39070.4 32431.0 32632.2 32836.8 32905.0 33377.2 23156.0 23986.6 24490.3 24508.3 24630.8 10:18:49 INFO - PID 21007 | 10:18:49 INFO - PID 21007 | [#2] jquery.html Cycles:180 Average:34106.78 Median:20494.64 stddev:78159.25 (381.4%) stddev-sans-first:78337.93 10:18:49 INFO - PID 21007 | Values: 561.6 567.6 573.8 575.8 588.6 20852.1 21801.0 22046.6 22072.6 22202.0 18703.7 19583.2 19692.4 19737.1 20030.3 3904.4 4003.2 6374.8 6381.6 6385.6 6261.1 6374.9 6379.6 6402.8 6415.4 6329.3 6354.4 6359.2 6361.4 6363.2 6331.1 6332.2 6335.1 6340.7 6342.1 5358.4 5669.9 5897.5 5918.5 5922.5 28112.7 28605.4 28666.3 28670.0 28705.9 1895.3 1915.6 1923.7 1923.8 1925.8 16932.7 17790.1 18078.4 18098.0 18194.5 2242.4 2291.1 2315.5 2316.0 2318.4 118686.4 125429.0 125654.5 127935.0 141961.0 18957.2 20359.7 20629.6 21607.9 21740.2 43242.6 43425.0 43544.3 43686.3 43704.8 11472.7 11489.3 11594.9 11638.5 11688.4 9578.6 9584.2 9608.8 9793.9 9826.8 10849.4 11156.0 11273.6 11404.4 11440.4 3555.4 4096.5 4119.0 4152.9 4205.8 916.7 932.1 955.8 965.1 988.4 19029.3 19270.3 19272.8 19284.9 19412.4 996.7 1003.4 1031.8 1037.1 1048.9 10397.5 10657.6 10663.0 10788.1 10803.5 454077.0 457825.0 470845.0 473587.0 473944.0 100095.5 101345.0 102270.0 102446.0 103289.0 1110.3 1132.1 1148.4 1194.0 1230.2 19166.9 19391.6 19468.5 19714.6 20121.0 55571.0 56457.0 56916.7 57455.4 58016.4 70367.0 70616.3 71942.3 72493.6 73124.0 19857.8 20082.2 20090.6 20207.6 20352.2 21957.1 22405.4 22422.4 22557.9 22660.2 17498.5 17532.5 17778.7 17843.5 17847.3 14054.9 15167.8 15310.5 15500.8 16023.9 18077.3 18480.4 19519.3 19528.3 19600.4 14439.1 14714.3 14716.4 14728.0 14755.6 17283.0 18306.0 18362.7 18473.5 18565.4 10:18:49 INFO - PID 21007 | 10:18:49 INFO - PID 21007 | [#3] mootools.html Cycles:180 Average:8358.25 Median:2558.85 stddev:5677.11 (221.9%) stddev-sans-first:5668.44 10:18:49 INFO - PID 21007 | Values: 1325.1 1367.1 1374.7 1379.9 1380.6 13073.5 13645.5 13673.5 13703.9 13732.0 13224.6 13715.1 13780.2 13830.2 13890.3 2525.0 2545.9 2571.7 2577.3 2580.7 2353.9 2382.5 2410.2 2413.6 2415.0 2215.4 2405.5 2438.4 2500.3 2503.0 2294.4 2299.3 2509.5 2600.1 2607.6 2586.5 2587.4 2596.3 2607.3 2608.4 13539.1 13699.1 13706.5 13717.5 13754.9 7137.6 7474.3 7496.2 7538.5 7539.3 4988.2 5232.0 5359.4 5368.7 5381.1 1807.2 1844.0 1876.3 1910.0 1913.5 22013.0 22061.8 22140.8 22213.1 22239.7 6090.8 6207.9 6228.4 6380.8 6384.9 15555.7 15585.1 15687.2 15692.9 15735.9 7132.5 7309.4 7326.7 7326.9 7327.3 6671.5 6690.4 6781.6 6808.5 6880.6 4651.0 4808.1 4822.9 4856.0 4954.1 1364.5 1366.8 1382.6 1386.1 1393.6 881.9 883.2 916.6 922.1 928.4 6956.3 7095.7 7102.7 7110.7 7117.4 720.4 722.5 731.3 734.4 737.0 4348.2 4756.7 4965.7 4991.8 5110.6 17361.8 18136.2 18319.1 18370.0 18385.1 16837.7 17997.9 18095.6 18225.4 18329.9 9493.8 9773.6 9797.7 9801.8 9837.7 7269.8 7680.7 7719.9 7772.5 7944.5 15366.2 15521.9 15712.3 16013.4 16884.7 15899.8 16163.0 16709.0 16897.7 17282.5 11156.7 11359.6 11414.4 11414.9 11421.4 12808.4 12914.7 12993.9 13098.3 13167.3 10354.8 10368.5 10431.7 10672.3 10743.5 9193.4 9778.9 9864.4 9913.4 10265.2 8777.4 8983.3 9120.6 9198.9 9283.4 6855.2 6936.9 7105.3 7121.9 7163.9 6846.9 7022.3 7056.9 7172.0 7195.1 10:18:49 INFO - PID 21007 | 10:18:49 INFO - PID 21007 | [#4] prototype.html Cycles:180 Average:5387.24 Median:5979.57 stddev:1507.24 (25.2%) stddev-sans-first:1465.96 10:18:49 INFO - PID 21007 | Values: 489.7 500.6 512.3 520.4 529.3 6102.7 6104.1 6109.9 6136.7 6173.2 5862.9 6040.1 6062.6 6065.5 6072.2 4849.3 4864.8 4904.0 4914.8 4943.4 4851.7 4857.9 4867.3 4868.7 4898.5 4842.5 4904.4 4907.0 4911.3 4916.6 4602.5 4618.9 4840.0 4844.6 4859.1 4342.2 4367.7 4384.9 4386.3 4418.2 5923.9 5939.0 5952.2 5973.9 5985.3 5559.6 5578.3 5582.8 5585.3 5592.2 6370.3 6413.2 6415.9 6430.9 6447.7 4802.7 4816.6 4820.2 4839.6 4847.5 6684.7 6750.5 6761.9 6767.8 6819.9 4946.7 4946.8 4955.0 4956.7 4957.0 4999.8 5005.8 5011.5 5015.2 5018.8 5532.6 5558.4 5562.6 5576.4 5584.7 6379.0 6391.9 6395.4 6433.2 6440.5 1717.2 1734.1 1740.5 1740.6 1744.6 1114.8 1208.3 1217.5 1225.0 1232.5 5448.2 5479.0 5514.8 5581.9 5611.4 6538.2 6576.5 6601.4 6601.8 6609.6 5534.4 5598.4 5623.2 5630.0 5656.2 3465.3 3478.2 3479.5 3504.8 3505.9 6336.6 6373.7 6376.2 6376.4 6399.6 6758.6 6765.7 6767.0 6787.0 6813.8 6311.0 6408.4 6424.3 6424.6 6446.9 6556.5 6603.9 6633.5 6634.6 6660.8 6403.0 6443.3 6496.4 6543.7 6546.0 6289.0 6369.4 6379.2 6416.5 6420.8 4864.9 4875.7 4877.7 4893.9 4905.9 6531.5 6544.3 6609.3 6624.1 6631.1 6273.3 6358.4 6425.7 6428.1 6438.2 6299.2 6334.8 6375.7 6424.3 6445.7 6213.3 6302.2 6318.4 6328.5 6341.5 5860.9 6291.3 6294.6 6330.8 6364.9 6033.9 6040.7 6074.0 6115.3 6171.8 10:18:49 INFO - PID 21007 | 10:18:49 INFO - PID 21007 | [#5] yui.html Cycles:180 Average:21805.40 Median:18301.77 stddev:29493.70 (161.2%) stddev-sans-first:29534.71 10:18:49 INFO - PID 21007 | Values: 911.8 928.3 938.1 943.4 944.3 17378.4 17574.8 17596.6 17597.0 18464.4 18139.2 18925.1 19500.4 19612.2 19676.9 1038.0 1048.6 1053.7 1053.7 1054.0 1024.7 1026.5 1029.6 1032.6 1061.5 1103.0 1110.3 1110.6 1113.4 1114.9 1060.5 1064.2 1064.8 1067.2 1070.5 779.0 780.2 783.6 792.8 816.7 17066.1 17217.1 17400.4 17437.7 17520.5 19584.0 19953.9 20039.9 20105.2 20241.2 15865.5 15879.9 15948.3 15957.0 16017.6 3476.9 3503.5 3611.4 3639.3 3645.0 110504.0 110655.4 113741.9 114469.4 115844.4 16204.7 16514.6 16551.4 16588.2 16679.6 27338.0 28805.3 29202.7 29355.0 29511.6 8596.7 8607.5 8642.7 8680.6 8727.3 3969.8 3977.7 4095.6 4106.2 4149.5 4909.8 4981.2 4996.5 5004.7 5027.4 1009.9 1019.8 1042.6 1051.7 1066.8 585.0 661.5 670.8 680.5 698.4 11392.9 11576.8 11962.3 12187.6 12438.4 657.3 669.5 680.1 684.9 701.5 4835.8 4968.4 4989.1 5021.7 5125.6 104015.0 105603.0 107214.5 107643.0 109396.5 92597.1 93479.0 93666.0 95424.5 96744.0 77661.6 79136.0 81274.0 81457.6 81461.0 10368.3 10386.4 10520.9 10566.1 10829.1 35770.6 36628.8 37145.4 37654.2 38105.0 47015.0 47929.9 48669.8 49392.8 49754.8 15058.3 15526.5 15644.9 15761.0 15919.8 14720.4 15454.7 15526.3 15535.9 15835.2 15395.0 15474.8 15666.5 15915.4 19984.0 17950.5 18514.9 18674.1 18681.1 20904.4 17519.5 18521.7 18743.6 19444.8 19489.2 13161.2 13347.7 13493.0 13653.8 13994.0 13369.3 13617.3 13803.9 13916.7 13928.4 10:18:49 INFO - PID 21007 | -------- Summary: end -------- 10:18:49 INFO - PID 21007 | 10:18:49 INFO - TEST-INFO | 21007: exit 0 10:18:49 INFO - TEST-OK | dromaeo_css | took 1110538ms 10:18:49 INFO - TEST-START | kraken 10:18:49 INFO - Initialising browser for kraken test... 10:18:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34244/getInfo.html -profile /tmp/tmpUMoF4R/profile 10:18:49 INFO - TEST-INFO | started process 21421 (/builds/slave/test/build/application/firefox/firefox http://localhost:34244/getInfo.html) 10:18:55 INFO - TEST-INFO | 21421: exit 0 10:18:55 INFO - Browser initialized. 10:18:55 INFO - Running cycle 1/1 for kraken test... 10:18:55 INFO - TEST-INFO | started process 21650 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUMoF4R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:19:07 INFO - PID 21650 | RSS: Main: 169852928 10:19:07 INFO - PID 21650 | 10:19:09 INFO - PID 21650 | Cycle 1(1): loaded http://localhost:34244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34244/tests/kraken/driver.html?testName=audio-beat-detection) 10:19:10 INFO - PID 21650 | RSS: Main: 176517120 10:19:10 INFO - PID 21650 | 10:19:13 INFO - PID 21650 | Cycle 1(1): loaded http://localhost:34244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34244/tests/kraken/driver.html?testName=audio-dft) 10:19:13 INFO - PID 21650 | RSS: Main: 177049600 10:19:13 INFO - PID 21650 | 10:19:16 INFO - PID 21650 | Cycle 1(1): loaded http://localhost:34244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34244/tests/kraken/driver.html?testName=audio-fft) 10:19:17 INFO - PID 21650 | RSS: Main: 170921984 10:19:17 INFO - PID 21650 | 10:19:19 INFO - PID 21650 | Cycle 1(1): loaded http://localhost:34244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34244/tests/kraken/driver.html?testName=audio-oscillator) 10:19:20 INFO - PID 21650 | RSS: Main: 171945984 10:19:20 INFO - PID 21650 | 10:19:22 INFO - PID 21650 | Cycle 1(1): loaded http://localhost:34244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:19:22 INFO - PID 21650 | RSS: Main: 172228608 10:19:22 INFO - PID 21650 | 10:19:25 INFO - PID 21650 | Cycle 1(1): loaded http://localhost:34244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34244/tests/kraken/driver.html?testName=imaging-darkroom) 10:19:26 INFO - PID 21650 | RSS: Main: 175476736 10:19:26 INFO - PID 21650 | 10:19:29 INFO - PID 21650 | Cycle 1(1): loaded http://localhost:34244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34244/tests/kraken/driver.html?testName=imaging-desaturate) 10:19:30 INFO - PID 21650 | RSS: Main: 177221632 10:19:30 INFO - PID 21650 | 10:19:33 INFO - PID 21650 | Cycle 1(1): loaded http://localhost:34244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34244/tests/kraken/driver.html?testName=json-parse-financial) 10:19:33 INFO - PID 21650 | RSS: Main: 175804416 10:19:33 INFO - PID 21650 | 10:19:35 INFO - PID 21650 | Cycle 1(1): loaded http://localhost:34244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:19:36 INFO - PID 21650 | RSS: Main: 175640576 10:19:36 INFO - PID 21650 | 10:19:37 INFO - PID 21650 | Cycle 1(1): loaded http://localhost:34244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34244/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:19:38 INFO - PID 21650 | RSS: Main: 175562752 10:19:38 INFO - PID 21650 | 10:19:40 INFO - PID 21650 | Cycle 1(1): loaded http://localhost:34244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:19:41 INFO - PID 21650 | RSS: Main: 175247360 10:19:41 INFO - PID 21650 | 10:19:43 INFO - PID 21650 | Cycle 1(1): loaded http://localhost:34244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:19:44 INFO - PID 21650 | RSS: Main: 175742976 10:19:44 INFO - PID 21650 | 10:19:47 INFO - PID 21650 | Cycle 1(1): loaded http://localhost:34244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:19:48 INFO - PID 21650 | RSS: Main: 175763456 10:19:48 INFO - PID 21650 | 10:19:50 INFO - PID 21650 | Cycle 1(1): loaded http://localhost:34244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34244/tests/kraken/driver.html?testName=ai-astar) 10:19:50 INFO - PID 21650 | RSS: Main: 176836608 10:19:50 INFO - PID 21650 | 10:19:50 INFO - PID 21650 | __start_tp_report 10:19:50 INFO - PID 21650 | _x_x_mozilla_page_load 10:19:50 INFO - PID 21650 | _x_x_mozilla_page_load_details 10:19:50 INFO - PID 21650 | |i|pagename|runs| 10:19:50 INFO - PID 21650 | |0;ai-astar;101;108;108;107;109;110;109;109;110;109 10:19:50 INFO - PID 21650 | |1;audio-beat-detection;149;123;146;174;124;151;149;128;166;121 10:19:50 INFO - PID 21650 | |2;audio-dft;169;164;163;162;164;168;164;170;170;174 10:19:50 INFO - PID 21650 | |3;audio-fft;75;78;76;167;75;74;74;74;93;76 10:19:50 INFO - PID 21650 | |4;audio-oscillator;81;81;142;83;83;81;142;81;81;133 10:19:50 INFO - PID 21650 | |5;imaging-gaussian-blur;114;114;116;114;114;114;114;115;114;114 10:19:50 INFO - PID 21650 | |6;imaging-darkroom;150;150;152;150;152;151;150;150;150;150 10:19:50 INFO - PID 21650 | |7;imaging-desaturate;94;94;94;94;95;94;95;94;94;95 10:19:50 INFO - PID 21650 | |8;json-parse-financial;54;54;54;55;58;58;54;57;54;55 10:19:50 INFO - PID 21650 | |9;json-stringify-tinderbox;55;54;55;54;55;54;54;53;55;54 10:19:50 INFO - PID 21650 | |10;stanford-crypto-aes;79;78;78;77;89;78;78;85;77;77 10:19:50 INFO - PID 21650 | |11;stanford-crypto-ccm;129;136;129;134;126;132;126;126;124;161 10:19:50 INFO - PID 21650 | |12;stanford-crypto-pbkdf2;180;195;182;182;182;199;186;185;184;180 10:19:50 INFO - PID 21650 | |13;stanford-crypto-sha256-iterative;69;69;70;68;71;69;67;68;71;68 10:19:50 INFO - PID 21650 | __end_tp_report 10:19:50 INFO - PID 21650 | __start_cc_report 10:19:50 INFO - PID 21650 | _x_x_mozilla_cycle_collect,934 10:19:50 INFO - PID 21650 | __end_cc_report 10:19:50 INFO - PID 21650 | __startTimestamp1500225590290__endTimestamp 10:19:50 INFO - PID 21650 | 10:19:50 INFO - PID 21650 | ------- Summary: start ------- 10:19:50 INFO - PID 21650 | Number of tests: 14 10:19:50 INFO - PID 21650 | 10:19:50 INFO - PID 21650 | [#0] ai-astar Cycles:10 Average:108.00 Median:109.00 stddev:2.62 (2.4%) stddev-sans-first:0.97 10:19:50 INFO - PID 21650 | Values: 101.0 108.0 108.0 107.0 109.0 110.0 109.0 109.0 110.0 109.0 10:19:50 INFO - PID 21650 | 10:19:50 INFO - PID 21650 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:149.00 stddev:18.57 (12.5%) stddev-sans-first:19.58 10:19:50 INFO - PID 21650 | Values: 149.0 123.0 146.0 174.0 124.0 151.0 149.0 128.0 166.0 121.0 10:19:50 INFO - PID 21650 | 10:19:50 INFO - PID 21650 | [#2] audio-dft Cycles:10 Average:166.80 Median:168.50 stddev:3.94 (2.3%) stddev-sans-first:4.10 10:19:50 INFO - PID 21650 | Values: 169.0 164.0 163.0 162.0 164.0 168.0 164.0 170.0 170.0 174.0 10:19:50 INFO - PID 21650 | 10:19:50 INFO - PID 21650 | [#3] audio-fft Cycles:10 Average:86.20 Median:75.50 stddev:28.96 (38.4%) stddev-sans-first:30.43 10:19:50 INFO - PID 21650 | Values: 75.0 78.0 76.0 167.0 75.0 74.0 74.0 74.0 93.0 76.0 10:19:50 INFO - PID 21650 | 10:19:50 INFO - PID 21650 | [#4] audio-oscillator Cycles:10 Average:98.80 Median:81.00 stddev:27.86 (34.4%) stddev-sans-first:28.80 10:19:50 INFO - PID 21650 | Values: 81.0 81.0 142.0 83.0 83.0 81.0 142.0 81.0 81.0 133.0 10:19:50 INFO - PID 21650 | 10:19:50 INFO - PID 21650 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 10:19:50 INFO - PID 21650 | Values: 114.0 114.0 116.0 114.0 114.0 114.0 114.0 115.0 114.0 114.0 10:19:50 INFO - PID 21650 | 10:19:50 INFO - PID 21650 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 10:19:50 INFO - PID 21650 | Values: 150.0 150.0 152.0 150.0 152.0 151.0 150.0 150.0 150.0 150.0 10:19:50 INFO - PID 21650 | 10:19:50 INFO - PID 21650 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:19:50 INFO - PID 21650 | Values: 94.0 94.0 94.0 94.0 95.0 94.0 95.0 94.0 94.0 95.0 10:19:50 INFO - PID 21650 | 10:19:50 INFO - PID 21650 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:1.70 (3.1%) stddev-sans-first:1.74 10:19:50 INFO - PID 21650 | Values: 54.0 54.0 54.0 55.0 58.0 58.0 54.0 57.0 54.0 55.0 10:19:50 INFO - PID 21650 | 10:19:50 INFO - PID 21650 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.50 stddev:0.67 (1.2%) stddev-sans-first:0.67 10:19:50 INFO - PID 21650 | Values: 55.0 54.0 55.0 54.0 55.0 54.0 54.0 53.0 55.0 54.0 10:19:50 INFO - PID 21650 | 10:19:50 INFO - PID 21650 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:78.00 stddev:4.06 (5.2%) stddev-sans-first:4.30 10:19:50 INFO - PID 21650 | Values: 79.0 78.0 78.0 77.0 89.0 78.0 78.0 85.0 77.0 77.0 10:19:50 INFO - PID 21650 | 10:19:50 INFO - PID 21650 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:130.50 stddev:10.80 (8.3%) stddev-sans-first:11.39 10:19:50 INFO - PID 21650 | Values: 129.0 136.0 129.0 134.0 126.0 132.0 126.0 126.0 124.0 161.0 10:19:50 INFO - PID 21650 | 10:19:50 INFO - PID 21650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.50 Median:184.50 stddev:6.43 (3.5%) stddev-sans-first:6.51 10:19:50 INFO - PID 21650 | Values: 180.0 195.0 182.0 182.0 182.0 199.0 186.0 185.0 184.0 180.0 10:19:50 INFO - PID 21650 | 10:19:50 INFO - PID 21650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.33 (1.9%) stddev-sans-first:1.41 10:19:50 INFO - PID 21650 | Values: 69.0 69.0 70.0 68.0 71.0 69.0 67.0 68.0 71.0 68.0 10:19:50 INFO - PID 21650 | -------- Summary: end -------- 10:19:50 INFO - PID 21650 | 10:19:50 INFO - PID 21650 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:19:50 INFO - TEST-INFO | 21650: exit 0 10:19:51 INFO - TEST-OK | kraken | took 61217ms 10:19:51 INFO - SUITE-END | took 1171s 10:19:51 INFO - Completed test suite (00:19:32) 10:19:51 INFO - javascript benchmark 10:19:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8310.097515827218, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3003.3993201359735, 3036.073997430784, 3065.632124145103, 3065.8773649054033, 3109.098361475171, 5827.796027139046, 5880.794172203963, 5932.110183472481, 5950.404959504048, 5959.195508606337, 5925.377835327293, 5939.376365481617, 5972.6117802342815, 5975.0, 5976.910346344808, 5487.890242195173, 5497.890042199154, 5505.174223866422, 5513.807016754415, 5536.861578460531, 5491.093969495028, 5492.258545096421, 5502.202180683798, 5505.119180931052, 5508.91736623951, 5492.203630473579, 5513.09034009388, 5515.834524964257, 5518.392976772552, 5521.089020311644, 5507.118860982244, 5509.641873278224, 5511.3937466878615, 5532.474414930595, 5535.418781028015, 5470.890582188334, 5499.422560631157, 5514.283143191399, 5536.667799932017, 5545.223668686387, 5987.37132601075, 5989.3711160327975, 6047.606905551125, 6057.575969682124, 6074.362191969868, 6186.072089186613, 6323.083152942843, 6388.872222555523, 6406.263279722845, 6465.094886715863, 6395.648239346834, 6408.67956602168, 6418.518611104139, 6437.259715132726, 6458.2895881453005, 5938.138969849348, 5940.435658612425, 5942.346341902387, 5943.3462319144855, 5949.405059494059, 5564.582656300794, 6474.902876456904, 6529.575577587441, 6556.147700798961, 6637.634930078795, 6210.441060304594, 6245.313015568284, 6363.490920726424, 6374.043893415932, 6383.329750376237, 6175.44421002103, 6349.55553111287, 6361.840953976188, 6425.036244563353, 6434.517411194179, 6083.11794789753, 6150.169727086875, 6155.96922015396, 6417.935820641827, 6423.100765892778, 6259.593126446857, 6289.182406287245, 6304.527160462983, 6308.369163083655, 6349.015902535114, 5075.0, 5107.233914912793, 5162.251473536317, 5188.195829646411, 5208.348956380452, 4372.978135109368, 4385.846495372711, 4402.273624851863, 4402.515723270438, 4404.66964977628, 5476.452354764491, 5496.945030549723, 5510.393856675762, 5514.28314319144, 5516.613837031369, 6333.493320534346, 6339.207599050119, 6356.523260755462, 6368.936310636927, 6383.744650214032, 5458.590605704509, 5478.534324582375, 5478.561715062785, 5530.225768392428, 5599.216109744639, 5603.7478313475995, 5619.100943848965, 5694.572907031989, 5694.743736531783, 5700.087985922232, 6039.969800150971, 6112.51099912006, 6125.601835880653, 6143.047827586731, 6170.753169873245, 6212.751489940351, 6274.780382686584, 6278.497720182283, 6291.056341548804, 6300.684965751786, 6033.155358249936, 6088.360722124113, 6101.237345331833, 6103.23709536308, 6103.42017508336, 5192.350956130484, 6283.7800676976085, 6379.043143528508, 6380.87238255223, 6385.68071596409, 6388.520860935541, 6431.196100487439, 6450.8064758057335, 6501.44737697301, 6515.087887695631, 6116.235470566179, 6228.56400051992, 6296.653684047421, 6316.652584107735, 6337.683115844282, 6189.7833575826435, 6194.628322300677, 6208.689565521616, 6222.408871157233, 6226.813195604139, 6120.816375508742, 6133.110698948538, 6133.754649813957, 6158.04550294705, 6167.784127555514, 6198.163247961467, 6218.782342617987, 6241.0, 6280.937190628035, 6374.4900407966325, 6071.544634152545, 6086.939130608637, 6131.019036954066, 6148.1085242640465, 6153.84615384619], "value": 5812.22383723882, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [843.1399972028531, 892.4422236102438, 1146.6445401925403, 1167.078008373385, 1173.4953969792984, 30682.846585767067, 37509.624903750955, 38089.42865857014, 41887.79056104723, 42244.36633450501, 42940.57059429405, 43336.783316083456, 43364.56635433645, 43445.0, 43600.56399436005, 7572.053493313336, 7646.235376462365, 7648.0822301323915, 7665.118511371208, 7696.615169241543, 7581.317681408672, 7680.884786728176, 7682.577458239794, 7689.615519224017, 7696.0, 7575.583342916138, 7645.388368930472, 7712.5372477651235, 7748.41886858485, 7748.922510774876, 7583.658735356922, 7704.26809453101, 7709.614519274014, 7716.074071111502, 7716.189800070996, 7514.286142816423, 7532.284432978859, 7552.5846078465665, 7606.619669016527, 7613.0483689538805, 39090.21819563621, 39289.41065884014, 39354.21291574181, 39367.60632393668, 39393.212135757414, 3586.1214002569277, 3621.89134325968, 3625.4380571011534, 3626.3110009098186, 3628.8911332660064, 30531.69468305333, 30810.53784193239, 30875.073747787603, 30892.382152356826, 30948.0, 4859.88222708779, 4884.633652476078, 4926.2364333528, 4927.457979622239, 5024.522670346311, 216785.0, 219399.0, 219500.9024954865, 220005.0, 220030.0, 49219.0, 49410.258846117336, 49840.0, 49847.50152498501, 49903.0, 44151.77924110359, 45117.0, 45134.09731805346, 50631.0, 50646.0, 14157.221352825487, 15909.284082216329, 16152.515424537283, 16300.10349430769, 16341.428050018192, 13498.055136140376, 13538.390772415265, 13544.390502427414, 13550.254735989418, 13558.050936434553, 14133.858661413255, 14279.57161285163, 14471.710565788626, 14514.927425362806, 14533.34599943005, 5673.886522269614, 5757.553039958001, 5770.13447982806, 5781.161731548986, 5895.67573783446, 984.9064338887795, 997.7954519323521, 1002.2433063037506, 1022.7136401807505, 1039.594558122333, 22712.41013129065, 23080.19219327349, 23114.075436982333, 23698.526029479657, 24195.879020604785, 1072.3565860483802, 1099.8075336816025, 1101.1081024370285, 1115.9274647147909, 1124.0726400719275, 12378.938105309597, 12442.129050966345, 12506.81239781404, 12521.37393130358, 12591.24452532851, 227335.0, 227462.0, 227689.0, 229412.0, 230291.0, 54523.0, 54634.726826365615, 54638.72680636651, 54701.45298547043, 54863.72568137134, 1419.8722115009698, 1467.530390275123, 1491.6270932266934, 1497.101738956639, 1498.7452133137392, 23050.308490745305, 23071.307860764206, 23674.053037878293, 27165.320866978484, 27838.86080569584, 52474.47525524696, 52939.470605293456, 52996.4700353007, 53133.734331328094, 53472.197917032056, 200448.0, 200853.0, 203105.0, 204445.0, 205264.0, 32031.0, 36312.63687363092, 36469.635303646624, 36588.0, 36842.263154737295, 45383.7730811357, 47155.0, 48318.27522587234, 48483.75758121187, 49205.50794492009, 33454.83272583621, 33529.83235083809, 34239.315213696085, 34523.30953380968, 34615.30769384649, 33256.334873301916, 33600.49599255964, 33861.49207761935, 33911.660883391836, 34105.829470852485, 36799.264014720095, 38011.42982855204, 38194.23611527698, 38483.230335392574, 39070.4139437903, 32431.0, 32632.184195395304, 32836.83581582077, 32905.0, 33377.16557085995, 23156.0, 23986.640200397356, 24490.285680002227, 24508.26475205747, 24630.753692462848], "value": 17699.098285448923, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.6209058885252, 567.6026781253124, 573.8278516445065, 575.8099827057072, 588.6232811000958, 20852.061657225422, 21801.0, 22046.559068818653, 22072.558548829013, 22202.0, 18703.719444208313, 19583.216671333128, 19692.409227723154, 19737.11182996765, 20030.29893953712, 3904.414337849317, 4003.219372222418, 6374.840628984266, 6381.617102973813, 6385.553011289212, 6261.092141639459, 6374.872502549946, 6379.585326953733, 6402.775902843401, 6415.422611964922, 6329.303776584572, 6354.396332348442, 6359.20509936258, 6361.4274715275615, 6363.204599425072, 6331.145295385133, 6332.208473940757, 6335.144755458024, 6340.746370145189, 6342.143810585558, 5358.383785864637, 5669.858253543694, 5897.4692277694785, 5918.526517878559, 5922.466977972003, 28112.718872811216, 28605.427891442054, 28666.283342916384, 28670.0, 28705.856470717514, 1895.3176856331709, 1915.6456055629753, 1923.6729755941383, 1923.7595300587286, 1925.7881633020356, 16932.746008809878, 17790.110494475226, 18078.367257145936, 18098.0, 18194.545136371566, 2242.39455347057, 2291.0606651272897, 2315.455867871049, 2316.0388438797877, 2318.374039009458, 118686.40656796747, 125429.0, 125654.48691026129, 127935.0, 141961.0, 18957.1990660887, 20359.69460458094, 20629.58740825175, 21607.891960540095, 21740.239091632033, 43242.56757432449, 43425.0, 43544.34683479751, 43686.344704829455, 43704.81475926255, 11472.713182170513, 11489.253198542068, 11594.942025289989, 11638.534458621729, 11688.415579221006, 9578.616855325708, 9584.233261339075, 9608.75978100539, 9793.853092203623, 9826.771653543306, 10849.403282819363, 11156.0, 11273.605423810128, 11404.429778511041, 11440.370779607036, 3555.4133567961, 4096.549379568245, 4118.979405103015, 4152.854650087233, 4205.810738516774, 916.6699988004314, 932.1098351074708, 955.7706150523964, 965.1410244882061, 988.4069558264983, 19029.333973311146, 19270.32553860608, 19272.80727192738, 19284.939328336797, 19412.417627470917, 996.7159359582485, 1003.3929472669076, 1031.8400647899587, 1037.1339931157418, 1048.8688913885765, 10397.53211105487, 10657.57369705203, 10663.0, 10788.08301294383, 10803.513841877135, 454077.0, 457825.0, 470845.0, 473587.0, 473944.0, 100095.49952250192, 101345.0, 102270.0, 102446.0, 103289.0, 1110.3448965110463, 1132.0603898764007, 1148.3970915269383, 1193.9999999999827, 1230.2065167966612, 19166.945817980144, 19391.612167756284, 19468.48081440866, 19714.60570788605, 20121.0, 55571.0, 56457.0, 56916.71541642265, 57455.42544574668, 58016.41983580279, 70367.0, 70616.29383706098, 71942.28057719565, 72493.637531812, 73124.0, 19857.801421985594, 20082.19671213135, 20090.59818803645, 20207.59584808325, 20352.18591256333, 21957.121715131216, 22405.439864002878, 22422.439439014157, 22557.887210563844, 22660.206892758673, 17498.475045748648, 17532.474025779247, 17778.733318999966, 17843.464696059138, 17847.286108555512, 14054.929725351309, 15167.848321516643, 15310.540683779505, 15500.84499154994, 16023.919880400523, 18077.27690892402, 18480.445586632424, 19519.316823911096, 19528.31650892212, 19600.411987640393, 14439.133651980916, 14714.337854796346, 14716.411343546139, 14728.042677226375, 14755.631109222355, 17283.0, 18306.0, 18362.72455913189, 18473.53816154553, 18565.44303670892], "value": 12226.521219288841, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.0790700463178, 1367.0703921333488, 1374.7319272741806, 1379.910305830121, 1380.6065271397654, 13073.477060917563, 13645.522406715767, 13673.453061877526, 13703.862961370383, 13732.038757286993, 13224.603261902133, 13715.108517946326, 13780.173189608631, 13830.23933683647, 13890.305484725774, 2524.9999999999955, 2545.9490810183784, 2571.742825717432, 2577.265479338389, 2580.716121226673, 2353.9293821185306, 2382.475855311837, 2410.192585483865, 2413.5655581995234, 2414.95170096598, 2215.4350640586626, 2405.482821193443, 2438.4391589934326, 2500.274920273119, 2502.9749702503013, 2294.4493321602777, 2299.2642354446584, 2509.4855554611263, 2600.0509813917974, 2607.5827867541293, 2586.4697736963876, 2587.3660953066433, 2596.260065881215, 2607.282997175773, 2608.4000679843552, 13539.11995720275, 13699.109557878706, 13706.52027179044, 13717.45130194791, 13754.862451375458, 7137.571745695275, 7474.327310542078, 7496.175420703718, 7538.509996850242, 7539.321461068475, 4988.226824842155, 5232.0, 5359.410464848864, 5368.70472124033, 5381.13901775714, 1807.2138619700472, 1844.0, 1876.3245231716571, 1910.0449775112443, 1913.4642300155979, 22013.0, 22061.779382206132, 22140.778592213872, 22213.111475540958, 22239.666405003936, 6090.847728806815, 6207.875842483125, 6228.377162283736, 6380.84047898797, 6384.904226436607, 15555.688886222211, 15585.142817145166, 15687.215639217993, 15692.92153539225, 15735.921320393554, 7132.500724949204, 7309.378702810214, 7326.706931722778, 7326.853462930818, 7327.267273272737, 6671.466282697373, 6690.397864192246, 6781.559198652072, 6808.523403361816, 6880.552764070319, 4650.9767451162525, 4808.134535783523, 4822.879428014257, 4855.975720121377, 4954.108260513142, 1364.5087768403366, 1366.8154799102192, 1382.5690410425161, 1386.0574809129687, 1393.5819254223693, 881.8633111867671, 883.2492381475822, 916.5508900638639, 922.1193759959223, 928.3919033033374, 6956.339147780953, 7095.716171353088, 7102.715891364391, 7110.680019399036, 7117.4306055515435, 720.4488566246825, 722.4545468171602, 731.2979539641897, 734.3904559215838, 736.9520981136209, 4348.195583816941, 4756.7145971241835, 4965.702057876467, 4991.800327986913, 5110.642255042186, 17361.82638173602, 18136.183871725803, 18319.084045797656, 18370.0, 18385.08074596265, 16837.747433788503, 17997.910010449865, 18095.63808723818, 18225.362112326005, 18329.90835045816, 9493.810123797486, 9773.560189791477, 9797.706068817946, 9801.803963920682, 9837.704868854089, 7269.818254543467, 7680.654370553227, 7719.884201736866, 7772.45592808498, 7944.523328600302, 15366.154861482726, 15521.922390387976, 15712.29294681765, 16013.439529616408, 16884.746728799324, 15899.761503577687, 16163.0, 16709.0, 16897.746533801757, 17282.481525554253, 11156.721081972692, 11359.602413915472, 11414.372209528223, 11414.885851141382, 11421.428928553705, 12808.423620937267, 12914.67713307175, 12993.935030324788, 13098.345082745634, 13167.341632918124, 10354.792904141725, 10368.533415996148, 10431.68704938853, 10672.252942293964, 10743.516541755484, 9193.402428842104, 9778.9022109778, 9864.408135511892, 9913.355631883904, 10265.178785697275, 8777.42946708462, 8983.281337492854, 9120.589573469342, 9198.862017069616, 9283.350165488351, 6855.211650660238, 6936.895946560705, 7105.32499412555, 7121.8575628486105, 7163.928360716326, 6846.938724497711, 7022.297770222936, 7056.894146587908, 7171.99592057102, 7195.064641596559], "value": 6083.572627590929, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.6963784904279, 500.5534006720576, 512.3288492075379, 520.378148113005, 529.2881074954186, 6102.664353460558, 6104.114903339018, 6109.938900610992, 6136.693165341726, 6173.166622505966, 5862.912056319148, 6040.1241819936195, 6062.636241825494, 6065.454109130177, 6072.180255665484, 4849.321095046696, 4864.805407783684, 4903.975480122604, 4914.827981020665, 4943.382077240345, 4851.684640498374, 4857.927131093036, 4867.269909513584, 4868.732219727914, 4898.534639209287, 4842.539958703936, 4904.435989861176, 4906.950930490685, 4911.287863259825, 4916.582090522292, 4602.516735742733, 4618.930716039245, 4839.951600483985, 4844.619283504219, 4859.149648811479, 4342.242675900794, 4367.67242456817, 4384.934225986613, 4386.342048692722, 4418.182636212311, 5923.911141332884, 5939.0104315054505, 5952.226210592638, 5973.850653733648, 5985.281766188042, 5559.583031272671, 5578.330600327946, 5582.8325150245555, 5585.329760428734, 5592.161175823619, 6370.299267080617, 6413.230412350501, 6415.935840641627, 6430.903536446957, 6447.742090316382, 4802.735849528274, 4816.61467082636, 4820.228763397875, 4839.564439200489, 4847.51524847516, 6684.665766711645, 6750.527463077587, 6761.932380676229, 6767.796966091025, 6819.896946889154, 4946.678465899705, 4946.802127914843, 4955.0, 4956.653034287565, 4957.0, 4999.800007999639, 5005.774740136702, 5011.5489605935645, 5015.172496538104, 5018.824341148043, 5532.585056120807, 5558.360788509373, 5562.638428502134, 5576.414476479992, 5584.692841893653, 6379.0, 6391.936080639227, 6395.360463953661, 6433.228012638513, 6440.452561532322, 1717.2444124585143, 1734.1415999080536, 1740.5387572293353, 1740.5561581796815, 1744.6336269383319, 1114.8439218509416, 1208.3293771956473, 1217.4947396830216, 1224.9693757655953, 1232.5069972011268, 5448.237246785453, 5479.0, 5514.834554963358, 5581.916271255935, 5611.382747897728, 6538.248101468392, 6576.487407896115, 6601.392449982231, 6601.834954126185, 6609.570377925419, 5534.418886016911, 5598.412166722435, 5623.2408624835125, 5630.0, 5656.179853921159, 3465.3415850988736, 3478.1652403422995, 3479.530263414407, 3504.807235602066, 3505.94741078884, 6336.58812177207, 6373.681315934277, 6376.162607639649, 6376.39424254695, 6399.552031357854, 6758.628275444898, 6765.661716914135, 6766.966165169241, 6787.0, 6813.797515167863, 6310.968445157745, 6408.4232419080645, 6424.3254458282145, 6424.646644434601, 6446.903296450557, 6556.508791477853, 6603.9009414859775, 6633.535652504278, 6634.635095069818, 6660.766873159416, 6402.967985160044, 6443.260319713745, 6496.447801936888, 6543.672816359258, 6546.0, 6288.968555157195, 6369.363063693593, 6379.202599675041, 6416.48726542569, 6420.807375778734, 4864.902701946012, 4875.68308059975, 4877.6585639004925, 4893.926591101207, 4905.926411103765, 6531.477481801349, 6544.312847151171, 6609.339066093352, 6624.138861947916, 6631.137952066393, 6273.309935906956, 6358.364163583789, 6425.678716064272, 6428.132202152649, 6438.229486891142, 6299.212598425197, 6334.809955701337, 6375.74497020114, 6424.293327734039, 6445.742170313135, 6213.347598502273, 6302.180716507009, 6318.368163183645, 6328.493720502441, 6341.451230173598, 5860.890079571436, 6291.339409361951, 6294.5593808434805, 6330.841728956813, 6364.872702546016, 6033.8535678221, 6040.731446396306, 6074.0, 6115.327313995368, 6171.797343669583], "value": 4946.579840655961, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [911.8130783189445, 928.262031684811, 938.0525669074233, 943.4433684126373, 944.3153713557667, 17378.391756288533, 17574.82425175748, 17596.64806703865, 17597.0, 18464.353747618836, 18139.183736731844, 18925.148368323426, 19500.41498755036, 19612.215511379527, 19676.9016154919, 1037.974050648736, 1048.6172547020321, 1053.7049626104665, 1053.7365658585354, 1053.9947300263489, 1024.6772266735954, 1026.4611079183414, 1029.5933106422958, 1032.6179313653959, 1061.522314958268, 1102.9613963511279, 1110.2505808579217, 1110.5835311758092, 1113.4265853085667, 1114.921955463118, 1060.5280650110703, 1064.239069065614, 1064.8136576099153, 1067.1729409707461, 1070.5022164693455, 779.0378882080626, 780.1613265739296, 783.5533745764916, 792.8097256658418, 816.6978218059356, 17066.146692665316, 17217.139143042798, 17400.390986315546, 17437.7384339235, 17520.474385768448, 19584.0, 19953.900230498755, 20039.89980050105, 20105.195792168295, 20241.190352385885, 15865.52403427899, 15879.920600396925, 15948.2823272953, 15957.0, 16017.599560010976, 3476.9304613907834, 3503.474478828196, 3611.4402267648557, 3639.290338384016, 3645.0, 110504.0, 110655.44672276668, 113741.86258137395, 114469.42765286204, 115844.42077789558, 16204.67590648204, 16514.58713532171, 16551.420700275434, 16588.170591470378, 16679.583010424838, 27338.0, 28805.27986800347, 29202.707972919998, 29355.0, 29511.55732664012, 8596.699115530926, 8607.526586037828, 8642.697505587274, 8680.609372578248, 8727.258183054384, 3969.761814291094, 3977.6817854572146, 4095.6313931746286, 4106.2198182345255, 4149.481314835645, 4909.828156014522, 4981.178105612606, 4996.475370086161, 5004.699718016931, 5027.421846487628, 1009.8687170667913, 1019.836826107834, 1042.635077722791, 1051.6844946516014, 1066.7546464313252, 584.9500147235638, 661.4708233413251, 670.7752902777527, 680.4862328941716, 698.3784431855653, 11392.943035284936, 11576.826347604792, 11962.265471506584, 12187.573434929735, 12438.440270187863, 657.3262406033854, 669.5146019136088, 680.0581195044898, 684.94177994871, 701.487913822902, 4835.8065677373215, 4968.378952630921, 4989.05645669057, 5021.6735912165595, 5125.641205115606, 104015.0, 105603.0, 107214.46392767986, 107643.0, 109396.453017736, 92597.07402925885, 93479.0, 93666.0, 95424.52287738517, 96744.0, 77661.61169194117, 79136.0, 81274.0, 81457.59271203606, 81461.0, 10368.274220804471, 10386.376817390981, 10520.947905209723, 10566.101881340172, 10829.133669306595, 35770.64229357673, 36628.81685591555, 37145.44281835721, 37654.2469150621, 38105.0, 47015.0, 47929.86534921938, 48669.756651216514, 49392.753036234586, 49754.751226243636, 15058.322375493348, 15526.534203973899, 15644.92177539105, 15760.975536590086, 15919.840801591836, 14720.38206747808, 15454.690906181588, 15526.301316440562, 15535.922320388325, 15835.208239588204, 15395.0, 15474.84525154734, 15666.451674191349, 15915.363385464452, 19984.0, 17950.461486155436, 18514.907425462785, 18674.06629668484, 18681.06594670234, 20904.37286881396, 17519.47441576755, 18521.72217416767, 18743.625127497646, 19444.805551944864, 19489.220431182595, 13161.210327380388, 13347.733045339233, 13493.0, 13653.795193071914, 13994.000865546908, 13369.26469044212, 13617.31913404306, 13803.861961380258, 13916.721665566834, 13928.442862285396], "value": 8700.54215725851, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 108.0, 107.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 146.0, 174.0, 124.0, 151.0, 149.0, 128.0, 166.0, 121.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 164.0, 163.0, 162.0, 164.0, 168.0, 164.0, 170.0, 170.0, 174.0], "value": 166.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 167.0, 75.0, 74.0, 74.0, 74.0, 93.0, 76.0], "value": 86.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 142.0, 83.0, 83.0, 81.0, 142.0, 81.0, 81.0, 133.0], "value": 98.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 116.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 152.0, 150.0, 152.0, 151.0, 150.0, 150.0, 150.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 58.0, 58.0, 54.0, 57.0, 54.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 54.0, 55.0, 54.0, 54.0, 53.0, 55.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 77.0, 89.0, 78.0, 78.0, 85.0, 77.0, 77.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 136.0, 129.0, 134.0, 126.0, 132.0, 126.0, 126.0, 124.0, 161.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 195.0, 182.0, 182.0, 182.0, 199.0, 186.0, 185.0, 184.0, 180.0], "value": 185.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 70.0, 68.0, 71.0, 69.0, 67.0, 68.0, 71.0, 68.0], "value": 69.0, "unit": "score"}]}]} 10:19:51 INFO - Return code: 0 10:19:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:19:51 INFO - # TBPL SUCCESS # 10:19:51 INFO - Running post-action listener: _package_coverage_data 10:19:51 INFO - Running post-action listener: _resource_record_post_action 10:19:51 INFO - [mozharness: 2017-07-16 17:19:51.561880Z] Finished run-tests step (success) 10:19:51 INFO - Running post-run listener: _resource_record_post_run 10:19:51 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 437948416; Read time: 16; Write time: 284604 10:19:51 INFO - TinderboxPrint: CPU usage
13.1% 10:19:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:19:51 INFO - TinderboxPrint: I/O write bytes / time
437,948,416 / 284,604 10:19:51 INFO - TinderboxPrint: CPU idle
8,252.7 (86.9%) 10:19:51 INFO - TinderboxPrint: CPU user
1,198.1 (12.6%) 10:19:51 INFO - TinderboxPrint: Swap in / out
0 / 0 10:19:51 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 108744704; Read time: 0; Write time: 84748 10:19:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:19:51 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 329203712; Read time: 16; Write time: 199856 10:19:52 INFO - Running post-run listener: _upload_blobber_files 10:19:52 INFO - Blob upload gear active. 10:19:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:19:52 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 10:19:52 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'] 10:19:52 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 10:19:52 INFO - Traceback (most recent call last): 10:19:52 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 10:19:52 INFO - main() 10:19:52 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 10:19:52 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 10:19:52 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 10:19:52 INFO - return set(response.json().get('whitelist', [])) 10:19:52 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 10:19:52 INFO - return json.loads(self.text or self.content, **kwargs) 10:19:52 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 10:19:52 INFO - return _default_decoder.decode(s) 10:19:52 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 10:19:52 INFO - obj, end = self.raw_decode(s) 10:19:52 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 10:19:52 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 10:19:52 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 10:19:52 ERROR - Return code: 1 10:19:52 INFO - Setting buildbot property blobber_files to {} 10:19:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:19:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:19:52 INFO - Contents: 10:19:52 INFO - blobber_files:{} 10:19:52 INFO - Running post-run listener: copy_logs_to_upload_dir 10:19:52 INFO - Copying logs to upload dir... 10:19:52 INFO - mkdir: /builds/slave/test/build/upload/logs 10:19:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.138619 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-07-16 10:19:52.469323) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 10:19:52.476994) ========= 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=20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/BQEDOoXIQH6z0T86mY66Ow/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-16 10:19:52.531565) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 10:19:52.531957) ========= 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=20e666a3d4cfbb71505a330e000001b4-1500223813.354965-1455964727 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 10:19:52.584810) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 10:19:52.585159) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 10:19:52.585480) ========= ========= Total master_lag: 0.26 =========