builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-076 starttime: 1495765084.82 results: success (0) revision: 862e534ade6d17176b09aeeb5dae63fdb53eddeb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:04.824275) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:04.824688) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:04.824950) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:04.857557) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:04.857850) ========= 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=9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-25 19:18:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 211M=0s 2017-05-25 19:18:05 (211 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.176849 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:05.051234) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:05.051537) ========= 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=9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015526 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:05.100826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-25 19:18:05.101136) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 862e534ade6d17176b09aeeb5dae63fdb53eddeb --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 862e534ade6d17176b09aeeb5dae63fdb53eddeb --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=9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-25 19:18:05,160 truncating revision to first 12 chars 2017-05-25 19:18:05,161 Setting DEBUG logging. 2017-05-25 19:18:05,161 attempt 1/10 2017-05-25 19:18:05,161 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/862e534ade6d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-25 19:18:06,053 unpacking tar archive at: mozilla-central-862e534ade6d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.415701 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-25 19:18:06.531869) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:06.535196) ========= script_repo_revision: 862e534ade6d17176b09aeeb5dae63fdb53eddeb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:06.535580) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:06.535837) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 19:18:06.544590) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2017-05-25 19:18:06.544868) ========= /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=9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:18:06 INFO - MultiFileLogger online at 20170525 19:18:06 in /builds/slave/test 19:18:06 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:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:18:06 INFO - {'append_to_log': False, 19:18:06 INFO - 'base_work_dir': '/builds/slave/test', 19:18:06 INFO - 'blob_upload_branch': 'Firefox', 19:18:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:18:06 INFO - 'branch': 'Firefox', 19:18:06 INFO - 'buildbot_json_path': 'buildprops.json', 19:18:06 INFO - 'config_files': ('talos/linux_config.py',), 19:18:06 INFO - 'default_actions': ('clobber', 19:18:06 INFO - 'read-buildbot-config', 19:18:06 INFO - 'download-and-extract', 19:18:06 INFO - 'populate-webroot', 19:18:06 INFO - 'create-virtualenv', 19:18:06 INFO - 'install', 19:18:06 INFO - 'run-tests'), 19:18:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:18:06 INFO - 'download_minidump_stackwalk': True, 19:18:06 INFO - 'download_symbols': 'ondemand', 19:18:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:18:06 INFO - 'tooltool.py': '/tools/tooltool.py', 19:18:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:18:06 INFO - '/tools/misc-python/virtualenv.py')}, 19:18:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:18:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:18:06 INFO - 'gecko_profile': False, 19:18:06 INFO - 'gecko_profile_interval': 0, 19:18:06 INFO - 'installer_path': 'installer.exe', 19:18:06 INFO - 'log_level': 'info', 19:18:06 INFO - 'log_name': 'talos', 19:18:06 INFO - 'log_to_console': True, 19:18:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:18:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:18:06 INFO - 'opt_config_files': (), 19:18:06 INFO - 'pip_index': False, 19:18:06 INFO - 'suite': 'dromaeojs-e10s', 19:18:06 INFO - 'system_bits': '32', 19:18:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:18:06 INFO - 'title': 'talos-linux64-ix-076', 19:18:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:18:06 INFO - 'use_talos_json': True, 19:18:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:18:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:18:06 INFO - 'work_dir': 'build'} 19:18:06 INFO - [mozharness: 2017-05-26 02:18:06.774532Z] Running clobber step. 19:18:06 INFO - Running pre-action listener: _resource_record_pre_action 19:18:06 INFO - Running main action method: clobber 19:18:06 INFO - rmtree: /builds/slave/test/build 19:18:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:18:07 INFO - Running post-action listener: _resource_record_post_action 19:18:07 INFO - [mozharness: 2017-05-26 02:18:07.775555Z] Finished clobber step (success) 19:18:07 INFO - [mozharness: 2017-05-26 02:18:07.775656Z] Running read-buildbot-config step. 19:18:07 INFO - Running pre-action listener: _resource_record_pre_action 19:18:07 INFO - Running main action method: read_buildbot_config 19:18:07 INFO - Using buildbot properties: 19:18:07 INFO - { 19:18:07 INFO - "project": "", 19:18:07 INFO - "product": "firefox", 19:18:07 INFO - "who": "ryanvm@gmail.com", 19:18:07 INFO - "installer_path": "public/build/target.tar.bz2", 19:18:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 19:18:07 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 19:18:07 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 19:18:07 INFO - "stage_platform": "linux64-stylosequential", 19:18:07 INFO - "basedir": "/builds/slave/test", 19:18:07 INFO - "buildnumber": 22, 19:18:07 INFO - "platform": "ubuntu64_hw_styloseq", 19:18:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:18:07 INFO - "slavebuilddir": "test", 19:18:07 INFO - "taskId": "UdfToqEpRcKeLlQfwFFelw", 19:18:07 INFO - "branch": "mozilla-central", 19:18:07 INFO - "script_repo_revision": "production", 19:18:07 INFO - "revision": "862e534ade6d17176b09aeeb5dae63fdb53eddeb", 19:18:07 INFO - "slavename": "talos-linux64-ix-076", 19:18:07 INFO - "repo_path": "mozilla-central" 19:18:07 INFO - } 19:18:07 INFO - Finding installer, test and symbols from parent task. 19:18:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UdfToqEpRcKeLlQfwFFelw'}, attempt #1 19:18:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UdfToqEpRcKeLlQfwFFelw'}, attempt #1 19:18:08 INFO - Task dependencies: I0FVOlGETem6W1BfHVNkVg 19:18:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg'}, attempt #1 19:18:09 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.tar.bz2 19:18:09 INFO - Set test_url: https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/test_packages.json 19:18:09 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.crashreporter-symbols.zip 19:18:09 INFO - Running post-action listener: _resource_record_post_action 19:18:09 INFO - [mozharness: 2017-05-26 02:18:09.335802Z] Finished read-buildbot-config step (success) 19:18:09 INFO - [mozharness: 2017-05-26 02:18:09.336022Z] Running download-and-extract step. 19:18:09 INFO - Running pre-action listener: _resource_record_pre_action 19:18:09 INFO - Running main action method: download_and_extract 19:18:09 INFO - mkdir: /builds/slave/test/build/tests 19:18:09 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:09 INFO - trying https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.test_packages.json 19:18:09 INFO - Downloading https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:18:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:18:09 INFO - Downloaded 986 bytes. 19:18:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:18:10 INFO - Using the following test package requirements: 19:18:10 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:18:10 INFO - u'common': [u'target.common.tests.zip'], 19:18:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:18:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:18:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:18:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:18:10 INFO - u'mozbase': [u'target.common.tests.zip'], 19:18:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:18:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:18:10 INFO - u'web-platform': [u'target.common.tests.zip', 19:18:10 INFO - u'target.web-platform.tests.zip'], 19:18:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:18:10 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:18:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.common.tests.zip 19:18:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:18:10 INFO - Fetch https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.common.tests.zip into memory 19:18:11 INFO - Content-Length response header: 63525242 19:18:11 INFO - Bytes received: 63525242 19:18:22 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:18:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.common.tests.zip 19:18:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:18:22 INFO - Fetch https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.common.tests.zip into memory 19:18:23 INFO - Content-Length response header: 63525242 19:18:23 INFO - Bytes received: 63525242 19:18:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.talos.tests.zip 19:18:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:18:37 INFO - Fetch https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.talos.tests.zip into memory 19:18:38 INFO - Content-Length response header: 14411888 19:18:38 INFO - Bytes received: 14411888 19:18:38 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:38 INFO - trying https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.tar.bz2 19:18:38 INFO - Downloading https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:18:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:18:39 INFO - Downloaded 55694567 bytes. 19:18:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.tar.bz2 19:18:39 INFO - mkdir: /builds/slave/test/properties 19:18:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:18:39 INFO - Writing to file /builds/slave/test/properties/build_url 19:18:39 INFO - Contents: 19:18:39 INFO - build_url:https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.tar.bz2 19:18:39 INFO - Running post-action listener: _resource_record_post_action 19:18:39 INFO - Running post-action listener: set_extra_try_arguments 19:18:39 INFO - [mozharness: 2017-05-26 02:18:39.677821Z] Finished download-and-extract step (success) 19:18:39 INFO - [mozharness: 2017-05-26 02:18:39.678014Z] Running populate-webroot step. 19:18:39 INFO - Running pre-action listener: _resource_record_pre_action 19:18:39 INFO - Running main action method: populate_webroot 19:18:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:18:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:18:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:18:39 INFO - '--tppagecycles', 19:18:39 INFO - '7'], 19:18:39 INFO - 'tests': ['tsvgm']}}, 19:18:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:18:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:18:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:18:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:18:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:18:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:18:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:18:39 INFO - 'talos_options': ['--disable-e10s'], 19:18:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:18:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:18:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:18:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:18:39 INFO - 'talos_options': ['--disable-e10s'], 19:18:39 INFO - 'tests': ['damp', 'tps']}, 19:18:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:18:39 INFO - 'tests': ['damp', 'tps']}, 19:18:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:18:39 INFO - 'tests': ['dromaeo_dom']}, 19:18:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:18:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:18:39 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 19:18:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:18:39 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:18:39 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:18:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:18:39 INFO - 'tests': ['a11yr', 19:18:39 INFO - 'ts_paint', 19:18:39 INFO - 'tpaint', 19:18:39 INFO - 'sessionrestore', 19:18:39 INFO - 'sessionrestore_no_auto_restore', 19:18:39 INFO - 'tabpaint']}, 19:18:39 INFO - 'other-e10s': {'tests': ['a11yr', 19:18:39 INFO - 'ts_paint', 19:18:39 INFO - 'tpaint', 19:18:39 INFO - 'sessionrestore', 19:18:39 INFO - 'sessionrestore_no_auto_restore', 19:18:39 INFO - 'tabpaint']}, 19:18:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:18:39 INFO - 'ts_paint', 19:18:39 INFO - 'tpaint', 19:18:39 INFO - 'sessionrestore', 19:18:39 INFO - 'sessionrestore_no_auto_restore', 19:18:39 INFO - 'tabpaint']}, 19:18:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:18:39 INFO - 'ts_paint', 19:18:39 INFO - 'tpaint', 19:18:39 INFO - 'sessionrestore', 19:18:39 INFO - 'sessionrestore_no_auto_restore', 19:18:39 INFO - 'tabpaint']}, 19:18:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:18:39 INFO - 'tests': ['a11yr', 19:18:39 INFO - 'ts_paint', 19:18:39 INFO - 'tpaint', 19:18:39 INFO - 'sessionrestore', 19:18:39 INFO - 'sessionrestore_no_auto_restore', 19:18:39 INFO - 'tabpaint']}, 19:18:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:18:39 INFO - 'tests': ['a11yr', 19:18:39 INFO - 'ts_paint', 19:18:39 INFO - 'tpaint', 19:18:39 INFO - 'sessionrestore', 19:18:39 INFO - 'sessionrestore_no_auto_restore', 19:18:39 INFO - 'tabpaint']}, 19:18:39 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 19:18:39 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 19:18:39 INFO - 'bloom_basic_ref']}, 19:18:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:18:39 INFO - 'tests': ['tsvgx', 19:18:39 INFO - 'tsvgr_opacity', 19:18:39 INFO - 'tart', 19:18:39 INFO - 'tscrollx', 19:18:39 INFO - 'cart', 19:18:39 INFO - 'tsvg_static']}, 19:18:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:18:39 INFO - 'tsvgr_opacity', 19:18:39 INFO - 'tart', 19:18:39 INFO - 'tscrollx', 19:18:39 INFO - 'cart', 19:18:39 INFO - 'tsvg_static']}, 19:18:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:18:39 INFO - 'talos_options': ['--disable-e10s'], 19:18:39 INFO - 'tests': ['tp5o']}, 19:18:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:18:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:18:39 INFO - 'talos_options': ['--disable-e10s', 19:18:39 INFO - '--xperf_path', 19:18:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:18:39 INFO - 'tests': ['tp5n']}, 19:18:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:18:39 INFO - 'talos_options': ['--xperf_path', 19:18:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:18:39 INFO - 'tests': ['tp5n']}}, 19:18:39 INFO - 'talos.zip': {'path': '', 19:18:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:18:39 INFO - Running post-action listener: _resource_record_post_action 19:18:39 INFO - [mozharness: 2017-05-26 02:18:39.693008Z] Finished populate-webroot step (success) 19:18:39 INFO - [mozharness: 2017-05-26 02:18:39.693106Z] Running create-virtualenv step. 19:18:39 INFO - Running pre-action listener: _resource_record_pre_action 19:18:39 INFO - Running main action method: create_virtualenv 19:18:39 INFO - Creating virtualenv /builds/slave/test/build/venv 19:18:39 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:18:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:18:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:18:39 INFO - Using real prefix '/usr' 19:18:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:18:40 INFO - Installing distribute.............................................................................................................................................................................................done. 19:18:42 INFO - Installing pip.................done. 19:18:42 INFO - Return code: 0 19:18:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:18:42 INFO - Reading from file tmpfile_stdout 19:18:42 INFO - Output received: 19:18:42 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:18:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:18: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:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18: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:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16705c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d7a0>, '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 0x166e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166eb30>, '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': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', '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:18: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', 'pip>=1.5'] in /builds/slave/test/build 19:18: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 pip>=1.5 19:18:42 INFO - Using env: {'DISPLAY': ':0', 19:18:42 INFO - 'HOME': '/home/cltbld', 19:18:42 INFO - 'LANG': 'en_US.UTF-8', 19:18:42 INFO - 'LANGUAGE': 'en_US:en', 19:18:42 INFO - 'LOGNAME': 'cltbld', 19:18:42 INFO - 'MAIL': '/var/mail/cltbld', 19:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:42 INFO - 'MOZ_NO_REMOTE': '1', 19:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:42 INFO - 'NO_EM_RESTART': '1', 19:18:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:42 INFO - 'PWD': '/builds/slave/test', 19:18:42 INFO - 'SHELL': '/bin/bash', 19:18:42 INFO - 'SHLVL': '1', 19:18:42 INFO - 'TERM': 'linux', 19:18:42 INFO - 'TMOUT': '86400', 19:18:42 INFO - 'USER': 'cltbld', 19:18:42 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', 19:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:42 INFO - '_': '/tools/buildbot/bin/python'} 19:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:42 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:18:42 INFO - Cleaning up... 19:18:42 INFO - Return code: 0 19:18:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:18: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:18:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18: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:18:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18: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', '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 0x12fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16705c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d7a0>, '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 0x166e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166eb30>, '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': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', '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:18: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', 'psutil>=3.1.1'] in /builds/slave/test/build 19:18: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 psutil>=3.1.1 19:18:42 INFO - Using env: {'DISPLAY': ':0', 19:18:42 INFO - 'HOME': '/home/cltbld', 19:18:42 INFO - 'LANG': 'en_US.UTF-8', 19:18:42 INFO - 'LANGUAGE': 'en_US:en', 19:18:42 INFO - 'LOGNAME': 'cltbld', 19:18:42 INFO - 'MAIL': '/var/mail/cltbld', 19:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:42 INFO - 'MOZ_NO_REMOTE': '1', 19:18:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:43 INFO - 'NO_EM_RESTART': '1', 19:18:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:43 INFO - 'PWD': '/builds/slave/test', 19:18:43 INFO - 'SHELL': '/bin/bash', 19:18:43 INFO - 'SHLVL': '1', 19:18:43 INFO - 'TERM': 'linux', 19:18:43 INFO - 'TMOUT': '86400', 19:18:43 INFO - 'USER': 'cltbld', 19:18:43 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', 19:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:43 INFO - '_': '/tools/buildbot/bin/python'} 19:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:43 INFO - Downloading/unpacking psutil>=3.1.1 19:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:18:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:18:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:18:44 INFO - Installing collected packages: psutil 19:18:44 INFO - Running setup.py install for psutil 19:18:44 INFO - building 'psutil._psutil_linux' extension 19:18:44 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:18:45 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:18:45 INFO - building 'psutil._psutil_posix' extension 19:18:45 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:18:45 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:18:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:18:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:18:45 INFO - Successfully installed psutil 19:18:45 INFO - Cleaning up... 19:18:45 INFO - Return code: 0 19:18:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:18:45 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:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:45 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:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:45 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 0x12fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16705c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d7a0>, '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 0x166e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166eb30>, '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': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', '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:18:45 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:18:45 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:18:45 INFO - Using env: {'DISPLAY': ':0', 19:18:45 INFO - 'HOME': '/home/cltbld', 19:18:45 INFO - 'LANG': 'en_US.UTF-8', 19:18:45 INFO - 'LANGUAGE': 'en_US:en', 19:18:45 INFO - 'LOGNAME': 'cltbld', 19:18:45 INFO - 'MAIL': '/var/mail/cltbld', 19:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:45 INFO - 'MOZ_NO_REMOTE': '1', 19:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:45 INFO - 'NO_EM_RESTART': '1', 19:18:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:45 INFO - 'PWD': '/builds/slave/test', 19:18:45 INFO - 'SHELL': '/bin/bash', 19:18:45 INFO - 'SHLVL': '1', 19:18:45 INFO - 'TERM': 'linux', 19:18:45 INFO - 'TMOUT': '86400', 19:18:45 INFO - 'USER': 'cltbld', 19:18:45 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', 19:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:45 INFO - '_': '/tools/buildbot/bin/python'} 19:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:18:46 INFO - Installing collected packages: mozsystemmonitor 19:18:46 INFO - Running setup.py install for mozsystemmonitor 19:18:47 INFO - Successfully installed mozsystemmonitor 19:18:47 INFO - Cleaning up... 19:18:47 INFO - Return code: 0 19:18:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:47 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 0x12fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16705c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d7a0>, '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 0x166e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166eb30>, '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': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', '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:18:47 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:18:47 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:18:47 INFO - Using env: {'DISPLAY': ':0', 19:18:47 INFO - 'HOME': '/home/cltbld', 19:18:47 INFO - 'LANG': 'en_US.UTF-8', 19:18:47 INFO - 'LANGUAGE': 'en_US:en', 19:18:47 INFO - 'LOGNAME': 'cltbld', 19:18:47 INFO - 'MAIL': '/var/mail/cltbld', 19:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:47 INFO - 'MOZ_NO_REMOTE': '1', 19:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:47 INFO - 'NO_EM_RESTART': '1', 19:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:47 INFO - 'PWD': '/builds/slave/test', 19:18:47 INFO - 'SHELL': '/bin/bash', 19:18:47 INFO - 'SHLVL': '1', 19:18:47 INFO - 'TERM': 'linux', 19:18:47 INFO - 'TMOUT': '86400', 19:18:47 INFO - 'USER': 'cltbld', 19:18:47 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', 19:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:47 INFO - '_': '/tools/buildbot/bin/python'} 19:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:47 INFO - Downloading/unpacking jsonschema==2.5.1 19:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:18:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:48 INFO - Downloading functools32-3.2.3-2.tar.gz 19:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:18:48 INFO - warning: no files found matching '*.txt' 19:18:48 INFO - no previously-included directories found matching 'build' 19:18:48 INFO - no previously-included directories found matching 'dist' 19:18:48 INFO - no previously-included directories found matching '.git*' 19:18:48 INFO - Installing collected packages: jsonschema, functools32 19:18:48 INFO - Running setup.py install for functools32 19:18:48 INFO - warning: no files found matching '*.txt' 19:18:48 INFO - no previously-included directories found matching 'build' 19:18:48 INFO - no previously-included directories found matching 'dist' 19:18:48 INFO - no previously-included directories found matching '.git*' 19:18:48 INFO - Successfully installed jsonschema functools32 19:18:48 INFO - Cleaning up... 19:18:48 INFO - Return code: 0 19:18:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:18:48 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:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:48 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:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:48 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 0x12fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16705c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d7a0>, '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 0x166e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166eb30>, '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': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', '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:18:48 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:18:48 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:18:48 INFO - Using env: {'DISPLAY': ':0', 19:18:48 INFO - 'HOME': '/home/cltbld', 19:18:48 INFO - 'LANG': 'en_US.UTF-8', 19:18:48 INFO - 'LANGUAGE': 'en_US:en', 19:18:48 INFO - 'LOGNAME': 'cltbld', 19:18:48 INFO - 'MAIL': '/var/mail/cltbld', 19:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:48 INFO - 'MOZ_NO_REMOTE': '1', 19:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:48 INFO - 'NO_EM_RESTART': '1', 19:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:48 INFO - 'PWD': '/builds/slave/test', 19:18:48 INFO - 'SHELL': '/bin/bash', 19:18:48 INFO - 'SHLVL': '1', 19:18:48 INFO - 'TERM': 'linux', 19:18:48 INFO - 'TMOUT': '86400', 19:18:48 INFO - 'USER': 'cltbld', 19:18:48 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', 19:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:48 INFO - '_': '/tools/buildbot/bin/python'} 19:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:18:49 INFO - Cleaning up... 19:18:49 INFO - Return code: 0 19:18:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:49 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 0x12fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16705c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d7a0>, '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 0x166e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166eb30>, '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': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', '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:18:49 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:18:49 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:18:49 INFO - Using env: {'DISPLAY': ':0', 19:18:49 INFO - 'HOME': '/home/cltbld', 19:18:49 INFO - 'LANG': 'en_US.UTF-8', 19:18:49 INFO - 'LANGUAGE': 'en_US:en', 19:18:49 INFO - 'LOGNAME': 'cltbld', 19:18:49 INFO - 'MAIL': '/var/mail/cltbld', 19:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:49 INFO - 'MOZ_NO_REMOTE': '1', 19:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:49 INFO - 'NO_EM_RESTART': '1', 19:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:49 INFO - 'PWD': '/builds/slave/test', 19:18:49 INFO - 'SHELL': '/bin/bash', 19:18:49 INFO - 'SHLVL': '1', 19:18:49 INFO - 'TERM': 'linux', 19:18:49 INFO - 'TMOUT': '86400', 19:18:49 INFO - 'USER': 'cltbld', 19:18:49 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', 19:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:49 INFO - '_': '/tools/buildbot/bin/python'} 19:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:49 INFO - Downloading/unpacking blobuploader==1.2.4 19:18:49 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:18:49 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:18:49 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:18:49 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:18:50 INFO - Downloading blobuploader-1.2.4.tar.gz 19:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:18:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:18:50 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:18:50 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:18:50 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:18:50 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:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:18:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:18:50 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:18:50 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:18:50 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:18:50 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:18:50 INFO - Downloading docopt-0.6.1.tar.gz 19:18:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:18:50 INFO - Installing collected packages: blobuploader, requests, docopt 19:18:50 INFO - Running setup.py install for blobuploader 19:18:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:18:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:18:51 INFO - Running setup.py install for requests 19:18:51 INFO - Running setup.py install for docopt 19:18:51 INFO - Successfully installed blobuploader requests docopt 19:18:51 INFO - Cleaning up... 19:18:51 INFO - Return code: 0 19:18:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:51 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:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:51 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:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:51 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 0x12fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16705c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d7a0>, '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 0x166e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166eb30>, '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': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', '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:18:51 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:18:51 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:18:51 INFO - Using env: {'DISPLAY': ':0', 19:18:51 INFO - 'HOME': '/home/cltbld', 19:18:51 INFO - 'LANG': 'en_US.UTF-8', 19:18:51 INFO - 'LANGUAGE': 'en_US:en', 19:18:51 INFO - 'LOGNAME': 'cltbld', 19:18:51 INFO - 'MAIL': '/var/mail/cltbld', 19:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:51 INFO - 'MOZ_NO_REMOTE': '1', 19:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:51 INFO - 'NO_EM_RESTART': '1', 19:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:51 INFO - 'PWD': '/builds/slave/test', 19:18:51 INFO - 'SHELL': '/bin/bash', 19:18:51 INFO - 'SHLVL': '1', 19:18:51 INFO - 'TERM': 'linux', 19:18:51 INFO - 'TMOUT': '86400', 19:18:51 INFO - 'USER': 'cltbld', 19:18:51 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', 19:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:51 INFO - '_': '/tools/buildbot/bin/python'} 19:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:18:51 INFO - Running setup.py (path:/tmp/pip-bupmb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:18:51 INFO - Running setup.py (path:/tmp/pip-fJ3a7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:18:51 INFO - Running setup.py (path:/tmp/pip-0OC8jY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:18:51 INFO - Running setup.py (path:/tmp/pip-vQXRwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:18:52 INFO - Running setup.py (path:/tmp/pip-SHKzdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:18:52 INFO - Running setup.py (path:/tmp/pip-4LrICe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:18:52 INFO - Running setup.py (path:/tmp/pip-pc6Z2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:18:52 INFO - Running setup.py (path:/tmp/pip-uibNmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:18:52 INFO - Running setup.py (path:/tmp/pip-q91PPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:18:52 INFO - Running setup.py (path:/tmp/pip-yw4TBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:18:52 INFO - Running setup.py (path:/tmp/pip-cuFke6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:18:52 INFO - Running setup.py (path:/tmp/pip-4v2cOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:18:52 INFO - Running setup.py (path:/tmp/pip-eJ60EN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:18:52 INFO - Running setup.py (path:/tmp/pip-XYGKx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:52 INFO - Running setup.py (path:/tmp/pip-5a23EW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:18:52 INFO - Running setup.py (path:/tmp/pip-00wrAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:18:52 INFO - Running setup.py (path:/tmp/pip-PTA48Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:18:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:18:52 INFO - Running setup.py install for manifestparser 19:18:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:18:53 INFO - Running setup.py install for mozcrash 19:18:53 INFO - Running setup.py install for mozdebug 19:18:53 INFO - Running setup.py install for mozdevice 19:18:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:18:53 INFO - Running setup.py install for mozfile 19:18:53 INFO - Running setup.py install for mozhttpd 19:18:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:18:53 INFO - Running setup.py install for mozinfo 19:18:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:18:53 INFO - Running setup.py install for mozInstall 19:18:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:18:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:18:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:18:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:18:53 INFO - Running setup.py install for mozleak 19:18:53 INFO - Running setup.py install for mozlog 19:18:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:18:54 INFO - Running setup.py install for moznetwork 19:18:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:18:54 INFO - Running setup.py install for mozprocess 19:18:54 INFO - Running setup.py install for mozprofile 19:18:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:18:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:18:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:18:54 INFO - Running setup.py install for mozrunner 19:18:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:18:54 INFO - Running setup.py install for mozscreenshot 19:18:54 INFO - Running setup.py install for moztest 19:18:54 INFO - Running setup.py install for mozversion 19:18:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:18:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:18:54 INFO - Cleaning up... 19:18:54 INFO - Return code: 0 19:18:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:54 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 0x12fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16705c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d7a0>, '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 0x166e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166eb30>, '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': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', '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:18:54 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:18:54 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:18:54 INFO - Using env: {'DISPLAY': ':0', 19:18:54 INFO - 'HOME': '/home/cltbld', 19:18:54 INFO - 'LANG': 'en_US.UTF-8', 19:18:54 INFO - 'LANGUAGE': 'en_US:en', 19:18:54 INFO - 'LOGNAME': 'cltbld', 19:18:54 INFO - 'MAIL': '/var/mail/cltbld', 19:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:54 INFO - 'MOZ_NO_REMOTE': '1', 19:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:54 INFO - 'NO_EM_RESTART': '1', 19:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:54 INFO - 'PWD': '/builds/slave/test', 19:18:54 INFO - 'SHELL': '/bin/bash', 19:18:54 INFO - 'SHLVL': '1', 19:18:54 INFO - 'TERM': 'linux', 19:18:54 INFO - 'TMOUT': '86400', 19:18:54 INFO - 'USER': 'cltbld', 19:18:54 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', 19:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:54 INFO - '_': '/tools/buildbot/bin/python'} 19:18:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:18:54 INFO - Running setup.py (path:/tmp/pip-ZphEeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:18:55 INFO - Running setup.py (path:/tmp/pip-CHLF9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:18:55 INFO - Running setup.py (path:/tmp/pip-uKJytE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:18:55 INFO - Running setup.py (path:/tmp/pip-Z4AFgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:18:55 INFO - Running setup.py (path:/tmp/pip-pZ_Cr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:18:55 INFO - Running setup.py (path:/tmp/pip-agzFOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:18:55 INFO - Running setup.py (path:/tmp/pip-OVy4La-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:18:55 INFO - Running setup.py (path:/tmp/pip-n7EQiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:18:55 INFO - Running setup.py (path:/tmp/pip-LLcDLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:18:55 INFO - Running setup.py (path:/tmp/pip-Muvasm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:18:55 INFO - Running setup.py (path:/tmp/pip-gquqg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:18:55 INFO - Running setup.py (path:/tmp/pip-fg7TTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:18:55 INFO - Running setup.py (path:/tmp/pip-IeyFCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:18:55 INFO - Running setup.py (path:/tmp/pip-tnybAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:18:55 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:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:55 INFO - Running setup.py (path:/tmp/pip-wY1gNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:56 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:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:18:56 INFO - Running setup.py (path:/tmp/pip-hXskQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:18:56 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:18:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:18:56 INFO - Running setup.py (path:/tmp/pip-S2EcdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:18:56 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:18:56 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:18:56 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:18:56 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:18:56 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:18:56 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:18:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:18:56 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:18:56 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:18:56 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:18:56 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:18:57 INFO - Downloading blessings-1.6.tar.gz 19:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:18:57 INFO - Installing collected packages: blessings 19:18:57 INFO - Running setup.py install for blessings 19:18:57 INFO - Successfully installed blessings 19:18:57 INFO - Cleaning up... 19:18:57 INFO - Return code: 0 19:18:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:18:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:18:57 INFO - Reading from file tmpfile_stdout 19:18:57 INFO - Current package versions: 19:18:57 INFO - argparse == 1.2.1 19:18:57 INFO - blessings == 1.6 19:18:57 INFO - blobuploader == 1.2.4 19:18:57 INFO - docopt == 0.6.1 19:18:57 INFO - functools32 == 3.2.3-2 19:18:57 INFO - jsonschema == 2.5.1 19:18:57 INFO - manifestparser == 1.1 19:18:57 INFO - mozInstall == 1.12 19:18:57 INFO - mozcrash == 1.0 19:18:57 INFO - mozdebug == 0.1 19:18:57 INFO - mozdevice == 0.51 19:18:57 INFO - mozfile == 1.2 19:18:57 INFO - mozhttpd == 0.7 19:18:57 INFO - mozinfo == 0.9 19:18:57 INFO - mozleak == 0.1 19:18:57 INFO - mozlog == 3.4 19:18:57 INFO - moznetwork == 0.27 19:18:57 INFO - mozprocess == 0.25 19:18:57 INFO - mozprofile == 0.28 19:18:57 INFO - mozrunner == 6.13 19:18:57 INFO - mozscreenshot == 0.1 19:18:57 INFO - mozsystemmonitor == 0.3 19:18:57 INFO - moztest == 0.8 19:18:57 INFO - mozversion == 1.4 19:18:57 INFO - psutil == 3.1.1 19:18:57 INFO - requests == 1.2.3 19:18:57 INFO - wsgiref == 0.1.2 19:18:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:57 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:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:57 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:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:57 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 0x12fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16705c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d7a0>, '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 0x166e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166eb30>, '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': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', '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:18:57 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:18:57 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:18:57 INFO - Using env: {'DISPLAY': ':0', 19:18:57 INFO - 'HOME': '/home/cltbld', 19:18:57 INFO - 'LANG': 'en_US.UTF-8', 19:18:57 INFO - 'LANGUAGE': 'en_US:en', 19:18:57 INFO - 'LOGNAME': 'cltbld', 19:18:57 INFO - 'MAIL': '/var/mail/cltbld', 19:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:57 INFO - 'MOZ_NO_REMOTE': '1', 19:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:57 INFO - 'NO_EM_RESTART': '1', 19:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:57 INFO - 'PWD': '/builds/slave/test', 19:18:57 INFO - 'SHELL': '/bin/bash', 19:18:57 INFO - 'SHLVL': '1', 19:18:57 INFO - 'TERM': 'linux', 19:18:57 INFO - 'TMOUT': '86400', 19:18:57 INFO - 'USER': 'cltbld', 19:18:57 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', 19:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:57 INFO - '_': '/tools/buildbot/bin/python'} 19:18:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:57 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:18:57 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:18:57 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:18:57 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:18:57 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:18:57 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:18:57 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:18:57 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:18:57 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:18:57 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:18:57 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:18:57 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:18:57 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:18:57 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:18:59 INFO - Downloading marionette_driver-1.4.0.tar.gz 19:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 19:18:59 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:18:59 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:18:59 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:18:59 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:18:59 INFO - Installing collected packages: marionette-driver 19:18:59 INFO - Running setup.py install for marionette-driver 19:18:59 INFO - Successfully installed marionette-driver 19:18:59 INFO - Cleaning up... 19:18:59 INFO - Return code: 0 19:18:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:18: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:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18: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:18:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:59 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 0x12fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14caa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16705c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166d7a0>, '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 0x166e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166eb30>, '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': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', '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:18:59 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:18:59 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:18:59 INFO - Using env: {'DISPLAY': ':0', 19:18:59 INFO - 'HOME': '/home/cltbld', 19:18:59 INFO - 'LANG': 'en_US.UTF-8', 19:18:59 INFO - 'LANGUAGE': 'en_US:en', 19:18:59 INFO - 'LOGNAME': 'cltbld', 19:18:59 INFO - 'MAIL': '/var/mail/cltbld', 19:18:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:59 INFO - 'MOZ_NO_REMOTE': '1', 19:18:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:59 INFO - 'NO_EM_RESTART': '1', 19:18:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:59 INFO - 'PWD': '/builds/slave/test', 19:18:59 INFO - 'SHELL': '/bin/bash', 19:18:59 INFO - 'SHLVL': '1', 19:18:59 INFO - 'TERM': 'linux', 19:18:59 INFO - 'TMOUT': '86400', 19:18:59 INFO - 'USER': 'cltbld', 19:18:59 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', 19:18:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:59 INFO - '_': '/tools/buildbot/bin/python'} 19:18:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:18:59 INFO - Cleaning up... 19:18:59 INFO - Return code: 0 19:18:59 INFO - Running post-action listener: _resource_record_post_action 19:18:59 INFO - Running post-action listener: _start_resource_monitoring 19:18:59 INFO - Starting resource monitoring. 19:18:59 INFO - [mozharness: 2017-05-26 02:18:59.538410Z] Finished create-virtualenv step (success) 19:18:59 INFO - [mozharness: 2017-05-26 02:18:59.538915Z] Running install step. 19:18:59 INFO - Running pre-action listener: _resource_record_pre_action 19:18:59 INFO - Running main action method: install 19:18:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:18:59 INFO - Reading from file tmpfile_stdout 19:18:59 INFO - Detecting whether we're running mozinstall >=1.0... 19:18:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:18:59 INFO - Reading from file tmpfile_stdout 19:18:59 INFO - Output received: 19:18:59 INFO - Usage: mozinstall [options] installer 19:18:59 INFO - Options: 19:18:59 INFO - -h, --help show this help message and exit 19:18:59 INFO - -d DEST, --destination=DEST 19:18:59 INFO - Directory to install application into. [default: 19:18:59 INFO - "/builds/slave/test"] 19:18:59 INFO - --app=APP Application being installed. [default: firefox] 19:18:59 INFO - mkdir: /builds/slave/test/build/application 19:18:59 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:18:59 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:15 INFO - Reading from file tmpfile_stdout 19:19:15 INFO - Output received: 19:19:15 INFO - /builds/slave/test/build/application/firefox/firefox 19:19:15 INFO - Running post-action listener: _resource_record_post_action 19:19:15 INFO - [mozharness: 2017-05-26 02:19:15.834416Z] Finished install step (success) 19:19:15 INFO - [mozharness: 2017-05-26 02:19:15.834569Z] Running run-tests step. 19:19:15 INFO - Running pre-action listener: _resource_record_pre_action 19:19:15 INFO - Running main action method: run_tests 19:19:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:19:15 INFO - Python 2.7.3 19:19:15 INFO - Return code: 0 19:19:15 INFO - grabbing minidump binary from tooltool 19:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:15 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 0x166d7a0>, '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 0x166e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166eb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:19:15 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:15 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:15 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:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:19:15 INFO - Return code: 0 19:19:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:19:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:19:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:19:15 INFO - ENV: RUST_BACKTRACE is now 1 19:19:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:19:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:19:15 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/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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:15 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/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --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:15 INFO - Using env: {'DISPLAY': ':0', 19:19:15 INFO - 'HOME': '/home/cltbld', 19:19:15 INFO - 'LANG': 'en_US.UTF-8', 19:19:15 INFO - 'LANGUAGE': 'en_US:en', 19:19:15 INFO - 'LOGNAME': 'cltbld', 19:19:15 INFO - 'MAIL': '/var/mail/cltbld', 19:19:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:19:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:15 INFO - 'MOZ_NO_REMOTE': '1', 19:19:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:19:15 INFO - 'NO_EM_RESTART': '1', 19:19:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:15 INFO - 'PWD': '/builds/slave/test', 19:19:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:19:15 INFO - 'RUST_BACKTRACE': '1', 19:19:15 INFO - 'SHELL': '/bin/bash', 19:19:15 INFO - 'SHLVL': '1', 19:19:15 INFO - 'TERM': 'linux', 19:19:15 INFO - 'TMOUT': '86400', 19:19:15 INFO - 'USER': 'cltbld', 19:19:15 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690', 19:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:15 INFO - '_': '/tools/buildbot/bin/python'} 19:19:15 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/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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:16 INFO - mozversion application_buildid: 20170526013124 19:19:16 INFO - mozversion application_changeset: 862e534ade6d17176b09aeeb5dae63fdb53eddeb 19:19:16 INFO - mozversion application_display_name: Nightly 19:19:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:19:16 INFO - mozversion application_name: Firefox 19:19:16 INFO - mozversion application_remotingname: firefox 19:19:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:19:16 INFO - mozversion application_vendor: Mozilla 19:19:16 INFO - mozversion application_version: 55.0a1 19:19:16 INFO - mozversion platform_buildid: 20170526013124 19:19:16 INFO - mozversion platform_changeset: 862e534ade6d17176b09aeeb5dae63fdb53eddeb 19:19:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:19:16 INFO - mozversion platform_version: 55.0a1 19:19:16 INFO - using testdate: 1495765156 19:19:16 INFO - actual date: 1495765156 19:19:16 INFO - starting webserver on 'localhost:45466' 19:19:16 INFO - SUITE-START | Running 2 tests 19:19:16 INFO - TEST-START | dromaeo_css 19:19:16 INFO - operating with platform_type : linux_ 19:19:16 INFO - Initialising browser for dromaeo_css test... 19:19:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45466/getInfo.html -profile /tmp/tmpldBOpz/profile 19:19:16 INFO - TEST-INFO | started process 3350 (/builds/slave/test/build/application/firefox/firefox http://localhost:45466/getInfo.html) 19:19:53 INFO - TEST-INFO | 3350: killed by SIGTERM 19:19:53 INFO - Browser initialized. 19:19:53 INFO - Running cycle 1/1 for dromaeo_css test... 19:19:53 INFO - TEST-INFO | started process 3570 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpldBOpz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:20:05 INFO - PID 3570 | RSS: Main: 172404736 19:20:05 INFO - PID 3570 | 19:23:10 INFO - PID 3570 | Cycle 1(1): loaded http://localhost:45466/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45466/tests/dromaeo/cssquery-ext.html) 19:23:11 INFO - PID 3570 | RSS: Main: 172838912 19:23:11 INFO - PID 3570 | 19:26:13 INFO - PID 3570 | Cycle 1(1): loaded http://localhost:45466/tests/dromaeo/cssquery-ext.html (next: http://localhost:45466/tests/dromaeo/cssquery-jquery.html) 19:26:14 INFO - PID 3570 | RSS: Main: 176414720 19:26:14 INFO - PID 3570 | 19:29:15 INFO - PID 3570 | Cycle 1(1): loaded http://localhost:45466/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45466/tests/dromaeo/cssquery-mootools.html) 19:29:16 INFO - PID 3570 | RSS: Main: 175247360 19:29:16 INFO - PID 3570 | 19:32:18 INFO - PID 3570 | Cycle 1(1): loaded http://localhost:45466/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45466/tests/dromaeo/cssquery-prototype.html) 19:32:19 INFO - PID 3570 | RSS: Main: 180838400 19:32:19 INFO - PID 3570 | 19:35:21 INFO - PID 3570 | Cycle 1(1): loaded http://localhost:45466/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45466/tests/dromaeo/cssquery-yui.html) 19:35:22 INFO - PID 3570 | RSS: Main: 177893376 19:35:22 INFO - PID 3570 | 19:38:24 INFO - PID 3570 | Cycle 1(1): loaded http://localhost:45466/tests/dromaeo/cssquery-yui.html (next: http://localhost:45466/tests/dromaeo/cssquery-dojo.html) 19:38:24 INFO - PID 3570 | RSS: Main: 176267264 19:38:24 INFO - PID 3570 | 19:38:24 INFO - PID 3570 | __start_tp_report 19:38:24 INFO - PID 3570 | _x_x_mozilla_page_load 19:38:24 INFO - PID 3570 | _x_x_mozilla_page_load_details 19:38:24 INFO - PID 3570 | |i|pagename|runs| 19:38:24 INFO - PID 3570 | |0;dojo.html;2705.1343570057584;2706.729327067295;2733.2073698627387;2758.2276962450496;2763.7650799682033;5157.638965272423;5185.066687996164;5271.130263506521;5274.73626318684;5299.231611416352;5166.9224961625605;5214.035403450364;5238.580913526918;5279.736013199335;5307.310049693544;4634.606058485033;4640.628749700016;4664.183767840623;4671.85984420468;4703.976480117594;4613.515580864011;4643.094596553673;4710.646701497401;4716.882077948045;4742;4547.408836851188;4582.541745825424;4650.395448591696;4700.529947005306;4718.363020992157;4600.332951721982;4669.813207471697;4677.4854765975715;4707.176244157259;4727.929081063787;4633.9536604634195;4639.860804175846;4648.209804333272;4655.7439340836245;4693.389859318267;5115.667481613683;5173.094708426048;5205.583553315726;5236.345456817898;5256.789728410859;5547.639403438804;5574.888502229933;5646.915296270559;5661.943380566183;5663.32040155184;5673.6879471629045;5684.8010319639025;5688.345840228385;5696.145578163268;5707.942920570783;5297;5326.414094449608;5332.9466705333225;5335.813246536352;5352.411234764173;5704.1443783432815;5721.5708821838525;5776.884462310814;5811.215485909348;5880.088586269135;5461.617686761889;5517.806876759374;5517.944820551824;5570.220169176318;5631.493165615114;5681.971590142106;5683.147527870852;5690.9146362804595;5722.656640601577;5734.254546908875;5546;5659.462351076641;5661.34894487131;5667.093265077568;5674.347450043216;5480.287562616914;5524.14375771756;5555.2222688823595;5591.608587398843;5646.802361917313;4717.481077081518;4729.385179926588;4730.077634861169;4743.407074115736;4756.548127927841;4069.369247766601;4076.103257283393;4099.1801639672185;4101.938470922939;4119.052617897841;4684.110019096361;4742.857714268577;4781.856544303677;4786.880327991828;4830;5649.576281778883;5733.569982251348;5739.971300143556;5742.856428589235;5761.596688231783;4781.545753153445;4783.23468245086;4791.976040119777;4798.1123492154065;4847.878803029882;5045.7981680732355;5053.065182941167;5058.038972595195;5067.315912351859;5106.872328191899;5146.202338637517;5215.55667768244;5218.321618189611;5272.604554658339;5286.259923610774;5732.856678583069;5738.397468265939;5745.080787074048;5748.281464816898;5798.768049277982;5274.762635681327;5285.68285902847;5289.047971365191;5290.947090529199;5292.047431462373;5416.106342453451;5485.917711234414;5526.668399896019;5637.746301416364;5682.204491371129;5711.457411545896;5731.914021289767;5756.395578464369;5764.13537969308;5768.855778605568;5336.146216605324;5403.351597808288;5448.346198456052;5501.394846566955;5532.889342213214;5449.754761035683;5551.750171242223;5557.194206839905;5586.078297080936;5596.90860282241;5428.728563571726;5459.808906688247;5473.151661492475;5483.232347471437;5484.780608775604;5464.18037294409;5532.529734972572;5540.36285827135;5546.195801608664;5572.498475137095;5354.598405119554;5356.089464791073;5358.410574836843;5367.919481207707;5395.865103372447 19:38:24 INFO - PID 3570 | |1;ext.html;687.9002544631029;734.2327268004934;753.5139834806548;1055.6041484443333;1063.5798859450522;32742.181445463877;33570.49644255338;33588.66411335889;33629.83185084071;33841.32317353651;34439.48340774891;34821.12947176315;34833.303333933305;34836;34856.651433485655;6686.933130668704;6840.384365407125;6871.106756121697;6884.414824739903;6969.337912898267;6780.08468856703;6885.655717214145;6887.965560172192;6894.310568943116;6903.240643529208;6799.456043516507;6854.074699915497;6884.242733299333;6884.277150899158;6913.308669133096;6852.383285504328;6858.897116543231;6874.793756187322;6875.518713690044;6893.551919125291;6726.3609957054005;6765.560238584526;6840.863182736367;6852.862942741117;6869.862602747917;30518.084457466313;30574;30819.845900770575;30827.537586936214;30827.537586936214;3056.3581647853975;3062.4793785056595;3070.846457677107;3077.1845460952864;3092.5206592978125;24506.264812055666;24524.63213051788;24539;24611.138610148737;24633.87683061591;3036.802607830484;3067;3084.9691503085132;3123.6095488063993;3152.133163380066;140530.29734851362;141783;147694;152155;152590.23704881515;39836.60163398387;39972.800135999714;39985.60014399877;39995;40000.1999960005;41056.58943410528;41182.58817411847;41301.79349103235;41516.79241603833;41549.1690166195;12841.807372889414;12983.610491685264;13012.804807927889;13063.216207027419;13090.672733181747;10297;10531.789364212673;10556.102731267929;10559.63041293551;10563.154947604173;13155.60533184006;13239.271840048697;13248;13328.466861325633;13446;5556.138798486241;5568.688994067416;5569.443055694398;5647.915281270784;5661.065924122474;860.3805260212762;910.0762725833284;910.7677542226822;919.6919032124314;941.087145468894;20172.495687607927;21103.68344474834;21107.894460527907;21386.251481198084;21408.678869816966;977.452626529146;989.4557993103764;992.4591097851688;997.3616885193337;1000.6347683095763;10413;10971.890281097247;11147.331160130418;11236.943815281034;11268.380239086766;175938;176364;176777;177957.1102144507;179284;39796.80101599474;39873.80063099666;39889.20221595552;39923.60076399257;39926.80036599856;1208.957686480969;1250.6185613388004;1257.0258050011132;1258.9559365422167;1263.6398626391617;19262.22951081941;19903.402897913085;20603.381898543066;20658.793412065686;20726.170953161705;29034;29112;29136.27159321034;29136.7086329134;29181.416371672873;154208;155331;155386;155635;156048.21975890046;29419.117426476383;29454.852725736233;29507;29546;29550.704492954796;34082.14794630154;34452.48321275133;34808.12979675528;35039.124021898635;35193.29613407666;26322;26354.86822565875;26918.73081269162;27166.456670866868;27503.86248068827;26125.216243512725;26528;26710.86644566765;26927.192184234504;27657.44685106327;29238.122856314345;29247.268818279714;29298;29754.10737677873;29767.851160744056;26237.34406639773;26444.603330950435;26461.470770584867;26620.7337926626;27109.322266943484;19207;21726.130954761633;21785.346439606838;21870.781292186875;21970.780292196872 19:38:24 INFO - PID 3570 | |2;jquery.html;421.6521369869856;421.91350773091517;421.9535851056381;440.4824331410593;442.31662082083176;17244.13779311034;17496.300147994065;17954.281828726853;17962.82037179628;18008.72986905196;18289.268429262847;18410.26358945644;18444.723329150074;18483.53791155222;18492.167852446637;5185.222216667492;5288.0745869472785;5494.560435165197;5500.889982200353;5509.118541033436;5356.303680521527;5419;5436.891262174754;5446.019716451037;5455.1544510600725;5335.146376579748;5388.595855310848;5400.29796126503;5411.810586629469;5412.5940554458375;5268.367795864482;5319.840404787863;5320.308359913225;5324.440933701983;5333.173358129496;4793.520647935214;4821.951780482221;4829.95170048302;4831.492693267227;4837.758112094416;21307.573848523098;21379.67930481044;21442.46393840151;21523.354299371043;21613.45966350838;1617.563257920355;1638.3528506239968;1647.4975132584557;1650.8596769274627;1653.5866033491627;14418.639534011629;14591.124532527976;14755.778663319952;14968.625784355369;15050.924745376204;2014.6977953306975;2065.7417822772154;2073.2536286936693;2100.12844669462;2108.367489753083;91264.5436772812;91344;91393.54303228442;93600.99999999932;95089;10776;11022.44887755609;11140.49867755953;11156.609518666808;11338.60314888975;15373.077615343114;15383.923080384526;15384.076955382488;15393.153376564173;15396;7799.220077992155;7863.0957439894;8054;8071.950646416046;8088.069871964799;7384.113906331275;7448.292412220831;7545.283198096172;7646.35006024483;7673.424493163036;6816;7024.473164512682;7078.327558881898;7080.822979425556;7125.216226215112;2071.730675012239;2078.958420831605;2087.645100332947;2101.747790265147;2196.022769867394;843.1484200957077;866.4281574161023;878.2622597018535;884.062893333069;914.5792935249859;16323.918380408022;16585.751213731804;16737.748933766004;16754.83245167557;17242.482725518254;882.6557642519423;883.0860059838037;885.7696998780364;898.7079199260136;916.9954150229206;9042.547872606343;9084.40951338161;9244.583993720298;9405.294602904809;9547.952260238655;340116;341390;342821.2984390555;356663;359883;68795;73090;74353.6282318585;75203;75210.62394687992;1071.566015763617;1079.2984560035882;1117.474786850179;1121.091915548392;1131.1516362727955;16624;17205.311787528357;17356;17616.29534818593;17772.733408998618;39056.21887562176;39277;39764.602353976086;40056.1988760229;40119;48492.75753621209;50463.74768126136;51918.74040629773;52746.20880686869;53191.734041329546;8422.70520531803;8524.616392262487;8678.479291242546;8718.520481373585;8746.51894145828;12748.681282968;12864.356782160667;12909.289989050316;13059.34703264852;13242.470301187845;10889.618863340062;11065.225434219527;11166.665000050012;11272;11488.080953523866;9488.383255088396;9900.405975641484;9910.653127140515;10035.09684128432;10225.670662813787;11044.613438529614;11054.778904422028;11068.225224234226;11148.498317575892;11261.549538018715;8560.571971401281;8573.699920502753;8660.653573856975;8665.306775458075;8771.956140219258;11026.393548354597;11063.502142403771;11110.722231944266;11196.27224230455;11445.771084578428 19:38:24 INFO - PID 3570 | |3;mootools.html;1258.8174714666375;1293.5860524632117;1321.3921596065816;1322.3454390076913;1327.7145413736046;10257;10405.84391234132;10687.465626718671;10709.089727373173;10921.836172457419;10523.84214236787;10752.193585481082;10765.946170269157;10795.136389088873;10802.891971080287;2141.71086903268;2156.277646988253;2194.628357276702;2201.856879302848;2202.3723238876923;2063.876167429959;2105.989470052655;2118.3221369161874;2126.9893650531803;2127.9042443090098;2084.3121769816;2098.9055492502875;2101.53766171442;2111.3771437425994;2113.17586141405;2060.0832629479887;2068.7931206879193;2071.140476702167;2072.678734796109;2073.481629592602;1977.73300604418;2020.2323117215365;2066.597013582337;2068.162394230339;2075.138817390781;10257.33327333721;10401.68794936153;10411.427371494565;10427.113695335906;10427.322224055488;5300.284461597712;5518.834434966958;5526.50261476465;5531.917021244684;5532.6680399175775;3166.0976621662717;3281.6390197078304;3380.797152170853;3381.712554432876;3384.4415671414185;1116.748731535398;1117.5306371324064;1120.4621781544904;1128.8137457319533;1146.1976616368493;15122.924385378003;15398.846011539854;15421.768673470018;15428.922855385763;15448.38206471751;4819.927701084486;4891.877703057381;5025.14572522672;5071.264666623319;5072.036313100499;12889.162204456868;12994.155379900276;12996.870031299755;13008.479660813651;13016.934915325362;5549.084401073858;5640.492355688008;5650.66096034231;5654.830355089354;5677.233573467529;5028.698278103326;5071.340725705634;5071.771770270347;5106;5112.185174263157;4311.245532031882;4315.784210789448;4325.675574331937;4344.261475549164;4369.868903932887;1296.3647812571771;1336.752700750345;1353.939072741729;1361.8229630148016;1373.3270697358423;723.9855202895912;742.9814254643569;747.917729049804;754.6717178027576;756.3911051603512;5619.100943848965;5668.26312579362;5833.066709326487;5894.145348924382;5960.612560183574;826.1944604011042;843.5992903370973;844.5270648436895;849.197508354599;854.7948492361912;3746.662800347982;3778.1688028633657;3786.981065094657;3882.2041481496226;3892.5134358205223;13317.800232996513;13344.666383340495;13388.598342049754;13629.250391228577;13634.386452609459;13355.599332020054;13499.932500337436;13710.040297179301;13736.862631373559;13769.173849569059;7246.601436920914;7372.815679608053;7381.44639152055;7400.74097406599;7411.221821708751;5574.16387541872;5753;5823.126531020212;5893.174955506147;5984.401559843981;12050.819237711617;12346.567870124503;12394.62816115518;12556.623301300975;12611.93694031524;12441.813372799234;12479.56321528742;12538.87461125377;12613.369331533204;12699.301538415106;7595.392368610387;7674;7769.223077692412;7769.805754856174;7788.727394541163;9632.036796320312;9756.902430975882;9800.460974646463;9825.16486098661;9827;8215.876761848696;8259.752207433787;8324;8422.747317580483;8441.944756905386;7901.68393264263;7976.7208147714555;8000.919990800017;8068.959655201921;8162.469439486415;7473.103227612503;7687.884681729666;7763.805904852424;7766.92233077662;7768.728094516665;4873.537013983666;5539.335279766454;5553.805616803554;5607.747651355618;5789.189513468202;5436.103042997861;5619.241402410622;5733.971330143323;5808.883822323614;5851.765929362778 19:38:24 INFO - PID 3570 | |4;prototype.html;385.0873429970968;389.84601082572374;390.4884601172464;391.42851436902123;399.97400168989;5376.628959615297;5419.918701219485;5429.809956651518;5437.293151890249;5449.520468186975;5182.300389447433;5285.365756109262;5317.734113294339;5319.707416092114;5325.547328477084;4180.24755544002;4201.978990105045;4205.401947260052;4211.515675697296;4222.345536441856;4181.372794080897;4184.184084103601;4186.602272784081;4204.390363397306;4206.242876282268;3889.5527014393424;4044.777537235451;4153.273177193994;4153.8753837384775;4161.583841615829;4047.332190188615;4055.9391609125887;4058.594140585947;4060;4063.085805693725;3528.5060091587197;3535.4343305071066;3539.911502212465;3544.8936531904083;3547.0954906498678;5155.149400348938;5294.073537130987;5302.628815982883;5318.973405132988;5331.760070796823;4752.833650822205;4777.80888764449;4788.688735232199;4796.081567373044;4806.567408933178;5690.2887139107615;5692.77228910843;5698.34469036062;5706.457886500776;5710.628809127435;3870.1679138985255;3993.28120938231;4005.6595189408936;4007.499062617173;4014.3376342903384;5832.270966129234;6035.275766907999;6069.393060693939;6075.574709770318;6114.4408175915305;4063.3498640218013;4084.4281800547947;4086.7139300248696;4098.918021639551;4099.344104943195;4135.648469880034;4135.875923722293;4136.607022332873;4146.274401979642;4156.397322388298;4590.747508886977;4752.2158843790385;4758.714477131383;4774.140654682121;4783.784729687172;5701.857453563611;5709.9714501427225;5722.113072473773;5740.885182296331;5743.2246646703;1421.8649228323293;1425.4939496478808;1426.1158081989233;1427.1722401007391;1432.7134573085425;906.6101576322113;950.0736781637847;954.9761255968517;960.5149399553181;966.8639348765173;4947.392097568305;4951.16806781486;4973.850784476472;4976.2038073908;4985.925211121836;5928.703564821742;5940.316863560746;5944.64332140073;5946.464818166386;5957.970210148921;4802.591779698765;4923.384576927884;4936.259561065797;4953.702777833341;4964.90070198594;3115.8286294254035;3160.652328243891;3160.8103513789247;3161.5772902193644;3164.098232003868;5447.564194864481;5463.9180412293845;5465.262189604353;5470.699111548903;5500.669959802424;5844.47399734026;6066.484348830399;6075.726592303357;6112.205413296243;6124.448799607968;5492.725363731797;5511.53151982078;5515.172724091419;5523.585731070106;5536.916946245809;5830.504407125272;5923.229980102559;5979.714361412317;6000.459958603747;6002.129691194665;5852.648841069549;5860.677662728591;5866.208061911588;5879.853003674943;5892.263467066617;5294.152935530296;5470.398256191736;5475.808346707846;5492.80775172867;5501.504864562208;4001.4598029265676;4015.779132147643;4019.296623091006;4024.879253622396;4027.9395809062303;5890.970545147246;5977.22296101504;5977.3126090500145;5986.820395388146;5986.892424901407;5750.153673931263;5759;5760.6255593386295;5777.2200752897825;5782.884342313214;5766.94233057664;5790.610253539036;5808.099744539603;5808.954388209993;5813.94186058134;5510.338759348743;5676.829695109153;5717.914231286617;5719.599628025998;5751.769929202785;5808.73860676279;5833.095870140135;5835;5853.94146058551;5864.237649105589;5457.918131228114;5581.832545023656;5600.27196464457;5614.775408983595;5619.8876022480135 19:38:24 INFO - PID 3570 | |5;yui.html;717.2970488920861;726.7020521586151;752.5183882315318;754.0724908362714;772.7990722412171;12328.198667086655;12614.684632884182;14052.789208161874;14749.48376806812;14824.481143159992;15612.141332226724;16161.91919040403;16191.352345906149;16199.109049002329;16251.51245462635;883.575883575884;897.7037577599376;902.5216635183364;902.7923577577161;903.4488961733338;908.0420156734642;911.2573252798948;911.9088091190861;916.1342531307916;916.5005072235614;908.736466424736;960.5581432541039;962.3888830592589;962.4369743699943;964.8118616869713;942.8727121838567;960.0543464687278;960.1023043454393;960.577345967772;961.2550273537994;693.8751024815531;695.2664938489891;696.3384784454738;697.0276464332228;697.5570512724406;15279.312430940634;15391.615209619737;15430.691386172213;15454.845451545452;15463.768043479356;16224.83775162245;16566.751498727528;16709.66580668392;16718.749218761608;16731.66536669272;12836.486540538368;12972.545960891324;13321.333933303393;13322.134061285986;13332.73334533304;3097.767667424952;3116.937661246785;3118.189270789588;3124.53132030195;3131.984340078308;88648.11351886527;89048;90535.54732226362;91224.54387728019;92887.07112928852;12940.15888967233;13113.934430327978;13116;13182.274974876282;13230.536931207362;23342.183023594094;23437.41406464852;23990;24000;24090.397740056287;6308.432241098323;6377.904331435032;6388.520860935449;6427.485801135898;6439.54923155384;3078.753699704063;3153.7950033247766;3154.763392745553;3157;3159.778815482894;3819.1216020315483;3884.18432129256;3892.416137579329;3897.4738410314812;4294.613484786384;750.7597568777938;772.447699894578;777.7511196417092;779.9532028078333;784.8430313937235;611.6788685939828;625.221599109112;625.7121724006917;628.0892705576932;639.3606393606393;10054.245931555162;10267.383956962607;10765.354078755143;10822.458877056115;11113.499892504857;598.5331441475656;610.4963405190736;612.7089632424563;631.4821846086257;632.6077831744255;4833.73414462208;4917.1842650103545;4948.826791062367;5051.898962020812;5088.516590923857;80760;81505;81691;82821;83107.16892830994;73351;74469.25530744623;76013.61993189999;76438.23561764423;77177;58587;64949.67525162439;66381;66440;66554;9969.800603988024;10388.532516036645;10907.236493445384;10938.234323597271;11084.334939903632;27549.58675619827;27809.860950695118;27910.581341279492;28666.713332866406;29376.26559336034;34126;34453.82773086119;34740.305193895474;34836.651633484355;35337;14308.49920252786;14426.495072672406;14549.636259093184;14737.11577305365;14737.410503579737;15110.320035598204;15266;15322.846771532142;15542.84457155414;15582.298796553956;13776.586702398945;13808.86191138116;13827.585172444842;14469.782953255499;14700.77948830747;13937.930310348384;14180.078294910798;14209;14326.140431574138;15065.815456758928;13574.79637805414;13674.726505470035;13758.380872860545;14172.645683857985;14377.640558985691;9641.710748677551;9716.659916902874;9892.752681183028;9942.751431214278;10338.638147664795;10697.946510267398;10898.673039808818;11322.094232461548;11459.598914037968;11620.128490363088 19:38:24 INFO - PID 3570 | __end_tp_report 19:38:24 INFO - PID 3570 | __start_cc_report 19:38:24 INFO - PID 3570 | _x_x_mozilla_cycle_collect,336 19:38:24 INFO - PID 3570 | __end_cc_report 19:38:24 INFO - PID 3570 | __startTimestamp1495766304638__endTimestamp 19:38:24 INFO - PID 3570 | 19:38:24 INFO - PID 3570 | ------- Summary: start ------- 19:38:24 INFO - PID 3570 | Number of tests: 6 19:38:24 INFO - PID 3570 | 19:38:24 INFO - PID 3570 | [#0] dojo.html Cycles:165 Average:5172.57 Median:5332.95 stddev:610.66 (11.5%) stddev-sans-first:581.05 19:38:24 INFO - PID 3570 | Values: 2705.1 2706.7 2733.2 2758.2 2763.8 5157.6 5185.1 5271.1 5274.7 5299.2 5166.9 5214.0 5238.6 5279.7 5307.3 4634.6 4640.6 4664.2 4671.9 4704.0 4613.5 4643.1 4710.6 4716.9 4742.0 4547.4 4582.5 4650.4 4700.5 4718.4 4600.3 4669.8 4677.5 4707.2 4727.9 4634.0 4639.9 4648.2 4655.7 4693.4 5115.7 5173.1 5205.6 5236.3 5256.8 5547.6 5574.9 5646.9 5661.9 5663.3 5673.7 5684.8 5688.3 5696.1 5707.9 5297.0 5326.4 5332.9 5335.8 5352.4 5704.1 5721.6 5776.9 5811.2 5880.1 5461.6 5517.8 5517.9 5570.2 5631.5 5682.0 5683.1 5690.9 5722.7 5734.3 5546.0 5659.5 5661.3 5667.1 5674.3 5480.3 5524.1 5555.2 5591.6 5646.8 4717.5 4729.4 4730.1 4743.4 4756.5 4069.4 4076.1 4099.2 4101.9 4119.1 4684.1 4742.9 4781.9 4786.9 4830.0 5649.6 5733.6 5740.0 5742.9 5761.6 4781.5 4783.2 4792.0 4798.1 4847.9 5045.8 5053.1 5058.0 5067.3 5106.9 5146.2 5215.6 5218.3 5272.6 5286.3 5732.9 5738.4 5745.1 5748.3 5798.8 5274.8 5285.7 5289.0 5290.9 5292.0 5416.1 5485.9 5526.7 5637.7 5682.2 5711.5 5731.9 5756.4 5764.1 5768.9 5336.1 5403.4 5448.3 5501.4 5532.9 5449.8 5551.8 5557.2 5586.1 5596.9 5428.7 5459.8 5473.2 5483.2 5484.8 5464.2 5532.5 5540.4 5546.2 5572.5 5354.6 5356.1 5358.4 5367.9 5395.9 19:38:24 INFO - PID 3570 | 19:38:24 INFO - PID 3570 | [#1] ext.html Cycles:180 Average:30211.85 Median:29652.41 stddev:41343.00 (139.4%) stddev-sans-first:41399.54 19:38:24 INFO - PID 3570 | Values: 687.9 734.2 753.5 1055.6 1063.6 32742.2 33570.5 33588.7 33629.8 33841.3 34439.5 34821.1 34833.3 34836.0 34856.7 6686.9 6840.4 6871.1 6884.4 6969.3 6780.1 6885.7 6888.0 6894.3 6903.2 6799.5 6854.1 6884.2 6884.3 6913.3 6852.4 6858.9 6874.8 6875.5 6893.6 6726.4 6765.6 6840.9 6852.9 6869.9 30518.1 30574.0 30819.8 30827.5 30827.5 3056.4 3062.5 3070.8 3077.2 3092.5 24506.3 24524.6 24539.0 24611.1 24633.9 3036.8 3067.0 3085.0 3123.6 3152.1 140530.3 141783.0 147694.0 152155.0 152590.2 39836.6 39972.8 39985.6 39995.0 40000.2 41056.6 41182.6 41301.8 41516.8 41549.2 12841.8 12983.6 13012.8 13063.2 13090.7 10297.0 10531.8 10556.1 10559.6 10563.2 13155.6 13239.3 13248.0 13328.5 13446.0 5556.1 5568.7 5569.4 5647.9 5661.1 860.4 910.1 910.8 919.7 941.1 20172.5 21103.7 21107.9 21386.3 21408.7 977.5 989.5 992.5 997.4 1000.6 10413.0 10971.9 11147.3 11236.9 11268.4 175938.0 176364.0 176777.0 177957.1 179284.0 39796.8 39873.8 39889.2 39923.6 39926.8 1209.0 1250.6 1257.0 1259.0 1263.6 19262.2 19903.4 20603.4 20658.8 20726.2 29034.0 29112.0 29136.3 29136.7 29181.4 154208.0 155331.0 155386.0 155635.0 156048.2 29419.1 29454.9 29507.0 29546.0 29550.7 34082.1 34452.5 34808.1 35039.1 35193.3 26322.0 26354.9 26918.7 27166.5 27503.9 26125.2 26528.0 26710.9 26927.2 27657.4 29238.1 29247.3 29298.0 29754.1 29767.9 26237.3 26444.6 26461.5 26620.7 27109.3 19207.0 21726.1 21785.3 21870.8 21970.8 19:38:24 INFO - PID 3570 | 19:38:24 INFO - PID 3570 | [#2] jquery.html Cycles:180 Average:24411.71 Median:40087.60 stddev:58250.57 (145.3%) stddev-sans-first:58386.13 19:38:24 INFO - PID 3570 | Values: 421.7 421.9 422.0 440.5 442.3 17244.1 17496.3 17954.3 17962.8 18008.7 18289.3 18410.3 18444.7 18483.5 18492.2 5185.2 5288.1 5494.6 5500.9 5509.1 5356.3 5419.0 5436.9 5446.0 5455.2 5335.1 5388.6 5400.3 5411.8 5412.6 5268.4 5319.8 5320.3 5324.4 5333.2 4793.5 4822.0 4830.0 4831.5 4837.8 21307.6 21379.7 21442.5 21523.4 21613.5 1617.6 1638.4 1647.5 1650.9 1653.6 14418.6 14591.1 14755.8 14968.6 15050.9 2014.7 2065.7 2073.3 2100.1 2108.4 91264.5 91344.0 91393.5 93601.0 95089.0 10776.0 11022.4 11140.5 11156.6 11338.6 15373.1 15383.9 15384.1 15393.2 15396.0 7799.2 7863.1 8054.0 8072.0 8088.1 7384.1 7448.3 7545.3 7646.4 7673.4 6816.0 7024.5 7078.3 7080.8 7125.2 2071.7 2079.0 2087.6 2101.7 2196.0 843.1 866.4 878.3 884.1 914.6 16323.9 16585.8 16737.7 16754.8 17242.5 882.7 883.1 885.8 898.7 917.0 9042.5 9084.4 9244.6 9405.3 9548.0 340116.0 341390.0 342821.3 356663.0 359883.0 68795.0 73090.0 74353.6 75203.0 75210.6 1071.6 1079.3 1117.5 1121.1 1131.2 16624.0 17205.3 17356.0 17616.3 17772.7 39056.2 39277.0 39764.6 40056.2 40119.0 48492.8 50463.7 51918.7 52746.2 53191.7 8422.7 8524.6 8678.5 8718.5 8746.5 12748.7 12864.4 12909.3 13059.3 13242.5 10889.6 11065.2 11166.7 11272.0 11488.1 9488.4 9900.4 9910.7 10035.1 10225.7 11044.6 11054.8 11068.2 11148.5 11261.5 8560.6 8573.7 8660.7 8665.3 8772.0 11026.4 11063.5 11110.7 11196.3 11445.8 19:38:24 INFO - PID 3570 | 19:38:24 INFO - PID 3570 | [#3] mootools.html Cycles:180 Average:6451.22 Median:3762.42 stddev:4216.02 (112.1%) stddev-sans-first:4209.79 19:38:24 INFO - PID 3570 | Values: 1258.8 1293.6 1321.4 1322.3 1327.7 10257.0 10405.8 10687.5 10709.1 10921.8 10523.8 10752.2 10765.9 10795.1 10802.9 2141.7 2156.3 2194.6 2201.9 2202.4 2063.9 2106.0 2118.3 2127.0 2127.9 2084.3 2098.9 2101.5 2111.4 2113.2 2060.1 2068.8 2071.1 2072.7 2073.5 1977.7 2020.2 2066.6 2068.2 2075.1 10257.3 10401.7 10411.4 10427.1 10427.3 5300.3 5518.8 5526.5 5531.9 5532.7 3166.1 3281.6 3380.8 3381.7 3384.4 1116.7 1117.5 1120.5 1128.8 1146.2 15122.9 15398.8 15421.8 15428.9 15448.4 4819.9 4891.9 5025.1 5071.3 5072.0 12889.2 12994.2 12996.9 13008.5 13016.9 5549.1 5640.5 5650.7 5654.8 5677.2 5028.7 5071.3 5071.8 5106.0 5112.2 4311.2 4315.8 4325.7 4344.3 4369.9 1296.4 1336.8 1353.9 1361.8 1373.3 724.0 743.0 747.9 754.7 756.4 5619.1 5668.3 5833.1 5894.1 5960.6 826.2 843.6 844.5 849.2 854.8 3746.7 3778.2 3787.0 3882.2 3892.5 13317.8 13344.7 13388.6 13629.3 13634.4 13355.6 13499.9 13710.0 13736.9 13769.2 7246.6 7372.8 7381.4 7400.7 7411.2 5574.2 5753.0 5823.1 5893.2 5984.4 12050.8 12346.6 12394.6 12556.6 12611.9 12441.8 12479.6 12538.9 12613.4 12699.3 7595.4 7674.0 7769.2 7769.8 7788.7 9632.0 9756.9 9800.5 9825.2 9827.0 8215.9 8259.8 8324.0 8422.7 8441.9 7901.7 7976.7 8000.9 8069.0 8162.5 7473.1 7687.9 7763.8 7766.9 7768.7 4873.5 5539.3 5553.8 5607.7 5789.2 5436.1 5619.2 5734.0 5808.9 5851.8 19:38:24 INFO - PID 3570 | 19:38:24 INFO - PID 3570 | [#4] prototype.html Cycles:180 Average:4719.70 Median:5354.19 stddev:1401.50 (26.2%) stddev-sans-first:1367.15 19:38:24 INFO - PID 3570 | Values: 385.1 389.8 390.5 391.4 400.0 5376.6 5419.9 5429.8 5437.3 5449.5 5182.3 5285.4 5317.7 5319.7 5325.5 4180.2 4202.0 4205.4 4211.5 4222.3 4181.4 4184.2 4186.6 4204.4 4206.2 3889.6 4044.8 4153.3 4153.9 4161.6 4047.3 4055.9 4058.6 4060.0 4063.1 3528.5 3535.4 3539.9 3544.9 3547.1 5155.1 5294.1 5302.6 5319.0 5331.8 4752.8 4777.8 4788.7 4796.1 4806.6 5690.3 5692.8 5698.3 5706.5 5710.6 3870.2 3993.3 4005.7 4007.5 4014.3 5832.3 6035.3 6069.4 6075.6 6114.4 4063.3 4084.4 4086.7 4098.9 4099.3 4135.6 4135.9 4136.6 4146.3 4156.4 4590.7 4752.2 4758.7 4774.1 4783.8 5701.9 5710.0 5722.1 5740.9 5743.2 1421.9 1425.5 1426.1 1427.2 1432.7 906.6 950.1 955.0 960.5 966.9 4947.4 4951.2 4973.9 4976.2 4985.9 5928.7 5940.3 5944.6 5946.5 5958.0 4802.6 4923.4 4936.3 4953.7 4964.9 3115.8 3160.7 3160.8 3161.6 3164.1 5447.6 5463.9 5465.3 5470.7 5500.7 5844.5 6066.5 6075.7 6112.2 6124.4 5492.7 5511.5 5515.2 5523.6 5536.9 5830.5 5923.2 5979.7 6000.5 6002.1 5852.6 5860.7 5866.2 5879.9 5892.3 5294.2 5470.4 5475.8 5492.8 5501.5 4001.5 4015.8 4019.3 4024.9 4027.9 5891.0 5977.2 5977.3 5986.8 5986.9 5750.2 5759.0 5760.6 5777.2 5782.9 5766.9 5790.6 5808.1 5809.0 5813.9 5510.3 5676.8 5717.9 5719.6 5751.8 5808.7 5833.1 5835.0 5853.9 5864.2 5457.9 5581.8 5600.3 5614.8 5619.9 19:38:24 INFO - PID 3570 | 19:38:24 INFO - PID 3570 | [#5] yui.html Cycles:180 Average:17520.07 Median:34289.91 stddev:23168.27 (67.6%) stddev-sans-first:23198.91 19:38:24 INFO - PID 3570 | Values: 717.3 726.7 752.5 754.1 772.8 12328.2 12614.7 14052.8 14749.5 14824.5 15612.1 16161.9 16191.4 16199.1 16251.5 883.6 897.7 902.5 902.8 903.4 908.0 911.3 911.9 916.1 916.5 908.7 960.6 962.4 962.4 964.8 942.9 960.1 960.1 960.6 961.3 693.9 695.3 696.3 697.0 697.6 15279.3 15391.6 15430.7 15454.8 15463.8 16224.8 16566.8 16709.7 16718.7 16731.7 12836.5 12972.5 13321.3 13322.1 13332.7 3097.8 3116.9 3118.2 3124.5 3132.0 88648.1 89048.0 90535.5 91224.5 92887.1 12940.2 13113.9 13116.0 13182.3 13230.5 23342.2 23437.4 23990.0 24000.0 24090.4 6308.4 6377.9 6388.5 6427.5 6439.5 3078.8 3153.8 3154.8 3157.0 3159.8 3819.1 3884.2 3892.4 3897.5 4294.6 750.8 772.4 777.8 780.0 784.8 611.7 625.2 625.7 628.1 639.4 10054.2 10267.4 10765.4 10822.5 11113.5 598.5 610.5 612.7 631.5 632.6 4833.7 4917.2 4948.8 5051.9 5088.5 80760.0 81505.0 81691.0 82821.0 83107.2 73351.0 74469.3 76013.6 76438.2 77177.0 58587.0 64949.7 66381.0 66440.0 66554.0 9969.8 10388.5 10907.2 10938.2 11084.3 27549.6 27809.9 27910.6 28666.7 29376.3 34126.0 34453.8 34740.3 34836.7 35337.0 14308.5 14426.5 14549.6 14737.1 14737.4 15110.3 15266.0 15322.8 15542.8 15582.3 13776.6 13808.9 13827.6 14469.8 14700.8 13937.9 14180.1 14209.0 14326.1 15065.8 13574.8 13674.7 13758.4 14172.6 14377.6 9641.7 9716.7 9892.8 9942.8 10338.6 10697.9 10898.7 11322.1 11459.6 11620.1 19:38:24 INFO - PID 3570 | -------- Summary: end -------- 19:38:24 INFO - PID 3570 | 19:38:25 INFO - TEST-INFO | 3570: exit 0 19:38:25 INFO - TEST-OK | dromaeo_css | took 1149107ms 19:38:25 INFO - TEST-START | kraken 19:38:25 INFO - operating with platform_type : linux_ 19:38:25 INFO - Initialising browser for kraken test... 19:38:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45466/getInfo.html -profile /tmp/tmpgHSngp/profile 19:38:25 INFO - TEST-INFO | started process 3989 (/builds/slave/test/build/application/firefox/firefox http://localhost:45466/getInfo.html) 19:39:00 INFO - TEST-INFO | 3989: killed by SIGTERM 19:39:00 INFO - Browser initialized. 19:39:00 INFO - Running cycle 1/1 for kraken test... 19:39:00 INFO - TEST-INFO | started process 4211 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgHSngp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:39:12 INFO - PID 4211 | RSS: Main: 172224512 19:39:12 INFO - PID 4211 | 19:39:15 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:45466/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45466/tests/kraken/driver.html?testName=audio-beat-detection) 19:39:16 INFO - PID 4211 | RSS: Main: 178397184 19:39:16 INFO - PID 4211 | 19:39:18 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:45466/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45466/tests/kraken/driver.html?testName=audio-dft) 19:39:19 INFO - PID 4211 | RSS: Main: 176984064 19:39:19 INFO - PID 4211 | 19:39:22 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:45466/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45466/tests/kraken/driver.html?testName=audio-fft) 19:39:22 INFO - PID 4211 | RSS: Main: 175239168 19:39:22 INFO - PID 4211 | 19:39:25 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:45466/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45466/tests/kraken/driver.html?testName=audio-oscillator) 19:39:25 INFO - PID 4211 | RSS: Main: 175583232 19:39:25 INFO - PID 4211 | 19:39:27 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:45466/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45466/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:39:28 INFO - PID 4211 | RSS: Main: 175542272 19:39:28 INFO - PID 4211 | 19:39:31 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:45466/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45466/tests/kraken/driver.html?testName=imaging-darkroom) 19:39:32 INFO - PID 4211 | RSS: Main: 176816128 19:39:32 INFO - PID 4211 | 19:39:35 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:45466/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45466/tests/kraken/driver.html?testName=imaging-desaturate) 19:39:36 INFO - PID 4211 | RSS: Main: 176594944 19:39:36 INFO - PID 4211 | 19:39:39 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:45466/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45466/tests/kraken/driver.html?testName=json-parse-financial) 19:39:39 INFO - PID 4211 | RSS: Main: 176685056 19:39:39 INFO - PID 4211 | 19:39:41 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:45466/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45466/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:39:42 INFO - PID 4211 | RSS: Main: 176721920 19:39:42 INFO - PID 4211 | 19:39:43 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:45466/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45466/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:39:44 INFO - PID 4211 | RSS: Main: 176996352 19:39:44 INFO - PID 4211 | 19:39:46 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:45466/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45466/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:39:47 INFO - PID 4211 | RSS: Main: 177115136 19:39:47 INFO - PID 4211 | 19:39:50 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:45466/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45466/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:39:50 INFO - PID 4211 | RSS: Main: 176877568 19:39:50 INFO - PID 4211 | 19:39:54 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:45466/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45466/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:39:54 INFO - PID 4211 | RSS: Main: 176873472 19:39:54 INFO - PID 4211 | 19:39:56 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:45466/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45466/tests/kraken/driver.html?testName=ai-astar) 19:39:56 INFO - PID 4211 | RSS: Main: 178733056 19:39:56 INFO - PID 4211 | 19:39:56 INFO - PID 4211 | __start_tp_report 19:39:56 INFO - PID 4211 | _x_x_mozilla_page_load 19:39:56 INFO - PID 4211 | _x_x_mozilla_page_load_details 19:39:56 INFO - PID 4211 | |i|pagename|runs| 19:39:56 INFO - PID 4211 | |0;ai-astar;103;111;110;111;110;110;110;114;114;115 19:39:56 INFO - PID 4211 | |1;audio-beat-detection;149;127;133;173;124;125;125;123;144;125 19:39:56 INFO - PID 4211 | |2;audio-dft;166;164;163;164;166;169;168;163;162;168 19:39:56 INFO - PID 4211 | |3;audio-fft;75;74;73;104;75;75;73;74;91;73 19:39:56 INFO - PID 4211 | |4;audio-oscillator;84;87;118;83;83;85;96;83;83;115 19:39:56 INFO - PID 4211 | |5;imaging-gaussian-blur;118;115;114;114;113;115;114;115;114;113 19:39:56 INFO - PID 4211 | |6;imaging-darkroom;149;154;150;151;149;151;149;150;151;149 19:39:56 INFO - PID 4211 | |7;imaging-desaturate;97;95;99;99;94;94;94;94;95;94 19:39:56 INFO - PID 4211 | |8;json-parse-financial;56;54;57;56;57;57;58;56;56;56 19:39:56 INFO - PID 4211 | |9;json-stringify-tinderbox;56;66;57;56;57;56;56;57;56;56 19:39:56 INFO - PID 4211 | |10;stanford-crypto-aes;87;87;88;85;86;86;87;89;122;88 19:39:56 INFO - PID 4211 | |11;stanford-crypto-ccm;139;145;141;137;132;137;134;133;133;139 19:39:56 INFO - PID 4211 | |12;stanford-crypto-pbkdf2;190;198;189;199;187;203;204;193;212;187 19:39:56 INFO - PID 4211 | |13;stanford-crypto-sha256-iterative;74;75;81;75;74;74;75;74;74;73 19:39:56 INFO - PID 4211 | __end_tp_report 19:39:56 INFO - PID 4211 | __start_cc_report 19:39:56 INFO - PID 4211 | _x_x_mozilla_cycle_collect,873 19:39:56 INFO - PID 4211 | __end_cc_report 19:39:56 INFO - PID 4211 | __startTimestamp1495766396815__endTimestamp 19:39:56 INFO - PID 4211 | 19:39:56 INFO - PID 4211 | ------- Summary: start ------- 19:39:56 INFO - PID 4211 | Number of tests: 14 19:39:56 INFO - PID 4211 | 19:39:56 INFO - PID 4211 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:3.36 (3.0%) stddev-sans-first:2.06 19:39:56 INFO - PID 4211 | Values: 103.0 111.0 110.0 111.0 110.0 110.0 110.0 114.0 114.0 115.0 19:39:56 INFO - PID 4211 | 19:39:56 INFO - PID 4211 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:130.00 stddev:16.17 (12.4%) stddev-sans-first:16.32 19:39:56 INFO - PID 4211 | Values: 149.0 127.0 133.0 173.0 124.0 125.0 125.0 123.0 144.0 125.0 19:39:56 INFO - PID 4211 | 19:39:56 INFO - PID 4211 | [#2] audio-dft Cycles:10 Average:165.30 Median:166.00 stddev:2.45 (1.5%) stddev-sans-first:2.59 19:39:56 INFO - PID 4211 | Values: 166.0 164.0 163.0 164.0 166.0 169.0 168.0 163.0 162.0 168.0 19:39:56 INFO - PID 4211 | 19:39:56 INFO - PID 4211 | [#3] audio-fft Cycles:10 Average:78.70 Median:74.50 stddev:10.40 (14.0%) stddev-sans-first:10.95 19:39:56 INFO - PID 4211 | Values: 75.0 74.0 73.0 104.0 75.0 75.0 73.0 74.0 91.0 73.0 19:39:56 INFO - PID 4211 | 19:39:56 INFO - PID 4211 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:83.50 stddev:13.67 (16.4%) stddev-sans-first:14.21 19:39:56 INFO - PID 4211 | Values: 84.0 87.0 118.0 83.0 83.0 85.0 96.0 83.0 83.0 115.0 19:39:56 INFO - PID 4211 | 19:39:56 INFO - PID 4211 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.50 stddev:1.43 (1.3%) stddev-sans-first:0.78 19:39:56 INFO - PID 4211 | Values: 118.0 115.0 114.0 114.0 113.0 115.0 114.0 115.0 114.0 113.0 19:39:56 INFO - PID 4211 | 19:39:56 INFO - PID 4211 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:150.50 stddev:1.57 (1.0%) stddev-sans-first:1.59 19:39:56 INFO - PID 4211 | Values: 149.0 154.0 150.0 151.0 149.0 151.0 149.0 150.0 151.0 149.0 19:39:56 INFO - PID 4211 | 19:39:56 INFO - PID 4211 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:2.07 (2.2%) stddev-sans-first:2.12 19:39:56 INFO - PID 4211 | Values: 97.0 95.0 99.0 99.0 94.0 94.0 94.0 94.0 95.0 94.0 19:39:56 INFO - PID 4211 | 19:39:56 INFO - PID 4211 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.50 stddev:1.06 (1.9%) stddev-sans-first:1.12 19:39:56 INFO - PID 4211 | Values: 56.0 54.0 57.0 56.0 57.0 57.0 58.0 56.0 56.0 56.0 19:39:56 INFO - PID 4211 | 19:39:56 INFO - PID 4211 | [#9] json-stringify-tinderbox Cycles:10 Average:57.30 Median:56.50 stddev:3.09 (5.5%) stddev-sans-first:3.24 19:39:56 INFO - PID 4211 | Values: 56.0 66.0 57.0 56.0 57.0 56.0 56.0 57.0 56.0 56.0 19:39:56 INFO - PID 4211 | 19:39:56 INFO - PID 4211 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:87.00 stddev:11.13 (12.8%) stddev-sans-first:11.73 19:39:56 INFO - PID 4211 | Values: 87.0 87.0 88.0 85.0 86.0 86.0 87.0 89.0 122.0 88.0 19:39:56 INFO - PID 4211 | 19:39:56 INFO - PID 4211 | [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:138.00 stddev:4.14 (3.0%) stddev-sans-first:4.32 19:39:56 INFO - PID 4211 | Values: 139.0 145.0 141.0 137.0 132.0 137.0 134.0 133.0 133.0 139.0 19:39:56 INFO - PID 4211 | 19:39:56 INFO - PID 4211 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.20 Median:198.50 stddev:8.42 (4.2%) stddev-sans-first:8.62 19:39:56 INFO - PID 4211 | Values: 190.0 198.0 189.0 199.0 187.0 203.0 204.0 193.0 212.0 187.0 19:39:56 INFO - PID 4211 | 19:39:56 INFO - PID 4211 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:74.50 stddev:2.23 (3.0%) stddev-sans-first:2.35 19:39:56 INFO - PID 4211 | Values: 74.0 75.0 81.0 75.0 74.0 74.0 75.0 74.0 74.0 73.0 19:39:56 INFO - PID 4211 | -------- Summary: end -------- 19:39:56 INFO - PID 4211 | 19:39:57 INFO - TEST-INFO | 4211: exit 0 19:39:57 INFO - TEST-OK | kraken | took 92535ms 19:39:57 INFO - SUITE-END | took 1241s 19:39:57 INFO - Completed test suite (00:20:41) 19:39:57 INFO - javascript benchmark 19:39:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6799.899584700072, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2705.1343570057584, 2706.729327067295, 2733.2073698627387, 2758.2276962450496, 2763.7650799682033, 5157.638965272423, 5185.066687996164, 5271.130263506521, 5274.73626318684, 5299.231611416352, 5166.9224961625605, 5214.035403450364, 5238.580913526918, 5279.736013199335, 5307.310049693544, 4634.606058485033, 4640.628749700016, 4664.183767840623, 4671.85984420468, 4703.976480117594, 4613.515580864011, 4643.094596553673, 4710.646701497401, 4716.882077948045, 4742.0, 4547.408836851188, 4582.541745825424, 4650.395448591696, 4700.529947005306, 4718.363020992157, 4600.332951721982, 4669.813207471697, 4677.4854765975715, 4707.176244157259, 4727.929081063787, 4633.9536604634195, 4639.860804175846, 4648.209804333272, 4655.7439340836245, 4693.389859318267, 5115.667481613683, 5173.094708426048, 5205.583553315726, 5236.345456817898, 5256.789728410859, 5547.639403438804, 5574.888502229933, 5646.915296270559, 5661.943380566183, 5663.32040155184, 5673.6879471629045, 5684.8010319639025, 5688.345840228385, 5696.145578163268, 5707.942920570783, 5297.0, 5326.414094449608, 5332.9466705333225, 5335.813246536352, 5352.411234764173, 5704.1443783432815, 5721.5708821838525, 5776.884462310814, 5811.215485909348, 5880.088586269135, 5461.617686761889, 5517.806876759374, 5517.944820551824, 5570.220169176318, 5631.493165615114, 5681.971590142106, 5683.147527870852, 5690.9146362804595, 5722.656640601577, 5734.254546908875, 5546.0, 5659.462351076641, 5661.34894487131, 5667.093265077568, 5674.347450043216, 5480.287562616914, 5524.14375771756, 5555.2222688823595, 5591.608587398843, 5646.802361917313, 4717.481077081518, 4729.385179926588, 4730.077634861169, 4743.407074115736, 4756.548127927841, 4069.369247766601, 4076.103257283393, 4099.1801639672185, 4101.938470922939, 4119.052617897841, 4684.110019096361, 4742.857714268577, 4781.856544303677, 4786.880327991828, 4830.0, 5649.576281778883, 5733.569982251348, 5739.971300143556, 5742.856428589235, 5761.596688231783, 4781.545753153445, 4783.23468245086, 4791.976040119777, 4798.1123492154065, 4847.878803029882, 5045.7981680732355, 5053.065182941167, 5058.038972595195, 5067.315912351859, 5106.872328191899, 5146.202338637517, 5215.55667768244, 5218.321618189611, 5272.604554658339, 5286.259923610774, 5732.856678583069, 5738.397468265939, 5745.080787074048, 5748.281464816898, 5798.768049277982, 5274.762635681327, 5285.68285902847, 5289.047971365191, 5290.947090529199, 5292.047431462373, 5416.106342453451, 5485.917711234414, 5526.668399896019, 5637.746301416364, 5682.204491371129, 5711.457411545896, 5731.914021289767, 5756.395578464369, 5764.13537969308, 5768.855778605568, 5336.146216605324, 5403.351597808288, 5448.346198456052, 5501.394846566955, 5532.889342213214, 5449.754761035683, 5551.750171242223, 5557.194206839905, 5586.078297080936, 5596.90860282241, 5428.728563571726, 5459.808906688247, 5473.151661492475, 5483.232347471437, 5484.780608775604, 5464.18037294409, 5532.529734972572, 5540.36285827135, 5546.195801608664, 5572.498475137095, 5354.598405119554, 5356.089464791073, 5358.410574836843, 5367.919481207707, 5395.865103372447], "value": 5128.132855738101, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.9002544631029, 734.2327268004934, 753.5139834806548, 1055.6041484443333, 1063.5798859450522, 32742.181445463877, 33570.49644255338, 33588.66411335889, 33629.83185084071, 33841.32317353651, 34439.48340774891, 34821.12947176315, 34833.303333933305, 34836.0, 34856.651433485655, 6686.933130668704, 6840.384365407125, 6871.106756121697, 6884.414824739903, 6969.337912898267, 6780.08468856703, 6885.655717214145, 6887.965560172192, 6894.310568943116, 6903.240643529208, 6799.456043516507, 6854.074699915497, 6884.242733299333, 6884.277150899158, 6913.308669133096, 6852.383285504328, 6858.897116543231, 6874.793756187322, 6875.518713690044, 6893.551919125291, 6726.3609957054005, 6765.560238584526, 6840.863182736367, 6852.862942741117, 6869.862602747917, 30518.084457466313, 30574.0, 30819.845900770575, 30827.537586936214, 30827.537586936214, 3056.3581647853975, 3062.4793785056595, 3070.846457677107, 3077.1845460952864, 3092.5206592978125, 24506.264812055666, 24524.63213051788, 24539.0, 24611.138610148737, 24633.87683061591, 3036.802607830484, 3067.0, 3084.9691503085132, 3123.6095488063993, 3152.133163380066, 140530.29734851362, 141783.0, 147694.0, 152155.0, 152590.23704881515, 39836.60163398387, 39972.800135999714, 39985.60014399877, 39995.0, 40000.1999960005, 41056.58943410528, 41182.58817411847, 41301.79349103235, 41516.79241603833, 41549.1690166195, 12841.807372889414, 12983.610491685264, 13012.804807927889, 13063.216207027419, 13090.672733181747, 10297.0, 10531.789364212673, 10556.102731267929, 10559.63041293551, 10563.154947604173, 13155.60533184006, 13239.271840048697, 13248.0, 13328.466861325633, 13446.0, 5556.138798486241, 5568.688994067416, 5569.443055694398, 5647.915281270784, 5661.065924122474, 860.3805260212762, 910.0762725833284, 910.7677542226822, 919.6919032124314, 941.087145468894, 20172.495687607927, 21103.68344474834, 21107.894460527907, 21386.251481198084, 21408.678869816966, 977.452626529146, 989.4557993103764, 992.4591097851688, 997.3616885193337, 1000.6347683095763, 10413.0, 10971.890281097247, 11147.331160130418, 11236.943815281034, 11268.380239086766, 175938.0, 176364.0, 176777.0, 177957.1102144507, 179284.0, 39796.80101599474, 39873.80063099666, 39889.20221595552, 39923.60076399257, 39926.80036599856, 1208.957686480969, 1250.6185613388004, 1257.0258050011132, 1258.9559365422167, 1263.6398626391617, 19262.22951081941, 19903.402897913085, 20603.381898543066, 20658.793412065686, 20726.170953161705, 29034.0, 29112.0, 29136.27159321034, 29136.7086329134, 29181.416371672873, 154208.0, 155331.0, 155386.0, 155635.0, 156048.21975890046, 29419.117426476383, 29454.852725736233, 29507.0, 29546.0, 29550.704492954796, 34082.14794630154, 34452.48321275133, 34808.12979675528, 35039.124021898635, 35193.29613407666, 26322.0, 26354.86822565875, 26918.73081269162, 27166.456670866868, 27503.86248068827, 26125.216243512725, 26528.0, 26710.86644566765, 26927.192184234504, 27657.44685106327, 29238.122856314345, 29247.268818279714, 29298.0, 29754.10737677873, 29767.851160744056, 26237.34406639773, 26444.603330950435, 26461.470770584867, 26620.7337926626, 27109.322266943484, 19207.0, 21726.130954761633, 21785.346439606838, 21870.781292186875, 21970.780292196872], "value": 14439.627586597086, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.6521369869856, 421.91350773091517, 421.9535851056381, 440.4824331410593, 442.31662082083176, 17244.13779311034, 17496.300147994065, 17954.281828726853, 17962.82037179628, 18008.72986905196, 18289.268429262847, 18410.26358945644, 18444.723329150074, 18483.53791155222, 18492.167852446637, 5185.222216667492, 5288.0745869472785, 5494.560435165197, 5500.889982200353, 5509.118541033436, 5356.303680521527, 5419.0, 5436.891262174754, 5446.019716451037, 5455.1544510600725, 5335.146376579748, 5388.595855310848, 5400.29796126503, 5411.810586629469, 5412.5940554458375, 5268.367795864482, 5319.840404787863, 5320.308359913225, 5324.440933701983, 5333.173358129496, 4793.520647935214, 4821.951780482221, 4829.95170048302, 4831.492693267227, 4837.758112094416, 21307.573848523098, 21379.67930481044, 21442.46393840151, 21523.354299371043, 21613.45966350838, 1617.563257920355, 1638.3528506239968, 1647.4975132584557, 1650.8596769274627, 1653.5866033491627, 14418.639534011629, 14591.124532527976, 14755.778663319952, 14968.625784355369, 15050.924745376204, 2014.6977953306975, 2065.7417822772154, 2073.2536286936693, 2100.12844669462, 2108.367489753083, 91264.5436772812, 91344.0, 91393.54303228442, 93600.99999999932, 95089.0, 10776.0, 11022.44887755609, 11140.49867755953, 11156.609518666808, 11338.60314888975, 15373.077615343114, 15383.923080384526, 15384.076955382488, 15393.153376564173, 15396.0, 7799.220077992155, 7863.0957439894, 8054.0, 8071.950646416046, 8088.069871964799, 7384.113906331275, 7448.292412220831, 7545.283198096172, 7646.35006024483, 7673.424493163036, 6816.0, 7024.473164512682, 7078.327558881898, 7080.822979425556, 7125.216226215112, 2071.730675012239, 2078.958420831605, 2087.645100332947, 2101.747790265147, 2196.022769867394, 843.1484200957077, 866.4281574161023, 878.2622597018535, 884.062893333069, 914.5792935249859, 16323.918380408022, 16585.751213731804, 16737.748933766004, 16754.83245167557, 17242.482725518254, 882.6557642519423, 883.0860059838037, 885.7696998780364, 898.7079199260136, 916.9954150229206, 9042.547872606343, 9084.40951338161, 9244.583993720298, 9405.294602904809, 9547.952260238655, 340116.0, 341390.0, 342821.2984390555, 356663.0, 359883.0, 68795.0, 73090.0, 74353.6282318585, 75203.0, 75210.62394687992, 1071.566015763617, 1079.2984560035882, 1117.474786850179, 1121.091915548392, 1131.1516362727955, 16624.0, 17205.311787528357, 17356.0, 17616.29534818593, 17772.733408998618, 39056.21887562176, 39277.0, 39764.602353976086, 40056.1988760229, 40119.0, 48492.75753621209, 50463.74768126136, 51918.74040629773, 52746.20880686869, 53191.734041329546, 8422.70520531803, 8524.616392262487, 8678.479291242546, 8718.520481373585, 8746.51894145828, 12748.681282968, 12864.356782160667, 12909.289989050316, 13059.34703264852, 13242.470301187845, 10889.618863340062, 11065.225434219527, 11166.665000050012, 11272.0, 11488.080953523866, 9488.383255088396, 9900.405975641484, 9910.653127140515, 10035.09684128432, 10225.670662813787, 11044.613438529614, 11054.778904422028, 11068.225224234226, 11148.498317575892, 11261.549538018715, 8560.571971401281, 8573.699920502753, 8660.653573856975, 8665.306775458075, 8771.956140219258, 11026.393548354597, 11063.502142403771, 11110.722231944266, 11196.27224230455, 11445.771084578428], "value": 8879.272238180209, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1258.8174714666375, 1293.5860524632117, 1321.3921596065816, 1322.3454390076913, 1327.7145413736046, 10257.0, 10405.84391234132, 10687.465626718671, 10709.089727373173, 10921.836172457419, 10523.84214236787, 10752.193585481082, 10765.946170269157, 10795.136389088873, 10802.891971080287, 2141.71086903268, 2156.277646988253, 2194.628357276702, 2201.856879302848, 2202.3723238876923, 2063.876167429959, 2105.989470052655, 2118.3221369161874, 2126.9893650531803, 2127.9042443090098, 2084.3121769816, 2098.9055492502875, 2101.53766171442, 2111.3771437425994, 2113.17586141405, 2060.0832629479887, 2068.7931206879193, 2071.140476702167, 2072.678734796109, 2073.481629592602, 1977.73300604418, 2020.2323117215365, 2066.597013582337, 2068.162394230339, 2075.138817390781, 10257.33327333721, 10401.68794936153, 10411.427371494565, 10427.113695335906, 10427.322224055488, 5300.284461597712, 5518.834434966958, 5526.50261476465, 5531.917021244684, 5532.6680399175775, 3166.0976621662717, 3281.6390197078304, 3380.797152170853, 3381.712554432876, 3384.4415671414185, 1116.748731535398, 1117.5306371324064, 1120.4621781544904, 1128.8137457319533, 1146.1976616368493, 15122.924385378003, 15398.846011539854, 15421.768673470018, 15428.922855385763, 15448.38206471751, 4819.927701084486, 4891.877703057381, 5025.14572522672, 5071.264666623319, 5072.036313100499, 12889.162204456868, 12994.155379900276, 12996.870031299755, 13008.479660813651, 13016.934915325362, 5549.084401073858, 5640.492355688008, 5650.66096034231, 5654.830355089354, 5677.233573467529, 5028.698278103326, 5071.340725705634, 5071.771770270347, 5106.0, 5112.185174263157, 4311.245532031882, 4315.784210789448, 4325.675574331937, 4344.261475549164, 4369.868903932887, 1296.3647812571771, 1336.752700750345, 1353.939072741729, 1361.8229630148016, 1373.3270697358423, 723.9855202895912, 742.9814254643569, 747.917729049804, 754.6717178027576, 756.3911051603512, 5619.100943848965, 5668.26312579362, 5833.066709326487, 5894.145348924382, 5960.612560183574, 826.1944604011042, 843.5992903370973, 844.5270648436895, 849.197508354599, 854.7948492361912, 3746.662800347982, 3778.1688028633657, 3786.981065094657, 3882.2041481496226, 3892.5134358205223, 13317.800232996513, 13344.666383340495, 13388.598342049754, 13629.250391228577, 13634.386452609459, 13355.599332020054, 13499.932500337436, 13710.040297179301, 13736.862631373559, 13769.173849569059, 7246.601436920914, 7372.815679608053, 7381.44639152055, 7400.74097406599, 7411.221821708751, 5574.16387541872, 5753.0, 5823.126531020212, 5893.174955506147, 5984.401559843981, 12050.819237711617, 12346.567870124503, 12394.62816115518, 12556.623301300975, 12611.93694031524, 12441.813372799234, 12479.56321528742, 12538.87461125377, 12613.369331533204, 12699.301538415106, 7595.392368610387, 7674.0, 7769.223077692412, 7769.805754856174, 7788.727394541163, 9632.036796320312, 9756.902430975882, 9800.460974646463, 9825.16486098661, 9827.0, 8215.876761848696, 8259.752207433787, 8324.0, 8422.747317580483, 8441.944756905386, 7901.68393264263, 7976.7208147714555, 8000.919990800017, 8068.959655201921, 8162.469439486415, 7473.103227612503, 7687.884681729666, 7763.805904852424, 7766.92233077662, 7768.728094516665, 4873.537013983666, 5539.335279766454, 5553.805616803554, 5607.747651355618, 5789.189513468202, 5436.103042997861, 5619.241402410622, 5733.971330143323, 5808.883822323614, 5851.765929362778], "value": 4835.847440054593, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.0873429970968, 389.84601082572374, 390.4884601172464, 391.42851436902123, 399.97400168989, 5376.628959615297, 5419.918701219485, 5429.809956651518, 5437.293151890249, 5449.520468186975, 5182.300389447433, 5285.365756109262, 5317.734113294339, 5319.707416092114, 5325.547328477084, 4180.24755544002, 4201.978990105045, 4205.401947260052, 4211.515675697296, 4222.345536441856, 4181.372794080897, 4184.184084103601, 4186.602272784081, 4204.390363397306, 4206.242876282268, 3889.5527014393424, 4044.777537235451, 4153.273177193994, 4153.8753837384775, 4161.583841615829, 4047.332190188615, 4055.9391609125887, 4058.594140585947, 4060.0, 4063.085805693725, 3528.5060091587197, 3535.4343305071066, 3539.911502212465, 3544.8936531904083, 3547.0954906498678, 5155.149400348938, 5294.073537130987, 5302.628815982883, 5318.973405132988, 5331.760070796823, 4752.833650822205, 4777.80888764449, 4788.688735232199, 4796.081567373044, 4806.567408933178, 5690.2887139107615, 5692.77228910843, 5698.34469036062, 5706.457886500776, 5710.628809127435, 3870.1679138985255, 3993.28120938231, 4005.6595189408936, 4007.499062617173, 4014.3376342903384, 5832.270966129234, 6035.275766907999, 6069.393060693939, 6075.574709770318, 6114.4408175915305, 4063.3498640218013, 4084.4281800547947, 4086.7139300248696, 4098.918021639551, 4099.344104943195, 4135.648469880034, 4135.875923722293, 4136.607022332873, 4146.274401979642, 4156.397322388298, 4590.747508886977, 4752.2158843790385, 4758.714477131383, 4774.140654682121, 4783.784729687172, 5701.857453563611, 5709.9714501427225, 5722.113072473773, 5740.885182296331, 5743.2246646703, 1421.8649228323293, 1425.4939496478808, 1426.1158081989233, 1427.1722401007391, 1432.7134573085425, 906.6101576322113, 950.0736781637847, 954.9761255968517, 960.5149399553181, 966.8639348765173, 4947.392097568305, 4951.16806781486, 4973.850784476472, 4976.2038073908, 4985.925211121836, 5928.703564821742, 5940.316863560746, 5944.64332140073, 5946.464818166386, 5957.970210148921, 4802.591779698765, 4923.384576927884, 4936.259561065797, 4953.702777833341, 4964.90070198594, 3115.8286294254035, 3160.652328243891, 3160.8103513789247, 3161.5772902193644, 3164.098232003868, 5447.564194864481, 5463.9180412293845, 5465.262189604353, 5470.699111548903, 5500.669959802424, 5844.47399734026, 6066.484348830399, 6075.726592303357, 6112.205413296243, 6124.448799607968, 5492.725363731797, 5511.53151982078, 5515.172724091419, 5523.585731070106, 5536.916946245809, 5830.504407125272, 5923.229980102559, 5979.714361412317, 6000.459958603747, 6002.129691194665, 5852.648841069549, 5860.677662728591, 5866.208061911588, 5879.853003674943, 5892.263467066617, 5294.152935530296, 5470.398256191736, 5475.808346707846, 5492.80775172867, 5501.504864562208, 4001.4598029265676, 4015.779132147643, 4019.296623091006, 4024.879253622396, 4027.9395809062303, 5890.970545147246, 5977.22296101504, 5977.3126090500145, 5986.820395388146, 5986.892424901407, 5750.153673931263, 5759.0, 5760.6255593386295, 5777.2200752897825, 5782.884342313214, 5766.94233057664, 5790.610253539036, 5808.099744539603, 5808.954388209993, 5813.94186058134, 5510.338759348743, 5676.829695109153, 5717.914231286617, 5719.599628025998, 5751.769929202785, 5808.73860676279, 5833.095870140135, 5835.0, 5853.94146058551, 5864.237649105589, 5457.918131228114, 5581.832545023656, 5600.27196464457, 5614.775408983595, 5619.8876022480135], "value": 4289.370872818224, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.2970488920861, 726.7020521586151, 752.5183882315318, 754.0724908362714, 772.7990722412171, 12328.198667086655, 12614.684632884182, 14052.789208161874, 14749.48376806812, 14824.481143159992, 15612.141332226724, 16161.91919040403, 16191.352345906149, 16199.109049002329, 16251.51245462635, 883.575883575884, 897.7037577599376, 902.5216635183364, 902.7923577577161, 903.4488961733338, 908.0420156734642, 911.2573252798948, 911.9088091190861, 916.1342531307916, 916.5005072235614, 908.736466424736, 960.5581432541039, 962.3888830592589, 962.4369743699943, 964.8118616869713, 942.8727121838567, 960.0543464687278, 960.1023043454393, 960.577345967772, 961.2550273537994, 693.8751024815531, 695.2664938489891, 696.3384784454738, 697.0276464332228, 697.5570512724406, 15279.312430940634, 15391.615209619737, 15430.691386172213, 15454.845451545452, 15463.768043479356, 16224.83775162245, 16566.751498727528, 16709.66580668392, 16718.749218761608, 16731.66536669272, 12836.486540538368, 12972.545960891324, 13321.333933303393, 13322.134061285986, 13332.73334533304, 3097.767667424952, 3116.937661246785, 3118.189270789588, 3124.53132030195, 3131.984340078308, 88648.11351886527, 89048.0, 90535.54732226362, 91224.54387728019, 92887.07112928852, 12940.15888967233, 13113.934430327978, 13116.0, 13182.274974876282, 13230.536931207362, 23342.183023594094, 23437.41406464852, 23990.0, 24000.0, 24090.397740056287, 6308.432241098323, 6377.904331435032, 6388.520860935449, 6427.485801135898, 6439.54923155384, 3078.753699704063, 3153.7950033247766, 3154.763392745553, 3157.0, 3159.778815482894, 3819.1216020315483, 3884.18432129256, 3892.416137579329, 3897.4738410314812, 4294.613484786384, 750.7597568777938, 772.447699894578, 777.7511196417092, 779.9532028078333, 784.8430313937235, 611.6788685939828, 625.221599109112, 625.7121724006917, 628.0892705576932, 639.3606393606393, 10054.245931555162, 10267.383956962607, 10765.354078755143, 10822.458877056115, 11113.499892504857, 598.5331441475656, 610.4963405190736, 612.7089632424563, 631.4821846086257, 632.6077831744255, 4833.73414462208, 4917.1842650103545, 4948.826791062367, 5051.898962020812, 5088.516590923857, 80760.0, 81505.0, 81691.0, 82821.0, 83107.16892830994, 73351.0, 74469.25530744623, 76013.61993189999, 76438.23561764423, 77177.0, 58587.0, 64949.67525162439, 66381.0, 66440.0, 66554.0, 9969.800603988024, 10388.532516036645, 10907.236493445384, 10938.234323597271, 11084.334939903632, 27549.58675619827, 27809.860950695118, 27910.581341279492, 28666.713332866406, 29376.26559336034, 34126.0, 34453.82773086119, 34740.305193895474, 34836.651633484355, 35337.0, 14308.49920252786, 14426.495072672406, 14549.636259093184, 14737.11577305365, 14737.410503579737, 15110.320035598204, 15266.0, 15322.846771532142, 15542.84457155414, 15582.298796553956, 13776.586702398945, 13808.86191138116, 13827.585172444842, 14469.782953255499, 14700.77948830747, 13937.930310348384, 14180.078294910798, 14209.0, 14326.140431574138, 15065.815456758928, 13574.79637805414, 13674.726505470035, 13758.380872860545, 14172.645683857985, 14377.640558985691, 9641.710748677551, 9716.659916902874, 9892.752681183028, 9942.751431214278, 10338.638147664795, 10697.946510267398, 10898.673039808818, 11322.094232461548, 11459.598914037968, 11620.128490363088], "value": 7248.109398998743, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 110.0, 111.0, 110.0, 110.0, 110.0, 114.0, 114.0, 115.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 127.0, 133.0, 173.0, 124.0, 125.0, 125.0, 123.0, 144.0, 125.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 163.0, 164.0, 166.0, 169.0, 168.0, 163.0, 162.0, 168.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 104.0, 75.0, 75.0, 73.0, 74.0, 91.0, 73.0], "value": 78.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 118.0, 83.0, 83.0, 85.0, 96.0, 83.0, 83.0, 115.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 114.0, 114.0, 113.0, 115.0, 114.0, 115.0, 114.0, 113.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 154.0, 150.0, 151.0, 149.0, 151.0, 149.0, 150.0, 151.0, 149.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 99.0, 99.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 57.0, 56.0, 57.0, 57.0, 58.0, 56.0, 56.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 66.0, 57.0, 56.0, 57.0, 56.0, 56.0, 57.0, 56.0, 56.0], "value": 57.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 88.0, 85.0, 86.0, 86.0, 87.0, 89.0, 122.0, 88.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 145.0, 141.0, 137.0, 132.0, 137.0, 134.0, 133.0, 133.0, 139.0], "value": 137.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 198.0, 189.0, 199.0, 187.0, 203.0, 204.0, 193.0, 212.0, 187.0], "value": 196.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 81.0, 75.0, 74.0, 74.0, 75.0, 74.0, 74.0, 73.0], "value": 74.9, "unit": "score"}]}]} 19:39:58 INFO - Return code: 0 19:39:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:39:58 INFO - # TBPL SUCCESS # 19:39:58 INFO - Running post-action listener: _resource_record_post_action 19:39:58 INFO - [mozharness: 2017-05-26 02:39:58.134005Z] Finished run-tests step (success) 19:39:58 INFO - Running post-run listener: _resource_record_post_run 19:39:58 INFO - Total resource usage - Wall time: 1258s; CPU: 13.0%; Read bytes: 8450048; Write bytes: 421462016; Read time: 1772; Write time: 271236 19:39:58 INFO - TinderboxPrint: CPU usage
12.7% 19:39:58 INFO - TinderboxPrint: I/O read bytes / time
8,450,048 / 1,772 19:39:58 INFO - TinderboxPrint: I/O write bytes / time
421,462,016 / 271,236 19:39:58 INFO - TinderboxPrint: CPU idle
8,766.2 (87.3%) 19:39:58 INFO - TinderboxPrint: CPU user
1,217.9 (12.1%) 19:39:58 INFO - TinderboxPrint: Swap in / out
0 / 0 19:39:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 104919040; Read time: 108; Write time: 79536 19:39:58 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 6238208; Write bytes: 288391168; Read time: 1512; Write time: 185380 19:39:58 INFO - Running post-run listener: _upload_blobber_files 19:39:58 INFO - Blob upload gear active. 19:39:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:39:58 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:39:58 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:39:58 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:39:59 INFO - (blobuploader) - INFO - Open directory for files ... 19:39:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:39:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:39:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:40:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:40:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:40:00 INFO - (blobuploader) - INFO - Done attempting. 19:40:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:40:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:40:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:40:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:40:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:40:07 INFO - (blobuploader) - INFO - Done attempting. 19:40:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:40:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:40:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:40:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:40:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:40:07 INFO - (blobuploader) - INFO - Done attempting. 19:40:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:40:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:40:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:40:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:40:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:40:08 INFO - (blobuploader) - INFO - Done attempting. 19:40:08 INFO - (blobuploader) - INFO - Iteration through files over. 19:40:08 INFO - Return code: 0 19:40:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:40:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:40:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f04e0c22735eb88a1a642933fe4f71d3b738126f8b0bb9688c0f27e78f5f8b30677aede305a61b262dc0ce8ca3c0ebd1c5b0cc186763dd8135dddca3c02c230f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1505dd972839835c96dfaaaa712e13d8eb27edef75d38a232a9fc56b4e6966753242f8c9512830771e1d7af3629170f947a7849fbffc4a6567bf0de9464638fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6468572b6a708cd4c0e89cf4e4af1abc3c2c87d99437fed96c25b06a6cfe71c2434a07b4ce353c90f3095a34a157742464f44589ae79883889b390e79414877e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86add31b0afba1560b8df98868d53a1c66595129b6ca61aaf584fcd748e6e42bda20c802f04e3b36fb9243fb4cfcbf06aad3f9b6f2c54b7f6c739ec97ce3f064"} 19:40:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:40:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:40:08 INFO - Contents: 19:40:08 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f04e0c22735eb88a1a642933fe4f71d3b738126f8b0bb9688c0f27e78f5f8b30677aede305a61b262dc0ce8ca3c0ebd1c5b0cc186763dd8135dddca3c02c230f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1505dd972839835c96dfaaaa712e13d8eb27edef75d38a232a9fc56b4e6966753242f8c9512830771e1d7af3629170f947a7849fbffc4a6567bf0de9464638fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6468572b6a708cd4c0e89cf4e4af1abc3c2c87d99437fed96c25b06a6cfe71c2434a07b4ce353c90f3095a34a157742464f44589ae79883889b390e79414877e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86add31b0afba1560b8df98868d53a1c66595129b6ca61aaf584fcd748e6e42bda20c802f04e3b36fb9243fb4cfcbf06aad3f9b6f2c54b7f6c739ec97ce3f064"} 19:40:08 INFO - Running post-run listener: copy_logs_to_upload_dir 19:40:08 INFO - Copying logs to upload dir... 19:40:08 INFO - mkdir: /builds/slave/test/build/upload/logs 19:40:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1322.017532 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2017-05-25 19:40:08.571561) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 19:40:08.574569) ========= 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=9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690 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/f04e0c22735eb88a1a642933fe4f71d3b738126f8b0bb9688c0f27e78f5f8b30677aede305a61b262dc0ce8ca3c0ebd1c5b0cc186763dd8135dddca3c02c230f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1505dd972839835c96dfaaaa712e13d8eb27edef75d38a232a9fc56b4e6966753242f8c9512830771e1d7af3629170f947a7849fbffc4a6567bf0de9464638fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6468572b6a708cd4c0e89cf4e4af1abc3c2c87d99437fed96c25b06a6cfe71c2434a07b4ce353c90f3095a34a157742464f44589ae79883889b390e79414877e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86add31b0afba1560b8df98868d53a1c66595129b6ca61aaf584fcd748e6e42bda20c802f04e3b36fb9243fb4cfcbf06aad3f9b6f2c54b7f6c739ec97ce3f064"} build_url:https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011076 build_url: 'https://queue.taskcluster.net/v1/task/I0FVOlGETem6W1BfHVNkVg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f04e0c22735eb88a1a642933fe4f71d3b738126f8b0bb9688c0f27e78f5f8b30677aede305a61b262dc0ce8ca3c0ebd1c5b0cc186763dd8135dddca3c02c230f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1505dd972839835c96dfaaaa712e13d8eb27edef75d38a232a9fc56b4e6966753242f8c9512830771e1d7af3629170f947a7849fbffc4a6567bf0de9464638fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6468572b6a708cd4c0e89cf4e4af1abc3c2c87d99437fed96c25b06a6cfe71c2434a07b4ce353c90f3095a34a157742464f44589ae79883889b390e79414877e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86add31b0afba1560b8df98868d53a1c66595129b6ca61aaf584fcd748e6e42bda20c802f04e3b36fb9243fb4cfcbf06aad3f9b6f2c54b7f6c739ec97ce3f064"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 19:40:08.598148) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:40:08.601496) ========= 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=9bfb7e13875ed353a705960e000001c0-1495765083.458677-1291806690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 19:40:08.684235) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 19:40:08.684547) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 19:40:08.684832) ========= ========= Total master_lag: 0.17 =========