builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1502414372.25 results: success (0) revision: d0068f9051be88eb4c97e28ec0a4f101ca4ff147 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-10 18:19:32.249587) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-10 18:19:32.249976) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-10 18:19:32.250264) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-10 18:19:32.334101) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 18:19:32.334356) ========= 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=0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-10 18:19:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 232M=0s 2017-08-10 18:19:32 (232 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.172316 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 18:19:32.555684) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 18:19:32.558987) ========= 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=0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018422 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 18:19:32.608478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-10 18:19:32.608779) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d0068f9051be88eb4c97e28ec0a4f101ca4ff147 --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 d0068f9051be88eb4c97e28ec0a4f101ca4ff147 --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=0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-10 18:19:32,626 truncating revision to first 12 chars 2017-08-10 18:19:32,626 Setting DEBUG logging. 2017-08-10 18:19:32,626 attempt 1/10 2017-08-10 18:19:32,626 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d0068f9051be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-10 18:19:33,451 unpacking tar archive at: mozilla-central-d0068f9051be/testing/mozharness/ program finished with exit code 0 elapsedTime=1.153227 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-10 18:19:33.777849) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-10 18:19:33.781204) ========= script_repo_revision: d0068f9051be88eb4c97e28ec0a4f101ca4ff147 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-10 18:19:33.781625) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-10 18:19:33.781958) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-10 18:19:33.790900) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-10 18:19:33.791245) ========= /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=0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:19:33 INFO - MultiFileLogger online at 20170810 18:19:33 in /builds/slave/test 18:19:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:19:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:19:34 INFO - {'append_to_log': False, 18:19:34 INFO - 'base_work_dir': '/builds/slave/test', 18:19:34 INFO - 'blob_upload_branch': 'Firefox', 18:19:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:19:34 INFO - 'branch': 'Firefox', 18:19:34 INFO - 'buildbot_json_path': 'buildprops.json', 18:19:34 INFO - 'code_coverage': False, 18:19:34 INFO - 'config_files': ('talos/linux_config.py',), 18:19:34 INFO - 'default_actions': ('clobber', 18:19:34 INFO - 'read-buildbot-config', 18:19:34 INFO - 'download-and-extract', 18:19:34 INFO - 'populate-webroot', 18:19:34 INFO - 'create-virtualenv', 18:19:34 INFO - 'install', 18:19:34 INFO - 'setup-mitmproxy', 18:19:34 INFO - 'run-tests'), 18:19:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:19:34 INFO - 'disable_ccov_upload': False, 18:19:34 INFO - 'download_minidump_stackwalk': True, 18:19:34 INFO - 'download_symbols': 'ondemand', 18:19:34 INFO - 'enable_stylo': False, 18:19:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:19:34 INFO - 'tooltool.py': '/tools/tooltool.py', 18:19:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:19:34 INFO - '/tools/misc-python/virtualenv.py')}, 18:19:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:19:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:19:34 INFO - 'gecko_profile': False, 18:19:34 INFO - 'gecko_profile_interval': 0, 18:19:34 INFO - 'installer_path': 'installer.exe', 18:19:34 INFO - 'log_level': 'info', 18:19:34 INFO - 'log_name': 'talos', 18:19:34 INFO - 'log_to_console': True, 18:19:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:19:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:19:34 INFO - 'opt_config_files': (), 18:19:34 INFO - 'pip_index': False, 18:19:34 INFO - 'suite': 'dromaeojs-e10s', 18:19:34 INFO - 'system_bits': '32', 18:19:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:19:34 INFO - 'title': 'talos-linux64-ix-058', 18:19:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:19:34 INFO - 'use_talos_json': True, 18:19:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:19:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:19:34 INFO - 'work_dir': 'build'} 18:19:34 INFO - [mozharness: 2017-08-11 01:19:34.006666Z] Running clobber step. 18:19:34 INFO - Running pre-action listener: _resource_record_pre_action 18:19:34 INFO - Running main action method: clobber 18:19:34 INFO - rmtree: /builds/slave/test/build 18:19:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:19:34 INFO - Running post-action listener: _resource_record_post_action 18:19:34 INFO - [mozharness: 2017-08-11 01:19:34.992552Z] Finished clobber step (success) 18:19:34 INFO - [mozharness: 2017-08-11 01:19:34.992654Z] Running read-buildbot-config step. 18:19:34 INFO - Running pre-action listener: _resource_record_pre_action 18:19:34 INFO - Running main action method: read_buildbot_config 18:19:34 INFO - Using buildbot properties: 18:19:34 INFO - { 18:19:34 INFO - "project": "", 18:19:34 INFO - "product": "firefox", 18:19:34 INFO - "who": "kwierso@gmail.com", 18:19:34 INFO - "installer_path": "public/build/target.tar.bz2", 18:19:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 18:19:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:19:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 18:19:34 INFO - "stage_platform": "linux64-stylo", 18:19:34 INFO - "basedir": "/builds/slave/test", 18:19:34 INFO - "buildnumber": 74, 18:19:34 INFO - "platform": "ubuntu64_hw_stylo", 18:19:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:19:34 INFO - "slavebuilddir": "test", 18:19:34 INFO - "taskId": "VpjXUVyfQ8Sw88CLuBjxhA", 18:19:34 INFO - "branch": "mozilla-central", 18:19:34 INFO - "script_repo_revision": "production", 18:19:34 INFO - "revision": "d0068f9051be88eb4c97e28ec0a4f101ca4ff147", 18:19:34 INFO - "slavename": "talos-linux64-ix-058", 18:19:34 INFO - "repo_path": "mozilla-central" 18:19:34 INFO - } 18:19:34 INFO - Finding installer, test and symbols from parent task. 18:19:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VpjXUVyfQ8Sw88CLuBjxhA'}, attempt #1 18:19:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VpjXUVyfQ8Sw88CLuBjxhA'}, attempt #1 18:19:35 INFO - Task dependencies: dTnd9BLdQ-u7ChXvVPHXNw 18:19:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw'}, attempt #1 18:19:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.tar.bz2 18:19:36 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.test_packages.json 18:19:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.crashreporter-symbols.zip 18:19:36 INFO - Running post-action listener: _resource_record_post_action 18:19:36 INFO - [mozharness: 2017-08-11 01:19:36.321395Z] Finished read-buildbot-config step (success) 18:19:36 INFO - [mozharness: 2017-08-11 01:19:36.321615Z] Running download-and-extract step. 18:19:36 INFO - Running pre-action listener: _resource_record_pre_action 18:19:36 INFO - Running main action method: download_and_extract 18:19:36 INFO - mkdir: /builds/slave/test/build/tests 18:19: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:19:36 INFO - trying https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.test_packages.json 18:19:36 INFO - Downloading https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:19:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:19:36 INFO - Downloaded 989 bytes. 18:19:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:19:36 INFO - Using the following test package requirements: 18:19:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:19:36 INFO - u'common': [u'target.common.tests.zip'], 18:19:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:19:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:19:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:19:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:19:36 INFO - u'mozbase': [u'target.common.tests.zip'], 18:19:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:19:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:19:36 INFO - u'web-platform': [u'target.common.tests.zip', 18:19:36 INFO - u'target.web-platform.tests.tar.gz'], 18:19:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:19:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:19:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.common.tests.zip 18:19:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:19:36 INFO - Fetch https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.common.tests.zip into memory 18:19:38 INFO - Content-Length response header: 54343543 18:19:38 INFO - Bytes received: 54343543 18:19:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:19:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.common.tests.zip 18:19:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:19:49 INFO - Fetch https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.common.tests.zip into memory 18:19:51 INFO - Content-Length response header: 54343543 18:19:51 INFO - Bytes received: 54343543 18:20:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.talos.tests.zip 18:20:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:20:04 INFO - Fetch https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.talos.tests.zip into memory 18:20:04 INFO - Content-Length response header: 14496008 18:20:04 INFO - Bytes received: 14496008 18:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:05 INFO - trying https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.tar.bz2 18:20:05 INFO - Downloading https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:20:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:20:06 INFO - Downloaded 61958000 bytes. 18:20:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.tar.bz2 18:20:06 INFO - mkdir: /builds/slave/test/properties 18:20:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:20:06 INFO - Writing to file /builds/slave/test/properties/build_url 18:20:06 INFO - Contents: 18:20:06 INFO - build_url:https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.tar.bz2 18:20:06 INFO - Running post-action listener: _resource_record_post_action 18:20:06 INFO - Running post-action listener: set_extra_try_arguments 18:20:06 INFO - [mozharness: 2017-08-11 01:20:06.854360Z] Finished download-and-extract step (success) 18:20:06 INFO - [mozharness: 2017-08-11 01:20:06.854589Z] Running populate-webroot step. 18:20:06 INFO - Running pre-action listener: _resource_record_pre_action 18:20:06 INFO - Running main action method: populate_webroot 18:20:06 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:20:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:20:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:20:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:20:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:20:06 INFO - 'tests': ['damp', 'tps']}, 18:20:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:20:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:20:06 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:20:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:20:06 INFO - 'other-e10s': {'tests': ['a11yr', 18:20:06 INFO - 'ts_paint', 18:20:06 INFO - 'tpaint', 18:20:06 INFO - 'sessionrestore', 18:20:06 INFO - 'sessionrestore_many_windows', 18:20:06 INFO - 'sessionrestore_no_auto_restore', 18:20:06 INFO - 'tabpaint']}, 18:20:06 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:20:06 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:20:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:20:06 INFO - 'tsvgr_opacity', 18:20:06 INFO - 'tart', 18:20:06 INFO - 'tscrollx', 18:20:06 INFO - 'tsvg_static']}, 18:20:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:20:06 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:20:06 INFO - 'talos_options': ['--mitmproxy', 18:20:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:20:06 INFO - '--firstNonBlankPaint'], 18:20:06 INFO - 'tests': ['tp6_google', 18:20:06 INFO - 'tp6_youtube', 18:20:06 INFO - 'tp6_amazon', 18:20:06 INFO - 'tp6_facebook']}, 18:20:06 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:20:06 INFO - 'talos_options': ['--stylo', 18:20:06 INFO - '--mitmproxy', 18:20:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:20:06 INFO - '--firstNonBlankPaint'], 18:20:06 INFO - 'tests': ['tp6_google', 18:20:06 INFO - 'tp6_youtube', 18:20:06 INFO - 'tp6_amazon', 18:20:06 INFO - 'tp6_facebook']}, 18:20:06 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:20:06 INFO - 'talos_options': ['--stylo', 18:20:06 INFO - '--stylo-threads=1', 18:20:06 INFO - '--mitmproxy', 18:20:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:20:06 INFO - '--firstNonBlankPaint'], 18:20:06 INFO - 'tests': ['tp6_google', 18:20:06 INFO - 'tp6_youtube', 18:20:06 INFO - 'tp6_amazon', 18:20:06 INFO - 'tp6_facebook']}, 18:20:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:20:06 INFO - 'talos_options': ['--xperf_path', 18:20:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:20:06 INFO - 'tests': ['tp5n']}}} 18:20:06 INFO - Running post-action listener: _resource_record_post_action 18:20:06 INFO - [mozharness: 2017-08-11 01:20:06.866868Z] Finished populate-webroot step (success) 18:20:06 INFO - [mozharness: 2017-08-11 01:20:06.866958Z] Running create-virtualenv step. 18:20:06 INFO - Running pre-action listener: _resource_record_pre_action 18:20:06 INFO - Running main action method: create_virtualenv 18:20:06 INFO - Creating virtualenv /builds/slave/test/build/venv 18:20:06 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:20:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:20:06 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:20:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:20:07 INFO - Using real prefix '/usr' 18:20:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:20:07 INFO - Installing distribute.............................................................................................................................................................................................done. 18:20:09 INFO - Installing pip.................done. 18:20:09 INFO - Return code: 0 18:20:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:20:09 INFO - Reading from file tmpfile_stdout 18:20:09 INFO - Output received: 18:20:09 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:20:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:20:09 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:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:09 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:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:09 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 0x281d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8df00>, '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 0x2b88ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b89050>, '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': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', '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:20:09 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:20:09 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:20:09 INFO - Using env: {'DISPLAY': ':0', 18:20:09 INFO - 'HOME': '/home/cltbld', 18:20:09 INFO - 'LANG': 'en_US.UTF-8', 18:20:09 INFO - 'LANGUAGE': 'en_US:en', 18:20:09 INFO - 'LOGNAME': 'cltbld', 18:20:09 INFO - 'MAIL': '/var/mail/cltbld', 18:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:09 INFO - 'MOZ_NO_REMOTE': '1', 18:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:09 INFO - 'NO_EM_RESTART': '1', 18:20:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:09 INFO - 'PWD': '/builds/slave/test', 18:20:09 INFO - 'SHELL': '/bin/bash', 18:20:09 INFO - 'SHLVL': '1', 18:20:09 INFO - 'TERM': 'linux', 18:20:09 INFO - 'TMOUT': '86400', 18:20:09 INFO - 'USER': 'cltbld', 18:20:09 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', 18:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:09 INFO - '_': '/tools/buildbot/bin/python'} 18:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:10 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:20:10 INFO - Cleaning up... 18:20:10 INFO - Return code: 0 18:20:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:20:10 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:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:10 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:20:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:10 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 0x281d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8df00>, '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 0x2b88ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b89050>, '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': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', '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:20:10 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:20:10 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:20:10 INFO - Using env: {'DISPLAY': ':0', 18:20:10 INFO - 'HOME': '/home/cltbld', 18:20:10 INFO - 'LANG': 'en_US.UTF-8', 18:20:10 INFO - 'LANGUAGE': 'en_US:en', 18:20:10 INFO - 'LOGNAME': 'cltbld', 18:20:10 INFO - 'MAIL': '/var/mail/cltbld', 18:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:10 INFO - 'MOZ_NO_REMOTE': '1', 18:20:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:10 INFO - 'NO_EM_RESTART': '1', 18:20:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:10 INFO - 'PWD': '/builds/slave/test', 18:20:10 INFO - 'SHELL': '/bin/bash', 18:20:10 INFO - 'SHLVL': '1', 18:20:10 INFO - 'TERM': 'linux', 18:20:10 INFO - 'TMOUT': '86400', 18:20:10 INFO - 'USER': 'cltbld', 18:20:10 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', 18:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:10 INFO - '_': '/tools/buildbot/bin/python'} 18:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:10 INFO - Downloading/unpacking psutil>=3.1.1 18:20:10 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:20:10 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:20:10 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:20:10 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:20:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:20:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:20:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:20:11 INFO - Installing collected packages: psutil 18:20:11 INFO - Running setup.py install for psutil 18:20:11 INFO - building 'psutil._psutil_linux' extension 18:20:11 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:20:12 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:20:12 INFO - building 'psutil._psutil_posix' extension 18:20:12 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:20:12 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:20:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:20:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:20:12 INFO - Successfully installed psutil 18:20:12 INFO - Cleaning up... 18:20:12 INFO - Return code: 0 18:20:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x281d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8df00>, '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 0x2b88ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b89050>, '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': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', '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:20:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:20:12 INFO - Using env: {'DISPLAY': ':0', 18:20:12 INFO - 'HOME': '/home/cltbld', 18:20:12 INFO - 'LANG': 'en_US.UTF-8', 18:20:12 INFO - 'LANGUAGE': 'en_US:en', 18:20:12 INFO - 'LOGNAME': 'cltbld', 18:20:12 INFO - 'MAIL': '/var/mail/cltbld', 18:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:12 INFO - 'MOZ_NO_REMOTE': '1', 18:20:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:12 INFO - 'NO_EM_RESTART': '1', 18:20:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:12 INFO - 'PWD': '/builds/slave/test', 18:20:12 INFO - 'SHELL': '/bin/bash', 18:20:12 INFO - 'SHLVL': '1', 18:20:12 INFO - 'TERM': 'linux', 18:20:12 INFO - 'TMOUT': '86400', 18:20:12 INFO - 'USER': 'cltbld', 18:20:12 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', 18:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:12 INFO - '_': '/tools/buildbot/bin/python'} 18:20:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:20:13 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:20:13 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:20:13 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:20:13 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:20:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:20:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:20:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:20:14 INFO - Installing collected packages: mozsystemmonitor 18:20:14 INFO - Running setup.py install for mozsystemmonitor 18:20:14 INFO - Successfully installed mozsystemmonitor 18:20:14 INFO - Cleaning up... 18:20:14 INFO - Return code: 0 18:20:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x281d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8df00>, '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 0x2b88ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b89050>, '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': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', '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:20:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:20:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:20:14 INFO - Using env: {'DISPLAY': ':0', 18:20:14 INFO - 'HOME': '/home/cltbld', 18:20:14 INFO - 'LANG': 'en_US.UTF-8', 18:20:14 INFO - 'LANGUAGE': 'en_US:en', 18:20:14 INFO - 'LOGNAME': 'cltbld', 18:20:14 INFO - 'MAIL': '/var/mail/cltbld', 18:20:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:14 INFO - 'MOZ_NO_REMOTE': '1', 18:20:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:14 INFO - 'NO_EM_RESTART': '1', 18:20:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:14 INFO - 'PWD': '/builds/slave/test', 18:20:14 INFO - 'SHELL': '/bin/bash', 18:20:14 INFO - 'SHLVL': '1', 18:20:14 INFO - 'TERM': 'linux', 18:20:14 INFO - 'TMOUT': '86400', 18:20:14 INFO - 'USER': 'cltbld', 18:20:14 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', 18:20:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:14 INFO - '_': '/tools/buildbot/bin/python'} 18:20:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:14 INFO - Downloading/unpacking jsonschema==2.5.1 18:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:20:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:15 INFO - Downloading functools32-3.2.3-2.tar.gz 18:20:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:20:15 INFO - warning: no files found matching '*.txt' 18:20:15 INFO - no previously-included directories found matching 'build' 18:20:15 INFO - no previously-included directories found matching 'dist' 18:20:15 INFO - no previously-included directories found matching '.git*' 18:20:15 INFO - Installing collected packages: jsonschema, functools32 18:20:16 INFO - Running setup.py install for functools32 18:20:16 INFO - warning: no files found matching '*.txt' 18:20:16 INFO - no previously-included directories found matching 'build' 18:20:16 INFO - no previously-included directories found matching 'dist' 18:20:16 INFO - no previously-included directories found matching '.git*' 18:20:16 INFO - Successfully installed jsonschema functools32 18:20:16 INFO - Cleaning up... 18:20:16 INFO - Return code: 0 18:20:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:20:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x281d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8df00>, '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 0x2b88ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b89050>, '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': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', '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:20:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:20:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:20:16 INFO - Using env: {'DISPLAY': ':0', 18:20:16 INFO - 'HOME': '/home/cltbld', 18:20:16 INFO - 'LANG': 'en_US.UTF-8', 18:20:16 INFO - 'LANGUAGE': 'en_US:en', 18:20:16 INFO - 'LOGNAME': 'cltbld', 18:20:16 INFO - 'MAIL': '/var/mail/cltbld', 18:20:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:16 INFO - 'MOZ_NO_REMOTE': '1', 18:20:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:16 INFO - 'NO_EM_RESTART': '1', 18:20:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:16 INFO - 'PWD': '/builds/slave/test', 18:20:16 INFO - 'SHELL': '/bin/bash', 18:20:16 INFO - 'SHLVL': '1', 18:20:16 INFO - 'TERM': 'linux', 18:20:16 INFO - 'TMOUT': '86400', 18:20:16 INFO - 'USER': 'cltbld', 18:20:16 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', 18:20:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:16 INFO - '_': '/tools/buildbot/bin/python'} 18:20:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:20:16 INFO - Cleaning up... 18:20:16 INFO - Return code: 0 18:20:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:20:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x281d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8df00>, '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 0x2b88ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b89050>, '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': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', '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:20:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:20:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:20:16 INFO - Using env: {'DISPLAY': ':0', 18:20:16 INFO - 'HOME': '/home/cltbld', 18:20:16 INFO - 'LANG': 'en_US.UTF-8', 18:20:16 INFO - 'LANGUAGE': 'en_US:en', 18:20:16 INFO - 'LOGNAME': 'cltbld', 18:20:16 INFO - 'MAIL': '/var/mail/cltbld', 18:20:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:16 INFO - 'MOZ_NO_REMOTE': '1', 18:20:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:16 INFO - 'NO_EM_RESTART': '1', 18:20:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:16 INFO - 'PWD': '/builds/slave/test', 18:20:16 INFO - 'SHELL': '/bin/bash', 18:20:16 INFO - 'SHLVL': '1', 18:20:16 INFO - 'TERM': 'linux', 18:20:16 INFO - 'TMOUT': '86400', 18:20:16 INFO - 'USER': 'cltbld', 18:20:16 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', 18:20:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:16 INFO - '_': '/tools/buildbot/bin/python'} 18:20:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:16 INFO - Downloading/unpacking blobuploader==1.2.4 18:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:17 INFO - Downloading blobuploader-1.2.4.tar.gz 18:20:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:20:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:20:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:18 INFO - Downloading docopt-0.6.1.tar.gz 18:20:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:20:18 INFO - Installing collected packages: blobuploader, requests, docopt 18:20:18 INFO - Running setup.py install for blobuploader 18:20:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:20:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:20:18 INFO - Running setup.py install for requests 18:20:18 INFO - Running setup.py install for docopt 18:20:18 INFO - Successfully installed blobuploader requests docopt 18:20:18 INFO - Cleaning up... 18:20:18 INFO - Return code: 0 18:20:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:18 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 0x281d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8df00>, '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 0x2b88ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b89050>, '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': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', '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:20:18 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:20:18 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:20:18 INFO - Using env: {'DISPLAY': ':0', 18:20:18 INFO - 'HOME': '/home/cltbld', 18:20:18 INFO - 'LANG': 'en_US.UTF-8', 18:20:18 INFO - 'LANGUAGE': 'en_US:en', 18:20:18 INFO - 'LOGNAME': 'cltbld', 18:20:18 INFO - 'MAIL': '/var/mail/cltbld', 18:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:18 INFO - 'MOZ_NO_REMOTE': '1', 18:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:18 INFO - 'NO_EM_RESTART': '1', 18:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:18 INFO - 'PWD': '/builds/slave/test', 18:20:18 INFO - 'SHELL': '/bin/bash', 18:20:18 INFO - 'SHLVL': '1', 18:20:18 INFO - 'TERM': 'linux', 18:20:18 INFO - 'TMOUT': '86400', 18:20:18 INFO - 'USER': 'cltbld', 18:20:18 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', 18:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:18 INFO - '_': '/tools/buildbot/bin/python'} 18:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:20:19 INFO - Running setup.py (path:/tmp/pip-2i1Ppu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:20:19 INFO - Running setup.py (path:/tmp/pip-n_01ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:20:19 INFO - Running setup.py (path:/tmp/pip-5G4fbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:20:19 INFO - Running setup.py (path:/tmp/pip-yAC9LU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:20:19 INFO - Running setup.py (path:/tmp/pip-JdS2w_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:20:19 INFO - Running setup.py (path:/tmp/pip-YSvzlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:20:19 INFO - Running setup.py (path:/tmp/pip-zdRq6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:20:19 INFO - Running setup.py (path:/tmp/pip-hTrJB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:20:19 INFO - Running setup.py (path:/tmp/pip-owOK8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:20:19 INFO - Running setup.py (path:/tmp/pip-YYyvlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:20:19 INFO - Running setup.py (path:/tmp/pip-lMGV3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:20:19 INFO - Running setup.py (path:/tmp/pip-DVBgFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:20:19 INFO - Running setup.py (path:/tmp/pip-9mVlX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:20:20 INFO - Running setup.py (path:/tmp/pip-anHZd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:20 INFO - Running setup.py (path:/tmp/pip-T9AIeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:20:20 INFO - Running setup.py (path:/tmp/pip-JXAfBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:20:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:20:20 INFO - Running setup.py (path:/tmp/pip-NrWBUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:20:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:20:20 INFO - Running setup.py install for manifestparser 18:20:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:20:20 INFO - Running setup.py install for mozcrash 18:20:20 INFO - Running setup.py install for mozdebug 18:20:20 INFO - Running setup.py install for mozdevice 18:20:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:20:20 INFO - Running setup.py install for mozfile 18:20:20 INFO - Running setup.py install for mozhttpd 18:20:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:20:20 INFO - Running setup.py install for mozinfo 18:20:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:20:21 INFO - Running setup.py install for mozInstall 18:20:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:20:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:20:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:20:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:20:21 INFO - Running setup.py install for mozleak 18:20:21 INFO - Running setup.py install for mozlog 18:20:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:20:21 INFO - Running setup.py install for moznetwork 18:20:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:20:21 INFO - Running setup.py install for mozprocess 18:20:21 INFO - Running setup.py install for mozprofile 18:20:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:20:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:20:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:20:21 INFO - Running setup.py install for mozrunner 18:20:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:20:21 INFO - Running setup.py install for mozscreenshot 18:20:21 INFO - Running setup.py install for moztest 18:20:21 INFO - Running setup.py install for mozversion 18:20:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:20:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:20:22 INFO - Cleaning up... 18:20:22 INFO - Return code: 0 18:20:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:20:22 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:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:22 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:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:22 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 0x281d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8df00>, '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 0x2b88ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b89050>, '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': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', '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:20:22 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:20:22 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:20:22 INFO - Using env: {'DISPLAY': ':0', 18:20:22 INFO - 'HOME': '/home/cltbld', 18:20:22 INFO - 'LANG': 'en_US.UTF-8', 18:20:22 INFO - 'LANGUAGE': 'en_US:en', 18:20:22 INFO - 'LOGNAME': 'cltbld', 18:20:22 INFO - 'MAIL': '/var/mail/cltbld', 18:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:22 INFO - 'MOZ_NO_REMOTE': '1', 18:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:22 INFO - 'NO_EM_RESTART': '1', 18:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:22 INFO - 'PWD': '/builds/slave/test', 18:20:22 INFO - 'SHELL': '/bin/bash', 18:20:22 INFO - 'SHLVL': '1', 18:20:22 INFO - 'TERM': 'linux', 18:20:22 INFO - 'TMOUT': '86400', 18:20:22 INFO - 'USER': 'cltbld', 18:20:22 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', 18:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:22 INFO - '_': '/tools/buildbot/bin/python'} 18:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:20:22 INFO - Running setup.py (path:/tmp/pip-Wyzenb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:20:22 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:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:20:22 INFO - Running setup.py (path:/tmp/pip-ZVq9Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:20:22 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:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:20:22 INFO - Running setup.py (path:/tmp/pip-o_j3y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:20:22 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:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:20:22 INFO - Running setup.py (path:/tmp/pip-mN_sSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:20:22 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:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:20:22 INFO - Running setup.py (path:/tmp/pip-imurr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:20:22 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:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:20:22 INFO - Running setup.py (path:/tmp/pip-mpwDxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:20:22 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:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:20:22 INFO - Running setup.py (path:/tmp/pip-lnGGnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:20:22 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:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:20:22 INFO - Running setup.py (path:/tmp/pip-3jr_cx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:20:22 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:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:20:22 INFO - Running setup.py (path:/tmp/pip-5fpIEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:20:22 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:20:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:20:23 INFO - Running setup.py (path:/tmp/pip-7iFoco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:20:23 INFO - Running setup.py (path:/tmp/pip-NMsMVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:20:23 INFO - Running setup.py (path:/tmp/pip-8tnCCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:20:23 INFO - Running setup.py (path:/tmp/pip-eZickh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:20:23 INFO - Running setup.py (path:/tmp/pip-LU9eZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:23 INFO - Running setup.py (path:/tmp/pip-uihhJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:20:23 INFO - Running setup.py (path:/tmp/pip-owPsZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:20:23 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:20:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:20:23 INFO - Running setup.py (path:/tmp/pip-WFnkz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:20:23 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:20:23 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:20:23 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:20:23 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:20:23 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:20:23 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:20:23 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:20:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:20:23 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:20:23 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:20:23 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:20:23 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:20:24 INFO - Downloading blessings-1.6.tar.gz 18:20:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:20:24 INFO - Installing collected packages: blessings 18:20:24 INFO - Running setup.py install for blessings 18:20:24 INFO - Successfully installed blessings 18:20:24 INFO - Cleaning up... 18:20:24 INFO - Return code: 0 18:20:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:20:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:20:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:20:25 INFO - Reading from file tmpfile_stdout 18:20:25 INFO - Current package versions: 18:20:25 INFO - argparse == 1.2.1 18:20:25 INFO - blessings == 1.6 18:20:25 INFO - blobuploader == 1.2.4 18:20:25 INFO - docopt == 0.6.1 18:20:25 INFO - functools32 == 3.2.3-2 18:20:25 INFO - jsonschema == 2.5.1 18:20:25 INFO - manifestparser == 1.1 18:20:25 INFO - mozInstall == 1.13 18:20:25 INFO - mozcrash == 1.0 18:20:25 INFO - mozdebug == 0.1 18:20:25 INFO - mozdevice == 0.51 18:20:25 INFO - mozfile == 1.2 18:20:25 INFO - mozhttpd == 0.7 18:20:25 INFO - mozinfo == 0.10 18:20:25 INFO - mozleak == 0.1 18:20:25 INFO - mozlog == 3.5 18:20:25 INFO - moznetwork == 0.27 18:20:25 INFO - mozprocess == 0.25 18:20:25 INFO - mozprofile == 0.28 18:20:25 INFO - mozrunner == 6.13 18:20:25 INFO - mozscreenshot == 0.1 18:20:25 INFO - mozsystemmonitor == 0.3 18:20:25 INFO - moztest == 0.8 18:20:25 INFO - mozversion == 1.4 18:20:25 INFO - psutil == 3.1.1 18:20:25 INFO - requests == 1.2.3 18:20:25 INFO - wsgiref == 0.1.2 18:20:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:20:25 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:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:25 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:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:25 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 0x281d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8df00>, '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 0x2b88ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b89050>, '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': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', '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:20:25 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:20:25 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:20:25 INFO - Using env: {'DISPLAY': ':0', 18:20:25 INFO - 'HOME': '/home/cltbld', 18:20:25 INFO - 'LANG': 'en_US.UTF-8', 18:20:25 INFO - 'LANGUAGE': 'en_US:en', 18:20:25 INFO - 'LOGNAME': 'cltbld', 18:20:25 INFO - 'MAIL': '/var/mail/cltbld', 18:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:25 INFO - 'MOZ_NO_REMOTE': '1', 18:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:25 INFO - 'NO_EM_RESTART': '1', 18:20:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:25 INFO - 'PWD': '/builds/slave/test', 18:20:25 INFO - 'SHELL': '/bin/bash', 18:20:25 INFO - 'SHLVL': '1', 18:20:25 INFO - 'TERM': 'linux', 18:20:25 INFO - 'TMOUT': '86400', 18:20:25 INFO - 'USER': 'cltbld', 18:20:25 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', 18:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:25 INFO - '_': '/tools/buildbot/bin/python'} 18:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:25 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:20:25 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:20:25 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:20:25 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:20:25 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:20:25 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:20:25 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:20:25 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:20:25 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:20:25 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:20:26 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:20:26 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:20:26 INFO - Installing collected packages: simplejson 18:20:26 INFO - Running setup.py install for simplejson 18:20:26 INFO - building 'simplejson._speedups' extension 18:20:26 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:20:27 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:20:27 INFO - Successfully installed simplejson 18:20:27 INFO - Cleaning up... 18:20:27 INFO - Return code: 0 18:20:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:20:27 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:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:27 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:20:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:27 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 0x281d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b8df00>, '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 0x2b88ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b89050>, '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': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', '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:20:27 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:20:27 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:20:27 INFO - Using env: {'DISPLAY': ':0', 18:20:27 INFO - 'HOME': '/home/cltbld', 18:20:27 INFO - 'LANG': 'en_US.UTF-8', 18:20:27 INFO - 'LANGUAGE': 'en_US:en', 18:20:27 INFO - 'LOGNAME': 'cltbld', 18:20:27 INFO - 'MAIL': '/var/mail/cltbld', 18:20:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:27 INFO - 'MOZ_NO_REMOTE': '1', 18:20:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:27 INFO - 'NO_EM_RESTART': '1', 18:20:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:27 INFO - 'PWD': '/builds/slave/test', 18:20:27 INFO - 'SHELL': '/bin/bash', 18:20:27 INFO - 'SHLVL': '1', 18:20:27 INFO - 'TERM': 'linux', 18:20:27 INFO - 'TMOUT': '86400', 18:20:27 INFO - 'USER': 'cltbld', 18:20:27 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', 18:20:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:27 INFO - '_': '/tools/buildbot/bin/python'} 18:20:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:20:27 INFO - Cleaning up... 18:20:27 INFO - Return code: 0 18:20:27 INFO - Running post-action listener: _resource_record_post_action 18:20:27 INFO - Running post-action listener: _start_resource_monitoring 18:20:27 INFO - Starting resource monitoring. 18:20:27 INFO - [mozharness: 2017-08-11 01:20:27.948675Z] Finished create-virtualenv step (success) 18:20:27 INFO - [mozharness: 2017-08-11 01:20:27.949708Z] Running install step. 18:20:27 INFO - Running pre-action listener: _resource_record_pre_action 18:20:27 INFO - Running main action method: install 18:20:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:20:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:20:28 INFO - Reading from file tmpfile_stdout 18:20:28 INFO - Detecting whether we're running mozinstall >=1.0... 18:20:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:20:28 INFO - Reading from file tmpfile_stdout 18:20:28 INFO - Output received: 18:20:28 INFO - Usage: mozinstall [options] installer 18:20:28 INFO - Options: 18:20:28 INFO - -h, --help show this help message and exit 18:20:28 INFO - -d DEST, --destination=DEST 18:20:28 INFO - Directory to install application into. [default: 18:20:28 INFO - "/builds/slave/test"] 18:20:28 INFO - --app=APP Application being installed. [default: firefox] 18:20:28 INFO - mkdir: /builds/slave/test/build/application 18:20:28 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:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:20:46 INFO - Reading from file tmpfile_stdout 18:20:46 INFO - Output received: 18:20:46 INFO - /builds/slave/test/build/application/firefox/firefox 18:20:46 INFO - Running post-action listener: _resource_record_post_action 18:20:46 INFO - [mozharness: 2017-08-11 01:20:46.367975Z] Finished install step (success) 18:20:46 INFO - [mozharness: 2017-08-11 01:20:46.368229Z] Running setup-mitmproxy step. 18:20:46 INFO - Running pre-action listener: _resource_record_pre_action 18:20:46 INFO - Running main action method: setup_mitmproxy 18:20:46 INFO - Skipping: mitmproxy is not required 18:20:46 INFO - Running post-action listener: _resource_record_post_action 18:20:46 INFO - [mozharness: 2017-08-11 01:20:46.369432Z] Finished setup-mitmproxy step (success) 18:20:46 INFO - [mozharness: 2017-08-11 01:20:46.369652Z] Running run-tests step. 18:20:46 INFO - Running pre-action listener: _resource_record_pre_action 18:20:46 INFO - Running pre-action listener: _set_gcov_prefix 18:20:46 INFO - Running main action method: run_tests 18:20:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:20:46 INFO - Python 2.7.3 18:20:46 INFO - Return code: 0 18:20:46 INFO - grabbing minidump binary from tooltool 18:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:46 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 0x2b8df00>, '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 0x2b88ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b89050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:20:46 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:20:46 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:20:46 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:20:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:20:46 INFO - Return code: 0 18:20:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:20:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:20:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:20:46 INFO - ENV: RUST_BACKTRACE is now full 18:20:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:20:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:20:46 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/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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:20:46 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/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-058 --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:20:46 INFO - Using env: {'DISPLAY': ':0', 18:20:46 INFO - 'HOME': '/home/cltbld', 18:20:46 INFO - 'LANG': 'en_US.UTF-8', 18:20:46 INFO - 'LANGUAGE': 'en_US:en', 18:20:46 INFO - 'LOGNAME': 'cltbld', 18:20:46 INFO - 'MAIL': '/var/mail/cltbld', 18:20:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:20:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:46 INFO - 'MOZ_NO_REMOTE': '1', 18:20:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:20:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:46 INFO - 'NO_EM_RESTART': '1', 18:20:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:46 INFO - 'PWD': '/builds/slave/test', 18:20:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:20:46 INFO - 'RUST_BACKTRACE': 'full', 18:20:46 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:20:46 INFO - 'SHELL': '/bin/bash', 18:20:46 INFO - 'SHLVL': '1', 18:20:46 INFO - 'STYLO_FORCE_ENABLED': '1', 18:20:46 INFO - 'TERM': 'linux', 18:20:46 INFO - 'TMOUT': '86400', 18:20:46 INFO - 'USER': 'cltbld', 18:20:46 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308', 18:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:46 INFO - '_': '/tools/buildbot/bin/python'} 18:20:46 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/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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:20:46 INFO - mozversion application_buildid: 20170811003658 18:20:46 INFO - mozversion application_changeset: d0068f9051be88eb4c97e28ec0a4f101ca4ff147 18:20:46 INFO - mozversion application_display_name: Nightly 18:20:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:20:46 INFO - mozversion application_name: Firefox 18:20:46 INFO - mozversion application_remotingname: firefox 18:20:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:20:46 INFO - mozversion application_vendor: Mozilla 18:20:46 INFO - mozversion application_version: 57.0a1 18:20:46 INFO - mozversion platform_buildid: 20170811003658 18:20:46 INFO - mozversion platform_changeset: d0068f9051be88eb4c97e28ec0a4f101ca4ff147 18:20:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:20:46 INFO - mozversion platform_version: 57.0a1 18:20:46 INFO - using testdate: 1502414446 18:20:46 INFO - actual date: 1502414446 18:20:46 INFO - starting webserver on 'localhost:43950' 18:20:46 INFO - SUITE-START | Running 2 tests 18:20:46 INFO - TEST-START | dromaeo_css 18:20:46 INFO - Initialising browser for dromaeo_css test... 18:20:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43950/getInfo.html -profile /tmp/tmpZq9XDI/profile 18:20:46 INFO - TEST-INFO | started process 3351 (/builds/slave/test/build/application/firefox/firefox http://localhost:43950/getInfo.html) 18:20:53 INFO - TEST-INFO | 3351: exit 0 18:20:53 INFO - Browser initialized. 18:20:53 INFO - Running cycle 1/1 for dromaeo_css test... 18:20:53 INFO - TEST-INFO | started process 3585 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZq9XDI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:20:54 INFO - PID 3585 | 18:20:54 INFO - PID 3585 | (/builds/slave/test/build/application/firefox/firefox:3639): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:20:54 INFO - PID 3585 | 18:21:05 INFO - PID 3585 | RSS: Main: 171732992 18:21:05 INFO - PID 3585 | 18:24:04 INFO - PID 3585 | Cycle 1(1): loaded http://localhost:43950/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43950/tests/dromaeo/cssquery-ext.html) 18:24:05 INFO - PID 3585 | RSS: Main: 175218688 18:24:05 INFO - PID 3585 | 18:27:07 INFO - PID 3585 | Cycle 1(1): loaded http://localhost:43950/tests/dromaeo/cssquery-ext.html (next: http://localhost:43950/tests/dromaeo/cssquery-jquery.html) 18:27:08 INFO - PID 3585 | RSS: Main: 171515904 18:27:08 INFO - PID 3585 | 18:30:10 INFO - PID 3585 | Cycle 1(1): loaded http://localhost:43950/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43950/tests/dromaeo/cssquery-mootools.html) 18:30:10 INFO - PID 3585 | RSS: Main: 173236224 18:30:10 INFO - PID 3585 | 18:33:12 INFO - PID 3585 | Cycle 1(1): loaded http://localhost:43950/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43950/tests/dromaeo/cssquery-prototype.html) 18:33:13 INFO - PID 3585 | RSS: Main: 173367296 18:33:13 INFO - PID 3585 | 18:36:16 INFO - PID 3585 | Cycle 1(1): loaded http://localhost:43950/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43950/tests/dromaeo/cssquery-yui.html) 18:36:17 INFO - PID 3585 | RSS: Main: 176726016 18:36:17 INFO - PID 3585 | 18:39:19 INFO - PID 3585 | Cycle 1(1): loaded http://localhost:43950/tests/dromaeo/cssquery-yui.html (next: http://localhost:43950/tests/dromaeo/cssquery-dojo.html) 18:39:19 INFO - PID 3585 | RSS: Main: 175554560 18:39:19 INFO - PID 3585 | 18:39:19 INFO - PID 3585 | __start_tp_report 18:39:19 INFO - PID 3585 | _x_x_mozilla_page_load 18:39:19 INFO - PID 3585 | _x_x_mozilla_page_load_details 18:39:19 INFO - PID 3585 | |i|pagename|runs| 18:39:19 INFO - PID 3585 | |0;dojo.html;3122.219445138714;3132.639746429161;3140.35622697347;3148.81107133572;3154.621445426549;6165.568410211287;6196;6289.528285378592;6290.18227630408;6312.873742525147;6210.937890621092;6243.344448832875;6293.30773614902;6338.0492926061115;6344.7462101515885;5521.834344969638;5583.748731307101;5671.914921276163;5736.368999410061;5743.253377060997;5642.322921249456;5666.490015898568;5683.886322273552;5699.173619825123;5784.843031393717;5664.461876121762;5724.084146536555;5737.42625737425;5764.394738552454;5768.826935191951;5697.145428185764;5733.770649174028;5761.510271626917;5765.4522820332;5794.97102514489;5577.191307260425;5577.358603760538;5684.289463817023;5693.402192769782;5726.31284245889;5923.911141332884;6206.596571222856;6215.378462153749;6241.687915604247;6263.78076767311;6676.866462670768;6679.56582822115;6744.932550674529;6754.459643228579;6776.322367763233;6628.2046154461295;6635.80092597218;6746;6839.384455398988;6847.589144651337;6239.344868788802;6239.96880015597;6251.406116418887;6251.499880009634;6265.686715664244;6901.62041087735;6909.412699920563;6913.170419549586;6917.446604271646;6921.134858142732;6535.869282614416;6546.214454265423;6635.2037755469655;6658.700358483879;6676.632785196861;6717.496187785936;6772.492063095189;6799.5920244785475;6804.727810887608;6819.215790184093;6642.767503137367;6670.699818508082;6706.631135287606;6776.390124888783;6811.489138314547;6584.736610535525;6636.8672626547195;6727.159105111861;6764.966175169093;6817.0796942413135;5440.4287549807495;5442.265294185314;5449.64577302474;5455.5908306877145;5461.481159289861;4618.607418369409;4653.069386122789;4688.367070445514;4699.976500117477;4700.153972284953;5709.68596727184;5812.9709351452975;5848.766049357978;5880.970595146997;5888.234529511136;6686.1642294713165;6695.531312808057;6715.697793599202;6724.529282950244;6751.291114433012;5798.246227990418;5801.332846722681;5814.970925145347;5816.82549523515;5863.413658634103;5907.61600495975;5951.970240148771;5956.255468066492;5972.880542389128;5977.760889564369;6506.772262970868;6589;6599.406053455212;6602.372774586503;6617.933820661828;6736.225334086643;6760.256371799196;6764.154480689914;6846.418054465227;6859.622720750406;6424.582402143846;6475.870482590416;6501.804945851632;6503.122078519528;6583.473322134122;6524.412802847766;6609.735610575523;6616.966915165393;6645.401913827779;6667.799966001027;6846.041554182319;6859.4512439003765;6863.862722745417;6864.4165245954655;6875.931240687529;6563.474922006323;6622.271550129578;6625.469962403093;6639.502037347122;6644.534882558368;6532;6532.05285233648;6615.272320044887;6636.27001029896;6646.003099535108;6460.35396460369;6460.870782584416;6556.0493728410065;6556.541042127005;6557.9344206557325;6401.327860574759;6465.612063276219;6530.314316996837;6532.902006469812;6553.737850485927;5916.792912248051;6318;6373.075903993802;6397.136386587751;6430.164078669743 18:39:19 INFO - PID 3585 | |1;ext.html;816.3510009542413;859.1709000814215;885.7962668586225;889.3063410539777;1168.7779321928826;30298.69701302986;41555.79222103893;41565;41587.584124158784;41788.37317440237;40580;41013.58986410135;41468.17063658725;41656.79171604138;41678.37482437766;7286.67209975551;7878.212178782133;7884.172161923001;7884.211578842127;7892.368610511174;7765.767026989171;7871.448998570102;7872.645730942121;7873.291403773659;7874.251946065115;7793.8051548711455;7849.0973538043;7861.292483676468;7899.960500197491;7903.802404939865;7733.8839917401;7769.067711874554;7799.259070388304;7842.333401660837;7868.52788832669;7726.227377262285;7772.261635144652;7773.883391749072;7780.260875216845;7788.883166752503;36565.45151822698;36753.081172970626;36754.81622591897;36762.26475470502;36951.26097478035;3636.563612366533;3650.7809531427934;3653.872114476007;3663.249033948061;3677.988553147879;30724.385512289853;30840.53739193914;30851.691483085106;30924.690753092407;31006.224844378845;5070.847874563769;5084.084864724348;5088.287639730441;5093.821716239914;5137.38351397831;191221;191670;191769;191871;192921;48247.75876120597;48248.5175148244;48254.75872620614;48518.75740621345;48550;50505.494945050814;51011.23483147756;51040.48959510357;51093.23360149601;51162.232566511535;14111.364988575539;14454.060486068372;15207.391704331703;15567.844321556866;15614.609634758996;11982.161248712506;12357.25856448616;12385.380730963416;12388.62834114978;12395.256284622772;14274.500392486214;14452.132872027712;14593.92703036478;14605.269736513132;14733.336999835034;5919.556033297434;6046.486048685911;6061.54538409621;6078.635281883101;6198.2252218472695;988.9109980101825;1001.2790790630734;1021.6577446555488;1026.373911913732;1031.28841099641;22248.555028899656;22459.213927512457;22685.773142268365;23063.077476900737;28378.574321385197;1079.7786453776957;1083.7290677330668;1085.8968398002178;1099.406320586874;1105.9225854190129;12007.819882701766;12388.504459821506;12416.192947458387;12496.562620308245;12569.120161588784;234352;236441;236975;237243;238094;51459.228111578355;51727.74136129295;51822.74088629608;52087.21869171965;52167;1448.3453123765828;1449.702810923758;1470.9117452952644;1481.8221813382463;1488.7692407676827;20450.386488405373;20765.584688305848;20957.476063098544;21155.153793848072;21666.133354665635;37243.25513489661;37468.81265593655;37476;37565.62434375731;37832.62167378291;222182;224036;225100;225126;225887;28789.56815647809;29448.411031778815;31335;31416.52875206828;32258.83870580726;41933.79033104815;42306.78846605747;42456.575434245264;42538;43040.35439468473;30844.38311233718;31483;31716.841415792773;31724.682753172172;31871.840640796647;30929.381412372077;31004.84497577588;31722.36555268928;31857.522137167496;32044.19889502781;34174.316513670085;34244.31511369808;34371.14072148217;34425;37184.6281537192;32687;33031.66968330382;33244.66755332416;33590.160245993065;34080.48879266863;22819.20132795344;24193.758062419856;24442.51114977726;24515;24874.25377238686 18:39:19 INFO - PID 3585 | |2;jquery.html;566.4477134793574;574.8534123798431;579.9391063938289;588.7703795519747;593.2376895689039;21896.124155033798;22411.32766017018;22882.970266338012;22972.425689357773;22986.310410687664;24379.146729864457;26000.869995650042;26321.47357052858;26339.60490592638;26466.867665661644;6294.7482100715915;6459.612423254596;6465.3857883501;6475.676216189196;6494.285628580852;6260.092286618437;6285.6857157142185;6335.081413195084;6554.737810487575;6888.138982627172;6836.282190370014;6877.862442751142;6884.827879303008;6898.206706228798;6901.551399159063;6880.793576192722;6883.070785443976;6889.7588584399555;6893.517453778238;6899.068625735512;6786.185657721105;6789.083473731032;6799.354061364163;6805.149356330458;6805.455563554904;31406.842965785254;31995.520067198777;32457.350852983043;32644.347113057607;32702.345953080807;1986.4140078676826;2019.7475315585552;2029.6143732690741;2031.1266155553105;2032.1972820735875;20132.698009529868;20697.793022069887;20942.895285523628;21096.789032109635;21101.788982110134;2476.8018558515278;2526.2673824590847;2551.413174969767;2580.9483810323877;2582.7029891562333;141862;144776.27611861977;145849.99999999895;145896.27051864672;146268;19682.50793730168;22065.669014964467;22329;23125.88437057804;23317.417064573183;43867.78066109649;43928.56071439308;44002.11995760067;44177.77911110424;44219;11287.097032237401;11327.546898123983;11358.886411135949;11522.596709115309;11552.76894462106;9325.347225694137;9372;9391.859122113174;9444.433333999981;9535.189508891683;9649.951750241344;11132.443377831076;11476.827847582294;11500;11777;3690.4755958059986;3850.4609354690365;4063.878083657495;4175.561566035522;4191.7484950903045;928.3501548915785;952.4904176265665;954.0983770336965;959.712086374085;964.1948972607951;18938;19521.804781952284;19620.509487262934;19748.30880919161;19971.301004464774;1001.5543083327995;1010.2625083688802;1016.192127258831;1019.1235537437798;1027.9331843430152;10629.362238265729;10918.344899306067;11207.66377008691;13043.804342934864;14338.856611433752;512124;515814;520350;520950;525091;116023.41988290005;119411.40294298646;119882.4005879965;120224.39887800506;120451;1256.2085885892013;1259.7354555543254;1279.9232046077266;1291.7803973324558;1293.6183825771232;20725.0673719686;20853;20901.581968360853;20969.790302096782;21472.03375848122;55736.72131639316;56826.7158664204;56934.430655692915;57338;58575.414245857;70301;70486.64756676184;70504;70888;71648.28351716416;14935.103893766409;15089;15256.237188140327;15364;15374.769378459556;24045.639315410634;24278.757212428358;24299.271021869372;24331.148409805573;24499.510009800062;16962.49112526626;17063.573410664834;17075.231614577126;17250.741238881677;17354.479365619052;16167.75748363799;16542.42101526441;16738.497845064667;16983.745243821104;17469.737953930955;16599.50201493957;17485.65028699444;17487.125643718016;17499.56251093733;17512.474625761246;14953.925230373778;15006.774898376314;15031.323590438238;15048.247587620794;15064.322105505498;15916.681666366376;16850.74723879167;16981.575460613585;17284.481465556055;17428.128593570018 18:39:19 INFO - PID 3585 | |3;mootools.html;1335.52588830965;1376.3806287170776;1405.1779708870313;1415.8017877497145;1420.9289535523221;13355.799663005051;13952.093113947587;14059;14059.086159399645;14070.437182512687;14520.346584403727;14887.776683349759;14904.925475372607;14934.402623895032;14938.327775250113;2242.6187548116777;2611.2688447234805;2627.159309021114;2641.7490338417915;2662.1081937550944;2258.322503249027;2607.556715358394;2682;2683.9060632877854;2687.4625074984983;2588.4693637804203;2611.229687242268;2642.445086531831;2656.9601455978177;2659.2022393282036;2617.254082586463;2620.9606855897177;2636.0773729194725;2640.485105404447;2645.603159526077;2480.231128350217;2501.1746123779108;2568.7559681830385;2575.3947822261753;2590.8704564771874;13525.45898164082;13928;13949.930250348785;13955.651108722363;13966.231857247847;7324.230955749623;7612.048493938258;7614.543127412373;7618.961905190494;7632.656530456143;4823.831165909211;4962.627802914796;5045.84862454127;5060.519250671217;5071.315372424712;1824.2429391802386;1852.3331600623765;1894.526368407898;1917.8178073083034;1926.6532024235632;22488.775112248833;22883.656745149;22906.198283060014;22932.426689332733;23123;6661.9000714989315;6837.658117094125;7061.234691327169;7062.081929349254;7122.715091396286;15799.21003949821;15946.840531594768;15998.600034999217;16014.439494617633;16109.516714498584;6996.860062798817;7377.889331659922;7478.738244161428;7515.323620874038;7525.0969883613225;5440.401555828856;5657.6322539035655;6960.303969602999;6962.094927659372;6964.756233531802;4651.37206477128;5078.619103567247;5215.217717342353;5242.18746094356;5242.947570524246;1428.6428392901776;1435.626737048354;1462.8610282023192;1475.0780762023735;1479.9260036998323;888.706726780161;912.3066469483108;914.6661468564059;919.9770005749776;922.686286662538;7217.963910180415;7224.277572242734;7234.023406840114;7236.276372362721;7400.259974002557;724.8767709489399;976.345848281653;1012.6455740490917;1014.1379827146866;1021.2799976017038;4993.226049962189;5084.491550844886;5161.66449180802;5209.218617207449;5287.312649355559;18486.537836553925;19408.611827763365;19461.805381946284;19486.610267794564;19520.219191232474;18605;18990;19219;19291.90354048249;19303.613927721646;10608.522616482123;10672.946635266619;10832.512536935857;10862.076723478434;10873.347599144077;7828.099768526692;7859.60701964888;7935.880961785693;8053.154418786177;8064.5967701615855;16648.417305394254;16759.664806703553;16905.66188676195;17293.740593891354;17296.308147674456;16941.407050753165;16958.660826783642;17121.74317385265;17365.82634173642;17602.38391656286;10183.236257280585;10473.214508912015;10481.580736770444;10564.630237941636;10619.469026548797;12584.685382865135;12934.159279646792;13082.345882706017;13089.476420943056;13098.21410715322;10455.059044686015;10486.842697359698;10547.419891906018;10637.14902807789;10829.67510974672;10378;10569.735756606146;10584.629537966443;10661.360318380923;10681.19891008193;9458.95270523643;9692.64302997595;9705.6117755289;9721.854172187564;9762.46306453152;6564.6389448580785;6581.901271481028;6620.404163625297;7030.50786444944;7108.147022357143;6717.798466046026;6749.156355455568;6810.114685090906;6823.738386771671;6840.486963477859 18:39:19 INFO - PID 3585 | |4;prototype.html;495.7026172322138;498.336391984841;514.295415281065;520.7578476008655;521.1661341853036;6192.164057852188;6210.9068363974575;6255.562110652256;6283.937160628392;6293.622382657044;5815.47660710536;5956.16613674086;6015.909761353583;6037.275526936763;6090.604110732799;4841.201201801716;4924.606031517488;4946.530079642428;4952.851414457572;4972.154733695263;4854.417469903598;4875.24433712775;4933.679310844784;4946.109700253953;4953.801847926079;4687.460941991663;4892.877678058059;4898.877528061809;4913.901721965559;4923.876903077434;4834.323194752737;4889;4913.975430122862;4921.548143297736;4964.106460837048;4441.600255976945;4444.466664000308;4449.132419178261;4467.3299005149165;4499.572540608637;6007.849803754941;6033.366496517846;6057.757689692407;6062.1808260795415;6095.908561371539;5642.858928526779;5655.293088363955;5692.203091567184;5692.829215123553;5694.971525142348;6417.588130611258;6459.35406459355;6466.932956062244;6485.772997945097;6494.415502604788;4783.425988881357;4847.854564363075;4850.781714822806;4855.63582731293;4872.634552408548;6733.259341472434;6775.932240677629;6824.488163387716;6897.2757860424435;6905.1713794345;4913.950860491349;4934.580560652313;4961.7519124044375;5016.372953380827;5031.245313203049;5013.323201367769;5024.84925452237;5025.447200807908;5045.192769156991;5074.797008119708;5615.837902407602;5640.182173584807;5645.1532270159805;5687.544996400278;5693.430656934273;6488.28628850826;6556.672166391661;6577.506686998494;6586.057113151632;6607.14107166075;1664.5755332390406;1719.217755921053;1745.5287072490357;1748.4055421156868;1762.101328322539;1149.7298134938283;1172.5778719660916;1403.0669604712753;1422.3599380278915;1431.0269017068285;5628.465295796893;5663.6035477517;5669.744861481243;5687.459691329317;5706.885862282814;6553.574017688835;6584.736610535525;6619.735210591522;6628.270890202074;6632.336766323426;5506.972465137729;5633.014222511044;5667.659940403589;5677.091665333527;5784.88430231393;3508.3158784037378;3512.2799826035603;3520.697341983431;3559.4126969049817;3562.8040457775073;6345.192884269493;6410.391012853772;6441.840468715676;6454.32229615893;6472.35276472349;6786.151731033621;6843.247242803288;6847.965760171267;6855.417289530346;6889.793306200822;6403.199600049994;6422.165118534561;6437.2918978912285;6489.7404103835315;6536.869262614721;6473.902891456726;6564.212294524687;6583.868322633616;6599.175103112111;6616.90074648871;6468.870622587616;6538.803835884931;6581.638009909501;6609.173853268341;6629;6437.67811609427;6455.806325810233;6468.8059358219325;6494.967525162344;6507.9674601628585;4956.942868709445;4987.775550100327;4988.301637770787;4997.550220480174;5005.822467226768;6576.2766095728475;6677;6719.65606878636;6732.966335168293;6741.157355330583;6444.645544495098;6477.4494167996245;6496.415322620986;6503.544751867324;6557.377049180321;6478.28738838718;6480.12518310041;6495.350464953656;6524.706388212447;6534.411902928759;6101.176341193882;6359.427651511386;6371.171747672773;6407.839804004937;6429.871402571829;6265.74937002533;6400.583962042452;6416.518761092843;6449.161608990801;6519.5436319457185;6177.6293422393;6214.2853571838;6264.530160238091;6295.244570651368;6342.39747224013 18:39:19 INFO - PID 3585 | |5;yui.html;898.752842968184;914.7164379042496;919.439142123305;927.2442958988424;937.4047479850293;18916.71624925627;19749.21003159872;19769.11039003245;19820.603587928268;19865.40403787887;15580.454684086058;15816;16146.354145834182;16212.675746485063;21352.145914163455;1029.0892560084342;1052.3212527919488;1055.8996895294972;1056.5351245452016;1057.318029870733;1049.2130901823632;1054.3884546962781;1055.1347894726327;1061.2995423020807;1061.4162210784077;1008.7478130467383;1114.7658991611772;1121.8317252412162;1126.2060247525476;1128.7968165730165;1107.7009207514006;1111.9666410007712;1114.9275297105703;1116.107114308554;1119.8544189255385;798.0662624729023;798.1061211443163;798.4371018431991;803.3934379543466;806.4838503357855;19415.3204637837;19694.70457943132;19894.60210795776;19947.401577952685;20223;21436.249731259486;22239.332820015425;22267.77732222673;22770.886145569333;22779.77220227793;15839.841601584067;16091.195440227943;16235;16284;16318.184090795412;3655.5613326400735;3707.0361705956375;3710.2950439416422;3710.9443358349645;3722.3671975764187;124939.3753031229;126857;126908;130231.34884325613;133191.6680833189;16294.592635184215;17026.063566503715;17030.06334651606;17048.65902681964;17104.14479276031;30478.695213048028;31038;31629.841850791057;31671.20821979469;32011.51982720261;8820.647174112964;9015.504147271962;9020.909790902138;9022.503762293138;9024.909750902538;4133.937990930139;4165.271077561475;4174.707770456039;4223.915521689549;4269.807858646368;5227.712475813791;5340.75966581497;5362.785488580413;5395.05586522357;5437.13005919051;945.3240932733129;980.6469670918464;983.4246965525105;990.5889056041661;995.8456439251928;681.7477533312607;704.264044073944;710.3642240194996;712.7790384980673;715.8617797701679;11008.669739907815;11724.179307448398;11831.940840295743;12664.430100645493;14135.78796318056;700.1283402164237;708.9432845372357;712.4478529139958;714.58196954781;723.08529709917;5420.91868621971;5555.611107222537;5734.684592347461;5884.0585506318785;5924.407559244128;101596;102229.48885255527;103597.48201259096;104347.4782626082;107104;89203;91733.54133229425;92312;97255.51372243093;97627;85740.57129714312;88056.55971720228;88954.55522722345;90217.54891225502;92599;13021.218726876417;13212.207267563977;13371.465141394625;13379.665508362368;13437.529686461317;37244;37608;37938;38225;39674.801625991684;48311.5168848307;49842.50157498524;50566.49433505618;51052;52015.73992130015;18467;18484.81515184885;18972.146253418905;19153.904230478758;19245.03774811282;21320.466988325417;21411.8929405352;21497.892510537346;21572;21596.67604985895;19128.71306930425;19372.709409358587;19410.320638777575;19539.51151221231;19633.410997670093;19163.233470661016;19221.32725354606;19425.708614370513;19486;19714.21143154258;18135.546611334823;18562.721559176895;18614;18635;18786;12387.19483233587;12399.504019839105;12664.556740514037;12730.618081457571;12773.105882588501;12766.61700148997;13007.284599347127;13394.93302533481;14250.786238206229;14890.478833240784 18:39:19 INFO - PID 3585 | __end_tp_report 18:39:19 INFO - PID 3585 | __start_cc_report 18:39:19 INFO - PID 3585 | _x_x_mozilla_cycle_collect,375 18:39:19 INFO - PID 3585 | __end_cc_report 18:39:19 INFO - PID 3585 | __startTimestamp1502415559586__endTimestamp 18:39:19 INFO - PID 3585 | 18:39:19 INFO - PID 3585 | ------- Summary: start ------- 18:39:19 INFO - PID 3585 | Number of tests: 6 18:39:19 INFO - PID 3585 | 18:39:19 INFO - PID 3585 | [#0] dojo.html Cycles:165 Average:6184.13 Median:6460.35 stddev:743.14 (11.5%) stddev-sans-first:705.54 18:39:19 INFO - PID 3585 | Values: 3122.2 3132.6 3140.4 3148.8 3154.6 6165.6 6196.0 6289.5 6290.2 6312.9 6210.9 6243.3 6293.3 6338.0 6344.7 5521.8 5583.7 5671.9 5736.4 5743.3 5642.3 5666.5 5683.9 5699.2 5784.8 5664.5 5724.1 5737.4 5764.4 5768.8 5697.1 5733.8 5761.5 5765.5 5795.0 5577.2 5577.4 5684.3 5693.4 5726.3 5923.9 6206.6 6215.4 6241.7 6263.8 6676.9 6679.6 6744.9 6754.5 6776.3 6628.2 6635.8 6746.0 6839.4 6847.6 6239.3 6240.0 6251.4 6251.5 6265.7 6901.6 6909.4 6913.2 6917.4 6921.1 6535.9 6546.2 6635.2 6658.7 6676.6 6717.5 6772.5 6799.6 6804.7 6819.2 6642.8 6670.7 6706.6 6776.4 6811.5 6584.7 6636.9 6727.2 6765.0 6817.1 5440.4 5442.3 5449.6 5455.6 5461.5 4618.6 4653.1 4688.4 4700.0 4700.2 5709.7 5813.0 5848.8 5881.0 5888.2 6686.2 6695.5 6715.7 6724.5 6751.3 5798.2 5801.3 5815.0 5816.8 5863.4 5907.6 5952.0 5956.3 5972.9 5977.8 6506.8 6589.0 6599.4 6602.4 6617.9 6736.2 6760.3 6764.2 6846.4 6859.6 6424.6 6475.9 6501.8 6503.1 6583.5 6524.4 6609.7 6617.0 6645.4 6667.8 6846.0 6859.5 6863.9 6864.4 6875.9 6563.5 6622.3 6625.5 6639.5 6644.5 6532.0 6532.1 6615.3 6636.3 6646.0 6460.4 6460.9 6556.0 6556.5 6557.9 6401.3 6465.6 6530.3 6532.9 6553.7 5916.8 6318.0 6373.1 6397.1 6430.2 18:39:19 INFO - PID 3585 | 18:39:19 INFO - PID 3585 | [#1] ext.html Cycles:180 Average:38216.22 Median:34127.40 stddev:56681.12 (166.1%) stddev-sans-first:56770.56 18:39:19 INFO - PID 3585 | Values: 816.4 859.2 885.8 889.3 1168.8 30298.7 41555.8 41565.0 41587.6 41788.4 40580.0 41013.6 41468.2 41656.8 41678.4 7286.7 7878.2 7884.2 7884.2 7892.4 7765.8 7871.4 7872.6 7873.3 7874.3 7793.8 7849.1 7861.3 7900.0 7903.8 7733.9 7769.1 7799.3 7842.3 7868.5 7726.2 7772.3 7773.9 7780.3 7788.9 36565.5 36753.1 36754.8 36762.3 36951.3 3636.6 3650.8 3653.9 3663.2 3678.0 30724.4 30840.5 30851.7 30924.7 31006.2 5070.8 5084.1 5088.3 5093.8 5137.4 191221.0 191670.0 191769.0 191871.0 192921.0 48247.8 48248.5 48254.8 48518.8 48550.0 50505.5 51011.2 51040.5 51093.2 51162.2 14111.4 14454.1 15207.4 15567.8 15614.6 11982.2 12357.3 12385.4 12388.6 12395.3 14274.5 14452.1 14593.9 14605.3 14733.3 5919.6 6046.5 6061.5 6078.6 6198.2 988.9 1001.3 1021.7 1026.4 1031.3 22248.6 22459.2 22685.8 23063.1 28378.6 1079.8 1083.7 1085.9 1099.4 1105.9 12007.8 12388.5 12416.2 12496.6 12569.1 234352.0 236441.0 236975.0 237243.0 238094.0 51459.2 51727.7 51822.7 52087.2 52167.0 1448.3 1449.7 1470.9 1481.8 1488.8 20450.4 20765.6 20957.5 21155.2 21666.1 37243.3 37468.8 37476.0 37565.6 37832.6 222182.0 224036.0 225100.0 225126.0 225887.0 28789.6 29448.4 31335.0 31416.5 32258.8 41933.8 42306.8 42456.6 42538.0 43040.4 30844.4 31483.0 31716.8 31724.7 31871.8 30929.4 31004.8 31722.4 31857.5 32044.2 34174.3 34244.3 34371.1 34425.0 37184.6 32687.0 33031.7 33244.7 33590.2 34080.5 22819.2 24193.8 24442.5 24515.0 24874.3 18:39:19 INFO - PID 3585 | 18:39:19 INFO - PID 3585 | [#2] jquery.html Cycles:180 Average:36987.57 Median:22979.37 stddev:87219.26 (379.6%) stddev-sans-first:87421.06 18:39:19 INFO - PID 3585 | Values: 566.4 574.9 579.9 588.8 593.2 21896.1 22411.3 22883.0 22972.4 22986.3 24379.1 26000.9 26321.5 26339.6 26466.9 6294.7 6459.6 6465.4 6475.7 6494.3 6260.1 6285.7 6335.1 6554.7 6888.1 6836.3 6877.9 6884.8 6898.2 6901.6 6880.8 6883.1 6889.8 6893.5 6899.1 6786.2 6789.1 6799.4 6805.1 6805.5 31406.8 31995.5 32457.4 32644.3 32702.3 1986.4 2019.7 2029.6 2031.1 2032.2 20132.7 20697.8 20942.9 21096.8 21101.8 2476.8 2526.3 2551.4 2580.9 2582.7 141862.0 144776.3 145850.0 145896.3 146268.0 19682.5 22065.7 22329.0 23125.9 23317.4 43867.8 43928.6 44002.1 44177.8 44219.0 11287.1 11327.5 11358.9 11522.6 11552.8 9325.3 9372.0 9391.9 9444.4 9535.2 9650.0 11132.4 11476.8 11500.0 11777.0 3690.5 3850.5 4063.9 4175.6 4191.7 928.4 952.5 954.1 959.7 964.2 18938.0 19521.8 19620.5 19748.3 19971.3 1001.6 1010.3 1016.2 1019.1 1027.9 10629.4 10918.3 11207.7 13043.8 14338.9 512124.0 515814.0 520350.0 520950.0 525091.0 116023.4 119411.4 119882.4 120224.4 120451.0 1256.2 1259.7 1279.9 1291.8 1293.6 20725.1 20853.0 20901.6 20969.8 21472.0 55736.7 56826.7 56934.4 57338.0 58575.4 70301.0 70486.6 70504.0 70888.0 71648.3 14935.1 15089.0 15256.2 15364.0 15374.8 24045.6 24278.8 24299.3 24331.1 24499.5 16962.5 17063.6 17075.2 17250.7 17354.5 16167.8 16542.4 16738.5 16983.7 17469.7 16599.5 17485.7 17487.1 17499.6 17512.5 14953.9 15006.8 15031.3 15048.2 15064.3 15916.7 16850.7 16981.6 17284.5 17428.1 18:39:19 INFO - PID 3585 | 18:39:19 INFO - PID 3585 | [#3] mootools.html Cycles:180 Average:8634.26 Median:2490.70 stddev:5934.38 (238.3%) stddev-sans-first:5925.69 18:39:19 INFO - PID 3585 | Values: 1335.5 1376.4 1405.2 1415.8 1420.9 13355.8 13952.1 14059.0 14059.1 14070.4 14520.3 14887.8 14904.9 14934.4 14938.3 2242.6 2611.3 2627.2 2641.7 2662.1 2258.3 2607.6 2682.0 2683.9 2687.5 2588.5 2611.2 2642.4 2657.0 2659.2 2617.3 2621.0 2636.1 2640.5 2645.6 2480.2 2501.2 2568.8 2575.4 2590.9 13525.5 13928.0 13949.9 13955.7 13966.2 7324.2 7612.0 7614.5 7619.0 7632.7 4823.8 4962.6 5045.8 5060.5 5071.3 1824.2 1852.3 1894.5 1917.8 1926.7 22488.8 22883.7 22906.2 22932.4 23123.0 6661.9 6837.7 7061.2 7062.1 7122.7 15799.2 15946.8 15998.6 16014.4 16109.5 6996.9 7377.9 7478.7 7515.3 7525.1 5440.4 5657.6 6960.3 6962.1 6964.8 4651.4 5078.6 5215.2 5242.2 5242.9 1428.6 1435.6 1462.9 1475.1 1479.9 888.7 912.3 914.7 920.0 922.7 7218.0 7224.3 7234.0 7236.3 7400.3 724.9 976.3 1012.6 1014.1 1021.3 4993.2 5084.5 5161.7 5209.2 5287.3 18486.5 19408.6 19461.8 19486.6 19520.2 18605.0 18990.0 19219.0 19291.9 19303.6 10608.5 10672.9 10832.5 10862.1 10873.3 7828.1 7859.6 7935.9 8053.2 8064.6 16648.4 16759.7 16905.7 17293.7 17296.3 16941.4 16958.7 17121.7 17365.8 17602.4 10183.2 10473.2 10481.6 10564.6 10619.5 12584.7 12934.2 13082.3 13089.5 13098.2 10455.1 10486.8 10547.4 10637.1 10829.7 10378.0 10569.7 10584.6 10661.4 10681.2 9459.0 9692.6 9705.6 9721.9 9762.5 6564.6 6581.9 6620.4 7030.5 7108.1 6717.8 6749.2 6810.1 6823.7 6840.5 18:39:19 INFO - PID 3585 | 18:39:19 INFO - PID 3585 | [#4] prototype.html Cycles:180 Average:5455.97 Median:6047.52 stddev:1520.85 (25.1%) stddev-sans-first:1478.84 18:39:19 INFO - PID 3585 | Values: 495.7 498.3 514.3 520.8 521.2 6192.2 6210.9 6255.6 6283.9 6293.6 5815.5 5956.2 6015.9 6037.3 6090.6 4841.2 4924.6 4946.5 4952.9 4972.2 4854.4 4875.2 4933.7 4946.1 4953.8 4687.5 4892.9 4898.9 4913.9 4923.9 4834.3 4889.0 4914.0 4921.5 4964.1 4441.6 4444.5 4449.1 4467.3 4499.6 6007.8 6033.4 6057.8 6062.2 6095.9 5642.9 5655.3 5692.2 5692.8 5695.0 6417.6 6459.4 6466.9 6485.8 6494.4 4783.4 4847.9 4850.8 4855.6 4872.6 6733.3 6775.9 6824.5 6897.3 6905.2 4914.0 4934.6 4961.8 5016.4 5031.2 5013.3 5024.8 5025.4 5045.2 5074.8 5615.8 5640.2 5645.2 5687.5 5693.4 6488.3 6556.7 6577.5 6586.1 6607.1 1664.6 1719.2 1745.5 1748.4 1762.1 1149.7 1172.6 1403.1 1422.4 1431.0 5628.5 5663.6 5669.7 5687.5 5706.9 6553.6 6584.7 6619.7 6628.3 6632.3 5507.0 5633.0 5667.7 5677.1 5784.9 3508.3 3512.3 3520.7 3559.4 3562.8 6345.2 6410.4 6441.8 6454.3 6472.4 6786.2 6843.2 6848.0 6855.4 6889.8 6403.2 6422.2 6437.3 6489.7 6536.9 6473.9 6564.2 6583.9 6599.2 6616.9 6468.9 6538.8 6581.6 6609.2 6629.0 6437.7 6455.8 6468.8 6495.0 6508.0 4956.9 4987.8 4988.3 4997.6 5005.8 6576.3 6677.0 6719.7 6733.0 6741.2 6444.6 6477.4 6496.4 6503.5 6557.4 6478.3 6480.1 6495.4 6524.7 6534.4 6101.2 6359.4 6371.2 6407.8 6429.9 6265.7 6400.6 6416.5 6449.2 6519.5 6177.6 6214.3 6264.5 6295.2 6342.4 18:39:19 INFO - PID 3585 | 18:39:19 INFO - PID 3585 | [#5] yui.html Cycles:180 Average:23125.71 Median:19880.00 stddev:31092.52 (156.4%) stddev-sans-first:31134.94 18:39:19 INFO - PID 3585 | Values: 898.8 914.7 919.4 927.2 937.4 18916.7 19749.2 19769.1 19820.6 19865.4 15580.5 15816.0 16146.4 16212.7 21352.1 1029.1 1052.3 1055.9 1056.5 1057.3 1049.2 1054.4 1055.1 1061.3 1061.4 1008.7 1114.8 1121.8 1126.2 1128.8 1107.7 1112.0 1114.9 1116.1 1119.9 798.1 798.1 798.4 803.4 806.5 19415.3 19694.7 19894.6 19947.4 20223.0 21436.2 22239.3 22267.8 22770.9 22779.8 15839.8 16091.2 16235.0 16284.0 16318.2 3655.6 3707.0 3710.3 3710.9 3722.4 124939.4 126857.0 126908.0 130231.3 133191.7 16294.6 17026.1 17030.1 17048.7 17104.1 30478.7 31038.0 31629.8 31671.2 32011.5 8820.6 9015.5 9020.9 9022.5 9024.9 4133.9 4165.3 4174.7 4223.9 4269.8 5227.7 5340.8 5362.8 5395.1 5437.1 945.3 980.6 983.4 990.6 995.8 681.7 704.3 710.4 712.8 715.9 11008.7 11724.2 11831.9 12664.4 14135.8 700.1 708.9 712.4 714.6 723.1 5420.9 5555.6 5734.7 5884.1 5924.4 101596.0 102229.5 103597.5 104347.5 107104.0 89203.0 91733.5 92312.0 97255.5 97627.0 85740.6 88056.6 88954.6 90217.5 92599.0 13021.2 13212.2 13371.5 13379.7 13437.5 37244.0 37608.0 37938.0 38225.0 39674.8 48311.5 49842.5 50566.5 51052.0 52015.7 18467.0 18484.8 18972.1 19153.9 19245.0 21320.5 21411.9 21497.9 21572.0 21596.7 19128.7 19372.7 19410.3 19539.5 19633.4 19163.2 19221.3 19425.7 19486.0 19714.2 18135.5 18562.7 18614.0 18635.0 18786.0 12387.2 12399.5 12664.6 12730.6 12773.1 12766.6 13007.3 13394.9 14250.8 14890.5 18:39:19 INFO - PID 3585 | -------- Summary: end -------- 18:39:19 INFO - PID 3585 | 18:39:20 INFO - TEST-INFO | 3585: exit 0 18:39:20 INFO - TEST-OK | dromaeo_css | took 1113501ms 18:39:20 INFO - TEST-START | kraken 18:39:20 INFO - Initialising browser for kraken test... 18:39:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43950/getInfo.html -profile /tmp/tmpYjghwZ/profile 18:39:20 INFO - TEST-INFO | started process 3957 (/builds/slave/test/build/application/firefox/firefox http://localhost:43950/getInfo.html) 18:39:26 INFO - TEST-INFO | 3957: exit 0 18:39:26 INFO - Browser initialized. 18:39:26 INFO - Running cycle 1/1 for kraken test... 18:39:26 INFO - TEST-INFO | started process 4193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYjghwZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:39:27 INFO - PID 4193 | 18:39:27 INFO - PID 4193 | (/builds/slave/test/build/application/firefox/firefox:4248): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:39:27 INFO - PID 4193 | 18:39:37 INFO - PID 4193 | RSS: Main: 168448000 18:39:37 INFO - PID 4193 | 18:39:40 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:43950/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43950/tests/kraken/driver.html?testName=audio-beat-detection) 18:39:41 INFO - PID 4193 | RSS: Main: 174764032 18:39:41 INFO - PID 4193 | 18:39:44 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:43950/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43950/tests/kraken/driver.html?testName=audio-dft) 18:39:44 INFO - PID 4193 | RSS: Main: 174997504 18:39:44 INFO - PID 4193 | 18:39:47 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:43950/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43950/tests/kraken/driver.html?testName=audio-fft) 18:39:48 INFO - PID 4193 | RSS: Main: 170233856 18:39:48 INFO - PID 4193 | 18:39:50 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:43950/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43950/tests/kraken/driver.html?testName=audio-oscillator) 18:39:51 INFO - PID 4193 | RSS: Main: 170696704 18:39:51 INFO - PID 4193 | 18:39:53 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:43950/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43950/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:39:54 INFO - PID 4193 | RSS: Main: 171249664 18:39:54 INFO - PID 4193 | 18:39:57 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:43950/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43950/tests/kraken/driver.html?testName=imaging-darkroom) 18:39:58 INFO - PID 4193 | RSS: Main: 173842432 18:39:58 INFO - PID 4193 | 18:40:01 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:43950/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43950/tests/kraken/driver.html?testName=imaging-desaturate) 18:40:02 INFO - PID 4193 | RSS: Main: 173064192 18:40:02 INFO - PID 4193 | 18:40:05 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:43950/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43950/tests/kraken/driver.html?testName=json-parse-financial) 18:40:05 INFO - PID 4193 | RSS: Main: 174129152 18:40:05 INFO - PID 4193 | 18:40:07 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:43950/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43950/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:40:08 INFO - PID 4193 | RSS: Main: 173891584 18:40:08 INFO - PID 4193 | 18:40:09 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:43950/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43950/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:40:10 INFO - PID 4193 | RSS: Main: 174338048 18:40:10 INFO - PID 4193 | 18:40:12 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:43950/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43950/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:40:13 INFO - PID 4193 | RSS: Main: 174116864 18:40:13 INFO - PID 4193 | 18:40:16 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:43950/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43950/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:40:17 INFO - PID 4193 | RSS: Main: 174358528 18:40:17 INFO - PID 4193 | 18:40:20 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:43950/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43950/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:40:20 INFO - PID 4193 | RSS: Main: 174534656 18:40:20 INFO - PID 4193 | 18:40:22 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:43950/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43950/tests/kraken/driver.html?testName=ai-astar) 18:40:22 INFO - PID 4193 | RSS: Main: 176001024 18:40:22 INFO - PID 4193 | 18:40:22 INFO - PID 4193 | __start_tp_report 18:40:22 INFO - PID 4193 | _x_x_mozilla_page_load 18:40:22 INFO - PID 4193 | _x_x_mozilla_page_load_details 18:40:22 INFO - PID 4193 | |i|pagename|runs| 18:40:22 INFO - PID 4193 | |0;ai-astar;107;112;103;108;107;110;113;98;108;108 18:40:22 INFO - PID 4193 | |1;audio-beat-detection;154;116;147;167;117;146;151;121;172;120 18:40:22 INFO - PID 4193 | |2;audio-dft;163;163;163;163;164;168;172;163;165;166 18:40:22 INFO - PID 4193 | |3;audio-fft;76;74;75;183;82;74;82;74;160;75 18:40:22 INFO - PID 4193 | |4;audio-oscillator;78;79;132;78;78;78;122;81;80;139 18:40:22 INFO - PID 4193 | |5;imaging-gaussian-blur;114;119;114;119;114;116;114;118;114;117 18:40:22 INFO - PID 4193 | |6;imaging-darkroom;150;151;150;155;150;150;151;150;152;152 18:40:22 INFO - PID 4193 | |7;imaging-desaturate;97;95;96;94;94;94;94;95;94;97 18:40:22 INFO - PID 4193 | |8;json-parse-financial;54;55;59;54;60;57;54;56;55;56 18:40:22 INFO - PID 4193 | |9;json-stringify-tinderbox;54;53;54;60;54;62;55;54;55;60 18:40:22 INFO - PID 4193 | |10;stanford-crypto-aes;79;79;88;90;78;79;83;86;85;78 18:40:22 INFO - PID 4193 | |11;stanford-crypto-ccm;147;136;127;142;137;128;142;129;125;172 18:40:22 INFO - PID 4193 | |12;stanford-crypto-pbkdf2;199;181;190;180;182;186;177;185;184;178 18:40:22 INFO - PID 4193 | |13;stanford-crypto-sha256-iterative;67;69;65;67;66;66;67;65;67;64 18:40:22 INFO - PID 4193 | __end_tp_report 18:40:22 INFO - PID 4193 | __start_cc_report 18:40:22 INFO - PID 4193 | _x_x_mozilla_cycle_collect,932 18:40:22 INFO - PID 4193 | __end_cc_report 18:40:22 INFO - PID 4193 | __startTimestamp1502415622953__endTimestamp 18:40:22 INFO - PID 4193 | 18:40:22 INFO - PID 4193 | ------- Summary: start ------- 18:40:22 INFO - PID 4193 | Number of tests: 14 18:40:22 INFO - PID 4193 | 18:40:22 INFO - PID 4193 | [#0] ai-astar Cycles:10 Average:107.40 Median:109.00 stddev:4.33 (4.0%) stddev-sans-first:4.59 18:40:22 INFO - PID 4193 | Values: 107.0 112.0 103.0 108.0 107.0 110.0 113.0 98.0 108.0 108.0 18:40:22 INFO - PID 4193 | 18:40:22 INFO - PID 4193 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:149.00 stddev:21.11 (14.2%) stddev-sans-first:21.86 18:40:22 INFO - PID 4193 | Values: 154.0 116.0 147.0 167.0 117.0 146.0 151.0 121.0 172.0 120.0 18:40:22 INFO - PID 4193 | 18:40:22 INFO - PID 4193 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.50 stddev:2.98 (1.8%) stddev-sans-first:3.07 18:40:22 INFO - PID 4193 | Values: 163.0 163.0 163.0 163.0 164.0 168.0 172.0 163.0 165.0 166.0 18:40:22 INFO - PID 4193 | 18:40:22 INFO - PID 4193 | [#3] audio-fft Cycles:10 Average:95.50 Median:75.00 stddev:40.54 (54.0%) stddev-sans-first:42.38 18:40:22 INFO - PID 4193 | Values: 76.0 74.0 75.0 183.0 82.0 74.0 82.0 74.0 160.0 75.0 18:40:22 INFO - PID 4193 | 18:40:22 INFO - PID 4193 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:78.00 stddev:25.53 (32.7%) stddev-sans-first:26.37 18:40:22 INFO - PID 4193 | Values: 78.0 79.0 132.0 78.0 78.0 78.0 122.0 81.0 80.0 139.0 18:40:22 INFO - PID 4193 | 18:40:22 INFO - PID 4193 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:116.50 stddev:2.18 (1.9%) stddev-sans-first:2.20 18:40:22 INFO - PID 4193 | Values: 114.0 119.0 114.0 119.0 114.0 116.0 114.0 118.0 114.0 117.0 18:40:22 INFO - PID 4193 | 18:40:22 INFO - PID 4193 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:1.60 (1.1%) stddev-sans-first:1.64 18:40:22 INFO - PID 4193 | Values: 150.0 151.0 150.0 155.0 150.0 150.0 151.0 150.0 152.0 152.0 18:40:22 INFO - PID 4193 | 18:40:22 INFO - PID 4193 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:1.25 (1.3%) stddev-sans-first:1.09 18:40:22 INFO - PID 4193 | Values: 97.0 95.0 96.0 94.0 94.0 94.0 94.0 95.0 94.0 97.0 18:40:22 INFO - PID 4193 | 18:40:22 INFO - PID 4193 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:2.11 (3.8%) stddev-sans-first:2.11 18:40:22 INFO - PID 4193 | Values: 54.0 55.0 59.0 54.0 60.0 57.0 54.0 56.0 55.0 56.0 18:40:22 INFO - PID 4193 | 18:40:22 INFO - PID 4193 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:55.00 stddev:3.25 (5.9%) stddev-sans-first:3.35 18:40:22 INFO - PID 4193 | Values: 54.0 53.0 54.0 60.0 54.0 62.0 55.0 54.0 55.0 60.0 18:40:22 INFO - PID 4193 | 18:40:22 INFO - PID 4193 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:84.00 stddev:4.50 (5.4%) stddev-sans-first:4.59 18:40:22 INFO - PID 4193 | Values: 79.0 79.0 88.0 90.0 78.0 79.0 83.0 86.0 85.0 78.0 18:40:22 INFO - PID 4193 | 18:40:22 INFO - PID 4193 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:139.50 stddev:13.91 (10.0%) stddev-sans-first:14.41 18:40:22 INFO - PID 4193 | Values: 147.0 136.0 127.0 142.0 137.0 128.0 142.0 129.0 125.0 172.0 18:40:22 INFO - PID 4193 | 18:40:22 INFO - PID 4193 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.20 Median:184.50 stddev:6.49 (3.5%) stddev-sans-first:4.13 18:40:22 INFO - PID 4193 | Values: 199.0 181.0 190.0 180.0 182.0 186.0 177.0 185.0 184.0 178.0 18:40:22 INFO - PID 4193 | 18:40:22 INFO - PID 4193 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:1.42 (2.1%) stddev-sans-first:1.48 18:40:22 INFO - PID 4193 | Values: 67.0 69.0 65.0 67.0 66.0 66.0 67.0 65.0 67.0 64.0 18:40:22 INFO - PID 4193 | -------- Summary: end -------- 18:40:22 INFO - PID 4193 | 18:40:23 INFO - PID 4193 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:40:23 INFO - TEST-INFO | 4193: exit 0 18:40:23 INFO - TEST-OK | kraken | took 63365ms 18:40:23 INFO - SUITE-END | took 1176s 18:40:24 INFO - Completed test suite (00:19:37) 18:40:24 INFO - javascript benchmark 18:40:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8548.052078924267, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3122.219445138714, 3132.639746429161, 3140.35622697347, 3148.81107133572, 3154.621445426549, 6165.568410211287, 6196.0, 6289.528285378592, 6290.18227630408, 6312.873742525147, 6210.937890621092, 6243.344448832875, 6293.30773614902, 6338.0492926061115, 6344.7462101515885, 5521.834344969638, 5583.748731307101, 5671.914921276163, 5736.368999410061, 5743.253377060997, 5642.322921249456, 5666.490015898568, 5683.886322273552, 5699.173619825123, 5784.843031393717, 5664.461876121762, 5724.084146536555, 5737.42625737425, 5764.394738552454, 5768.826935191951, 5697.145428185764, 5733.770649174028, 5761.510271626917, 5765.4522820332, 5794.97102514489, 5577.191307260425, 5577.358603760538, 5684.289463817023, 5693.402192769782, 5726.31284245889, 5923.911141332884, 6206.596571222856, 6215.378462153749, 6241.687915604247, 6263.78076767311, 6676.866462670768, 6679.56582822115, 6744.932550674529, 6754.459643228579, 6776.322367763233, 6628.2046154461295, 6635.80092597218, 6746.0, 6839.384455398988, 6847.589144651337, 6239.344868788802, 6239.96880015597, 6251.406116418887, 6251.499880009634, 6265.686715664244, 6901.62041087735, 6909.412699920563, 6913.170419549586, 6917.446604271646, 6921.134858142732, 6535.869282614416, 6546.214454265423, 6635.2037755469655, 6658.700358483879, 6676.632785196861, 6717.496187785936, 6772.492063095189, 6799.5920244785475, 6804.727810887608, 6819.215790184093, 6642.767503137367, 6670.699818508082, 6706.631135287606, 6776.390124888783, 6811.489138314547, 6584.736610535525, 6636.8672626547195, 6727.159105111861, 6764.966175169093, 6817.0796942413135, 5440.4287549807495, 5442.265294185314, 5449.64577302474, 5455.5908306877145, 5461.481159289861, 4618.607418369409, 4653.069386122789, 4688.367070445514, 4699.976500117477, 4700.153972284953, 5709.68596727184, 5812.9709351452975, 5848.766049357978, 5880.970595146997, 5888.234529511136, 6686.1642294713165, 6695.531312808057, 6715.697793599202, 6724.529282950244, 6751.291114433012, 5798.246227990418, 5801.332846722681, 5814.970925145347, 5816.82549523515, 5863.413658634103, 5907.61600495975, 5951.970240148771, 5956.255468066492, 5972.880542389128, 5977.760889564369, 6506.772262970868, 6589.0, 6599.406053455212, 6602.372774586503, 6617.933820661828, 6736.225334086643, 6760.256371799196, 6764.154480689914, 6846.418054465227, 6859.622720750406, 6424.582402143846, 6475.870482590416, 6501.804945851632, 6503.122078519528, 6583.473322134122, 6524.412802847766, 6609.735610575523, 6616.966915165393, 6645.401913827779, 6667.799966001027, 6846.041554182319, 6859.4512439003765, 6863.862722745417, 6864.4165245954655, 6875.931240687529, 6563.474922006323, 6622.271550129578, 6625.469962403093, 6639.502037347122, 6644.534882558368, 6532.0, 6532.05285233648, 6615.272320044887, 6636.27001029896, 6646.003099535108, 6460.35396460369, 6460.870782584416, 6556.0493728410065, 6556.541042127005, 6557.9344206557325, 6401.327860574759, 6465.612063276219, 6530.314316996837, 6532.902006469812, 6553.737850485927, 5916.792912248051, 6318.0, 6373.075903993802, 6397.136386587751, 6430.164078669743], "value": 6127.4204603123635, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.3510009542413, 859.1709000814215, 885.7962668586225, 889.3063410539777, 1168.7779321928826, 30298.69701302986, 41555.79222103893, 41565.0, 41587.584124158784, 41788.37317440237, 40580.0, 41013.58986410135, 41468.17063658725, 41656.79171604138, 41678.37482437766, 7286.67209975551, 7878.212178782133, 7884.172161923001, 7884.211578842127, 7892.368610511174, 7765.767026989171, 7871.448998570102, 7872.645730942121, 7873.291403773659, 7874.251946065115, 7793.8051548711455, 7849.0973538043, 7861.292483676468, 7899.960500197491, 7903.802404939865, 7733.8839917401, 7769.067711874554, 7799.259070388304, 7842.333401660837, 7868.52788832669, 7726.227377262285, 7772.261635144652, 7773.883391749072, 7780.260875216845, 7788.883166752503, 36565.45151822698, 36753.081172970626, 36754.81622591897, 36762.26475470502, 36951.26097478035, 3636.563612366533, 3650.7809531427934, 3653.872114476007, 3663.249033948061, 3677.988553147879, 30724.385512289853, 30840.53739193914, 30851.691483085106, 30924.690753092407, 31006.224844378845, 5070.847874563769, 5084.084864724348, 5088.287639730441, 5093.821716239914, 5137.38351397831, 191221.0, 191670.0, 191769.0, 191871.0, 192921.0, 48247.75876120597, 48248.5175148244, 48254.75872620614, 48518.75740621345, 48550.0, 50505.494945050814, 51011.23483147756, 51040.48959510357, 51093.23360149601, 51162.232566511535, 14111.364988575539, 14454.060486068372, 15207.391704331703, 15567.844321556866, 15614.609634758996, 11982.161248712506, 12357.25856448616, 12385.380730963416, 12388.62834114978, 12395.256284622772, 14274.500392486214, 14452.132872027712, 14593.92703036478, 14605.269736513132, 14733.336999835034, 5919.556033297434, 6046.486048685911, 6061.54538409621, 6078.635281883101, 6198.2252218472695, 988.9109980101825, 1001.2790790630734, 1021.6577446555488, 1026.373911913732, 1031.28841099641, 22248.555028899656, 22459.213927512457, 22685.773142268365, 23063.077476900737, 28378.574321385197, 1079.7786453776957, 1083.7290677330668, 1085.8968398002178, 1099.406320586874, 1105.9225854190129, 12007.819882701766, 12388.504459821506, 12416.192947458387, 12496.562620308245, 12569.120161588784, 234352.0, 236441.0, 236975.0, 237243.0, 238094.0, 51459.228111578355, 51727.74136129295, 51822.74088629608, 52087.21869171965, 52167.0, 1448.3453123765828, 1449.702810923758, 1470.9117452952644, 1481.8221813382463, 1488.7692407676827, 20450.386488405373, 20765.584688305848, 20957.476063098544, 21155.153793848072, 21666.133354665635, 37243.25513489661, 37468.81265593655, 37476.0, 37565.62434375731, 37832.62167378291, 222182.0, 224036.0, 225100.0, 225126.0, 225887.0, 28789.56815647809, 29448.411031778815, 31335.0, 31416.52875206828, 32258.83870580726, 41933.79033104815, 42306.78846605747, 42456.575434245264, 42538.0, 43040.35439468473, 30844.38311233718, 31483.0, 31716.841415792773, 31724.682753172172, 31871.840640796647, 30929.381412372077, 31004.84497577588, 31722.36555268928, 31857.522137167496, 32044.19889502781, 34174.316513670085, 34244.31511369808, 34371.14072148217, 34425.0, 37184.6281537192, 32687.0, 33031.66968330382, 33244.66755332416, 33590.160245993065, 34080.48879266863, 22819.20132795344, 24193.758062419856, 24442.51114977726, 24515.0, 24874.25377238686], "value": 17143.204212008186, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.4477134793574, 574.8534123798431, 579.9391063938289, 588.7703795519747, 593.2376895689039, 21896.124155033798, 22411.32766017018, 22882.970266338012, 22972.425689357773, 22986.310410687664, 24379.146729864457, 26000.869995650042, 26321.47357052858, 26339.60490592638, 26466.867665661644, 6294.7482100715915, 6459.612423254596, 6465.3857883501, 6475.676216189196, 6494.285628580852, 6260.092286618437, 6285.6857157142185, 6335.081413195084, 6554.737810487575, 6888.138982627172, 6836.282190370014, 6877.862442751142, 6884.827879303008, 6898.206706228798, 6901.551399159063, 6880.793576192722, 6883.070785443976, 6889.7588584399555, 6893.517453778238, 6899.068625735512, 6786.185657721105, 6789.083473731032, 6799.354061364163, 6805.149356330458, 6805.455563554904, 31406.842965785254, 31995.520067198777, 32457.350852983043, 32644.347113057607, 32702.345953080807, 1986.4140078676826, 2019.7475315585552, 2029.6143732690741, 2031.1266155553105, 2032.1972820735875, 20132.698009529868, 20697.793022069887, 20942.895285523628, 21096.789032109635, 21101.788982110134, 2476.8018558515278, 2526.2673824590847, 2551.413174969767, 2580.9483810323877, 2582.7029891562333, 141862.0, 144776.27611861977, 145849.99999999895, 145896.27051864672, 146268.0, 19682.50793730168, 22065.669014964467, 22329.0, 23125.88437057804, 23317.417064573183, 43867.78066109649, 43928.56071439308, 44002.11995760067, 44177.77911110424, 44219.0, 11287.097032237401, 11327.546898123983, 11358.886411135949, 11522.596709115309, 11552.76894462106, 9325.347225694137, 9372.0, 9391.859122113174, 9444.433333999981, 9535.189508891683, 9649.951750241344, 11132.443377831076, 11476.827847582294, 11500.0, 11777.0, 3690.4755958059986, 3850.4609354690365, 4063.878083657495, 4175.561566035522, 4191.7484950903045, 928.3501548915785, 952.4904176265665, 954.0983770336965, 959.712086374085, 964.1948972607951, 18938.0, 19521.804781952284, 19620.509487262934, 19748.30880919161, 19971.301004464774, 1001.5543083327995, 1010.2625083688802, 1016.192127258831, 1019.1235537437798, 1027.9331843430152, 10629.362238265729, 10918.344899306067, 11207.66377008691, 13043.804342934864, 14338.856611433752, 512124.0, 515814.0, 520350.0, 520950.0, 525091.0, 116023.41988290005, 119411.40294298646, 119882.4005879965, 120224.39887800506, 120451.0, 1256.2085885892013, 1259.7354555543254, 1279.9232046077266, 1291.7803973324558, 1293.6183825771232, 20725.0673719686, 20853.0, 20901.581968360853, 20969.790302096782, 21472.03375848122, 55736.72131639316, 56826.7158664204, 56934.430655692915, 57338.0, 58575.414245857, 70301.0, 70486.64756676184, 70504.0, 70888.0, 71648.28351716416, 14935.103893766409, 15089.0, 15256.237188140327, 15364.0, 15374.769378459556, 24045.639315410634, 24278.757212428358, 24299.271021869372, 24331.148409805573, 24499.510009800062, 16962.49112526626, 17063.573410664834, 17075.231614577126, 17250.741238881677, 17354.479365619052, 16167.75748363799, 16542.42101526441, 16738.497845064667, 16983.745243821104, 17469.737953930955, 16599.50201493957, 17485.65028699444, 17487.125643718016, 17499.56251093733, 17512.474625761246, 14953.925230373778, 15006.774898376314, 15031.323590438238, 15048.247587620794, 15064.322105505498, 15916.681666366376, 16850.74723879167, 16981.575460613585, 17284.481465556055, 17428.128593570018], "value": 12814.435312687667, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.52588830965, 1376.3806287170776, 1405.1779708870313, 1415.8017877497145, 1420.9289535523221, 13355.799663005051, 13952.093113947587, 14059.0, 14059.086159399645, 14070.437182512687, 14520.346584403727, 14887.776683349759, 14904.925475372607, 14934.402623895032, 14938.327775250113, 2242.6187548116777, 2611.2688447234805, 2627.159309021114, 2641.7490338417915, 2662.1081937550944, 2258.322503249027, 2607.556715358394, 2682.0, 2683.9060632877854, 2687.4625074984983, 2588.4693637804203, 2611.229687242268, 2642.445086531831, 2656.9601455978177, 2659.2022393282036, 2617.254082586463, 2620.9606855897177, 2636.0773729194725, 2640.485105404447, 2645.603159526077, 2480.231128350217, 2501.1746123779108, 2568.7559681830385, 2575.3947822261753, 2590.8704564771874, 13525.45898164082, 13928.0, 13949.930250348785, 13955.651108722363, 13966.231857247847, 7324.230955749623, 7612.048493938258, 7614.543127412373, 7618.961905190494, 7632.656530456143, 4823.831165909211, 4962.627802914796, 5045.84862454127, 5060.519250671217, 5071.315372424712, 1824.2429391802386, 1852.3331600623765, 1894.526368407898, 1917.8178073083034, 1926.6532024235632, 22488.775112248833, 22883.656745149, 22906.198283060014, 22932.426689332733, 23123.0, 6661.9000714989315, 6837.658117094125, 7061.234691327169, 7062.081929349254, 7122.715091396286, 15799.21003949821, 15946.840531594768, 15998.600034999217, 16014.439494617633, 16109.516714498584, 6996.860062798817, 7377.889331659922, 7478.738244161428, 7515.323620874038, 7525.0969883613225, 5440.401555828856, 5657.6322539035655, 6960.303969602999, 6962.094927659372, 6964.756233531802, 4651.37206477128, 5078.619103567247, 5215.217717342353, 5242.18746094356, 5242.947570524246, 1428.6428392901776, 1435.626737048354, 1462.8610282023192, 1475.0780762023735, 1479.9260036998323, 888.706726780161, 912.3066469483108, 914.6661468564059, 919.9770005749776, 922.686286662538, 7217.963910180415, 7224.277572242734, 7234.023406840114, 7236.276372362721, 7400.259974002557, 724.8767709489399, 976.345848281653, 1012.6455740490917, 1014.1379827146866, 1021.2799976017038, 4993.226049962189, 5084.491550844886, 5161.66449180802, 5209.218617207449, 5287.312649355559, 18486.537836553925, 19408.611827763365, 19461.805381946284, 19486.610267794564, 19520.219191232474, 18605.0, 18990.0, 19219.0, 19291.90354048249, 19303.613927721646, 10608.522616482123, 10672.946635266619, 10832.512536935857, 10862.076723478434, 10873.347599144077, 7828.099768526692, 7859.60701964888, 7935.880961785693, 8053.154418786177, 8064.5967701615855, 16648.417305394254, 16759.664806703553, 16905.66188676195, 17293.740593891354, 17296.308147674456, 16941.407050753165, 16958.660826783642, 17121.74317385265, 17365.82634173642, 17602.38391656286, 10183.236257280585, 10473.214508912015, 10481.580736770444, 10564.630237941636, 10619.469026548797, 12584.685382865135, 12934.159279646792, 13082.345882706017, 13089.476420943056, 13098.21410715322, 10455.059044686015, 10486.842697359698, 10547.419891906018, 10637.14902807789, 10829.67510974672, 10378.0, 10569.735756606146, 10584.629537966443, 10661.360318380923, 10681.19891008193, 9458.95270523643, 9692.64302997595, 9705.6117755289, 9721.854172187564, 9762.46306453152, 6564.6389448580785, 6581.901271481028, 6620.404163625297, 7030.50786444944, 7108.147022357143, 6717.798466046026, 6749.156355455568, 6810.114685090906, 6823.738386771671, 6840.486963477859], "value": 6297.582188159663, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.7026172322138, 498.336391984841, 514.295415281065, 520.7578476008655, 521.1661341853036, 6192.164057852188, 6210.9068363974575, 6255.562110652256, 6283.937160628392, 6293.622382657044, 5815.47660710536, 5956.16613674086, 6015.909761353583, 6037.275526936763, 6090.604110732799, 4841.201201801716, 4924.606031517488, 4946.530079642428, 4952.851414457572, 4972.154733695263, 4854.417469903598, 4875.24433712775, 4933.679310844784, 4946.109700253953, 4953.801847926079, 4687.460941991663, 4892.877678058059, 4898.877528061809, 4913.901721965559, 4923.876903077434, 4834.323194752737, 4889.0, 4913.975430122862, 4921.548143297736, 4964.106460837048, 4441.600255976945, 4444.466664000308, 4449.132419178261, 4467.3299005149165, 4499.572540608637, 6007.849803754941, 6033.366496517846, 6057.757689692407, 6062.1808260795415, 6095.908561371539, 5642.858928526779, 5655.293088363955, 5692.203091567184, 5692.829215123553, 5694.971525142348, 6417.588130611258, 6459.35406459355, 6466.932956062244, 6485.772997945097, 6494.415502604788, 4783.425988881357, 4847.854564363075, 4850.781714822806, 4855.63582731293, 4872.634552408548, 6733.259341472434, 6775.932240677629, 6824.488163387716, 6897.2757860424435, 6905.1713794345, 4913.950860491349, 4934.580560652313, 4961.7519124044375, 5016.372953380827, 5031.245313203049, 5013.323201367769, 5024.84925452237, 5025.447200807908, 5045.192769156991, 5074.797008119708, 5615.837902407602, 5640.182173584807, 5645.1532270159805, 5687.544996400278, 5693.430656934273, 6488.28628850826, 6556.672166391661, 6577.506686998494, 6586.057113151632, 6607.14107166075, 1664.5755332390406, 1719.217755921053, 1745.5287072490357, 1748.4055421156868, 1762.101328322539, 1149.7298134938283, 1172.5778719660916, 1403.0669604712753, 1422.3599380278915, 1431.0269017068285, 5628.465295796893, 5663.6035477517, 5669.744861481243, 5687.459691329317, 5706.885862282814, 6553.574017688835, 6584.736610535525, 6619.735210591522, 6628.270890202074, 6632.336766323426, 5506.972465137729, 5633.014222511044, 5667.659940403589, 5677.091665333527, 5784.88430231393, 3508.3158784037378, 3512.2799826035603, 3520.697341983431, 3559.4126969049817, 3562.8040457775073, 6345.192884269493, 6410.391012853772, 6441.840468715676, 6454.32229615893, 6472.35276472349, 6786.151731033621, 6843.247242803288, 6847.965760171267, 6855.417289530346, 6889.793306200822, 6403.199600049994, 6422.165118534561, 6437.2918978912285, 6489.7404103835315, 6536.869262614721, 6473.902891456726, 6564.212294524687, 6583.868322633616, 6599.175103112111, 6616.90074648871, 6468.870622587616, 6538.803835884931, 6581.638009909501, 6609.173853268341, 6629.0, 6437.67811609427, 6455.806325810233, 6468.8059358219325, 6494.967525162344, 6507.9674601628585, 4956.942868709445, 4987.775550100327, 4988.301637770787, 4997.550220480174, 5005.822467226768, 6576.2766095728475, 6677.0, 6719.65606878636, 6732.966335168293, 6741.157355330583, 6444.645544495098, 6477.4494167996245, 6496.415322620986, 6503.544751867324, 6557.377049180321, 6478.28738838718, 6480.12518310041, 6495.350464953656, 6524.706388212447, 6534.411902928759, 6101.176341193882, 6359.427651511386, 6371.171747672773, 6407.839804004937, 6429.871402571829, 6265.74937002533, 6400.583962042452, 6416.518761092843, 6449.161608990801, 6519.5436319457185, 6177.6293422393, 6214.2853571838, 6264.530160238091, 6295.244570651368, 6342.39747224013], "value": 5014.961804662485, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [898.752842968184, 914.7164379042496, 919.439142123305, 927.2442958988424, 937.4047479850293, 18916.71624925627, 19749.21003159872, 19769.11039003245, 19820.603587928268, 19865.40403787887, 15580.454684086058, 15816.0, 16146.354145834182, 16212.675746485063, 21352.145914163455, 1029.0892560084342, 1052.3212527919488, 1055.8996895294972, 1056.5351245452016, 1057.318029870733, 1049.2130901823632, 1054.3884546962781, 1055.1347894726327, 1061.2995423020807, 1061.4162210784077, 1008.7478130467383, 1114.7658991611772, 1121.8317252412162, 1126.2060247525476, 1128.7968165730165, 1107.7009207514006, 1111.9666410007712, 1114.9275297105703, 1116.107114308554, 1119.8544189255385, 798.0662624729023, 798.1061211443163, 798.4371018431991, 803.3934379543466, 806.4838503357855, 19415.3204637837, 19694.70457943132, 19894.60210795776, 19947.401577952685, 20223.0, 21436.249731259486, 22239.332820015425, 22267.77732222673, 22770.886145569333, 22779.77220227793, 15839.841601584067, 16091.195440227943, 16235.0, 16284.0, 16318.184090795412, 3655.5613326400735, 3707.0361705956375, 3710.2950439416422, 3710.9443358349645, 3722.3671975764187, 124939.3753031229, 126857.0, 126908.0, 130231.34884325613, 133191.6680833189, 16294.592635184215, 17026.063566503715, 17030.06334651606, 17048.65902681964, 17104.14479276031, 30478.695213048028, 31038.0, 31629.841850791057, 31671.20821979469, 32011.51982720261, 8820.647174112964, 9015.504147271962, 9020.909790902138, 9022.503762293138, 9024.909750902538, 4133.937990930139, 4165.271077561475, 4174.707770456039, 4223.915521689549, 4269.807858646368, 5227.712475813791, 5340.75966581497, 5362.785488580413, 5395.05586522357, 5437.13005919051, 945.3240932733129, 980.6469670918464, 983.4246965525105, 990.5889056041661, 995.8456439251928, 681.7477533312607, 704.264044073944, 710.3642240194996, 712.7790384980673, 715.8617797701679, 11008.669739907815, 11724.179307448398, 11831.940840295743, 12664.430100645493, 14135.78796318056, 700.1283402164237, 708.9432845372357, 712.4478529139958, 714.58196954781, 723.08529709917, 5420.91868621971, 5555.611107222537, 5734.684592347461, 5884.0585506318785, 5924.407559244128, 101596.0, 102229.48885255527, 103597.48201259096, 104347.4782626082, 107104.0, 89203.0, 91733.54133229425, 92312.0, 97255.51372243093, 97627.0, 85740.57129714312, 88056.55971720228, 88954.55522722345, 90217.54891225502, 92599.0, 13021.218726876417, 13212.207267563977, 13371.465141394625, 13379.665508362368, 13437.529686461317, 37244.0, 37608.0, 37938.0, 38225.0, 39674.801625991684, 48311.5168848307, 49842.50157498524, 50566.49433505618, 51052.0, 52015.73992130015, 18467.0, 18484.81515184885, 18972.146253418905, 19153.904230478758, 19245.03774811282, 21320.466988325417, 21411.8929405352, 21497.892510537346, 21572.0, 21596.67604985895, 19128.71306930425, 19372.709409358587, 19410.320638777575, 19539.51151221231, 19633.410997670093, 19163.233470661016, 19221.32725354606, 19425.708614370513, 19486.0, 19714.21143154258, 18135.546611334823, 18562.721559176895, 18614.0, 18635.0, 18786.0, 12387.19483233587, 12399.504019839105, 12664.556740514037, 12730.618081457571, 12773.105882588501, 12766.61700148997, 13007.284599347127, 13394.93302533481, 14250.786238206229, 14890.478833240784], "value": 9176.227693954816, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 112.0, 103.0, 108.0, 107.0, 110.0, 113.0, 98.0, 108.0, 108.0], "value": 107.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 116.0, 147.0, 167.0, 117.0, 146.0, 151.0, 121.0, 172.0, 120.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 163.0, 164.0, 168.0, 172.0, 163.0, 165.0, 166.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 183.0, 82.0, 74.0, 82.0, 74.0, 160.0, 75.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 132.0, 78.0, 78.0, 78.0, 122.0, 81.0, 80.0, 139.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 119.0, 114.0, 119.0, 114.0, 116.0, 114.0, 118.0, 114.0, 117.0], "value": 115.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 155.0, 150.0, 150.0, 151.0, 150.0, 152.0, 152.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 96.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 97.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 59.0, 54.0, 60.0, 57.0, 54.0, 56.0, 55.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 60.0, 54.0, 62.0, 55.0, 54.0, 55.0, 60.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 88.0, 90.0, 78.0, 79.0, 83.0, 86.0, 85.0, 78.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 136.0, 127.0, 142.0, 137.0, 128.0, 142.0, 129.0, 125.0, 172.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 181.0, 190.0, 180.0, 182.0, 186.0, 177.0, 185.0, 184.0, 178.0], "value": 184.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 65.0, 67.0, 66.0, 66.0, 67.0, 65.0, 67.0, 64.0], "value": 66.3, "unit": "score"}]}]} 18:40:24 INFO - Return code: 0 18:40:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:40:24 INFO - # TBPL SUCCESS # 18:40:24 INFO - Running post-action listener: _package_coverage_data 18:40:24 INFO - Running post-action listener: _resource_record_post_action 18:40:24 INFO - [mozharness: 2017-08-11 01:40:24.250501Z] Finished run-tests step (success) 18:40:24 INFO - Running post-run listener: _resource_record_post_run 18:40:24 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 5292032; Write bytes: 442249216; Read time: 2296; Write time: 441112 18:40:24 INFO - TinderboxPrint: CPU usage
13.2% 18:40:24 INFO - TinderboxPrint: I/O read bytes / time
5,292,032 / 2,296 18:40:24 INFO - TinderboxPrint: I/O write bytes / time
442,249,216 / 441,112 18:40:24 INFO - TinderboxPrint: CPU idle
8,274.9 (86.8%) 18:40:24 INFO - TinderboxPrint: CPU user
1,205.2 (12.6%) 18:40:24 INFO - TinderboxPrint: Swap in / out
0 / 0 18:40:24 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 119697408; Read time: 0; Write time: 133164 18:40:24 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:40:24 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 3055616; Write bytes: 322551808; Read time: 2128; Write time: 307948 18:40:24 INFO - Running post-run listener: _upload_blobber_files 18:40:24 INFO - Blob upload gear active. 18:40:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:40:24 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:40:24 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:40:24 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:40:25 INFO - (blobuploader) - INFO - Open directory for files ... 18:40:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:40:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:40:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:40:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:40:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:40:26 INFO - (blobuploader) - INFO - Done attempting. 18:40:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:40:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:40:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:40:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:40:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:40:33 INFO - (blobuploader) - INFO - Done attempting. 18:40:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:40:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:40:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:40:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:40:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:40:34 INFO - (blobuploader) - INFO - Done attempting. 18:40:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:40:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:40:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:40:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:40:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:40:35 INFO - (blobuploader) - INFO - Done attempting. 18:40:35 INFO - (blobuploader) - INFO - Iteration through files over. 18:40:35 INFO - Return code: 0 18:40:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:40:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:40:35 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93518aabe1ee97549637bd4f21ebc9f954170079c4cad9ae530fef9b5b2761c6a87414715651a1f3833e4a5d1d799bcf35faf72fc5d3bb42ae972f19fc8ed645", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f969b1cb63af87e6e910c35439d2f5b6492a6971e011145df5c486848402fc75d9c34321b237cd68c554bc85d7d924973f9d726856fa7ddfe7a35eff685735ba", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6d30cf8844729a1a2515be5e40a4dd999aad2c79089b712b23ff434c88e55a11cff726a986b2f4dea7a66306ffcfaf7f4a36859193a850da2e5a8bf5a961dd9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26f95ed934c7bbc4949e2776d3c804664c341c57b6319fad3e2461ed93cdbd8afc2a929bd63492e42a28401de914ba8e1c5180bd067b87cc330ba2f364e037a7"} 18:40:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:40:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:40:35 INFO - Contents: 18:40:35 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93518aabe1ee97549637bd4f21ebc9f954170079c4cad9ae530fef9b5b2761c6a87414715651a1f3833e4a5d1d799bcf35faf72fc5d3bb42ae972f19fc8ed645", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f969b1cb63af87e6e910c35439d2f5b6492a6971e011145df5c486848402fc75d9c34321b237cd68c554bc85d7d924973f9d726856fa7ddfe7a35eff685735ba", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6d30cf8844729a1a2515be5e40a4dd999aad2c79089b712b23ff434c88e55a11cff726a986b2f4dea7a66306ffcfaf7f4a36859193a850da2e5a8bf5a961dd9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26f95ed934c7bbc4949e2776d3c804664c341c57b6319fad3e2461ed93cdbd8afc2a929bd63492e42a28401de914ba8e1c5180bd067b87cc330ba2f364e037a7"} 18:40:35 INFO - Running post-run listener: copy_logs_to_upload_dir 18:40:35 INFO - Copying logs to upload dir... 18:40:35 INFO - mkdir: /builds/slave/test/build/upload/logs 18:40:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.383416 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-10 18:40:35.194930) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-10 18:40:35.198306) ========= 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=0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308 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/93518aabe1ee97549637bd4f21ebc9f954170079c4cad9ae530fef9b5b2761c6a87414715651a1f3833e4a5d1d799bcf35faf72fc5d3bb42ae972f19fc8ed645", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f969b1cb63af87e6e910c35439d2f5b6492a6971e011145df5c486848402fc75d9c34321b237cd68c554bc85d7d924973f9d726856fa7ddfe7a35eff685735ba", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6d30cf8844729a1a2515be5e40a4dd999aad2c79089b712b23ff434c88e55a11cff726a986b2f4dea7a66306ffcfaf7f4a36859193a850da2e5a8bf5a961dd9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26f95ed934c7bbc4949e2776d3c804664c341c57b6319fad3e2461ed93cdbd8afc2a929bd63492e42a28401de914ba8e1c5180bd067b87cc330ba2f364e037a7"} build_url:https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/dTnd9BLdQ-u7ChXvVPHXNw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93518aabe1ee97549637bd4f21ebc9f954170079c4cad9ae530fef9b5b2761c6a87414715651a1f3833e4a5d1d799bcf35faf72fc5d3bb42ae972f19fc8ed645", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f969b1cb63af87e6e910c35439d2f5b6492a6971e011145df5c486848402fc75d9c34321b237cd68c554bc85d7d924973f9d726856fa7ddfe7a35eff685735ba", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6d30cf8844729a1a2515be5e40a4dd999aad2c79089b712b23ff434c88e55a11cff726a986b2f4dea7a66306ffcfaf7f4a36859193a850da2e5a8bf5a961dd9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26f95ed934c7bbc4949e2776d3c804664c341c57b6319fad3e2461ed93cdbd8afc2a929bd63492e42a28401de914ba8e1c5180bd067b87cc330ba2f364e037a7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-10 18:40:35.223297) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 18:40:35.223581) ========= 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=0e2a256762fed810e2f0f810000001b3-1502413759.28892-1347146308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004305 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 18:40:35.304718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-10 18:40:35.307046) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-10 18:40:35.307337) ========= ========= Total master_lag: 0.21 =========