builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-089 starttime: 1495084041.95 results: success (0) revision: baf05f61bc14fdf45511bc1165ce76daa08c5c0f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-17 22:07:21.952669) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-17 22:07:21.953161) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-17 22:07:21.953467) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-17 22:07:21.990413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 22:07:21.990685) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-17 22:07:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-05-17 22:07:23 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128551 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 22:07:22.132520) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 22:07:22.132844) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015472 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 22:07:22.183611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-17 22:07:22.183970) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev baf05f61bc14fdf45511bc1165ce76daa08c5c0f --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 baf05f61bc14fdf45511bc1165ce76daa08c5c0f --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=8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-17 22:07:23,263 truncating revision to first 12 chars 2017-05-17 22:07:23,263 Setting DEBUG logging. 2017-05-17 22:07:23,263 attempt 1/10 2017-05-17 22:07:23,263 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/baf05f61bc14?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-17 22:07:24,062 unpacking tar archive at: mozilla-central-baf05f61bc14/testing/mozharness/ program finished with exit code 0 elapsedTime=1.135477 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-17 22:07:23.331960) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-17 22:07:23.332289) ========= script_repo_revision: baf05f61bc14fdf45511bc1165ce76daa08c5c0f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-17 22:07:23.332735) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-17 22:07:23.333014) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-17 22:07:23.342998) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-17 22:07:23.343441) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:07:24 INFO - MultiFileLogger online at 20170517 22:07:24 in /builds/slave/test 22:07:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 22:07:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:07:24 INFO - {'append_to_log': False, 22:07:24 INFO - 'base_work_dir': '/builds/slave/test', 22:07:24 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 22:07:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:07:24 INFO - 'branch': 'Firefox-Non-PGO', 22:07:24 INFO - 'buildbot_json_path': 'buildprops.json', 22:07:24 INFO - 'config_files': ('talos/linux_config.py',), 22:07:24 INFO - 'default_actions': ('clobber', 22:07:24 INFO - 'read-buildbot-config', 22:07:24 INFO - 'download-and-extract', 22:07:24 INFO - 'populate-webroot', 22:07:24 INFO - 'create-virtualenv', 22:07:24 INFO - 'install', 22:07:24 INFO - 'run-tests'), 22:07:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:07:24 INFO - 'download_minidump_stackwalk': True, 22:07:24 INFO - 'download_symbols': 'ondemand', 22:07:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:07:24 INFO - 'tooltool.py': '/tools/tooltool.py', 22:07:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:07:24 INFO - '/tools/misc-python/virtualenv.py')}, 22:07:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:07:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:07:24 INFO - 'gecko_profile': False, 22:07:24 INFO - 'gecko_profile_interval': 0, 22:07:24 INFO - 'installer_path': 'installer.exe', 22:07:24 INFO - 'log_level': 'info', 22:07:24 INFO - 'log_name': 'talos', 22:07:24 INFO - 'log_to_console': True, 22:07:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:07:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:07:24 INFO - 'opt_config_files': (), 22:07:24 INFO - 'pip_index': False, 22:07:24 INFO - 'suite': 'dromaeojs-e10s', 22:07:24 INFO - 'system_bits': '32', 22:07:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:07:24 INFO - 'title': 'talos-linux64-ix-089', 22:07:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:07:24 INFO - 'use_talos_json': True, 22:07:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:07:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:07:24 INFO - 'work_dir': 'build'} 22:07:24 INFO - [mozharness: 2017-05-18 05:07:24.518297Z] Running clobber step. 22:07:24 INFO - Running pre-action listener: _resource_record_pre_action 22:07:24 INFO - Running main action method: clobber 22:07:24 INFO - rmtree: /builds/slave/test/build 22:07:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:07:25 INFO - Running post-action listener: _resource_record_post_action 22:07:25 INFO - [mozharness: 2017-05-18 05:07:25.513811Z] Finished clobber step (success) 22:07:25 INFO - [mozharness: 2017-05-18 05:07:25.513911Z] Running read-buildbot-config step. 22:07:25 INFO - Running pre-action listener: _resource_record_pre_action 22:07:25 INFO - Running main action method: read_buildbot_config 22:07:25 INFO - Using buildbot properties: 22:07:25 INFO - { 22:07:25 INFO - "project": "", 22:07:25 INFO - "product": "firefox", 22:07:25 INFO - "who": "ihsiao@mozilla.com", 22:07:25 INFO - "installer_path": "public/build/target.tar.bz2", 22:07:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:07:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 22:07:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 22:07:25 INFO - "stage_platform": "linux64", 22:07:25 INFO - "basedir": "/builds/slave/test", 22:07:25 INFO - "buildnumber": 882, 22:07:25 INFO - "platform": "ubuntu64_hw", 22:07:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:07:25 INFO - "slavebuilddir": "test", 22:07:25 INFO - "taskId": "IC2eHiUgT9K9GfWyBgWJ4Q", 22:07:25 INFO - "branch": "mozilla-central", 22:07:25 INFO - "script_repo_revision": "production", 22:07:25 INFO - "revision": "baf05f61bc14fdf45511bc1165ce76daa08c5c0f", 22:07:25 INFO - "slavename": "talos-linux64-ix-089", 22:07:25 INFO - "repo_path": "mozilla-central" 22:07:25 INFO - } 22:07:25 INFO - Finding installer, test and symbols from parent task. 22:07:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IC2eHiUgT9K9GfWyBgWJ4Q'}, attempt #1 22:07:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IC2eHiUgT9K9GfWyBgWJ4Q'}, attempt #1 22:07:26 INFO - Task dependencies: cXaURRPmTlKd_UcwqZ_aYA 22:07:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA'}, attempt #1 22:07:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.tar.bz2 22:07:26 INFO - Set test_url: https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/test_packages.json 22:07:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.crashreporter-symbols.zip 22:07:26 INFO - Running post-action listener: _resource_record_post_action 22:07:26 INFO - [mozharness: 2017-05-18 05:07:26.874186Z] Finished read-buildbot-config step (success) 22:07:26 INFO - [mozharness: 2017-05-18 05:07:26.874408Z] Running download-and-extract step. 22:07:26 INFO - Running pre-action listener: _resource_record_pre_action 22:07:26 INFO - Running main action method: download_and_extract 22:07:26 INFO - mkdir: /builds/slave/test/build/tests 22:07:26 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')]} 22:07:26 INFO - trying https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.test_packages.json 22:07:26 INFO - Downloading https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 22:07:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 22:07:27 INFO - Downloaded 986 bytes. 22:07:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 22:07:27 INFO - Using the following test package requirements: 22:07:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 22:07:27 INFO - u'common': [u'target.common.tests.zip'], 22:07:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 22:07:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 22:07:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 22:07:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 22:07:27 INFO - u'mozbase': [u'target.common.tests.zip'], 22:07:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 22:07:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 22:07:27 INFO - u'web-platform': [u'target.common.tests.zip', 22:07:27 INFO - u'target.web-platform.tests.zip'], 22:07:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 22:07:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 22:07:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.common.tests.zip 22:07:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:07:27 INFO - Fetch https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.common.tests.zip into memory 22:07:29 INFO - Content-Length response header: 62453613 22:07:29 INFO - Bytes received: 62453613 22:07:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 22:07:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.common.tests.zip 22:07:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:07:40 INFO - Fetch https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.common.tests.zip into memory 22:07:41 INFO - Content-Length response header: 62453613 22:07:41 INFO - Bytes received: 62453613 22:07:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.talos.tests.zip 22:07:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 22:07:53 INFO - Fetch https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.talos.tests.zip into memory 22:07:54 INFO - Content-Length response header: 14410001 22:07:54 INFO - Bytes received: 14410001 22:07:54 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')]} 22:07:54 INFO - trying https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.tar.bz2 22:07:54 INFO - Downloading https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 22:07:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 22:07:57 INFO - Downloaded 58213508 bytes. 22:07:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.tar.bz2 22:07:57 INFO - mkdir: /builds/slave/test/properties 22:07:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:07:57 INFO - Writing to file /builds/slave/test/properties/build_url 22:07:57 INFO - Contents: 22:07:57 INFO - build_url:https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.tar.bz2 22:07:57 INFO - Running post-action listener: _resource_record_post_action 22:07:57 INFO - Running post-action listener: set_extra_try_arguments 22:07:57 INFO - [mozharness: 2017-05-18 05:07:57.256118Z] Finished download-and-extract step (success) 22:07:57 INFO - [mozharness: 2017-05-18 05:07:57.256349Z] Running populate-webroot step. 22:07:57 INFO - Running pre-action listener: _resource_record_pre_action 22:07:57 INFO - Running main action method: populate_webroot 22:07:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:07:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:07:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:07:57 INFO - '--tppagecycles', 22:07:57 INFO - '7'], 22:07:57 INFO - 'tests': ['tsvgm']}}, 22:07:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:07:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:07:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:07:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:07:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:07:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:07:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:07:57 INFO - 'talos_options': ['--disable-e10s'], 22:07:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:07:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:07:57 INFO - 'talos_options': ['--disable-e10s'], 22:07:57 INFO - 'tests': ['damp', 'tps']}, 22:07:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:07:57 INFO - 'tests': ['damp', 'tps']}, 22:07:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:07:57 INFO - 'tests': ['dromaeo_dom']}, 22:07:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:07:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:07:57 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 22:07:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 22:07:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 22:07:57 INFO - 'tests': ['ts_paint', 'tp5o']}, 22:07:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:07:57 INFO - 'tests': ['a11yr', 22:07:57 INFO - 'ts_paint', 22:07:57 INFO - 'tpaint', 22:07:57 INFO - 'sessionrestore', 22:07:57 INFO - 'sessionrestore_no_auto_restore', 22:07:57 INFO - 'tabpaint']}, 22:07:57 INFO - 'other-e10s': {'tests': ['a11yr', 22:07:57 INFO - 'ts_paint', 22:07:57 INFO - 'tpaint', 22:07:57 INFO - 'sessionrestore', 22:07:57 INFO - 'sessionrestore_no_auto_restore', 22:07:57 INFO - 'tabpaint']}, 22:07:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:07:57 INFO - 'ts_paint', 22:07:57 INFO - 'tpaint', 22:07:57 INFO - 'sessionrestore', 22:07:57 INFO - 'sessionrestore_no_auto_restore', 22:07:57 INFO - 'tabpaint']}, 22:07:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:07:57 INFO - 'ts_paint', 22:07:57 INFO - 'tpaint', 22:07:57 INFO - 'sessionrestore', 22:07:57 INFO - 'sessionrestore_no_auto_restore', 22:07:57 INFO - 'tabpaint']}, 22:07:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:07:57 INFO - 'tests': ['a11yr', 22:07:57 INFO - 'ts_paint', 22:07:57 INFO - 'tpaint', 22:07:57 INFO - 'sessionrestore', 22:07:57 INFO - 'sessionrestore_no_auto_restore', 22:07:57 INFO - 'tabpaint']}, 22:07:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:07:57 INFO - 'tests': ['a11yr', 22:07:57 INFO - 'ts_paint', 22:07:57 INFO - 'tpaint', 22:07:57 INFO - 'sessionrestore', 22:07:57 INFO - 'sessionrestore_no_auto_restore', 22:07:57 INFO - 'tabpaint']}, 22:07:57 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 22:07:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 22:07:57 INFO - 'bloom_basic_ref']}, 22:07:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:07:57 INFO - 'tests': ['tsvgx', 22:07:57 INFO - 'tsvgr_opacity', 22:07:57 INFO - 'tart', 22:07:57 INFO - 'tscrollx', 22:07:57 INFO - 'cart', 22:07:57 INFO - 'tsvg_static']}, 22:07:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:07:57 INFO - 'tsvgr_opacity', 22:07:57 INFO - 'tart', 22:07:57 INFO - 'tscrollx', 22:07:57 INFO - 'cart', 22:07:57 INFO - 'tsvg_static']}, 22:07:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:07:57 INFO - 'talos_options': ['--disable-e10s'], 22:07:57 INFO - 'tests': ['tp5o']}, 22:07:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:07:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:07:57 INFO - 'talos_options': ['--disable-e10s', 22:07:57 INFO - '--xperf_path', 22:07:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:57 INFO - 'tests': ['tp5n']}, 22:07:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:07:57 INFO - 'talos_options': ['--xperf_path', 22:07:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:57 INFO - 'tests': ['tp5n']}}, 22:07:57 INFO - 'talos.zip': {'path': '', 22:07:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:07:57 INFO - Running post-action listener: _resource_record_post_action 22:07:57 INFO - [mozharness: 2017-05-18 05:07:57.273588Z] Finished populate-webroot step (success) 22:07:57 INFO - [mozharness: 2017-05-18 05:07:57.273679Z] Running create-virtualenv step. 22:07:57 INFO - Running pre-action listener: _resource_record_pre_action 22:07:57 INFO - Running main action method: create_virtualenv 22:07:57 INFO - Creating virtualenv /builds/slave/test/build/venv 22:07:57 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 22:07:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:07:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:07:57 INFO - Using real prefix '/usr' 22:07:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:07:57 INFO - Installing distribute.............................................................................................................................................................................................done. 22:07:59 INFO - Installing pip.................done. 22:07:59 INFO - Return code: 0 22:07:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:07:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:08:00 INFO - Reading from file tmpfile_stdout 22:08:00 INFO - Output received: 22:08:00 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) 22:08:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:00 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 0x295f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd25c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf7a0>, '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 0x2cd06a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', '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 22:08:00 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 22:08:00 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 22:08:00 INFO - Using env: {'DISPLAY': ':0', 22:08:00 INFO - 'HOME': '/home/cltbld', 22:08:00 INFO - 'LANG': 'en_US.UTF-8', 22:08:00 INFO - 'LANGUAGE': 'en_US:en', 22:08:00 INFO - 'LOGNAME': 'cltbld', 22:08:00 INFO - 'MAIL': '/var/mail/cltbld', 22:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:00 INFO - 'MOZ_NO_REMOTE': '1', 22:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:00 INFO - 'NO_EM_RESTART': '1', 22:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:00 INFO - 'PWD': '/builds/slave/test', 22:08:00 INFO - 'SHELL': '/bin/bash', 22:08:00 INFO - 'SHLVL': '1', 22:08:00 INFO - 'TERM': 'linux', 22:08:00 INFO - 'TMOUT': '86400', 22:08:00 INFO - 'USER': 'cltbld', 22:08:00 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', 22:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:00 INFO - '_': '/tools/buildbot/bin/python'} 22:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:00 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 22:08:00 INFO - Cleaning up... 22:08:00 INFO - Return code: 0 22:08:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:00 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 0x295f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd25c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf7a0>, '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 0x2cd06a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', '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 22:08:00 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 22:08:00 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 22:08:00 INFO - Using env: {'DISPLAY': ':0', 22:08:00 INFO - 'HOME': '/home/cltbld', 22:08:00 INFO - 'LANG': 'en_US.UTF-8', 22:08:00 INFO - 'LANGUAGE': 'en_US:en', 22:08:00 INFO - 'LOGNAME': 'cltbld', 22:08:00 INFO - 'MAIL': '/var/mail/cltbld', 22:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:00 INFO - 'MOZ_NO_REMOTE': '1', 22:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:00 INFO - 'NO_EM_RESTART': '1', 22:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:00 INFO - 'PWD': '/builds/slave/test', 22:08:00 INFO - 'SHELL': '/bin/bash', 22:08:00 INFO - 'SHLVL': '1', 22:08:00 INFO - 'TERM': 'linux', 22:08:00 INFO - 'TMOUT': '86400', 22:08:00 INFO - 'USER': 'cltbld', 22:08:00 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', 22:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:00 INFO - '_': '/tools/buildbot/bin/python'} 22:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:00 INFO - Downloading/unpacking psutil>=3.1.1 22:08:00 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 22:08:00 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 22:08:00 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 22:08:00 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 22:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:08:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:08:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:08:01 INFO - Installing collected packages: psutil 22:08:01 INFO - Running setup.py install for psutil 22:08:01 INFO - building 'psutil._psutil_linux' extension 22:08:01 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 22:08:01 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 22:08:01 INFO - building 'psutil._psutil_posix' extension 22:08:01 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 22:08:02 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 22:08:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:08:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:08:02 INFO - Successfully installed psutil 22:08:02 INFO - Cleaning up... 22:08:02 INFO - Return code: 0 22:08:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:08:02 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')]} 22:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:02 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')]} 22:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:02 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 0x295f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd25c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf7a0>, '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 0x2cd06a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', '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 22:08:02 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 22:08:02 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 22:08:02 INFO - Using env: {'DISPLAY': ':0', 22:08:02 INFO - 'HOME': '/home/cltbld', 22:08:02 INFO - 'LANG': 'en_US.UTF-8', 22:08:02 INFO - 'LANGUAGE': 'en_US:en', 22:08:02 INFO - 'LOGNAME': 'cltbld', 22:08:02 INFO - 'MAIL': '/var/mail/cltbld', 22:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:02 INFO - 'MOZ_NO_REMOTE': '1', 22:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:02 INFO - 'NO_EM_RESTART': '1', 22:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:02 INFO - 'PWD': '/builds/slave/test', 22:08:02 INFO - 'SHELL': '/bin/bash', 22:08:02 INFO - 'SHLVL': '1', 22:08:02 INFO - 'TERM': 'linux', 22:08:02 INFO - 'TMOUT': '86400', 22:08:02 INFO - 'USER': 'cltbld', 22:08:02 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', 22:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:02 INFO - '_': '/tools/buildbot/bin/python'} 22:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:08:02 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 22:08:02 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 22:08:02 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 22:08:02 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 22:08:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:08:03 INFO - Installing collected packages: mozsystemmonitor 22:08:03 INFO - Running setup.py install for mozsystemmonitor 22:08:03 INFO - Successfully installed mozsystemmonitor 22:08:03 INFO - Cleaning up... 22:08:03 INFO - Return code: 0 22:08:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:08:03 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')]} 22:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:03 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')]} 22:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:03 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 0x295f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd25c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf7a0>, '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 0x2cd06a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', '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 22:08:03 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 22:08:03 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 22:08:03 INFO - Using env: {'DISPLAY': ':0', 22:08:03 INFO - 'HOME': '/home/cltbld', 22:08:03 INFO - 'LANG': 'en_US.UTF-8', 22:08:03 INFO - 'LANGUAGE': 'en_US:en', 22:08:03 INFO - 'LOGNAME': 'cltbld', 22:08:03 INFO - 'MAIL': '/var/mail/cltbld', 22:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:03 INFO - 'MOZ_NO_REMOTE': '1', 22:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:03 INFO - 'NO_EM_RESTART': '1', 22:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:03 INFO - 'PWD': '/builds/slave/test', 22:08:03 INFO - 'SHELL': '/bin/bash', 22:08:03 INFO - 'SHLVL': '1', 22:08:03 INFO - 'TERM': 'linux', 22:08:03 INFO - 'TMOUT': '86400', 22:08:03 INFO - 'USER': 'cltbld', 22:08:03 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', 22:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:03 INFO - '_': '/tools/buildbot/bin/python'} 22:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:03 INFO - Downloading/unpacking jsonschema==2.5.1 22:08:03 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 22:08:03 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 22:08:03 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 22:08:03 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 22:08:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:08:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:08:04 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 22:08:04 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 22:08:04 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 22:08:04 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 22:08:05 INFO - Downloading functools32-3.2.3-2.tar.gz 22:08:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:08:05 INFO - warning: no files found matching '*.txt' 22:08:05 INFO - no previously-included directories found matching 'build' 22:08:05 INFO - no previously-included directories found matching 'dist' 22:08:05 INFO - no previously-included directories found matching '.git*' 22:08:05 INFO - Installing collected packages: jsonschema, functools32 22:08:05 INFO - Running setup.py install for functools32 22:08:05 INFO - warning: no files found matching '*.txt' 22:08:05 INFO - no previously-included directories found matching 'build' 22:08:05 INFO - no previously-included directories found matching 'dist' 22:08:05 INFO - no previously-included directories found matching '.git*' 22:08:05 INFO - Successfully installed jsonschema functools32 22:08:05 INFO - Cleaning up... 22:08:05 INFO - Return code: 0 22:08:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:05 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 0x295f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd25c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf7a0>, '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 0x2cd06a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', '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 22:08:05 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 22:08:05 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 22:08:05 INFO - Using env: {'DISPLAY': ':0', 22:08:05 INFO - 'HOME': '/home/cltbld', 22:08:05 INFO - 'LANG': 'en_US.UTF-8', 22:08:05 INFO - 'LANGUAGE': 'en_US:en', 22:08:05 INFO - 'LOGNAME': 'cltbld', 22:08:05 INFO - 'MAIL': '/var/mail/cltbld', 22:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:05 INFO - 'MOZ_NO_REMOTE': '1', 22:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:05 INFO - 'NO_EM_RESTART': '1', 22:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:05 INFO - 'PWD': '/builds/slave/test', 22:08:05 INFO - 'SHELL': '/bin/bash', 22:08:05 INFO - 'SHLVL': '1', 22:08:05 INFO - 'TERM': 'linux', 22:08:05 INFO - 'TMOUT': '86400', 22:08:05 INFO - 'USER': 'cltbld', 22:08:05 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', 22:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:05 INFO - '_': '/tools/buildbot/bin/python'} 22:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:08:05 INFO - Cleaning up... 22:08:05 INFO - Return code: 0 22:08:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:05 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 0x295f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd25c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf7a0>, '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 0x2cd06a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', '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 22:08:05 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 22:08:05 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 22:08:05 INFO - Using env: {'DISPLAY': ':0', 22:08:05 INFO - 'HOME': '/home/cltbld', 22:08:05 INFO - 'LANG': 'en_US.UTF-8', 22:08:05 INFO - 'LANGUAGE': 'en_US:en', 22:08:05 INFO - 'LOGNAME': 'cltbld', 22:08:05 INFO - 'MAIL': '/var/mail/cltbld', 22:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:05 INFO - 'MOZ_NO_REMOTE': '1', 22:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:05 INFO - 'NO_EM_RESTART': '1', 22:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:05 INFO - 'PWD': '/builds/slave/test', 22:08:05 INFO - 'SHELL': '/bin/bash', 22:08:05 INFO - 'SHLVL': '1', 22:08:05 INFO - 'TERM': 'linux', 22:08:05 INFO - 'TMOUT': '86400', 22:08:05 INFO - 'USER': 'cltbld', 22:08:05 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', 22:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:05 INFO - '_': '/tools/buildbot/bin/python'} 22:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:05 INFO - Downloading/unpacking blobuploader==1.2.4 22:08:05 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 22:08:05 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 22:08:05 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 22:08:05 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 22:08:06 INFO - Downloading blobuploader-1.2.4.tar.gz 22:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:08:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:08:06 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 22:08:06 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 22:08:06 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 22:08:06 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 22:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:08:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:08:07 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 22:08:07 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 22:08:07 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 22:08:07 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 22:08:07 INFO - Downloading docopt-0.6.1.tar.gz 22:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:08:07 INFO - Installing collected packages: blobuploader, requests, docopt 22:08:07 INFO - Running setup.py install for blobuploader 22:08:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:08:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:08:07 INFO - Running setup.py install for requests 22:08:07 INFO - Running setup.py install for docopt 22:08:08 INFO - Successfully installed blobuploader requests docopt 22:08:08 INFO - Cleaning up... 22:08:08 INFO - Return code: 0 22:08:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:08 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 0x295f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd25c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf7a0>, '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 0x2cd06a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', '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 22:08:08 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 22:08:08 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 22:08:08 INFO - Using env: {'DISPLAY': ':0', 22:08:08 INFO - 'HOME': '/home/cltbld', 22:08:08 INFO - 'LANG': 'en_US.UTF-8', 22:08:08 INFO - 'LANGUAGE': 'en_US:en', 22:08:08 INFO - 'LOGNAME': 'cltbld', 22:08:08 INFO - 'MAIL': '/var/mail/cltbld', 22:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:08 INFO - 'MOZ_NO_REMOTE': '1', 22:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:08 INFO - 'NO_EM_RESTART': '1', 22:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:08 INFO - 'PWD': '/builds/slave/test', 22:08:08 INFO - 'SHELL': '/bin/bash', 22:08:08 INFO - 'SHLVL': '1', 22:08:08 INFO - 'TERM': 'linux', 22:08:08 INFO - 'TMOUT': '86400', 22:08:08 INFO - 'USER': 'cltbld', 22:08:08 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', 22:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:08 INFO - '_': '/tools/buildbot/bin/python'} 22:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:08:08 INFO - Running setup.py (path:/tmp/pip-eaIo5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:08:08 INFO - Running setup.py (path:/tmp/pip-A8SDNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:08:08 INFO - Running setup.py (path:/tmp/pip-hTjgNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:08:08 INFO - Running setup.py (path:/tmp/pip-W4x8uS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:08:08 INFO - Running setup.py (path:/tmp/pip-aLXl1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:08:08 INFO - Running setup.py (path:/tmp/pip-YiP2Tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:08:08 INFO - Running setup.py (path:/tmp/pip-BjO4Kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:08:08 INFO - Running setup.py (path:/tmp/pip-XRF6oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:08:08 INFO - Running setup.py (path:/tmp/pip-LyN810-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:08:08 INFO - Running setup.py (path:/tmp/pip-RBAZuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:08:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:08:08 INFO - Running setup.py (path:/tmp/pip-eXFeXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:08:09 INFO - Running setup.py (path:/tmp/pip-Us5nMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:08:09 INFO - Running setup.py (path:/tmp/pip-gNV9IR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:08:09 INFO - Running setup.py (path:/tmp/pip-3oLouf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:09 INFO - Running setup.py (path:/tmp/pip-KjBAyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:08:09 INFO - Running setup.py (path:/tmp/pip-uvl8GQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:08:09 INFO - Running setup.py (path:/tmp/pip-x8bB_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:08:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:08:09 INFO - Running setup.py install for manifestparser 22:08:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:08:09 INFO - Running setup.py install for mozcrash 22:08:09 INFO - Running setup.py install for mozdebug 22:08:09 INFO - Running setup.py install for mozdevice 22:08:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:08:09 INFO - Running setup.py install for mozfile 22:08:10 INFO - Running setup.py install for mozhttpd 22:08:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:08:10 INFO - Running setup.py install for mozinfo 22:08:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:08:10 INFO - Running setup.py install for mozInstall 22:08:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:08:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:08:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:08:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:08:10 INFO - Running setup.py install for mozleak 22:08:10 INFO - Running setup.py install for mozlog 22:08:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:08:10 INFO - Running setup.py install for moznetwork 22:08:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:08:10 INFO - Running setup.py install for mozprocess 22:08:10 INFO - Running setup.py install for mozprofile 22:08:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:08:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:08:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:08:10 INFO - Running setup.py install for mozrunner 22:08:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:08:10 INFO - Running setup.py install for mozscreenshot 22:08:11 INFO - Running setup.py install for moztest 22:08:11 INFO - Running setup.py install for mozversion 22:08:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:08:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:08:11 INFO - Cleaning up... 22:08:11 INFO - Return code: 0 22:08:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:11 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 0x295f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd25c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf7a0>, '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 0x2cd06a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', '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 22:08:11 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 22:08:11 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 22:08:11 INFO - Using env: {'DISPLAY': ':0', 22:08:11 INFO - 'HOME': '/home/cltbld', 22:08:11 INFO - 'LANG': 'en_US.UTF-8', 22:08:11 INFO - 'LANGUAGE': 'en_US:en', 22:08:11 INFO - 'LOGNAME': 'cltbld', 22:08:11 INFO - 'MAIL': '/var/mail/cltbld', 22:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:11 INFO - 'MOZ_NO_REMOTE': '1', 22:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:11 INFO - 'NO_EM_RESTART': '1', 22:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:11 INFO - 'PWD': '/builds/slave/test', 22:08:11 INFO - 'SHELL': '/bin/bash', 22:08:11 INFO - 'SHLVL': '1', 22:08:11 INFO - 'TERM': 'linux', 22:08:11 INFO - 'TMOUT': '86400', 22:08:11 INFO - 'USER': 'cltbld', 22:08:11 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', 22:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:11 INFO - '_': '/tools/buildbot/bin/python'} 22:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:08:11 INFO - Running setup.py (path:/tmp/pip-HolW_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:08:11 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)) 22:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:08:11 INFO - Running setup.py (path:/tmp/pip-_5APQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:08:11 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)) 22:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:08:11 INFO - Running setup.py (path:/tmp/pip-HOnCWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:08:11 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)) 22:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:08:11 INFO - Running setup.py (path:/tmp/pip-XDQM3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:08:11 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)) 22:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:08:11 INFO - Running setup.py (path:/tmp/pip-PEndyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:08:11 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)) 22:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:08:11 INFO - Running setup.py (path:/tmp/pip-5srdMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:08:11 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)) 22:08:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:08:11 INFO - Running setup.py (path:/tmp/pip-KN3G6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:08:12 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)) 22:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:08:12 INFO - Running setup.py (path:/tmp/pip-PqU9I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:08:12 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)) 22:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:08:12 INFO - Running setup.py (path:/tmp/pip-cjWLsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:08:12 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)) 22:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:08:12 INFO - Running setup.py (path:/tmp/pip-XQgCcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:08:12 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)) 22:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:08:12 INFO - Running setup.py (path:/tmp/pip-2T_f5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:08:12 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)) 22:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:08:12 INFO - Running setup.py (path:/tmp/pip-GzHk3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:08:12 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)) 22:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:08:12 INFO - Running setup.py (path:/tmp/pip-5FQhbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:08:12 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)) 22:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:08:12 INFO - Running setup.py (path:/tmp/pip-J1aRbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:08:12 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)) 22:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:12 INFO - Running setup.py (path:/tmp/pip-I3x6tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:12 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)) 22:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:08:12 INFO - Running setup.py (path:/tmp/pip-rcsyyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:08:12 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)) 22:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:08:12 INFO - Running setup.py (path:/tmp/pip-lJ1cDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:08:12 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)) 22:08:12 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)) 22:08:12 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)) 22:08:12 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)) 22:08:12 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)) 22:08:12 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)) 22:08:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:13 INFO - Downloading blessings-1.6.tar.gz 22:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:08:13 INFO - Installing collected packages: blessings 22:08:13 INFO - Running setup.py install for blessings 22:08:13 INFO - Successfully installed blessings 22:08:13 INFO - Cleaning up... 22:08:14 INFO - Return code: 0 22:08:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:08:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:08:14 INFO - Reading from file tmpfile_stdout 22:08:14 INFO - Current package versions: 22:08:14 INFO - argparse == 1.2.1 22:08:14 INFO - blessings == 1.6 22:08:14 INFO - blobuploader == 1.2.4 22:08:14 INFO - docopt == 0.6.1 22:08:14 INFO - functools32 == 3.2.3-2 22:08:14 INFO - jsonschema == 2.5.1 22:08:14 INFO - manifestparser == 1.1 22:08:14 INFO - mozInstall == 1.12 22:08:14 INFO - mozcrash == 1.0 22:08:14 INFO - mozdebug == 0.1 22:08:14 INFO - mozdevice == 0.50 22:08:14 INFO - mozfile == 1.2 22:08:14 INFO - mozhttpd == 0.7 22:08:14 INFO - mozinfo == 0.9 22:08:14 INFO - mozleak == 0.1 22:08:14 INFO - mozlog == 3.4 22:08:14 INFO - moznetwork == 0.27 22:08:14 INFO - mozprocess == 0.25 22:08:14 INFO - mozprofile == 0.28 22:08:14 INFO - mozrunner == 6.13 22:08:14 INFO - mozscreenshot == 0.1 22:08:14 INFO - mozsystemmonitor == 0.3 22:08:14 INFO - moztest == 0.8 22:08:14 INFO - mozversion == 1.4 22:08:14 INFO - psutil == 3.1.1 22:08:14 INFO - requests == 1.2.3 22:08:14 INFO - wsgiref == 0.1.2 22:08:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:08: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')]} 22:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08: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')]} 22:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:14 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 0x295f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd25c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf7a0>, '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 0x2cd06a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', '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 22:08:14 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 22:08:14 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 22:08:14 INFO - Using env: {'DISPLAY': ':0', 22:08:14 INFO - 'HOME': '/home/cltbld', 22:08:14 INFO - 'LANG': 'en_US.UTF-8', 22:08:14 INFO - 'LANGUAGE': 'en_US:en', 22:08:14 INFO - 'LOGNAME': 'cltbld', 22:08:14 INFO - 'MAIL': '/var/mail/cltbld', 22:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:14 INFO - 'MOZ_NO_REMOTE': '1', 22:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:14 INFO - 'NO_EM_RESTART': '1', 22:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:14 INFO - 'PWD': '/builds/slave/test', 22:08:14 INFO - 'SHELL': '/bin/bash', 22:08:14 INFO - 'SHLVL': '1', 22:08:14 INFO - 'TERM': 'linux', 22:08:14 INFO - 'TMOUT': '86400', 22:08:14 INFO - 'USER': 'cltbld', 22:08:14 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', 22:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:14 INFO - '_': '/tools/buildbot/bin/python'} 22:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:14 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)) 22:08:14 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)) 22:08:14 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)) 22:08:14 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)) 22:08:14 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)) 22:08:14 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)) 22:08:14 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)) 22:08:14 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)) 22:08:14 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)) 22:08:14 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)) 22:08:14 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)) 22:08:14 INFO - Cleaning up... 22:08:14 INFO - Return code: 0 22:08:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:08: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')]} 22:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08: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')]} 22:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x295f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd25c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf7a0>, '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 0x2cd06a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', '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 22:08:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:08:14 INFO - Using env: {'DISPLAY': ':0', 22:08:14 INFO - 'HOME': '/home/cltbld', 22:08:14 INFO - 'LANG': 'en_US.UTF-8', 22:08:14 INFO - 'LANGUAGE': 'en_US:en', 22:08:14 INFO - 'LOGNAME': 'cltbld', 22:08:14 INFO - 'MAIL': '/var/mail/cltbld', 22:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:14 INFO - 'MOZ_NO_REMOTE': '1', 22:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:14 INFO - 'NO_EM_RESTART': '1', 22:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:14 INFO - 'PWD': '/builds/slave/test', 22:08:14 INFO - 'SHELL': '/bin/bash', 22:08:14 INFO - 'SHLVL': '1', 22:08:14 INFO - 'TERM': 'linux', 22:08:14 INFO - 'TMOUT': '86400', 22:08:14 INFO - 'USER': 'cltbld', 22:08:14 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', 22:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:14 INFO - '_': '/tools/buildbot/bin/python'} 22:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:08:14 INFO - Cleaning up... 22:08:14 INFO - Return code: 0 22:08:14 INFO - Running post-action listener: _resource_record_post_action 22:08:14 INFO - Running post-action listener: _start_resource_monitoring 22:08:14 INFO - Starting resource monitoring. 22:08:14 INFO - [mozharness: 2017-05-18 05:08:14.738578Z] Finished create-virtualenv step (success) 22:08:14 INFO - [mozharness: 2017-05-18 05:08:14.739031Z] Running install step. 22:08:14 INFO - Running pre-action listener: _resource_record_pre_action 22:08:14 INFO - Running main action method: install 22:08:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:08:14 INFO - Reading from file tmpfile_stdout 22:08:14 INFO - Detecting whether we're running mozinstall >=1.0... 22:08:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:08:15 INFO - Reading from file tmpfile_stdout 22:08:15 INFO - Output received: 22:08:15 INFO - Usage: mozinstall [options] installer 22:08:15 INFO - Options: 22:08:15 INFO - -h, --help show this help message and exit 22:08:15 INFO - -d DEST, --destination=DEST 22:08:15 INFO - Directory to install application into. [default: 22:08:15 INFO - "/builds/slave/test"] 22:08:15 INFO - --app=APP Application being installed. [default: firefox] 22:08:15 INFO - mkdir: /builds/slave/test/build/application 22:08:15 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'] 22:08:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 22:08:32 INFO - Reading from file tmpfile_stdout 22:08:32 INFO - Output received: 22:08:32 INFO - /builds/slave/test/build/application/firefox/firefox 22:08:32 INFO - Running post-action listener: _resource_record_post_action 22:08:32 INFO - [mozharness: 2017-05-18 05:08:32.279842Z] Finished install step (success) 22:08:32 INFO - [mozharness: 2017-05-18 05:08:32.280121Z] Running run-tests step. 22:08:32 INFO - Running pre-action listener: _resource_record_pre_action 22:08:32 INFO - Running main action method: run_tests 22:08:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:08:32 INFO - Python 2.7.3 22:08:32 INFO - Return code: 0 22:08:32 INFO - grabbing minidump binary from tooltool 22:08:32 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')]} 22:08:32 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 0x2ccf7a0>, '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 0x2cd06a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd0b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:08:32 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 22:08:32 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 22:08:32 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 22:08:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:08:32 INFO - Return code: 0 22:08:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:08:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:08:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:08:32 INFO - ENV: RUST_BACKTRACE is now 1 22:08:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:08:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:08:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-089 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:08:32 INFO - Using env: {'DISPLAY': ':0', 22:08:32 INFO - 'HOME': '/home/cltbld', 22:08:32 INFO - 'LANG': 'en_US.UTF-8', 22:08:32 INFO - 'LANGUAGE': 'en_US:en', 22:08:32 INFO - 'LOGNAME': 'cltbld', 22:08:32 INFO - 'MAIL': '/var/mail/cltbld', 22:08:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:08:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:32 INFO - 'MOZ_NO_REMOTE': '1', 22:08:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:08:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:32 INFO - 'NO_EM_RESTART': '1', 22:08:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:32 INFO - 'PWD': '/builds/slave/test', 22:08:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:08:32 INFO - 'RUST_BACKTRACE': '1', 22:08:32 INFO - 'SHELL': '/bin/bash', 22:08:32 INFO - 'SHLVL': '1', 22:08:32 INFO - 'TERM': 'linux', 22:08:32 INFO - 'TMOUT': '86400', 22:08:32 INFO - 'USER': 'cltbld', 22:08:32 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842', 22:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:32 INFO - '_': '/tools/buildbot/bin/python'} 22:08:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:08:32 INFO - mozversion application_buildid: 20170518040634 22:08:32 INFO - mozversion application_changeset: baf05f61bc14fdf45511bc1165ce76daa08c5c0f 22:08:32 INFO - mozversion application_display_name: Nightly 22:08:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:08:32 INFO - mozversion application_name: Firefox 22:08:32 INFO - mozversion application_remotingname: firefox 22:08:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:08:32 INFO - mozversion application_vendor: Mozilla 22:08:32 INFO - mozversion application_version: 55.0a1 22:08:32 INFO - mozversion platform_buildid: 20170518040634 22:08:32 INFO - mozversion platform_changeset: baf05f61bc14fdf45511bc1165ce76daa08c5c0f 22:08:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:08:32 INFO - mozversion platform_version: 55.0a1 22:08:32 INFO - using testdate: 1495084112 22:08:32 INFO - actual date: 1495084112 22:08:32 INFO - starting webserver on 'localhost:53593' 22:08:32 INFO - SUITE-START | Running 2 tests 22:08:32 INFO - TEST-START | dromaeo_css 22:08:32 INFO - operating with platform_type : linux_ 22:08:32 INFO - Initialising browser for dromaeo_css test... 22:08:32 INFO - TEST-INFO | started process 8955 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOgGMUm/profile http://localhost:53593/getInfo.html) 22:08:33 INFO - PID 8955 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 22:08:36 INFO - PID 8955 | __metrics Screen width/height:1600/1200 22:08:36 INFO - PID 8955 | colorDepth:24 22:08:36 INFO - PID 8955 | Browser inner width/height: 1024/695 22:08:36 INFO - PID 8955 | __metrics 22:08:38 INFO - TEST-INFO | 8955: exit 0 22:08:38 INFO - Browser initialized. 22:08:38 INFO - Running cycle 1/1 for dromaeo_css test... 22:08:38 INFO - TEST-INFO | started process 9118 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOgGMUm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:08:50 INFO - PID 9118 | RSS: Main: 164937728 22:08:50 INFO - PID 9118 | 22:11:55 INFO - PID 9118 | Cycle 1(1): loaded http://localhost:53593/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53593/tests/dromaeo/cssquery-ext.html) 22:11:56 INFO - PID 9118 | RSS: Main: 171868160 22:11:56 INFO - PID 9118 | 22:14:58 INFO - PID 9118 | Cycle 1(1): loaded http://localhost:53593/tests/dromaeo/cssquery-ext.html (next: http://localhost:53593/tests/dromaeo/cssquery-jquery.html) 22:14:59 INFO - PID 9118 | RSS: Main: 171261952 22:14:59 INFO - PID 9118 | 22:18:01 INFO - PID 9118 | Cycle 1(1): loaded http://localhost:53593/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53593/tests/dromaeo/cssquery-mootools.html) 22:18:01 INFO - PID 9118 | RSS: Main: 172957696 22:18:01 INFO - PID 9118 | 22:21:03 INFO - PID 9118 | Cycle 1(1): loaded http://localhost:53593/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53593/tests/dromaeo/cssquery-prototype.html) 22:21:04 INFO - PID 9118 | RSS: Main: 170676224 22:21:04 INFO - PID 9118 | 22:24:06 INFO - PID 9118 | Cycle 1(1): loaded http://localhost:53593/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53593/tests/dromaeo/cssquery-yui.html) 22:24:07 INFO - PID 9118 | RSS: Main: 170856448 22:24:07 INFO - PID 9118 | 22:27:09 INFO - PID 9118 | Cycle 1(1): loaded http://localhost:53593/tests/dromaeo/cssquery-yui.html (next: http://localhost:53593/tests/dromaeo/cssquery-dojo.html) 22:27:09 INFO - PID 9118 | RSS: Main: 173850624 22:27:09 INFO - PID 9118 | 22:27:09 INFO - PID 9118 | __start_tp_report 22:27:09 INFO - PID 9118 | _x_x_mozilla_page_load 22:27:09 INFO - PID 9118 | _x_x_mozilla_page_load_details 22:27:09 INFO - PID 9118 | |i|pagename|runs| 22:27:09 INFO - PID 9118 | |0;dojo.html;2686.4224191798767;2700.9054683086097;2716.8369897806133;2733.152722655977;2735.193118030181;5263.3683957925;5314.256004159421;5318.46815318468;5319.867003324919;5355.491228333307;5267.47325267473;5285.392179899312;5347.491988261109;5359.598030147745;5404.135338345865;4500.729956202622;4704.929426058612;4706.788194531237;4729.2433210686295;4731.053789242148;4744.952550474485;4791.520847915215;4796.712197268158;4804.663673542854;4810.206315957863;4657.347971284023;4713.835015774432;4742.691725037862;4777.116233496779;4788.401449818773;4753.667243292971;4754.500777418356;4756;4771.308160316735;4798.592119669832;4665.46347170073;4705.952940470585;4707.741074240916;4712.269598212282;4722.8110875564935;5201.505856943622;5272.393674727417;5284.180951952453;5300.92048619271;5349.7057661828585;5751.827445176651;5765;5778.479936805707;5799.39106393831;5839.708014599296;5779.88440231193;5810.941890581124;5822.0684690449325;5834.4165583441745;5836.5914385993;5249.42256351801;5290.497402746733;5359.410464848864;5376.086065368897;5392.56859451243;5968.16445697594;5996.040633498619;5998.790042348497;6006.069059295816;6025.18659980897;5674.602777805514;5680.6591604503865;5682.090865461506;5686.545076393962;5728.255326807488;5618.073017951992;5618.438156184349;5686.175504551817;5741.8564535886935;5765.019946609086;5759.65442073477;5765.279340082489;5772.94227057724;5801.564882633735;5825.359210486928;5684.943150568524;5697.800576979786;5743.0811070228565;5751.252337196138;5787.450192231731;4446.599806017409;4488.147252022105;4489.618382437529;4514.864554063383;4519.960409105924;3869.5936926622862;3886.650201481824;3891.163399868985;3928.0965377962657;3929.390944403622;4818.638602104857;4847.5394837490385;4899.58353539946;4910.975445122752;4920.335754673145;5786.884262314814;5813.563982701315;5840.737166827503;5878.5003274721275;5879.353271140171;4867.902641947141;4870.732109733999;4870.756462176877;4893.486183950705;4930.975345123323;5059.949400506021;5087.389513258433;5129.9743501283;5130.7947682093045;5143.3827940646615;5367.919481207707;5376.73116344189;5380.246765452918;5406.5945054121885;5422.996745602076;5792.478676919098;5842.561807864342;5842.941570584239;5849.64902105875;5852.531797456279;5317.335333083364;5353.946460535501;5355.55632764693;5359.3032905722;5398.217258497574;5667.631603945731;5732.7706891723865;5758;5759.65442073477;5762.654240745569;5823.4467725566;5824.475797178275;5832.883342333044;5875.911861322169;5887.764489420375;5443.8094666686475;5580.274564306615;5629.831105066854;5657.547396208376;5675.971620141873;5619.297587801525;5622.465865742748;5626.35296940857;5659.830205093854;5678.97778399892;5506.421825708243;5507.669539827623;5511.917321240265;5534.086875665631;5585.581081418991;5647.830565083054;5679.602427830012;5690.487856092972;5694.943050569607;5731.426857314235;5404.513593776579;5447.673139611636;5460.972695136499;5479.671219726829;5484.067708489487 22:27:09 INFO - PID 9118 | |1;ext.html;704.1655638068888;739.6745432009915;756.8788993760998;1071.646356702288;1087.9782404351918;31001;32542.67457325426;32551.67448325516;32677.836610816972;32752.836235818846;33723.66276337236;34061.14847128823;34174.31651366971;34223.4866477003;34260.31479370417;6819.829504262383;6851.657417129149;6972.047826608557;7002.194747604014;7021.403180729644;7010.894836577456;7045.964770176142;7047.577145371269;7059.541129826544;7076.044733960926;7046.1192350956135;7065.32879376461;7077.044598979123;7115.252898445667;7124;7016.684249208798;7027.789166325018;7057.647117644123;7079.469039821983;7102.786916392516;6953.79138625842;6992.475564332695;7021;7026.613536255504;7036.155661320623;31453;31567.52648710271;31598.368032639217;31687;31730.841345793353;3061.2959019425657;3068.769842261817;3076.507758758588;3082.4143412751505;3099.7210251077286;24961.87519062393;25027.749722502725;25053.62419563708;25071.62392564113;25099.37251568707;2992.7755418343713;2997.385535965122;3014.427258820817;3014.713602207809;3015.9396812063637;144846.2757686205;145535.27232363875;153469.23265383602;155785.22107389505;157154;39664;39853.80073099616;39865.60134398677;39867.20265594672;39905;41258.79370603188;41366.1726765463;41540.376894346606;41575;41680.79159604243;12210.816837747441;12293.631191064282;12326.445309961073;12348.814767778491;12350.197237179555;9693.61225550984;9713.90286097144;9717.222622190207;9723.124918757347;9782.706518804447;12603;12664.240145591293;12707.301098439675;12747.808782868264;12854.871451285368;5257.947420525746;5332;5341.759620817073;5408.567314614821;5494.340679118532;798.0503201190564;840.1472505407016;854.2994744309607;871.2681347667863;880.2737741363401;19346.129424175946;19856.305029323903;19949.501262468555;20162.395128146178;20776;904.5929331800716;922.5710044829186;938.0338251600862;943.8725772020827;945.7068308824287;10165;10319.864814870358;10651.09465695409;10722.517486713117;10807.621733239299;176689;178407;179534;180158;180327;40455.59544404577;40491.39262911059;40817.591824081974;41184.38223426651;41205.1758964819;1214.1925619462959;1255.7425727725795;1259.8929091027364;1272.8599854016052;1274.9808752868714;18714.625707485502;19168.27843331253;19744;20037.899810500854;20371.287004954756;29586.556201656564;29902.70097298999;30034.3993120132;30070;30084;146719;147275;147408;147918.26040869727;148366;28688.13935581936;28890;29263;29271.70728292775;29345.413091738472;34214.48678269778;34306.65693343035;35491.290174195856;35593.64406355903;35901;27234.319142021606;27670.72329276762;27849;28617.713822862337;28821.27946801347;26323.868380657976;28115;28151.43697126005;28375.858120709265;29915.850420747756;30016.24959376033;31404;31494.527582086746;31724.682753172172;32047.519287211177;27015.324616884736;27620.585691214244;27668;27673.584896226974;28844.567331489623;21939.341819745434;22693.43266418353;22784;22865.19971800979;23050.308490745305 22:27:09 INFO - PID 9118 | |2;jquery.html;414.37636357282287;415.63424186715685;423.68435515540915;438.56362918895695;441.0781466734524;14794.482193123244;16909.23908424121;17670.116494175287;17675.46973590791;17851.46445606634;17981.730274045898;18271.817281827178;18294.542636434096;18382.448526544224;18426.81573184268;5195.272661827347;5213.139831927746;5411.053065713504;5443.319585051869;5446.2919820423485;5326.067938110815;5406;5408.945910540903;5420.83737487874;5422.267993820823;5202.739863006854;5357.142857142858;5369.9463005369835;5388.811391601294;5391.487808658171;5333.54664853486;5335.759890804904;5339;5376.247325374451;5383.380911195223;4683.672142949995;4859.41686997559;4878.219484882402;4879.756012199376;4891.217405215184;21097.15611375543;21255.893720531454;21302.680459793115;21312.46718832026;21346;1556.0741358891441;1604.4865642994246;1605.8153312368993;1606.9357225710958;1607.8954867933546;14124.929375353058;14489.985701000935;14493.202873841934;14654.780178297335;14842.554723358317;2029.3201777404588;2047.2425202674956;2081.115525901501;2082.5730725201447;2090.205721825712;80194;80441.59779201125;81099;82035.17964820335;82304.58847705723;10616.681499555025;10954.561817527368;11158.853842515307;11210;11313.547458101584;15150.924245378703;15338.469152589698;15352.925295229226;15445.845541544666;15457.38170473191;6881.931180688129;6884.1050663414435;7066.505344625827;7074.7170113195925;7090.255523170096;6020.277566692025;6064.211652485237;6150.269575110021;6236.376362363818;6258.499320054385;6954.269801670752;6954.374106330454;6963.164420269499;7037.7184912602925;7105.609191494517;1957.2953736654792;1990.3133418970433;2014.103723842905;2024.7975202479633;2038.2967876082728;830.5390508267969;871.4292138649195;871.6121326009992;874.881890944727;899.2131884600974;16730.247138878778;17047.14764261782;17066.31734730597;17167.914160429118;17879.821201787814;859.3683642522741;862.6678728689375;865.6450855149359;872.5549969515466;888.5290795878195;9263.027382124914;9406.670766523139;9811.215102791759;9841.753956151011;9877.40735555869;349504;351871;354260;386839;397328;77707.61146194233;80383.59808200922;80643.59678201571;82615;82735;1075.5805235957982;1096.5504143301048;1121.556984990924;1126.774645070989;1131.8924702153283;17004;17310.221040052977;17715.468535943943;17972.460826175236;18379.081045947918;38160.80919595384;38354.61645383511;38796.22407551777;39633.80183099066;39658.2068358637;48590.51409486002;48712.51287487221;49069.75465122652;49308.26037609367;50786;8076.152004039492;8180.590970451334;8214.301784348158;8284.668613255402;8546.914530854861;11974.341411222467;12060.577879774166;12176.634700958986;12522;13107.475700971854;10764.946175269073;10779;10937.890621093688;10995.175361847734;11108;10080.798384032132;10302.896971030494;10309.123724483203;10315.381077135396;10421.062104410335;10465.529051192563;11098.722531936766;11335.319880807177;11350.489227984595;11367.261128026652;8136.796580085545;8306.501609903426;8382.622781974947;8436.831263374575;8664.48013119215;10811.13510919109;10864.945675271572;11119.944400278271;11256;11273.943630282125 22:27:09 INFO - PID 9118 | |3;mootools.html;1200.2738343302303;1247.232951734683;1265.1649911058703;1267.1573403686548;1273.3824095313778;10131.69604911852;10489.475526223678;10545.103666188374;10573.577056917733;10758.085562727178;10527.947360263208;10684.78630427393;10740.570377184922;10743.785124297528;10761.408122553257;2269.4893648928983;2271.681964524968;2290.1869836208157;2304.9423764405856;2311.503026849227;2143.07847625521;2203.9449013774624;2205.6691496275607;2209;2215.9113635454564;2187.6937228787983;2192.9561408771897;2231.419830843984;2242.2040175737625;2250.8199344052437;2132.3389749177804;2151.505153814616;2195.3084778294788;2197.28588208832;2207.8012978831903;1957.4127761671584;2126.33020598511;2131.211451762842;2150.0754675489534;2154.4183070570857;10060.899391006069;10132.34139780912;10135.44255065971;10144.594216231342;10150.949245253727;5613.691246981414;5793;5796.739146738407;5800.738966746507;5807.767689292423;3325.6341802401716;3556.928861422783;3606.0804494853905;3610.945835812465;3623.058004918714;1053.873535175784;1091.579741799405;1107.983380249297;1109.545086514525;1119.8936101070385;15123.848761512354;15239.238038098161;15271.160086195256;15282.465113721077;15308.693826123415;4688.46082700487;4786.688865223749;4942.110420124341;5039.596832253411;5089.618278629117;10469.267151299337;10470.790584188426;10474.162067034618;10489.737756556147;10500.47497625131;5694.288213973254;5697.772089116472;5699.914501282484;5705.229793977843;5706.3152421709665;5036.244563315532;5280.577553795687;5285.445028272053;5300.469953004746;5312.893742125136;3850.3646898261472;3901.9219615608095;3956.7032472564097;3975.6421922027157;4031.8992025199605;1113.287496002559;1122.966311010671;1126.9774604507863;1132.9490172942237;1143.1940481960198;675.76010516267;700.4816435837546;704.5737328916034;713.8037039813989;719.2016861283971;5162.432132465426;5311.49540793624;5359.437259087817;5411.56707463402;5444.891102177934;832.7168762620738;844.8225872566829;854.7649396416035;859.3554833874595;863.5509535041743;3673.7061035117126;3695.6119607440833;3761.586225515191;3782.0733920189728;3889.2415978883846;12903.935480322538;13322.20066795976;13333.133346332457;13671.043026988016;13692.589222323346;13278.468861245636;13465.798013029813;13574.59276221715;13588.184708917497;13713.382897769625;7690.807729806687;7712.6529306181355;7810.765677029698;7819.966808629683;7852.5288482690075;5787.56593255516;5803.187553742564;5881.3236477803885;5984.551158663205;6048.969755151196;11384.032357249727;11409.486573104065;11487.94256028748;11691.590794322157;12268.938655307024;12152.635420937386;12256.938715306367;12398.690032749253;12405.317707526172;12427.31649759272;8329.6668133274;8521.957390213009;8619.439736417113;8628.654853805778;8643.351748619005;9405.482698451651;9567.234621230424;9618.51907404641;9656;9672.56473458682;7914.802129946797;7948.960255198687;7953.443258971816;7995.960020199862;8357.582120893809;8119.269265766109;8217.342612590859;8247.711330103417;8438.071812100541;8491.532965686947;7559.962200189184;7619.123800762984;7632.1604623492485;7684.077910650758;7718.459707820399;5359.758810853599;5396.298481197419;5437.728113594384;5449.100898351728;5565.638233514808;5298.7350632469;5378.435264297193;5433;5479.808206712746;5573.442655734556 22:27:09 INFO - PID 9118 | |4;prototype.html;371.9572249191342;393.49435974772416;393.76767707052835;395.73683500472185;398.8723608445298;5485.945140548603;5637;5662.716864156796;5663.178839068332;5668.971655141724;5413.675179489233;5451.454854514546;5466.835994920149;5471.838623743619;5483.232347471348;4081.510218773751;4082.0815316553685;4088.625171066945;4100.815463304159;4114.37482194533;4056.7565946043333;4061.6953728470335;4086.16233672098;4112.773797441139;4132.710710250284;4046.3496409851596;4050.8987275318204;4060.7157498975084;4067.2475592015426;4080.4491393661774;4068.7558746475156;4072.3687828386646;4075.49056367954;4078.347464405681;4082.7340825841648;3543.6080645564143;3545.2377738786026;3551.254236610315;3556.87550935716;3558.466230065485;5321.760520776575;5333.546648534879;5367.35591728995;5373.865653358658;5377.247185394009;4763.76181190939;4834.589059929875;4841.878953026167;4845.951540484585;4850.927236091461;5611.466910643482;5804.129380592903;5812.476877081083;5846;5868;4032.818523166435;4045.4538637284177;4046.8381264749373;4056.188762247533;4063.6952228582677;6002.579819412643;6181.320054793969;6184.690765461709;6187.925900761423;6269.153664255313;4111.814968326433;4126.855560055384;4132.958670413317;4141.5237247716295;4149.97925010373;4210.0948296116485;4215.831366745296;4218.535961044283;4221.915561688749;4222.535521092677;4749.738764367924;4799.112164249625;4874.658773885865;4882.609391248691;4884.3161957326;5843.5909486336395;5853.443922827325;5853.590248682552;5862.618929769551;5866.823995280149;1427.7858321251895;1449.4926775628446;1459.241194578813;1460.7589747691725;1468.4493315006873;961.3174646001418;964.3442459127721;964.7346979580672;966.8694726211871;978.1490103609763;5003;5004.224345226496;5004.724740139254;5044.798208071709;5064.949350506521;6059.909101363483;6062.636241825505;6072.483838873657;6082.118092876508;6095.116208149793;4935.3090567320605;4951.356323677971;5008.724520151354;5024.191291135188;5028.195488721787;3195.7123858852815;3202.7277681396877;3217.1957010747315;3217.7104060634188;3228.838558072087;5322.92015619766;5540.750666220029;5560.165975103767;5560.610757247035;5561.4716601922755;6235.657038862906;6250.249970003629;6265.122882796412;6277.2153480814895;6310.1796766420075;5592.273004509388;5594.580406469531;5607.635503692329;5621.8594535136945;5631.436856314418;5822.57346949983;6012.518998480198;6087.9605332214205;6106.1146133811235;6147.293061297829;5842.678652674143;5996.760129594942;5999.39056981706;6003.769227308479;6005.837898356501;5520.199571062254;5573.637713548606;5591.440855914376;5596.636218645775;5610.18652295423;4124.958750412457;4145.0880806222585;4148.004478924976;4153.626173644387;4158.189153115113;5983;6077.20996270482;6123.510119190365;6148.754049837957;6175.382461753788;5900.970495147497;5903.439173278532;5903.675297858487;5909.163601471232;5928.199693041384;5844.47399734026;5867.706614669164;5909;5926.318473375617;5943.732532036155;5747.3103227612955;5825.5338073846;5844.590878638624;5852.678102704393;5868.823935281948;5904.439078287556;5930.940690593211;5956.642601443928;5958.344582096052;5967.46292833647;5621.606487545996;5649.237352957298;5702.37273899879;5727.770889164553;5770.163326317576 22:27:09 INFO - PID 9118 | |5;yui.html;710.0910834132312;721.8159369360814;730.5689643110563;732.5421611492816;737.0933751485672;11678.708032299175;12131.211471254363;13065.73868522629;13939.442422303122;13958.092723972935;13276.800847987264;14511.129332240072;15250.618734531643;15311.770323445156;15345.156016419092;824.6701319472214;848.6266042941086;851.1956201389689;851.3870013590205;854.5001174313003;895.1943251074052;896.7264984179823;896.9910300897005;899.0470101692194;899.1233547291404;944.1078181118845;946.2666433514013;946.3706635087658;947.554649314821;948.7390967483963;922.9584668689926;924.2236521322054;925.2597921662643;930.0467021303184;930.1070971867016;686.5297271369128;691.0981169573704;691.4744793956579;691.6265216782981;692.944564434844;14025.929870350685;14166.433342666282;14683;15151.318190681446;15357.692846143127;15233.923830380889;15465.690686186326;15633;15639.765403518957;15953;11751.529938802438;11803.468843902045;11815.232009919328;12385.938070309681;12514.18657787241;2689.623452716621;2690.246730915327;2699.068821256683;2699.4601079783924;2708.377073273158;69874;70343.64828175929;70866;70981.29018709798;72696.27303726948;11752.412379380996;11775.293482391084;11838.585649502225;12008.459619317151;12067.939660301818;21917.671234931488;21947.231846885603;22123.115075396803;22123.225687100876;22162.88918555429;6109.694515274218;6132.2947860996555;6242.344553821874;6269.968650156811;6368.29948705642;2943.2788966703297;3004.143819011615;3014.788964772445;3043.1174959262007;3048.8628011739524;3411.113110591264;3445.776024558446;3460.2214501736908;3471.9132021699156;3472.618012018676;729.7701224114387;745.530315900979;751.5903832411349;752;755.2560727683227;590.3653572409677;596.1118381441908;600.7236671131241;606.7360698096343;625.1997443272618;9368.344215904957;9853.950730246303;9997.950010249902;10136.44249566281;10410.739731506621;557.4620491225986;565.1579147070835;567.7445149682659;569.3281927325712;571.2773341722724;4073.409355643415;4215.367694845736;4249.277622804131;4259.616634502848;4374.693771436033;66195.33804661891;66570.0086992173;67577.66211168913;67853.66073169603;68177.65911170412;53917.73041134769;53931.73034134804;54074;55261;56197.43802562004;52170.21744673909;52467.73766131145;52955;53290.46709532855;53323.733381332844;8192.54940978252;8348.791280218044;8414.6213420395;8457.450265732708;8664.393492455467;27519.724802751716;27734.861325694048;27884.16347509578;28104.330088641545;28306.15081547557;32436.35127297488;32902.67097328996;33662.49506257457;45686;46435.071298573166;13776.380062896993;14366.13803171813;14390.712185756016;14449.638759031108;14646.26768661584;15942.123183225034;16171.353145874033;16218.594535136715;16239.10684912294;16253.268602913135;13172.275524845842;13910.026298159437;14224.14655120696;14334.928325358724;14371.209583472591;13846.446142154604;14145.43418263258;14341.92829035848;14506.1296322221;14715.467287405449;13083.738325233251;13416.597502074954;13435.790778829953;13468;13936.372863220977;10137.543810528396;10245.180385569285;10560.788784224425;11040.5031773572;11068.833967490333;10791.892081079088;11525.654230373102;11543.826842597537;11610.12924030718;11616.419179041182 22:27:09 INFO - PID 9118 | __end_tp_report 22:27:09 INFO - PID 9118 | __start_cc_report 22:27:09 INFO - PID 9118 | _x_x_mozilla_cycle_collect,278 22:27:09 INFO - PID 9118 | __end_cc_report 22:27:09 INFO - PID 9118 | __startTimestamp1495085229631__endTimestamp 22:27:09 INFO - PID 9118 | 22:27:09 INFO - PID 9118 | ------- Summary: start ------- 22:27:09 INFO - PID 9118 | Number of tests: 6 22:27:09 INFO - PID 9118 | 22:27:09 INFO - PID 9118 | [#0] dojo.html Cycles:165 Average:5252.53 Median:5404.14 stddev:664.80 (12.3%) stddev-sans-first:635.63 22:27:09 INFO - PID 9118 | Values: 2686.4 2700.9 2716.8 2733.2 2735.2 5263.4 5314.3 5318.5 5319.9 5355.5 5267.5 5285.4 5347.5 5359.6 5404.1 4500.7 4704.9 4706.8 4729.2 4731.1 4745.0 4791.5 4796.7 4804.7 4810.2 4657.3 4713.8 4742.7 4777.1 4788.4 4753.7 4754.5 4756.0 4771.3 4798.6 4665.5 4706.0 4707.7 4712.3 4722.8 5201.5 5272.4 5284.2 5300.9 5349.7 5751.8 5765.0 5778.5 5799.4 5839.7 5779.9 5810.9 5822.1 5834.4 5836.6 5249.4 5290.5 5359.4 5376.1 5392.6 5968.2 5996.0 5998.8 6006.1 6025.2 5674.6 5680.7 5682.1 5686.5 5728.3 5618.1 5618.4 5686.2 5741.9 5765.0 5759.7 5765.3 5772.9 5801.6 5825.4 5684.9 5697.8 5743.1 5751.3 5787.5 4446.6 4488.1 4489.6 4514.9 4520.0 3869.6 3886.7 3891.2 3928.1 3929.4 4818.6 4847.5 4899.6 4911.0 4920.3 5786.9 5813.6 5840.7 5878.5 5879.4 4867.9 4870.7 4870.8 4893.5 4931.0 5059.9 5087.4 5130.0 5130.8 5143.4 5367.9 5376.7 5380.2 5406.6 5423.0 5792.5 5842.6 5842.9 5849.6 5852.5 5317.3 5353.9 5355.6 5359.3 5398.2 5667.6 5732.8 5758.0 5759.7 5762.7 5823.4 5824.5 5832.9 5875.9 5887.8 5443.8 5580.3 5629.8 5657.5 5676.0 5619.3 5622.5 5626.4 5659.8 5679.0 5506.4 5507.7 5511.9 5534.1 5585.6 5647.8 5679.6 5690.5 5694.9 5731.4 5404.5 5447.7 5461.0 5479.7 5484.1 22:27:09 INFO - PID 9118 | 22:27:09 INFO - PID 9118 | [#1] ext.html Cycles:180 Average:30294.87 Median:3079.46 stddev:41261.12 (1339.9%) stddev-sans-first:41317.04 22:27:09 INFO - PID 9118 | Values: 704.2 739.7 756.9 1071.6 1088.0 31001.0 32542.7 32551.7 32677.8 32752.8 33723.7 34061.1 34174.3 34223.5 34260.3 6819.8 6851.7 6972.0 7002.2 7021.4 7010.9 7046.0 7047.6 7059.5 7076.0 7046.1 7065.3 7077.0 7115.3 7124.0 7016.7 7027.8 7057.6 7079.5 7102.8 6953.8 6992.5 7021.0 7026.6 7036.2 31453.0 31567.5 31598.4 31687.0 31730.8 3061.3 3068.8 3076.5 3082.4 3099.7 24961.9 25027.7 25053.6 25071.6 25099.4 2992.8 2997.4 3014.4 3014.7 3015.9 144846.3 145535.3 153469.2 155785.2 157154.0 39664.0 39853.8 39865.6 39867.2 39905.0 41258.8 41366.2 41540.4 41575.0 41680.8 12210.8 12293.6 12326.4 12348.8 12350.2 9693.6 9713.9 9717.2 9723.1 9782.7 12603.0 12664.2 12707.3 12747.8 12854.9 5257.9 5332.0 5341.8 5408.6 5494.3 798.1 840.1 854.3 871.3 880.3 19346.1 19856.3 19949.5 20162.4 20776.0 904.6 922.6 938.0 943.9 945.7 10165.0 10319.9 10651.1 10722.5 10807.6 176689.0 178407.0 179534.0 180158.0 180327.0 40455.6 40491.4 40817.6 41184.4 41205.2 1214.2 1255.7 1259.9 1272.9 1275.0 18714.6 19168.3 19744.0 20037.9 20371.3 29586.6 29902.7 30034.4 30070.0 30084.0 146719.0 147275.0 147408.0 147918.3 148366.0 28688.1 28890.0 29263.0 29271.7 29345.4 34214.5 34306.7 35491.3 35593.6 35901.0 27234.3 27670.7 27849.0 28617.7 28821.3 26323.9 28115.0 28151.4 28375.9 29915.9 30016.2 31404.0 31494.5 31724.7 32047.5 27015.3 27620.6 27668.0 27673.6 28844.6 21939.3 22693.4 22784.0 22865.2 23050.3 22:27:09 INFO - PID 9118 | 22:27:09 INFO - PID 9118 | [#2] jquery.html Cycles:180 Average:24664.08 Median:212817.61 stddev:61264.57 (28.8%) stddev-sans-first:61409.38 22:27:09 INFO - PID 9118 | Values: 414.4 415.6 423.7 438.6 441.1 14794.5 16909.2 17670.1 17675.5 17851.5 17981.7 18271.8 18294.5 18382.4 18426.8 5195.3 5213.1 5411.1 5443.3 5446.3 5326.1 5406.0 5408.9 5420.8 5422.3 5202.7 5357.1 5369.9 5388.8 5391.5 5333.5 5335.8 5339.0 5376.2 5383.4 4683.7 4859.4 4878.2 4879.8 4891.2 21097.2 21255.9 21302.7 21312.5 21346.0 1556.1 1604.5 1605.8 1606.9 1607.9 14124.9 14490.0 14493.2 14654.8 14842.6 2029.3 2047.2 2081.1 2082.6 2090.2 80194.0 80441.6 81099.0 82035.2 82304.6 10616.7 10954.6 11158.9 11210.0 11313.5 15150.9 15338.5 15352.9 15445.8 15457.4 6881.9 6884.1 7066.5 7074.7 7090.3 6020.3 6064.2 6150.3 6236.4 6258.5 6954.3 6954.4 6963.2 7037.7 7105.6 1957.3 1990.3 2014.1 2024.8 2038.3 830.5 871.4 871.6 874.9 899.2 16730.2 17047.1 17066.3 17167.9 17879.8 859.4 862.7 865.6 872.6 888.5 9263.0 9406.7 9811.2 9841.8 9877.4 349504.0 351871.0 354260.0 386839.0 397328.0 77707.6 80383.6 80643.6 82615.0 82735.0 1075.6 1096.6 1121.6 1126.8 1131.9 17004.0 17310.2 17715.5 17972.5 18379.1 38160.8 38354.6 38796.2 39633.8 39658.2 48590.5 48712.5 49069.8 49308.3 50786.0 8076.2 8180.6 8214.3 8284.7 8546.9 11974.3 12060.6 12176.6 12522.0 13107.5 10764.9 10779.0 10937.9 10995.2 11108.0 10080.8 10302.9 10309.1 10315.4 10421.1 10465.5 11098.7 11335.3 11350.5 11367.3 8136.8 8306.5 8382.6 8436.8 8664.5 10811.1 10864.9 11119.9 11256.0 11273.9 22:27:09 INFO - PID 9118 | 22:27:09 INFO - PID 9118 | [#3] mootools.html Cycles:180 Average:6355.83 Median:3684.66 stddev:4073.18 (110.5%) stddev-sans-first:4066.18 22:27:09 INFO - PID 9118 | Values: 1200.3 1247.2 1265.2 1267.2 1273.4 10131.7 10489.5 10545.1 10573.6 10758.1 10527.9 10684.8 10740.6 10743.8 10761.4 2269.5 2271.7 2290.2 2304.9 2311.5 2143.1 2203.9 2205.7 2209.0 2215.9 2187.7 2193.0 2231.4 2242.2 2250.8 2132.3 2151.5 2195.3 2197.3 2207.8 1957.4 2126.3 2131.2 2150.1 2154.4 10060.9 10132.3 10135.4 10144.6 10150.9 5613.7 5793.0 5796.7 5800.7 5807.8 3325.6 3556.9 3606.1 3610.9 3623.1 1053.9 1091.6 1108.0 1109.5 1119.9 15123.8 15239.2 15271.2 15282.5 15308.7 4688.5 4786.7 4942.1 5039.6 5089.6 10469.3 10470.8 10474.2 10489.7 10500.5 5694.3 5697.8 5699.9 5705.2 5706.3 5036.2 5280.6 5285.4 5300.5 5312.9 3850.4 3901.9 3956.7 3975.6 4031.9 1113.3 1123.0 1127.0 1132.9 1143.2 675.8 700.5 704.6 713.8 719.2 5162.4 5311.5 5359.4 5411.6 5444.9 832.7 844.8 854.8 859.4 863.6 3673.7 3695.6 3761.6 3782.1 3889.2 12903.9 13322.2 13333.1 13671.0 13692.6 13278.5 13465.8 13574.6 13588.2 13713.4 7690.8 7712.7 7810.8 7820.0 7852.5 5787.6 5803.2 5881.3 5984.6 6049.0 11384.0 11409.5 11487.9 11691.6 12268.9 12152.6 12256.9 12398.7 12405.3 12427.3 8329.7 8522.0 8619.4 8628.7 8643.4 9405.5 9567.2 9618.5 9656.0 9672.6 7914.8 7949.0 7953.4 7996.0 8357.6 8119.3 8217.3 8247.7 8438.1 8491.5 7560.0 7619.1 7632.2 7684.1 7718.5 5359.8 5396.3 5437.7 5449.1 5565.6 5298.7 5378.4 5433.0 5479.8 5573.4 22:27:09 INFO - PID 9118 | 22:27:09 INFO - PID 9118 | [#4] prototype.html Cycles:180 Average:4799.54 Median:5484.59 stddev:1442.83 (26.3%) stddev-sans-first:1408.09 22:27:09 INFO - PID 9118 | Values: 372.0 393.5 393.8 395.7 398.9 5485.9 5637.0 5662.7 5663.2 5669.0 5413.7 5451.5 5466.8 5471.8 5483.2 4081.5 4082.1 4088.6 4100.8 4114.4 4056.8 4061.7 4086.2 4112.8 4132.7 4046.3 4050.9 4060.7 4067.2 4080.4 4068.8 4072.4 4075.5 4078.3 4082.7 3543.6 3545.2 3551.3 3556.9 3558.5 5321.8 5333.5 5367.4 5373.9 5377.2 4763.8 4834.6 4841.9 4846.0 4850.9 5611.5 5804.1 5812.5 5846.0 5868.0 4032.8 4045.5 4046.8 4056.2 4063.7 6002.6 6181.3 6184.7 6187.9 6269.2 4111.8 4126.9 4133.0 4141.5 4150.0 4210.1 4215.8 4218.5 4221.9 4222.5 4749.7 4799.1 4874.7 4882.6 4884.3 5843.6 5853.4 5853.6 5862.6 5866.8 1427.8 1449.5 1459.2 1460.8 1468.4 961.3 964.3 964.7 966.9 978.1 5003.0 5004.2 5004.7 5044.8 5064.9 6059.9 6062.6 6072.5 6082.1 6095.1 4935.3 4951.4 5008.7 5024.2 5028.2 3195.7 3202.7 3217.2 3217.7 3228.8 5322.9 5540.8 5560.2 5560.6 5561.5 6235.7 6250.2 6265.1 6277.2 6310.2 5592.3 5594.6 5607.6 5621.9 5631.4 5822.6 6012.5 6088.0 6106.1 6147.3 5842.7 5996.8 5999.4 6003.8 6005.8 5520.2 5573.6 5591.4 5596.6 5610.2 4125.0 4145.1 4148.0 4153.6 4158.2 5983.0 6077.2 6123.5 6148.8 6175.4 5901.0 5903.4 5903.7 5909.2 5928.2 5844.5 5867.7 5909.0 5926.3 5943.7 5747.3 5825.5 5844.6 5852.7 5868.8 5904.4 5930.9 5956.6 5958.3 5967.5 5621.6 5649.2 5702.4 5727.8 5770.2 22:27:09 INFO - PID 9118 | 22:27:09 INFO - PID 9118 | [#5] yui.html Cycles:180 Average:15418.67 Median:3428.44 stddev:18489.43 (539.3%) stddev-sans-first:18508.30 22:27:09 INFO - PID 9118 | Values: 710.1 721.8 730.6 732.5 737.1 11678.7 12131.2 13065.7 13939.4 13958.1 13276.8 14511.1 15250.6 15311.8 15345.2 824.7 848.6 851.2 851.4 854.5 895.2 896.7 897.0 899.0 899.1 944.1 946.3 946.4 947.6 948.7 923.0 924.2 925.3 930.0 930.1 686.5 691.1 691.5 691.6 692.9 14025.9 14166.4 14683.0 15151.3 15357.7 15233.9 15465.7 15633.0 15639.8 15953.0 11751.5 11803.5 11815.2 12385.9 12514.2 2689.6 2690.2 2699.1 2699.5 2708.4 69874.0 70343.6 70866.0 70981.3 72696.3 11752.4 11775.3 11838.6 12008.5 12067.9 21917.7 21947.2 22123.1 22123.2 22162.9 6109.7 6132.3 6242.3 6270.0 6368.3 2943.3 3004.1 3014.8 3043.1 3048.9 3411.1 3445.8 3460.2 3471.9 3472.6 729.8 745.5 751.6 752.0 755.3 590.4 596.1 600.7 606.7 625.2 9368.3 9854.0 9998.0 10136.4 10410.7 557.5 565.2 567.7 569.3 571.3 4073.4 4215.4 4249.3 4259.6 4374.7 66195.3 66570.0 67577.7 67853.7 68177.7 53917.7 53931.7 54074.0 55261.0 56197.4 52170.2 52467.7 52955.0 53290.5 53323.7 8192.5 8348.8 8414.6 8457.5 8664.4 27519.7 27734.9 27884.2 28104.3 28306.2 32436.4 32902.7 33662.5 45686.0 46435.1 13776.4 14366.1 14390.7 14449.6 14646.3 15942.1 16171.4 16218.6 16239.1 16253.3 13172.3 13910.0 14224.1 14334.9 14371.2 13846.4 14145.4 14341.9 14506.1 14715.5 13083.7 13416.6 13435.8 13468.0 13936.4 10137.5 10245.2 10560.8 11040.5 11068.8 10791.9 11525.7 11543.8 11610.1 11616.4 22:27:09 INFO - PID 9118 | -------- Summary: end -------- 22:27:09 INFO - PID 9118 | 22:27:10 INFO - TEST-INFO | 9118: exit 0 22:27:10 INFO - TEST-OK | dromaeo_css | took 1117909ms 22:27:10 INFO - TEST-START | kraken 22:27:10 INFO - operating with platform_type : linux_ 22:27:10 INFO - Initialising browser for kraken test... 22:27:10 INFO - TEST-INFO | started process 9523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjAm6HS/profile http://localhost:53593/getInfo.html) 22:27:10 INFO - PID 9523 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 22:27:14 INFO - PID 9523 | __metrics Screen width/height:1600/1200 22:27:14 INFO - PID 9523 | colorDepth:24 22:27:14 INFO - PID 9523 | Browser inner width/height: 1024/695 22:27:14 INFO - PID 9523 | __metrics 22:27:16 INFO - TEST-INFO | 9523: exit 0 22:27:16 INFO - Browser initialized. 22:27:16 INFO - Running cycle 1/1 for kraken test... 22:27:16 INFO - TEST-INFO | started process 9688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjAm6HS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:27:28 INFO - PID 9688 | RSS: Main: 164872192 22:27:28 INFO - PID 9688 | 22:27:30 INFO - PID 9688 | Cycle 1(1): loaded http://localhost:53593/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53593/tests/kraken/driver.html?testName=audio-beat-detection) 22:27:31 INFO - PID 9688 | RSS: Main: 170696704 22:27:31 INFO - PID 9688 | 22:27:34 INFO - PID 9688 | Cycle 1(1): loaded http://localhost:53593/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53593/tests/kraken/driver.html?testName=audio-dft) 22:27:35 INFO - PID 9688 | RSS: Main: 170389504 22:27:35 INFO - PID 9688 | 22:27:38 INFO - PID 9688 | Cycle 1(1): loaded http://localhost:53593/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53593/tests/kraken/driver.html?testName=audio-fft) 22:27:38 INFO - PID 9688 | RSS: Main: 165216256 22:27:38 INFO - PID 9688 | 22:27:40 INFO - PID 9688 | Cycle 1(1): loaded http://localhost:53593/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53593/tests/kraken/driver.html?testName=audio-oscillator) 22:27:41 INFO - PID 9688 | RSS: Main: 165715968 22:27:41 INFO - PID 9688 | 22:27:43 INFO - PID 9688 | Cycle 1(1): loaded http://localhost:53593/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53593/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:27:44 INFO - PID 9688 | RSS: Main: 166031360 22:27:44 INFO - PID 9688 | 22:27:47 INFO - PID 9688 | Cycle 1(1): loaded http://localhost:53593/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53593/tests/kraken/driver.html?testName=imaging-darkroom) 22:27:47 INFO - PID 9688 | RSS: Main: 170188800 22:27:47 INFO - PID 9688 | 22:27:51 INFO - PID 9688 | Cycle 1(1): loaded http://localhost:53593/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53593/tests/kraken/driver.html?testName=imaging-desaturate) 22:27:51 INFO - PID 9688 | RSS: Main: 167956480 22:27:51 INFO - PID 9688 | 22:27:54 INFO - PID 9688 | Cycle 1(1): loaded http://localhost:53593/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53593/tests/kraken/driver.html?testName=json-parse-financial) 22:27:55 INFO - PID 9688 | RSS: Main: 169164800 22:27:55 INFO - PID 9688 | 22:27:56 INFO - PID 9688 | Cycle 1(1): loaded http://localhost:53593/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53593/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:27:57 INFO - PID 9688 | RSS: Main: 168841216 22:27:57 INFO - PID 9688 | 22:27:59 INFO - PID 9688 | Cycle 1(1): loaded http://localhost:53593/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53593/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:28:00 INFO - PID 9688 | RSS: Main: 169189376 22:28:00 INFO - PID 9688 | 22:28:02 INFO - PID 9688 | Cycle 1(1): loaded http://localhost:53593/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53593/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:28:02 INFO - PID 9688 | RSS: Main: 168734720 22:28:02 INFO - PID 9688 | 22:28:05 INFO - PID 9688 | Cycle 1(1): loaded http://localhost:53593/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:28:06 INFO - PID 9688 | RSS: Main: 168857600 22:28:06 INFO - PID 9688 | 22:28:09 INFO - PID 9688 | Cycle 1(1): loaded http://localhost:53593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:28:10 INFO - PID 9688 | RSS: Main: 168878080 22:28:10 INFO - PID 9688 | 22:28:11 INFO - PID 9688 | Cycle 1(1): loaded http://localhost:53593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53593/tests/kraken/driver.html?testName=ai-astar) 22:28:12 INFO - PID 9688 | RSS: Main: 170344448 22:28:12 INFO - PID 9688 | 22:28:12 INFO - PID 9688 | __start_tp_report 22:28:12 INFO - PID 9688 | _x_x_mozilla_page_load 22:28:12 INFO - PID 9688 | _x_x_mozilla_page_load_details 22:28:12 INFO - PID 9688 | |i|pagename|runs| 22:28:12 INFO - PID 9688 | |0;ai-astar;107;115;115;112;113;113;113;112;111;114 22:28:12 INFO - PID 9688 | |1;audio-beat-detection;154;133;128;174;127;129;125;123;146;124 22:28:12 INFO - PID 9688 | |2;audio-dft;164;164;162;163;163;167;171;165;165;163 22:28:12 INFO - PID 9688 | |3;audio-fft;74;75;75;112;76;76;75;75;97;74 22:28:12 INFO - PID 9688 | |4;audio-oscillator;83;83;106;83;83;84;96;83;83;102 22:28:12 INFO - PID 9688 | |5;imaging-gaussian-blur;114;116;114;114;114;114;114;114;114;117 22:28:12 INFO - PID 9688 | |6;imaging-darkroom;150;151;150;152;150;151;150;151;151;149 22:28:12 INFO - PID 9688 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;94;95 22:28:12 INFO - PID 9688 | |8;json-parse-financial;54;53;52;54;56;55;55;55;55;56 22:28:12 INFO - PID 9688 | |9;json-stringify-tinderbox;56;57;56;56;55;55;56;56;59;55 22:28:12 INFO - PID 9688 | |10;stanford-crypto-aes;91;82;83;82;82;83;81;82;82;83 22:28:12 INFO - PID 9688 | |11;stanford-crypto-ccm;141;133;133;136;136;148;136;132;178;132 22:28:12 INFO - PID 9688 | |12;stanford-crypto-pbkdf2;189;197;194;196;192;195;214;195;186;194 22:28:12 INFO - PID 9688 | |13;stanford-crypto-sha256-iterative;75;76;78;72;80;77;73;75;73;74 22:28:12 INFO - PID 9688 | __end_tp_report 22:28:12 INFO - PID 9688 | __start_cc_report 22:28:12 INFO - PID 9688 | _x_x_mozilla_cycle_collect,760 22:28:12 INFO - PID 9688 | __end_cc_report 22:28:12 INFO - PID 9688 | __startTimestamp1495085292087__endTimestamp 22:28:12 INFO - PID 9688 | 22:28:12 INFO - PID 9688 | ------- Summary: start ------- 22:28:12 INFO - PID 9688 | Number of tests: 14 22:28:12 INFO - PID 9688 | 22:28:12 INFO - PID 9688 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:2.32 (2.1%) stddev-sans-first:1.36 22:28:12 INFO - PID 9688 | Values: 107.0 115.0 115.0 112.0 113.0 113.0 113.0 112.0 111.0 114.0 22:28:12 INFO - PID 9688 | 22:28:12 INFO - PID 9688 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:131.00 stddev:16.68 (12.7%) stddev-sans-first:16.42 22:28:12 INFO - PID 9688 | Values: 154.0 133.0 128.0 174.0 127.0 129.0 125.0 123.0 146.0 124.0 22:28:12 INFO - PID 9688 | 22:28:12 INFO - PID 9688 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:2.63 (1.6%) stddev-sans-first:2.77 22:28:12 INFO - PID 9688 | Values: 164.0 164.0 162.0 163.0 163.0 167.0 171.0 165.0 165.0 163.0 22:28:12 INFO - PID 9688 | 22:28:12 INFO - PID 9688 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:12.95 (17.3%) stddev-sans-first:13.49 22:28:12 INFO - PID 9688 | Values: 74.0 75.0 75.0 112.0 76.0 76.0 75.0 75.0 97.0 74.0 22:28:12 INFO - PID 9688 | 22:28:12 INFO - PID 9688 | [#4] audio-oscillator Cycles:10 Average:88.60 Median:83.00 stddev:9.11 (11.0%) stddev-sans-first:9.43 22:28:12 INFO - PID 9688 | Values: 83.0 83.0 106.0 83.0 83.0 84.0 96.0 83.0 83.0 102.0 22:28:12 INFO - PID 9688 | 22:28:12 INFO - PID 9688 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:1.08 (0.9%) stddev-sans-first:1.13 22:28:12 INFO - PID 9688 | Values: 114.0 116.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 117.0 22:28:12 INFO - PID 9688 | 22:28:12 INFO - PID 9688 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 22:28:12 INFO - PID 9688 | Values: 150.0 151.0 150.0 152.0 150.0 151.0 150.0 151.0 151.0 149.0 22:28:12 INFO - PID 9688 | 22:28:12 INFO - PID 9688 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:28:12 INFO - PID 9688 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 22:28:12 INFO - PID 9688 | 22:28:12 INFO - PID 9688 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:1.27 (2.3%) stddev-sans-first:1.33 22:28:12 INFO - PID 9688 | Values: 54.0 53.0 52.0 54.0 56.0 55.0 55.0 55.0 55.0 56.0 22:28:12 INFO - PID 9688 | 22:28:12 INFO - PID 9688 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:1.20 (2.1%) stddev-sans-first:1.27 22:28:12 INFO - PID 9688 | Values: 56.0 57.0 56.0 56.0 55.0 55.0 56.0 56.0 59.0 55.0 22:28:12 INFO - PID 9688 | 22:28:12 INFO - PID 9688 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:82.50 stddev:2.85 (3.4%) stddev-sans-first:0.67 22:28:12 INFO - PID 9688 | Values: 91.0 82.0 83.0 82.0 82.0 83.0 81.0 82.0 82.0 83.0 22:28:12 INFO - PID 9688 | 22:28:12 INFO - PID 9688 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:136.00 stddev:14.07 (10.3%) stddev-sans-first:14.92 22:28:12 INFO - PID 9688 | Values: 141.0 133.0 133.0 136.0 136.0 148.0 136.0 132.0 178.0 132.0 22:28:12 INFO - PID 9688 | 22:28:12 INFO - PID 9688 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.20 Median:195.00 stddev:7.41 (3.8%) stddev-sans-first:7.51 22:28:12 INFO - PID 9688 | Values: 189.0 197.0 194.0 196.0 192.0 195.0 214.0 195.0 186.0 194.0 22:28:12 INFO - PID 9688 | 22:28:12 INFO - PID 9688 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.30 Median:75.50 stddev:2.50 (3.3%) stddev-sans-first:2.65 22:28:12 INFO - PID 9688 | Values: 75.0 76.0 78.0 72.0 80.0 77.0 73.0 75.0 73.0 74.0 22:28:12 INFO - PID 9688 | -------- Summary: end -------- 22:28:12 INFO - PID 9688 | 22:28:13 INFO - TEST-INFO | 9688: exit 0 22:28:13 INFO - TEST-OK | kraken | took 62735ms 22:28:13 INFO - SUITE-END | took 1180s 22:28:13 INFO - Completed test suite (00:19:40) 22:28:13 INFO - javascript benchmark 22:28:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6724.076904382265, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2686.4224191798767, 2700.9054683086097, 2716.8369897806133, 2733.152722655977, 2735.193118030181, 5263.3683957925, 5314.256004159421, 5318.46815318468, 5319.867003324919, 5355.491228333307, 5267.47325267473, 5285.392179899312, 5347.491988261109, 5359.598030147745, 5404.135338345865, 4500.729956202622, 4704.929426058612, 4706.788194531237, 4729.2433210686295, 4731.053789242148, 4744.952550474485, 4791.520847915215, 4796.712197268158, 4804.663673542854, 4810.206315957863, 4657.347971284023, 4713.835015774432, 4742.691725037862, 4777.116233496779, 4788.401449818773, 4753.667243292971, 4754.500777418356, 4756.0, 4771.308160316735, 4798.592119669832, 4665.46347170073, 4705.952940470585, 4707.741074240916, 4712.269598212282, 4722.8110875564935, 5201.505856943622, 5272.393674727417, 5284.180951952453, 5300.92048619271, 5349.7057661828585, 5751.827445176651, 5765.0, 5778.479936805707, 5799.39106393831, 5839.708014599296, 5779.88440231193, 5810.941890581124, 5822.0684690449325, 5834.4165583441745, 5836.5914385993, 5249.42256351801, 5290.497402746733, 5359.410464848864, 5376.086065368897, 5392.56859451243, 5968.16445697594, 5996.040633498619, 5998.790042348497, 6006.069059295816, 6025.18659980897, 5674.602777805514, 5680.6591604503865, 5682.090865461506, 5686.545076393962, 5728.255326807488, 5618.073017951992, 5618.438156184349, 5686.175504551817, 5741.8564535886935, 5765.019946609086, 5759.65442073477, 5765.279340082489, 5772.94227057724, 5801.564882633735, 5825.359210486928, 5684.943150568524, 5697.800576979786, 5743.0811070228565, 5751.252337196138, 5787.450192231731, 4446.599806017409, 4488.147252022105, 4489.618382437529, 4514.864554063383, 4519.960409105924, 3869.5936926622862, 3886.650201481824, 3891.163399868985, 3928.0965377962657, 3929.390944403622, 4818.638602104857, 4847.5394837490385, 4899.58353539946, 4910.975445122752, 4920.335754673145, 5786.884262314814, 5813.563982701315, 5840.737166827503, 5878.5003274721275, 5879.353271140171, 4867.902641947141, 4870.732109733999, 4870.756462176877, 4893.486183950705, 4930.975345123323, 5059.949400506021, 5087.389513258433, 5129.9743501283, 5130.7947682093045, 5143.3827940646615, 5367.919481207707, 5376.73116344189, 5380.246765452918, 5406.5945054121885, 5422.996745602076, 5792.478676919098, 5842.561807864342, 5842.941570584239, 5849.64902105875, 5852.531797456279, 5317.335333083364, 5353.946460535501, 5355.55632764693, 5359.3032905722, 5398.217258497574, 5667.631603945731, 5732.7706891723865, 5758.0, 5759.65442073477, 5762.654240745569, 5823.4467725566, 5824.475797178275, 5832.883342333044, 5875.911861322169, 5887.764489420375, 5443.8094666686475, 5580.274564306615, 5629.831105066854, 5657.547396208376, 5675.971620141873, 5619.297587801525, 5622.465865742748, 5626.35296940857, 5659.830205093854, 5678.97778399892, 5506.421825708243, 5507.669539827623, 5511.917321240265, 5534.086875665631, 5585.581081418991, 5647.830565083054, 5679.602427830012, 5690.487856092972, 5694.943050569607, 5731.426857314235, 5404.513593776579, 5447.673139611636, 5460.972695136499, 5479.671219726829, 5484.067708489487], "value": 5200.639504313037, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.1655638068888, 739.6745432009915, 756.8788993760998, 1071.646356702288, 1087.9782404351918, 31001.0, 32542.67457325426, 32551.67448325516, 32677.836610816972, 32752.836235818846, 33723.66276337236, 34061.14847128823, 34174.31651366971, 34223.4866477003, 34260.31479370417, 6819.829504262383, 6851.657417129149, 6972.047826608557, 7002.194747604014, 7021.403180729644, 7010.894836577456, 7045.964770176142, 7047.577145371269, 7059.541129826544, 7076.044733960926, 7046.1192350956135, 7065.32879376461, 7077.044598979123, 7115.252898445667, 7124.0, 7016.684249208798, 7027.789166325018, 7057.647117644123, 7079.469039821983, 7102.786916392516, 6953.79138625842, 6992.475564332695, 7021.0, 7026.613536255504, 7036.155661320623, 31453.0, 31567.52648710271, 31598.368032639217, 31687.0, 31730.841345793353, 3061.2959019425657, 3068.769842261817, 3076.507758758588, 3082.4143412751505, 3099.7210251077286, 24961.87519062393, 25027.749722502725, 25053.62419563708, 25071.62392564113, 25099.37251568707, 2992.7755418343713, 2997.385535965122, 3014.427258820817, 3014.713602207809, 3015.9396812063637, 144846.2757686205, 145535.27232363875, 153469.23265383602, 155785.22107389505, 157154.0, 39664.0, 39853.80073099616, 39865.60134398677, 39867.20265594672, 39905.0, 41258.79370603188, 41366.1726765463, 41540.376894346606, 41575.0, 41680.79159604243, 12210.816837747441, 12293.631191064282, 12326.445309961073, 12348.814767778491, 12350.197237179555, 9693.61225550984, 9713.90286097144, 9717.222622190207, 9723.124918757347, 9782.706518804447, 12603.0, 12664.240145591293, 12707.301098439675, 12747.808782868264, 12854.871451285368, 5257.947420525746, 5332.0, 5341.759620817073, 5408.567314614821, 5494.340679118532, 798.0503201190564, 840.1472505407016, 854.2994744309607, 871.2681347667863, 880.2737741363401, 19346.129424175946, 19856.305029323903, 19949.501262468555, 20162.395128146178, 20776.0, 904.5929331800716, 922.5710044829186, 938.0338251600862, 943.8725772020827, 945.7068308824287, 10165.0, 10319.864814870358, 10651.09465695409, 10722.517486713117, 10807.621733239299, 176689.0, 178407.0, 179534.0, 180158.0, 180327.0, 40455.59544404577, 40491.39262911059, 40817.591824081974, 41184.38223426651, 41205.1758964819, 1214.1925619462959, 1255.7425727725795, 1259.8929091027364, 1272.8599854016052, 1274.9808752868714, 18714.625707485502, 19168.27843331253, 19744.0, 20037.899810500854, 20371.287004954756, 29586.556201656564, 29902.70097298999, 30034.3993120132, 30070.0, 30084.0, 146719.0, 147275.0, 147408.0, 147918.26040869727, 148366.0, 28688.13935581936, 28890.0, 29263.0, 29271.70728292775, 29345.413091738472, 34214.48678269778, 34306.65693343035, 35491.290174195856, 35593.64406355903, 35901.0, 27234.319142021606, 27670.72329276762, 27849.0, 28617.713822862337, 28821.27946801347, 26323.868380657976, 28115.0, 28151.43697126005, 28375.858120709265, 29915.850420747756, 30016.24959376033, 31404.0, 31494.527582086746, 31724.682753172172, 32047.519287211177, 27015.324616884736, 27620.585691214244, 27668.0, 27673.584896226974, 28844.567331489623, 21939.341819745434, 22693.43266418353, 22784.0, 22865.19971800979, 23050.308490745305], "value": 14414.165500789424, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.37636357282287, 415.63424186715685, 423.68435515540915, 438.56362918895695, 441.0781466734524, 14794.482193123244, 16909.23908424121, 17670.116494175287, 17675.46973590791, 17851.46445606634, 17981.730274045898, 18271.817281827178, 18294.542636434096, 18382.448526544224, 18426.81573184268, 5195.272661827347, 5213.139831927746, 5411.053065713504, 5443.319585051869, 5446.2919820423485, 5326.067938110815, 5406.0, 5408.945910540903, 5420.83737487874, 5422.267993820823, 5202.739863006854, 5357.142857142858, 5369.9463005369835, 5388.811391601294, 5391.487808658171, 5333.54664853486, 5335.759890804904, 5339.0, 5376.247325374451, 5383.380911195223, 4683.672142949995, 4859.41686997559, 4878.219484882402, 4879.756012199376, 4891.217405215184, 21097.15611375543, 21255.893720531454, 21302.680459793115, 21312.46718832026, 21346.0, 1556.0741358891441, 1604.4865642994246, 1605.8153312368993, 1606.9357225710958, 1607.8954867933546, 14124.929375353058, 14489.985701000935, 14493.202873841934, 14654.780178297335, 14842.554723358317, 2029.3201777404588, 2047.2425202674956, 2081.115525901501, 2082.5730725201447, 2090.205721825712, 80194.0, 80441.59779201125, 81099.0, 82035.17964820335, 82304.58847705723, 10616.681499555025, 10954.561817527368, 11158.853842515307, 11210.0, 11313.547458101584, 15150.924245378703, 15338.469152589698, 15352.925295229226, 15445.845541544666, 15457.38170473191, 6881.931180688129, 6884.1050663414435, 7066.505344625827, 7074.7170113195925, 7090.255523170096, 6020.277566692025, 6064.211652485237, 6150.269575110021, 6236.376362363818, 6258.499320054385, 6954.269801670752, 6954.374106330454, 6963.164420269499, 7037.7184912602925, 7105.609191494517, 1957.2953736654792, 1990.3133418970433, 2014.103723842905, 2024.7975202479633, 2038.2967876082728, 830.5390508267969, 871.4292138649195, 871.6121326009992, 874.881890944727, 899.2131884600974, 16730.247138878778, 17047.14764261782, 17066.31734730597, 17167.914160429118, 17879.821201787814, 859.3683642522741, 862.6678728689375, 865.6450855149359, 872.5549969515466, 888.5290795878195, 9263.027382124914, 9406.670766523139, 9811.215102791759, 9841.753956151011, 9877.40735555869, 349504.0, 351871.0, 354260.0, 386839.0, 397328.0, 77707.61146194233, 80383.59808200922, 80643.59678201571, 82615.0, 82735.0, 1075.5805235957982, 1096.5504143301048, 1121.556984990924, 1126.774645070989, 1131.8924702153283, 17004.0, 17310.221040052977, 17715.468535943943, 17972.460826175236, 18379.081045947918, 38160.80919595384, 38354.61645383511, 38796.22407551777, 39633.80183099066, 39658.2068358637, 48590.51409486002, 48712.51287487221, 49069.75465122652, 49308.26037609367, 50786.0, 8076.152004039492, 8180.590970451334, 8214.301784348158, 8284.668613255402, 8546.914530854861, 11974.341411222467, 12060.577879774166, 12176.634700958986, 12522.0, 13107.475700971854, 10764.946175269073, 10779.0, 10937.890621093688, 10995.175361847734, 11108.0, 10080.798384032132, 10302.896971030494, 10309.123724483203, 10315.381077135396, 10421.062104410335, 10465.529051192563, 11098.722531936766, 11335.319880807177, 11350.489227984595, 11367.261128026652, 8136.796580085545, 8306.501609903426, 8382.622781974947, 8436.831263374575, 8664.48013119215, 10811.13510919109, 10864.945675271572, 11119.944400278271, 11256.0, 11273.943630282125], "value": 8728.33162745942, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1200.2738343302303, 1247.232951734683, 1265.1649911058703, 1267.1573403686548, 1273.3824095313778, 10131.69604911852, 10489.475526223678, 10545.103666188374, 10573.577056917733, 10758.085562727178, 10527.947360263208, 10684.78630427393, 10740.570377184922, 10743.785124297528, 10761.408122553257, 2269.4893648928983, 2271.681964524968, 2290.1869836208157, 2304.9423764405856, 2311.503026849227, 2143.07847625521, 2203.9449013774624, 2205.6691496275607, 2209.0, 2215.9113635454564, 2187.6937228787983, 2192.9561408771897, 2231.419830843984, 2242.2040175737625, 2250.8199344052437, 2132.3389749177804, 2151.505153814616, 2195.3084778294788, 2197.28588208832, 2207.8012978831903, 1957.4127761671584, 2126.33020598511, 2131.211451762842, 2150.0754675489534, 2154.4183070570857, 10060.899391006069, 10132.34139780912, 10135.44255065971, 10144.594216231342, 10150.949245253727, 5613.691246981414, 5793.0, 5796.739146738407, 5800.738966746507, 5807.767689292423, 3325.6341802401716, 3556.928861422783, 3606.0804494853905, 3610.945835812465, 3623.058004918714, 1053.873535175784, 1091.579741799405, 1107.983380249297, 1109.545086514525, 1119.8936101070385, 15123.848761512354, 15239.238038098161, 15271.160086195256, 15282.465113721077, 15308.693826123415, 4688.46082700487, 4786.688865223749, 4942.110420124341, 5039.596832253411, 5089.618278629117, 10469.267151299337, 10470.790584188426, 10474.162067034618, 10489.737756556147, 10500.47497625131, 5694.288213973254, 5697.772089116472, 5699.914501282484, 5705.229793977843, 5706.3152421709665, 5036.244563315532, 5280.577553795687, 5285.445028272053, 5300.469953004746, 5312.893742125136, 3850.3646898261472, 3901.9219615608095, 3956.7032472564097, 3975.6421922027157, 4031.8992025199605, 1113.287496002559, 1122.966311010671, 1126.9774604507863, 1132.9490172942237, 1143.1940481960198, 675.76010516267, 700.4816435837546, 704.5737328916034, 713.8037039813989, 719.2016861283971, 5162.432132465426, 5311.49540793624, 5359.437259087817, 5411.56707463402, 5444.891102177934, 832.7168762620738, 844.8225872566829, 854.7649396416035, 859.3554833874595, 863.5509535041743, 3673.7061035117126, 3695.6119607440833, 3761.586225515191, 3782.0733920189728, 3889.2415978883846, 12903.935480322538, 13322.20066795976, 13333.133346332457, 13671.043026988016, 13692.589222323346, 13278.468861245636, 13465.798013029813, 13574.59276221715, 13588.184708917497, 13713.382897769625, 7690.807729806687, 7712.6529306181355, 7810.765677029698, 7819.966808629683, 7852.5288482690075, 5787.56593255516, 5803.187553742564, 5881.3236477803885, 5984.551158663205, 6048.969755151196, 11384.032357249727, 11409.486573104065, 11487.94256028748, 11691.590794322157, 12268.938655307024, 12152.635420937386, 12256.938715306367, 12398.690032749253, 12405.317707526172, 12427.31649759272, 8329.6668133274, 8521.957390213009, 8619.439736417113, 8628.654853805778, 8643.351748619005, 9405.482698451651, 9567.234621230424, 9618.51907404641, 9656.0, 9672.56473458682, 7914.802129946797, 7948.960255198687, 7953.443258971816, 7995.960020199862, 8357.582120893809, 8119.269265766109, 8217.342612590859, 8247.711330103417, 8438.071812100541, 8491.532965686947, 7559.962200189184, 7619.123800762984, 7632.1604623492485, 7684.077910650758, 7718.459707820399, 5359.758810853599, 5396.298481197419, 5437.728113594384, 5449.100898351728, 5565.638233514808, 5298.7350632469, 5378.435264297193, 5433.0, 5479.808206712746, 5573.442655734556], "value": 4786.011138573088, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.9572249191342, 393.49435974772416, 393.76767707052835, 395.73683500472185, 398.8723608445298, 5485.945140548603, 5637.0, 5662.716864156796, 5663.178839068332, 5668.971655141724, 5413.675179489233, 5451.454854514546, 5466.835994920149, 5471.838623743619, 5483.232347471348, 4081.510218773751, 4082.0815316553685, 4088.625171066945, 4100.815463304159, 4114.37482194533, 4056.7565946043333, 4061.6953728470335, 4086.16233672098, 4112.773797441139, 4132.710710250284, 4046.3496409851596, 4050.8987275318204, 4060.7157498975084, 4067.2475592015426, 4080.4491393661774, 4068.7558746475156, 4072.3687828386646, 4075.49056367954, 4078.347464405681, 4082.7340825841648, 3543.6080645564143, 3545.2377738786026, 3551.254236610315, 3556.87550935716, 3558.466230065485, 5321.760520776575, 5333.546648534879, 5367.35591728995, 5373.865653358658, 5377.247185394009, 4763.76181190939, 4834.589059929875, 4841.878953026167, 4845.951540484585, 4850.927236091461, 5611.466910643482, 5804.129380592903, 5812.476877081083, 5846.0, 5868.0, 4032.818523166435, 4045.4538637284177, 4046.8381264749373, 4056.188762247533, 4063.6952228582677, 6002.579819412643, 6181.320054793969, 6184.690765461709, 6187.925900761423, 6269.153664255313, 4111.814968326433, 4126.855560055384, 4132.958670413317, 4141.5237247716295, 4149.97925010373, 4210.0948296116485, 4215.831366745296, 4218.535961044283, 4221.915561688749, 4222.535521092677, 4749.738764367924, 4799.112164249625, 4874.658773885865, 4882.609391248691, 4884.3161957326, 5843.5909486336395, 5853.443922827325, 5853.590248682552, 5862.618929769551, 5866.823995280149, 1427.7858321251895, 1449.4926775628446, 1459.241194578813, 1460.7589747691725, 1468.4493315006873, 961.3174646001418, 964.3442459127721, 964.7346979580672, 966.8694726211871, 978.1490103609763, 5003.0, 5004.224345226496, 5004.724740139254, 5044.798208071709, 5064.949350506521, 6059.909101363483, 6062.636241825505, 6072.483838873657, 6082.118092876508, 6095.116208149793, 4935.3090567320605, 4951.356323677971, 5008.724520151354, 5024.191291135188, 5028.195488721787, 3195.7123858852815, 3202.7277681396877, 3217.1957010747315, 3217.7104060634188, 3228.838558072087, 5322.92015619766, 5540.750666220029, 5560.165975103767, 5560.610757247035, 5561.4716601922755, 6235.657038862906, 6250.249970003629, 6265.122882796412, 6277.2153480814895, 6310.1796766420075, 5592.273004509388, 5594.580406469531, 5607.635503692329, 5621.8594535136945, 5631.436856314418, 5822.57346949983, 6012.518998480198, 6087.9605332214205, 6106.1146133811235, 6147.293061297829, 5842.678652674143, 5996.760129594942, 5999.39056981706, 6003.769227308479, 6005.837898356501, 5520.199571062254, 5573.637713548606, 5591.440855914376, 5596.636218645775, 5610.18652295423, 4124.958750412457, 4145.0880806222585, 4148.004478924976, 4153.626173644387, 4158.189153115113, 5983.0, 6077.20996270482, 6123.510119190365, 6148.754049837957, 6175.382461753788, 5900.970495147497, 5903.439173278532, 5903.675297858487, 5909.163601471232, 5928.199693041384, 5844.47399734026, 5867.706614669164, 5909.0, 5926.318473375617, 5943.732532036155, 5747.3103227612955, 5825.5338073846, 5844.590878638624, 5852.678102704393, 5868.823935281948, 5904.439078287556, 5930.940690593211, 5956.642601443928, 5958.344582096052, 5967.46292833647, 5621.606487545996, 5649.237352957298, 5702.37273899879, 5727.770889164553, 5770.163326317576], "value": 4355.898294748224, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.0910834132312, 721.8159369360814, 730.5689643110563, 732.5421611492816, 737.0933751485672, 11678.708032299175, 12131.211471254363, 13065.73868522629, 13939.442422303122, 13958.092723972935, 13276.800847987264, 14511.129332240072, 15250.618734531643, 15311.770323445156, 15345.156016419092, 824.6701319472214, 848.6266042941086, 851.1956201389689, 851.3870013590205, 854.5001174313003, 895.1943251074052, 896.7264984179823, 896.9910300897005, 899.0470101692194, 899.1233547291404, 944.1078181118845, 946.2666433514013, 946.3706635087658, 947.554649314821, 948.7390967483963, 922.9584668689926, 924.2236521322054, 925.2597921662643, 930.0467021303184, 930.1070971867016, 686.5297271369128, 691.0981169573704, 691.4744793956579, 691.6265216782981, 692.944564434844, 14025.929870350685, 14166.433342666282, 14683.0, 15151.318190681446, 15357.692846143127, 15233.923830380889, 15465.690686186326, 15633.0, 15639.765403518957, 15953.0, 11751.529938802438, 11803.468843902045, 11815.232009919328, 12385.938070309681, 12514.18657787241, 2689.623452716621, 2690.246730915327, 2699.068821256683, 2699.4601079783924, 2708.377073273158, 69874.0, 70343.64828175929, 70866.0, 70981.29018709798, 72696.27303726948, 11752.412379380996, 11775.293482391084, 11838.585649502225, 12008.459619317151, 12067.939660301818, 21917.671234931488, 21947.231846885603, 22123.115075396803, 22123.225687100876, 22162.88918555429, 6109.694515274218, 6132.2947860996555, 6242.344553821874, 6269.968650156811, 6368.29948705642, 2943.2788966703297, 3004.143819011615, 3014.788964772445, 3043.1174959262007, 3048.8628011739524, 3411.113110591264, 3445.776024558446, 3460.2214501736908, 3471.9132021699156, 3472.618012018676, 729.7701224114387, 745.530315900979, 751.5903832411349, 752.0, 755.2560727683227, 590.3653572409677, 596.1118381441908, 600.7236671131241, 606.7360698096343, 625.1997443272618, 9368.344215904957, 9853.950730246303, 9997.950010249902, 10136.44249566281, 10410.739731506621, 557.4620491225986, 565.1579147070835, 567.7445149682659, 569.3281927325712, 571.2773341722724, 4073.409355643415, 4215.367694845736, 4249.277622804131, 4259.616634502848, 4374.693771436033, 66195.33804661891, 66570.0086992173, 67577.66211168913, 67853.66073169603, 68177.65911170412, 53917.73041134769, 53931.73034134804, 54074.0, 55261.0, 56197.43802562004, 52170.21744673909, 52467.73766131145, 52955.0, 53290.46709532855, 53323.733381332844, 8192.54940978252, 8348.791280218044, 8414.6213420395, 8457.450265732708, 8664.393492455467, 27519.724802751716, 27734.861325694048, 27884.16347509578, 28104.330088641545, 28306.15081547557, 32436.35127297488, 32902.67097328996, 33662.49506257457, 45686.0, 46435.071298573166, 13776.380062896993, 14366.13803171813, 14390.712185756016, 14449.638759031108, 14646.26768661584, 15942.123183225034, 16171.353145874033, 16218.594535136715, 16239.10684912294, 16253.268602913135, 13172.275524845842, 13910.026298159437, 14224.14655120696, 14334.928325358724, 14371.209583472591, 13846.446142154604, 14145.43418263258, 14341.92829035848, 14506.1296322221, 14715.467287405449, 13083.738325233251, 13416.597502074954, 13435.790778829953, 13468.0, 13936.372863220977, 10137.543810528396, 10245.180385569285, 10560.788784224425, 11040.5031773572, 11068.833967490333, 10791.892081079088, 11525.654230373102, 11543.826842597537, 11610.12924030718, 11616.419179041182], "value": 6775.427468999252, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 115.0, 112.0, 113.0, 113.0, 113.0, 112.0, 111.0, 114.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 133.0, 128.0, 174.0, 127.0, 129.0, 125.0, 123.0, 146.0, 124.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 163.0, 163.0, 167.0, 171.0, 165.0, 165.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 112.0, 76.0, 76.0, 75.0, 75.0, 97.0, 74.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 106.0, 83.0, 83.0, 84.0, 96.0, 83.0, 83.0, 102.0], "value": 88.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 117.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 152.0, 150.0, 151.0, 150.0, 151.0, 151.0, 149.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 54.0, 56.0, 55.0, 55.0, 55.0, 55.0, 56.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 56.0, 55.0, 55.0, 56.0, 56.0, 59.0, 55.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 82.0, 83.0, 82.0, 82.0, 83.0, 81.0, 82.0, 82.0, 83.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 133.0, 133.0, 136.0, 136.0, 148.0, 136.0, 132.0, 178.0, 132.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 197.0, 194.0, 196.0, 192.0, 195.0, 214.0, 195.0, 186.0, 194.0], "value": 195.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 78.0, 72.0, 80.0, 77.0, 73.0, 75.0, 73.0, 74.0], "value": 75.3, "unit": "score"}]}]} 22:28:13 INFO - Return code: 0 22:28:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:28:13 INFO - # TBPL SUCCESS # 22:28:13 INFO - Running post-action listener: _resource_record_post_action 22:28:13 INFO - [mozharness: 2017-05-18 05:28:13.368676Z] Finished run-tests step (success) 22:28:13 INFO - Running post-run listener: _resource_record_post_run 22:28:13 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 415346688; Read time: 8; Write time: 284628 22:28:13 INFO - TinderboxPrint: CPU usage
13.3% 22:28:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 22:28:13 INFO - TinderboxPrint: I/O write bytes / time
415,346,688 / 284,628 22:28:13 INFO - TinderboxPrint: CPU idle
8,289.3 (86.7%) 22:28:13 INFO - TinderboxPrint: CPU user
1,213.6 (12.7%) 22:28:13 INFO - TinderboxPrint: Swap in / out
0 / 0 22:28:13 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 97558528; Read time: 0; Write time: 78148 22:28:13 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 317214720; Read time: 0; Write time: 206452 22:28:14 INFO - Running post-run listener: _upload_blobber_files 22:28:14 INFO - Blob upload gear active. 22:28:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:28:14 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 22:28:14 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'] 22:28:14 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 22:28:14 INFO - (blobuploader) - INFO - Open directory for files ... 22:28:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:28:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:28:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:15 INFO - (blobuploader) - INFO - Done attempting. 22:28:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:28:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:28:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:16 INFO - (blobuploader) - INFO - Done attempting. 22:28:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:28:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:28:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:16 INFO - (blobuploader) - INFO - Done attempting. 22:28:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:28:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:28:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:20 INFO - (blobuploader) - INFO - Done attempting. 22:28:20 INFO - (blobuploader) - INFO - Iteration through files over. 22:28:20 INFO - Return code: 0 22:28:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:28:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:28:20 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2d5c43033a6998af103a3489359fcde0625d4d283cdda2f6942e28fe982c8e35d56a914a98e221a1ff8362f981a5e5c959c1c1d707522e948ea3389e6c5c1c6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/268ba20750769c36e533f22e4ccc6484c08c1e927e6a853514ab85fec0413b77d4c0e7c65c9dd6e281a77874eb89bf3666925ceb0bd235f6b0ad8599419a2e10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd1a5f7d8a3b0d54e21cd3525c22b69c00b589121fd08fc981d442fedc90b39d3d80c2b9a944a61ade1b38d1581eae0a441258d94a84db360763a76168f1994e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/467335ff804d15de9053d98808e245d188407ae7a7030f562b0331aceb332068cd3a23940b3fb733478429b8e3b33dab25ba93ec9c9f91539233477a17297981"} 22:28:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:28:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:28:20 INFO - Contents: 22:28:20 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2d5c43033a6998af103a3489359fcde0625d4d283cdda2f6942e28fe982c8e35d56a914a98e221a1ff8362f981a5e5c959c1c1d707522e948ea3389e6c5c1c6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/268ba20750769c36e533f22e4ccc6484c08c1e927e6a853514ab85fec0413b77d4c0e7c65c9dd6e281a77874eb89bf3666925ceb0bd235f6b0ad8599419a2e10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd1a5f7d8a3b0d54e21cd3525c22b69c00b589121fd08fc981d442fedc90b39d3d80c2b9a944a61ade1b38d1581eae0a441258d94a84db360763a76168f1994e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/467335ff804d15de9053d98808e245d188407ae7a7030f562b0331aceb332068cd3a23940b3fb733478429b8e3b33dab25ba93ec9c9f91539233477a17297981"} 22:28:20 INFO - Running post-run listener: copy_logs_to_upload_dir 22:28:20 INFO - Copying logs to upload dir... 22:28:20 INFO - mkdir: /builds/slave/test/build/upload/logs 22:28:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.984361 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-17 22:28:19.335275) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-17 22:28:19.338924) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2d5c43033a6998af103a3489359fcde0625d4d283cdda2f6942e28fe982c8e35d56a914a98e221a1ff8362f981a5e5c959c1c1d707522e948ea3389e6c5c1c6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/268ba20750769c36e533f22e4ccc6484c08c1e927e6a853514ab85fec0413b77d4c0e7c65c9dd6e281a77874eb89bf3666925ceb0bd235f6b0ad8599419a2e10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd1a5f7d8a3b0d54e21cd3525c22b69c00b589121fd08fc981d442fedc90b39d3d80c2b9a944a61ade1b38d1581eae0a441258d94a84db360763a76168f1994e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/467335ff804d15de9053d98808e245d188407ae7a7030f562b0331aceb332068cd3a23940b3fb733478429b8e3b33dab25ba93ec9c9f91539233477a17297981"} build_url:https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/cXaURRPmTlKd_UcwqZ_aYA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2d5c43033a6998af103a3489359fcde0625d4d283cdda2f6942e28fe982c8e35d56a914a98e221a1ff8362f981a5e5c959c1c1d707522e948ea3389e6c5c1c6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/268ba20750769c36e533f22e4ccc6484c08c1e927e6a853514ab85fec0413b77d4c0e7c65c9dd6e281a77874eb89bf3666925ceb0bd235f6b0ad8599419a2e10", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bd1a5f7d8a3b0d54e21cd3525c22b69c00b589121fd08fc981d442fedc90b39d3d80c2b9a944a61ade1b38d1581eae0a441258d94a84db360763a76168f1994e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/467335ff804d15de9053d98808e245d188407ae7a7030f562b0331aceb332068cd3a23940b3fb733478429b8e3b33dab25ba93ec9c9f91539233477a17297981"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-17 22:28:19.363586) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 22:28:19.363949) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1495075860.72956-552040842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 22:28:19.446512) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-17 22:28:19.446860) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-17 22:28:19.447182) ========= ========= Total master_lag: 0.16 =========