builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-071 starttime: 1495112164.15 results: success (0) revision: 2fa6931995b23f1f39752385b6689dc6b8d94c1b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-18 05:56:04.153780) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-18 05:56:04.154251) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-18 05:56:04.154526) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-18 05:56:04.241125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 05:56:04.241409) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-18 05:56:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 49.6M=0s 2017-05-18 05:56:04 (49.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106827 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 05:56:04.360806) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 05:56:04.361140) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022698 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 05:56:04.410689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 05:56:04.414080) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2fa6931995b23f1f39752385b6689dc6b8d94c1b --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 2fa6931995b23f1f39752385b6689dc6b8d94c1b --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=dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-18 05:56:05,016 truncating revision to first 12 chars 2017-05-18 05:56:05,016 Setting DEBUG logging. 2017-05-18 05:56:05,016 attempt 1/10 2017-05-18 05:56:05,016 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2fa6931995b2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-18 05:56:05,439 unpacking tar archive at: mozilla-central-2fa6931995b2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.738045 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 05:56:05.165314) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-18 05:56:05.165611) ========= script_repo_revision: 2fa6931995b23f1f39752385b6689dc6b8d94c1b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-18 05:56:05.168996) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-18 05:56:05.169263) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-18 05:56:05.177470) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-18 05:56:05.177730) ========= /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=dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:56:05 INFO - MultiFileLogger online at 20170518 05:56:05 in /builds/slave/test 05:56:05 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 05:56:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:56:05 INFO - {'append_to_log': False, 05:56:05 INFO - 'base_work_dir': '/builds/slave/test', 05:56:05 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:56:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:56:05 INFO - 'branch': 'Firefox-Non-PGO', 05:56:05 INFO - 'buildbot_json_path': 'buildprops.json', 05:56:05 INFO - 'config_files': ('talos/linux_config.py',), 05:56:05 INFO - 'default_actions': ('clobber', 05:56:05 INFO - 'read-buildbot-config', 05:56:05 INFO - 'download-and-extract', 05:56:05 INFO - 'populate-webroot', 05:56:05 INFO - 'create-virtualenv', 05:56:05 INFO - 'install', 05:56:05 INFO - 'run-tests'), 05:56:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:56:05 INFO - 'download_minidump_stackwalk': True, 05:56:05 INFO - 'download_symbols': 'ondemand', 05:56:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:56:05 INFO - 'tooltool.py': '/tools/tooltool.py', 05:56:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:56:05 INFO - '/tools/misc-python/virtualenv.py')}, 05:56:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:56:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:56:05 INFO - 'gecko_profile': False, 05:56:05 INFO - 'gecko_profile_interval': 0, 05:56:05 INFO - 'installer_path': 'installer.exe', 05:56:05 INFO - 'log_level': 'info', 05:56:05 INFO - 'log_name': 'talos', 05:56:05 INFO - 'log_to_console': True, 05:56:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:56:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:56:05 INFO - 'opt_config_files': (), 05:56:05 INFO - 'pip_index': False, 05:56:05 INFO - 'suite': 'dromaeojs-e10s', 05:56:05 INFO - 'system_bits': '32', 05:56:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:56:05 INFO - 'title': 'talos-linux64-ix-071', 05:56:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:56:05 INFO - 'use_talos_json': True, 05:56:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:56:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:56:05 INFO - 'work_dir': 'build'} 05:56:05 INFO - [mozharness: 2017-05-18 12:56:05.881515Z] Running clobber step. 05:56:05 INFO - Running pre-action listener: _resource_record_pre_action 05:56:05 INFO - Running main action method: clobber 05:56:05 INFO - rmtree: /builds/slave/test/build 05:56:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:56:07 INFO - Running post-action listener: _resource_record_post_action 05:56:07 INFO - [mozharness: 2017-05-18 12:56:07.404944Z] Finished clobber step (success) 05:56:07 INFO - [mozharness: 2017-05-18 12:56:07.405042Z] Running read-buildbot-config step. 05:56:07 INFO - Running pre-action listener: _resource_record_pre_action 05:56:07 INFO - Running main action method: read_buildbot_config 05:56:07 INFO - Using buildbot properties: 05:56:07 INFO - { 05:56:07 INFO - "project": "", 05:56:07 INFO - "product": "firefox", 05:56:07 INFO - "who": "cbook@mozilla.com", 05:56:07 INFO - "installer_path": "public/build/target.tar.bz2", 05:56:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:56:07 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:56:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:56:07 INFO - "stage_platform": "linux64", 05:56:07 INFO - "basedir": "/builds/slave/test", 05:56:07 INFO - "buildnumber": 614, 05:56:07 INFO - "platform": "ubuntu64_hw", 05:56:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:56:07 INFO - "slavebuilddir": "test", 05:56:07 INFO - "taskId": "egR0tb6mQx2CpWXNBVh-xw", 05:56:07 INFO - "branch": "mozilla-central", 05:56:07 INFO - "script_repo_revision": "production", 05:56:07 INFO - "revision": "2fa6931995b23f1f39752385b6689dc6b8d94c1b", 05:56:07 INFO - "slavename": "talos-linux64-ix-071", 05:56:07 INFO - "repo_path": "mozilla-central" 05:56:07 INFO - } 05:56:07 INFO - Finding installer, test and symbols from parent task. 05:56:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/egR0tb6mQx2CpWXNBVh-xw'}, attempt #1 05:56:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/egR0tb6mQx2CpWXNBVh-xw'}, attempt #1 05:56:08 INFO - Task dependencies: KtwpRYHvSpO5mzdHiFjTsQ 05:56:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ'}, attempt #1 05:56:08 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.tar.bz2 05:56:08 INFO - Set test_url: https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/test_packages.json 05:56:08 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.crashreporter-symbols.zip 05:56:08 INFO - Running post-action listener: _resource_record_post_action 05:56:08 INFO - [mozharness: 2017-05-18 12:56:08.791159Z] Finished read-buildbot-config step (success) 05:56:08 INFO - [mozharness: 2017-05-18 12:56:08.791380Z] Running download-and-extract step. 05:56:08 INFO - Running pre-action listener: _resource_record_pre_action 05:56:08 INFO - Running main action method: download_and_extract 05:56:08 INFO - mkdir: /builds/slave/test/build/tests 05:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:08 INFO - trying https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.test_packages.json 05:56:08 INFO - Downloading https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:56:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:56:09 INFO - Downloaded 986 bytes. 05:56:09 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:56:09 INFO - Using the following test package requirements: 05:56:09 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:56:09 INFO - u'common': [u'target.common.tests.zip'], 05:56:09 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:56:09 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:56:09 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:56:09 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:56:09 INFO - u'mozbase': [u'target.common.tests.zip'], 05:56:09 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:56:09 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:56:09 INFO - u'web-platform': [u'target.common.tests.zip', 05:56:09 INFO - u'target.web-platform.tests.zip'], 05:56:09 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:56:09 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:56:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.common.tests.zip 05:56:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:56:09 INFO - Fetch https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.common.tests.zip into memory 05:56:11 INFO - Content-Length response header: 62462502 05:56:11 INFO - Bytes received: 62462502 05:56:22 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:56:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.common.tests.zip 05:56:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:56:22 INFO - Fetch https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.common.tests.zip into memory 05:56:23 INFO - Content-Length response header: 62462502 05:56:23 INFO - Bytes received: 62462502 05:56:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.talos.tests.zip 05:56:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:56:35 INFO - Fetch https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.talos.tests.zip into memory 05:56:36 INFO - Content-Length response header: 14410001 05:56:36 INFO - Bytes received: 14410001 05:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:36 INFO - trying https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.tar.bz2 05:56:36 INFO - Downloading https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:56:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:56:38 INFO - Downloaded 58094991 bytes. 05:56:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.tar.bz2 05:56:38 INFO - mkdir: /builds/slave/test/properties 05:56:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:56:38 INFO - Writing to file /builds/slave/test/properties/build_url 05:56:38 INFO - Contents: 05:56:38 INFO - build_url:https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.tar.bz2 05:56:38 INFO - Running post-action listener: _resource_record_post_action 05:56:38 INFO - Running post-action listener: set_extra_try_arguments 05:56:38 INFO - [mozharness: 2017-05-18 12:56:38.098851Z] Finished download-and-extract step (success) 05:56:38 INFO - [mozharness: 2017-05-18 12:56:38.098949Z] Running populate-webroot step. 05:56:38 INFO - Running pre-action listener: _resource_record_pre_action 05:56:38 INFO - Running main action method: populate_webroot 05:56:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:56:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:56:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:56:38 INFO - '--tppagecycles', 05:56:38 INFO - '7'], 05:56:38 INFO - 'tests': ['tsvgm']}}, 05:56:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:56:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:56:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:56:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:56:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:56:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:56:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:56:38 INFO - 'talos_options': ['--disable-e10s'], 05:56:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:56:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:56:38 INFO - 'talos_options': ['--disable-e10s'], 05:56:38 INFO - 'tests': ['damp', 'tps']}, 05:56:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:56:38 INFO - 'tests': ['damp', 'tps']}, 05:56:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:56:38 INFO - 'tests': ['dromaeo_dom']}, 05:56:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:56:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:56:38 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:56:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:56:38 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:56:38 INFO - 'tests': ['ts_paint', 'tp5o']}, 05:56:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:56:38 INFO - 'tests': ['a11yr', 05:56:38 INFO - 'ts_paint', 05:56:38 INFO - 'tpaint', 05:56:38 INFO - 'sessionrestore', 05:56:38 INFO - 'sessionrestore_no_auto_restore', 05:56:38 INFO - 'tabpaint']}, 05:56:38 INFO - 'other-e10s': {'tests': ['a11yr', 05:56:38 INFO - 'ts_paint', 05:56:38 INFO - 'tpaint', 05:56:38 INFO - 'sessionrestore', 05:56:38 INFO - 'sessionrestore_no_auto_restore', 05:56:38 INFO - 'tabpaint']}, 05:56:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:56:38 INFO - 'ts_paint', 05:56:38 INFO - 'tpaint', 05:56:38 INFO - 'sessionrestore', 05:56:38 INFO - 'sessionrestore_no_auto_restore', 05:56:38 INFO - 'tabpaint']}, 05:56:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:56:38 INFO - 'ts_paint', 05:56:38 INFO - 'tpaint', 05:56:38 INFO - 'sessionrestore', 05:56:38 INFO - 'sessionrestore_no_auto_restore', 05:56:38 INFO - 'tabpaint']}, 05:56:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:56:38 INFO - 'tests': ['a11yr', 05:56:38 INFO - 'ts_paint', 05:56:38 INFO - 'tpaint', 05:56:38 INFO - 'sessionrestore', 05:56:38 INFO - 'sessionrestore_no_auto_restore', 05:56:38 INFO - 'tabpaint']}, 05:56:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:56:38 INFO - 'tests': ['a11yr', 05:56:38 INFO - 'ts_paint', 05:56:38 INFO - 'tpaint', 05:56:38 INFO - 'sessionrestore', 05:56:38 INFO - 'sessionrestore_no_auto_restore', 05:56:38 INFO - 'tabpaint']}, 05:56:38 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:56:38 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:56:38 INFO - 'bloom_basic_ref']}, 05:56:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:56:38 INFO - 'tests': ['tsvgx', 05:56:38 INFO - 'tsvgr_opacity', 05:56:38 INFO - 'tart', 05:56:38 INFO - 'tscrollx', 05:56:38 INFO - 'cart', 05:56:38 INFO - 'tsvg_static']}, 05:56:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:56:38 INFO - 'tsvgr_opacity', 05:56:38 INFO - 'tart', 05:56:38 INFO - 'tscrollx', 05:56:38 INFO - 'cart', 05:56:38 INFO - 'tsvg_static']}, 05:56:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:56:38 INFO - 'talos_options': ['--disable-e10s'], 05:56:38 INFO - 'tests': ['tp5o']}, 05:56:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:56:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:56:38 INFO - 'talos_options': ['--disable-e10s', 05:56:38 INFO - '--xperf_path', 05:56:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:38 INFO - 'tests': ['tp5n']}, 05:56:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:56:38 INFO - 'talos_options': ['--xperf_path', 05:56:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:38 INFO - 'tests': ['tp5n']}}, 05:56:38 INFO - 'talos.zip': {'path': '', 05:56:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:56:38 INFO - Running post-action listener: _resource_record_post_action 05:56:38 INFO - [mozharness: 2017-05-18 12:56:38.114757Z] Finished populate-webroot step (success) 05:56:38 INFO - [mozharness: 2017-05-18 12:56:38.114846Z] Running create-virtualenv step. 05:56:38 INFO - Running pre-action listener: _resource_record_pre_action 05:56:38 INFO - Running main action method: create_virtualenv 05:56:38 INFO - Creating virtualenv /builds/slave/test/build/venv 05:56:38 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 05:56:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:56:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:56:38 INFO - Using real prefix '/usr' 05:56:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:56:38 INFO - Installing distribute.............................................................................................................................................................................................done. 05:56:40 INFO - Installing pip.................done. 05:56:40 INFO - Return code: 0 05:56:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:56:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:56:40 INFO - Reading from file tmpfile_stdout 05:56:40 INFO - Output received: 05:56:40 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) 05:56:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:40 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 0xd9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf69a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c7a0>, '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 0x110d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110db30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', '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 05:56:40 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 05:56:40 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 05:56:40 INFO - Using env: {'DISPLAY': ':0', 05:56:40 INFO - 'HOME': '/home/cltbld', 05:56:40 INFO - 'LANG': 'en_US.UTF-8', 05:56:40 INFO - 'LANGUAGE': 'en_US:en', 05:56:40 INFO - 'LOGNAME': 'cltbld', 05:56:40 INFO - 'MAIL': '/var/mail/cltbld', 05:56:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:40 INFO - 'MOZ_NO_REMOTE': '1', 05:56:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:40 INFO - 'NO_EM_RESTART': '1', 05:56:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:40 INFO - 'PWD': '/builds/slave/test', 05:56:40 INFO - 'SHELL': '/bin/bash', 05:56:40 INFO - 'SHLVL': '1', 05:56:40 INFO - 'TERM': 'linux', 05:56:40 INFO - 'TMOUT': '86400', 05:56:40 INFO - 'USER': 'cltbld', 05:56:40 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', 05:56:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:40 INFO - '_': '/tools/buildbot/bin/python'} 05:56:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:41 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 05:56:41 INFO - Cleaning up... 05:56:41 INFO - Return code: 0 05:56:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:56:41 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')]} 05:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:41 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')]} 05:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:41 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 0xd9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf69a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c7a0>, '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 0x110d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110db30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', '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 05:56:41 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 05:56:41 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 05:56:41 INFO - Using env: {'DISPLAY': ':0', 05:56:41 INFO - 'HOME': '/home/cltbld', 05:56:41 INFO - 'LANG': 'en_US.UTF-8', 05:56:41 INFO - 'LANGUAGE': 'en_US:en', 05:56:41 INFO - 'LOGNAME': 'cltbld', 05:56:41 INFO - 'MAIL': '/var/mail/cltbld', 05:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:41 INFO - 'MOZ_NO_REMOTE': '1', 05:56:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:41 INFO - 'NO_EM_RESTART': '1', 05:56:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:41 INFO - 'PWD': '/builds/slave/test', 05:56:41 INFO - 'SHELL': '/bin/bash', 05:56:41 INFO - 'SHLVL': '1', 05:56:41 INFO - 'TERM': 'linux', 05:56:41 INFO - 'TMOUT': '86400', 05:56:41 INFO - 'USER': 'cltbld', 05:56:41 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', 05:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:41 INFO - '_': '/tools/buildbot/bin/python'} 05:56:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:41 INFO - Downloading/unpacking psutil>=3.1.1 05:56:41 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 05:56:41 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 05:56:41 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 05:56:41 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 05:56:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:56:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:56:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:56:42 INFO - Installing collected packages: psutil 05:56:42 INFO - Running setup.py install for psutil 05:56:42 INFO - building 'psutil._psutil_linux' extension 05:56:42 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 05:56:42 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 05:56:42 INFO - building 'psutil._psutil_posix' extension 05:56:42 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 05:56:42 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 05:56:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:56:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:56:43 INFO - Successfully installed psutil 05:56:43 INFO - Cleaning up... 05:56:43 INFO - Return code: 0 05:56:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:56:43 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')]} 05:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:43 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')]} 05:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:43 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 0xd9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf69a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c7a0>, '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 0x110d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110db30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', '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 05:56:43 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 05:56:43 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 05:56:43 INFO - Using env: {'DISPLAY': ':0', 05:56:43 INFO - 'HOME': '/home/cltbld', 05:56:43 INFO - 'LANG': 'en_US.UTF-8', 05:56:43 INFO - 'LANGUAGE': 'en_US:en', 05:56:43 INFO - 'LOGNAME': 'cltbld', 05:56:43 INFO - 'MAIL': '/var/mail/cltbld', 05:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:43 INFO - 'MOZ_NO_REMOTE': '1', 05:56:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:43 INFO - 'NO_EM_RESTART': '1', 05:56:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:43 INFO - 'PWD': '/builds/slave/test', 05:56:43 INFO - 'SHELL': '/bin/bash', 05:56:43 INFO - 'SHLVL': '1', 05:56:43 INFO - 'TERM': 'linux', 05:56:43 INFO - 'TMOUT': '86400', 05:56:43 INFO - 'USER': 'cltbld', 05:56:43 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', 05:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:43 INFO - '_': '/tools/buildbot/bin/python'} 05:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:56:43 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 05:56:43 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 05:56:43 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 05:56:43 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 05:56:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:56:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:56:44 INFO - Installing collected packages: mozsystemmonitor 05:56:44 INFO - Running setup.py install for mozsystemmonitor 05:56:44 INFO - Successfully installed mozsystemmonitor 05:56:44 INFO - Cleaning up... 05:56:44 INFO - Return code: 0 05:56:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:44 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 0xd9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf69a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c7a0>, '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 0x110d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110db30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', '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 05:56:44 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 05:56:44 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 05:56:44 INFO - Using env: {'DISPLAY': ':0', 05:56:44 INFO - 'HOME': '/home/cltbld', 05:56:44 INFO - 'LANG': 'en_US.UTF-8', 05:56:44 INFO - 'LANGUAGE': 'en_US:en', 05:56:44 INFO - 'LOGNAME': 'cltbld', 05:56:44 INFO - 'MAIL': '/var/mail/cltbld', 05:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:44 INFO - 'MOZ_NO_REMOTE': '1', 05:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:44 INFO - 'NO_EM_RESTART': '1', 05:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:44 INFO - 'PWD': '/builds/slave/test', 05:56:44 INFO - 'SHELL': '/bin/bash', 05:56:44 INFO - 'SHLVL': '1', 05:56:44 INFO - 'TERM': 'linux', 05:56:44 INFO - 'TMOUT': '86400', 05:56:44 INFO - 'USER': 'cltbld', 05:56:44 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', 05:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:44 INFO - '_': '/tools/buildbot/bin/python'} 05:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:44 INFO - Downloading/unpacking jsonschema==2.5.1 05:56:44 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 05:56:44 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 05:56:44 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 05:56:44 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 05:56:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:56:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:45 INFO - Downloading functools32-3.2.3-2.tar.gz 05:56:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:56:46 INFO - warning: no files found matching '*.txt' 05:56:46 INFO - no previously-included directories found matching 'build' 05:56:46 INFO - no previously-included directories found matching 'dist' 05:56:46 INFO - no previously-included directories found matching '.git*' 05:56:46 INFO - Installing collected packages: jsonschema, functools32 05:56:46 INFO - Running setup.py install for functools32 05:56:46 INFO - warning: no files found matching '*.txt' 05:56:46 INFO - no previously-included directories found matching 'build' 05:56:46 INFO - no previously-included directories found matching 'dist' 05:56:46 INFO - no previously-included directories found matching '.git*' 05:56:46 INFO - Successfully installed jsonschema functools32 05:56:46 INFO - Cleaning up... 05:56:46 INFO - Return code: 0 05:56:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:46 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 0xd9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf69a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c7a0>, '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 0x110d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110db30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', '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 05:56:46 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 05:56:46 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 05:56:46 INFO - Using env: {'DISPLAY': ':0', 05:56:46 INFO - 'HOME': '/home/cltbld', 05:56:46 INFO - 'LANG': 'en_US.UTF-8', 05:56:46 INFO - 'LANGUAGE': 'en_US:en', 05:56:46 INFO - 'LOGNAME': 'cltbld', 05:56:46 INFO - 'MAIL': '/var/mail/cltbld', 05:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:46 INFO - 'MOZ_NO_REMOTE': '1', 05:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:46 INFO - 'NO_EM_RESTART': '1', 05:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:46 INFO - 'PWD': '/builds/slave/test', 05:56:46 INFO - 'SHELL': '/bin/bash', 05:56:46 INFO - 'SHLVL': '1', 05:56:46 INFO - 'TERM': 'linux', 05:56:46 INFO - 'TMOUT': '86400', 05:56:46 INFO - 'USER': 'cltbld', 05:56:46 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', 05:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:46 INFO - '_': '/tools/buildbot/bin/python'} 05:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:56:46 INFO - Cleaning up... 05:56:46 INFO - Return code: 0 05:56:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:46 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 0xd9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf69a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c7a0>, '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 0x110d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110db30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', '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 05:56:46 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 05:56:46 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 05:56:46 INFO - Using env: {'DISPLAY': ':0', 05:56:46 INFO - 'HOME': '/home/cltbld', 05:56:46 INFO - 'LANG': 'en_US.UTF-8', 05:56:46 INFO - 'LANGUAGE': 'en_US:en', 05:56:46 INFO - 'LOGNAME': 'cltbld', 05:56:46 INFO - 'MAIL': '/var/mail/cltbld', 05:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:46 INFO - 'MOZ_NO_REMOTE': '1', 05:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:46 INFO - 'NO_EM_RESTART': '1', 05:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:46 INFO - 'PWD': '/builds/slave/test', 05:56:46 INFO - 'SHELL': '/bin/bash', 05:56:46 INFO - 'SHLVL': '1', 05:56:46 INFO - 'TERM': 'linux', 05:56:46 INFO - 'TMOUT': '86400', 05:56:46 INFO - 'USER': 'cltbld', 05:56:46 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', 05:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:46 INFO - '_': '/tools/buildbot/bin/python'} 05:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:46 INFO - Downloading/unpacking blobuploader==1.2.4 05:56:46 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 05:56:46 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 05:56:46 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 05:56:46 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 05:56:47 INFO - Downloading blobuploader-1.2.4.tar.gz 05:56:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:56:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:56:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:56:48 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 05:56:48 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 05:56:48 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 05:56:48 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 05:56:48 INFO - Downloading docopt-0.6.1.tar.gz 05:56:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:56:48 INFO - Installing collected packages: blobuploader, requests, docopt 05:56:48 INFO - Running setup.py install for blobuploader 05:56:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:56:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:56:48 INFO - Running setup.py install for requests 05:56:48 INFO - Running setup.py install for docopt 05:56:48 INFO - Successfully installed blobuploader requests docopt 05:56:48 INFO - Cleaning up... 05:56:49 INFO - Return code: 0 05:56:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:49 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 0xd9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf69a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c7a0>, '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 0x110d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110db30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', '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 05:56:49 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 05:56:49 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 05:56:49 INFO - Using env: {'DISPLAY': ':0', 05:56:49 INFO - 'HOME': '/home/cltbld', 05:56:49 INFO - 'LANG': 'en_US.UTF-8', 05:56:49 INFO - 'LANGUAGE': 'en_US:en', 05:56:49 INFO - 'LOGNAME': 'cltbld', 05:56:49 INFO - 'MAIL': '/var/mail/cltbld', 05:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:49 INFO - 'MOZ_NO_REMOTE': '1', 05:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:49 INFO - 'NO_EM_RESTART': '1', 05:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:49 INFO - 'PWD': '/builds/slave/test', 05:56:49 INFO - 'SHELL': '/bin/bash', 05:56:49 INFO - 'SHLVL': '1', 05:56:49 INFO - 'TERM': 'linux', 05:56:49 INFO - 'TMOUT': '86400', 05:56:49 INFO - 'USER': 'cltbld', 05:56:49 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', 05:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:49 INFO - '_': '/tools/buildbot/bin/python'} 05:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:56:49 INFO - Running setup.py (path:/tmp/pip-wwl9DH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:56:49 INFO - Running setup.py (path:/tmp/pip-BtVa93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:56:49 INFO - Running setup.py (path:/tmp/pip-VK5IwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:56:49 INFO - Running setup.py (path:/tmp/pip-frkan8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:56:49 INFO - Running setup.py (path:/tmp/pip-G7sAPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:56:49 INFO - Running setup.py (path:/tmp/pip-yE9smW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:56:49 INFO - Running setup.py (path:/tmp/pip-fnIqOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:56:49 INFO - Running setup.py (path:/tmp/pip-MOfHwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:56:49 INFO - Running setup.py (path:/tmp/pip-YT7MV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:56:49 INFO - Running setup.py (path:/tmp/pip-5W7odp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:56:49 INFO - Running setup.py (path:/tmp/pip-sPe_Bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:56:50 INFO - Running setup.py (path:/tmp/pip-EMznd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:56:50 INFO - Running setup.py (path:/tmp/pip-ddMOJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:56:50 INFO - Running setup.py (path:/tmp/pip-dGmLWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:56:50 INFO - Running setup.py (path:/tmp/pip-KjB1J1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:56:50 INFO - Running setup.py (path:/tmp/pip-jAWRJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:56:50 INFO - Running setup.py (path:/tmp/pip-hiE1OS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:56:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:56:50 INFO - Running setup.py install for manifestparser 05:56:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:56:50 INFO - Running setup.py install for mozcrash 05:56:50 INFO - Running setup.py install for mozdebug 05:56:50 INFO - Running setup.py install for mozdevice 05:56:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:56:50 INFO - Running setup.py install for mozfile 05:56:50 INFO - Running setup.py install for mozhttpd 05:56:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:56:51 INFO - Running setup.py install for mozinfo 05:56:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:56:51 INFO - Running setup.py install for mozInstall 05:56:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:56:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:56:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:56:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:56:51 INFO - Running setup.py install for mozleak 05:56:51 INFO - Running setup.py install for mozlog 05:56:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:56:51 INFO - Running setup.py install for moznetwork 05:56:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:56:51 INFO - Running setup.py install for mozprocess 05:56:51 INFO - Running setup.py install for mozprofile 05:56:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:56:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:56:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:56:51 INFO - Running setup.py install for mozrunner 05:56:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:56:51 INFO - Running setup.py install for mozscreenshot 05:56:52 INFO - Running setup.py install for moztest 05:56:52 INFO - Running setup.py install for mozversion 05:56:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:56:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:56:52 INFO - Cleaning up... 05:56:52 INFO - Return code: 0 05:56:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:56:52 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')]} 05:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:52 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')]} 05:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:52 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 0xd9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf69a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c7a0>, '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 0x110d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110db30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', '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 05:56:52 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 05:56:52 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 05:56:52 INFO - Using env: {'DISPLAY': ':0', 05:56:52 INFO - 'HOME': '/home/cltbld', 05:56:52 INFO - 'LANG': 'en_US.UTF-8', 05:56:52 INFO - 'LANGUAGE': 'en_US:en', 05:56:52 INFO - 'LOGNAME': 'cltbld', 05:56:52 INFO - 'MAIL': '/var/mail/cltbld', 05:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:52 INFO - 'MOZ_NO_REMOTE': '1', 05:56:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:52 INFO - 'NO_EM_RESTART': '1', 05:56:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:52 INFO - 'PWD': '/builds/slave/test', 05:56:52 INFO - 'SHELL': '/bin/bash', 05:56:52 INFO - 'SHLVL': '1', 05:56:52 INFO - 'TERM': 'linux', 05:56:52 INFO - 'TMOUT': '86400', 05:56:52 INFO - 'USER': 'cltbld', 05:56:52 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', 05:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:52 INFO - '_': '/tools/buildbot/bin/python'} 05:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:56:52 INFO - Running setup.py (path:/tmp/pip-RcUiVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:56:52 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)) 05:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:56:52 INFO - Running setup.py (path:/tmp/pip-g4WZUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:56:52 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)) 05:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:56:52 INFO - Running setup.py (path:/tmp/pip-bd4nac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:56:52 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)) 05:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:56:52 INFO - Running setup.py (path:/tmp/pip-FIhGAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:56:52 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)) 05:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:56:52 INFO - Running setup.py (path:/tmp/pip-3u2yJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:56:52 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)) 05:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:56:52 INFO - Running setup.py (path:/tmp/pip-aMzF8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:56:52 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)) 05:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:56:52 INFO - Running setup.py (path:/tmp/pip-eWm7UB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:56:52 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)) 05:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:56:52 INFO - Running setup.py (path:/tmp/pip-_AewoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:56:53 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)) 05:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:56:53 INFO - Running setup.py (path:/tmp/pip-Ad41VA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:56:53 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)) 05:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:56:53 INFO - Running setup.py (path:/tmp/pip-fAgINw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:56:53 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)) 05:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:56:53 INFO - Running setup.py (path:/tmp/pip-LASVo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:56:53 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)) 05:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:56:53 INFO - Running setup.py (path:/tmp/pip-igDcAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:56:53 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)) 05:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:56:53 INFO - Running setup.py (path:/tmp/pip-qfVTqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:56:53 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)) 05:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:56:53 INFO - Running setup.py (path:/tmp/pip-aJHwDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:56:53 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)) 05:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:56:53 INFO - Running setup.py (path:/tmp/pip-siTbrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:56:53 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)) 05:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:56:53 INFO - Running setup.py (path:/tmp/pip-xYZtnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:56:53 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)) 05:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:56:53 INFO - Running setup.py (path:/tmp/pip-ViXYAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:56:53 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)) 05:56:53 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)) 05:56:53 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)) 05:56:53 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)) 05:56:53 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)) 05:56:53 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)) 05:56:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:56:53 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 05:56:53 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 05:56:53 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 05:56:53 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 05:56:54 INFO - Downloading blessings-1.6.tar.gz 05:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:56:54 INFO - Installing collected packages: blessings 05:56:54 INFO - Running setup.py install for blessings 05:56:54 INFO - Successfully installed blessings 05:56:54 INFO - Cleaning up... 05:56:54 INFO - Return code: 0 05:56:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:56:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:56:55 INFO - Reading from file tmpfile_stdout 05:56:55 INFO - Current package versions: 05:56:55 INFO - argparse == 1.2.1 05:56:55 INFO - blessings == 1.6 05:56:55 INFO - blobuploader == 1.2.4 05:56:55 INFO - docopt == 0.6.1 05:56:55 INFO - functools32 == 3.2.3-2 05:56:55 INFO - jsonschema == 2.5.1 05:56:55 INFO - manifestparser == 1.1 05:56:55 INFO - mozInstall == 1.12 05:56:55 INFO - mozcrash == 1.0 05:56:55 INFO - mozdebug == 0.1 05:56:55 INFO - mozdevice == 0.50 05:56:55 INFO - mozfile == 1.2 05:56:55 INFO - mozhttpd == 0.7 05:56:55 INFO - mozinfo == 0.9 05:56:55 INFO - mozleak == 0.1 05:56:55 INFO - mozlog == 3.4 05:56:55 INFO - moznetwork == 0.27 05:56:55 INFO - mozprocess == 0.25 05:56:55 INFO - mozprofile == 0.28 05:56:55 INFO - mozrunner == 6.13 05:56:55 INFO - mozscreenshot == 0.1 05:56:55 INFO - mozsystemmonitor == 0.3 05:56:55 INFO - moztest == 0.8 05:56:55 INFO - mozversion == 1.4 05:56:55 INFO - psutil == 3.1.1 05:56:55 INFO - requests == 1.2.3 05:56:55 INFO - wsgiref == 0.1.2 05:56:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:56:55 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')]} 05:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:55 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')]} 05:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:55 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 0xd9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf69a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c7a0>, '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 0x110d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110db30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', '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 05:56:55 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 05:56:55 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 05:56:55 INFO - Using env: {'DISPLAY': ':0', 05:56:55 INFO - 'HOME': '/home/cltbld', 05:56:55 INFO - 'LANG': 'en_US.UTF-8', 05:56:55 INFO - 'LANGUAGE': 'en_US:en', 05:56:55 INFO - 'LOGNAME': 'cltbld', 05:56:55 INFO - 'MAIL': '/var/mail/cltbld', 05:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:55 INFO - 'MOZ_NO_REMOTE': '1', 05:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:55 INFO - 'NO_EM_RESTART': '1', 05:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:55 INFO - 'PWD': '/builds/slave/test', 05:56:55 INFO - 'SHELL': '/bin/bash', 05:56:55 INFO - 'SHLVL': '1', 05:56:55 INFO - 'TERM': 'linux', 05:56:55 INFO - 'TMOUT': '86400', 05:56:55 INFO - 'USER': 'cltbld', 05:56:55 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', 05:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:55 INFO - '_': '/tools/buildbot/bin/python'} 05:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:55 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)) 05:56:55 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)) 05:56:55 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)) 05:56:55 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)) 05:56:55 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)) 05:56:55 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)) 05:56:55 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)) 05:56:55 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)) 05:56:55 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)) 05:56:55 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)) 05:56:55 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)) 05:56:55 INFO - Cleaning up... 05:56:55 INFO - Return code: 0 05:56:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:56:55 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')]} 05:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:55 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')]} 05:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:55 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 0xd9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf69a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110f5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110c7a0>, '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 0x110d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110db30>, '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': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', '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 05:56:55 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 05:56:55 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 05:56:55 INFO - Using env: {'DISPLAY': ':0', 05:56:55 INFO - 'HOME': '/home/cltbld', 05:56:55 INFO - 'LANG': 'en_US.UTF-8', 05:56:55 INFO - 'LANGUAGE': 'en_US:en', 05:56:55 INFO - 'LOGNAME': 'cltbld', 05:56:55 INFO - 'MAIL': '/var/mail/cltbld', 05:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:55 INFO - 'MOZ_NO_REMOTE': '1', 05:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:55 INFO - 'NO_EM_RESTART': '1', 05:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:55 INFO - 'PWD': '/builds/slave/test', 05:56:55 INFO - 'SHELL': '/bin/bash', 05:56:55 INFO - 'SHLVL': '1', 05:56:55 INFO - 'TERM': 'linux', 05:56:55 INFO - 'TMOUT': '86400', 05:56:55 INFO - 'USER': 'cltbld', 05:56:55 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', 05:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:55 INFO - '_': '/tools/buildbot/bin/python'} 05:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:56:55 INFO - Cleaning up... 05:56:55 INFO - Return code: 0 05:56:55 INFO - Running post-action listener: _resource_record_post_action 05:56:55 INFO - Running post-action listener: _start_resource_monitoring 05:56:55 INFO - Starting resource monitoring. 05:56:55 INFO - [mozharness: 2017-05-18 12:56:55.684796Z] Finished create-virtualenv step (success) 05:56:55 INFO - [mozharness: 2017-05-18 12:56:55.685454Z] Running install step. 05:56:55 INFO - Running pre-action listener: _resource_record_pre_action 05:56:55 INFO - Running main action method: install 05:56:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:56:55 INFO - Reading from file tmpfile_stdout 05:56:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:56:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:56:55 INFO - Reading from file tmpfile_stdout 05:56:55 INFO - Output received: 05:56:55 INFO - Usage: mozinstall [options] installer 05:56:55 INFO - Options: 05:56:55 INFO - -h, --help show this help message and exit 05:56:55 INFO - -d DEST, --destination=DEST 05:56:55 INFO - Directory to install application into. [default: 05:56:55 INFO - "/builds/slave/test"] 05:56:55 INFO - --app=APP Application being installed. [default: firefox] 05:56:55 INFO - mkdir: /builds/slave/test/build/application 05:56:55 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'] 05:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:57:12 INFO - Reading from file tmpfile_stdout 05:57:12 INFO - Output received: 05:57:12 INFO - /builds/slave/test/build/application/firefox/firefox 05:57:12 INFO - Running post-action listener: _resource_record_post_action 05:57:12 INFO - [mozharness: 2017-05-18 12:57:12.829157Z] Finished install step (success) 05:57:12 INFO - [mozharness: 2017-05-18 12:57:12.829441Z] Running run-tests step. 05:57:12 INFO - Running pre-action listener: _resource_record_pre_action 05:57:12 INFO - Running main action method: run_tests 05:57:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:57:12 INFO - Python 2.7.3 05:57:12 INFO - Return code: 0 05:57:12 INFO - grabbing minidump binary from tooltool 05:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:12 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 0x110c7a0>, '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 0x110d6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110db30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:57:12 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 05:57:12 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 05:57:12 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 05:57:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:57:12 INFO - Return code: 0 05:57:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:57:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:57:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:57:12 INFO - ENV: RUST_BACKTRACE is now 1 05:57:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:57:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:57:12 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/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--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 05:57:12 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/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-071 --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 05:57:12 INFO - Using env: {'DISPLAY': ':0', 05:57:12 INFO - 'HOME': '/home/cltbld', 05:57:12 INFO - 'LANG': 'en_US.UTF-8', 05:57:12 INFO - 'LANGUAGE': 'en_US:en', 05:57:12 INFO - 'LOGNAME': 'cltbld', 05:57:12 INFO - 'MAIL': '/var/mail/cltbld', 05:57:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:57:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:12 INFO - 'MOZ_NO_REMOTE': '1', 05:57:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:12 INFO - 'NO_EM_RESTART': '1', 05:57:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:12 INFO - 'PWD': '/builds/slave/test', 05:57:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:57:12 INFO - 'RUST_BACKTRACE': '1', 05:57:12 INFO - 'SHELL': '/bin/bash', 05:57:12 INFO - 'SHLVL': '1', 05:57:12 INFO - 'TERM': 'linux', 05:57:12 INFO - 'TMOUT': '86400', 05:57:12 INFO - 'USER': 'cltbld', 05:57:12 INFO - 'XDG_SESSION_COOKIE': 'dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520', 05:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:12 INFO - '_': '/tools/buildbot/bin/python'} 05:57:12 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/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-071', '--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 05:57:13 INFO - mozversion application_buildid: 20170518121928 05:57:13 INFO - mozversion application_changeset: 2fa6931995b23f1f39752385b6689dc6b8d94c1b 05:57:13 INFO - mozversion application_display_name: Nightly 05:57:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:57:13 INFO - mozversion application_name: Firefox 05:57:13 INFO - mozversion application_remotingname: firefox 05:57:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:57:13 INFO - mozversion application_vendor: Mozilla 05:57:13 INFO - mozversion application_version: 55.0a1 05:57:13 INFO - mozversion platform_buildid: 20170518121928 05:57:13 INFO - mozversion platform_changeset: 2fa6931995b23f1f39752385b6689dc6b8d94c1b 05:57:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:57:13 INFO - mozversion platform_version: 55.0a1 05:57:13 INFO - using testdate: 1495112233 05:57:13 INFO - actual date: 1495112233 05:57:13 INFO - starting webserver on 'localhost:36531' 05:57:13 INFO - SUITE-START | Running 2 tests 05:57:13 INFO - TEST-START | dromaeo_css 05:57:13 INFO - operating with platform_type : linux_ 05:57:13 INFO - Initialising browser for dromaeo_css test... 05:57:13 INFO - TEST-INFO | started process 5700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSFWN09/profile http://localhost:36531/getInfo.html) 05:57:13 INFO - PID 5700 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 05:57:17 INFO - PID 5700 | __metrics Screen width/height:1600/1200 05:57:17 INFO - PID 5700 | colorDepth:24 05:57:17 INFO - PID 5700 | Browser inner width/height: 1024/695 05:57:17 INFO - PID 5700 | __metrics 05:57:19 INFO - TEST-INFO | 5700: exit 0 05:57:19 INFO - Browser initialized. 05:57:19 INFO - Running cycle 1/1 for dromaeo_css test... 05:57:19 INFO - TEST-INFO | started process 5862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSFWN09/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:30 INFO - PID 5862 | RSS: Main: 165490688 05:57:30 INFO - PID 5862 | 06:00:36 INFO - PID 5862 | Cycle 1(1): loaded http://localhost:36531/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36531/tests/dromaeo/cssquery-ext.html) 06:00:37 INFO - PID 5862 | RSS: Main: 173699072 06:00:37 INFO - PID 5862 | 06:03:39 INFO - PID 5862 | Cycle 1(1): loaded http://localhost:36531/tests/dromaeo/cssquery-ext.html (next: http://localhost:36531/tests/dromaeo/cssquery-jquery.html) 06:03:40 INFO - PID 5862 | RSS: Main: 170967040 06:03:40 INFO - PID 5862 | 06:06:42 INFO - PID 5862 | Cycle 1(1): loaded http://localhost:36531/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36531/tests/dromaeo/cssquery-mootools.html) 06:06:42 INFO - PID 5862 | RSS: Main: 172421120 06:06:42 INFO - PID 5862 | 06:09:44 INFO - PID 5862 | Cycle 1(1): loaded http://localhost:36531/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36531/tests/dromaeo/cssquery-prototype.html) 06:09:45 INFO - PID 5862 | RSS: Main: 170090496 06:09:45 INFO - PID 5862 | 06:12:48 INFO - PID 5862 | Cycle 1(1): loaded http://localhost:36531/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36531/tests/dromaeo/cssquery-yui.html) 06:12:48 INFO - PID 5862 | RSS: Main: 170848256 06:12:48 INFO - PID 5862 | 06:15:50 INFO - PID 5862 | Cycle 1(1): loaded http://localhost:36531/tests/dromaeo/cssquery-yui.html (next: http://localhost:36531/tests/dromaeo/cssquery-dojo.html) 06:15:50 INFO - PID 5862 | RSS: Main: 177811456 06:15:50 INFO - PID 5862 | 06:15:50 INFO - PID 5862 | __start_tp_report 06:15:50 INFO - PID 5862 | _x_x_mozilla_page_load 06:15:50 INFO - PID 5862 | _x_x_mozilla_page_load_details 06:15:50 INFO - PID 5862 | |i|pagename|runs| 06:15:50 INFO - PID 5862 | |0;dojo.html;2713.2809805401566;2717.442924200539;2726.809123361364;2746.3134216445874;2747.2994386431455;5379.058664733676;5390.1375779875225;5416.268803711493;5427.1587903874915;5440.727963601819;5449.56403487721;5515.200295957084;5569.832905012846;5570.610057295991;5584.4136365681625;4797.0645724083815;4799.856004319876;4826.613870890338;4872.171730805771;4926.802927882881;4788.784504697297;4854.757262136896;4859.927101093486;4861.659683822134;4909.165441874889;4810.11012962603;4841.370621819176;4854.223324268136;4882.780274887621;4907.11671899058;4827.227643577046;4876.7073975561225;4897.681650692693;4906.067847109038;4926.014797040606;4701.153792317382;4790.185668436339;4805.6155507559315;4818.686785358976;4855.417349917997;5352.812651557216;5425;5430.3755068167275;5433.375161856397;5438.53772429344;5741.483266506035;5792.044312688401;5874.1776151338845;5883.441073098049;5890.410958904118;5832.88334233313;5842.2405087338375;5858.121281807763;5858.209141765849;5933.317668468095;5404.486573775485;5411.18832175169;5431.456854314537;5431.674099553999;5437.401885792559;5969.582129250911;6000.489958353502;6074.42292982166;6078.635281883101;6084.117802918552;5640.746166422521;5648.435156484401;5663.490285874291;5772.278465191851;5863.824085277449;5904.5571582131515;5974.014287642491;5977.252843394575;5991.161237426763;6015.3383127855905;5919.644821310735;5922.526197904157;5927.407259274038;5933.881322373529;5934.109883517507;5909.881802363929;5912.615679980788;5931.347551769302;5932.3177834548715;5949.196858424058;4797.376341075707;4817.855464336076;4869.464358920516;4896.143174944442;4903.264510323409;4142.192272506893;4148.191102734938;4182.163567286494;4231.576842315805;4237.8304867805555;4854.611631069506;4915.827946021944;4960.0327936052845;4967.403911530567;5013.749312534359;5781.6241944274325;5867.589268751147;5920.089704342794;5923.289205295392;5941.781934703376;4889.168841296988;4919.754012299442;4943.629227807929;4958.925616115761;4960.50394960501;5186;5236.319278493771;5240.161574148195;5260.894782104337;5269.683818970874;5303.655262407931;5476.17857321405;5483.396826349099;5499.120140777456;5507.146392309199;5868.853278668067;5921.7631294747725;5982.46157845796;6014.127951447103;6016.368281330398;5253.789848406173;5373.194020896741;5376;5417.593680473901;5429.484199001088;5727.31272247333;5786.681732504752;5842.970785146217;5865;5865.472107510344;5817.825465236049;5874.295084589877;5942.524598032233;5955.40445955401;5958.255218097738;5707.743151558107;5730.455606717355;5775;5777.104548794943;5791.131330300489;5810.912836307543;5812.825615231381;5835.56233282514;5842.269716285465;5851.970740146272;5685.829425117253;5761.798337058183;5765.91351129725;5771.336296325976;5773.884522309614;5688;5752.309722833287;5766.596338256281;5863.325717542537;5893.823185304448;5504.862378440571;5524.613277070566;5540.473655002768;5549.833504994856;5597.804076857454 06:15:50 INFO - PID 5862 | |1;ext.html;672.6569449580716;732.406750532069;753.3972821742607;1061.0821639282024;1082.4533610526682;32535.511967320508;33654.326913461715;33684.831575842116;33732.662673373256;33796.32407351852;34858.65141348586;34872.47691284633;34959.475607865905;35184.296314073705;35372.2925541489;6823.624700641462;6897.206821215562;6985.930140698604;7043.380022594806;7065.752698655548;7020.333068358498;7107.218205997337;7111.431085513146;7122.216556178816;7122.893156602655;7087.18497372801;7141.428685705131;7145.85708285834;7159.35565799078;7182;7064.18761842387;7077.893831592531;7085.291470852873;7095.006699062135;7096.112985876765;6695.765648202289;6723.865522689568;6774.729010839561;6782.355676210752;6796.898046529306;32279.51580726291;32379;32494.187645309055;32679.6732032679;32760.672393276;3112.813231206112;3141;3141.811491310506;3143.654198038214;3144.3239703463864;24583.262502124966;24637.5072498549;24800.5039899201;24831.751682483125;24835.00659973599;2943.323035701779;2943.396603696237;2969.881204751807;2978.240548660078;2988.5218365061487;134730;135915;151261;153326;153881.23059384633;39336.6066339333;39406.60593394087;39414.80292598519;39517;39671;39788.20423591512;39876.80061599673;40019;40065.39901901474;40105.39841902374;12684.556040538537;12765.425555849823;12776.041796865273;12783.93608031954;12893.677658058623;10069.395836249849;10117.190624750003;10127.341722787995;10198.745031374276;10228.87482376938;12747.49010039588;12802.615921522369;12825.739189371045;12900.387451568555;12977.41601627929;5547.639403438763;5560.944390556124;5582.274304340491;5623.268975033219;5640.32316122068;871.8125602995386;889.888763904512;902.255639097747;904.7692838326185;930.2511478260066;20259.18963241454;20628.17487300491;20976.685349719766;21127.154913803584;21426.78573214279;955.3121752338305;965.7199412170391;972.3825370889394;980.4215512847454;1004.2919741582167;10665.946670266754;11199.94400028011;11245.594300712411;11299.887001129884;11353.716157095974;170254.14872925557;170540;170594;171447.14276428788;171486;39911.800440997606;39992.400113998316;40096;40102.19795604071;40292.39561406581;1161.3264306702092;1210.8365370675021;1214.2228973456995;1225.9816102758466;1234.6357824441811;19099.427017189508;19788.307409241184;20335;20377.18491260333;20592.79407205909;28384.43231135407;28563.571546427236;28620.57069144006;28622.284442889093;28679.713202868537;147878;148107;148917;149254.25372873066;149584;27600.585991210548;28069.43861122807;28805.7119428803;30018.69981300159;30358.84820575883;35523;36207.63792362042;36281.27437451289;36361.27277454489;36831.63168368389;26768.866155669097;27048;27542.5868611975;28003.579946300415;28840.134795956154;27147;27307.72692273052;27870.399496696817;27929.720702793526;28919.421611568072;30617;30970;31197.688023119477;31308.217294567818;31382.529262061544;26343.868280658473;26626;27197.32006699769;27262;27853.582196267478;21357.252496163183;22251.443713907283;22310.553788924455;22375.552488950456;22421 06:15:50 INFO - PID 5862 | |2;jquery.html;425.3407218810842;427.89944363074665;431.8245823801736;444.55766512320247;447.27318108074377;16858.578535536617;17365.826341736578;17930.103494825238;18113.366032188875;18250.087495625234;17869;18282.542936426595;19204.423867283967;19251.556133290025;19333.130009149587;5504.22940788288;5511.173324001392;5635.915461268064;5669.0646043402785;5675.489205971462;5553.111502159655;5604.103343465046;5642.971785141069;5652.689102099383;5669.716514174295;5389.326334208224;5486.945130548684;5528.668279903199;5559.360673522557;5568.721563921808;5348.598855085884;5508.6970216638065;5540.196671482653;5561.165825126243;5572.4706152915405;5003.149464591028;5040.36995375578;5058.721770302632;5062.544371006627;5063.8480845574695;21545.56908861814;21770.238041668625;21791.23730669419;21903.452413689625;22085.33743987683;1605.6066263765451;1623.7483190105552;1638.2545941596545;1651.9091449970247;1652.842979916906;14516.854831451656;14581.781273280909;14844.406223751144;15007.549773506813;15069.54791356261;1982.3557343863301;2027.9290224842207;2045.5193029638024;2050.3438899552148;2071.3475255294684;77111.61444192744;77732;79149.60425197895;79200;80960;10865.185111116698;11176.105911527058;11224.831627525593;11238.269512481662;11463.598774043036;15750.448734294245;15881;15890.682186356207;15920.363185472683;15938.362465501483;7240.565566066053;7485.700571977169;7573.886391704129;7753.883691744629;7767.417443691633;6725;6764.526483146133;6994.68523916425;6998.75504357345;7009.7897063088185;6890.2076261229595;7000.579965202104;7003.039149038277;7071.681774320168;7079.469039822034;2113.3448630924463;2116.8624039437386;2151.2900742755164;2153.3432303147692;2161.492049368397;873.3493547307297;908.5638893331238;914.277720600718;916.029009250197;946.3375637054089;17037.40369087076;17558.91220543889;18031.909840450975;18140.183691733902;18169.818301816813;894.552723638181;904.3714618340322;904.895936967244;915.7573243090586;925.4077390470104;9350.95324523373;9836.06557377048;9843.409395436296;9857.408555486694;10049.447280399501;357775;359222;361829;364562;365106;73666.63166684132;75082.62458687671;75212.24787752162;76777.61611191908;79582.80625790618;1046.7173863056933;1055.6832950114936;1058.0477570186893;1068.1348108032519;1073.8765042020111;15127.621809454851;15188.46840360582;15495.302711378241;15648.92175539115;15684.92157539205;36329.63670363263;37887;38315.808420957714;38370.42444363393;38676.893002474055;46787.06425871531;48580;48846.02307953892;50045.249321259485;50118;8397.538135402612;8474.322054235523;8624.568771561271;8626.611802468778;9105.908940910771;12890.613281601567;13054.804177937149;13374.665633359244;13581.66045848822;13606.86393136056;11452.255603385753;11463.484143213409;11623.76752464963;11867.940660296988;12020.579279725518;9856.5564549594;10152.187824974131;10205.744856378353;10651.946740266249;11040.116790656568;11126.49930753102;11856.76286474283;11883.76232475363;12185.086118541321;12201.816972745239;8534.786630334043;8729.694460693845;8765.167309105625;8846.601902914255;9037.186653201243;11267.746450710054;11395.943020284845;11548.249363791327;11658.18392712536;11769.234999724991 06:15:50 INFO - PID 5862 | |3;mootools.html;1198.2391181599685;1211.715246916974;1217.287886586347;1252.279939035055;1260.7163388237648;10130.746731331712;10550.630727924525;10605.15158787296;10611.416372099531;10796.946015269932;9902.554385052672;9997.15024222942;10029.34809237399;10030.247731420155;10059.748506287346;2232.2075663139553;2249.516353983893;2258.9661155082604;2260.9095636174534;2261.762514935933;2171.2183613898983;2214.8892555372167;2234.128689810975;2241.025154057982;2245.461089338555;2236.7539570647214;2237.5301186750803;2260.8078313343303;2271.8750468724215;2275.8748268845206;2108.862923909941;2142.2930432957087;2167.5231449081175;2169.8698078115285;2172.56548690261;1970.980290197094;2172.5654869026257;2172.913083476659;2199.604071267171;2201.2955854126685;10315.948420257926;10336.379817210916;10355.689329320057;10414.843777343345;10435.68692939213;5531.419200983879;5780.913286300709;5784.68184249866;5784.797532086357;5799.217105690762;3344.3980083584943;3539.469079638049;3601.7478776485655;3603.1172362771026;3651.4522821576975;1045.5190612318343;1068.4016950507742;1094.7263184203948;1097.7365432296272;1113.465536542456;15514.767278490832;15554.688906221925;15596.844031559653;15651.765223521656;15655.373785048585;4621.491635920046;4910.607151427877;4989.226669866104;4989.426215985208;5007.874803129878;10840.078593319657;10897.727556811144;10926.289791163708;10930.234883558234;10956.28784129029;5694.800681976111;5711.400302968212;5712.400197979236;5715.971420142872;5731.656100633975;5145.408278047998;5196.870078248074;5207.765650545734;5278.736063196825;5348.679079255179;3731.402975523903;3828.1003964068423;3915.451836742858;3937.586553411908;4050.088730035777;1079.2445288298065;1102.6802227354137;1104.8342748587777;1113.1910645201547;1116.6147679050714;680.3808534233823;701.8947157926352;703.549728173969;720.7513407874275;723.9058922340167;5202.167653175549;5259.579233661298;5265.815696450606;5388.137897936312;5479.698616576126;501.8971110922252;515.1448595331732;517.6824980424827;518.4996478398364;519.070863154956;3471.5139880416764;3711.832967516468;3811.4282857571584;3900.7074469414906;3918.8040597970557;13193.340332983313;13575.52485662997;13838.792418113737;13889.861101389059;13925.373358198905;13383.665408364868;13474.326283685776;13594.184348939096;13667.179969201681;13767.586972390643;7564.281393267631;7569.470137090461;7663.923360766433;7697.730579429693;7729.227077292226;5848.356680765028;5892.528597712087;5911.881762364815;6057.969710151598;6144.56988010835;11818.704532386759;11866.525338986688;11975.101867360157;12008.879911200776;12199.451024703732;12106.818397723864;12518.624441266777;12549.121561490972;12579.559715409916;12652.240865548096;7210.9278907210255;7298.160711518243;7324.157721861841;7329.413646908128;7335.559866408033;9665.371750836173;9694.9030509694;9716.854247186438;9790.412575245507;9810.950945245228;8180.5909704515725;8235.464694794819;8296.626651800563;8355.707550235713;8428.704995325379;8023.799405014688;8055.355571554379;8129;8212.260896519341;8296.70961516344;7168.498205125591;7244.492885497964;7298.197198308076;7307.26927307265;7313.378362839218;5286.8942621148135;5329.733513324396;5378.865528361665;5455.618106732491;5474.808381706621;5245.160774276097;5352.116900711495;5522.171674248895;5540.058190107611;5667.376588575171 06:15:50 INFO - PID 5862 | |4;prototype.html;376.60268416820253;378.273714468221;379.7209051347261;380.4825437405129;385.94403811447324;5458.699771512565;5534.426491681367;5570.192322113291;5609.915851262234;5633.971830140844;5436.700981446019;5483.725813709309;5536.363318218406;5550.611457197998;5565.638233514819;4259.87220383389;4376;4390.495093064291;4398.7580683062415;4405.7356558606425;4391.209582275189;4396.252637051693;4397.890052748675;4402;4416.514183439819;4398.670099742516;4398.780060996954;4404.845830395937;4419.270820314644;4425.645948324142;4333.371661109153;4368.213721530124;4394.099209662011;4394.6923715339935;4400.6259467945265;3908.0816008238326;3954.802259887023;3968.8214030368704;3972.543157536891;3974.8608798691907;5410.621256512046;5431.158170483582;5444.257837492004;5452.182172674131;5465.398806131322;5063.569596584295;5152.124138896396;5222.929299493632;5233.842984710464;5246.7901283948595;5929.1995580596495;5931.73307201177;5944.583879128462;5962.522998160137;5982.641041537521;4447.777611119431;4468.977655111737;4476.187144206601;4483.21543729846;4496.8875778105485;5975.402459754033;6185.16500272462;6215.81352559424;6230.9065364020025;6233.189685340922;4348.7390756554705;4372.628326592212;4385.802638881258;4386.561343865652;4394.538573449806;4420.734755914591;4431.189177307513;4437.933430998538;4459.878085340275;4461.464624245112;4878.780454879539;4959.355283813081;5002.699838009731;5022.522860328263;5030;5933.406659334119;5960.731767070492;5965.79119730816;5986.341502434729;5992.790252341147;1616.7170745119556;1631.111044480761;1632.1023437109543;1650.678117767048;1653.7602047703015;1112.3826276416505;1152.3143729481112;1161.611873810788;1171.0748508678048;1180.8110702287593;4962.367712646173;5028.547430731252;5039.496050394931;5040.596752259884;5072.949270507322;6083.087536869505;6092.695365231721;6104.236970378703;6111.174991376196;6117.296510901214;4977.034071541721;5023.899522009539;5031.84904452867;5079.847604571869;5086.669366491166;3209.646938836726;3211.4379983502795;3215.469447541176;3225.1614580209316;3230.78999865008;5506.475855452513;5579.9163012554845;5590.91613625796;5593.300837395325;5644.8306550803545;6082.482988945901;6208.161898143783;6233.189685340967;6274.498040156776;6303.2751233607805;5632.4930756231315;5635.802746903839;5651.598070819968;5654.692005177018;5657.971710141505;5986.281646202484;6101.237345331833;6106.755729770937;6122.602030867979;6139.539534535017;5964.343922168471;5972.701364931823;6008.669523176267;6010.338862725184;6016.007358785751;5623.522000629992;5643.802466913638;5674.3260738081535;5681.551204442841;5709.400512946081;4082.7544850332793;4109.321961876257;4118.52636946755;4125.216208920296;4158.604932531404;6071.878562428815;6137.40427488865;6141.109539116893;6150.938490615036;6159.846003849761;5915.881682366415;5937.940620593911;5939.227900372924;5940.138679891305;5948.821535353946;5779.653220806765;5859.794907178229;5879.588428809942;5894.2926848778425;5927.436893495111;5831.387704291158;5832.591718579659;5841.678707671119;5865.648061116347;5897.321807991964;5848.444397782374;5950.910736338872;5982.850428739316;5988.8802223956145;5995.400459953969;5743.540516758566;5766.4233576642;5766.481016708516;5769.74036168365;5769.769209231584 06:15:50 INFO - PID 5862 | |5;yui.html;719.2843121094505;740.5704691279059;749.9962500187495;757.8370650310183;763.5075376382233;13632.318384080794;14501.202433866134;14514.637134071667;15308.387664493435;16600.50198494044;15865.603359915978;16009.83990160098;16254;16258;16373.508794736177;888.7689200807772;910.4355299714186;913.9451632902014;916.3814425262955;918.5269586163131;883.8276536075468;911.6034524981621;913.159892898535;914.1955079530004;919.5448253114718;965.903409659032;966.5891995901749;966.8018056298478;966.8791401074866;967.0571193086754;952.2667545989584;957.3298690916351;958.0515289863055;958.7219706285134;965.0301447045674;701.7894631610548;704.2218348724637;707.3421717802441;708.1077841919167;708.1997343002425;14140.434382624682;14190.290485475685;14654.194019328932;14780.778288325684;14807.777883331759;15613.765793513106;15743.212839357986;15844.366225350972;16022.439214627431;16090.5977350566;12488.81266780999;12711.682207944783;12738.554150604778;12802.615921522369;12813.93593032029;2928.355761732437;2970.3465237647897;2971.1383698727345;2972.4055188962293;2977.285451491648;62720.059199112504;67398;69165.96251056239;69782.65108674475;71027.64486177536;12466.87533124657;12656.873431265754;12791.10462267651;12802.551910683082;12822.80765788514;22542;22681.432964176027;22898.542029159322;23228.3031509055;23240.41898952506;6393.1688880445245;6459.09572659828;6459.128017717642;6477.902831457532;6494.837629059311;3009.458297506426;3057.2509735114595;3062.9846850765603;3067.831269280211;3083.383323335342;3388.423967925459;3443.1908501502126;3445.5348527948404;3595.227026189382;3611.7652352596997;708.4155571653406;719.7660760252834;720.1034711783863;727.4544091931052;727.8034930568717;584.780707234787;591.5681552466723;593.9346671866091;605.3432026251567;605.6154341992778;9194.264458843276;10392.272540922215;10466.424346660855;10726.410047447465;11061.612843550598;595.330253464852;597.3697748874891;600.9789657362059;618.5144661440837;630.0486265738767;4304.246756817544;4449.510553839075;4462;4470.754108523997;4486.439195100613;56815.71592142013;57247.85504289891;57615.711921440125;58833;62949;48875.755621221666;49610.75194624004;50062.249066264034;50290.49709502858;51241.487585124414;46386.76806615946;47157.292640610416;47625.76187119042;48130.27804582934;49191.26213106806;9803.803923921625;10291.53688084023;10307.226957978331;10467.842982355423;10734.731631708957;24649.260522184362;25546.616800748376;25580.616290755283;25580.616290756025;25798.226053217684;43110.56889431191;43399.78300108479;47244.527554724016;47670.52329476661;47741.283880742514;13054.608361749162;14254;14438.350274237475;14617.707645846811;14620.707585848437;14326.426942922166;14389.136651800925;14699.55901322962;14766;15067.924660376628;14089.365978530786;14116.435342586181;14119.364628591944;14126.929365353108;14502.492412765503;13412.39644215993;13569.253691047088;13638.454461821417;13739.313034348443;13887.722245555235;13578.86421135776;13811.549787272192;14042.508512202025;14119.505817296345;14271.357788899317;9296.023917488566;9384.530773461436;9563.521823908637;9728.902710973083;9923.1069203772;9724.95137524308;9841.901580984098;9955.651552195639;10050.798984020132;10340 06:15:50 INFO - PID 5862 | __end_tp_report 06:15:50 INFO - PID 5862 | __start_cc_report 06:15:50 INFO - PID 5862 | _x_x_mozilla_cycle_collect,286 06:15:50 INFO - PID 5862 | __end_cc_report 06:15:50 INFO - PID 5862 | __startTimestamp1495113350959__endTimestamp 06:15:50 INFO - PID 5862 | 06:15:50 INFO - PID 5862 | ------- Summary: start ------- 06:15:50 INFO - PID 5862 | Number of tests: 6 06:15:50 INFO - PID 5862 | 06:15:50 INFO - PID 5862 | [#0] dojo.html Cycles:165 Average:5372.10 Median:5515.20 stddev:661.15 (12.0%) stddev-sans-first:629.42 06:15:50 INFO - PID 5862 | Values: 2713.3 2717.4 2726.8 2746.3 2747.3 5379.1 5390.1 5416.3 5427.2 5440.7 5449.6 5515.2 5569.8 5570.6 5584.4 4797.1 4799.9 4826.6 4872.2 4926.8 4788.8 4854.8 4859.9 4861.7 4909.2 4810.1 4841.4 4854.2 4882.8 4907.1 4827.2 4876.7 4897.7 4906.1 4926.0 4701.2 4790.2 4805.6 4818.7 4855.4 5352.8 5425.0 5430.4 5433.4 5438.5 5741.5 5792.0 5874.2 5883.4 5890.4 5832.9 5842.2 5858.1 5858.2 5933.3 5404.5 5411.2 5431.5 5431.7 5437.4 5969.6 6000.5 6074.4 6078.6 6084.1 5640.7 5648.4 5663.5 5772.3 5863.8 5904.6 5974.0 5977.3 5991.2 6015.3 5919.6 5922.5 5927.4 5933.9 5934.1 5909.9 5912.6 5931.3 5932.3 5949.2 4797.4 4817.9 4869.5 4896.1 4903.3 4142.2 4148.2 4182.2 4231.6 4237.8 4854.6 4915.8 4960.0 4967.4 5013.7 5781.6 5867.6 5920.1 5923.3 5941.8 4889.2 4919.8 4943.6 4958.9 4960.5 5186.0 5236.3 5240.2 5260.9 5269.7 5303.7 5476.2 5483.4 5499.1 5507.1 5868.9 5921.8 5982.5 6014.1 6016.4 5253.8 5373.2 5376.0 5417.6 5429.5 5727.3 5786.7 5843.0 5865.0 5865.5 5817.8 5874.3 5942.5 5955.4 5958.3 5707.7 5730.5 5775.0 5777.1 5791.1 5810.9 5812.8 5835.6 5842.3 5852.0 5685.8 5761.8 5765.9 5771.3 5773.9 5688.0 5752.3 5766.6 5863.3 5893.8 5504.9 5524.6 5540.5 5549.8 5597.8 06:15:50 INFO - PID 5862 | 06:15:50 INFO - PID 5862 | [#1] ext.html Cycles:180 Average:29967.51 Median:16503.61 stddev:40078.38 (242.8%) stddev-sans-first:40130.45 06:15:50 INFO - PID 5862 | Values: 672.7 732.4 753.4 1061.1 1082.5 32535.5 33654.3 33684.8 33732.7 33796.3 34858.7 34872.5 34959.5 35184.3 35372.3 6823.6 6897.2 6985.9 7043.4 7065.8 7020.3 7107.2 7111.4 7122.2 7122.9 7087.2 7141.4 7145.9 7159.4 7182.0 7064.2 7077.9 7085.3 7095.0 7096.1 6695.8 6723.9 6774.7 6782.4 6796.9 32279.5 32379.0 32494.2 32679.7 32760.7 3112.8 3141.0 3141.8 3143.7 3144.3 24583.3 24637.5 24800.5 24831.8 24835.0 2943.3 2943.4 2969.9 2978.2 2988.5 134730.0 135915.0 151261.0 153326.0 153881.2 39336.6 39406.6 39414.8 39517.0 39671.0 39788.2 39876.8 40019.0 40065.4 40105.4 12684.6 12765.4 12776.0 12783.9 12893.7 10069.4 10117.2 10127.3 10198.7 10228.9 12747.5 12802.6 12825.7 12900.4 12977.4 5547.6 5560.9 5582.3 5623.3 5640.3 871.8 889.9 902.3 904.8 930.3 20259.2 20628.2 20976.7 21127.2 21426.8 955.3 965.7 972.4 980.4 1004.3 10665.9 11199.9 11245.6 11299.9 11353.7 170254.1 170540.0 170594.0 171447.1 171486.0 39911.8 39992.4 40096.0 40102.2 40292.4 1161.3 1210.8 1214.2 1226.0 1234.6 19099.4 19788.3 20335.0 20377.2 20592.8 28384.4 28563.6 28620.6 28622.3 28679.7 147878.0 148107.0 148917.0 149254.3 149584.0 27600.6 28069.4 28805.7 30018.7 30358.8 35523.0 36207.6 36281.3 36361.3 36831.6 26768.9 27048.0 27542.6 28003.6 28840.1 27147.0 27307.7 27870.4 27929.7 28919.4 30617.0 30970.0 31197.7 31308.2 31382.5 26343.9 26626.0 27197.3 27262.0 27853.6 21357.3 22251.4 22310.6 22375.6 22421.0 06:15:50 INFO - PID 5862 | 06:15:50 INFO - PID 5862 | [#2] jquery.html Cycles:180 Average:24461.93 Median:201496.50 stddev:59953.82 (29.8%) stddev-sans-first:60094.84 06:15:50 INFO - PID 5862 | Values: 425.3 427.9 431.8 444.6 447.3 16858.6 17365.8 17930.1 18113.4 18250.1 17869.0 18282.5 19204.4 19251.6 19333.1 5504.2 5511.2 5635.9 5669.1 5675.5 5553.1 5604.1 5643.0 5652.7 5669.7 5389.3 5486.9 5528.7 5559.4 5568.7 5348.6 5508.7 5540.2 5561.2 5572.5 5003.1 5040.4 5058.7 5062.5 5063.8 21545.6 21770.2 21791.2 21903.5 22085.3 1605.6 1623.7 1638.3 1651.9 1652.8 14516.9 14581.8 14844.4 15007.5 15069.5 1982.4 2027.9 2045.5 2050.3 2071.3 77111.6 77732.0 79149.6 79200.0 80960.0 10865.2 11176.1 11224.8 11238.3 11463.6 15750.4 15881.0 15890.7 15920.4 15938.4 7240.6 7485.7 7573.9 7753.9 7767.4 6725.0 6764.5 6994.7 6998.8 7009.8 6890.2 7000.6 7003.0 7071.7 7079.5 2113.3 2116.9 2151.3 2153.3 2161.5 873.3 908.6 914.3 916.0 946.3 17037.4 17558.9 18031.9 18140.2 18169.8 894.6 904.4 904.9 915.8 925.4 9351.0 9836.1 9843.4 9857.4 10049.4 357775.0 359222.0 361829.0 364562.0 365106.0 73666.6 75082.6 75212.2 76777.6 79582.8 1046.7 1055.7 1058.0 1068.1 1073.9 15127.6 15188.5 15495.3 15648.9 15684.9 36329.6 37887.0 38315.8 38370.4 38676.9 46787.1 48580.0 48846.0 50045.2 50118.0 8397.5 8474.3 8624.6 8626.6 9105.9 12890.6 13054.8 13374.7 13581.7 13606.9 11452.3 11463.5 11623.8 11867.9 12020.6 9856.6 10152.2 10205.7 10651.9 11040.1 11126.5 11856.8 11883.8 12185.1 12201.8 8534.8 8729.7 8765.2 8846.6 9037.2 11267.7 11395.9 11548.2 11658.2 11769.2 06:15:50 INFO - PID 5862 | 06:15:50 INFO - PID 5862 | [#3] mootools.html Cycles:180 Average:6336.69 Median:3771.42 stddev:4133.87 (109.6%) stddev-sans-first:4127.44 06:15:50 INFO - PID 5862 | Values: 1198.2 1211.7 1217.3 1252.3 1260.7 10130.7 10550.6 10605.2 10611.4 10796.9 9902.6 9997.2 10029.3 10030.2 10059.7 2232.2 2249.5 2259.0 2260.9 2261.8 2171.2 2214.9 2234.1 2241.0 2245.5 2236.8 2237.5 2260.8 2271.9 2275.9 2108.9 2142.3 2167.5 2169.9 2172.6 1971.0 2172.6 2172.9 2199.6 2201.3 10315.9 10336.4 10355.7 10414.8 10435.7 5531.4 5780.9 5784.7 5784.8 5799.2 3344.4 3539.5 3601.7 3603.1 3651.5 1045.5 1068.4 1094.7 1097.7 1113.5 15514.8 15554.7 15596.8 15651.8 15655.4 4621.5 4910.6 4989.2 4989.4 5007.9 10840.1 10897.7 10926.3 10930.2 10956.3 5694.8 5711.4 5712.4 5716.0 5731.7 5145.4 5196.9 5207.8 5278.7 5348.7 3731.4 3828.1 3915.5 3937.6 4050.1 1079.2 1102.7 1104.8 1113.2 1116.6 680.4 701.9 703.5 720.8 723.9 5202.2 5259.6 5265.8 5388.1 5479.7 501.9 515.1 517.7 518.5 519.1 3471.5 3711.8 3811.4 3900.7 3918.8 13193.3 13575.5 13838.8 13889.9 13925.4 13383.7 13474.3 13594.2 13667.2 13767.6 7564.3 7569.5 7663.9 7697.7 7729.2 5848.4 5892.5 5911.9 6058.0 6144.6 11818.7 11866.5 11975.1 12008.9 12199.5 12106.8 12518.6 12549.1 12579.6 12652.2 7210.9 7298.2 7324.2 7329.4 7335.6 9665.4 9694.9 9716.9 9790.4 9811.0 8180.6 8235.5 8296.6 8355.7 8428.7 8023.8 8055.4 8129.0 8212.3 8296.7 7168.5 7244.5 7298.2 7307.3 7313.4 5286.9 5329.7 5378.9 5455.6 5474.8 5245.2 5352.1 5522.2 5540.1 5667.4 06:15:50 INFO - PID 5862 | 06:15:50 INFO - PID 5862 | [#4] prototype.html Cycles:180 Average:4915.55 Median:5462.05 stddev:1398.05 (25.6%) stddev-sans-first:1359.83 06:15:50 INFO - PID 5862 | Values: 376.6 378.3 379.7 380.5 385.9 5458.7 5534.4 5570.2 5609.9 5634.0 5436.7 5483.7 5536.4 5550.6 5565.6 4259.9 4376.0 4390.5 4398.8 4405.7 4391.2 4396.3 4397.9 4402.0 4416.5 4398.7 4398.8 4404.8 4419.3 4425.6 4333.4 4368.2 4394.1 4394.7 4400.6 3908.1 3954.8 3968.8 3972.5 3974.9 5410.6 5431.2 5444.3 5452.2 5465.4 5063.6 5152.1 5222.9 5233.8 5246.8 5929.2 5931.7 5944.6 5962.5 5982.6 4447.8 4469.0 4476.2 4483.2 4496.9 5975.4 6185.2 6215.8 6230.9 6233.2 4348.7 4372.6 4385.8 4386.6 4394.5 4420.7 4431.2 4437.9 4459.9 4461.5 4878.8 4959.4 5002.7 5022.5 5030.0 5933.4 5960.7 5965.8 5986.3 5992.8 1616.7 1631.1 1632.1 1650.7 1653.8 1112.4 1152.3 1161.6 1171.1 1180.8 4962.4 5028.5 5039.5 5040.6 5072.9 6083.1 6092.7 6104.2 6111.2 6117.3 4977.0 5023.9 5031.8 5079.8 5086.7 3209.6 3211.4 3215.5 3225.2 3230.8 5506.5 5579.9 5590.9 5593.3 5644.8 6082.5 6208.2 6233.2 6274.5 6303.3 5632.5 5635.8 5651.6 5654.7 5658.0 5986.3 6101.2 6106.8 6122.6 6139.5 5964.3 5972.7 6008.7 6010.3 6016.0 5623.5 5643.8 5674.3 5681.6 5709.4 4082.8 4109.3 4118.5 4125.2 4158.6 6071.9 6137.4 6141.1 6150.9 6159.8 5915.9 5937.9 5939.2 5940.1 5948.8 5779.7 5859.8 5879.6 5894.3 5927.4 5831.4 5832.6 5841.7 5865.6 5897.3 5848.4 5950.9 5982.9 5988.9 5995.4 5743.5 5766.4 5766.5 5769.7 5769.8 06:15:50 INFO - PID 5862 | 06:15:50 INFO - PID 5862 | [#5] yui.html Cycles:180 Average:15108.35 Median:23707.41 stddev:17284.71 (72.9%) stddev-sans-first:17299.42 06:15:50 INFO - PID 5862 | Values: 719.3 740.6 750.0 757.8 763.5 13632.3 14501.2 14514.6 15308.4 16600.5 15865.6 16009.8 16254.0 16258.0 16373.5 888.8 910.4 913.9 916.4 918.5 883.8 911.6 913.2 914.2 919.5 965.9 966.6 966.8 966.9 967.1 952.3 957.3 958.1 958.7 965.0 701.8 704.2 707.3 708.1 708.2 14140.4 14190.3 14654.2 14780.8 14807.8 15613.8 15743.2 15844.4 16022.4 16090.6 12488.8 12711.7 12738.6 12802.6 12813.9 2928.4 2970.3 2971.1 2972.4 2977.3 62720.1 67398.0 69166.0 69782.7 71027.6 12466.9 12656.9 12791.1 12802.6 12822.8 22542.0 22681.4 22898.5 23228.3 23240.4 6393.2 6459.1 6459.1 6477.9 6494.8 3009.5 3057.3 3063.0 3067.8 3083.4 3388.4 3443.2 3445.5 3595.2 3611.8 708.4 719.8 720.1 727.5 727.8 584.8 591.6 593.9 605.3 605.6 9194.3 10392.3 10466.4 10726.4 11061.6 595.3 597.4 601.0 618.5 630.0 4304.2 4449.5 4462.0 4470.8 4486.4 56815.7 57247.9 57615.7 58833.0 62949.0 48875.8 49610.8 50062.2 50290.5 51241.5 46386.8 47157.3 47625.8 48130.3 49191.3 9803.8 10291.5 10307.2 10467.8 10734.7 24649.3 25546.6 25580.6 25580.6 25798.2 43110.6 43399.8 47244.5 47670.5 47741.3 13054.6 14254.0 14438.4 14617.7 14620.7 14326.4 14389.1 14699.6 14766.0 15067.9 14089.4 14116.4 14119.4 14126.9 14502.5 13412.4 13569.3 13638.5 13739.3 13887.7 13578.9 13811.5 14042.5 14119.5 14271.4 9296.0 9384.5 9563.5 9728.9 9923.1 9725.0 9841.9 9955.7 10050.8 10340.0 06:15:50 INFO - PID 5862 | -------- Summary: end -------- 06:15:50 INFO - PID 5862 | 06:15:51 INFO - TEST-INFO | 5862: exit 0 06:15:51 INFO - TEST-OK | dromaeo_css | took 1118704ms 06:15:51 INFO - TEST-START | kraken 06:15:51 INFO - operating with platform_type : linux_ 06:15:51 INFO - Initialising browser for kraken test... 06:15:51 INFO - TEST-INFO | started process 6266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEVuTtD/profile http://localhost:36531/getInfo.html) 06:15:52 INFO - PID 6266 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 06:15:55 INFO - PID 6266 | __metrics Screen width/height:1600/1200 06:15:55 INFO - PID 6266 | colorDepth:24 06:15:55 INFO - PID 6266 | Browser inner width/height: 1024/695 06:15:55 INFO - PID 6266 | __metrics 06:15:57 INFO - TEST-INFO | 6266: exit 0 06:15:57 INFO - Browser initialized. 06:15:57 INFO - Running cycle 1/1 for kraken test... 06:15:57 INFO - TEST-INFO | started process 6430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEVuTtD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:09 INFO - PID 6430 | RSS: Main: 165220352 06:16:09 INFO - PID 6430 | 06:16:12 INFO - PID 6430 | Cycle 1(1): loaded http://localhost:36531/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36531/tests/kraken/driver.html?testName=audio-beat-detection) 06:16:13 INFO - PID 6430 | RSS: Main: 170606592 06:16:13 INFO - PID 6430 | 06:16:15 INFO - PID 6430 | Cycle 1(1): loaded http://localhost:36531/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36531/tests/kraken/driver.html?testName=audio-dft) 06:16:16 INFO - PID 6430 | RSS: Main: 170151936 06:16:16 INFO - PID 6430 | 06:16:19 INFO - PID 6430 | Cycle 1(1): loaded http://localhost:36531/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36531/tests/kraken/driver.html?testName=audio-fft) 06:16:19 INFO - PID 6430 | RSS: Main: 165257216 06:16:19 INFO - PID 6430 | 06:16:21 INFO - PID 6430 | Cycle 1(1): loaded http://localhost:36531/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36531/tests/kraken/driver.html?testName=audio-oscillator) 06:16:22 INFO - PID 6430 | RSS: Main: 165953536 06:16:22 INFO - PID 6430 | 06:16:24 INFO - PID 6430 | Cycle 1(1): loaded http://localhost:36531/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36531/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:16:25 INFO - PID 6430 | RSS: Main: 165883904 06:16:25 INFO - PID 6430 | 06:16:28 INFO - PID 6430 | Cycle 1(1): loaded http://localhost:36531/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36531/tests/kraken/driver.html?testName=imaging-darkroom) 06:16:29 INFO - PID 6430 | RSS: Main: 170299392 06:16:29 INFO - PID 6430 | 06:16:32 INFO - PID 6430 | Cycle 1(1): loaded http://localhost:36531/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36531/tests/kraken/driver.html?testName=imaging-desaturate) 06:16:33 INFO - PID 6430 | RSS: Main: 168452096 06:16:33 INFO - PID 6430 | 06:16:36 INFO - PID 6430 | Cycle 1(1): loaded http://localhost:36531/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36531/tests/kraken/driver.html?testName=json-parse-financial) 06:16:36 INFO - PID 6430 | RSS: Main: 168779776 06:16:36 INFO - PID 6430 | 06:16:38 INFO - PID 6430 | Cycle 1(1): loaded http://localhost:36531/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36531/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:16:38 INFO - PID 6430 | RSS: Main: 168865792 06:16:38 INFO - PID 6430 | 06:16:40 INFO - PID 6430 | Cycle 1(1): loaded http://localhost:36531/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36531/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:16:41 INFO - PID 6430 | RSS: Main: 168886272 06:16:41 INFO - PID 6430 | 06:16:43 INFO - PID 6430 | Cycle 1(1): loaded http://localhost:36531/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36531/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:16:44 INFO - PID 6430 | RSS: Main: 168955904 06:16:44 INFO - PID 6430 | 06:16:46 INFO - PID 6430 | Cycle 1(1): loaded http://localhost:36531/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:16:47 INFO - PID 6430 | RSS: Main: 169037824 06:16:47 INFO - PID 6430 | 06:16:50 INFO - PID 6430 | Cycle 1(1): loaded http://localhost:36531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:16:51 INFO - PID 6430 | RSS: Main: 169107456 06:16:51 INFO - PID 6430 | 06:16:53 INFO - PID 6430 | Cycle 1(1): loaded http://localhost:36531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36531/tests/kraken/driver.html?testName=ai-astar) 06:16:53 INFO - PID 6430 | RSS: Main: 170434560 06:16:53 INFO - PID 6430 | 06:16:53 INFO - PID 6430 | __start_tp_report 06:16:53 INFO - PID 6430 | _x_x_mozilla_page_load 06:16:53 INFO - PID 6430 | _x_x_mozilla_page_load_details 06:16:53 INFO - PID 6430 | |i|pagename|runs| 06:16:53 INFO - PID 6430 | |0;ai-astar;103;111;111;113;112;112;112;111;113;114 06:16:53 INFO - PID 6430 | |1;audio-beat-detection;153;122;124;170;123;127;122;123;146;126 06:16:53 INFO - PID 6430 | |2;audio-dft;165;164;163;164;163;166;169;172;166;166 06:16:53 INFO - PID 6430 | |3;audio-fft;74;76;74;106;77;75;75;75;93;76 06:16:53 INFO - PID 6430 | |4;audio-oscillator;83;82;105;84;84;84;97;83;84;104 06:16:53 INFO - PID 6430 | |5;imaging-gaussian-blur;114;115;114;114;114;114;114;118;115;132 06:16:53 INFO - PID 6430 | |6;imaging-darkroom;153;151;151;152;150;150;150;150;153;151 06:16:53 INFO - PID 6430 | |7;imaging-desaturate;94;95;94;100;95;94;95;95;95;94 06:16:53 INFO - PID 6430 | |8;json-parse-financial;54;53;52;55;56;58;55;56;55;55 06:16:53 INFO - PID 6430 | |9;json-stringify-tinderbox;57;56;57;56;57;56;57;56;57;56 06:16:53 INFO - PID 6430 | |10;stanford-crypto-aes;89;90;83;84;91;82;84;83;82;83 06:16:53 INFO - PID 6430 | |11;stanford-crypto-ccm;135;135;132;139;137;137;133;139;181;135 06:16:53 INFO - PID 6430 | |12;stanford-crypto-pbkdf2;194;194;195;201;194;193;199;205;194;195 06:16:53 INFO - PID 6430 | |13;stanford-crypto-sha256-iterative;76;78;78;73;75;77;72;73;73;74 06:16:53 INFO - PID 6430 | __end_tp_report 06:16:53 INFO - PID 6430 | __start_cc_report 06:16:53 INFO - PID 6430 | _x_x_mozilla_cycle_collect,771 06:16:53 INFO - PID 6430 | __end_cc_report 06:16:53 INFO - PID 6430 | __startTimestamp1495113413480__endTimestamp 06:16:53 INFO - PID 6430 | 06:16:53 INFO - PID 6430 | ------- Summary: start ------- 06:16:53 INFO - PID 6430 | Number of tests: 14 06:16:53 INFO - PID 6430 | 06:16:53 INFO - PID 6430 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:3.05 (2.7%) stddev-sans-first:1.05 06:16:53 INFO - PID 6430 | Values: 103.0 111.0 111.0 113.0 112.0 112.0 112.0 111.0 113.0 114.0 06:16:53 INFO - PID 6430 | 06:16:53 INFO - PID 6430 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:126.50 stddev:16.81 (13.3%) stddev-sans-first:16.30 06:16:53 INFO - PID 6430 | Values: 153.0 122.0 124.0 170.0 123.0 127.0 122.0 123.0 146.0 126.0 06:16:53 INFO - PID 6430 | 06:16:53 INFO - PID 6430 | [#2] audio-dft Cycles:10 Average:165.80 Median:166.00 stddev:2.82 (1.7%) stddev-sans-first:2.98 06:16:53 INFO - PID 6430 | Values: 165.0 164.0 163.0 164.0 163.0 166.0 169.0 172.0 166.0 166.0 06:16:53 INFO - PID 6430 | 06:16:53 INFO - PID 6430 | [#3] audio-fft Cycles:10 Average:80.10 Median:75.50 stddev:10.71 (14.2%) stddev-sans-first:11.13 06:16:53 INFO - PID 6430 | Values: 74.0 76.0 74.0 106.0 77.0 75.0 75.0 75.0 93.0 76.0 06:16:53 INFO - PID 6430 | 06:16:53 INFO - PID 6430 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:84.00 stddev:9.23 (11.0%) stddev-sans-first:9.53 06:16:53 INFO - PID 6430 | Values: 83.0 82.0 105.0 84.0 84.0 84.0 97.0 83.0 84.0 104.0 06:16:53 INFO - PID 6430 | 06:16:53 INFO - PID 6430 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:114.50 stddev:5.62 (4.9%) stddev-sans-first:5.89 06:16:53 INFO - PID 6430 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 114.0 118.0 115.0 132.0 06:16:53 INFO - PID 6430 | 06:16:53 INFO - PID 6430 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:1.20 (0.8%) stddev-sans-first:1.05 06:16:53 INFO - PID 6430 | Values: 153.0 151.0 151.0 152.0 150.0 150.0 150.0 150.0 153.0 151.0 06:16:53 INFO - PID 6430 | 06:16:53 INFO - PID 6430 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:1.79 (1.9%) stddev-sans-first:1.86 06:16:53 INFO - PID 6430 | Values: 94.0 95.0 94.0 100.0 95.0 94.0 95.0 95.0 95.0 94.0 06:16:53 INFO - PID 6430 | 06:16:53 INFO - PID 6430 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.66 (3.0%) stddev-sans-first:1.73 06:16:53 INFO - PID 6430 | Values: 54.0 53.0 52.0 55.0 56.0 58.0 55.0 56.0 55.0 55.0 06:16:53 INFO - PID 6430 | 06:16:53 INFO - PID 6430 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:57.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 06:16:53 INFO - PID 6430 | Values: 57.0 56.0 57.0 56.0 57.0 56.0 57.0 56.0 57.0 56.0 06:16:53 INFO - PID 6430 | 06:16:53 INFO - PID 6430 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.00 stddev:3.48 (4.1%) stddev-sans-first:3.39 06:16:53 INFO - PID 6430 | Values: 89.0 90.0 83.0 84.0 91.0 82.0 84.0 83.0 82.0 83.0 06:16:53 INFO - PID 6430 | 06:16:53 INFO - PID 6430 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:137.00 stddev:14.48 (10.6%) stddev-sans-first:15.24 06:16:53 INFO - PID 6430 | Values: 135.0 135.0 132.0 139.0 137.0 137.0 133.0 139.0 181.0 135.0 06:16:53 INFO - PID 6430 | 06:16:53 INFO - PID 6430 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.40 Median:195.00 stddev:3.95 (2.0%) stddev-sans-first:4.09 06:16:53 INFO - PID 6430 | Values: 194.0 194.0 195.0 201.0 194.0 193.0 199.0 205.0 194.0 195.0 06:16:53 INFO - PID 6430 | 06:16:53 INFO - PID 6430 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:75.50 stddev:2.23 (3.0%) stddev-sans-first:2.33 06:16:53 INFO - PID 6430 | Values: 76.0 78.0 78.0 73.0 75.0 77.0 72.0 73.0 73.0 74.0 06:16:53 INFO - PID 6430 | -------- Summary: end -------- 06:16:53 INFO - PID 6430 | 06:16:54 INFO - TEST-INFO | 6430: exit 0 06:16:54 INFO - TEST-OK | kraken | took 62783ms 06:16:54 INFO - SUITE-END | took 1181s 06:16:54 INFO - Completed test suite (00:19:41) 06:16:54 INFO - javascript benchmark 06:16:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6807.448734318121, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2713.2809805401566, 2717.442924200539, 2726.809123361364, 2746.3134216445874, 2747.2994386431455, 5379.058664733676, 5390.1375779875225, 5416.268803711493, 5427.1587903874915, 5440.727963601819, 5449.56403487721, 5515.200295957084, 5569.832905012846, 5570.610057295991, 5584.4136365681625, 4797.0645724083815, 4799.856004319876, 4826.613870890338, 4872.171730805771, 4926.802927882881, 4788.784504697297, 4854.757262136896, 4859.927101093486, 4861.659683822134, 4909.165441874889, 4810.11012962603, 4841.370621819176, 4854.223324268136, 4882.780274887621, 4907.11671899058, 4827.227643577046, 4876.7073975561225, 4897.681650692693, 4906.067847109038, 4926.014797040606, 4701.153792317382, 4790.185668436339, 4805.6155507559315, 4818.686785358976, 4855.417349917997, 5352.812651557216, 5425.0, 5430.3755068167275, 5433.375161856397, 5438.53772429344, 5741.483266506035, 5792.044312688401, 5874.1776151338845, 5883.441073098049, 5890.410958904118, 5832.88334233313, 5842.2405087338375, 5858.121281807763, 5858.209141765849, 5933.317668468095, 5404.486573775485, 5411.18832175169, 5431.456854314537, 5431.674099553999, 5437.401885792559, 5969.582129250911, 6000.489958353502, 6074.42292982166, 6078.635281883101, 6084.117802918552, 5640.746166422521, 5648.435156484401, 5663.490285874291, 5772.278465191851, 5863.824085277449, 5904.5571582131515, 5974.014287642491, 5977.252843394575, 5991.161237426763, 6015.3383127855905, 5919.644821310735, 5922.526197904157, 5927.407259274038, 5933.881322373529, 5934.109883517507, 5909.881802363929, 5912.615679980788, 5931.347551769302, 5932.3177834548715, 5949.196858424058, 4797.376341075707, 4817.855464336076, 4869.464358920516, 4896.143174944442, 4903.264510323409, 4142.192272506893, 4148.191102734938, 4182.163567286494, 4231.576842315805, 4237.8304867805555, 4854.611631069506, 4915.827946021944, 4960.0327936052845, 4967.403911530567, 5013.749312534359, 5781.6241944274325, 5867.589268751147, 5920.089704342794, 5923.289205295392, 5941.781934703376, 4889.168841296988, 4919.754012299442, 4943.629227807929, 4958.925616115761, 4960.50394960501, 5186.0, 5236.319278493771, 5240.161574148195, 5260.894782104337, 5269.683818970874, 5303.655262407931, 5476.17857321405, 5483.396826349099, 5499.120140777456, 5507.146392309199, 5868.853278668067, 5921.7631294747725, 5982.46157845796, 6014.127951447103, 6016.368281330398, 5253.789848406173, 5373.194020896741, 5376.0, 5417.593680473901, 5429.484199001088, 5727.31272247333, 5786.681732504752, 5842.970785146217, 5865.0, 5865.472107510344, 5817.825465236049, 5874.295084589877, 5942.524598032233, 5955.40445955401, 5958.255218097738, 5707.743151558107, 5730.455606717355, 5775.0, 5777.104548794943, 5791.131330300489, 5810.912836307543, 5812.825615231381, 5835.56233282514, 5842.269716285465, 5851.970740146272, 5685.829425117253, 5761.798337058183, 5765.91351129725, 5771.336296325976, 5773.884522309614, 5688.0, 5752.309722833287, 5766.596338256281, 5863.325717542537, 5893.823185304448, 5504.862378440571, 5524.613277070566, 5540.473655002768, 5549.833504994856, 5597.804076857454], "value": 5321.234685652963, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.6569449580716, 732.406750532069, 753.3972821742607, 1061.0821639282024, 1082.4533610526682, 32535.511967320508, 33654.326913461715, 33684.831575842116, 33732.662673373256, 33796.32407351852, 34858.65141348586, 34872.47691284633, 34959.475607865905, 35184.296314073705, 35372.2925541489, 6823.624700641462, 6897.206821215562, 6985.930140698604, 7043.380022594806, 7065.752698655548, 7020.333068358498, 7107.218205997337, 7111.431085513146, 7122.216556178816, 7122.893156602655, 7087.18497372801, 7141.428685705131, 7145.85708285834, 7159.35565799078, 7182.0, 7064.18761842387, 7077.893831592531, 7085.291470852873, 7095.006699062135, 7096.112985876765, 6695.765648202289, 6723.865522689568, 6774.729010839561, 6782.355676210752, 6796.898046529306, 32279.51580726291, 32379.0, 32494.187645309055, 32679.6732032679, 32760.672393276, 3112.813231206112, 3141.0, 3141.811491310506, 3143.654198038214, 3144.3239703463864, 24583.262502124966, 24637.5072498549, 24800.5039899201, 24831.751682483125, 24835.00659973599, 2943.323035701779, 2943.396603696237, 2969.881204751807, 2978.240548660078, 2988.5218365061487, 134730.0, 135915.0, 151261.0, 153326.0, 153881.23059384633, 39336.6066339333, 39406.60593394087, 39414.80292598519, 39517.0, 39671.0, 39788.20423591512, 39876.80061599673, 40019.0, 40065.39901901474, 40105.39841902374, 12684.556040538537, 12765.425555849823, 12776.041796865273, 12783.93608031954, 12893.677658058623, 10069.395836249849, 10117.190624750003, 10127.341722787995, 10198.745031374276, 10228.87482376938, 12747.49010039588, 12802.615921522369, 12825.739189371045, 12900.387451568555, 12977.41601627929, 5547.639403438763, 5560.944390556124, 5582.274304340491, 5623.268975033219, 5640.32316122068, 871.8125602995386, 889.888763904512, 902.255639097747, 904.7692838326185, 930.2511478260066, 20259.18963241454, 20628.17487300491, 20976.685349719766, 21127.154913803584, 21426.78573214279, 955.3121752338305, 965.7199412170391, 972.3825370889394, 980.4215512847454, 1004.2919741582167, 10665.946670266754, 11199.94400028011, 11245.594300712411, 11299.887001129884, 11353.716157095974, 170254.14872925557, 170540.0, 170594.0, 171447.14276428788, 171486.0, 39911.800440997606, 39992.400113998316, 40096.0, 40102.19795604071, 40292.39561406581, 1161.3264306702092, 1210.8365370675021, 1214.2228973456995, 1225.9816102758466, 1234.6357824441811, 19099.427017189508, 19788.307409241184, 20335.0, 20377.18491260333, 20592.79407205909, 28384.43231135407, 28563.571546427236, 28620.57069144006, 28622.284442889093, 28679.713202868537, 147878.0, 148107.0, 148917.0, 149254.25372873066, 149584.0, 27600.585991210548, 28069.43861122807, 28805.7119428803, 30018.69981300159, 30358.84820575883, 35523.0, 36207.63792362042, 36281.27437451289, 36361.27277454489, 36831.63168368389, 26768.866155669097, 27048.0, 27542.5868611975, 28003.579946300415, 28840.134795956154, 27147.0, 27307.72692273052, 27870.399496696817, 27929.720702793526, 28919.421611568072, 30617.0, 30970.0, 31197.688023119477, 31308.217294567818, 31382.529262061544, 26343.868280658473, 26626.0, 27197.32006699769, 27262.0, 27853.582196267478, 21357.252496163183, 22251.443713907283, 22310.553788924455, 22375.552488950456, 22421.0], "value": 14468.531738907666, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.3407218810842, 427.89944363074665, 431.8245823801736, 444.55766512320247, 447.27318108074377, 16858.578535536617, 17365.826341736578, 17930.103494825238, 18113.366032188875, 18250.087495625234, 17869.0, 18282.542936426595, 19204.423867283967, 19251.556133290025, 19333.130009149587, 5504.22940788288, 5511.173324001392, 5635.915461268064, 5669.0646043402785, 5675.489205971462, 5553.111502159655, 5604.103343465046, 5642.971785141069, 5652.689102099383, 5669.716514174295, 5389.326334208224, 5486.945130548684, 5528.668279903199, 5559.360673522557, 5568.721563921808, 5348.598855085884, 5508.6970216638065, 5540.196671482653, 5561.165825126243, 5572.4706152915405, 5003.149464591028, 5040.36995375578, 5058.721770302632, 5062.544371006627, 5063.8480845574695, 21545.56908861814, 21770.238041668625, 21791.23730669419, 21903.452413689625, 22085.33743987683, 1605.6066263765451, 1623.7483190105552, 1638.2545941596545, 1651.9091449970247, 1652.842979916906, 14516.854831451656, 14581.781273280909, 14844.406223751144, 15007.549773506813, 15069.54791356261, 1982.3557343863301, 2027.9290224842207, 2045.5193029638024, 2050.3438899552148, 2071.3475255294684, 77111.61444192744, 77732.0, 79149.60425197895, 79200.0, 80960.0, 10865.185111116698, 11176.105911527058, 11224.831627525593, 11238.269512481662, 11463.598774043036, 15750.448734294245, 15881.0, 15890.682186356207, 15920.363185472683, 15938.362465501483, 7240.565566066053, 7485.700571977169, 7573.886391704129, 7753.883691744629, 7767.417443691633, 6725.0, 6764.526483146133, 6994.68523916425, 6998.75504357345, 7009.7897063088185, 6890.2076261229595, 7000.579965202104, 7003.039149038277, 7071.681774320168, 7079.469039822034, 2113.3448630924463, 2116.8624039437386, 2151.2900742755164, 2153.3432303147692, 2161.492049368397, 873.3493547307297, 908.5638893331238, 914.277720600718, 916.029009250197, 946.3375637054089, 17037.40369087076, 17558.91220543889, 18031.909840450975, 18140.183691733902, 18169.818301816813, 894.552723638181, 904.3714618340322, 904.895936967244, 915.7573243090586, 925.4077390470104, 9350.95324523373, 9836.06557377048, 9843.409395436296, 9857.408555486694, 10049.447280399501, 357775.0, 359222.0, 361829.0, 364562.0, 365106.0, 73666.63166684132, 75082.62458687671, 75212.24787752162, 76777.61611191908, 79582.80625790618, 1046.7173863056933, 1055.6832950114936, 1058.0477570186893, 1068.1348108032519, 1073.8765042020111, 15127.621809454851, 15188.46840360582, 15495.302711378241, 15648.92175539115, 15684.92157539205, 36329.63670363263, 37887.0, 38315.808420957714, 38370.42444363393, 38676.893002474055, 46787.06425871531, 48580.0, 48846.02307953892, 50045.249321259485, 50118.0, 8397.538135402612, 8474.322054235523, 8624.568771561271, 8626.611802468778, 9105.908940910771, 12890.613281601567, 13054.804177937149, 13374.665633359244, 13581.66045848822, 13606.86393136056, 11452.255603385753, 11463.484143213409, 11623.76752464963, 11867.940660296988, 12020.579279725518, 9856.5564549594, 10152.187824974131, 10205.744856378353, 10651.946740266249, 11040.116790656568, 11126.49930753102, 11856.76286474283, 11883.76232475363, 12185.086118541321, 12201.816972745239, 8534.786630334043, 8729.694460693845, 8765.167309105625, 8846.601902914255, 9037.186653201243, 11267.746450710054, 11395.943020284845, 11548.249363791327, 11658.18392712536, 11769.234999724991], "value": 8924.768193997636, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1198.2391181599685, 1211.715246916974, 1217.287886586347, 1252.279939035055, 1260.7163388237648, 10130.746731331712, 10550.630727924525, 10605.15158787296, 10611.416372099531, 10796.946015269932, 9902.554385052672, 9997.15024222942, 10029.34809237399, 10030.247731420155, 10059.748506287346, 2232.2075663139553, 2249.516353983893, 2258.9661155082604, 2260.9095636174534, 2261.762514935933, 2171.2183613898983, 2214.8892555372167, 2234.128689810975, 2241.025154057982, 2245.461089338555, 2236.7539570647214, 2237.5301186750803, 2260.8078313343303, 2271.8750468724215, 2275.8748268845206, 2108.862923909941, 2142.2930432957087, 2167.5231449081175, 2169.8698078115285, 2172.56548690261, 1970.980290197094, 2172.5654869026257, 2172.913083476659, 2199.604071267171, 2201.2955854126685, 10315.948420257926, 10336.379817210916, 10355.689329320057, 10414.843777343345, 10435.68692939213, 5531.419200983879, 5780.913286300709, 5784.68184249866, 5784.797532086357, 5799.217105690762, 3344.3980083584943, 3539.469079638049, 3601.7478776485655, 3603.1172362771026, 3651.4522821576975, 1045.5190612318343, 1068.4016950507742, 1094.7263184203948, 1097.7365432296272, 1113.465536542456, 15514.767278490832, 15554.688906221925, 15596.844031559653, 15651.765223521656, 15655.373785048585, 4621.491635920046, 4910.607151427877, 4989.226669866104, 4989.426215985208, 5007.874803129878, 10840.078593319657, 10897.727556811144, 10926.289791163708, 10930.234883558234, 10956.28784129029, 5694.800681976111, 5711.400302968212, 5712.400197979236, 5715.971420142872, 5731.656100633975, 5145.408278047998, 5196.870078248074, 5207.765650545734, 5278.736063196825, 5348.679079255179, 3731.402975523903, 3828.1003964068423, 3915.451836742858, 3937.586553411908, 4050.088730035777, 1079.2445288298065, 1102.6802227354137, 1104.8342748587777, 1113.1910645201547, 1116.6147679050714, 680.3808534233823, 701.8947157926352, 703.549728173969, 720.7513407874275, 723.9058922340167, 5202.167653175549, 5259.579233661298, 5265.815696450606, 5388.137897936312, 5479.698616576126, 501.8971110922252, 515.1448595331732, 517.6824980424827, 518.4996478398364, 519.070863154956, 3471.5139880416764, 3711.832967516468, 3811.4282857571584, 3900.7074469414906, 3918.8040597970557, 13193.340332983313, 13575.52485662997, 13838.792418113737, 13889.861101389059, 13925.373358198905, 13383.665408364868, 13474.326283685776, 13594.184348939096, 13667.179969201681, 13767.586972390643, 7564.281393267631, 7569.470137090461, 7663.923360766433, 7697.730579429693, 7729.227077292226, 5848.356680765028, 5892.528597712087, 5911.881762364815, 6057.969710151598, 6144.56988010835, 11818.704532386759, 11866.525338986688, 11975.101867360157, 12008.879911200776, 12199.451024703732, 12106.818397723864, 12518.624441266777, 12549.121561490972, 12579.559715409916, 12652.240865548096, 7210.9278907210255, 7298.160711518243, 7324.157721861841, 7329.413646908128, 7335.559866408033, 9665.371750836173, 9694.9030509694, 9716.854247186438, 9790.412575245507, 9810.950945245228, 8180.5909704515725, 8235.464694794819, 8296.626651800563, 8355.707550235713, 8428.704995325379, 8023.799405014688, 8055.355571554379, 8129.0, 8212.260896519341, 8296.70961516344, 7168.498205125591, 7244.492885497964, 7298.197198308076, 7307.26927307265, 7313.378362839218, 5286.8942621148135, 5329.733513324396, 5378.865528361665, 5455.618106732491, 5474.808381706621, 5245.160774276097, 5352.116900711495, 5522.171674248895, 5540.058190107611, 5667.376588575171], "value": 4700.332369339043, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.60268416820253, 378.273714468221, 379.7209051347261, 380.4825437405129, 385.94403811447324, 5458.699771512565, 5534.426491681367, 5570.192322113291, 5609.915851262234, 5633.971830140844, 5436.700981446019, 5483.725813709309, 5536.363318218406, 5550.611457197998, 5565.638233514819, 4259.87220383389, 4376.0, 4390.495093064291, 4398.7580683062415, 4405.7356558606425, 4391.209582275189, 4396.252637051693, 4397.890052748675, 4402.0, 4416.514183439819, 4398.670099742516, 4398.780060996954, 4404.845830395937, 4419.270820314644, 4425.645948324142, 4333.371661109153, 4368.213721530124, 4394.099209662011, 4394.6923715339935, 4400.6259467945265, 3908.0816008238326, 3954.802259887023, 3968.8214030368704, 3972.543157536891, 3974.8608798691907, 5410.621256512046, 5431.158170483582, 5444.257837492004, 5452.182172674131, 5465.398806131322, 5063.569596584295, 5152.124138896396, 5222.929299493632, 5233.842984710464, 5246.7901283948595, 5929.1995580596495, 5931.73307201177, 5944.583879128462, 5962.522998160137, 5982.641041537521, 4447.777611119431, 4468.977655111737, 4476.187144206601, 4483.21543729846, 4496.8875778105485, 5975.402459754033, 6185.16500272462, 6215.81352559424, 6230.9065364020025, 6233.189685340922, 4348.7390756554705, 4372.628326592212, 4385.802638881258, 4386.561343865652, 4394.538573449806, 4420.734755914591, 4431.189177307513, 4437.933430998538, 4459.878085340275, 4461.464624245112, 4878.780454879539, 4959.355283813081, 5002.699838009731, 5022.522860328263, 5030.0, 5933.406659334119, 5960.731767070492, 5965.79119730816, 5986.341502434729, 5992.790252341147, 1616.7170745119556, 1631.111044480761, 1632.1023437109543, 1650.678117767048, 1653.7602047703015, 1112.3826276416505, 1152.3143729481112, 1161.611873810788, 1171.0748508678048, 1180.8110702287593, 4962.367712646173, 5028.547430731252, 5039.496050394931, 5040.596752259884, 5072.949270507322, 6083.087536869505, 6092.695365231721, 6104.236970378703, 6111.174991376196, 6117.296510901214, 4977.034071541721, 5023.899522009539, 5031.84904452867, 5079.847604571869, 5086.669366491166, 3209.646938836726, 3211.4379983502795, 3215.469447541176, 3225.1614580209316, 3230.78999865008, 5506.475855452513, 5579.9163012554845, 5590.91613625796, 5593.300837395325, 5644.8306550803545, 6082.482988945901, 6208.161898143783, 6233.189685340967, 6274.498040156776, 6303.2751233607805, 5632.4930756231315, 5635.802746903839, 5651.598070819968, 5654.692005177018, 5657.971710141505, 5986.281646202484, 6101.237345331833, 6106.755729770937, 6122.602030867979, 6139.539534535017, 5964.343922168471, 5972.701364931823, 6008.669523176267, 6010.338862725184, 6016.007358785751, 5623.522000629992, 5643.802466913638, 5674.3260738081535, 5681.551204442841, 5709.400512946081, 4082.7544850332793, 4109.321961876257, 4118.52636946755, 4125.216208920296, 4158.604932531404, 6071.878562428815, 6137.40427488865, 6141.109539116893, 6150.938490615036, 6159.846003849761, 5915.881682366415, 5937.940620593911, 5939.227900372924, 5940.138679891305, 5948.821535353946, 5779.653220806765, 5859.794907178229, 5879.588428809942, 5894.2926848778425, 5927.436893495111, 5831.387704291158, 5832.591718579659, 5841.678707671119, 5865.648061116347, 5897.321807991964, 5848.444397782374, 5950.910736338872, 5982.850428739316, 5988.8802223956145, 5995.400459953969, 5743.540516758566, 5766.4233576642, 5766.481016708516, 5769.74036168365, 5769.769209231584], "value": 4492.9721617511495, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.2843121094505, 740.5704691279059, 749.9962500187495, 757.8370650310183, 763.5075376382233, 13632.318384080794, 14501.202433866134, 14514.637134071667, 15308.387664493435, 16600.50198494044, 15865.603359915978, 16009.83990160098, 16254.0, 16258.0, 16373.508794736177, 888.7689200807772, 910.4355299714186, 913.9451632902014, 916.3814425262955, 918.5269586163131, 883.8276536075468, 911.6034524981621, 913.159892898535, 914.1955079530004, 919.5448253114718, 965.903409659032, 966.5891995901749, 966.8018056298478, 966.8791401074866, 967.0571193086754, 952.2667545989584, 957.3298690916351, 958.0515289863055, 958.7219706285134, 965.0301447045674, 701.7894631610548, 704.2218348724637, 707.3421717802441, 708.1077841919167, 708.1997343002425, 14140.434382624682, 14190.290485475685, 14654.194019328932, 14780.778288325684, 14807.777883331759, 15613.765793513106, 15743.212839357986, 15844.366225350972, 16022.439214627431, 16090.5977350566, 12488.81266780999, 12711.682207944783, 12738.554150604778, 12802.615921522369, 12813.93593032029, 2928.355761732437, 2970.3465237647897, 2971.1383698727345, 2972.4055188962293, 2977.285451491648, 62720.059199112504, 67398.0, 69165.96251056239, 69782.65108674475, 71027.64486177536, 12466.87533124657, 12656.873431265754, 12791.10462267651, 12802.551910683082, 12822.80765788514, 22542.0, 22681.432964176027, 22898.542029159322, 23228.3031509055, 23240.41898952506, 6393.1688880445245, 6459.09572659828, 6459.128017717642, 6477.902831457532, 6494.837629059311, 3009.458297506426, 3057.2509735114595, 3062.9846850765603, 3067.831269280211, 3083.383323335342, 3388.423967925459, 3443.1908501502126, 3445.5348527948404, 3595.227026189382, 3611.7652352596997, 708.4155571653406, 719.7660760252834, 720.1034711783863, 727.4544091931052, 727.8034930568717, 584.780707234787, 591.5681552466723, 593.9346671866091, 605.3432026251567, 605.6154341992778, 9194.264458843276, 10392.272540922215, 10466.424346660855, 10726.410047447465, 11061.612843550598, 595.330253464852, 597.3697748874891, 600.9789657362059, 618.5144661440837, 630.0486265738767, 4304.246756817544, 4449.510553839075, 4462.0, 4470.754108523997, 4486.439195100613, 56815.71592142013, 57247.85504289891, 57615.711921440125, 58833.0, 62949.0, 48875.755621221666, 49610.75194624004, 50062.249066264034, 50290.49709502858, 51241.487585124414, 46386.76806615946, 47157.292640610416, 47625.76187119042, 48130.27804582934, 49191.26213106806, 9803.803923921625, 10291.53688084023, 10307.226957978331, 10467.842982355423, 10734.731631708957, 24649.260522184362, 25546.616800748376, 25580.616290755283, 25580.616290756025, 25798.226053217684, 43110.56889431191, 43399.78300108479, 47244.527554724016, 47670.52329476661, 47741.283880742514, 13054.608361749162, 14254.0, 14438.350274237475, 14617.707645846811, 14620.707585848437, 14326.426942922166, 14389.136651800925, 14699.55901322962, 14766.0, 15067.924660376628, 14089.365978530786, 14116.435342586181, 14119.364628591944, 14126.929365353108, 14502.492412765503, 13412.39644215993, 13569.253691047088, 13638.454461821417, 13739.313034348443, 13887.722245555235, 13578.86421135776, 13811.549787272192, 14042.508512202025, 14119.505817296345, 14271.357788899317, 9296.023917488566, 9384.530773461436, 9563.521823908637, 9728.902710973083, 9923.1069203772, 9724.95137524308, 9841.901580984098, 9955.651552195639, 10050.798984020132, 10340.0], "value": 6857.72823809533, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 111.0, 113.0, 112.0, 112.0, 112.0, 111.0, 113.0, 114.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 124.0, 170.0, 123.0, 127.0, 122.0, 123.0, 146.0, 126.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 164.0, 163.0, 166.0, 169.0, 172.0, 166.0, 166.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 106.0, 77.0, 75.0, 75.0, 75.0, 93.0, 76.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 105.0, 84.0, 84.0, 84.0, 97.0, 83.0, 84.0, 104.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 118.0, 115.0, 132.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 151.0, 152.0, 150.0, 150.0, 150.0, 150.0, 153.0, 151.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 100.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 55.0, 56.0, 58.0, 55.0, 56.0, 55.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 56.0, 57.0, 56.0, 57.0, 56.0, 57.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 83.0, 84.0, 91.0, 82.0, 84.0, 83.0, 82.0, 83.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 132.0, 139.0, 137.0, 137.0, 133.0, 139.0, 181.0, 135.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 194.0, 195.0, 201.0, 194.0, 193.0, 199.0, 205.0, 194.0, 195.0], "value": 196.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 78.0, 73.0, 75.0, 77.0, 72.0, 73.0, 73.0, 74.0], "value": 74.9, "unit": "score"}]}]} 06:16:54 INFO - Return code: 0 06:16:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:16:54 INFO - # TBPL SUCCESS # 06:16:54 INFO - Running post-action listener: _resource_record_post_action 06:16:54 INFO - [mozharness: 2017-05-18 13:16:54.775825Z] Finished run-tests step (success) 06:16:54 INFO - Running post-run listener: _resource_record_post_run 06:16:54 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 413933568; Read time: 8; Write time: 250180 06:16:54 INFO - TinderboxPrint: CPU usage
13.3% 06:16:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 06:16:54 INFO - TinderboxPrint: I/O write bytes / time
413,933,568 / 250,180 06:16:54 INFO - TinderboxPrint: CPU idle
8,297.4 (86.7%) 06:16:54 INFO - TinderboxPrint: CPU user
1,215.4 (12.7%) 06:16:54 INFO - TinderboxPrint: Swap in / out
0 / 0 06:16:54 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 97533952; Read time: 0; Write time: 82472 06:16:54 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 315871232; Read time: 0; Write time: 167708 06:16:55 INFO - Running post-run listener: _upload_blobber_files 06:16:55 INFO - Blob upload gear active. 06:16:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:16:55 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 06:16:55 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'] 06:16:55 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 06:16:55 INFO - (blobuploader) - INFO - Open directory for files ... 06:16:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:16:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:16:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:16:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:16:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:16:56 INFO - (blobuploader) - INFO - Done attempting. 06:16:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:16:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:16:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:16:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:16:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:16:58 INFO - (blobuploader) - INFO - Done attempting. 06:16:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:16:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:16:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:17:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:01 INFO - (blobuploader) - INFO - Done attempting. 06:17:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:17:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:17:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:02 INFO - (blobuploader) - INFO - Done attempting. 06:17:02 INFO - (blobuploader) - INFO - Iteration through files over. 06:17:02 INFO - Return code: 0 06:17:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:17:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:17:02 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cde4e94e59d00d30d4a0442e022c40c31a3d4a85da6fb477bc6c42bb47a85a27f8aa98b48d5fcededc7dec71e8f19747d4bd939a43f3772ef28a1b11c3ec711c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa54c0abd37f7c38f61712d17fad6667e78e13f1282bbd22e0a0da2969df4cfd138ab549c1701048c467f19805299fa11ee9cde845612fa30e84d4b3d06fe616", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c39aba7951573596136745973b54855e33a261d68edc12befe79c162d00ced7a17d1aa986c3a8b4c030a3df420ac5ddcbd50e4e6a8ffec0c6866e887ae7d6ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32a56f04af2e1965bf2e817426eb4f422f04c17930d62d3605919764db18020a33fd950579c1d64b9a45d773b27989b76d39d40424a0a93dc452070a4c52f777"} 06:17:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:17:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:17:02 INFO - Contents: 06:17:02 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cde4e94e59d00d30d4a0442e022c40c31a3d4a85da6fb477bc6c42bb47a85a27f8aa98b48d5fcededc7dec71e8f19747d4bd939a43f3772ef28a1b11c3ec711c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa54c0abd37f7c38f61712d17fad6667e78e13f1282bbd22e0a0da2969df4cfd138ab549c1701048c467f19805299fa11ee9cde845612fa30e84d4b3d06fe616", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c39aba7951573596136745973b54855e33a261d68edc12befe79c162d00ced7a17d1aa986c3a8b4c030a3df420ac5ddcbd50e4e6a8ffec0c6866e887ae7d6ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32a56f04af2e1965bf2e817426eb4f422f04c17930d62d3605919764db18020a33fd950579c1d64b9a45d773b27989b76d39d40424a0a93dc452070a4c52f777"} 06:17:02 INFO - Running post-run listener: copy_logs_to_upload_dir 06:17:02 INFO - Copying logs to upload dir... 06:17:02 INFO - mkdir: /builds/slave/test/build/upload/logs 06:17:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.861923 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-18 06:17:02.107921) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-18 06:17:02.115279) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520 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/cde4e94e59d00d30d4a0442e022c40c31a3d4a85da6fb477bc6c42bb47a85a27f8aa98b48d5fcededc7dec71e8f19747d4bd939a43f3772ef28a1b11c3ec711c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa54c0abd37f7c38f61712d17fad6667e78e13f1282bbd22e0a0da2969df4cfd138ab549c1701048c467f19805299fa11ee9cde845612fa30e84d4b3d06fe616", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c39aba7951573596136745973b54855e33a261d68edc12befe79c162d00ced7a17d1aa986c3a8b4c030a3df420ac5ddcbd50e4e6a8ffec0c6866e887ae7d6ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32a56f04af2e1965bf2e817426eb4f422f04c17930d62d3605919764db18020a33fd950579c1d64b9a45d773b27989b76d39d40424a0a93dc452070a4c52f777"} build_url:https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011211 build_url: 'https://queue.taskcluster.net/v1/task/KtwpRYHvSpO5mzdHiFjTsQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cde4e94e59d00d30d4a0442e022c40c31a3d4a85da6fb477bc6c42bb47a85a27f8aa98b48d5fcededc7dec71e8f19747d4bd939a43f3772ef28a1b11c3ec711c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa54c0abd37f7c38f61712d17fad6667e78e13f1282bbd22e0a0da2969df4cfd138ab549c1701048c467f19805299fa11ee9cde845612fa30e84d4b3d06fe616", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c39aba7951573596136745973b54855e33a261d68edc12befe79c162d00ced7a17d1aa986c3a8b4c030a3df420ac5ddcbd50e4e6a8ffec0c6866e887ae7d6ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32a56f04af2e1965bf2e817426eb4f422f04c17930d62d3605919764db18020a33fd950579c1d64b9a45d773b27989b76d39d40424a0a93dc452070a4c52f777"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-18 06:17:02.142085) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 06:17:02.142391) ========= 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=dbb0bb31bf4a4c7db9ba1648000001b6-1495108868.917201-1328088520 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 06:17:02.221539) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-18 06:17:02.221863) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-18 06:17:02.222150) ========= ========= Total master_lag: 0.21 =========