builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-041 starttime: 1501637096.54 results: success (0) revision: fec8d72590053c3ad72cd3492d389213dfabc2ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:56.535287) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:56.535658) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:56.535936) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:56.673347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:56.673645) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-01 18:24:56-- 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% 37.4M=0s 2017-08-01 18:24:57 (37.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086091 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:56.778062) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:56.778371) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017814 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:56.833923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-01 18:24:56.834250) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fec8d72590053c3ad72cd3492d389213dfabc2ff --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 fec8d72590053c3ad72cd3492d389213dfabc2ff --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=8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-01 18:24:57,147 truncating revision to first 12 chars 2017-08-01 18:24:57,148 Setting DEBUG logging. 2017-08-01 18:24:57,148 attempt 1/10 2017-08-01 18:24:57,148 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fec8d7259005?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-01 18:24:57,747 unpacking tar archive at: mozilla-central-fec8d7259005/testing/mozharness/ program finished with exit code 0 elapsedTime=1.093812 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-01 18:24:57.950840) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:57.951282) ========= script_repo_revision: fec8d72590053c3ad72cd3492d389213dfabc2ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:57.955861) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:57.956300) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:57.968793) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-08-01 18:24:57.969181) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:24:58 INFO - MultiFileLogger online at 20170801 18:24:58 in /builds/slave/test 18:24:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:24:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:24:58 INFO - {'append_to_log': False, 18:24:58 INFO - 'base_work_dir': '/builds/slave/test', 18:24:58 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:24:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:24:58 INFO - 'branch': 'Firefox-Non-PGO', 18:24:58 INFO - 'buildbot_json_path': 'buildprops.json', 18:24:58 INFO - 'code_coverage': False, 18:24:58 INFO - 'config_files': ('talos/linux_config.py',), 18:24:58 INFO - 'default_actions': ('clobber', 18:24:58 INFO - 'read-buildbot-config', 18:24:58 INFO - 'download-and-extract', 18:24:58 INFO - 'populate-webroot', 18:24:58 INFO - 'create-virtualenv', 18:24:58 INFO - 'install', 18:24:58 INFO - 'setup-mitmproxy', 18:24:58 INFO - 'run-tests'), 18:24:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:24:58 INFO - 'disable_ccov_upload': False, 18:24:58 INFO - 'download_minidump_stackwalk': True, 18:24:58 INFO - 'download_symbols': 'ondemand', 18:24:58 INFO - 'enable_stylo': False, 18:24:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:24:58 INFO - 'tooltool.py': '/tools/tooltool.py', 18:24:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:24:58 INFO - '/tools/misc-python/virtualenv.py')}, 18:24:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:24:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:24:58 INFO - 'gecko_profile': False, 18:24:58 INFO - 'gecko_profile_interval': 0, 18:24:58 INFO - 'installer_path': 'installer.exe', 18:24:58 INFO - 'log_level': 'info', 18:24:58 INFO - 'log_name': 'talos', 18:24:58 INFO - 'log_to_console': True, 18:24:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:24:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:24:58 INFO - 'opt_config_files': (), 18:24:58 INFO - 'pip_index': False, 18:24:58 INFO - 'suite': 'dromaeojs-e10s', 18:24:58 INFO - 'system_bits': '32', 18:24:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:24:58 INFO - 'title': 'talos-linux64-ix-041', 18:24:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:24:58 INFO - 'use_talos_json': True, 18:24:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:24:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:24:58 INFO - 'work_dir': 'build'} 18:24:58 INFO - [mozharness: 2017-08-02 01:24:58.386949Z] Running clobber step. 18:24:58 INFO - Running pre-action listener: _resource_record_pre_action 18:24:58 INFO - Running main action method: clobber 18:24:58 INFO - rmtree: /builds/slave/test/build 18:24:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:24:59 INFO - Running post-action listener: _resource_record_post_action 18:24:59 INFO - [mozharness: 2017-08-02 01:24:59.418408Z] Finished clobber step (success) 18:24:59 INFO - [mozharness: 2017-08-02 01:24:59.418510Z] Running read-buildbot-config step. 18:24:59 INFO - Running pre-action listener: _resource_record_pre_action 18:24:59 INFO - Running main action method: read_buildbot_config 18:24:59 INFO - Using buildbot properties: 18:24:59 INFO - { 18:24:59 INFO - "project": "", 18:24:59 INFO - "product": "firefox", 18:24:59 INFO - "who": "kwierso@gmail.com", 18:24:59 INFO - "installer_path": "public/build/target.tar.bz2", 18:24:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:24:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:24:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:24:59 INFO - "stage_platform": "linux64", 18:24:59 INFO - "basedir": "/builds/slave/test", 18:24:59 INFO - "buildnumber": 749, 18:24:59 INFO - "platform": "ubuntu64_hw", 18:24:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:24:59 INFO - "slavebuilddir": "test", 18:24:59 INFO - "taskId": "XMWudpgQQyGpkVpXlvC3jA", 18:24:59 INFO - "branch": "mozilla-central", 18:24:59 INFO - "script_repo_revision": "production", 18:24:59 INFO - "revision": "fec8d72590053c3ad72cd3492d389213dfabc2ff", 18:24:59 INFO - "slavename": "talos-linux64-ix-041", 18:24:59 INFO - "repo_path": "mozilla-central" 18:24:59 INFO - } 18:24:59 INFO - Finding installer, test and symbols from parent task. 18:24:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XMWudpgQQyGpkVpXlvC3jA'}, attempt #1 18:24:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XMWudpgQQyGpkVpXlvC3jA'}, attempt #1 18:25:00 INFO - Task dependencies: N1L-RPQ_Te2bYSv3MuD1AQ 18:25:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ'}, attempt #1 18:25:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.tar.bz2 18:25:00 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.test_packages.json 18:25:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.crashreporter-symbols.zip 18:25:00 INFO - Running post-action listener: _resource_record_post_action 18:25:00 INFO - [mozharness: 2017-08-02 01:25:00.768443Z] Finished read-buildbot-config step (success) 18:25:00 INFO - [mozharness: 2017-08-02 01:25:00.768664Z] Running download-and-extract step. 18:25:00 INFO - Running pre-action listener: _resource_record_pre_action 18:25:00 INFO - Running main action method: download_and_extract 18:25:00 INFO - mkdir: /builds/slave/test/build/tests 18:25:00 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')]} 18:25:00 INFO - trying https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.test_packages.json 18:25:00 INFO - Downloading https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:25:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:25:01 INFO - Downloaded 989 bytes. 18:25:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:25:01 INFO - Using the following test package requirements: 18:25:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:25:01 INFO - u'common': [u'target.common.tests.zip'], 18:25:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:25:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:25:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:25:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:25:01 INFO - u'mozbase': [u'target.common.tests.zip'], 18:25:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:25:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:25:01 INFO - u'web-platform': [u'target.common.tests.zip', 18:25:01 INFO - u'target.web-platform.tests.tar.gz'], 18:25:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:25:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:25:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.common.tests.zip 18:25:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:25:01 INFO - Fetch https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.common.tests.zip into memory 18:25:03 INFO - Content-Length response header: 72391672 18:25:03 INFO - Bytes received: 72391672 18:25:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:25:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.common.tests.zip 18:25:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:25:14 INFO - Fetch https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.common.tests.zip into memory 18:25:16 INFO - Content-Length response header: 72391672 18:25:17 INFO - Bytes received: 72391672 18:25:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.talos.tests.zip 18:25:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:25:30 INFO - Fetch https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.talos.tests.zip into memory 18:25:31 INFO - Content-Length response header: 14496467 18:25:31 INFO - Bytes received: 14496467 18:25:31 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')]} 18:25:31 INFO - trying https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.tar.bz2 18:25:31 INFO - Downloading https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:25:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:25:33 INFO - Downloaded 62254921 bytes. 18:25:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.tar.bz2 18:25:33 INFO - mkdir: /builds/slave/test/properties 18:25:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:25:33 INFO - Writing to file /builds/slave/test/properties/build_url 18:25:33 INFO - Contents: 18:25:33 INFO - build_url:https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.tar.bz2 18:25:33 INFO - Running post-action listener: _resource_record_post_action 18:25:33 INFO - Running post-action listener: set_extra_try_arguments 18:25:33 INFO - [mozharness: 2017-08-02 01:25:33.594715Z] Finished download-and-extract step (success) 18:25:33 INFO - [mozharness: 2017-08-02 01:25:33.594942Z] Running populate-webroot step. 18:25:33 INFO - Running pre-action listener: _resource_record_pre_action 18:25:33 INFO - Running main action method: populate_webroot 18:25:33 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:25:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:25:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:25:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:25:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:25:33 INFO - 'tests': ['damp', 'tps']}, 18:25:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:25:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:25:33 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:25:33 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:25:33 INFO - 'other-e10s': {'tests': ['a11yr', 18:25:33 INFO - 'ts_paint', 18:25:33 INFO - 'tpaint', 18:25:33 INFO - 'sessionrestore', 18:25:33 INFO - 'sessionrestore_many_windows', 18:25:33 INFO - 'sessionrestore_no_auto_restore', 18:25:33 INFO - 'tabpaint']}, 18:25:33 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:25:33 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:25:33 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:25:33 INFO - 'talos_options': ['--mitmproxy', 18:25:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:25:33 INFO - '--firstNonBlankPaint'], 18:25:33 INFO - 'tests': ['quantum_pageload_google', 18:25:33 INFO - 'quantum_pageload_youtube', 18:25:33 INFO - 'quantum_pageload_amazon', 18:25:33 INFO - 'quantum_pageload_facebook']}, 18:25:33 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:25:33 INFO - 'talos_options': ['--stylo', 18:25:33 INFO - '--mitmproxy', 18:25:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:25:33 INFO - '--firstNonBlankPaint'], 18:25:33 INFO - 'tests': ['quantum_pageload_google', 18:25:33 INFO - 'quantum_pageload_youtube', 18:25:33 INFO - 'quantum_pageload_amazon', 18:25:33 INFO - 'quantum_pageload_facebook']}, 18:25:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:25:33 INFO - 'tsvgr_opacity', 18:25:33 INFO - 'tart', 18:25:33 INFO - 'tscrollx', 18:25:33 INFO - 'cart', 18:25:33 INFO - 'tsvg_static']}, 18:25:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:25:33 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:25:33 INFO - 'talos_options': ['--stylo', 18:25:33 INFO - '--stylo-threads=1', 18:25:33 INFO - '--mitmproxy', 18:25:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:25:33 INFO - '--firstNonBlankPaint'], 18:25:33 INFO - 'tests': ['tp6_google', 18:25:33 INFO - 'tp6_youtube', 18:25:33 INFO - 'tp6_amazon', 18:25:33 INFO - 'tp6_facebook']}, 18:25:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:25:33 INFO - 'talos_options': ['--xperf_path', 18:25:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:25:33 INFO - 'tests': ['tp5n']}}} 18:25:33 INFO - Running post-action listener: _resource_record_post_action 18:25:33 INFO - [mozharness: 2017-08-02 01:25:33.609917Z] Finished populate-webroot step (success) 18:25:33 INFO - [mozharness: 2017-08-02 01:25:33.610007Z] Running create-virtualenv step. 18:25:33 INFO - Running pre-action listener: _resource_record_pre_action 18:25:33 INFO - Running main action method: create_virtualenv 18:25:33 INFO - Creating virtualenv /builds/slave/test/build/venv 18:25:33 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 18:25:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:25:33 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:25:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:25:33 INFO - Using real prefix '/usr' 18:25:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:25:34 INFO - Installing distribute.............................................................................................................................................................................................done. 18:25:36 INFO - Installing pip.................done. 18:25:36 INFO - Return code: 0 18:25:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:25:36 INFO - Reading from file tmpfile_stdout 18:25:36 INFO - Output received: 18:25:36 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) 18:25:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:25: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')]} 18:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25: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')]} 18:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:36 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 0x28221f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b92d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8feb0>, '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 0x2b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', '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 18:25:36 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 18:25:36 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 18:25:36 INFO - Using env: {'DISPLAY': ':0', 18:25:36 INFO - 'HOME': '/home/cltbld', 18:25:36 INFO - 'LANG': 'en_US.UTF-8', 18:25:36 INFO - 'LANGUAGE': 'en_US:en', 18:25:36 INFO - 'LOGNAME': 'cltbld', 18:25:36 INFO - 'MAIL': '/var/mail/cltbld', 18:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:36 INFO - 'MOZ_NO_REMOTE': '1', 18:25:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:36 INFO - 'NO_EM_RESTART': '1', 18:25:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:36 INFO - 'PWD': '/builds/slave/test', 18:25:36 INFO - 'SHELL': '/bin/bash', 18:25:36 INFO - 'SHLVL': '1', 18:25:36 INFO - 'TERM': 'linux', 18:25:36 INFO - 'TMOUT': '86400', 18:25:36 INFO - 'USER': 'cltbld', 18:25:36 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', 18:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:36 INFO - '_': '/tools/buildbot/bin/python'} 18:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:36 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 18:25:36 INFO - Cleaning up... 18:25:36 INFO - Return code: 0 18:25:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:25: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')]} 18:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25: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')]} 18:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:36 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 0x28221f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b92d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8feb0>, '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 0x2b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', '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 18:25:36 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 18:25:36 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 18:25:36 INFO - Using env: {'DISPLAY': ':0', 18:25:36 INFO - 'HOME': '/home/cltbld', 18:25:36 INFO - 'LANG': 'en_US.UTF-8', 18:25:36 INFO - 'LANGUAGE': 'en_US:en', 18:25:36 INFO - 'LOGNAME': 'cltbld', 18:25:36 INFO - 'MAIL': '/var/mail/cltbld', 18:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:36 INFO - 'MOZ_NO_REMOTE': '1', 18:25:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:36 INFO - 'NO_EM_RESTART': '1', 18:25:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:36 INFO - 'PWD': '/builds/slave/test', 18:25:36 INFO - 'SHELL': '/bin/bash', 18:25:36 INFO - 'SHLVL': '1', 18:25:36 INFO - 'TERM': 'linux', 18:25:36 INFO - 'TMOUT': '86400', 18:25:36 INFO - 'USER': 'cltbld', 18:25:36 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', 18:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:36 INFO - '_': '/tools/buildbot/bin/python'} 18:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:36 INFO - Downloading/unpacking psutil>=3.1.1 18:25:36 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 18:25:36 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 18:25:36 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 18:25:36 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 18:25:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:25:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:25:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:25:37 INFO - Installing collected packages: psutil 18:25:38 INFO - Running setup.py install for psutil 18:25:38 INFO - building 'psutil._psutil_linux' extension 18:25:38 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 18:25:38 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 18:25:38 INFO - building 'psutil._psutil_posix' extension 18:25:38 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 18:25:38 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 18:25:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:25:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:25:38 INFO - Successfully installed psutil 18:25:38 INFO - Cleaning up... 18:25:38 INFO - Return code: 0 18:25:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:25:38 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')]} 18:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:38 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')]} 18:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:38 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 0x28221f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b92d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8feb0>, '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 0x2b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', '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 18:25:38 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 18:25:38 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 18:25:38 INFO - Using env: {'DISPLAY': ':0', 18:25:38 INFO - 'HOME': '/home/cltbld', 18:25:38 INFO - 'LANG': 'en_US.UTF-8', 18:25:38 INFO - 'LANGUAGE': 'en_US:en', 18:25:38 INFO - 'LOGNAME': 'cltbld', 18:25:38 INFO - 'MAIL': '/var/mail/cltbld', 18:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:38 INFO - 'MOZ_NO_REMOTE': '1', 18:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:38 INFO - 'NO_EM_RESTART': '1', 18:25:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:38 INFO - 'PWD': '/builds/slave/test', 18:25:38 INFO - 'SHELL': '/bin/bash', 18:25:38 INFO - 'SHLVL': '1', 18:25:38 INFO - 'TERM': 'linux', 18:25:38 INFO - 'TMOUT': '86400', 18:25:38 INFO - 'USER': 'cltbld', 18:25:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', 18:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:38 INFO - '_': '/tools/buildbot/bin/python'} 18:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:25:38 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 18:25:38 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 18:25:38 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 18:25:38 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 18:25:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:25:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:25:39 INFO - Installing collected packages: mozsystemmonitor 18:25:39 INFO - Running setup.py install for mozsystemmonitor 18:25:39 INFO - Successfully installed mozsystemmonitor 18:25:39 INFO - Cleaning up... 18:25:40 INFO - Return code: 0 18:25:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:25:40 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')]} 18:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:40 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')]} 18:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:40 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 0x28221f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b92d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8feb0>, '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 0x2b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', '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 18:25:40 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 18:25:40 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 18:25:40 INFO - Using env: {'DISPLAY': ':0', 18:25:40 INFO - 'HOME': '/home/cltbld', 18:25:40 INFO - 'LANG': 'en_US.UTF-8', 18:25:40 INFO - 'LANGUAGE': 'en_US:en', 18:25:40 INFO - 'LOGNAME': 'cltbld', 18:25:40 INFO - 'MAIL': '/var/mail/cltbld', 18:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:40 INFO - 'MOZ_NO_REMOTE': '1', 18:25:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:40 INFO - 'NO_EM_RESTART': '1', 18:25:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:40 INFO - 'PWD': '/builds/slave/test', 18:25:40 INFO - 'SHELL': '/bin/bash', 18:25:40 INFO - 'SHLVL': '1', 18:25:40 INFO - 'TERM': 'linux', 18:25:40 INFO - 'TMOUT': '86400', 18:25:40 INFO - 'USER': 'cltbld', 18:25:40 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', 18:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:40 INFO - '_': '/tools/buildbot/bin/python'} 18:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:40 INFO - Downloading/unpacking jsonschema==2.5.1 18:25:40 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 18:25:40 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 18:25:40 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 18:25:40 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 18:25:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:25:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:25:41 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 18:25:41 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 18:25:41 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 18:25:41 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 18:25:41 INFO - Downloading functools32-3.2.3-2.tar.gz 18:25:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:25:41 INFO - warning: no files found matching '*.txt' 18:25:41 INFO - no previously-included directories found matching 'build' 18:25:41 INFO - no previously-included directories found matching 'dist' 18:25:41 INFO - no previously-included directories found matching '.git*' 18:25:41 INFO - Installing collected packages: jsonschema, functools32 18:25:41 INFO - Running setup.py install for functools32 18:25:41 INFO - warning: no files found matching '*.txt' 18:25:41 INFO - no previously-included directories found matching 'build' 18:25:41 INFO - no previously-included directories found matching 'dist' 18:25:41 INFO - no previously-included directories found matching '.git*' 18:25:41 INFO - Successfully installed jsonschema functools32 18:25:41 INFO - Cleaning up... 18:25:41 INFO - Return code: 0 18:25:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:41 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 0x28221f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b92d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8feb0>, '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 0x2b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', '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 18:25:41 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 18:25:41 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 18:25:41 INFO - Using env: {'DISPLAY': ':0', 18:25:41 INFO - 'HOME': '/home/cltbld', 18:25:41 INFO - 'LANG': 'en_US.UTF-8', 18:25:41 INFO - 'LANGUAGE': 'en_US:en', 18:25:41 INFO - 'LOGNAME': 'cltbld', 18:25:41 INFO - 'MAIL': '/var/mail/cltbld', 18:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:41 INFO - 'MOZ_NO_REMOTE': '1', 18:25:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:41 INFO - 'NO_EM_RESTART': '1', 18:25:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:41 INFO - 'PWD': '/builds/slave/test', 18:25:41 INFO - 'SHELL': '/bin/bash', 18:25:41 INFO - 'SHLVL': '1', 18:25:41 INFO - 'TERM': 'linux', 18:25:41 INFO - 'TMOUT': '86400', 18:25:41 INFO - 'USER': 'cltbld', 18:25:41 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', 18:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:41 INFO - '_': '/tools/buildbot/bin/python'} 18:25:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:25:41 INFO - Cleaning up... 18:25:41 INFO - Return code: 0 18:25:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:41 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 0x28221f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b92d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8feb0>, '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 0x2b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', '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 18:25:41 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 18:25:41 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 18:25:41 INFO - Using env: {'DISPLAY': ':0', 18:25:41 INFO - 'HOME': '/home/cltbld', 18:25:41 INFO - 'LANG': 'en_US.UTF-8', 18:25:41 INFO - 'LANGUAGE': 'en_US:en', 18:25:41 INFO - 'LOGNAME': 'cltbld', 18:25:41 INFO - 'MAIL': '/var/mail/cltbld', 18:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:41 INFO - 'MOZ_NO_REMOTE': '1', 18:25:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:41 INFO - 'NO_EM_RESTART': '1', 18:25:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:41 INFO - 'PWD': '/builds/slave/test', 18:25:41 INFO - 'SHELL': '/bin/bash', 18:25:41 INFO - 'SHLVL': '1', 18:25:41 INFO - 'TERM': 'linux', 18:25:41 INFO - 'TMOUT': '86400', 18:25:41 INFO - 'USER': 'cltbld', 18:25:41 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', 18:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:41 INFO - '_': '/tools/buildbot/bin/python'} 18:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:42 INFO - Downloading/unpacking blobuploader==1.2.4 18:25: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 18:25: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 18:25: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 18:25: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 18:25:43 INFO - Downloading blobuploader-1.2.4.tar.gz 18:25:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:25:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:25:43 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 18:25:43 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 18:25:43 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 18:25:43 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 18:25:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:25:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:25:43 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 18:25:43 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 18:25:43 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 18:25:43 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 18:25:43 INFO - Downloading docopt-0.6.1.tar.gz 18:25:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:25:44 INFO - Installing collected packages: blobuploader, requests, docopt 18:25:44 INFO - Running setup.py install for blobuploader 18:25:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:25:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:25:44 INFO - Running setup.py install for requests 18:25:44 INFO - Running setup.py install for docopt 18:25:44 INFO - Successfully installed blobuploader requests docopt 18:25:44 INFO - Cleaning up... 18:25:44 INFO - Return code: 0 18:25:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25: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')]} 18:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25: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')]} 18:25:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:44 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 0x28221f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b92d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8feb0>, '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 0x2b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', '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 18:25:44 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 18:25:44 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 18:25:44 INFO - Using env: {'DISPLAY': ':0', 18:25:44 INFO - 'HOME': '/home/cltbld', 18:25:44 INFO - 'LANG': 'en_US.UTF-8', 18:25:44 INFO - 'LANGUAGE': 'en_US:en', 18:25:44 INFO - 'LOGNAME': 'cltbld', 18:25:44 INFO - 'MAIL': '/var/mail/cltbld', 18:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:44 INFO - 'MOZ_NO_REMOTE': '1', 18:25:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:44 INFO - 'NO_EM_RESTART': '1', 18:25:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:44 INFO - 'PWD': '/builds/slave/test', 18:25:44 INFO - 'SHELL': '/bin/bash', 18:25:44 INFO - 'SHLVL': '1', 18:25:44 INFO - 'TERM': 'linux', 18:25:44 INFO - 'TMOUT': '86400', 18:25:44 INFO - 'USER': 'cltbld', 18:25:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', 18:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:44 INFO - '_': '/tools/buildbot/bin/python'} 18:25:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:25:44 INFO - Running setup.py (path:/tmp/pip-rBDlgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:25:44 INFO - Running setup.py (path:/tmp/pip-2Qb98_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:25:44 INFO - Running setup.py (path:/tmp/pip-3gAbLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:25:45 INFO - Running setup.py (path:/tmp/pip-uBbX2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:25:45 INFO - Running setup.py (path:/tmp/pip-UQyvhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:25:45 INFO - Running setup.py (path:/tmp/pip-v7BI_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:25:45 INFO - Running setup.py (path:/tmp/pip-0raboE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:25:45 INFO - Running setup.py (path:/tmp/pip-_WERaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:25:45 INFO - Running setup.py (path:/tmp/pip-qI1bCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:25:45 INFO - Running setup.py (path:/tmp/pip-TBp0sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:25:45 INFO - Running setup.py (path:/tmp/pip-bIKiKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:25:45 INFO - Running setup.py (path:/tmp/pip-O5g2gW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:25:45 INFO - Running setup.py (path:/tmp/pip-9R2hig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:25:45 INFO - Running setup.py (path:/tmp/pip-H9hVt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:45 INFO - Running setup.py (path:/tmp/pip-Jhd28G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:25:45 INFO - Running setup.py (path:/tmp/pip-5Xch7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:25:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:25:45 INFO - Running setup.py (path:/tmp/pip-5hZYqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:25:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:25:46 INFO - Running setup.py install for manifestparser 18:25:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:25:46 INFO - Running setup.py install for mozcrash 18:25:46 INFO - Running setup.py install for mozdebug 18:25:46 INFO - Running setup.py install for mozdevice 18:25:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:25:46 INFO - Running setup.py install for mozfile 18:25:46 INFO - Running setup.py install for mozhttpd 18:25:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:25:46 INFO - Running setup.py install for mozinfo 18:25:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:25:46 INFO - Running setup.py install for mozInstall 18:25:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:25:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:25:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:25:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:25:46 INFO - Running setup.py install for mozleak 18:25:46 INFO - Running setup.py install for mozlog 18:25:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:25:47 INFO - Running setup.py install for moznetwork 18:25:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:25:47 INFO - Running setup.py install for mozprocess 18:25:47 INFO - Running setup.py install for mozprofile 18:25:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:25:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:25:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:25:47 INFO - Running setup.py install for mozrunner 18:25:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:25:47 INFO - Running setup.py install for mozscreenshot 18:25:47 INFO - Running setup.py install for moztest 18:25:47 INFO - Running setup.py install for mozversion 18:25:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:25:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:25:47 INFO - Cleaning up... 18:25:47 INFO - Return code: 0 18:25:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:47 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 0x28221f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b92d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8feb0>, '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 0x2b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', '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 18:25:47 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 18:25:47 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 18:25:47 INFO - Using env: {'DISPLAY': ':0', 18:25:47 INFO - 'HOME': '/home/cltbld', 18:25:47 INFO - 'LANG': 'en_US.UTF-8', 18:25:47 INFO - 'LANGUAGE': 'en_US:en', 18:25:47 INFO - 'LOGNAME': 'cltbld', 18:25:47 INFO - 'MAIL': '/var/mail/cltbld', 18:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:47 INFO - 'MOZ_NO_REMOTE': '1', 18:25:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:47 INFO - 'NO_EM_RESTART': '1', 18:25:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:47 INFO - 'PWD': '/builds/slave/test', 18:25:47 INFO - 'SHELL': '/bin/bash', 18:25:47 INFO - 'SHLVL': '1', 18:25:47 INFO - 'TERM': 'linux', 18:25:47 INFO - 'TMOUT': '86400', 18:25:47 INFO - 'USER': 'cltbld', 18:25:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', 18:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:47 INFO - '_': '/tools/buildbot/bin/python'} 18:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:25:48 INFO - Running setup.py (path:/tmp/pip-F9y0my-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:25:48 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)) 18:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:25:48 INFO - Running setup.py (path:/tmp/pip-iyt4av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:25:48 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)) 18:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:25:48 INFO - Running setup.py (path:/tmp/pip-gEqbWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:25:48 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)) 18:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:25:48 INFO - Running setup.py (path:/tmp/pip-iMpJpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:25:48 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)) 18:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:25:48 INFO - Running setup.py (path:/tmp/pip-h9wiHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:25:48 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)) 18:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:25:48 INFO - Running setup.py (path:/tmp/pip-yjw95b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:25:48 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)) 18:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:25:48 INFO - Running setup.py (path:/tmp/pip-99yNnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:25:48 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)) 18:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:25:48 INFO - Running setup.py (path:/tmp/pip-0785YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:25:48 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)) 18:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:25:48 INFO - Running setup.py (path:/tmp/pip-M8JcwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:25:48 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)) 18:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:25:48 INFO - Running setup.py (path:/tmp/pip-UR5SNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:25:48 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)) 18:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:25:48 INFO - Running setup.py (path:/tmp/pip-mFP4bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:25:48 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)) 18:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:25:48 INFO - Running setup.py (path:/tmp/pip-3P3v1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:25:48 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)) 18:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:25:48 INFO - Running setup.py (path:/tmp/pip-4ZgX9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:25:48 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)) 18:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:25:48 INFO - Running setup.py (path:/tmp/pip-8TzBtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:25:49 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)) 18:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:49 INFO - Running setup.py (path:/tmp/pip-UholKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:49 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)) 18:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:25:49 INFO - Running setup.py (path:/tmp/pip-vdvmMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:25:49 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)) 18:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:25:49 INFO - Running setup.py (path:/tmp/pip-4tdPGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:25:49 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)) 18:25:49 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)) 18:25:49 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)) 18:25:49 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)) 18:25:49 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)) 18:25:49 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)) 18:25:49 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)) 18:25:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:25: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 18:25: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 18:25: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 18:25: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 18:25:50 INFO - Downloading blessings-1.6.tar.gz 18:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:25:50 INFO - Installing collected packages: blessings 18:25:50 INFO - Running setup.py install for blessings 18:25:50 INFO - Successfully installed blessings 18:25:50 INFO - Cleaning up... 18:25:50 INFO - Return code: 0 18:25:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:25:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:25:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:25:50 INFO - Reading from file tmpfile_stdout 18:25:50 INFO - Current package versions: 18:25:50 INFO - argparse == 1.2.1 18:25:50 INFO - blessings == 1.6 18:25:50 INFO - blobuploader == 1.2.4 18:25:50 INFO - docopt == 0.6.1 18:25:50 INFO - functools32 == 3.2.3-2 18:25:50 INFO - jsonschema == 2.5.1 18:25:50 INFO - manifestparser == 1.1 18:25:50 INFO - mozInstall == 1.13 18:25:50 INFO - mozcrash == 1.0 18:25:50 INFO - mozdebug == 0.1 18:25:50 INFO - mozdevice == 0.51 18:25:50 INFO - mozfile == 1.2 18:25:50 INFO - mozhttpd == 0.7 18:25:50 INFO - mozinfo == 0.10 18:25:50 INFO - mozleak == 0.1 18:25:50 INFO - mozlog == 3.5 18:25:50 INFO - moznetwork == 0.27 18:25:50 INFO - mozprocess == 0.25 18:25:50 INFO - mozprofile == 0.28 18:25:50 INFO - mozrunner == 6.13 18:25:50 INFO - mozscreenshot == 0.1 18:25:50 INFO - mozsystemmonitor == 0.3 18:25:50 INFO - moztest == 0.8 18:25:50 INFO - mozversion == 1.4 18:25:50 INFO - psutil == 3.1.1 18:25:50 INFO - requests == 1.2.3 18:25:50 INFO - wsgiref == 0.1.2 18:25:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25: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')]} 18:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25: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')]} 18:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:50 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 0x28221f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b92d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8feb0>, '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 0x2b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', '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 18:25:50 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 18:25:50 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 18:25:50 INFO - Using env: {'DISPLAY': ':0', 18:25:50 INFO - 'HOME': '/home/cltbld', 18:25:50 INFO - 'LANG': 'en_US.UTF-8', 18:25:50 INFO - 'LANGUAGE': 'en_US:en', 18:25:50 INFO - 'LOGNAME': 'cltbld', 18:25:50 INFO - 'MAIL': '/var/mail/cltbld', 18:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:50 INFO - 'MOZ_NO_REMOTE': '1', 18:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:50 INFO - 'NO_EM_RESTART': '1', 18:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:50 INFO - 'PWD': '/builds/slave/test', 18:25:50 INFO - 'SHELL': '/bin/bash', 18:25:50 INFO - 'SHLVL': '1', 18:25:50 INFO - 'TERM': 'linux', 18:25:50 INFO - 'TMOUT': '86400', 18:25:50 INFO - 'USER': 'cltbld', 18:25:50 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', 18:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:50 INFO - '_': '/tools/buildbot/bin/python'} 18:25:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:51 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)) 18:25:51 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)) 18:25:51 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)) 18:25:51 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)) 18:25:51 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)) 18:25:51 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)) 18:25:51 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)) 18:25:51 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)) 18:25:51 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)) 18:25:51 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:25:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:25:52 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)) 18:25:52 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)) 18:25:52 INFO - Installing collected packages: simplejson 18:25:52 INFO - Running setup.py install for simplejson 18:25:52 INFO - building 'simplejson._speedups' extension 18:25:52 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 18:25:53 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 18:25:53 INFO - Successfully installed simplejson 18:25:53 INFO - Cleaning up... 18:25:53 INFO - Return code: 0 18:25:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:25: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')]} 18:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25: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')]} 18:25:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:53 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 0x28221f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29efa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b92d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8feb0>, '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 0x2b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91240>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', '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 18:25:53 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 18:25:53 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 18:25:53 INFO - Using env: {'DISPLAY': ':0', 18:25:53 INFO - 'HOME': '/home/cltbld', 18:25:53 INFO - 'LANG': 'en_US.UTF-8', 18:25:53 INFO - 'LANGUAGE': 'en_US:en', 18:25:53 INFO - 'LOGNAME': 'cltbld', 18:25:53 INFO - 'MAIL': '/var/mail/cltbld', 18:25:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:53 INFO - 'MOZ_NO_REMOTE': '1', 18:25:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:53 INFO - 'NO_EM_RESTART': '1', 18:25:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:53 INFO - 'PWD': '/builds/slave/test', 18:25:53 INFO - 'SHELL': '/bin/bash', 18:25:53 INFO - 'SHLVL': '1', 18:25:53 INFO - 'TERM': 'linux', 18:25:53 INFO - 'TMOUT': '86400', 18:25:53 INFO - 'USER': 'cltbld', 18:25:53 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', 18:25:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:53 INFO - '_': '/tools/buildbot/bin/python'} 18:25:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:25:53 INFO - Cleaning up... 18:25:53 INFO - Return code: 0 18:25:53 INFO - Running post-action listener: _resource_record_post_action 18:25:53 INFO - Running post-action listener: _start_resource_monitoring 18:25:53 INFO - Starting resource monitoring. 18:25:53 INFO - [mozharness: 2017-08-02 01:25:53.504918Z] Finished create-virtualenv step (success) 18:25:53 INFO - [mozharness: 2017-08-02 01:25:53.505488Z] Running install step. 18:25:53 INFO - Running pre-action listener: _resource_record_pre_action 18:25:53 INFO - Running main action method: install 18:25:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:25:53 INFO - Reading from file tmpfile_stdout 18:25:53 INFO - Detecting whether we're running mozinstall >=1.0... 18:25:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:25:53 INFO - Reading from file tmpfile_stdout 18:25:53 INFO - Output received: 18:25:53 INFO - Usage: mozinstall [options] installer 18:25:53 INFO - Options: 18:25:53 INFO - -h, --help show this help message and exit 18:25:53 INFO - -d DEST, --destination=DEST 18:25:53 INFO - Directory to install application into. [default: 18:25:53 INFO - "/builds/slave/test"] 18:25:53 INFO - --app=APP Application being installed. [default: firefox] 18:25:53 INFO - mkdir: /builds/slave/test/build/application 18:25:53 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'] 18:25:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:26:11 INFO - Reading from file tmpfile_stdout 18:26:11 INFO - Output received: 18:26:11 INFO - /builds/slave/test/build/application/firefox/firefox 18:26:11 INFO - Running post-action listener: _resource_record_post_action 18:26:11 INFO - [mozharness: 2017-08-02 01:26:11.885710Z] Finished install step (success) 18:26:11 INFO - [mozharness: 2017-08-02 01:26:11.885962Z] Running setup-mitmproxy step. 18:26:11 INFO - Running pre-action listener: _resource_record_pre_action 18:26:11 INFO - Running main action method: setup_mitmproxy 18:26:11 INFO - Skipping: mitmproxy is not required 18:26:11 INFO - Running post-action listener: _resource_record_post_action 18:26:11 INFO - [mozharness: 2017-08-02 01:26:11.887086Z] Finished setup-mitmproxy step (success) 18:26:11 INFO - [mozharness: 2017-08-02 01:26:11.887306Z] Running run-tests step. 18:26:11 INFO - Running pre-action listener: _resource_record_pre_action 18:26:11 INFO - Running pre-action listener: _set_gcov_prefix 18:26:11 INFO - Running main action method: run_tests 18:26:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:26:11 INFO - Python 2.7.3 18:26:11 INFO - Return code: 0 18:26:11 INFO - grabbing minidump binary from tooltool 18:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:11 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 0x2b8feb0>, '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 0x2b90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:26:11 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 18:26:11 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 18:26:11 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 18:26:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:26:12 INFO - Return code: 0 18:26:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:26:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:26:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:26:12 INFO - ENV: RUST_BACKTRACE is now 1 18:26:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:26:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:26:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 18:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 18:26:12 INFO - Using env: {'DISPLAY': ':0', 18:26:12 INFO - 'HOME': '/home/cltbld', 18:26:12 INFO - 'LANG': 'en_US.UTF-8', 18:26:12 INFO - 'LANGUAGE': 'en_US:en', 18:26:12 INFO - 'LOGNAME': 'cltbld', 18:26:12 INFO - 'MAIL': '/var/mail/cltbld', 18:26:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:26:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:12 INFO - 'MOZ_NO_REMOTE': '1', 18:26:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:12 INFO - 'NO_EM_RESTART': '1', 18:26:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:12 INFO - 'PWD': '/builds/slave/test', 18:26:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:26:12 INFO - 'RUST_BACKTRACE': '1', 18:26:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:26:12 INFO - 'SHELL': '/bin/bash', 18:26:12 INFO - 'SHLVL': '1', 18:26:12 INFO - 'TERM': 'linux', 18:26:12 INFO - 'TMOUT': '86400', 18:26:12 INFO - 'USER': 'cltbld', 18:26:12 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732', 18:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:12 INFO - '_': '/tools/buildbot/bin/python'} 18:26:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 18:26:12 INFO - mozversion application_buildid: 20170802003420 18:26:12 INFO - mozversion application_changeset: fec8d72590053c3ad72cd3492d389213dfabc2ff 18:26:12 INFO - mozversion application_display_name: Nightly 18:26:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:26:12 INFO - mozversion application_name: Firefox 18:26:12 INFO - mozversion application_remotingname: firefox 18:26:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:26:12 INFO - mozversion application_vendor: Mozilla 18:26:12 INFO - mozversion application_version: 56.0a1 18:26:12 INFO - mozversion platform_buildid: 20170802003420 18:26:12 INFO - mozversion platform_changeset: fec8d72590053c3ad72cd3492d389213dfabc2ff 18:26:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:26:12 INFO - mozversion platform_version: 56.0a1 18:26:12 INFO - using testdate: 1501637172 18:26:12 INFO - actual date: 1501637172 18:26:12 INFO - starting webserver on 'localhost:48441' 18:26:12 INFO - SUITE-START | Running 2 tests 18:26:12 INFO - TEST-START | dromaeo_css 18:26:12 INFO - Initialising browser for dromaeo_css test... 18:26:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48441/getInfo.html -profile /tmp/tmpqKWbEd/profile 18:26:12 INFO - TEST-INFO | started process 14459 (/builds/slave/test/build/application/firefox/firefox http://localhost:48441/getInfo.html) 18:26:18 INFO - TEST-INFO | 14459: exit 0 18:26:18 INFO - Browser initialized. 18:26:18 INFO - Running cycle 1/1 for dromaeo_css test... 18:26:18 INFO - TEST-INFO | started process 14668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqKWbEd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:26:19 INFO - PID 14668 | 18:26:19 INFO - PID 14668 | (/builds/slave/test/build/application/firefox/firefox:14716): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:26:19 INFO - PID 14668 | 18:26:29 INFO - PID 14668 | RSS: Main: 171753472 18:26:29 INFO - PID 14668 | 18:29:28 INFO - PID 14668 | Cycle 1(1): loaded http://localhost:48441/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48441/tests/dromaeo/cssquery-ext.html) 18:29:29 INFO - PID 14668 | RSS: Main: 171589632 18:29:29 INFO - PID 14668 | 18:32:31 INFO - PID 14668 | Cycle 1(1): loaded http://localhost:48441/tests/dromaeo/cssquery-ext.html (next: http://localhost:48441/tests/dromaeo/cssquery-jquery.html) 18:32:32 INFO - PID 14668 | RSS: Main: 171651072 18:32:32 INFO - PID 14668 | 18:35:33 INFO - PID 14668 | Cycle 1(1): loaded http://localhost:48441/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48441/tests/dromaeo/cssquery-mootools.html) 18:35:34 INFO - PID 14668 | RSS: Main: 173654016 18:35:34 INFO - PID 14668 | 18:38:36 INFO - PID 14668 | Cycle 1(1): loaded http://localhost:48441/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48441/tests/dromaeo/cssquery-prototype.html) 18:38:36 INFO - PID 14668 | RSS: Main: 171872256 18:38:36 INFO - PID 14668 | 18:41:40 INFO - PID 14668 | Cycle 1(1): loaded http://localhost:48441/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48441/tests/dromaeo/cssquery-yui.html) 18:41:41 INFO - PID 14668 | RSS: Main: 174600192 18:41:41 INFO - PID 14668 | 18:44:43 INFO - PID 14668 | Cycle 1(1): loaded http://localhost:48441/tests/dromaeo/cssquery-yui.html (next: http://localhost:48441/tests/dromaeo/cssquery-dojo.html) 18:44:43 INFO - PID 14668 | RSS: Main: 175976448 18:44:43 INFO - PID 14668 | 18:44:43 INFO - PID 14668 | __start_tp_report 18:44:43 INFO - PID 14668 | _x_x_mozilla_page_load 18:44:43 INFO - PID 14668 | _x_x_mozilla_page_load_details 18:44:43 INFO - PID 14668 | |i|pagename|runs| 18:44:43 INFO - PID 14668 | |0;dojo.html;3116.6104236970377;3155.8264295463746;3156.7948083374595;3169.5404166395874;3181.650018497965;6150.3234644189215;6165.506759459238;6203.100550420187;6240.3759624037575;6251.656158911258;6028.4574388305045;6106.938930610692;6107.816765497031;6113.419225173612;6113.449789518942;5579.944200557983;5619.072852979253;5630.634008789416;5686.857828554299;5757.68332741699;5671.744771485293;5688.402717714643;5693.459121383483;5723.313202415695;5724.570657200706;205.81729076120783;5480;5598.636088654224;5700.7719691212305;5721.399253078429;5510.724463776795;5523.944760552424;5548.167774833767;5626.915596266059;5684.175794509814;5570.387257401682;5575.832725018216;5656.575756818214;5662.980663480572;5663.405342439026;6048.758049678007;6077.270727512682;6090.512758979271;6127.080937859312;6180.84547886302;6541.869162616721;6561.639109848957;6633.767818126391;6635.900461493082;6642.036904648847;6538.869222615521;6577.342265773432;6618.437432818217;6626.768063117768;6708.060871477997;6227.190465239535;6232.220972378453;6234.251889773211;6236.937630623681;6257.812265632084;6802.489813264025;6824.658767061726;6921.204061532888;6933.168019837652;6945.16658001033;6510.121133646991;6522.641254731036;6585;6598.010298455174;6603.141591593158;6482.708278127496;6552.803415897531;6558.278589355167;6566.638834864033;6582.17722784652;6526.24948130971;6548.443382312462;6560.639164845884;6573.915303974886;6583;6519.348065193538;6587.967060164764;6610.173728283965;6612.371824676648;6628.502862285348;5400.648957817729;5413.702246376409;5416.214648875891;5420.268263784339;5458.8908221835345;4567.383403240587;4634.768261586907;4653.371794807657;4695.201815691341;4739.052189562101;5718.685472299064;5751.683657398883;5771.509421699203;5799.739011744482;5801.390853960358;6555.934440655532;6663.86672266552;6673.532852700265;6687.933120668828;6771.4582833373215;5652.689102099424;5659.122835960433;5670.546356291569;5773.076307790818;5788.218590490314;5930.525557955353;5935.0503919372695;5949.553783466257;5962.910556341659;5976.491998180203;6478.740850366027;6480;6498.285188629247;6568.507361947873;6573.80278591643;6540.215174179129;6690.19717633887;6714.294999025227;6788.1175447191545;6796.490263230178;6417.614943103429;6434.517411194086;6436.420722135031;6441.645709485836;6453.548251622341;6469.967650161719;6481.287058423664;6546.247181573989;6558;6558.606483610999;6629.701663425254;6648.069270302259;6672.666366681549;6676.132102826796;6805.149356330458;6456.063870738811;6477.740890364333;6511.023346498063;6553.803385898431;6554.115194448688;6365.8726825464155;6460.644664543495;6467.611943283418;6471.061696053952;6581.703823328057;6376.617402955838;6406.103145559532;6414.166158399378;6416.454601358937;6419.325970773189;6461.386168314003;6471.288158302489;6495.253045899782;6535.705893234721;6595.967020164869;6213.875722485615;6287.748490060347;6299.244090709144;6300.59046161998;6446.290908000023 18:44:43 INFO - PID 14668 | |1;ext.html;853.6969375871565;878.4377998081227;905.5427009360272;916.7341470973419;1149.3219000789531;31755.682443175563;32225.67774322256;42278.788606057;43328.78335608318;43669.563304366944;44477.332840007424;44858.77570612142;44918.55081449184;45000.3249951251;45061.7746911265;7717.073951125873;7720.266574675411;7807.984961954938;7874.9212507875045;7880.0937892142565;7770;7864.449488535804;7873.5275883447175;7882.5270483771155;7883.684652613889;7832.216778322179;7889.092754333267;7895.8026049348655;7898.131205567383;7898.921010789876;7797.6880924762945;7884.526928384258;7886.842263154762;7894;7901.604919754018;7771.339436147934;7815.53106813593;7830.921690783076;7831.921680783176;7833.686652533892;40082;40192.79903600463;40247;40264;40283;3674.2467794102145;3696.8336424860677;3700.4264339027222;3729.0863738384;3730.9253814923823;32867.34265314704;32899.17752056194;32947.50578741321;32997;33001.17497062569;4973.35346404965;4974.626902982254;4999.375078115236;5014.974925125351;5017.347744793154;199404;199736;201063;201651;201983;51555.7422212894;51889;51956.74021629868;52020.47979520232;52046.21930671043;54863.45136548583;54932.725336373864;55241.72379138159;55256.44743552594;55322.723386383615;16898;17290.654186916192;17311.48065558035;17323;17340.132993350533;11014.50434730439;11284.435778211056;14158.50445234412;14182.219977901315;14485;15317.31072101758;15334.693306133815;15351.385944562317;15433.691326173413;15494.845051549566;5986.5210783137245;6038.456538911519;6131.233595800525;6142.201513803177;6183.752649894044;1006.9244806639531;1027.8047171037479;1030.7268573827942;1035.570238351091;1044.159451641436;23595.41011474727;23871.045158193825;23963.52072958566;23977;29665.703342966724;1098.8516550265772;1102.079763397556;1116.547798141754;1122.2200570603352;1127.1658972360394;12693.555725549562;12835.679108022374;12924.289164096064;12974.610761677164;12981.286029268293;236707;237811;239087;239835.40246896312;240170;56560;57303.42696573064;57427.71286143542;57460.712696437084;57525.712371437876;1478.7560052591416;1521.7489114296018;1527.2287494815048;1541.1215607104068;1545.9458918938008;24244.63633045541;28313;29075.836966521103;29493;29865.850670747375;54380;55206.72396638152;55371;55414.44585554093;55531.722341388035;223873;225267;226398;227387;228275;31955.520667190474;33229.50155747714;33834.66165338315;38397.23205535818;38748.225035499694;42241.57758422376;42374.576254237065;46735.76632116818;47932.76033619949;48561;34210.82894585511;34526.65473345234;34582.827085865414;34694.47958280678;34698.826505867306;34008.31983360369;34233.31533369368;34238.82880585581;34384.48423273603;34695.306093878484;38179;38185;38198.618013819505;38599.61400386073;38606;32797.50803737898;33104.33791324208;33114.17214569655;33886.152846179044;33893.32213355768;23625.228107891635;24133.758662413853;24344.391390215387;24563;24769.752302476743 18:44:43 INFO - PID 14668 | |2;jquery.html;582.6154737873003;589.2075158911266;591.1989254560074;593.557799439418;607.380471918643;22410.88794556027;23034.848257587095;23401.41496462587;23407.882960585215;23443.531129377403;25248;27213.45573088537;27290;27315.726842731616;27406.862965685144;6764.053032575431;6921.757738479154;6927.757528486504;6940.410065144469;6943.89584156238;6175.598586091912;6687.598744075371;6728.93271067288;6774.085498457719;6776.559523630973;6621.503387245976;6631.104800851896;6632.568883022588;6635.734570617194;6665.866682666344;6634.469242460592;6655.600663960154;6658.300878407746;6660.167479065117;6663.13379260693;6153.323134455206;6163.8150855474405;6164.630122192682;6172.413620706071;6201.875962480725;29338.266543336373;30063.248418789706;30816;31089;31105;1889.1498825528568;1913.9808601913942;1917.3289348727974;1918.6546421644098;1920.2319072371024;19259.80740192594;19892.502687432785;19920.90435026073;19935.302264420676;19950.80049199504;2286.7141607299086;2312.6993490846085;2329.2779238436137;2334.400935359284;2416.7583241675866;144867.275663621;148460;148642.25678871645;149639.25180374138;149707;14819.407223711147;15040.849591503946;15373.1544765039;15437.922810385877;15464.768028479582;24455.63316550253;24540.754592454203;24568.631470527955;24610.138645147694;24646.753532464805;9770.51147442625;10271.126954208976;10336.896631033593;10344.689659310232;10490.737731556772;9379.671711490066;9400.90599094014;9404.153626173676;9450.291228157916;9529.857052144223;8948.8657670135;9207.179020706466;9472.621095156117;9523;9580.473073980858;2776.9166924992282;2777.8611069446447;2821.8165819221686;2826.519491686377;2882.423515296949;959.9712008639752;991.5538007896475;992.2161492420906;1009.7929924365487;1012.5190534496055;20285.391438256876;20323.898380508002;20403.38789836307;20563.8971805143;20934.58130837405;1033.6537260017828;1069.9304545204536;1070.2615195515225;1081.810683130449;1083.3391631105019;11268.21122521432;11285.322880627189;11344.095936361324;11379.203455758017;11630.360330181751;483492;485289;488514;492355;492664;122662;124696;125794;125965;127677;1211.4911737070452;1243;1243.3348158735034;1266.366816591704;1277.3038693911656;18310.26758929628;18417.631647367245;18436.26254949787;18519.44441666752;21220.681689774974;57949.71025145016;58899.70550147222;60330.69834650798;61647;62574.6871265659;73134.26865731274;73274;74165;74180.62909685633;74659.62670186615;12728.74542509163;14898.553043408716;15361.231938403258;15433.922830385776;15463.149526776135;21918.561628767653;23734.287971360885;24744.752552474965;24961.75038249667;25164.74835251624;19184.424467266006;19276.8072319275;19407.902960485106;19684.606307873477;19914.800851991295;17462;17525.386611468537;17710.734338985185;17837.643247135245;18051.638967220846;19190.61618767645;20059.59880802405;20082.899585502564;20235.696464553337;20319.898400507904;14714.484993025193;15165.09009459436;15180.468683596022;15182.544523664308;15202.923985380445;18612.813871861108;18726.344577939708;18762.155702993125;18873;18949.43151705451 18:44:43 INFO - PID 14668 | |3;mootools.html;1340.6246251049704;1371.8833899118574;1389.979150312746;1398.5944076217897;1408.7605107131787;11961.342126183057;13413.865861341385;14049.999999999987;14057.648558786035;14086.788698169536;12128.272303661786;12264.202826816272;13815.378307976165;14303.570892873204;14319.782818460444;2650.41690828018;2758.6413766210367;2761.1854502921587;2763.5163846326914;2769.1138835572624;2618.2407101940416;2683;2702.50003749306;2708.146933715883;2715.8370497770097;2606.622039804237;2612.2163350994624;2615.123933482286;2618;2640.6303117563557;2561.1164148368784;2601.752833480816;2738.2880451082665;2746;2776.5557510798176;2328.2549584133085;2347.084636991575;2350.6944097267415;2357.2928121563464;2737.4798788230173;13806.93096534521;13951.302434878215;13960.232187229698;13983.161010339412;14002.369893354824;7693.230676932318;7973.920260797376;7988.121306656263;7995.200479952016;8000;5065.316182315414;5241.344831896013;5348.866278343034;5426.294581704393;5430.239766432703;1892.9716054259197;1896.6775648139712;1904.9523761905925;1935.6515827151106;1940.0590713503939;22762.886185568965;23282.883585581963;23293.53412931732;23295;23327.650085248733;6931.376176144171;6985.3713165815325;6998.720051197997;7228.819279518054;7279.854402911912;18116;18137.727934081;18268.451946441626;18273.725894111598;18291.908540457214;7808;7979.9202007979175;7994.760157195294;7995.2404521571525;8010.639521221559;7102.928970710227;7188.784336469915;7242.674079666428;7257.419406447471;7335;5485;5625.634333768292;5651.773929042874;5676.552479117881;5705.115707065412;1654.1067823375483;1716.7768190135203;1718.957026074358;1725.3357457379;1756.1394916490829;915.1489115123;921.7004473546124;928.2852203803034;940.5626383731598;955.016333176829;7969.840603187904;8165.469244499089;8254.793630159174;8268.2558569729;8346.290565301895;1010.0808264479435;1010.2524132142162;1036.1969473657825;1037.8080055189814;1040.2406243442329;4605.861824145214;4755.690880092783;4843.782029808667;5353.437889021675;5357.598180136505;18415.90792046058;19027.14377853;19073.904630476758;19099.331523396893;19255.422337329903;18875;18930;19066;19107.331243406414;19153.80846191548;9661.372010819274;10201.948990255001;10394.896051039545;10465.215108866865;10503.632372866912;8000.679972801023;8037.598120094089;8085.83828323442;8104.392170587347;8141.185881411811;15429.922850385676;16149.838501615304;16398.918005410374;16572.088535130682;17119.14404279806;16811.495655130366;16817.747733784247;17000.914995424944;17068.402605908734;17110;10945.452727363441;11007.83488247693;11052;11189.552417903193;11194.384308862765;12810.167339122927;12844.165129266941;12850.55023074188;12884;12884.35578221104;10386.584536618753;10511.947440263055;10553.208509361675;10737.194710396907;10873.891261087289;10494.632687855888;10572.36565806054;10610.416427096276;10647.148228141576;10780.784384312426;9073.410228335137;9311.394759340621;9346.579403926975;9363.906360936304;9406.153446189603;7019.789406317818;7030.648467576703;7046.577205367695;7052.471064670068;7088.681009354488;6832.385085342343;6993.0908981832035;7078.4691148163065;7091.539049961736;7145.749898753519 18:44:43 INFO - PID 14668 | |4;prototype.html;478.9616830653548;488.9733048346863;510.16333213529816;518.1993819548794;530.411243519693;6164.938350616492;6187.164732761082;6209.192804935357;6222.937770622292;6280.623162610246;5920.733566989485;6103.711108334374;6103.786367477139;6120.632762034281;6137.81586552403;4896.939412866958;4937.481564435737;4938.38270216223;4949.8267560635295;4963.528464795857;4847.44254410742;4880.048390563841;4900.289458028602;4917.901641967159;4929.433115191745;4917.704937703731;5007.399112106534;5151.253068305094;5154.433012368637;5210.478952104778;5092.261622064799;5140.6401551891195;5166.664166829181;5182.870428239286;5230.581553475751;4765.189917713962;4766.428028636586;4778.617710583145;4781.856544303677;4808.302796094582;6016.368281330441;6020.548458865603;6030.66831324277;6077.541390066396;6099.237595300588;6028.276606807167;6031.366706495843;6057.121717350959;6067.939320606782;6118.388161183891;6569.67151642416;6572.507061970371;6614.8346291343105;6658.9001164982565;6678;5293.602979776532;5299.708516031616;5341.545968592674;5343.851072019495;5368.194770784375;6797.490188235902;6945.062416573748;6978.197507286625;7007.89488157673;7047.471439641996;5500.7524661390335;5500.972495137498;5523.475269849358;5527.668339899538;5541.501264886099;5566.415526369754;5582.190582365615;5585.1901474286815;5606.243157173811;5647.745851436695;6042.12389203563;6046.818595442144;6054.54590905675;6072.301685306246;6087.1173679816175;6575.013747937752;6664.733410663519;6676.198856137295;6691.397774200345;6707.8261304271555;1828.542864283929;1857.619188066443;1929.8842069475877;1931.7681878174708;1946.7371904792956;1346.3537501999094;1392.9373178206802;1429.3139293139352;1459.569427019032;1478.4381934864898;5734.655920644775;5740.425957404226;5763.971180144073;5766.163906233573;5833.570775160113;6613.834654133685;6642;6648.301928297556;6660.733570657217;6713.791517526794;5724.713764311851;5729.828105156852;5785.71071446426;5827;5854.268216472941;3570.553680789901;3574.5889222739197;3578.3022310649694;3615.3492371373404;3616.367135751233;6556.967215163893;6573.7370505180215;6620;6627.469802415795;6647.86704265912;6931.133608298963;6974.105746115305;6979.883218685088;6993.545419547713;7001.299870012958;6498.740050398026;6511.576747511492;6521.250056243593;6587.176602924635;6627.4366678831875;6712.261651218264;6732.730690772511;6751.56114852533;6808.183018037669;6811.910094384874;6642.867142657024;6675.33246675348;6711.765088221889;6756.155480564929;6771.255161932085;6486.383793539606;6542.803715888531;6567.737290508326;6602.702878370389;6630.9668451657435;4938.678985865908;5008.424031236309;5008.9499105009945;5026.472220416804;5051.520105589963;6715.086200432853;6719.193696756421;6739.393454589111;6774.390304872585;6816.977453381834;6497.967510162608;6543.869122617616;6588.670566471753;6629.933700662931;6682.9331706682315;6528.850908255453;6531.902021469777;6565.901511477236;6625.370589793962;6629.613339197788;6258.968705156445;6272.372762723874;6282.403171698681;6408.327125651926;6502.739890404331;6505.795363709109;6555.311692272243;6572.934270657232;6582.728958509307;6597;6170.321264660974;6254.6247225166635;6271.686415679289;6274.6548939808745;6372.235331760218 18:44:43 INFO - PID 14668 | |5;yui.html;881.3213825354474;892.678635691151;901.4456109492664;905.556277424062;918.5131880103545;18110.728339074925;18807.529811754714;18931.52671183221;18934.526636834085;20556;20233.494162645904;20972.790272097314;21093.57812843746;21127.683084753742;21146.259880904134;1009.8081364540714;1039.2984735303678;1042.0725554256717;1043.3844032021107;1043.9582416703322;1007.5163921317771;1037.8443233514995;1051.369178492902;1053.4048262731571;1057.603398725478;1102.685734565649;1105.1324710102572;1107.5182295701356;1108.5731993182642;1109.6504601050642;1097.8243481043075;1099.3074363151204;1100.5652767156969;1103.2112039891435;1103.8454616353677;793.0800271684875;796.4186144114828;800.2117913854848;800.5997001499251;800.9799755006171;19506.219751209934;19695.803041969684;19894.303699370597;19902;20398.28605998798;20680.896595516926;20738.792612073838;21177.68233476499;21206.151753929826;21268.787312126835;15898.443554475538;16316.102614356205;16352.264148113363;16512.174391280387;16593.336266549322;3538.469229615578;3562.8752993645357;3564.3405969895653;3565.4651802229873;3565.6434356564396;130262;130347;130392;134092.999999999;134756;14387.352569134206;14812.62968425798;14904.70190596182;15173.544793656209;15289.464868729541;29444.55833162504;30128.69871301303;30992.845035774677;31104.066877993697;31126.22184445407;7297;7671.693132274647;8287.337013038943;8890.955545222361;9125;4312.870613881589;4400.295952647561;4406.184855801687;4422.889427764331;4432.689711720213;5172.715500647425;5225.686458812407;5298.894022119536;5313.2030195470215;5336.62643614951;1067.8467255364187;1072.7586293083993;1086.4893500054961;1094.715374002749;1099.6261271167682;606.5541826757329;619.7149311316755;635.196476457282;639.9904001439982;652.1261509577095;10666;11539.538418463335;11738.941305293589;11755.588554400554;11812.822807657893;667.2626747444004;674.9460043196533;675.5136301862651;689.3175756001523;690.702997710989;5256.500632439912;5329.600279979017;5373.2208829719475;5459.153831156177;5460.890782184334;103742.4812875946;105855.4707226459;106123;106236;107363;95222.52388738011;95545;96797.51601242089;99095;99116;85977;86452.13547864566;86719.13280867237;86844.99999999873;91424.54287728519;11581.073514119018;12073.698157546132;12456.43946022413;12648.177868438523;12707.93646031801;36334.27331453409;37190.25619487649;37660.43509347417;38274.80862595669;38781.41827872641;67158.32841671717;68374.3162568368;68835.65582172057;71460.85617431486;72855.27144728697;18953.715694264873;19354.903225483784;19559.70660440123;19623.70564441563;19689.310874119335;20733.377998660064;21400.892995534923;21432.249871254433;21496.67754983645;21772.564548709255;16816.159192040104;17213.483595492155;17917.641647167246;17985.190666420305;18249.361272355403;18199.727004094686;18923.526911827314;19001.529801125766;19374.128164232927;19520.414387568395;18189;18209.81790182134;18667;18859.24563017464;18963.33628323002;13661.607734338526;13782.310884455537;14297.571072867831;14427.639309016939;14539.418423263374;13802.861971380158;13924.094933829674;14067.015308928278;14154.009219354546;14162.78755818643 18:44:43 INFO - PID 14668 | __end_tp_report 18:44:43 INFO - PID 14668 | __start_cc_report 18:44:43 INFO - PID 14668 | _x_x_mozilla_cycle_collect,386 18:44:43 INFO - PID 14668 | __end_cc_report 18:44:43 INFO - PID 14668 | __startTimestamp1501638283390__endTimestamp 18:44:43 INFO - PID 14668 | 18:44:43 INFO - PID 14668 | ------- Summary: start ------- 18:44:43 INFO - PID 14668 | Number of tests: 6 18:44:43 INFO - PID 14668 | 18:44:43 INFO - PID 14668 | [#0] dojo.html Cycles:165 Average:6076.33 Median:6414.17 stddev:849.76 (13.2%) stddev-sans-first:820.03 18:44:43 INFO - PID 14668 | Values: 3116.6 3155.8 3156.8 3169.5 3181.7 6150.3 6165.5 6203.1 6240.4 6251.7 6028.5 6106.9 6107.8 6113.4 6113.4 5579.9 5619.1 5630.6 5686.9 5757.7 5671.7 5688.4 5693.5 5723.3 5724.6 205.8 5480.0 5598.6 5700.8 5721.4 5510.7 5523.9 5548.2 5626.9 5684.2 5570.4 5575.8 5656.6 5663.0 5663.4 6048.8 6077.3 6090.5 6127.1 6180.8 6541.9 6561.6 6633.8 6635.9 6642.0 6538.9 6577.3 6618.4 6626.8 6708.1 6227.2 6232.2 6234.3 6236.9 6257.8 6802.5 6824.7 6921.2 6933.2 6945.2 6510.1 6522.6 6585.0 6598.0 6603.1 6482.7 6552.8 6558.3 6566.6 6582.2 6526.2 6548.4 6560.6 6573.9 6583.0 6519.3 6588.0 6610.2 6612.4 6628.5 5400.6 5413.7 5416.2 5420.3 5458.9 4567.4 4634.8 4653.4 4695.2 4739.1 5718.7 5751.7 5771.5 5799.7 5801.4 6555.9 6663.9 6673.5 6687.9 6771.5 5652.7 5659.1 5670.5 5773.1 5788.2 5930.5 5935.1 5949.6 5962.9 5976.5 6478.7 6480.0 6498.3 6568.5 6573.8 6540.2 6690.2 6714.3 6788.1 6796.5 6417.6 6434.5 6436.4 6441.6 6453.5 6470.0 6481.3 6546.2 6558.0 6558.6 6629.7 6648.1 6672.7 6676.1 6805.1 6456.1 6477.7 6511.0 6553.8 6554.1 6365.9 6460.6 6467.6 6471.1 6581.7 6376.6 6406.1 6414.2 6416.5 6419.3 6461.4 6471.3 6495.3 6535.7 6596.0 6213.9 6287.7 6299.2 6300.6 6446.3 18:44:43 INFO - PID 14668 | 18:44:43 INFO - PID 14668 | [#1] ext.html Cycles:180 Average:40496.72 Median:19186.54 stddev:57729.17 (300.9%) stddev-sans-first:57814.37 18:44:43 INFO - PID 14668 | Values: 853.7 878.4 905.5 916.7 1149.3 31755.7 32225.7 42278.8 43328.8 43669.6 44477.3 44858.8 44918.6 45000.3 45061.8 7717.1 7720.3 7808.0 7874.9 7880.1 7770.0 7864.4 7873.5 7882.5 7883.7 7832.2 7889.1 7895.8 7898.1 7898.9 7797.7 7884.5 7886.8 7894.0 7901.6 7771.3 7815.5 7830.9 7831.9 7833.7 40082.0 40192.8 40247.0 40264.0 40283.0 3674.2 3696.8 3700.4 3729.1 3730.9 32867.3 32899.2 32947.5 32997.0 33001.2 4973.4 4974.6 4999.4 5015.0 5017.3 199404.0 199736.0 201063.0 201651.0 201983.0 51555.7 51889.0 51956.7 52020.5 52046.2 54863.5 54932.7 55241.7 55256.4 55322.7 16898.0 17290.7 17311.5 17323.0 17340.1 11014.5 11284.4 14158.5 14182.2 14485.0 15317.3 15334.7 15351.4 15433.7 15494.8 5986.5 6038.5 6131.2 6142.2 6183.8 1006.9 1027.8 1030.7 1035.6 1044.2 23595.4 23871.0 23963.5 23977.0 29665.7 1098.9 1102.1 1116.5 1122.2 1127.2 12693.6 12835.7 12924.3 12974.6 12981.3 236707.0 237811.0 239087.0 239835.4 240170.0 56560.0 57303.4 57427.7 57460.7 57525.7 1478.8 1521.7 1527.2 1541.1 1545.9 24244.6 28313.0 29075.8 29493.0 29865.9 54380.0 55206.7 55371.0 55414.4 55531.7 223873.0 225267.0 226398.0 227387.0 228275.0 31955.5 33229.5 33834.7 38397.2 38748.2 42241.6 42374.6 46735.8 47932.8 48561.0 34210.8 34526.7 34582.8 34694.5 34698.8 34008.3 34233.3 34238.8 34384.5 34695.3 38179.0 38185.0 38198.6 38599.6 38606.0 32797.5 33104.3 33114.2 33886.2 33893.3 23625.2 24133.8 24344.4 24563.0 24769.8 18:44:43 INFO - PID 14668 | 18:44:43 INFO - PID 14668 | [#2] jquery.html Cycles:180 Average:35837.16 Median:2320.99 stddev:82978.26 (3575.1%) stddev-sans-first:83168.82 18:44:43 INFO - PID 14668 | Values: 582.6 589.2 591.2 593.6 607.4 22410.9 23034.8 23401.4 23407.9 23443.5 25248.0 27213.5 27290.0 27315.7 27406.9 6764.1 6921.8 6927.8 6940.4 6943.9 6175.6 6687.6 6728.9 6774.1 6776.6 6621.5 6631.1 6632.6 6635.7 6665.9 6634.5 6655.6 6658.3 6660.2 6663.1 6153.3 6163.8 6164.6 6172.4 6201.9 29338.3 30063.2 30816.0 31089.0 31105.0 1889.1 1914.0 1917.3 1918.7 1920.2 19259.8 19892.5 19920.9 19935.3 19950.8 2286.7 2312.7 2329.3 2334.4 2416.8 144867.3 148460.0 148642.3 149639.3 149707.0 14819.4 15040.8 15373.2 15437.9 15464.8 24455.6 24540.8 24568.6 24610.1 24646.8 9770.5 10271.1 10336.9 10344.7 10490.7 9379.7 9400.9 9404.2 9450.3 9529.9 8948.9 9207.2 9472.6 9523.0 9580.5 2776.9 2777.9 2821.8 2826.5 2882.4 960.0 991.6 992.2 1009.8 1012.5 20285.4 20323.9 20403.4 20563.9 20934.6 1033.7 1069.9 1070.3 1081.8 1083.3 11268.2 11285.3 11344.1 11379.2 11630.4 483492.0 485289.0 488514.0 492355.0 492664.0 122662.0 124696.0 125794.0 125965.0 127677.0 1211.5 1243.0 1243.3 1266.4 1277.3 18310.3 18417.6 18436.3 18519.4 21220.7 57949.7 58899.7 60330.7 61647.0 62574.7 73134.3 73274.0 74165.0 74180.6 74659.6 12728.7 14898.6 15361.2 15433.9 15463.1 21918.6 23734.3 24744.8 24961.8 25164.7 19184.4 19276.8 19407.9 19684.6 19914.8 17462.0 17525.4 17710.7 17837.6 18051.6 19190.6 20059.6 20082.9 20235.7 20319.9 14714.5 15165.1 15180.5 15182.5 15202.9 18612.8 18726.3 18762.2 18873.0 18949.4 18:44:43 INFO - PID 14668 | 18:44:43 INFO - PID 14668 | [#3] mootools.html Cycles:180 Average:8745.15 Median:2348.89 stddev:5899.35 (251.2%) stddev-sans-first:5889.67 18:44:43 INFO - PID 14668 | Values: 1340.6 1371.9 1390.0 1398.6 1408.8 11961.3 13413.9 14050.0 14057.6 14086.8 12128.3 12264.2 13815.4 14303.6 14319.8 2650.4 2758.6 2761.2 2763.5 2769.1 2618.2 2683.0 2702.5 2708.1 2715.8 2606.6 2612.2 2615.1 2618.0 2640.6 2561.1 2601.8 2738.3 2746.0 2776.6 2328.3 2347.1 2350.7 2357.3 2737.5 13806.9 13951.3 13960.2 13983.2 14002.4 7693.2 7973.9 7988.1 7995.2 8000.0 5065.3 5241.3 5348.9 5426.3 5430.2 1893.0 1896.7 1905.0 1935.7 1940.1 22762.9 23282.9 23293.5 23295.0 23327.7 6931.4 6985.4 6998.7 7228.8 7279.9 18116.0 18137.7 18268.5 18273.7 18291.9 7808.0 7979.9 7994.8 7995.2 8010.6 7102.9 7188.8 7242.7 7257.4 7335.0 5485.0 5625.6 5651.8 5676.6 5705.1 1654.1 1716.8 1719.0 1725.3 1756.1 915.1 921.7 928.3 940.6 955.0 7969.8 8165.5 8254.8 8268.3 8346.3 1010.1 1010.3 1036.2 1037.8 1040.2 4605.9 4755.7 4843.8 5353.4 5357.6 18415.9 19027.1 19073.9 19099.3 19255.4 18875.0 18930.0 19066.0 19107.3 19153.8 9661.4 10201.9 10394.9 10465.2 10503.6 8000.7 8037.6 8085.8 8104.4 8141.2 15429.9 16149.8 16398.9 16572.1 17119.1 16811.5 16817.7 17000.9 17068.4 17110.0 10945.5 11007.8 11052.0 11189.6 11194.4 12810.2 12844.2 12850.6 12884.0 12884.4 10386.6 10511.9 10553.2 10737.2 10873.9 10494.6 10572.4 10610.4 10647.1 10780.8 9073.4 9311.4 9346.6 9363.9 9406.2 7019.8 7030.6 7046.6 7052.5 7088.7 6832.4 6993.1 7078.5 7091.5 7145.7 18:44:43 INFO - PID 14668 | 18:44:43 INFO - PID 14668 | [#4] prototype.html Cycles:180 Average:5608.43 Median:6103.75 stddev:1519.44 (24.9%) stddev-sans-first:1474.12 18:44:43 INFO - PID 14668 | Values: 479.0 489.0 510.2 518.2 530.4 6164.9 6187.2 6209.2 6222.9 6280.6 5920.7 6103.7 6103.8 6120.6 6137.8 4896.9 4937.5 4938.4 4949.8 4963.5 4847.4 4880.0 4900.3 4917.9 4929.4 4917.7 5007.4 5151.3 5154.4 5210.5 5092.3 5140.6 5166.7 5182.9 5230.6 4765.2 4766.4 4778.6 4781.9 4808.3 6016.4 6020.5 6030.7 6077.5 6099.2 6028.3 6031.4 6057.1 6067.9 6118.4 6569.7 6572.5 6614.8 6658.9 6678.0 5293.6 5299.7 5341.5 5343.9 5368.2 6797.5 6945.1 6978.2 7007.9 7047.5 5500.8 5501.0 5523.5 5527.7 5541.5 5566.4 5582.2 5585.2 5606.2 5647.7 6042.1 6046.8 6054.5 6072.3 6087.1 6575.0 6664.7 6676.2 6691.4 6707.8 1828.5 1857.6 1929.9 1931.8 1946.7 1346.4 1392.9 1429.3 1459.6 1478.4 5734.7 5740.4 5764.0 5766.2 5833.6 6613.8 6642.0 6648.3 6660.7 6713.8 5724.7 5729.8 5785.7 5827.0 5854.3 3570.6 3574.6 3578.3 3615.3 3616.4 6557.0 6573.7 6620.0 6627.5 6647.9 6931.1 6974.1 6979.9 6993.5 7001.3 6498.7 6511.6 6521.3 6587.2 6627.4 6712.3 6732.7 6751.6 6808.2 6811.9 6642.9 6675.3 6711.8 6756.2 6771.3 6486.4 6542.8 6567.7 6602.7 6631.0 4938.7 5008.4 5008.9 5026.5 5051.5 6715.1 6719.2 6739.4 6774.4 6817.0 6498.0 6543.9 6588.7 6629.9 6682.9 6528.9 6531.9 6565.9 6625.4 6629.6 6259.0 6272.4 6282.4 6408.3 6502.7 6505.8 6555.3 6572.9 6582.7 6597.0 6170.3 6254.6 6271.7 6274.7 6372.2 18:44:43 INFO - PID 14668 | 18:44:43 INFO - PID 14668 | [#5] yui.html Cycles:180 Average:23770.96 Median:19795.05 stddev:32335.71 (163.4%) stddev-sans-first:32380.74 18:44:43 INFO - PID 14668 | Values: 881.3 892.7 901.4 905.6 918.5 18110.7 18807.5 18931.5 18934.5 20556.0 20233.5 20972.8 21093.6 21127.7 21146.3 1009.8 1039.3 1042.1 1043.4 1044.0 1007.5 1037.8 1051.4 1053.4 1057.6 1102.7 1105.1 1107.5 1108.6 1109.7 1097.8 1099.3 1100.6 1103.2 1103.8 793.1 796.4 800.2 800.6 801.0 19506.2 19695.8 19894.3 19902.0 20398.3 20680.9 20738.8 21177.7 21206.2 21268.8 15898.4 16316.1 16352.3 16512.2 16593.3 3538.5 3562.9 3564.3 3565.5 3565.6 130262.0 130347.0 130392.0 134093.0 134756.0 14387.4 14812.6 14904.7 15173.5 15289.5 29444.6 30128.7 30992.8 31104.1 31126.2 7297.0 7671.7 8287.3 8891.0 9125.0 4312.9 4400.3 4406.2 4422.9 4432.7 5172.7 5225.7 5298.9 5313.2 5336.6 1067.8 1072.8 1086.5 1094.7 1099.6 606.6 619.7 635.2 640.0 652.1 10666.0 11539.5 11738.9 11755.6 11812.8 667.3 674.9 675.5 689.3 690.7 5256.5 5329.6 5373.2 5459.2 5460.9 103742.5 105855.5 106123.0 106236.0 107363.0 95222.5 95545.0 96797.5 99095.0 99116.0 85977.0 86452.1 86719.1 86845.0 91424.5 11581.1 12073.7 12456.4 12648.2 12707.9 36334.3 37190.3 37660.4 38274.8 38781.4 67158.3 68374.3 68835.7 71460.9 72855.3 18953.7 19354.9 19559.7 19623.7 19689.3 20733.4 21400.9 21432.2 21496.7 21772.6 16816.2 17213.5 17917.6 17985.2 18249.4 18199.7 18923.5 19001.5 19374.1 19520.4 18189.0 18209.8 18667.0 18859.2 18963.3 13661.6 13782.3 14297.6 14427.6 14539.4 13802.9 13924.1 14067.0 14154.0 14162.8 18:44:43 INFO - PID 14668 | -------- Summary: end -------- 18:44:43 INFO - PID 14668 | 18:44:44 INFO - TEST-INFO | 14668: exit 0 18:44:44 INFO - TEST-OK | dromaeo_css | took 1111847ms 18:44:44 INFO - TEST-START | kraken 18:44:44 INFO - Initialising browser for kraken test... 18:44:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48441/getInfo.html -profile /tmp/tmpr1qaCf/profile 18:44:44 INFO - TEST-INFO | started process 15029 (/builds/slave/test/build/application/firefox/firefox http://localhost:48441/getInfo.html) 18:44:50 INFO - TEST-INFO | 15029: exit 0 18:44:50 INFO - Browser initialized. 18:44:50 INFO - Running cycle 1/1 for kraken test... 18:44:50 INFO - TEST-INFO | started process 15237 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr1qaCf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:44:51 INFO - PID 15237 | 18:44:51 INFO - PID 15237 | (/builds/slave/test/build/application/firefox/firefox:15285): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:44:51 INFO - PID 15237 | 18:45:01 INFO - PID 15237 | RSS: Main: 172023808 18:45:01 INFO - PID 15237 | 18:45:04 INFO - PID 15237 | Cycle 1(1): loaded http://localhost:48441/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48441/tests/kraken/driver.html?testName=audio-beat-detection) 18:45:05 INFO - PID 15237 | RSS: Main: 176631808 18:45:05 INFO - PID 15237 | 18:45:07 INFO - PID 15237 | Cycle 1(1): loaded http://localhost:48441/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48441/tests/kraken/driver.html?testName=audio-dft) 18:45:08 INFO - PID 15237 | RSS: Main: 177106944 18:45:08 INFO - PID 15237 | 18:45:11 INFO - PID 15237 | Cycle 1(1): loaded http://localhost:48441/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48441/tests/kraken/driver.html?testName=audio-fft) 18:45:12 INFO - PID 15237 | RSS: Main: 171696128 18:45:12 INFO - PID 15237 | 18:45:14 INFO - PID 15237 | Cycle 1(1): loaded http://localhost:48441/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48441/tests/kraken/driver.html?testName=audio-oscillator) 18:45:14 INFO - PID 15237 | RSS: Main: 172294144 18:45:14 INFO - PID 15237 | 18:45:16 INFO - PID 15237 | Cycle 1(1): loaded http://localhost:48441/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48441/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:45:17 INFO - PID 15237 | RSS: Main: 172548096 18:45:17 INFO - PID 15237 | 18:45:20 INFO - PID 15237 | Cycle 1(1): loaded http://localhost:48441/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48441/tests/kraken/driver.html?testName=imaging-darkroom) 18:45:21 INFO - PID 15237 | RSS: Main: 175493120 18:45:21 INFO - PID 15237 | 18:45:24 INFO - PID 15237 | Cycle 1(1): loaded http://localhost:48441/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48441/tests/kraken/driver.html?testName=imaging-desaturate) 18:45:25 INFO - PID 15237 | RSS: Main: 174952448 18:45:25 INFO - PID 15237 | 18:45:28 INFO - PID 15237 | Cycle 1(1): loaded http://localhost:48441/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48441/tests/kraken/driver.html?testName=json-parse-financial) 18:45:28 INFO - PID 15237 | RSS: Main: 175452160 18:45:28 INFO - PID 15237 | 18:45:30 INFO - PID 15237 | Cycle 1(1): loaded http://localhost:48441/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48441/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:45:31 INFO - PID 15237 | RSS: Main: 175353856 18:45:31 INFO - PID 15237 | 18:45:32 INFO - PID 15237 | Cycle 1(1): loaded http://localhost:48441/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48441/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:45:33 INFO - PID 15237 | RSS: Main: 175525888 18:45:33 INFO - PID 15237 | 18:45:35 INFO - PID 15237 | Cycle 1(1): loaded http://localhost:48441/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48441/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:45:36 INFO - PID 15237 | RSS: Main: 171978752 18:45:36 INFO - PID 15237 | 18:45:39 INFO - PID 15237 | Cycle 1(1): loaded http://localhost:48441/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:45:39 INFO - PID 15237 | RSS: Main: 173109248 18:45:39 INFO - PID 15237 | 18:45:42 INFO - PID 15237 | Cycle 1(1): loaded http://localhost:48441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:45:43 INFO - PID 15237 | RSS: Main: 173109248 18:45:43 INFO - PID 15237 | 18:45:45 INFO - PID 15237 | Cycle 1(1): loaded http://localhost:48441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48441/tests/kraken/driver.html?testName=ai-astar) 18:45:45 INFO - PID 15237 | RSS: Main: 174727168 18:45:45 INFO - PID 15237 | 18:45:45 INFO - PID 15237 | __start_tp_report 18:45:45 INFO - PID 15237 | _x_x_mozilla_page_load 18:45:45 INFO - PID 15237 | _x_x_mozilla_page_load_details 18:45:45 INFO - PID 15237 | |i|pagename|runs| 18:45:45 INFO - PID 15237 | |0;ai-astar;100;108;101;108;109;111;109;103;107;109 18:45:45 INFO - PID 15237 | |1;audio-beat-detection;150;118;141;171;118;150;148;128;181;120 18:45:45 INFO - PID 15237 | |2;audio-dft;164;162;163;165;163;162;162;163;179;164 18:45:45 INFO - PID 15237 | |3;audio-fft;74;76;75;171;77;75;73;74;149;76 18:45:45 INFO - PID 15237 | |4;audio-oscillator;78;79;133;79;78;78;123;78;79;124 18:45:45 INFO - PID 15237 | |5;imaging-gaussian-blur;114;115;115;114;115;114;114;115;114;114 18:45:45 INFO - PID 15237 | |6;imaging-darkroom;151;151;152;150;150;150;151;151;151;150 18:45:45 INFO - PID 15237 | |7;imaging-desaturate;93;94;94;94;95;94;94;94;94;95 18:45:45 INFO - PID 15237 | |8;json-parse-financial;55;54;54;53;55;54;54;55;55;53 18:45:45 INFO - PID 15237 | |9;json-stringify-tinderbox;54;54;54;54;53;55;54;55;54;55 18:45:45 INFO - PID 15237 | |10;stanford-crypto-aes;76;91;78;89;78;78;79;79;80;77 18:45:45 INFO - PID 15237 | |11;stanford-crypto-ccm;141;128;126;131;130;135;126;125;125;159 18:45:45 INFO - PID 15237 | |12;stanford-crypto-pbkdf2;187;173;175;176;172;192;181;173;171;171 18:45:45 INFO - PID 15237 | |13;stanford-crypto-sha256-iterative;68;67;67;66;68;69;71;67;67;66 18:45:45 INFO - PID 15237 | __end_tp_report 18:45:45 INFO - PID 15237 | __start_cc_report 18:45:45 INFO - PID 15237 | _x_x_mozilla_cycle_collect,1027 18:45:45 INFO - PID 15237 | __end_cc_report 18:45:45 INFO - PID 15237 | __startTimestamp1501638345455__endTimestamp 18:45:45 INFO - PID 15237 | 18:45:45 INFO - PID 15237 | ------- Summary: start ------- 18:45:45 INFO - PID 15237 | Number of tests: 14 18:45:45 INFO - PID 15237 | 18:45:45 INFO - PID 15237 | [#0] ai-astar Cycles:10 Average:106.50 Median:108.50 stddev:3.78 (3.5%) stddev-sans-first:3.19 18:45:45 INFO - PID 15237 | Values: 100.0 108.0 101.0 108.0 109.0 111.0 109.0 103.0 107.0 109.0 18:45:45 INFO - PID 15237 | 18:45:45 INFO - PID 15237 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:149.00 stddev:22.00 (14.8%) stddev-sans-first:23.17 18:45:45 INFO - PID 15237 | Values: 150.0 118.0 141.0 171.0 118.0 150.0 148.0 128.0 181.0 120.0 18:45:45 INFO - PID 15237 | 18:45:45 INFO - PID 15237 | [#2] audio-dft Cycles:10 Average:164.70 Median:163.50 stddev:5.12 (3.1%) stddev-sans-first:5.43 18:45:45 INFO - PID 15237 | Values: 164.0 162.0 163.0 165.0 163.0 162.0 162.0 163.0 179.0 164.0 18:45:45 INFO - PID 15237 | 18:45:45 INFO - PID 15237 | [#3] audio-fft Cycles:10 Average:92.00 Median:75.00 stddev:36.23 (48.3%) stddev-sans-first:37.84 18:45:45 INFO - PID 15237 | Values: 74.0 76.0 75.0 171.0 77.0 75.0 73.0 74.0 149.0 76.0 18:45:45 INFO - PID 15237 | 18:45:45 INFO - PID 15237 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:78.00 stddev:23.45 (30.1%) stddev-sans-first:24.24 18:45:45 INFO - PID 15237 | Values: 78.0 79.0 133.0 79.0 78.0 78.0 123.0 78.0 79.0 124.0 18:45:45 INFO - PID 15237 | 18:45:45 INFO - PID 15237 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:45:45 INFO - PID 15237 | Values: 114.0 115.0 115.0 114.0 115.0 114.0 114.0 115.0 114.0 114.0 18:45:45 INFO - PID 15237 | 18:45:45 INFO - PID 15237 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 18:45:45 INFO - PID 15237 | Values: 151.0 151.0 152.0 150.0 150.0 150.0 151.0 151.0 151.0 150.0 18:45:45 INFO - PID 15237 | 18:45:45 INFO - PID 15237 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 18:45:45 INFO - PID 15237 | Values: 93.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 18:45:45 INFO - PID 15237 | 18:45:45 INFO - PID 15237 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:0.79 (1.4%) stddev-sans-first:0.78 18:45:45 INFO - PID 15237 | Values: 55.0 54.0 54.0 53.0 55.0 54.0 54.0 55.0 55.0 53.0 18:45:45 INFO - PID 15237 | 18:45:45 INFO - PID 15237 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 18:45:45 INFO - PID 15237 | Values: 54.0 54.0 54.0 54.0 53.0 55.0 54.0 55.0 54.0 55.0 18:45:45 INFO - PID 15237 | 18:45:45 INFO - PID 15237 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:79.00 stddev:5.15 (6.5%) stddev-sans-first:5.20 18:45:45 INFO - PID 15237 | Values: 76.0 91.0 78.0 89.0 78.0 78.0 79.0 79.0 80.0 77.0 18:45:45 INFO - PID 15237 | 18:45:45 INFO - PID 15237 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:130.50 stddev:10.57 (8.1%) stddev-sans-first:10.77 18:45:45 INFO - PID 15237 | Values: 141.0 128.0 126.0 131.0 130.0 135.0 126.0 125.0 125.0 159.0 18:45:45 INFO - PID 15237 | 18:45:45 INFO - PID 15237 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:175.50 stddev:7.26 (4.1%) stddev-sans-first:6.76 18:45:45 INFO - PID 15237 | Values: 187.0 173.0 175.0 176.0 172.0 192.0 181.0 173.0 171.0 171.0 18:45:45 INFO - PID 15237 | 18:45:45 INFO - PID 15237 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.51 (2.2%) stddev-sans-first:1.59 18:45:45 INFO - PID 15237 | Values: 68.0 67.0 67.0 66.0 68.0 69.0 71.0 67.0 67.0 66.0 18:45:45 INFO - PID 15237 | -------- Summary: end -------- 18:45:45 INFO - PID 15237 | 18:45:45 INFO - PID 15237 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:45:46 INFO - TEST-INFO | 15237: exit 0 18:45:46 INFO - TEST-OK | kraken | took 62089ms 18:45:46 INFO - SUITE-END | took 1173s 18:45:46 INFO - Completed test suite (00:19:34) 18:45:46 INFO - javascript benchmark 18:45:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8631.920857822037, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3116.6104236970377, 3155.8264295463746, 3156.7948083374595, 3169.5404166395874, 3181.650018497965, 6150.3234644189215, 6165.506759459238, 6203.100550420187, 6240.3759624037575, 6251.656158911258, 6028.4574388305045, 6106.938930610692, 6107.816765497031, 6113.419225173612, 6113.449789518942, 5579.944200557983, 5619.072852979253, 5630.634008789416, 5686.857828554299, 5757.68332741699, 5671.744771485293, 5688.402717714643, 5693.459121383483, 5723.313202415695, 5724.570657200706, 205.81729076120783, 5480.0, 5598.636088654224, 5700.7719691212305, 5721.399253078429, 5510.724463776795, 5523.944760552424, 5548.167774833767, 5626.915596266059, 5684.175794509814, 5570.387257401682, 5575.832725018216, 5656.575756818214, 5662.980663480572, 5663.405342439026, 6048.758049678007, 6077.270727512682, 6090.512758979271, 6127.080937859312, 6180.84547886302, 6541.869162616721, 6561.639109848957, 6633.767818126391, 6635.900461493082, 6642.036904648847, 6538.869222615521, 6577.342265773432, 6618.437432818217, 6626.768063117768, 6708.060871477997, 6227.190465239535, 6232.220972378453, 6234.251889773211, 6236.937630623681, 6257.812265632084, 6802.489813264025, 6824.658767061726, 6921.204061532888, 6933.168019837652, 6945.16658001033, 6510.121133646991, 6522.641254731036, 6585.0, 6598.010298455174, 6603.141591593158, 6482.708278127496, 6552.803415897531, 6558.278589355167, 6566.638834864033, 6582.17722784652, 6526.24948130971, 6548.443382312462, 6560.639164845884, 6573.915303974886, 6583.0, 6519.348065193538, 6587.967060164764, 6610.173728283965, 6612.371824676648, 6628.502862285348, 5400.648957817729, 5413.702246376409, 5416.214648875891, 5420.268263784339, 5458.8908221835345, 4567.383403240587, 4634.768261586907, 4653.371794807657, 4695.201815691341, 4739.052189562101, 5718.685472299064, 5751.683657398883, 5771.509421699203, 5799.739011744482, 5801.390853960358, 6555.934440655532, 6663.86672266552, 6673.532852700265, 6687.933120668828, 6771.4582833373215, 5652.689102099424, 5659.122835960433, 5670.546356291569, 5773.076307790818, 5788.218590490314, 5930.525557955353, 5935.0503919372695, 5949.553783466257, 5962.910556341659, 5976.491998180203, 6478.740850366027, 6480.0, 6498.285188629247, 6568.507361947873, 6573.80278591643, 6540.215174179129, 6690.19717633887, 6714.294999025227, 6788.1175447191545, 6796.490263230178, 6417.614943103429, 6434.517411194086, 6436.420722135031, 6441.645709485836, 6453.548251622341, 6469.967650161719, 6481.287058423664, 6546.247181573989, 6558.0, 6558.606483610999, 6629.701663425254, 6648.069270302259, 6672.666366681549, 6676.132102826796, 6805.149356330458, 6456.063870738811, 6477.740890364333, 6511.023346498063, 6553.803385898431, 6554.115194448688, 6365.8726825464155, 6460.644664543495, 6467.611943283418, 6471.061696053952, 6581.703823328057, 6376.617402955838, 6406.103145559532, 6414.166158399378, 6416.454601358937, 6419.325970773189, 6461.386168314003, 6471.288158302489, 6495.253045899782, 6535.705893234721, 6595.967020164869, 6213.875722485615, 6287.748490060347, 6299.244090709144, 6300.59046161998, 6446.290908000023], "value": 6016.889719633499, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.6969375871565, 878.4377998081227, 905.5427009360272, 916.7341470973419, 1149.3219000789531, 31755.682443175563, 32225.67774322256, 42278.788606057, 43328.78335608318, 43669.563304366944, 44477.332840007424, 44858.77570612142, 44918.55081449184, 45000.3249951251, 45061.7746911265, 7717.073951125873, 7720.266574675411, 7807.984961954938, 7874.9212507875045, 7880.0937892142565, 7770.0, 7864.449488535804, 7873.5275883447175, 7882.5270483771155, 7883.684652613889, 7832.216778322179, 7889.092754333267, 7895.8026049348655, 7898.131205567383, 7898.921010789876, 7797.6880924762945, 7884.526928384258, 7886.842263154762, 7894.0, 7901.604919754018, 7771.339436147934, 7815.53106813593, 7830.921690783076, 7831.921680783176, 7833.686652533892, 40082.0, 40192.79903600463, 40247.0, 40264.0, 40283.0, 3674.2467794102145, 3696.8336424860677, 3700.4264339027222, 3729.0863738384, 3730.9253814923823, 32867.34265314704, 32899.17752056194, 32947.50578741321, 32997.0, 33001.17497062569, 4973.35346404965, 4974.626902982254, 4999.375078115236, 5014.974925125351, 5017.347744793154, 199404.0, 199736.0, 201063.0, 201651.0, 201983.0, 51555.7422212894, 51889.0, 51956.74021629868, 52020.47979520232, 52046.21930671043, 54863.45136548583, 54932.725336373864, 55241.72379138159, 55256.44743552594, 55322.723386383615, 16898.0, 17290.654186916192, 17311.48065558035, 17323.0, 17340.132993350533, 11014.50434730439, 11284.435778211056, 14158.50445234412, 14182.219977901315, 14485.0, 15317.31072101758, 15334.693306133815, 15351.385944562317, 15433.691326173413, 15494.845051549566, 5986.5210783137245, 6038.456538911519, 6131.233595800525, 6142.201513803177, 6183.752649894044, 1006.9244806639531, 1027.8047171037479, 1030.7268573827942, 1035.570238351091, 1044.159451641436, 23595.41011474727, 23871.045158193825, 23963.52072958566, 23977.0, 29665.703342966724, 1098.8516550265772, 1102.079763397556, 1116.547798141754, 1122.2200570603352, 1127.1658972360394, 12693.555725549562, 12835.679108022374, 12924.289164096064, 12974.610761677164, 12981.286029268293, 236707.0, 237811.0, 239087.0, 239835.40246896312, 240170.0, 56560.0, 57303.42696573064, 57427.71286143542, 57460.712696437084, 57525.712371437876, 1478.7560052591416, 1521.7489114296018, 1527.2287494815048, 1541.1215607104068, 1545.9458918938008, 24244.63633045541, 28313.0, 29075.836966521103, 29493.0, 29865.850670747375, 54380.0, 55206.72396638152, 55371.0, 55414.44585554093, 55531.722341388035, 223873.0, 225267.0, 226398.0, 227387.0, 228275.0, 31955.520667190474, 33229.50155747714, 33834.66165338315, 38397.23205535818, 38748.225035499694, 42241.57758422376, 42374.576254237065, 46735.76632116818, 47932.76033619949, 48561.0, 34210.82894585511, 34526.65473345234, 34582.827085865414, 34694.47958280678, 34698.826505867306, 34008.31983360369, 34233.31533369368, 34238.82880585581, 34384.48423273603, 34695.306093878484, 38179.0, 38185.0, 38198.618013819505, 38599.61400386073, 38606.0, 32797.50803737898, 33104.33791324208, 33114.17214569655, 33886.152846179044, 33893.32213355768, 23625.228107891635, 24133.758662413853, 24344.391390215387, 24563.0, 24769.752302476743], "value": 18200.972731960082, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.6154737873003, 589.2075158911266, 591.1989254560074, 593.557799439418, 607.380471918643, 22410.88794556027, 23034.848257587095, 23401.41496462587, 23407.882960585215, 23443.531129377403, 25248.0, 27213.45573088537, 27290.0, 27315.726842731616, 27406.862965685144, 6764.053032575431, 6921.757738479154, 6927.757528486504, 6940.410065144469, 6943.89584156238, 6175.598586091912, 6687.598744075371, 6728.93271067288, 6774.085498457719, 6776.559523630973, 6621.503387245976, 6631.104800851896, 6632.568883022588, 6635.734570617194, 6665.866682666344, 6634.469242460592, 6655.600663960154, 6658.300878407746, 6660.167479065117, 6663.13379260693, 6153.323134455206, 6163.8150855474405, 6164.630122192682, 6172.413620706071, 6201.875962480725, 29338.266543336373, 30063.248418789706, 30816.0, 31089.0, 31105.0, 1889.1498825528568, 1913.9808601913942, 1917.3289348727974, 1918.6546421644098, 1920.2319072371024, 19259.80740192594, 19892.502687432785, 19920.90435026073, 19935.302264420676, 19950.80049199504, 2286.7141607299086, 2312.6993490846085, 2329.2779238436137, 2334.400935359284, 2416.7583241675866, 144867.275663621, 148460.0, 148642.25678871645, 149639.25180374138, 149707.0, 14819.407223711147, 15040.849591503946, 15373.1544765039, 15437.922810385877, 15464.768028479582, 24455.63316550253, 24540.754592454203, 24568.631470527955, 24610.138645147694, 24646.753532464805, 9770.51147442625, 10271.126954208976, 10336.896631033593, 10344.689659310232, 10490.737731556772, 9379.671711490066, 9400.90599094014, 9404.153626173676, 9450.291228157916, 9529.857052144223, 8948.8657670135, 9207.179020706466, 9472.621095156117, 9523.0, 9580.473073980858, 2776.9166924992282, 2777.8611069446447, 2821.8165819221686, 2826.519491686377, 2882.423515296949, 959.9712008639752, 991.5538007896475, 992.2161492420906, 1009.7929924365487, 1012.5190534496055, 20285.391438256876, 20323.898380508002, 20403.38789836307, 20563.8971805143, 20934.58130837405, 1033.6537260017828, 1069.9304545204536, 1070.2615195515225, 1081.810683130449, 1083.3391631105019, 11268.21122521432, 11285.322880627189, 11344.095936361324, 11379.203455758017, 11630.360330181751, 483492.0, 485289.0, 488514.0, 492355.0, 492664.0, 122662.0, 124696.0, 125794.0, 125965.0, 127677.0, 1211.4911737070452, 1243.0, 1243.3348158735034, 1266.366816591704, 1277.3038693911656, 18310.26758929628, 18417.631647367245, 18436.26254949787, 18519.44441666752, 21220.681689774974, 57949.71025145016, 58899.70550147222, 60330.69834650798, 61647.0, 62574.6871265659, 73134.26865731274, 73274.0, 74165.0, 74180.62909685633, 74659.62670186615, 12728.74542509163, 14898.553043408716, 15361.231938403258, 15433.922830385776, 15463.149526776135, 21918.561628767653, 23734.287971360885, 24744.752552474965, 24961.75038249667, 25164.74835251624, 19184.424467266006, 19276.8072319275, 19407.902960485106, 19684.606307873477, 19914.800851991295, 17462.0, 17525.386611468537, 17710.734338985185, 17837.643247135245, 18051.638967220846, 19190.61618767645, 20059.59880802405, 20082.899585502564, 20235.696464553337, 20319.898400507904, 14714.484993025193, 15165.09009459436, 15180.468683596022, 15182.544523664308, 15202.923985380445, 18612.813871861108, 18726.344577939708, 18762.155702993125, 18873.0, 18949.43151705451], "value": 12343.299843370349, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.6246251049704, 1371.8833899118574, 1389.979150312746, 1398.5944076217897, 1408.7605107131787, 11961.342126183057, 13413.865861341385, 14049.999999999987, 14057.648558786035, 14086.788698169536, 12128.272303661786, 12264.202826816272, 13815.378307976165, 14303.570892873204, 14319.782818460444, 2650.41690828018, 2758.6413766210367, 2761.1854502921587, 2763.5163846326914, 2769.1138835572624, 2618.2407101940416, 2683.0, 2702.50003749306, 2708.146933715883, 2715.8370497770097, 2606.622039804237, 2612.2163350994624, 2615.123933482286, 2618.0, 2640.6303117563557, 2561.1164148368784, 2601.752833480816, 2738.2880451082665, 2746.0, 2776.5557510798176, 2328.2549584133085, 2347.084636991575, 2350.6944097267415, 2357.2928121563464, 2737.4798788230173, 13806.93096534521, 13951.302434878215, 13960.232187229698, 13983.161010339412, 14002.369893354824, 7693.230676932318, 7973.920260797376, 7988.121306656263, 7995.200479952016, 8000.0, 5065.316182315414, 5241.344831896013, 5348.866278343034, 5426.294581704393, 5430.239766432703, 1892.9716054259197, 1896.6775648139712, 1904.9523761905925, 1935.6515827151106, 1940.0590713503939, 22762.886185568965, 23282.883585581963, 23293.53412931732, 23295.0, 23327.650085248733, 6931.376176144171, 6985.3713165815325, 6998.720051197997, 7228.819279518054, 7279.854402911912, 18116.0, 18137.727934081, 18268.451946441626, 18273.725894111598, 18291.908540457214, 7808.0, 7979.9202007979175, 7994.760157195294, 7995.2404521571525, 8010.639521221559, 7102.928970710227, 7188.784336469915, 7242.674079666428, 7257.419406447471, 7335.0, 5485.0, 5625.634333768292, 5651.773929042874, 5676.552479117881, 5705.115707065412, 1654.1067823375483, 1716.7768190135203, 1718.957026074358, 1725.3357457379, 1756.1394916490829, 915.1489115123, 921.7004473546124, 928.2852203803034, 940.5626383731598, 955.016333176829, 7969.840603187904, 8165.469244499089, 8254.793630159174, 8268.2558569729, 8346.290565301895, 1010.0808264479435, 1010.2524132142162, 1036.1969473657825, 1037.8080055189814, 1040.2406243442329, 4605.861824145214, 4755.690880092783, 4843.782029808667, 5353.437889021675, 5357.598180136505, 18415.90792046058, 19027.14377853, 19073.904630476758, 19099.331523396893, 19255.422337329903, 18875.0, 18930.0, 19066.0, 19107.331243406414, 19153.80846191548, 9661.372010819274, 10201.948990255001, 10394.896051039545, 10465.215108866865, 10503.632372866912, 8000.679972801023, 8037.598120094089, 8085.83828323442, 8104.392170587347, 8141.185881411811, 15429.922850385676, 16149.838501615304, 16398.918005410374, 16572.088535130682, 17119.14404279806, 16811.495655130366, 16817.747733784247, 17000.914995424944, 17068.402605908734, 17110.0, 10945.452727363441, 11007.83488247693, 11052.0, 11189.552417903193, 11194.384308862765, 12810.167339122927, 12844.165129266941, 12850.55023074188, 12884.0, 12884.35578221104, 10386.584536618753, 10511.947440263055, 10553.208509361675, 10737.194710396907, 10873.891261087289, 10494.632687855888, 10572.36565806054, 10610.416427096276, 10647.148228141576, 10780.784384312426, 9073.410228335137, 9311.394759340621, 9346.579403926975, 9363.906360936304, 9406.153446189603, 7019.789406317818, 7030.648467576703, 7046.577205367695, 7052.471064670068, 7088.681009354488, 6832.385085342343, 6993.0908981832035, 7078.4691148163065, 7091.539049961736, 7145.749898753519], "value": 6450.864778639542, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.9616830653548, 488.9733048346863, 510.16333213529816, 518.1993819548794, 530.411243519693, 6164.938350616492, 6187.164732761082, 6209.192804935357, 6222.937770622292, 6280.623162610246, 5920.733566989485, 6103.711108334374, 6103.786367477139, 6120.632762034281, 6137.81586552403, 4896.939412866958, 4937.481564435737, 4938.38270216223, 4949.8267560635295, 4963.528464795857, 4847.44254410742, 4880.048390563841, 4900.289458028602, 4917.901641967159, 4929.433115191745, 4917.704937703731, 5007.399112106534, 5151.253068305094, 5154.433012368637, 5210.478952104778, 5092.261622064799, 5140.6401551891195, 5166.664166829181, 5182.870428239286, 5230.581553475751, 4765.189917713962, 4766.428028636586, 4778.617710583145, 4781.856544303677, 4808.302796094582, 6016.368281330441, 6020.548458865603, 6030.66831324277, 6077.541390066396, 6099.237595300588, 6028.276606807167, 6031.366706495843, 6057.121717350959, 6067.939320606782, 6118.388161183891, 6569.67151642416, 6572.507061970371, 6614.8346291343105, 6658.9001164982565, 6678.0, 5293.602979776532, 5299.708516031616, 5341.545968592674, 5343.851072019495, 5368.194770784375, 6797.490188235902, 6945.062416573748, 6978.197507286625, 7007.89488157673, 7047.471439641996, 5500.7524661390335, 5500.972495137498, 5523.475269849358, 5527.668339899538, 5541.501264886099, 5566.415526369754, 5582.190582365615, 5585.1901474286815, 5606.243157173811, 5647.745851436695, 6042.12389203563, 6046.818595442144, 6054.54590905675, 6072.301685306246, 6087.1173679816175, 6575.013747937752, 6664.733410663519, 6676.198856137295, 6691.397774200345, 6707.8261304271555, 1828.542864283929, 1857.619188066443, 1929.8842069475877, 1931.7681878174708, 1946.7371904792956, 1346.3537501999094, 1392.9373178206802, 1429.3139293139352, 1459.569427019032, 1478.4381934864898, 5734.655920644775, 5740.425957404226, 5763.971180144073, 5766.163906233573, 5833.570775160113, 6613.834654133685, 6642.0, 6648.301928297556, 6660.733570657217, 6713.791517526794, 5724.713764311851, 5729.828105156852, 5785.71071446426, 5827.0, 5854.268216472941, 3570.553680789901, 3574.5889222739197, 3578.3022310649694, 3615.3492371373404, 3616.367135751233, 6556.967215163893, 6573.7370505180215, 6620.0, 6627.469802415795, 6647.86704265912, 6931.133608298963, 6974.105746115305, 6979.883218685088, 6993.545419547713, 7001.299870012958, 6498.740050398026, 6511.576747511492, 6521.250056243593, 6587.176602924635, 6627.4366678831875, 6712.261651218264, 6732.730690772511, 6751.56114852533, 6808.183018037669, 6811.910094384874, 6642.867142657024, 6675.33246675348, 6711.765088221889, 6756.155480564929, 6771.255161932085, 6486.383793539606, 6542.803715888531, 6567.737290508326, 6602.702878370389, 6630.9668451657435, 4938.678985865908, 5008.424031236309, 5008.9499105009945, 5026.472220416804, 5051.520105589963, 6715.086200432853, 6719.193696756421, 6739.393454589111, 6774.390304872585, 6816.977453381834, 6497.967510162608, 6543.869122617616, 6588.670566471753, 6629.933700662931, 6682.9331706682315, 6528.850908255453, 6531.902021469777, 6565.901511477236, 6625.370589793962, 6629.613339197788, 6258.968705156445, 6272.372762723874, 6282.403171698681, 6408.327125651926, 6502.739890404331, 6505.795363709109, 6555.311692272243, 6572.934270657232, 6582.728958509307, 6597.0, 6170.321264660974, 6254.6247225166635, 6271.686415679289, 6274.6548939808745, 6372.235331760218], "value": 5169.0811002593455, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.3213825354474, 892.678635691151, 901.4456109492664, 905.556277424062, 918.5131880103545, 18110.728339074925, 18807.529811754714, 18931.52671183221, 18934.526636834085, 20556.0, 20233.494162645904, 20972.790272097314, 21093.57812843746, 21127.683084753742, 21146.259880904134, 1009.8081364540714, 1039.2984735303678, 1042.0725554256717, 1043.3844032021107, 1043.9582416703322, 1007.5163921317771, 1037.8443233514995, 1051.369178492902, 1053.4048262731571, 1057.603398725478, 1102.685734565649, 1105.1324710102572, 1107.5182295701356, 1108.5731993182642, 1109.6504601050642, 1097.8243481043075, 1099.3074363151204, 1100.5652767156969, 1103.2112039891435, 1103.8454616353677, 793.0800271684875, 796.4186144114828, 800.2117913854848, 800.5997001499251, 800.9799755006171, 19506.219751209934, 19695.803041969684, 19894.303699370597, 19902.0, 20398.28605998798, 20680.896595516926, 20738.792612073838, 21177.68233476499, 21206.151753929826, 21268.787312126835, 15898.443554475538, 16316.102614356205, 16352.264148113363, 16512.174391280387, 16593.336266549322, 3538.469229615578, 3562.8752993645357, 3564.3405969895653, 3565.4651802229873, 3565.6434356564396, 130262.0, 130347.0, 130392.0, 134092.999999999, 134756.0, 14387.352569134206, 14812.62968425798, 14904.70190596182, 15173.544793656209, 15289.464868729541, 29444.55833162504, 30128.69871301303, 30992.845035774677, 31104.066877993697, 31126.22184445407, 7297.0, 7671.693132274647, 8287.337013038943, 8890.955545222361, 9125.0, 4312.870613881589, 4400.295952647561, 4406.184855801687, 4422.889427764331, 4432.689711720213, 5172.715500647425, 5225.686458812407, 5298.894022119536, 5313.2030195470215, 5336.62643614951, 1067.8467255364187, 1072.7586293083993, 1086.4893500054961, 1094.715374002749, 1099.6261271167682, 606.5541826757329, 619.7149311316755, 635.196476457282, 639.9904001439982, 652.1261509577095, 10666.0, 11539.538418463335, 11738.941305293589, 11755.588554400554, 11812.822807657893, 667.2626747444004, 674.9460043196533, 675.5136301862651, 689.3175756001523, 690.702997710989, 5256.500632439912, 5329.600279979017, 5373.2208829719475, 5459.153831156177, 5460.890782184334, 103742.4812875946, 105855.4707226459, 106123.0, 106236.0, 107363.0, 95222.52388738011, 95545.0, 96797.51601242089, 99095.0, 99116.0, 85977.0, 86452.13547864566, 86719.13280867237, 86844.99999999873, 91424.54287728519, 11581.073514119018, 12073.698157546132, 12456.43946022413, 12648.177868438523, 12707.93646031801, 36334.27331453409, 37190.25619487649, 37660.43509347417, 38274.80862595669, 38781.41827872641, 67158.32841671717, 68374.3162568368, 68835.65582172057, 71460.85617431486, 72855.27144728697, 18953.715694264873, 19354.903225483784, 19559.70660440123, 19623.70564441563, 19689.310874119335, 20733.377998660064, 21400.892995534923, 21432.249871254433, 21496.67754983645, 21772.564548709255, 16816.159192040104, 17213.483595492155, 17917.641647167246, 17985.190666420305, 18249.361272355403, 18199.727004094686, 18923.526911827314, 19001.529801125766, 19374.128164232927, 19520.414387568395, 18189.0, 18209.81790182134, 18667.0, 18859.24563017464, 18963.33628323002, 13661.607734338526, 13782.310884455537, 14297.571072867831, 14427.639309016939, 14539.418423263374, 13802.861971380158, 13924.094933829674, 14067.015308928278, 14154.009219354546, 14162.78755818643], "value": 9176.719886057155, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 108.0, 101.0, 108.0, 109.0, 111.0, 109.0, 103.0, 107.0, 109.0], "value": 106.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 118.0, 141.0, 171.0, 118.0, 150.0, 148.0, 128.0, 181.0, 120.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 165.0, 163.0, 162.0, 162.0, 163.0, 179.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 171.0, 77.0, 75.0, 73.0, 74.0, 149.0, 76.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 133.0, 79.0, 78.0, 78.0, 123.0, 78.0, 79.0, 124.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 115.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 152.0, 150.0, 150.0, 150.0, 151.0, 151.0, 151.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 53.0, 55.0, 54.0, 54.0, 55.0, 55.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 53.0, 55.0, 54.0, 55.0, 54.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 91.0, 78.0, 89.0, 78.0, 78.0, 79.0, 79.0, 80.0, 77.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 128.0, 126.0, 131.0, 130.0, 135.0, 126.0, 125.0, 125.0, 159.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 173.0, 175.0, 176.0, 172.0, 192.0, 181.0, 173.0, 171.0, 171.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 66.0, 68.0, 69.0, 71.0, 67.0, 67.0, 66.0], "value": 67.6, "unit": "score"}]}]} 18:45:46 INFO - Return code: 0 18:45:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:45:46 INFO - # TBPL SUCCESS # 18:45:46 INFO - Running post-action listener: _package_coverage_data 18:45:46 INFO - Running post-action listener: _resource_record_post_action 18:45:46 INFO - [mozharness: 2017-08-02 01:45:46.725364Z] Finished run-tests step (success) 18:45:46 INFO - Running post-run listener: _resource_record_post_run 18:45:46 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 339968; Write bytes: 443109376; Read time: 96; Write time: 312308 18:45:46 INFO - TinderboxPrint: CPU usage
13.1% 18:45:46 INFO - TinderboxPrint: I/O read bytes / time
339,968 / 96 18:45:46 INFO - TinderboxPrint: I/O write bytes / time
443,109,376 / 312,308 18:45:46 INFO - TinderboxPrint: CPU idle
8,259.9 (86.8%) 18:45:46 INFO - TinderboxPrint: CPU user
1,201.5 (12.6%) 18:45:46 INFO - TinderboxPrint: Swap in / out
0 / 0 18:45:46 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 119975936; Read time: 0; Write time: 114320 18:45:46 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:45:46 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 335872; Write bytes: 323133440; Read time: 84; Write time: 197988 18:45:47 INFO - Running post-run listener: _upload_blobber_files 18:45:47 INFO - Blob upload gear active. 18:45:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:45:47 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 18:45:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:45:47 INFO - (blobuploader) - INFO - Open directory for files ... 18:45:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:45:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:45:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:54 INFO - (blobuploader) - INFO - Done attempting. 18:45:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:45:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:45:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:55 INFO - (blobuploader) - INFO - Done attempting. 18:45:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:45:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:45:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:56 INFO - (blobuploader) - INFO - Done attempting. 18:45:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:45:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:45:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:57 INFO - (blobuploader) - INFO - Done attempting. 18:45:57 INFO - (blobuploader) - INFO - Iteration through files over. 18:45:57 INFO - Return code: 0 18:45:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:45:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:45:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e91473c3990c659e8bf68be4f12634cb3d4357a15d87f2cec124859bc9886f3d48ae1879a138e6765e96af9f94646e754d6f28a43c06496cbcd9fad3d1c30425", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23385d61de81bce85a575f6738551aa1f653d11a9c62825f380de6ffbe28800330cf51341777e592e0c66b421ceccedaf88912d3e77bd9550869ed720034e891", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7601707ffd608924c541a88a185a38777274247936f64824c6f3a2dd74a3a6e5c3ae16438a9a7c2ababf1bb69b637e62f629ace8ecc99d865a3e53cfeef317f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a3f5213fb7a134364b74e79859ae3802e83fc3cde8343033ef915f0785ca91203089de286451c67f0670e0e163b34a5f2992eb7c84f594a2d425d310453923d1"} 18:45:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:45:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:45:57 INFO - Contents: 18:45:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e91473c3990c659e8bf68be4f12634cb3d4357a15d87f2cec124859bc9886f3d48ae1879a138e6765e96af9f94646e754d6f28a43c06496cbcd9fad3d1c30425", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23385d61de81bce85a575f6738551aa1f653d11a9c62825f380de6ffbe28800330cf51341777e592e0c66b421ceccedaf88912d3e77bd9550869ed720034e891", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7601707ffd608924c541a88a185a38777274247936f64824c6f3a2dd74a3a6e5c3ae16438a9a7c2ababf1bb69b637e62f629ace8ecc99d865a3e53cfeef317f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a3f5213fb7a134364b74e79859ae3802e83fc3cde8343033ef915f0785ca91203089de286451c67f0670e0e163b34a5f2992eb7c84f594a2d425d310453923d1"} 18:45:57 INFO - Running post-run listener: copy_logs_to_upload_dir 18:45:57 INFO - Copying logs to upload dir... 18:45:57 INFO - mkdir: /builds/slave/test/build/upload/logs 18:45:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.446852 ========= master_lag: 0.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-08-01 18:45:57.705165) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-01 18:45:57.709036) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e91473c3990c659e8bf68be4f12634cb3d4357a15d87f2cec124859bc9886f3d48ae1879a138e6765e96af9f94646e754d6f28a43c06496cbcd9fad3d1c30425", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23385d61de81bce85a575f6738551aa1f653d11a9c62825f380de6ffbe28800330cf51341777e592e0c66b421ceccedaf88912d3e77bd9550869ed720034e891", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7601707ffd608924c541a88a185a38777274247936f64824c6f3a2dd74a3a6e5c3ae16438a9a7c2ababf1bb69b637e62f629ace8ecc99d865a3e53cfeef317f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a3f5213fb7a134364b74e79859ae3802e83fc3cde8343033ef915f0785ca91203089de286451c67f0670e0e163b34a5f2992eb7c84f594a2d425d310453923d1"} build_url:https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e91473c3990c659e8bf68be4f12634cb3d4357a15d87f2cec124859bc9886f3d48ae1879a138e6765e96af9f94646e754d6f28a43c06496cbcd9fad3d1c30425", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23385d61de81bce85a575f6738551aa1f653d11a9c62825f380de6ffbe28800330cf51341777e592e0c66b421ceccedaf88912d3e77bd9550869ed720034e891", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7601707ffd608924c541a88a185a38777274247936f64824c6f3a2dd74a3a6e5c3ae16438a9a7c2ababf1bb69b637e62f629ace8ecc99d865a3e53cfeef317f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a3f5213fb7a134364b74e79859ae3802e83fc3cde8343033ef915f0785ca91203089de286451c67f0670e0e163b34a5f2992eb7c84f594a2d425d310453923d1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-01 18:45:57.743373) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 18:45:57.743703) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1501636681.586788-298071732 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 18:45:57.821116) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-01 18:45:57.822634) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-01 18:45:57.822916) ========= ========= Total master_lag: 0.46 =========