builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-006 starttime: 1495792721.43 results: success (0) revision: 44e41de60c48a94a004494dd48f57dd1d8c157d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 02:58:41.430469) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 02:58:41.430914) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 02:58:41.431227) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 02:58:41.450041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 02:58:41.450390) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-26 02:58:42-- 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% 225M=0s 2017-05-26 02:58:42 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127707 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 02:58:41.591295) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 02:58:41.591608) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019882 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 02:58:41.643848) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-26 02:58:41.647225) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 44e41de60c48a94a004494dd48f57dd1d8c157d8 --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 44e41de60c48a94a004494dd48f57dd1d8c157d8 --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=e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-26 02:58:42,554 truncating revision to first 12 chars 2017-05-26 02:58:42,554 Setting DEBUG logging. 2017-05-26 02:58:42,554 attempt 1/10 2017-05-26 02:58:42,554 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/44e41de60c48?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-26 02:58:43,958 unpacking tar archive at: mozilla-central-44e41de60c48/testing/mozharness/ program finished with exit code 0 elapsedTime=1.753373 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-26 02:58:43.412773) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 02:58:43.416118) ========= script_repo_revision: 44e41de60c48a94a004494dd48f57dd1d8c157d8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 02:58:43.416530) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 02:58:43.416791) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 02:58:43.426095) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2017-05-26 02:58:43.426402) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:58:44 INFO - MultiFileLogger online at 20170526 02:58:44 in /builds/slave/test 02:58:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:58:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:58:44 INFO - {'append_to_log': False, 02:58:44 INFO - 'base_work_dir': '/builds/slave/test', 02:58:44 INFO - 'blob_upload_branch': 'Firefox', 02:58:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:58:44 INFO - 'branch': 'Firefox', 02:58:44 INFO - 'buildbot_json_path': 'buildprops.json', 02:58:44 INFO - 'config_files': ('talos/linux_config.py',), 02:58:44 INFO - 'default_actions': ('clobber', 02:58:44 INFO - 'read-buildbot-config', 02:58:44 INFO - 'download-and-extract', 02:58:44 INFO - 'populate-webroot', 02:58:44 INFO - 'create-virtualenv', 02:58:44 INFO - 'install', 02:58:44 INFO - 'run-tests'), 02:58:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:58:44 INFO - 'download_minidump_stackwalk': True, 02:58:44 INFO - 'download_symbols': 'ondemand', 02:58:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:58:44 INFO - 'tooltool.py': '/tools/tooltool.py', 02:58:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:58:44 INFO - '/tools/misc-python/virtualenv.py')}, 02:58:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:58:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:58:44 INFO - 'gecko_profile': False, 02:58:44 INFO - 'gecko_profile_interval': 0, 02:58:44 INFO - 'installer_path': 'installer.exe', 02:58:44 INFO - 'log_level': 'info', 02:58:44 INFO - 'log_name': 'talos', 02:58:44 INFO - 'log_to_console': True, 02:58:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:58:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:58:44 INFO - 'opt_config_files': (), 02:58:44 INFO - 'pip_index': False, 02:58:44 INFO - 'suite': 'dromaeojs-e10s', 02:58:44 INFO - 'system_bits': '32', 02:58:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:58:44 INFO - 'title': 'talos-linux64-ix-006', 02:58:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:58:44 INFO - 'use_talos_json': True, 02:58:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:58:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:58:44 INFO - 'work_dir': 'build'} 02:58:44 INFO - [mozharness: 2017-05-26 09:58:44.438124Z] Running clobber step. 02:58:44 INFO - Running pre-action listener: _resource_record_pre_action 02:58:44 INFO - Running main action method: clobber 02:58:44 INFO - rmtree: /builds/slave/test/build 02:58:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:58:46 INFO - Running post-action listener: _resource_record_post_action 02:58:46 INFO - [mozharness: 2017-05-26 09:58:46.001974Z] Finished clobber step (success) 02:58:46 INFO - [mozharness: 2017-05-26 09:58:46.002074Z] Running read-buildbot-config step. 02:58:46 INFO - Running pre-action listener: _resource_record_pre_action 02:58:46 INFO - Running main action method: read_buildbot_config 02:58:46 INFO - Using buildbot properties: 02:58:46 INFO - { 02:58:46 INFO - "project": "", 02:58:46 INFO - "product": "firefox", 02:58:46 INFO - "who": "cbook@mozilla.com", 02:58:46 INFO - "installer_path": "public/build/target.tar.bz2", 02:58:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 02:58:46 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:58:46 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 02:58:46 INFO - "stage_platform": "linux64-stylo", 02:58:46 INFO - "basedir": "/builds/slave/test", 02:58:46 INFO - "buildnumber": 121, 02:58:46 INFO - "platform": "ubuntu64_hw_stylo", 02:58:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:58:46 INFO - "slavebuilddir": "test", 02:58:46 INFO - "taskId": "Hfg_BPNwTr6fikp9Ib9gmQ", 02:58:46 INFO - "branch": "mozilla-central", 02:58:46 INFO - "script_repo_revision": "production", 02:58:46 INFO - "revision": "44e41de60c48a94a004494dd48f57dd1d8c157d8", 02:58:46 INFO - "slavename": "talos-linux64-ix-006", 02:58:46 INFO - "repo_path": "mozilla-central" 02:58:46 INFO - } 02:58:46 INFO - Finding installer, test and symbols from parent task. 02:58:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hfg_BPNwTr6fikp9Ib9gmQ'}, attempt #1 02:58:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hfg_BPNwTr6fikp9Ib9gmQ'}, attempt #1 02:58:46 INFO - Task dependencies: NFuEOrIaQwe1ljVu4fod9g 02:58:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g'}, attempt #1 02:58:47 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.tar.bz2 02:58:47 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/test_packages.json 02:58:47 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.crashreporter-symbols.zip 02:58:47 INFO - Running post-action listener: _resource_record_post_action 02:58:47 INFO - [mozharness: 2017-05-26 09:58:47.409356Z] Finished read-buildbot-config step (success) 02:58:47 INFO - [mozharness: 2017-05-26 09:58:47.409614Z] Running download-and-extract step. 02:58:47 INFO - Running pre-action listener: _resource_record_pre_action 02:58:47 INFO - Running main action method: download_and_extract 02:58:47 INFO - mkdir: /builds/slave/test/build/tests 02:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:47 INFO - trying https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.test_packages.json 02:58:47 INFO - Downloading https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:58:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:58:47 INFO - Downloaded 986 bytes. 02:58:47 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:58:47 INFO - Using the following test package requirements: 02:58:47 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:58:47 INFO - u'common': [u'target.common.tests.zip'], 02:58:47 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:58:47 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:58:47 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:58:47 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:58:47 INFO - u'mozbase': [u'target.common.tests.zip'], 02:58:47 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:58:47 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:58:47 INFO - u'web-platform': [u'target.common.tests.zip', 02:58:47 INFO - u'target.web-platform.tests.zip'], 02:58:47 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:58:47 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:58:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.common.tests.zip 02:58:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:58:47 INFO - Fetch https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.common.tests.zip into memory 02:58:49 INFO - Content-Length response header: 63525232 02:58:49 INFO - Bytes received: 63525232 02:59:00 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:59:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.common.tests.zip 02:59:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:59:00 INFO - Fetch https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.common.tests.zip into memory 02:59:01 INFO - Content-Length response header: 63525232 02:59:01 INFO - Bytes received: 63525232 02:59:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.talos.tests.zip 02:59:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:59:13 INFO - Fetch https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.talos.tests.zip into memory 02:59:14 INFO - Content-Length response header: 14411888 02:59:14 INFO - Bytes received: 14411888 02:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:14 INFO - trying https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.tar.bz2 02:59:14 INFO - Downloading https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:59:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:59:15 INFO - Downloaded 55769297 bytes. 02:59:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.tar.bz2 02:59:15 INFO - mkdir: /builds/slave/test/properties 02:59:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:59:15 INFO - Writing to file /builds/slave/test/properties/build_url 02:59:15 INFO - Contents: 02:59:15 INFO - build_url:https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.tar.bz2 02:59:15 INFO - Running post-action listener: _resource_record_post_action 02:59:15 INFO - Running post-action listener: set_extra_try_arguments 02:59:15 INFO - [mozharness: 2017-05-26 09:59:15.527599Z] Finished download-and-extract step (success) 02:59:15 INFO - [mozharness: 2017-05-26 09:59:15.527698Z] Running populate-webroot step. 02:59:15 INFO - Running pre-action listener: _resource_record_pre_action 02:59:15 INFO - Running main action method: populate_webroot 02:59:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:59:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:59:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:59:15 INFO - '--tppagecycles', 02:59:15 INFO - '7'], 02:59:15 INFO - 'tests': ['tsvgm']}}, 02:59:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:59:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:59:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:59:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:59:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:59:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:59:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:59:15 INFO - 'talos_options': ['--disable-e10s'], 02:59:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:59:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:59:15 INFO - 'talos_options': ['--disable-e10s'], 02:59:15 INFO - 'tests': ['damp', 'tps']}, 02:59:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:59:15 INFO - 'tests': ['damp', 'tps']}, 02:59:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:59:15 INFO - 'tests': ['dromaeo_dom']}, 02:59:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:59:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:59:15 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:59:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:59:15 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:59:15 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:59:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:59:15 INFO - 'tests': ['a11yr', 02:59:15 INFO - 'ts_paint', 02:59:15 INFO - 'tpaint', 02:59:15 INFO - 'sessionrestore', 02:59:15 INFO - 'sessionrestore_no_auto_restore', 02:59:15 INFO - 'tabpaint']}, 02:59:15 INFO - 'other-e10s': {'tests': ['a11yr', 02:59:15 INFO - 'ts_paint', 02:59:15 INFO - 'tpaint', 02:59:15 INFO - 'sessionrestore', 02:59:15 INFO - 'sessionrestore_no_auto_restore', 02:59:15 INFO - 'tabpaint']}, 02:59:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:59:15 INFO - 'ts_paint', 02:59:15 INFO - 'tpaint', 02:59:15 INFO - 'sessionrestore', 02:59:15 INFO - 'sessionrestore_no_auto_restore', 02:59:15 INFO - 'tabpaint']}, 02:59:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:59:15 INFO - 'ts_paint', 02:59:15 INFO - 'tpaint', 02:59:15 INFO - 'sessionrestore', 02:59:15 INFO - 'sessionrestore_no_auto_restore', 02:59:15 INFO - 'tabpaint']}, 02:59:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:59:15 INFO - 'tests': ['a11yr', 02:59:15 INFO - 'ts_paint', 02:59:15 INFO - 'tpaint', 02:59:15 INFO - 'sessionrestore', 02:59:15 INFO - 'sessionrestore_no_auto_restore', 02:59:15 INFO - 'tabpaint']}, 02:59:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:59:15 INFO - 'tests': ['a11yr', 02:59:15 INFO - 'ts_paint', 02:59:15 INFO - 'tpaint', 02:59:15 INFO - 'sessionrestore', 02:59:15 INFO - 'sessionrestore_no_auto_restore', 02:59:15 INFO - 'tabpaint']}, 02:59:15 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:59:15 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:59:15 INFO - 'bloom_basic_ref']}, 02:59:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:59:15 INFO - 'tests': ['tsvgx', 02:59:15 INFO - 'tsvgr_opacity', 02:59:15 INFO - 'tart', 02:59:15 INFO - 'tscrollx', 02:59:15 INFO - 'cart', 02:59:15 INFO - 'tsvg_static']}, 02:59:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:59:15 INFO - 'tsvgr_opacity', 02:59:15 INFO - 'tart', 02:59:15 INFO - 'tscrollx', 02:59:15 INFO - 'cart', 02:59:15 INFO - 'tsvg_static']}, 02:59:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:59:15 INFO - 'talos_options': ['--disable-e10s'], 02:59:15 INFO - 'tests': ['tp5o']}, 02:59:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:59:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:59:15 INFO - 'talos_options': ['--disable-e10s', 02:59:15 INFO - '--xperf_path', 02:59:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:15 INFO - 'tests': ['tp5n']}, 02:59:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:59:15 INFO - 'talos_options': ['--xperf_path', 02:59:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:15 INFO - 'tests': ['tp5n']}}, 02:59:15 INFO - 'talos.zip': {'path': '', 02:59:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:59:15 INFO - Running post-action listener: _resource_record_post_action 02:59:15 INFO - [mozharness: 2017-05-26 09:59:15.541892Z] Finished populate-webroot step (success) 02:59:15 INFO - [mozharness: 2017-05-26 09:59:15.541980Z] Running create-virtualenv step. 02:59:15 INFO - Running pre-action listener: _resource_record_pre_action 02:59:15 INFO - Running main action method: create_virtualenv 02:59:15 INFO - Creating virtualenv /builds/slave/test/build/venv 02:59:15 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 02:59:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:59:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:59:15 INFO - Using real prefix '/usr' 02:59:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:59:16 INFO - Installing distribute.............................................................................................................................................................................................done. 02:59:18 INFO - Installing pip.................done. 02:59:18 INFO - Return code: 0 02:59:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:59:18 INFO - Reading from file tmpfile_stdout 02:59:18 INFO - Output received: 02:59:18 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) 02:59:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf197a0>, '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 0xf1a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ab30>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', '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 02:59:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:59:18 INFO - Using env: {'DISPLAY': ':0', 02:59:18 INFO - 'HOME': '/home/cltbld', 02:59:18 INFO - 'LANG': 'en_US.UTF-8', 02:59:18 INFO - 'LANGUAGE': 'en_US:en', 02:59:18 INFO - 'LOGNAME': 'cltbld', 02:59:18 INFO - 'MAIL': '/var/mail/cltbld', 02:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:18 INFO - 'MOZ_NO_REMOTE': '1', 02:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:18 INFO - 'NO_EM_RESTART': '1', 02:59:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:18 INFO - 'PWD': '/builds/slave/test', 02:59:18 INFO - 'SHELL': '/bin/bash', 02:59:18 INFO - 'SHLVL': '1', 02:59:18 INFO - 'TERM': 'linux', 02:59:18 INFO - 'TMOUT': '86400', 02:59:18 INFO - 'USER': 'cltbld', 02:59:18 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', 02:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:18 INFO - '_': '/tools/buildbot/bin/python'} 02:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:18 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 02:59:18 INFO - Cleaning up... 02:59:18 INFO - Return code: 0 02:59:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf197a0>, '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 0xf1a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ab30>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', '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 02:59:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:59:18 INFO - Using env: {'DISPLAY': ':0', 02:59:18 INFO - 'HOME': '/home/cltbld', 02:59:18 INFO - 'LANG': 'en_US.UTF-8', 02:59:18 INFO - 'LANGUAGE': 'en_US:en', 02:59:18 INFO - 'LOGNAME': 'cltbld', 02:59:18 INFO - 'MAIL': '/var/mail/cltbld', 02:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:18 INFO - 'MOZ_NO_REMOTE': '1', 02:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:18 INFO - 'NO_EM_RESTART': '1', 02:59:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:18 INFO - 'PWD': '/builds/slave/test', 02:59:18 INFO - 'SHELL': '/bin/bash', 02:59:18 INFO - 'SHLVL': '1', 02:59:18 INFO - 'TERM': 'linux', 02:59:18 INFO - 'TMOUT': '86400', 02:59:18 INFO - 'USER': 'cltbld', 02:59:18 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', 02:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:18 INFO - '_': '/tools/buildbot/bin/python'} 02:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:18 INFO - Downloading/unpacking psutil>=3.1.1 02:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:59:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:19 INFO - Installing collected packages: psutil 02:59:19 INFO - Running setup.py install for psutil 02:59:20 INFO - building 'psutil._psutil_linux' extension 02:59:20 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 02:59:20 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 02:59:20 INFO - building 'psutil._psutil_posix' extension 02:59:20 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 02:59:20 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 02:59:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:20 INFO - Successfully installed psutil 02:59:20 INFO - Cleaning up... 02:59:20 INFO - Return code: 0 02:59:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:59:20 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')]} 02:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:20 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')]} 02:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:20 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 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf197a0>, '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 0xf1a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ab30>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', '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 02:59:20 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 02:59:20 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 02:59:20 INFO - Using env: {'DISPLAY': ':0', 02:59:20 INFO - 'HOME': '/home/cltbld', 02:59:20 INFO - 'LANG': 'en_US.UTF-8', 02:59:20 INFO - 'LANGUAGE': 'en_US:en', 02:59:20 INFO - 'LOGNAME': 'cltbld', 02:59:20 INFO - 'MAIL': '/var/mail/cltbld', 02:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:20 INFO - 'MOZ_NO_REMOTE': '1', 02:59:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:20 INFO - 'NO_EM_RESTART': '1', 02:59:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:20 INFO - 'PWD': '/builds/slave/test', 02:59:20 INFO - 'SHELL': '/bin/bash', 02:59:20 INFO - 'SHLVL': '1', 02:59:20 INFO - 'TERM': 'linux', 02:59:20 INFO - 'TMOUT': '86400', 02:59:20 INFO - 'USER': 'cltbld', 02:59:20 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', 02:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:20 INFO - '_': '/tools/buildbot/bin/python'} 02:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:59:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:59:21 INFO - Installing collected packages: mozsystemmonitor 02:59:21 INFO - Running setup.py install for mozsystemmonitor 02:59:21 INFO - Successfully installed mozsystemmonitor 02:59:21 INFO - Cleaning up... 02:59:21 INFO - Return code: 0 02:59:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:59:21 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')]} 02:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:21 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')]} 02:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:21 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 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf197a0>, '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 0xf1a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ab30>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', '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 02:59:21 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 02:59:21 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 02:59:21 INFO - Using env: {'DISPLAY': ':0', 02:59:21 INFO - 'HOME': '/home/cltbld', 02:59:21 INFO - 'LANG': 'en_US.UTF-8', 02:59:21 INFO - 'LANGUAGE': 'en_US:en', 02:59:21 INFO - 'LOGNAME': 'cltbld', 02:59:21 INFO - 'MAIL': '/var/mail/cltbld', 02:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:21 INFO - 'MOZ_NO_REMOTE': '1', 02:59:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:21 INFO - 'NO_EM_RESTART': '1', 02:59:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:21 INFO - 'PWD': '/builds/slave/test', 02:59:21 INFO - 'SHELL': '/bin/bash', 02:59:21 INFO - 'SHLVL': '1', 02:59:21 INFO - 'TERM': 'linux', 02:59:21 INFO - 'TMOUT': '86400', 02:59:21 INFO - 'USER': 'cltbld', 02:59:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', 02:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:21 INFO - '_': '/tools/buildbot/bin/python'} 02:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:22 INFO - Downloading/unpacking jsonschema==2.5.1 02:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:59:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:59:23 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 02:59:23 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 02:59:23 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 02:59:23 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 02:59:23 INFO - Downloading functools32-3.2.3-2.tar.gz 02:59:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:59:23 INFO - warning: no files found matching '*.txt' 02:59:23 INFO - no previously-included directories found matching 'build' 02:59:23 INFO - no previously-included directories found matching 'dist' 02:59:23 INFO - no previously-included directories found matching '.git*' 02:59:23 INFO - Installing collected packages: jsonschema, functools32 02:59:23 INFO - Running setup.py install for functools32 02:59:23 INFO - warning: no files found matching '*.txt' 02:59:23 INFO - no previously-included directories found matching 'build' 02:59:23 INFO - no previously-included directories found matching 'dist' 02:59:23 INFO - no previously-included directories found matching '.git*' 02:59:23 INFO - Successfully installed jsonschema functools32 02:59:23 INFO - Cleaning up... 02:59:23 INFO - Return code: 0 02:59:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:59:23 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')]} 02:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:23 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')]} 02:59:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:23 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 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf197a0>, '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 0xf1a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ab30>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', '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 02:59:23 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 02:59:23 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 02:59:23 INFO - Using env: {'DISPLAY': ':0', 02:59:23 INFO - 'HOME': '/home/cltbld', 02:59:23 INFO - 'LANG': 'en_US.UTF-8', 02:59:23 INFO - 'LANGUAGE': 'en_US:en', 02:59:23 INFO - 'LOGNAME': 'cltbld', 02:59:23 INFO - 'MAIL': '/var/mail/cltbld', 02:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:23 INFO - 'MOZ_NO_REMOTE': '1', 02:59:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:23 INFO - 'NO_EM_RESTART': '1', 02:59:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:23 INFO - 'PWD': '/builds/slave/test', 02:59:23 INFO - 'SHELL': '/bin/bash', 02:59:23 INFO - 'SHLVL': '1', 02:59:23 INFO - 'TERM': 'linux', 02:59:23 INFO - 'TMOUT': '86400', 02:59:23 INFO - 'USER': 'cltbld', 02:59:23 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', 02:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:23 INFO - '_': '/tools/buildbot/bin/python'} 02:59:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:59:23 INFO - Cleaning up... 02:59:23 INFO - Return code: 0 02:59:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:59:23 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')]} 02:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:23 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')]} 02:59:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:23 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 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf197a0>, '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 0xf1a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ab30>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', '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 02:59:23 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 02:59:23 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 02:59:23 INFO - Using env: {'DISPLAY': ':0', 02:59:23 INFO - 'HOME': '/home/cltbld', 02:59:23 INFO - 'LANG': 'en_US.UTF-8', 02:59:23 INFO - 'LANGUAGE': 'en_US:en', 02:59:23 INFO - 'LOGNAME': 'cltbld', 02:59:23 INFO - 'MAIL': '/var/mail/cltbld', 02:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:23 INFO - 'MOZ_NO_REMOTE': '1', 02:59:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:23 INFO - 'NO_EM_RESTART': '1', 02:59:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:23 INFO - 'PWD': '/builds/slave/test', 02:59:23 INFO - 'SHELL': '/bin/bash', 02:59:23 INFO - 'SHLVL': '1', 02:59:23 INFO - 'TERM': 'linux', 02:59:23 INFO - 'TMOUT': '86400', 02:59:23 INFO - 'USER': 'cltbld', 02:59:23 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', 02:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:23 INFO - '_': '/tools/buildbot/bin/python'} 02:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:24 INFO - Downloading/unpacking blobuploader==1.2.4 02:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:25 INFO - Downloading blobuploader-1.2.4.tar.gz 02:59:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:59:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:59:25 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 02:59:25 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 02:59:25 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 02:59:25 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 02:59:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:59:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:59:25 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 02:59:25 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 02:59:25 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 02:59:25 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 02:59:25 INFO - Downloading docopt-0.6.1.tar.gz 02:59:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:59:25 INFO - Installing collected packages: blobuploader, requests, docopt 02:59:25 INFO - Running setup.py install for blobuploader 02:59:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:59:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:59:25 INFO - Running setup.py install for requests 02:59:26 INFO - Running setup.py install for docopt 02:59:26 INFO - Successfully installed blobuploader requests docopt 02:59:26 INFO - Cleaning up... 02:59:26 INFO - Return code: 0 02:59:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:26 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 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf197a0>, '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 0xf1a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ab30>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', '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 02:59:26 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 02:59:26 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 02:59:26 INFO - Using env: {'DISPLAY': ':0', 02:59:26 INFO - 'HOME': '/home/cltbld', 02:59:26 INFO - 'LANG': 'en_US.UTF-8', 02:59:26 INFO - 'LANGUAGE': 'en_US:en', 02:59:26 INFO - 'LOGNAME': 'cltbld', 02:59:26 INFO - 'MAIL': '/var/mail/cltbld', 02:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:26 INFO - 'MOZ_NO_REMOTE': '1', 02:59:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:26 INFO - 'NO_EM_RESTART': '1', 02:59:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:26 INFO - 'PWD': '/builds/slave/test', 02:59:26 INFO - 'SHELL': '/bin/bash', 02:59:26 INFO - 'SHLVL': '1', 02:59:26 INFO - 'TERM': 'linux', 02:59:26 INFO - 'TMOUT': '86400', 02:59:26 INFO - 'USER': 'cltbld', 02:59:26 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', 02:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:26 INFO - '_': '/tools/buildbot/bin/python'} 02:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:59:26 INFO - Running setup.py (path:/tmp/pip-TYi5FG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:59:26 INFO - Running setup.py (path:/tmp/pip-WfOcDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:59:26 INFO - Running setup.py (path:/tmp/pip-a2yZpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:59:26 INFO - Running setup.py (path:/tmp/pip-tdfpTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:59:26 INFO - Running setup.py (path:/tmp/pip-DcEFNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:59:26 INFO - Running setup.py (path:/tmp/pip-9bDe3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:59:27 INFO - Running setup.py (path:/tmp/pip-aaKzyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:59:27 INFO - Running setup.py (path:/tmp/pip-zgBXUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:59:27 INFO - Running setup.py (path:/tmp/pip-W9Kqa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:59:27 INFO - Running setup.py (path:/tmp/pip-zQUnXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:59:27 INFO - Running setup.py (path:/tmp/pip-an_zsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:59:27 INFO - Running setup.py (path:/tmp/pip-g3LznE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:59:27 INFO - Running setup.py (path:/tmp/pip-9U2DiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:59:27 INFO - Running setup.py (path:/tmp/pip-O95JUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:27 INFO - Running setup.py (path:/tmp/pip-9dkgo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:59:27 INFO - Running setup.py (path:/tmp/pip-ednSwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:59:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:59:27 INFO - Running setup.py (path:/tmp/pip-RMBbWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:59:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:59:27 INFO - Running setup.py install for manifestparser 02:59:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:59:27 INFO - Running setup.py install for mozcrash 02:59:28 INFO - Running setup.py install for mozdebug 02:59:28 INFO - Running setup.py install for mozdevice 02:59:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:59:28 INFO - Running setup.py install for mozfile 02:59:28 INFO - Running setup.py install for mozhttpd 02:59:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:59:28 INFO - Running setup.py install for mozinfo 02:59:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:59:28 INFO - Running setup.py install for mozInstall 02:59:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:59:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:59:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:59:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:59:28 INFO - Running setup.py install for mozleak 02:59:28 INFO - Running setup.py install for mozlog 02:59:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:59:28 INFO - Running setup.py install for moznetwork 02:59:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:59:28 INFO - Running setup.py install for mozprocess 02:59:29 INFO - Running setup.py install for mozprofile 02:59:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:59:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:59:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:59:29 INFO - Running setup.py install for mozrunner 02:59:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:59:29 INFO - Running setup.py install for mozscreenshot 02:59:29 INFO - Running setup.py install for moztest 02:59:29 INFO - Running setup.py install for mozversion 02:59:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:59:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:59:29 INFO - Cleaning up... 02:59:29 INFO - Return code: 0 02:59:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:29 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 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf197a0>, '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 0xf1a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ab30>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', '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 02:59:29 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 02:59:29 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 02:59:29 INFO - Using env: {'DISPLAY': ':0', 02:59:29 INFO - 'HOME': '/home/cltbld', 02:59:29 INFO - 'LANG': 'en_US.UTF-8', 02:59:29 INFO - 'LANGUAGE': 'en_US:en', 02:59:29 INFO - 'LOGNAME': 'cltbld', 02:59:29 INFO - 'MAIL': '/var/mail/cltbld', 02:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:29 INFO - 'MOZ_NO_REMOTE': '1', 02:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:29 INFO - 'NO_EM_RESTART': '1', 02:59:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:29 INFO - 'PWD': '/builds/slave/test', 02:59:29 INFO - 'SHELL': '/bin/bash', 02:59:29 INFO - 'SHLVL': '1', 02:59:29 INFO - 'TERM': 'linux', 02:59:29 INFO - 'TMOUT': '86400', 02:59:29 INFO - 'USER': 'cltbld', 02:59:29 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', 02:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:29 INFO - '_': '/tools/buildbot/bin/python'} 02:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:59:29 INFO - Running setup.py (path:/tmp/pip-zSYnx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:59:29 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)) 02:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:59:29 INFO - Running setup.py (path:/tmp/pip-HQCs80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:59:29 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)) 02:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:59:29 INFO - Running setup.py (path:/tmp/pip-MkdRAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:59:30 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)) 02:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:59:30 INFO - Running setup.py (path:/tmp/pip-GHu9s5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:59:30 INFO - Running setup.py (path:/tmp/pip-d8w1jZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:59:30 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)) 02:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:59:30 INFO - Running setup.py (path:/tmp/pip-JiGzQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:59:30 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)) 02:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:59:30 INFO - Running setup.py (path:/tmp/pip-EcseO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:59:30 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)) 02:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:59:30 INFO - Running setup.py (path:/tmp/pip-RLMFjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:59:30 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)) 02:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:59:30 INFO - Running setup.py (path:/tmp/pip-olLZXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:59:30 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)) 02:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:59:30 INFO - Running setup.py (path:/tmp/pip-TrTN7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:59:30 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)) 02:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:59:30 INFO - Running setup.py (path:/tmp/pip-wa_goa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:59:30 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)) 02:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:59:30 INFO - Running setup.py (path:/tmp/pip-4b8a1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:59:30 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)) 02:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:59:30 INFO - Running setup.py (path:/tmp/pip-mJII6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:59:30 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)) 02:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:59:30 INFO - Running setup.py (path:/tmp/pip-9MF9ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:59:30 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)) 02:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:30 INFO - Running setup.py (path:/tmp/pip-mJRwwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:31 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)) 02:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:59:31 INFO - Running setup.py (path:/tmp/pip-6zBQTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:59:31 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)) 02:59:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:59:31 INFO - Running setup.py (path:/tmp/pip-zAdFaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:59:31 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)) 02:59:31 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)) 02:59:31 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)) 02:59:31 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)) 02:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:59:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:59:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:59:31 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 02:59:31 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 02:59:31 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 02:59:31 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 02:59:32 INFO - Downloading blessings-1.6.tar.gz 02:59:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:59:32 INFO - Installing collected packages: blessings 02:59:32 INFO - Running setup.py install for blessings 02:59:32 INFO - Successfully installed blessings 02:59:32 INFO - Cleaning up... 02:59:32 INFO - Return code: 0 02:59:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:59:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:59:32 INFO - Reading from file tmpfile_stdout 02:59:32 INFO - Current package versions: 02:59:32 INFO - argparse == 1.2.1 02:59:32 INFO - blessings == 1.6 02:59:32 INFO - blobuploader == 1.2.4 02:59:32 INFO - docopt == 0.6.1 02:59:32 INFO - functools32 == 3.2.3-2 02:59:32 INFO - jsonschema == 2.5.1 02:59:32 INFO - manifestparser == 1.1 02:59:32 INFO - mozInstall == 1.12 02:59:32 INFO - mozcrash == 1.0 02:59:32 INFO - mozdebug == 0.1 02:59:32 INFO - mozdevice == 0.51 02:59:32 INFO - mozfile == 1.2 02:59:32 INFO - mozhttpd == 0.7 02:59:32 INFO - mozinfo == 0.9 02:59:32 INFO - mozleak == 0.1 02:59:32 INFO - mozlog == 3.4 02:59:32 INFO - moznetwork == 0.27 02:59:32 INFO - mozprocess == 0.25 02:59:32 INFO - mozprofile == 0.28 02:59:32 INFO - mozrunner == 6.13 02:59:32 INFO - mozscreenshot == 0.1 02:59:32 INFO - mozsystemmonitor == 0.3 02:59:32 INFO - moztest == 0.8 02:59:32 INFO - mozversion == 1.4 02:59:32 INFO - psutil == 3.1.1 02:59:32 INFO - requests == 1.2.3 02:59:32 INFO - wsgiref == 0.1.2 02:59:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:32 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 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf197a0>, '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 0xf1a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ab30>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', '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 02:59:32 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 02:59:32 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 02:59:32 INFO - Using env: {'DISPLAY': ':0', 02:59:32 INFO - 'HOME': '/home/cltbld', 02:59:32 INFO - 'LANG': 'en_US.UTF-8', 02:59:32 INFO - 'LANGUAGE': 'en_US:en', 02:59:32 INFO - 'LOGNAME': 'cltbld', 02:59:32 INFO - 'MAIL': '/var/mail/cltbld', 02:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:32 INFO - 'MOZ_NO_REMOTE': '1', 02:59:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:32 INFO - 'NO_EM_RESTART': '1', 02:59:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:32 INFO - 'PWD': '/builds/slave/test', 02:59:32 INFO - 'SHELL': '/bin/bash', 02:59:32 INFO - 'SHLVL': '1', 02:59:32 INFO - 'TERM': 'linux', 02:59:32 INFO - 'TMOUT': '86400', 02:59:32 INFO - 'USER': 'cltbld', 02:59:32 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', 02:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:32 INFO - '_': '/tools/buildbot/bin/python'} 02:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:32 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)) 02:59:32 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)) 02:59:32 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)) 02:59:32 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)) 02:59:32 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)) 02:59:32 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)) 02:59:32 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)) 02:59:32 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)) 02:59:32 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)) 02:59:32 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:59:32 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 02:59:32 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 02:59:32 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 02:59:32 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 02:59:33 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:59:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:59:34 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)) 02:59:34 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)) 02:59:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:59:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:59:34 INFO - Installing collected packages: marionette-driver 02:59:34 INFO - Running setup.py install for marionette-driver 02:59:34 INFO - Successfully installed marionette-driver 02:59:34 INFO - Cleaning up... 02:59:34 INFO - Return code: 0 02:59:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:34 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 0xba91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1c5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf197a0>, '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 0xf1a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ab30>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', '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 02:59:34 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 02:59:34 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 02:59:34 INFO - Using env: {'DISPLAY': ':0', 02:59:34 INFO - 'HOME': '/home/cltbld', 02:59:34 INFO - 'LANG': 'en_US.UTF-8', 02:59:34 INFO - 'LANGUAGE': 'en_US:en', 02:59:34 INFO - 'LOGNAME': 'cltbld', 02:59:34 INFO - 'MAIL': '/var/mail/cltbld', 02:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:34 INFO - 'MOZ_NO_REMOTE': '1', 02:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:34 INFO - 'NO_EM_RESTART': '1', 02:59:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:34 INFO - 'PWD': '/builds/slave/test', 02:59:34 INFO - 'SHELL': '/bin/bash', 02:59:34 INFO - 'SHLVL': '1', 02:59:34 INFO - 'TERM': 'linux', 02:59:34 INFO - 'TMOUT': '86400', 02:59:34 INFO - 'USER': 'cltbld', 02:59:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', 02:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:34 INFO - '_': '/tools/buildbot/bin/python'} 02:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:59:34 INFO - Cleaning up... 02:59:34 INFO - Return code: 0 02:59:34 INFO - Running post-action listener: _resource_record_post_action 02:59:34 INFO - Running post-action listener: _start_resource_monitoring 02:59:34 INFO - Starting resource monitoring. 02:59:34 INFO - [mozharness: 2017-05-26 09:59:34.493779Z] Finished create-virtualenv step (success) 02:59:34 INFO - [mozharness: 2017-05-26 09:59:34.494239Z] Running install step. 02:59:34 INFO - Running pre-action listener: _resource_record_pre_action 02:59:34 INFO - Running main action method: install 02:59:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:59:34 INFO - Reading from file tmpfile_stdout 02:59:34 INFO - Detecting whether we're running mozinstall >=1.0... 02:59:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:59:34 INFO - Reading from file tmpfile_stdout 02:59:34 INFO - Output received: 02:59:34 INFO - Usage: mozinstall [options] installer 02:59:34 INFO - Options: 02:59:34 INFO - -h, --help show this help message and exit 02:59:34 INFO - -d DEST, --destination=DEST 02:59:34 INFO - Directory to install application into. [default: 02:59:34 INFO - "/builds/slave/test"] 02:59:34 INFO - --app=APP Application being installed. [default: firefox] 02:59:34 INFO - mkdir: /builds/slave/test/build/application 02:59:34 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'] 02:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:59:50 INFO - Reading from file tmpfile_stdout 02:59:50 INFO - Output received: 02:59:50 INFO - /builds/slave/test/build/application/firefox/firefox 02:59:50 INFO - Running post-action listener: _resource_record_post_action 02:59:50 INFO - [mozharness: 2017-05-26 09:59:50.805937Z] Finished install step (success) 02:59:50 INFO - [mozharness: 2017-05-26 09:59:50.806215Z] Running run-tests step. 02:59:50 INFO - Running pre-action listener: _resource_record_pre_action 02:59:50 INFO - Running main action method: run_tests 02:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:59:50 INFO - Python 2.7.3 02:59:50 INFO - Return code: 0 02:59:50 INFO - grabbing minidump binary from tooltool 02:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:50 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 0xf197a0>, '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 0xf1a6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf1ab30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:59:50 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 02:59:50 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 02:59:50 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 02:59:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:59:50 INFO - Return code: 0 02:59:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:59:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:59:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:59:50 INFO - ENV: RUST_BACKTRACE is now 1 02:59:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:59:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:59:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 02:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 02:59:50 INFO - Using env: {'DISPLAY': ':0', 02:59:50 INFO - 'HOME': '/home/cltbld', 02:59:50 INFO - 'LANG': 'en_US.UTF-8', 02:59:50 INFO - 'LANGUAGE': 'en_US:en', 02:59:50 INFO - 'LOGNAME': 'cltbld', 02:59:50 INFO - 'MAIL': '/var/mail/cltbld', 02:59:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:59:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:50 INFO - 'MOZ_NO_REMOTE': '1', 02:59:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:50 INFO - 'NO_EM_RESTART': '1', 02:59:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:50 INFO - 'PWD': '/builds/slave/test', 02:59:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:59:50 INFO - 'RUST_BACKTRACE': '1', 02:59:50 INFO - 'SHELL': '/bin/bash', 02:59:50 INFO - 'SHLVL': '1', 02:59:50 INFO - 'TERM': 'linux', 02:59:50 INFO - 'TMOUT': '86400', 02:59:50 INFO - 'USER': 'cltbld', 02:59:50 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719', 02:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:50 INFO - '_': '/tools/buildbot/bin/python'} 02:59:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 02:59:51 INFO - mozversion application_buildid: 20170526091018 02:59:51 INFO - mozversion application_changeset: 44e41de60c48a94a004494dd48f57dd1d8c157d8 02:59:51 INFO - mozversion application_display_name: Nightly 02:59:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:59:51 INFO - mozversion application_name: Firefox 02:59:51 INFO - mozversion application_remotingname: firefox 02:59:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:59:51 INFO - mozversion application_vendor: Mozilla 02:59:51 INFO - mozversion application_version: 55.0a1 02:59:51 INFO - mozversion platform_buildid: 20170526091018 02:59:51 INFO - mozversion platform_changeset: 44e41de60c48a94a004494dd48f57dd1d8c157d8 02:59:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:59:51 INFO - mozversion platform_version: 55.0a1 02:59:51 INFO - using testdate: 1495792791 02:59:51 INFO - actual date: 1495792791 02:59:51 INFO - starting webserver on 'localhost:47193' 02:59:51 INFO - SUITE-START | Running 2 tests 02:59:51 INFO - TEST-START | dromaeo_css 02:59:51 INFO - operating with platform_type : linux_ 02:59:51 INFO - Initialising browser for dromaeo_css test... 02:59:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47193/getInfo.html -profile /tmp/tmp52QybQ/profile 02:59:51 INFO - TEST-INFO | started process 15170 (/builds/slave/test/build/application/firefox/firefox http://localhost:47193/getInfo.html) 03:00:25 INFO - TEST-INFO | 15170: killed by SIGTERM 03:00:26 INFO - Browser initialized. 03:00:26 INFO - Running cycle 1/1 for dromaeo_css test... 03:00:26 INFO - TEST-INFO | started process 15391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp52QybQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:00:38 INFO - PID 15391 | RSS: Main: 172171264 03:00:38 INFO - PID 15391 | 03:03:43 INFO - PID 15391 | Cycle 1(1): loaded http://localhost:47193/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47193/tests/dromaeo/cssquery-ext.html) 03:03:44 INFO - PID 15391 | RSS: Main: 172122112 03:03:44 INFO - PID 15391 | 03:06:46 INFO - PID 15391 | Cycle 1(1): loaded http://localhost:47193/tests/dromaeo/cssquery-ext.html (next: http://localhost:47193/tests/dromaeo/cssquery-jquery.html) 03:06:47 INFO - PID 15391 | RSS: Main: 176005120 03:06:47 INFO - PID 15391 | 03:09:49 INFO - PID 15391 | Cycle 1(1): loaded http://localhost:47193/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47193/tests/dromaeo/cssquery-mootools.html) 03:09:49 INFO - PID 15391 | RSS: Main: 174006272 03:09:49 INFO - PID 15391 | 03:12:51 INFO - PID 15391 | Cycle 1(1): loaded http://localhost:47193/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47193/tests/dromaeo/cssquery-prototype.html) 03:12:52 INFO - PID 15391 | RSS: Main: 178638848 03:12:52 INFO - PID 15391 | 03:15:55 INFO - PID 15391 | Cycle 1(1): loaded http://localhost:47193/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47193/tests/dromaeo/cssquery-yui.html) 03:15:55 INFO - PID 15391 | RSS: Main: 177840128 03:15:55 INFO - PID 15391 | 03:18:57 INFO - PID 15391 | Cycle 1(1): loaded http://localhost:47193/tests/dromaeo/cssquery-yui.html (next: http://localhost:47193/tests/dromaeo/cssquery-dojo.html) 03:18:57 INFO - PID 15391 | RSS: Main: 175448064 03:18:57 INFO - PID 15391 | 03:18:57 INFO - PID 15391 | __start_tp_report 03:18:57 INFO - PID 15391 | _x_x_mozilla_page_load 03:18:57 INFO - PID 15391 | _x_x_mozilla_page_load_details 03:18:57 INFO - PID 15391 | |i|pagename|runs| 03:18:57 INFO - PID 15391 | |0;dojo.html;2745.656792900887;2755.0357374918794;2766.3360793409574;2770.2381844992624;2782.7773778097753;5293.52358287754;5361.437049109846;5387.89224215516;5397.51422371987;5414.675119492833;5301.072312345344;5308.840734777963;5315.946840531594;5357.7589008494615;5397.325334333208;4725.503822098664;4747.76261186941;4775.617950563956;4782.78477468513;4816.686915350509;4755.405574303212;4802.567768900798;4824.252240902648;4841.854744357657;4847.73337466441;4667.696599721041;4719.575238228542;4774.594159496447;4777.5222477752295;4824.614030877521;4684.953150468486;4761.190597598382;4764.833230836939;4795.592374648159;4807.591354734852;4729.385179926622;4732.1718699227495;4735.83424580138;4750.144973904696;4772.49888761682;5222.4255331913455;5320.228566857822;5324.520793128637;5362.410134885159;5413.53984911283;5667;5715.971420142914;5773.480386765169;5782.479576838105;5799.2750906136735;5851.0638297872565;5865.882682346371;5870.794522191745;5870.853228669274;5876.059830427154;5446;5452.781888724407;5457.208704737791;5458.263134476874;5460.6177567569885;5812.244408226988;5866.12008198765;5871.324797648325;5903.822885313448;5965.821025369246;5583.525400340935;5674.035413979634;5681.034224181816;5696.23100881384;5756.366799652035;5635.239242702265;5660.575456840754;5720.685362305113;5738.713064346766;5798.275215598051;5795.217645617872;5812.651240925558;5815.41845815415;5823.883522329615;5843.707814609337;5792.4497172768515;5796.449337312949;5801.216835727208;5805.912911306334;5816.5928385013485;4698.389209402824;4777.546133117417;4793.520647935248;4802.159622066124;4850.078485087822;4155.667546596265;4174.958250417457;4187.623113919762;4216.135692183095;4241.066965267636;4798.520147985243;4860.538248866352;4876.439209490883;4906.215005599159;4917.983954245793;5722.856928576819;5734.684592347461;5812.854678633068;5815.76736930518;5839.065749480148;4925.039617274597;4926.088673595396;4932.235503496964;4938.43208031081;4944.035912997003;5130.281760553526;5133.820316288912;5139.511746384088;5142.151544995034;5183.248428977777;5312.920306195488;5397.892042159214;5412.648177868426;5413.269208656781;5414.7292635367285;5734.05388110957;5785.508231800344;5802.564807639359;5815.2149459822385;5817.505512031525;5363.463653634605;5436.646617969819;5452.809151679672;5462.098753705594;5488.231647569263;5659.638001418714;5724.198612194379;5762.596618236683;5764.855878603068;5766.221560089334;5730.197772311796;5882.970585147047;5887.970560147171;5894.498967587631;5894.911576326273;5491.395946445808;5530.087535556588;5546.36216835053;5561.443855614406;5568.6658800472105;5533.5849811263515;5577.330720313588;5623.2127502148915;5631.8592035199445;5635.718214089361;5561.221428999862;5592.161175823497;5619.325680918316;5657.462541058593;5674.404187560247;5710.343310519177;5711.114777209539;5713;5732;5732.828015159385;5351.277577527139;5398.4871437213405;5430.83707488776;5536.529395001309;5543.6396634218645 03:18:57 INFO - PID 15391 | |1;ext.html;654.3358491131503;700.6076597105621;702.448577866375;1154.2439701995197;1189.4290740444592;34489.31021379574;35519.82240088802;35560.466593001096;35564.46653300196;35582.46626300601;34273.31453370931;34502;34565.82717086418;34660.653393466055;34695.306093878105;6359.077933699611;6481.513886458534;6665.600063996176;6817.659117044128;6824.522283440161;6811.386975172233;6877.656117194146;6924.89612655808;6928.618925959096;6931.133608298963;6887.070245516841;6926.861462770741;6934;6935.3411425914455;6942.236354001056;6870;6879.105716256855;6884.552504087218;6890.552114112592;6948.6525673716615;6804.421624161952;6835.213950395669;6860.873129329874;6866.038754574363;6873.450123990069;32202.355952881044;32213.838930805196;32354;32354.514682279783;32373.352532949208;2971.52455607104;2976.851157442119;2997.4304882072556;2998.5502174673757;3006.6241719785025;25394.873025634937;25616;25699.486010279878;25715.099971501095;25737;2907.5057240269207;2915.839628820414;2923.3422479942055;2924.941501169965;2927.4291513154944;147985.26007370002;148197;148258;155931;160432.3956760429;40606;40773.592264077575;40839.57061502833;40912.38631420531;41024.1795164101;41469.79265103655;42032.57967420348;42103;42172.789136054125;42523.149537009085;12913.09608327427;12968.610941671765;13001.869981300255;13027.869721302855;13073.15024523422;10368.377897326185;10379.532921018572;10464.947675261576;10486.056254937092;10496.055355018085;13280.468781248643;13303.401346939218;13333.20000799955;13402.932985335206;13546;5424.7016414096815;5478.123500239943;5503.394626591072;5551.3893471718075;5645.576581756384;832.1636755061124;889;905.8460061789511;927.1192367251003;932.5197523275518;20959.37121886346;21116.894415527822;21283;21463;21469.926503674753;979.1481411172325;981.8576306435527;984.522506584306;997.1324947295899;1004.1414590524996;11049.944750276198;11597.536098556133;14270.85729142716;14568.125912445286;14957.177355245565;180384;180669;181338;181545;181808;44302.77848610736;44375.33436998448;44506.777466112464;44636.10727785426;44862;1218.7257866980035;1262.6717053565956;1270.1743866486672;1270.4664041102758;1272.1730874931368;24279.393015174763;25122.24633261005;26249.343766405993;26260.343491412867;26350.604740929284;30742.846285768428;31049.68950310468;31100.22249443782;31196.220094497818;31219.37561248808;165034;165233;166415;166546;166678;29670.406591868472;30748.385032299677;31176.376472470878;31276.687233127377;31582.842085789423;36250.63749362578;37328;37346.078661740125;37388.43917341297;37548;26934.865325673247;27343.45313093767;27557.586636200875;27905.16284511468;28381.716182837907;27370.863145684143;27856.86495545725;27923.581146282417;28581.28546786264;29209.70790292155;31495.275708643887;31551.52672709865;31554.368912622078;31616.209594760316;31709.365812683154;27015;27106.78019489167;27192.592111118745;28010.579841302806;28901.855490722413;21543.353699389045;22433.214837481264;22438.77561224432;22467.550648987257;22513.324600262018 03:18:57 INFO - PID 15391 | |2;jquery.html;423.5853892053421;424.90864464140213;426.71410155196014;446.9217886869798;453.65522203125613;17393.217305221264;18096.185671644776;18118.90940545297;19239;19664.60670786587;19085.61828763424;19347;19467.61064778707;19496.317628882993;19701.60596788067;5277.208418737182;5307.575393968483;5415.83752487426;5497.312835895513;5534.916976245359;5354.437784032679;5435.130379139338;5439.945600543983;5450.482204190595;5453.972730136364;5201.193814958688;5339.092354299759;5394.406615272336;5398.163284690879;5409.404965453797;5375.0593646111965;5436.565074794027;5446.264754258164;5451.2640793492765;5476.151196564499;4874.585660218886;4913.70517768935;4920.507949205086;4954.3063971044085;4993.300937868701;21625.45936351588;21912.89043554772;22048.11807527697;22290;22777.88611056934;1597.8482044205782;1611.4521062838692;1650.1584192062014;1650.7688923550713;1659.1787065402582;14691.706165876729;16152.919235403866;16804.66390672192;16826.747598786027;17072.914635426867;2147.7744836792067;2163.9242626508;2228.6211344071385;2247.685324054634;2250.1561914282142;84674;89478;96196.51901740517;98864.0113598862;99674.50162749212;17860.28558857657;18356.86970431642;18366.816331836777;18413.26346946134;18424.263029478672;35012;35069.47395789065;35074;35181.64818351835;35346;9023.503707296162;9092.27261819053;9181;9288.7677808054;9432.90567094334;7288.781336559911;7318.853622927511;7501.137369202612;7518.210587888302;7530.811729706801;9062.410943288665;9570.56932438042;9753.268504862164;9828.950855245677;9888.901110988798;3689.0777305673582;3705.2404257127223;3810.580836108026;3827.1962887793875;3830.5020347354666;834.7287131682227;874.9650013999369;875.9211670949645;876.6142897125244;896.5427631907774;16947.830521694872;16987.74518382225;17364.48831688117;17478.91260543689;18085.54786130331;843.3211264931666;864.1229152410309;869.6564856881496;876.8772371867943;882.0870399136862;9387.90612093884;9600.183984361267;9833.655822046194;9840.114389704817;9994.250431217688;355648;362946;363742;367372;369277;63461;71189;73168.26831731615;75199;81098.59450702826;1013.6806905824642;1018.607835983137;1051.2641151194196;1057.3497299161115;1058.3332500524775;17338.826611734225;17654.73517897207;18173.54566135857;18212.817871821113;18262.543436414195;38896.222075557765;39239.41140882946;39881.999999998836;40278.19443611053;40746.79626601848;47467.52532474631;47576.286355704;48920.5107948916;49727.25409118794;50200.748996254784;11033.172512061466;11216.195951012247;11220.495077721358;11314.886851131383;11692.532298707956;12231.755364892475;12412.441440135397;12505.874941250471;12645.93677031609;12712.427940742873;9745.22038236925;9959.751006224902;9987.350822196535;10644.680659580225;10948.45257737126;8837.160469755363;8841.55792210374;9072.863907041268;9138.954305228432;9215.907840921505;9219.539023048956;9400.576974036048;9587.952060239653;9700.27247956392;10636.468176591294;10964.616238431616;11104.888951110708;11260.887391125983;11308.264962777394;11646;9953.651622193189;10059.547320370748;10133.695989120339;10230;10261.17910567138 03:18:57 INFO - PID 15391 | |3;mootools.html;1282.8909542688873;1317.4203350525768;1329.7340531893624;1338.2840180503433;1339.0492750147396;10146;10572.312799668025;10584.312019718713;10713.303635263723;10979.890201097987;10705.518251678674;10815.080718138948;10837.6748697539;10857.619983300587;10875.673729788119;2225.2434172381386;2259.4012586664467;2266.3654176830432;2270.6594010898334;2275.1923067311113;2179.6185667508203;2200.262911924507;2219.1678120704737;2221.7778222177735;2236.686863839064;2165.4261620670536;2201.7798220178015;2202.515446601745;2215.523662412581;2220.3782940776528;2098.412444515538;2114.746230452348;2117.502386939068;2124.7344081989672;2124.734408198975;1833.9358122465649;1900.790912999569;2037.2767667478129;2076.968845467319;2106.252280440452;10504.789904201949;10597.364158150458;10597.576096956112;10607.416592087433;10634.627788027381;5485.835424937219;5667.744951477193;5695.7152142392715;5699.2306038684665;5714.285714285715;3048.527478240876;3160.4153231652217;3201.9199520011953;3202.96797032029;3207.182168547029;987.3631507677579;996.9700908972742;1001.2790790630734;1002.6991902429315;1026.0867827633413;15276.77084843717;15327.923360383238;15362.769558456632;15385.769213461806;15500.767488487681;4799.472058073609;4860.3681521401995;4901.1913034349645;4956.157453232959;4996.350474438373;11542.422878856023;11544.19190656646;11544.538218471167;11561.595344162914;11562.76874462506;5557.166425036277;5726.398728133569;5730.997075511768;5733.913991290134;5741.598088133791;5202.063628546898;5228.869278268074;5229.895402091937;5244.396894357122;5253.921191182136;3773;3849.480320156743;3861.768293902319;3889.105505733697;3956.8615098471414;1155.9768804623861;1165.1901928160016;1178.9056875449944;1192.0344520938067;1198.2570806100273;701.7333413302912;705.5555000349747;707.1937990690617;715.2847152847153;729.835911720815;5484.7531861066345;5495;5542.473465020817;5567.860803479945;5587.972060139673;541.3098299667955;558.9860253493695;559.5663360895338;562.0192763627496;562.7692646015196;3486.6164721880573;3563.394222982099;3669.486271921933;3697.4638677392168;3832.7961422182357;13324.866751332556;14000.789988150185;14112.788308175386;14232.146071235758;14296.857031429761;13826.930865345608;14250.216238106796;14272.85727142736;14365.569032929028;14379.209143497208;7474.70101195957;7503.5497870127965;7707.961460192663;7723.382129429745;7758.14660387357;5878.706064696663;6033.366496517802;6073.271207455134;6392.169018027626;6396.648184349905;12430.005599552194;12551.497940082294;12617.873821262037;12750.489980401051;12915.677108072374;12781.04142189358;12881.871181288441;12916.22502649844;12931;13114.409851556513;8829.278290733246;8862.734117976472;8938.4190027648;9008;9015;9798.51007449639;9885.060919212663;9904.653337133454;9951;9953.651622193189;8161;8377.204165604258;8431.831363372821;8475.618597163018;8591.269742071994;8195.385346098947;8438.451500652438;8452.873206902024;8540.658373665232;8651.394402391772;6678.065070890177;6782;6812.65936703153;6828.658567071528;6832.248452670103;4575.3823233863;5246.108161612611;5270.578353731769;5411;5466.699331536804;5418.322709661293;5428.511433970962;5466.562674985912;5525.033119204043;5548.55611551083 03:18:57 INFO - PID 15391 | |4;prototype.html;386.3914334922497;388.41737393909136;392.5956265047001;394;395.2293028594242;5404.810831620894;5509.209506910255;5554.222408862757;5572.359178694446;5589.8602534936645;5305;5448.182772584114;5454.400015998237;5455.809046683366;5459.863503412416;3988.940165897514;4123.195976784528;4134.6692264618905;4155.085881106152;4165.854195103165;4121.031557583965;4131.111810960643;4136.234796562646;4140.730852494593;4154.854580089697;4105.979470102645;4116.732412393199;4116.732412393199;4118.608732170439;4121.5466298707115;4055.1281474483126;4106.958930410718;4111.814968326403;4113.5269444013875;4131.29767939451;3630.7821530708243;3633.6729694327637;3640.872569460056;3645.6354364563595;3646.08847788053;5281.762320695578;5291.126964050965;5296.205569164617;5305.44292849253;5310.283111779899;4774.665773395864;4814;4830.661853670244;4853.417589889201;4901.754912254373;5759.481646651821;5760.567957403212;5768.336641286264;5770.855728606776;5777.740001699934;4048.4332193492933;4065.7763822989723;4078.3498768601935;4082.183563287325;4086.856960006415;5851.268591426072;6087.604305720114;6112.027182331476;6145.754169833157;6172.8888800015975;4165.791710414467;4178.8537401190815;4204.600562946515;4204.747715137101;4222.261104306734;4234.661227101825;4237.660987121023;4241.321388577812;4245.660347172219;4262.616364527207;4746.43042834862;4830.8792280193275;4862.635302352338;4862.902741945141;4886.926696099561;5803.970980145156;5810.385326602961;5842.707864606753;5853.209816674695;5858.443447872445;1443.631873872156;1463.9121652700871;1470.6029372069481;1470.6764511807385;1471.4408524760522;967.8064387122604;976.8339382305026;978.9657361992296;985.093713783321;988.1008282462924;4966.726830024383;5015.423226328946;5019.67372120811;5026.648134630541;5047.495250474996;5997.340292567814;6000.819975400657;6022.488088512526;6039.275286965592;6040.909386359208;4773.212419950669;4948.70307781527;4979.377577802775;4986.850394488171;5007.84976450707;3164.4304025275674;3186.85659145339;3196.7602429817393;3198.9040328789706;3199.360127974368;5478.424765399655;5584.888302233932;5589.888202235932;5594.832155035356;5603.859903502445;5997.610155339889;6145.66198859067;6166.506679465632;6193.969030154821;6196.132541444202;5529.502344788908;5554.222408862763;5581.134924086773;5581.6930068846605;5591.888162236733;5968.641881487125;5981.983062879234;5985.311689155803;6044.486218671462;6047.637141771332;5634.352049514358;5830.737616807339;5913.05391137416;5945.31628862669;5949.25634295713;5522.5858060644805;5565.888682226252;5597.80407685729;5599;5619.353774315842;4080.285949958686;4158.625723684762;4169.207850508394;4176.979115104405;4185.97907010463;5976.7908123215475;6009.729562169626;6014.398560143951;6047.425494578008;6058.969705151446;5766.942330576809;5823.7670493181495;5837.532997360286;5850.707464626837;5864.44287792659;5663;5781.24843770324;5803.506701930383;5803.622764520293;5809.8547536311935;5724.198612194379;5746.942530574808;5753.942460575508;5761.683107429131;5769.134629805395;5777.162311464898;5850.327212370632;5857.58996870215;5867.413258674099;5912.320083190316;5643.88712225745;5695.8860822784145;5704.3154821421695;5711.5150060983615;5728.971355143198 03:18:57 INFO - PID 15391 | |5;yui.html;743.1973468653853;744.2185705009739;763.6296396247819;764.5336344829657;773.7523992322456;11716.472758725857;12131.15081944262;12913.741725165492;13785.655358616026;13807.240601766898;15084.622884427894;15493.767593486107;15611.297491612877;15617.21913904306;15662;875.1511034296722;900.2617853360247;905.2124651553158;907.874235947427;909.0545832334365;905.4522014181424;909.6634245329237;911.2118017914522;912.7170577121113;913.0732306708696;945.5792172483248;946.2808265718035;946.7538440005613;947.7962238118803;948.8481842905137;931.9114684104999;932.911373419524;941.0166376136954;942.0014784328633;942.3968660057569;671.2046225223127;680.7515256931234;699.7655785311927;700.1807884774826;700.6251655364356;14749.115053096848;14772.409103635842;14892.851071489255;14911.478098266618;14990.700185996218;15613.375464981387;16470.42353517633;16595.91702041482;16612.169391530377;16635.584110397216;12726.490940362375;12931.482740690455;12947.41736621845;13091.34543272842;13150.868491315061;2839.687634360219;2867.555528893025;2868.5553739170255;2869.0962346860674;2883.5818806273182;77808.61095694486;79163;80222.59888700578;80529.59735201286;81221.59389203135;9849.803003939882;9951.502424878727;9990.750231244278;10055.547500362502;10085.445300508543;18147.274109035756;18201.45395638133;18304.908475457538;18520.722189167172;18639.906800466182;5943.049112142036;5979.073243647242;5989.460948514655;6034.125051867454;6042.697865106815;2952.5423559348337;3004.4742170120144;3021.957424688479;3038.5745995560637;3044.4367791958557;3146.2606287522412;3205.006448001127;3207.3905957868396;3216.7748257621743;3220.162757683019;658.5850913924197;672.6031641331638;744.2483092076933;797.7686470923484;802.2498963469175;601.8134378342728;611.4802417944711;613.7698363113832;615.8306465721872;634.6033728919425;9845.50772461374;10208.132308753839;10503.159747220205;10547;10826.891731082746;593.7476572456775;594.5392320951297;607.2227548737623;609.2262826210688;609.8810731907236;4383.7588932609015;4567.862964111016;4572.679912406166;4573.748443835554;4591.4260717410325;85813.57093214494;87406.12593874107;88897;89584.55207723919;89624.5518772402;79846.60076699695;80074.59962700149;80147.59926200332;81343.59328203321;81914;61227.08159377613;61428.69285653543;63481.68259158767;66986.66506667533;67766.66116669483;10033.397996120257;10463.529141188512;10609.522571484147;10650.627228046982;10733.892661073289;29217;29284.707152928197;29637.703622964356;29825.70174298316;30340.848295759264;35486;35703.464448032784;35749.821250893576;36555;36763.26473470462;13535.661608459868;13947.58157255284;14063.296835158406;14103.717925641635;14281.64295892611;16285.755713664541;16350.427735029218;16557.58606034859;16718;16860.241289142265;14772.18752968597;14955.775663365275;15210.08739475635;15272.770908436605;15430.459933902259;14382.712345753236;14682.486112985995;14690;14769.556913292618;15112.848871511143;14605.561833145022;14703.55889323322;14811.481598144013;14880.702385952003;15496;10895.618653347095;10977.28647637933;11228.270162439741;11437.370944598128;11826.940865295619;10980.890191097988;11560.42197890119;11969.281843089442;12149.757004859677;12184.086193535342 03:18:57 INFO - PID 15391 | __end_tp_report 03:18:57 INFO - PID 15391 | __start_cc_report 03:18:57 INFO - PID 15391 | _x_x_mozilla_cycle_collect,330 03:18:57 INFO - PID 15391 | __end_cc_report 03:18:57 INFO - PID 15391 | __startTimestamp1495793937911__endTimestamp 03:18:57 INFO - PID 15391 | 03:18:57 INFO - PID 15391 | ------- Summary: start ------- 03:18:57 INFO - PID 15391 | Number of tests: 6 03:18:57 INFO - PID 15391 | 03:18:57 INFO - PID 15391 | [#0] dojo.html Cycles:165 Average:5286.98 Median:5452.81 stddev:627.23 (11.5%) stddev-sans-first:596.63 03:18:57 INFO - PID 15391 | Values: 2745.7 2755.0 2766.3 2770.2 2782.8 5293.5 5361.4 5387.9 5397.5 5414.7 5301.1 5308.8 5315.9 5357.8 5397.3 4725.5 4747.8 4775.6 4782.8 4816.7 4755.4 4802.6 4824.3 4841.9 4847.7 4667.7 4719.6 4774.6 4777.5 4824.6 4685.0 4761.2 4764.8 4795.6 4807.6 4729.4 4732.2 4735.8 4750.1 4772.5 5222.4 5320.2 5324.5 5362.4 5413.5 5667.0 5716.0 5773.5 5782.5 5799.3 5851.1 5865.9 5870.8 5870.9 5876.1 5446.0 5452.8 5457.2 5458.3 5460.6 5812.2 5866.1 5871.3 5903.8 5965.8 5583.5 5674.0 5681.0 5696.2 5756.4 5635.2 5660.6 5720.7 5738.7 5798.3 5795.2 5812.7 5815.4 5823.9 5843.7 5792.4 5796.4 5801.2 5805.9 5816.6 4698.4 4777.5 4793.5 4802.2 4850.1 4155.7 4175.0 4187.6 4216.1 4241.1 4798.5 4860.5 4876.4 4906.2 4918.0 5722.9 5734.7 5812.9 5815.8 5839.1 4925.0 4926.1 4932.2 4938.4 4944.0 5130.3 5133.8 5139.5 5142.2 5183.2 5312.9 5397.9 5412.6 5413.3 5414.7 5734.1 5785.5 5802.6 5815.2 5817.5 5363.5 5436.6 5452.8 5462.1 5488.2 5659.6 5724.2 5762.6 5764.9 5766.2 5730.2 5883.0 5888.0 5894.5 5894.9 5491.4 5530.1 5546.4 5561.4 5568.7 5533.6 5577.3 5623.2 5631.9 5635.7 5561.2 5592.2 5619.3 5657.5 5674.4 5710.3 5711.1 5713.0 5732.0 5732.8 5351.3 5398.5 5430.8 5536.5 5543.6 03:18:57 INFO - PID 15391 | 03:18:57 INFO - PID 15391 | [#1] ext.html Cycles:180 Average:31601.07 Median:30899.04 stddev:43036.97 (139.3%) stddev-sans-first:43094.96 03:18:57 INFO - PID 15391 | Values: 654.3 700.6 702.4 1154.2 1189.4 34489.3 35519.8 35560.5 35564.5 35582.5 34273.3 34502.0 34565.8 34660.7 34695.3 6359.1 6481.5 6665.6 6817.7 6824.5 6811.4 6877.7 6924.9 6928.6 6931.1 6887.1 6926.9 6934.0 6935.3 6942.2 6870.0 6879.1 6884.6 6890.6 6948.7 6804.4 6835.2 6860.9 6866.0 6873.5 32202.4 32213.8 32354.0 32354.5 32373.4 2971.5 2976.9 2997.4 2998.6 3006.6 25394.9 25616.0 25699.5 25715.1 25737.0 2907.5 2915.8 2923.3 2924.9 2927.4 147985.3 148197.0 148258.0 155931.0 160432.4 40606.0 40773.6 40839.6 40912.4 41024.2 41469.8 42032.6 42103.0 42172.8 42523.1 12913.1 12968.6 13001.9 13027.9 13073.2 10368.4 10379.5 10464.9 10486.1 10496.1 13280.5 13303.4 13333.2 13402.9 13546.0 5424.7 5478.1 5503.4 5551.4 5645.6 832.2 889.0 905.8 927.1 932.5 20959.4 21116.9 21283.0 21463.0 21469.9 979.1 981.9 984.5 997.1 1004.1 11049.9 11597.5 14270.9 14568.1 14957.2 180384.0 180669.0 181338.0 181545.0 181808.0 44302.8 44375.3 44506.8 44636.1 44862.0 1218.7 1262.7 1270.2 1270.5 1272.2 24279.4 25122.2 26249.3 26260.3 26350.6 30742.8 31049.7 31100.2 31196.2 31219.4 165034.0 165233.0 166415.0 166546.0 166678.0 29670.4 30748.4 31176.4 31276.7 31582.8 36250.6 37328.0 37346.1 37388.4 37548.0 26934.9 27343.5 27557.6 27905.2 28381.7 27370.9 27856.9 27923.6 28581.3 29209.7 31495.3 31551.5 31554.4 31616.2 31709.4 27015.0 27106.8 27192.6 28010.6 28901.9 21543.4 22433.2 22438.8 22467.6 22513.3 03:18:57 INFO - PID 15391 | 03:18:57 INFO - PID 15391 | [#2] jquery.html Cycles:180 Average:25877.89 Median:40512.50 stddev:60572.01 (149.5%) stddev-sans-first:60711.78 03:18:57 INFO - PID 15391 | Values: 423.6 424.9 426.7 446.9 453.7 17393.2 18096.2 18118.9 19239.0 19664.6 19085.6 19347.0 19467.6 19496.3 19701.6 5277.2 5307.6 5415.8 5497.3 5534.9 5354.4 5435.1 5439.9 5450.5 5454.0 5201.2 5339.1 5394.4 5398.2 5409.4 5375.1 5436.6 5446.3 5451.3 5476.2 4874.6 4913.7 4920.5 4954.3 4993.3 21625.5 21912.9 22048.1 22290.0 22777.9 1597.8 1611.5 1650.2 1650.8 1659.2 14691.7 16152.9 16804.7 16826.7 17072.9 2147.8 2163.9 2228.6 2247.7 2250.2 84674.0 89478.0 96196.5 98864.0 99674.5 17860.3 18356.9 18366.8 18413.3 18424.3 35012.0 35069.5 35074.0 35181.6 35346.0 9023.5 9092.3 9181.0 9288.8 9432.9 7288.8 7318.9 7501.1 7518.2 7530.8 9062.4 9570.6 9753.3 9829.0 9888.9 3689.1 3705.2 3810.6 3827.2 3830.5 834.7 875.0 875.9 876.6 896.5 16947.8 16987.7 17364.5 17478.9 18085.5 843.3 864.1 869.7 876.9 882.1 9387.9 9600.2 9833.7 9840.1 9994.3 355648.0 362946.0 363742.0 367372.0 369277.0 63461.0 71189.0 73168.3 75199.0 81098.6 1013.7 1018.6 1051.3 1057.3 1058.3 17338.8 17654.7 18173.5 18212.8 18262.5 38896.2 39239.4 39882.0 40278.2 40746.8 47467.5 47576.3 48920.5 49727.3 50200.7 11033.2 11216.2 11220.5 11314.9 11692.5 12231.8 12412.4 12505.9 12645.9 12712.4 9745.2 9959.8 9987.4 10644.7 10948.5 8837.2 8841.6 9072.9 9139.0 9215.9 9219.5 9400.6 9588.0 9700.3 10636.5 10964.6 11104.9 11260.9 11308.3 11646.0 9953.7 10059.5 10133.7 10230.0 10261.2 03:18:57 INFO - PID 15391 | 03:18:57 INFO - PID 15391 | [#3] mootools.html Cycles:180 Average:6469.68 Median:3683.48 stddev:4300.68 (116.8%) stddev-sans-first:4295.09 03:18:57 INFO - PID 15391 | Values: 1282.9 1317.4 1329.7 1338.3 1339.0 10146.0 10572.3 10584.3 10713.3 10979.9 10705.5 10815.1 10837.7 10857.6 10875.7 2225.2 2259.4 2266.4 2270.7 2275.2 2179.6 2200.3 2219.2 2221.8 2236.7 2165.4 2201.8 2202.5 2215.5 2220.4 2098.4 2114.7 2117.5 2124.7 2124.7 1833.9 1900.8 2037.3 2077.0 2106.3 10504.8 10597.4 10597.6 10607.4 10634.6 5485.8 5667.7 5695.7 5699.2 5714.3 3048.5 3160.4 3201.9 3203.0 3207.2 987.4 997.0 1001.3 1002.7 1026.1 15276.8 15327.9 15362.8 15385.8 15500.8 4799.5 4860.4 4901.2 4956.2 4996.4 11542.4 11544.2 11544.5 11561.6 11562.8 5557.2 5726.4 5731.0 5733.9 5741.6 5202.1 5228.9 5229.9 5244.4 5253.9 3773.0 3849.5 3861.8 3889.1 3956.9 1156.0 1165.2 1178.9 1192.0 1198.3 701.7 705.6 707.2 715.3 729.8 5484.8 5495.0 5542.5 5567.9 5588.0 541.3 559.0 559.6 562.0 562.8 3486.6 3563.4 3669.5 3697.5 3832.8 13324.9 14000.8 14112.8 14232.1 14296.9 13826.9 14250.2 14272.9 14365.6 14379.2 7474.7 7503.5 7708.0 7723.4 7758.1 5878.7 6033.4 6073.3 6392.2 6396.6 12430.0 12551.5 12617.9 12750.5 12915.7 12781.0 12881.9 12916.2 12931.0 13114.4 8829.3 8862.7 8938.4 9008.0 9015.0 9798.5 9885.1 9904.7 9951.0 9953.7 8161.0 8377.2 8431.8 8475.6 8591.3 8195.4 8438.5 8452.9 8540.7 8651.4 6678.1 6782.0 6812.7 6828.7 6832.2 4575.4 5246.1 5270.6 5411.0 5466.7 5418.3 5428.5 5466.6 5525.0 5548.6 03:18:57 INFO - PID 15391 | 03:18:57 INFO - PID 15391 | [#4] prototype.html Cycles:180 Average:4778.12 Median:5469.14 stddev:1412.84 (25.8%) stddev-sans-first:1377.82 03:18:57 INFO - PID 15391 | Values: 386.4 388.4 392.6 394.0 395.2 5404.8 5509.2 5554.2 5572.4 5589.9 5305.0 5448.2 5454.4 5455.8 5459.9 3988.9 4123.2 4134.7 4155.1 4165.9 4121.0 4131.1 4136.2 4140.7 4154.9 4106.0 4116.7 4116.7 4118.6 4121.5 4055.1 4107.0 4111.8 4113.5 4131.3 3630.8 3633.7 3640.9 3645.6 3646.1 5281.8 5291.1 5296.2 5305.4 5310.3 4774.7 4814.0 4830.7 4853.4 4901.8 5759.5 5760.6 5768.3 5770.9 5777.7 4048.4 4065.8 4078.3 4082.2 4086.9 5851.3 6087.6 6112.0 6145.8 6172.9 4165.8 4178.9 4204.6 4204.7 4222.3 4234.7 4237.7 4241.3 4245.7 4262.6 4746.4 4830.9 4862.6 4862.9 4886.9 5804.0 5810.4 5842.7 5853.2 5858.4 1443.6 1463.9 1470.6 1470.7 1471.4 967.8 976.8 979.0 985.1 988.1 4966.7 5015.4 5019.7 5026.6 5047.5 5997.3 6000.8 6022.5 6039.3 6040.9 4773.2 4948.7 4979.4 4986.9 5007.8 3164.4 3186.9 3196.8 3198.9 3199.4 5478.4 5584.9 5589.9 5594.8 5603.9 5997.6 6145.7 6166.5 6194.0 6196.1 5529.5 5554.2 5581.1 5581.7 5591.9 5968.6 5982.0 5985.3 6044.5 6047.6 5634.4 5830.7 5913.1 5945.3 5949.3 5522.6 5565.9 5597.8 5599.0 5619.4 4080.3 4158.6 4169.2 4177.0 4186.0 5976.8 6009.7 6014.4 6047.4 6059.0 5766.9 5823.8 5837.5 5850.7 5864.4 5663.0 5781.2 5803.5 5803.6 5809.9 5724.2 5746.9 5753.9 5761.7 5769.1 5777.2 5850.3 5857.6 5867.4 5912.3 5643.9 5695.9 5704.3 5711.5 5729.0 03:18:57 INFO - PID 15391 | 03:18:57 INFO - PID 15391 | [#5] yui.html Cycles:180 Average:17374.30 Median:3095.35 stddev:23230.82 (750.5%) stddev-sans-first:23262.42 03:18:57 INFO - PID 15391 | Values: 743.2 744.2 763.6 764.5 773.8 11716.5 12131.2 12913.7 13785.7 13807.2 15084.6 15493.8 15611.3 15617.2 15662.0 875.2 900.3 905.2 907.9 909.1 905.5 909.7 911.2 912.7 913.1 945.6 946.3 946.8 947.8 948.8 931.9 932.9 941.0 942.0 942.4 671.2 680.8 699.8 700.2 700.6 14749.1 14772.4 14892.9 14911.5 14990.7 15613.4 16470.4 16595.9 16612.2 16635.6 12726.5 12931.5 12947.4 13091.3 13150.9 2839.7 2867.6 2868.6 2869.1 2883.6 77808.6 79163.0 80222.6 80529.6 81221.6 9849.8 9951.5 9990.8 10055.5 10085.4 18147.3 18201.5 18304.9 18520.7 18639.9 5943.0 5979.1 5989.5 6034.1 6042.7 2952.5 3004.5 3022.0 3038.6 3044.4 3146.3 3205.0 3207.4 3216.8 3220.2 658.6 672.6 744.2 797.8 802.2 601.8 611.5 613.8 615.8 634.6 9845.5 10208.1 10503.2 10547.0 10826.9 593.7 594.5 607.2 609.2 609.9 4383.8 4567.9 4572.7 4573.7 4591.4 85813.6 87406.1 88897.0 89584.6 89624.6 79846.6 80074.6 80147.6 81343.6 81914.0 61227.1 61428.7 63481.7 66986.7 67766.7 10033.4 10463.5 10609.5 10650.6 10733.9 29217.0 29284.7 29637.7 29825.7 30340.8 35486.0 35703.5 35749.8 36555.0 36763.3 13535.7 13947.6 14063.3 14103.7 14281.6 16285.8 16350.4 16557.6 16718.0 16860.2 14772.2 14955.8 15210.1 15272.8 15430.5 14382.7 14682.5 14690.0 14769.6 15112.8 14605.6 14703.6 14811.5 14880.7 15496.0 10895.6 10977.3 11228.3 11437.4 11826.9 10980.9 11560.4 11969.3 12149.8 12184.1 03:18:57 INFO - PID 15391 | -------- Summary: end -------- 03:18:57 INFO - PID 15391 | 03:18:58 INFO - TEST-INFO | 15391: exit 0 03:18:58 INFO - TEST-OK | dromaeo_css | took 1147536ms 03:18:58 INFO - TEST-START | kraken 03:18:58 INFO - operating with platform_type : linux_ 03:18:58 INFO - Initialising browser for kraken test... 03:18:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47193/getInfo.html -profile /tmp/tmpBV27GR/profile 03:18:58 INFO - TEST-INFO | started process 15813 (/builds/slave/test/build/application/firefox/firefox http://localhost:47193/getInfo.html) 03:19:33 INFO - TEST-INFO | 15813: killed by SIGTERM 03:19:33 INFO - Browser initialized. 03:19:33 INFO - Running cycle 1/1 for kraken test... 03:19:33 INFO - TEST-INFO | started process 16038 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBV27GR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:45 INFO - PID 16038 | RSS: Main: 172662784 03:19:45 INFO - PID 16038 | 03:19:48 INFO - PID 16038 | Cycle 1(1): loaded http://localhost:47193/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47193/tests/kraken/driver.html?testName=audio-beat-detection) 03:19:49 INFO - PID 16038 | RSS: Main: 178405376 03:19:49 INFO - PID 16038 | 03:19:51 INFO - PID 16038 | Cycle 1(1): loaded http://localhost:47193/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47193/tests/kraken/driver.html?testName=audio-dft) 03:19:52 INFO - PID 16038 | RSS: Main: 177115136 03:19:52 INFO - PID 16038 | 03:19:55 INFO - PID 16038 | Cycle 1(1): loaded http://localhost:47193/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47193/tests/kraken/driver.html?testName=audio-fft) 03:19:56 INFO - PID 16038 | RSS: Main: 174907392 03:19:56 INFO - PID 16038 | 03:19:58 INFO - PID 16038 | Cycle 1(1): loaded http://localhost:47193/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47193/tests/kraken/driver.html?testName=audio-oscillator) 03:19:58 INFO - PID 16038 | RSS: Main: 175153152 03:19:58 INFO - PID 16038 | 03:20:00 INFO - PID 16038 | Cycle 1(1): loaded http://localhost:47193/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47193/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:20:01 INFO - PID 16038 | RSS: Main: 175820800 03:20:01 INFO - PID 16038 | 03:20:04 INFO - PID 16038 | Cycle 1(1): loaded http://localhost:47193/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47193/tests/kraken/driver.html?testName=imaging-darkroom) 03:20:05 INFO - PID 16038 | RSS: Main: 176795648 03:20:05 INFO - PID 16038 | 03:20:08 INFO - PID 16038 | Cycle 1(1): loaded http://localhost:47193/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47193/tests/kraken/driver.html?testName=imaging-desaturate) 03:20:09 INFO - PID 16038 | RSS: Main: 175706112 03:20:09 INFO - PID 16038 | 03:20:12 INFO - PID 16038 | Cycle 1(1): loaded http://localhost:47193/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47193/tests/kraken/driver.html?testName=json-parse-financial) 03:20:13 INFO - PID 16038 | RSS: Main: 176996352 03:20:13 INFO - PID 16038 | 03:20:14 INFO - PID 16038 | Cycle 1(1): loaded http://localhost:47193/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47193/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:20:15 INFO - PID 16038 | RSS: Main: 177029120 03:20:15 INFO - PID 16038 | 03:20:17 INFO - PID 16038 | Cycle 1(1): loaded http://localhost:47193/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47193/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:20:17 INFO - PID 16038 | RSS: Main: 176324608 03:20:17 INFO - PID 16038 | 03:20:19 INFO - PID 16038 | Cycle 1(1): loaded http://localhost:47193/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47193/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:20:20 INFO - PID 16038 | RSS: Main: 176627712 03:20:20 INFO - PID 16038 | 03:20:23 INFO - PID 16038 | Cycle 1(1): loaded http://localhost:47193/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:20:24 INFO - PID 16038 | RSS: Main: 176463872 03:20:24 INFO - PID 16038 | 03:20:27 INFO - PID 16038 | Cycle 1(1): loaded http://localhost:47193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:20:27 INFO - PID 16038 | RSS: Main: 176267264 03:20:27 INFO - PID 16038 | 03:20:29 INFO - PID 16038 | Cycle 1(1): loaded http://localhost:47193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47193/tests/kraken/driver.html?testName=ai-astar) 03:20:30 INFO - PID 16038 | RSS: Main: 177635328 03:20:30 INFO - PID 16038 | 03:20:30 INFO - PID 16038 | __start_tp_report 03:20:30 INFO - PID 16038 | _x_x_mozilla_page_load 03:20:30 INFO - PID 16038 | _x_x_mozilla_page_load_details 03:20:30 INFO - PID 16038 | |i|pagename|runs| 03:20:30 INFO - PID 16038 | |0;ai-astar;104;111;112;113;111;112;113;112;111;112 03:20:30 INFO - PID 16038 | |1;audio-beat-detection;145;123;125;180;122;128;127;124;146;124 03:20:30 INFO - PID 16038 | |2;audio-dft;163;165;163;165;171;168;169;163;165;163 03:20:30 INFO - PID 16038 | |3;audio-fft;73;74;75;118;75;74;76;74;97;74 03:20:30 INFO - PID 16038 | |4;audio-oscillator;83;83;109;83;85;83;111;83;84;106 03:20:30 INFO - PID 16038 | |5;imaging-gaussian-blur;113;115;114;115;114;115;114;115;118;119 03:20:30 INFO - PID 16038 | |6;imaging-darkroom;154;150;151;150;150;151;151;151;151;152 03:20:30 INFO - PID 16038 | |7;imaging-desaturate;95;95;94;95;94;95;95;95;95;94 03:20:30 INFO - PID 16038 | |8;json-parse-financial;54;54;58;58;56;54;55;57;55;61 03:20:30 INFO - PID 16038 | |9;json-stringify-tinderbox;56;56;58;55;63;56;56;56;57;55 03:20:30 INFO - PID 16038 | |10;stanford-crypto-aes;96;88;86;97;86;89;91;88;129;90 03:20:30 INFO - PID 16038 | |11;stanford-crypto-ccm;134;138;152;131;129;134;141;134;148;131 03:20:30 INFO - PID 16038 | |12;stanford-crypto-pbkdf2;192;196;198;198;200;192;194;195;197;200 03:20:30 INFO - PID 16038 | |13;stanford-crypto-sha256-iterative;77;77;72;73;76;78;74;71;74;74 03:20:30 INFO - PID 16038 | __end_tp_report 03:20:30 INFO - PID 16038 | __start_cc_report 03:20:30 INFO - PID 16038 | _x_x_mozilla_cycle_collect,887 03:20:30 INFO - PID 16038 | __end_cc_report 03:20:30 INFO - PID 16038 | __startTimestamp1495794030006__endTimestamp 03:20:30 INFO - PID 16038 | 03:20:30 INFO - PID 16038 | ------- Summary: start ------- 03:20:30 INFO - PID 16038 | Number of tests: 14 03:20:30 INFO - PID 16038 | 03:20:30 INFO - PID 16038 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.60 (2.3%) stddev-sans-first:0.78 03:20:30 INFO - PID 16038 | Values: 104.0 111.0 112.0 113.0 111.0 112.0 113.0 112.0 111.0 112.0 03:20:30 INFO - PID 16038 | 03:20:30 INFO - PID 16038 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:127.50 stddev:18.29 (14.3%) stddev-sans-first:18.99 03:20:30 INFO - PID 16038 | Values: 145.0 123.0 125.0 180.0 122.0 128.0 127.0 124.0 146.0 124.0 03:20:30 INFO - PID 16038 | 03:20:30 INFO - PID 16038 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.00 stddev:2.88 (1.7%) stddev-sans-first:2.91 03:20:30 INFO - PID 16038 | Values: 163.0 165.0 163.0 165.0 171.0 168.0 169.0 163.0 165.0 163.0 03:20:30 INFO - PID 16038 | 03:20:30 INFO - PID 16038 | [#3] audio-fft Cycles:10 Average:81.00 Median:74.50 stddev:14.84 (19.9%) stddev-sans-first:15.46 03:20:30 INFO - PID 16038 | Values: 73.0 74.0 75.0 118.0 75.0 74.0 76.0 74.0 97.0 74.0 03:20:30 INFO - PID 16038 | 03:20:30 INFO - PID 16038 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:83.00 stddev:12.27 (14.8%) stddev-sans-first:12.66 03:20:30 INFO - PID 16038 | Values: 83.0 83.0 109.0 83.0 85.0 83.0 111.0 83.0 84.0 106.0 03:20:30 INFO - PID 16038 | 03:20:30 INFO - PID 16038 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:1.87 (1.6%) stddev-sans-first:1.81 03:20:30 INFO - PID 16038 | Values: 113.0 115.0 114.0 115.0 114.0 115.0 114.0 115.0 118.0 119.0 03:20:30 INFO - PID 16038 | 03:20:30 INFO - PID 16038 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:1.20 (0.8%) stddev-sans-first:0.67 03:20:30 INFO - PID 16038 | Values: 154.0 150.0 151.0 150.0 150.0 151.0 151.0 151.0 151.0 152.0 03:20:30 INFO - PID 16038 | 03:20:30 INFO - PID 16038 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:20:30 INFO - PID 16038 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 03:20:30 INFO - PID 16038 | 03:20:30 INFO - PID 16038 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.50 stddev:2.30 (4.1%) stddev-sans-first:2.30 03:20:30 INFO - PID 16038 | Values: 54.0 54.0 58.0 58.0 56.0 54.0 55.0 57.0 55.0 61.0 03:20:30 INFO - PID 16038 | 03:20:30 INFO - PID 16038 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:56.00 stddev:2.35 (4.2%) stddev-sans-first:2.47 03:20:30 INFO - PID 16038 | Values: 56.0 56.0 58.0 55.0 63.0 56.0 56.0 56.0 57.0 55.0 03:20:30 INFO - PID 16038 | 03:20:30 INFO - PID 16038 | [#10] stanford-crypto-aes Cycles:10 Average:94.00 Median:89.50 stddev:12.86 (14.4%) stddev-sans-first:13.62 03:20:30 INFO - PID 16038 | Values: 96.0 88.0 86.0 97.0 86.0 89.0 91.0 88.0 129.0 90.0 03:20:30 INFO - PID 16038 | 03:20:30 INFO - PID 16038 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:136.00 stddev:7.64 (5.6%) stddev-sans-first:8.02 03:20:30 INFO - PID 16038 | Values: 134.0 138.0 152.0 131.0 129.0 134.0 141.0 134.0 148.0 131.0 03:20:30 INFO - PID 16038 | 03:20:30 INFO - PID 16038 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.20 Median:197.50 stddev:2.94 (1.5%) stddev-sans-first:2.69 03:20:30 INFO - PID 16038 | Values: 192.0 196.0 198.0 198.0 200.0 192.0 194.0 195.0 197.0 200.0 03:20:30 INFO - PID 16038 | 03:20:30 INFO - PID 16038 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:75.00 stddev:2.32 (3.1%) stddev-sans-first:2.29 03:20:30 INFO - PID 16038 | Values: 77.0 77.0 72.0 73.0 76.0 78.0 74.0 71.0 74.0 74.0 03:20:30 INFO - PID 16038 | -------- Summary: end -------- 03:20:30 INFO - PID 16038 | 03:20:31 INFO - TEST-INFO | 16038: exit 0 03:20:31 INFO - TEST-OK | kraken | took 92408ms 03:20:31 INFO - SUITE-END | took 1239s 03:20:31 INFO - Completed test suite (00:20:40) 03:20:31 INFO - javascript benchmark 03:20:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6918.7578873498705, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2745.656792900887, 2755.0357374918794, 2766.3360793409574, 2770.2381844992624, 2782.7773778097753, 5293.52358287754, 5361.437049109846, 5387.89224215516, 5397.51422371987, 5414.675119492833, 5301.072312345344, 5308.840734777963, 5315.946840531594, 5357.7589008494615, 5397.325334333208, 4725.503822098664, 4747.76261186941, 4775.617950563956, 4782.78477468513, 4816.686915350509, 4755.405574303212, 4802.567768900798, 4824.252240902648, 4841.854744357657, 4847.73337466441, 4667.696599721041, 4719.575238228542, 4774.594159496447, 4777.5222477752295, 4824.614030877521, 4684.953150468486, 4761.190597598382, 4764.833230836939, 4795.592374648159, 4807.591354734852, 4729.385179926622, 4732.1718699227495, 4735.83424580138, 4750.144973904696, 4772.49888761682, 5222.4255331913455, 5320.228566857822, 5324.520793128637, 5362.410134885159, 5413.53984911283, 5667.0, 5715.971420142914, 5773.480386765169, 5782.479576838105, 5799.2750906136735, 5851.0638297872565, 5865.882682346371, 5870.794522191745, 5870.853228669274, 5876.059830427154, 5446.0, 5452.781888724407, 5457.208704737791, 5458.263134476874, 5460.6177567569885, 5812.244408226988, 5866.12008198765, 5871.324797648325, 5903.822885313448, 5965.821025369246, 5583.525400340935, 5674.035413979634, 5681.034224181816, 5696.23100881384, 5756.366799652035, 5635.239242702265, 5660.575456840754, 5720.685362305113, 5738.713064346766, 5798.275215598051, 5795.217645617872, 5812.651240925558, 5815.41845815415, 5823.883522329615, 5843.707814609337, 5792.4497172768515, 5796.449337312949, 5801.216835727208, 5805.912911306334, 5816.5928385013485, 4698.389209402824, 4777.546133117417, 4793.520647935248, 4802.159622066124, 4850.078485087822, 4155.667546596265, 4174.958250417457, 4187.623113919762, 4216.135692183095, 4241.066965267636, 4798.520147985243, 4860.538248866352, 4876.439209490883, 4906.215005599159, 4917.983954245793, 5722.856928576819, 5734.684592347461, 5812.854678633068, 5815.76736930518, 5839.065749480148, 4925.039617274597, 4926.088673595396, 4932.235503496964, 4938.43208031081, 4944.035912997003, 5130.281760553526, 5133.820316288912, 5139.511746384088, 5142.151544995034, 5183.248428977777, 5312.920306195488, 5397.892042159214, 5412.648177868426, 5413.269208656781, 5414.7292635367285, 5734.05388110957, 5785.508231800344, 5802.564807639359, 5815.2149459822385, 5817.505512031525, 5363.463653634605, 5436.646617969819, 5452.809151679672, 5462.098753705594, 5488.231647569263, 5659.638001418714, 5724.198612194379, 5762.596618236683, 5764.855878603068, 5766.221560089334, 5730.197772311796, 5882.970585147047, 5887.970560147171, 5894.498967587631, 5894.911576326273, 5491.395946445808, 5530.087535556588, 5546.36216835053, 5561.443855614406, 5568.6658800472105, 5533.5849811263515, 5577.330720313588, 5623.2127502148915, 5631.8592035199445, 5635.718214089361, 5561.221428999862, 5592.161175823497, 5619.325680918316, 5657.462541058593, 5674.404187560247, 5710.343310519177, 5711.114777209539, 5713.0, 5732.0, 5732.828015159385, 5351.277577527139, 5398.4871437213405, 5430.83707488776, 5536.529395001309, 5543.6396634218645], "value": 5240.781599366424, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.3358491131503, 700.6076597105621, 702.448577866375, 1154.2439701995197, 1189.4290740444592, 34489.31021379574, 35519.82240088802, 35560.466593001096, 35564.46653300196, 35582.46626300601, 34273.31453370931, 34502.0, 34565.82717086418, 34660.653393466055, 34695.306093878105, 6359.077933699611, 6481.513886458534, 6665.600063996176, 6817.659117044128, 6824.522283440161, 6811.386975172233, 6877.656117194146, 6924.89612655808, 6928.618925959096, 6931.133608298963, 6887.070245516841, 6926.861462770741, 6934.0, 6935.3411425914455, 6942.236354001056, 6870.0, 6879.105716256855, 6884.552504087218, 6890.552114112592, 6948.6525673716615, 6804.421624161952, 6835.213950395669, 6860.873129329874, 6866.038754574363, 6873.450123990069, 32202.355952881044, 32213.838930805196, 32354.0, 32354.514682279783, 32373.352532949208, 2971.52455607104, 2976.851157442119, 2997.4304882072556, 2998.5502174673757, 3006.6241719785025, 25394.873025634937, 25616.0, 25699.486010279878, 25715.099971501095, 25737.0, 2907.5057240269207, 2915.839628820414, 2923.3422479942055, 2924.941501169965, 2927.4291513154944, 147985.26007370002, 148197.0, 148258.0, 155931.0, 160432.3956760429, 40606.0, 40773.592264077575, 40839.57061502833, 40912.38631420531, 41024.1795164101, 41469.79265103655, 42032.57967420348, 42103.0, 42172.789136054125, 42523.149537009085, 12913.09608327427, 12968.610941671765, 13001.869981300255, 13027.869721302855, 13073.15024523422, 10368.377897326185, 10379.532921018572, 10464.947675261576, 10486.056254937092, 10496.055355018085, 13280.468781248643, 13303.401346939218, 13333.20000799955, 13402.932985335206, 13546.0, 5424.7016414096815, 5478.123500239943, 5503.394626591072, 5551.3893471718075, 5645.576581756384, 832.1636755061124, 889.0, 905.8460061789511, 927.1192367251003, 932.5197523275518, 20959.37121886346, 21116.894415527822, 21283.0, 21463.0, 21469.926503674753, 979.1481411172325, 981.8576306435527, 984.522506584306, 997.1324947295899, 1004.1414590524996, 11049.944750276198, 11597.536098556133, 14270.85729142716, 14568.125912445286, 14957.177355245565, 180384.0, 180669.0, 181338.0, 181545.0, 181808.0, 44302.77848610736, 44375.33436998448, 44506.777466112464, 44636.10727785426, 44862.0, 1218.7257866980035, 1262.6717053565956, 1270.1743866486672, 1270.4664041102758, 1272.1730874931368, 24279.393015174763, 25122.24633261005, 26249.343766405993, 26260.343491412867, 26350.604740929284, 30742.846285768428, 31049.68950310468, 31100.22249443782, 31196.220094497818, 31219.37561248808, 165034.0, 165233.0, 166415.0, 166546.0, 166678.0, 29670.406591868472, 30748.385032299677, 31176.376472470878, 31276.687233127377, 31582.842085789423, 36250.63749362578, 37328.0, 37346.078661740125, 37388.43917341297, 37548.0, 26934.865325673247, 27343.45313093767, 27557.586636200875, 27905.16284511468, 28381.716182837907, 27370.863145684143, 27856.86495545725, 27923.581146282417, 28581.28546786264, 29209.70790292155, 31495.275708643887, 31551.52672709865, 31554.368912622078, 31616.209594760316, 31709.365812683154, 27015.0, 27106.78019489167, 27192.592111118745, 28010.579841302806, 28901.855490722413, 21543.353699389045, 22433.214837481264, 22438.77561224432, 22467.550648987257, 22513.324600262018], "value": 14916.800843910269, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.5853892053421, 424.90864464140213, 426.71410155196014, 446.9217886869798, 453.65522203125613, 17393.217305221264, 18096.185671644776, 18118.90940545297, 19239.0, 19664.60670786587, 19085.61828763424, 19347.0, 19467.61064778707, 19496.317628882993, 19701.60596788067, 5277.208418737182, 5307.575393968483, 5415.83752487426, 5497.312835895513, 5534.916976245359, 5354.437784032679, 5435.130379139338, 5439.945600543983, 5450.482204190595, 5453.972730136364, 5201.193814958688, 5339.092354299759, 5394.406615272336, 5398.163284690879, 5409.404965453797, 5375.0593646111965, 5436.565074794027, 5446.264754258164, 5451.2640793492765, 5476.151196564499, 4874.585660218886, 4913.70517768935, 4920.507949205086, 4954.3063971044085, 4993.300937868701, 21625.45936351588, 21912.89043554772, 22048.11807527697, 22290.0, 22777.88611056934, 1597.8482044205782, 1611.4521062838692, 1650.1584192062014, 1650.7688923550713, 1659.1787065402582, 14691.706165876729, 16152.919235403866, 16804.66390672192, 16826.747598786027, 17072.914635426867, 2147.7744836792067, 2163.9242626508, 2228.6211344071385, 2247.685324054634, 2250.1561914282142, 84674.0, 89478.0, 96196.51901740517, 98864.0113598862, 99674.50162749212, 17860.28558857657, 18356.86970431642, 18366.816331836777, 18413.26346946134, 18424.263029478672, 35012.0, 35069.47395789065, 35074.0, 35181.64818351835, 35346.0, 9023.503707296162, 9092.27261819053, 9181.0, 9288.7677808054, 9432.90567094334, 7288.781336559911, 7318.853622927511, 7501.137369202612, 7518.210587888302, 7530.811729706801, 9062.410943288665, 9570.56932438042, 9753.268504862164, 9828.950855245677, 9888.901110988798, 3689.0777305673582, 3705.2404257127223, 3810.580836108026, 3827.1962887793875, 3830.5020347354666, 834.7287131682227, 874.9650013999369, 875.9211670949645, 876.6142897125244, 896.5427631907774, 16947.830521694872, 16987.74518382225, 17364.48831688117, 17478.91260543689, 18085.54786130331, 843.3211264931666, 864.1229152410309, 869.6564856881496, 876.8772371867943, 882.0870399136862, 9387.90612093884, 9600.183984361267, 9833.655822046194, 9840.114389704817, 9994.250431217688, 355648.0, 362946.0, 363742.0, 367372.0, 369277.0, 63461.0, 71189.0, 73168.26831731615, 75199.0, 81098.59450702826, 1013.6806905824642, 1018.607835983137, 1051.2641151194196, 1057.3497299161115, 1058.3332500524775, 17338.826611734225, 17654.73517897207, 18173.54566135857, 18212.817871821113, 18262.543436414195, 38896.222075557765, 39239.41140882946, 39881.999999998836, 40278.19443611053, 40746.79626601848, 47467.52532474631, 47576.286355704, 48920.5107948916, 49727.25409118794, 50200.748996254784, 11033.172512061466, 11216.195951012247, 11220.495077721358, 11314.886851131383, 11692.532298707956, 12231.755364892475, 12412.441440135397, 12505.874941250471, 12645.93677031609, 12712.427940742873, 9745.22038236925, 9959.751006224902, 9987.350822196535, 10644.680659580225, 10948.45257737126, 8837.160469755363, 8841.55792210374, 9072.863907041268, 9138.954305228432, 9215.907840921505, 9219.539023048956, 9400.576974036048, 9587.952060239653, 9700.27247956392, 10636.468176591294, 10964.616238431616, 11104.888951110708, 11260.887391125983, 11308.264962777394, 11646.0, 9953.651622193189, 10059.547320370748, 10133.695989120339, 10230.0, 10261.17910567138], "value": 9598.108980480763, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1282.8909542688873, 1317.4203350525768, 1329.7340531893624, 1338.2840180503433, 1339.0492750147396, 10146.0, 10572.312799668025, 10584.312019718713, 10713.303635263723, 10979.890201097987, 10705.518251678674, 10815.080718138948, 10837.6748697539, 10857.619983300587, 10875.673729788119, 2225.2434172381386, 2259.4012586664467, 2266.3654176830432, 2270.6594010898334, 2275.1923067311113, 2179.6185667508203, 2200.262911924507, 2219.1678120704737, 2221.7778222177735, 2236.686863839064, 2165.4261620670536, 2201.7798220178015, 2202.515446601745, 2215.523662412581, 2220.3782940776528, 2098.412444515538, 2114.746230452348, 2117.502386939068, 2124.7344081989672, 2124.734408198975, 1833.9358122465649, 1900.790912999569, 2037.2767667478129, 2076.968845467319, 2106.252280440452, 10504.789904201949, 10597.364158150458, 10597.576096956112, 10607.416592087433, 10634.627788027381, 5485.835424937219, 5667.744951477193, 5695.7152142392715, 5699.2306038684665, 5714.285714285715, 3048.527478240876, 3160.4153231652217, 3201.9199520011953, 3202.96797032029, 3207.182168547029, 987.3631507677579, 996.9700908972742, 1001.2790790630734, 1002.6991902429315, 1026.0867827633413, 15276.77084843717, 15327.923360383238, 15362.769558456632, 15385.769213461806, 15500.767488487681, 4799.472058073609, 4860.3681521401995, 4901.1913034349645, 4956.157453232959, 4996.350474438373, 11542.422878856023, 11544.19190656646, 11544.538218471167, 11561.595344162914, 11562.76874462506, 5557.166425036277, 5726.398728133569, 5730.997075511768, 5733.913991290134, 5741.598088133791, 5202.063628546898, 5228.869278268074, 5229.895402091937, 5244.396894357122, 5253.921191182136, 3773.0, 3849.480320156743, 3861.768293902319, 3889.105505733697, 3956.8615098471414, 1155.9768804623861, 1165.1901928160016, 1178.9056875449944, 1192.0344520938067, 1198.2570806100273, 701.7333413302912, 705.5555000349747, 707.1937990690617, 715.2847152847153, 729.835911720815, 5484.7531861066345, 5495.0, 5542.473465020817, 5567.860803479945, 5587.972060139673, 541.3098299667955, 558.9860253493695, 559.5663360895338, 562.0192763627496, 562.7692646015196, 3486.6164721880573, 3563.394222982099, 3669.486271921933, 3697.4638677392168, 3832.7961422182357, 13324.866751332556, 14000.789988150185, 14112.788308175386, 14232.146071235758, 14296.857031429761, 13826.930865345608, 14250.216238106796, 14272.85727142736, 14365.569032929028, 14379.209143497208, 7474.70101195957, 7503.5497870127965, 7707.961460192663, 7723.382129429745, 7758.14660387357, 5878.706064696663, 6033.366496517802, 6073.271207455134, 6392.169018027626, 6396.648184349905, 12430.005599552194, 12551.497940082294, 12617.873821262037, 12750.489980401051, 12915.677108072374, 12781.04142189358, 12881.871181288441, 12916.22502649844, 12931.0, 13114.409851556513, 8829.278290733246, 8862.734117976472, 8938.4190027648, 9008.0, 9015.0, 9798.51007449639, 9885.060919212663, 9904.653337133454, 9951.0, 9953.651622193189, 8161.0, 8377.204165604258, 8431.831363372821, 8475.618597163018, 8591.269742071994, 8195.385346098947, 8438.451500652438, 8452.873206902024, 8540.658373665232, 8651.394402391772, 6678.065070890177, 6782.0, 6812.65936703153, 6828.658567071528, 6832.248452670103, 4575.3823233863, 5246.108161612611, 5270.578353731769, 5411.0, 5466.699331536804, 5418.322709661293, 5428.511433970962, 5466.562674985912, 5525.033119204043, 5548.55611551083], "value": 4753.199751495134, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.3914334922497, 388.41737393909136, 392.5956265047001, 394.0, 395.2293028594242, 5404.810831620894, 5509.209506910255, 5554.222408862757, 5572.359178694446, 5589.8602534936645, 5305.0, 5448.182772584114, 5454.400015998237, 5455.809046683366, 5459.863503412416, 3988.940165897514, 4123.195976784528, 4134.6692264618905, 4155.085881106152, 4165.854195103165, 4121.031557583965, 4131.111810960643, 4136.234796562646, 4140.730852494593, 4154.854580089697, 4105.979470102645, 4116.732412393199, 4116.732412393199, 4118.608732170439, 4121.5466298707115, 4055.1281474483126, 4106.958930410718, 4111.814968326403, 4113.5269444013875, 4131.29767939451, 3630.7821530708243, 3633.6729694327637, 3640.872569460056, 3645.6354364563595, 3646.08847788053, 5281.762320695578, 5291.126964050965, 5296.205569164617, 5305.44292849253, 5310.283111779899, 4774.665773395864, 4814.0, 4830.661853670244, 4853.417589889201, 4901.754912254373, 5759.481646651821, 5760.567957403212, 5768.336641286264, 5770.855728606776, 5777.740001699934, 4048.4332193492933, 4065.7763822989723, 4078.3498768601935, 4082.183563287325, 4086.856960006415, 5851.268591426072, 6087.604305720114, 6112.027182331476, 6145.754169833157, 6172.8888800015975, 4165.791710414467, 4178.8537401190815, 4204.600562946515, 4204.747715137101, 4222.261104306734, 4234.661227101825, 4237.660987121023, 4241.321388577812, 4245.660347172219, 4262.616364527207, 4746.43042834862, 4830.8792280193275, 4862.635302352338, 4862.902741945141, 4886.926696099561, 5803.970980145156, 5810.385326602961, 5842.707864606753, 5853.209816674695, 5858.443447872445, 1443.631873872156, 1463.9121652700871, 1470.6029372069481, 1470.6764511807385, 1471.4408524760522, 967.8064387122604, 976.8339382305026, 978.9657361992296, 985.093713783321, 988.1008282462924, 4966.726830024383, 5015.423226328946, 5019.67372120811, 5026.648134630541, 5047.495250474996, 5997.340292567814, 6000.819975400657, 6022.488088512526, 6039.275286965592, 6040.909386359208, 4773.212419950669, 4948.70307781527, 4979.377577802775, 4986.850394488171, 5007.84976450707, 3164.4304025275674, 3186.85659145339, 3196.7602429817393, 3198.9040328789706, 3199.360127974368, 5478.424765399655, 5584.888302233932, 5589.888202235932, 5594.832155035356, 5603.859903502445, 5997.610155339889, 6145.66198859067, 6166.506679465632, 6193.969030154821, 6196.132541444202, 5529.502344788908, 5554.222408862763, 5581.134924086773, 5581.6930068846605, 5591.888162236733, 5968.641881487125, 5981.983062879234, 5985.311689155803, 6044.486218671462, 6047.637141771332, 5634.352049514358, 5830.737616807339, 5913.05391137416, 5945.31628862669, 5949.25634295713, 5522.5858060644805, 5565.888682226252, 5597.80407685729, 5599.0, 5619.353774315842, 4080.285949958686, 4158.625723684762, 4169.207850508394, 4176.979115104405, 4185.97907010463, 5976.7908123215475, 6009.729562169626, 6014.398560143951, 6047.425494578008, 6058.969705151446, 5766.942330576809, 5823.7670493181495, 5837.532997360286, 5850.707464626837, 5864.44287792659, 5663.0, 5781.24843770324, 5803.506701930383, 5803.622764520293, 5809.8547536311935, 5724.198612194379, 5746.942530574808, 5753.942460575508, 5761.683107429131, 5769.134629805395, 5777.162311464898, 5850.327212370632, 5857.58996870215, 5867.413258674099, 5912.320083190316, 5643.88712225745, 5695.8860822784145, 5704.3154821421695, 5711.5150060983615, 5728.971355143198], "value": 4345.104871953294, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.1973468653853, 744.2185705009739, 763.6296396247819, 764.5336344829657, 773.7523992322456, 11716.472758725857, 12131.15081944262, 12913.741725165492, 13785.655358616026, 13807.240601766898, 15084.622884427894, 15493.767593486107, 15611.297491612877, 15617.21913904306, 15662.0, 875.1511034296722, 900.2617853360247, 905.2124651553158, 907.874235947427, 909.0545832334365, 905.4522014181424, 909.6634245329237, 911.2118017914522, 912.7170577121113, 913.0732306708696, 945.5792172483248, 946.2808265718035, 946.7538440005613, 947.7962238118803, 948.8481842905137, 931.9114684104999, 932.911373419524, 941.0166376136954, 942.0014784328633, 942.3968660057569, 671.2046225223127, 680.7515256931234, 699.7655785311927, 700.1807884774826, 700.6251655364356, 14749.115053096848, 14772.409103635842, 14892.851071489255, 14911.478098266618, 14990.700185996218, 15613.375464981387, 16470.42353517633, 16595.91702041482, 16612.169391530377, 16635.584110397216, 12726.490940362375, 12931.482740690455, 12947.41736621845, 13091.34543272842, 13150.868491315061, 2839.687634360219, 2867.555528893025, 2868.5553739170255, 2869.0962346860674, 2883.5818806273182, 77808.61095694486, 79163.0, 80222.59888700578, 80529.59735201286, 81221.59389203135, 9849.803003939882, 9951.502424878727, 9990.750231244278, 10055.547500362502, 10085.445300508543, 18147.274109035756, 18201.45395638133, 18304.908475457538, 18520.722189167172, 18639.906800466182, 5943.049112142036, 5979.073243647242, 5989.460948514655, 6034.125051867454, 6042.697865106815, 2952.5423559348337, 3004.4742170120144, 3021.957424688479, 3038.5745995560637, 3044.4367791958557, 3146.2606287522412, 3205.006448001127, 3207.3905957868396, 3216.7748257621743, 3220.162757683019, 658.5850913924197, 672.6031641331638, 744.2483092076933, 797.7686470923484, 802.2498963469175, 601.8134378342728, 611.4802417944711, 613.7698363113832, 615.8306465721872, 634.6033728919425, 9845.50772461374, 10208.132308753839, 10503.159747220205, 10547.0, 10826.891731082746, 593.7476572456775, 594.5392320951297, 607.2227548737623, 609.2262826210688, 609.8810731907236, 4383.7588932609015, 4567.862964111016, 4572.679912406166, 4573.748443835554, 4591.4260717410325, 85813.57093214494, 87406.12593874107, 88897.0, 89584.55207723919, 89624.5518772402, 79846.60076699695, 80074.59962700149, 80147.59926200332, 81343.59328203321, 81914.0, 61227.08159377613, 61428.69285653543, 63481.68259158767, 66986.66506667533, 67766.66116669483, 10033.397996120257, 10463.529141188512, 10609.522571484147, 10650.627228046982, 10733.892661073289, 29217.0, 29284.707152928197, 29637.703622964356, 29825.70174298316, 30340.848295759264, 35486.0, 35703.464448032784, 35749.821250893576, 36555.0, 36763.26473470462, 13535.661608459868, 13947.58157255284, 14063.296835158406, 14103.717925641635, 14281.64295892611, 16285.755713664541, 16350.427735029218, 16557.58606034859, 16718.0, 16860.241289142265, 14772.18752968597, 14955.775663365275, 15210.08739475635, 15272.770908436605, 15430.459933902259, 14382.712345753236, 14682.486112985995, 14690.0, 14769.556913292618, 15112.848871511143, 14605.561833145022, 14703.55889323322, 14811.481598144013, 14880.702385952003, 15496.0, 10895.618653347095, 10977.28647637933, 11228.270162439741, 11437.370944598128, 11826.940865295619, 10980.890191097988, 11560.42197890119, 11969.281843089442, 12149.757004859677, 12184.086193535342], "value": 7077.693696563268, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 112.0, 113.0, 111.0, 112.0, 113.0, 112.0, 111.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 123.0, 125.0, 180.0, 122.0, 128.0, 127.0, 124.0, 146.0, 124.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 165.0, 171.0, 168.0, 169.0, 163.0, 165.0, 163.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 118.0, 75.0, 74.0, 76.0, 74.0, 97.0, 74.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 109.0, 83.0, 85.0, 83.0, 111.0, 83.0, 84.0, 106.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 115.0, 114.0, 115.0, 114.0, 115.0, 118.0, 119.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 150.0, 151.0, 150.0, 150.0, 151.0, 151.0, 151.0, 151.0, 152.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 58.0, 58.0, 56.0, 54.0, 55.0, 57.0, 55.0, 61.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 58.0, 55.0, 63.0, 56.0, 56.0, 56.0, 57.0, 55.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 88.0, 86.0, 97.0, 86.0, 89.0, 91.0, 88.0, 129.0, 90.0], "value": 94.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 138.0, 152.0, 131.0, 129.0, 134.0, 141.0, 134.0, 148.0, 131.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 196.0, 198.0, 198.0, 200.0, 192.0, 194.0, 195.0, 197.0, 200.0], "value": 196.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 72.0, 73.0, 76.0, 78.0, 74.0, 71.0, 74.0, 74.0], "value": 74.6, "unit": "score"}]}]} 03:20:31 INFO - Return code: 0 03:20:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:20:31 INFO - # TBPL SUCCESS # 03:20:31 INFO - Running post-action listener: _resource_record_post_action 03:20:31 INFO - [mozharness: 2017-05-26 10:20:31.313029Z] Finished run-tests step (success) 03:20:31 INFO - Running post-run listener: _resource_record_post_run 03:20:31 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 4096; Write bytes: 408326144; Read time: 16; Write time: 238556 03:20:31 INFO - TinderboxPrint: CPU usage
12.7% 03:20:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:20:31 INFO - TinderboxPrint: I/O write bytes / time
408,326,144 / 238,556 03:20:31 INFO - TinderboxPrint: CPU idle
8,750.5 (87.3%) 03:20:31 INFO - TinderboxPrint: CPU user
1,221.5 (12.2%) 03:20:31 INFO - TinderboxPrint: Swap in / out
0 / 0 03:20:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99340288; Read time: 0; Write time: 59760 03:20:31 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 0; Write bytes: 308985856; Read time: 0; Write time: 178796 03:20:31 INFO - Running post-run listener: _upload_blobber_files 03:20:31 INFO - Blob upload gear active. 03:20:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:20:31 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 03:20:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:20:32 INFO - (blobuploader) - INFO - Open directory for files ... 03:20:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:20:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:20:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:33 INFO - (blobuploader) - INFO - Done attempting. 03:20:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:20:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:20:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:36 INFO - (blobuploader) - INFO - Done attempting. 03:20:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:20:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:20:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:37 INFO - (blobuploader) - INFO - Done attempting. 03:20:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:20:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:20:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:37 INFO - (blobuploader) - INFO - Done attempting. 03:20:37 INFO - (blobuploader) - INFO - Iteration through files over. 03:20:38 INFO - Return code: 0 03:20:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:20:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:20:38 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0cd0c48bdb36d80c4e371694071242b3bb58292e7b3bcce0d5f214e3c3ae514132a230057e7142801e89c60848a1581dc01d4a9c4b34f888bf068a00bde01da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c51849be881ccb41659f2f872a339d7f6e90acb00893eaa905de2c860ec3fe39406b8b071428bd442333e659750a74ececd394f9ba6fac110140618dcda87e4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f90d8a3e68b5eef360c639480f027e15103fcd1513e0e5123db22039c3ba2d857ac29396c0f8a70d04433aa16cf6add2bafbe6866e46ec560df08daa623a420", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea586d20df4acf27cccdc80d944ef6fcd12021116b3e7acc2495d46e92409da25053489836f856ad680bc3e0e613132f5a653e151af35d9a57827e4204f33376"} 03:20:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:20:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:20:38 INFO - Contents: 03:20:38 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0cd0c48bdb36d80c4e371694071242b3bb58292e7b3bcce0d5f214e3c3ae514132a230057e7142801e89c60848a1581dc01d4a9c4b34f888bf068a00bde01da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c51849be881ccb41659f2f872a339d7f6e90acb00893eaa905de2c860ec3fe39406b8b071428bd442333e659750a74ececd394f9ba6fac110140618dcda87e4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f90d8a3e68b5eef360c639480f027e15103fcd1513e0e5123db22039c3ba2d857ac29396c0f8a70d04433aa16cf6add2bafbe6866e46ec560df08daa623a420", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea586d20df4acf27cccdc80d944ef6fcd12021116b3e7acc2495d46e92409da25053489836f856ad680bc3e0e613132f5a653e151af35d9a57827e4204f33376"} 03:20:38 INFO - Running post-run listener: copy_logs_to_upload_dir 03:20:38 INFO - Copying logs to upload dir... 03:20:38 INFO - mkdir: /builds/slave/test/build/upload/logs 03:20:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1313.753788 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2017-05-26 03:20:37.267112) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 03:20:37.271293) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719 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/sha512/d0cd0c48bdb36d80c4e371694071242b3bb58292e7b3bcce0d5f214e3c3ae514132a230057e7142801e89c60848a1581dc01d4a9c4b34f888bf068a00bde01da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c51849be881ccb41659f2f872a339d7f6e90acb00893eaa905de2c860ec3fe39406b8b071428bd442333e659750a74ececd394f9ba6fac110140618dcda87e4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f90d8a3e68b5eef360c639480f027e15103fcd1513e0e5123db22039c3ba2d857ac29396c0f8a70d04433aa16cf6add2bafbe6866e46ec560df08daa623a420", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea586d20df4acf27cccdc80d944ef6fcd12021116b3e7acc2495d46e92409da25053489836f856ad680bc3e0e613132f5a653e151af35d9a57827e4204f33376"} build_url:https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/NFuEOrIaQwe1ljVu4fod9g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0cd0c48bdb36d80c4e371694071242b3bb58292e7b3bcce0d5f214e3c3ae514132a230057e7142801e89c60848a1581dc01d4a9c4b34f888bf068a00bde01da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c51849be881ccb41659f2f872a339d7f6e90acb00893eaa905de2c860ec3fe39406b8b071428bd442333e659750a74ececd394f9ba6fac110140618dcda87e4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f90d8a3e68b5eef360c639480f027e15103fcd1513e0e5123db22039c3ba2d857ac29396c0f8a70d04433aa16cf6add2bafbe6866e46ec560df08daa623a420", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea586d20df4acf27cccdc80d944ef6fcd12021116b3e7acc2495d46e92409da25053489836f856ad680bc3e0e613132f5a653e151af35d9a57827e4204f33376"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 03:20:37.298194) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 03:20:37.298487) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1495792721.591444-2062545719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004622 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 03:20:37.379377) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 03:20:37.379658) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 03:20:37.382939) ========= ========= Total master_lag: 0.24 =========