builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1495105642.64 results: success (0) revision: baf05f61bc14fdf45511bc1165ce76daa08c5c0f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-18 04:07:22.641764) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-18 04:07:22.642436) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-18 04:07:22.642884) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-18 04:07:22.659598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 04:07:22.659982) ========= 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=8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-18 04: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2017-05-18 04:07:23 (42.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.156706 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 04:07:22.830532) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 04:07:22.830869) ========= 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=8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016046 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 04:07:22.881112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-18 04:07:22.881501) ========= 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=8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-18 04:07:23,286 truncating revision to first 12 chars 2017-05-18 04:07:23,287 Setting DEBUG logging. 2017-05-18 04:07:23,287 attempt 1/10 2017-05-18 04:07:23,287 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-18 04:07:24,025 unpacking tar archive at: mozilla-central-baf05f61bc14/testing/mozharness/ program finished with exit code 0 elapsedTime=1.114841 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-18 04:07:24.106642) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-18 04:07:24.107235) ========= script_repo_revision: baf05f61bc14fdf45511bc1165ce76daa08c5c0f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-18 04:07:24.107713) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-18 04:07:24.108006) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-18 04:07:24.118118) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-05-18 04:07:24.118500) ========= /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=8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:07:24 INFO - MultiFileLogger online at 20170518 04:07:24 in /builds/slave/test 04: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 04:07:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:07:24 INFO - {'append_to_log': False, 04:07:24 INFO - 'base_work_dir': '/builds/slave/test', 04:07:24 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:07:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:07:24 INFO - 'branch': 'Firefox-Non-PGO', 04:07:24 INFO - 'buildbot_json_path': 'buildprops.json', 04:07:24 INFO - 'config_files': ('talos/linux_config.py',), 04:07:24 INFO - 'default_actions': ('clobber', 04:07:24 INFO - 'read-buildbot-config', 04:07:24 INFO - 'download-and-extract', 04:07:24 INFO - 'populate-webroot', 04:07:24 INFO - 'create-virtualenv', 04:07:24 INFO - 'install', 04:07:24 INFO - 'run-tests'), 04:07:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:07:24 INFO - 'download_minidump_stackwalk': True, 04:07:24 INFO - 'download_symbols': 'ondemand', 04:07:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:07:24 INFO - 'tooltool.py': '/tools/tooltool.py', 04:07:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:07:24 INFO - '/tools/misc-python/virtualenv.py')}, 04:07:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:07:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:07:24 INFO - 'gecko_profile': False, 04:07:24 INFO - 'gecko_profile_interval': 0, 04:07:24 INFO - 'installer_path': 'installer.exe', 04:07:24 INFO - 'log_level': 'info', 04:07:24 INFO - 'log_name': 'talos', 04:07:24 INFO - 'log_to_console': True, 04:07:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:07:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:07:24 INFO - 'opt_config_files': (), 04:07:24 INFO - 'pip_index': False, 04:07:24 INFO - 'suite': 'dromaeojs-e10s', 04:07:24 INFO - 'system_bits': '32', 04:07:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:07:24 INFO - 'title': 'talos-linux64-ix-001', 04:07:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:07:24 INFO - 'use_talos_json': True, 04:07:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:07:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:07:24 INFO - 'work_dir': 'build'} 04:07:24 INFO - [mozharness: 2017-05-18 11:07:24.627169Z] Running clobber step. 04:07:24 INFO - Running pre-action listener: _resource_record_pre_action 04:07:24 INFO - Running main action method: clobber 04:07:24 INFO - rmtree: /builds/slave/test/build 04:07:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:07:26 INFO - Running post-action listener: _resource_record_post_action 04:07:26 INFO - [mozharness: 2017-05-18 11:07:26.054335Z] Finished clobber step (success) 04:07:26 INFO - [mozharness: 2017-05-18 11:07:26.054433Z] Running read-buildbot-config step. 04:07:26 INFO - Running pre-action listener: _resource_record_pre_action 04:07:26 INFO - Running main action method: read_buildbot_config 04:07:26 INFO - Using buildbot properties: 04:07:26 INFO - { 04:07:26 INFO - "project": "", 04:07:26 INFO - "product": "firefox", 04:07:26 INFO - "who": "nobody@mozilla.org", 04:07:26 INFO - "installer_path": "public/build/target.tar.bz2", 04:07:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:07:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:07:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:07:26 INFO - "stage_platform": "linux64", 04:07:26 INFO - "basedir": "/builds/slave/test", 04:07:26 INFO - "buildnumber": 883, 04:07:26 INFO - "platform": "ubuntu64_hw", 04:07:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:07:26 INFO - "slavebuilddir": "test", 04:07:26 INFO - "taskId": "cBrXvTrEQzGd2qHv8yjmVA", 04:07:26 INFO - "branch": "mozilla-central", 04:07:26 INFO - "script_repo_revision": "production", 04:07:26 INFO - "revision": "baf05f61bc14fdf45511bc1165ce76daa08c5c0f", 04:07:26 INFO - "slavename": "talos-linux64-ix-001", 04:07:26 INFO - "repo_path": "mozilla-central" 04:07:26 INFO - } 04:07:26 INFO - Finding installer, test and symbols from parent task. 04:07:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cBrXvTrEQzGd2qHv8yjmVA'}, attempt #1 04:07:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cBrXvTrEQzGd2qHv8yjmVA'}, attempt #1 04:07:27 INFO - Task dependencies: eSx1ujILQsSaVYkb-6lnbQ 04:07:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ'}, attempt #1 04:07:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.tar.bz2 04:07:27 INFO - Set test_url: https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/test_packages.json 04:07:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.crashreporter-symbols.zip 04:07:27 INFO - Running post-action listener: _resource_record_post_action 04:07:27 INFO - [mozharness: 2017-05-18 11:07:27.510945Z] Finished read-buildbot-config step (success) 04:07:27 INFO - [mozharness: 2017-05-18 11:07:27.511165Z] Running download-and-extract step. 04:07:27 INFO - Running pre-action listener: _resource_record_pre_action 04:07:27 INFO - Running main action method: download_and_extract 04:07:27 INFO - mkdir: /builds/slave/test/build/tests 04:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:07:27 INFO - trying https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.test_packages.json 04:07:27 INFO - Downloading https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:07:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:07:28 INFO - Downloaded 986 bytes. 04:07:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:07:28 INFO - Using the following test package requirements: 04:07:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:07:28 INFO - u'common': [u'target.common.tests.zip'], 04:07:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:07:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:07:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:07:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:07:28 INFO - u'mozbase': [u'target.common.tests.zip'], 04:07:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:07:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:07:28 INFO - u'web-platform': [u'target.common.tests.zip', 04:07:28 INFO - u'target.web-platform.tests.zip'], 04:07:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:07:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:07:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.common.tests.zip 04:07:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:07:28 INFO - Fetch https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.common.tests.zip into memory 04:07:35 INFO - Content-Length response header: 64604203 04:07:35 INFO - Bytes received: 64604203 04:07:45 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:07:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.common.tests.zip 04:07:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:07:45 INFO - Fetch https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.common.tests.zip into memory 04:07:47 INFO - Content-Length response header: 64604203 04:07:47 INFO - Bytes received: 64604203 04:07:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.talos.tests.zip 04:07:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:07:59 INFO - Fetch https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.talos.tests.zip into memory 04:08:00 INFO - Content-Length response header: 14410001 04:08:00 INFO - Bytes received: 14410001 04: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')]} 04:08:00 INFO - trying https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.tar.bz2 04:08:00 INFO - Downloading https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:08:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:08:08 INFO - Downloaded 63582858 bytes. 04:08:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.tar.bz2 04:08:08 INFO - mkdir: /builds/slave/test/properties 04:08:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:08:08 INFO - Writing to file /builds/slave/test/properties/build_url 04:08:08 INFO - Contents: 04:08:08 INFO - build_url:https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.tar.bz2 04:08:08 INFO - Running post-action listener: _resource_record_post_action 04:08:08 INFO - Running post-action listener: set_extra_try_arguments 04:08:08 INFO - [mozharness: 2017-05-18 11:08:08.299532Z] Finished download-and-extract step (success) 04:08:08 INFO - [mozharness: 2017-05-18 11:08:08.299760Z] Running populate-webroot step. 04:08:08 INFO - Running pre-action listener: _resource_record_pre_action 04:08:08 INFO - Running main action method: populate_webroot 04:08:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:08:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:08:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:08:08 INFO - '--tppagecycles', 04:08:08 INFO - '7'], 04:08:08 INFO - 'tests': ['tsvgm']}}, 04:08:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:08:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:08:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:08:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:08:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:08:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:08:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:08:08 INFO - 'talos_options': ['--disable-e10s'], 04:08:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:08:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:08:08 INFO - 'talos_options': ['--disable-e10s'], 04:08:08 INFO - 'tests': ['damp', 'tps']}, 04:08:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:08:08 INFO - 'tests': ['damp', 'tps']}, 04:08:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:08:08 INFO - 'tests': ['dromaeo_dom']}, 04:08:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:08:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:08:08 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:08:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:08:08 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:08:08 INFO - 'tests': ['ts_paint', 'tp5o']}, 04:08:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:08:08 INFO - 'tests': ['a11yr', 04:08:08 INFO - 'ts_paint', 04:08:08 INFO - 'tpaint', 04:08:08 INFO - 'sessionrestore', 04:08:08 INFO - 'sessionrestore_no_auto_restore', 04:08:08 INFO - 'tabpaint']}, 04:08:08 INFO - 'other-e10s': {'tests': ['a11yr', 04:08:08 INFO - 'ts_paint', 04:08:08 INFO - 'tpaint', 04:08:08 INFO - 'sessionrestore', 04:08:08 INFO - 'sessionrestore_no_auto_restore', 04:08:08 INFO - 'tabpaint']}, 04:08:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:08:08 INFO - 'ts_paint', 04:08:08 INFO - 'tpaint', 04:08:08 INFO - 'sessionrestore', 04:08:08 INFO - 'sessionrestore_no_auto_restore', 04:08:08 INFO - 'tabpaint']}, 04:08:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:08:08 INFO - 'ts_paint', 04:08:08 INFO - 'tpaint', 04:08:08 INFO - 'sessionrestore', 04:08:08 INFO - 'sessionrestore_no_auto_restore', 04:08:08 INFO - 'tabpaint']}, 04:08:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:08:08 INFO - 'tests': ['a11yr', 04:08:08 INFO - 'ts_paint', 04:08:08 INFO - 'tpaint', 04:08:08 INFO - 'sessionrestore', 04:08:08 INFO - 'sessionrestore_no_auto_restore', 04:08:08 INFO - 'tabpaint']}, 04:08:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:08:08 INFO - 'tests': ['a11yr', 04:08:08 INFO - 'ts_paint', 04:08:08 INFO - 'tpaint', 04:08:08 INFO - 'sessionrestore', 04:08:08 INFO - 'sessionrestore_no_auto_restore', 04:08:08 INFO - 'tabpaint']}, 04:08:08 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:08:08 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:08:08 INFO - 'bloom_basic_ref']}, 04:08:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:08:08 INFO - 'tests': ['tsvgx', 04:08:08 INFO - 'tsvgr_opacity', 04:08:08 INFO - 'tart', 04:08:08 INFO - 'tscrollx', 04:08:08 INFO - 'cart', 04:08:08 INFO - 'tsvg_static']}, 04:08:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:08:08 INFO - 'tsvgr_opacity', 04:08:08 INFO - 'tart', 04:08:08 INFO - 'tscrollx', 04:08:08 INFO - 'cart', 04:08:08 INFO - 'tsvg_static']}, 04:08:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:08:08 INFO - 'talos_options': ['--disable-e10s'], 04:08:08 INFO - 'tests': ['tp5o']}, 04:08:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:08:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:08:08 INFO - 'talos_options': ['--disable-e10s', 04:08:08 INFO - '--xperf_path', 04:08:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:08 INFO - 'tests': ['tp5n']}, 04:08:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:08:08 INFO - 'talos_options': ['--xperf_path', 04:08:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:08 INFO - 'tests': ['tp5n']}}, 04:08:08 INFO - 'talos.zip': {'path': '', 04:08:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:08:08 INFO - Running post-action listener: _resource_record_post_action 04:08:08 INFO - [mozharness: 2017-05-18 11:08:08.322146Z] Finished populate-webroot step (success) 04:08:08 INFO - [mozharness: 2017-05-18 11:08:08.322236Z] Running create-virtualenv step. 04:08:08 INFO - Running pre-action listener: _resource_record_pre_action 04:08:08 INFO - Running main action method: create_virtualenv 04:08:08 INFO - Creating virtualenv /builds/slave/test/build/venv 04:08:08 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 04:08:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:08:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:08:08 INFO - Using real prefix '/usr' 04:08:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:08:08 INFO - Installing distribute.............................................................................................................................................................................................done. 04:08:10 INFO - Installing pip.................done. 04:08:10 INFO - Return code: 0 04:08:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:08:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:08:11 INFO - Reading from file tmpfile_stdout 04:08:11 INFO - Output received: 04:08:11 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) 04:08:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04: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')]} 04:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04: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')]} 04:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:11 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 0x15741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e47a0>, '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 0x18e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', '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 04:08:11 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 04:08:11 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 04:08:11 INFO - Using env: {'DISPLAY': ':0', 04:08:11 INFO - 'HOME': '/home/cltbld', 04:08:11 INFO - 'LANG': 'en_US.UTF-8', 04:08:11 INFO - 'LANGUAGE': 'en_US:en', 04:08:11 INFO - 'LOGNAME': 'cltbld', 04:08:11 INFO - 'MAIL': '/var/mail/cltbld', 04:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:11 INFO - 'MOZ_NO_REMOTE': '1', 04:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:11 INFO - 'NO_EM_RESTART': '1', 04:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:11 INFO - 'PWD': '/builds/slave/test', 04:08:11 INFO - 'SHELL': '/bin/bash', 04:08:11 INFO - 'SHLVL': '1', 04:08:11 INFO - 'TERM': 'linux', 04:08:11 INFO - 'TMOUT': '86400', 04:08:11 INFO - 'USER': 'cltbld', 04:08:11 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', 04:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:11 INFO - '_': '/tools/buildbot/bin/python'} 04:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:11 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 04:08:11 INFO - Cleaning up... 04:08:11 INFO - Return code: 0 04:08:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04: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')]} 04:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04: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')]} 04:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:11 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 0x15741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e47a0>, '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 0x18e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', '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 04:08:11 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 04:08:11 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 04:08:11 INFO - Using env: {'DISPLAY': ':0', 04:08:11 INFO - 'HOME': '/home/cltbld', 04:08:11 INFO - 'LANG': 'en_US.UTF-8', 04:08:11 INFO - 'LANGUAGE': 'en_US:en', 04:08:11 INFO - 'LOGNAME': 'cltbld', 04:08:11 INFO - 'MAIL': '/var/mail/cltbld', 04:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:11 INFO - 'MOZ_NO_REMOTE': '1', 04:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:11 INFO - 'NO_EM_RESTART': '1', 04:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:11 INFO - 'PWD': '/builds/slave/test', 04:08:11 INFO - 'SHELL': '/bin/bash', 04:08:11 INFO - 'SHLVL': '1', 04:08:11 INFO - 'TERM': 'linux', 04:08:11 INFO - 'TMOUT': '86400', 04:08:11 INFO - 'USER': 'cltbld', 04:08:11 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', 04:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:11 INFO - '_': '/tools/buildbot/bin/python'} 04:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:11 INFO - Downloading/unpacking psutil>=3.1.1 04:08:11 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 04:08:11 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 04:08:11 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 04:08:11 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 04:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:08:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:13 INFO - Installing collected packages: psutil 04:08:13 INFO - Running setup.py install for psutil 04:08:13 INFO - building 'psutil._psutil_linux' extension 04:08:13 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 04:08:13 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 04:08:13 INFO - building 'psutil._psutil_posix' extension 04:08:13 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 04:08:13 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 04:08:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:13 INFO - Successfully installed psutil 04:08:13 INFO - Cleaning up... 04:08:13 INFO - Return code: 0 04:08:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e47a0>, '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 0x18e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', '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 04: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04: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 mozsystemmonitor==0.3 04:08:14 INFO - Using env: {'DISPLAY': ':0', 04:08:14 INFO - 'HOME': '/home/cltbld', 04:08:14 INFO - 'LANG': 'en_US.UTF-8', 04:08:14 INFO - 'LANGUAGE': 'en_US:en', 04:08:14 INFO - 'LOGNAME': 'cltbld', 04:08:14 INFO - 'MAIL': '/var/mail/cltbld', 04:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:14 INFO - 'MOZ_NO_REMOTE': '1', 04:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:14 INFO - 'NO_EM_RESTART': '1', 04:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:14 INFO - 'PWD': '/builds/slave/test', 04:08:14 INFO - 'SHELL': '/bin/bash', 04:08:14 INFO - 'SHLVL': '1', 04:08:14 INFO - 'TERM': 'linux', 04:08:14 INFO - 'TMOUT': '86400', 04:08:14 INFO - 'USER': 'cltbld', 04:08:14 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', 04:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:14 INFO - '_': '/tools/buildbot/bin/python'} 04:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:08:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:08:15 INFO - Installing collected packages: mozsystemmonitor 04:08:15 INFO - Running setup.py install for mozsystemmonitor 04:08:15 INFO - Successfully installed mozsystemmonitor 04:08:15 INFO - Cleaning up... 04:08:15 INFO - Return code: 0 04:08:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:08:15 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')]} 04:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:15 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')]} 04:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:15 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 0x15741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e47a0>, '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 0x18e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', '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 04:08:15 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 04:08:15 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 04:08:15 INFO - Using env: {'DISPLAY': ':0', 04:08:15 INFO - 'HOME': '/home/cltbld', 04:08:15 INFO - 'LANG': 'en_US.UTF-8', 04:08:15 INFO - 'LANGUAGE': 'en_US:en', 04:08:15 INFO - 'LOGNAME': 'cltbld', 04:08:15 INFO - 'MAIL': '/var/mail/cltbld', 04:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:15 INFO - 'MOZ_NO_REMOTE': '1', 04:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:15 INFO - 'NO_EM_RESTART': '1', 04:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:15 INFO - 'PWD': '/builds/slave/test', 04:08:15 INFO - 'SHELL': '/bin/bash', 04:08:15 INFO - 'SHLVL': '1', 04:08:15 INFO - 'TERM': 'linux', 04:08:15 INFO - 'TMOUT': '86400', 04:08:15 INFO - 'USER': 'cltbld', 04:08:15 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', 04:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:15 INFO - '_': '/tools/buildbot/bin/python'} 04:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:15 INFO - Downloading/unpacking jsonschema==2.5.1 04:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:08:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:17 INFO - Downloading functools32-3.2.3-2.tar.gz 04:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:08:17 INFO - warning: no files found matching '*.txt' 04:08:17 INFO - no previously-included directories found matching 'build' 04:08:17 INFO - no previously-included directories found matching 'dist' 04:08:17 INFO - no previously-included directories found matching '.git*' 04:08:17 INFO - Installing collected packages: jsonschema, functools32 04:08:17 INFO - Running setup.py install for functools32 04:08:18 INFO - warning: no files found matching '*.txt' 04:08:18 INFO - no previously-included directories found matching 'build' 04:08:18 INFO - no previously-included directories found matching 'dist' 04:08:18 INFO - no previously-included directories found matching '.git*' 04:08:18 INFO - Successfully installed jsonschema functools32 04:08:18 INFO - Cleaning up... 04:08:18 INFO - Return code: 0 04:08:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:18 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 0x15741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e47a0>, '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 0x18e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', '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 04:08:18 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 04:08:18 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 04:08:18 INFO - Using env: {'DISPLAY': ':0', 04:08:18 INFO - 'HOME': '/home/cltbld', 04:08:18 INFO - 'LANG': 'en_US.UTF-8', 04:08:18 INFO - 'LANGUAGE': 'en_US:en', 04:08:18 INFO - 'LOGNAME': 'cltbld', 04:08:18 INFO - 'MAIL': '/var/mail/cltbld', 04:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:18 INFO - 'MOZ_NO_REMOTE': '1', 04:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:18 INFO - 'NO_EM_RESTART': '1', 04:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:18 INFO - 'PWD': '/builds/slave/test', 04:08:18 INFO - 'SHELL': '/bin/bash', 04:08:18 INFO - 'SHLVL': '1', 04:08:18 INFO - 'TERM': 'linux', 04:08:18 INFO - 'TMOUT': '86400', 04:08:18 INFO - 'USER': 'cltbld', 04:08:18 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', 04:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:18 INFO - '_': '/tools/buildbot/bin/python'} 04:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:08:18 INFO - Cleaning up... 04:08:18 INFO - Return code: 0 04:08:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:18 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 0x15741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e47a0>, '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 0x18e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', '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 04:08:18 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 04:08:18 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 04:08:18 INFO - Using env: {'DISPLAY': ':0', 04:08:18 INFO - 'HOME': '/home/cltbld', 04:08:18 INFO - 'LANG': 'en_US.UTF-8', 04:08:18 INFO - 'LANGUAGE': 'en_US:en', 04:08:18 INFO - 'LOGNAME': 'cltbld', 04:08:18 INFO - 'MAIL': '/var/mail/cltbld', 04:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:18 INFO - 'MOZ_NO_REMOTE': '1', 04:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:18 INFO - 'NO_EM_RESTART': '1', 04:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:18 INFO - 'PWD': '/builds/slave/test', 04:08:18 INFO - 'SHELL': '/bin/bash', 04:08:18 INFO - 'SHLVL': '1', 04:08:18 INFO - 'TERM': 'linux', 04:08:18 INFO - 'TMOUT': '86400', 04:08:18 INFO - 'USER': 'cltbld', 04:08:18 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', 04:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:18 INFO - '_': '/tools/buildbot/bin/python'} 04:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:18 INFO - Downloading/unpacking blobuploader==1.2.4 04:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:20 INFO - Downloading blobuploader-1.2.4.tar.gz 04:08:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:08:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:08:20 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 04:08:20 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 04:08:20 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 04:08:20 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 04:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:08:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:21 INFO - Downloading docopt-0.6.1.tar.gz 04:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:08:21 INFO - Installing collected packages: blobuploader, requests, docopt 04:08:21 INFO - Running setup.py install for blobuploader 04:08:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:08:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:08:22 INFO - Running setup.py install for requests 04:08:22 INFO - Running setup.py install for docopt 04:08:22 INFO - Successfully installed blobuploader requests docopt 04:08:22 INFO - Cleaning up... 04:08:22 INFO - Return code: 0 04:08:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:22 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 0x15741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e47a0>, '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 0x18e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', '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 04:08:22 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 04:08:22 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 04:08:22 INFO - Using env: {'DISPLAY': ':0', 04:08:22 INFO - 'HOME': '/home/cltbld', 04:08:22 INFO - 'LANG': 'en_US.UTF-8', 04:08:22 INFO - 'LANGUAGE': 'en_US:en', 04:08:22 INFO - 'LOGNAME': 'cltbld', 04:08:22 INFO - 'MAIL': '/var/mail/cltbld', 04:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:22 INFO - 'MOZ_NO_REMOTE': '1', 04:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:22 INFO - 'NO_EM_RESTART': '1', 04:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:22 INFO - 'PWD': '/builds/slave/test', 04:08:22 INFO - 'SHELL': '/bin/bash', 04:08:22 INFO - 'SHLVL': '1', 04:08:22 INFO - 'TERM': 'linux', 04:08:22 INFO - 'TMOUT': '86400', 04:08:22 INFO - 'USER': 'cltbld', 04:08:22 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', 04:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:22 INFO - '_': '/tools/buildbot/bin/python'} 04:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:22 INFO - Running setup.py (path:/tmp/pip-Zfz7z3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:22 INFO - Running setup.py (path:/tmp/pip-sEXW1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:22 INFO - Running setup.py (path:/tmp/pip-j3OHmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:23 INFO - Running setup.py (path:/tmp/pip-M6qnGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:23 INFO - Running setup.py (path:/tmp/pip-dfg4yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:23 INFO - Running setup.py (path:/tmp/pip-YJdS5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:23 INFO - Running setup.py (path:/tmp/pip-9fpT0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:23 INFO - Running setup.py (path:/tmp/pip-_d3SR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:23 INFO - Running setup.py (path:/tmp/pip-neSLrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:23 INFO - Running setup.py (path:/tmp/pip-wLnqBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:23 INFO - Running setup.py (path:/tmp/pip-9f2m1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:23 INFO - Running setup.py (path:/tmp/pip-GtMNSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:23 INFO - Running setup.py (path:/tmp/pip-o33kOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:23 INFO - Running setup.py (path:/tmp/pip-qg3HLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:23 INFO - Running setup.py (path:/tmp/pip-ypDkj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:23 INFO - Running setup.py (path:/tmp/pip-SUOVZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:23 INFO - Running setup.py (path:/tmp/pip-6BGUAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:08:24 INFO - Running setup.py install for manifestparser 04:08:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:08:24 INFO - Running setup.py install for mozcrash 04:08:24 INFO - Running setup.py install for mozdebug 04:08:24 INFO - Running setup.py install for mozdevice 04:08:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:08:24 INFO - Running setup.py install for mozfile 04:08:24 INFO - Running setup.py install for mozhttpd 04:08:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:08:24 INFO - Running setup.py install for mozinfo 04:08:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:08:24 INFO - Running setup.py install for mozInstall 04:08:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:08:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:08:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:08:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:08:24 INFO - Running setup.py install for mozleak 04:08:24 INFO - Running setup.py install for mozlog 04:08:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:08:25 INFO - Running setup.py install for moznetwork 04:08:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:08:25 INFO - Running setup.py install for mozprocess 04:08:25 INFO - Running setup.py install for mozprofile 04:08:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:08:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:08:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:08:25 INFO - Running setup.py install for mozrunner 04:08:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:08:25 INFO - Running setup.py install for mozscreenshot 04:08:25 INFO - Running setup.py install for moztest 04:08:25 INFO - Running setup.py install for mozversion 04:08:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:08:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:08:25 INFO - Cleaning up... 04:08:25 INFO - Return code: 0 04:08:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:25 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 0x15741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e47a0>, '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 0x18e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', '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 04:08:25 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 04:08:25 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 04:08:25 INFO - Using env: {'DISPLAY': ':0', 04:08:25 INFO - 'HOME': '/home/cltbld', 04:08:25 INFO - 'LANG': 'en_US.UTF-8', 04:08:25 INFO - 'LANGUAGE': 'en_US:en', 04:08:25 INFO - 'LOGNAME': 'cltbld', 04:08:25 INFO - 'MAIL': '/var/mail/cltbld', 04:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:25 INFO - 'MOZ_NO_REMOTE': '1', 04:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:25 INFO - 'NO_EM_RESTART': '1', 04:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:25 INFO - 'PWD': '/builds/slave/test', 04:08:25 INFO - 'SHELL': '/bin/bash', 04:08:25 INFO - 'SHLVL': '1', 04:08:25 INFO - 'TERM': 'linux', 04:08:25 INFO - 'TMOUT': '86400', 04:08:25 INFO - 'USER': 'cltbld', 04:08:25 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', 04:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:25 INFO - '_': '/tools/buildbot/bin/python'} 04:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:26 INFO - Running setup.py (path:/tmp/pip-WszUR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:26 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)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:26 INFO - Running setup.py (path:/tmp/pip-keK35W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:26 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)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:26 INFO - Running setup.py (path:/tmp/pip-YpDXyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:26 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)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:26 INFO - Running setup.py (path:/tmp/pip-kJljR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:26 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)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:26 INFO - Running setup.py (path:/tmp/pip-AUZAvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:26 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)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:26 INFO - Running setup.py (path:/tmp/pip-_4m0wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:26 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)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:26 INFO - Running setup.py (path:/tmp/pip-QTKBFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:26 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)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:26 INFO - Running setup.py (path:/tmp/pip-DhY9LX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:26 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)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:26 INFO - Running setup.py (path:/tmp/pip-k8WoT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:26 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)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:26 INFO - Running setup.py (path:/tmp/pip-TQamtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:26 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)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:26 INFO - Running setup.py (path:/tmp/pip-BXPQsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:26 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)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:26 INFO - Running setup.py (path:/tmp/pip-FrXFld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:26 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)) 04:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:26 INFO - Running setup.py (path:/tmp/pip-zqa2K7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:27 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)) 04:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:27 INFO - Running setup.py (path:/tmp/pip-JG3iBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:27 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)) 04:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:27 INFO - Running setup.py (path:/tmp/pip-4iyKA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:27 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)) 04:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:27 INFO - Running setup.py (path:/tmp/pip-8mwi8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:27 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)) 04:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:27 INFO - Running setup.py (path:/tmp/pip-73hy5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:27 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)) 04:08:27 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)) 04:08:27 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)) 04:08:27 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)) 04:08:27 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)) 04:08:27 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)) 04:08:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:08:27 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 04:08:27 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 04:08:27 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 04:08:27 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 04:08:28 INFO - Downloading blessings-1.6.tar.gz 04:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:08:28 INFO - Installing collected packages: blessings 04:08:28 INFO - Running setup.py install for blessings 04:08:28 INFO - Successfully installed blessings 04:08:28 INFO - Cleaning up... 04:08:28 INFO - Return code: 0 04:08:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:08:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:08:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:08:28 INFO - Reading from file tmpfile_stdout 04:08:28 INFO - Current package versions: 04:08:28 INFO - argparse == 1.2.1 04:08:28 INFO - blessings == 1.6 04:08:28 INFO - blobuploader == 1.2.4 04:08:28 INFO - docopt == 0.6.1 04:08:28 INFO - functools32 == 3.2.3-2 04:08:28 INFO - jsonschema == 2.5.1 04:08:28 INFO - manifestparser == 1.1 04:08:28 INFO - mozInstall == 1.12 04:08:28 INFO - mozcrash == 1.0 04:08:28 INFO - mozdebug == 0.1 04:08:28 INFO - mozdevice == 0.50 04:08:28 INFO - mozfile == 1.2 04:08:28 INFO - mozhttpd == 0.7 04:08:28 INFO - mozinfo == 0.9 04:08:28 INFO - mozleak == 0.1 04:08:28 INFO - mozlog == 3.4 04:08:28 INFO - moznetwork == 0.27 04:08:28 INFO - mozprocess == 0.25 04:08:28 INFO - mozprofile == 0.28 04:08:28 INFO - mozrunner == 6.13 04:08:28 INFO - mozscreenshot == 0.1 04:08:28 INFO - mozsystemmonitor == 0.3 04:08:28 INFO - moztest == 0.8 04:08:28 INFO - mozversion == 1.4 04:08:28 INFO - psutil == 3.1.1 04:08:28 INFO - requests == 1.2.3 04:08:28 INFO - wsgiref == 0.1.2 04:08:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:28 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')]} 04:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:28 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')]} 04:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:28 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 0x15741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e47a0>, '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 0x18e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', '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 04:08:28 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 04:08:28 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 04:08:28 INFO - Using env: {'DISPLAY': ':0', 04:08:28 INFO - 'HOME': '/home/cltbld', 04:08:28 INFO - 'LANG': 'en_US.UTF-8', 04:08:28 INFO - 'LANGUAGE': 'en_US:en', 04:08:28 INFO - 'LOGNAME': 'cltbld', 04:08:28 INFO - 'MAIL': '/var/mail/cltbld', 04:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:28 INFO - 'MOZ_NO_REMOTE': '1', 04:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:28 INFO - 'NO_EM_RESTART': '1', 04:08:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:28 INFO - 'PWD': '/builds/slave/test', 04:08:28 INFO - 'SHELL': '/bin/bash', 04:08:28 INFO - 'SHLVL': '1', 04:08:28 INFO - 'TERM': 'linux', 04:08:28 INFO - 'TMOUT': '86400', 04:08:28 INFO - 'USER': 'cltbld', 04:08:28 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', 04:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:28 INFO - '_': '/tools/buildbot/bin/python'} 04:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:29 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)) 04:08:29 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)) 04:08:29 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)) 04:08:29 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)) 04:08:29 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)) 04:08:29 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)) 04:08:29 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)) 04:08:29 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)) 04:08:29 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)) 04:08:29 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)) 04:08:29 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)) 04:08:29 INFO - Cleaning up... 04:08:29 INFO - Return code: 0 04:08:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:08:29 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')]} 04:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:29 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')]} 04:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:29 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 0x15741f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e75c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e47a0>, '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 0x18e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5b30>, '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': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', '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 04:08:29 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 04:08:29 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 04:08:29 INFO - Using env: {'DISPLAY': ':0', 04:08:29 INFO - 'HOME': '/home/cltbld', 04:08:29 INFO - 'LANG': 'en_US.UTF-8', 04:08:29 INFO - 'LANGUAGE': 'en_US:en', 04:08:29 INFO - 'LOGNAME': 'cltbld', 04:08:29 INFO - 'MAIL': '/var/mail/cltbld', 04:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:29 INFO - 'MOZ_NO_REMOTE': '1', 04:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:29 INFO - 'NO_EM_RESTART': '1', 04:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:29 INFO - 'PWD': '/builds/slave/test', 04:08:29 INFO - 'SHELL': '/bin/bash', 04:08:29 INFO - 'SHLVL': '1', 04:08:29 INFO - 'TERM': 'linux', 04:08:29 INFO - 'TMOUT': '86400', 04:08:29 INFO - 'USER': 'cltbld', 04:08:29 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', 04:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:29 INFO - '_': '/tools/buildbot/bin/python'} 04:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:08:29 INFO - Cleaning up... 04:08:29 INFO - Return code: 0 04:08:29 INFO - Running post-action listener: _resource_record_post_action 04:08:29 INFO - Running post-action listener: _start_resource_monitoring 04:08:29 INFO - Starting resource monitoring. 04:08:29 INFO - [mozharness: 2017-05-18 11:08:29.450111Z] Finished create-virtualenv step (success) 04:08:29 INFO - [mozharness: 2017-05-18 11:08:29.450571Z] Running install step. 04:08:29 INFO - Running pre-action listener: _resource_record_pre_action 04:08:29 INFO - Running main action method: install 04:08:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:08:29 INFO - Reading from file tmpfile_stdout 04:08:29 INFO - Detecting whether we're running mozinstall >=1.0... 04:08:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:08:29 INFO - Reading from file tmpfile_stdout 04:08:29 INFO - Output received: 04:08:29 INFO - Usage: mozinstall [options] installer 04:08:29 INFO - Options: 04:08:29 INFO - -h, --help show this help message and exit 04:08:29 INFO - -d DEST, --destination=DEST 04:08:29 INFO - Directory to install application into. [default: 04:08:29 INFO - "/builds/slave/test"] 04:08:29 INFO - --app=APP Application being installed. [default: firefox] 04:08:29 INFO - mkdir: /builds/slave/test/build/application 04:08:29 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'] 04:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:08:47 INFO - Reading from file tmpfile_stdout 04:08:47 INFO - Output received: 04:08:47 INFO - /builds/slave/test/build/application/firefox/firefox 04:08:47 INFO - Running post-action listener: _resource_record_post_action 04:08:47 INFO - [mozharness: 2017-05-18 11:08:47.788542Z] Finished install step (success) 04:08:47 INFO - [mozharness: 2017-05-18 11:08:47.788818Z] Running run-tests step. 04:08:47 INFO - Running pre-action listener: _resource_record_pre_action 04:08:47 INFO - Running main action method: run_tests 04:08:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:08:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:08:47 INFO - Python 2.7.3 04:08:47 INFO - Return code: 0 04:08:47 INFO - grabbing minidump binary from tooltool 04:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:08:47 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 0x18e47a0>, '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 0x18e56a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:08:47 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 04:08:47 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 04:08:47 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 04:08:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:08:47 INFO - Return code: 0 04:08:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:08:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:08:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:08:47 INFO - ENV: RUST_BACKTRACE is now 1 04:08:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:08:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:08:47 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/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 04:08:47 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/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 04:08:47 INFO - Using env: {'DISPLAY': ':0', 04:08:47 INFO - 'HOME': '/home/cltbld', 04:08:47 INFO - 'LANG': 'en_US.UTF-8', 04:08:47 INFO - 'LANGUAGE': 'en_US:en', 04:08:47 INFO - 'LOGNAME': 'cltbld', 04:08:47 INFO - 'MAIL': '/var/mail/cltbld', 04:08:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:08:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:08:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:47 INFO - 'MOZ_NO_REMOTE': '1', 04:08:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:08:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:47 INFO - 'NO_EM_RESTART': '1', 04:08:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:47 INFO - 'PWD': '/builds/slave/test', 04:08:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:08:47 INFO - 'RUST_BACKTRACE': '1', 04:08:47 INFO - 'SHELL': '/bin/bash', 04:08:47 INFO - 'SHLVL': '1', 04:08:47 INFO - 'TERM': 'linux', 04:08:47 INFO - 'TMOUT': '86400', 04:08:47 INFO - 'USER': 'cltbld', 04:08:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198', 04:08:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:47 INFO - '_': '/tools/buildbot/bin/python'} 04:08:47 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/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 04:08:48 INFO - mozversion application_buildid: 20170518100156 04:08:48 INFO - mozversion application_changeset: baf05f61bc14fdf45511bc1165ce76daa08c5c0f 04:08:48 INFO - mozversion application_display_name: Nightly 04:08:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:08:48 INFO - mozversion application_name: Firefox 04:08:48 INFO - mozversion application_remotingname: firefox 04:08:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:08:48 INFO - mozversion application_vendor: Mozilla 04:08:48 INFO - mozversion application_version: 55.0a1 04:08:48 INFO - mozversion platform_buildid: 20170518100156 04:08:48 INFO - mozversion platform_changeset: baf05f61bc14fdf45511bc1165ce76daa08c5c0f 04:08:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:08:48 INFO - mozversion platform_version: 55.0a1 04:08:48 INFO - using testdate: 1495105728 04:08:48 INFO - actual date: 1495105728 04:08:48 INFO - starting webserver on 'localhost:52775' 04:08:48 INFO - SUITE-START | Running 2 tests 04:08:48 INFO - TEST-START | dromaeo_css 04:08:48 INFO - operating with platform_type : linux_ 04:08:48 INFO - Initialising browser for dromaeo_css test... 04:08:48 INFO - TEST-INFO | started process 24119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHEXeFe/profile http://localhost:52775/getInfo.html) 04:08:48 INFO - PID 24119 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 04:08:51 INFO - PID 24119 | __metrics Screen width/height:1600/1200 04:08:51 INFO - PID 24119 | colorDepth:24 04:08:51 INFO - PID 24119 | Browser inner width/height: 1024/695 04:08:51 INFO - PID 24119 | __metrics 04:08:53 INFO - TEST-INFO | 24119: exit 0 04:08:53 INFO - Browser initialized. 04:08:53 INFO - Running cycle 1/1 for dromaeo_css test... 04:08:53 INFO - TEST-INFO | started process 24285 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHEXeFe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:05 INFO - PID 24285 | RSS: Main: 161640448 04:09:05 INFO - PID 24285 | 04:12:06 INFO - PID 24285 | Cycle 1(1): loaded http://localhost:52775/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52775/tests/dromaeo/cssquery-ext.html) 04:12:07 INFO - PID 24285 | RSS: Main: 169558016 04:12:07 INFO - PID 24285 | 04:15:08 INFO - PID 24285 | Cycle 1(1): loaded http://localhost:52775/tests/dromaeo/cssquery-ext.html (next: http://localhost:52775/tests/dromaeo/cssquery-jquery.html) 04:15:09 INFO - PID 24285 | RSS: Main: 169779200 04:15:09 INFO - PID 24285 | 04:18:11 INFO - PID 24285 | Cycle 1(1): loaded http://localhost:52775/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52775/tests/dromaeo/cssquery-mootools.html) 04:18:11 INFO - PID 24285 | RSS: Main: 171880448 04:18:11 INFO - PID 24285 | 04:21:13 INFO - PID 24285 | Cycle 1(1): loaded http://localhost:52775/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52775/tests/dromaeo/cssquery-prototype.html) 04:21:13 INFO - PID 24285 | RSS: Main: 168128512 04:21:13 INFO - PID 24285 | 04:24:16 INFO - PID 24285 | Cycle 1(1): loaded http://localhost:52775/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52775/tests/dromaeo/cssquery-yui.html) 04:24:17 INFO - PID 24285 | RSS: Main: 170303488 04:24:17 INFO - PID 24285 | 04:27:18 INFO - PID 24285 | Cycle 1(1): loaded http://localhost:52775/tests/dromaeo/cssquery-yui.html (next: http://localhost:52775/tests/dromaeo/cssquery-dojo.html) 04:27:18 INFO - PID 24285 | RSS: Main: 169328640 04:27:18 INFO - PID 24285 | 04:27:18 INFO - PID 24285 | __start_tp_report 04:27:18 INFO - PID 24285 | _x_x_mozilla_page_load 04:27:18 INFO - PID 24285 | _x_x_mozilla_page_load_details 04:27:18 INFO - PID 24285 | |i|pagename|runs| 04:27:18 INFO - PID 24285 | |0;dojo.html;3342.097633638917;3354.83225838708;3375.40930337191;3388.7289016878653;3406.795592264463;5871.588988770788;5934.2285502884615;5951.494122999545;5959.433853783895;5969.910451343233;5938.584299099054;5958.702064896759;5970.492508136803;5997.070454079614;6036.185115009473;5180.430152683201;5244.973775131138;5278.287431196797;5325.680459172443;5350.91973620396;5298.311219541473;5346.144616861303;5369.19462080689;5372.785088596452;5389.6496727712765;5233.241180028913;5316.787328506855;5373.086575282211;5422.810201642943;5442.755076021569;5265.710385928773;5285.947140528584;5309.33633295838;5359.651622644516;5366.087765079946;5212.869678258074;5224.555912747421;5240.423553409122;5245.842624721265;5263.921041184347;5908.822735317947;5913.48676812353;5948.167256584082;5950.8809823803285;5981.401859813984;6255.968720156416;6324.430801227912;6363.7454501819875;6395.040743888408;6449.677516124175;6507.2191337039385;6513.348665133496;6518.120053792724;6534.477241820643;6536.182977127859;6035.486983606399;6048;6049.18336024631;6061.939380606225;6063.090536419572;6346.30190679025;6427.453666438405;6509.349065093453;6572.441342485847;6589.86820263592;6290.654014029181;6323.683815809191;6324.936750632527;6327.96836015817;6332.430081292706;6217.626942383471;6385.042243663394;6425.164728585254;6446.77436289737;6457.935420645734;6270.435660790551;6317.14718513004;6402.423781859655;6429.549931504844;6440.291567927524;6412.903806442907;6446.194225721785;6448.548601597937;6453.322401147906;6453.935460645427;4849.612031037508;4883.731394773322;4886.291487734258;4903.53416425439;4941.085899108676;4282.100758840616;4317.287647538121;4380.5838445347645;4387.188370151533;4401.713888597231;6022.09668549721;6056.66688332146;6065.727042283108;6078.1186727924205;6127.356627554132;6444.903326450107;6478.643674597943;6493.285738568754;6498.862699027746;6506.804795856132;5863.648181109147;5895.793647222326;5931.584789064724;6032.517398608101;6034.275886893513;5358.383785864676;5424.294841670637;5433.646812957145;5450.645708029045;5473.233747275384;6600.9009864851105;6628.635425051669;6652.401283884376;6664.833379165366;6670.099536562502;6426.903596445964;6440.066190402272;6456.515761317826;6484.708188131451;6505.219373675;6378.138951241709;6485.708143133665;6579.4736421087155;6667.566608170453;6705;6389.9361006389345;6403.679816009274;6403.7118329676205;6411.6794160290865;6426.485881129592;6486.2216534016225;6516.73933042692;6519.054737063194;6534.052562378523;6537.378948999837;6073.362296958756;6132.20254427538;6208.503319734501;6279.340669229665;6296.590721603081;6202.131701561875;6208.0998255253635;6237.781677641261;6244.812655620339;6247.406496382836;6115.635867915819;6188.535859810622;6240.282367527792;6248.937510624835;6251.656158911122;6100.30868792748;6296.496280297473;6311.084892690443;6311.337309582611;6322.0516922462;5987.341392446914;6049.939500604937;6095.05526643371;6165.907511387422;6182.783602573888 04:27:18 INFO - PID 24285 | |1;ext.html;718.2099690340626;763.4426868386078;777.3509119884898;785.403093648827;1109.9722506937321;29739.25651858702;37127.81436092819;37771.43342849852;37995.810020949924;38032.80983595078;39207.41188882169;39487.802560987155;39619;39623.80188099063;39739.60260397395;7269.4184465242915;7321.59731214783;7343.669534870917;7414.5551266923885;7518.51129676572;7474.364679002291;7503.437242206829;7504.474686771928;7510.436717246201;7553.20691327411;7510.1738808731;7526.983857179265;7534;7558.281963213513;7574.772756817304;7535.208803075653;7540.208278130772;7568.167501574822;7577.886331705029;7580.620968951531;7403.555786652818;7423.44324175689;7449.962750186269;7460.440466964999;7465.29079737424;35568.466473002925;35895.641043589494;36056.63943360585;36310;36468.81765591155;3501.6848483636595;3546.0425685065147;3556.590992035897;3564.2515071834946;3575.2313252650547;29371.706282937324;29522.11433656994;29545.40909181826;29556.408871822445;29593.40813183746;3515.753897227195;3549.7870127792157;3575.87484438046;3587.228745819635;3599.892003239881;202581;202826;203338;213491;214377;46542.53457465382;46737;46776.28191348458;46887.29669054967;46993;48323.516764831904;48402.75798620984;48418;48534.27198592024;48586.27120593123;15127.428337182706;15223.086614803147;15278.236088195546;15294.464693735667;15310.693786124215;12327.137100402886;12369.567065152676;12397.256164630151;12429.254244745343;12490.687732806753;14132.293385330693;14229.14625122496;14245;14252.643683907778;14296.356663950148;5861.648301101947;5960.1059841023325;6014.939850601438;6045.274567051982;6144.07838824171;1066.6053560182781;1112.57165991094;1119.7928383248961;1121.74199934014;1122.4163435013747;26381.47237055248;26690.733092669212;26698.5995210072;26711.465770684867;26849.463010739677;1201.0931746531312;1212.4301578258205;1213.3811756004325;1235.5799028330232;1242.521629172757;13476.39356228972;13578.796318055238;13695.589132326046;13808.585742427744;13843.238621875893;254309;257436;258221;258408;258666;53328;53856;53958;54206.7289663557;54320.185197222076;1454.4836583013089;1507.5854140111337;1554.0442627783832;1557.4471062772552;1557.9298931548108;23729.406764830328;25081.247562573153;25177.98902235248;25193;25424.491510169322;37772;37808.24383512369;37867.431988520744;37952;37985.62014379821;202150;203464;203518;204570;205298;33286.66713332836;34458.655413445544;35562.64437355697;35663.28673426465;36227.27545449129;42281.365779513944;42320.1535969285;44229;44255.557444426435;44916.55083449124;32232.35535289328;32521.02436926896;32746.672533274363;33038.33923321472;33386;32339.19152021218;32731;32983.50524742083;33046.83476582602;33442;37462.250754985296;37569.2486150281;38366.424503633025;38899;39195.21609567736;31168.376632467676;31212.687873120976;31432.214194645316;31524;32029.199270018435;23820;26433.73566264313;26727.732722672525;26785.732142679102;26866.462670746867 04:27:18 INFO - PID 24285 | |2;jquery.html;439.8086832227983;446.4018215591107;448.5245639622001;463.69859591265697;466.3983461334878;18630.254789808427;19896;20348.38954831354;20448.137260783504;20631.174753009862;21975.560488790255;22457.663135052946;22941.655875161887;23261.302160935156;23456.64815027776;5449.509544141037;5617.297837770278;5623.156526521014;5633.549316054706;5636.887262254752;5279.1817268323475;5492;5515.944840551603;5525.198846167304;5527.336719593634;5454.481824226692;5463.235147079412;5471.616986810925;5484.561235101182;5503.422140675231;5341.545968592674;5520.6687598744;5524.58565607579;5550.91673624896;5561.416051314594;5000.399952005746;5032.471590482984;5058.620603454756;5060.139776238048;5064.721440320781;25189.74810251911;25406.872965635237;25449.236522904343;25696;25811.612825807628;2104.4844013216707;2128.8296936245065;2140.4327853118934;2142.4108370198164;2143.19630138698;17149.228284727218;17575.12124393788;17584.824151758447;17750.822491775176;17859.73210401845;1994.331898813899;2033.7661168965462;2083.624947509448;2092.5082605587677;2241.4620491082187;109472.8887960906;113071.43464282708;113477.99999999917;113495.43252283768;114902;12480.937595311965;12686;12790.680232994064;12830.935845320713;12907.290099044454;17825.554361141076;17834.910825446048;17865;17893.926364417915;17906.28374865017;9033.864492032624;9333.300002499704;9401.10689484498;9419.387739797028;9473;8382.664693412316;8557.657693692183;8616.78458038554;8650.178233067974;8787.604557794915;7947.841043179104;8039.67841286342;8058.959314711552;8215.34277257818;8227.762702208367;2259.7175353080866;2277.4078739527513;2330.382448651109;2341.5433990372053;2513.2585887162963;1009.1271050541229;1051.6529545250048;1053.1522124689698;1054.715226888751;1056.0495554001461;19760;20975.26586569493;21206.363809085753;21208.74972681931;21392;1074.409075008742;1077.5635867473686;1079.2499213046858;1082.0910435234441;1083.7290677330668;10434.791304173874;11279.830802537968;11358.716032099099;11388.601398951163;11429.942850285861;455585;459505;460639;510754;523163;95019;96534;97865.51067244618;99051.50474247582;102932.48533757283;1252.3425201769144;1273.2042473454092;1308.9934550327378;1318.8021796730568;1320.1353113710536;19813.405597832087;19821.60356792885;20326.390208293775;20399.388018359474;20796.1681532737;45782.31326530172;47385.52614473949;47924.52075479201;48528.272075919594;49363.25955110748;59115.70442147762;59789.40210598012;59944.40055599388;60295.39704602898;61272;9700.466474343979;9717.85423218638;9729.513524323615;9892.851607225753;9966.202703783534;14887.032342897677;15007.624809379853;15173.924130379277;15239.619009524407;15807.841921580637;12186.329751863732;12507.56223532172;12821;12984.610461686165;13254.469821207043;11846.822297665369;12228;12312.507499699912;12542.435590398272;13012.869871301165;12926.224426534438;13102;13170.868291316965;13270.469181232642;13416.329183540589;9720.562574684014;9779.511024448891;9867.802643946938;10032;10039.096481316716;12764.936175319064;13476.32618369058;13514.59456216315;13753.862461375658;13873.653158671113 04:27:18 INFO - PID 24285 | |3;mootools.html;1380.9171449713017;1421.665908511499;1431.0412023943957;1440.1287221231155;1447.0015689174468;11324.377159256248;11718.296902185853;11786.587469438571;11844.703882402933;12136.271823690584;11751;11771.882281177186;11835.171537992344;11920.225185362968;11923.880761192386;2323.5352929414144;2354.8822558872075;2355.6231003039516;2357.846739961897;2360.858348499087;2285.268714011517;2338.4972230970425;2343.5430091132234;2347.9647805282934;2355.422921384263;2143.431990522513;2149.9892500537476;2173.3588591365506;2179.08478439056;2183.3995651195887;2301.666258392532;2307.8384513084093;2354.658574506687;2355.5406695694346;2359.2214569192124;2210.6573481110454;2243.955120897589;2252.5044490212126;2282.3723476044056;2289.107248173197;11595.826062609067;11694.298342099417;11714.297142171497;11740.88259117415;11800.173987820855;6626.900596491057;6812.897806532906;6833.453323734089;6835.69239384224;6847.383735463832;3788.2612890486366;3992.9201415971806;4054.7567145971334;4062.73592216505;4102.118044620421;1318.0312470334297;1321.8876395506393;1365.5766712319114;1371.2115533568137;1384.2525036480288;17586.12069396525;17800.55498612532;17806.643867122715;17811.554711132198;17818.91090544552;5040.47075057121;5117.437081920985;5302.3637163540625;5353.0899747043095;5429.294191755125;12527;12559.560415385418;12636.305003224727;12644.936775316064;12660.746785064248;6557.639329836809;6573.539852210395;6576.86846263072;6579.769708060195;6585.736570537125;5923.555733320019;6055.031195008777;6106.328303886569;6112.266528016667;6223.1287619733275;3985.6278183703266;4051.331530297468;4167.603178646496;4214.978925105416;4219.683523735732;1169.479581586186;1184.490669012333;1191.237607930925;1195.8923696867323;1207.3359652191434;874.3224001398839;894.6689724801865;910.544727636182;917.3899356927568;926.5691453474167;6547.836304092436;6596.10952521413;6605.306442823435;6609.074729537869;6685.866282674319;664.930182330858;665.0356982375478;666.7666316789182;667.2393471442559;680.557637535596;4026.1746342000406;4127.6491498222385;4613.331066995267;4668.206404911173;4683.461401938821;14449.927750361181;15281.847181528043;15339.386424542894;15360.308786104652;15533.611659708371;15021.774673379909;15481.612959676098;15485.380584776709;15586.610334741723;15600.29798659063;9091.27269818413;9382.437053776795;9390.530473476436;9397.342186046912;9445.527723613792;7380.409567234501;7458.067741532309;7537.095548534211;7594.392448603988;7768.689252429839;13303;13798.517051903134;13952.720945580828;13976.371063301973;13982.091164074303;13653.453861845415;13813.378397971914;14073.507427239998;14094;14141.787873181705;9689.83721953342;9707.126358627758;9732.464714440774;9847.950760246153;9874;10761.40812255302;11025;11052;11081.335119892832;11136.777264454504;9284.257259419366;9411.858822117536;9471.810563788547;9528.285378596494;9756.51217439111;9412.576434060347;9415.681804547232;9468.573914174016;9470.052994700474;9635.22918166531;8441.873371899304;8511.872321915052;8578.056413794602;8681.21869031765;8697.478151310941;6254.874902502015;6329.525285603506;6374.362563743589;6403.871922561616;6515.576487528296;6276.592021518587;6306.716197771019;6483.578567393104;6650.966745166436;6683.298253683488 04:27:18 INFO - PID 24285 | |4;prototype.html;382.83920753283616;387.2294134672003;387.6569236225941;393.5769048273107;394.46155997064;6096.329403765582;6162.137300777889;6187.350328215534;6200.906986395202;6246.688195478943;5986.461218490346;6077.02767557191;6082.543809214316;6107.206063211787;6111.847203819907;4642.210824159893;4701.743163281627;4707.576318131368;4718.882027949311;4729.69256998294;4701.553352431513;4705.29420586913;4716.622670186377;4728;4752.952470475303;4626.259798432252;4697.600703940169;4721.598664113537;4745.715257084568;4762.952370476286;4680.227762419197;4687.5937218834215;4719.740414277213;4723.433188017426;4728.739919304437;4174.4364510791265;4187.539370669224;4213.220554197453;4220.155968806221;4220.767857767822;5925.970370148121;5942.940570594325;6016.278046634388;6042.365551617061;6042.667653279068;5530.778768849241;5592.972035139798;5605.383407825136;5614;5625.38120806711;6490.332961876525;6529.11856899322;6533.640649764261;6559;6561.573497722633;4725.598324142452;4770.379850619432;4771.642126840501;4800.199925028114;4841.346418233528;6557.803265901983;6736.528443008991;6836.589804611689;6842.486813488958;6864.24493305741;4704.1767690654;4744.4069491313585;4753.667243292936;4762.380890484214;4763.73799441034;4812.5668689818085;4813.061453016629;4814.181589129857;4827.179379505493;4827.61379089672;5431.755570999315;5435.864103397367;5444.156155795858;5500.42245564218;5504.174373843955;6516;6529.11856899322;6537.673116344164;6546.18172728409;6552.967235163889;1698.72595553335;1748.160882776249;1767.646470705864;1770.725537541683;1772.2556526259002;1204.5302332090491;1227.766724322376;1233.2292317301687;1242.353975932528;1251.9061070419573;6072.544559158081;6102.816915492543;6105.694715264219;6116.327204007555;6132;6573.244076931119;6599.7360105595235;6640.169978752656;6653.035309880137;6680.96659516709;5987.550933679991;6029.577929544977;6112;6115.266168059772;6128.4790792783115;3492.633273506296;3501.9824900875333;3523.524324216249;3531.446163687969;3552.2185119273718;6731.427828634621;6848.3494068063455;6885.552439091443;6907.758228461979;6917.412019978257;6755.594664320157;6795.456363490909;6826.419754320938;6831.521793474509;6859.691313890887;6732.663366831639;6904;6918.93081069193;6964.965175174092;7007.6145811978795;6623.701933413105;6709.295523969913;6723.495737819585;6734.831629209309;6741.157355330583;6455.2576453708425;6477.190351206099;6609.306022867722;6675.399214070757;6684.328917770557;6890.276520965226;6902.620355880274;6927.3419025192525;6971.825704357431;7023.929760702327;4454.129265708475;4479.46246450428;4489.820407183806;4491.842785502622;4513.909721805479;6541.953287473982;6634.436072933855;6766.221884483348;6780.864382712417;6802.489813263926;6468.062130991074;6496.545241833026;6536.379043990813;6557.901631475436;6585.20977482686;6388.233411990405;6465.77369792055;6514.185726784152;6548.705308261045;6574.769883054261;6417.7753778617525;6459.806205813833;6481.902771458337;6484.870302593828;6512.772052978123;6386.712597933197;6413.262474815269;6507.869842603216;6575.572587781779;6576.079348891063;6324.873502530016;6348.396902294275;6350.666360064438;6391.552591318563;6403.423691867568 04:27:18 INFO - PID 24285 | |5;yui.html;808.6926967752253;846.1538461538462;846.5978660136435;852.3735054734769;853.9829203415932;16560.503184904443;16600.833991660078;17067.573310667223;18081.367152149644;18612.81387186128;17670.734938975893;18160;18269.177886995083;18400;18408.355707550207;953.213598781005;978.7553111722069;985.0887928665991;986.9703908882746;988.5156273426005;995.6266400099962;999.0708640963901;1000.4697510319506;1002.6941782756256;1006.0040559845773;1040.4277647293995;1042.4475028235047;1048.9003544663244;1050.385524468187;1052.4264275969615;1043.2697112021615;1044.2846650044744;1048.7116043088135;1049.04536871447;1050.4695128959866;720.2833180984953;736.2269616902231;736.5359823311334;740.8407192453594;742.3689863615883;16337.836621633869;16393.67212655752;16437.917810410872;16482.093484858327;16483.175841208013;16883.83116168847;18017.639647207114;18806.81193188078;18823.341183058663;18924.43226703201;14190.21953792541;14419.495317663832;14515.564533064025;14526.636834079127;14663.92668036653;3446.3796516627;3479.5476588043393;3480.7041401480906;3483.4948932404914;3493.074335301147;95128;95639.52180239125;95828.52085739597;96250.51874740582;97290.51354743181;13005.674858128623;13014.609561713163;13027.47890084405;13181.868181318065;13219.206847589176;25016.87491562567;26402.6039609406;26510;26912.327191819968;26940.057098001475;7741.225877412214;7837.255460731221;7850.528968261922;7888.092869320101;7914.564698941614;3836.8848934532007;3931.1154990126993;3945.585713500099;3964.0288129407904;3981.323175060189;4288;4333.155034768253;4374.496932852699;4376.474823021258;4377.846775362847;790.0835031363705;812.5043723328765;814.1573471457132;815.8001289684065;816.5794615772882;720.6036679826075;724.4240828541323;728.8250819803209;735.4447392218948;760.1676164599754;11735.823962640567;11870.703232419259;12022;13035.413406396736;13309.600711978655;722.989155162673;727.1637616740791;728.8250819803209;729.1833146875427;729.241588747707;5484.890302193934;5643.689597072118;5721.742521586539;5737.8565535861935;5834.095715164156;82091;82183.58908205421;84036.15963840284;84780.57609712036;85552;73428.26571734321;75057.62471187719;76641.61679191569;77132.22867771363;78072.60963695259;67595.66202168958;68236;68506.65746671235;69463.30536694669;69893;11157.386343751172;11243.775124497628;11462.656120316404;11551.88448115508;11576.768464630828;36167.45748813823;37483.250334992605;37831.43252851265;37994.24011519699;38037;43655.78172109119;44264.77867610641;44410.555894440644;45364;45956.7702161487;13976.371063301973;14080.577582672537;14102.153870767786;14138.717225655635;14409.855901440851;15025.323860426088;15143.318550665466;15194.164320962453;15577.84422155764;15584.84415155834;15107.697846042798;15234.619134521725;15285.77071343953;15347.539573812803;15582;13706.588802335946;14001.299935003006;14051.086679365808;14109.082909610843;14136.43454261818;15006.624834379229;15148.924255379094;15157.621059473602;15306.15816130079;15501.689966200838;10537.315074520131;10733.248672593156;10754.193435492525;10839.403832789272;10851.837222441827;11224.55101795919;11584.884151158381;11740.119491038377;11749.647510574696;11789 04:27:18 INFO - PID 24285 | __end_tp_report 04:27:18 INFO - PID 24285 | __start_cc_report 04:27:18 INFO - PID 24285 | _x_x_mozilla_cycle_collect,252 04:27:18 INFO - PID 24285 | __end_cc_report 04:27:18 INFO - PID 24285 | __startTimestamp1495106838906__endTimestamp 04:27:18 INFO - PID 24285 | 04:27:18 INFO - PID 24285 | ------- Summary: start ------- 04:27:18 INFO - PID 24285 | Number of tests: 6 04:27:18 INFO - PID 24285 | 04:27:18 INFO - PID 24285 | [#0] dojo.html Cycles:165 Average:5924.01 Median:6165.91 stddev:710.04 (11.5%) stddev-sans-first:682.71 04:27:18 INFO - PID 24285 | Values: 3342.1 3354.8 3375.4 3388.7 3406.8 5871.6 5934.2 5951.5 5959.4 5969.9 5938.6 5958.7 5970.5 5997.1 6036.2 5180.4 5245.0 5278.3 5325.7 5350.9 5298.3 5346.1 5369.2 5372.8 5389.6 5233.2 5316.8 5373.1 5422.8 5442.8 5265.7 5285.9 5309.3 5359.7 5366.1 5212.9 5224.6 5240.4 5245.8 5263.9 5908.8 5913.5 5948.2 5950.9 5981.4 6256.0 6324.4 6363.7 6395.0 6449.7 6507.2 6513.3 6518.1 6534.5 6536.2 6035.5 6048.0 6049.2 6061.9 6063.1 6346.3 6427.5 6509.3 6572.4 6589.9 6290.7 6323.7 6324.9 6328.0 6332.4 6217.6 6385.0 6425.2 6446.8 6457.9 6270.4 6317.1 6402.4 6429.5 6440.3 6412.9 6446.2 6448.5 6453.3 6453.9 4849.6 4883.7 4886.3 4903.5 4941.1 4282.1 4317.3 4380.6 4387.2 4401.7 6022.1 6056.7 6065.7 6078.1 6127.4 6444.9 6478.6 6493.3 6498.9 6506.8 5863.6 5895.8 5931.6 6032.5 6034.3 5358.4 5424.3 5433.6 5450.6 5473.2 6600.9 6628.6 6652.4 6664.8 6670.1 6426.9 6440.1 6456.5 6484.7 6505.2 6378.1 6485.7 6579.5 6667.6 6705.0 6389.9 6403.7 6403.7 6411.7 6426.5 6486.2 6516.7 6519.1 6534.1 6537.4 6073.4 6132.2 6208.5 6279.3 6296.6 6202.1 6208.1 6237.8 6244.8 6247.4 6115.6 6188.5 6240.3 6248.9 6251.7 6100.3 6296.5 6311.1 6311.3 6322.1 5987.3 6049.9 6095.1 6165.9 6182.8 04:27:18 INFO - PID 24285 | 04:27:18 INFO - PID 24285 | [#1] ext.html Cycles:180 Average:38873.34 Median:3530.90 stddev:58191.11 (1648.1%) stddev-sans-first:58283.83 04:27:18 INFO - PID 24285 | Values: 718.2 763.4 777.4 785.4 1110.0 29739.3 37127.8 37771.4 37995.8 38032.8 39207.4 39487.8 39619.0 39623.8 39739.6 7269.4 7321.6 7343.7 7414.6 7518.5 7474.4 7503.4 7504.5 7510.4 7553.2 7510.2 7527.0 7534.0 7558.3 7574.8 7535.2 7540.2 7568.2 7577.9 7580.6 7403.6 7423.4 7450.0 7460.4 7465.3 35568.5 35895.6 36056.6 36310.0 36468.8 3501.7 3546.0 3556.6 3564.3 3575.2 29371.7 29522.1 29545.4 29556.4 29593.4 3515.8 3549.8 3575.9 3587.2 3599.9 202581.0 202826.0 203338.0 213491.0 214377.0 46542.5 46737.0 46776.3 46887.3 46993.0 48323.5 48402.8 48418.0 48534.3 48586.3 15127.4 15223.1 15278.2 15294.5 15310.7 12327.1 12369.6 12397.3 12429.3 12490.7 14132.3 14229.1 14245.0 14252.6 14296.4 5861.6 5960.1 6014.9 6045.3 6144.1 1066.6 1112.6 1119.8 1121.7 1122.4 26381.5 26690.7 26698.6 26711.5 26849.5 1201.1 1212.4 1213.4 1235.6 1242.5 13476.4 13578.8 13695.6 13808.6 13843.2 254309.0 257436.0 258221.0 258408.0 258666.0 53328.0 53856.0 53958.0 54206.7 54320.2 1454.5 1507.6 1554.0 1557.4 1557.9 23729.4 25081.2 25178.0 25193.0 25424.5 37772.0 37808.2 37867.4 37952.0 37985.6 202150.0 203464.0 203518.0 204570.0 205298.0 33286.7 34458.7 35562.6 35663.3 36227.3 42281.4 42320.2 44229.0 44255.6 44916.6 32232.4 32521.0 32746.7 33038.3 33386.0 32339.2 32731.0 32983.5 33046.8 33442.0 37462.3 37569.2 38366.4 38899.0 39195.2 31168.4 31212.7 31432.2 31524.0 32029.2 23820.0 26433.7 26727.7 26785.7 26866.5 04:27:18 INFO - PID 24285 | 04:27:18 INFO - PID 24285 | [#2] jquery.html Cycles:180 Average:31112.53 Median:2142.80 stddev:80393.16 (3751.8%) stddev-sans-first:80585.70 04:27:18 INFO - PID 24285 | Values: 439.8 446.4 448.5 463.7 466.4 18630.3 19896.0 20348.4 20448.1 20631.2 21975.6 22457.7 22941.7 23261.3 23456.6 5449.5 5617.3 5623.2 5633.5 5636.9 5279.2 5492.0 5515.9 5525.2 5527.3 5454.5 5463.2 5471.6 5484.6 5503.4 5341.5 5520.7 5524.6 5550.9 5561.4 5000.4 5032.5 5058.6 5060.1 5064.7 25189.7 25406.9 25449.2 25696.0 25811.6 2104.5 2128.8 2140.4 2142.4 2143.2 17149.2 17575.1 17584.8 17750.8 17859.7 1994.3 2033.8 2083.6 2092.5 2241.5 109472.9 113071.4 113478.0 113495.4 114902.0 12480.9 12686.0 12790.7 12830.9 12907.3 17825.6 17834.9 17865.0 17893.9 17906.3 9033.9 9333.3 9401.1 9419.4 9473.0 8382.7 8557.7 8616.8 8650.2 8787.6 7947.8 8039.7 8059.0 8215.3 8227.8 2259.7 2277.4 2330.4 2341.5 2513.3 1009.1 1051.7 1053.2 1054.7 1056.0 19760.0 20975.3 21206.4 21208.7 21392.0 1074.4 1077.6 1079.2 1082.1 1083.7 10434.8 11279.8 11358.7 11388.6 11429.9 455585.0 459505.0 460639.0 510754.0 523163.0 95019.0 96534.0 97865.5 99051.5 102932.5 1252.3 1273.2 1309.0 1318.8 1320.1 19813.4 19821.6 20326.4 20399.4 20796.2 45782.3 47385.5 47924.5 48528.3 49363.3 59115.7 59789.4 59944.4 60295.4 61272.0 9700.5 9717.9 9729.5 9892.9 9966.2 14887.0 15007.6 15173.9 15239.6 15807.8 12186.3 12507.6 12821.0 12984.6 13254.5 11846.8 12228.0 12312.5 12542.4 13012.9 12926.2 13102.0 13170.9 13270.5 13416.3 9720.6 9779.5 9867.8 10032.0 10039.1 12764.9 13476.3 13514.6 13753.9 13873.7 04:27:18 INFO - PID 24285 | 04:27:18 INFO - PID 24285 | [#3] mootools.html Cycles:180 Average:7305.24 Median:3886.94 stddev:4739.17 (121.9%) stddev-sans-first:4731.56 04:27:18 INFO - PID 24285 | Values: 1380.9 1421.7 1431.0 1440.1 1447.0 11324.4 11718.3 11786.6 11844.7 12136.3 11751.0 11771.9 11835.2 11920.2 11923.9 2323.5 2354.9 2355.6 2357.8 2360.9 2285.3 2338.5 2343.5 2348.0 2355.4 2143.4 2150.0 2173.4 2179.1 2183.4 2301.7 2307.8 2354.7 2355.5 2359.2 2210.7 2244.0 2252.5 2282.4 2289.1 11595.8 11694.3 11714.3 11740.9 11800.2 6626.9 6812.9 6833.5 6835.7 6847.4 3788.3 3992.9 4054.8 4062.7 4102.1 1318.0 1321.9 1365.6 1371.2 1384.3 17586.1 17800.6 17806.6 17811.6 17818.9 5040.5 5117.4 5302.4 5353.1 5429.3 12527.0 12559.6 12636.3 12644.9 12660.7 6557.6 6573.5 6576.9 6579.8 6585.7 5923.6 6055.0 6106.3 6112.3 6223.1 3985.6 4051.3 4167.6 4215.0 4219.7 1169.5 1184.5 1191.2 1195.9 1207.3 874.3 894.7 910.5 917.4 926.6 6547.8 6596.1 6605.3 6609.1 6685.9 664.9 665.0 666.8 667.2 680.6 4026.2 4127.6 4613.3 4668.2 4683.5 14449.9 15281.8 15339.4 15360.3 15533.6 15021.8 15481.6 15485.4 15586.6 15600.3 9091.3 9382.4 9390.5 9397.3 9445.5 7380.4 7458.1 7537.1 7594.4 7768.7 13303.0 13798.5 13952.7 13976.4 13982.1 13653.5 13813.4 14073.5 14094.0 14141.8 9689.8 9707.1 9732.5 9848.0 9874.0 10761.4 11025.0 11052.0 11081.3 11136.8 9284.3 9411.9 9471.8 9528.3 9756.5 9412.6 9415.7 9468.6 9470.1 9635.2 8441.9 8511.9 8578.1 8681.2 8697.5 6254.9 6329.5 6374.4 6403.9 6515.6 6276.6 6306.7 6483.6 6651.0 6683.3 04:27:18 INFO - PID 24285 | 04:27:18 INFO - PID 24285 | [#4] prototype.html Cycles:180 Average:5460.73 Median:6111.92 stddev:1605.65 (26.3%) stddev-sans-first:1564.27 04:27:18 INFO - PID 24285 | Values: 382.8 387.2 387.7 393.6 394.5 6096.3 6162.1 6187.4 6200.9 6246.7 5986.5 6077.0 6082.5 6107.2 6111.8 4642.2 4701.7 4707.6 4718.9 4729.7 4701.6 4705.3 4716.6 4728.0 4753.0 4626.3 4697.6 4721.6 4745.7 4763.0 4680.2 4687.6 4719.7 4723.4 4728.7 4174.4 4187.5 4213.2 4220.2 4220.8 5926.0 5942.9 6016.3 6042.4 6042.7 5530.8 5593.0 5605.4 5614.0 5625.4 6490.3 6529.1 6533.6 6559.0 6561.6 4725.6 4770.4 4771.6 4800.2 4841.3 6557.8 6736.5 6836.6 6842.5 6864.2 4704.2 4744.4 4753.7 4762.4 4763.7 4812.6 4813.1 4814.2 4827.2 4827.6 5431.8 5435.9 5444.2 5500.4 5504.2 6516.0 6529.1 6537.7 6546.2 6553.0 1698.7 1748.2 1767.6 1770.7 1772.3 1204.5 1227.8 1233.2 1242.4 1251.9 6072.5 6102.8 6105.7 6116.3 6132.0 6573.2 6599.7 6640.2 6653.0 6681.0 5987.6 6029.6 6112.0 6115.3 6128.5 3492.6 3502.0 3523.5 3531.4 3552.2 6731.4 6848.3 6885.6 6907.8 6917.4 6755.6 6795.5 6826.4 6831.5 6859.7 6732.7 6904.0 6918.9 6965.0 7007.6 6623.7 6709.3 6723.5 6734.8 6741.2 6455.3 6477.2 6609.3 6675.4 6684.3 6890.3 6902.6 6927.3 6971.8 7023.9 4454.1 4479.5 4489.8 4491.8 4513.9 6542.0 6634.4 6766.2 6780.9 6802.5 6468.1 6496.5 6536.4 6557.9 6585.2 6388.2 6465.8 6514.2 6548.7 6574.8 6417.8 6459.8 6481.9 6484.9 6512.8 6386.7 6413.3 6507.9 6575.6 6576.1 6324.9 6348.4 6350.7 6391.6 6403.4 04:27:18 INFO - PID 24285 | 04:27:18 INFO - PID 24285 | [#5] yui.html Cycles:180 Average:19009.34 Median:26711.16 stddev:24358.37 (91.2%) stddev-sans-first:24388.36 04:27:18 INFO - PID 24285 | Values: 808.7 846.2 846.6 852.4 854.0 16560.5 16600.8 17067.6 18081.4 18612.8 17670.7 18160.0 18269.2 18400.0 18408.4 953.2 978.8 985.1 987.0 988.5 995.6 999.1 1000.5 1002.7 1006.0 1040.4 1042.4 1048.9 1050.4 1052.4 1043.3 1044.3 1048.7 1049.0 1050.5 720.3 736.2 736.5 740.8 742.4 16337.8 16393.7 16437.9 16482.1 16483.2 16883.8 18017.6 18806.8 18823.3 18924.4 14190.2 14419.5 14515.6 14526.6 14663.9 3446.4 3479.5 3480.7 3483.5 3493.1 95128.0 95639.5 95828.5 96250.5 97290.5 13005.7 13014.6 13027.5 13181.9 13219.2 25016.9 26402.6 26510.0 26912.3 26940.1 7741.2 7837.3 7850.5 7888.1 7914.6 3836.9 3931.1 3945.6 3964.0 3981.3 4288.0 4333.2 4374.5 4376.5 4377.8 790.1 812.5 814.2 815.8 816.6 720.6 724.4 728.8 735.4 760.2 11735.8 11870.7 12022.0 13035.4 13309.6 723.0 727.2 728.8 729.2 729.2 5484.9 5643.7 5721.7 5737.9 5834.1 82091.0 82183.6 84036.2 84780.6 85552.0 73428.3 75057.6 76641.6 77132.2 78072.6 67595.7 68236.0 68506.7 69463.3 69893.0 11157.4 11243.8 11462.7 11551.9 11576.8 36167.5 37483.3 37831.4 37994.2 38037.0 43655.8 44264.8 44410.6 45364.0 45956.8 13976.4 14080.6 14102.2 14138.7 14409.9 15025.3 15143.3 15194.2 15577.8 15584.8 15107.7 15234.6 15285.8 15347.5 15582.0 13706.6 14001.3 14051.1 14109.1 14136.4 15006.6 15148.9 15157.6 15306.2 15501.7 10537.3 10733.2 10754.2 10839.4 10851.8 11224.6 11584.9 11740.1 11749.6 11789.0 04:27:18 INFO - PID 24285 | -------- Summary: end -------- 04:27:18 INFO - PID 24285 | 04:27:19 INFO - TEST-INFO | 24285: exit 0 04:27:19 INFO - TEST-OK | dromaeo_css | took 1111648ms 04:27:19 INFO - TEST-START | kraken 04:27:19 INFO - operating with platform_type : linux_ 04:27:19 INFO - Initialising browser for kraken test... 04:27:19 INFO - TEST-INFO | started process 24692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppszx_Z/profile http://localhost:52775/getInfo.html) 04:27:20 INFO - PID 24692 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 04:27:23 INFO - PID 24692 | __metrics Screen width/height:1600/1200 04:27:23 INFO - PID 24692 | colorDepth:24 04:27:23 INFO - PID 24692 | Browser inner width/height: 1024/695 04:27:23 INFO - PID 24692 | __metrics 04:27:25 INFO - TEST-INFO | 24692: exit 0 04:27:25 INFO - Browser initialized. 04:27:25 INFO - Running cycle 1/1 for kraken test... 04:27:25 INFO - TEST-INFO | started process 24857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppszx_Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:27:36 INFO - PID 24857 | RSS: Main: 161079296 04:27:36 INFO - PID 24857 | 04:27:38 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:52775/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52775/tests/kraken/driver.html?testName=audio-beat-detection) 04:27:39 INFO - PID 24857 | RSS: Main: 166612992 04:27:39 INFO - PID 24857 | 04:27:42 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:52775/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52775/tests/kraken/driver.html?testName=audio-dft) 04:27:42 INFO - PID 24857 | RSS: Main: 166014976 04:27:42 INFO - PID 24857 | 04:27:45 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:52775/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52775/tests/kraken/driver.html?testName=audio-fft) 04:27:46 INFO - PID 24857 | RSS: Main: 161271808 04:27:46 INFO - PID 24857 | 04:27:48 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:52775/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52775/tests/kraken/driver.html?testName=audio-oscillator) 04:27:49 INFO - PID 24857 | RSS: Main: 162258944 04:27:49 INFO - PID 24857 | 04:27:51 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:52775/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52775/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:27:51 INFO - PID 24857 | RSS: Main: 162226176 04:27:51 INFO - PID 24857 | 04:27:54 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:52775/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52775/tests/kraken/driver.html?testName=imaging-darkroom) 04:27:55 INFO - PID 24857 | RSS: Main: 162529280 04:27:55 INFO - PID 24857 | 04:27:58 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:52775/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52775/tests/kraken/driver.html?testName=imaging-desaturate) 04:27:59 INFO - PID 24857 | RSS: Main: 166215680 04:27:59 INFO - PID 24857 | 04:28:02 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:52775/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52775/tests/kraken/driver.html?testName=json-parse-financial) 04:28:02 INFO - PID 24857 | RSS: Main: 166014976 04:28:02 INFO - PID 24857 | 04:28:04 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:52775/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52775/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:28:04 INFO - PID 24857 | RSS: Main: 165933056 04:28:04 INFO - PID 24857 | 04:28:06 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:52775/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52775/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:28:07 INFO - PID 24857 | RSS: Main: 166309888 04:28:07 INFO - PID 24857 | 04:28:09 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:52775/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52775/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:28:09 INFO - PID 24857 | RSS: Main: 166354944 04:28:09 INFO - PID 24857 | 04:28:12 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:52775/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:28:13 INFO - PID 24857 | RSS: Main: 165941248 04:28:13 INFO - PID 24857 | 04:28:16 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:52775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:28:16 INFO - PID 24857 | RSS: Main: 166002688 04:28:16 INFO - PID 24857 | 04:28:18 INFO - PID 24857 | Cycle 1(1): loaded http://localhost:52775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52775/tests/kraken/driver.html?testName=ai-astar) 04:28:18 INFO - PID 24857 | RSS: Main: 168124416 04:28:18 INFO - PID 24857 | 04:28:18 INFO - PID 24857 | __start_tp_report 04:28:18 INFO - PID 24857 | _x_x_mozilla_page_load 04:28:18 INFO - PID 24857 | _x_x_mozilla_page_load_details 04:28:18 INFO - PID 24857 | |i|pagename|runs| 04:28:18 INFO - PID 24857 | |0;ai-astar;101;109;109;109;109;110;111;110;110;110 04:28:18 INFO - PID 24857 | |1;audio-beat-detection;141;123;131;159;119;118;118;119;144;119 04:28:18 INFO - PID 24857 | |2;audio-dft;163;166;162;162;163;163;162;162;166;176 04:28:18 INFO - PID 24857 | |3;audio-fft;76;75;75;103;75;74;73;74;99;75 04:28:18 INFO - PID 24857 | |4;audio-oscillator;83;81;104;83;82;82;96;82;82;98 04:28:18 INFO - PID 24857 | |5;imaging-gaussian-blur;114;115;114;114;113;113;114;114;114;115 04:28:18 INFO - PID 24857 | |6;imaging-darkroom;148;148;148;148;148;147;149;148;151;147 04:28:18 INFO - PID 24857 | |7;imaging-desaturate;95;95;94;94;94;94;94;95;94;95 04:28:18 INFO - PID 24857 | |8;json-parse-financial;48;48;48;50;49;49;50;49;49;48 04:28:18 INFO - PID 24857 | |9;json-stringify-tinderbox;55;55;54;55;54;54;54;54;54;55 04:28:18 INFO - PID 24857 | |10;stanford-crypto-aes;80;80;87;81;80;81;79;81;79;81 04:28:18 INFO - PID 24857 | |11;stanford-crypto-ccm;141;138;125;126;127;137;125;124;173;123 04:28:18 INFO - PID 24857 | |12;stanford-crypto-pbkdf2;180;187;186;180;181;186;190;176;189;183 04:28:18 INFO - PID 24857 | |13;stanford-crypto-sha256-iterative;68;69;66;66;68;66;65;65;70;64 04:28:18 INFO - PID 24857 | __end_tp_report 04:28:18 INFO - PID 24857 | __start_cc_report 04:28:18 INFO - PID 24857 | _x_x_mozilla_cycle_collect,721 04:28:18 INFO - PID 24857 | __end_cc_report 04:28:18 INFO - PID 24857 | __startTimestamp1495106898655__endTimestamp 04:28:18 INFO - PID 24857 | 04:28:18 INFO - PID 24857 | ------- Summary: start ------- 04:28:18 INFO - PID 24857 | Number of tests: 14 04:28:18 INFO - PID 24857 | 04:28:18 INFO - PID 24857 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:2.82 (2.6%) stddev-sans-first:0.71 04:28:18 INFO - PID 24857 | Values: 101.0 109.0 109.0 109.0 109.0 110.0 111.0 110.0 110.0 110.0 04:28:18 INFO - PID 24857 | 04:28:18 INFO - PID 24857 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:127.00 stddev:14.34 (11.3%) stddev-sans-first:14.55 04:28:18 INFO - PID 24857 | Values: 141.0 123.0 131.0 159.0 119.0 118.0 118.0 119.0 144.0 119.0 04:28:18 INFO - PID 24857 | 04:28:18 INFO - PID 24857 | [#2] audio-dft Cycles:10 Average:164.50 Median:163.00 stddev:4.33 (2.7%) stddev-sans-first:4.56 04:28:18 INFO - PID 24857 | Values: 163.0 166.0 162.0 162.0 163.0 163.0 162.0 162.0 166.0 176.0 04:28:18 INFO - PID 24857 | 04:28:18 INFO - PID 24857 | [#3] audio-fft Cycles:10 Average:79.90 Median:75.00 stddev:11.19 (14.9%) stddev-sans-first:11.78 04:28:18 INFO - PID 24857 | Values: 76.0 75.0 75.0 103.0 75.0 74.0 73.0 74.0 99.0 75.0 04:28:18 INFO - PID 24857 | 04:28:18 INFO - PID 24857 | [#4] audio-oscillator Cycles:10 Average:87.30 Median:82.50 stddev:8.55 (10.4%) stddev-sans-first:8.93 04:28:18 INFO - PID 24857 | Values: 83.0 81.0 104.0 83.0 82.0 82.0 96.0 82.0 82.0 98.0 04:28:18 INFO - PID 24857 | 04:28:18 INFO - PID 24857 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:28:18 INFO - PID 24857 | Values: 114.0 115.0 114.0 114.0 113.0 113.0 114.0 114.0 114.0 115.0 04:28:18 INFO - PID 24857 | 04:28:18 INFO - PID 24857 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 04:28:18 INFO - PID 24857 | Values: 148.0 148.0 148.0 148.0 148.0 147.0 149.0 148.0 151.0 147.0 04:28:18 INFO - PID 24857 | 04:28:18 INFO - PID 24857 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:28:18 INFO - PID 24857 | Values: 95.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 95.0 04:28:18 INFO - PID 24857 | 04:28:18 INFO - PID 24857 | [#8] json-parse-financial Cycles:10 Average:48.80 Median:49.00 stddev:0.79 (1.6%) stddev-sans-first:0.78 04:28:18 INFO - PID 24857 | Values: 48.0 48.0 48.0 50.0 49.0 49.0 50.0 49.0 49.0 48.0 04:28:18 INFO - PID 24857 | 04:28:18 INFO - PID 24857 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 04:28:18 INFO - PID 24857 | Values: 55.0 55.0 54.0 55.0 54.0 54.0 54.0 54.0 54.0 55.0 04:28:18 INFO - PID 24857 | 04:28:18 INFO - PID 24857 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:81.00 stddev:2.28 (2.8%) stddev-sans-first:2.40 04:28:18 INFO - PID 24857 | Values: 80.0 80.0 87.0 81.0 80.0 81.0 79.0 81.0 79.0 81.0 04:28:18 INFO - PID 24857 | 04:28:18 INFO - PID 24857 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:132.00 stddev:15.24 (11.5%) stddev-sans-first:15.95 04:28:18 INFO - PID 24857 | Values: 141.0 138.0 125.0 126.0 127.0 137.0 125.0 124.0 173.0 123.0 04:28:18 INFO - PID 24857 | 04:28:18 INFO - PID 24857 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.80 Median:186.00 stddev:4.52 (2.4%) stddev-sans-first:4.58 04:28:18 INFO - PID 24857 | Values: 180.0 187.0 186.0 180.0 181.0 186.0 190.0 176.0 189.0 183.0 04:28:18 INFO - PID 24857 | 04:28:18 INFO - PID 24857 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.95 (2.9%) stddev-sans-first:2.01 04:28:18 INFO - PID 24857 | Values: 68.0 69.0 66.0 66.0 68.0 66.0 65.0 65.0 70.0 64.0 04:28:18 INFO - PID 24857 | -------- Summary: end -------- 04:28:18 INFO - PID 24857 | 04:28:19 INFO - TEST-INFO | 24857: exit 0 04:28:19 INFO - TEST-OK | kraken | took 59939ms 04:28:19 INFO - SUITE-END | took 1171s 04:28:19 INFO - Completed test suite (00:19:31) 04:28:19 INFO - javascript benchmark 04:28:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7788.272540252272, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3342.097633638917, 3354.83225838708, 3375.40930337191, 3388.7289016878653, 3406.795592264463, 5871.588988770788, 5934.2285502884615, 5951.494122999545, 5959.433853783895, 5969.910451343233, 5938.584299099054, 5958.702064896759, 5970.492508136803, 5997.070454079614, 6036.185115009473, 5180.430152683201, 5244.973775131138, 5278.287431196797, 5325.680459172443, 5350.91973620396, 5298.311219541473, 5346.144616861303, 5369.19462080689, 5372.785088596452, 5389.6496727712765, 5233.241180028913, 5316.787328506855, 5373.086575282211, 5422.810201642943, 5442.755076021569, 5265.710385928773, 5285.947140528584, 5309.33633295838, 5359.651622644516, 5366.087765079946, 5212.869678258074, 5224.555912747421, 5240.423553409122, 5245.842624721265, 5263.921041184347, 5908.822735317947, 5913.48676812353, 5948.167256584082, 5950.8809823803285, 5981.401859813984, 6255.968720156416, 6324.430801227912, 6363.7454501819875, 6395.040743888408, 6449.677516124175, 6507.2191337039385, 6513.348665133496, 6518.120053792724, 6534.477241820643, 6536.182977127859, 6035.486983606399, 6048.0, 6049.18336024631, 6061.939380606225, 6063.090536419572, 6346.30190679025, 6427.453666438405, 6509.349065093453, 6572.441342485847, 6589.86820263592, 6290.654014029181, 6323.683815809191, 6324.936750632527, 6327.96836015817, 6332.430081292706, 6217.626942383471, 6385.042243663394, 6425.164728585254, 6446.77436289737, 6457.935420645734, 6270.435660790551, 6317.14718513004, 6402.423781859655, 6429.549931504844, 6440.291567927524, 6412.903806442907, 6446.194225721785, 6448.548601597937, 6453.322401147906, 6453.935460645427, 4849.612031037508, 4883.731394773322, 4886.291487734258, 4903.53416425439, 4941.085899108676, 4282.100758840616, 4317.287647538121, 4380.5838445347645, 4387.188370151533, 4401.713888597231, 6022.09668549721, 6056.66688332146, 6065.727042283108, 6078.1186727924205, 6127.356627554132, 6444.903326450107, 6478.643674597943, 6493.285738568754, 6498.862699027746, 6506.804795856132, 5863.648181109147, 5895.793647222326, 5931.584789064724, 6032.517398608101, 6034.275886893513, 5358.383785864676, 5424.294841670637, 5433.646812957145, 5450.645708029045, 5473.233747275384, 6600.9009864851105, 6628.635425051669, 6652.401283884376, 6664.833379165366, 6670.099536562502, 6426.903596445964, 6440.066190402272, 6456.515761317826, 6484.708188131451, 6505.219373675, 6378.138951241709, 6485.708143133665, 6579.4736421087155, 6667.566608170453, 6705.0, 6389.9361006389345, 6403.679816009274, 6403.7118329676205, 6411.6794160290865, 6426.485881129592, 6486.2216534016225, 6516.73933042692, 6519.054737063194, 6534.052562378523, 6537.378948999837, 6073.362296958756, 6132.20254427538, 6208.503319734501, 6279.340669229665, 6296.590721603081, 6202.131701561875, 6208.0998255253635, 6237.781677641261, 6244.812655620339, 6247.406496382836, 6115.635867915819, 6188.535859810622, 6240.282367527792, 6248.937510624835, 6251.656158911122, 6100.30868792748, 6296.496280297473, 6311.084892690443, 6311.337309582611, 6322.0516922462, 5987.341392446914, 6049.939500604937, 6095.05526643371, 6165.907511387422, 6182.783602573888], "value": 5873.474713703176, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.2099690340626, 763.4426868386078, 777.3509119884898, 785.403093648827, 1109.9722506937321, 29739.25651858702, 37127.81436092819, 37771.43342849852, 37995.810020949924, 38032.80983595078, 39207.41188882169, 39487.802560987155, 39619.0, 39623.80188099063, 39739.60260397395, 7269.4184465242915, 7321.59731214783, 7343.669534870917, 7414.5551266923885, 7518.51129676572, 7474.364679002291, 7503.437242206829, 7504.474686771928, 7510.436717246201, 7553.20691327411, 7510.1738808731, 7526.983857179265, 7534.0, 7558.281963213513, 7574.772756817304, 7535.208803075653, 7540.208278130772, 7568.167501574822, 7577.886331705029, 7580.620968951531, 7403.555786652818, 7423.44324175689, 7449.962750186269, 7460.440466964999, 7465.29079737424, 35568.466473002925, 35895.641043589494, 36056.63943360585, 36310.0, 36468.81765591155, 3501.6848483636595, 3546.0425685065147, 3556.590992035897, 3564.2515071834946, 3575.2313252650547, 29371.706282937324, 29522.11433656994, 29545.40909181826, 29556.408871822445, 29593.40813183746, 3515.753897227195, 3549.7870127792157, 3575.87484438046, 3587.228745819635, 3599.892003239881, 202581.0, 202826.0, 203338.0, 213491.0, 214377.0, 46542.53457465382, 46737.0, 46776.28191348458, 46887.29669054967, 46993.0, 48323.516764831904, 48402.75798620984, 48418.0, 48534.27198592024, 48586.27120593123, 15127.428337182706, 15223.086614803147, 15278.236088195546, 15294.464693735667, 15310.693786124215, 12327.137100402886, 12369.567065152676, 12397.256164630151, 12429.254244745343, 12490.687732806753, 14132.293385330693, 14229.14625122496, 14245.0, 14252.643683907778, 14296.356663950148, 5861.648301101947, 5960.1059841023325, 6014.939850601438, 6045.274567051982, 6144.07838824171, 1066.6053560182781, 1112.57165991094, 1119.7928383248961, 1121.74199934014, 1122.4163435013747, 26381.47237055248, 26690.733092669212, 26698.5995210072, 26711.465770684867, 26849.463010739677, 1201.0931746531312, 1212.4301578258205, 1213.3811756004325, 1235.5799028330232, 1242.521629172757, 13476.39356228972, 13578.796318055238, 13695.589132326046, 13808.585742427744, 13843.238621875893, 254309.0, 257436.0, 258221.0, 258408.0, 258666.0, 53328.0, 53856.0, 53958.0, 54206.7289663557, 54320.185197222076, 1454.4836583013089, 1507.5854140111337, 1554.0442627783832, 1557.4471062772552, 1557.9298931548108, 23729.406764830328, 25081.247562573153, 25177.98902235248, 25193.0, 25424.491510169322, 37772.0, 37808.24383512369, 37867.431988520744, 37952.0, 37985.62014379821, 202150.0, 203464.0, 203518.0, 204570.0, 205298.0, 33286.66713332836, 34458.655413445544, 35562.64437355697, 35663.28673426465, 36227.27545449129, 42281.365779513944, 42320.1535969285, 44229.0, 44255.557444426435, 44916.55083449124, 32232.35535289328, 32521.02436926896, 32746.672533274363, 33038.33923321472, 33386.0, 32339.19152021218, 32731.0, 32983.50524742083, 33046.83476582602, 33442.0, 37462.250754985296, 37569.2486150281, 38366.424503633025, 38899.0, 39195.21609567736, 31168.376632467676, 31212.687873120976, 31432.214194645316, 31524.0, 32029.199270018435, 23820.0, 26433.73566264313, 26727.732722672525, 26785.732142679102, 26866.462670746867], "value": 17196.49462327852, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.8086832227983, 446.4018215591107, 448.5245639622001, 463.69859591265697, 466.3983461334878, 18630.254789808427, 19896.0, 20348.38954831354, 20448.137260783504, 20631.174753009862, 21975.560488790255, 22457.663135052946, 22941.655875161887, 23261.302160935156, 23456.64815027776, 5449.509544141037, 5617.297837770278, 5623.156526521014, 5633.549316054706, 5636.887262254752, 5279.1817268323475, 5492.0, 5515.944840551603, 5525.198846167304, 5527.336719593634, 5454.481824226692, 5463.235147079412, 5471.616986810925, 5484.561235101182, 5503.422140675231, 5341.545968592674, 5520.6687598744, 5524.58565607579, 5550.91673624896, 5561.416051314594, 5000.399952005746, 5032.471590482984, 5058.620603454756, 5060.139776238048, 5064.721440320781, 25189.74810251911, 25406.872965635237, 25449.236522904343, 25696.0, 25811.612825807628, 2104.4844013216707, 2128.8296936245065, 2140.4327853118934, 2142.4108370198164, 2143.19630138698, 17149.228284727218, 17575.12124393788, 17584.824151758447, 17750.822491775176, 17859.73210401845, 1994.331898813899, 2033.7661168965462, 2083.624947509448, 2092.5082605587677, 2241.4620491082187, 109472.8887960906, 113071.43464282708, 113477.99999999917, 113495.43252283768, 114902.0, 12480.937595311965, 12686.0, 12790.680232994064, 12830.935845320713, 12907.290099044454, 17825.554361141076, 17834.910825446048, 17865.0, 17893.926364417915, 17906.28374865017, 9033.864492032624, 9333.300002499704, 9401.10689484498, 9419.387739797028, 9473.0, 8382.664693412316, 8557.657693692183, 8616.78458038554, 8650.178233067974, 8787.604557794915, 7947.841043179104, 8039.67841286342, 8058.959314711552, 8215.34277257818, 8227.762702208367, 2259.7175353080866, 2277.4078739527513, 2330.382448651109, 2341.5433990372053, 2513.2585887162963, 1009.1271050541229, 1051.6529545250048, 1053.1522124689698, 1054.715226888751, 1056.0495554001461, 19760.0, 20975.26586569493, 21206.363809085753, 21208.74972681931, 21392.0, 1074.409075008742, 1077.5635867473686, 1079.2499213046858, 1082.0910435234441, 1083.7290677330668, 10434.791304173874, 11279.830802537968, 11358.716032099099, 11388.601398951163, 11429.942850285861, 455585.0, 459505.0, 460639.0, 510754.0, 523163.0, 95019.0, 96534.0, 97865.51067244618, 99051.50474247582, 102932.48533757283, 1252.3425201769144, 1273.2042473454092, 1308.9934550327378, 1318.8021796730568, 1320.1353113710536, 19813.405597832087, 19821.60356792885, 20326.390208293775, 20399.388018359474, 20796.1681532737, 45782.31326530172, 47385.52614473949, 47924.52075479201, 48528.272075919594, 49363.25955110748, 59115.70442147762, 59789.40210598012, 59944.40055599388, 60295.39704602898, 61272.0, 9700.466474343979, 9717.85423218638, 9729.513524323615, 9892.851607225753, 9966.202703783534, 14887.032342897677, 15007.624809379853, 15173.924130379277, 15239.619009524407, 15807.841921580637, 12186.329751863732, 12507.56223532172, 12821.0, 12984.610461686165, 13254.469821207043, 11846.822297665369, 12228.0, 12312.507499699912, 12542.435590398272, 13012.869871301165, 12926.224426534438, 13102.0, 13170.868291316965, 13270.469181232642, 13416.329183540589, 9720.562574684014, 9779.511024448891, 9867.802643946938, 10032.0, 10039.096481316716, 12764.936175319064, 13476.32618369058, 13514.59456216315, 13753.862461375658, 13873.653158671113], "value": 10303.283899431879, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.9171449713017, 1421.665908511499, 1431.0412023943957, 1440.1287221231155, 1447.0015689174468, 11324.377159256248, 11718.296902185853, 11786.587469438571, 11844.703882402933, 12136.271823690584, 11751.0, 11771.882281177186, 11835.171537992344, 11920.225185362968, 11923.880761192386, 2323.5352929414144, 2354.8822558872075, 2355.6231003039516, 2357.846739961897, 2360.858348499087, 2285.268714011517, 2338.4972230970425, 2343.5430091132234, 2347.9647805282934, 2355.422921384263, 2143.431990522513, 2149.9892500537476, 2173.3588591365506, 2179.08478439056, 2183.3995651195887, 2301.666258392532, 2307.8384513084093, 2354.658574506687, 2355.5406695694346, 2359.2214569192124, 2210.6573481110454, 2243.955120897589, 2252.5044490212126, 2282.3723476044056, 2289.107248173197, 11595.826062609067, 11694.298342099417, 11714.297142171497, 11740.88259117415, 11800.173987820855, 6626.900596491057, 6812.897806532906, 6833.453323734089, 6835.69239384224, 6847.383735463832, 3788.2612890486366, 3992.9201415971806, 4054.7567145971334, 4062.73592216505, 4102.118044620421, 1318.0312470334297, 1321.8876395506393, 1365.5766712319114, 1371.2115533568137, 1384.2525036480288, 17586.12069396525, 17800.55498612532, 17806.643867122715, 17811.554711132198, 17818.91090544552, 5040.47075057121, 5117.437081920985, 5302.3637163540625, 5353.0899747043095, 5429.294191755125, 12527.0, 12559.560415385418, 12636.305003224727, 12644.936775316064, 12660.746785064248, 6557.639329836809, 6573.539852210395, 6576.86846263072, 6579.769708060195, 6585.736570537125, 5923.555733320019, 6055.031195008777, 6106.328303886569, 6112.266528016667, 6223.1287619733275, 3985.6278183703266, 4051.331530297468, 4167.603178646496, 4214.978925105416, 4219.683523735732, 1169.479581586186, 1184.490669012333, 1191.237607930925, 1195.8923696867323, 1207.3359652191434, 874.3224001398839, 894.6689724801865, 910.544727636182, 917.3899356927568, 926.5691453474167, 6547.836304092436, 6596.10952521413, 6605.306442823435, 6609.074729537869, 6685.866282674319, 664.930182330858, 665.0356982375478, 666.7666316789182, 667.2393471442559, 680.557637535596, 4026.1746342000406, 4127.6491498222385, 4613.331066995267, 4668.206404911173, 4683.461401938821, 14449.927750361181, 15281.847181528043, 15339.386424542894, 15360.308786104652, 15533.611659708371, 15021.774673379909, 15481.612959676098, 15485.380584776709, 15586.610334741723, 15600.29798659063, 9091.27269818413, 9382.437053776795, 9390.530473476436, 9397.342186046912, 9445.527723613792, 7380.409567234501, 7458.067741532309, 7537.095548534211, 7594.392448603988, 7768.689252429839, 13303.0, 13798.517051903134, 13952.720945580828, 13976.371063301973, 13982.091164074303, 13653.453861845415, 13813.378397971914, 14073.507427239998, 14094.0, 14141.787873181705, 9689.83721953342, 9707.126358627758, 9732.464714440774, 9847.950760246153, 9874.0, 10761.40812255302, 11025.0, 11052.0, 11081.335119892832, 11136.777264454504, 9284.257259419366, 9411.858822117536, 9471.810563788547, 9528.285378596494, 9756.51217439111, 9412.576434060347, 9415.681804547232, 9468.573914174016, 9470.052994700474, 9635.22918166531, 8441.873371899304, 8511.872321915052, 8578.056413794602, 8681.21869031765, 8697.478151310941, 6254.874902502015, 6329.525285603506, 6374.362563743589, 6403.871922561616, 6515.576487528296, 6276.592021518587, 6306.716197771019, 6483.578567393104, 6650.966745166436, 6683.298253683488], "value": 5404.452190673194, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.83920753283616, 387.2294134672003, 387.6569236225941, 393.5769048273107, 394.46155997064, 6096.329403765582, 6162.137300777889, 6187.350328215534, 6200.906986395202, 6246.688195478943, 5986.461218490346, 6077.02767557191, 6082.543809214316, 6107.206063211787, 6111.847203819907, 4642.210824159893, 4701.743163281627, 4707.576318131368, 4718.882027949311, 4729.69256998294, 4701.553352431513, 4705.29420586913, 4716.622670186377, 4728.0, 4752.952470475303, 4626.259798432252, 4697.600703940169, 4721.598664113537, 4745.715257084568, 4762.952370476286, 4680.227762419197, 4687.5937218834215, 4719.740414277213, 4723.433188017426, 4728.739919304437, 4174.4364510791265, 4187.539370669224, 4213.220554197453, 4220.155968806221, 4220.767857767822, 5925.970370148121, 5942.940570594325, 6016.278046634388, 6042.365551617061, 6042.667653279068, 5530.778768849241, 5592.972035139798, 5605.383407825136, 5614.0, 5625.38120806711, 6490.332961876525, 6529.11856899322, 6533.640649764261, 6559.0, 6561.573497722633, 4725.598324142452, 4770.379850619432, 4771.642126840501, 4800.199925028114, 4841.346418233528, 6557.803265901983, 6736.528443008991, 6836.589804611689, 6842.486813488958, 6864.24493305741, 4704.1767690654, 4744.4069491313585, 4753.667243292936, 4762.380890484214, 4763.73799441034, 4812.5668689818085, 4813.061453016629, 4814.181589129857, 4827.179379505493, 4827.61379089672, 5431.755570999315, 5435.864103397367, 5444.156155795858, 5500.42245564218, 5504.174373843955, 6516.0, 6529.11856899322, 6537.673116344164, 6546.18172728409, 6552.967235163889, 1698.72595553335, 1748.160882776249, 1767.646470705864, 1770.725537541683, 1772.2556526259002, 1204.5302332090491, 1227.766724322376, 1233.2292317301687, 1242.353975932528, 1251.9061070419573, 6072.544559158081, 6102.816915492543, 6105.694715264219, 6116.327204007555, 6132.0, 6573.244076931119, 6599.7360105595235, 6640.169978752656, 6653.035309880137, 6680.96659516709, 5987.550933679991, 6029.577929544977, 6112.0, 6115.266168059772, 6128.4790792783115, 3492.633273506296, 3501.9824900875333, 3523.524324216249, 3531.446163687969, 3552.2185119273718, 6731.427828634621, 6848.3494068063455, 6885.552439091443, 6907.758228461979, 6917.412019978257, 6755.594664320157, 6795.456363490909, 6826.419754320938, 6831.521793474509, 6859.691313890887, 6732.663366831639, 6904.0, 6918.93081069193, 6964.965175174092, 7007.6145811978795, 6623.701933413105, 6709.295523969913, 6723.495737819585, 6734.831629209309, 6741.157355330583, 6455.2576453708425, 6477.190351206099, 6609.306022867722, 6675.399214070757, 6684.328917770557, 6890.276520965226, 6902.620355880274, 6927.3419025192525, 6971.825704357431, 7023.929760702327, 4454.129265708475, 4479.46246450428, 4489.820407183806, 4491.842785502622, 4513.909721805479, 6541.953287473982, 6634.436072933855, 6766.221884483348, 6780.864382712417, 6802.489813263926, 6468.062130991074, 6496.545241833026, 6536.379043990813, 6557.901631475436, 6585.20977482686, 6388.233411990405, 6465.77369792055, 6514.185726784152, 6548.705308261045, 6574.769883054261, 6417.7753778617525, 6459.806205813833, 6481.902771458337, 6484.870302593828, 6512.772052978123, 6386.712597933197, 6413.262474815269, 6507.869842603216, 6575.572587781779, 6576.079348891063, 6324.873502530016, 6348.396902294275, 6350.666360064438, 6391.552591318563, 6403.423691867568], "value": 4961.878246070989, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.6926967752253, 846.1538461538462, 846.5978660136435, 852.3735054734769, 853.9829203415932, 16560.503184904443, 16600.833991660078, 17067.573310667223, 18081.367152149644, 18612.81387186128, 17670.734938975893, 18160.0, 18269.177886995083, 18400.0, 18408.355707550207, 953.213598781005, 978.7553111722069, 985.0887928665991, 986.9703908882746, 988.5156273426005, 995.6266400099962, 999.0708640963901, 1000.4697510319506, 1002.6941782756256, 1006.0040559845773, 1040.4277647293995, 1042.4475028235047, 1048.9003544663244, 1050.385524468187, 1052.4264275969615, 1043.2697112021615, 1044.2846650044744, 1048.7116043088135, 1049.04536871447, 1050.4695128959866, 720.2833180984953, 736.2269616902231, 736.5359823311334, 740.8407192453594, 742.3689863615883, 16337.836621633869, 16393.67212655752, 16437.917810410872, 16482.093484858327, 16483.175841208013, 16883.83116168847, 18017.639647207114, 18806.81193188078, 18823.341183058663, 18924.43226703201, 14190.21953792541, 14419.495317663832, 14515.564533064025, 14526.636834079127, 14663.92668036653, 3446.3796516627, 3479.5476588043393, 3480.7041401480906, 3483.4948932404914, 3493.074335301147, 95128.0, 95639.52180239125, 95828.52085739597, 96250.51874740582, 97290.51354743181, 13005.674858128623, 13014.609561713163, 13027.47890084405, 13181.868181318065, 13219.206847589176, 25016.87491562567, 26402.6039609406, 26510.0, 26912.327191819968, 26940.057098001475, 7741.225877412214, 7837.255460731221, 7850.528968261922, 7888.092869320101, 7914.564698941614, 3836.8848934532007, 3931.1154990126993, 3945.585713500099, 3964.0288129407904, 3981.323175060189, 4288.0, 4333.155034768253, 4374.496932852699, 4376.474823021258, 4377.846775362847, 790.0835031363705, 812.5043723328765, 814.1573471457132, 815.8001289684065, 816.5794615772882, 720.6036679826075, 724.4240828541323, 728.8250819803209, 735.4447392218948, 760.1676164599754, 11735.823962640567, 11870.703232419259, 12022.0, 13035.413406396736, 13309.600711978655, 722.989155162673, 727.1637616740791, 728.8250819803209, 729.1833146875427, 729.241588747707, 5484.890302193934, 5643.689597072118, 5721.742521586539, 5737.8565535861935, 5834.095715164156, 82091.0, 82183.58908205421, 84036.15963840284, 84780.57609712036, 85552.0, 73428.26571734321, 75057.62471187719, 76641.61679191569, 77132.22867771363, 78072.60963695259, 67595.66202168958, 68236.0, 68506.65746671235, 69463.30536694669, 69893.0, 11157.386343751172, 11243.775124497628, 11462.656120316404, 11551.88448115508, 11576.768464630828, 36167.45748813823, 37483.250334992605, 37831.43252851265, 37994.24011519699, 38037.0, 43655.78172109119, 44264.77867610641, 44410.555894440644, 45364.0, 45956.7702161487, 13976.371063301973, 14080.577582672537, 14102.153870767786, 14138.717225655635, 14409.855901440851, 15025.323860426088, 15143.318550665466, 15194.164320962453, 15577.84422155764, 15584.84415155834, 15107.697846042798, 15234.619134521725, 15285.77071343953, 15347.539573812803, 15582.0, 13706.588802335946, 14001.299935003006, 14051.086679365808, 14109.082909610843, 14136.43454261818, 15006.624834379229, 15148.924255379094, 15157.621059473602, 15306.15816130079, 15501.689966200838, 10537.315074520131, 10733.248672593156, 10754.193435492525, 10839.403832789272, 10851.837222441827, 11224.55101795919, 11584.884151158381, 11740.119491038377, 11749.647510574696, 11789.0], "value": 7996.674233087603, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1494.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 109.0, 109.0, 109.0, 110.0, 111.0, 110.0, 110.0, 110.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 123.0, 131.0, 159.0, 119.0, 118.0, 118.0, 119.0, 144.0, 119.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 162.0, 162.0, 163.0, 163.0, 162.0, 162.0, 166.0, 176.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 103.0, 75.0, 74.0, 73.0, 74.0, 99.0, 75.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 104.0, 83.0, 82.0, 82.0, 96.0, 82.0, 82.0, 98.0], "value": 87.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 114.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 149.0, 148.0, 151.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 48.0, 50.0, 49.0, 49.0, 50.0, 49.0, 49.0, 48.0], "value": 48.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 87.0, 81.0, 80.0, 81.0, 79.0, 81.0, 79.0, 81.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 138.0, 125.0, 126.0, 127.0, 137.0, 125.0, 124.0, 173.0, 123.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 187.0, 186.0, 180.0, 181.0, 186.0, 190.0, 176.0, 189.0, 183.0], "value": 183.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 66.0, 66.0, 68.0, 66.0, 65.0, 65.0, 70.0, 64.0], "value": 66.7, "unit": "score"}]}]} 04:28:19 INFO - Return code: 0 04:28:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:28:19 INFO - # TBPL SUCCESS # 04:28:19 INFO - Running post-action listener: _resource_record_post_action 04:28:19 INFO - [mozharness: 2017-05-18 11:28:19.980137Z] Finished run-tests step (success) 04:28:19 INFO - Running post-run listener: _resource_record_post_run 04:28:20 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 434253824; Read time: 20; Write time: 361632 04:28:20 INFO - TinderboxPrint: CPU usage
13.2% 04:28:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 04:28:20 INFO - TinderboxPrint: I/O write bytes / time
434,253,824 / 361,632 04:28:20 INFO - TinderboxPrint: CPU idle
8,240.8 (86.8%) 04:28:20 INFO - TinderboxPrint: CPU user
1,199.4 (12.6%) 04:28:20 INFO - TinderboxPrint: Swap in / out
0 / 0 04:28:20 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 109166592; Read time: 0; Write time: 79704 04:28:20 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 323964928; Read time: 0; Write time: 281884 04:28:20 INFO - Running post-run listener: _upload_blobber_files 04:28:20 INFO - Blob upload gear active. 04:28:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:28:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:28:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:28:21 INFO - (blobuploader) - INFO - Open directory for files ... 04:28:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:28:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:28:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:26 INFO - (blobuploader) - INFO - Done attempting. 04:28:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:28:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:28:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:27 INFO - (blobuploader) - INFO - Done attempting. 04:28:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:28:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:28:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:28 INFO - (blobuploader) - INFO - Done attempting. 04:28:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:28:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:28:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:29 INFO - (blobuploader) - INFO - Done attempting. 04:28:29 INFO - (blobuploader) - INFO - Iteration through files over. 04:28:29 INFO - Return code: 0 04:28:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:28:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:28:29 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd7dfefb9aec000818daccfc5af166250d2aed54d86a9837bf14172d1908b5ef4f64ba7bb6ca162c6db5c747d3ac5e6341ad438f3e45b0d218838de29ddc59a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71cd62399038a29b61e49223a5a8ca4fb10b6ba296e4d328dcfa85554ce4b4b1428810f97da723364b785369d76a77b70fddd8b2d5dc91a7b9b49581e0f83117", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f367af967e3810c8adccc276e4f843ff11e6ebe077db667a4ea94bfdb368ede693a77c641cdc85abfbd1eb782d9fc0a96ec6c1472c1255b35a11e4b3794f740", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e68b5a7d05edbdc703a801aade980728f9c54605365315291e4161ec207c7d2b7723d35384eb059ae514092bcb5969b1686bfee6bc8fb3cc0f4917e27b858b5a"} 04:28:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:28:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:28:29 INFO - Contents: 04:28:29 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd7dfefb9aec000818daccfc5af166250d2aed54d86a9837bf14172d1908b5ef4f64ba7bb6ca162c6db5c747d3ac5e6341ad438f3e45b0d218838de29ddc59a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71cd62399038a29b61e49223a5a8ca4fb10b6ba296e4d328dcfa85554ce4b4b1428810f97da723364b785369d76a77b70fddd8b2d5dc91a7b9b49581e0f83117", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f367af967e3810c8adccc276e4f843ff11e6ebe077db667a4ea94bfdb368ede693a77c641cdc85abfbd1eb782d9fc0a96ec6c1472c1255b35a11e4b3794f740", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e68b5a7d05edbdc703a801aade980728f9c54605365315291e4161ec207c7d2b7723d35384eb059ae514092bcb5969b1686bfee6bc8fb3cc0f4917e27b858b5a"} 04:28:29 INFO - Running post-run listener: copy_logs_to_upload_dir 04:28:29 INFO - Copying logs to upload dir... 04:28:29 INFO - mkdir: /builds/slave/test/build/upload/logs 04:28:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.960866 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-05-18 04:28:29.100080) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-18 04:28:29.103342) ========= 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=8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198 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/fd7dfefb9aec000818daccfc5af166250d2aed54d86a9837bf14172d1908b5ef4f64ba7bb6ca162c6db5c747d3ac5e6341ad438f3e45b0d218838de29ddc59a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71cd62399038a29b61e49223a5a8ca4fb10b6ba296e4d328dcfa85554ce4b4b1428810f97da723364b785369d76a77b70fddd8b2d5dc91a7b9b49581e0f83117", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f367af967e3810c8adccc276e4f843ff11e6ebe077db667a4ea94bfdb368ede693a77c641cdc85abfbd1eb782d9fc0a96ec6c1472c1255b35a11e4b3794f740", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e68b5a7d05edbdc703a801aade980728f9c54605365315291e4161ec207c7d2b7723d35384eb059ae514092bcb5969b1686bfee6bc8fb3cc0f4917e27b858b5a"} build_url:https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011207 build_url: 'https://queue.taskcluster.net/v1/task/eSx1ujILQsSaVYkb-6lnbQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fd7dfefb9aec000818daccfc5af166250d2aed54d86a9837bf14172d1908b5ef4f64ba7bb6ca162c6db5c747d3ac5e6341ad438f3e45b0d218838de29ddc59a5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71cd62399038a29b61e49223a5a8ca4fb10b6ba296e4d328dcfa85554ce4b4b1428810f97da723364b785369d76a77b70fddd8b2d5dc91a7b9b49581e0f83117", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f367af967e3810c8adccc276e4f843ff11e6ebe077db667a4ea94bfdb368ede693a77c641cdc85abfbd1eb782d9fc0a96ec6c1472c1255b35a11e4b3794f740", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e68b5a7d05edbdc703a801aade980728f9c54605365315291e4161ec207c7d2b7723d35384eb059ae514092bcb5969b1686bfee6bc8fb3cc0f4917e27b858b5a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-18 04:28:29.128578) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 04:28:29.128994) ========= 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=8887e36bb8e381bfd44124ac000001a8-1495095424.30238-512198198 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 04:28:29.215423) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-18 04:28:29.216167) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-18 04:28:29.216729) ========= ========= Total master_lag: 0.27 =========