builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1500340289.74 results: success (0) revision: 5e73b9798464c3f7106f0161dc9a49b234f42f9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-17 18:11:29.737839) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-17 18:11:29.738229) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 18:11:29.739431) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 18:11:29.762012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 18:11:29.762282) ========= 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=d2a8c569965ab8367867b893000001a1-1500339494.74252-244863601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-17 18:11:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-07-17 18:11:30 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.403882 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 18:11:30.179355) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 18:11:30.179665) ========= 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=d2a8c569965ab8367867b893000001a1-1500339494.74252-244863601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022911 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 18:11:30.230096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-17 18:11:30.230382) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5e73b9798464c3f7106f0161dc9a49b234f42f9c --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 5e73b9798464c3f7106f0161dc9a49b234f42f9c --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=d2a8c569965ab8367867b893000001a1-1500339494.74252-244863601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-17 18:11:30,659 truncating revision to first 12 chars 2017-07-17 18:11:30,659 Setting DEBUG logging. 2017-07-17 18:11:30,659 attempt 1/10 2017-07-17 18:11:30,659 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5e73b9798464?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-17 18:11:31,782 unpacking tar archive at: mozilla-central-5e73b9798464/testing/mozharness/ program finished with exit code 0 elapsedTime=1.479278 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-17 18:11:31.722179) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 18:11:31.722467) ========= script_repo_revision: 5e73b9798464c3f7106f0161dc9a49b234f42f9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 18:11:31.722847) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 18:11:31.723106) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 18:11:31.735962) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-07-17 18:11:31.736221) ========= /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=d2a8c569965ab8367867b893000001a1-1500339494.74252-244863601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:11:32 INFO - MultiFileLogger online at 20170717 18:11:32 in /builds/slave/test 18:11:32 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:11:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:11:32 INFO - {'append_to_log': False, 18:11:32 INFO - 'base_work_dir': '/builds/slave/test', 18:11:32 INFO - 'blob_upload_branch': 'Firefox', 18:11:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:11:32 INFO - 'branch': 'Firefox', 18:11:32 INFO - 'buildbot_json_path': 'buildprops.json', 18:11:32 INFO - 'code_coverage': False, 18:11:32 INFO - 'config_files': ('talos/linux_config.py',), 18:11:32 INFO - 'default_actions': ('clobber', 18:11:32 INFO - 'read-buildbot-config', 18:11:32 INFO - 'download-and-extract', 18:11:32 INFO - 'populate-webroot', 18:11:32 INFO - 'create-virtualenv', 18:11:32 INFO - 'install', 18:11:32 INFO - 'setup-mitmproxy', 18:11:32 INFO - 'run-tests'), 18:11:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:11:32 INFO - 'disable_ccov_upload': False, 18:11:32 INFO - 'download_minidump_stackwalk': True, 18:11:32 INFO - 'download_symbols': 'ondemand', 18:11:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:11:32 INFO - 'tooltool.py': '/tools/tooltool.py', 18:11:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:11:32 INFO - '/tools/misc-python/virtualenv.py')}, 18:11:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:11:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:11:32 INFO - 'gecko_profile': False, 18:11:32 INFO - 'gecko_profile_interval': 0, 18:11:32 INFO - 'installer_path': 'installer.exe', 18:11:32 INFO - 'log_level': 'info', 18:11:32 INFO - 'log_name': 'talos', 18:11:32 INFO - 'log_to_console': True, 18:11:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:11:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:11:32 INFO - 'opt_config_files': (), 18:11:32 INFO - 'pip_index': False, 18:11:32 INFO - 'suite': 'dromaeojs-e10s', 18:11:32 INFO - 'system_bits': '32', 18:11:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:11:32 INFO - 'title': 'talos-linux64-ix-043', 18:11:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:11:32 INFO - 'use_talos_json': True, 18:11:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:11:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:11:32 INFO - 'work_dir': 'build'} 18:11:32 INFO - [mozharness: 2017-07-18 01:11:32.279050Z] Running clobber step. 18:11:32 INFO - Running pre-action listener: _resource_record_pre_action 18:11:32 INFO - Running main action method: clobber 18:11:32 INFO - rmtree: /builds/slave/test/build 18:11:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:11:33 INFO - Running post-action listener: _resource_record_post_action 18:11:33 INFO - [mozharness: 2017-07-18 01:11:33.309535Z] Finished clobber step (success) 18:11:33 INFO - [mozharness: 2017-07-18 01:11:33.309638Z] Running read-buildbot-config step. 18:11:33 INFO - Running pre-action listener: _resource_record_pre_action 18:11:33 INFO - Running main action method: read_buildbot_config 18:11:33 INFO - Using buildbot properties: 18:11:33 INFO - { 18:11:33 INFO - "project": "", 18:11:33 INFO - "product": "firefox", 18:11:33 INFO - "who": "kwierso@gmail.com", 18:11:33 INFO - "installer_path": "public/build/target.tar.bz2", 18:11:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 18:11:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:11:33 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 18:11:33 INFO - "stage_platform": "linux64-stylo", 18:11:33 INFO - "basedir": "/builds/slave/test", 18:11:33 INFO - "buildnumber": 217, 18:11:33 INFO - "platform": "ubuntu64_hw_stylo", 18:11:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:11:33 INFO - "slavebuilddir": "test", 18:11:33 INFO - "taskId": "CX3rpPaQSCKfhAOhbVeBYQ", 18:11:33 INFO - "branch": "mozilla-central", 18:11:33 INFO - "script_repo_revision": "production", 18:11:33 INFO - "revision": "5e73b9798464c3f7106f0161dc9a49b234f42f9c", 18:11:33 INFO - "slavename": "talos-linux64-ix-043", 18:11:33 INFO - "repo_path": "mozilla-central" 18:11:33 INFO - } 18:11:33 INFO - Finding installer, test and symbols from parent task. 18:11:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CX3rpPaQSCKfhAOhbVeBYQ'}, attempt #1 18:11:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CX3rpPaQSCKfhAOhbVeBYQ'}, attempt #1 18:11:34 INFO - Task dependencies: e_KBwBrBSNuUWab6NjyQ4Q 18:11:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q'}, attempt #1 18:11:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.tar.bz2 18:11:34 INFO - Set test_url: https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/test_packages.json 18:11:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.crashreporter-symbols.zip 18:11:34 INFO - Running post-action listener: _resource_record_post_action 18:11:34 INFO - [mozharness: 2017-07-18 01:11:34.689146Z] Finished read-buildbot-config step (success) 18:11:34 INFO - [mozharness: 2017-07-18 01:11:34.689368Z] Running download-and-extract step. 18:11:34 INFO - Running pre-action listener: _resource_record_pre_action 18:11:34 INFO - Running main action method: download_and_extract 18:11:34 INFO - mkdir: /builds/slave/test/build/tests 18:11:34 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:11:34 INFO - trying https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.test_packages.json 18:11:34 INFO - Downloading https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:11:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:11:35 INFO - Downloaded 989 bytes. 18:11:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:11:35 INFO - Using the following test package requirements: 18:11:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:11:35 INFO - u'common': [u'target.common.tests.zip'], 18:11:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:11:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:11:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:11:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:11:35 INFO - u'mozbase': [u'target.common.tests.zip'], 18:11:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:11:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:11:35 INFO - u'web-platform': [u'target.common.tests.zip', 18:11:35 INFO - u'target.web-platform.tests.tar.gz'], 18:11:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:11:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:11:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.common.tests.zip 18:11:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:11:35 INFO - Fetch https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.common.tests.zip into memory 18:11:37 INFO - Content-Length response header: 72769394 18:11:37 INFO - Bytes received: 72769394 18:11:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:11:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.common.tests.zip 18:11:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:11:48 INFO - Fetch https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.common.tests.zip into memory 18:11:50 INFO - Content-Length response header: 72769394 18:11:50 INFO - Bytes received: 72769394 18:12:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.talos.tests.zip 18:12:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:12:03 INFO - Fetch https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.talos.tests.zip into memory 18:12:03 INFO - Content-Length response header: 14495033 18:12:03 INFO - Bytes received: 14495033 18:12:04 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:12:04 INFO - trying https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.tar.bz2 18:12:04 INFO - Downloading https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:12:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:12:05 INFO - Downloaded 61925351 bytes. 18:12:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.tar.bz2 18:12:05 INFO - mkdir: /builds/slave/test/properties 18:12:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:12:05 INFO - Writing to file /builds/slave/test/properties/build_url 18:12:05 INFO - Contents: 18:12:05 INFO - build_url:https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.tar.bz2 18:12:05 INFO - Running post-action listener: _resource_record_post_action 18:12:05 INFO - Running post-action listener: set_extra_try_arguments 18:12:05 INFO - [mozharness: 2017-07-18 01:12:05.517809Z] Finished download-and-extract step (success) 18:12:05 INFO - [mozharness: 2017-07-18 01:12:05.517907Z] Running populate-webroot step. 18:12:05 INFO - Running pre-action listener: _resource_record_pre_action 18:12:05 INFO - Running main action method: populate_webroot 18:12:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:12:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:12:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:12:05 INFO - '--tppagecycles', 18:12:05 INFO - '7'], 18:12:05 INFO - 'tests': ['tsvgm']}}, 18:12:05 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:12:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:12:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:12:05 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:12:05 INFO - 'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:12:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:12:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:12:05 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:12:05 INFO - 'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['damp', 'tps']}, 18:12:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:12:05 INFO - 'tests': ['damp', 'tps']}, 18:12:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['dromaeo_dom']}, 18:12:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:12:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:12:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:12:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:12:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:12:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['a11yr', 18:12:05 INFO - 'ts_paint', 18:12:05 INFO - 'tpaint', 18:12:05 INFO - 'sessionrestore', 18:12:05 INFO - 'sessionrestore_no_auto_restore', 18:12:05 INFO - 'tabpaint']}, 18:12:05 INFO - 'other-e10s': {'tests': ['a11yr', 18:12:05 INFO - 'ts_paint', 18:12:05 INFO - 'tpaint', 18:12:05 INFO - 'sessionrestore', 18:12:05 INFO - 'sessionrestore_many_windows', 18:12:05 INFO - 'sessionrestore_no_auto_restore', 18:12:05 INFO - 'tabpaint']}, 18:12:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:12:05 INFO - 'ts_paint', 18:12:05 INFO - 'tpaint', 18:12:05 INFO - 'sessionrestore', 18:12:05 INFO - 'sessionrestore_many_windows', 18:12:05 INFO - 'sessionrestore_no_auto_restore', 18:12:05 INFO - 'tabpaint']}, 18:12:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:12:05 INFO - 'ts_paint', 18:12:05 INFO - 'tpaint', 18:12:05 INFO - 'sessionrestore', 18:12:05 INFO - 'sessionrestore_many_windows', 18:12:05 INFO - 'sessionrestore_no_auto_restore', 18:12:05 INFO - 'tabpaint']}, 18:12:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['a11yr', 18:12:05 INFO - 'ts_paint', 18:12:05 INFO - 'tpaint', 18:12:05 INFO - 'sessionrestore', 18:12:05 INFO - 'sessionrestore_no_auto_restore', 18:12:05 INFO - 'tabpaint']}, 18:12:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['a11yr', 18:12:05 INFO - 'ts_paint', 18:12:05 INFO - 'tpaint', 18:12:05 INFO - 'sessionrestore', 18:12:05 INFO - 'sessionrestore_no_auto_restore', 18:12:05 INFO - 'tabpaint']}, 18:12:05 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 18:12:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:12:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:12:05 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:12:05 INFO - 'talos_options': ['--mitmproxy', 18:12:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:12:05 INFO - '--firstNonBlankPaint'], 18:12:05 INFO - 'tests': ['quantum_pageload_google', 18:12:05 INFO - 'quantum_pageload_youtube', 18:12:05 INFO - 'quantum_pageload_amazon', 18:12:05 INFO - 'quantum_pageload_facebook']}, 18:12:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['tsvgx', 18:12:05 INFO - 'tsvgr_opacity', 18:12:05 INFO - 'tart', 18:12:05 INFO - 'tscrollx', 18:12:05 INFO - 'cart', 18:12:05 INFO - 'tsvg_static']}, 18:12:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:12:05 INFO - 'tsvgr_opacity', 18:12:05 INFO - 'tart', 18:12:05 INFO - 'tscrollx', 18:12:05 INFO - 'cart', 18:12:05 INFO - 'tsvg_static']}, 18:12:05 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:12:05 INFO - 'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['tp5o']}, 18:12:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:12:05 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:12:05 INFO - 'talos_options': ['--disable-e10s', 18:12:05 INFO - '--xperf_path', 18:12:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:12:05 INFO - 'tests': ['tp5n']}, 18:12:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:12:05 INFO - 'talos_options': ['--xperf_path', 18:12:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:12:05 INFO - 'tests': ['tp5n']}}, 18:12:05 INFO - 'talos.zip': {'path': '', 18:12:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:12:05 INFO - Running post-action listener: _resource_record_post_action 18:12:05 INFO - [mozharness: 2017-07-18 01:12:05.535051Z] Finished populate-webroot step (success) 18:12:05 INFO - [mozharness: 2017-07-18 01:12:05.535142Z] Running create-virtualenv step. 18:12:05 INFO - Running pre-action listener: _resource_record_pre_action 18:12:05 INFO - Running main action method: create_virtualenv 18:12:05 INFO - Creating virtualenv /builds/slave/test/build/venv 18:12:05 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:12:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:12:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:12:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:12:05 INFO - Using real prefix '/usr' 18:12:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:12:06 INFO - Installing distribute.............................................................................................................................................................................................done. 18:12:08 INFO - Installing pip.................done. 18:12:08 INFO - Return code: 0 18:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:12:08 INFO - Reading from file tmpfile_stdout 18:12:08 INFO - Output received: 18:12:08 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:12:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:12:08 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:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:08 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:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:08 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 0x15531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1d00>, '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 0x18c2c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3090>, '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': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', '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:12:08 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:12:08 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:12:08 INFO - Using env: {'DISPLAY': ':0', 18:12:08 INFO - 'HOME': '/home/cltbld', 18:12:08 INFO - 'LANG': 'en_US.UTF-8', 18:12:08 INFO - 'LANGUAGE': 'en_US:en', 18:12:08 INFO - 'LOGNAME': 'cltbld', 18:12:08 INFO - 'MAIL': '/var/mail/cltbld', 18:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:08 INFO - 'MOZ_NO_REMOTE': '1', 18:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:08 INFO - 'NO_EM_RESTART': '1', 18:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:08 INFO - 'PWD': '/builds/slave/test', 18:12:08 INFO - 'SHELL': '/bin/bash', 18:12:08 INFO - 'SHLVL': '1', 18:12:08 INFO - 'TERM': 'linux', 18:12:08 INFO - 'TMOUT': '86400', 18:12:08 INFO - 'USER': 'cltbld', 18:12:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', 18:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:08 INFO - '_': '/tools/buildbot/bin/python'} 18:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:08 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:12:08 INFO - Cleaning up... 18:12:08 INFO - Return code: 0 18:12:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:12:08 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:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:08 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:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:08 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 0x15531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1d00>, '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 0x18c2c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3090>, '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': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', '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:12:08 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:12:08 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:12:08 INFO - Using env: {'DISPLAY': ':0', 18:12:08 INFO - 'HOME': '/home/cltbld', 18:12:08 INFO - 'LANG': 'en_US.UTF-8', 18:12:08 INFO - 'LANGUAGE': 'en_US:en', 18:12:08 INFO - 'LOGNAME': 'cltbld', 18:12:08 INFO - 'MAIL': '/var/mail/cltbld', 18:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:08 INFO - 'MOZ_NO_REMOTE': '1', 18:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:08 INFO - 'NO_EM_RESTART': '1', 18:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:08 INFO - 'PWD': '/builds/slave/test', 18:12:08 INFO - 'SHELL': '/bin/bash', 18:12:08 INFO - 'SHLVL': '1', 18:12:08 INFO - 'TERM': 'linux', 18:12:08 INFO - 'TMOUT': '86400', 18:12:08 INFO - 'USER': 'cltbld', 18:12:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', 18:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:08 INFO - '_': '/tools/buildbot/bin/python'} 18:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:08 INFO - Downloading/unpacking psutil>=3.1.1 18:12:08 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:12:08 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:12:08 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:12:08 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:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:12:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:12:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:12:09 INFO - Installing collected packages: psutil 18:12:09 INFO - Running setup.py install for psutil 18:12:10 INFO - building 'psutil._psutil_linux' extension 18:12:10 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:12:10 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:12:10 INFO - building 'psutil._psutil_posix' extension 18:12:10 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:12:10 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:12:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:12:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:12:10 INFO - Successfully installed psutil 18:12:10 INFO - Cleaning up... 18:12:10 INFO - Return code: 0 18:12:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:12: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:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12: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:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1d00>, '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 0x18c2c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3090>, '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': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', '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:12: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:12: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 mozsystemmonitor==0.3 18:12:10 INFO - Using env: {'DISPLAY': ':0', 18:12:10 INFO - 'HOME': '/home/cltbld', 18:12:10 INFO - 'LANG': 'en_US.UTF-8', 18:12:10 INFO - 'LANGUAGE': 'en_US:en', 18:12:10 INFO - 'LOGNAME': 'cltbld', 18:12:10 INFO - 'MAIL': '/var/mail/cltbld', 18:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:10 INFO - 'MOZ_NO_REMOTE': '1', 18:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:10 INFO - 'NO_EM_RESTART': '1', 18:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:10 INFO - 'PWD': '/builds/slave/test', 18:12:10 INFO - 'SHELL': '/bin/bash', 18:12:10 INFO - 'SHLVL': '1', 18:12:10 INFO - 'TERM': 'linux', 18:12:10 INFO - 'TMOUT': '86400', 18:12:10 INFO - 'USER': 'cltbld', 18:12:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', 18:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:10 INFO - '_': '/tools/buildbot/bin/python'} 18:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:12: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:12: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:12: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:12: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:12:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:12:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:12:11 INFO - Installing collected packages: mozsystemmonitor 18:12:11 INFO - Running setup.py install for mozsystemmonitor 18:12:11 INFO - Successfully installed mozsystemmonitor 18:12:11 INFO - Cleaning up... 18:12:12 INFO - Return code: 0 18:12:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:12: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:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12: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:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12: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', '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 0x15531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1d00>, '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 0x18c2c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3090>, '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': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', '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:12: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:12: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 jsonschema==2.5.1 18:12:12 INFO - Using env: {'DISPLAY': ':0', 18:12:12 INFO - 'HOME': '/home/cltbld', 18:12:12 INFO - 'LANG': 'en_US.UTF-8', 18:12:12 INFO - 'LANGUAGE': 'en_US:en', 18:12:12 INFO - 'LOGNAME': 'cltbld', 18:12:12 INFO - 'MAIL': '/var/mail/cltbld', 18:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:12 INFO - 'MOZ_NO_REMOTE': '1', 18:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:12 INFO - 'NO_EM_RESTART': '1', 18:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:12 INFO - 'PWD': '/builds/slave/test', 18:12:12 INFO - 'SHELL': '/bin/bash', 18:12:12 INFO - 'SHLVL': '1', 18:12:12 INFO - 'TERM': 'linux', 18:12:12 INFO - 'TMOUT': '86400', 18:12:12 INFO - 'USER': 'cltbld', 18:12:12 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', 18:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:12 INFO - '_': '/tools/buildbot/bin/python'} 18:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:12 INFO - Downloading/unpacking jsonschema==2.5.1 18:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:12:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:12: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:12: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:12: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:12: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:12:13 INFO - Downloading functools32-3.2.3-2.tar.gz 18:12:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:12:13 INFO - warning: no files found matching '*.txt' 18:12:13 INFO - no previously-included directories found matching 'build' 18:12:13 INFO - no previously-included directories found matching 'dist' 18:12:13 INFO - no previously-included directories found matching '.git*' 18:12:13 INFO - Installing collected packages: jsonschema, functools32 18:12:13 INFO - Running setup.py install for functools32 18:12:13 INFO - warning: no files found matching '*.txt' 18:12:13 INFO - no previously-included directories found matching 'build' 18:12:13 INFO - no previously-included directories found matching 'dist' 18:12:13 INFO - no previously-included directories found matching '.git*' 18:12:13 INFO - Successfully installed jsonschema functools32 18:12:13 INFO - Cleaning up... 18:12:13 INFO - Return code: 0 18:12:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:12:13 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:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:13 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:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:13 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 0x15531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1d00>, '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 0x18c2c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3090>, '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': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', '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:12:13 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:12:13 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:12:13 INFO - Using env: {'DISPLAY': ':0', 18:12:13 INFO - 'HOME': '/home/cltbld', 18:12:13 INFO - 'LANG': 'en_US.UTF-8', 18:12:13 INFO - 'LANGUAGE': 'en_US:en', 18:12:13 INFO - 'LOGNAME': 'cltbld', 18:12:13 INFO - 'MAIL': '/var/mail/cltbld', 18:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:13 INFO - 'MOZ_NO_REMOTE': '1', 18:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:13 INFO - 'NO_EM_RESTART': '1', 18:12:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:13 INFO - 'PWD': '/builds/slave/test', 18:12:13 INFO - 'SHELL': '/bin/bash', 18:12:13 INFO - 'SHLVL': '1', 18:12:13 INFO - 'TERM': 'linux', 18:12:13 INFO - 'TMOUT': '86400', 18:12:13 INFO - 'USER': 'cltbld', 18:12:13 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', 18:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:13 INFO - '_': '/tools/buildbot/bin/python'} 18:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:12:13 INFO - Cleaning up... 18:12:13 INFO - Return code: 0 18:12:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:12:13 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:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:13 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:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:13 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 0x15531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1d00>, '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 0x18c2c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3090>, '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': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', '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:12:13 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:12:13 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:12:13 INFO - Using env: {'DISPLAY': ':0', 18:12:13 INFO - 'HOME': '/home/cltbld', 18:12:13 INFO - 'LANG': 'en_US.UTF-8', 18:12:13 INFO - 'LANGUAGE': 'en_US:en', 18:12:13 INFO - 'LOGNAME': 'cltbld', 18:12:13 INFO - 'MAIL': '/var/mail/cltbld', 18:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:13 INFO - 'MOZ_NO_REMOTE': '1', 18:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:13 INFO - 'NO_EM_RESTART': '1', 18:12:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:13 INFO - 'PWD': '/builds/slave/test', 18:12:13 INFO - 'SHELL': '/bin/bash', 18:12:13 INFO - 'SHLVL': '1', 18:12:13 INFO - 'TERM': 'linux', 18:12:13 INFO - 'TMOUT': '86400', 18:12:13 INFO - 'USER': 'cltbld', 18:12:13 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', 18:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:13 INFO - '_': '/tools/buildbot/bin/python'} 18:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:14 INFO - Downloading/unpacking blobuploader==1.2.4 18:12: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:12: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:12: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:12: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:12:15 INFO - Downloading blobuploader-1.2.4.tar.gz 18:12:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:12:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:12: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:12: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:12: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:12: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:12:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:12:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:12: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:12: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:12: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:12: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:12:15 INFO - Downloading docopt-0.6.1.tar.gz 18:12:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:12:15 INFO - Installing collected packages: blobuploader, requests, docopt 18:12:15 INFO - Running setup.py install for blobuploader 18:12:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:12:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:12:16 INFO - Running setup.py install for requests 18:12:16 INFO - Running setup.py install for docopt 18:12:16 INFO - Successfully installed blobuploader requests docopt 18:12:16 INFO - Cleaning up... 18:12:16 INFO - Return code: 0 18:12:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12: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:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12: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:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:16 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 0x15531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1d00>, '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 0x18c2c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3090>, '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': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', '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:12:16 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:12:16 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:12:16 INFO - Using env: {'DISPLAY': ':0', 18:12:16 INFO - 'HOME': '/home/cltbld', 18:12:16 INFO - 'LANG': 'en_US.UTF-8', 18:12:16 INFO - 'LANGUAGE': 'en_US:en', 18:12:16 INFO - 'LOGNAME': 'cltbld', 18:12:16 INFO - 'MAIL': '/var/mail/cltbld', 18:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:16 INFO - 'MOZ_NO_REMOTE': '1', 18:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:16 INFO - 'NO_EM_RESTART': '1', 18:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:16 INFO - 'PWD': '/builds/slave/test', 18:12:16 INFO - 'SHELL': '/bin/bash', 18:12:16 INFO - 'SHLVL': '1', 18:12:16 INFO - 'TERM': 'linux', 18:12:16 INFO - 'TMOUT': '86400', 18:12:16 INFO - 'USER': 'cltbld', 18:12:16 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', 18:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:16 INFO - '_': '/tools/buildbot/bin/python'} 18:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:16 INFO - Running setup.py (path:/tmp/pip-RxxtEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:16 INFO - Running setup.py (path:/tmp/pip-n0mkss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:16 INFO - Running setup.py (path:/tmp/pip-2nKs9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:16 INFO - Running setup.py (path:/tmp/pip-dqt4Ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:17 INFO - Running setup.py (path:/tmp/pip-bHICs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:17 INFO - Running setup.py (path:/tmp/pip-tC06uY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:17 INFO - Running setup.py (path:/tmp/pip-dbwyLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:17 INFO - Running setup.py (path:/tmp/pip-_nsgDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:17 INFO - Running setup.py (path:/tmp/pip-Rzo5i2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:17 INFO - Running setup.py (path:/tmp/pip-vj3mo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:17 INFO - Running setup.py (path:/tmp/pip-e_RA8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:17 INFO - Running setup.py (path:/tmp/pip-IhH6QG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:17 INFO - Running setup.py (path:/tmp/pip-jlt5bI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:17 INFO - Running setup.py (path:/tmp/pip-pcUN3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:17 INFO - Running setup.py (path:/tmp/pip-0KPLZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:17 INFO - Running setup.py (path:/tmp/pip-Uq0t6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:17 INFO - Running setup.py (path:/tmp/pip-zj6wyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:12:17 INFO - Running setup.py install for manifestparser 18:12:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:12:18 INFO - Running setup.py install for mozcrash 18:12:18 INFO - Running setup.py install for mozdebug 18:12:18 INFO - Running setup.py install for mozdevice 18:12:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:12:18 INFO - Running setup.py install for mozfile 18:12:18 INFO - Running setup.py install for mozhttpd 18:12:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:12:18 INFO - Running setup.py install for mozinfo 18:12:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:12:18 INFO - Running setup.py install for mozInstall 18:12:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:12:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:12:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:12:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:12:18 INFO - Running setup.py install for mozleak 18:12:18 INFO - Running setup.py install for mozlog 18:12:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:12:18 INFO - Running setup.py install for moznetwork 18:12:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:12:19 INFO - Running setup.py install for mozprocess 18:12:19 INFO - Running setup.py install for mozprofile 18:12:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:12:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:12:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:12:19 INFO - Running setup.py install for mozrunner 18:12:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:12:19 INFO - Running setup.py install for mozscreenshot 18:12:19 INFO - Running setup.py install for moztest 18:12:19 INFO - Running setup.py install for mozversion 18:12:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:12:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:12:19 INFO - Cleaning up... 18:12:19 INFO - Return code: 0 18:12:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:19 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:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:19 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:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:19 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 0x15531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1d00>, '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 0x18c2c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3090>, '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': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', '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:12:19 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:12:19 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:12:19 INFO - Using env: {'DISPLAY': ':0', 18:12:19 INFO - 'HOME': '/home/cltbld', 18:12:19 INFO - 'LANG': 'en_US.UTF-8', 18:12:19 INFO - 'LANGUAGE': 'en_US:en', 18:12:19 INFO - 'LOGNAME': 'cltbld', 18:12:19 INFO - 'MAIL': '/var/mail/cltbld', 18:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:19 INFO - 'MOZ_NO_REMOTE': '1', 18:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:19 INFO - 'NO_EM_RESTART': '1', 18:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:19 INFO - 'PWD': '/builds/slave/test', 18:12:19 INFO - 'SHELL': '/bin/bash', 18:12:19 INFO - 'SHLVL': '1', 18:12:19 INFO - 'TERM': 'linux', 18:12:19 INFO - 'TMOUT': '86400', 18:12:19 INFO - 'USER': 'cltbld', 18:12:19 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', 18:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:19 INFO - '_': '/tools/buildbot/bin/python'} 18:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:19 INFO - Running setup.py (path:/tmp/pip-OL_PNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:20 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:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:20 INFO - Running setup.py (path:/tmp/pip-OR31Ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:20 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:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:20 INFO - Running setup.py (path:/tmp/pip-52R6SP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:20 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:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:20 INFO - Running setup.py (path:/tmp/pip-L33Xda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:20 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:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:20 INFO - Running setup.py (path:/tmp/pip-7ghdZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:20 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:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:20 INFO - Running setup.py (path:/tmp/pip-3wdmuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:20 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:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:20 INFO - Running setup.py (path:/tmp/pip-Xra7_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:20 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:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:20 INFO - Running setup.py (path:/tmp/pip-ORLn9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:20 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:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:20 INFO - Running setup.py (path:/tmp/pip-YWnEbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:20 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:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:20 INFO - Running setup.py (path:/tmp/pip-u6pnEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:20 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:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:20 INFO - Running setup.py (path:/tmp/pip-x90t2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:20 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:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:20 INFO - Running setup.py (path:/tmp/pip-TL2Q6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:20 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:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:20 INFO - Running setup.py (path:/tmp/pip-gkx795-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:20 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:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:20 INFO - Running setup.py (path:/tmp/pip-ek65gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:20 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:12:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:20 INFO - Running setup.py (path:/tmp/pip-mCb5fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:21 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:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:21 INFO - Running setup.py (path:/tmp/pip-ft4RZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:21 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:12:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:21 INFO - Running setup.py (path:/tmp/pip-R1YkI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:21 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:12:21 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:12:21 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:12:21 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:12:21 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:12:21 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:12:21 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:12:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:12:21 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:12:21 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:12:21 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:12:21 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:12:22 INFO - Downloading blessings-1.6.tar.gz 18:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:12:22 INFO - Installing collected packages: blessings 18:12:22 INFO - Running setup.py install for blessings 18:12:22 INFO - Successfully installed blessings 18:12:22 INFO - Cleaning up... 18:12:22 INFO - Return code: 0 18:12:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:12:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:22 INFO - Reading from file tmpfile_stdout 18:12:22 INFO - Current package versions: 18:12:22 INFO - argparse == 1.2.1 18:12:22 INFO - blessings == 1.6 18:12:22 INFO - blobuploader == 1.2.4 18:12:22 INFO - docopt == 0.6.1 18:12:22 INFO - functools32 == 3.2.3-2 18:12:22 INFO - jsonschema == 2.5.1 18:12:22 INFO - manifestparser == 1.1 18:12:22 INFO - mozInstall == 1.13 18:12:22 INFO - mozcrash == 1.0 18:12:22 INFO - mozdebug == 0.1 18:12:22 INFO - mozdevice == 0.51 18:12:22 INFO - mozfile == 1.2 18:12:22 INFO - mozhttpd == 0.7 18:12:22 INFO - mozinfo == 0.10 18:12:22 INFO - mozleak == 0.1 18:12:22 INFO - mozlog == 3.5 18:12:22 INFO - moznetwork == 0.27 18:12:22 INFO - mozprocess == 0.25 18:12:22 INFO - mozprofile == 0.28 18:12:22 INFO - mozrunner == 6.13 18:12:22 INFO - mozscreenshot == 0.1 18:12:22 INFO - mozsystemmonitor == 0.3 18:12:22 INFO - moztest == 0.8 18:12:22 INFO - mozversion == 1.4 18:12:22 INFO - psutil == 3.1.1 18:12:22 INFO - requests == 1.2.3 18:12:22 INFO - wsgiref == 0.1.2 18:12:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12: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:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12: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:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:22 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 0x15531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1d00>, '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 0x18c2c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3090>, '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': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', '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:12:22 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:12:22 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:12:22 INFO - Using env: {'DISPLAY': ':0', 18:12:22 INFO - 'HOME': '/home/cltbld', 18:12:22 INFO - 'LANG': 'en_US.UTF-8', 18:12:22 INFO - 'LANGUAGE': 'en_US:en', 18:12:22 INFO - 'LOGNAME': 'cltbld', 18:12:22 INFO - 'MAIL': '/var/mail/cltbld', 18:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:22 INFO - 'MOZ_NO_REMOTE': '1', 18:12:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:22 INFO - 'NO_EM_RESTART': '1', 18:12:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:22 INFO - 'PWD': '/builds/slave/test', 18:12:22 INFO - 'SHELL': '/bin/bash', 18:12:22 INFO - 'SHLVL': '1', 18:12:22 INFO - 'TERM': 'linux', 18:12:22 INFO - 'TMOUT': '86400', 18:12:22 INFO - 'USER': 'cltbld', 18:12:22 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', 18:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:22 INFO - '_': '/tools/buildbot/bin/python'} 18:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:22 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:12:22 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:12:22 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:12:22 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:12:22 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:12:22 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:12:22 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:12:22 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:12:22 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:12:22 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:12:22 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:12:22 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:12:22 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:12:22 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:12:24 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:12:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:12:24 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 18:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:12:24 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:12:24 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:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:12:24 INFO - Installing collected packages: marionette-driver, simplejson 18:12:24 INFO - Running setup.py install for marionette-driver 18:12:24 INFO - Running setup.py install for simplejson 18:12:24 INFO - building 'simplejson._speedups' extension 18:12:24 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:12:25 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:12:25 INFO - Successfully installed marionette-driver simplejson 18:12:25 INFO - Cleaning up... 18:12:25 INFO - Return code: 0 18:12:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:12: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:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12: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:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:25 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 0x15531f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c4b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c1d00>, '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 0x18c2c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3090>, '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': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', '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:12:25 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:12:25 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:12:25 INFO - Using env: {'DISPLAY': ':0', 18:12:25 INFO - 'HOME': '/home/cltbld', 18:12:25 INFO - 'LANG': 'en_US.UTF-8', 18:12:25 INFO - 'LANGUAGE': 'en_US:en', 18:12:25 INFO - 'LOGNAME': 'cltbld', 18:12:25 INFO - 'MAIL': '/var/mail/cltbld', 18:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:25 INFO - 'MOZ_NO_REMOTE': '1', 18:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:25 INFO - 'NO_EM_RESTART': '1', 18:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:25 INFO - 'PWD': '/builds/slave/test', 18:12:25 INFO - 'SHELL': '/bin/bash', 18:12:25 INFO - 'SHLVL': '1', 18:12:25 INFO - 'TERM': 'linux', 18:12:25 INFO - 'TMOUT': '86400', 18:12:25 INFO - 'USER': 'cltbld', 18:12:25 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', 18:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:25 INFO - '_': '/tools/buildbot/bin/python'} 18:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:12:25 INFO - Cleaning up... 18:12:25 INFO - Return code: 0 18:12:25 INFO - Running post-action listener: _resource_record_post_action 18:12:25 INFO - Running post-action listener: _start_resource_monitoring 18:12:25 INFO - Starting resource monitoring. 18:12:25 INFO - [mozharness: 2017-07-18 01:12:25.756333Z] Finished create-virtualenv step (success) 18:12:25 INFO - [mozharness: 2017-07-18 01:12:25.756841Z] Running install step. 18:12:25 INFO - Running pre-action listener: _resource_record_pre_action 18:12:25 INFO - Running main action method: install 18:12:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:25 INFO - Reading from file tmpfile_stdout 18:12:25 INFO - Detecting whether we're running mozinstall >=1.0... 18:12:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:12:26 INFO - Reading from file tmpfile_stdout 18:12:26 INFO - Output received: 18:12:26 INFO - Usage: mozinstall [options] installer 18:12:26 INFO - Options: 18:12:26 INFO - -h, --help show this help message and exit 18:12:26 INFO - -d DEST, --destination=DEST 18:12:26 INFO - Directory to install application into. [default: 18:12:26 INFO - "/builds/slave/test"] 18:12:26 INFO - --app=APP Application being installed. [default: firefox] 18:12:26 INFO - mkdir: /builds/slave/test/build/application 18:12:26 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:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:12:44 INFO - Reading from file tmpfile_stdout 18:12:44 INFO - Output received: 18:12:44 INFO - /builds/slave/test/build/application/firefox/firefox 18:12:44 INFO - Running post-action listener: _resource_record_post_action 18:12:44 INFO - [mozharness: 2017-07-18 01:12:44.077467Z] Finished install step (success) 18:12:44 INFO - [mozharness: 2017-07-18 01:12:44.077617Z] Running setup-mitmproxy step. 18:12:44 INFO - Running pre-action listener: _resource_record_pre_action 18:12:44 INFO - Running main action method: setup_mitmproxy 18:12:44 INFO - Skipping: mitmproxy is not required 18:12:44 INFO - Running post-action listener: _resource_record_post_action 18:12:44 INFO - [mozharness: 2017-07-18 01:12:44.078144Z] Finished setup-mitmproxy step (success) 18:12:44 INFO - [mozharness: 2017-07-18 01:12:44.078258Z] Running run-tests step. 18:12:44 INFO - Running pre-action listener: _resource_record_pre_action 18:12:44 INFO - Running pre-action listener: _set_gcov_prefix 18:12:44 INFO - Running main action method: run_tests 18:12:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:12:44 INFO - Python 2.7.3 18:12:44 INFO - Return code: 0 18:12:44 INFO - grabbing minidump binary from tooltool 18:12:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:12:44 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 0x18c1d00>, '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 0x18c2c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c3090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:12:44 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:12:44 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:12:44 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:12:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:12:44 INFO - Return code: 0 18:12:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:12:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:12:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:12:44 INFO - ENV: RUST_BACKTRACE is now 1 18:12:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:12:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:12:44 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/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:12:44 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/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-043 --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:12:44 INFO - Using env: {'DISPLAY': ':0', 18:12:44 INFO - 'HOME': '/home/cltbld', 18:12:44 INFO - 'LANG': 'en_US.UTF-8', 18:12:44 INFO - 'LANGUAGE': 'en_US:en', 18:12:44 INFO - 'LOGNAME': 'cltbld', 18:12:44 INFO - 'MAIL': '/var/mail/cltbld', 18:12:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:12:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:44 INFO - 'MOZ_NO_REMOTE': '1', 18:12:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:12:44 INFO - 'NO_EM_RESTART': '1', 18:12:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:44 INFO - 'PWD': '/builds/slave/test', 18:12:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:12:44 INFO - 'RUST_BACKTRACE': '1', 18:12:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:12:44 INFO - 'SHELL': '/bin/bash', 18:12:44 INFO - 'SHLVL': '1', 18:12:44 INFO - 'TERM': 'linux', 18:12:44 INFO - 'TMOUT': '86400', 18:12:44 INFO - 'USER': 'cltbld', 18:12:44 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1500339494.74252-244863601', 18:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:44 INFO - '_': '/tools/buildbot/bin/python'} 18:12:44 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/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:12:44 INFO - mozversion application_buildid: 20170718002759 18:12:44 INFO - mozversion application_changeset: 5e73b9798464c3f7106f0161dc9a49b234f42f9c 18:12:44 INFO - mozversion application_display_name: Nightly 18:12:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:12:44 INFO - mozversion application_name: Firefox 18:12:44 INFO - mozversion application_remotingname: firefox 18:12:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:12:44 INFO - mozversion application_vendor: Mozilla 18:12:44 INFO - mozversion application_version: 56.0a1 18:12:44 INFO - mozversion platform_buildid: 20170718002759 18:12:44 INFO - mozversion platform_changeset: 5e73b9798464c3f7106f0161dc9a49b234f42f9c 18:12:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:12:44 INFO - mozversion platform_version: 56.0a1 18:12:44 INFO - using testdate: 1500340364 18:12:44 INFO - actual date: 1500340364 18:12:44 INFO - starting webserver on 'localhost:58493' 18:12:44 INFO - SUITE-START | Running 2 tests 18:12:44 INFO - TEST-START | dromaeo_css 18:12:44 INFO - Initialising browser for dromaeo_css test... 18:12:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58493/getInfo.html -profile /tmp/tmp_KuWdT/profile 18:12:44 INFO - TEST-INFO | started process 31126 (/builds/slave/test/build/application/firefox/firefox http://localhost:58493/getInfo.html) 18:12:51 INFO - TEST-INFO | 31126: exit 0 18:12:51 INFO - Browser initialized. 18:12:51 INFO - Running cycle 1/1 for dromaeo_css test... 18:12:51 INFO - TEST-INFO | started process 31352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_KuWdT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:13:02 INFO - PID 31352 | RSS: Main: 170459136 18:13:02 INFO - PID 31352 | 18:16:00 INFO - PID 31352 | Cycle 1(1): loaded http://localhost:58493/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58493/tests/dromaeo/cssquery-ext.html) 18:16:02 INFO - PID 31352 | RSS: Main: 177745920 18:16:02 INFO - PID 31352 | 18:19:04 INFO - PID 31352 | Cycle 1(1): loaded http://localhost:58493/tests/dromaeo/cssquery-ext.html (next: http://localhost:58493/tests/dromaeo/cssquery-jquery.html) 18:19:05 INFO - PID 31352 | RSS: Main: 175755264 18:19:05 INFO - PID 31352 | 18:22:06 INFO - PID 31352 | Cycle 1(1): loaded http://localhost:58493/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58493/tests/dromaeo/cssquery-mootools.html) 18:22:07 INFO - PID 31352 | RSS: Main: 178475008 18:22:07 INFO - PID 31352 | 18:25:09 INFO - PID 31352 | Cycle 1(1): loaded http://localhost:58493/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58493/tests/dromaeo/cssquery-prototype.html) 18:25:09 INFO - PID 31352 | RSS: Main: 177496064 18:25:09 INFO - PID 31352 | 18:28:13 INFO - PID 31352 | Cycle 1(1): loaded http://localhost:58493/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58493/tests/dromaeo/cssquery-yui.html) 18:28:13 INFO - PID 31352 | RSS: Main: 176377856 18:28:13 INFO - PID 31352 | 18:31:15 INFO - PID 31352 | Cycle 1(1): loaded http://localhost:58493/tests/dromaeo/cssquery-yui.html (next: http://localhost:58493/tests/dromaeo/cssquery-dojo.html) 18:31:15 INFO - PID 31352 | RSS: Main: 180449280 18:31:15 INFO - PID 31352 | 18:31:15 INFO - PID 31352 | __start_tp_report 18:31:15 INFO - PID 31352 | _x_x_mozilla_page_load 18:31:15 INFO - PID 31352 | _x_x_mozilla_page_load_details 18:31:15 INFO - PID 31352 | |i|pagename|runs| 18:31:15 INFO - PID 31352 | |0;dojo.html;3080.3993221321853;3090.4591696453117;3101.5657807906896;3103.705148010939;3107.1144723753728;5978.671173085479;6017.097435384689;6019.8495037624025;6094.1468194452755;6137.26352837659;6104.5116390688745;6121.143039974396;6172.9074063889075;6176.320604733487;6179.443850053494;5588.86027849305;5610.831675049755;5632.436756324355;5651.208830763697;5670.631408958405;5525.226468294442;5537.280153580029;5616.9157462638095;5660.773569057233;5682.914756278659;5497.147942068986;5521.585881058937;5526.640768350085;5558.277423934883;5590.496855283024;5533.861653458655;5561.555075593943;5581.49766521011;5584.6090773645865;5586.441355864422;5477.123660214386;5544.279243698294;5554.1946417769195;5556.388797232301;5561.221428999943;5964.910526342108;5978.611390259663;5981.5214782817275;6003.759849606011;6014.338422773491;6532.771353002622;6534.019897015438;6537.477001839841;6543.149390579194;6551.4431273341825;6610.7355705771715;6615.834604134887;6623.9006414903815;6624.668766561653;6639.535232533724;6080.14877917092;6108.816735497898;6114.419130182626;6131.908021379683;6189.288231853349;6748.089007983957;6753.324667533306;6823.454123670094;6839.589624622538;6857.828554286183;6344.111824344595;6434.067060276234;6442.420182183626;6486.545941784124;6503.187101612299;6455.419012288917;6458.063580780855;6458.12815269942;6474.482041436674;6481.870362592722;5322;6379.266384365857;6403.807885763435;6472.288048314682;6485.70814313357;6313;6377.585456945284;6387.977923532212;6487.3836985486305;6539.574927629784;5254.500822421864;5321;5333.466653334635;5344.171653393731;5380.91928621071;4509.6392288616835;4524;4552.88617784558;4560.908781824345;4626.884327891829;5594.832155035356;5600.467955544217;5640.576956728261;5655.632383895034;5667.036603777367;6424.807255782334;6559.720854433435;6569.540132190797;6648.96675516629;6663.333666633394;5565.332160140728;5619.747111379916;5701.800436984686;5702.971485142548;5705.4579814917515;5676.943230567724;5736.397678243808;5808.912866307009;5809;5809.593328466966;6200.596961197598;6211.627302361872;6232.283287422005;6241.095041218998;6323.336049714806;6453.9354606453335;6530.8040758777315;6554.213494380705;6563.048357987969;6566.113574667359;6301.747930082745;6308.116863639002;6311.147995020613;6313.684315784284;6322.810315690536;5558.749856256559;6382.329855365306;6406.807795766134;6413.16628838248;6416.903746443901;6553.541252112306;6587.143671322698;6602.537822352389;6645.568038077509;6664.733410663519;6330.746770129143;6344.777932772331;6410.1025856381075;6440.6135631862235;6444.420002199825;6208.3791620839365;6330.366963303817;6361.809145725636;6403.7118329676205;6421.71102300407;6222.160008398808;6241.344658810941;6246.1255424239735;6263.060540918898;6271.3415091414745;6231.563790534619;6315.147455093687;6326.304106548184;6339.809805705836;6383.457406120532;6169.259688837189;6188.1027251049245;6194.876102477835;6198.132261483486;6198.535109866868 18:31:15 INFO - PID 31352 | |1;ext.html;665.171861033014;741.7589283482863;761.1665226576899;784.2236186175686;793.9483933544316;41172.588274117246;41961.580384196146;42104.36843447351;42143;42325.78837105814;38464.23071538575;38734.8063259684;38746.64386746464;38756.418653720146;38853;6784.084148639944;6866.313368663119;6888.001239820223;6905.033295338657;6905.551139175963;6751.257361690235;6821.420179284767;6863.519553631248;6887.552309099892;6895.275996020421;6822.863542729143;6871.862562748742;6883.759068432606;6896.862062758742;6909.654517274142;6745.0556922030955;6762.357576030269;6790.320967903195;6801.4218791402545;6830.282820303871;6009.948259054648;6100.176476175704;6103.206583144163;6167.599106058136;6180.567360284782;33917.6608233917;34172;34178.145546361295;34343.6565634343;34372.312553749034;3418.8632454701783;3459.4637831136215;3576.535050443426;3673.5040769496045;3677.8344974476213;32790;32984.505232421296;33035.504467433006;33067.50398744021;33152;4838.685485443435;4844.418669759616;4896.583790377822;4913.901721965576;4938.580220681247;178406.10796946063;178898.9999999987;197416;197826;198099;44240;44535;49163.50836491661;49641.50358496441;49864.501354986714;51015.489845101816;51090;51236.74381628068;51387;51477.7426112867;15831.208439577975;15879.12664803447;15887.761683574756;15925.442609508611;15925.840741592667;13454.865451345557;13482.85395741373;13500.662483437993;13502.594922152352;13621.25083120438;13700.972427068009;13737.862621373859;13753.312334383241;13855.099418537762;13938.233397163254;5556.333240011225;5577.135543990688;5608.1587761835235;5661.952538780339;5674.97162514193;965.724768441005;979.8775153105862;984.1683777208248;997.1623835977814;999.8200323941614;22613.434664133198;23026.078956841873;23062.538749225256;23340.949657265464;29452.55821162684;1067.4822710985165;1077.8113830079863;1088.5319312695617;1090.9454527273604;1102.5314241447352;12296.75406491883;12396.566120185931;12483;12493.562725304571;12517.123801333819;243741;245586;247052;247961;248302;52248.21627675588;52440;52640.473595264324;52710.209346859825;52780.47219527832;1448.4278709909738;1495.0431723696843;1509.8792096632462;1510.2826157575284;1519.050593379138;21865.53188151441;22056.33830985073;22274.888625557418;22295.66556501686;22711;38004.809975949946;38202;38339.42490862695;38346.42480362741;38389.232215356096;210550;211632;212117.93941030197;212241;213296;31006.534901976036;31119;31193.220169495944;31940.5208921871;34230.48654270138;41736;43458;43585;43719.34420983624;43829.34255986099;29581.03429352513;30873.28741687773;31777;32199.55102020368;32367.190820229684;30482.826193457113;31229.53155702621;31646.525302120026;31751.04746857598;31794.84102579472;34698.65301346954;34720.652793471745;34868.82565587156;35113.47329790004;35402.46896296506;29227;31042.53436198504;31299;31302.843485782425;31570.526442103845;22932;23718;23722.406939825953;23748.287551373487;24197.51604967926 18:31:15 INFO - PID 31352 | |2;jquery.html;558.290970467506;562.1455387810526;573.3206150711408;578.141459932001;592.5111782779206;16121.91939040303;21151.57696846062;22426.88786556067;22485.775142248574;22499.662505062395;19401.223951041942;19760.01199940001;19842.503937401572;21745.782542174573;24576.75423245767;6151.292601350857;6327.335629758878;6344.555881088326;6350.491960643138;6359.55483116182;6232.657203853786;6296.905546416808;6351.079093531435;6353.714082866282;6362.936370636281;3766.962330376702;5854.765809367642;6311.526635502356;6326.905096423558;6342.6511541865175;6303.968480157616;6307.274663413675;6317.842053948665;6318.210223722035;6319.873602527947;5866.794662186846;5867;5868.647881127104;5876.471117599393;5893.263342082239;28155.155345339674;28344.291392715142;28492.145235642965;28502.144935651962;28511.71488285132;1866.9906650466796;1914.4065339744584;1970.339936121401;1976.7430234069623;1987.4435158155738;18335.816641833677;18640;18661.720074198896;18673.439796806117;18684;2208.9116435342726;2217.7671344508753;2240.148743477468;2257.853239539441;2333.381653861728;124926.37536812348;127645;130800;133505;133679.6632033677;13887.444502219798;14542.563723088324;14856.182909940057;14964.176970266522;14970.62573435651;22810;22813.543729125657;22841.31476055721;22860.42848928757;22884.313470595574;10350.637727679647;10440.675255619688;10449.268551201343;10572.048515633629;10646.840297395545;9819.754506137404;9884.752881177885;9943.900560994442;10034.046765557261;10048.497575121215;8996.640134394682;9133.269338452908;9148.496832674135;9199.402038867453;9264.72205833826;2647.3381654586356;2652.4032092779357;2669.9599506007426;2691.3809823740257;2813.8041332434045;973.4241333848814;973.4548652754338;985.3574504737295;995.8456439251928;1001.6844693921537;18386.448406547825;19027.14377853;19113.713294300596;19228.134733937008;19331.613367732567;1018.7554986803262;1044.6500422358442;1046.4819914142547;1070.7216123807866;1071.8820929697727;10317.896821031844;10493.790124197625;10592;10609.84085238722;10649;429538;484618;499892;501397;511272;111092;112287.4385628083;112966;115307.42346288214;115978;1271.853736820259;1286.26040026983;1334.9933250333686;1335.7128217433103;1337.0774165825549;18883.622327553647;19012.904935475235;20126.094325755083;20286;20302.79697203009;55169;55301.72349138228;57478.7126064367;58361.4163858356;59568.702156488944;70218.64890675514;70878.64560677164;70988;71427.28572714207;72490.27509724835;13011.284379359226;13409.530666426628;13521.526746563823;13618.93190534041;14602.85397146015;21516.892415537823;21834.563308734054;22984.885075574515;23133.074677013403;23261.651075234222;17476.563085922953;17550.122493875;18140.274389024293;18341.082945852922;18582.907085464485;15534.378624854879;16116.758248626515;16838.57903552421;16870.409535666193;16988.235529400958;18731.250749970393;18920.7161892569;18936.810631893506;18986.1456234467;19207.32774352891;14506.274686265855;14534.563963081124;14545.781813272597;14554.345054472786;20824.271150510267;18791.90604046971;18862.71705924385;18980;19067.332643357415;19221.615567688288 18:31:15 INFO - PID 31352 | |3;mootools.html;1340.3298350824587;1397.6855207578296;1412.5479846449134;1414.1373762005182;1414.681696618261;13527.864721352784;13982.930085349559;14101.929490352533;14133.081349712262;14170.929145354272;13686.247256400893;14097.436102555912;14103.365348559313;14126.717465650681;14182.787258191136;2509.4604659998145;2554.6551215585937;2564.974350256492;2570.2417786752953;2578.8968441262327;2497.3382053755677;2552.0302285131716;2558.206955843685;2566.101864347482;2582;2531.164715643833;2546;2559.5776696844996;2572.974270257292;2576.046862660818;2292.1633603734685;2294.2773026496684;2303.3780879162614;2315.90736370545;2327.045911176418;2340.461693810433;2400.987995060031;2401;2408.542376948392;2409.1447536124774;13305.467781288737;13751.518696845662;13821.378037988316;13848.584542463743;13866.514671986533;7256.346928776436;7522.699092036312;7536.208698086677;7541.095068591804;7564.886526702104;4761.952380476186;4846.806127754886;4926.753662316905;4974.925376119361;4985.501449855022;1763.4621440460655;1796.7664203653571;1817.100535235054;1860.8232217939274;1867.6638205123072;20514.179432822817;21132.894335528224;22323;22477.775222247896;22646.43383915399;5727.627704199213;5868.794592189253;6306.4639505642535;6384.7126879290545;6452.612843229421;15375.077495350315;15383.38466461329;15383.769243461356;15515.767263491056;15525.301361438762;7157.463190260752;7426.9257307427315;7455.739049133363;7457.366123879422;7464.178940316561;6741.730330786713;6770.830729231809;6817.216020157646;6849.2465828758795;6878.174619045646;4668.719876807402;4795.448523419851;4805.8077676892535;4841.491643377465;4854.320395144682;1370.2463644995412;1384.9169049857042;1400.3278426355407;1412.9081609695336;1423.2954687429788;886.2156991062956;891.1445012787797;913.0960349254191;925.3337596930199;931.3992474853682;7166.175889772743;7208.927910720826;7253.601051942193;8053.15441878606;8198.139195384518;696.9162951610193;700.261224408244;709.5848928376854;722.1334398721555;724.7680742162563;4377.4528183977;4501.392312037899;4994.775235114428;5083.2375143727995;5088.669236499616;17854.375096871547;17998.37005704794;18482.260709571467;18731.90634046821;19100.044997750334;18432.354867579572;18436.631267374578;18767.812321876878;18794.248230070643;18992.145353459127;10453.163746900229;10534.736631584272;10705.982931621484;10708.518116684769;10713.625023124308;7297.781066568012;7547.622618868925;7633.198514156155;7708.845823083395;7727.806804829925;15692.058476491447;15801.604959876095;15811.367545298519;15930.920345398663;16148.919255404118;15365;16166.191690415197;16466.68063077926;16887.66224675524;16920.57698557546;10087.394756314645;10382.065614094769;10390.480475976019;10395.116415104801;10400.479976001321;12792.104552681596;12874.420651070912;12887.871121288666;12952.158109722837;13100.803487947878;9760.560774765294;10168.84746728785;10312.948435257777;10490.108340791117;10526.842097368393;9872.555734992085;10285;10296.588136474757;10359.792804144026;10649.467526623794;9447.385919915183;9550.90449095528;9603.37578057424;9607.759806004906;9610.135087841849;6943.47923905699;7119.715211391694;7151.749688760869;7192.352688257873;7212.855742885218;6470.126532917996;6545.574537655038;6596.70314835824;6598.538102332791;6635.966820165868 18:31:15 INFO - PID 31352 | |4;prototype.html;489.72575357799656;500.32206360381684;518.2071430711013;521.9321488206534;530.2894121876684;6045.486133678637;6093.080679585927;6124.356942521038;6160.784372546962;6202.8206447616185;5743.5118014968775;5914.6155499892475;5917.934771741085;6017.608855424405;6018.578699491027;4738;4837.661363704542;4896.192128298826;4897.951020489785;4936.185529387647;4835.419749630032;4871;4891.192953162724;4911.5088491150955;4913.484084171164;4816.373871396731;4845.685030473026;4854.247591623304;4915.459299477055;4925.808015433134;4650.139724151026;4836.9201243465295;4863.756812159413;4875.780589873429;4886.218205087169;4350.1734670412525;4360.890977725582;4362.17118747437;4363.716358436692;4377.934330985037;5803.622764520293;5831.679257640828;5873.412658734135;5925.911111333334;5958.285005799288;5517.44825517449;5520.095567029369;5545.972270138664;5564.666120032771;5573.944260557383;6387.329330420332;6389.1694079769795;6391.872162556723;6406.615603063785;6413.5189860760165;4724.5984091352275;4732.408448943882;4742.644301677354;4765;4837.177679794443;6738.22510411304;6745.932540674579;6753.89869151968;6808.6255255960905;6830.209233875197;4890.510948905152;4901.705897646153;4910.607151427877;4917.680350777188;4931.901361972812;4901.255297033673;4938.925916111261;4964.429090654548;4982.153033984231;4992.726854652041;5500.614956952975;5510.421405752419;5523.861903452365;5532.28080349552;5562.694051827189;6494.577852439576;6494.935050649433;6502.951570255354;6532.399562107219;6533.542652014314;1727.8444939955214;1752.1502071495315;1752.9211185496683;1754.6841568517789;1758.7273972534279;1111.1166622535104;1128.2891778179694;1200.4514176712119;1210.8062709966364;1226.6136167107334;5523.585731070186;5579.246801681802;5615.691136987423;5620.9437905621235;5681.573881958787;6443.387878151568;6450.645214513153;6450.903236451457;6526;6568.405479835534;5644.230625121765;5647.181158732043;5658.264425624642;5660.971695141498;5728.51307638847;3394.185395505061;3429.382711111974;3484.686378225972;3508.9649103508636;3515.402381595135;6252.155958945484;6299.0866324382705;6323.177986861679;6323.936760632427;6361.522885783492;6619.536632435684;6661.866762664719;6699.9665001674675;6714.29499902513;6733.326667333227;6283.654399008098;6296.2759282681245;6301.842453938597;6308.653024083627;6378.77674281398;6427.357264273535;6472;6504.869902601827;6559.245686745894;6596.944488881756;6406.405405810654;6488.902666459912;6520.793653174178;6522.5760325578685;6589.4069533742195;6303.46420554258;6351.2060992375955;6382.170317858649;6439.935600643934;6446.4520515756685;4937.580305674058;4946.4558898521855;4957.677750946177;4958.677685950402;4962;6636.203655561363;6636.767713130017;6644.302348253364;6653.500987425866;6691.297413771484;6411.198600174978;6419.293877673359;6424.2933277338525;6443.517990862034;6488.156539649815;6300.306966233619;6346.524010699309;6350.968245158745;6427.903581446189;6477.77327793525;6288.528360373082;6290.779822706367;6343.333949935375;6405.701063951975;6420.564997726194;6484.416402523607;6512.511561632991;6516.706748196248;6527.771527996687;6530.216374035146;5995.520358371407;6172.969135154475;6264.248290205204;6303.684815759286;6309.779157729457 18:31:15 INFO - PID 31352 | |5;yui.html;885.9158379953903;899.7480705402486;903.3811838890358;915.9358844880853;918.0681608167711;17557.64884702307;18237.270509179634;18314.542136446595;18425.631487370243;18472.538186545342;19529.51176220595;20359.89820050898;20730.689039664416;20978.265760698378;21255.574888502222;1026.7073883943078;1046.8063408269456;1054.8312270036795;1059.793340298642;1062.8458873463344;1052.0846863229;1053.4311471805215;1053.8629978102836;1055.530289021386;1057.8994995475457;1012.7012531303246;1063.8351055586397;1109.2567979453745;1114.5987444519967;1130.4573804573809;1106.7067227184803;1110.0453609895483;1121.7476067884743;1124.8087825069758;1125.1729978465821;804.284187073505;806.9838603227961;809.4293523066283;810.3841080778592;811.9025716913949;19136.425907222805;19732.50668733293;19831.206751729915;19961.401157965283;20518.692219616718;19641.80358196414;19872.205111795654;20337.796622033737;20474.897625511927;20621.278255261142;16503.257353419125;16528.421505247257;16773.580660483465;17036.82963170377;17079.743803842954;3539.94690079649;3549.0772399176144;3556.28874225156;3566.8038257895805;3572.5534308211472;117327.4133629335;117653.41173294165;125851.3707431457;127211.36394318062;128026.35986820099;14638;15107.4712385066;15151.242437878282;15265.847341526665;15329.770053449207;27792.16623501298;28603.427931441256;28704.856475717905;28735.42529149405;28826.71173288282;8038.678452861937;8191.79520511992;8330.916690833135;8383.035950865607;8421.621027053674;4185.518665353462;4303.569643035671;4306.074194048295;4307.310830267143;4321.114171594815;4945.950540494549;4983.202687570044;5144.356955380577;5144.794208231704;5147.279380886679;876.4084243135858;913.5751875377981;969.5636963366513;1000.5297510170209;1000.6747806962766;611.1535523300261;679.6058286194094;701.8982247574073;709.2234003765868;725.365305357812;11470.483828227583;11888.405579720978;12065.396730163457;13397;14437.422503099968;687.6836655138592;709.230484923853;710.9715611375487;729.4711334282603;732.4213871041924;5253.026948317457;5448.318960129984;5579.6652200868075;5697.401772813878;5902.468777810018;96100.03899961051;97280;98671;102352.48823755834;106996.46501767598;85054;86800;87662.12337876539;89370;89754.55122724344;71112.64443677852;75097.24902751012;76268;77308;78317.216827831;10860.185486088732;11019.338839669645;11218.775624487302;11256.662300131009;11350.772984540428;33611.663883361834;35078.29843403168;35772.821135894155;36177.819110904275;36550.26899462049;44316.55683443253;44433;44465.55534444614;45435.772821137005;45741.771291143334;15616.4534241301;15943.68112637764;16000.679986400439;18205;19250.326238581583;20740.377788666363;21632.891835540722;21695;21707.348779536638;22092.447688807908;17097.316107355568;19221.90389048046;20122.39632811018;20148.697769533763;20436.182552697726;19370.903145484182;19707.802921970597;20044.899775501028;20170.697439538126;20283.188672452936;18858.339958101402;19058.52353691169;19296.903515482893;19358.903205483883;19613.117409716313;12961.805572916226;14043;14053.718925621635;14215.857841421453;14320.928395358373;13545.59363219105;14340.067895586753;14805.259737013323;14951.476698315506;15000 18:31:15 INFO - PID 31352 | __end_tp_report 18:31:15 INFO - PID 31352 | __start_cc_report 18:31:15 INFO - PID 31352 | _x_x_mozilla_cycle_collect,347 18:31:15 INFO - PID 31352 | __end_cc_report 18:31:15 INFO - PID 31352 | __startTimestamp1500341475635__endTimestamp 18:31:15 INFO - PID 31352 | 18:31:15 INFO - PID 31352 | ------- Summary: start ------- 18:31:15 INFO - PID 31352 | Number of tests: 6 18:31:15 INFO - PID 31352 | 18:31:15 INFO - PID 31352 | [#0] dojo.html Cycles:165 Average:5992.30 Median:6200.60 stddev:703.34 (11.3%) stddev-sans-first:667.37 18:31:15 INFO - PID 31352 | Values: 3080.4 3090.5 3101.6 3103.7 3107.1 5978.7 6017.1 6019.8 6094.1 6137.3 6104.5 6121.1 6172.9 6176.3 6179.4 5588.9 5610.8 5632.4 5651.2 5670.6 5525.2 5537.3 5616.9 5660.8 5682.9 5497.1 5521.6 5526.6 5558.3 5590.5 5533.9 5561.6 5581.5 5584.6 5586.4 5477.1 5544.3 5554.2 5556.4 5561.2 5964.9 5978.6 5981.5 6003.8 6014.3 6532.8 6534.0 6537.5 6543.1 6551.4 6610.7 6615.8 6623.9 6624.7 6639.5 6080.1 6108.8 6114.4 6131.9 6189.3 6748.1 6753.3 6823.5 6839.6 6857.8 6344.1 6434.1 6442.4 6486.5 6503.2 6455.4 6458.1 6458.1 6474.5 6481.9 5322.0 6379.3 6403.8 6472.3 6485.7 6313.0 6377.6 6388.0 6487.4 6539.6 5254.5 5321.0 5333.5 5344.2 5380.9 4509.6 4524.0 4552.9 4560.9 4626.9 5594.8 5600.5 5640.6 5655.6 5667.0 6424.8 6559.7 6569.5 6649.0 6663.3 5565.3 5619.7 5701.8 5703.0 5705.5 5676.9 5736.4 5808.9 5809.0 5809.6 6200.6 6211.6 6232.3 6241.1 6323.3 6453.9 6530.8 6554.2 6563.0 6566.1 6301.7 6308.1 6311.1 6313.7 6322.8 5558.7 6382.3 6406.8 6413.2 6416.9 6553.5 6587.1 6602.5 6645.6 6664.7 6330.7 6344.8 6410.1 6440.6 6444.4 6208.4 6330.4 6361.8 6403.7 6421.7 6222.2 6241.3 6246.1 6263.1 6271.3 6231.6 6315.1 6326.3 6339.8 6383.5 6169.3 6188.1 6194.9 6198.1 6198.5 18:31:15 INFO - PID 31352 | 18:31:15 INFO - PID 31352 | [#1] ext.html Cycles:180 Average:37985.92 Median:18915.89 stddev:56529.08 (298.8%) stddev-sans-first:56618.20 18:31:15 INFO - PID 31352 | Values: 665.2 741.8 761.2 784.2 793.9 41172.6 41961.6 42104.4 42143.0 42325.8 38464.2 38734.8 38746.6 38756.4 38853.0 6784.1 6866.3 6888.0 6905.0 6905.6 6751.3 6821.4 6863.5 6887.6 6895.3 6822.9 6871.9 6883.8 6896.9 6909.7 6745.1 6762.4 6790.3 6801.4 6830.3 6009.9 6100.2 6103.2 6167.6 6180.6 33917.7 34172.0 34178.1 34343.7 34372.3 3418.9 3459.5 3576.5 3673.5 3677.8 32790.0 32984.5 33035.5 33067.5 33152.0 4838.7 4844.4 4896.6 4913.9 4938.6 178406.1 178899.0 197416.0 197826.0 198099.0 44240.0 44535.0 49163.5 49641.5 49864.5 51015.5 51090.0 51236.7 51387.0 51477.7 15831.2 15879.1 15887.8 15925.4 15925.8 13454.9 13482.9 13500.7 13502.6 13621.3 13701.0 13737.9 13753.3 13855.1 13938.2 5556.3 5577.1 5608.2 5662.0 5675.0 965.7 979.9 984.2 997.2 999.8 22613.4 23026.1 23062.5 23340.9 29452.6 1067.5 1077.8 1088.5 1090.9 1102.5 12296.8 12396.6 12483.0 12493.6 12517.1 243741.0 245586.0 247052.0 247961.0 248302.0 52248.2 52440.0 52640.5 52710.2 52780.5 1448.4 1495.0 1509.9 1510.3 1519.1 21865.5 22056.3 22274.9 22295.7 22711.0 38004.8 38202.0 38339.4 38346.4 38389.2 210550.0 211632.0 212117.9 212241.0 213296.0 31006.5 31119.0 31193.2 31940.5 34230.5 41736.0 43458.0 43585.0 43719.3 43829.3 29581.0 30873.3 31777.0 32199.6 32367.2 30482.8 31229.5 31646.5 31751.0 31794.8 34698.7 34720.7 34868.8 35113.5 35402.5 29227.0 31042.5 31299.0 31302.8 31570.5 22932.0 23718.0 23722.4 23748.3 24197.5 18:31:15 INFO - PID 31352 | 18:31:15 INFO - PID 31352 | [#2] jquery.html Cycles:180 Average:34123.68 Median:20563.53 stddev:81719.48 (397.4%) stddev-sans-first:81909.87 18:31:15 INFO - PID 31352 | Values: 558.3 562.1 573.3 578.1 592.5 16121.9 21151.6 22426.9 22485.8 22499.7 19401.2 19760.0 19842.5 21745.8 24576.8 6151.3 6327.3 6344.6 6350.5 6359.6 6232.7 6296.9 6351.1 6353.7 6362.9 3767.0 5854.8 6311.5 6326.9 6342.7 6304.0 6307.3 6317.8 6318.2 6319.9 5866.8 5867.0 5868.6 5876.5 5893.3 28155.2 28344.3 28492.1 28502.1 28511.7 1867.0 1914.4 1970.3 1976.7 1987.4 18335.8 18640.0 18661.7 18673.4 18684.0 2208.9 2217.8 2240.1 2257.9 2333.4 124926.4 127645.0 130800.0 133505.0 133679.7 13887.4 14542.6 14856.2 14964.2 14970.6 22810.0 22813.5 22841.3 22860.4 22884.3 10350.6 10440.7 10449.3 10572.0 10646.8 9819.8 9884.8 9943.9 10034.0 10048.5 8996.6 9133.3 9148.5 9199.4 9264.7 2647.3 2652.4 2670.0 2691.4 2813.8 973.4 973.5 985.4 995.8 1001.7 18386.4 19027.1 19113.7 19228.1 19331.6 1018.8 1044.7 1046.5 1070.7 1071.9 10317.9 10493.8 10592.0 10609.8 10649.0 429538.0 484618.0 499892.0 501397.0 511272.0 111092.0 112287.4 112966.0 115307.4 115978.0 1271.9 1286.3 1335.0 1335.7 1337.1 18883.6 19012.9 20126.1 20286.0 20302.8 55169.0 55301.7 57478.7 58361.4 59568.7 70218.6 70878.6 70988.0 71427.3 72490.3 13011.3 13409.5 13521.5 13618.9 14602.9 21516.9 21834.6 22984.9 23133.1 23261.7 17476.6 17550.1 18140.3 18341.1 18582.9 15534.4 16116.8 16838.6 16870.4 16988.2 18731.3 18920.7 18936.8 18986.1 19207.3 14506.3 14534.6 14545.8 14554.3 20824.3 18791.9 18862.7 18980.0 19067.3 19221.6 18:31:15 INFO - PID 31352 | 18:31:15 INFO - PID 31352 | [#3] mootools.html Cycles:180 Average:8392.37 Median:2404.77 stddev:5722.68 (238.0%) stddev-sans-first:5714.20 18:31:15 INFO - PID 31352 | Values: 1340.3 1397.7 1412.5 1414.1 1414.7 13527.9 13982.9 14101.9 14133.1 14170.9 13686.2 14097.4 14103.4 14126.7 14182.8 2509.5 2554.7 2565.0 2570.2 2578.9 2497.3 2552.0 2558.2 2566.1 2582.0 2531.2 2546.0 2559.6 2573.0 2576.0 2292.2 2294.3 2303.4 2315.9 2327.0 2340.5 2401.0 2401.0 2408.5 2409.1 13305.5 13751.5 13821.4 13848.6 13866.5 7256.3 7522.7 7536.2 7541.1 7564.9 4762.0 4846.8 4926.8 4974.9 4985.5 1763.5 1796.8 1817.1 1860.8 1867.7 20514.2 21132.9 22323.0 22477.8 22646.4 5727.6 5868.8 6306.5 6384.7 6452.6 15375.1 15383.4 15383.8 15515.8 15525.3 7157.5 7426.9 7455.7 7457.4 7464.2 6741.7 6770.8 6817.2 6849.2 6878.2 4668.7 4795.4 4805.8 4841.5 4854.3 1370.2 1384.9 1400.3 1412.9 1423.3 886.2 891.1 913.1 925.3 931.4 7166.2 7208.9 7253.6 8053.2 8198.1 696.9 700.3 709.6 722.1 724.8 4377.5 4501.4 4994.8 5083.2 5088.7 17854.4 17998.4 18482.3 18731.9 19100.0 18432.4 18436.6 18767.8 18794.2 18992.1 10453.2 10534.7 10706.0 10708.5 10713.6 7297.8 7547.6 7633.2 7708.8 7727.8 15692.1 15801.6 15811.4 15930.9 16148.9 15365.0 16166.2 16466.7 16887.7 16920.6 10087.4 10382.1 10390.5 10395.1 10400.5 12792.1 12874.4 12887.9 12952.2 13100.8 9760.6 10168.8 10312.9 10490.1 10526.8 9872.6 10285.0 10296.6 10359.8 10649.5 9447.4 9550.9 9603.4 9607.8 9610.1 6943.5 7119.7 7151.7 7192.4 7212.9 6470.1 6545.6 6596.7 6598.5 6636.0 18:31:15 INFO - PID 31352 | 18:31:15 INFO - PID 31352 | [#4] prototype.html Cycles:180 Average:5388.46 Median:5921.92 stddev:1511.72 (25.5%) stddev-sans-first:1470.56 18:31:15 INFO - PID 31352 | Values: 489.7 500.3 518.2 521.9 530.3 6045.5 6093.1 6124.4 6160.8 6202.8 5743.5 5914.6 5917.9 6017.6 6018.6 4738.0 4837.7 4896.2 4898.0 4936.2 4835.4 4871.0 4891.2 4911.5 4913.5 4816.4 4845.7 4854.2 4915.5 4925.8 4650.1 4836.9 4863.8 4875.8 4886.2 4350.2 4360.9 4362.2 4363.7 4377.9 5803.6 5831.7 5873.4 5925.9 5958.3 5517.4 5520.1 5546.0 5564.7 5573.9 6387.3 6389.2 6391.9 6406.6 6413.5 4724.6 4732.4 4742.6 4765.0 4837.2 6738.2 6745.9 6753.9 6808.6 6830.2 4890.5 4901.7 4910.6 4917.7 4931.9 4901.3 4938.9 4964.4 4982.2 4992.7 5500.6 5510.4 5523.9 5532.3 5562.7 6494.6 6494.9 6503.0 6532.4 6533.5 1727.8 1752.2 1752.9 1754.7 1758.7 1111.1 1128.3 1200.5 1210.8 1226.6 5523.6 5579.2 5615.7 5620.9 5681.6 6443.4 6450.6 6450.9 6526.0 6568.4 5644.2 5647.2 5658.3 5661.0 5728.5 3394.2 3429.4 3484.7 3509.0 3515.4 6252.2 6299.1 6323.2 6323.9 6361.5 6619.5 6661.9 6700.0 6714.3 6733.3 6283.7 6296.3 6301.8 6308.7 6378.8 6427.4 6472.0 6504.9 6559.2 6596.9 6406.4 6488.9 6520.8 6522.6 6589.4 6303.5 6351.2 6382.2 6439.9 6446.5 4937.6 4946.5 4957.7 4958.7 4962.0 6636.2 6636.8 6644.3 6653.5 6691.3 6411.2 6419.3 6424.3 6443.5 6488.2 6300.3 6346.5 6351.0 6427.9 6477.8 6288.5 6290.8 6343.3 6405.7 6420.6 6484.4 6512.5 6516.7 6527.8 6530.2 5995.5 6173.0 6264.2 6303.7 6309.8 18:31:15 INFO - PID 31352 | 18:31:15 INFO - PID 31352 | [#5] yui.html Cycles:180 Average:21969.04 Median:20348.85 stddev:29060.42 (142.8%) stddev-sans-first:29098.82 18:31:15 INFO - PID 31352 | Values: 885.9 899.7 903.4 915.9 918.1 17557.6 18237.3 18314.5 18425.6 18472.5 19529.5 20359.9 20730.7 20978.3 21255.6 1026.7 1046.8 1054.8 1059.8 1062.8 1052.1 1053.4 1053.9 1055.5 1057.9 1012.7 1063.8 1109.3 1114.6 1130.5 1106.7 1110.0 1121.7 1124.8 1125.2 804.3 807.0 809.4 810.4 811.9 19136.4 19732.5 19831.2 19961.4 20518.7 19641.8 19872.2 20337.8 20474.9 20621.3 16503.3 16528.4 16773.6 17036.8 17079.7 3539.9 3549.1 3556.3 3566.8 3572.6 117327.4 117653.4 125851.4 127211.4 128026.4 14638.0 15107.5 15151.2 15265.8 15329.8 27792.2 28603.4 28704.9 28735.4 28826.7 8038.7 8191.8 8330.9 8383.0 8421.6 4185.5 4303.6 4306.1 4307.3 4321.1 4946.0 4983.2 5144.4 5144.8 5147.3 876.4 913.6 969.6 1000.5 1000.7 611.2 679.6 701.9 709.2 725.4 11470.5 11888.4 12065.4 13397.0 14437.4 687.7 709.2 711.0 729.5 732.4 5253.0 5448.3 5579.7 5697.4 5902.5 96100.0 97280.0 98671.0 102352.5 106996.5 85054.0 86800.0 87662.1 89370.0 89754.6 71112.6 75097.2 76268.0 77308.0 78317.2 10860.2 11019.3 11218.8 11256.7 11350.8 33611.7 35078.3 35772.8 36177.8 36550.3 44316.6 44433.0 44465.6 45435.8 45741.8 15616.5 15943.7 16000.7 18205.0 19250.3 20740.4 21632.9 21695.0 21707.3 22092.4 17097.3 19221.9 20122.4 20148.7 20436.2 19370.9 19707.8 20044.9 20170.7 20283.2 18858.3 19058.5 19296.9 19358.9 19613.1 12961.8 14043.0 14053.7 14215.9 14320.9 13545.6 14340.1 14805.3 14951.5 15000.0 18:31:15 INFO - PID 31352 | -------- Summary: end -------- 18:31:15 INFO - PID 31352 | 18:31:16 INFO - TEST-INFO | 31352: exit 0 18:31:16 INFO - TEST-OK | dromaeo_css | took 1111952ms 18:31:16 INFO - TEST-START | kraken 18:31:16 INFO - Initialising browser for kraken test... 18:31:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58493/getInfo.html -profile /tmp/tmpTYaDbg/profile 18:31:16 INFO - TEST-INFO | started process 31770 (/builds/slave/test/build/application/firefox/firefox http://localhost:58493/getInfo.html) 18:31:22 INFO - TEST-INFO | 31770: exit 0 18:31:23 INFO - Browser initialized. 18:31:23 INFO - Running cycle 1/1 for kraken test... 18:31:23 INFO - TEST-INFO | started process 31995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTYaDbg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:31:34 INFO - PID 31995 | RSS: Main: 170647552 18:31:34 INFO - PID 31995 | 18:31:37 INFO - PID 31995 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58493/tests/kraken/driver.html?testName=audio-beat-detection) 18:31:37 INFO - PID 31995 | RSS: Main: 178040832 18:31:37 INFO - PID 31995 | 18:31:40 INFO - PID 31995 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58493/tests/kraken/driver.html?testName=audio-dft) 18:31:41 INFO - PID 31995 | RSS: Main: 178249728 18:31:41 INFO - PID 31995 | 18:31:44 INFO - PID 31995 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58493/tests/kraken/driver.html?testName=audio-fft) 18:31:44 INFO - PID 31995 | RSS: Main: 171409408 18:31:44 INFO - PID 31995 | 18:31:46 INFO - PID 31995 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58493/tests/kraken/driver.html?testName=audio-oscillator) 18:31:47 INFO - PID 31995 | RSS: Main: 172507136 18:31:47 INFO - PID 31995 | 18:31:49 INFO - PID 31995 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58493/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:31:50 INFO - PID 31995 | RSS: Main: 172326912 18:31:50 INFO - PID 31995 | 18:31:53 INFO - PID 31995 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58493/tests/kraken/driver.html?testName=imaging-darkroom) 18:31:53 INFO - PID 31995 | RSS: Main: 176263168 18:31:53 INFO - PID 31995 | 18:31:57 INFO - PID 31995 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58493/tests/kraken/driver.html?testName=imaging-desaturate) 18:31:57 INFO - PID 31995 | RSS: Main: 177246208 18:31:57 INFO - PID 31995 | 18:32:00 INFO - PID 31995 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58493/tests/kraken/driver.html?testName=json-parse-financial) 18:32:01 INFO - PID 31995 | RSS: Main: 176144384 18:32:01 INFO - PID 31995 | 18:32:02 INFO - PID 31995 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58493/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:32:03 INFO - PID 31995 | RSS: Main: 175460352 18:32:03 INFO - PID 31995 | 18:32:05 INFO - PID 31995 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58493/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:32:05 INFO - PID 31995 | RSS: Main: 176168960 18:32:05 INFO - PID 31995 | 18:32:08 INFO - PID 31995 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58493/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:32:08 INFO - PID 31995 | RSS: Main: 175783936 18:32:08 INFO - PID 31995 | 18:32:11 INFO - PID 31995 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58493/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:32:12 INFO - PID 31995 | RSS: Main: 175898624 18:32:12 INFO - PID 31995 | 18:32:15 INFO - PID 31995 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58493/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:32:15 INFO - PID 31995 | RSS: Main: 176693248 18:32:15 INFO - PID 31995 | 18:32:17 INFO - PID 31995 | Cycle 1(1): loaded http://localhost:58493/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58493/tests/kraken/driver.html?testName=ai-astar) 18:32:17 INFO - PID 31995 | RSS: Main: 178003968 18:32:17 INFO - PID 31995 | 18:32:17 INFO - PID 31995 | __start_tp_report 18:32:17 INFO - PID 31995 | _x_x_mozilla_page_load 18:32:17 INFO - PID 31995 | _x_x_mozilla_page_load_details 18:32:17 INFO - PID 31995 | |i|pagename|runs| 18:32:17 INFO - PID 31995 | |0;ai-astar;100;111;103;111;112;110;110;100;109;108 18:32:17 INFO - PID 31995 | |1;audio-beat-detection;166;120;146;173;122;149;149;125;188;124 18:32:17 INFO - PID 31995 | |2;audio-dft;163;163;161;162;162;169;165;165;172;164 18:32:17 INFO - PID 31995 | |3;audio-fft;75;75;75;163;75;74;76;75;93;76 18:32:17 INFO - PID 31995 | |4;audio-oscillator;82;84;136;82;82;82;138;84;83;133 18:32:17 INFO - PID 31995 | |5;imaging-gaussian-blur;113;113;114;115;114;113;113;113;115;113 18:32:17 INFO - PID 31995 | |6;imaging-darkroom;150;149;151;150;150;150;150;151;150;152 18:32:17 INFO - PID 31995 | |7;imaging-desaturate;94;95;94;94;94;93;94;94;94;94 18:32:17 INFO - PID 31995 | |8;json-parse-financial;56;54;55;54;55;55;57;55;56;55 18:32:17 INFO - PID 31995 | |9;json-stringify-tinderbox;55;54;54;55;53;55;54;55;54;54 18:32:17 INFO - PID 31995 | |10;stanford-crypto-aes;86;79;80;81;77;77;78;81;80;78 18:32:17 INFO - PID 31995 | |11;stanford-crypto-ccm;137;126;124;127;132;126;128;125;134;153 18:32:17 INFO - PID 31995 | |12;stanford-crypto-pbkdf2;187;190;183;193;191;182;181;182;181;192 18:32:17 INFO - PID 31995 | |13;stanford-crypto-sha256-iterative;67;75;70;71;69;71;71;74;70;69 18:32:17 INFO - PID 31995 | __end_tp_report 18:32:17 INFO - PID 31995 | __start_cc_report 18:32:17 INFO - PID 31995 | _x_x_mozilla_cycle_collect,939 18:32:17 INFO - PID 31995 | __end_cc_report 18:32:17 INFO - PID 31995 | __startTimestamp1500341537720__endTimestamp 18:32:17 INFO - PID 31995 | 18:32:17 INFO - PID 31995 | ------- Summary: start ------- 18:32:17 INFO - PID 31995 | Number of tests: 14 18:32:17 INFO - PID 31995 | 18:32:17 INFO - PID 31995 | [#0] ai-astar Cycles:10 Average:107.40 Median:110.00 stddev:4.62 (4.2%) stddev-sans-first:4.06 18:32:17 INFO - PID 31995 | Values: 100.0 111.0 103.0 111.0 112.0 110.0 110.0 100.0 109.0 108.0 18:32:17 INFO - PID 31995 | 18:32:17 INFO - PID 31995 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:149.00 stddev:23.78 (16.0%) stddev-sans-first:24.11 18:32:17 INFO - PID 31995 | Values: 166.0 120.0 146.0 173.0 122.0 149.0 149.0 125.0 188.0 124.0 18:32:17 INFO - PID 31995 | 18:32:17 INFO - PID 31995 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:3.44 (2.1%) stddev-sans-first:3.60 18:32:17 INFO - PID 31995 | Values: 163.0 163.0 161.0 162.0 162.0 169.0 165.0 165.0 172.0 164.0 18:32:17 INFO - PID 31995 | 18:32:17 INFO - PID 31995 | [#3] audio-fft Cycles:10 Average:85.70 Median:75.00 stddev:27.74 (37.0%) stddev-sans-first:29.15 18:32:17 INFO - PID 31995 | Values: 75.0 75.0 75.0 163.0 75.0 74.0 76.0 75.0 93.0 76.0 18:32:17 INFO - PID 31995 | 18:32:17 INFO - PID 31995 | [#4] audio-oscillator Cycles:10 Average:98.60 Median:82.00 stddev:25.62 (31.2%) stddev-sans-first:26.46 18:32:17 INFO - PID 31995 | Values: 82.0 84.0 136.0 82.0 82.0 82.0 138.0 84.0 83.0 133.0 18:32:17 INFO - PID 31995 | 18:32:17 INFO - PID 31995 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:113.50 stddev:0.84 (0.7%) stddev-sans-first:0.87 18:32:17 INFO - PID 31995 | Values: 113.0 113.0 114.0 115.0 114.0 113.0 113.0 113.0 115.0 113.0 18:32:17 INFO - PID 31995 | 18:32:17 INFO - PID 31995 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 18:32:17 INFO - PID 31995 | Values: 150.0 149.0 151.0 150.0 150.0 150.0 150.0 151.0 150.0 152.0 18:32:17 INFO - PID 31995 | 18:32:17 INFO - PID 31995 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 18:32:17 INFO - PID 31995 | Values: 94.0 95.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 18:32:17 INFO - PID 31995 | 18:32:17 INFO - PID 31995 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:0.92 (1.7%) stddev-sans-first:0.93 18:32:17 INFO - PID 31995 | Values: 56.0 54.0 55.0 54.0 55.0 55.0 57.0 55.0 56.0 55.0 18:32:17 INFO - PID 31995 | 18:32:17 INFO - PID 31995 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.50 stddev:0.67 (1.2%) stddev-sans-first:0.67 18:32:17 INFO - PID 31995 | Values: 55.0 54.0 54.0 55.0 53.0 55.0 54.0 55.0 54.0 54.0 18:32:17 INFO - PID 31995 | 18:32:17 INFO - PID 31995 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:2.67 (3.3%) stddev-sans-first:1.58 18:32:17 INFO - PID 31995 | Values: 86.0 79.0 80.0 81.0 77.0 77.0 78.0 81.0 80.0 78.0 18:32:17 INFO - PID 31995 | 18:32:17 INFO - PID 31995 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:130.00 stddev:8.75 (6.7%) stddev-sans-first:9.03 18:32:17 INFO - PID 31995 | Values: 137.0 126.0 124.0 127.0 132.0 126.0 128.0 125.0 134.0 153.0 18:32:17 INFO - PID 31995 | 18:32:17 INFO - PID 31995 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.20 Median:188.50 stddev:4.92 (2.6%) stddev-sans-first:5.21 18:32:17 INFO - PID 31995 | Values: 187.0 190.0 183.0 193.0 191.0 182.0 181.0 182.0 181.0 192.0 18:32:17 INFO - PID 31995 | 18:32:17 INFO - PID 31995 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.00 stddev:2.36 (3.3%) stddev-sans-first:2.09 18:32:17 INFO - PID 31995 | Values: 67.0 75.0 70.0 71.0 69.0 71.0 71.0 74.0 70.0 69.0 18:32:17 INFO - PID 31995 | -------- Summary: end -------- 18:32:17 INFO - PID 31995 | 18:32:18 INFO - PID 31995 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:32:18 INFO - TEST-INFO | 31995: exit 0 18:32:18 INFO - TEST-OK | kraken | took 62143ms 18:32:18 INFO - SUITE-END | took 1174s 18:32:18 INFO - Completed test suite (00:19:34) 18:32:18 INFO - javascript benchmark 18:32:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8243.130615898519, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3080.3993221321853, 3090.4591696453117, 3101.5657807906896, 3103.705148010939, 3107.1144723753728, 5978.671173085479, 6017.097435384689, 6019.8495037624025, 6094.1468194452755, 6137.26352837659, 6104.5116390688745, 6121.143039974396, 6172.9074063889075, 6176.320604733487, 6179.443850053494, 5588.86027849305, 5610.831675049755, 5632.436756324355, 5651.208830763697, 5670.631408958405, 5525.226468294442, 5537.280153580029, 5616.9157462638095, 5660.773569057233, 5682.914756278659, 5497.147942068986, 5521.585881058937, 5526.640768350085, 5558.277423934883, 5590.496855283024, 5533.861653458655, 5561.555075593943, 5581.49766521011, 5584.6090773645865, 5586.441355864422, 5477.123660214386, 5544.279243698294, 5554.1946417769195, 5556.388797232301, 5561.221428999943, 5964.910526342108, 5978.611390259663, 5981.5214782817275, 6003.759849606011, 6014.338422773491, 6532.771353002622, 6534.019897015438, 6537.477001839841, 6543.149390579194, 6551.4431273341825, 6610.7355705771715, 6615.834604134887, 6623.9006414903815, 6624.668766561653, 6639.535232533724, 6080.14877917092, 6108.816735497898, 6114.419130182626, 6131.908021379683, 6189.288231853349, 6748.089007983957, 6753.324667533306, 6823.454123670094, 6839.589624622538, 6857.828554286183, 6344.111824344595, 6434.067060276234, 6442.420182183626, 6486.545941784124, 6503.187101612299, 6455.419012288917, 6458.063580780855, 6458.12815269942, 6474.482041436674, 6481.870362592722, 5322.0, 6379.266384365857, 6403.807885763435, 6472.288048314682, 6485.70814313357, 6313.0, 6377.585456945284, 6387.977923532212, 6487.3836985486305, 6539.574927629784, 5254.500822421864, 5321.0, 5333.466653334635, 5344.171653393731, 5380.91928621071, 4509.6392288616835, 4524.0, 4552.88617784558, 4560.908781824345, 4626.884327891829, 5594.832155035356, 5600.467955544217, 5640.576956728261, 5655.632383895034, 5667.036603777367, 6424.807255782334, 6559.720854433435, 6569.540132190797, 6648.96675516629, 6663.333666633394, 5565.332160140728, 5619.747111379916, 5701.800436984686, 5702.971485142548, 5705.4579814917515, 5676.943230567724, 5736.397678243808, 5808.912866307009, 5809.0, 5809.593328466966, 6200.596961197598, 6211.627302361872, 6232.283287422005, 6241.095041218998, 6323.336049714806, 6453.9354606453335, 6530.8040758777315, 6554.213494380705, 6563.048357987969, 6566.113574667359, 6301.747930082745, 6308.116863639002, 6311.147995020613, 6313.684315784284, 6322.810315690536, 5558.749856256559, 6382.329855365306, 6406.807795766134, 6413.16628838248, 6416.903746443901, 6553.541252112306, 6587.143671322698, 6602.537822352389, 6645.568038077509, 6664.733410663519, 6330.746770129143, 6344.777932772331, 6410.1025856381075, 6440.6135631862235, 6444.420002199825, 6208.3791620839365, 6330.366963303817, 6361.809145725636, 6403.7118329676205, 6421.71102300407, 6222.160008398808, 6241.344658810941, 6246.1255424239735, 6263.060540918898, 6271.3415091414745, 6231.563790534619, 6315.147455093687, 6326.304106548184, 6339.809805705836, 6383.457406120532, 6169.259688837189, 6188.1027251049245, 6194.876102477835, 6198.132261483486, 6198.535109866868], "value": 5940.81321996934, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.171861033014, 741.7589283482863, 761.1665226576899, 784.2236186175686, 793.9483933544316, 41172.588274117246, 41961.580384196146, 42104.36843447351, 42143.0, 42325.78837105814, 38464.23071538575, 38734.8063259684, 38746.64386746464, 38756.418653720146, 38853.0, 6784.084148639944, 6866.313368663119, 6888.001239820223, 6905.033295338657, 6905.551139175963, 6751.257361690235, 6821.420179284767, 6863.519553631248, 6887.552309099892, 6895.275996020421, 6822.863542729143, 6871.862562748742, 6883.759068432606, 6896.862062758742, 6909.654517274142, 6745.0556922030955, 6762.357576030269, 6790.320967903195, 6801.4218791402545, 6830.282820303871, 6009.948259054648, 6100.176476175704, 6103.206583144163, 6167.599106058136, 6180.567360284782, 33917.6608233917, 34172.0, 34178.145546361295, 34343.6565634343, 34372.312553749034, 3418.8632454701783, 3459.4637831136215, 3576.535050443426, 3673.5040769496045, 3677.8344974476213, 32790.0, 32984.505232421296, 33035.504467433006, 33067.50398744021, 33152.0, 4838.685485443435, 4844.418669759616, 4896.583790377822, 4913.901721965576, 4938.580220681247, 178406.10796946063, 178898.9999999987, 197416.0, 197826.0, 198099.0, 44240.0, 44535.0, 49163.50836491661, 49641.50358496441, 49864.501354986714, 51015.489845101816, 51090.0, 51236.74381628068, 51387.0, 51477.7426112867, 15831.208439577975, 15879.12664803447, 15887.761683574756, 15925.442609508611, 15925.840741592667, 13454.865451345557, 13482.85395741373, 13500.662483437993, 13502.594922152352, 13621.25083120438, 13700.972427068009, 13737.862621373859, 13753.312334383241, 13855.099418537762, 13938.233397163254, 5556.333240011225, 5577.135543990688, 5608.1587761835235, 5661.952538780339, 5674.97162514193, 965.724768441005, 979.8775153105862, 984.1683777208248, 997.1623835977814, 999.8200323941614, 22613.434664133198, 23026.078956841873, 23062.538749225256, 23340.949657265464, 29452.55821162684, 1067.4822710985165, 1077.8113830079863, 1088.5319312695617, 1090.9454527273604, 1102.5314241447352, 12296.75406491883, 12396.566120185931, 12483.0, 12493.562725304571, 12517.123801333819, 243741.0, 245586.0, 247052.0, 247961.0, 248302.0, 52248.21627675588, 52440.0, 52640.473595264324, 52710.209346859825, 52780.47219527832, 1448.4278709909738, 1495.0431723696843, 1509.8792096632462, 1510.2826157575284, 1519.050593379138, 21865.53188151441, 22056.33830985073, 22274.888625557418, 22295.66556501686, 22711.0, 38004.809975949946, 38202.0, 38339.42490862695, 38346.42480362741, 38389.232215356096, 210550.0, 211632.0, 212117.93941030197, 212241.0, 213296.0, 31006.534901976036, 31119.0, 31193.220169495944, 31940.5208921871, 34230.48654270138, 41736.0, 43458.0, 43585.0, 43719.34420983624, 43829.34255986099, 29581.03429352513, 30873.28741687773, 31777.0, 32199.55102020368, 32367.190820229684, 30482.826193457113, 31229.53155702621, 31646.525302120026, 31751.04746857598, 31794.84102579472, 34698.65301346954, 34720.652793471745, 34868.82565587156, 35113.47329790004, 35402.46896296506, 29227.0, 31042.53436198504, 31299.0, 31302.843485782425, 31570.526442103845, 22932.0, 23718.0, 23722.406939825953, 23748.287551373487, 24197.51604967926], "value": 16667.63177581535, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.290970467506, 562.1455387810526, 573.3206150711408, 578.141459932001, 592.5111782779206, 16121.91939040303, 21151.57696846062, 22426.88786556067, 22485.775142248574, 22499.662505062395, 19401.223951041942, 19760.01199940001, 19842.503937401572, 21745.782542174573, 24576.75423245767, 6151.292601350857, 6327.335629758878, 6344.555881088326, 6350.491960643138, 6359.55483116182, 6232.657203853786, 6296.905546416808, 6351.079093531435, 6353.714082866282, 6362.936370636281, 3766.962330376702, 5854.765809367642, 6311.526635502356, 6326.905096423558, 6342.6511541865175, 6303.968480157616, 6307.274663413675, 6317.842053948665, 6318.210223722035, 6319.873602527947, 5866.794662186846, 5867.0, 5868.647881127104, 5876.471117599393, 5893.263342082239, 28155.155345339674, 28344.291392715142, 28492.145235642965, 28502.144935651962, 28511.71488285132, 1866.9906650466796, 1914.4065339744584, 1970.339936121401, 1976.7430234069623, 1987.4435158155738, 18335.816641833677, 18640.0, 18661.720074198896, 18673.439796806117, 18684.0, 2208.9116435342726, 2217.7671344508753, 2240.148743477468, 2257.853239539441, 2333.381653861728, 124926.37536812348, 127645.0, 130800.0, 133505.0, 133679.6632033677, 13887.444502219798, 14542.563723088324, 14856.182909940057, 14964.176970266522, 14970.62573435651, 22810.0, 22813.543729125657, 22841.31476055721, 22860.42848928757, 22884.313470595574, 10350.637727679647, 10440.675255619688, 10449.268551201343, 10572.048515633629, 10646.840297395545, 9819.754506137404, 9884.752881177885, 9943.900560994442, 10034.046765557261, 10048.497575121215, 8996.640134394682, 9133.269338452908, 9148.496832674135, 9199.402038867453, 9264.72205833826, 2647.3381654586356, 2652.4032092779357, 2669.9599506007426, 2691.3809823740257, 2813.8041332434045, 973.4241333848814, 973.4548652754338, 985.3574504737295, 995.8456439251928, 1001.6844693921537, 18386.448406547825, 19027.14377853, 19113.713294300596, 19228.134733937008, 19331.613367732567, 1018.7554986803262, 1044.6500422358442, 1046.4819914142547, 1070.7216123807866, 1071.8820929697727, 10317.896821031844, 10493.790124197625, 10592.0, 10609.84085238722, 10649.0, 429538.0, 484618.0, 499892.0, 501397.0, 511272.0, 111092.0, 112287.4385628083, 112966.0, 115307.42346288214, 115978.0, 1271.853736820259, 1286.26040026983, 1334.9933250333686, 1335.7128217433103, 1337.0774165825549, 18883.622327553647, 19012.904935475235, 20126.094325755083, 20286.0, 20302.79697203009, 55169.0, 55301.72349138228, 57478.7126064367, 58361.4163858356, 59568.702156488944, 70218.64890675514, 70878.64560677164, 70988.0, 71427.28572714207, 72490.27509724835, 13011.284379359226, 13409.530666426628, 13521.526746563823, 13618.93190534041, 14602.85397146015, 21516.892415537823, 21834.563308734054, 22984.885075574515, 23133.074677013403, 23261.651075234222, 17476.563085922953, 17550.122493875, 18140.274389024293, 18341.082945852922, 18582.907085464485, 15534.378624854879, 16116.758248626515, 16838.57903552421, 16870.409535666193, 16988.235529400958, 18731.250749970393, 18920.7161892569, 18936.810631893506, 18986.1456234467, 19207.32774352891, 14506.274686265855, 14534.563963081124, 14545.781813272597, 14554.345054472786, 20824.271150510267, 18791.90604046971, 18862.71705924385, 18980.0, 19067.332643357415, 19221.615567688288], "value": 11764.383413365096, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.3298350824587, 1397.6855207578296, 1412.5479846449134, 1414.1373762005182, 1414.681696618261, 13527.864721352784, 13982.930085349559, 14101.929490352533, 14133.081349712262, 14170.929145354272, 13686.247256400893, 14097.436102555912, 14103.365348559313, 14126.717465650681, 14182.787258191136, 2509.4604659998145, 2554.6551215585937, 2564.974350256492, 2570.2417786752953, 2578.8968441262327, 2497.3382053755677, 2552.0302285131716, 2558.206955843685, 2566.101864347482, 2582.0, 2531.164715643833, 2546.0, 2559.5776696844996, 2572.974270257292, 2576.046862660818, 2292.1633603734685, 2294.2773026496684, 2303.3780879162614, 2315.90736370545, 2327.045911176418, 2340.461693810433, 2400.987995060031, 2401.0, 2408.542376948392, 2409.1447536124774, 13305.467781288737, 13751.518696845662, 13821.378037988316, 13848.584542463743, 13866.514671986533, 7256.346928776436, 7522.699092036312, 7536.208698086677, 7541.095068591804, 7564.886526702104, 4761.952380476186, 4846.806127754886, 4926.753662316905, 4974.925376119361, 4985.501449855022, 1763.4621440460655, 1796.7664203653571, 1817.100535235054, 1860.8232217939274, 1867.6638205123072, 20514.179432822817, 21132.894335528224, 22323.0, 22477.775222247896, 22646.43383915399, 5727.627704199213, 5868.794592189253, 6306.4639505642535, 6384.7126879290545, 6452.612843229421, 15375.077495350315, 15383.38466461329, 15383.769243461356, 15515.767263491056, 15525.301361438762, 7157.463190260752, 7426.9257307427315, 7455.739049133363, 7457.366123879422, 7464.178940316561, 6741.730330786713, 6770.830729231809, 6817.216020157646, 6849.2465828758795, 6878.174619045646, 4668.719876807402, 4795.448523419851, 4805.8077676892535, 4841.491643377465, 4854.320395144682, 1370.2463644995412, 1384.9169049857042, 1400.3278426355407, 1412.9081609695336, 1423.2954687429788, 886.2156991062956, 891.1445012787797, 913.0960349254191, 925.3337596930199, 931.3992474853682, 7166.175889772743, 7208.927910720826, 7253.601051942193, 8053.15441878606, 8198.139195384518, 696.9162951610193, 700.261224408244, 709.5848928376854, 722.1334398721555, 724.7680742162563, 4377.4528183977, 4501.392312037899, 4994.775235114428, 5083.2375143727995, 5088.669236499616, 17854.375096871547, 17998.37005704794, 18482.260709571467, 18731.90634046821, 19100.044997750334, 18432.354867579572, 18436.631267374578, 18767.812321876878, 18794.248230070643, 18992.145353459127, 10453.163746900229, 10534.736631584272, 10705.982931621484, 10708.518116684769, 10713.625023124308, 7297.781066568012, 7547.622618868925, 7633.198514156155, 7708.845823083395, 7727.806804829925, 15692.058476491447, 15801.604959876095, 15811.367545298519, 15930.920345398663, 16148.919255404118, 15365.0, 16166.191690415197, 16466.68063077926, 16887.66224675524, 16920.57698557546, 10087.394756314645, 10382.065614094769, 10390.480475976019, 10395.116415104801, 10400.479976001321, 12792.104552681596, 12874.420651070912, 12887.871121288666, 12952.158109722837, 13100.803487947878, 9760.560774765294, 10168.84746728785, 10312.948435257777, 10490.108340791117, 10526.842097368393, 9872.555734992085, 10285.0, 10296.588136474757, 10359.792804144026, 10649.467526623794, 9447.385919915183, 9550.90449095528, 9603.37578057424, 9607.759806004906, 9610.135087841849, 6943.47923905699, 7119.715211391694, 7151.749688760869, 7192.352688257873, 7212.855742885218, 6470.126532917996, 6545.574537655038, 6596.70314835824, 6598.538102332791, 6635.966820165868], "value": 6087.100974664085, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.72575357799656, 500.32206360381684, 518.2071430711013, 521.9321488206534, 530.2894121876684, 6045.486133678637, 6093.080679585927, 6124.356942521038, 6160.784372546962, 6202.8206447616185, 5743.5118014968775, 5914.6155499892475, 5917.934771741085, 6017.608855424405, 6018.578699491027, 4738.0, 4837.661363704542, 4896.192128298826, 4897.951020489785, 4936.185529387647, 4835.419749630032, 4871.0, 4891.192953162724, 4911.5088491150955, 4913.484084171164, 4816.373871396731, 4845.685030473026, 4854.247591623304, 4915.459299477055, 4925.808015433134, 4650.139724151026, 4836.9201243465295, 4863.756812159413, 4875.780589873429, 4886.218205087169, 4350.1734670412525, 4360.890977725582, 4362.17118747437, 4363.716358436692, 4377.934330985037, 5803.622764520293, 5831.679257640828, 5873.412658734135, 5925.911111333334, 5958.285005799288, 5517.44825517449, 5520.095567029369, 5545.972270138664, 5564.666120032771, 5573.944260557383, 6387.329330420332, 6389.1694079769795, 6391.872162556723, 6406.615603063785, 6413.5189860760165, 4724.5984091352275, 4732.408448943882, 4742.644301677354, 4765.0, 4837.177679794443, 6738.22510411304, 6745.932540674579, 6753.89869151968, 6808.6255255960905, 6830.209233875197, 4890.510948905152, 4901.705897646153, 4910.607151427877, 4917.680350777188, 4931.901361972812, 4901.255297033673, 4938.925916111261, 4964.429090654548, 4982.153033984231, 4992.726854652041, 5500.614956952975, 5510.421405752419, 5523.861903452365, 5532.28080349552, 5562.694051827189, 6494.577852439576, 6494.935050649433, 6502.951570255354, 6532.399562107219, 6533.542652014314, 1727.8444939955214, 1752.1502071495315, 1752.9211185496683, 1754.6841568517789, 1758.7273972534279, 1111.1166622535104, 1128.2891778179694, 1200.4514176712119, 1210.8062709966364, 1226.6136167107334, 5523.585731070186, 5579.246801681802, 5615.691136987423, 5620.9437905621235, 5681.573881958787, 6443.387878151568, 6450.645214513153, 6450.903236451457, 6526.0, 6568.405479835534, 5644.230625121765, 5647.181158732043, 5658.264425624642, 5660.971695141498, 5728.51307638847, 3394.185395505061, 3429.382711111974, 3484.686378225972, 3508.9649103508636, 3515.402381595135, 6252.155958945484, 6299.0866324382705, 6323.177986861679, 6323.936760632427, 6361.522885783492, 6619.536632435684, 6661.866762664719, 6699.9665001674675, 6714.29499902513, 6733.326667333227, 6283.654399008098, 6296.2759282681245, 6301.842453938597, 6308.653024083627, 6378.77674281398, 6427.357264273535, 6472.0, 6504.869902601827, 6559.245686745894, 6596.944488881756, 6406.405405810654, 6488.902666459912, 6520.793653174178, 6522.5760325578685, 6589.4069533742195, 6303.46420554258, 6351.2060992375955, 6382.170317858649, 6439.935600643934, 6446.4520515756685, 4937.580305674058, 4946.4558898521855, 4957.677750946177, 4958.677685950402, 4962.0, 6636.203655561363, 6636.767713130017, 6644.302348253364, 6653.500987425866, 6691.297413771484, 6411.198600174978, 6419.293877673359, 6424.2933277338525, 6443.517990862034, 6488.156539649815, 6300.306966233619, 6346.524010699309, 6350.968245158745, 6427.903581446189, 6477.77327793525, 6288.528360373082, 6290.779822706367, 6343.333949935375, 6405.701063951975, 6420.564997726194, 6484.416402523607, 6512.511561632991, 6516.706748196248, 6527.771527996687, 6530.216374035146, 5995.520358371407, 6172.969135154475, 6264.248290205204, 6303.684815759286, 6309.779157729457], "value": 4945.629749042974, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [885.9158379953903, 899.7480705402486, 903.3811838890358, 915.9358844880853, 918.0681608167711, 17557.64884702307, 18237.270509179634, 18314.542136446595, 18425.631487370243, 18472.538186545342, 19529.51176220595, 20359.89820050898, 20730.689039664416, 20978.265760698378, 21255.574888502222, 1026.7073883943078, 1046.8063408269456, 1054.8312270036795, 1059.793340298642, 1062.8458873463344, 1052.0846863229, 1053.4311471805215, 1053.8629978102836, 1055.530289021386, 1057.8994995475457, 1012.7012531303246, 1063.8351055586397, 1109.2567979453745, 1114.5987444519967, 1130.4573804573809, 1106.7067227184803, 1110.0453609895483, 1121.7476067884743, 1124.8087825069758, 1125.1729978465821, 804.284187073505, 806.9838603227961, 809.4293523066283, 810.3841080778592, 811.9025716913949, 19136.425907222805, 19732.50668733293, 19831.206751729915, 19961.401157965283, 20518.692219616718, 19641.80358196414, 19872.205111795654, 20337.796622033737, 20474.897625511927, 20621.278255261142, 16503.257353419125, 16528.421505247257, 16773.580660483465, 17036.82963170377, 17079.743803842954, 3539.94690079649, 3549.0772399176144, 3556.28874225156, 3566.8038257895805, 3572.5534308211472, 117327.4133629335, 117653.41173294165, 125851.3707431457, 127211.36394318062, 128026.35986820099, 14638.0, 15107.4712385066, 15151.242437878282, 15265.847341526665, 15329.770053449207, 27792.16623501298, 28603.427931441256, 28704.856475717905, 28735.42529149405, 28826.71173288282, 8038.678452861937, 8191.79520511992, 8330.916690833135, 8383.035950865607, 8421.621027053674, 4185.518665353462, 4303.569643035671, 4306.074194048295, 4307.310830267143, 4321.114171594815, 4945.950540494549, 4983.202687570044, 5144.356955380577, 5144.794208231704, 5147.279380886679, 876.4084243135858, 913.5751875377981, 969.5636963366513, 1000.5297510170209, 1000.6747806962766, 611.1535523300261, 679.6058286194094, 701.8982247574073, 709.2234003765868, 725.365305357812, 11470.483828227583, 11888.405579720978, 12065.396730163457, 13397.0, 14437.422503099968, 687.6836655138592, 709.230484923853, 710.9715611375487, 729.4711334282603, 732.4213871041924, 5253.026948317457, 5448.318960129984, 5579.6652200868075, 5697.401772813878, 5902.468777810018, 96100.03899961051, 97280.0, 98671.0, 102352.48823755834, 106996.46501767598, 85054.0, 86800.0, 87662.12337876539, 89370.0, 89754.55122724344, 71112.64443677852, 75097.24902751012, 76268.0, 77308.0, 78317.216827831, 10860.185486088732, 11019.338839669645, 11218.775624487302, 11256.662300131009, 11350.772984540428, 33611.663883361834, 35078.29843403168, 35772.821135894155, 36177.819110904275, 36550.26899462049, 44316.55683443253, 44433.0, 44465.55534444614, 45435.772821137005, 45741.771291143334, 15616.4534241301, 15943.68112637764, 16000.679986400439, 18205.0, 19250.326238581583, 20740.377788666363, 21632.891835540722, 21695.0, 21707.348779536638, 22092.447688807908, 17097.316107355568, 19221.90389048046, 20122.39632811018, 20148.697769533763, 20436.182552697726, 19370.903145484182, 19707.802921970597, 20044.899775501028, 20170.697439538126, 20283.188672452936, 18858.339958101402, 19058.52353691169, 19296.903515482893, 19358.903205483883, 19613.117409716313, 12961.805572916226, 14043.0, 14053.718925621635, 14215.857841421453, 14320.928395358373, 13545.59363219105, 14340.067895586753, 14805.259737013323, 14951.476698315506, 15000.0], "value": 8945.494483497692, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 103.0, 111.0, 112.0, 110.0, 110.0, 100.0, 109.0, 108.0], "value": 107.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 120.0, 146.0, 173.0, 122.0, 149.0, 149.0, 125.0, 188.0, 124.0], "value": 146.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 162.0, 162.0, 169.0, 165.0, 165.0, 172.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 163.0, 75.0, 74.0, 76.0, 75.0, 93.0, 76.0], "value": 85.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 136.0, 82.0, 82.0, 82.0, 138.0, 84.0, 83.0, 133.0], "value": 98.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 115.0, 114.0, 113.0, 113.0, 113.0, 115.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 151.0, 150.0, 150.0, 150.0, 150.0, 151.0, 150.0, 152.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 54.0, 55.0, 55.0, 57.0, 55.0, 56.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 55.0, 53.0, 55.0, 54.0, 55.0, 54.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 79.0, 80.0, 81.0, 77.0, 77.0, 78.0, 81.0, 80.0, 78.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 126.0, 124.0, 127.0, 132.0, 126.0, 128.0, 125.0, 134.0, 153.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 190.0, 183.0, 193.0, 191.0, 182.0, 181.0, 182.0, 181.0, 192.0], "value": 186.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 75.0, 70.0, 71.0, 69.0, 71.0, 71.0, 74.0, 70.0, 69.0], "value": 70.7, "unit": "score"}]}]} 18:32:18 INFO - Return code: 0 18:32:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:32:19 INFO - # TBPL SUCCESS # 18:32:19 INFO - Running post-action listener: _package_coverage_data 18:32:19 INFO - Running post-action listener: _resource_record_post_action 18:32:19 INFO - [mozharness: 2017-07-18 01:32:19.009731Z] Finished run-tests step (success) 18:32:19 INFO - Running post-run listener: _resource_record_post_run 18:32:19 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 433737728; Read time: 152; Write time: 259772 18:32:19 INFO - TinderboxPrint: CPU usage
13.1% 18:32:19 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 152 18:32:19 INFO - TinderboxPrint: I/O write bytes / time
433,737,728 / 259,772 18:32:19 INFO - TinderboxPrint: CPU idle
8,266.6 (86.9%) 18:32:19 INFO - TinderboxPrint: CPU user
1,197.9 (12.6%) 18:32:19 INFO - TinderboxPrint: Swap in / out
0 / 0 18:32:19 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 107102208; Read time: 140; Write time: 65556 18:32:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:32:19 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 326635520; Read time: 0; Write time: 194216 18:32:19 INFO - Running post-run listener: _upload_blobber_files 18:32:19 INFO - Blob upload gear active. 18:32:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:32:19 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:32:19 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:32:19 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:32:20 INFO - Traceback (most recent call last): 18:32:20 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 18:32:20 INFO - main() 18:32:20 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 18:32:20 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 18:32:20 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 18:32:20 INFO - return set(response.json().get('whitelist', [])) 18:32:20 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 18:32:20 INFO - return json.loads(self.text or self.content, **kwargs) 18:32:20 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 18:32:20 INFO - return _default_decoder.decode(s) 18:32:20 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 18:32:20 INFO - obj, end = self.raw_decode(s) 18:32:20 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 18:32:20 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 18:32:20 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 18:32:20 ERROR - Return code: 1 18:32:20 INFO - Setting buildbot property blobber_files to {} 18:32:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:32:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:32:20 INFO - Contents: 18:32:20 INFO - blobber_files:{} 18:32:20 INFO - Running post-run listener: copy_logs_to_upload_dir 18:32:20 INFO - Copying logs to upload dir... 18:32:20 INFO - mkdir: /builds/slave/test/build/upload/logs 18:32:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.017678 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-07-17 18:32:19.766884) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-17 18:32:19.769993) ========= 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=d2a8c569965ab8367867b893000001a1-1500339494.74252-244863601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/e_KBwBrBSNuUWab6NjyQ4Q/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-17 18:32:19.821052) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 18:32:19.821401) ========= 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=d2a8c569965ab8367867b893000001a1-1500339494.74252-244863601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 18:32:19.872113) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 18:32:19.872432) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 18:32:19.872805) ========= ========= Total master_lag: 0.15 =========