builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1495765118.87 results: success (0) revision: 0874cf4bb194d381a3afaa51276b6cee22f82211 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:38.866905) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:38.867353) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:38.867635) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:38.884505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:38.884824) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-25 19:18:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-05-25 19:18:39 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.326531 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:39.251027) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:39.251505) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018133 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:39.304311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-25 19:18:39.305140) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0874cf4bb194d381a3afaa51276b6cee22f82211 --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 0874cf4bb194d381a3afaa51276b6cee22f82211 --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=97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-25 19:18:39,548 truncating revision to first 12 chars 2017-05-25 19:18:39,548 Setting DEBUG logging. 2017-05-25 19:18:39,548 attempt 1/10 2017-05-25 19:18:39,548 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0874cf4bb194?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-25 19:18:40,582 unpacking tar archive at: mozilla-central-0874cf4bb194/testing/mozharness/ program finished with exit code 0 elapsedTime=1.344537 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-25 19:18:40.664098) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:40.664628) ========= script_repo_revision: 0874cf4bb194d381a3afaa51276b6cee22f82211 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:40.665258) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:40.665732) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:40.676408) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 13 secs) (at 2017-05-25 19:18:40.677028) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:18:41 INFO - MultiFileLogger online at 20170525 19:18:41 in /builds/slave/test 19:18:41 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 19:18:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:18:41 INFO - {'append_to_log': False, 19:18:41 INFO - 'base_work_dir': '/builds/slave/test', 19:18:41 INFO - 'blob_upload_branch': 'Firefox', 19:18:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:18:41 INFO - 'branch': 'Firefox', 19:18:41 INFO - 'buildbot_json_path': 'buildprops.json', 19:18:41 INFO - 'config_files': ('talos/linux_config.py',), 19:18:41 INFO - 'default_actions': ('clobber', 19:18:41 INFO - 'read-buildbot-config', 19:18:41 INFO - 'download-and-extract', 19:18:41 INFO - 'populate-webroot', 19:18:41 INFO - 'create-virtualenv', 19:18:41 INFO - 'install', 19:18:41 INFO - 'run-tests'), 19:18:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:18:41 INFO - 'download_minidump_stackwalk': True, 19:18:41 INFO - 'download_symbols': 'ondemand', 19:18:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:18:41 INFO - 'tooltool.py': '/tools/tooltool.py', 19:18:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:18:41 INFO - '/tools/misc-python/virtualenv.py')}, 19:18:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:18:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:18:41 INFO - 'gecko_profile': False, 19:18:41 INFO - 'gecko_profile_interval': 0, 19:18:41 INFO - 'installer_path': 'installer.exe', 19:18:41 INFO - 'log_level': 'info', 19:18:41 INFO - 'log_name': 'talos', 19:18:41 INFO - 'log_to_console': True, 19:18:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:18:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:18:41 INFO - 'opt_config_files': (), 19:18:41 INFO - 'pip_index': False, 19:18:41 INFO - 'suite': 'dromaeojs-e10s', 19:18:41 INFO - 'system_bits': '32', 19:18:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:18:41 INFO - 'title': 'talos-linux64-ix-068', 19:18:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:18:41 INFO - 'use_talos_json': True, 19:18:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:18:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:18:41 INFO - 'work_dir': 'build'} 19:18:41 INFO - [mozharness: 2017-05-26 02:18:41.139736Z] Running clobber step. 19:18:41 INFO - Running pre-action listener: _resource_record_pre_action 19:18:41 INFO - Running main action method: clobber 19:18:41 INFO - rmtree: /builds/slave/test/build 19:18:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:18:42 INFO - Running post-action listener: _resource_record_post_action 19:18:42 INFO - [mozharness: 2017-05-26 02:18:42.118844Z] Finished clobber step (success) 19:18:42 INFO - [mozharness: 2017-05-26 02:18:42.118945Z] Running read-buildbot-config step. 19:18:42 INFO - Running pre-action listener: _resource_record_pre_action 19:18:42 INFO - Running main action method: read_buildbot_config 19:18:42 INFO - Using buildbot properties: 19:18:42 INFO - { 19:18:42 INFO - "project": "", 19:18:42 INFO - "product": "firefox", 19:18:42 INFO - "who": "ryanvm@gmail.com", 19:18:42 INFO - "installer_path": "public/build/target.tar.bz2", 19:18:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 19:18:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 19:18:42 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 19:18:42 INFO - "stage_platform": "linux64-stylosequential", 19:18:42 INFO - "basedir": "/builds/slave/test", 19:18:42 INFO - "buildnumber": 19, 19:18:42 INFO - "platform": "ubuntu64_hw_styloseq", 19:18:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:18:42 INFO - "slavebuilddir": "test", 19:18:42 INFO - "taskId": "FN36vtPsTH-cfoWCxIVxKQ", 19:18:42 INFO - "branch": "mozilla-central", 19:18:42 INFO - "script_repo_revision": "production", 19:18:42 INFO - "revision": "0874cf4bb194d381a3afaa51276b6cee22f82211", 19:18:42 INFO - "slavename": "talos-linux64-ix-068", 19:18:42 INFO - "repo_path": "mozilla-central" 19:18:42 INFO - } 19:18:42 INFO - Finding installer, test and symbols from parent task. 19:18:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FN36vtPsTH-cfoWCxIVxKQ'}, attempt #1 19:18:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FN36vtPsTH-cfoWCxIVxKQ'}, attempt #1 19:18:50 INFO - Task dependencies: Jpw0YMk3QZ2w6sRLR3PrOw 19:18:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw'}, attempt #1 19:18:50 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.tar.bz2 19:18:50 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/test_packages.json 19:18:50 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.crashreporter-symbols.zip 19:18:50 INFO - Running post-action listener: _resource_record_post_action 19:18:50 INFO - [mozharness: 2017-05-26 02:18:50.970276Z] Finished read-buildbot-config step (success) 19:18:50 INFO - [mozharness: 2017-05-26 02:18:50.970502Z] Running download-and-extract step. 19:18:50 INFO - Running pre-action listener: _resource_record_pre_action 19:18:50 INFO - Running main action method: download_and_extract 19:18:50 INFO - mkdir: /builds/slave/test/build/tests 19:18: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')]} 19:18:50 INFO - trying https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.test_packages.json 19:18:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:18:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:18:51 INFO - Downloaded 986 bytes. 19:18:51 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:18:51 INFO - Using the following test package requirements: 19:18:51 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:18:51 INFO - u'common': [u'target.common.tests.zip'], 19:18:51 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:18:51 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:18:51 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:18:51 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:18:51 INFO - u'mozbase': [u'target.common.tests.zip'], 19:18:51 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:18:51 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:18:51 INFO - u'web-platform': [u'target.common.tests.zip', 19:18:51 INFO - u'target.web-platform.tests.zip'], 19:18:51 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:18:51 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:18:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.common.tests.zip 19:18:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:18:51 INFO - Fetch https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.common.tests.zip into memory 19:18:52 INFO - Content-Length response header: 63525237 19:18:52 INFO - Bytes received: 63525237 19:19:03 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:19:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.common.tests.zip 19:19:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:19:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.common.tests.zip into memory 19:19:05 INFO - Content-Length response header: 63525237 19:19:05 INFO - Bytes received: 63525237 19:19:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.talos.tests.zip 19:19:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:19:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.talos.tests.zip into memory 19:19:21 INFO - Content-Length response header: 14411888 19:19:21 INFO - Bytes received: 14411888 19:19: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')]} 19:19:21 INFO - trying https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.tar.bz2 19:19:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:19:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:19:22 INFO - Downloaded 55709306 bytes. 19:19:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.tar.bz2 19:19:22 INFO - mkdir: /builds/slave/test/properties 19:19:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:19:22 INFO - Writing to file /builds/slave/test/properties/build_url 19:19:22 INFO - Contents: 19:19:22 INFO - build_url:https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.tar.bz2 19:19:22 INFO - Running post-action listener: _resource_record_post_action 19:19:22 INFO - Running post-action listener: set_extra_try_arguments 19:19:22 INFO - [mozharness: 2017-05-26 02:19:22.314369Z] Finished download-and-extract step (success) 19:19:22 INFO - [mozharness: 2017-05-26 02:19:22.314466Z] Running populate-webroot step. 19:19:22 INFO - Running pre-action listener: _resource_record_pre_action 19:19:22 INFO - Running main action method: populate_webroot 19:19:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:19:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:19:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:19:22 INFO - '--tppagecycles', 19:19:22 INFO - '7'], 19:19:22 INFO - 'tests': ['tsvgm']}}, 19:19:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:19:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:19:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:19:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:19:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:19:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:19:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:19:22 INFO - 'talos_options': ['--disable-e10s'], 19:19:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:19:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:19:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:19:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:19:22 INFO - 'talos_options': ['--disable-e10s'], 19:19:22 INFO - 'tests': ['damp', 'tps']}, 19:19:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:19:22 INFO - 'tests': ['damp', 'tps']}, 19:19:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:19:22 INFO - 'tests': ['dromaeo_dom']}, 19:19:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:19:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:19:22 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 19:19:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:19:22 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:19:22 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:19:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:19:22 INFO - 'tests': ['a11yr', 19:19:22 INFO - 'ts_paint', 19:19:22 INFO - 'tpaint', 19:19:22 INFO - 'sessionrestore', 19:19:22 INFO - 'sessionrestore_no_auto_restore', 19:19:22 INFO - 'tabpaint']}, 19:19:22 INFO - 'other-e10s': {'tests': ['a11yr', 19:19:22 INFO - 'ts_paint', 19:19:22 INFO - 'tpaint', 19:19:22 INFO - 'sessionrestore', 19:19:22 INFO - 'sessionrestore_no_auto_restore', 19:19:22 INFO - 'tabpaint']}, 19:19:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:19:22 INFO - 'ts_paint', 19:19:22 INFO - 'tpaint', 19:19:22 INFO - 'sessionrestore', 19:19:22 INFO - 'sessionrestore_no_auto_restore', 19:19:22 INFO - 'tabpaint']}, 19:19:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:19:22 INFO - 'ts_paint', 19:19:22 INFO - 'tpaint', 19:19:22 INFO - 'sessionrestore', 19:19:22 INFO - 'sessionrestore_no_auto_restore', 19:19:22 INFO - 'tabpaint']}, 19:19:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:19:22 INFO - 'tests': ['a11yr', 19:19:22 INFO - 'ts_paint', 19:19:22 INFO - 'tpaint', 19:19:22 INFO - 'sessionrestore', 19:19:22 INFO - 'sessionrestore_no_auto_restore', 19:19:22 INFO - 'tabpaint']}, 19:19:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:19:22 INFO - 'tests': ['a11yr', 19:19:22 INFO - 'ts_paint', 19:19:22 INFO - 'tpaint', 19:19:22 INFO - 'sessionrestore', 19:19:22 INFO - 'sessionrestore_no_auto_restore', 19:19:22 INFO - 'tabpaint']}, 19:19:22 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 19:19:22 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 19:19:22 INFO - 'bloom_basic_ref']}, 19:19:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:19:22 INFO - 'tests': ['tsvgx', 19:19:22 INFO - 'tsvgr_opacity', 19:19:22 INFO - 'tart', 19:19:22 INFO - 'tscrollx', 19:19:22 INFO - 'cart', 19:19:22 INFO - 'tsvg_static']}, 19:19:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:19:22 INFO - 'tsvgr_opacity', 19:19:22 INFO - 'tart', 19:19:22 INFO - 'tscrollx', 19:19:22 INFO - 'cart', 19:19:22 INFO - 'tsvg_static']}, 19:19:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:19:22 INFO - 'talos_options': ['--disable-e10s'], 19:19:22 INFO - 'tests': ['tp5o']}, 19:19:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:19:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:19:22 INFO - 'talos_options': ['--disable-e10s', 19:19:22 INFO - '--xperf_path', 19:19:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:19:22 INFO - 'tests': ['tp5n']}, 19:19:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:19:22 INFO - 'talos_options': ['--xperf_path', 19:19:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:19:22 INFO - 'tests': ['tp5n']}}, 19:19:22 INFO - 'talos.zip': {'path': '', 19:19:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:19:22 INFO - Running post-action listener: _resource_record_post_action 19:19:22 INFO - [mozharness: 2017-05-26 02:19:22.328506Z] Finished populate-webroot step (success) 19:19:22 INFO - [mozharness: 2017-05-26 02:19:22.328594Z] Running create-virtualenv step. 19:19:22 INFO - Running pre-action listener: _resource_record_pre_action 19:19:22 INFO - Running main action method: create_virtualenv 19:19:22 INFO - Creating virtualenv /builds/slave/test/build/venv 19:19:22 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 19:19:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:19:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:19:22 INFO - Using real prefix '/usr' 19:19:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:19:23 INFO - Installing distribute.............................................................................................................................................................................................done. 19:19:25 INFO - Installing pip.................done. 19:19:25 INFO - Return code: 0 19:19:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:19:25 INFO - Reading from file tmpfile_stdout 19:19:25 INFO - Output received: 19:19:25 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) 19:19:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:25 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 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16195c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16167a0>, '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 0x16176a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617b30>, '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': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', '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 19:19:25 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 19:19:25 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 19:19:25 INFO - Using env: {'DISPLAY': ':0', 19:19:25 INFO - 'HOME': '/home/cltbld', 19:19:25 INFO - 'LANG': 'en_US.UTF-8', 19:19:25 INFO - 'LANGUAGE': 'en_US:en', 19:19:25 INFO - 'LOGNAME': 'cltbld', 19:19:25 INFO - 'MAIL': '/var/mail/cltbld', 19:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:25 INFO - 'MOZ_NO_REMOTE': '1', 19:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:25 INFO - 'NO_EM_RESTART': '1', 19:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:25 INFO - 'PWD': '/builds/slave/test', 19:19:25 INFO - 'SHELL': '/bin/bash', 19:19:25 INFO - 'SHLVL': '1', 19:19:25 INFO - 'TERM': 'linux', 19:19:25 INFO - 'TMOUT': '86400', 19:19:25 INFO - 'USER': 'cltbld', 19:19:25 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', 19:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:25 INFO - '_': '/tools/buildbot/bin/python'} 19:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:25 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 19:19:25 INFO - Cleaning up... 19:19:25 INFO - Return code: 0 19:19:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:25 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 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16195c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16167a0>, '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 0x16176a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617b30>, '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': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', '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 19:19:25 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 19:19:25 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 19:19:25 INFO - Using env: {'DISPLAY': ':0', 19:19:25 INFO - 'HOME': '/home/cltbld', 19:19:25 INFO - 'LANG': 'en_US.UTF-8', 19:19:25 INFO - 'LANGUAGE': 'en_US:en', 19:19:25 INFO - 'LOGNAME': 'cltbld', 19:19:25 INFO - 'MAIL': '/var/mail/cltbld', 19:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:25 INFO - 'MOZ_NO_REMOTE': '1', 19:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:25 INFO - 'NO_EM_RESTART': '1', 19:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:25 INFO - 'PWD': '/builds/slave/test', 19:19:25 INFO - 'SHELL': '/bin/bash', 19:19:25 INFO - 'SHLVL': '1', 19:19:25 INFO - 'TERM': 'linux', 19:19:25 INFO - 'TMOUT': '86400', 19:19:25 INFO - 'USER': 'cltbld', 19:19:25 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', 19:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:25 INFO - '_': '/tools/buildbot/bin/python'} 19:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:25 INFO - Downloading/unpacking psutil>=3.1.1 19:19: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 19:19: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 19:19: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 19:19: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 19:19:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:19:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:19:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:19:27 INFO - Installing collected packages: psutil 19:19:27 INFO - Running setup.py install for psutil 19:19:27 INFO - building 'psutil._psutil_linux' extension 19:19:27 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 19:19:28 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 19:19:28 INFO - building 'psutil._psutil_posix' extension 19:19:28 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 19:19:28 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 19:19:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:19:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:19:28 INFO - Successfully installed psutil 19:19:28 INFO - Cleaning up... 19:19:28 INFO - Return code: 0 19:19:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:28 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 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16195c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16167a0>, '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 0x16176a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617b30>, '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': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', '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 19:19:28 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 19:19:28 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 19:19:28 INFO - Using env: {'DISPLAY': ':0', 19:19:28 INFO - 'HOME': '/home/cltbld', 19:19:28 INFO - 'LANG': 'en_US.UTF-8', 19:19:28 INFO - 'LANGUAGE': 'en_US:en', 19:19:28 INFO - 'LOGNAME': 'cltbld', 19:19:28 INFO - 'MAIL': '/var/mail/cltbld', 19:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:28 INFO - 'MOZ_NO_REMOTE': '1', 19:19:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:28 INFO - 'NO_EM_RESTART': '1', 19:19:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:28 INFO - 'PWD': '/builds/slave/test', 19:19:28 INFO - 'SHELL': '/bin/bash', 19:19:28 INFO - 'SHLVL': '1', 19:19:28 INFO - 'TERM': 'linux', 19:19:28 INFO - 'TMOUT': '86400', 19:19:28 INFO - 'USER': 'cltbld', 19:19:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', 19:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:28 INFO - '_': '/tools/buildbot/bin/python'} 19:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:19:28 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 19:19:28 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 19:19:28 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 19:19:28 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 19:19:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:19:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:19:30 INFO - Installing collected packages: mozsystemmonitor 19:19:30 INFO - Running setup.py install for mozsystemmonitor 19:19:30 INFO - Successfully installed mozsystemmonitor 19:19:30 INFO - Cleaning up... 19:19:30 INFO - Return code: 0 19:19:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:19:30 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')]} 19:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:30 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')]} 19:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:30 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 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16195c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16167a0>, '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 0x16176a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617b30>, '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': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', '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 19:19:30 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 19:19:30 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 19:19:30 INFO - Using env: {'DISPLAY': ':0', 19:19:30 INFO - 'HOME': '/home/cltbld', 19:19:30 INFO - 'LANG': 'en_US.UTF-8', 19:19:30 INFO - 'LANGUAGE': 'en_US:en', 19:19:30 INFO - 'LOGNAME': 'cltbld', 19:19:30 INFO - 'MAIL': '/var/mail/cltbld', 19:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:30 INFO - 'MOZ_NO_REMOTE': '1', 19:19:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:30 INFO - 'NO_EM_RESTART': '1', 19:19:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:30 INFO - 'PWD': '/builds/slave/test', 19:19:30 INFO - 'SHELL': '/bin/bash', 19:19:30 INFO - 'SHLVL': '1', 19:19:30 INFO - 'TERM': 'linux', 19:19:30 INFO - 'TMOUT': '86400', 19:19:30 INFO - 'USER': 'cltbld', 19:19:30 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', 19:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:30 INFO - '_': '/tools/buildbot/bin/python'} 19:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:30 INFO - Downloading/unpacking jsonschema==2.5.1 19:19:30 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 19:19:30 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 19:19:30 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 19:19:30 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 19:19:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:19:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:19: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 19:19: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 19:19: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 19:19: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 19:19:31 INFO - Downloading functools32-3.2.3-2.tar.gz 19:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:19:31 INFO - warning: no files found matching '*.txt' 19:19:31 INFO - no previously-included directories found matching 'build' 19:19:31 INFO - no previously-included directories found matching 'dist' 19:19:31 INFO - no previously-included directories found matching '.git*' 19:19:31 INFO - Installing collected packages: jsonschema, functools32 19:19:31 INFO - Running setup.py install for functools32 19:19:31 INFO - warning: no files found matching '*.txt' 19:19:31 INFO - no previously-included directories found matching 'build' 19:19:31 INFO - no previously-included directories found matching 'dist' 19:19:31 INFO - no previously-included directories found matching '.git*' 19:19:31 INFO - Successfully installed jsonschema functools32 19:19:31 INFO - Cleaning up... 19:19:31 INFO - Return code: 0 19:19:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:19:31 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')]} 19:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:31 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')]} 19:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:31 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 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16195c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16167a0>, '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 0x16176a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617b30>, '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': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', '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 19:19:31 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 19:19:31 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 19:19:31 INFO - Using env: {'DISPLAY': ':0', 19:19:31 INFO - 'HOME': '/home/cltbld', 19:19:31 INFO - 'LANG': 'en_US.UTF-8', 19:19:31 INFO - 'LANGUAGE': 'en_US:en', 19:19:31 INFO - 'LOGNAME': 'cltbld', 19:19:31 INFO - 'MAIL': '/var/mail/cltbld', 19:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:31 INFO - 'MOZ_NO_REMOTE': '1', 19:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:31 INFO - 'NO_EM_RESTART': '1', 19:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:31 INFO - 'PWD': '/builds/slave/test', 19:19:31 INFO - 'SHELL': '/bin/bash', 19:19:31 INFO - 'SHLVL': '1', 19:19:31 INFO - 'TERM': 'linux', 19:19:31 INFO - 'TMOUT': '86400', 19:19:31 INFO - 'USER': 'cltbld', 19:19:31 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', 19:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:31 INFO - '_': '/tools/buildbot/bin/python'} 19:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:19:32 INFO - Cleaning up... 19:19:32 INFO - Return code: 0 19:19:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:19: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')]} 19:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19: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')]} 19:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:32 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 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16195c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16167a0>, '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 0x16176a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617b30>, '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': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', '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 19:19:32 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 19:19:32 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 19:19:32 INFO - Using env: {'DISPLAY': ':0', 19:19:32 INFO - 'HOME': '/home/cltbld', 19:19:32 INFO - 'LANG': 'en_US.UTF-8', 19:19:32 INFO - 'LANGUAGE': 'en_US:en', 19:19:32 INFO - 'LOGNAME': 'cltbld', 19:19:32 INFO - 'MAIL': '/var/mail/cltbld', 19:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:32 INFO - 'MOZ_NO_REMOTE': '1', 19:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:32 INFO - 'NO_EM_RESTART': '1', 19:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:32 INFO - 'PWD': '/builds/slave/test', 19:19:32 INFO - 'SHELL': '/bin/bash', 19:19:32 INFO - 'SHLVL': '1', 19:19:32 INFO - 'TERM': 'linux', 19:19:32 INFO - 'TMOUT': '86400', 19:19:32 INFO - 'USER': 'cltbld', 19:19:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', 19:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:32 INFO - '_': '/tools/buildbot/bin/python'} 19:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:32 INFO - Downloading/unpacking blobuploader==1.2.4 19:19: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 19:19: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 19:19: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 19:19: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 19:19:33 INFO - Downloading blobuploader-1.2.4.tar.gz 19:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:19:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:19:33 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 19:19:33 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 19:19:33 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 19:19:33 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 19:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:19:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:19:33 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 19:19:33 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 19:19:33 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 19:19:33 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 19:19:33 INFO - Downloading docopt-0.6.1.tar.gz 19:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:19:34 INFO - Installing collected packages: blobuploader, requests, docopt 19:19:34 INFO - Running setup.py install for blobuploader 19:19:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:19:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:19:34 INFO - Running setup.py install for requests 19:19:34 INFO - Running setup.py install for docopt 19:19:34 INFO - Successfully installed blobuploader requests docopt 19:19:34 INFO - Cleaning up... 19:19:34 INFO - Return code: 0 19:19:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:19: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')]} 19:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19: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')]} 19:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:34 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 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16195c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16167a0>, '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 0x16176a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617b30>, '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': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', '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 19:19:34 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 19:19:34 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 19:19:34 INFO - Using env: {'DISPLAY': ':0', 19:19:34 INFO - 'HOME': '/home/cltbld', 19:19:34 INFO - 'LANG': 'en_US.UTF-8', 19:19:34 INFO - 'LANGUAGE': 'en_US:en', 19:19:34 INFO - 'LOGNAME': 'cltbld', 19:19:34 INFO - 'MAIL': '/var/mail/cltbld', 19:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:34 INFO - 'MOZ_NO_REMOTE': '1', 19:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:34 INFO - 'NO_EM_RESTART': '1', 19:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:34 INFO - 'PWD': '/builds/slave/test', 19:19:34 INFO - 'SHELL': '/bin/bash', 19:19:34 INFO - 'SHLVL': '1', 19:19:34 INFO - 'TERM': 'linux', 19:19:34 INFO - 'TMOUT': '86400', 19:19:34 INFO - 'USER': 'cltbld', 19:19:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', 19:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:34 INFO - '_': '/tools/buildbot/bin/python'} 19:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:19:34 INFO - Running setup.py (path:/tmp/pip-brGQE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:19:34 INFO - Running setup.py (path:/tmp/pip-ehd0QH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:19:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:19:34 INFO - Running setup.py (path:/tmp/pip-HZWxSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:19:35 INFO - Running setup.py (path:/tmp/pip-KXx39i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:19:35 INFO - Running setup.py (path:/tmp/pip-kEuSqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:19:35 INFO - Running setup.py (path:/tmp/pip-QjgM8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:19:35 INFO - Running setup.py (path:/tmp/pip-Syg9DT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:19:35 INFO - Running setup.py (path:/tmp/pip-Eqxg37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:19:35 INFO - Running setup.py (path:/tmp/pip-Ji9IVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:19:35 INFO - Running setup.py (path:/tmp/pip-7oWrCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:19:35 INFO - Running setup.py (path:/tmp/pip-OI6okQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:19:35 INFO - Running setup.py (path:/tmp/pip-sq8fOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:19:35 INFO - Running setup.py (path:/tmp/pip-lTsMkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:19:35 INFO - Running setup.py (path:/tmp/pip-xJIA9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:19:35 INFO - Running setup.py (path:/tmp/pip-fByY03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:19:35 INFO - Running setup.py (path:/tmp/pip-pxoVfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:19:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:19:35 INFO - Running setup.py (path:/tmp/pip-GrUPJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:19:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:19:36 INFO - Running setup.py install for manifestparser 19:19:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:19:36 INFO - Running setup.py install for mozcrash 19:19:36 INFO - Running setup.py install for mozdebug 19:19:36 INFO - Running setup.py install for mozdevice 19:19:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:19:36 INFO - Running setup.py install for mozfile 19:19:36 INFO - Running setup.py install for mozhttpd 19:19:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:19:36 INFO - Running setup.py install for mozinfo 19:19:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:19:36 INFO - Running setup.py install for mozInstall 19:19:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:19:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:19:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:19:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:19:36 INFO - Running setup.py install for mozleak 19:19:36 INFO - Running setup.py install for mozlog 19:19:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:19:37 INFO - Running setup.py install for moznetwork 19:19:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:19:37 INFO - Running setup.py install for mozprocess 19:19:37 INFO - Running setup.py install for mozprofile 19:19:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:19:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:19:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:19:37 INFO - Running setup.py install for mozrunner 19:19:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:19:37 INFO - Running setup.py install for mozscreenshot 19:19:37 INFO - Running setup.py install for moztest 19:19:37 INFO - Running setup.py install for mozversion 19:19:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:19:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:19:37 INFO - Cleaning up... 19:19:37 INFO - Return code: 0 19:19:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:19:37 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')]} 19:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:37 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')]} 19:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:37 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 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16195c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16167a0>, '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 0x16176a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617b30>, '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': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', '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 19:19:37 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 19:19:37 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 19:19:37 INFO - Using env: {'DISPLAY': ':0', 19:19:37 INFO - 'HOME': '/home/cltbld', 19:19:37 INFO - 'LANG': 'en_US.UTF-8', 19:19:37 INFO - 'LANGUAGE': 'en_US:en', 19:19:37 INFO - 'LOGNAME': 'cltbld', 19:19:37 INFO - 'MAIL': '/var/mail/cltbld', 19:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:37 INFO - 'MOZ_NO_REMOTE': '1', 19:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:37 INFO - 'NO_EM_RESTART': '1', 19:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:37 INFO - 'PWD': '/builds/slave/test', 19:19:37 INFO - 'SHELL': '/bin/bash', 19:19:37 INFO - 'SHLVL': '1', 19:19:37 INFO - 'TERM': 'linux', 19:19:37 INFO - 'TMOUT': '86400', 19:19:37 INFO - 'USER': 'cltbld', 19:19:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', 19:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:37 INFO - '_': '/tools/buildbot/bin/python'} 19:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:19:38 INFO - Running setup.py (path:/tmp/pip-FExYLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:19:38 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)) 19:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:19:38 INFO - Running setup.py (path:/tmp/pip-xWmPjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:19:38 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)) 19:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:19:38 INFO - Running setup.py (path:/tmp/pip-mUTJmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:19:38 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)) 19:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:19:38 INFO - Running setup.py (path:/tmp/pip-gn8J9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:19:38 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)) 19:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:19:38 INFO - Running setup.py (path:/tmp/pip-_o4o63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:19:38 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)) 19:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:19:38 INFO - Running setup.py (path:/tmp/pip-EZ3X7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:19:38 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)) 19:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:19:38 INFO - Running setup.py (path:/tmp/pip-IuDQNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:19:38 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)) 19:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:19:38 INFO - Running setup.py (path:/tmp/pip-kkd9bI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:19:38 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)) 19:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:19:38 INFO - Running setup.py (path:/tmp/pip-PKldM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:19:38 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)) 19:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:19:38 INFO - Running setup.py (path:/tmp/pip-t0OyIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:19:38 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)) 19:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:19:38 INFO - Running setup.py (path:/tmp/pip-ReplVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:19:38 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)) 19:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:19:38 INFO - Running setup.py (path:/tmp/pip-EY4t8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:19:38 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)) 19:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:19:38 INFO - Running setup.py (path:/tmp/pip-UZnLBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:19:38 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)) 19:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:19:39 INFO - Running setup.py (path:/tmp/pip-BOLuJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:19:39 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)) 19:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:19:39 INFO - Running setup.py (path:/tmp/pip-8CTjVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:19:39 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)) 19:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:19:39 INFO - Running setup.py (path:/tmp/pip-WEhDkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:19:39 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)) 19:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:19:39 INFO - Running setup.py (path:/tmp/pip-loXX94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:19:39 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)) 19:19:39 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)) 19:19:39 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)) 19:19:39 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)) 19:19:39 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)) 19:19:39 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)) 19:19:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:19:39 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 19:19:39 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 19:19:39 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 19:19:39 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 19:19:40 INFO - Downloading blessings-1.6.tar.gz 19:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:19:40 INFO - Installing collected packages: blessings 19:19:40 INFO - Running setup.py install for blessings 19:19:40 INFO - Successfully installed blessings 19:19:40 INFO - Cleaning up... 19:19:40 INFO - Return code: 0 19:19:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:19:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:19:40 INFO - Reading from file tmpfile_stdout 19:19:40 INFO - Current package versions: 19:19:40 INFO - argparse == 1.2.1 19:19:40 INFO - blessings == 1.6 19:19:40 INFO - blobuploader == 1.2.4 19:19:40 INFO - docopt == 0.6.1 19:19:40 INFO - functools32 == 3.2.3-2 19:19:40 INFO - jsonschema == 2.5.1 19:19:40 INFO - manifestparser == 1.1 19:19:40 INFO - mozInstall == 1.12 19:19:40 INFO - mozcrash == 1.0 19:19:40 INFO - mozdebug == 0.1 19:19:40 INFO - mozdevice == 0.51 19:19:40 INFO - mozfile == 1.2 19:19:40 INFO - mozhttpd == 0.7 19:19:40 INFO - mozinfo == 0.9 19:19:40 INFO - mozleak == 0.1 19:19:40 INFO - mozlog == 3.4 19:19:40 INFO - moznetwork == 0.27 19:19:40 INFO - mozprocess == 0.25 19:19:40 INFO - mozprofile == 0.28 19:19:40 INFO - mozrunner == 6.13 19:19:40 INFO - mozscreenshot == 0.1 19:19:40 INFO - mozsystemmonitor == 0.3 19:19:40 INFO - moztest == 0.8 19:19:40 INFO - mozversion == 1.4 19:19:40 INFO - psutil == 3.1.1 19:19:40 INFO - requests == 1.2.3 19:19:40 INFO - wsgiref == 0.1.2 19:19:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:40 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 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16195c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16167a0>, '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 0x16176a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617b30>, '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': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', '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 19:19:40 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 19:19:40 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 19:19:40 INFO - Using env: {'DISPLAY': ':0', 19:19:40 INFO - 'HOME': '/home/cltbld', 19:19:40 INFO - 'LANG': 'en_US.UTF-8', 19:19:40 INFO - 'LANGUAGE': 'en_US:en', 19:19:40 INFO - 'LOGNAME': 'cltbld', 19:19:40 INFO - 'MAIL': '/var/mail/cltbld', 19:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:40 INFO - 'MOZ_NO_REMOTE': '1', 19:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:40 INFO - 'NO_EM_RESTART': '1', 19:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:40 INFO - 'PWD': '/builds/slave/test', 19:19:40 INFO - 'SHELL': '/bin/bash', 19:19:40 INFO - 'SHLVL': '1', 19:19:40 INFO - 'TERM': 'linux', 19:19:40 INFO - 'TMOUT': '86400', 19:19:40 INFO - 'USER': 'cltbld', 19:19:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', 19:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:40 INFO - '_': '/tools/buildbot/bin/python'} 19:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:41 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)) 19:19:41 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)) 19:19:41 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)) 19:19:41 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)) 19:19:41 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)) 19:19:41 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)) 19:19:41 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)) 19:19:41 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)) 19:19:41 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)) 19:19:41 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:19:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:19:42 INFO - Downloading marionette_driver-1.4.0.tar.gz 19:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 19:19:42 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)) 19:19:42 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)) 19:19:42 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)) 19:19:42 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)) 19:19:42 INFO - Installing collected packages: marionette-driver 19:19:42 INFO - Running setup.py install for marionette-driver 19:19:42 INFO - Successfully installed marionette-driver 19:19:42 INFO - Cleaning up... 19:19:42 INFO - Return code: 0 19:19:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:19:42 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')]} 19:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:42 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')]} 19:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:42 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 0x12a61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16195c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16167a0>, '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 0x16176a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617b30>, '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': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', '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 19:19:42 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 19:19:42 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 19:19:42 INFO - Using env: {'DISPLAY': ':0', 19:19:42 INFO - 'HOME': '/home/cltbld', 19:19:42 INFO - 'LANG': 'en_US.UTF-8', 19:19:42 INFO - 'LANGUAGE': 'en_US:en', 19:19:42 INFO - 'LOGNAME': 'cltbld', 19:19:42 INFO - 'MAIL': '/var/mail/cltbld', 19:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:42 INFO - 'MOZ_NO_REMOTE': '1', 19:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:42 INFO - 'NO_EM_RESTART': '1', 19:19:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:42 INFO - 'PWD': '/builds/slave/test', 19:19:42 INFO - 'SHELL': '/bin/bash', 19:19:42 INFO - 'SHLVL': '1', 19:19:42 INFO - 'TERM': 'linux', 19:19:42 INFO - 'TMOUT': '86400', 19:19:42 INFO - 'USER': 'cltbld', 19:19:42 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', 19:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:42 INFO - '_': '/tools/buildbot/bin/python'} 19:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:19:42 INFO - Cleaning up... 19:19:42 INFO - Return code: 0 19:19:42 INFO - Running post-action listener: _resource_record_post_action 19:19:42 INFO - Running post-action listener: _start_resource_monitoring 19:19:42 INFO - Starting resource monitoring. 19:19:42 INFO - [mozharness: 2017-05-26 02:19:42.676577Z] Finished create-virtualenv step (success) 19:19:42 INFO - [mozharness: 2017-05-26 02:19:42.677503Z] Running install step. 19:19:42 INFO - Running pre-action listener: _resource_record_pre_action 19:19:42 INFO - Running main action method: install 19:19:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:19:42 INFO - Reading from file tmpfile_stdout 19:19:42 INFO - Detecting whether we're running mozinstall >=1.0... 19:19:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:19:42 INFO - Reading from file tmpfile_stdout 19:19:42 INFO - Output received: 19:19:42 INFO - Usage: mozinstall [options] installer 19:19:42 INFO - Options: 19:19:42 INFO - -h, --help show this help message and exit 19:19:42 INFO - -d DEST, --destination=DEST 19:19:42 INFO - Directory to install application into. [default: 19:19:42 INFO - "/builds/slave/test"] 19:19:42 INFO - --app=APP Application being installed. [default: firefox] 19:19:42 INFO - mkdir: /builds/slave/test/build/application 19:19:42 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'] 19:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:19:59 INFO - Reading from file tmpfile_stdout 19:19:59 INFO - Output received: 19:19:59 INFO - /builds/slave/test/build/application/firefox/firefox 19:19:59 INFO - Running post-action listener: _resource_record_post_action 19:19:59 INFO - [mozharness: 2017-05-26 02:19:59.123083Z] Finished install step (success) 19:19:59 INFO - [mozharness: 2017-05-26 02:19:59.123363Z] Running run-tests step. 19:19:59 INFO - Running pre-action listener: _resource_record_pre_action 19:19:59 INFO - Running main action method: run_tests 19:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:19:59 INFO - Python 2.7.3 19:19:59 INFO - Return code: 0 19:19:59 INFO - grabbing minidump binary from tooltool 19:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:59 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 0x16167a0>, '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 0x16176a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1617b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:19:59 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 19:19:59 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 19:19:59 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 19:19:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:19:59 INFO - Return code: 0 19:19:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:19:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:19:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:19:59 INFO - ENV: RUST_BACKTRACE is now 1 19:19:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:19:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:19:59 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/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 19:19:59 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/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 19:19:59 INFO - Using env: {'DISPLAY': ':0', 19:19:59 INFO - 'HOME': '/home/cltbld', 19:19:59 INFO - 'LANG': 'en_US.UTF-8', 19:19:59 INFO - 'LANGUAGE': 'en_US:en', 19:19:59 INFO - 'LOGNAME': 'cltbld', 19:19:59 INFO - 'MAIL': '/var/mail/cltbld', 19:19:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:19:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:59 INFO - 'MOZ_NO_REMOTE': '1', 19:19:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:59 INFO - 'NO_EM_RESTART': '1', 19:19:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:59 INFO - 'PWD': '/builds/slave/test', 19:19:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:19:59 INFO - 'RUST_BACKTRACE': '1', 19:19:59 INFO - 'SHELL': '/bin/bash', 19:19:59 INFO - 'SHLVL': '1', 19:19:59 INFO - 'TERM': 'linux', 19:19:59 INFO - 'TMOUT': '86400', 19:19:59 INFO - 'USER': 'cltbld', 19:19:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428', 19:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:59 INFO - '_': '/tools/buildbot/bin/python'} 19:19:59 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/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 19:19:59 INFO - mozversion application_buildid: 20170526013027 19:19:59 INFO - mozversion application_changeset: 0874cf4bb194d381a3afaa51276b6cee22f82211 19:19:59 INFO - mozversion application_display_name: Nightly 19:19:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:19:59 INFO - mozversion application_name: Firefox 19:19:59 INFO - mozversion application_remotingname: firefox 19:19:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:19:59 INFO - mozversion application_vendor: Mozilla 19:19:59 INFO - mozversion application_version: 55.0a1 19:19:59 INFO - mozversion platform_buildid: 20170526013027 19:19:59 INFO - mozversion platform_changeset: 0874cf4bb194d381a3afaa51276b6cee22f82211 19:19:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:19:59 INFO - mozversion platform_version: 55.0a1 19:19:59 INFO - using testdate: 1495765199 19:19:59 INFO - actual date: 1495765199 19:19:59 INFO - starting webserver on 'localhost:34009' 19:19:59 INFO - SUITE-START | Running 2 tests 19:19:59 INFO - TEST-START | dromaeo_css 19:19:59 INFO - operating with platform_type : linux_ 19:19:59 INFO - Initialising browser for dromaeo_css test... 19:19:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34009/getInfo.html -profile /tmp/tmpbMUzgr/profile 19:19:59 INFO - TEST-INFO | started process 3304 (/builds/slave/test/build/application/firefox/firefox http://localhost:34009/getInfo.html) 19:20:37 INFO - TEST-INFO | 3304: killed by SIGTERM 19:20:37 INFO - Browser initialized. 19:20:37 INFO - Running cycle 1/1 for dromaeo_css test... 19:20:37 INFO - TEST-INFO | started process 3525 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbMUzgr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:20:49 INFO - PID 3525 | RSS: Main: 172949504 19:20:49 INFO - PID 3525 | 19:23:54 INFO - PID 3525 | Cycle 1(1): loaded http://localhost:34009/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34009/tests/dromaeo/cssquery-ext.html) 19:23:55 INFO - PID 3525 | RSS: Main: 170147840 19:23:55 INFO - PID 3525 | 19:26:57 INFO - PID 3525 | Cycle 1(1): loaded http://localhost:34009/tests/dromaeo/cssquery-ext.html (next: http://localhost:34009/tests/dromaeo/cssquery-jquery.html) 19:26:58 INFO - PID 3525 | RSS: Main: 176353280 19:26:58 INFO - PID 3525 | 19:29:59 INFO - PID 3525 | Cycle 1(1): loaded http://localhost:34009/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34009/tests/dromaeo/cssquery-mootools.html) 19:30:00 INFO - PID 3525 | RSS: Main: 175362048 19:30:00 INFO - PID 3525 | 19:33:02 INFO - PID 3525 | Cycle 1(1): loaded http://localhost:34009/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34009/tests/dromaeo/cssquery-prototype.html) 19:33:02 INFO - PID 3525 | RSS: Main: 178896896 19:33:02 INFO - PID 3525 | 19:36:05 INFO - PID 3525 | Cycle 1(1): loaded http://localhost:34009/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34009/tests/dromaeo/cssquery-yui.html) 19:36:06 INFO - PID 3525 | RSS: Main: 177156096 19:36:06 INFO - PID 3525 | 19:39:08 INFO - PID 3525 | Cycle 1(1): loaded http://localhost:34009/tests/dromaeo/cssquery-yui.html (next: http://localhost:34009/tests/dromaeo/cssquery-dojo.html) 19:39:08 INFO - PID 3525 | RSS: Main: 177041408 19:39:08 INFO - PID 3525 | 19:39:08 INFO - PID 3525 | __start_tp_report 19:39:08 INFO - PID 3525 | _x_x_mozilla_page_load 19:39:08 INFO - PID 3525 | _x_x_mozilla_page_load_details 19:39:08 INFO - PID 3525 | |i|pagename|runs| 19:39:08 INFO - PID 3525 | |0;dojo.html;2698.716634753351;2723.128598848367;2739.2740923655233;2761.875715592797;2764.3780149466374;5087.592992560595;5151;5204.479552044793;5206.193040078789;5206.8698282542955;5135.486451354872;5146.5625421839095;5152.40747314059;5239.397469291023;5242.895142097156;4587.747673877935;4631.745254011028;4660.5339466053465;4673.065386922612;4706.5293470653005;4683.180443422404;4691.9296210556695;4714.90570188596;4734.692245004081;4745.09843129806;4563.885902852455;4603.171429142753;4633.351330813689;4649.070185962821;4669.486356500782;4649.604783593399;4650.511696271877;4673.158831410345;4677.251639737626;4709.7174169549935;4596.7931443085145;4602.171609110359;4607.124646317189;4622.699524530928;4630.768461576941;5016.548510634024;5074.441811400743;5089.3638295213095;5166.483351664841;5185.662931909452;5486.204500347428;5540.390557038722;5592.328920529562;5594.049011667986;5615.382307946123;5590.91613625796;5607.943920560783;5618.325800903876;5623.325200975909;5626.437356264381;5212.374515058179;5212.8957420851375;5219.765110570033;5240.895182096337;5276.577873770089;5631.155326701028;5679.488846003796;5682.943170568324;5766.711664416763;5767.423257674199;5396.757145928443;5397.7571009304675;5405.594580406485;5456.972715136479;5511.173324001432;5522.116461366162;5529.806456774074;5564.777408903679;5580.1629755537;5616.606837521416;5470.617056805985;5496.862578435571;5548.778048878;5584.162375643686;5596.300462442195;5589.217509548666;5607.7476513556985;5608.383077861432;5612.859678507988;5626;4658.790354433991;4668.50980647034;4670.64970127235;4677.555632214934;4712.458067322234;4010.859619913289;4018.517777866675;4019.457373254573;4045.0291929937193;4053.108316170438;4586.128635559233;4657.138429390574;4678.625709943196;4740.834070807574;4751.382320298339;5621.971890140605;5629.099344105005;5634.239377684042;5638.238837756932;5681.943180568224;4718.8584342469785;4724.338592597039;4736.052789442126;4741.83403580873;4744.146053710365;4901.681390709592;4930.580900623416;4965.677230979974;4972.353594032753;4972.776225069808;5181.766820493011;5190.922136168036;5191.351081114861;5228.424873263862;5240.633155679066;5508.862278442911;5522.696251706195;5589.5807814413265;5597.244372009726;5601.915971260516;5167.58659307262;5178.71517066565;5214.504622060898;5225.1117310056625;5237.973810131078;5410.810621628224;5536.086545719912;5537.307836520435;5537.972310138423;5541.113421852484;5568.220449137043;5575.581831362583;5609.747561359667;5675.404082571271;5690.630109042899;5451.945480545144;5463.344398672185;5476.890462190813;5512.228288039598;5522.475364840334;5411.756470958738;5464.808731694372;5467.17992301158;5471.425500322409;5474.479924407175;5271.7891284349735;5323.547498462674;5339.893202135858;5355.678659280456;5386.865328366822;5328.333958255218;5387.515123638735;5388.110961691277;5429.511343978903;5445.809396671098;5176.4047134578495;5177.689338639693;5238.633295669267;5250.65870718402;5301 19:39:08 INFO - PID 3525 | |1;ext.html;663.555417870027;692.6848284030765;712.3588770106903;1143.1540659911668;1170.2159553099423;33025.174370640714;33674.49488257675;33779.32441351171;33820.49269260963;33834.15414614636;31494.842525787397;31761;31845.36309273813;31875.203119921956;31918.36163276733;6167.136600875881;6642.966785166067;6780.627065511395;6806.7957961261245;6810.216825065107;6794.966025169867;6889.34551217636;6902.827429314257;6920.134983127109;6941.826454338657;6840.31596840317;6909.758158464455;6917.446604271646;6926.896096558556;6949.548279361826;6873.037774711544;6904.13698287714;6905.205901321337;6932.341427564374;6935.4104901083465;6628.900566491507;6673.899891501631;6676.899846502306;6679.064930909628;6699.631520266384;30782.23044423885;30875.22811929697;30890.227744306347;30899.382012359853;30922.226944326572;3084.3522860199387;3100.3799240151834;3103.1156120505775;3108.1607965849093;3108.2384815720065;24034.879825600936;24035.87982060096;24144.396390090213;24162.758372416403;24209.152679656305;2843.957340639892;2852.1728698677357;2877.7697784177426;2890.2629829393372;2904.0271509044496;146389;147234.99999999892;147280;155556;159074;38381.61618383836;38645.03387415281;38647.6135238644;38648.80675596604;38753.41869871954;39933.80033099816;39993.80003099966;39997.80001099976;40008.199836003114;42472.36291455631;12603.621891343275;12684.80972785409;12788.744225115446;12814.67963300925;12955;9948.054934781185;10087.596496140219;10111.443870587189;10440.63457778974;10473.266871319087;12570.182938108994;12646.177998430072;12659.873401266053;12688.936555317348;12775.105742597929;5256.26412302278;5329.173978033411;5390.838274851761;5414.675119492843;5459.344878614592;872.1496540872726;921.5346250143634;925.0887875442684;929.4098247612815;954.5227386306847;20168.29410970609;20661.793382066287;21502;21755.782442175376;21785.346439606838;986.5264672956878;990.2770977186694;993.4784238274964;1023.6570748799087;1024.897510248984;10963.50664220112;11277.097832173406;11359.943200283946;11487.25332853362;11493.482793274323;184035;184080;184256;184820;185178;40257.396139057935;40607.7969610156;40640.593594064274;40648.18703625911;40686.18627627431;1197.6107764976418;1245.9563915263104;1255.347219445883;1260.6596219020996;1262.5265525427965;20018.499537511678;20458.283960061326;21206.15175392967;21561.92873625206;21606.783932161106;29587.556186656788;35903.76866082065;36670.266594668494;36707.08232294214;36896.81551592225;167897;168251;169803;170459;171104;29805.850970745007;30170.54744178883;30515;30526.84736576392;30591.847040764653;34685.826570866986;35271;35769.28461430809;35830.46254306239;36012.81993590015;27251.59122613202;28019.719802801712;28078.85960570184;28213.71786282193;28662.856685716437;24085.75914240835;27453.17640470789;28079.57880631833;28276.71723282741;29553;31244.375112498077;31308;31708.207294817814;31890.202744930633;32009.67990320067;27396.589051164647;27416;27532.862335688995;27977.642682878184;29092.418151636426;20320.59358812845;22576.565406075635;22606.773932261123;22705.772942270367;22745.886270568542 19:39:08 INFO - PID 3525 | |2;jquery.html;400.87572852415735;414.7843121576782;420.2813189446047;430.2578052858818;444.5310197741384;17172.3131074757;17417.21622526986;17712;17764.37824676135;17985.37051203208;17934.82065179351;18165.273389064456;18169.818301816977;18890.43328700141;19025.904870475628;5290.761915713783;5410.269613602172;5487.2317875497465;5534.225208470817;5643.435656434365;5276.15581506959;5440.6735595864375;5451.509364157225;5461.617686761928;5462.535684466825;5369.9463005370035;5429.701366424845;5439.564834813225;5444.128939369702;5450.127979523277;5255.763490642911;5411.431799661038;5431.103867861798;5451.400345961941;5453.018456677796;4886.682365646222;4909.803607855682;4929.556339929388;4932.950670493321;4953.702777833341;20824.47938801542;21210.575788484144;21430.357089287347;21538.569228615495;21657.783422165736;1651.719207734688;1666.8666506679438;1684.3262694922007;1687.1311274693542;1690.357664087651;14245.074070185508;14302;14440.85559144416;14526.564203073925;14897.329620167118;1976.644204043286;2011.0950072467301;2041.2243347527992;2086.113401804242;2087.5094352827073;77113.61443192748;77311.22688773152;77779.22220777832;78387.6080619599;78502.60748696278;10891.83662245067;10946.890531094587;11087.889121108847;11258.943705281585;11397.772044559228;15629.765553516707;15653.295601697951;15721.528354149394;15725.292361843745;15749.68500629981;7466;7542.396608271325;7710.961445192738;7744.883826742604;7778.572178530235;6923.238443771181;6995.510314277952;7008.194057683329;7135.5361901476235;7168.8529835227155;6887.827804304932;6889.138857642794;6984.2317345092;6985.93014069863;7015.473839462061;1965.8427325814187;1995.8103980121866;2024.8278896293684;2040.9387718368473;2043.1929387891996;855.2260204514924;870.2211520688948;895.2882458445551;897.5781382750097;904.8642703594381;16675.91662041682;16822.158892055348;16917.238724257437;16928.068956207528;17606.735898961524;880.5641207602278;886.6453418632469;890.3500444675424;897.7800438892383;910.4582773249906;9017.729468115967;9304.395214311184;9570.521473926276;9598.856017159747;9714.22286217101;342040;345531;349373;350164;350648;76071.61964190143;76746.61626691831;77737;78004;78304.60847695725;1035.6168217759478;1049.344159900047;1050.9159267258601;1055.7993981143559;1065.6057258814287;14252.643683907985;14465.349059292146;14486.710265794414;14503.419863205354;15071.4724984625;37214.44178337273;37505.2498950025;37832;37888.81055594704;38734.418983715834;45245.321320179566;51167;52396.738016309675;53367.46632533625;53902;7918.564478953713;8050.637721302673;8057.637406316612;8222.588870556328;8340.666373344999;11965.940170299093;12069.637910862688;12686.238825670489;13177.670558236121;13190.60428187156;10641.414722190353;10959.945200274267;11064.612738554111;11240.606578769704;11895;10259.333143345659;10273.794524109626;10371.636992705218;10486.161107111566;10659.94670026645;10802.837957430487;10979.615713449992;11210.83183752228;11254.324740515594;11282.379469129277;8214.26071653554;8261.83476330482;8511.446755960842;8573.399862009599;8595.269402100892;10650.254482186172;10666;10698.679039628823;11174.944125279322;11269.49287282058 19:39:08 INFO - PID 3525 | |3;mootools.html;1278.3863745402205;1330.8469526004512;1331.8401791784988;1343.0934119469362;1348.0900392235242;10092.24308176887;10451.529681164347;10531.315464494803;10548.261621686484;10747.62383316584;10189.337693049965;10462.790744185111;10536.26246162769;10542.947285263583;10566.947165264162;2078.4596005038684;2119.7668256491775;2119.872807631547;2120.279105104264;2130.2970019893396;1973.9111739971736;2012.869163504375;2022.5651484930736;2023.8077382648626;2029.81731644152;2091.843111766616;2101.2015434135005;2110.0610228448268;2113.3448630924386;2120.321497120922;1899.5251187203198;1918.9136488858035;1924.8748831326059;1925.0663428237294;1927.7493925789697;1867;1875.7373967644542;1897.1368027547571;1912.053533500912;2006.518435575466;10339.379637221791;10399.532021058994;10402.063814256677;10403.947980260125;10409.843852342221;5233.110371236899;5396.082665946798;5397.217403476513;5411.404745477994;5430.484104010113;3153.085605174497;3265.804051756902;3285.917852053694;3328.6005679318637;3332.6334103248623;1074.5486895503907;1079.3631757263252;1094.781043791237;1106.955721771128;1119.7144728094283;14771.409143634242;15037.774433383507;15076.924615376962;15103.5468935931;15116.546503604799;4426.468823741172;4554.658400619966;4673.182193116191;4674.929876051794;4683;10810.135189184846;10814.78370432587;10835.83746243807;10842.186835987333;10853.891461085288;5276.92084618731;5492.642978206404;5493.066178749622;5500.064988951888;5500.669959802424;5063.797448102108;5067.645264831426;5102.719350435687;5112.795488180505;5129.461406552333;3680.190358121209;3716.95925140961;3720.2373513429684;3787.8484860605818;3801.6388443098413;1038.4132964874973;1038.849366841819;1039.2880876599554;1059.0627294844119;1060.2790102730064;718.9820254493575;751.751921865783;754.1101500229781;766.31797700047;766.9616519174019;5687.914681279784;5780.826575202751;5877.353491115974;5920.615160014585;6002.459778619946;564.6724899558246;576.7779404929132;579.1862433281246;582.4961408381804;587.8442212813608;3843.5387753469204;3914.2954268231993;3929.941050884239;4063.9390409143884;4107.219628270619;12013.87986120145;13187.73624527504;13699;13706.040577159703;13713.862861371457;12972.545960891512;13523;13567.932160339134;13584.592462226148;13638.659033524242;7536.773896783106;7621.12357078943;7626.3898888089925;7637.847243055107;7645.694172233048;5831.300243970581;5966.642001479925;6080.90878636812;6218.689065546614;6422.839429014312;11842.289462631925;12143.08926830509;12148.635540933787;12376.81434778461;12384.62846114618;12287.324197169242;12481.56314528987;12537.749245014866;12621.558245461365;12750.872491274968;7470.572064079304;7696.384289256734;7699.461037727306;7703.191164927826;7709.843523471524;9280.118388753057;9401.529923503935;9402.341836071682;9410.57652405657;9427.292953028413;7954.323882470055;8020.879686804819;8022.3181029610805;8089.797755056171;8362.163783621589;7856.410769192219;7955.920440795518;7961.641726122222;7968.282854543119;8005.759827205193;7266.745663901738;7406.03721516221;7424.925750742639;7434.442416818868;7449.515781474187;4885.926711099265;5199.55803756685;5212.322398088224;5452.645578037414;5502.422245664147;5215.087359711959;5247.632665713363;5274.4198138204;5313.920291195713;5460.6996615186545 19:39:08 INFO - PID 3525 | |4;prototype.html;371.7286380941914;375.1053736837641;384.3619591478147;384.63843986652546;385.0604524959099;5367.490088441592;5422.237772723865;5466.999999999995;5477.151041588555;5564.4713752193575;5309.123994540906;5383.562601772209;5392.622516423852;5395.514403703666;5410.431904650014;4012.8194231259663;4118.958810411902;4133.875983720493;4136.855210067633;4147.253494371012;4129.752214867118;4138.3999320098565;4140.544540100602;4143.7720925349095;4153.107081977374;4090.1615168890453;4091.9386209206887;4092.1406504634065;4092.9386059209137;4096.487939007624;4046.251443482965;4065.2276067547073;4072.552019277877;4081.5918408159096;4083.7958102094776;3578.8389522471552;3581;3584.211473475831;3584.910377240564;3598.964010359889;5195.870103247411;5245.239440281138;5348.438413966555;5349.491798279158;5355.919661205085;4745.525447455261;4758.619310455155;4762.595179409755;4799.784009719571;4823.614110871122;5705;5743.856403589902;5747.942520574783;5749.942500574983;5765.711714414305;3976.602339766;3989.3816458448987;3993.3610622300585;3994.4807175067344;4023.597640235953;6005.477699366276;6064.181335519736;6101.359357267467;6135.570510064297;6150;4090.795460226977;4106.650934670586;4110.581849262;4110.671146308288;4113;4119.6910231732145;4124.4019617155345;4134.793260337031;4153.899216707575;4170;4683.367745354401;4792.664513484023;4804.855854324376;4811.123661771911;4843.200871856175;5795.391483894215;5813.505852002542;5821.592488525847;5838.941610583925;5846.766129354864;1406.655369434495;1418.1207651256286;1418.3404716806735;1426.6718654709475;1432.4270291883122;920.1074957291416;946.7491114854569;961.7691753979135;969.8690676758547;972.1736523954582;4917.557419832232;4964.67729597575;4973.1297023020825;4974;4999.275105109738;5934.703264836828;5952.345242023374;5976.147394307778;6001.2498437695285;6023.698815059317;4834.7454240268335;4936.950630493721;4951.158303088484;4969.254611808257;4972.229304457815;3126.609173853268;3188.4420226460275;3192.138122706903;3192.792468489587;3193.952090718641;5519.668819870821;5519.668819870821;5526.281583394133;5538.889222215533;5541.750621221974;5952.404759524013;6092.3603021682975;6119.204503414617;6119.418655227746;6130.2030736004035;5255.185446255837;5485.424030476902;5495.203195536625;5501.972490137524;5502.413865483297;5936.575221946615;5953.255843019622;5958.910616340671;5991.310999235144;6011.458968692664;5730.484256416776;5855.151003104611;5865.501432378295;5882.705864706833;5901.439363260483;5492.670439773627;5498.917516237179;5500.724963751876;5506.724663766716;5548.306461692288;4064.3700226464944;4083.774867539667;4097.7541347519245;4099.446574712376;4100.282450571198;5774.307083150049;5907.616004959664;5957.374475680164;5961.2846458425265;6067.544934130046;5738.483536481736;5771.134329850556;5775.104858746901;5783.450572195635;5792.768289268551;5646.85882852932;5732.570057245806;5754.741036653277;5761.5390768739235;5763.250777398911;5668.773249069991;5684.232628595087;5703.600747947604;5704.80033198836;5713.800016999385;5772.7402266898935;5778.479936805539;5807.128930660435;5815.476607105381;5825.912611310919;5528.226048353315;5650.773969041193;5652.745626446737;5689.146628005832;5690.260266165372 19:39:08 INFO - PID 3525 | |5;yui.html;738.9778306650795;755.4636208292115;767.4052609227848;767.6392095715014;779.3414564692835;11914;12283.44724487398;13630.727385452285;14622.561323160297;14675.486357977474;13457.596272111829;13881;13954.581362559114;14017.36921838517;14058.367373468192;867.8611422172454;882.1222883231194;884.332329091535;885.6457417033174;886.7605746448455;895.1496078725205;896.4083704754863;899.0470101692194;899.7480705402497;900.5002223765807;934.103260869566;935.5135329628589;937.8171256604965;938.2447130060299;939.5490164720939;918.4810582021137;920.1534588178858;929.061647735785;931.1433481197247;933.1927882381725;678.0608856733411;686.4679873098339;686.8111269400905;686.8626274745021;689.7861662884521;13875.861241387558;14067.226302553356;14073.36669849849;14103.576892693132;14223.146611203361;15742.606434839106;16321.428749993693;16809.15954202285;16921.915390422968;16933.06868122253;11993.64019079429;12221.572244971383;12253.387330633434;12394.938025309906;12566.246025238515;2779.069011881022;2795.888164473419;2796.804223704321;2797.37059161689;2798.3004248937764;83933.58033209795;85725.14274857297;85765;85897;87209;12332.568360107352;12526.37368131608;12663.873361266453;12676.366181691063;12695.428705708266;22431.887840560692;23128.537429251322;23361.7663823363;23372.415689607897;23390.64914026291;5890.440408161304;5892;5895.616784909053;5938.376470470538;5956.970215148983;2889.2921234297733;2901.8113822601886;2940.8382538960136;2949.8525073746227;2959.2897704551183;3683.4474828775897;3744.2885851688093;3747.194353214072;3748.475213470116;3768.1333293342686;651.6481100205931;655.3970347280418;659.8350412396901;739.2976672161468;792.7740593930702;605.0742364182807;618.7494064903722;621.4220774679501;644.1818890009662;647.4011539326199;9679;10234.48827558619;10450.790984180274;10969.725756855983;11337.26307789991;608.7747533412577;610.914471973924;615.9661218632929;624.0389799708489;637.4900079936033;4403.53762854902;4485.798139083749;4508.233600287959;4516.36770852081;4532.9546704533195;83881;85457.57271213604;86735.56632216925;88812;89242;75656;75980.24019759842;76191.23808761952;76872;77313;60250.69874650599;61320.38679613325;62279.6886015567;65826;67093.66453167703;9268.629254829732;10111.241656875616;10174.186065114922;10276.22928280367;10541.525631346454;26165.476690465704;26784;27146.185614431597;27559.448811023267;28062.158135255973;33111.50332744962;33498.83250583829;33563.32873342568;33887.83056084704;34089.82955085209;14094.788578171541;14141.575752727435;14373.137611743328;14538.273086345429;14559.490417835324;15492.147931863856;15624.765628515808;15648.530544083696;15670.373185072469;15909.204539772734;14496.130232186102;14904.850951490347;15561.221938903236;15779.842201577838;15835.841641583436;14658.926705366404;14901.92549037248;14935.17856517902;15023.248837558296;15136.394544218549;13530.93234533821;13727.107737996997;13894.513692020731;14785.482508112165;14999.2500374983;10553.208509361983;10959.50682219318;11129.499172537417;11208.215424920178;11312.83030754523;11259.662210133709;11558;11629.127815413709;11685.883141168479;11688 19:39:08 INFO - PID 3525 | __end_tp_report 19:39:08 INFO - PID 3525 | __start_cc_report 19:39:08 INFO - PID 3525 | _x_x_mozilla_cycle_collect,340 19:39:08 INFO - PID 3525 | __end_cc_report 19:39:08 INFO - PID 3525 | __startTimestamp1495766348260__endTimestamp 19:39:08 INFO - PID 3525 | 19:39:08 INFO - PID 3525 | ------- Summary: start ------- 19:39:08 INFO - PID 3525 | Number of tests: 6 19:39:08 INFO - PID 3525 | 19:39:08 INFO - PID 3525 | [#0] dojo.html Cycles:165 Average:5104.91 Median:5238.63 stddev:588.13 (11.2%) stddev-sans-first:558.82 19:39:08 INFO - PID 3525 | Values: 2698.7 2723.1 2739.3 2761.9 2764.4 5087.6 5151.0 5204.5 5206.2 5206.9 5135.5 5146.6 5152.4 5239.4 5242.9 4587.7 4631.7 4660.5 4673.1 4706.5 4683.2 4691.9 4714.9 4734.7 4745.1 4563.9 4603.2 4633.4 4649.1 4669.5 4649.6 4650.5 4673.2 4677.3 4709.7 4596.8 4602.2 4607.1 4622.7 4630.8 5016.5 5074.4 5089.4 5166.5 5185.7 5486.2 5540.4 5592.3 5594.0 5615.4 5590.9 5607.9 5618.3 5623.3 5626.4 5212.4 5212.9 5219.8 5240.9 5276.6 5631.2 5679.5 5682.9 5766.7 5767.4 5396.8 5397.8 5405.6 5457.0 5511.2 5522.1 5529.8 5564.8 5580.2 5616.6 5470.6 5496.9 5548.8 5584.2 5596.3 5589.2 5607.7 5608.4 5612.9 5626.0 4658.8 4668.5 4670.6 4677.6 4712.5 4010.9 4018.5 4019.5 4045.0 4053.1 4586.1 4657.1 4678.6 4740.8 4751.4 5622.0 5629.1 5634.2 5638.2 5681.9 4718.9 4724.3 4736.1 4741.8 4744.1 4901.7 4930.6 4965.7 4972.4 4972.8 5181.8 5190.9 5191.4 5228.4 5240.6 5508.9 5522.7 5589.6 5597.2 5601.9 5167.6 5178.7 5214.5 5225.1 5238.0 5410.8 5536.1 5537.3 5538.0 5541.1 5568.2 5575.6 5609.7 5675.4 5690.6 5451.9 5463.3 5476.9 5512.2 5522.5 5411.8 5464.8 5467.2 5471.4 5474.5 5271.8 5323.5 5339.9 5355.7 5386.9 5328.3 5387.5 5388.1 5429.5 5445.8 5176.4 5177.7 5238.6 5250.7 5301.0 19:39:08 INFO - PID 3525 | 19:39:08 INFO - PID 3525 | [#1] ext.html Cycles:180 Average:31163.82 Median:16979.79 stddev:43609.25 (256.8%) stddev-sans-first:43671.45 19:39:08 INFO - PID 3525 | Values: 663.6 692.7 712.4 1143.2 1170.2 33025.2 33674.5 33779.3 33820.5 33834.2 31494.8 31761.0 31845.4 31875.2 31918.4 6167.1 6643.0 6780.6 6806.8 6810.2 6795.0 6889.3 6902.8 6920.1 6941.8 6840.3 6909.8 6917.4 6926.9 6949.5 6873.0 6904.1 6905.2 6932.3 6935.4 6628.9 6673.9 6676.9 6679.1 6699.6 30782.2 30875.2 30890.2 30899.4 30922.2 3084.4 3100.4 3103.1 3108.2 3108.2 24034.9 24035.9 24144.4 24162.8 24209.2 2844.0 2852.2 2877.8 2890.3 2904.0 146389.0 147235.0 147280.0 155556.0 159074.0 38381.6 38645.0 38647.6 38648.8 38753.4 39933.8 39993.8 39997.8 40008.2 42472.4 12603.6 12684.8 12788.7 12814.7 12955.0 9948.1 10087.6 10111.4 10440.6 10473.3 12570.2 12646.2 12659.9 12688.9 12775.1 5256.3 5329.2 5390.8 5414.7 5459.3 872.1 921.5 925.1 929.4 954.5 20168.3 20661.8 21502.0 21755.8 21785.3 986.5 990.3 993.5 1023.7 1024.9 10963.5 11277.1 11359.9 11487.3 11493.5 184035.0 184080.0 184256.0 184820.0 185178.0 40257.4 40607.8 40640.6 40648.2 40686.2 1197.6 1246.0 1255.3 1260.7 1262.5 20018.5 20458.3 21206.2 21561.9 21606.8 29587.6 35903.8 36670.3 36707.1 36896.8 167897.0 168251.0 169803.0 170459.0 171104.0 29805.9 30170.5 30515.0 30526.8 30591.8 34685.8 35271.0 35769.3 35830.5 36012.8 27251.6 28019.7 28078.9 28213.7 28662.9 24085.8 27453.2 28079.6 28276.7 29553.0 31244.4 31308.0 31708.2 31890.2 32009.7 27396.6 27416.0 27532.9 27977.6 29092.4 20320.6 22576.6 22606.8 22705.8 22745.9 19:39:08 INFO - PID 3525 | 19:39:08 INFO - PID 3525 | [#2] jquery.html Cycles:180 Average:23929.50 Median:37359.85 stddev:57812.96 (154.7%) stddev-sans-first:57948.15 19:39:08 INFO - PID 3525 | Values: 400.9 414.8 420.3 430.3 444.5 17172.3 17417.2 17712.0 17764.4 17985.4 17934.8 18165.3 18169.8 18890.4 19025.9 5290.8 5410.3 5487.2 5534.2 5643.4 5276.2 5440.7 5451.5 5461.6 5462.5 5369.9 5429.7 5439.6 5444.1 5450.1 5255.8 5411.4 5431.1 5451.4 5453.0 4886.7 4909.8 4929.6 4933.0 4953.7 20824.5 21210.6 21430.4 21538.6 21657.8 1651.7 1666.9 1684.3 1687.1 1690.4 14245.1 14302.0 14440.9 14526.6 14897.3 1976.6 2011.1 2041.2 2086.1 2087.5 77113.6 77311.2 77779.2 78387.6 78502.6 10891.8 10946.9 11087.9 11258.9 11397.8 15629.8 15653.3 15721.5 15725.3 15749.7 7466.0 7542.4 7711.0 7744.9 7778.6 6923.2 6995.5 7008.2 7135.5 7168.9 6887.8 6889.1 6984.2 6985.9 7015.5 1965.8 1995.8 2024.8 2040.9 2043.2 855.2 870.2 895.3 897.6 904.9 16675.9 16822.2 16917.2 16928.1 17606.7 880.6 886.6 890.4 897.8 910.5 9017.7 9304.4 9570.5 9598.9 9714.2 342040.0 345531.0 349373.0 350164.0 350648.0 76071.6 76746.6 77737.0 78004.0 78304.6 1035.6 1049.3 1050.9 1055.8 1065.6 14252.6 14465.3 14486.7 14503.4 15071.5 37214.4 37505.2 37832.0 37888.8 38734.4 45245.3 51167.0 52396.7 53367.5 53902.0 7918.6 8050.6 8057.6 8222.6 8340.7 11965.9 12069.6 12686.2 13177.7 13190.6 10641.4 10959.9 11064.6 11240.6 11895.0 10259.3 10273.8 10371.6 10486.2 10659.9 10802.8 10979.6 11210.8 11254.3 11282.4 8214.3 8261.8 8511.4 8573.4 8595.3 10650.3 10666.0 10698.7 11174.9 11269.5 19:39:08 INFO - PID 3525 | 19:39:08 INFO - PID 3525 | [#3] mootools.html Cycles:180 Average:6266.33 Median:3698.57 stddev:4115.90 (111.3%) stddev-sans-first:4110.38 19:39:08 INFO - PID 3525 | Values: 1278.4 1330.8 1331.8 1343.1 1348.1 10092.2 10451.5 10531.3 10548.3 10747.6 10189.3 10462.8 10536.3 10542.9 10566.9 2078.5 2119.8 2119.9 2120.3 2130.3 1973.9 2012.9 2022.6 2023.8 2029.8 2091.8 2101.2 2110.1 2113.3 2120.3 1899.5 1918.9 1924.9 1925.1 1927.7 1867.0 1875.7 1897.1 1912.1 2006.5 10339.4 10399.5 10402.1 10403.9 10409.8 5233.1 5396.1 5397.2 5411.4 5430.5 3153.1 3265.8 3285.9 3328.6 3332.6 1074.5 1079.4 1094.8 1107.0 1119.7 14771.4 15037.8 15076.9 15103.5 15116.5 4426.5 4554.7 4673.2 4674.9 4683.0 10810.1 10814.8 10835.8 10842.2 10853.9 5276.9 5492.6 5493.1 5500.1 5500.7 5063.8 5067.6 5102.7 5112.8 5129.5 3680.2 3717.0 3720.2 3787.8 3801.6 1038.4 1038.8 1039.3 1059.1 1060.3 719.0 751.8 754.1 766.3 767.0 5687.9 5780.8 5877.4 5920.6 6002.5 564.7 576.8 579.2 582.5 587.8 3843.5 3914.3 3929.9 4063.9 4107.2 12013.9 13187.7 13699.0 13706.0 13713.9 12972.5 13523.0 13567.9 13584.6 13638.7 7536.8 7621.1 7626.4 7637.8 7645.7 5831.3 5966.6 6080.9 6218.7 6422.8 11842.3 12143.1 12148.6 12376.8 12384.6 12287.3 12481.6 12537.7 12621.6 12750.9 7470.6 7696.4 7699.5 7703.2 7709.8 9280.1 9401.5 9402.3 9410.6 9427.3 7954.3 8020.9 8022.3 8089.8 8362.2 7856.4 7955.9 7961.6 7968.3 8005.8 7266.7 7406.0 7424.9 7434.4 7449.5 4885.9 5199.6 5212.3 5452.6 5502.4 5215.1 5247.6 5274.4 5313.9 5460.7 19:39:08 INFO - PID 3525 | 19:39:08 INFO - PID 3525 | [#4] prototype.html Cycles:180 Average:4735.03 Median:5402.97 stddev:1408.27 (26.1%) stddev-sans-first:1373.62 19:39:08 INFO - PID 3525 | Values: 371.7 375.1 384.4 384.6 385.1 5367.5 5422.2 5467.0 5477.2 5564.5 5309.1 5383.6 5392.6 5395.5 5410.4 4012.8 4119.0 4133.9 4136.9 4147.3 4129.8 4138.4 4140.5 4143.8 4153.1 4090.2 4091.9 4092.1 4092.9 4096.5 4046.3 4065.2 4072.6 4081.6 4083.8 3578.8 3581.0 3584.2 3584.9 3599.0 5195.9 5245.2 5348.4 5349.5 5355.9 4745.5 4758.6 4762.6 4799.8 4823.6 5705.0 5743.9 5747.9 5749.9 5765.7 3976.6 3989.4 3993.4 3994.5 4023.6 6005.5 6064.2 6101.4 6135.6 6150.0 4090.8 4106.7 4110.6 4110.7 4113.0 4119.7 4124.4 4134.8 4153.9 4170.0 4683.4 4792.7 4804.9 4811.1 4843.2 5795.4 5813.5 5821.6 5838.9 5846.8 1406.7 1418.1 1418.3 1426.7 1432.4 920.1 946.7 961.8 969.9 972.2 4917.6 4964.7 4973.1 4974.0 4999.3 5934.7 5952.3 5976.1 6001.2 6023.7 4834.7 4937.0 4951.2 4969.3 4972.2 3126.6 3188.4 3192.1 3192.8 3194.0 5519.7 5519.7 5526.3 5538.9 5541.8 5952.4 6092.4 6119.2 6119.4 6130.2 5255.2 5485.4 5495.2 5502.0 5502.4 5936.6 5953.3 5958.9 5991.3 6011.5 5730.5 5855.2 5865.5 5882.7 5901.4 5492.7 5498.9 5500.7 5506.7 5548.3 4064.4 4083.8 4097.8 4099.4 4100.3 5774.3 5907.6 5957.4 5961.3 6067.5 5738.5 5771.1 5775.1 5783.5 5792.8 5646.9 5732.6 5754.7 5761.5 5763.3 5668.8 5684.2 5703.6 5704.8 5713.8 5772.7 5778.5 5807.1 5815.5 5825.9 5528.2 5650.8 5652.7 5689.1 5690.3 19:39:08 INFO - PID 3525 | 19:39:08 INFO - PID 3525 | [#5] yui.html Cycles:180 Average:17320.23 Median:2945.35 stddev:23144.85 (785.8%) stddev-sans-first:23176.29 19:39:08 INFO - PID 3525 | Values: 739.0 755.5 767.4 767.6 779.3 11914.0 12283.4 13630.7 14622.6 14675.5 13457.6 13881.0 13954.6 14017.4 14058.4 867.9 882.1 884.3 885.6 886.8 895.1 896.4 899.0 899.7 900.5 934.1 935.5 937.8 938.2 939.5 918.5 920.2 929.1 931.1 933.2 678.1 686.5 686.8 686.9 689.8 13875.9 14067.2 14073.4 14103.6 14223.1 15742.6 16321.4 16809.2 16921.9 16933.1 11993.6 12221.6 12253.4 12394.9 12566.2 2779.1 2795.9 2796.8 2797.4 2798.3 83933.6 85725.1 85765.0 85897.0 87209.0 12332.6 12526.4 12663.9 12676.4 12695.4 22431.9 23128.5 23361.8 23372.4 23390.6 5890.4 5892.0 5895.6 5938.4 5957.0 2889.3 2901.8 2940.8 2949.9 2959.3 3683.4 3744.3 3747.2 3748.5 3768.1 651.6 655.4 659.8 739.3 792.8 605.1 618.7 621.4 644.2 647.4 9679.0 10234.5 10450.8 10969.7 11337.3 608.8 610.9 616.0 624.0 637.5 4403.5 4485.8 4508.2 4516.4 4533.0 83881.0 85457.6 86735.6 88812.0 89242.0 75656.0 75980.2 76191.2 76872.0 77313.0 60250.7 61320.4 62279.7 65826.0 67093.7 9268.6 10111.2 10174.2 10276.2 10541.5 26165.5 26784.0 27146.2 27559.4 28062.2 33111.5 33498.8 33563.3 33887.8 34089.8 14094.8 14141.6 14373.1 14538.3 14559.5 15492.1 15624.8 15648.5 15670.4 15909.2 14496.1 14904.9 15561.2 15779.8 15835.8 14658.9 14901.9 14935.2 15023.2 15136.4 13530.9 13727.1 13894.5 14785.5 14999.3 10553.2 10959.5 11129.5 11208.2 11312.8 11259.7 11558.0 11629.1 11685.9 11688.0 19:39:08 INFO - PID 3525 | -------- Summary: end -------- 19:39:08 INFO - PID 3525 | 19:39:09 INFO - TEST-INFO | 3525: exit 0 19:39:09 INFO - TEST-OK | dromaeo_css | took 1149461ms 19:39:09 INFO - TEST-START | kraken 19:39:09 INFO - operating with platform_type : linux_ 19:39:09 INFO - Initialising browser for kraken test... 19:39:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34009/getInfo.html -profile /tmp/tmp5t5474/profile 19:39:09 INFO - TEST-INFO | started process 3950 (/builds/slave/test/build/application/firefox/firefox http://localhost:34009/getInfo.html) 19:39:44 INFO - TEST-INFO | 3950: killed by SIGTERM 19:39:44 INFO - Browser initialized. 19:39:44 INFO - Running cycle 1/1 for kraken test... 19:39:44 INFO - TEST-INFO | started process 4176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5t5474/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:39:56 INFO - PID 4176 | RSS: Main: 172544000 19:39:56 INFO - PID 4176 | 19:39:59 INFO - PID 4176 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34009/tests/kraken/driver.html?testName=audio-beat-detection) 19:40:00 INFO - PID 4176 | RSS: Main: 177840128 19:40:00 INFO - PID 4176 | 19:40:02 INFO - PID 4176 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34009/tests/kraken/driver.html?testName=audio-dft) 19:40:03 INFO - PID 4176 | RSS: Main: 177467392 19:40:03 INFO - PID 4176 | 19:40:06 INFO - PID 4176 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34009/tests/kraken/driver.html?testName=audio-fft) 19:40:07 INFO - PID 4176 | RSS: Main: 175460352 19:40:07 INFO - PID 4176 | 19:40:09 INFO - PID 4176 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34009/tests/kraken/driver.html?testName=audio-oscillator) 19:40:09 INFO - PID 4176 | RSS: Main: 175931392 19:40:09 INFO - PID 4176 | 19:40:11 INFO - PID 4176 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34009/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:40:12 INFO - PID 4176 | RSS: Main: 176431104 19:40:12 INFO - PID 4176 | 19:40:15 INFO - PID 4176 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34009/tests/kraken/driver.html?testName=imaging-darkroom) 19:40:16 INFO - PID 4176 | RSS: Main: 180441088 19:40:16 INFO - PID 4176 | 19:40:19 INFO - PID 4176 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34009/tests/kraken/driver.html?testName=imaging-desaturate) 19:40:20 INFO - PID 4176 | RSS: Main: 176283648 19:40:20 INFO - PID 4176 | 19:40:23 INFO - PID 4176 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34009/tests/kraken/driver.html?testName=json-parse-financial) 19:40:24 INFO - PID 4176 | RSS: Main: 176701440 19:40:24 INFO - PID 4176 | 19:40:25 INFO - PID 4176 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34009/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:40:26 INFO - PID 4176 | RSS: Main: 176967680 19:40:26 INFO - PID 4176 | 19:40:28 INFO - PID 4176 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34009/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:40:28 INFO - PID 4176 | RSS: Main: 176771072 19:40:28 INFO - PID 4176 | 19:40:31 INFO - PID 4176 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34009/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:40:31 INFO - PID 4176 | RSS: Main: 176390144 19:40:31 INFO - PID 4176 | 19:40:34 INFO - PID 4176 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34009/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:40:35 INFO - PID 4176 | RSS: Main: 176574464 19:40:35 INFO - PID 4176 | 19:40:38 INFO - PID 4176 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34009/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:40:39 INFO - PID 4176 | RSS: Main: 176607232 19:40:39 INFO - PID 4176 | 19:40:40 INFO - PID 4176 | Cycle 1(1): loaded http://localhost:34009/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34009/tests/kraken/driver.html?testName=ai-astar) 19:40:41 INFO - PID 4176 | RSS: Main: 177782784 19:40:41 INFO - PID 4176 | 19:40:41 INFO - PID 4176 | __start_tp_report 19:40:41 INFO - PID 4176 | _x_x_mozilla_page_load 19:40:41 INFO - PID 4176 | _x_x_mozilla_page_load_details 19:40:41 INFO - PID 4176 | |i|pagename|runs| 19:40:41 INFO - PID 4176 | |0;ai-astar;105;112;115;111;114;116;111;111;112;114 19:40:41 INFO - PID 4176 | |1;audio-beat-detection;153;124;123;178;123;129;137;126;146;123 19:40:41 INFO - PID 4176 | |2;audio-dft;166;164;164;171;169;171;165;166;167;165 19:40:41 INFO - PID 4176 | |3;audio-fft;74;76;75;110;79;74;74;74;100;74 19:40:41 INFO - PID 4176 | |4;audio-oscillator;84;85;111;85;84;84;95;83;82;102 19:40:41 INFO - PID 4176 | |5;imaging-gaussian-blur;118;115;114;114;114;114;115;114;114;113 19:40:41 INFO - PID 4176 | |6;imaging-darkroom;150;150;154;151;150;155;152;151;151;150 19:40:41 INFO - PID 4176 | |7;imaging-desaturate;94;97;97;95;95;95;96;95;94;94 19:40:41 INFO - PID 4176 | |8;json-parse-financial;56;57;58;61;56;57;59;58;58;59 19:40:41 INFO - PID 4176 | |9;json-stringify-tinderbox;57;56;56;57;57;56;56;57;58;61 19:40:41 INFO - PID 4176 | |10;stanford-crypto-aes;98;87;89;87;87;87;89;90;120;89 19:40:41 INFO - PID 4176 | |11;stanford-crypto-ccm;142;138;136;133;133;146;151;135;138;143 19:40:41 INFO - PID 4176 | |12;stanford-crypto-pbkdf2;188;213;198;188;191;203;198;195;200;195 19:40:41 INFO - PID 4176 | |13;stanford-crypto-sha256-iterative;77;77;74;75;76;74;74;75;75;75 19:40:41 INFO - PID 4176 | __end_tp_report 19:40:41 INFO - PID 4176 | __start_cc_report 19:40:41 INFO - PID 4176 | _x_x_mozilla_cycle_collect,899 19:40:41 INFO - PID 4176 | __end_cc_report 19:40:41 INFO - PID 4176 | __startTimestamp1495766441127__endTimestamp 19:40:41 INFO - PID 4176 | 19:40:41 INFO - PID 4176 | ------- Summary: start ------- 19:40:41 INFO - PID 4176 | Number of tests: 14 19:40:41 INFO - PID 4176 | 19:40:41 INFO - PID 4176 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:3.07 (2.7%) stddev-sans-first:1.90 19:40:41 INFO - PID 4176 | Values: 105.0 112.0 115.0 111.0 114.0 116.0 111.0 111.0 112.0 114.0 19:40:41 INFO - PID 4176 | 19:40:41 INFO - PID 4176 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:133.00 stddev:18.12 (13.6%) stddev-sans-first:18.17 19:40:41 INFO - PID 4176 | Values: 153.0 124.0 123.0 178.0 123.0 129.0 137.0 126.0 146.0 123.0 19:40:41 INFO - PID 4176 | 19:40:41 INFO - PID 4176 | [#2] audio-dft Cycles:10 Average:166.80 Median:166.50 stddev:2.66 (1.6%) stddev-sans-first:2.80 19:40:41 INFO - PID 4176 | Values: 166.0 164.0 164.0 171.0 169.0 171.0 165.0 166.0 167.0 165.0 19:40:41 INFO - PID 4176 | 19:40:41 INFO - PID 4176 | [#3] audio-fft Cycles:10 Average:81.00 Median:74.00 stddev:12.96 (17.5%) stddev-sans-first:13.50 19:40:41 INFO - PID 4176 | Values: 74.0 76.0 75.0 110.0 79.0 74.0 74.0 74.0 100.0 74.0 19:40:41 INFO - PID 4176 | 19:40:41 INFO - PID 4176 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:84.00 stddev:9.88 (11.8%) stddev-sans-first:10.28 19:40:41 INFO - PID 4176 | Values: 84.0 85.0 111.0 85.0 84.0 84.0 95.0 83.0 82.0 102.0 19:40:41 INFO - PID 4176 | 19:40:41 INFO - PID 4176 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:0.60 19:40:41 INFO - PID 4176 | Values: 118.0 115.0 114.0 114.0 114.0 114.0 115.0 114.0 114.0 113.0 19:40:41 INFO - PID 4176 | 19:40:41 INFO - PID 4176 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.00 stddev:1.78 (1.2%) stddev-sans-first:1.81 19:40:41 INFO - PID 4176 | Values: 150.0 150.0 154.0 151.0 150.0 155.0 152.0 151.0 151.0 150.0 19:40:41 INFO - PID 4176 | 19:40:41 INFO - PID 4176 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.14 (1.2%) stddev-sans-first:1.12 19:40:41 INFO - PID 4176 | Values: 94.0 97.0 97.0 95.0 95.0 95.0 96.0 95.0 94.0 94.0 19:40:41 INFO - PID 4176 | 19:40:41 INFO - PID 4176 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.00 stddev:1.52 (2.6%) stddev-sans-first:1.45 19:40:41 INFO - PID 4176 | Values: 56.0 57.0 58.0 61.0 56.0 57.0 59.0 58.0 58.0 59.0 19:40:41 INFO - PID 4176 | 19:40:41 INFO - PID 4176 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:1.52 (2.7%) stddev-sans-first:1.62 19:40:41 INFO - PID 4176 | Values: 57.0 56.0 56.0 57.0 57.0 56.0 56.0 57.0 58.0 61.0 19:40:41 INFO - PID 4176 | 19:40:41 INFO - PID 4176 | [#10] stanford-crypto-aes Cycles:10 Average:92.30 Median:89.00 stddev:10.27 (11.5%) stddev-sans-first:10.69 19:40:41 INFO - PID 4176 | Values: 98.0 87.0 89.0 87.0 87.0 87.0 89.0 90.0 120.0 89.0 19:40:41 INFO - PID 4176 | 19:40:41 INFO - PID 4176 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:140.00 stddev:5.91 (4.2%) stddev-sans-first:6.20 19:40:41 INFO - PID 4176 | Values: 142.0 138.0 136.0 133.0 133.0 146.0 151.0 135.0 138.0 143.0 19:40:41 INFO - PID 4176 | 19:40:41 INFO - PID 4176 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.90 Median:198.00 stddev:7.52 (3.8%) stddev-sans-first:7.25 19:40:41 INFO - PID 4176 | Values: 188.0 213.0 198.0 188.0 191.0 203.0 198.0 195.0 200.0 195.0 19:40:41 INFO - PID 4176 | 19:40:41 INFO - PID 4176 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:75.00 stddev:1.14 (1.5%) stddev-sans-first:1.00 19:40:41 INFO - PID 4176 | Values: 77.0 77.0 74.0 75.0 76.0 74.0 74.0 75.0 75.0 75.0 19:40:41 INFO - PID 4176 | -------- Summary: end -------- 19:40:41 INFO - PID 4176 | 19:40:42 INFO - TEST-INFO | 4176: exit 0 19:40:42 INFO - TEST-OK | kraken | took 93176ms 19:40:42 INFO - SUITE-END | took 1242s 19:40:42 INFO - Completed test suite (00:20:42) 19:40:42 INFO - javascript benchmark 19:40:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6707.916137118632, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2698.716634753351, 2723.128598848367, 2739.2740923655233, 2761.875715592797, 2764.3780149466374, 5087.592992560595, 5151.0, 5204.479552044793, 5206.193040078789, 5206.8698282542955, 5135.486451354872, 5146.5625421839095, 5152.40747314059, 5239.397469291023, 5242.895142097156, 4587.747673877935, 4631.745254011028, 4660.5339466053465, 4673.065386922612, 4706.5293470653005, 4683.180443422404, 4691.9296210556695, 4714.90570188596, 4734.692245004081, 4745.09843129806, 4563.885902852455, 4603.171429142753, 4633.351330813689, 4649.070185962821, 4669.486356500782, 4649.604783593399, 4650.511696271877, 4673.158831410345, 4677.251639737626, 4709.7174169549935, 4596.7931443085145, 4602.171609110359, 4607.124646317189, 4622.699524530928, 4630.768461576941, 5016.548510634024, 5074.441811400743, 5089.3638295213095, 5166.483351664841, 5185.662931909452, 5486.204500347428, 5540.390557038722, 5592.328920529562, 5594.049011667986, 5615.382307946123, 5590.91613625796, 5607.943920560783, 5618.325800903876, 5623.325200975909, 5626.437356264381, 5212.374515058179, 5212.8957420851375, 5219.765110570033, 5240.895182096337, 5276.577873770089, 5631.155326701028, 5679.488846003796, 5682.943170568324, 5766.711664416763, 5767.423257674199, 5396.757145928443, 5397.7571009304675, 5405.594580406485, 5456.972715136479, 5511.173324001432, 5522.116461366162, 5529.806456774074, 5564.777408903679, 5580.1629755537, 5616.606837521416, 5470.617056805985, 5496.862578435571, 5548.778048878, 5584.162375643686, 5596.300462442195, 5589.217509548666, 5607.7476513556985, 5608.383077861432, 5612.859678507988, 5626.0, 4658.790354433991, 4668.50980647034, 4670.64970127235, 4677.555632214934, 4712.458067322234, 4010.859619913289, 4018.517777866675, 4019.457373254573, 4045.0291929937193, 4053.108316170438, 4586.128635559233, 4657.138429390574, 4678.625709943196, 4740.834070807574, 4751.382320298339, 5621.971890140605, 5629.099344105005, 5634.239377684042, 5638.238837756932, 5681.943180568224, 4718.8584342469785, 4724.338592597039, 4736.052789442126, 4741.83403580873, 4744.146053710365, 4901.681390709592, 4930.580900623416, 4965.677230979974, 4972.353594032753, 4972.776225069808, 5181.766820493011, 5190.922136168036, 5191.351081114861, 5228.424873263862, 5240.633155679066, 5508.862278442911, 5522.696251706195, 5589.5807814413265, 5597.244372009726, 5601.915971260516, 5167.58659307262, 5178.71517066565, 5214.504622060898, 5225.1117310056625, 5237.973810131078, 5410.810621628224, 5536.086545719912, 5537.307836520435, 5537.972310138423, 5541.113421852484, 5568.220449137043, 5575.581831362583, 5609.747561359667, 5675.404082571271, 5690.630109042899, 5451.945480545144, 5463.344398672185, 5476.890462190813, 5512.228288039598, 5522.475364840334, 5411.756470958738, 5464.808731694372, 5467.17992301158, 5471.425500322409, 5474.479924407175, 5271.7891284349735, 5323.547498462674, 5339.893202135858, 5355.678659280456, 5386.865328366822, 5328.333958255218, 5387.515123638735, 5388.110961691277, 5429.511343978903, 5445.809396671098, 5176.4047134578495, 5177.689338639693, 5238.633295669267, 5250.65870718402, 5301.0], "value": 5063.176522135011, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.555417870027, 692.6848284030765, 712.3588770106903, 1143.1540659911668, 1170.2159553099423, 33025.174370640714, 33674.49488257675, 33779.32441351171, 33820.49269260963, 33834.15414614636, 31494.842525787397, 31761.0, 31845.36309273813, 31875.203119921956, 31918.36163276733, 6167.136600875881, 6642.966785166067, 6780.627065511395, 6806.7957961261245, 6810.216825065107, 6794.966025169867, 6889.34551217636, 6902.827429314257, 6920.134983127109, 6941.826454338657, 6840.31596840317, 6909.758158464455, 6917.446604271646, 6926.896096558556, 6949.548279361826, 6873.037774711544, 6904.13698287714, 6905.205901321337, 6932.341427564374, 6935.4104901083465, 6628.900566491507, 6673.899891501631, 6676.899846502306, 6679.064930909628, 6699.631520266384, 30782.23044423885, 30875.22811929697, 30890.227744306347, 30899.382012359853, 30922.226944326572, 3084.3522860199387, 3100.3799240151834, 3103.1156120505775, 3108.1607965849093, 3108.2384815720065, 24034.879825600936, 24035.87982060096, 24144.396390090213, 24162.758372416403, 24209.152679656305, 2843.957340639892, 2852.1728698677357, 2877.7697784177426, 2890.2629829393372, 2904.0271509044496, 146389.0, 147234.99999999892, 147280.0, 155556.0, 159074.0, 38381.61618383836, 38645.03387415281, 38647.6135238644, 38648.80675596604, 38753.41869871954, 39933.80033099816, 39993.80003099966, 39997.80001099976, 40008.199836003114, 42472.36291455631, 12603.621891343275, 12684.80972785409, 12788.744225115446, 12814.67963300925, 12955.0, 9948.054934781185, 10087.596496140219, 10111.443870587189, 10440.63457778974, 10473.266871319087, 12570.182938108994, 12646.177998430072, 12659.873401266053, 12688.936555317348, 12775.105742597929, 5256.26412302278, 5329.173978033411, 5390.838274851761, 5414.675119492843, 5459.344878614592, 872.1496540872726, 921.5346250143634, 925.0887875442684, 929.4098247612815, 954.5227386306847, 20168.29410970609, 20661.793382066287, 21502.0, 21755.782442175376, 21785.346439606838, 986.5264672956878, 990.2770977186694, 993.4784238274964, 1023.6570748799087, 1024.897510248984, 10963.50664220112, 11277.097832173406, 11359.943200283946, 11487.25332853362, 11493.482793274323, 184035.0, 184080.0, 184256.0, 184820.0, 185178.0, 40257.396139057935, 40607.7969610156, 40640.593594064274, 40648.18703625911, 40686.18627627431, 1197.6107764976418, 1245.9563915263104, 1255.347219445883, 1260.6596219020996, 1262.5265525427965, 20018.499537511678, 20458.283960061326, 21206.15175392967, 21561.92873625206, 21606.783932161106, 29587.556186656788, 35903.76866082065, 36670.266594668494, 36707.08232294214, 36896.81551592225, 167897.0, 168251.0, 169803.0, 170459.0, 171104.0, 29805.850970745007, 30170.54744178883, 30515.0, 30526.84736576392, 30591.847040764653, 34685.826570866986, 35271.0, 35769.28461430809, 35830.46254306239, 36012.81993590015, 27251.59122613202, 28019.719802801712, 28078.85960570184, 28213.71786282193, 28662.856685716437, 24085.75914240835, 27453.17640470789, 28079.57880631833, 28276.71723282741, 29553.0, 31244.375112498077, 31308.0, 31708.207294817814, 31890.202744930633, 32009.67990320067, 27396.589051164647, 27416.0, 27532.862335688995, 27977.642682878184, 29092.418151636426, 20320.59358812845, 22576.565406075635, 22606.773932261123, 22705.772942270367, 22745.886270568542], "value": 14586.149472649426, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.87572852415735, 414.7843121576782, 420.2813189446047, 430.2578052858818, 444.5310197741384, 17172.3131074757, 17417.21622526986, 17712.0, 17764.37824676135, 17985.37051203208, 17934.82065179351, 18165.273389064456, 18169.818301816977, 18890.43328700141, 19025.904870475628, 5290.761915713783, 5410.269613602172, 5487.2317875497465, 5534.225208470817, 5643.435656434365, 5276.15581506959, 5440.6735595864375, 5451.509364157225, 5461.617686761928, 5462.535684466825, 5369.9463005370035, 5429.701366424845, 5439.564834813225, 5444.128939369702, 5450.127979523277, 5255.763490642911, 5411.431799661038, 5431.103867861798, 5451.400345961941, 5453.018456677796, 4886.682365646222, 4909.803607855682, 4929.556339929388, 4932.950670493321, 4953.702777833341, 20824.47938801542, 21210.575788484144, 21430.357089287347, 21538.569228615495, 21657.783422165736, 1651.719207734688, 1666.8666506679438, 1684.3262694922007, 1687.1311274693542, 1690.357664087651, 14245.074070185508, 14302.0, 14440.85559144416, 14526.564203073925, 14897.329620167118, 1976.644204043286, 2011.0950072467301, 2041.2243347527992, 2086.113401804242, 2087.5094352827073, 77113.61443192748, 77311.22688773152, 77779.22220777832, 78387.6080619599, 78502.60748696278, 10891.83662245067, 10946.890531094587, 11087.889121108847, 11258.943705281585, 11397.772044559228, 15629.765553516707, 15653.295601697951, 15721.528354149394, 15725.292361843745, 15749.68500629981, 7466.0, 7542.396608271325, 7710.961445192738, 7744.883826742604, 7778.572178530235, 6923.238443771181, 6995.510314277952, 7008.194057683329, 7135.5361901476235, 7168.8529835227155, 6887.827804304932, 6889.138857642794, 6984.2317345092, 6985.93014069863, 7015.473839462061, 1965.8427325814187, 1995.8103980121866, 2024.8278896293684, 2040.9387718368473, 2043.1929387891996, 855.2260204514924, 870.2211520688948, 895.2882458445551, 897.5781382750097, 904.8642703594381, 16675.91662041682, 16822.158892055348, 16917.238724257437, 16928.068956207528, 17606.735898961524, 880.5641207602278, 886.6453418632469, 890.3500444675424, 897.7800438892383, 910.4582773249906, 9017.729468115967, 9304.395214311184, 9570.521473926276, 9598.856017159747, 9714.22286217101, 342040.0, 345531.0, 349373.0, 350164.0, 350648.0, 76071.61964190143, 76746.61626691831, 77737.0, 78004.0, 78304.60847695725, 1035.6168217759478, 1049.344159900047, 1050.9159267258601, 1055.7993981143559, 1065.6057258814287, 14252.643683907985, 14465.349059292146, 14486.710265794414, 14503.419863205354, 15071.4724984625, 37214.44178337273, 37505.2498950025, 37832.0, 37888.81055594704, 38734.418983715834, 45245.321320179566, 51167.0, 52396.738016309675, 53367.46632533625, 53902.0, 7918.564478953713, 8050.637721302673, 8057.637406316612, 8222.588870556328, 8340.666373344999, 11965.940170299093, 12069.637910862688, 12686.238825670489, 13177.670558236121, 13190.60428187156, 10641.414722190353, 10959.945200274267, 11064.612738554111, 11240.606578769704, 11895.0, 10259.333143345659, 10273.794524109626, 10371.636992705218, 10486.161107111566, 10659.94670026645, 10802.837957430487, 10979.615713449992, 11210.83183752228, 11254.324740515594, 11282.379469129277, 8214.26071653554, 8261.83476330482, 8511.446755960842, 8573.399862009599, 8595.269402100892, 10650.254482186172, 10666.0, 10698.679039628823, 11174.944125279322, 11269.49287282058], "value": 8739.774857258903, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.3863745402205, 1330.8469526004512, 1331.8401791784988, 1343.0934119469362, 1348.0900392235242, 10092.24308176887, 10451.529681164347, 10531.315464494803, 10548.261621686484, 10747.62383316584, 10189.337693049965, 10462.790744185111, 10536.26246162769, 10542.947285263583, 10566.947165264162, 2078.4596005038684, 2119.7668256491775, 2119.872807631547, 2120.279105104264, 2130.2970019893396, 1973.9111739971736, 2012.869163504375, 2022.5651484930736, 2023.8077382648626, 2029.81731644152, 2091.843111766616, 2101.2015434135005, 2110.0610228448268, 2113.3448630924386, 2120.321497120922, 1899.5251187203198, 1918.9136488858035, 1924.8748831326059, 1925.0663428237294, 1927.7493925789697, 1867.0, 1875.7373967644542, 1897.1368027547571, 1912.053533500912, 2006.518435575466, 10339.379637221791, 10399.532021058994, 10402.063814256677, 10403.947980260125, 10409.843852342221, 5233.110371236899, 5396.082665946798, 5397.217403476513, 5411.404745477994, 5430.484104010113, 3153.085605174497, 3265.804051756902, 3285.917852053694, 3328.6005679318637, 3332.6334103248623, 1074.5486895503907, 1079.3631757263252, 1094.781043791237, 1106.955721771128, 1119.7144728094283, 14771.409143634242, 15037.774433383507, 15076.924615376962, 15103.5468935931, 15116.546503604799, 4426.468823741172, 4554.658400619966, 4673.182193116191, 4674.929876051794, 4683.0, 10810.135189184846, 10814.78370432587, 10835.83746243807, 10842.186835987333, 10853.891461085288, 5276.92084618731, 5492.642978206404, 5493.066178749622, 5500.064988951888, 5500.669959802424, 5063.797448102108, 5067.645264831426, 5102.719350435687, 5112.795488180505, 5129.461406552333, 3680.190358121209, 3716.95925140961, 3720.2373513429684, 3787.8484860605818, 3801.6388443098413, 1038.4132964874973, 1038.849366841819, 1039.2880876599554, 1059.0627294844119, 1060.2790102730064, 718.9820254493575, 751.751921865783, 754.1101500229781, 766.31797700047, 766.9616519174019, 5687.914681279784, 5780.826575202751, 5877.353491115974, 5920.615160014585, 6002.459778619946, 564.6724899558246, 576.7779404929132, 579.1862433281246, 582.4961408381804, 587.8442212813608, 3843.5387753469204, 3914.2954268231993, 3929.941050884239, 4063.9390409143884, 4107.219628270619, 12013.87986120145, 13187.73624527504, 13699.0, 13706.040577159703, 13713.862861371457, 12972.545960891512, 13523.0, 13567.932160339134, 13584.592462226148, 13638.659033524242, 7536.773896783106, 7621.12357078943, 7626.3898888089925, 7637.847243055107, 7645.694172233048, 5831.300243970581, 5966.642001479925, 6080.90878636812, 6218.689065546614, 6422.839429014312, 11842.289462631925, 12143.08926830509, 12148.635540933787, 12376.81434778461, 12384.62846114618, 12287.324197169242, 12481.56314528987, 12537.749245014866, 12621.558245461365, 12750.872491274968, 7470.572064079304, 7696.384289256734, 7699.461037727306, 7703.191164927826, 7709.843523471524, 9280.118388753057, 9401.529923503935, 9402.341836071682, 9410.57652405657, 9427.292953028413, 7954.323882470055, 8020.879686804819, 8022.3181029610805, 8089.797755056171, 8362.163783621589, 7856.410769192219, 7955.920440795518, 7961.641726122222, 7968.282854543119, 8005.759827205193, 7266.745663901738, 7406.03721516221, 7424.925750742639, 7434.442416818868, 7449.515781474187, 4885.926711099265, 5199.55803756685, 5212.322398088224, 5452.645578037414, 5502.422245664147, 5215.087359711959, 5247.632665713363, 5274.4198138204, 5313.920291195713, 5460.6996615186545], "value": 4635.447907981758, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.7286380941914, 375.1053736837641, 384.3619591478147, 384.63843986652546, 385.0604524959099, 5367.490088441592, 5422.237772723865, 5466.999999999995, 5477.151041588555, 5564.4713752193575, 5309.123994540906, 5383.562601772209, 5392.622516423852, 5395.514403703666, 5410.431904650014, 4012.8194231259663, 4118.958810411902, 4133.875983720493, 4136.855210067633, 4147.253494371012, 4129.752214867118, 4138.3999320098565, 4140.544540100602, 4143.7720925349095, 4153.107081977374, 4090.1615168890453, 4091.9386209206887, 4092.1406504634065, 4092.9386059209137, 4096.487939007624, 4046.251443482965, 4065.2276067547073, 4072.552019277877, 4081.5918408159096, 4083.7958102094776, 3578.8389522471552, 3581.0, 3584.211473475831, 3584.910377240564, 3598.964010359889, 5195.870103247411, 5245.239440281138, 5348.438413966555, 5349.491798279158, 5355.919661205085, 4745.525447455261, 4758.619310455155, 4762.595179409755, 4799.784009719571, 4823.614110871122, 5705.0, 5743.856403589902, 5747.942520574783, 5749.942500574983, 5765.711714414305, 3976.602339766, 3989.3816458448987, 3993.3610622300585, 3994.4807175067344, 4023.597640235953, 6005.477699366276, 6064.181335519736, 6101.359357267467, 6135.570510064297, 6150.0, 4090.795460226977, 4106.650934670586, 4110.581849262, 4110.671146308288, 4113.0, 4119.6910231732145, 4124.4019617155345, 4134.793260337031, 4153.899216707575, 4170.0, 4683.367745354401, 4792.664513484023, 4804.855854324376, 4811.123661771911, 4843.200871856175, 5795.391483894215, 5813.505852002542, 5821.592488525847, 5838.941610583925, 5846.766129354864, 1406.655369434495, 1418.1207651256286, 1418.3404716806735, 1426.6718654709475, 1432.4270291883122, 920.1074957291416, 946.7491114854569, 961.7691753979135, 969.8690676758547, 972.1736523954582, 4917.557419832232, 4964.67729597575, 4973.1297023020825, 4974.0, 4999.275105109738, 5934.703264836828, 5952.345242023374, 5976.147394307778, 6001.2498437695285, 6023.698815059317, 4834.7454240268335, 4936.950630493721, 4951.158303088484, 4969.254611808257, 4972.229304457815, 3126.609173853268, 3188.4420226460275, 3192.138122706903, 3192.792468489587, 3193.952090718641, 5519.668819870821, 5519.668819870821, 5526.281583394133, 5538.889222215533, 5541.750621221974, 5952.404759524013, 6092.3603021682975, 6119.204503414617, 6119.418655227746, 6130.2030736004035, 5255.185446255837, 5485.424030476902, 5495.203195536625, 5501.972490137524, 5502.413865483297, 5936.575221946615, 5953.255843019622, 5958.910616340671, 5991.310999235144, 6011.458968692664, 5730.484256416776, 5855.151003104611, 5865.501432378295, 5882.705864706833, 5901.439363260483, 5492.670439773627, 5498.917516237179, 5500.724963751876, 5506.724663766716, 5548.306461692288, 4064.3700226464944, 4083.774867539667, 4097.7541347519245, 4099.446574712376, 4100.282450571198, 5774.307083150049, 5907.616004959664, 5957.374475680164, 5961.2846458425265, 6067.544934130046, 5738.483536481736, 5771.134329850556, 5775.104858746901, 5783.450572195635, 5792.768289268551, 5646.85882852932, 5732.570057245806, 5754.741036653277, 5761.5390768739235, 5763.250777398911, 5668.773249069991, 5684.232628595087, 5703.600747947604, 5704.80033198836, 5713.800016999385, 5772.7402266898935, 5778.479936805539, 5807.128930660435, 5815.476607105381, 5825.912611310919, 5528.226048353315, 5650.773969041193, 5652.745626446737, 5689.146628005832, 5690.260266165372], "value": 4299.364481646243, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.9778306650795, 755.4636208292115, 767.4052609227848, 767.6392095715014, 779.3414564692835, 11914.0, 12283.44724487398, 13630.727385452285, 14622.561323160297, 14675.486357977474, 13457.596272111829, 13881.0, 13954.581362559114, 14017.36921838517, 14058.367373468192, 867.8611422172454, 882.1222883231194, 884.332329091535, 885.6457417033174, 886.7605746448455, 895.1496078725205, 896.4083704754863, 899.0470101692194, 899.7480705402497, 900.5002223765807, 934.103260869566, 935.5135329628589, 937.8171256604965, 938.2447130060299, 939.5490164720939, 918.4810582021137, 920.1534588178858, 929.061647735785, 931.1433481197247, 933.1927882381725, 678.0608856733411, 686.4679873098339, 686.8111269400905, 686.8626274745021, 689.7861662884521, 13875.861241387558, 14067.226302553356, 14073.36669849849, 14103.576892693132, 14223.146611203361, 15742.606434839106, 16321.428749993693, 16809.15954202285, 16921.915390422968, 16933.06868122253, 11993.64019079429, 12221.572244971383, 12253.387330633434, 12394.938025309906, 12566.246025238515, 2779.069011881022, 2795.888164473419, 2796.804223704321, 2797.37059161689, 2798.3004248937764, 83933.58033209795, 85725.14274857297, 85765.0, 85897.0, 87209.0, 12332.568360107352, 12526.37368131608, 12663.873361266453, 12676.366181691063, 12695.428705708266, 22431.887840560692, 23128.537429251322, 23361.7663823363, 23372.415689607897, 23390.64914026291, 5890.440408161304, 5892.0, 5895.616784909053, 5938.376470470538, 5956.970215148983, 2889.2921234297733, 2901.8113822601886, 2940.8382538960136, 2949.8525073746227, 2959.2897704551183, 3683.4474828775897, 3744.2885851688093, 3747.194353214072, 3748.475213470116, 3768.1333293342686, 651.6481100205931, 655.3970347280418, 659.8350412396901, 739.2976672161468, 792.7740593930702, 605.0742364182807, 618.7494064903722, 621.4220774679501, 644.1818890009662, 647.4011539326199, 9679.0, 10234.48827558619, 10450.790984180274, 10969.725756855983, 11337.26307789991, 608.7747533412577, 610.914471973924, 615.9661218632929, 624.0389799708489, 637.4900079936033, 4403.53762854902, 4485.798139083749, 4508.233600287959, 4516.36770852081, 4532.9546704533195, 83881.0, 85457.57271213604, 86735.56632216925, 88812.0, 89242.0, 75656.0, 75980.24019759842, 76191.23808761952, 76872.0, 77313.0, 60250.69874650599, 61320.38679613325, 62279.6886015567, 65826.0, 67093.66453167703, 9268.629254829732, 10111.241656875616, 10174.186065114922, 10276.22928280367, 10541.525631346454, 26165.476690465704, 26784.0, 27146.185614431597, 27559.448811023267, 28062.158135255973, 33111.50332744962, 33498.83250583829, 33563.32873342568, 33887.83056084704, 34089.82955085209, 14094.788578171541, 14141.575752727435, 14373.137611743328, 14538.273086345429, 14559.490417835324, 15492.147931863856, 15624.765628515808, 15648.530544083696, 15670.373185072469, 15909.204539772734, 14496.130232186102, 14904.850951490347, 15561.221938903236, 15779.842201577838, 15835.841641583436, 14658.926705366404, 14901.92549037248, 14935.17856517902, 15023.248837558296, 15136.394544218549, 13530.93234533821, 13727.107737996997, 13894.513692020731, 14785.482508112165, 14999.2500374983, 10553.208509361983, 10959.50682219318, 11129.499172537417, 11208.215424920178, 11312.83030754523, 11259.662210133709, 11558.0, 11629.127815413709, 11685.883141168479, 11688.0], "value": 7081.626260855457, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1565.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 115.0, 111.0, 114.0, 116.0, 111.0, 111.0, 112.0, 114.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 123.0, 178.0, 123.0, 129.0, 137.0, 126.0, 146.0, 123.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 164.0, 171.0, 169.0, 171.0, 165.0, 166.0, 167.0, 165.0], "value": 166.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 110.0, 79.0, 74.0, 74.0, 74.0, 100.0, 74.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 111.0, 85.0, 84.0, 84.0, 95.0, 83.0, 82.0, 102.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 113.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 154.0, 151.0, 150.0, 155.0, 152.0, 151.0, 151.0, 150.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 97.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 61.0, 56.0, 57.0, 59.0, 58.0, 58.0, 59.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 57.0, 57.0, 56.0, 56.0, 57.0, 58.0, 61.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 87.0, 89.0, 87.0, 87.0, 87.0, 89.0, 90.0, 120.0, 89.0], "value": 92.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 138.0, 136.0, 133.0, 133.0, 146.0, 151.0, 135.0, 138.0, 143.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 213.0, 198.0, 188.0, 191.0, 203.0, 198.0, 195.0, 200.0, 195.0], "value": 196.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 74.0, 75.0, 76.0, 74.0, 74.0, 75.0, 75.0, 75.0], "value": 75.2, "unit": "score"}]}]} 19:40:42 INFO - Return code: 0 19:40:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:40:42 INFO - # TBPL SUCCESS # 19:40:42 INFO - Running post-action listener: _resource_record_post_action 19:40:42 INFO - [mozharness: 2017-05-26 02:40:42.438619Z] Finished run-tests step (success) 19:40:42 INFO - Running post-run listener: _resource_record_post_run 19:40:42 INFO - Total resource usage - Wall time: 1259s; CPU: 13.0%; Read bytes: 8720384; Write bytes: 407359488; Read time: 2396; Write time: 277348 19:40:42 INFO - TinderboxPrint: CPU usage
12.7% 19:40:42 INFO - TinderboxPrint: I/O read bytes / time
8,720,384 / 2,396 19:40:42 INFO - TinderboxPrint: I/O write bytes / time
407,359,488 / 277,348 19:40:42 INFO - TinderboxPrint: CPU idle
8,771.6 (87.3%) 19:40:42 INFO - TinderboxPrint: CPU user
1,218.4 (12.1%) 19:40:42 INFO - TinderboxPrint: Swap in / out
0 / 0 19:40:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 99577856; Read time: 96; Write time: 83536 19:40:42 INFO - run-tests - Wall time: 1243s; CPU: 13.0%; Read bytes: 6356992; Write bytes: 307781632; Read time: 1820; Write time: 193812 19:40:43 INFO - Running post-run listener: _upload_blobber_files 19:40:43 INFO - Blob upload gear active. 19:40:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:40:43 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 19:40:43 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'] 19:40:43 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 19:40:43 INFO - (blobuploader) - INFO - Open directory for files ... 19:40:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:40:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:40:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:40:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:40:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:40:45 INFO - (blobuploader) - INFO - Done attempting. 19:40:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:40:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:40:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:40:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:40:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:40:46 INFO - (blobuploader) - INFO - Done attempting. 19:40:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:40:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:40:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:40:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:40:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:40:52 INFO - (blobuploader) - INFO - Done attempting. 19:40:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:40:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:40:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:40:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:40:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:40:53 INFO - (blobuploader) - INFO - Done attempting. 19:40:53 INFO - (blobuploader) - INFO - Iteration through files over. 19:40:53 INFO - Return code: 0 19:40:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:40:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:40:53 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dafa0389cb4d9435ec6dbe64df317aeba06ee224b668eda6df4ebf97cc5f98a73f28b72db7c2e07616fd3cf4e0831257992e54dcfbbb27281be152a4a749305", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a84b465926ec3bef4d036109fc24bbe9f127b394039c367e812b03aa4d893d5d112a3c908aa19b2ca83f06da159295597bc8da757c3bbd53bf584de5a247565", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2fa4442c335b41f63813e44b57e6990052c7043e8a1c874bda8685b3dd7789b49276178785c5d88426eaf5bbe281c59e5e9358ad4e48114340ac6b0b7340b81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cecf2c04bfe111b880808ede8353bbd62b966c107ab9d3cd0a6f71654f1155aef53c3807eded68c8fc9bae43d06f84e56e28796fb768e101f6c81b088d5ab6e"} 19:40:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:40:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:40:53 INFO - Contents: 19:40:53 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dafa0389cb4d9435ec6dbe64df317aeba06ee224b668eda6df4ebf97cc5f98a73f28b72db7c2e07616fd3cf4e0831257992e54dcfbbb27281be152a4a749305", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a84b465926ec3bef4d036109fc24bbe9f127b394039c367e812b03aa4d893d5d112a3c908aa19b2ca83f06da159295597bc8da757c3bbd53bf584de5a247565", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2fa4442c335b41f63813e44b57e6990052c7043e8a1c874bda8685b3dd7789b49276178785c5d88426eaf5bbe281c59e5e9358ad4e48114340ac6b0b7340b81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cecf2c04bfe111b880808ede8353bbd62b966c107ab9d3cd0a6f71654f1155aef53c3807eded68c8fc9bae43d06f84e56e28796fb768e101f6c81b088d5ab6e"} 19:40:53 INFO - Running post-run listener: copy_logs_to_upload_dir 19:40:53 INFO - Copying logs to upload dir... 19:40:53 INFO - mkdir: /builds/slave/test/build/upload/logs 19:40:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1332.915953 ========= master_lag: 0.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 13 secs) (at 2017-05-25 19:40:53.775409) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 19:40:53.779842) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428 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/7dafa0389cb4d9435ec6dbe64df317aeba06ee224b668eda6df4ebf97cc5f98a73f28b72db7c2e07616fd3cf4e0831257992e54dcfbbb27281be152a4a749305", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a84b465926ec3bef4d036109fc24bbe9f127b394039c367e812b03aa4d893d5d112a3c908aa19b2ca83f06da159295597bc8da757c3bbd53bf584de5a247565", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2fa4442c335b41f63813e44b57e6990052c7043e8a1c874bda8685b3dd7789b49276178785c5d88426eaf5bbe281c59e5e9358ad4e48114340ac6b0b7340b81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cecf2c04bfe111b880808ede8353bbd62b966c107ab9d3cd0a6f71654f1155aef53c3807eded68c8fc9bae43d06f84e56e28796fb768e101f6c81b088d5ab6e"} build_url:https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/Jpw0YMk3QZ2w6sRLR3PrOw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dafa0389cb4d9435ec6dbe64df317aeba06ee224b668eda6df4ebf97cc5f98a73f28b72db7c2e07616fd3cf4e0831257992e54dcfbbb27281be152a4a749305", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7a84b465926ec3bef4d036109fc24bbe9f127b394039c367e812b03aa4d893d5d112a3c908aa19b2ca83f06da159295597bc8da757c3bbd53bf584de5a247565", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2fa4442c335b41f63813e44b57e6990052c7043e8a1c874bda8685b3dd7789b49276178785c5d88426eaf5bbe281c59e5e9358ad4e48114340ac6b0b7340b81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8cecf2c04bfe111b880808ede8353bbd62b966c107ab9d3cd0a6f71654f1155aef53c3807eded68c8fc9bae43d06f84e56e28796fb768e101f6c81b088d5ab6e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 19:40:53.810393) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:40:53.810946) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1495765117.987338-652219428 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:40:53.893199) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 19:40:53.893571) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 19:40:53.893932) ========= ========= Total master_lag: 0.37 =========