builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1501637096.37 results: success (0) revision: fec8d72590053c3ad72cd3492d389213dfabc2ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:56.374193) ========= 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.374642) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:56.375013) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:56.507373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:56.507632) ========= 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=836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816 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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 214M=0s 2017-08-01 18:24:57 (214 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126336 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:56.664478) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:56.666806) ========= 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=836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018113 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:56.721308) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:56.721630) ========= 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=836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-01 18:24:57,229 truncating revision to first 12 chars 2017-08-01 18:24:57,229 Setting DEBUG logging. 2017-08-01 18:24:57,229 attempt 1/10 2017-08-01 18:24:57,229 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,652 unpacking tar archive at: mozilla-central-fec8d7259005/testing/mozharness/ program finished with exit code 0 elapsedTime=0.800517 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:57.540917) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:57.541331) ========= script_repo_revision: fec8d72590053c3ad72cd3492d389213dfabc2ff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:57.544538) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:57.544873) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-01 18:24:57.577607) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-01 18:24:57.577885) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816 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 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 18:24:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:24:58 INFO - 'branch': 'Firefox', 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-028', 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.195618Z] 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.244460Z] Finished clobber step (success) 18:24:59 INFO - [mozharness: 2017-08-02 01:24:59.244563Z] 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_stylo_test-dromaeojs-e10s", 18:24:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:24:59 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 18:24:59 INFO - "stage_platform": "linux64-stylo", 18:24:59 INFO - "basedir": "/builds/slave/test", 18:24:59 INFO - "buildnumber": 59, 18:24:59 INFO - "platform": "ubuntu64_hw_stylo", 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": "SeiDOjUdSoSG73RKmjaj-g", 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-028", 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/SeiDOjUdSoSG73RKmjaj-g'}, attempt #1 18:24:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SeiDOjUdSoSG73RKmjaj-g'}, 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.598042Z] Finished read-buildbot-config step (success) 18:25:00 INFO - [mozharness: 2017-08-02 01:25:00.598264Z] 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:17 INFO - Content-Length response header: 72391672 18:25:17 INFO - Bytes received: 72391672 18:25:29 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:29 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:29 INFO - Fetch https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.talos.tests.zip into memory 18:25:30 INFO - Content-Length response header: 14496467 18:25:30 INFO - Bytes received: 14496467 18:25:30 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:30 INFO - trying https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.tar.bz2 18:25:30 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:30 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.791508Z] Finished download-and-extract step (success) 18:25:33 INFO - [mozharness: 2017-08-02 01:25:33.791738Z] 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.811271Z] Finished populate-webroot step (success) 18:25:33 INFO - [mozharness: 2017-08-02 01:25:33.811360Z] 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 0x1f3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2107a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22aad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a7eb0>, '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 0x22a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9240>, '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', 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 0x1f3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2107a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22aad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a7eb0>, '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 0x22a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9240>, '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', 18:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:36 INFO - '_': '/tools/buildbot/bin/python'} 18:25:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:37 INFO - Downloading/unpacking psutil>=3.1.1 18:25:37 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:37 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 - 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:37 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 - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 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 - 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 0x1f3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2107a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22aad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a7eb0>, '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 0x22a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9240>, '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', 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:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:25:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:25:40 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:40 INFO - Installing collected packages: mozsystemmonitor 18:25:40 INFO - Running setup.py install for mozsystemmonitor 18:25:40 INFO - Successfully installed mozsystemmonitor 18:25:40 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 0x1f3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2107a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22aad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a7eb0>, '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 0x22a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9240>, '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', 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 0x1f3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2107a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22aad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a7eb0>, '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 0x22a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9240>, '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', 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 - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:25:42 INFO - Cleaning up... 18:25:42 INFO - Return code: 0 18:25:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1f3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2107a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22aad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a7eb0>, '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 0x22a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9240>, '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', '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:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:25:42 INFO - Using env: {'DISPLAY': ':0', 18:25:42 INFO - 'HOME': '/home/cltbld', 18:25:42 INFO - 'LANG': 'en_US.UTF-8', 18:25:42 INFO - 'LANGUAGE': 'en_US:en', 18:25:42 INFO - 'LOGNAME': 'cltbld', 18:25:42 INFO - 'MAIL': '/var/mail/cltbld', 18:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:42 INFO - 'MOZ_NO_REMOTE': '1', 18:25:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:42 INFO - 'NO_EM_RESTART': '1', 18:25:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:42 INFO - 'PWD': '/builds/slave/test', 18:25:42 INFO - 'SHELL': '/bin/bash', 18:25:42 INFO - 'SHLVL': '1', 18:25:42 INFO - 'TERM': 'linux', 18:25:42 INFO - 'TMOUT': '86400', 18:25:42 INFO - 'USER': 'cltbld', 18:25:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', 18:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:42 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 0x1f3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2107a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22aad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a7eb0>, '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 0x22a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9240>, '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', 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-35nTPI-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-2UTETS-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-ZmjQqq-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-1lPshk-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-aQNOX7-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-lgbVoj-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-ujBpfi-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-dBJvQY-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-Ublun4-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-HEDjT_-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-Xy1HBB-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-ROtzkZ-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-zkeKE0-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-pOLZuC-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-pKW9Wo-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-GW_Med-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-BDOciM-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 0x1f3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2107a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22aad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a7eb0>, '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 0x22a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9240>, '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', 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-93pkG1-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-9o8M50-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-s4_612-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-Rdqt1m-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-VAEV8Q-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-QIeokn-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-oFyhZl-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-cF98Rv-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-cQK7iR-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-RTmtqR-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-acdUeB-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-gdhW1r-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-kqZTkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:25:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:25:49 INFO - Running setup.py (path:/tmp/pip-M9KkzE-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-rNwbGM-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-SJY2Td-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-YzTtYS-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 0x1f3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2107a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22aad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a7eb0>, '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 0x22a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9240>, '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', 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 0x1f3b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2107a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22aad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a7eb0>, '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 0x22a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9240>, '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', 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.538928Z] Finished create-virtualenv step (success) 18:25:53 INFO - [mozharness: 2017-08-02 01:25:53.539442Z] 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.932380Z] Finished install step (success) 18:26:11 INFO - [mozharness: 2017-08-02 01:26:11.932635Z] 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.933680Z] Finished setup-mitmproxy step (success) 18:26:11 INFO - [mozharness: 2017-08-02 01:26:11.933774Z] 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 0x22a7eb0>, '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 0x22a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a9240>, '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', '--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-028', '--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 --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-028 --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 - 'STYLO_FORCE_ENABLED': '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': '836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816', 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', '--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-028', '--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:39837' 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:39837/getInfo.html -profile /tmp/tmpZGLz7l/profile 18:26:12 INFO - TEST-INFO | started process 26427 (/builds/slave/test/build/application/firefox/firefox http://localhost:39837/getInfo.html) 18:26:18 INFO - TEST-INFO | 26427: 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 26654 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZGLz7l/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 26654 | 18:26:19 INFO - PID 26654 | (/builds/slave/test/build/application/firefox/firefox:26709): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:26:19 INFO - PID 26654 | 18:26:30 INFO - PID 26654 | RSS: Main: 171716608 18:26:30 INFO - PID 26654 | 18:29:28 INFO - PID 26654 | Cycle 1(1): loaded http://localhost:39837/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39837/tests/dromaeo/cssquery-ext.html) 18:29:29 INFO - PID 26654 | RSS: Main: 176463872 18:29:29 INFO - PID 26654 | 18:32:31 INFO - PID 26654 | Cycle 1(1): loaded http://localhost:39837/tests/dromaeo/cssquery-ext.html (next: http://localhost:39837/tests/dromaeo/cssquery-jquery.html) 18:32:32 INFO - PID 26654 | RSS: Main: 171552768 18:32:32 INFO - PID 26654 | 18:35:34 INFO - PID 26654 | Cycle 1(1): loaded http://localhost:39837/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39837/tests/dromaeo/cssquery-mootools.html) 18:35:34 INFO - PID 26654 | RSS: Main: 173178880 18:35:34 INFO - PID 26654 | 18:38:36 INFO - PID 26654 | Cycle 1(1): loaded http://localhost:39837/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39837/tests/dromaeo/cssquery-prototype.html) 18:38:37 INFO - PID 26654 | RSS: Main: 173502464 18:38:37 INFO - PID 26654 | 18:41:41 INFO - PID 26654 | Cycle 1(1): loaded http://localhost:39837/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39837/tests/dromaeo/cssquery-yui.html) 18:41:41 INFO - PID 26654 | RSS: Main: 177471488 18:41:41 INFO - PID 26654 | 18:44:43 INFO - PID 26654 | Cycle 1(1): loaded http://localhost:39837/tests/dromaeo/cssquery-yui.html (next: http://localhost:39837/tests/dromaeo/cssquery-dojo.html) 18:44:43 INFO - PID 26654 | RSS: Main: 177201152 18:44:43 INFO - PID 26654 | 18:44:43 INFO - PID 26654 | __start_tp_report 18:44:43 INFO - PID 26654 | _x_x_mozilla_page_load 18:44:43 INFO - PID 26654 | _x_x_mozilla_page_load_details 18:44:43 INFO - PID 26654 | |i|pagename|runs| 18:44:43 INFO - PID 26654 | |0;dojo.html;3113.361760839028;3117.984410077949;3156.1320636824858;3163.8259895705733;3178.1577881861313;6063.333033366326;6087.78692745754;6158.815235542929;6175.567710260278;6221.471174950129;6156.168917196177;6163.106349579309;6198.690065496729;6205.813825585228;6206.441420272175;5652.971735141318;5696.800611978571;5708.800191993281;5731.512821410185;5745.626534275259;163.5392270824625;5560.6941618210985;5671.120976248688;5792.623479473842;5800.738966746507;5537.1140617501005;5573.442655734435;5580.414056524068;5594.9720251398885;5615.2700148980775;5616.269884914935;5621.606487545873;5664.518515926151;5691.288588926384;5696.943030569682;5602.187682785973;5662.886742265173;5679.148127780824;5691.231683722686;5702.030654788655;6062.727177277033;6063.757449702007;6065.4844338231305;6087.939120608781;6181.320054793969;6413.967930160366;6561.606303621798;6644.103046088813;6651.534392592521;6662.900056499157;6564.113844631009;6601.504887133437;6638.070670106189;6706.295838936939;6707.731690732365;6174.166487524171;6210.813675589739;6265.279492858289;6272.435480806749;6277.340879207709;6800.65996700163;6807.353301436356;6890.655467226618;6906.240313565504;6938.548994315353;6451.387118223761;6474.158359413246;6477.255115661759;6533.542652014408;6577.210734711865;6612.4710023198995;6614.669266536654;6619.338066193439;6623.768168114093;6639.800805975829;6413.486921046305;6489.156409666713;6529.967350163219;6540.247871494839;6603.76886808969;6562.310957349505;6563.474922006228;6615.933840661532;6655.367740064686;6670.866582668416;5328.467153284718;5392.137258038773;5395.082835917825;5395.352557693023;5399.9190012149065;4559.224931761609;4560.840370587013;4567.451905771329;4569.109023740405;4569.771511424482;5724.25584673998;5794.913076303858;5800.390958949334;5813.215215945877;5836.708164591753;6631.403173714389;6671.833204169838;6682.699278532477;6767.492438067165;6788.015737718003;5571.0807716726285;5761.107028410603;5820.738066787005;5825.359210486843;5826.504747096459;5811.88376232473;5843.2403787507355;5884.176215329857;5890.823275301748;5910.970445147746;6424.261209960914;6427.775027874002;6456.483481321483;6511.055896895018;6518.934810651927;6633.568818026813;6639.502037347122;6737.562058466184;6738.7304507819135;6754.898676519758;6325.905111423424;6403.807885763435;6417.935820641734;6474.611523308617;6520.152380190545;6548.639824809681;6568.310327415744;6601.207855057231;6624.966875165594;6641.468682505485;6647.169103862017;6654.268030516736;6661.733530658913;6754.12196414463;6755.763548275787;6264.968675156595;6415.486761059011;6417.1657684500715;6467.126937863328;6522.543421960418;6348.396902294275;6412.134361861089;6414.5189110815945;6428.4857211423905;6445.0332450132855;6261.592996455216;6263.968680156752;6298.1812364392335;6313.747450101944;6327.240731112296;6442.35576442352;6468.482521398371;6555.2789193187755;6565.441937435371;6572.474202063919;6199.721012554356;6250.156228909039;6286.937130628635;6297.842553936188;6311.368863113652 18:44:43 INFO - PID 26654 | |1;ext.html;845.0704225352109;882.8940527136745;902.7923577577161;905.6196397513044;1163.1741463560872;31374.372512549762;32057.839710801443;43140.13719725604;43181;43190.9202269943;43918.56081439184;44252;44280.557194428045;44416.55583444165;44456.11087778243;7338.633068346561;7683.462157648967;7918.6436610352675;7929.207079292053;7932.2067793220795;7731.3814894808565;7836.608169591526;7836.921630783705;7838;7844.587974164648;7853.882191767099;7865.960670196641;7872.252136047066;7909.406794490407;7914.445988780788;7783.182765809565;7791.649375778075;7806.453548251625;7846.489978151402;7848.843023139505;7700.845983080307;7735.61321933901;7737.30364267213;7744.535327880289;7756.806079847993;39351.21297574032;39401.21197576061;39636;39728.20543589112;39835;3530.6116327203986;3555.4489054196642;3580;3594.2991116732246;3594.4248920172645;32186.839065804754;32190.517142242887;32246.032619021233;32252.193695157574;32279;4947.03532811102;4956.504349565051;4961.627877909171;4967.205247160437;5001.349824522825;202438;205952;206145;206214;206763;51722.74138629283;51735.48264517382;51790.482095178566;51834.48165518372;51994.74002629962;53206.73396632992;53331.73334133382;53350;53430.19854702183;53508.73245633825;16849.494515164566;17186.570335741708;17203.56991075208;17253.309867605156;17329.65340693179;10945;11021.669349919515;13970.860291396955;14047.08693934891;14140.929295353457;15109.697806044038;15130.092194468367;15185.240737963279;15203.315850786741;15396.384144634088;6178.969105154445;6304.71628776697;6331.430171284606;6340.590575581342;6352.809415717536;998.6454808542862;1010.3331801011298;1015.7663737340453;1019.2050200843354;1023.4473384372355;22751.203707870478;28841;29538.852305738335;29691.554626680616;30016.39967200644;1064.2071656615872;1065.8188108021654;1078.6979645699216;1091.2088735666578;1098.4343063322394;12487.375631218403;12603.18079324841;12651.683707907192;12720.554780582635;12835.550755723505;243781;245083;246149;246728;247158;54510;54911;55188.44811551833;55274;55294.89410211773;1455.7015811758565;1463.0563286680244;1508.6379268975368;1509.7508911029777;1514.538065889892;22756.772432275466;23077;23271.650925235797;23283.650745238498;23441.41396465102;39679.60320396759;39978;40052.599474006056;40078;40119.598804011584;217735;218372;220041;220043;220408;35252.47121293234;37304.44043339406;39450.60549394469;39516.60483395244;39599;47869.5213047865;49465.50534494753;49569.75215124046;49614.50385496099;49668.25497617611;35548.466772998945;35587.82206088953;35604.28791424105;35894;36601.81699091488;35162.47256291106;35334.46998294976;35546.644533555365;35655.465168023016;36107.45838812472;39567;39660.2067958645;39691.40462893117;39932.401013984236;39989;33960;34266;34549.65450345565;35283.294334113685;35752;25294.1147059852;25408.74591254064;25525.744742552335;25838.741612583635;25988.61017084783 18:44:43 INFO - PID 26654 | |2;jquery.html;568.7156421789107;581.4272941152966;590.9468147866694;593.2406519654841;597.5607928172795;22662.206822761185;23425.76574234257;23436.531269374624;23452.179173728924;23452.29643110705;26235.3441163971;26839.73160268397;27059.458810823773;27060.323491912714;27066.18801435955;6549.345065493449;6648.634325112117;6704.128463299764;6716.6977486013;6720.596764194164;6191.845203869917;6483.935160648404;6517.706703198343;6528.967355163218;6551.115599394092;6477.222733272014;6484.1894763154605;6493.967530162343;6500.512461565378;6501.804945851608;6480.351964803505;6487.772927947546;6504.869902601921;6507.869842603145;6514.3485651435185;6026.698665066773;6068.514518838482;6076.453119219247;6078.088286756978;6087.239095113111;29664.406711865642;29897.701022989928;30006.64970076352;30169.245768855733;30750.384992300027;1901.9714704279447;1941.1652989214633;1943.2227109156308;1943.319838056683;1943.5724140689026;18610.90694546532;19234.134463949154;19257.4222773317;19300.1314940828;19325.80674193254;2274.977250227493;2275.465265662568;2329.650552417151;2369.241842610348;2376.3346263046374;141093;144422.27788861093;144662.55337446596;144952;145463;14234.715305693828;14887.851121488864;15030.924845375921;15308.158051307062;15872.761908571381;23191.768082318962;24400.633990490158;24424.145154919494;24460.633090503656;24509.387265318153;10494.317869338469;10499.632512862014;10622.840657390145;10743.462826858626;10939.28894621863;9728.367656102331;9731.951340243253;9818.165455936325;9858.457784821903;10021.599136034478;9389.577469013775;9478.715638530855;9516.476593787409;9539.950605433396;9570.760730981781;2665.813712897742;2675.6922953860553;2700.409304182897;2755.2973991632007;2839.2617919340705;949.2738055387634;967.8354679704327;973.0415540692412;976.62888102522;997.3018886779283;19127.23491060342;19373.709394359095;19530.609387812165;19754.90122549378;19831.801681983285;1034.6947650443137;1053.6154303679255;1054.383185836279;1058.0424715632364;1058.169337070396;10645.20160987929;10795.406252656023;10861.45692715377;11076.335419874673;11168.329900205852;489980;493952;501000;502932;503523;114377;115422.42288788503;115628.42185789018;116778.24832627518;125052.37473812573;1271.173737070893;1271.5486002469174;1309.7249577588814;1322.2991814338416;1324.5628942448968;20690.896545517175;20825.791742082387;21005.789942100382;21275.255366062112;21324.78675213228;60553.14258421852;60837;61095.38904610897;62399.6880015597;62868.371316286255;76363.61818190874;77024.61487692526;77257.61371193107;77593.61203193948;78431;14361.856381436051;15094.698106038037;15152.393904243707;15194.088354698753;15202.46791362297;23161.76838231596;23529.64705529453;23582.292531223404;23722.525549488568;23749.287521373695;18145.637087257917;18264.45206643803;18592;18619.34832280918;18882.905585472534;16914.915425422794;16988.320467181667;17555.297788088334;17560.12199390051;17883;19452.513687157367;19616;19949.800501994796;19977.800221997593;20135.59728805445;14704.632384190481;15300.387984480496;15316.846831531988;15318.310676019828;15367.462138825087;18910.14904329281;19045.61908761845;19154.904225478782;19257.22971081197;19363.225470981004 18:44:43 INFO - PID 26654 | |3;mootools.html;1371.7119404924963;1439.366678661389;1441.5170917742555;1449.4636984315805;1451.0568130715037;13493.122947008449;13642.795358069638;14108.788368174473;14136.222507762082;14141.151530908128;13689.726205475909;14490.20303883286;14510.854891451083;14616.634584135401;14622.634434139152;2736.370634754003;2796.6504186976626;2798.3144129688153;2801.3696918193345;2802.14534566957;2668.106184428219;2709.512287788197;2767.225176950457;2772.085211880075;2773.7087605801403;2688.7176846431134;2744.2727677165567;2751.7798576113964;2752.4357506711076;2753.063958254193;2640.7359264073534;2693.0708905427696;2703.499852527279;2704.634874291965;2714.674239091302;2292.1175347491335;2358.056777289098;2625.9868700656375;2626.3828000419885;2629.815912886099;11710.531578736925;13392.866071339356;13942.860571394258;13950.651233719136;13974.371153298125;7613.771586852348;7962.044554653478;7967.4821136626515;7969.282764551161;7988.241117093867;5178.533931946105;5400.91898621521;5466.508014278695;5473.370562385297;5514.91727624086;1855.5268406556377;1880.2479008396615;1897.6773948428663;1928.980710192894;1938.3603410874377;22172.88913555422;22766.54466910669;22812.657810133027;22831.20090796814;22832.77167228323;7014.438844892396;7066.540674856118;7085.14978202619;7252.854942901113;7268.600226987566;18023.18895649699;18070.3675371364;18118.27526898909;18118.637627247383;18121.818781812013;7464;7841.333486653584;7875.133735289113;7995.680172793023;7996.120426753053;7006.754763583352;7061.682224299816;7066.470014748915;7074.186468556079;7079.115110611174;5596.692181930033;5618.494335509824;5626.887462250814;5700.942990570041;5768.798092066758;1737.1401156427396;1804.954876128081;1814.637072585488;1821.0985562146557;1837.467134530971;886.5478605910903;912.5254867468879;921.8663293822358;931.4550987672152;940.2478017585904;7353.926460735431;7381.261873812576;7382.815429614303;7413.221611730691;7647.158812530617;684.2473279392628;693.5457275484565;714.8641758065951;729.5112274775913;741.1069661058411;4810.6151507879285;5196.220566914993;5304.363476382859;5313.734313284321;5341.919871201935;17149.57126071858;18104.9094754528;18839.05804709759;18951.81048189528;19236.615267694848;18145.818541814413;18846.905765471085;18874.245030198912;18879.90560047191;18933;10498.737531561772;10570.312929659547;10586.100181484506;10672.519736611872;10768.246222764332;8266.380021498291;8419.663213471393;8497.490150590736;8543.914560854311;8562.78593035179;16214.756778648094;16449.753253700965;16582.17089145514;16582.75125873089;16688;16317;16857.325706971584;16993.06538140365;17007.829921700624;17297;10906.563737450731;11118.110551155727;11161.888381116085;11162.274452160584;11162.665120046411;12355.32045737493;12502.124851260325;12882.48470061187;12909.935450322688;12924.870751292743;10330.793384132125;10414.583416663248;10424.530896109845;10425.478726063819;10602.992715691997;9920.751981200528;9959.452230127123;10030.699079027641;10114.039166279192;10120.342177758423;9164.541772911462;9333.300002499975;9333.953330233306;9357.906420935704;9365.484898330385;7151.463640227108;7159.749408770668;7193.784186474414;7202.3877970373105;7240.565566066053;7444.888326674996;7447.069116360455;7460.738874139379;7484.775456736306;7618.085829700472 18:44:43 INFO - PID 26654 | |4;prototype.html;499.3660392080368;517.4385791416314;524.3602804578414;526.4367127173925;538.8733647592815;6196.918526808019;6227.9999999999945;6235.222961455986;6238.906416403746;6277.5291853110975;6173.938260617392;6186.133941248228;6196;6204.31752507225;6220.720067596958;5137.486251374851;5168.371962831696;5170.974145129278;5182.6631268967585;5187.19598462239;4750.691205071676;4932.383452068491;5107.897842043157;5113.948860511403;5131.717755523445;4852.684575502599;4887.755612219393;4899.559039686427;4900.779464924087;4912.336834527328;4886.193778026622;4902.828401005983;4911.533404326583;4923.335349727777;4933.28467372229;4385.2106620808245;4388.934165987513;4409.889752756207;4445.11097780442;4445.155420470101;6035.486983606399;6042.879142417171;6053.485453736438;6062.333143354227;6072.119542666333;5567.137093750475;5574.498295153415;5618.353889302701;5622.353429355636;5675.9432405675825;6331.398517140864;6345.17512723343;6467.288598254188;6485.702859428086;6494.512911531607;4740.2889566564945;4774.976125119352;4780.139574876521;4803.351547541107;4821.686590371614;6564.081028655992;6705.597664140168;6710.899336509956;6841.350071743226;6889.655517224119;4941.5669455858115;4973.452920178777;4982.103221420107;4991.850244492671;5016.724080175552;5005.1491246488185;5036.5718913892;5039.244113382949;5040.899182016339;5102.617303702237;5590;5631.1271752878365;5652.886942261214;5679.460451257124;5694.345150307685;6575.769848055391;6606.405423511907;6629.088837585848;6631.171103612049;6655.134832471747;1752.404182577904;1772.0962309222132;1782.5008997480727;1793.4261036468206;1794.716777504091;1157;1200.429795846983;1219.615821016377;1239.3865036806837;1241.5468354050888;5754.884902302014;5755.366909639936;5773.39379365169;5796.246487956539;5806.419358064244;6560.311167327457;6636.668166591748;6645;6696.732130714814;6717.361850624183;5713.600047996601;5741.483266505951;5745.597808153473;5749.942500574941;5755.510781583528;3561.7506774526055;3591.3894637911094;3602;3611.476335931275;3637.690796282293;6345.682715864188;6420.967895160495;6431.646259455775;6451.677406131732;6467.935320646828;6747.392734653905;6752.493562982698;6822.385985261251;6827.761028363983;6924.549904256207;6400.519961002943;6447.323031081763;6447.549301407146;6450.548461607643;6560.606363618198;6277.865525721277;6686.765963191265;6758.222804377363;6763.458923286224;6766.714324278568;6586.209654841449;6632.834179145367;6636.4027237546925;6654.604342436622;6698.899516507354;6371.74513019474;6491.870162596816;6543.967280163569;6553.442957348679;6581.572197807127;4938.358013458227;4942.827001054946;4952.851414457572;4964.180910149785;4971.527704868176;6459.935400646122;6577.967110164419;6657.7669781557415;6764.898526522008;6842.965785171043;6490.967545162244;6541.313162117909;6566.4418524425955;6589.86981183953;6621.3047629998155;6490.935090649033;6563.671816409065;6586.769463068769;6630.502712296694;6632.137822083098;6389.552731308764;6438.323975982642;6468.994611670397;6502.869942601027;6544.821932052277;6526.706298216686;6611.636360000246;6642.4021838034805;6644.106429667521;6651.667416629052;6433.13439102655;6478.578892372169;6478.967605161944;6516.674166291761;6528 18:44:43 INFO - PID 26654 | |5;yui.html;931.4411353188088;942.1097063275204;946.0161432110606;955.2060223845251;970.0396607358715;18237.270509179634;19200.711989320138;19202.711959320623;19221.903890480546;19246.615067698654;16815.579610509743;17913.92516449014;21955.231566895163;21994.34016979489;22049.889750551225;1039.7192757955347;1053.3311347294484;1054.96307629233;1055.0135623192302;1055.7993981143597;1057.8836328003952;1067.9305845120082;1068.385678235014;1070.2454769387564;1071.464267866067;991.1723710701573;1087.7606926476162;1089.319175515303;1090.0462095666292;1090.983635245472;1070.6680928912062;1075.983860242097;1076.359566058194;1081.2701426537096;1082.35058964621;787.075186655683;787.7203592724558;793.2266040610416;793.8690116130831;795.157133438557;19034.61930761391;19840.80159198404;19897.60204795896;20235.79764202354;20239.392818215478;19759.407217783344;19761.11075001614;20157.092930818148;20157.294494692615;20618.17527298906;13989.790153147609;14073.718525629532;14268.215248161347;14310.928445357811;14326.928365358212;3484.3379757846183;3550.5916819565564;3559.7864128152396;3576.6423357664285;3580.4629305604367;126405;127084.36457817744;127185;128850.35574822065;130535;15234.619134521505;15502.5349239523;15779;15793.68412631741;15821.288042037906;30571.388572228876;31064.22339441487;31285.217869553442;31290.530642040387;31344.05967820969;7750.263724946121;7775.22247775218;7842.372610191171;7892.763217103496;7893.960530197312;4318.417013703172;4363.934540981888;4372.737635741865;4417.138657961731;4419.535948725402;5037.269595908646;5139.640225184276;5170.948290517047;5186.533212010937;5190.325257716549;921.7188757429049;953.0707560128819;954.9092836180552;966.0918736387773;966.6181858165985;641.470786601056;659.5020759326774;659.6273105695267;667.2026927821207;679.0628932073706;11138.888611113947;11487.54049837997;11510.194286399872;11527.020203282815;12374.381280935917;626.2891618013497;631.9968400158061;692.2592825676478;695.1345574759356;701.1796198447828;5051.368578927634;5396.001739678172;5593.720313984284;5604.523615492729;5743.511801496836;100266.4986675062;101370.49314753526;103044.02817563289;104676;105260;93133.53433232926;95434.52282738681;95636.52181739047;96843.51578242064;97271;83637.58181209177;85233;86766.13233867707;87300.56349718338;87929;12102;12135.75728485443;12215.26708397499;12451.875481245072;12520;35085.47371789476;35548.466772998945;36204.45693314655;36783.26433471369;39453;69989.30010699827;71609.28390716235;71688;73976;73982.49507518054;18081.186346614697;18587.72118418252;18637.90681046586;18686.25254989785;18750.53123671919;19748.210071596975;20156.496087597927;20384.694229586272;20396.79603203949;20500.17999280012;17989.910050450188;18004.649651275944;18029.36897208644;18042.097895105453;18179.909100454413;18112.275508979492;18430.81569184291;18754.437366879014;18967.71548426747;18981.95599242055;17740.733888991417;18039.639207216045;18047.368342107962;18071.81928180754;18218;13774;14076.436942522594;14216.075955062888;14388.35252413623;14512.201828899511;13430.462781488632;13782.241976691379;13930.233837139054;13948.651283717989;14036.2981850905 18:44:43 INFO - PID 26654 | __end_tp_report 18:44:43 INFO - PID 26654 | __start_cc_report 18:44:43 INFO - PID 26654 | _x_x_mozilla_cycle_collect,369 18:44:43 INFO - PID 26654 | __end_cc_report 18:44:43 INFO - PID 26654 | __startTimestamp1501638283851__endTimestamp 18:44:43 INFO - PID 26654 | 18:44:43 INFO - PID 26654 | ------- Summary: start ------- 18:44:43 INFO - PID 26654 | Number of tests: 6 18:44:43 INFO - PID 26654 | 18:44:43 INFO - PID 26654 | [#0] dojo.html Cycles:165 Average:6068.08 Median:6298.18 stddev:854.12 (13.6%) stddev-sans-first:824.69 18:44:43 INFO - PID 26654 | Values: 3113.4 3118.0 3156.1 3163.8 3178.2 6063.3 6087.8 6158.8 6175.6 6221.5 6156.2 6163.1 6198.7 6205.8 6206.4 5653.0 5696.8 5708.8 5731.5 5745.6 163.5 5560.7 5671.1 5792.6 5800.7 5537.1 5573.4 5580.4 5595.0 5615.3 5616.3 5621.6 5664.5 5691.3 5696.9 5602.2 5662.9 5679.1 5691.2 5702.0 6062.7 6063.8 6065.5 6087.9 6181.3 6414.0 6561.6 6644.1 6651.5 6662.9 6564.1 6601.5 6638.1 6706.3 6707.7 6174.2 6210.8 6265.3 6272.4 6277.3 6800.7 6807.4 6890.7 6906.2 6938.5 6451.4 6474.2 6477.3 6533.5 6577.2 6612.5 6614.7 6619.3 6623.8 6639.8 6413.5 6489.2 6530.0 6540.2 6603.8 6562.3 6563.5 6615.9 6655.4 6670.9 5328.5 5392.1 5395.1 5395.4 5399.9 4559.2 4560.8 4567.5 4569.1 4569.8 5724.3 5794.9 5800.4 5813.2 5836.7 6631.4 6671.8 6682.7 6767.5 6788.0 5571.1 5761.1 5820.7 5825.4 5826.5 5811.9 5843.2 5884.2 5890.8 5911.0 6424.3 6427.8 6456.5 6511.1 6518.9 6633.6 6639.5 6737.6 6738.7 6754.9 6325.9 6403.8 6417.9 6474.6 6520.2 6548.6 6568.3 6601.2 6625.0 6641.5 6647.2 6654.3 6661.7 6754.1 6755.8 6265.0 6415.5 6417.2 6467.1 6522.5 6348.4 6412.1 6414.5 6428.5 6445.0 6261.6 6264.0 6298.2 6313.7 6327.2 6442.4 6468.5 6555.3 6565.4 6572.5 6199.7 6250.2 6286.9 6297.8 6311.4 18:44:43 INFO - PID 26654 | 18:44:43 INFO - PID 26654 | [#1] ext.html Cycles:180 Average:40334.71 Median:19850.94 stddev:58109.49 (292.7%) stddev-sans-first:58196.85 18:44:43 INFO - PID 26654 | Values: 845.1 882.9 902.8 905.6 1163.2 31374.4 32057.8 43140.1 43181.0 43190.9 43918.6 44252.0 44280.6 44416.6 44456.1 7338.6 7683.5 7918.6 7929.2 7932.2 7731.4 7836.6 7836.9 7838.0 7844.6 7853.9 7866.0 7872.3 7909.4 7914.4 7783.2 7791.6 7806.5 7846.5 7848.8 7700.8 7735.6 7737.3 7744.5 7756.8 39351.2 39401.2 39636.0 39728.2 39835.0 3530.6 3555.4 3580.0 3594.3 3594.4 32186.8 32190.5 32246.0 32252.2 32279.0 4947.0 4956.5 4961.6 4967.2 5001.3 202438.0 205952.0 206145.0 206214.0 206763.0 51722.7 51735.5 51790.5 51834.5 51994.7 53206.7 53331.7 53350.0 53430.2 53508.7 16849.5 17186.6 17203.6 17253.3 17329.7 10945.0 11021.7 13970.9 14047.1 14140.9 15109.7 15130.1 15185.2 15203.3 15396.4 6179.0 6304.7 6331.4 6340.6 6352.8 998.6 1010.3 1015.8 1019.2 1023.4 22751.2 28841.0 29538.9 29691.6 30016.4 1064.2 1065.8 1078.7 1091.2 1098.4 12487.4 12603.2 12651.7 12720.6 12835.6 243781.0 245083.0 246149.0 246728.0 247158.0 54510.0 54911.0 55188.4 55274.0 55294.9 1455.7 1463.1 1508.6 1509.8 1514.5 22756.8 23077.0 23271.7 23283.7 23441.4 39679.6 39978.0 40052.6 40078.0 40119.6 217735.0 218372.0 220041.0 220043.0 220408.0 35252.5 37304.4 39450.6 39516.6 39599.0 47869.5 49465.5 49569.8 49614.5 49668.3 35548.5 35587.8 35604.3 35894.0 36601.8 35162.5 35334.5 35546.6 35655.5 36107.5 39567.0 39660.2 39691.4 39932.4 39989.0 33960.0 34266.0 34549.7 35283.3 35752.0 25294.1 25408.7 25525.7 25838.7 25988.6 18:44:43 INFO - PID 26654 | 18:44:43 INFO - PID 26654 | [#2] jquery.html Cycles:180 Average:35847.51 Median:12760.71 stddev:84171.25 (659.6%) stddev-sans-first:84365.69 18:44:43 INFO - PID 26654 | Values: 568.7 581.4 590.9 593.2 597.6 22662.2 23425.8 23436.5 23452.2 23452.3 26235.3 26839.7 27059.5 27060.3 27066.2 6549.3 6648.6 6704.1 6716.7 6720.6 6191.8 6483.9 6517.7 6529.0 6551.1 6477.2 6484.2 6494.0 6500.5 6501.8 6480.4 6487.8 6504.9 6507.9 6514.3 6026.7 6068.5 6076.5 6078.1 6087.2 29664.4 29897.7 30006.6 30169.2 30750.4 1902.0 1941.2 1943.2 1943.3 1943.6 18610.9 19234.1 19257.4 19300.1 19325.8 2275.0 2275.5 2329.7 2369.2 2376.3 141093.0 144422.3 144662.6 144952.0 145463.0 14234.7 14887.9 15030.9 15308.2 15872.8 23191.8 24400.6 24424.1 24460.6 24509.4 10494.3 10499.6 10622.8 10743.5 10939.3 9728.4 9732.0 9818.2 9858.5 10021.6 9389.6 9478.7 9516.5 9540.0 9570.8 2665.8 2675.7 2700.4 2755.3 2839.3 949.3 967.8 973.0 976.6 997.3 19127.2 19373.7 19530.6 19754.9 19831.8 1034.7 1053.6 1054.4 1058.0 1058.2 10645.2 10795.4 10861.5 11076.3 11168.3 489980.0 493952.0 501000.0 502932.0 503523.0 114377.0 115422.4 115628.4 116778.2 125052.4 1271.2 1271.5 1309.7 1322.3 1324.6 20690.9 20825.8 21005.8 21275.3 21324.8 60553.1 60837.0 61095.4 62399.7 62868.4 76363.6 77024.6 77257.6 77593.6 78431.0 14361.9 15094.7 15152.4 15194.1 15202.5 23161.8 23529.6 23582.3 23722.5 23749.3 18145.6 18264.5 18592.0 18619.3 18882.9 16914.9 16988.3 17555.3 17560.1 17883.0 19452.5 19616.0 19949.8 19977.8 20135.6 14704.6 15300.4 15316.8 15318.3 15367.5 18910.1 19045.6 19154.9 19257.2 19363.2 18:44:43 INFO - PID 26654 | 18:44:43 INFO - PID 26654 | [#3] mootools.html Cycles:180 Average:8729.38 Median:2690.89 stddev:5832.21 (216.7%) stddev-sans-first:5822.37 18:44:43 INFO - PID 26654 | Values: 1371.7 1439.4 1441.5 1449.5 1451.1 13493.1 13642.8 14108.8 14136.2 14141.2 13689.7 14490.2 14510.9 14616.6 14622.6 2736.4 2796.7 2798.3 2801.4 2802.1 2668.1 2709.5 2767.2 2772.1 2773.7 2688.7 2744.3 2751.8 2752.4 2753.1 2640.7 2693.1 2703.5 2704.6 2714.7 2292.1 2358.1 2626.0 2626.4 2629.8 11710.5 13392.9 13942.9 13950.7 13974.4 7613.8 7962.0 7967.5 7969.3 7988.2 5178.5 5400.9 5466.5 5473.4 5514.9 1855.5 1880.2 1897.7 1929.0 1938.4 22172.9 22766.5 22812.7 22831.2 22832.8 7014.4 7066.5 7085.1 7252.9 7268.6 18023.2 18070.4 18118.3 18118.6 18121.8 7464.0 7841.3 7875.1 7995.7 7996.1 7006.8 7061.7 7066.5 7074.2 7079.1 5596.7 5618.5 5626.9 5700.9 5768.8 1737.1 1805.0 1814.6 1821.1 1837.5 886.5 912.5 921.9 931.5 940.2 7353.9 7381.3 7382.8 7413.2 7647.2 684.2 693.5 714.9 729.5 741.1 4810.6 5196.2 5304.4 5313.7 5341.9 17149.6 18104.9 18839.1 18951.8 19236.6 18145.8 18846.9 18874.2 18879.9 18933.0 10498.7 10570.3 10586.1 10672.5 10768.2 8266.4 8419.7 8497.5 8543.9 8562.8 16214.8 16449.8 16582.2 16582.8 16688.0 16317.0 16857.3 16993.1 17007.8 17297.0 10906.6 11118.1 11161.9 11162.3 11162.7 12355.3 12502.1 12882.5 12909.9 12924.9 10330.8 10414.6 10424.5 10425.5 10603.0 9920.8 9959.5 10030.7 10114.0 10120.3 9164.5 9333.3 9334.0 9357.9 9365.5 7151.5 7159.7 7193.8 7202.4 7240.6 7444.9 7447.1 7460.7 7484.8 7618.1 18:44:43 INFO - PID 26654 | 18:44:43 INFO - PID 26654 | [#4] prototype.html Cycles:180 Average:5495.79 Median:6180.04 stddev:1538.41 (24.9%) stddev-sans-first:1496.32 18:44:43 INFO - PID 26654 | Values: 499.4 517.4 524.4 526.4 538.9 6196.9 6228.0 6235.2 6238.9 6277.5 6173.9 6186.1 6196.0 6204.3 6220.7 5137.5 5168.4 5171.0 5182.7 5187.2 4750.7 4932.4 5107.9 5113.9 5131.7 4852.7 4887.8 4899.6 4900.8 4912.3 4886.2 4902.8 4911.5 4923.3 4933.3 4385.2 4388.9 4409.9 4445.1 4445.2 6035.5 6042.9 6053.5 6062.3 6072.1 5567.1 5574.5 5618.4 5622.4 5675.9 6331.4 6345.2 6467.3 6485.7 6494.5 4740.3 4775.0 4780.1 4803.4 4821.7 6564.1 6705.6 6710.9 6841.4 6889.7 4941.6 4973.5 4982.1 4991.9 5016.7 5005.1 5036.6 5039.2 5040.9 5102.6 5590.0 5631.1 5652.9 5679.5 5694.3 6575.8 6606.4 6629.1 6631.2 6655.1 1752.4 1772.1 1782.5 1793.4 1794.7 1157.0 1200.4 1219.6 1239.4 1241.5 5754.9 5755.4 5773.4 5796.2 5806.4 6560.3 6636.7 6645.0 6696.7 6717.4 5713.6 5741.5 5745.6 5749.9 5755.5 3561.8 3591.4 3602.0 3611.5 3637.7 6345.7 6421.0 6431.6 6451.7 6467.9 6747.4 6752.5 6822.4 6827.8 6924.5 6400.5 6447.3 6447.5 6450.5 6560.6 6277.9 6686.8 6758.2 6763.5 6766.7 6586.2 6632.8 6636.4 6654.6 6698.9 6371.7 6491.9 6544.0 6553.4 6581.6 4938.4 4942.8 4952.9 4964.2 4971.5 6459.9 6578.0 6657.8 6764.9 6843.0 6491.0 6541.3 6566.4 6589.9 6621.3 6490.9 6563.7 6586.8 6630.5 6632.1 6389.6 6438.3 6469.0 6502.9 6544.8 6526.7 6611.6 6642.4 6644.1 6651.7 6433.1 6478.6 6479.0 6516.7 6528.0 18:44:43 INFO - PID 26654 | 18:44:43 INFO - PID 26654 | [#5] yui.html Cycles:180 Average:23382.43 Median:19869.20 stddev:31721.49 (159.7%) stddev-sans-first:31765.68 18:44:43 INFO - PID 26654 | Values: 931.4 942.1 946.0 955.2 970.0 18237.3 19200.7 19202.7 19221.9 19246.6 16815.6 17913.9 21955.2 21994.3 22049.9 1039.7 1053.3 1055.0 1055.0 1055.8 1057.9 1067.9 1068.4 1070.2 1071.5 991.2 1087.8 1089.3 1090.0 1091.0 1070.7 1076.0 1076.4 1081.3 1082.4 787.1 787.7 793.2 793.9 795.2 19034.6 19840.8 19897.6 20235.8 20239.4 19759.4 19761.1 20157.1 20157.3 20618.2 13989.8 14073.7 14268.2 14310.9 14326.9 3484.3 3550.6 3559.8 3576.6 3580.5 126405.0 127084.4 127185.0 128850.4 130535.0 15234.6 15502.5 15779.0 15793.7 15821.3 30571.4 31064.2 31285.2 31290.5 31344.1 7750.3 7775.2 7842.4 7892.8 7894.0 4318.4 4363.9 4372.7 4417.1 4419.5 5037.3 5139.6 5170.9 5186.5 5190.3 921.7 953.1 954.9 966.1 966.6 641.5 659.5 659.6 667.2 679.1 11138.9 11487.5 11510.2 11527.0 12374.4 626.3 632.0 692.3 695.1 701.2 5051.4 5396.0 5593.7 5604.5 5743.5 100266.5 101370.5 103044.0 104676.0 105260.0 93133.5 95434.5 95636.5 96843.5 97271.0 83637.6 85233.0 86766.1 87300.6 87929.0 12102.0 12135.8 12215.3 12451.9 12520.0 35085.5 35548.5 36204.5 36783.3 39453.0 69989.3 71609.3 71688.0 73976.0 73982.5 18081.2 18587.7 18637.9 18686.3 18750.5 19748.2 20156.5 20384.7 20396.8 20500.2 17989.9 18004.6 18029.4 18042.1 18179.9 18112.3 18430.8 18754.4 18967.7 18982.0 17740.7 18039.6 18047.4 18071.8 18218.0 13774.0 14076.4 14216.1 14388.4 14512.2 13430.5 13782.2 13930.2 13948.7 14036.3 18:44:43 INFO - PID 26654 | -------- Summary: end -------- 18:44:43 INFO - PID 26654 | 18:44:44 INFO - TEST-INFO | 26654: exit 0 18:44:44 INFO - TEST-OK | dromaeo_css | took 1112307ms 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:39837/getInfo.html -profile /tmp/tmpHW2Av7/profile 18:44:44 INFO - TEST-INFO | started process 27027 (/builds/slave/test/build/application/firefox/firefox http://localhost:39837/getInfo.html) 18:44:50 INFO - TEST-INFO | 27027: 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 27252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHW2Av7/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 27252 | 18:44:51 INFO - PID 27252 | (/builds/slave/test/build/application/firefox/firefox:27307): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:44:51 INFO - PID 27252 | 18:45:01 INFO - PID 27252 | RSS: Main: 174366720 18:45:01 INFO - PID 27252 | 18:45:04 INFO - PID 27252 | Cycle 1(1): loaded http://localhost:39837/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39837/tests/kraken/driver.html?testName=audio-beat-detection) 18:45:05 INFO - PID 27252 | RSS: Main: 179392512 18:45:05 INFO - PID 27252 | 18:45:08 INFO - PID 27252 | Cycle 1(1): loaded http://localhost:39837/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39837/tests/kraken/driver.html?testName=audio-dft) 18:45:08 INFO - PID 27252 | RSS: Main: 179777536 18:45:08 INFO - PID 27252 | 18:45:11 INFO - PID 27252 | Cycle 1(1): loaded http://localhost:39837/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39837/tests/kraken/driver.html?testName=audio-fft) 18:45:12 INFO - PID 27252 | RSS: Main: 174714880 18:45:12 INFO - PID 27252 | 18:45:14 INFO - PID 27252 | Cycle 1(1): loaded http://localhost:39837/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39837/tests/kraken/driver.html?testName=audio-oscillator) 18:45:15 INFO - PID 27252 | RSS: Main: 175218688 18:45:15 INFO - PID 27252 | 18:45:17 INFO - PID 27252 | Cycle 1(1): loaded http://localhost:39837/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39837/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:45:18 INFO - PID 27252 | RSS: Main: 175374336 18:45:18 INFO - PID 27252 | 18:45:21 INFO - PID 27252 | Cycle 1(1): loaded http://localhost:39837/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39837/tests/kraken/driver.html?testName=imaging-darkroom) 18:45:22 INFO - PID 27252 | RSS: Main: 178114560 18:45:22 INFO - PID 27252 | 18:45:25 INFO - PID 27252 | Cycle 1(1): loaded http://localhost:39837/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39837/tests/kraken/driver.html?testName=imaging-desaturate) 18:45:26 INFO - PID 27252 | RSS: Main: 177258496 18:45:26 INFO - PID 27252 | 18:45:29 INFO - PID 27252 | Cycle 1(1): loaded http://localhost:39837/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39837/tests/kraken/driver.html?testName=json-parse-financial) 18:45:29 INFO - PID 27252 | RSS: Main: 178356224 18:45:29 INFO - PID 27252 | 18:45:31 INFO - PID 27252 | Cycle 1(1): loaded http://localhost:39837/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39837/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:45:32 INFO - PID 27252 | RSS: Main: 178786304 18:45:32 INFO - PID 27252 | 18:45:33 INFO - PID 27252 | Cycle 1(1): loaded http://localhost:39837/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39837/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:45:34 INFO - PID 27252 | RSS: Main: 175079424 18:45:34 INFO - PID 27252 | 18:45:36 INFO - PID 27252 | Cycle 1(1): loaded http://localhost:39837/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39837/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:45:37 INFO - PID 27252 | RSS: Main: 175501312 18:45:37 INFO - PID 27252 | 18:45:40 INFO - PID 27252 | Cycle 1(1): loaded http://localhost:39837/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39837/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:45:41 INFO - PID 27252 | RSS: Main: 175771648 18:45:41 INFO - PID 27252 | 18:45:44 INFO - PID 27252 | Cycle 1(1): loaded http://localhost:39837/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39837/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:45:44 INFO - PID 27252 | RSS: Main: 176037888 18:45:44 INFO - PID 27252 | 18:45:46 INFO - PID 27252 | Cycle 1(1): loaded http://localhost:39837/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39837/tests/kraken/driver.html?testName=ai-astar) 18:45:46 INFO - PID 27252 | RSS: Main: 177410048 18:45:46 INFO - PID 27252 | 18:45:46 INFO - PID 27252 | __start_tp_report 18:45:46 INFO - PID 27252 | _x_x_mozilla_page_load 18:45:46 INFO - PID 27252 | _x_x_mozilla_page_load_details 18:45:46 INFO - PID 27252 | |i|pagename|runs| 18:45:46 INFO - PID 27252 | |0;ai-astar;98;108;104;108;108;109;109;98;109;116 18:45:46 INFO - PID 27252 | |1;audio-beat-detection;163;127;147;187;118;141;152;124;171;126 18:45:46 INFO - PID 27252 | |2;audio-dft;166;163;163;163;168;167;165;161;164;172 18:45:46 INFO - PID 27252 | |3;audio-fft;73;77;78;170;77;74;77;76;158;82 18:45:46 INFO - PID 27252 | |4;audio-oscillator;80;84;130;80;79;81;136;79;78;133 18:45:46 INFO - PID 27252 | |5;imaging-gaussian-blur;114;114;113;115;115;115;114;118;118;119 18:45:46 INFO - PID 27252 | |6;imaging-darkroom;151;151;150;151;152;151;150;151;157;152 18:45:46 INFO - PID 27252 | |7;imaging-desaturate;94;94;95;94;94;95;94;94;94;95 18:45:46 INFO - PID 27252 | |8;json-parse-financial;54;55;60;57;57;58;59;58;60;54 18:45:46 INFO - PID 27252 | |9;json-stringify-tinderbox;58;54;53;54;54;55;53;54;53;54 18:45:46 INFO - PID 27252 | |10;stanford-crypto-aes;83;77;84;79;78;79;90;88;89;77 18:45:46 INFO - PID 27252 | |11;stanford-crypto-ccm;136;136;142;132;140;126;130;139;125;174 18:45:46 INFO - PID 27252 | |12;stanford-crypto-pbkdf2;171;195;179;173;179;175;174;184;180;177 18:45:46 INFO - PID 27252 | |13;stanford-crypto-sha256-iterative;69;73;68;65;66;66;70;73;65;71 18:45:46 INFO - PID 27252 | __end_tp_report 18:45:46 INFO - PID 27252 | __start_cc_report 18:45:46 INFO - PID 27252 | _x_x_mozilla_cycle_collect,973 18:45:46 INFO - PID 27252 | __end_cc_report 18:45:46 INFO - PID 27252 | __startTimestamp1501638346947__endTimestamp 18:45:46 INFO - PID 27252 | 18:45:46 INFO - PID 27252 | ------- Summary: start ------- 18:45:46 INFO - PID 27252 | Number of tests: 14 18:45:46 INFO - PID 27252 | 18:45:46 INFO - PID 27252 | [#0] ai-astar Cycles:10 Average:106.70 Median:109.00 stddev:5.44 (5.0%) stddev-sans-first:4.77 18:45:46 INFO - PID 27252 | Values: 98.0 108.0 104.0 108.0 108.0 109.0 109.0 98.0 109.0 116.0 18:45:46 INFO - PID 27252 | 18:45:46 INFO - PID 27252 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:149.50 stddev:22.81 (15.3%) stddev-sans-first:23.31 18:45:46 INFO - PID 27252 | Values: 163.0 127.0 147.0 187.0 118.0 141.0 152.0 124.0 171.0 126.0 18:45:46 INFO - PID 27252 | 18:45:46 INFO - PID 27252 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.50 stddev:3.19 (1.9%) stddev-sans-first:3.37 18:45:46 INFO - PID 27252 | Values: 166.0 163.0 163.0 163.0 168.0 167.0 165.0 161.0 164.0 172.0 18:45:46 INFO - PID 27252 | 18:45:46 INFO - PID 27252 | [#3] audio-fft Cycles:10 Average:94.20 Median:77.00 stddev:36.97 (48.0%) stddev-sans-first:38.41 18:45:46 INFO - PID 27252 | Values: 73.0 77.0 78.0 170.0 77.0 74.0 77.0 76.0 158.0 82.0 18:45:46 INFO - PID 27252 | 18:45:46 INFO - PID 27252 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:79.50 stddev:25.62 (32.2%) stddev-sans-first:26.51 18:45:46 INFO - PID 27252 | Values: 80.0 84.0 130.0 80.0 79.0 81.0 136.0 79.0 78.0 133.0 18:45:46 INFO - PID 27252 | 18:45:46 INFO - PID 27252 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.00 stddev:2.07 (1.8%) stddev-sans-first:2.12 18:45:46 INFO - PID 27252 | Values: 114.0 114.0 113.0 115.0 115.0 115.0 114.0 118.0 118.0 119.0 18:45:46 INFO - PID 27252 | 18:45:46 INFO - PID 27252 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:151.00 stddev:2.01 (1.3%) stddev-sans-first:2.12 18:45:46 INFO - PID 27252 | Values: 151.0 151.0 150.0 151.0 152.0 151.0 150.0 151.0 157.0 152.0 18:45:46 INFO - PID 27252 | 18:45:46 INFO - PID 27252 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 18:45:46 INFO - PID 27252 | Values: 94.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 95.0 18:45:46 INFO - PID 27252 | 18:45:46 INFO - PID 27252 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:58.00 stddev:2.25 (3.9%) stddev-sans-first:2.07 18:45:46 INFO - PID 27252 | Values: 54.0 55.0 60.0 57.0 57.0 58.0 59.0 58.0 60.0 54.0 18:45:46 INFO - PID 27252 | 18:45:46 INFO - PID 27252 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.00 stddev:1.48 (2.7%) stddev-sans-first:0.67 18:45:46 INFO - PID 27252 | Values: 58.0 54.0 53.0 54.0 54.0 55.0 53.0 54.0 53.0 54.0 18:45:46 INFO - PID 27252 | 18:45:46 INFO - PID 27252 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.50 stddev:5.13 (6.1%) stddev-sans-first:5.43 18:45:46 INFO - PID 27252 | Values: 83.0 77.0 84.0 79.0 78.0 79.0 90.0 88.0 89.0 77.0 18:45:46 INFO - PID 27252 | 18:45:46 INFO - PID 27252 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:137.50 stddev:13.90 (10.1%) stddev-sans-first:14.72 18:45:46 INFO - PID 27252 | Values: 136.0 136.0 142.0 132.0 140.0 126.0 130.0 139.0 125.0 174.0 18:45:46 INFO - PID 27252 | 18:45:46 INFO - PID 27252 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.70 Median:179.00 stddev:6.88 (3.8%) stddev-sans-first:6.71 18:45:46 INFO - PID 27252 | Values: 171.0 195.0 179.0 173.0 179.0 175.0 174.0 184.0 180.0 177.0 18:45:46 INFO - PID 27252 | 18:45:46 INFO - PID 27252 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.50 stddev:3.10 (4.5%) stddev-sans-first:3.28 18:45:46 INFO - PID 27252 | Values: 69.0 73.0 68.0 65.0 66.0 66.0 70.0 73.0 65.0 71.0 18:45:46 INFO - PID 27252 | -------- Summary: end -------- 18:45:46 INFO - PID 27252 | 18:45:47 INFO - PID 27252 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:45:47 INFO - TEST-INFO | 27252: exit 0 18:45:47 INFO - TEST-OK | kraken | took 63101ms 18:45:47 INFO - SUITE-END | took 1175s 18:45:48 INFO - Completed test suite (00:19:35) 18:45:48 INFO - javascript benchmark 18:45:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8549.358275960372, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3113.361760839028, 3117.984410077949, 3156.1320636824858, 3163.8259895705733, 3178.1577881861313, 6063.333033366326, 6087.78692745754, 6158.815235542929, 6175.567710260278, 6221.471174950129, 6156.168917196177, 6163.106349579309, 6198.690065496729, 6205.813825585228, 6206.441420272175, 5652.971735141318, 5696.800611978571, 5708.800191993281, 5731.512821410185, 5745.626534275259, 163.5392270824625, 5560.6941618210985, 5671.120976248688, 5792.623479473842, 5800.738966746507, 5537.1140617501005, 5573.442655734435, 5580.414056524068, 5594.9720251398885, 5615.2700148980775, 5616.269884914935, 5621.606487545873, 5664.518515926151, 5691.288588926384, 5696.943030569682, 5602.187682785973, 5662.886742265173, 5679.148127780824, 5691.231683722686, 5702.030654788655, 6062.727177277033, 6063.757449702007, 6065.4844338231305, 6087.939120608781, 6181.320054793969, 6413.967930160366, 6561.606303621798, 6644.103046088813, 6651.534392592521, 6662.900056499157, 6564.113844631009, 6601.504887133437, 6638.070670106189, 6706.295838936939, 6707.731690732365, 6174.166487524171, 6210.813675589739, 6265.279492858289, 6272.435480806749, 6277.340879207709, 6800.65996700163, 6807.353301436356, 6890.655467226618, 6906.240313565504, 6938.548994315353, 6451.387118223761, 6474.158359413246, 6477.255115661759, 6533.542652014408, 6577.210734711865, 6612.4710023198995, 6614.669266536654, 6619.338066193439, 6623.768168114093, 6639.800805975829, 6413.486921046305, 6489.156409666713, 6529.967350163219, 6540.247871494839, 6603.76886808969, 6562.310957349505, 6563.474922006228, 6615.933840661532, 6655.367740064686, 6670.866582668416, 5328.467153284718, 5392.137258038773, 5395.082835917825, 5395.352557693023, 5399.9190012149065, 4559.224931761609, 4560.840370587013, 4567.451905771329, 4569.109023740405, 4569.771511424482, 5724.25584673998, 5794.913076303858, 5800.390958949334, 5813.215215945877, 5836.708164591753, 6631.403173714389, 6671.833204169838, 6682.699278532477, 6767.492438067165, 6788.015737718003, 5571.0807716726285, 5761.107028410603, 5820.738066787005, 5825.359210486843, 5826.504747096459, 5811.88376232473, 5843.2403787507355, 5884.176215329857, 5890.823275301748, 5910.970445147746, 6424.261209960914, 6427.775027874002, 6456.483481321483, 6511.055896895018, 6518.934810651927, 6633.568818026813, 6639.502037347122, 6737.562058466184, 6738.7304507819135, 6754.898676519758, 6325.905111423424, 6403.807885763435, 6417.935820641734, 6474.611523308617, 6520.152380190545, 6548.639824809681, 6568.310327415744, 6601.207855057231, 6624.966875165594, 6641.468682505485, 6647.169103862017, 6654.268030516736, 6661.733530658913, 6754.12196414463, 6755.763548275787, 6264.968675156595, 6415.486761059011, 6417.1657684500715, 6467.126937863328, 6522.543421960418, 6348.396902294275, 6412.134361861089, 6414.5189110815945, 6428.4857211423905, 6445.0332450132855, 6261.592996455216, 6263.968680156752, 6298.1812364392335, 6313.747450101944, 6327.240731112296, 6442.35576442352, 6468.482521398371, 6555.2789193187755, 6565.441937435371, 6572.474202063919, 6199.721012554356, 6250.156228909039, 6286.937130628635, 6297.842553936188, 6311.368863113652], "value": 6008.441152923204, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.0704225352109, 882.8940527136745, 902.7923577577161, 905.6196397513044, 1163.1741463560872, 31374.372512549762, 32057.839710801443, 43140.13719725604, 43181.0, 43190.9202269943, 43918.56081439184, 44252.0, 44280.557194428045, 44416.55583444165, 44456.11087778243, 7338.633068346561, 7683.462157648967, 7918.6436610352675, 7929.207079292053, 7932.2067793220795, 7731.3814894808565, 7836.608169591526, 7836.921630783705, 7838.0, 7844.587974164648, 7853.882191767099, 7865.960670196641, 7872.252136047066, 7909.406794490407, 7914.445988780788, 7783.182765809565, 7791.649375778075, 7806.453548251625, 7846.489978151402, 7848.843023139505, 7700.845983080307, 7735.61321933901, 7737.30364267213, 7744.535327880289, 7756.806079847993, 39351.21297574032, 39401.21197576061, 39636.0, 39728.20543589112, 39835.0, 3530.6116327203986, 3555.4489054196642, 3580.0, 3594.2991116732246, 3594.4248920172645, 32186.839065804754, 32190.517142242887, 32246.032619021233, 32252.193695157574, 32279.0, 4947.03532811102, 4956.504349565051, 4961.627877909171, 4967.205247160437, 5001.349824522825, 202438.0, 205952.0, 206145.0, 206214.0, 206763.0, 51722.74138629283, 51735.48264517382, 51790.482095178566, 51834.48165518372, 51994.74002629962, 53206.73396632992, 53331.73334133382, 53350.0, 53430.19854702183, 53508.73245633825, 16849.494515164566, 17186.570335741708, 17203.56991075208, 17253.309867605156, 17329.65340693179, 10945.0, 11021.669349919515, 13970.860291396955, 14047.08693934891, 14140.929295353457, 15109.697806044038, 15130.092194468367, 15185.240737963279, 15203.315850786741, 15396.384144634088, 6178.969105154445, 6304.71628776697, 6331.430171284606, 6340.590575581342, 6352.809415717536, 998.6454808542862, 1010.3331801011298, 1015.7663737340453, 1019.2050200843354, 1023.4473384372355, 22751.203707870478, 28841.0, 29538.852305738335, 29691.554626680616, 30016.39967200644, 1064.2071656615872, 1065.8188108021654, 1078.6979645699216, 1091.2088735666578, 1098.4343063322394, 12487.375631218403, 12603.18079324841, 12651.683707907192, 12720.554780582635, 12835.550755723505, 243781.0, 245083.0, 246149.0, 246728.0, 247158.0, 54510.0, 54911.0, 55188.44811551833, 55274.0, 55294.89410211773, 1455.7015811758565, 1463.0563286680244, 1508.6379268975368, 1509.7508911029777, 1514.538065889892, 22756.772432275466, 23077.0, 23271.650925235797, 23283.650745238498, 23441.41396465102, 39679.60320396759, 39978.0, 40052.599474006056, 40078.0, 40119.598804011584, 217735.0, 218372.0, 220041.0, 220043.0, 220408.0, 35252.47121293234, 37304.44043339406, 39450.60549394469, 39516.60483395244, 39599.0, 47869.5213047865, 49465.50534494753, 49569.75215124046, 49614.50385496099, 49668.25497617611, 35548.466772998945, 35587.82206088953, 35604.28791424105, 35894.0, 36601.81699091488, 35162.47256291106, 35334.46998294976, 35546.644533555365, 35655.465168023016, 36107.45838812472, 39567.0, 39660.2067958645, 39691.40462893117, 39932.401013984236, 39989.0, 33960.0, 34266.0, 34549.65450345565, 35283.294334113685, 35752.0, 25294.1147059852, 25408.74591254064, 25525.744742552335, 25838.741612583635, 25988.61017084783], "value": 18051.357352113722, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.7156421789107, 581.4272941152966, 590.9468147866694, 593.2406519654841, 597.5607928172795, 22662.206822761185, 23425.76574234257, 23436.531269374624, 23452.179173728924, 23452.29643110705, 26235.3441163971, 26839.73160268397, 27059.458810823773, 27060.323491912714, 27066.18801435955, 6549.345065493449, 6648.634325112117, 6704.128463299764, 6716.6977486013, 6720.596764194164, 6191.845203869917, 6483.935160648404, 6517.706703198343, 6528.967355163218, 6551.115599394092, 6477.222733272014, 6484.1894763154605, 6493.967530162343, 6500.512461565378, 6501.804945851608, 6480.351964803505, 6487.772927947546, 6504.869902601921, 6507.869842603145, 6514.3485651435185, 6026.698665066773, 6068.514518838482, 6076.453119219247, 6078.088286756978, 6087.239095113111, 29664.406711865642, 29897.701022989928, 30006.64970076352, 30169.245768855733, 30750.384992300027, 1901.9714704279447, 1941.1652989214633, 1943.2227109156308, 1943.319838056683, 1943.5724140689026, 18610.90694546532, 19234.134463949154, 19257.4222773317, 19300.1314940828, 19325.80674193254, 2274.977250227493, 2275.465265662568, 2329.650552417151, 2369.241842610348, 2376.3346263046374, 141093.0, 144422.27788861093, 144662.55337446596, 144952.0, 145463.0, 14234.715305693828, 14887.851121488864, 15030.924845375921, 15308.158051307062, 15872.761908571381, 23191.768082318962, 24400.633990490158, 24424.145154919494, 24460.633090503656, 24509.387265318153, 10494.317869338469, 10499.632512862014, 10622.840657390145, 10743.462826858626, 10939.28894621863, 9728.367656102331, 9731.951340243253, 9818.165455936325, 9858.457784821903, 10021.599136034478, 9389.577469013775, 9478.715638530855, 9516.476593787409, 9539.950605433396, 9570.760730981781, 2665.813712897742, 2675.6922953860553, 2700.409304182897, 2755.2973991632007, 2839.2617919340705, 949.2738055387634, 967.8354679704327, 973.0415540692412, 976.62888102522, 997.3018886779283, 19127.23491060342, 19373.709394359095, 19530.609387812165, 19754.90122549378, 19831.801681983285, 1034.6947650443137, 1053.6154303679255, 1054.383185836279, 1058.0424715632364, 1058.169337070396, 10645.20160987929, 10795.406252656023, 10861.45692715377, 11076.335419874673, 11168.329900205852, 489980.0, 493952.0, 501000.0, 502932.0, 503523.0, 114377.0, 115422.42288788503, 115628.42185789018, 116778.24832627518, 125052.37473812573, 1271.173737070893, 1271.5486002469174, 1309.7249577588814, 1322.2991814338416, 1324.5628942448968, 20690.896545517175, 20825.791742082387, 21005.789942100382, 21275.255366062112, 21324.78675213228, 60553.14258421852, 60837.0, 61095.38904610897, 62399.6880015597, 62868.371316286255, 76363.61818190874, 77024.61487692526, 77257.61371193107, 77593.61203193948, 78431.0, 14361.856381436051, 15094.698106038037, 15152.393904243707, 15194.088354698753, 15202.46791362297, 23161.76838231596, 23529.64705529453, 23582.292531223404, 23722.525549488568, 23749.287521373695, 18145.637087257917, 18264.45206643803, 18592.0, 18619.34832280918, 18882.905585472534, 16914.915425422794, 16988.320467181667, 17555.297788088334, 17560.12199390051, 17883.0, 19452.513687157367, 19616.0, 19949.800501994796, 19977.800221997593, 20135.59728805445, 14704.632384190481, 15300.387984480496, 15316.846831531988, 15318.310676019828, 15367.462138825087, 18910.14904329281, 19045.61908761845, 19154.904225478782, 19257.22971081197, 19363.225470981004], "value": 12281.301733738577, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.7119404924963, 1439.366678661389, 1441.5170917742555, 1449.4636984315805, 1451.0568130715037, 13493.122947008449, 13642.795358069638, 14108.788368174473, 14136.222507762082, 14141.151530908128, 13689.726205475909, 14490.20303883286, 14510.854891451083, 14616.634584135401, 14622.634434139152, 2736.370634754003, 2796.6504186976626, 2798.3144129688153, 2801.3696918193345, 2802.14534566957, 2668.106184428219, 2709.512287788197, 2767.225176950457, 2772.085211880075, 2773.7087605801403, 2688.7176846431134, 2744.2727677165567, 2751.7798576113964, 2752.4357506711076, 2753.063958254193, 2640.7359264073534, 2693.0708905427696, 2703.499852527279, 2704.634874291965, 2714.674239091302, 2292.1175347491335, 2358.056777289098, 2625.9868700656375, 2626.3828000419885, 2629.815912886099, 11710.531578736925, 13392.866071339356, 13942.860571394258, 13950.651233719136, 13974.371153298125, 7613.771586852348, 7962.044554653478, 7967.4821136626515, 7969.282764551161, 7988.241117093867, 5178.533931946105, 5400.91898621521, 5466.508014278695, 5473.370562385297, 5514.91727624086, 1855.5268406556377, 1880.2479008396615, 1897.6773948428663, 1928.980710192894, 1938.3603410874377, 22172.88913555422, 22766.54466910669, 22812.657810133027, 22831.20090796814, 22832.77167228323, 7014.438844892396, 7066.540674856118, 7085.14978202619, 7252.854942901113, 7268.600226987566, 18023.18895649699, 18070.3675371364, 18118.27526898909, 18118.637627247383, 18121.818781812013, 7464.0, 7841.333486653584, 7875.133735289113, 7995.680172793023, 7996.120426753053, 7006.754763583352, 7061.682224299816, 7066.470014748915, 7074.186468556079, 7079.115110611174, 5596.692181930033, 5618.494335509824, 5626.887462250814, 5700.942990570041, 5768.798092066758, 1737.1401156427396, 1804.954876128081, 1814.637072585488, 1821.0985562146557, 1837.467134530971, 886.5478605910903, 912.5254867468879, 921.8663293822358, 931.4550987672152, 940.2478017585904, 7353.926460735431, 7381.261873812576, 7382.815429614303, 7413.221611730691, 7647.158812530617, 684.2473279392628, 693.5457275484565, 714.8641758065951, 729.5112274775913, 741.1069661058411, 4810.6151507879285, 5196.220566914993, 5304.363476382859, 5313.734313284321, 5341.919871201935, 17149.57126071858, 18104.9094754528, 18839.05804709759, 18951.81048189528, 19236.615267694848, 18145.818541814413, 18846.905765471085, 18874.245030198912, 18879.90560047191, 18933.0, 10498.737531561772, 10570.312929659547, 10586.100181484506, 10672.519736611872, 10768.246222764332, 8266.380021498291, 8419.663213471393, 8497.490150590736, 8543.914560854311, 8562.78593035179, 16214.756778648094, 16449.753253700965, 16582.17089145514, 16582.75125873089, 16688.0, 16317.0, 16857.325706971584, 16993.06538140365, 17007.829921700624, 17297.0, 10906.563737450731, 11118.110551155727, 11161.888381116085, 11162.274452160584, 11162.665120046411, 12355.32045737493, 12502.124851260325, 12882.48470061187, 12909.935450322688, 12924.870751292743, 10330.793384132125, 10414.583416663248, 10424.530896109845, 10425.478726063819, 10602.992715691997, 9920.751981200528, 9959.452230127123, 10030.699079027641, 10114.039166279192, 10120.342177758423, 9164.541772911462, 9333.300002499975, 9333.953330233306, 9357.906420935704, 9365.484898330385, 7151.463640227108, 7159.749408770668, 7193.784186474414, 7202.3877970373105, 7240.565566066053, 7444.888326674996, 7447.069116360455, 7460.738874139379, 7484.775456736306, 7618.085829700472], "value": 6420.270623457857, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.3660392080368, 517.4385791416314, 524.3602804578414, 526.4367127173925, 538.8733647592815, 6196.918526808019, 6227.9999999999945, 6235.222961455986, 6238.906416403746, 6277.5291853110975, 6173.938260617392, 6186.133941248228, 6196.0, 6204.31752507225, 6220.720067596958, 5137.486251374851, 5168.371962831696, 5170.974145129278, 5182.6631268967585, 5187.19598462239, 4750.691205071676, 4932.383452068491, 5107.897842043157, 5113.948860511403, 5131.717755523445, 4852.684575502599, 4887.755612219393, 4899.559039686427, 4900.779464924087, 4912.336834527328, 4886.193778026622, 4902.828401005983, 4911.533404326583, 4923.335349727777, 4933.28467372229, 4385.2106620808245, 4388.934165987513, 4409.889752756207, 4445.11097780442, 4445.155420470101, 6035.486983606399, 6042.879142417171, 6053.485453736438, 6062.333143354227, 6072.119542666333, 5567.137093750475, 5574.498295153415, 5618.353889302701, 5622.353429355636, 5675.9432405675825, 6331.398517140864, 6345.17512723343, 6467.288598254188, 6485.702859428086, 6494.512911531607, 4740.2889566564945, 4774.976125119352, 4780.139574876521, 4803.351547541107, 4821.686590371614, 6564.081028655992, 6705.597664140168, 6710.899336509956, 6841.350071743226, 6889.655517224119, 4941.5669455858115, 4973.452920178777, 4982.103221420107, 4991.850244492671, 5016.724080175552, 5005.1491246488185, 5036.5718913892, 5039.244113382949, 5040.899182016339, 5102.617303702237, 5590.0, 5631.1271752878365, 5652.886942261214, 5679.460451257124, 5694.345150307685, 6575.769848055391, 6606.405423511907, 6629.088837585848, 6631.171103612049, 6655.134832471747, 1752.404182577904, 1772.0962309222132, 1782.5008997480727, 1793.4261036468206, 1794.716777504091, 1157.0, 1200.429795846983, 1219.615821016377, 1239.3865036806837, 1241.5468354050888, 5754.884902302014, 5755.366909639936, 5773.39379365169, 5796.246487956539, 5806.419358064244, 6560.311167327457, 6636.668166591748, 6645.0, 6696.732130714814, 6717.361850624183, 5713.600047996601, 5741.483266505951, 5745.597808153473, 5749.942500574941, 5755.510781583528, 3561.7506774526055, 3591.3894637911094, 3602.0, 3611.476335931275, 3637.690796282293, 6345.682715864188, 6420.967895160495, 6431.646259455775, 6451.677406131732, 6467.935320646828, 6747.392734653905, 6752.493562982698, 6822.385985261251, 6827.761028363983, 6924.549904256207, 6400.519961002943, 6447.323031081763, 6447.549301407146, 6450.548461607643, 6560.606363618198, 6277.865525721277, 6686.765963191265, 6758.222804377363, 6763.458923286224, 6766.714324278568, 6586.209654841449, 6632.834179145367, 6636.4027237546925, 6654.604342436622, 6698.899516507354, 6371.74513019474, 6491.870162596816, 6543.967280163569, 6553.442957348679, 6581.572197807127, 4938.358013458227, 4942.827001054946, 4952.851414457572, 4964.180910149785, 4971.527704868176, 6459.935400646122, 6577.967110164419, 6657.7669781557415, 6764.898526522008, 6842.965785171043, 6490.967545162244, 6541.313162117909, 6566.4418524425955, 6589.86981183953, 6621.3047629998155, 6490.935090649033, 6563.671816409065, 6586.769463068769, 6630.502712296694, 6632.137822083098, 6389.552731308764, 6438.323975982642, 6468.994611670397, 6502.869942601027, 6544.821932052277, 6526.706298216686, 6611.636360000246, 6642.4021838034805, 6644.106429667521, 6651.667416629052, 6433.13439102655, 6478.578892372169, 6478.967605161944, 6516.674166291761, 6528.0], "value": 5045.636817789133, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [931.4411353188088, 942.1097063275204, 946.0161432110606, 955.2060223845251, 970.0396607358715, 18237.270509179634, 19200.711989320138, 19202.711959320623, 19221.903890480546, 19246.615067698654, 16815.579610509743, 17913.92516449014, 21955.231566895163, 21994.34016979489, 22049.889750551225, 1039.7192757955347, 1053.3311347294484, 1054.96307629233, 1055.0135623192302, 1055.7993981143597, 1057.8836328003952, 1067.9305845120082, 1068.385678235014, 1070.2454769387564, 1071.464267866067, 991.1723710701573, 1087.7606926476162, 1089.319175515303, 1090.0462095666292, 1090.983635245472, 1070.6680928912062, 1075.983860242097, 1076.359566058194, 1081.2701426537096, 1082.35058964621, 787.075186655683, 787.7203592724558, 793.2266040610416, 793.8690116130831, 795.157133438557, 19034.61930761391, 19840.80159198404, 19897.60204795896, 20235.79764202354, 20239.392818215478, 19759.407217783344, 19761.11075001614, 20157.092930818148, 20157.294494692615, 20618.17527298906, 13989.790153147609, 14073.718525629532, 14268.215248161347, 14310.928445357811, 14326.928365358212, 3484.3379757846183, 3550.5916819565564, 3559.7864128152396, 3576.6423357664285, 3580.4629305604367, 126405.0, 127084.36457817744, 127185.0, 128850.35574822065, 130535.0, 15234.619134521505, 15502.5349239523, 15779.0, 15793.68412631741, 15821.288042037906, 30571.388572228876, 31064.22339441487, 31285.217869553442, 31290.530642040387, 31344.05967820969, 7750.263724946121, 7775.22247775218, 7842.372610191171, 7892.763217103496, 7893.960530197312, 4318.417013703172, 4363.934540981888, 4372.737635741865, 4417.138657961731, 4419.535948725402, 5037.269595908646, 5139.640225184276, 5170.948290517047, 5186.533212010937, 5190.325257716549, 921.7188757429049, 953.0707560128819, 954.9092836180552, 966.0918736387773, 966.6181858165985, 641.470786601056, 659.5020759326774, 659.6273105695267, 667.2026927821207, 679.0628932073706, 11138.888611113947, 11487.54049837997, 11510.194286399872, 11527.020203282815, 12374.381280935917, 626.2891618013497, 631.9968400158061, 692.2592825676478, 695.1345574759356, 701.1796198447828, 5051.368578927634, 5396.001739678172, 5593.720313984284, 5604.523615492729, 5743.511801496836, 100266.4986675062, 101370.49314753526, 103044.02817563289, 104676.0, 105260.0, 93133.53433232926, 95434.52282738681, 95636.52181739047, 96843.51578242064, 97271.0, 83637.58181209177, 85233.0, 86766.13233867707, 87300.56349718338, 87929.0, 12102.0, 12135.75728485443, 12215.26708397499, 12451.875481245072, 12520.0, 35085.47371789476, 35548.466772998945, 36204.45693314655, 36783.26433471369, 39453.0, 69989.30010699827, 71609.28390716235, 71688.0, 73976.0, 73982.49507518054, 18081.186346614697, 18587.72118418252, 18637.90681046586, 18686.25254989785, 18750.53123671919, 19748.210071596975, 20156.496087597927, 20384.694229586272, 20396.79603203949, 20500.17999280012, 17989.910050450188, 18004.649651275944, 18029.36897208644, 18042.097895105453, 18179.909100454413, 18112.275508979492, 18430.81569184291, 18754.437366879014, 18967.71548426747, 18981.95599242055, 17740.733888991417, 18039.639207216045, 18047.368342107962, 18071.81928180754, 18218.0, 13774.0, 14076.436942522594, 14216.075955062888, 14388.35252413623, 14512.201828899511, 13430.462781488632, 13782.241976691379, 13930.233837139054, 13948.651283717989, 14036.2981850905], "value": 9048.718720322191, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 108.0, 104.0, 108.0, 108.0, 109.0, 109.0, 98.0, 109.0, 116.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 127.0, 147.0, 187.0, 118.0, 141.0, 152.0, 124.0, 171.0, 126.0], "value": 145.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 163.0, 163.0, 168.0, 167.0, 165.0, 161.0, 164.0, 172.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 78.0, 170.0, 77.0, 74.0, 77.0, 76.0, 158.0, 82.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 130.0, 80.0, 79.0, 81.0, 136.0, 79.0, 78.0, 133.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 115.0, 115.0, 115.0, 114.0, 118.0, 118.0, 119.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 151.0, 152.0, 151.0, 150.0, 151.0, 157.0, 152.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 60.0, 57.0, 57.0, 58.0, 59.0, 58.0, 60.0, 54.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 53.0, 54.0, 54.0, 55.0, 53.0, 54.0, 53.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 77.0, 84.0, 79.0, 78.0, 79.0, 90.0, 88.0, 89.0, 77.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 136.0, 142.0, 132.0, 140.0, 126.0, 130.0, 139.0, 125.0, 174.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 195.0, 179.0, 173.0, 179.0, 175.0, 174.0, 184.0, 180.0, 177.0], "value": 178.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 68.0, 65.0, 66.0, 66.0, 70.0, 73.0, 65.0, 71.0], "value": 68.6, "unit": "score"}]}]} 18:45:48 INFO - Return code: 0 18:45:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:45:48 INFO - # TBPL SUCCESS # 18:45:48 INFO - Running post-action listener: _package_coverage_data 18:45:48 INFO - Running post-action listener: _resource_record_post_action 18:45:48 INFO - [mozharness: 2017-08-02 01:45:48.215509Z] Finished run-tests step (success) 18:45:48 INFO - Running post-run listener: _resource_record_post_run 18:45:48 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 432865280; Read time: 32; Write time: 374520 18:45:48 INFO - TinderboxPrint: CPU usage
13.2% 18:45:48 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 32 18:45:48 INFO - TinderboxPrint: I/O write bytes / time
432,865,280 / 374,520 18:45:48 INFO - TinderboxPrint: CPU idle
8,263.2 (86.8%) 18:45:48 INFO - TinderboxPrint: CPU user
1,205.0 (12.7%) 18:45:48 INFO - TinderboxPrint: Swap in / out
0 / 0 18:45:48 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106631168; Read time: 0; Write time: 83584 18:45:48 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:48 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 322707456; Read time: 16; Write time: 290416 18:45:48 INFO - Running post-run listener: _upload_blobber_files 18:45:48 INFO - Blob upload gear active. 18:45:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:45:48 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:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:45:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:45:49 INFO - (blobuploader) - INFO - Open directory for files ... 18:45:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:45:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:45:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:50 INFO - (blobuploader) - INFO - Done attempting. 18:45:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:45:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:45:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:51 INFO - (blobuploader) - INFO - Done attempting. 18:45:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:45:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:45:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:58 INFO - (blobuploader) - INFO - Done attempting. 18:45:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:45:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:45:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:59 INFO - (blobuploader) - INFO - Done attempting. 18:45:59 INFO - (blobuploader) - INFO - Iteration through files over. 18:45:59 INFO - Return code: 0 18:45:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:45:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:45:59 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78564c3d3968b77951f6678fb2df1341165cec5102b7fd0e344fffffdb0dcdb34d4065c8d938b48283f15ae428624f9afd6e48f29dab713064dc3667cf1e327b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3db2037fa2f23003e5af57262b1b77446aef8f7c0d64cb84ff3589f059bbff6ac36a3e52e5651ff7a91d4151a178e6d6134999710b971e3f6915b5461b19388f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fbed8598b5dadfab75caf67983242bb1e51e1c159f3b20a1d94a35e99cdec9c7b070449dce63bed205600d7d3afc5e2bcd91a315544dfb20a696b74879317ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21d05dc2a9cf5108368ed011793a0de8e162a3383286f8ac521f8e2468d3101f5b5fbe86fa48841ffe0e333a3134a74db80bab3214bb949cc7862990dd4b82a0"} 18:45:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:45:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:45:59 INFO - Contents: 18:45:59 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78564c3d3968b77951f6678fb2df1341165cec5102b7fd0e344fffffdb0dcdb34d4065c8d938b48283f15ae428624f9afd6e48f29dab713064dc3667cf1e327b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3db2037fa2f23003e5af57262b1b77446aef8f7c0d64cb84ff3589f059bbff6ac36a3e52e5651ff7a91d4151a178e6d6134999710b971e3f6915b5461b19388f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fbed8598b5dadfab75caf67983242bb1e51e1c159f3b20a1d94a35e99cdec9c7b070449dce63bed205600d7d3afc5e2bcd91a315544dfb20a696b74879317ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21d05dc2a9cf5108368ed011793a0de8e162a3383286f8ac521f8e2468d3101f5b5fbe86fa48841ffe0e333a3134a74db80bab3214bb949cc7862990dd4b82a0"} 18:45:59 INFO - Running post-run listener: copy_logs_to_upload_dir 18:45:59 INFO - Copying logs to upload dir... 18:45:59 INFO - mkdir: /builds/slave/test/build/upload/logs 18:45:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.056872 ========= master_lag: 0.29 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-01 18:45:58.924571) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-01 18:45:58.928680) ========= 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=836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78564c3d3968b77951f6678fb2df1341165cec5102b7fd0e344fffffdb0dcdb34d4065c8d938b48283f15ae428624f9afd6e48f29dab713064dc3667cf1e327b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3db2037fa2f23003e5af57262b1b77446aef8f7c0d64cb84ff3589f059bbff6ac36a3e52e5651ff7a91d4151a178e6d6134999710b971e3f6915b5461b19388f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fbed8598b5dadfab75caf67983242bb1e51e1c159f3b20a1d94a35e99cdec9c7b070449dce63bed205600d7d3afc5e2bcd91a315544dfb20a696b74879317ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21d05dc2a9cf5108368ed011793a0de8e162a3383286f8ac521f8e2468d3101f5b5fbe86fa48841ffe0e333a3134a74db80bab3214bb949cc7862990dd4b82a0"} 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.010445 build_url: 'https://queue.taskcluster.net/v1/task/N1L-RPQ_Te2bYSv3MuD1AQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78564c3d3968b77951f6678fb2df1341165cec5102b7fd0e344fffffdb0dcdb34d4065c8d938b48283f15ae428624f9afd6e48f29dab713064dc3667cf1e327b", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3db2037fa2f23003e5af57262b1b77446aef8f7c0d64cb84ff3589f059bbff6ac36a3e52e5651ff7a91d4151a178e6d6134999710b971e3f6915b5461b19388f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2fbed8598b5dadfab75caf67983242bb1e51e1c159f3b20a1d94a35e99cdec9c7b070449dce63bed205600d7d3afc5e2bcd91a315544dfb20a696b74879317ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21d05dc2a9cf5108368ed011793a0de8e162a3383286f8ac521f8e2468d3101f5b5fbe86fa48841ffe0e333a3134a74db80bab3214bb949cc7862990dd4b82a0"}' ========= master_lag: 0.15 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-01 18:45:59.088704) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 18:45:59.089092) ========= 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=836cfdc75598d54cb747368e000001a9-1501636672.827714-1707214816 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 18:45:59.170154) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-01 18:45:59.170474) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-01 18:45:59.170757) ========= ========= Total master_lag: 0.60 =========