builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1494586330.39 results: success (0) revision: 8a7d0b15595f9916123848ca906f29c62d4914c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:10.394560) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:10.396255) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:10.396586) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:10.425104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:10.425369) ========= 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=3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-12 03:52:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 49.7M=0s 2017-05-12 03:52:10 (49.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.160421 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:10.603041) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:10.603412) ========= 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=3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021020 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:10.653565) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:10.653968) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8a7d0b15595f9916123848ca906f29c62d4914c9 --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 8a7d0b15595f9916123848ca906f29c62d4914c9 --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=3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-12 03:52:10,663 truncating revision to first 12 chars 2017-05-12 03:52:10,663 Setting DEBUG logging. 2017-05-12 03:52:10,663 attempt 1/10 2017-05-12 03:52:10,663 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8a7d0b15595f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-12 03:52:10,993 unpacking tar archive at: mozilla-central-8a7d0b15595f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.711224 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:11.378304) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:11.378633) ========= script_repo_revision: 8a7d0b15595f9916123848ca906f29c62d4914c9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:11.379001) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:11.379258) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:11.389724) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-12 03:52:11.390008) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:52:11 INFO - MultiFileLogger online at 20170512 03:52:11 in /builds/slave/test 03:52:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:52:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:52:11 INFO - {'append_to_log': False, 03:52:11 INFO - 'base_work_dir': '/builds/slave/test', 03:52:11 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:52:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:52:11 INFO - 'branch': 'Firefox-Non-PGO', 03:52:11 INFO - 'buildbot_json_path': 'buildprops.json', 03:52:11 INFO - 'config_files': ('talos/linux_config.py',), 03:52:11 INFO - 'default_actions': ('clobber', 03:52:11 INFO - 'read-buildbot-config', 03:52:11 INFO - 'download-and-extract', 03:52:11 INFO - 'populate-webroot', 03:52:11 INFO - 'create-virtualenv', 03:52:11 INFO - 'install', 03:52:11 INFO - 'run-tests'), 03:52:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:52:11 INFO - 'download_minidump_stackwalk': True, 03:52:11 INFO - 'download_symbols': 'ondemand', 03:52:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:52:11 INFO - 'tooltool.py': '/tools/tooltool.py', 03:52:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:52:11 INFO - '/tools/misc-python/virtualenv.py')}, 03:52:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:52:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:52:11 INFO - 'gecko_profile': False, 03:52:11 INFO - 'gecko_profile_interval': 0, 03:52:11 INFO - 'installer_path': 'installer.exe', 03:52:11 INFO - 'log_level': 'info', 03:52:11 INFO - 'log_name': 'talos', 03:52:11 INFO - 'log_to_console': True, 03:52:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:52:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:52:11 INFO - 'opt_config_files': (), 03:52:11 INFO - 'pip_index': False, 03:52:11 INFO - 'suite': 'dromaeojs', 03:52:11 INFO - 'system_bits': '32', 03:52:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:52:11 INFO - 'title': 'talos-linux64-ix-030', 03:52:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:52:11 INFO - 'use_talos_json': True, 03:52:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:52:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:52:11 INFO - 'work_dir': 'build'} 03:52:11 INFO - [mozharness: 2017-05-12 10:52:11.499032Z] Running clobber step. 03:52:11 INFO - Running pre-action listener: _resource_record_pre_action 03:52:11 INFO - Running main action method: clobber 03:52:11 INFO - rmtree: /builds/slave/test/build 03:52:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:52:12 INFO - Running post-action listener: _resource_record_post_action 03:52:12 INFO - [mozharness: 2017-05-12 10:52:12.943499Z] Finished clobber step (success) 03:52:12 INFO - [mozharness: 2017-05-12 10:52:12.943599Z] Running read-buildbot-config step. 03:52:12 INFO - Running pre-action listener: _resource_record_pre_action 03:52:12 INFO - Running main action method: read_buildbot_config 03:52:12 INFO - Using buildbot properties: 03:52:12 INFO - { 03:52:12 INFO - "project": "", 03:52:12 INFO - "product": "firefox", 03:52:12 INFO - "who": "nobody@mozilla.org", 03:52:12 INFO - "installer_path": "public/build/target.tar.bz2", 03:52:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:52:12 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:52:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:52:12 INFO - "stage_platform": "linux64", 03:52:12 INFO - "basedir": "/builds/slave/test", 03:52:12 INFO - "buildnumber": 1151, 03:52:12 INFO - "platform": "ubuntu64_hw", 03:52:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:52:12 INFO - "slavebuilddir": "test", 03:52:12 INFO - "taskId": "I1-DnlCUS-mOqe2sMBhFyw", 03:52:12 INFO - "branch": "mozilla-central", 03:52:12 INFO - "script_repo_revision": "production", 03:52:12 INFO - "revision": "8a7d0b15595f9916123848ca906f29c62d4914c9", 03:52:12 INFO - "slavename": "talos-linux64-ix-030", 03:52:12 INFO - "repo_path": "mozilla-central" 03:52:12 INFO - } 03:52:12 INFO - Finding installer, test and symbols from parent task. 03:52:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I1-DnlCUS-mOqe2sMBhFyw'}, attempt #1 03:52:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I1-DnlCUS-mOqe2sMBhFyw'}, attempt #1 03:52:13 INFO - Task dependencies: Jt9B3QZUS5CaIvbQegJIuA 03:52:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA'}, attempt #1 03:52:14 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.tar.bz2 03:52:14 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/test_packages.json 03:52:14 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.crashreporter-symbols.zip 03:52:14 INFO - Running post-action listener: _resource_record_post_action 03:52:14 INFO - [mozharness: 2017-05-12 10:52:14.330116Z] Finished read-buildbot-config step (success) 03:52:14 INFO - [mozharness: 2017-05-12 10:52:14.330332Z] Running download-and-extract step. 03:52:14 INFO - Running pre-action listener: _resource_record_pre_action 03:52:14 INFO - Running main action method: download_and_extract 03:52:14 INFO - mkdir: /builds/slave/test/build/tests 03:52:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:14 INFO - trying https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.test_packages.json 03:52:14 INFO - Downloading https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:52:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:52:14 INFO - Downloaded 986 bytes. 03:52:14 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:52:14 INFO - Using the following test package requirements: 03:52:14 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:52:14 INFO - u'common': [u'target.common.tests.zip'], 03:52:14 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:52:14 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:52:14 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:52:14 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:52:14 INFO - u'mozbase': [u'target.common.tests.zip'], 03:52:14 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:52:14 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:52:14 INFO - u'web-platform': [u'target.common.tests.zip', 03:52:14 INFO - u'target.web-platform.tests.zip'], 03:52:14 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:52:14 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:52:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.common.tests.zip 03:52:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:52:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.common.tests.zip into memory 03:52:16 INFO - Content-Length response header: 60743182 03:52:16 INFO - Bytes received: 60743182 03:52:26 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:52:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.common.tests.zip 03:52:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:52:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.common.tests.zip into memory 03:52:28 INFO - Content-Length response header: 60743182 03:52:28 INFO - Bytes received: 60743182 03:52:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.talos.tests.zip 03:52:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:52:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.talos.tests.zip into memory 03:52:40 INFO - Content-Length response header: 14409411 03:52:40 INFO - Bytes received: 14409411 03:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:40 INFO - trying https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.tar.bz2 03:52:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:52:42 INFO - Downloaded 68949041 bytes. 03:52:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.tar.bz2 03:52:42 INFO - mkdir: /builds/slave/test/properties 03:52:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:52:42 INFO - Writing to file /builds/slave/test/properties/build_url 03:52:42 INFO - Contents: 03:52:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.tar.bz2 03:52:42 INFO - Running post-action listener: _resource_record_post_action 03:52:42 INFO - Running post-action listener: set_extra_try_arguments 03:52:42 INFO - [mozharness: 2017-05-12 10:52:42.571542Z] Finished download-and-extract step (success) 03:52:42 INFO - [mozharness: 2017-05-12 10:52:42.571766Z] Running populate-webroot step. 03:52:42 INFO - Running pre-action listener: _resource_record_pre_action 03:52:42 INFO - Running main action method: populate_webroot 03:52:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:52:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:52:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:52:42 INFO - '--tppagecycles', 03:52:42 INFO - '7'], 03:52:42 INFO - 'tests': ['tsvgm']}}, 03:52:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:52:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:52:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:52:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:52:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:52:42 INFO - 'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:52:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:52:42 INFO - 'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['damp', 'tps']}, 03:52:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:52:42 INFO - 'tests': ['damp', 'tps']}, 03:52:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['dromaeo_dom']}, 03:52:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:52:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:52:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:52:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['a11yr', 03:52:42 INFO - 'ts_paint', 03:52:42 INFO - 'tpaint', 03:52:42 INFO - 'sessionrestore', 03:52:42 INFO - 'sessionrestore_no_auto_restore', 03:52:42 INFO - 'tabpaint']}, 03:52:42 INFO - 'other-e10s': {'tests': ['a11yr', 03:52:42 INFO - 'ts_paint', 03:52:42 INFO - 'tpaint', 03:52:42 INFO - 'sessionrestore', 03:52:42 INFO - 'sessionrestore_no_auto_restore', 03:52:42 INFO - 'tabpaint']}, 03:52:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:52:42 INFO - 'ts_paint', 03:52:42 INFO - 'tpaint', 03:52:42 INFO - 'sessionrestore', 03:52:42 INFO - 'sessionrestore_no_auto_restore', 03:52:42 INFO - 'tabpaint']}, 03:52:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:52:42 INFO - 'ts_paint', 03:52:42 INFO - 'tpaint', 03:52:42 INFO - 'sessionrestore', 03:52:42 INFO - 'sessionrestore_no_auto_restore', 03:52:42 INFO - 'tabpaint']}, 03:52:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['a11yr', 03:52:42 INFO - 'ts_paint', 03:52:42 INFO - 'tpaint', 03:52:42 INFO - 'sessionrestore', 03:52:42 INFO - 'sessionrestore_no_auto_restore', 03:52:42 INFO - 'tabpaint']}, 03:52:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['a11yr', 03:52:42 INFO - 'ts_paint', 03:52:42 INFO - 'tpaint', 03:52:42 INFO - 'sessionrestore', 03:52:42 INFO - 'sessionrestore_no_auto_restore', 03:52:42 INFO - 'tabpaint']}, 03:52:42 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:52:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:52:42 INFO - 'bloom_basic_ref']}, 03:52:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['tsvgx', 03:52:42 INFO - 'tsvgr_opacity', 03:52:42 INFO - 'tart', 03:52:42 INFO - 'tscrollx', 03:52:42 INFO - 'cart', 03:52:42 INFO - 'tsvg_static']}, 03:52:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:52:42 INFO - 'tsvgr_opacity', 03:52:42 INFO - 'tart', 03:52:42 INFO - 'tscrollx', 03:52:42 INFO - 'cart', 03:52:42 INFO - 'tsvg_static']}, 03:52:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:52:42 INFO - 'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['tp5o']}, 03:52:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:52:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:52:42 INFO - 'talos_options': ['--disable-e10s', 03:52:42 INFO - '--xperf_path', 03:52:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:42 INFO - 'tests': ['tp5n']}, 03:52:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:52:42 INFO - 'talos_options': ['--xperf_path', 03:52:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:42 INFO - 'tests': ['tp5n']}}, 03:52:42 INFO - 'talos.zip': {'path': '', 03:52:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:52:42 INFO - Running post-action listener: _resource_record_post_action 03:52:42 INFO - [mozharness: 2017-05-12 10:52:42.593746Z] Finished populate-webroot step (success) 03:52:42 INFO - [mozharness: 2017-05-12 10:52:42.593835Z] Running create-virtualenv step. 03:52:42 INFO - Running pre-action listener: _resource_record_pre_action 03:52:42 INFO - Running main action method: create_virtualenv 03:52:42 INFO - Creating virtualenv /builds/slave/test/build/venv 03:52:42 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 03:52:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:52:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:52:42 INFO - Using real prefix '/usr' 03:52:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:52:43 INFO - Installing distribute.............................................................................................................................................................................................done. 03:52:45 INFO - Installing pip.................done. 03:52:45 INFO - Return code: 0 03:52:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:52:45 INFO - Reading from file tmpfile_stdout 03:52:45 INFO - Output received: 03:52:45 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) 03:52:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:52:45 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')]} 03:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:45 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')]} 03:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:45 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 0x1d9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210ba30>, '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 0x210c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210cca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', '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 03:52:45 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 03:52:45 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 03:52:45 INFO - Using env: {'DISPLAY': ':0', 03:52:45 INFO - 'HOME': '/home/cltbld', 03:52:45 INFO - 'LANG': 'en_US.UTF-8', 03:52:45 INFO - 'LANGUAGE': 'en_US:en', 03:52:45 INFO - 'LOGNAME': 'cltbld', 03:52:45 INFO - 'MAIL': '/var/mail/cltbld', 03:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:45 INFO - 'MOZ_NO_REMOTE': '1', 03:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:45 INFO - 'NO_EM_RESTART': '1', 03:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:45 INFO - 'PWD': '/builds/slave/test', 03:52:45 INFO - 'SHELL': '/bin/bash', 03:52:45 INFO - 'SHLVL': '1', 03:52:45 INFO - 'TERM': 'linux', 03:52:45 INFO - 'TMOUT': '86400', 03:52:45 INFO - 'USER': 'cltbld', 03:52:45 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', 03:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:45 INFO - '_': '/tools/buildbot/bin/python'} 03:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:45 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 03:52:45 INFO - Cleaning up... 03:52:45 INFO - Return code: 0 03:52:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:52:45 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')]} 03:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:45 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')]} 03:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:45 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 0x1d9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210ba30>, '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 0x210c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210cca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', '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 03:52:45 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 03:52:45 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 03:52:45 INFO - Using env: {'DISPLAY': ':0', 03:52:45 INFO - 'HOME': '/home/cltbld', 03:52:45 INFO - 'LANG': 'en_US.UTF-8', 03:52:45 INFO - 'LANGUAGE': 'en_US:en', 03:52:45 INFO - 'LOGNAME': 'cltbld', 03:52:45 INFO - 'MAIL': '/var/mail/cltbld', 03:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:45 INFO - 'MOZ_NO_REMOTE': '1', 03:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:45 INFO - 'NO_EM_RESTART': '1', 03:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:45 INFO - 'PWD': '/builds/slave/test', 03:52:45 INFO - 'SHELL': '/bin/bash', 03:52:45 INFO - 'SHLVL': '1', 03:52:45 INFO - 'TERM': 'linux', 03:52:45 INFO - 'TMOUT': '86400', 03:52:45 INFO - 'USER': 'cltbld', 03:52:45 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', 03:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:45 INFO - '_': '/tools/buildbot/bin/python'} 03:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:45 INFO - Downloading/unpacking psutil>=3.1.1 03:52:45 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 03:52:45 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 03:52:45 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 03:52:45 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 03:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:52:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:46 INFO - Installing collected packages: psutil 03:52:46 INFO - Running setup.py install for psutil 03:52:47 INFO - building 'psutil._psutil_linux' extension 03:52:47 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 03:52:47 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 03:52:47 INFO - building 'psutil._psutil_posix' extension 03:52:47 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 03:52:47 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 03:52:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:47 INFO - Successfully installed psutil 03:52:47 INFO - Cleaning up... 03:52:47 INFO - Return code: 0 03:52:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:47 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 0x1d9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210ba30>, '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 0x210c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210cca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', '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 03:52:47 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 03:52:47 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 03:52:47 INFO - Using env: {'DISPLAY': ':0', 03:52:47 INFO - 'HOME': '/home/cltbld', 03:52:47 INFO - 'LANG': 'en_US.UTF-8', 03:52:47 INFO - 'LANGUAGE': 'en_US:en', 03:52:47 INFO - 'LOGNAME': 'cltbld', 03:52:47 INFO - 'MAIL': '/var/mail/cltbld', 03:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:47 INFO - 'MOZ_NO_REMOTE': '1', 03:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:47 INFO - 'NO_EM_RESTART': '1', 03:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:47 INFO - 'PWD': '/builds/slave/test', 03:52:47 INFO - 'SHELL': '/bin/bash', 03:52:47 INFO - 'SHLVL': '1', 03:52:47 INFO - 'TERM': 'linux', 03:52:47 INFO - 'TMOUT': '86400', 03:52:47 INFO - 'USER': 'cltbld', 03:52:47 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', 03:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:47 INFO - '_': '/tools/buildbot/bin/python'} 03:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:52:48 INFO - Installing collected packages: mozsystemmonitor 03:52:48 INFO - Running setup.py install for mozsystemmonitor 03:52:48 INFO - Successfully installed mozsystemmonitor 03:52:48 INFO - Cleaning up... 03:52:48 INFO - Return code: 0 03:52:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:49 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')]} 03:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:49 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 0x1d9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210ba30>, '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 0x210c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210cca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', '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 03:52:49 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 03:52:49 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 03:52:49 INFO - Using env: {'DISPLAY': ':0', 03:52:49 INFO - 'HOME': '/home/cltbld', 03:52:49 INFO - 'LANG': 'en_US.UTF-8', 03:52:49 INFO - 'LANGUAGE': 'en_US:en', 03:52:49 INFO - 'LOGNAME': 'cltbld', 03:52:49 INFO - 'MAIL': '/var/mail/cltbld', 03:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:49 INFO - 'MOZ_NO_REMOTE': '1', 03:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:49 INFO - 'NO_EM_RESTART': '1', 03:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:49 INFO - 'PWD': '/builds/slave/test', 03:52:49 INFO - 'SHELL': '/bin/bash', 03:52:49 INFO - 'SHLVL': '1', 03:52:49 INFO - 'TERM': 'linux', 03:52:49 INFO - 'TMOUT': '86400', 03:52:49 INFO - 'USER': 'cltbld', 03:52:49 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', 03:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:49 INFO - '_': '/tools/buildbot/bin/python'} 03:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:49 INFO - Downloading/unpacking jsonschema==2.5.1 03:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:52:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:52:50 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 03:52:50 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 03:52:50 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 03:52:50 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 03:52:50 INFO - Downloading functools32-3.2.3-2.tar.gz 03:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:52:50 INFO - warning: no files found matching '*.txt' 03:52:50 INFO - no previously-included directories found matching 'build' 03:52:50 INFO - no previously-included directories found matching 'dist' 03:52:50 INFO - no previously-included directories found matching '.git*' 03:52:50 INFO - Installing collected packages: jsonschema, functools32 03:52:50 INFO - Running setup.py install for functools32 03:52:50 INFO - warning: no files found matching '*.txt' 03:52:50 INFO - no previously-included directories found matching 'build' 03:52:50 INFO - no previously-included directories found matching 'dist' 03:52:50 INFO - no previously-included directories found matching '.git*' 03:52:50 INFO - Successfully installed jsonschema functools32 03:52:50 INFO - Cleaning up... 03:52:50 INFO - Return code: 0 03:52:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:50 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 0x1d9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210ba30>, '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 0x210c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210cca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', '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 03:52:50 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 03:52:50 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 03:52:50 INFO - Using env: {'DISPLAY': ':0', 03:52:50 INFO - 'HOME': '/home/cltbld', 03:52:50 INFO - 'LANG': 'en_US.UTF-8', 03:52:50 INFO - 'LANGUAGE': 'en_US:en', 03:52:50 INFO - 'LOGNAME': 'cltbld', 03:52:50 INFO - 'MAIL': '/var/mail/cltbld', 03:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:50 INFO - 'MOZ_NO_REMOTE': '1', 03:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:50 INFO - 'NO_EM_RESTART': '1', 03:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:50 INFO - 'PWD': '/builds/slave/test', 03:52:50 INFO - 'SHELL': '/bin/bash', 03:52:50 INFO - 'SHLVL': '1', 03:52:50 INFO - 'TERM': 'linux', 03:52:50 INFO - 'TMOUT': '86400', 03:52:50 INFO - 'USER': 'cltbld', 03:52:50 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', 03:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:50 INFO - '_': '/tools/buildbot/bin/python'} 03:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:52:50 INFO - Cleaning up... 03:52:50 INFO - Return code: 0 03:52:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:50 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 0x1d9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210ba30>, '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 0x210c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210cca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', '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 03:52:50 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 03:52:50 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 03:52:50 INFO - Using env: {'DISPLAY': ':0', 03:52:50 INFO - 'HOME': '/home/cltbld', 03:52:50 INFO - 'LANG': 'en_US.UTF-8', 03:52:50 INFO - 'LANGUAGE': 'en_US:en', 03:52:50 INFO - 'LOGNAME': 'cltbld', 03:52:50 INFO - 'MAIL': '/var/mail/cltbld', 03:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:50 INFO - 'MOZ_NO_REMOTE': '1', 03:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:50 INFO - 'NO_EM_RESTART': '1', 03:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:50 INFO - 'PWD': '/builds/slave/test', 03:52:50 INFO - 'SHELL': '/bin/bash', 03:52:50 INFO - 'SHLVL': '1', 03:52:50 INFO - 'TERM': 'linux', 03:52:50 INFO - 'TMOUT': '86400', 03:52:50 INFO - 'USER': 'cltbld', 03:52:50 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', 03:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:50 INFO - '_': '/tools/buildbot/bin/python'} 03:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:51 INFO - Downloading/unpacking blobuploader==1.2.4 03:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:52 INFO - Downloading blobuploader-1.2.4.tar.gz 03:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:52:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:52:52 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 03:52:52 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 03:52:52 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 03:52:52 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 03:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:52:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:52:52 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 03:52:52 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 03:52:52 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 03:52:52 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 03:52:52 INFO - Downloading docopt-0.6.1.tar.gz 03:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:52:52 INFO - Installing collected packages: blobuploader, requests, docopt 03:52:52 INFO - Running setup.py install for blobuploader 03:52:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:52:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:52:52 INFO - Running setup.py install for requests 03:52:53 INFO - Running setup.py install for docopt 03:52:53 INFO - Successfully installed blobuploader requests docopt 03:52:53 INFO - Cleaning up... 03:52:53 INFO - Return code: 0 03:52:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:53 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 0x1d9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210ba30>, '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 0x210c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210cca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', '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 03:52:53 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 03:52:53 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 03:52:53 INFO - Using env: {'DISPLAY': ':0', 03:52:53 INFO - 'HOME': '/home/cltbld', 03:52:53 INFO - 'LANG': 'en_US.UTF-8', 03:52:53 INFO - 'LANGUAGE': 'en_US:en', 03:52:53 INFO - 'LOGNAME': 'cltbld', 03:52:53 INFO - 'MAIL': '/var/mail/cltbld', 03:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:53 INFO - 'MOZ_NO_REMOTE': '1', 03:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:53 INFO - 'NO_EM_RESTART': '1', 03:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:53 INFO - 'PWD': '/builds/slave/test', 03:52:53 INFO - 'SHELL': '/bin/bash', 03:52:53 INFO - 'SHLVL': '1', 03:52:53 INFO - 'TERM': 'linux', 03:52:53 INFO - 'TMOUT': '86400', 03:52:53 INFO - 'USER': 'cltbld', 03:52:53 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', 03:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:53 INFO - '_': '/tools/buildbot/bin/python'} 03:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:53 INFO - Running setup.py (path:/tmp/pip-UwUaQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:53 INFO - Running setup.py (path:/tmp/pip-z7H0DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:53 INFO - Running setup.py (path:/tmp/pip-LCzjRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:53 INFO - Running setup.py (path:/tmp/pip-OEUyoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:53 INFO - Running setup.py (path:/tmp/pip-7vXDKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:54 INFO - Running setup.py (path:/tmp/pip-aP85fP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:54 INFO - Running setup.py (path:/tmp/pip-4Jys_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:54 INFO - Running setup.py (path:/tmp/pip-DOXZCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:54 INFO - Running setup.py (path:/tmp/pip-bqhCBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:54 INFO - Running setup.py (path:/tmp/pip-huiwlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:54 INFO - Running setup.py (path:/tmp/pip-pEI0OL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:54 INFO - Running setup.py (path:/tmp/pip-W5h_yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:54 INFO - Running setup.py (path:/tmp/pip-dPCApw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:54 INFO - Running setup.py (path:/tmp/pip-W3NkI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:54 INFO - Running setup.py (path:/tmp/pip-NMHgzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:54 INFO - Running setup.py (path:/tmp/pip-5VrVmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:54 INFO - Running setup.py (path:/tmp/pip-sEcdI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:52:54 INFO - Running setup.py install for manifestparser 03:52:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Running setup.py install for mozcrash 03:52:55 INFO - Running setup.py install for mozdebug 03:52:55 INFO - Running setup.py install for mozdevice 03:52:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Running setup.py install for mozfile 03:52:55 INFO - Running setup.py install for mozhttpd 03:52:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Running setup.py install for mozinfo 03:52:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Running setup.py install for mozInstall 03:52:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Running setup.py install for mozleak 03:52:55 INFO - Running setup.py install for mozlog 03:52:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Running setup.py install for moznetwork 03:52:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:52:56 INFO - Running setup.py install for mozprocess 03:52:56 INFO - Running setup.py install for mozprofile 03:52:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:52:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:52:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:52:56 INFO - Running setup.py install for mozrunner 03:52:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:52:56 INFO - Running setup.py install for mozscreenshot 03:52:56 INFO - Running setup.py install for moztest 03:52:56 INFO - Running setup.py install for mozversion 03:52:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:52:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:52:56 INFO - Cleaning up... 03:52:56 INFO - Return code: 0 03:52:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:56 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')]} 03:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:56 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')]} 03:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:56 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 0x1d9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210ba30>, '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 0x210c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210cca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', '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 03:52:56 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 03:52:56 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 03:52:56 INFO - Using env: {'DISPLAY': ':0', 03:52:56 INFO - 'HOME': '/home/cltbld', 03:52:56 INFO - 'LANG': 'en_US.UTF-8', 03:52:56 INFO - 'LANGUAGE': 'en_US:en', 03:52:56 INFO - 'LOGNAME': 'cltbld', 03:52:56 INFO - 'MAIL': '/var/mail/cltbld', 03:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:56 INFO - 'MOZ_NO_REMOTE': '1', 03:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:56 INFO - 'NO_EM_RESTART': '1', 03:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:56 INFO - 'PWD': '/builds/slave/test', 03:52:56 INFO - 'SHELL': '/bin/bash', 03:52:56 INFO - 'SHLVL': '1', 03:52:56 INFO - 'TERM': 'linux', 03:52:56 INFO - 'TMOUT': '86400', 03:52:56 INFO - 'USER': 'cltbld', 03:52:56 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', 03:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:56 INFO - '_': '/tools/buildbot/bin/python'} 03:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:56 INFO - Running setup.py (path:/tmp/pip-SGREud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:56 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)) 03:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:56 INFO - Running setup.py (path:/tmp/pip-D9sOrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:57 INFO - Running setup.py (path:/tmp/pip-caJmi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:57 INFO - Running setup.py (path:/tmp/pip-_pjqH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:57 INFO - Running setup.py (path:/tmp/pip-GSEPOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:57 INFO - Running setup.py (path:/tmp/pip-XjZa8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:57 INFO - Running setup.py (path:/tmp/pip-xj58o7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:57 INFO - Running setup.py (path:/tmp/pip-D0m0NM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:57 INFO - Running setup.py (path:/tmp/pip-qjzHC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:57 INFO - Running setup.py (path:/tmp/pip-VLRhk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:57 INFO - Running setup.py (path:/tmp/pip-sNfMKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:57 INFO - Running setup.py (path:/tmp/pip-rJUDGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:57 INFO - Running setup.py (path:/tmp/pip-Huy9TL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:57 INFO - Running setup.py (path:/tmp/pip-lDlhUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:57 INFO - Running setup.py (path:/tmp/pip-Se_JR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:57 INFO - Running setup.py (path:/tmp/pip-aNtap5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:58 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)) 03:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:58 INFO - Running setup.py (path:/tmp/pip-NdbkFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:58 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)) 03:52:58 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)) 03:52:58 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)) 03:52:58 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)) 03:52:58 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:52:58 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:52:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:59 INFO - Downloading blessings-1.6.tar.gz 03:52:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:52:59 INFO - Installing collected packages: blessings 03:52:59 INFO - Running setup.py install for blessings 03:52:59 INFO - Successfully installed blessings 03:52:59 INFO - Cleaning up... 03:52:59 INFO - Return code: 0 03:52:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:52:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:59 INFO - Reading from file tmpfile_stdout 03:52:59 INFO - Current package versions: 03:52:59 INFO - argparse == 1.2.1 03:52:59 INFO - blessings == 1.6 03:52:59 INFO - blobuploader == 1.2.4 03:52:59 INFO - docopt == 0.6.1 03:52:59 INFO - functools32 == 3.2.3-2 03:52:59 INFO - jsonschema == 2.5.1 03:52:59 INFO - manifestparser == 1.1 03:52:59 INFO - mozInstall == 1.12 03:52:59 INFO - mozcrash == 1.0 03:52:59 INFO - mozdebug == 0.1 03:52:59 INFO - mozdevice == 0.50 03:52:59 INFO - mozfile == 1.2 03:52:59 INFO - mozhttpd == 0.7 03:52:59 INFO - mozinfo == 0.9 03:52:59 INFO - mozleak == 0.1 03:52:59 INFO - mozlog == 3.4 03:52:59 INFO - moznetwork == 0.27 03:52:59 INFO - mozprocess == 0.25 03:52:59 INFO - mozprofile == 0.28 03:52:59 INFO - mozrunner == 6.13 03:52:59 INFO - mozscreenshot == 0.1 03:52:59 INFO - mozsystemmonitor == 0.3 03:52:59 INFO - moztest == 0.8 03:52:59 INFO - mozversion == 1.4 03:52:59 INFO - psutil == 3.1.1 03:52:59 INFO - requests == 1.2.3 03:52:59 INFO - wsgiref == 0.1.2 03:52:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:59 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 0x1d9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210ba30>, '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 0x210c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210cca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', '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 03:52:59 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 03:52:59 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 03:52:59 INFO - Using env: {'DISPLAY': ':0', 03:52:59 INFO - 'HOME': '/home/cltbld', 03:52:59 INFO - 'LANG': 'en_US.UTF-8', 03:52:59 INFO - 'LANGUAGE': 'en_US:en', 03:52:59 INFO - 'LOGNAME': 'cltbld', 03:52:59 INFO - 'MAIL': '/var/mail/cltbld', 03:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:59 INFO - 'MOZ_NO_REMOTE': '1', 03:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:59 INFO - 'NO_EM_RESTART': '1', 03:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:59 INFO - 'PWD': '/builds/slave/test', 03:52:59 INFO - 'SHELL': '/bin/bash', 03:52:59 INFO - 'SHLVL': '1', 03:52:59 INFO - 'TERM': 'linux', 03:52:59 INFO - 'TMOUT': '86400', 03:52:59 INFO - 'USER': 'cltbld', 03:52:59 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', 03:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:59 INFO - '_': '/tools/buildbot/bin/python'} 03:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 INFO - Cleaning up... 03:52:59 INFO - Return code: 0 03:52:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210ba30>, '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 0x210c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210cca0>, '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': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', '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 03:52:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:52:59 INFO - Using env: {'DISPLAY': ':0', 03:52:59 INFO - 'HOME': '/home/cltbld', 03:52:59 INFO - 'LANG': 'en_US.UTF-8', 03:52:59 INFO - 'LANGUAGE': 'en_US:en', 03:52:59 INFO - 'LOGNAME': 'cltbld', 03:52:59 INFO - 'MAIL': '/var/mail/cltbld', 03:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:59 INFO - 'MOZ_NO_REMOTE': '1', 03:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:59 INFO - 'NO_EM_RESTART': '1', 03:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:59 INFO - 'PWD': '/builds/slave/test', 03:52:59 INFO - 'SHELL': '/bin/bash', 03:52:59 INFO - 'SHLVL': '1', 03:52:59 INFO - 'TERM': 'linux', 03:52:59 INFO - 'TMOUT': '86400', 03:52:59 INFO - 'USER': 'cltbld', 03:52:59 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', 03:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:59 INFO - '_': '/tools/buildbot/bin/python'} 03:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:53:00 INFO - Cleaning up... 03:53:00 INFO - Return code: 0 03:53:00 INFO - Running post-action listener: _resource_record_post_action 03:53:00 INFO - Running post-action listener: _start_resource_monitoring 03:53:00 INFO - Starting resource monitoring. 03:53:00 INFO - [mozharness: 2017-05-12 10:53:00.108968Z] Finished create-virtualenv step (success) 03:53:00 INFO - [mozharness: 2017-05-12 10:53:00.109529Z] Running install step. 03:53:00 INFO - Running pre-action listener: _resource_record_pre_action 03:53:00 INFO - Running main action method: install 03:53:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:53:00 INFO - Reading from file tmpfile_stdout 03:53:00 INFO - Detecting whether we're running mozinstall >=1.0... 03:53:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:53:00 INFO - Reading from file tmpfile_stdout 03:53:00 INFO - Output received: 03:53:00 INFO - Usage: mozinstall [options] installer 03:53:00 INFO - Options: 03:53:00 INFO - -h, --help show this help message and exit 03:53:00 INFO - -d DEST, --destination=DEST 03:53:00 INFO - Directory to install application into. [default: 03:53:00 INFO - "/builds/slave/test"] 03:53:00 INFO - --app=APP Application being installed. [default: firefox] 03:53:00 INFO - mkdir: /builds/slave/test/build/application 03:53:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:53:17 INFO - Reading from file tmpfile_stdout 03:53:17 INFO - Output received: 03:53:17 INFO - /builds/slave/test/build/application/firefox/firefox 03:53:17 INFO - Running post-action listener: _resource_record_post_action 03:53:17 INFO - [mozharness: 2017-05-12 10:53:17.550248Z] Finished install step (success) 03:53:17 INFO - [mozharness: 2017-05-12 10:53:17.550495Z] Running run-tests step. 03:53:17 INFO - Running pre-action listener: _resource_record_pre_action 03:53:17 INFO - Running main action method: run_tests 03:53:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:53:17 INFO - Python 2.7.3 03:53:17 INFO - Return code: 0 03:53:17 INFO - grabbing minidump binary from tooltool 03:53:17 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')]} 03:53:17 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 0x210ba30>, '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 0x210c7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210cca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:53:17 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 03:53:17 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 03:53:17 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 03:53:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:53:17 INFO - Return code: 0 03:53:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:53:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:53:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:53:17 INFO - ENV: RUST_BACKTRACE is now 1 03:53:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:53:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:53:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:53:17 INFO - Using env: {'DISPLAY': ':0', 03:53:17 INFO - 'HOME': '/home/cltbld', 03:53:17 INFO - 'LANG': 'en_US.UTF-8', 03:53:17 INFO - 'LANGUAGE': 'en_US:en', 03:53:17 INFO - 'LOGNAME': 'cltbld', 03:53:17 INFO - 'MAIL': '/var/mail/cltbld', 03:53:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:53:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:17 INFO - 'MOZ_NO_REMOTE': '1', 03:53:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:53:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:17 INFO - 'NO_EM_RESTART': '1', 03:53:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:17 INFO - 'PWD': '/builds/slave/test', 03:53:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:53:17 INFO - 'RUST_BACKTRACE': '1', 03:53:17 INFO - 'SHELL': '/bin/bash', 03:53:17 INFO - 'SHLVL': '1', 03:53:17 INFO - 'TERM': 'linux', 03:53:17 INFO - 'TMOUT': '86400', 03:53:17 INFO - 'USER': 'cltbld', 03:53:17 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564', 03:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:17 INFO - '_': '/tools/buildbot/bin/python'} 03:53:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:53:17 INFO - mozversion application_buildid: 20170512100218 03:53:17 INFO - mozversion application_changeset: 8a7d0b15595f9916123848ca906f29c62d4914c9 03:53:17 INFO - mozversion application_display_name: Nightly 03:53:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:53:17 INFO - mozversion application_name: Firefox 03:53:17 INFO - mozversion application_remotingname: firefox 03:53:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:53:17 INFO - mozversion application_vendor: Mozilla 03:53:17 INFO - mozversion application_version: 55.0a1 03:53:17 INFO - mozversion platform_buildid: 20170512100218 03:53:17 INFO - mozversion platform_changeset: 8a7d0b15595f9916123848ca906f29c62d4914c9 03:53:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:53:17 INFO - mozversion platform_version: 55.0a1 03:53:17 INFO - using testdate: 1494586397 03:53:17 INFO - actual date: 1494586397 03:53:17 INFO - starting webserver on 'localhost:52591' 03:53:17 INFO - SUITE-START | Running 2 tests 03:53:17 INFO - TEST-START | dromaeo_css 03:53:17 INFO - operating with platform_type : linux_ 03:53:17 INFO - Initialising browser for dromaeo_css test... 03:53:17 INFO - TEST-INFO | started process 21872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppA3x__/profile http://localhost:52591/getInfo.html) 03:53:21 INFO - PID 21872 | __metrics Screen width/height:1600/1200 03:53:21 INFO - PID 21872 | colorDepth:24 03:53:21 INFO - PID 21872 | Browser inner width/height: 1024/695 03:53:21 INFO - PID 21872 | __metrics 03:53:22 INFO - PID 21872 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:53:22 INFO - PID 21872 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:53:23 INFO - TEST-INFO | 21872: exit 0 03:53:23 INFO - Browser initialized. 03:53:23 INFO - Running cycle 1/1 for dromaeo_css test... 03:53:23 INFO - TEST-INFO | started process 21972 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppA3x__/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:35 INFO - PID 21972 | RSS: Main: 144465920 03:53:35 INFO - PID 21972 | 03:56:37 INFO - PID 21972 | Cycle 1(1): loaded http://localhost:52591/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52591/tests/dromaeo/cssquery-ext.html) 03:56:39 INFO - PID 21972 | RSS: Main: 300277760 03:56:39 INFO - PID 21972 | 03:59:41 INFO - PID 21972 | Cycle 1(1): loaded http://localhost:52591/tests/dromaeo/cssquery-ext.html (next: http://localhost:52591/tests/dromaeo/cssquery-jquery.html) 03:59:41 INFO - PID 21972 | RSS: Main: 217829376 03:59:41 INFO - PID 21972 | 04:02:43 INFO - PID 21972 | Cycle 1(1): loaded http://localhost:52591/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52591/tests/dromaeo/cssquery-mootools.html) 04:02:43 INFO - PID 21972 | RSS: Main: 174530560 04:02:43 INFO - PID 21972 | 04:05:45 INFO - PID 21972 | Cycle 1(1): loaded http://localhost:52591/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52591/tests/dromaeo/cssquery-prototype.html) 04:05:46 INFO - PID 21972 | RSS: Main: 185638912 04:05:46 INFO - PID 21972 | 04:08:48 INFO - PID 21972 | Cycle 1(1): loaded http://localhost:52591/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52591/tests/dromaeo/cssquery-yui.html) 04:08:49 INFO - PID 21972 | RSS: Main: 178356224 04:08:49 INFO - PID 21972 | 04:11:51 INFO - PID 21972 | Cycle 1(1): loaded http://localhost:52591/tests/dromaeo/cssquery-yui.html (next: http://localhost:52591/tests/dromaeo/cssquery-dojo.html) 04:11:51 INFO - PID 21972 | RSS: Main: 264794112 04:11:51 INFO - PID 21972 | 04:11:51 INFO - PID 21972 | __start_tp_report 04:11:51 INFO - PID 21972 | _x_x_mozilla_page_load 04:11:51 INFO - PID 21972 | _x_x_mozilla_page_load_details 04:11:51 INFO - PID 21972 | |i|pagename|runs| 04:11:51 INFO - PID 21972 | |0;dojo.html;3275.2139486523233;3282.294306724054;3290.4406250937354;3313.9171520711993;3351.346487434951;5602.215689803421;5689.8577535561635;5753.223314852494;5794.7682092716295;5817.476427121558;5676.120201368794;5755.884882302352;5773.9422605773925;5783.884322313551;5837.532997360212;4747.7388743619085;5018.523240292185;5094.872628184288;5138;5188.221766734982;5012.749362531858;5145.228215767646;5160.122779127539;5199.922001169985;5215.348081489814;5070.290159377671;5077.695338279678;5141.485851414866;5171.146760784466;5180.6373553851245;5110.310108135392;5128.461511541272;5131.102057139986;5131.255967884673;5134.768935397916;5052.873678158076;5109.514596113363;5111.182210846247;5113.9772045591035;5117.692938423706;5614.747336369873;5667.971660141714;5688.345840228385;5787.536997040269;5797.681127537984;6207.782727604512;6210.254769427697;6212.006079027379;6226.937730622681;6234.470070044052;6275.403836635513;6280.528960327948;6289.276733175698;6291;6300.779472718433;5633.746481408347;5643.717814109278;5687.829365119053;5707.229524014288;5798.478136967651;6347.650879201688;6358.046293056079;6372.299047104815;6372.681365931685;6378.936210637927;5975.163477113208;6008.24896887889;6037.275526936708;6037.849053773691;6098.024316109401;6094.537231721354;6100.969495152496;6110.755569777248;6115.785947491817;6120.386183820725;6011;6020.277566692025;6040.7583696651645;6080.118382834465;6081.604695694766;6087.66517841523;6139.719840936791;6184.783532576338;6189.659568723763;6189.876202475925;4756.072565849626;4757.952420475751;4757.95242047582;4773.952260477351;4799.832005879777;4179.749215047107;4220.577942205755;4231.407602935591;4247.384129301296;4265.954841063959;5775.191473193756;5786.566007549451;5856.297244330623;5858.970705146447;5873.060310350409;6260.123582698426;6300.527460440485;6303.558750887486;6310.179676642099;6316.652584107918;5853;5853.122031695195;5853.326867410217;5859.677717725566;5911.994960856665;5288.947110528922;5395.379531353866;5414.972925135349;5464.508194262456;5473.863153421116;6487.059376390397;6543.509236807164;6544.149260596092;6548;6549.083128361938;6281.309056003744;6282.026285925689;6287.591306565241;6289;6292.685365731603;6191.9690401547705;6323.399277068671;6397.616143031433;6477.093206951125;6527.738890444519;6126.754929802936;6149.385061493815;6164.445199932027;6180.783672571439;6187.102870083902;6063.454289114001;6280.466160376419;6283.088952102011;6287.748490060347;6291.779787707408;5930.970345148246;5975.103734439695;5996.820095397145;5999.130126131774;6005.699715014319;6068.059450785136;6069.302030266399;6093.055576385667;6118.174046503665;6126.479249263863;6036.0644100164545;6051.939480605313;6055.939440605537;6057.242844644419;6064.727087281171;5916.290045194604;6053.788117415869;6067.150598916067;6113.2969708482315;6117.938820611737;5708.54331653475;5827.067669172912;5838.803045375603;5869.941300586939;5887.087501437284 04:11:51 INFO - PID 21972 | |1;ext.html;752.1087511299111;822.4119754375622;845.2266176448547;1130.9886901130985;1152.9769404611902;31021.689783102163;31582.84208578954;31601.68398316016;31627;38390.61609383905;41421.1005229634;41705.374419383734;41780.37329440061;41849;41873.37189942153;7065.929340706604;7173;7174.569525828441;7175.569465832041;7177.3540381365665;5633.295838020247;5697.259356283677;7097.432205423554;7212.206657267722;7289.708411663553;7235.312645298688;7264.7094116235285;7269.927300727004;7271.018412514296;7279.781606551785;7172.103487064117;7175.9641201794175;7196;7204.531705439182;7210.278972102827;5605.962896864053;5656.85857853557;5658.745356458928;7238.348548630596;7306;34552;34635;34831.65168348309;34860.82569587136;34880.30239395198;3595.1191957970204;3631.2737452509605;3631.963680363189;3632.346177688015;3636.709063274932;28593.285167870763;28656;28680.569791453145;28777.136685899248;28817.56773648397;3821.102041020358;3867.61323867611;3881.3013657541633;3889.2804831106055;3931.253061918226;191928;192964;193517.03241483844;193835;194165;50439.49560504348;50511.49488505068;50623;50678.74660626673;50695;52196;52675.47324526782;52704.47295527072;52713;52749.472505275226;13592.048556600943;13678.589642310746;13682.863171368357;13709.97175211863;13710.794338084937;10716.089132423831;10758.623448179276;10767.946160269148;10772.676819695422;10819.67540973772;12070.577529786415;12314.876851231553;14118;15498.922505387627;15889.920550397173;6070.575059745864;6289.7169627365965;6299.433051025429;6307.337729538424;6323.9051414228825;1064.1965316186229;1091.8525998990035;1105.7346236903247;1107.3743335015852;1116.3580940958982;27035.1889443317;27439.314017149733;27627;27664.723352766618;27673.308167295978;1174.0842143128202;1175.324188591546;1182.1075088308444;1182.7102359921873;1194.5639841457805;13308.201507909556;14049.93065187248;14066.85933140676;14214.502492412716;14245;240122;241669;241902;242044;242759;54721.452785471636;55022.44977550254;55119.448805512235;55155.44844551583;55217.44782552203;1438.6834896322791;1492.5522343297184;1513.6291608555973;1529.9388024478897;1532.1802835483186;24460.143894963592;25557.23328300154;25807.354816128995;25885.22344329673;26153.215403537924;39900.401493977035;40026.79986600048;40051.39922901217;40129.598704012584;40181.79909100436;209545;210191;211188;211415;211676;36059.27881442304;36293;36419.45370819387;36423.453648194765;36428.81785591055;43901.78049109734;46070.76964615155;46346;46413;46822.29766553437;30837.395656100434;32772.36138193033;33794.15514612154;34122.658773411946;34123.488147678305;32785.50821737628;32819.34361312808;33256.501152483215;33563.66436335703;33717.325653487285;37577;38669.2266154681;38674;38706;38831.805840970614;31800.36399272048;32432.83783581067;32681.836590816893;33096;33258.66741332556;25158.49683006293;25936.481270374865;26147.869260653573;26275.21174364772;26289.868550657888 04:11:51 INFO - PID 21972 | |2;jquery.html;448.69040362150133;449.6627529352985;451.5033463190491;468.0989095990218;474.1086756897033;18792;19156;19817.50456238593;19900.70148947767;20067.1973121075;21259.893700531513;21353.145874165013;21627.6755848662;21992.89003554984;22055.448613784665;5386.272853164812;5555.138953462219;5560.471755183271;5560.638558493705;5561.082421400464;4265.658747300208;5474;5513.751881165357;5517.972410137943;5533.6956467394275;5488.313960754906;5491.176323551459;5496.120620700689;5496.241202815101;5497.917531237034;5344.331958505187;5375.00562395958;5412.052890744104;5421.376541697716;5422.484863937959;4887.218045112765;4951.504849515056;4958.776855041532;4960.379952505937;4963.925541116886;24113.156039538706;24436.877815610987;24537.263882083567;24583.63124553133;24989.250322490356;2116.703661487393;2144.4853235223436;2145.5816115857415;2145.7854214578574;2150.580636775829;16167.757483637755;16691.332346706116;16699.74950375745;16766.07786571738;16881.746773798404;2126.7554231263293;2210.8172127911653;2225.5103877147003;2236.4297104238476;2254.4363909022745;93718;104968;119677;119761;119877;11933.105017123751;11985.284561785875;12129.575464858688;12310.630681079403;12340;17214.31142754301;17219.483415497554;17220.397286095176;17242.655146897243;17258.568535786704;8744.475331480131;8858.379913406;8956.104389560991;9019.00790912999;9044.81910361789;8174.632141553644;8280;8282.461639993382;8487.915120848837;8511.063782983867;7590.203028681909;7750.418718596128;7889.447738658354;7892;7957.283844453911;2091.1948899673735;2092.5082605587677;2139.080195515943;2151.2900742754855;2168.349495151448;1054.931429457083;1094.5676457799125;1095.4686976816238;1097.8792332843382;1101.9173561982723;21042.84264365444;21218.2573609926;21254;21547.784522154892;21828.781712182674;1083.978320433587;1095.0418383914075;1098.132475344469;1099.8680158381046;1112.1492058575197;10775.730606734895;11523.942380288212;11630.418479076012;11648.708782280512;11688.357140357362;493080;500326;501475;504774.66577339236;516881.97416310286;78762.81855772168;94412;94861.5256923711;96300.51849740706;102132;1180.3567055954525;1240.3116270469795;1246.5574720973923;1250.0312258000122;1264.2604076615098;19901.203951841766;20015.799842001394;20638.484037899172;20698.379048628565;20879.26922557703;45896.85403816799;46474.37339693095;47054.529454705014;47489.7625511884;47841.76079119582;57105.42894571001;57810.710946445;58521.70739146447;58578.70710646419;59781.701091494266;9699.12707856268;9858.654947076819;9945.950270248602;9989.150922171697;10235.181185505291;15325.540233793005;15519.922400387926;15643.530694079196;15709.371625135323;15783.763243551586;12156.209846360312;12854.742905141658;12903.870961290268;13495.325233738471;13771.380287886868;12076.09429292789;12368.072394570263;12384.690382740504;12489.18820276679;12754.42605082755;13514.05401621877;13566.660833479242;13602.659933501742;13817.516386926409;14003.22982235946;9802.558884850056;9845.753856153653;9856.457894815854;10208.2343824212;10246.38521688701;13227.272500012592;13234.867651323364;13246.47014119463;13401.66495837612;13771.104878182887 04:11:51 INFO - PID 21972 | |3;mootools.html;1354.431138921653;1371.1635902099717;1397.8672026157517;1398.811160493333;1401.5164768154982;11366.488508017139;11819.940900295507;11836.644900652984;11842.171048026641;11845;11597.53609855607;11930.761384772299;12340.938295308533;12352.320622365767;12361.19652222605;2473.3445636906235;2525.507526032415;2533.9113131040417;2534.6831646044243;2536.5053814506177;2103.3269353806786;2329.2895666821614;2446.498467814094;2452.0314475782056;2452.546278938402;2108.7785782492847;2416.4804567018086;2505.1232068775967;2506.310764539748;2508.5735424977706;2364.7635236476217;2372.95254094918;2383.177803657744;2385.2844146755992;2389.259329607827;2357.799587035087;2367.857928524294;2402.627592723131;2410.2287268074224;2415.251272105653;11395.772084558344;11583.6524904253;11628.6511404658;11629.185956983014;11632.476538555786;6502.7398904043785;6717.731290748364;6723.865522689519;6734.56225345351;6738.696758645872;3911.706622003361;4057.655099316532;4100.712950093494;4123.381492776078;4191.790410479494;1333.7532556477083;1380.4478208716494;1380.9171449713049;1384.1072508232135;1389.9374528146157;18279.360222392286;18439.354622588144;18453.907730461262;18460.907695461436;18471.90764046171;5380.811671591554;5413.024246150127;5459.672419654833;5546.223528705985;5630.239917611152;12660.303683297323;12718.236905785683;12719.046071544672;12722.109452338247;12726.936365318114;6556.18047744032;6584.637844918576;6604.966975165094;6607.306232845578;6615.37153970372;5908.231929849092;5996.190514280604;6127.448529632355;6185.690715464209;6190.442860142609;4234.724742891703;4323.0705398339505;4328.156009578102;4342.500612429548;4360.520342762294;1106.9723256918642;1130.8416821644976;1264.8482182138018;1278.4247088810073;1301.1477482249143;814.8899898513744;823.5058964621179;834.9039860416009;847.4576271186446;851.5699571716367;6589.4069533742195;6614.048855587614;6697.593505363928;6736.831579210461;6895.689693963784;946.2193690205607;952.1858810716737;956.6556039825657;958.075457183821;963.3641796414333;4074.1444296698023;4222.408862759216;4261.914761704748;4311.159323931866;4410.095930334273;15621;16413.753793692864;16422.343106275854;16426.260818263207;16440.095794731165;14314;14903.925480372529;14950.327235274439;16081.276342564614;16324.510264692079;9474.810503789886;9638.277129215337;9658.517074146404;9718.562664680107;9735.513224338754;6669.399754022162;7085.149782025984;7090.574565526085;7108.893366599608;7123.430125589836;13739.793903091662;13751.381187846371;13944.093633913762;14153.929230353782;14335.641608959442;14211.573652790019;14597.197154156624;14610.926945365205;14782.63043423923;14789.482368117064;9686.806263874823;9927.156191723785;9937.552810123418;9942.652007179713;10312.587496500057;11487.655370338904;11538.596149135075;11555.537778488766;11562.47968841421;11574.88425115738;8593.613287401957;9559.713208603753;9598.280128990215;9864.852027219455;9984.650537231162;9076;9382.155605995493;9405.529723513933;9596.376235544667;9633.373830701263;8247.711330103417;8359.95820020896;8361.790955226168;8364.498130112213;8366.539840308842;6049.304330002106;6062.151298818258;6101.816945491642;6163.784267550794;6329.841753956188;5911.349751527415;5922.726613778058;5929.85175370602;5962.612430192024;6215.316315205414 04:11:51 INFO - PID 21972 | |4;prototype.html;403.1513663737834;419.0863916661678;424.72605169665565;430.6145999330601;432.08182611949604;5842.240508733864;5869;5893.440123188296;5904.380040095782;5918.585699001066;5555.30558680165;5712.771489140439;5717.2281741964825;5778.757567123068;5793;4383.013821890081;4391.758453285068;4394.296912494002;4399.428074350346;4403.097365040175;4413.624841888443;4420.668449866257;4421.6904816662845;4424.845130420436;4429.822807087713;4308.18144552534;4334.60988511034;4343.413639158721;4351.825926962933;4369.868903932887;4339.370791235253;4342.482589102821;4346.913061738764;4352.390665306828;4364.738115713068;3836.846526138951;3839.9808000960097;3842.5581058178386;3849.3648547989546;3864.574896761354;5561.749721262553;5618.410066942953;5667.8583035424035;5680.5514593778325;5684.886302273972;5131.563817075553;5141.53726164647;5141.843085305776;5143.768530416103;5151.819686310999;5882.794102206402;6034.883546543903;6066.514678825727;6079.635221886701;6084.421979911901;4229.471316085489;4245.5375881988375;4279.293916503804;4289.185054839601;4296.140771845643;6089.847753806146;6179.69101544921;6195.938040619581;6344.779327235477;6439.83900402489;4373.938243229752;4380.62764665007;4384.868453946387;4390.517043125254;4399.318105693623;4437.667174961826;4468.419105516262;4472.619827314649;4478.910421791546;4483.3947417098925;5012.223105418666;5086.847394578169;5118.616103792156;5131.666441681354;5139.89264401601;6042;6080.908786368208;6098.786542470993;6105.633661980295;6108.114323423168;1519.5517322389921;1531.7778922056239;1537.4318195440812;1540.6456515001612;1544.7296723073416;1009.9501000986098;1026.7279171019686;1038.382162613244;1040.70339953113;1046.4924511611862;5830.82507524775;5837.6497410155525;5839.073105875051;5853.063509838491;5853.619514731528;6108.175396321529;6247.718852651642;6262.246570960138;6264.561480696399;6290.370962903765;5790.478856902815;5791.420857914175;5819.447152520504;5823.359430462646;5848.795292164754;3266.2852002698774;3296.7032967033083;3301.752368572367;3303.587051618548;3314.900552983366;6317.5893566918;6465.288818229991;6476.935230647728;6605.24039735427;6613.966930165415;6443.29123796382;6446.871062578723;6458.418742313214;6462.319796852758;6468.676566171766;6288.591241569284;6499.935000650027;6568.376004279681;6611.702473388709;6618.6690665467495;6244.406781355764;6266.310705822447;6271.843203919939;6277.3408792078;6288.1825362704385;6015.699215039318;6175.197224360804;6218.875622487615;6219.813405597839;6241.160272076285;6526.804195874131;6549.410553050057;6554.14796076507;6556.672166391757;6556.754596323018;4386.727848923904;4394.231009573376;4409.581089796464;4412.161689279027;4420.336949457607;6183.783567575113;6309.864224439645;6327.778527751507;6333.556651034383;6343.238811342484;6040.305364883095;6041.18444010053;6078.179445774764;6090.898639969204;6103.8779224414375;5825.300963884191;6067.544934130046;6094.124700239879;6106.1146133811235;6106.6336019838955;6030;6070.6357618543025;6074.271087469532;6076.210092687922;6082.817515474543;6038.184845045863;6093.329733729198;6117;6129.172561704291;6152.138700582012;5895.911561326498;5913.113033045078;5920.957269741933;5923.437273459014;5929.970350148222 04:11:51 INFO - PID 21972 | |5;yui.html;853.1511146409324;867.845765132374;872.2542226396431;885.269652536657;886.5655828643964;17036;17299.308027678908;17720.113994300296;17725.29098836045;17730.64538709225;16073.196340183002;16250.024998500068;16511.174441277948;16520.75218871718;16589.170541472908;917.9908200917989;942.9198518125968;943.2548286853378;943.79708362702;944.7874228298647;999.7650552120245;1007.6523599358246;1009.9394036357842;1010.1615659003047;1010.3836659637615;1046.4506134279488;1048.13528838708;1050.322541960435;1051.6424415698662;1051.8579991701138;1045.7385653586603;1048.355261514171;1049.7480604654866;1050.438015661625;1050.616524968381;767.4014268870291;769.0655853138463;769.4806005945964;769.6651956398929;769.7729169894894;14759.77860332096;15251.542453726406;15430.228488575527;16104.83895161045;16110.838891611169;17211.397601083903;17654.470365888916;18782.812171878242;19136.138873750715;19309.131089101025;14695.70608587833;15066.849331506653;15083.396664133421;15191.848081519154;15230.238488075553;3507.0706262840367;3523.0839981604713;3526.4357702767434;3533.628968958248;3540.5928318243473;99203.0398480073;104383;104566.47716761443;104663.47668261686;106207;14624.780628290584;14853;14873.405063797543;15004.399824006918;15054.096754194565;27317.590236146472;27749.751261193294;27752.722472775014;27968.160955171377;28064.71935280662;8105.797355066053;8279;8320.292775114183;8321.708740194064;8341.541215233221;3861.2663593917064;3912.7065470089856;3968.1270120573427;3983.183447393277;4003.2994226010915;4626.884327891829;4705.364775755298;4706.294055891643;4707.976460117678;4712.410948631421;846.8983721953405;872.0930232558069;872.4895935877582;876.5003947749849;916.4089162490156;665.4044630056072;691.8858388365863;699.2832346844424;702.3082263969985;728.6393235348536;11645.6506304811;12200.633980980585;12431.564895228805;12797.360131993362;12920.41858116387;711.6904146696204;721.1490441279341;727.105660038156;729.4201110117469;750.3097150621442;5442.319710036246;5757.625754325955;5798.304203495523;5814.476697097281;5888.057910734262;85432.57283713666;85669.57165214134;85684;86949;87826.56086719525;53264;73325.6333718328;74505.62747186229;74737;76995.23004769992;41856.19451645819;61705.691471542355;61950;62082;65547.67226163934;12347.38263086824;13129.212247265195;13210.471581136648;13235.757239476005;13240.602781916557;32655.510167347984;34383.4842477358;35060.47409288914;35188.296234075686;35832.104197395274;52758.472415275355;54071;56387;57074.14388784255;57215;16973.23620437108;17419.39032133869;17439.389621363192;17545.649087018443;17690;18345.54136146607;18844.811551884304;18894.622107558047;19059.42821715351;19156.61686766229;16547.420840270534;16559.00645961246;16722.414715485385;16842.242099105813;16920.66158676844;17046.403375881786;17478.62546442048;17640;17756;18019.459416217534;16913.577160571083;16928.32286708567;17134;17211;17289.65420691554;11937.641870743892;12315.815262770886;13197.142185757895;13224.206547607175;13549.796753048515;14082.647933801327;14420.567382978528;14466.782998255245;14693.19187444658;14845.554633361016 04:11:51 INFO - PID 21972 | __end_tp_report 04:11:51 INFO - PID 21972 | __start_cc_report 04:11:51 INFO - PID 21972 | _x_x_mozilla_cycle_collect,1607 04:11:51 INFO - PID 21972 | __end_cc_report 04:11:51 INFO - PID 21972 | __startTimestamp1494587511526__endTimestamp 04:11:51 INFO - PID 21972 | 04:11:51 INFO - PID 21972 | ------- Summary: start ------- 04:11:51 INFO - PID 21972 | Number of tests: 6 04:11:51 INFO - PID 21972 | 04:11:51 INFO - PID 21972 | [#0] dojo.html Cycles:165 Average:5726.65 Median:5975.10 stddev:682.57 (11.4%) stddev-sans-first:657.01 04:11:51 INFO - PID 21972 | Values: 3275.2 3282.3 3290.4 3313.9 3351.3 5602.2 5689.9 5753.2 5794.8 5817.5 5676.1 5755.9 5773.9 5783.9 5837.5 4747.7 5018.5 5094.9 5138.0 5188.2 5012.7 5145.2 5160.1 5199.9 5215.3 5070.3 5077.7 5141.5 5171.1 5180.6 5110.3 5128.5 5131.1 5131.3 5134.8 5052.9 5109.5 5111.2 5114.0 5117.7 5614.7 5668.0 5688.3 5787.5 5797.7 6207.8 6210.3 6212.0 6226.9 6234.5 6275.4 6280.5 6289.3 6291.0 6300.8 5633.7 5643.7 5687.8 5707.2 5798.5 6347.7 6358.0 6372.3 6372.7 6378.9 5975.2 6008.2 6037.3 6037.8 6098.0 6094.5 6101.0 6110.8 6115.8 6120.4 6011.0 6020.3 6040.8 6080.1 6081.6 6087.7 6139.7 6184.8 6189.7 6189.9 4756.1 4758.0 4758.0 4774.0 4799.8 4179.7 4220.6 4231.4 4247.4 4266.0 5775.2 5786.6 5856.3 5859.0 5873.1 6260.1 6300.5 6303.6 6310.2 6316.7 5853.0 5853.1 5853.3 5859.7 5912.0 5288.9 5395.4 5415.0 5464.5 5473.9 6487.1 6543.5 6544.1 6548.0 6549.1 6281.3 6282.0 6287.6 6289.0 6292.7 6192.0 6323.4 6397.6 6477.1 6527.7 6126.8 6149.4 6164.4 6180.8 6187.1 6063.5 6280.5 6283.1 6287.7 6291.8 5931.0 5975.1 5996.8 5999.1 6005.7 6068.1 6069.3 6093.1 6118.2 6126.5 6036.1 6051.9 6055.9 6057.2 6064.7 5916.3 6053.8 6067.2 6113.3 6117.9 5708.5 5827.1 5838.8 5869.9 5887.1 04:11:51 INFO - PID 21972 | 04:11:51 INFO - PID 21972 | [#1] ext.html Cycles:180 Average:38506.78 Median:34337.74 stddev:56164.95 (163.6%) stddev-sans-first:56250.96 04:11:51 INFO - PID 21972 | Values: 752.1 822.4 845.2 1131.0 1153.0 31021.7 31582.8 31601.7 31627.0 38390.6 41421.1 41705.4 41780.4 41849.0 41873.4 7065.9 7173.0 7174.6 7175.6 7177.4 5633.3 5697.3 7097.4 7212.2 7289.7 7235.3 7264.7 7269.9 7271.0 7279.8 7172.1 7176.0 7196.0 7204.5 7210.3 5606.0 5656.9 5658.7 7238.3 7306.0 34552.0 34635.0 34831.7 34860.8 34880.3 3595.1 3631.3 3632.0 3632.3 3636.7 28593.3 28656.0 28680.6 28777.1 28817.6 3821.1 3867.6 3881.3 3889.3 3931.3 191928.0 192964.0 193517.0 193835.0 194165.0 50439.5 50511.5 50623.0 50678.7 50695.0 52196.0 52675.5 52704.5 52713.0 52749.5 13592.0 13678.6 13682.9 13710.0 13710.8 10716.1 10758.6 10767.9 10772.7 10819.7 12070.6 12314.9 14118.0 15498.9 15889.9 6070.6 6289.7 6299.4 6307.3 6323.9 1064.2 1091.9 1105.7 1107.4 1116.4 27035.2 27439.3 27627.0 27664.7 27673.3 1174.1 1175.3 1182.1 1182.7 1194.6 13308.2 14049.9 14066.9 14214.5 14245.0 240122.0 241669.0 241902.0 242044.0 242759.0 54721.5 55022.4 55119.4 55155.4 55217.4 1438.7 1492.6 1513.6 1529.9 1532.2 24460.1 25557.2 25807.4 25885.2 26153.2 39900.4 40026.8 40051.4 40129.6 40181.8 209545.0 210191.0 211188.0 211415.0 211676.0 36059.3 36293.0 36419.5 36423.5 36428.8 43901.8 46070.8 46346.0 46413.0 46822.3 30837.4 32772.4 33794.2 34122.7 34123.5 32785.5 32819.3 33256.5 33563.7 33717.3 37577.0 38669.2 38674.0 38706.0 38831.8 31800.4 32432.8 32681.8 33096.0 33258.7 25158.5 25936.5 26147.9 26275.2 26289.9 04:11:51 INFO - PID 21972 | 04:11:51 INFO - PID 21972 | [#2] jquery.html Cycles:180 Average:31351.38 Median:2148.18 stddev:83502.59 (3887.1%) stddev-sans-first:83704.60 04:11:51 INFO - PID 21972 | Values: 448.7 449.7 451.5 468.1 474.1 18792.0 19156.0 19817.5 19900.7 20067.2 21259.9 21353.1 21627.7 21992.9 22055.4 5386.3 5555.1 5560.5 5560.6 5561.1 4265.7 5474.0 5513.8 5518.0 5533.7 5488.3 5491.2 5496.1 5496.2 5497.9 5344.3 5375.0 5412.1 5421.4 5422.5 4887.2 4951.5 4958.8 4960.4 4963.9 24113.2 24436.9 24537.3 24583.6 24989.3 2116.7 2144.5 2145.6 2145.8 2150.6 16167.8 16691.3 16699.7 16766.1 16881.7 2126.8 2210.8 2225.5 2236.4 2254.4 93718.0 104968.0 119677.0 119761.0 119877.0 11933.1 11985.3 12129.6 12310.6 12340.0 17214.3 17219.5 17220.4 17242.7 17258.6 8744.5 8858.4 8956.1 9019.0 9044.8 8174.6 8280.0 8282.5 8487.9 8511.1 7590.2 7750.4 7889.4 7892.0 7957.3 2091.2 2092.5 2139.1 2151.3 2168.3 1054.9 1094.6 1095.5 1097.9 1101.9 21042.8 21218.3 21254.0 21547.8 21828.8 1084.0 1095.0 1098.1 1099.9 1112.1 10775.7 11523.9 11630.4 11648.7 11688.4 493080.0 500326.0 501475.0 504774.7 516882.0 78762.8 94412.0 94861.5 96300.5 102132.0 1180.4 1240.3 1246.6 1250.0 1264.3 19901.2 20015.8 20638.5 20698.4 20879.3 45896.9 46474.4 47054.5 47489.8 47841.8 57105.4 57810.7 58521.7 58578.7 59781.7 9699.1 9858.7 9946.0 9989.2 10235.2 15325.5 15519.9 15643.5 15709.4 15783.8 12156.2 12854.7 12903.9 13495.3 13771.4 12076.1 12368.1 12384.7 12489.2 12754.4 13514.1 13566.7 13602.7 13817.5 14003.2 9802.6 9845.8 9856.5 10208.2 10246.4 13227.3 13234.9 13246.5 13401.7 13771.1 04:11:51 INFO - PID 21972 | 04:11:51 INFO - PID 21972 | [#3] mootools.html Cycles:180 Average:7397.89 Median:3224.11 stddev:4859.07 (150.7%) stddev-sans-first:4851.48 04:11:51 INFO - PID 21972 | Values: 1354.4 1371.2 1397.9 1398.8 1401.5 11366.5 11819.9 11836.6 11842.2 11845.0 11597.5 11930.8 12340.9 12352.3 12361.2 2473.3 2525.5 2533.9 2534.7 2536.5 2103.3 2329.3 2446.5 2452.0 2452.5 2108.8 2416.5 2505.1 2506.3 2508.6 2364.8 2373.0 2383.2 2385.3 2389.3 2357.8 2367.9 2402.6 2410.2 2415.3 11395.8 11583.7 11628.7 11629.2 11632.5 6502.7 6717.7 6723.9 6734.6 6738.7 3911.7 4057.7 4100.7 4123.4 4191.8 1333.8 1380.4 1380.9 1384.1 1389.9 18279.4 18439.4 18453.9 18460.9 18471.9 5380.8 5413.0 5459.7 5546.2 5630.2 12660.3 12718.2 12719.0 12722.1 12726.9 6556.2 6584.6 6605.0 6607.3 6615.4 5908.2 5996.2 6127.4 6185.7 6190.4 4234.7 4323.1 4328.2 4342.5 4360.5 1107.0 1130.8 1264.8 1278.4 1301.1 814.9 823.5 834.9 847.5 851.6 6589.4 6614.0 6697.6 6736.8 6895.7 946.2 952.2 956.7 958.1 963.4 4074.1 4222.4 4261.9 4311.2 4410.1 15621.0 16413.8 16422.3 16426.3 16440.1 14314.0 14903.9 14950.3 16081.3 16324.5 9474.8 9638.3 9658.5 9718.6 9735.5 6669.4 7085.1 7090.6 7108.9 7123.4 13739.8 13751.4 13944.1 14153.9 14335.6 14211.6 14597.2 14610.9 14782.6 14789.5 9686.8 9927.2 9937.6 9942.7 10312.6 11487.7 11538.6 11555.5 11562.5 11574.9 8593.6 9559.7 9598.3 9864.9 9984.7 9076.0 9382.2 9405.5 9596.4 9633.4 8247.7 8360.0 8361.8 8364.5 8366.5 6049.3 6062.2 6101.8 6163.8 6329.8 5911.3 5922.7 5929.9 5962.6 6215.3 04:11:51 INFO - PID 21972 | 04:11:51 INFO - PID 21972 | [#4] prototype.html Cycles:180 Average:5107.40 Median:5834.24 stddev:1525.66 (26.2%) stddev-sans-first:1488.52 04:11:51 INFO - PID 21972 | Values: 403.2 419.1 424.7 430.6 432.1 5842.2 5869.0 5893.4 5904.4 5918.6 5555.3 5712.8 5717.2 5778.8 5793.0 4383.0 4391.8 4394.3 4399.4 4403.1 4413.6 4420.7 4421.7 4424.8 4429.8 4308.2 4334.6 4343.4 4351.8 4369.9 4339.4 4342.5 4346.9 4352.4 4364.7 3836.8 3840.0 3842.6 3849.4 3864.6 5561.7 5618.4 5667.9 5680.6 5684.9 5131.6 5141.5 5141.8 5143.8 5151.8 5882.8 6034.9 6066.5 6079.6 6084.4 4229.5 4245.5 4279.3 4289.2 4296.1 6089.8 6179.7 6195.9 6344.8 6439.8 4373.9 4380.6 4384.9 4390.5 4399.3 4437.7 4468.4 4472.6 4478.9 4483.4 5012.2 5086.8 5118.6 5131.7 5139.9 6042.0 6080.9 6098.8 6105.6 6108.1 1519.6 1531.8 1537.4 1540.6 1544.7 1010.0 1026.7 1038.4 1040.7 1046.5 5830.8 5837.6 5839.1 5853.1 5853.6 6108.2 6247.7 6262.2 6264.6 6290.4 5790.5 5791.4 5819.4 5823.4 5848.8 3266.3 3296.7 3301.8 3303.6 3314.9 6317.6 6465.3 6476.9 6605.2 6614.0 6443.3 6446.9 6458.4 6462.3 6468.7 6288.6 6499.9 6568.4 6611.7 6618.7 6244.4 6266.3 6271.8 6277.3 6288.2 6015.7 6175.2 6218.9 6219.8 6241.2 6526.8 6549.4 6554.1 6556.7 6556.8 4386.7 4394.2 4409.6 4412.2 4420.3 6183.8 6309.9 6327.8 6333.6 6343.2 6040.3 6041.2 6078.2 6090.9 6103.9 5825.3 6067.5 6094.1 6106.1 6106.6 6030.0 6070.6 6074.3 6076.2 6082.8 6038.2 6093.3 6117.0 6129.2 6152.1 5895.9 5913.1 5921.0 5923.4 5930.0 04:11:51 INFO - PID 21972 | 04:11:51 INFO - PID 21972 | [#5] yui.html Cycles:180 Average:19711.22 Median:19146.38 stddev:24715.17 (129.1%) stddev-sans-first:24743.93 04:11:51 INFO - PID 21972 | Values: 853.2 867.8 872.3 885.3 886.6 17036.0 17299.3 17720.1 17725.3 17730.6 16073.2 16250.0 16511.2 16520.8 16589.2 918.0 942.9 943.3 943.8 944.8 999.8 1007.7 1009.9 1010.2 1010.4 1046.5 1048.1 1050.3 1051.6 1051.9 1045.7 1048.4 1049.7 1050.4 1050.6 767.4 769.1 769.5 769.7 769.8 14759.8 15251.5 15430.2 16104.8 16110.8 17211.4 17654.5 18782.8 19136.1 19309.1 14695.7 15066.8 15083.4 15191.8 15230.2 3507.1 3523.1 3526.4 3533.6 3540.6 99203.0 104383.0 104566.5 104663.5 106207.0 14624.8 14853.0 14873.4 15004.4 15054.1 27317.6 27749.8 27752.7 27968.2 28064.7 8105.8 8279.0 8320.3 8321.7 8341.5 3861.3 3912.7 3968.1 3983.2 4003.3 4626.9 4705.4 4706.3 4708.0 4712.4 846.9 872.1 872.5 876.5 916.4 665.4 691.9 699.3 702.3 728.6 11645.7 12200.6 12431.6 12797.4 12920.4 711.7 721.1 727.1 729.4 750.3 5442.3 5757.6 5798.3 5814.5 5888.1 85432.6 85669.6 85684.0 86949.0 87826.6 53264.0 73325.6 74505.6 74737.0 76995.2 41856.2 61705.7 61950.0 62082.0 65547.7 12347.4 13129.2 13210.5 13235.8 13240.6 32655.5 34383.5 35060.5 35188.3 35832.1 52758.5 54071.0 56387.0 57074.1 57215.0 16973.2 17419.4 17439.4 17545.6 17690.0 18345.5 18844.8 18894.6 19059.4 19156.6 16547.4 16559.0 16722.4 16842.2 16920.7 17046.4 17478.6 17640.0 17756.0 18019.5 16913.6 16928.3 17134.0 17211.0 17289.7 11937.6 12315.8 13197.1 13224.2 13549.8 14082.6 14420.6 14466.8 14693.2 14845.6 04:11:51 INFO - PID 21972 | -------- Summary: end -------- 04:11:51 INFO - PID 21972 | 04:11:52 INFO - TEST-INFO | 21972: exit 0 04:11:52 INFO - TEST-OK | dromaeo_css | took 1114466ms 04:11:52 INFO - TEST-START | kraken 04:11:52 INFO - operating with platform_type : linux_ 04:11:52 INFO - Initialising browser for kraken test... 04:11:52 INFO - TEST-INFO | started process 22304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUsz7Vp/profile http://localhost:52591/getInfo.html) 04:11:55 INFO - PID 22304 | __metrics Screen width/height:1600/1200 04:11:55 INFO - PID 22304 | colorDepth:24 04:11:55 INFO - PID 22304 | Browser inner width/height: 1024/695 04:11:55 INFO - PID 22304 | __metrics 04:11:56 INFO - PID 22304 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:11:56 INFO - PID 22304 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:11:57 INFO - TEST-INFO | 22304: exit 0 04:11:57 INFO - Browser initialized. 04:11:57 INFO - Running cycle 1/1 for kraken test... 04:11:57 INFO - TEST-INFO | started process 22405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUsz7Vp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:09 INFO - PID 22405 | RSS: Main: 144506880 04:12:09 INFO - PID 22405 | 04:12:11 INFO - PID 22405 | Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52591/tests/kraken/driver.html?testName=audio-beat-detection) 04:12:12 INFO - PID 22405 | RSS: Main: 217907200 04:12:12 INFO - PID 22405 | 04:12:15 INFO - PID 22405 | Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52591/tests/kraken/driver.html?testName=audio-dft) 04:12:15 INFO - PID 22405 | RSS: Main: 179453952 04:12:15 INFO - PID 22405 | 04:12:18 INFO - PID 22405 | Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52591/tests/kraken/driver.html?testName=audio-fft) 04:12:19 INFO - PID 22405 | RSS: Main: 259473408 04:12:19 INFO - PID 22405 | 04:12:21 INFO - PID 22405 | Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52591/tests/kraken/driver.html?testName=audio-oscillator) 04:12:22 INFO - PID 22405 | RSS: Main: 171438080 04:12:22 INFO - PID 22405 | 04:12:24 INFO - PID 22405 | Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52591/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:12:24 INFO - PID 22405 | RSS: Main: 174149632 04:12:24 INFO - PID 22405 | 04:12:27 INFO - PID 22405 | Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52591/tests/kraken/driver.html?testName=imaging-darkroom) 04:12:28 INFO - PID 22405 | RSS: Main: 230289408 04:12:28 INFO - PID 22405 | 04:12:31 INFO - PID 22405 | Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52591/tests/kraken/driver.html?testName=imaging-desaturate) 04:12:32 INFO - PID 22405 | RSS: Main: 249446400 04:12:32 INFO - PID 22405 | 04:12:34 INFO - PID 22405 | Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52591/tests/kraken/driver.html?testName=json-parse-financial) 04:12:35 INFO - PID 22405 | RSS: Main: 264224768 04:12:35 INFO - PID 22405 | 04:12:37 INFO - PID 22405 | Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52591/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:12:37 INFO - PID 22405 | RSS: Main: 198316032 04:12:37 INFO - PID 22405 | 04:12:39 INFO - PID 22405 | Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52591/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:12:39 INFO - PID 22405 | RSS: Main: 202579968 04:12:39 INFO - PID 22405 | 04:12:41 INFO - PID 22405 | Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52591/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:12:42 INFO - PID 22405 | RSS: Main: 211955712 04:12:42 INFO - PID 22405 | 04:12:44 INFO - PID 22405 | Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52591/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:12:45 INFO - PID 22405 | RSS: Main: 221540352 04:12:45 INFO - PID 22405 | 04:12:48 INFO - PID 22405 | Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52591/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:12:49 INFO - PID 22405 | RSS: Main: 216563712 04:12:49 INFO - PID 22405 | 04:12:50 INFO - PID 22405 | Cycle 1(1): loaded http://localhost:52591/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52591/tests/kraken/driver.html?testName=ai-astar) 04:12:51 INFO - PID 22405 | RSS: Main: 266149888 04:12:51 INFO - PID 22405 | 04:12:51 INFO - PID 22405 | __start_tp_report 04:12:51 INFO - PID 22405 | _x_x_mozilla_page_load 04:12:51 INFO - PID 22405 | _x_x_mozilla_page_load_details 04:12:51 INFO - PID 22405 | |i|pagename|runs| 04:12:51 INFO - PID 22405 | |0;ai-astar;107;109;110;109;109;111;110;109;110;112 04:12:51 INFO - PID 22405 | |1;audio-beat-detection;151;117;118;179;118;118;116;115;136;118 04:12:51 INFO - PID 22405 | |2;audio-dft;162;161;164;162;162;159;162;159;163;161 04:12:51 INFO - PID 22405 | |3;audio-fft;74;74;74;113;76;74;76;76;95;76 04:12:51 INFO - PID 22405 | |4;audio-oscillator;81;81;107;82;82;81;94;82;82;104 04:12:51 INFO - PID 22405 | |5;imaging-gaussian-blur;113;113;113;113;112;112;113;113;112;112 04:12:51 INFO - PID 22405 | |6;imaging-darkroom;147;146;146;146;147;148;147;147;147;146 04:12:51 INFO - PID 22405 | |7;imaging-desaturate;94;93;93;93;93;93;93;94;93;93 04:12:51 INFO - PID 22405 | |8;json-parse-financial;46;46;47;47;47;49;47;47;46;45 04:12:51 INFO - PID 22405 | |9;json-stringify-tinderbox;57;53;54;53;53;53;54;55;55;54 04:12:51 INFO - PID 22405 | |10;stanford-crypto-aes;78;78;78;78;79;80;80;80;78;78 04:12:51 INFO - PID 22405 | |11;stanford-crypto-ccm;142;123;124;122;123;122;125;123;169;131 04:12:51 INFO - PID 22405 | |12;stanford-crypto-pbkdf2;186;180;182;185;181;182;181;186;187;182 04:12:51 INFO - PID 22405 | |13;stanford-crypto-sha256-iterative;65;68;67;67;67;66;65;64;64;64 04:12:51 INFO - PID 22405 | __end_tp_report 04:12:51 INFO - PID 22405 | __start_cc_report 04:12:51 INFO - PID 22405 | _x_x_mozilla_cycle_collect,1694 04:12:51 INFO - PID 22405 | __end_cc_report 04:12:51 INFO - PID 22405 | __startTimestamp1494587571139__endTimestamp 04:12:51 INFO - PID 22405 | 04:12:51 INFO - PID 22405 | ------- Summary: start ------- 04:12:51 INFO - PID 22405 | Number of tests: 14 04:12:51 INFO - PID 22405 | 04:12:51 INFO - PID 22405 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:1.35 (1.2%) stddev-sans-first:1.05 04:12:51 INFO - PID 22405 | Values: 107.0 109.0 110.0 109.0 109.0 111.0 110.0 109.0 110.0 112.0 04:12:51 INFO - PID 22405 | 04:12:51 INFO - PID 22405 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:118.00 stddev:21.15 (17.9%) stddev-sans-first:20.82 04:12:51 INFO - PID 22405 | Values: 151.0 117.0 118.0 179.0 118.0 118.0 116.0 115.0 136.0 118.0 04:12:51 INFO - PID 22405 | 04:12:51 INFO - PID 22405 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.58 (1.0%) stddev-sans-first:1.67 04:12:51 INFO - PID 22405 | Values: 162.0 161.0 164.0 162.0 162.0 159.0 162.0 159.0 163.0 161.0 04:12:51 INFO - PID 22405 | 04:12:51 INFO - PID 22405 | [#3] audio-fft Cycles:10 Average:80.80 Median:76.00 stddev:12.98 (17.1%) stddev-sans-first:13.53 04:12:51 INFO - PID 22405 | Values: 74.0 74.0 74.0 113.0 76.0 74.0 76.0 76.0 95.0 76.0 04:12:51 INFO - PID 22405 | 04:12:51 INFO - PID 22405 | [#4] audio-oscillator Cycles:10 Average:87.60 Median:82.00 stddev:10.23 (12.5%) stddev-sans-first:10.57 04:12:51 INFO - PID 22405 | Values: 81.0 81.0 107.0 82.0 82.0 81.0 94.0 82.0 82.0 104.0 04:12:51 INFO - PID 22405 | 04:12:51 INFO - PID 22405 | [#5] imaging-gaussian-blur Cycles:10 Average:112.60 Median:113.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:12:51 INFO - PID 22405 | Values: 113.0 113.0 113.0 113.0 112.0 112.0 113.0 113.0 112.0 112.0 04:12:51 INFO - PID 22405 | 04:12:51 INFO - PID 22405 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 04:12:51 INFO - PID 22405 | Values: 147.0 146.0 146.0 146.0 147.0 148.0 147.0 147.0 147.0 146.0 04:12:51 INFO - PID 22405 | 04:12:51 INFO - PID 22405 | [#7] imaging-desaturate Cycles:10 Average:93.20 Median:93.00 stddev:0.42 (0.5%) stddev-sans-first:0.33 04:12:51 INFO - PID 22405 | Values: 94.0 93.0 93.0 93.0 93.0 93.0 93.0 94.0 93.0 93.0 04:12:51 INFO - PID 22405 | 04:12:51 INFO - PID 22405 | [#8] json-parse-financial Cycles:10 Average:46.70 Median:47.00 stddev:1.06 (2.3%) stddev-sans-first:1.09 04:12:51 INFO - PID 22405 | Values: 46.0 46.0 47.0 47.0 47.0 49.0 47.0 47.0 46.0 45.0 04:12:51 INFO - PID 22405 | 04:12:51 INFO - PID 22405 | [#9] json-stringify-tinderbox Cycles:10 Average:54.10 Median:54.00 stddev:1.29 (2.4%) stddev-sans-first:0.83 04:12:51 INFO - PID 22405 | Values: 57.0 53.0 54.0 53.0 53.0 53.0 54.0 55.0 55.0 54.0 04:12:51 INFO - PID 22405 | 04:12:51 INFO - PID 22405 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.50 stddev:0.95 (1.2%) stddev-sans-first:0.97 04:12:51 INFO - PID 22405 | Values: 78.0 78.0 78.0 78.0 79.0 80.0 80.0 80.0 78.0 78.0 04:12:51 INFO - PID 22405 | 04:12:51 INFO - PID 22405 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:124.50 stddev:14.91 (12.0%) stddev-sans-first:15.21 04:12:51 INFO - PID 22405 | Values: 142.0 123.0 124.0 122.0 123.0 122.0 125.0 123.0 169.0 131.0 04:12:51 INFO - PID 22405 | 04:12:51 INFO - PID 22405 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.20 Median:183.50 stddev:2.53 (1.4%) stddev-sans-first:2.47 04:12:51 INFO - PID 22405 | Values: 186.0 180.0 182.0 185.0 181.0 182.0 181.0 186.0 187.0 182.0 04:12:51 INFO - PID 22405 | 04:12:51 INFO - PID 22405 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.50 stddev:1.49 (2.2%) stddev-sans-first:1.56 04:12:51 INFO - PID 22405 | Values: 65.0 68.0 67.0 67.0 67.0 66.0 65.0 64.0 64.0 64.0 04:12:51 INFO - PID 22405 | -------- Summary: end -------- 04:12:51 INFO - PID 22405 | 04:12:52 INFO - TEST-INFO | 22405: exit 0 04:12:52 INFO - TEST-OK | kraken | took 59937ms 04:12:52 INFO - SUITE-END | took 1174s 04:12:52 INFO - Completed test suite (00:19:34) 04:12:52 INFO - javascript benchmark 04:12:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7721.579120448726, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3275.2139486523233, 3282.294306724054, 3290.4406250937354, 3313.9171520711993, 3351.346487434951, 5602.215689803421, 5689.8577535561635, 5753.223314852494, 5794.7682092716295, 5817.476427121558, 5676.120201368794, 5755.884882302352, 5773.9422605773925, 5783.884322313551, 5837.532997360212, 4747.7388743619085, 5018.523240292185, 5094.872628184288, 5138.0, 5188.221766734982, 5012.749362531858, 5145.228215767646, 5160.122779127539, 5199.922001169985, 5215.348081489814, 5070.290159377671, 5077.695338279678, 5141.485851414866, 5171.146760784466, 5180.6373553851245, 5110.310108135392, 5128.461511541272, 5131.102057139986, 5131.255967884673, 5134.768935397916, 5052.873678158076, 5109.514596113363, 5111.182210846247, 5113.9772045591035, 5117.692938423706, 5614.747336369873, 5667.971660141714, 5688.345840228385, 5787.536997040269, 5797.681127537984, 6207.782727604512, 6210.254769427697, 6212.006079027379, 6226.937730622681, 6234.470070044052, 6275.403836635513, 6280.528960327948, 6289.276733175698, 6291.0, 6300.779472718433, 5633.746481408347, 5643.717814109278, 5687.829365119053, 5707.229524014288, 5798.478136967651, 6347.650879201688, 6358.046293056079, 6372.299047104815, 6372.681365931685, 6378.936210637927, 5975.163477113208, 6008.24896887889, 6037.275526936708, 6037.849053773691, 6098.024316109401, 6094.537231721354, 6100.969495152496, 6110.755569777248, 6115.785947491817, 6120.386183820725, 6011.0, 6020.277566692025, 6040.7583696651645, 6080.118382834465, 6081.604695694766, 6087.66517841523, 6139.719840936791, 6184.783532576338, 6189.659568723763, 6189.876202475925, 4756.072565849626, 4757.952420475751, 4757.95242047582, 4773.952260477351, 4799.832005879777, 4179.749215047107, 4220.577942205755, 4231.407602935591, 4247.384129301296, 4265.954841063959, 5775.191473193756, 5786.566007549451, 5856.297244330623, 5858.970705146447, 5873.060310350409, 6260.123582698426, 6300.527460440485, 6303.558750887486, 6310.179676642099, 6316.652584107918, 5853.0, 5853.122031695195, 5853.326867410217, 5859.677717725566, 5911.994960856665, 5288.947110528922, 5395.379531353866, 5414.972925135349, 5464.508194262456, 5473.863153421116, 6487.059376390397, 6543.509236807164, 6544.149260596092, 6548.0, 6549.083128361938, 6281.309056003744, 6282.026285925689, 6287.591306565241, 6289.0, 6292.685365731603, 6191.9690401547705, 6323.399277068671, 6397.616143031433, 6477.093206951125, 6527.738890444519, 6126.754929802936, 6149.385061493815, 6164.445199932027, 6180.783672571439, 6187.102870083902, 6063.454289114001, 6280.466160376419, 6283.088952102011, 6287.748490060347, 6291.779787707408, 5930.970345148246, 5975.103734439695, 5996.820095397145, 5999.130126131774, 6005.699715014319, 6068.059450785136, 6069.302030266399, 6093.055576385667, 6118.174046503665, 6126.479249263863, 6036.0644100164545, 6051.939480605313, 6055.939440605537, 6057.242844644419, 6064.727087281171, 5916.290045194604, 6053.788117415869, 6067.150598916067, 6113.2969708482315, 6117.938820611737, 5708.54331653475, 5827.067669172912, 5838.803045375603, 5869.941300586939, 5887.087501437284], "value": 5678.812626221587, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.1087511299111, 822.4119754375622, 845.2266176448547, 1130.9886901130985, 1152.9769404611902, 31021.689783102163, 31582.84208578954, 31601.68398316016, 31627.0, 38390.61609383905, 41421.1005229634, 41705.374419383734, 41780.37329440061, 41849.0, 41873.37189942153, 7065.929340706604, 7173.0, 7174.569525828441, 7175.569465832041, 7177.3540381365665, 5633.295838020247, 5697.259356283677, 7097.432205423554, 7212.206657267722, 7289.708411663553, 7235.312645298688, 7264.7094116235285, 7269.927300727004, 7271.018412514296, 7279.781606551785, 7172.103487064117, 7175.9641201794175, 7196.0, 7204.531705439182, 7210.278972102827, 5605.962896864053, 5656.85857853557, 5658.745356458928, 7238.348548630596, 7306.0, 34552.0, 34635.0, 34831.65168348309, 34860.82569587136, 34880.30239395198, 3595.1191957970204, 3631.2737452509605, 3631.963680363189, 3632.346177688015, 3636.709063274932, 28593.285167870763, 28656.0, 28680.569791453145, 28777.136685899248, 28817.56773648397, 3821.102041020358, 3867.61323867611, 3881.3013657541633, 3889.2804831106055, 3931.253061918226, 191928.0, 192964.0, 193517.03241483844, 193835.0, 194165.0, 50439.49560504348, 50511.49488505068, 50623.0, 50678.74660626673, 50695.0, 52196.0, 52675.47324526782, 52704.47295527072, 52713.0, 52749.472505275226, 13592.048556600943, 13678.589642310746, 13682.863171368357, 13709.97175211863, 13710.794338084937, 10716.089132423831, 10758.623448179276, 10767.946160269148, 10772.676819695422, 10819.67540973772, 12070.577529786415, 12314.876851231553, 14118.0, 15498.922505387627, 15889.920550397173, 6070.575059745864, 6289.7169627365965, 6299.433051025429, 6307.337729538424, 6323.9051414228825, 1064.1965316186229, 1091.8525998990035, 1105.7346236903247, 1107.3743335015852, 1116.3580940958982, 27035.1889443317, 27439.314017149733, 27627.0, 27664.723352766618, 27673.308167295978, 1174.0842143128202, 1175.324188591546, 1182.1075088308444, 1182.7102359921873, 1194.5639841457805, 13308.201507909556, 14049.93065187248, 14066.85933140676, 14214.502492412716, 14245.0, 240122.0, 241669.0, 241902.0, 242044.0, 242759.0, 54721.452785471636, 55022.44977550254, 55119.448805512235, 55155.44844551583, 55217.44782552203, 1438.6834896322791, 1492.5522343297184, 1513.6291608555973, 1529.9388024478897, 1532.1802835483186, 24460.143894963592, 25557.23328300154, 25807.354816128995, 25885.22344329673, 26153.215403537924, 39900.401493977035, 40026.79986600048, 40051.39922901217, 40129.598704012584, 40181.79909100436, 209545.0, 210191.0, 211188.0, 211415.0, 211676.0, 36059.27881442304, 36293.0, 36419.45370819387, 36423.453648194765, 36428.81785591055, 43901.78049109734, 46070.76964615155, 46346.0, 46413.0, 46822.29766553437, 30837.395656100434, 32772.36138193033, 33794.15514612154, 34122.658773411946, 34123.488147678305, 32785.50821737628, 32819.34361312808, 33256.501152483215, 33563.66436335703, 33717.325653487285, 37577.0, 38669.2266154681, 38674.0, 38706.0, 38831.805840970614, 31800.36399272048, 32432.83783581067, 32681.836590816893, 33096.0, 33258.66741332556, 25158.49683006293, 25936.481270374865, 26147.869260653573, 26275.21174364772, 26289.868550657888], "value": 17091.111517299367, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.69040362150133, 449.6627529352985, 451.5033463190491, 468.0989095990218, 474.1086756897033, 18792.0, 19156.0, 19817.50456238593, 19900.70148947767, 20067.1973121075, 21259.893700531513, 21353.145874165013, 21627.6755848662, 21992.89003554984, 22055.448613784665, 5386.272853164812, 5555.138953462219, 5560.471755183271, 5560.638558493705, 5561.082421400464, 4265.658747300208, 5474.0, 5513.751881165357, 5517.972410137943, 5533.6956467394275, 5488.313960754906, 5491.176323551459, 5496.120620700689, 5496.241202815101, 5497.917531237034, 5344.331958505187, 5375.00562395958, 5412.052890744104, 5421.376541697716, 5422.484863937959, 4887.218045112765, 4951.504849515056, 4958.776855041532, 4960.379952505937, 4963.925541116886, 24113.156039538706, 24436.877815610987, 24537.263882083567, 24583.63124553133, 24989.250322490356, 2116.703661487393, 2144.4853235223436, 2145.5816115857415, 2145.7854214578574, 2150.580636775829, 16167.757483637755, 16691.332346706116, 16699.74950375745, 16766.07786571738, 16881.746773798404, 2126.7554231263293, 2210.8172127911653, 2225.5103877147003, 2236.4297104238476, 2254.4363909022745, 93718.0, 104968.0, 119677.0, 119761.0, 119877.0, 11933.105017123751, 11985.284561785875, 12129.575464858688, 12310.630681079403, 12340.0, 17214.31142754301, 17219.483415497554, 17220.397286095176, 17242.655146897243, 17258.568535786704, 8744.475331480131, 8858.379913406, 8956.104389560991, 9019.00790912999, 9044.81910361789, 8174.632141553644, 8280.0, 8282.461639993382, 8487.915120848837, 8511.063782983867, 7590.203028681909, 7750.418718596128, 7889.447738658354, 7892.0, 7957.283844453911, 2091.1948899673735, 2092.5082605587677, 2139.080195515943, 2151.2900742754855, 2168.349495151448, 1054.931429457083, 1094.5676457799125, 1095.4686976816238, 1097.8792332843382, 1101.9173561982723, 21042.84264365444, 21218.2573609926, 21254.0, 21547.784522154892, 21828.781712182674, 1083.978320433587, 1095.0418383914075, 1098.132475344469, 1099.8680158381046, 1112.1492058575197, 10775.730606734895, 11523.942380288212, 11630.418479076012, 11648.708782280512, 11688.357140357362, 493080.0, 500326.0, 501475.0, 504774.66577339236, 516881.97416310286, 78762.81855772168, 94412.0, 94861.5256923711, 96300.51849740706, 102132.0, 1180.3567055954525, 1240.3116270469795, 1246.5574720973923, 1250.0312258000122, 1264.2604076615098, 19901.203951841766, 20015.799842001394, 20638.484037899172, 20698.379048628565, 20879.26922557703, 45896.85403816799, 46474.37339693095, 47054.529454705014, 47489.7625511884, 47841.76079119582, 57105.42894571001, 57810.710946445, 58521.70739146447, 58578.70710646419, 59781.701091494266, 9699.12707856268, 9858.654947076819, 9945.950270248602, 9989.150922171697, 10235.181185505291, 15325.540233793005, 15519.922400387926, 15643.530694079196, 15709.371625135323, 15783.763243551586, 12156.209846360312, 12854.742905141658, 12903.870961290268, 13495.325233738471, 13771.380287886868, 12076.09429292789, 12368.072394570263, 12384.690382740504, 12489.18820276679, 12754.42605082755, 13514.05401621877, 13566.660833479242, 13602.659933501742, 13817.516386926409, 14003.22982235946, 9802.558884850056, 9845.753856153653, 9856.457894815854, 10208.2343824212, 10246.38521688701, 13227.272500012592, 13234.867651323364, 13246.47014119463, 13401.66495837612, 13771.104878182887], "value": 10198.69661522999, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.431138921653, 1371.1635902099717, 1397.8672026157517, 1398.811160493333, 1401.5164768154982, 11366.488508017139, 11819.940900295507, 11836.644900652984, 11842.171048026641, 11845.0, 11597.53609855607, 11930.761384772299, 12340.938295308533, 12352.320622365767, 12361.19652222605, 2473.3445636906235, 2525.507526032415, 2533.9113131040417, 2534.6831646044243, 2536.5053814506177, 2103.3269353806786, 2329.2895666821614, 2446.498467814094, 2452.0314475782056, 2452.546278938402, 2108.7785782492847, 2416.4804567018086, 2505.1232068775967, 2506.310764539748, 2508.5735424977706, 2364.7635236476217, 2372.95254094918, 2383.177803657744, 2385.2844146755992, 2389.259329607827, 2357.799587035087, 2367.857928524294, 2402.627592723131, 2410.2287268074224, 2415.251272105653, 11395.772084558344, 11583.6524904253, 11628.6511404658, 11629.185956983014, 11632.476538555786, 6502.7398904043785, 6717.731290748364, 6723.865522689519, 6734.56225345351, 6738.696758645872, 3911.706622003361, 4057.655099316532, 4100.712950093494, 4123.381492776078, 4191.790410479494, 1333.7532556477083, 1380.4478208716494, 1380.9171449713049, 1384.1072508232135, 1389.9374528146157, 18279.360222392286, 18439.354622588144, 18453.907730461262, 18460.907695461436, 18471.90764046171, 5380.811671591554, 5413.024246150127, 5459.672419654833, 5546.223528705985, 5630.239917611152, 12660.303683297323, 12718.236905785683, 12719.046071544672, 12722.109452338247, 12726.936365318114, 6556.18047744032, 6584.637844918576, 6604.966975165094, 6607.306232845578, 6615.37153970372, 5908.231929849092, 5996.190514280604, 6127.448529632355, 6185.690715464209, 6190.442860142609, 4234.724742891703, 4323.0705398339505, 4328.156009578102, 4342.500612429548, 4360.520342762294, 1106.9723256918642, 1130.8416821644976, 1264.8482182138018, 1278.4247088810073, 1301.1477482249143, 814.8899898513744, 823.5058964621179, 834.9039860416009, 847.4576271186446, 851.5699571716367, 6589.4069533742195, 6614.048855587614, 6697.593505363928, 6736.831579210461, 6895.689693963784, 946.2193690205607, 952.1858810716737, 956.6556039825657, 958.075457183821, 963.3641796414333, 4074.1444296698023, 4222.408862759216, 4261.914761704748, 4311.159323931866, 4410.095930334273, 15621.0, 16413.753793692864, 16422.343106275854, 16426.260818263207, 16440.095794731165, 14314.0, 14903.925480372529, 14950.327235274439, 16081.276342564614, 16324.510264692079, 9474.810503789886, 9638.277129215337, 9658.517074146404, 9718.562664680107, 9735.513224338754, 6669.399754022162, 7085.149782025984, 7090.574565526085, 7108.893366599608, 7123.430125589836, 13739.793903091662, 13751.381187846371, 13944.093633913762, 14153.929230353782, 14335.641608959442, 14211.573652790019, 14597.197154156624, 14610.926945365205, 14782.63043423923, 14789.482368117064, 9686.806263874823, 9927.156191723785, 9937.552810123418, 9942.652007179713, 10312.587496500057, 11487.655370338904, 11538.596149135075, 11555.537778488766, 11562.47968841421, 11574.88425115738, 8593.613287401957, 9559.713208603753, 9598.280128990215, 9864.852027219455, 9984.650537231162, 9076.0, 9382.155605995493, 9405.529723513933, 9596.376235544667, 9633.373830701263, 8247.711330103417, 8359.95820020896, 8361.790955226168, 8364.498130112213, 8366.539840308842, 6049.304330002106, 6062.151298818258, 6101.816945491642, 6163.784267550794, 6329.841753956188, 5911.349751527415, 5922.726613778058, 5929.85175370602, 5962.612430192024, 6215.316315205414], "value": 5505.727386947388, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.1513663737834, 419.0863916661678, 424.72605169665565, 430.6145999330601, 432.08182611949604, 5842.240508733864, 5869.0, 5893.440123188296, 5904.380040095782, 5918.585699001066, 5555.30558680165, 5712.771489140439, 5717.2281741964825, 5778.757567123068, 5793.0, 4383.013821890081, 4391.758453285068, 4394.296912494002, 4399.428074350346, 4403.097365040175, 4413.624841888443, 4420.668449866257, 4421.6904816662845, 4424.845130420436, 4429.822807087713, 4308.18144552534, 4334.60988511034, 4343.413639158721, 4351.825926962933, 4369.868903932887, 4339.370791235253, 4342.482589102821, 4346.913061738764, 4352.390665306828, 4364.738115713068, 3836.846526138951, 3839.9808000960097, 3842.5581058178386, 3849.3648547989546, 3864.574896761354, 5561.749721262553, 5618.410066942953, 5667.8583035424035, 5680.5514593778325, 5684.886302273972, 5131.563817075553, 5141.53726164647, 5141.843085305776, 5143.768530416103, 5151.819686310999, 5882.794102206402, 6034.883546543903, 6066.514678825727, 6079.635221886701, 6084.421979911901, 4229.471316085489, 4245.5375881988375, 4279.293916503804, 4289.185054839601, 4296.140771845643, 6089.847753806146, 6179.69101544921, 6195.938040619581, 6344.779327235477, 6439.83900402489, 4373.938243229752, 4380.62764665007, 4384.868453946387, 4390.517043125254, 4399.318105693623, 4437.667174961826, 4468.419105516262, 4472.619827314649, 4478.910421791546, 4483.3947417098925, 5012.223105418666, 5086.847394578169, 5118.616103792156, 5131.666441681354, 5139.89264401601, 6042.0, 6080.908786368208, 6098.786542470993, 6105.633661980295, 6108.114323423168, 1519.5517322389921, 1531.7778922056239, 1537.4318195440812, 1540.6456515001612, 1544.7296723073416, 1009.9501000986098, 1026.7279171019686, 1038.382162613244, 1040.70339953113, 1046.4924511611862, 5830.82507524775, 5837.6497410155525, 5839.073105875051, 5853.063509838491, 5853.619514731528, 6108.175396321529, 6247.718852651642, 6262.246570960138, 6264.561480696399, 6290.370962903765, 5790.478856902815, 5791.420857914175, 5819.447152520504, 5823.359430462646, 5848.795292164754, 3266.2852002698774, 3296.7032967033083, 3301.752368572367, 3303.587051618548, 3314.900552983366, 6317.5893566918, 6465.288818229991, 6476.935230647728, 6605.24039735427, 6613.966930165415, 6443.29123796382, 6446.871062578723, 6458.418742313214, 6462.319796852758, 6468.676566171766, 6288.591241569284, 6499.935000650027, 6568.376004279681, 6611.702473388709, 6618.6690665467495, 6244.406781355764, 6266.310705822447, 6271.843203919939, 6277.3408792078, 6288.1825362704385, 6015.699215039318, 6175.197224360804, 6218.875622487615, 6219.813405597839, 6241.160272076285, 6526.804195874131, 6549.410553050057, 6554.14796076507, 6556.672166391757, 6556.754596323018, 4386.727848923904, 4394.231009573376, 4409.581089796464, 4412.161689279027, 4420.336949457607, 6183.783567575113, 6309.864224439645, 6327.778527751507, 6333.556651034383, 6343.238811342484, 6040.305364883095, 6041.18444010053, 6078.179445774764, 6090.898639969204, 6103.8779224414375, 5825.300963884191, 6067.544934130046, 6094.124700239879, 6106.1146133811235, 6106.6336019838955, 6030.0, 6070.6357618543025, 6074.271087469532, 6076.210092687922, 6082.817515474543, 6038.184845045863, 6093.329733729198, 6117.0, 6129.172561704291, 6152.138700582012, 5895.911561326498, 5913.113033045078, 5920.957269741933, 5923.437273459014, 5929.970350148222], "value": 4638.147894661369, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.1511146409324, 867.845765132374, 872.2542226396431, 885.269652536657, 886.5655828643964, 17036.0, 17299.308027678908, 17720.113994300296, 17725.29098836045, 17730.64538709225, 16073.196340183002, 16250.024998500068, 16511.174441277948, 16520.75218871718, 16589.170541472908, 917.9908200917989, 942.9198518125968, 943.2548286853378, 943.79708362702, 944.7874228298647, 999.7650552120245, 1007.6523599358246, 1009.9394036357842, 1010.1615659003047, 1010.3836659637615, 1046.4506134279488, 1048.13528838708, 1050.322541960435, 1051.6424415698662, 1051.8579991701138, 1045.7385653586603, 1048.355261514171, 1049.7480604654866, 1050.438015661625, 1050.616524968381, 767.4014268870291, 769.0655853138463, 769.4806005945964, 769.6651956398929, 769.7729169894894, 14759.77860332096, 15251.542453726406, 15430.228488575527, 16104.83895161045, 16110.838891611169, 17211.397601083903, 17654.470365888916, 18782.812171878242, 19136.138873750715, 19309.131089101025, 14695.70608587833, 15066.849331506653, 15083.396664133421, 15191.848081519154, 15230.238488075553, 3507.0706262840367, 3523.0839981604713, 3526.4357702767434, 3533.628968958248, 3540.5928318243473, 99203.0398480073, 104383.0, 104566.47716761443, 104663.47668261686, 106207.0, 14624.780628290584, 14853.0, 14873.405063797543, 15004.399824006918, 15054.096754194565, 27317.590236146472, 27749.751261193294, 27752.722472775014, 27968.160955171377, 28064.71935280662, 8105.797355066053, 8279.0, 8320.292775114183, 8321.708740194064, 8341.541215233221, 3861.2663593917064, 3912.7065470089856, 3968.1270120573427, 3983.183447393277, 4003.2994226010915, 4626.884327891829, 4705.364775755298, 4706.294055891643, 4707.976460117678, 4712.410948631421, 846.8983721953405, 872.0930232558069, 872.4895935877582, 876.5003947749849, 916.4089162490156, 665.4044630056072, 691.8858388365863, 699.2832346844424, 702.3082263969985, 728.6393235348536, 11645.6506304811, 12200.633980980585, 12431.564895228805, 12797.360131993362, 12920.41858116387, 711.6904146696204, 721.1490441279341, 727.105660038156, 729.4201110117469, 750.3097150621442, 5442.319710036246, 5757.625754325955, 5798.304203495523, 5814.476697097281, 5888.057910734262, 85432.57283713666, 85669.57165214134, 85684.0, 86949.0, 87826.56086719525, 53264.0, 73325.6333718328, 74505.62747186229, 74737.0, 76995.23004769992, 41856.19451645819, 61705.691471542355, 61950.0, 62082.0, 65547.67226163934, 12347.38263086824, 13129.212247265195, 13210.471581136648, 13235.757239476005, 13240.602781916557, 32655.510167347984, 34383.4842477358, 35060.47409288914, 35188.296234075686, 35832.104197395274, 52758.472415275355, 54071.0, 56387.0, 57074.14388784255, 57215.0, 16973.23620437108, 17419.39032133869, 17439.389621363192, 17545.649087018443, 17690.0, 18345.54136146607, 18844.811551884304, 18894.622107558047, 19059.42821715351, 19156.61686766229, 16547.420840270534, 16559.00645961246, 16722.414715485385, 16842.242099105813, 16920.66158676844, 17046.403375881786, 17478.62546442048, 17640.0, 17756.0, 18019.459416217534, 16913.577160571083, 16928.32286708567, 17134.0, 17211.0, 17289.65420691554, 11937.641870743892, 12315.815262770886, 13197.142185757895, 13224.206547607175, 13549.796753048515, 14082.647933801327, 14420.567382978528, 14466.782998255245, 14693.19187444658, 14845.554633361016], "value": 8384.43165019284, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1479.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 109.0, 110.0, 109.0, 109.0, 111.0, 110.0, 109.0, 110.0, 112.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 117.0, 118.0, 179.0, 118.0, 118.0, 116.0, 115.0, 136.0, 118.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 164.0, 162.0, 162.0, 159.0, 162.0, 159.0, 163.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 113.0, 76.0, 74.0, 76.0, 76.0, 95.0, 76.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 107.0, 82.0, 82.0, 81.0, 94.0, 82.0, 82.0, 104.0], "value": 87.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 112.0, 112.0, 113.0, 113.0, 112.0, 112.0], "value": 112.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 94.0, 93.0, 93.0], "value": 93.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 46.0, 47.0, 47.0, 47.0, 49.0, 47.0, 47.0, 46.0, 45.0], "value": 46.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 54.0, 53.0, 53.0, 53.0, 54.0, 55.0, 55.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 78.0, 79.0, 80.0, 80.0, 80.0, 78.0, 78.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 123.0, 124.0, 122.0, 123.0, 122.0, 125.0, 123.0, 169.0, 131.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 180.0, 182.0, 185.0, 181.0, 182.0, 181.0, 186.0, 187.0, 182.0], "value": 183.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 67.0, 67.0, 67.0, 66.0, 65.0, 64.0, 64.0, 64.0], "value": 65.7, "unit": "score"}]}]} 04:12:52 INFO - Return code: 0 04:12:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:12:52 INFO - # TBPL SUCCESS # 04:12:52 INFO - Running post-action listener: _resource_record_post_action 04:12:52 INFO - [mozharness: 2017-05-12 11:12:52.440571Z] Finished run-tests step (success) 04:12:52 INFO - Running post-run listener: _resource_record_post_run 04:12:52 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 90112; Write bytes: 381652992; Read time: 440; Write time: 278280 04:12:52 INFO - TinderboxPrint: CPU usage
12.9% 04:12:52 INFO - TinderboxPrint: I/O read bytes / time
90,112 / 440 04:12:52 INFO - TinderboxPrint: I/O write bytes / time
381,652,992 / 278,280 04:12:52 INFO - TinderboxPrint: CPU idle
8,287.8 (87.1%) 04:12:52 INFO - TinderboxPrint: CPU user
1,182.6 (12.4%) 04:12:52 INFO - TinderboxPrint: Swap in / out
0 / 0 04:12:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 73728; Write bytes: 112267264; Read time: 232; Write time: 128968 04:12:52 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 12288; Write bytes: 269385728; Read time: 204; Write time: 149312 04:12:53 INFO - Running post-run listener: _upload_blobber_files 04:12:53 INFO - Blob upload gear active. 04:12:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:12:53 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 04:12:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:12:53 INFO - (blobuploader) - INFO - Open directory for files ... 04:12:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:12:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:12:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:56 INFO - (blobuploader) - INFO - Done attempting. 04:12:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:12:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:12:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:57 INFO - (blobuploader) - INFO - Done attempting. 04:12:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:12:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:12:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:58 INFO - (blobuploader) - INFO - Done attempting. 04:12:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:12:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:12:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:58 INFO - (blobuploader) - INFO - Done attempting. 04:12:58 INFO - (blobuploader) - INFO - Iteration through files over. 04:12:59 INFO - Return code: 0 04:12:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:12:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:12:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24eaecab8dbc7a90bfa4c26cf930986da3d0839f26a754f2ea17839eeec728817c1ed76c122190bc243abe73e8cd81f5297d33238bc323c2fc1bd07279f645a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/add19c979e88a0156a3296f5dcb93da6c7e400d1427f70607c443dfe92c2d1284f2bd62defdf7d168931887dd1bf5591eab31f8887c24b62da59c101481ea646", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f1aa4fe4c26b21b7d428637763eccd37533a34cdebf83488a67626decf2964f67ea4d930acf1176c63d58d41d61ba18f0b48e1f06ae76f4cf15542cc71fcc83", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce00dc93f0fb3944602cda0f282d5674ef086662397657bdecbd7f8e00ad4b24c5beeb5cd9256ea3828b4ff1c4f395157b5f24e70d7cdf36daaaf6e9e34cac27"} 04:12:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:12:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:12:59 INFO - Contents: 04:12:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24eaecab8dbc7a90bfa4c26cf930986da3d0839f26a754f2ea17839eeec728817c1ed76c122190bc243abe73e8cd81f5297d33238bc323c2fc1bd07279f645a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/add19c979e88a0156a3296f5dcb93da6c7e400d1427f70607c443dfe92c2d1284f2bd62defdf7d168931887dd1bf5591eab31f8887c24b62da59c101481ea646", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f1aa4fe4c26b21b7d428637763eccd37533a34cdebf83488a67626decf2964f67ea4d930acf1176c63d58d41d61ba18f0b48e1f06ae76f4cf15542cc71fcc83", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce00dc93f0fb3944602cda0f282d5674ef086662397657bdecbd7f8e00ad4b24c5beeb5cd9256ea3828b4ff1c4f395157b5f24e70d7cdf36daaaf6e9e34cac27"} 04:12:59 INFO - Running post-run listener: copy_logs_to_upload_dir 04:12:59 INFO - Copying logs to upload dir... 04:12:59 INFO - mkdir: /builds/slave/test/build/upload/logs 04:12:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.681152 ========= master_lag: 0.75 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-12 04:12:59.823680) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 04:12:59.830823) ========= 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=3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24eaecab8dbc7a90bfa4c26cf930986da3d0839f26a754f2ea17839eeec728817c1ed76c122190bc243abe73e8cd81f5297d33238bc323c2fc1bd07279f645a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/add19c979e88a0156a3296f5dcb93da6c7e400d1427f70607c443dfe92c2d1284f2bd62defdf7d168931887dd1bf5591eab31f8887c24b62da59c101481ea646", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f1aa4fe4c26b21b7d428637763eccd37533a34cdebf83488a67626decf2964f67ea4d930acf1176c63d58d41d61ba18f0b48e1f06ae76f4cf15542cc71fcc83", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce00dc93f0fb3944602cda0f282d5674ef086662397657bdecbd7f8e00ad4b24c5beeb5cd9256ea3828b4ff1c4f395157b5f24e70d7cdf36daaaf6e9e34cac27"} build_url:https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011099 build_url: 'https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/24eaecab8dbc7a90bfa4c26cf930986da3d0839f26a754f2ea17839eeec728817c1ed76c122190bc243abe73e8cd81f5297d33238bc323c2fc1bd07279f645a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/add19c979e88a0156a3296f5dcb93da6c7e400d1427f70607c443dfe92c2d1284f2bd62defdf7d168931887dd1bf5591eab31f8887c24b62da59c101481ea646", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8f1aa4fe4c26b21b7d428637763eccd37533a34cdebf83488a67626decf2964f67ea4d930acf1176c63d58d41d61ba18f0b48e1f06ae76f4cf15542cc71fcc83", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ce00dc93f0fb3944602cda0f282d5674ef086662397657bdecbd7f8e00ad4b24c5beeb5cd9256ea3828b4ff1c4f395157b5f24e70d7cdf36daaaf6e9e34cac27"}' ========= master_lag: 0.07 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 04:12:59.908296) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 04:12:59.911773) ========= 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=3836458cccd887f2d2de3cf1000001de-1494585487.964664-758595564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.12 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 04:13:00.032080) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 04:13:00.032399) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 04:13:00.037320) ========= ========= Total master_lag: 0.99 =========