builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-049 starttime: 1495882308.73 results: success (0) revision: ebad93e117700d8e2d65573b824beb18a8cc2030 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 03:51:48.729484) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 03:51:48.729877) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 03:51:48.730148) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 03:51:48.750649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 03:51:48.750934) ========= 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=db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-27 03:51:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.9M=0s 2017-05-27 03:51:50 (41.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144859 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 03:51:48.908381) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 03:51:48.908649) ========= 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=db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018446 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 03:51:48.961224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 03:51:48.961516) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ebad93e117700d8e2d65573b824beb18a8cc2030 --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 ebad93e117700d8e2d65573b824beb18a8cc2030 --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=db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-27 03:51:50,807 truncating revision to first 12 chars 2017-05-27 03:51:50,807 Setting DEBUG logging. 2017-05-27 03:51:50,807 attempt 1/10 2017-05-27 03:51:50,807 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ebad93e11770?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-27 03:51:51,322 unpacking tar archive at: mozilla-central-ebad93e11770/testing/mozharness/ program finished with exit code 0 elapsedTime=0.846039 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 03:51:49.822545) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 03:51:49.825870) ========= script_repo_revision: ebad93e117700d8e2d65573b824beb18a8cc2030 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 03:51:49.826257) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 03:51:49.826524) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 03:51:49.836000) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 49 secs) (at 2017-05-27 03:51:49.836259) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:51:51 INFO - MultiFileLogger online at 20170527 03:51:51 in /builds/slave/test 03:51:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:51:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:51:51 INFO - {'append_to_log': False, 03:51:51 INFO - 'base_work_dir': '/builds/slave/test', 03:51:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:51:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:51:51 INFO - 'branch': 'Firefox-Non-PGO', 03:51:51 INFO - 'buildbot_json_path': 'buildprops.json', 03:51:51 INFO - 'config_files': ('talos/linux_config.py',), 03:51:51 INFO - 'default_actions': ('clobber', 03:51:51 INFO - 'read-buildbot-config', 03:51:51 INFO - 'download-and-extract', 03:51:51 INFO - 'populate-webroot', 03:51:51 INFO - 'create-virtualenv', 03:51:51 INFO - 'install', 03:51:51 INFO - 'run-tests'), 03:51:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:51:51 INFO - 'download_minidump_stackwalk': True, 03:51:51 INFO - 'download_symbols': 'ondemand', 03:51:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:51:51 INFO - 'tooltool.py': '/tools/tooltool.py', 03:51:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:51:51 INFO - '/tools/misc-python/virtualenv.py')}, 03:51:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:51:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:51:51 INFO - 'gecko_profile': False, 03:51:51 INFO - 'gecko_profile_interval': 0, 03:51:51 INFO - 'installer_path': 'installer.exe', 03:51:51 INFO - 'log_level': 'info', 03:51:51 INFO - 'log_name': 'talos', 03:51:51 INFO - 'log_to_console': True, 03:51:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:51:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:51:51 INFO - 'opt_config_files': (), 03:51:51 INFO - 'pip_index': False, 03:51:51 INFO - 'suite': 'dromaeojs-e10s', 03:51:51 INFO - 'system_bits': '32', 03:51:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:51:51 INFO - 'title': 'talos-linux64-ix-049', 03:51:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:51:51 INFO - 'use_talos_json': True, 03:51:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:51:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:51:51 INFO - 'work_dir': 'build'} 03:51:51 INFO - [mozharness: 2017-05-27 10:51:51.781952Z] Running clobber step. 03:51:51 INFO - Running pre-action listener: _resource_record_pre_action 03:51:51 INFO - Running main action method: clobber 03:51:51 INFO - rmtree: /builds/slave/test/build 03:51:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:51:52 INFO - Running post-action listener: _resource_record_post_action 03:51:52 INFO - [mozharness: 2017-05-27 10:51:52.803128Z] Finished clobber step (success) 03:51:52 INFO - [mozharness: 2017-05-27 10:51:52.803227Z] Running read-buildbot-config step. 03:51:52 INFO - Running pre-action listener: _resource_record_pre_action 03:51:52 INFO - Running main action method: read_buildbot_config 03:51:52 INFO - Using buildbot properties: 03:51:52 INFO - { 03:51:52 INFO - "project": "", 03:51:52 INFO - "product": "firefox", 03:51:52 INFO - "who": "nobody@mozilla.org", 03:51:52 INFO - "installer_path": "public/build/target.tar.bz2", 03:51:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:51:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:51:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:51:52 INFO - "stage_platform": "linux64", 03:51:52 INFO - "basedir": "/builds/slave/test", 03:51:52 INFO - "buildnumber": 858, 03:51:52 INFO - "platform": "ubuntu64_hw", 03:51:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:51:52 INFO - "slavebuilddir": "test", 03:51:52 INFO - "taskId": "Q6CiF4rwSsm_gXvdaRJjQw", 03:51:52 INFO - "branch": "mozilla-central", 03:51:52 INFO - "script_repo_revision": "production", 03:51:52 INFO - "revision": "ebad93e117700d8e2d65573b824beb18a8cc2030", 03:51:52 INFO - "slavename": "talos-linux64-ix-049", 03:51:52 INFO - "repo_path": "mozilla-central" 03:51:52 INFO - } 03:51:52 INFO - Finding installer, test and symbols from parent task. 03:51:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q6CiF4rwSsm_gXvdaRJjQw'}, attempt #1 03:51:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q6CiF4rwSsm_gXvdaRJjQw'}, attempt #1 03:51:53 INFO - Task dependencies: FJoS62EEQEWW5osLeSA_bQ 03:51:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ'}, attempt #1 03:51:54 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.tar.bz2 03:51:54 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/test_packages.json 03:51:54 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.crashreporter-symbols.zip 03:51:54 INFO - Running post-action listener: _resource_record_post_action 03:51:54 INFO - [mozharness: 2017-05-27 10:51:54.172305Z] Finished read-buildbot-config step (success) 03:51:54 INFO - [mozharness: 2017-05-27 10:51:54.172524Z] Running download-and-extract step. 03:51:54 INFO - Running pre-action listener: _resource_record_pre_action 03:51:54 INFO - Running main action method: download_and_extract 03:51:54 INFO - mkdir: /builds/slave/test/build/tests 03:51: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')]} 03:51:54 INFO - trying https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.test_packages.json 03:51:54 INFO - Downloading https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:51:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:51:54 INFO - Downloaded 986 bytes. 03:51:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:51:54 INFO - Using the following test package requirements: 03:51:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:51:54 INFO - u'common': [u'target.common.tests.zip'], 03:51:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:51:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:51:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:51:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:51:54 INFO - u'mozbase': [u'target.common.tests.zip'], 03:51:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:51:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:51:54 INFO - u'web-platform': [u'target.common.tests.zip', 03:51:54 INFO - u'target.web-platform.tests.zip'], 03:51:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:51:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:51:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.common.tests.zip 03:51:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:51:54 INFO - Fetch https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.common.tests.zip into memory 03:51:56 INFO - Content-Length response header: 65712462 03:51:56 INFO - Bytes received: 65712462 03:52:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:52:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.common.tests.zip 03:52:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:52:07 INFO - Fetch https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.common.tests.zip into memory 03:52:08 INFO - Content-Length response header: 65712462 03:52:08 INFO - Bytes received: 65712462 03:52:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.talos.tests.zip 03:52:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:52:20 INFO - Fetch https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.talos.tests.zip into memory 03:52:21 INFO - Content-Length response header: 14441221 03:52:21 INFO - Bytes received: 14441221 03:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:22 INFO - trying https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.tar.bz2 03:52:22 INFO - Downloading https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:52:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:52:23 INFO - Downloaded 59522121 bytes. 03:52:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.tar.bz2 03:52:23 INFO - mkdir: /builds/slave/test/properties 03:52:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:52:23 INFO - Writing to file /builds/slave/test/properties/build_url 03:52:23 INFO - Contents: 03:52:23 INFO - build_url:https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.tar.bz2 03:52:23 INFO - Running post-action listener: _resource_record_post_action 03:52:23 INFO - Running post-action listener: set_extra_try_arguments 03:52:23 INFO - [mozharness: 2017-05-27 10:52:23.582378Z] Finished download-and-extract step (success) 03:52:23 INFO - [mozharness: 2017-05-27 10:52:23.582507Z] Running populate-webroot step. 03:52:23 INFO - Running pre-action listener: _resource_record_pre_action 03:52:23 INFO - Running main action method: populate_webroot 03:52:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:52:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:52:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:52:23 INFO - '--tppagecycles', 03:52:23 INFO - '7'], 03:52:23 INFO - 'tests': ['tsvgm']}}, 03:52:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:52:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:52:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:52:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:52:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:52:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:52:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:52:23 INFO - 'talos_options': ['--disable-e10s'], 03:52:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:52:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:52:23 INFO - 'talos_options': ['--disable-e10s'], 03:52:23 INFO - 'tests': ['damp', 'tps']}, 03:52:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:52:23 INFO - 'tests': ['damp', 'tps']}, 03:52:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:52:23 INFO - 'tests': ['dromaeo_dom']}, 03:52:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:52:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:52:23 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:52:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:52:23 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:52:23 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:52:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:52:23 INFO - 'tests': ['a11yr', 03:52:23 INFO - 'ts_paint', 03:52:23 INFO - 'tpaint', 03:52:23 INFO - 'sessionrestore', 03:52:23 INFO - 'sessionrestore_no_auto_restore', 03:52:23 INFO - 'tabpaint']}, 03:52:23 INFO - 'other-e10s': {'tests': ['a11yr', 03:52:23 INFO - 'ts_paint', 03:52:23 INFO - 'tpaint', 03:52:23 INFO - 'sessionrestore', 03:52:23 INFO - 'sessionrestore_no_auto_restore', 03:52:23 INFO - 'tabpaint']}, 03:52:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:52:23 INFO - 'ts_paint', 03:52:23 INFO - 'tpaint', 03:52:23 INFO - 'sessionrestore', 03:52:23 INFO - 'sessionrestore_no_auto_restore', 03:52:23 INFO - 'tabpaint']}, 03:52:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:52:23 INFO - 'ts_paint', 03:52:23 INFO - 'tpaint', 03:52:23 INFO - 'sessionrestore', 03:52:23 INFO - 'sessionrestore_no_auto_restore', 03:52:23 INFO - 'tabpaint']}, 03:52:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:52:23 INFO - 'tests': ['a11yr', 03:52:23 INFO - 'ts_paint', 03:52:23 INFO - 'tpaint', 03:52:23 INFO - 'sessionrestore', 03:52:23 INFO - 'sessionrestore_no_auto_restore', 03:52:23 INFO - 'tabpaint']}, 03:52:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:52:23 INFO - 'tests': ['a11yr', 03:52:23 INFO - 'ts_paint', 03:52:23 INFO - 'tpaint', 03:52:23 INFO - 'sessionrestore', 03:52:23 INFO - 'sessionrestore_no_auto_restore', 03:52:23 INFO - 'tabpaint']}, 03:52:23 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:52:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:52:23 INFO - 'bloom_basic_ref']}, 03:52:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:52:23 INFO - 'tests': ['tsvgx', 03:52:23 INFO - 'tsvgr_opacity', 03:52:23 INFO - 'tart', 03:52:23 INFO - 'tscrollx', 03:52:23 INFO - 'cart', 03:52:23 INFO - 'tsvg_static']}, 03:52:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:52:23 INFO - 'tsvgr_opacity', 03:52:23 INFO - 'tart', 03:52:23 INFO - 'tscrollx', 03:52:23 INFO - 'cart', 03:52:23 INFO - 'tsvg_static']}, 03:52:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:52:23 INFO - 'talos_options': ['--disable-e10s'], 03:52:23 INFO - 'tests': ['tp5o']}, 03:52:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:52:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:52:23 INFO - 'talos_options': ['--disable-e10s', 03:52:23 INFO - '--xperf_path', 03:52:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:23 INFO - 'tests': ['tp5n']}, 03:52:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:52:23 INFO - 'talos_options': ['--xperf_path', 03:52:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:23 INFO - 'tests': ['tp5n']}}, 03:52:23 INFO - 'talos.zip': {'path': '', 03:52:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:52:23 INFO - Running post-action listener: _resource_record_post_action 03:52:23 INFO - [mozharness: 2017-05-27 10:52:23.598554Z] Finished populate-webroot step (success) 03:52:23 INFO - [mozharness: 2017-05-27 10:52:23.598643Z] Running create-virtualenv step. 03:52:23 INFO - Running pre-action listener: _resource_record_pre_action 03:52:23 INFO - Running main action method: create_virtualenv 03:52:23 INFO - Creating virtualenv /builds/slave/test/build/venv 03:52:23 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 03:52:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:52:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:52:23 INFO - Using real prefix '/usr' 03:52:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:52:24 INFO - Installing distribute.............................................................................................................................................................................................done. 03:52:26 INFO - Installing pip.................done. 03:52:26 INFO - Return code: 0 03:52:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:52:26 INFO - Reading from file tmpfile_stdout 03:52:26 INFO - Output received: 03:52:26 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) 03:52:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:26 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 0x10e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14575c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14547a0>, '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 0x14556a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1455b30>, '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': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', '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 03:52:26 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 03:52:26 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 03:52:26 INFO - Using env: {'DISPLAY': ':0', 03:52:26 INFO - 'HOME': '/home/cltbld', 03:52:26 INFO - 'LANG': 'en_US.UTF-8', 03:52:26 INFO - 'LANGUAGE': 'en_US:en', 03:52:26 INFO - 'LOGNAME': 'cltbld', 03:52:26 INFO - 'MAIL': '/var/mail/cltbld', 03:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:26 INFO - 'MOZ_NO_REMOTE': '1', 03:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:26 INFO - 'NO_EM_RESTART': '1', 03:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:26 INFO - 'PWD': '/builds/slave/test', 03:52:26 INFO - 'SHELL': '/bin/bash', 03:52:26 INFO - 'SHLVL': '1', 03:52:26 INFO - 'TERM': 'linux', 03:52:26 INFO - 'TMOUT': '86400', 03:52:26 INFO - 'USER': 'cltbld', 03:52:26 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', 03:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:26 INFO - '_': '/tools/buildbot/bin/python'} 03:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:26 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 03:52:26 INFO - Cleaning up... 03:52:26 INFO - Return code: 0 03:52:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:26 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 0x10e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14575c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14547a0>, '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 0x14556a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1455b30>, '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': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', '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 03:52:26 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 03:52:26 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 03:52:26 INFO - Using env: {'DISPLAY': ':0', 03:52:26 INFO - 'HOME': '/home/cltbld', 03:52:26 INFO - 'LANG': 'en_US.UTF-8', 03:52:26 INFO - 'LANGUAGE': 'en_US:en', 03:52:26 INFO - 'LOGNAME': 'cltbld', 03:52:26 INFO - 'MAIL': '/var/mail/cltbld', 03:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:26 INFO - 'MOZ_NO_REMOTE': '1', 03:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:26 INFO - 'NO_EM_RESTART': '1', 03:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:26 INFO - 'PWD': '/builds/slave/test', 03:52:26 INFO - 'SHELL': '/bin/bash', 03:52:26 INFO - 'SHLVL': '1', 03:52:26 INFO - 'TERM': 'linux', 03:52:26 INFO - 'TMOUT': '86400', 03:52:26 INFO - 'USER': 'cltbld', 03:52:26 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', 03:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:26 INFO - '_': '/tools/buildbot/bin/python'} 03:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:26 INFO - Downloading/unpacking psutil>=3.1.1 03:52:26 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 03:52:26 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 03:52:26 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 03:52:26 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 03:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:52:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:28 INFO - Installing collected packages: psutil 03:52:28 INFO - Running setup.py install for psutil 03:52:28 INFO - building 'psutil._psutil_linux' extension 03:52:28 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 03:52:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:52:28 INFO - building 'psutil._psutil_posix' extension 03:52:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:52:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:52:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:28 INFO - Successfully installed psutil 03:52:28 INFO - Cleaning up... 03:52:28 INFO - Return code: 0 03:52:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14575c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14547a0>, '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 0x14556a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1455b30>, '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': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', '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 03:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:52:28 INFO - Using env: {'DISPLAY': ':0', 03:52:28 INFO - 'HOME': '/home/cltbld', 03:52:28 INFO - 'LANG': 'en_US.UTF-8', 03:52:28 INFO - 'LANGUAGE': 'en_US:en', 03:52:28 INFO - 'LOGNAME': 'cltbld', 03:52:28 INFO - 'MAIL': '/var/mail/cltbld', 03:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:28 INFO - 'MOZ_NO_REMOTE': '1', 03:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:28 INFO - 'NO_EM_RESTART': '1', 03:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:28 INFO - 'PWD': '/builds/slave/test', 03:52:28 INFO - 'SHELL': '/bin/bash', 03:52:28 INFO - 'SHLVL': '1', 03:52:28 INFO - 'TERM': 'linux', 03:52:28 INFO - 'TMOUT': '86400', 03:52:28 INFO - 'USER': 'cltbld', 03:52:28 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', 03:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:28 INFO - '_': '/tools/buildbot/bin/python'} 03:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:52:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:52:29 INFO - Installing collected packages: mozsystemmonitor 03:52:29 INFO - Running setup.py install for mozsystemmonitor 03:52:29 INFO - Successfully installed mozsystemmonitor 03:52:29 INFO - Cleaning up... 03:52:30 INFO - Return code: 0 03:52:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14575c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14547a0>, '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 0x14556a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1455b30>, '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': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', '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 03:52:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:52:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:52:30 INFO - Using env: {'DISPLAY': ':0', 03:52:30 INFO - 'HOME': '/home/cltbld', 03:52:30 INFO - 'LANG': 'en_US.UTF-8', 03:52:30 INFO - 'LANGUAGE': 'en_US:en', 03:52:30 INFO - 'LOGNAME': 'cltbld', 03:52:30 INFO - 'MAIL': '/var/mail/cltbld', 03:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:30 INFO - 'MOZ_NO_REMOTE': '1', 03:52:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:30 INFO - 'NO_EM_RESTART': '1', 03:52:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:30 INFO - 'PWD': '/builds/slave/test', 03:52:30 INFO - 'SHELL': '/bin/bash', 03:52:30 INFO - 'SHLVL': '1', 03:52:30 INFO - 'TERM': 'linux', 03:52:30 INFO - 'TMOUT': '86400', 03:52:30 INFO - 'USER': 'cltbld', 03:52:30 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', 03:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:30 INFO - '_': '/tools/buildbot/bin/python'} 03:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:30 INFO - Downloading/unpacking jsonschema==2.5.1 03:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:52:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:31 INFO - Downloading functools32-3.2.3-2.tar.gz 03:52:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:52:31 INFO - warning: no files found matching '*.txt' 03:52:31 INFO - no previously-included directories found matching 'build' 03:52:31 INFO - no previously-included directories found matching 'dist' 03:52:31 INFO - no previously-included directories found matching '.git*' 03:52:31 INFO - Installing collected packages: jsonschema, functools32 03:52:31 INFO - Running setup.py install for functools32 03:52:31 INFO - warning: no files found matching '*.txt' 03:52:31 INFO - no previously-included directories found matching 'build' 03:52:31 INFO - no previously-included directories found matching 'dist' 03:52:31 INFO - no previously-included directories found matching '.git*' 03:52:31 INFO - Successfully installed jsonschema functools32 03:52:31 INFO - Cleaning up... 03:52:31 INFO - Return code: 0 03:52:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14575c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14547a0>, '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 0x14556a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1455b30>, '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': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', '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 03:52:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:52:31 INFO - Using env: {'DISPLAY': ':0', 03:52:31 INFO - 'HOME': '/home/cltbld', 03:52:31 INFO - 'LANG': 'en_US.UTF-8', 03:52:31 INFO - 'LANGUAGE': 'en_US:en', 03:52:31 INFO - 'LOGNAME': 'cltbld', 03:52:31 INFO - 'MAIL': '/var/mail/cltbld', 03:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:31 INFO - 'MOZ_NO_REMOTE': '1', 03:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:31 INFO - 'NO_EM_RESTART': '1', 03:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:31 INFO - 'PWD': '/builds/slave/test', 03:52:31 INFO - 'SHELL': '/bin/bash', 03:52:31 INFO - 'SHLVL': '1', 03:52:31 INFO - 'TERM': 'linux', 03:52:31 INFO - 'TMOUT': '86400', 03:52:31 INFO - 'USER': 'cltbld', 03:52:31 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', 03:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:31 INFO - '_': '/tools/buildbot/bin/python'} 03:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:52:31 INFO - Cleaning up... 03:52:31 INFO - Return code: 0 03:52:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14575c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14547a0>, '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 0x14556a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1455b30>, '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': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', '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 03:52:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:52:31 INFO - Using env: {'DISPLAY': ':0', 03:52:31 INFO - 'HOME': '/home/cltbld', 03:52:31 INFO - 'LANG': 'en_US.UTF-8', 03:52:31 INFO - 'LANGUAGE': 'en_US:en', 03:52:31 INFO - 'LOGNAME': 'cltbld', 03:52:31 INFO - 'MAIL': '/var/mail/cltbld', 03:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:31 INFO - 'MOZ_NO_REMOTE': '1', 03:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:31 INFO - 'NO_EM_RESTART': '1', 03:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:31 INFO - 'PWD': '/builds/slave/test', 03:52:31 INFO - 'SHELL': '/bin/bash', 03:52:31 INFO - 'SHLVL': '1', 03:52:31 INFO - 'TERM': 'linux', 03:52:31 INFO - 'TMOUT': '86400', 03:52:31 INFO - 'USER': 'cltbld', 03:52:31 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', 03:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:31 INFO - '_': '/tools/buildbot/bin/python'} 03:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:32 INFO - Downloading/unpacking blobuploader==1.2.4 03:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:33 INFO - Downloading blobuploader-1.2.4.tar.gz 03:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:52:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:52:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:33 INFO - Downloading docopt-0.6.1.tar.gz 03:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:52:33 INFO - Installing collected packages: blobuploader, requests, docopt 03:52:33 INFO - Running setup.py install for blobuploader 03:52:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:52:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:52:33 INFO - Running setup.py install for requests 03:52:34 INFO - Running setup.py install for docopt 03:52:34 INFO - Successfully installed blobuploader requests docopt 03:52:34 INFO - Cleaning up... 03:52:34 INFO - Return code: 0 03:52:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14575c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14547a0>, '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 0x14556a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1455b30>, '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': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', '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 03:52:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:52:34 INFO - Using env: {'DISPLAY': ':0', 03:52:34 INFO - 'HOME': '/home/cltbld', 03:52:34 INFO - 'LANG': 'en_US.UTF-8', 03:52:34 INFO - 'LANGUAGE': 'en_US:en', 03:52:34 INFO - 'LOGNAME': 'cltbld', 03:52:34 INFO - 'MAIL': '/var/mail/cltbld', 03:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:34 INFO - 'MOZ_NO_REMOTE': '1', 03:52:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:34 INFO - 'NO_EM_RESTART': '1', 03:52:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:34 INFO - 'PWD': '/builds/slave/test', 03:52:34 INFO - 'SHELL': '/bin/bash', 03:52:34 INFO - 'SHLVL': '1', 03:52:34 INFO - 'TERM': 'linux', 03:52:34 INFO - 'TMOUT': '86400', 03:52:34 INFO - 'USER': 'cltbld', 03:52:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', 03:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:34 INFO - '_': '/tools/buildbot/bin/python'} 03:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:34 INFO - Running setup.py (path:/tmp/pip-E87WZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:34 INFO - Running setup.py (path:/tmp/pip-WdnuOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:34 INFO - Running setup.py (path:/tmp/pip-5wMIKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:34 INFO - Running setup.py (path:/tmp/pip-XzbvFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:34 INFO - Running setup.py (path:/tmp/pip-wGmo6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:35 INFO - Running setup.py (path:/tmp/pip-eK3W_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:35 INFO - Running setup.py (path:/tmp/pip-w5nQNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:35 INFO - Running setup.py (path:/tmp/pip-Ukyu54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:35 INFO - Running setup.py (path:/tmp/pip-HnPJHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:35 INFO - Running setup.py (path:/tmp/pip-6QZig5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:35 INFO - Running setup.py (path:/tmp/pip-W2WxOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:35 INFO - Running setup.py (path:/tmp/pip-g3wzTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:35 INFO - Running setup.py (path:/tmp/pip-p6R1aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:35 INFO - Running setup.py (path:/tmp/pip-iKszRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:35 INFO - Running setup.py (path:/tmp/pip-Pi3jrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:35 INFO - Running setup.py (path:/tmp/pip-6Me3cR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:35 INFO - Running setup.py (path:/tmp/pip-MepgWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:52:35 INFO - Running setup.py install for manifestparser 03:52:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:52:35 INFO - Running setup.py install for mozcrash 03:52:36 INFO - Running setup.py install for mozdebug 03:52:36 INFO - Running setup.py install for mozdevice 03:52:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:52:36 INFO - Running setup.py install for mozfile 03:52:36 INFO - Running setup.py install for mozhttpd 03:52:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:52:36 INFO - Running setup.py install for mozinfo 03:52:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:52:36 INFO - Running setup.py install for mozInstall 03:52:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:52:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:52:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:52:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:52:36 INFO - Running setup.py install for mozleak 03:52:36 INFO - Running setup.py install for mozlog 03:52:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:52:36 INFO - Running setup.py install for moznetwork 03:52:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:52:36 INFO - Running setup.py install for mozprocess 03:52:37 INFO - Running setup.py install for mozprofile 03:52:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:52:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:52:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:52:37 INFO - Running setup.py install for mozrunner 03:52:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:52:37 INFO - Running setup.py install for mozscreenshot 03:52:37 INFO - Running setup.py install for moztest 03:52:37 INFO - Running setup.py install for mozversion 03:52:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:52:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:52:37 INFO - Cleaning up... 03:52:37 INFO - Return code: 0 03:52:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14575c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14547a0>, '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 0x14556a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1455b30>, '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': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', '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 03:52:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:52:37 INFO - Using env: {'DISPLAY': ':0', 03:52:37 INFO - 'HOME': '/home/cltbld', 03:52:37 INFO - 'LANG': 'en_US.UTF-8', 03:52:37 INFO - 'LANGUAGE': 'en_US:en', 03:52:37 INFO - 'LOGNAME': 'cltbld', 03:52:37 INFO - 'MAIL': '/var/mail/cltbld', 03:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:37 INFO - 'MOZ_NO_REMOTE': '1', 03:52:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:37 INFO - 'NO_EM_RESTART': '1', 03:52:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:37 INFO - 'PWD': '/builds/slave/test', 03:52:37 INFO - 'SHELL': '/bin/bash', 03:52:37 INFO - 'SHLVL': '1', 03:52:37 INFO - 'TERM': 'linux', 03:52:37 INFO - 'TMOUT': '86400', 03:52:37 INFO - 'USER': 'cltbld', 03:52:37 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', 03:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:37 INFO - '_': '/tools/buildbot/bin/python'} 03:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:37 INFO - Running setup.py (path:/tmp/pip-WvAsGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:37 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)) 03:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:37 INFO - Running setup.py (path:/tmp/pip-PxYzN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:38 INFO - Running setup.py (path:/tmp/pip-dhyYh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:38 INFO - Running setup.py (path:/tmp/pip-R0IKeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:38 INFO - Running setup.py (path:/tmp/pip-Br7PVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:38 INFO - Running setup.py (path:/tmp/pip-8fwcYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:38 INFO - Running setup.py (path:/tmp/pip-Vg292U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:38 INFO - Running setup.py (path:/tmp/pip-dIkyRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:38 INFO - Running setup.py (path:/tmp/pip-OCsaGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:38 INFO - Running setup.py (path:/tmp/pip-q7gvqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:38 INFO - Running setup.py (path:/tmp/pip-tgjDRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:38 INFO - Running setup.py (path:/tmp/pip-j9UzFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:38 INFO - Running setup.py (path:/tmp/pip-GyFviN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:38 INFO - Running setup.py (path:/tmp/pip-bqWUlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:38 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)) 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:38 INFO - Running setup.py (path:/tmp/pip-zUN4nY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:38 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)) 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:38 INFO - Running setup.py (path:/tmp/pip-iHMocj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:39 INFO - Running setup.py (path:/tmp/pip-SUXGcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:52:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:40 INFO - Downloading blessings-1.6.tar.gz 03:52:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:52:40 INFO - Installing collected packages: blessings 03:52:40 INFO - Running setup.py install for blessings 03:52:40 INFO - Successfully installed blessings 03:52:40 INFO - Cleaning up... 03:52:40 INFO - Return code: 0 03:52:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:52:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:40 INFO - Reading from file tmpfile_stdout 03:52:40 INFO - Current package versions: 03:52:40 INFO - argparse == 1.2.1 03:52:40 INFO - blessings == 1.6 03:52:40 INFO - blobuploader == 1.2.4 03:52:40 INFO - docopt == 0.6.1 03:52:40 INFO - functools32 == 3.2.3-2 03:52:40 INFO - jsonschema == 2.5.1 03:52:40 INFO - manifestparser == 1.1 03:52:40 INFO - mozInstall == 1.12 03:52:40 INFO - mozcrash == 1.0 03:52:40 INFO - mozdebug == 0.1 03:52:40 INFO - mozdevice == 0.51 03:52:40 INFO - mozfile == 1.2 03:52:40 INFO - mozhttpd == 0.7 03:52:40 INFO - mozinfo == 0.9 03:52:40 INFO - mozleak == 0.1 03:52:40 INFO - mozlog == 3.4 03:52:40 INFO - moznetwork == 0.27 03:52:40 INFO - mozprocess == 0.25 03:52:40 INFO - mozprofile == 0.28 03:52:40 INFO - mozrunner == 6.13 03:52:40 INFO - mozscreenshot == 0.1 03:52:40 INFO - mozsystemmonitor == 0.3 03:52:40 INFO - moztest == 0.8 03:52:40 INFO - mozversion == 1.4 03:52:40 INFO - psutil == 3.1.1 03:52:40 INFO - requests == 1.2.3 03:52:40 INFO - wsgiref == 0.1.2 03:52:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14575c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14547a0>, '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 0x14556a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1455b30>, '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': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', '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 03:52:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:52:40 INFO - Using env: {'DISPLAY': ':0', 03:52:40 INFO - 'HOME': '/home/cltbld', 03:52:40 INFO - 'LANG': 'en_US.UTF-8', 03:52:40 INFO - 'LANGUAGE': 'en_US:en', 03:52:40 INFO - 'LOGNAME': 'cltbld', 03:52:40 INFO - 'MAIL': '/var/mail/cltbld', 03:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:40 INFO - 'MOZ_NO_REMOTE': '1', 03:52:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:40 INFO - 'NO_EM_RESTART': '1', 03:52:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:40 INFO - 'PWD': '/builds/slave/test', 03:52:40 INFO - 'SHELL': '/bin/bash', 03:52:40 INFO - 'SHLVL': '1', 03:52:40 INFO - 'TERM': 'linux', 03:52:40 INFO - 'TMOUT': '86400', 03:52:40 INFO - 'USER': 'cltbld', 03:52:40 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', 03:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:40 INFO - '_': '/tools/buildbot/bin/python'} 03:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:40 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)) 03:52:40 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)) 03:52:40 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)) 03:52:40 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)) 03:52:40 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)) 03:52:40 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)) 03:52:40 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)) 03:52:40 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)) 03:52:40 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)) 03:52:40 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:52:40 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 03:52:40 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 03:52:40 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 03:52:40 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 03:52:41 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:52:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:52:41 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)) 03:52:41 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)) 03:52:41 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)) 03:52:41 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)) 03:52:41 INFO - Installing collected packages: marionette-driver 03:52:41 INFO - Running setup.py install for marionette-driver 03:52:42 INFO - Successfully installed marionette-driver 03:52:42 INFO - Cleaning up... 03:52:42 INFO - Return code: 0 03:52:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52: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')]} 03:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14575c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14547a0>, '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 0x14556a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1455b30>, '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': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', '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 03:52:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:52:42 INFO - Using env: {'DISPLAY': ':0', 03:52:42 INFO - 'HOME': '/home/cltbld', 03:52:42 INFO - 'LANG': 'en_US.UTF-8', 03:52:42 INFO - 'LANGUAGE': 'en_US:en', 03:52:42 INFO - 'LOGNAME': 'cltbld', 03:52:42 INFO - 'MAIL': '/var/mail/cltbld', 03:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:42 INFO - 'MOZ_NO_REMOTE': '1', 03:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:42 INFO - 'NO_EM_RESTART': '1', 03:52:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:42 INFO - 'PWD': '/builds/slave/test', 03:52:42 INFO - 'SHELL': '/bin/bash', 03:52:42 INFO - 'SHLVL': '1', 03:52:42 INFO - 'TERM': 'linux', 03:52:42 INFO - 'TMOUT': '86400', 03:52:42 INFO - 'USER': 'cltbld', 03:52:42 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', 03:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:42 INFO - '_': '/tools/buildbot/bin/python'} 03:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:52:42 INFO - Cleaning up... 03:52:42 INFO - Return code: 0 03:52:42 INFO - Running post-action listener: _resource_record_post_action 03:52:42 INFO - Running post-action listener: _start_resource_monitoring 03:52:42 INFO - Starting resource monitoring. 03:52:42 INFO - [mozharness: 2017-05-27 10:52:42.399219Z] Finished create-virtualenv step (success) 03:52:42 INFO - [mozharness: 2017-05-27 10:52:42.399724Z] Running install step. 03:52:42 INFO - Running pre-action listener: _resource_record_pre_action 03:52:42 INFO - Running main action method: install 03:52:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:42 INFO - Reading from file tmpfile_stdout 03:52:42 INFO - Detecting whether we're running mozinstall >=1.0... 03:52:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:52:42 INFO - Reading from file tmpfile_stdout 03:52:42 INFO - Output received: 03:52:42 INFO - Usage: mozinstall [options] installer 03:52:42 INFO - Options: 03:52:42 INFO - -h, --help show this help message and exit 03:52:42 INFO - -d DEST, --destination=DEST 03:52:42 INFO - Directory to install application into. [default: 03:52:42 INFO - "/builds/slave/test"] 03:52:42 INFO - --app=APP Application being installed. [default: firefox] 03:52:42 INFO - mkdir: /builds/slave/test/build/application 03:52:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:52:59 INFO - Reading from file tmpfile_stdout 03:52:59 INFO - Output received: 03:52:59 INFO - /builds/slave/test/build/application/firefox/firefox 03:52:59 INFO - Running post-action listener: _resource_record_post_action 03:52:59 INFO - [mozharness: 2017-05-27 10:52:59.842180Z] Finished install step (success) 03:52:59 INFO - [mozharness: 2017-05-27 10:52:59.842454Z] Running run-tests step. 03:52:59 INFO - Running pre-action listener: _resource_record_pre_action 03:52:59 INFO - Running main action method: run_tests 03:52:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:52:59 INFO - Python 2.7.3 03:52:59 INFO - Return code: 0 03:52:59 INFO - grabbing minidump binary from tooltool 03:52: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')]} 03:52:59 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14547a0>, '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 0x14556a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1455b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:52:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:52:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:52:59 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:52:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:52:59 INFO - Return code: 0 03:52:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:52:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:52:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:52:59 INFO - ENV: RUST_BACKTRACE is now 1 03:52:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:52:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:52:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 03:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 03:52:59 INFO - Using env: {'DISPLAY': ':0', 03:52:59 INFO - 'HOME': '/home/cltbld', 03:52:59 INFO - 'LANG': 'en_US.UTF-8', 03:52:59 INFO - 'LANGUAGE': 'en_US:en', 03:52:59 INFO - 'LOGNAME': 'cltbld', 03:52:59 INFO - 'MAIL': '/var/mail/cltbld', 03:52:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:52:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:59 INFO - 'MOZ_NO_REMOTE': '1', 03:52:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:59 INFO - 'NO_EM_RESTART': '1', 03:52:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:59 INFO - 'PWD': '/builds/slave/test', 03:52:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:52:59 INFO - 'RUST_BACKTRACE': '1', 03:52:59 INFO - 'SHELL': '/bin/bash', 03:52:59 INFO - 'SHLVL': '1', 03:52:59 INFO - 'TERM': 'linux', 03:52:59 INFO - 'TMOUT': '86400', 03:52:59 INFO - 'USER': 'cltbld', 03:52:59 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016', 03:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:59 INFO - '_': '/tools/buildbot/bin/python'} 03:52:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 03:53:00 INFO - mozversion application_buildid: 20170527100132 03:53:00 INFO - mozversion application_changeset: ebad93e117700d8e2d65573b824beb18a8cc2030 03:53:00 INFO - mozversion application_display_name: Nightly 03:53:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:53:00 INFO - mozversion application_name: Firefox 03:53:00 INFO - mozversion application_remotingname: firefox 03:53:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:53:00 INFO - mozversion application_vendor: Mozilla 03:53:00 INFO - mozversion application_version: 55.0a1 03:53:00 INFO - mozversion platform_buildid: 20170527100132 03:53:00 INFO - mozversion platform_changeset: ebad93e117700d8e2d65573b824beb18a8cc2030 03:53:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:53:00 INFO - mozversion platform_version: 55.0a1 03:53:00 INFO - using testdate: 1495882380 03:53:00 INFO - actual date: 1495882380 03:53:00 INFO - starting webserver on 'localhost:49850' 03:53:00 INFO - SUITE-START | Running 2 tests 03:53:00 INFO - TEST-START | dromaeo_css 03:53:00 INFO - operating with platform_type : linux_ 03:53:00 INFO - Initialising browser for dromaeo_css test... 03:53:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49850/getInfo.html -profile /tmp/tmptljwlh/profile 03:53:00 INFO - TEST-INFO | started process 16965 (/builds/slave/test/build/application/firefox/firefox http://localhost:49850/getInfo.html) 03:53:34 INFO - TEST-INFO | 16965: killed by SIGTERM 03:53:35 INFO - Browser initialized. 03:53:35 INFO - Running cycle 1/1 for dromaeo_css test... 03:53:35 INFO - TEST-INFO | started process 17169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptljwlh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:46 INFO - PID 17169 | RSS: Main: 180932608 03:53:46 INFO - PID 17169 | 03:56:47 INFO - PID 17169 | Cycle 1(1): loaded http://localhost:49850/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49850/tests/dromaeo/cssquery-ext.html) 03:56:48 INFO - PID 17169 | RSS: Main: 176693248 03:56:48 INFO - PID 17169 | 03:59:50 INFO - PID 17169 | Cycle 1(1): loaded http://localhost:49850/tests/dromaeo/cssquery-ext.html (next: http://localhost:49850/tests/dromaeo/cssquery-jquery.html) 03:59:50 INFO - PID 17169 | RSS: Main: 183939072 03:59:50 INFO - PID 17169 | 04:02:52 INFO - PID 17169 | Cycle 1(1): loaded http://localhost:49850/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49850/tests/dromaeo/cssquery-mootools.html) 04:02:53 INFO - PID 17169 | RSS: Main: 179396608 04:02:53 INFO - PID 17169 | 04:05:54 INFO - PID 17169 | Cycle 1(1): loaded http://localhost:49850/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49850/tests/dromaeo/cssquery-prototype.html) 04:05:55 INFO - PID 17169 | RSS: Main: 183685120 04:05:55 INFO - PID 17169 | 04:08:57 INFO - PID 17169 | Cycle 1(1): loaded http://localhost:49850/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49850/tests/dromaeo/cssquery-yui.html) 04:08:58 INFO - PID 17169 | RSS: Main: 182685696 04:08:58 INFO - PID 17169 | 04:11:59 INFO - PID 17169 | Cycle 1(1): loaded http://localhost:49850/tests/dromaeo/cssquery-yui.html (next: http://localhost:49850/tests/dromaeo/cssquery-dojo.html) 04:12:00 INFO - PID 17169 | RSS: Main: 181567488 04:12:00 INFO - PID 17169 | 04:12:00 INFO - PID 17169 | __start_tp_report 04:12:00 INFO - PID 17169 | _x_x_mozilla_page_load 04:12:00 INFO - PID 17169 | _x_x_mozilla_page_load_details 04:12:00 INFO - PID 17169 | |i|pagename|runs| 04:12:00 INFO - PID 17169 | |0;dojo.html;3389.406853800585;3391.7456190785683;3418.1283772637976;3419.9829000854993;3423.8116903570326;5821.126830975356;5934.495567876736;5940.554458415614;5945.524358051356;5987.850303742403;5917.171595976567;5955.88088238236;6003.609765365259;6050.727717252723;6099.542534309922;4987.0777666192325;5226.764795584208;5297.576193904488;5320.228566857803;5328.92006619901;5352.384475785276;5413.215083812845;5418.187271909206;5428.538574221196;5437.238786569884;5164.096283150471;5193.324867767204;5231.398389185254;5245.186996015624;5369.006733754268;5281.498257665516;5288.92066619001;5291.28567643367;5291.708956007418;5333.040052790496;5196.32447781786;5227.869303267449;5244.423113457517;5249.343832020997;5272.182811664198;5839.270091238595;5933.465988061095;5958.344582095966;5979.073243647242;5982.491488223506;6423.967880160616;6526.086347911296;6529.967350163266;6543.214814222276;6548.541602087856;6574.901376479356;6622.966885165543;6628.0720699101685;6630.071789949411;6645.60126392418;5897.793577224862;6088.482478989247;6104.633721976696;6119.143319935212;6121.051237058263;6533.869322613521;6632.502562307846;6720.529562930548;6728.158980127484;6740.39336459721;6173.166622505994;6287.937120628735;6291.716872740738;6302.275238347557;6340.302566717657;6512.869742605121;6545.14913061299;6545.345465453512;6556.049372840911;6575.638339891352;6201.751929922752;6502.284748677642;6512.479001679854;6522.412982831473;6523.836904077341;6398.9040164397575;6421.389967953037;6427.742890284429;6477.611343319416;6493.577917435352;4928.753562321869;4941.975290123526;4945;4945.060438516671;4956.975215123901;4382.69321147523;4390.53899340571;4393.253146965024;4414.050979039522;4421.137878113737;5993.940060599425;6038.094285857069;6055.545834062463;6121.296050954108;6132.754689812357;6402.231732192166;6432.292447830735;6434.613923164625;6436.485081193493;6467.741290348334;6015.488683461955;6018.969905150446;6024.277086749618;6043.214382130383;6054.636721796706;5355.518003379714;5380.596455265871;5409.080456322435;5438.347398312228;5458.918116228259;6590.143281373391;6676.365745254193;6698.66506674674;6710.6309152997055;6710.832229194211;6450.870982580416;6491.48068154537;6503.772367967098;6569.507286953402;6612.0743095965645;6575.079488871466;6789.966050169717;6838.555493892881;6850.862982740417;6862.039314495874;6274.058891166179;6340.873182536416;6369.49044076482;6396;6398.90401643985;6579.769708060195;6602.570832895846;6607.768728094494;6608.008798680236;6609.339066093545;6149.954507733606;6200.534959877937;6258.4680302173;6367.808965731036;6388.68056597159;6365;6395.936040639534;6400.199975003125;6400.487960963019;6402.391772781578;6151.477124444294;6212.937870621236;6223;6230.096635987666;6292;6302.797915043904;6427.357264273535;6429.4534964526665;6432.453241474527;6433.8713225736155;6165.568410211422;6195.96902015487;6210;6224.782132625336;6233.376662333912 04:12:00 INFO - PID 17169 | |1;ext.html;744.8659241336558;810.5177419435436;828.8881001064856;1150.8101163308054;1159.9942000289998;36024;36717.26565468689;36888;37008.62991370089;37031.25937481252;39408.80295598525;39518.20963580727;39560.604393956055;39725.20549589006;39865.20269594606;7135.25079866613;7179.317964793337;7269.636518174097;7350.338469537741;7354.6322683865865;7045.823854403629;7063.328983746535;7085;7108.147022357324;7116.85766284674;7084.57492550446;7092.6808293626655;7140;7174.139103307611;7186.676599553007;7059.082319298484;7071.7878463646175;7118.822029449253;7148.356647901714;7154.534955227893;7279.053723015974;7309.269073092702;7313.158986716542;7323;7323.377512911409;37544.62455375439;37643.058923526856;37707.434388484195;37758.81120594407;37815;3508.7193024557973;3522.788632682047;3528.752987290891;3541.3448512025357;3543.255916257589;28791;28883.42233155325;28899.422011559862;28903.42193156146;28938.565921511195;3329.051220402174;3332.683395077464;3355.0102719697747;3359.8320083995945;3369.7641165118453;172369;173056.13471932686;181914;206850;207462;44959;45208.54791452109;45227;45262.32106518405;45273.77363113163;47070.76464617655;47131.76434117876;47228.52771472241;47365;47483.28775068377;14575.635609109646;14618.48835290781;14699.55901322962;14715.779263311058;14717.852821471648;11935.164538482397;11949.342786146846;11981.940090299493;11986.101042421853;12003.459844307026;13732.176069435865;13757.587272381845;13851.307434628228;13853.861461385459;14014;5587.27365442498;5638.407967163471;5691.9715401423555;5746.224259724883;5775.5668324875805;1045.3936716704293;1080.6379862746069;1086.8858769829212;1091.579741799413;1091.8635170603675;25086.623700644504;25373.111941081974;25397.11110111137;25583.744162558138;25590;1175.418168006825;1182.066167727503;1182.6511179202157;1189.2231639122745;1192.3263356203718;12917.483300667867;13279.336033198302;13457.461701532025;13481.393337299845;13528.120672156278;250289;250702;252117;252584;252731;51278.74360628173;51394;51431.485685143416;51653.48346516562;51660;1488.977665335021;1497.2364094312197;1506.5630967019442;1508.8566586174295;1521.5359315408907;24158.87920560386;25299.241022769347;29007.85496072506;29540.556891647073;30595.2351191222;47244;47345;47484.7625761869;47708.7614561925;47754;197011;197561;198010;198030;198175;28427.43145137127;28903;31410.21474463157;35569.64430355767;37252.441213382364;45123.32315015343;45801.083978320916;48087;48115.5188448111;48855.511444885095;34368.48447273243;34413.48379774355;34428.31143377069;34732.47901281432;35673.46489802603;34163.316733665684;34731.652683473854;34858.825705871306;34960;35141.64858351384;41232.38151427791;41303;41308.79345603253;41312.58687413087;41435;32490.512642310856;32519.837400812845;33465.665343346256;34150.31699365949;35404;26822.59766103471;28108.578371324038;28128.156155314555;28173.71826281711;28312.66974841224 04:12:00 INFO - PID 17169 | |2;jquery.html;430.3888478360727;434.4352341955457;437.1082990698975;460.8041582327511;462.58367469277647;18599.256029758828;19698.803011969892;20278.29025984091;20392.184312627476;20404.591908161845;21625.134994600197;22289.108435662554;22714.77285227147;22746.090156393766;22895.313140605766;5480.177973304007;5739.655620662753;5743.081107022877;5745.683987380692;5751.827445176651;5523.088690366085;5588.748506317225;5680.204771332017;5693.743781529841;5695.0887857942735;5691.971540142294;5722.856928576777;5723.084306510959;5726.341470730857;5747.971260143714;5462.617616766828;5551.555875529948;5723.313202415716;5727.312722473309;5739.885202295973;5097.592192624581;5102.744862756885;5106.64253502255;5108.2848401223855;5112.974435127838;25110.49779004428;25187.24438266855;25782.48435031289;25852.87073564639;26004.34989125268;2106.7577228618597;2192.243675931801;2193.3419974007734;2196.121551379445;2197.549502352014;16909.154542272838;17209.827901721073;17325.306987720476;17427.47717568475;17603.823961760474;2111.4088055344528;2192.9561408771897;2195.6596727507263;2250.887455627212;2300.6318988961684;107593;110230.44884775525;113848;115929.42035289854;119001;11998.940005299917;12479.93760031194;12787.488500459878;12841.807372889414;12851.742965140646;17612.383566575107;17612.735808962876;17770.91114544419;17775.200115994812;17776;8206.138355472709;8388.454750441202;8413.158684131538;8435.367347448966;8586.914130858737;7537;7570.545767253982;7702.1912699166905;7724.266194711493;7779.260970207822;7965.840683186304;8033.638486268132;8057.234562716532;8112;8152.959235203904;2217.837608331896;2222.333300010023;2247.8538894971775;2267.331137314496;2394.457459004116;990.8662330585423;1033.3644808442905;1036.461040259061;1039.3867618105355;1040.089921318846;19421;20079.49801254951;20370.79629203689;20411;20416.285430009877;1048.7220886465093;1049.9317544359592;1049.968500944973;1053.752368193474;1077.849101125843;11045.991854574384;11188.497861769321;11245.873188441812;11269.21115521922;11324;481154;484591;493116;502265;505098;92534;94962.52518737501;95247;95723.52138239403;96079;1173.5364531010202;1175.8706542280343;1179.0803173524664;1188.4354931407513;1191.8867707567767;16793.91603041977;17291.308347666454;17483;17586.82413175852;17728.91135544314;45866.2480251186;46944.530554694014;47401.28898066601;47470.76264618655;47985.5201447981;56080;56147.15779263396;56359;56378.71810640921;57323.42676573181;9589.664361747306;9640;9724.70825875225;9870;10041.347312424668;15082.849171508144;15138.167400792621;15200.163990980602;15716.607084822514;15930.203489825231;11945.163838531567;12503.187292825936;13363.732725345633;13376.732465350444;13377.331133443484;12095.57665481704;12200.328981906081;12394.81407778902;12397.380130993595;12706.174098683556;12177.634670959886;12519.248845069325;12557;12847.100702950704;13217.867821322048;9643.710688679352;9710.75723106928;9765.365251258645;9989.350692204984;10035.498225088862;11846.170768046153;11884.702882427662;12074.939625301817;12091.334976576372;12093.213941094153 04:12:00 INFO - PID 17169 | |3;mootools.html;1290.2581015915848;1317.479595559754;1324.768165571026;1331.2411925202632;1345.4954392102961;11422;11603.187776855624;11903.940480297608;11910.82133767993;11915.523379064849;11724.355160466172;11923.105767067484;11928.165028448013;11930.821037684442;11931.224470409417;2353.1999120299097;2376.786089251967;2384.3681424422457;2398.568257713611;2404.1345115758313;2322.3033090072995;2364.196173301077;2375.1212051540956;2376.4177776444794;2388.5700573896693;2178.346496051186;2183.4323076000196;2197.7142971413696;2198.86806791593;2203.0747086223823;2234.0505285253867;2291.862488250702;2302.2632757517686;2302.5740238055846;2303.8502497337618;1948.4641723526145;2003.3689387842783;2237.496563273267;2265.76209498002;2292.885355732207;11165.274257173258;11214.66356009321;11246;11251.381174035425;11252.437378131142;6274.592151510137;6457.903131453032;6488.351164883521;6503.349665033506;6511.3488651134985;3550.928981420357;3703.185299234191;3777.2823163598828;3793.848246070154;3805.429185622179;1215.0826126274694;1244.9875501244962;1250.0749445410422;1277.572013375511;1282.487005197919;17502.649947000988;17764.289428422846;17782.199801008985;17791.377301794506;17800.109994500224;5234.842954711365;5304.124819404755;5305.761240744176;5417.726834193962;5454.12733962572;13000.739985200244;13085.803712944313;13088.803667944989;13107.541236056692;13146.868531314565;6339.397757213057;6435.03474478832;6451.516136289797;6475.838104047342;6483.189601299838;5952.345242023374;6026.668533230714;6042.305134909454;6090.147379366892;6152.8769424611255;4222.451081359403;4316.482022157361;4317.611414972667;4342.913141737147;4360.65114790816;1170.700522420113;1207.7644859252362;1209.0992210803008;1216.2823933879054;1217.7990631545695;787.9054513458307;807.3299161695778;824.9917500825035;832.5504227717086;852.3096292003497;5983.222181116427;6090.23872015998;6091.573589848668;6116.3883611638485;6215.96892015537;600.8017354273079;612.650789050246;619.4208415131866;622.956393052482;625.8810825943148;4207.810648520824;4338.9566104338555;4384.6273066789045;4385.495667998221;4408.647308215335;14570.344334504973;15444.227788610524;15583;15601.609959751097;15614.921925390527;14882.553523394316;15455.30451129702;15663.295151718201;15693.21533923322;15694;9193;9294.163525282622;9358.906410935939;9404.811903761887;9454.621815127455;6408.39120283591;6692;6757.391834734897;6765;6780.86438271222;13603.387847547083;13662.863371366158;13677.931610341884;13708.451661933412;13755.17468951866;13943.233122178377;14087.15477071379;14123.64690882736;14158.50445234412;14248.572542823731;8942.284617230476;9144;9146.542672866197;9149.261640288323;9159.725208243763;11074.39090850011;11103.666889993314;11165.832512512481;11245.887541124484;11266.830997535208;8776.56117194125;9037.77405564866;9070.909290907006;9076.09239076087;9166.450012999241;8782.253508451853;8828.984666763405;8885.244754195966;8927.821443570961;8970;7727.42044346665;7738.071431428265;7789.221077892165;7814.140444551209;7842.960785196037;6257.7184026719815;6263.749450021948;6281.905771413524;6454.451371633276;6462.386073323027;5838.065909454637;5884.529237661062;5895.469407753323;5910.231669882888;6042.791441711587 04:12:00 INFO - PID 17169 | |4;prototype.html;395.16422765850217;398.87435457830765;400.4813766172806;416.04932728714886;425.8913976935882;6006.579539432241;6099.5120390368775;6101.237345331828;6139.478144357729;6150.969245153768;5919.200907877435;5957.731902064406;5971.402859714027;5981.491573216271;6024.427679370453;4558.703684260512;4561.566651168134;4573.542645735433;4575.24508456106;4577.336286238494;4526.434195725535;4544.954550454486;4569;4585.174668559658;4588.4723256825555;4522.547745225467;4559.974005848674;4567.2920697291975;4568.84009059683;4576.748278844662;4535.206338890681;4542.295944128666;4551.203539380628;4554.703944243647;4575.428071491064;4025.5370632377358;4202.390653355246;4328.61042506176;4373.322135069069;4386.1008493258805;5937.664025594207;5950.8809823803285;5962.910556341659;5999.220101386792;6003.369646187131;5536.141898005815;5666.971665141689;5674.347450043257;5674.460926212003;5706.115552089392;6387.393197646216;6413.615183088983;6425.261094974091;6444.260049786578;6469.4500967417825;4894.41267047953;4926.704397736112;4936.679115857458;4938.234573641092;4970.738314067091;6730.528862979593;6755.729770809211;6762.492813039042;6770.559913605649;6786.0499530065335;5054.82308119214;5072.340595722532;5094.388673359221;5101.642884998015;5102.642815002989;5044.284943119357;5174.715390653475;5193.870153246124;5196.246544251062;5201.569568368654;5673.716344160132;5680.375158732536;5705.771769129188;5712.942870571241;5736.913946290809;6451.387118223761;6453.741850326029;6482.12491313676;6496.35036496356;6518.478521718251;1752.4129416645312;1766.4435702753592;1775.9112044397987;1791.7222830461299;1798.2357498063532;1276.6489215465822;1280.7118398360294;1296.695276609996;1297.5393735224047;1310.316243626935;6096.542759293071;6098.573099882966;6101.450869421773;6132.478739307119;6176.907346389808;6460.806175814733;6535.705893234815;6558.409743123047;6576.210854697467;6579.638119903451;5887.470127688529;6002.459778619857;6054.636721796706;6054.66699331541;6097;3470.35798377301;3472.913177170591;3484.3728128936527;3497.772644778132;3502;6491.253505846888;6802.387785099365;6835.965820170867;6855.794326170223;6868.484863635247;6556.573822701509;6664.86670266592;6696.43080338167;6717;6733.797986060426;6817.352351526696;6848.6918088686125;6850.45196384298;6893.276205998298;6895;6374.74501019954;6551.705173267119;6562.212534495891;6587.080686991232;6624.271330153776;6532.738690452328;6569.047488114292;6575.454768129582;6581.701730107309;6582.440492558187;6841.836887728999;6864.931350686429;6887.965560172367;6911.89632155508;6924.169099708067;4488.214562451492;4576.977115114403;4625.635437545865;4667.416572928384;4680.836170734008;6634.4692424604955;6636.13730215069;6650.3682150195655;6677.2988836173445;6687.130673012477;6287.308396076336;6396.808095757135;6400.295967443484;6411.903821442589;6423.197100362455;6394.072859435263;6394.360563943568;6400.935990640034;6448.613083215022;6451.290358060516;6250.593711408744;6333.145025421509;6387.4570661492435;6422.197225346832;6459.935400645933;6368.542020585516;6444.387783160592;6458.031295305554;6484.383983521558;6488.475208326134;6092.765338934953;6200.720967556561;6213.161223234805;6235.314115447388;6289.371062893674 04:12:00 INFO - PID 17169 | |5;yui.html;833.2750507058852;844.733908818722;851.2891735400943;860.5138096975209;863.9524826134564;16440.260188291526;17068.317267309307;17129.914350428247;20329;21083.894580527074;19141.138648760803;19329.226830926782;19444.125014374353;19460.12429440675;19472;970.941743495389;976.3995142987047;983.2330781990023;986.7039888033597;987.3138168972567;1001.694483182629;1008.6721815409984;1009.8434742614907;1011.8482227665872;1014.0923873133542;1032.9793404131913;1047.5704960966004;1048.1562342314435;1048.3447845096814;1050.1965996013018;1033.0444338986445;1033.9431331276776;1034.270839058462;1034.8447732840098;1034.8965103489666;761.0562902001534;763.3206446262831;763.5800309829627;766.0424469413233;772.891795148674;17340.393086241922;17432.389866354744;17642;19156.32952846644;19305.710414343797;17327.393541226123;17703.822961770347;19221.423357299165;19527.218911243534;19654;12736.872631273662;12762.489500419972;12804.61586152417;12820;12830.166039207515;3416.794992300445;3433.759636825423;3460.498227756986;3473.70473509752;3491.825408729553;109869.45065274702;114891.42554287259;116617;116826.83173168244;117605;14645.048071875508;14973.775393369107;15122.697546049018;15127.54617361481;15199.392024318904;24266.150684726304;24795.380115496897;24993.375165621004;27342.45315093727;27435.31411714683;8227.095019547965;8422.747317580483;8436.535990520457;8462.02686691026;8462.492250464991;3928.823202955874;3961;4026.91946161081;4048.2915489789757;4050.513938327361;4648.604868586141;4707;4715.03341814934;4725.10223057618;4734.857954261378;872.520113937332;902.444996327254;904.3759805734154;908.123660667459;908.9045650206765;661.8874791285493;683.2279524137792;692.9896051559231;693.3967448319893;695.3706895259797;12537.811932821014;12540.937295313648;12881.35593220354;12920.806187907188;13669.248191349572;676.9966150169217;686.5331574529368;689.648289352864;694.7707256605308;695.4123765418213;5359.629117657346;5385.071473769703;5533.3083364579425;5665.9716701417055;5712.857178570569;107459.46270268755;108922.45538772256;109963;109967.45016275028;110936.4453177745;96755.51622241843;98630.50684746531;99175;99669.50165249128;99950.50024749829;73883.63058184675;79834.60082699549;81205;81454.59272703718;84164;11439.542418303176;12228.816567751313;12286;12448.937755311166;12534.937325313314;37469;37597.81201093977;37760.244795104496;37827.24345513129;38207;47291.05417891554;47433.762831185624;47482.28776568285;48348.5165148344;49022.75488622534;16205.837941620905;16645.25096370642;16720.498385048468;16731.91634041822;16794.496165115066;18877.811221887605;18933.148008339384;18960.241590336784;19119.522011949255;19291.61416771685;17141.657166856345;17632.471025869243;17754;18109.909450452662;18114.27542898269;17644.117794109985;17673.911630441766;17734.379296724554;17760.28958841632;18098.457046288633;16600;16831.242594083542;16983.830161698224;17036.659266814346;17127.22927468242;9964.950175249078;10331.431771252654;10535.31520451199;10589.682309530726;10872.836907446237;11801.645950621494;12146.453409596767;12299.954503867271;12325.198862073936;12376.257424554555 04:12:00 INFO - PID 17169 | __end_tp_report 04:12:00 INFO - PID 17169 | __start_cc_report 04:12:00 INFO - PID 17169 | _x_x_mozilla_cycle_collect,340 04:12:00 INFO - PID 17169 | __end_cc_report 04:12:00 INFO - PID 17169 | __startTimestamp1495883520167__endTimestamp 04:12:00 INFO - PID 17169 | 04:12:00 INFO - PID 17169 | ------- Summary: start ------- 04:12:00 INFO - PID 17169 | Number of tests: 6 04:12:00 INFO - PID 17169 | 04:12:00 INFO - PID 17169 | [#0] dojo.html Cycles:165 Average:5970.30 Median:6210.00 stddev:737.02 (11.9%) stddev-sans-first:710.92 04:12:00 INFO - PID 17169 | Values: 3389.4 3391.7 3418.1 3420.0 3423.8 5821.1 5934.5 5940.6 5945.5 5987.9 5917.2 5955.9 6003.6 6050.7 6099.5 4987.1 5226.8 5297.6 5320.2 5328.9 5352.4 5413.2 5418.2 5428.5 5437.2 5164.1 5193.3 5231.4 5245.2 5369.0 5281.5 5288.9 5291.3 5291.7 5333.0 5196.3 5227.9 5244.4 5249.3 5272.2 5839.3 5933.5 5958.3 5979.1 5982.5 6424.0 6526.1 6530.0 6543.2 6548.5 6574.9 6623.0 6628.1 6630.1 6645.6 5897.8 6088.5 6104.6 6119.1 6121.1 6533.9 6632.5 6720.5 6728.2 6740.4 6173.2 6287.9 6291.7 6302.3 6340.3 6512.9 6545.1 6545.3 6556.0 6575.6 6201.8 6502.3 6512.5 6522.4 6523.8 6398.9 6421.4 6427.7 6477.6 6493.6 4928.8 4942.0 4945.0 4945.1 4957.0 4382.7 4390.5 4393.3 4414.1 4421.1 5993.9 6038.1 6055.5 6121.3 6132.8 6402.2 6432.3 6434.6 6436.5 6467.7 6015.5 6019.0 6024.3 6043.2 6054.6 5355.5 5380.6 5409.1 5438.3 5458.9 6590.1 6676.4 6698.7 6710.6 6710.8 6450.9 6491.5 6503.8 6569.5 6612.1 6575.1 6790.0 6838.6 6850.9 6862.0 6274.1 6340.9 6369.5 6396.0 6398.9 6579.8 6602.6 6607.8 6608.0 6609.3 6150.0 6200.5 6258.5 6367.8 6388.7 6365.0 6395.9 6400.2 6400.5 6402.4 6151.5 6212.9 6223.0 6230.1 6292.0 6302.8 6427.4 6429.5 6432.5 6433.9 6165.6 6196.0 6210.0 6224.8 6233.4 04:12:00 INFO - PID 17169 | 04:12:00 INFO - PID 17169 | [#1] ext.html Cycles:180 Average:38446.58 Median:34909.41 stddev:55707.66 (159.6%) stddev-sans-first:55792.00 04:12:00 INFO - PID 17169 | Values: 744.9 810.5 828.9 1150.8 1160.0 36024.0 36717.3 36888.0 37008.6 37031.3 39408.8 39518.2 39560.6 39725.2 39865.2 7135.3 7179.3 7269.6 7350.3 7354.6 7045.8 7063.3 7085.0 7108.1 7116.9 7084.6 7092.7 7140.0 7174.1 7186.7 7059.1 7071.8 7118.8 7148.4 7154.5 7279.1 7309.3 7313.2 7323.0 7323.4 37544.6 37643.1 37707.4 37758.8 37815.0 3508.7 3522.8 3528.8 3541.3 3543.3 28791.0 28883.4 28899.4 28903.4 28938.6 3329.1 3332.7 3355.0 3359.8 3369.8 172369.0 173056.1 181914.0 206850.0 207462.0 44959.0 45208.5 45227.0 45262.3 45273.8 47070.8 47131.8 47228.5 47365.0 47483.3 14575.6 14618.5 14699.6 14715.8 14717.9 11935.2 11949.3 11981.9 11986.1 12003.5 13732.2 13757.6 13851.3 13853.9 14014.0 5587.3 5638.4 5692.0 5746.2 5775.6 1045.4 1080.6 1086.9 1091.6 1091.9 25086.6 25373.1 25397.1 25583.7 25590.0 1175.4 1182.1 1182.7 1189.2 1192.3 12917.5 13279.3 13457.5 13481.4 13528.1 250289.0 250702.0 252117.0 252584.0 252731.0 51278.7 51394.0 51431.5 51653.5 51660.0 1489.0 1497.2 1506.6 1508.9 1521.5 24158.9 25299.2 29007.9 29540.6 30595.2 47244.0 47345.0 47484.8 47708.8 47754.0 197011.0 197561.0 198010.0 198030.0 198175.0 28427.4 28903.0 31410.2 35569.6 37252.4 45123.3 45801.1 48087.0 48115.5 48855.5 34368.5 34413.5 34428.3 34732.5 35673.5 34163.3 34731.7 34858.8 34960.0 35141.6 41232.4 41303.0 41308.8 41312.6 41435.0 32490.5 32519.8 33465.7 34150.3 35404.0 26822.6 28108.6 28128.2 28173.7 28312.7 04:12:00 INFO - PID 17169 | 04:12:00 INFO - PID 17169 | [#2] jquery.html Cycles:180 Average:31015.50 Median:2220.09 stddev:81980.92 (3692.7%) stddev-sans-first:82178.73 04:12:00 INFO - PID 17169 | Values: 430.4 434.4 437.1 460.8 462.6 18599.3 19698.8 20278.3 20392.2 20404.6 21625.1 22289.1 22714.8 22746.1 22895.3 5480.2 5739.7 5743.1 5745.7 5751.8 5523.1 5588.7 5680.2 5693.7 5695.1 5692.0 5722.9 5723.1 5726.3 5748.0 5462.6 5551.6 5723.3 5727.3 5739.9 5097.6 5102.7 5106.6 5108.3 5113.0 25110.5 25187.2 25782.5 25852.9 26004.3 2106.8 2192.2 2193.3 2196.1 2197.5 16909.2 17209.8 17325.3 17427.5 17603.8 2111.4 2193.0 2195.7 2250.9 2300.6 107593.0 110230.4 113848.0 115929.4 119001.0 11998.9 12479.9 12787.5 12841.8 12851.7 17612.4 17612.7 17770.9 17775.2 17776.0 8206.1 8388.5 8413.2 8435.4 8586.9 7537.0 7570.5 7702.2 7724.3 7779.3 7965.8 8033.6 8057.2 8112.0 8153.0 2217.8 2222.3 2247.9 2267.3 2394.5 990.9 1033.4 1036.5 1039.4 1040.1 19421.0 20079.5 20370.8 20411.0 20416.3 1048.7 1049.9 1050.0 1053.8 1077.8 11046.0 11188.5 11245.9 11269.2 11324.0 481154.0 484591.0 493116.0 502265.0 505098.0 92534.0 94962.5 95247.0 95723.5 96079.0 1173.5 1175.9 1179.1 1188.4 1191.9 16793.9 17291.3 17483.0 17586.8 17728.9 45866.2 46944.5 47401.3 47470.8 47985.5 56080.0 56147.2 56359.0 56378.7 57323.4 9589.7 9640.0 9724.7 9870.0 10041.3 15082.8 15138.2 15200.2 15716.6 15930.2 11945.2 12503.2 13363.7 13376.7 13377.3 12095.6 12200.3 12394.8 12397.4 12706.2 12177.6 12519.2 12557.0 12847.1 13217.9 9643.7 9710.8 9765.4 9989.4 10035.5 11846.2 11884.7 12074.9 12091.3 12093.2 04:12:00 INFO - PID 17169 | 04:12:00 INFO - PID 17169 | [#3] mootools.html Cycles:180 Average:7164.38 Median:3627.06 stddev:4755.96 (131.1%) stddev-sans-first:4748.82 04:12:00 INFO - PID 17169 | Values: 1290.3 1317.5 1324.8 1331.2 1345.5 11422.0 11603.2 11903.9 11910.8 11915.5 11724.4 11923.1 11928.2 11930.8 11931.2 2353.2 2376.8 2384.4 2398.6 2404.1 2322.3 2364.2 2375.1 2376.4 2388.6 2178.3 2183.4 2197.7 2198.9 2203.1 2234.1 2291.9 2302.3 2302.6 2303.9 1948.5 2003.4 2237.5 2265.8 2292.9 11165.3 11214.7 11246.0 11251.4 11252.4 6274.6 6457.9 6488.4 6503.3 6511.3 3550.9 3703.2 3777.3 3793.8 3805.4 1215.1 1245.0 1250.1 1277.6 1282.5 17502.6 17764.3 17782.2 17791.4 17800.1 5234.8 5304.1 5305.8 5417.7 5454.1 13000.7 13085.8 13088.8 13107.5 13146.9 6339.4 6435.0 6451.5 6475.8 6483.2 5952.3 6026.7 6042.3 6090.1 6152.9 4222.5 4316.5 4317.6 4342.9 4360.7 1170.7 1207.8 1209.1 1216.3 1217.8 787.9 807.3 825.0 832.6 852.3 5983.2 6090.2 6091.6 6116.4 6216.0 600.8 612.7 619.4 623.0 625.9 4207.8 4339.0 4384.6 4385.5 4408.6 14570.3 15444.2 15583.0 15601.6 15614.9 14882.6 15455.3 15663.3 15693.2 15694.0 9193.0 9294.2 9358.9 9404.8 9454.6 6408.4 6692.0 6757.4 6765.0 6780.9 13603.4 13662.9 13677.9 13708.5 13755.2 13943.2 14087.2 14123.6 14158.5 14248.6 8942.3 9144.0 9146.5 9149.3 9159.7 11074.4 11103.7 11165.8 11245.9 11266.8 8776.6 9037.8 9070.9 9076.1 9166.5 8782.3 8829.0 8885.2 8927.8 8970.0 7727.4 7738.1 7789.2 7814.1 7843.0 6257.7 6263.7 6281.9 6454.5 6462.4 5838.1 5884.5 5895.5 5910.2 6042.8 04:12:00 INFO - PID 17169 | 04:12:00 INFO - PID 17169 | [#4] prototype.html Cycles:180 Average:5438.56 Median:6094.65 stddev:1568.82 (25.7%) stddev-sans-first:1526.87 04:12:00 INFO - PID 17169 | Values: 395.2 398.9 400.5 416.0 425.9 6006.6 6099.5 6101.2 6139.5 6151.0 5919.2 5957.7 5971.4 5981.5 6024.4 4558.7 4561.6 4573.5 4575.2 4577.3 4526.4 4545.0 4569.0 4585.2 4588.5 4522.5 4560.0 4567.3 4568.8 4576.7 4535.2 4542.3 4551.2 4554.7 4575.4 4025.5 4202.4 4328.6 4373.3 4386.1 5937.7 5950.9 5962.9 5999.2 6003.4 5536.1 5667.0 5674.3 5674.5 5706.1 6387.4 6413.6 6425.3 6444.3 6469.5 4894.4 4926.7 4936.7 4938.2 4970.7 6730.5 6755.7 6762.5 6770.6 6786.0 5054.8 5072.3 5094.4 5101.6 5102.6 5044.3 5174.7 5193.9 5196.2 5201.6 5673.7 5680.4 5705.8 5712.9 5736.9 6451.4 6453.7 6482.1 6496.4 6518.5 1752.4 1766.4 1775.9 1791.7 1798.2 1276.6 1280.7 1296.7 1297.5 1310.3 6096.5 6098.6 6101.5 6132.5 6176.9 6460.8 6535.7 6558.4 6576.2 6579.6 5887.5 6002.5 6054.6 6054.7 6097.0 3470.4 3472.9 3484.4 3497.8 3502.0 6491.3 6802.4 6836.0 6855.8 6868.5 6556.6 6664.9 6696.4 6717.0 6733.8 6817.4 6848.7 6850.5 6893.3 6895.0 6374.7 6551.7 6562.2 6587.1 6624.3 6532.7 6569.0 6575.5 6581.7 6582.4 6841.8 6864.9 6888.0 6911.9 6924.2 4488.2 4577.0 4625.6 4667.4 4680.8 6634.5 6636.1 6650.4 6677.3 6687.1 6287.3 6396.8 6400.3 6411.9 6423.2 6394.1 6394.4 6400.9 6448.6 6451.3 6250.6 6333.1 6387.5 6422.2 6459.9 6368.5 6444.4 6458.0 6484.4 6488.5 6092.8 6200.7 6213.2 6235.3 6289.4 04:12:00 INFO - PID 17169 | 04:12:00 INFO - PID 17169 | [#5] yui.html Cycles:180 Average:21871.26 Median:19317.47 stddev:30220.02 (156.4%) stddev-sans-first:30263.51 04:12:00 INFO - PID 17169 | Values: 833.3 844.7 851.3 860.5 864.0 16440.3 17068.3 17129.9 20329.0 21083.9 19141.1 19329.2 19444.1 19460.1 19472.0 970.9 976.4 983.2 986.7 987.3 1001.7 1008.7 1009.8 1011.8 1014.1 1033.0 1047.6 1048.2 1048.3 1050.2 1033.0 1033.9 1034.3 1034.8 1034.9 761.1 763.3 763.6 766.0 772.9 17340.4 17432.4 17642.0 19156.3 19305.7 17327.4 17703.8 19221.4 19527.2 19654.0 12736.9 12762.5 12804.6 12820.0 12830.2 3416.8 3433.8 3460.5 3473.7 3491.8 109869.5 114891.4 116617.0 116826.8 117605.0 14645.0 14973.8 15122.7 15127.5 15199.4 24266.2 24795.4 24993.4 27342.5 27435.3 8227.1 8422.7 8436.5 8462.0 8462.5 3928.8 3961.0 4026.9 4048.3 4050.5 4648.6 4707.0 4715.0 4725.1 4734.9 872.5 902.4 904.4 908.1 908.9 661.9 683.2 693.0 693.4 695.4 12537.8 12540.9 12881.4 12920.8 13669.2 677.0 686.5 689.6 694.8 695.4 5359.6 5385.1 5533.3 5666.0 5712.9 107459.5 108922.5 109963.0 109967.5 110936.4 96755.5 98630.5 99175.0 99669.5 99950.5 73883.6 79834.6 81205.0 81454.6 84164.0 11439.5 12228.8 12286.0 12448.9 12534.9 37469.0 37597.8 37760.2 37827.2 38207.0 47291.1 47433.8 47482.3 48348.5 49022.8 16205.8 16645.3 16720.5 16731.9 16794.5 18877.8 18933.1 18960.2 19119.5 19291.6 17141.7 17632.5 17754.0 18109.9 18114.3 17644.1 17673.9 17734.4 17760.3 18098.5 16600.0 16831.2 16983.8 17036.7 17127.2 9965.0 10331.4 10535.3 10589.7 10872.8 11801.6 12146.5 12300.0 12325.2 12376.3 04:12:00 INFO - PID 17169 | -------- Summary: end -------- 04:12:00 INFO - PID 17169 | 04:12:00 INFO - TEST-INFO | 17169: exit 0 04:12:00 INFO - TEST-OK | dromaeo_css | took 1140828ms 04:12:00 INFO - TEST-START | kraken 04:12:00 INFO - operating with platform_type : linux_ 04:12:00 INFO - Initialising browser for kraken test... 04:12:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49850/getInfo.html -profile /tmp/tmpGjIwH1/profile 04:12:00 INFO - TEST-INFO | started process 17575 (/builds/slave/test/build/application/firefox/firefox http://localhost:49850/getInfo.html) 04:12:35 INFO - TEST-INFO | 17575: killed by SIGTERM 04:12:35 INFO - Browser initialized. 04:12:35 INFO - Running cycle 1/1 for kraken test... 04:12:35 INFO - TEST-INFO | started process 17778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGjIwH1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:47 INFO - PID 17778 | RSS: Main: 181088256 04:12:47 INFO - PID 17778 | 04:12:50 INFO - PID 17778 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49850/tests/kraken/driver.html?testName=audio-beat-detection) 04:12:50 INFO - PID 17778 | RSS: Main: 185151488 04:12:50 INFO - PID 17778 | 04:12:53 INFO - PID 17778 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49850/tests/kraken/driver.html?testName=audio-dft) 04:12:54 INFO - PID 17778 | RSS: Main: 184008704 04:12:54 INFO - PID 17778 | 04:12:56 INFO - PID 17778 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49850/tests/kraken/driver.html?testName=audio-fft) 04:12:57 INFO - PID 17778 | RSS: Main: 179683328 04:12:57 INFO - PID 17778 | 04:12:59 INFO - PID 17778 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49850/tests/kraken/driver.html?testName=audio-oscillator) 04:13:00 INFO - PID 17778 | RSS: Main: 180916224 04:13:00 INFO - PID 17778 | 04:13:02 INFO - PID 17778 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49850/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:13:02 INFO - PID 17778 | RSS: Main: 180719616 04:13:02 INFO - PID 17778 | 04:13:06 INFO - PID 17778 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49850/tests/kraken/driver.html?testName=imaging-darkroom) 04:13:06 INFO - PID 17778 | RSS: Main: 181837824 04:13:06 INFO - PID 17778 | 04:13:10 INFO - PID 17778 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49850/tests/kraken/driver.html?testName=imaging-desaturate) 04:13:10 INFO - PID 17778 | RSS: Main: 180596736 04:13:10 INFO - PID 17778 | 04:13:13 INFO - PID 17778 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49850/tests/kraken/driver.html?testName=json-parse-financial) 04:13:14 INFO - PID 17778 | RSS: Main: 181489664 04:13:14 INFO - PID 17778 | 04:13:15 INFO - PID 17778 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49850/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:13:16 INFO - PID 17778 | RSS: Main: 181469184 04:13:16 INFO - PID 17778 | 04:13:17 INFO - PID 17778 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49850/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:13:18 INFO - PID 17778 | RSS: Main: 180940800 04:13:18 INFO - PID 17778 | 04:13:20 INFO - PID 17778 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49850/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:13:21 INFO - PID 17778 | RSS: Main: 181215232 04:13:21 INFO - PID 17778 | 04:13:24 INFO - PID 17778 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:13:24 INFO - PID 17778 | RSS: Main: 180576256 04:13:24 INFO - PID 17778 | 04:13:27 INFO - PID 17778 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:13:28 INFO - PID 17778 | RSS: Main: 181161984 04:13:28 INFO - PID 17778 | 04:13:29 INFO - PID 17778 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49850/tests/kraken/driver.html?testName=ai-astar) 04:13:30 INFO - PID 17778 | RSS: Main: 182824960 04:13:30 INFO - PID 17778 | 04:13:30 INFO - PID 17778 | __start_tp_report 04:13:30 INFO - PID 17778 | _x_x_mozilla_page_load 04:13:30 INFO - PID 17778 | _x_x_mozilla_page_load_details 04:13:30 INFO - PID 17778 | |i|pagename|runs| 04:13:30 INFO - PID 17778 | |0;ai-astar;102;112;110;110;110;110;112;110;110;110 04:13:30 INFO - PID 17778 | |1;audio-beat-detection;155;118;117;159;119;118;122;120;143;122 04:13:30 INFO - PID 17778 | |2;audio-dft;163;163;164;163;163;164;167;168;170;163 04:13:30 INFO - PID 17778 | |3;audio-fft;74;74;74;101;73;74;74;73;97;73 04:13:30 INFO - PID 17778 | |4;audio-oscillator;83;81;105;83;82;81;109;81;82;112 04:13:30 INFO - PID 17778 | |5;imaging-gaussian-blur;114;115;113;114;114;113;118;114;113;113 04:13:30 INFO - PID 17778 | |6;imaging-darkroom;150;149;150;149;149;148;148;149;148;149 04:13:30 INFO - PID 17778 | |7;imaging-desaturate;94;95;95;95;95;94;95;95;95;94 04:13:30 INFO - PID 17778 | |8;json-parse-financial;47;49;48;50;48;48;48;50;49;48 04:13:30 INFO - PID 17778 | |9;json-stringify-tinderbox;56;55;55;56;55;55;56;56;56;56 04:13:30 INFO - PID 17778 | |10;stanford-crypto-aes;85;94;84;90;85;86;86;85;138;83 04:13:30 INFO - PID 17778 | |11;stanford-crypto-ccm;127;126;127;128;126;125;128;125;132;134 04:13:30 INFO - PID 17778 | |12;stanford-crypto-pbkdf2;175;183;181;181;182;185;181;187;182;174 04:13:30 INFO - PID 17778 | |13;stanford-crypto-sha256-iterative;66;65;64;65;70;67;63;63;64;66 04:13:30 INFO - PID 17778 | __end_tp_report 04:13:30 INFO - PID 17778 | __start_cc_report 04:13:30 INFO - PID 17778 | _x_x_mozilla_cycle_collect,910 04:13:30 INFO - PID 17778 | __end_cc_report 04:13:30 INFO - PID 17778 | __startTimestamp1495883610226__endTimestamp 04:13:30 INFO - PID 17778 | 04:13:30 INFO - PID 17778 | ------- Summary: start ------- 04:13:30 INFO - PID 17778 | Number of tests: 14 04:13:30 INFO - PID 17778 | 04:13:30 INFO - PID 17778 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:2.80 (2.5%) stddev-sans-first:0.88 04:13:30 INFO - PID 17778 | Values: 102.0 112.0 110.0 110.0 110.0 110.0 112.0 110.0 110.0 110.0 04:13:30 INFO - PID 17778 | 04:13:30 INFO - PID 17778 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:122.00 stddev:16.45 (13.5%) stddev-sans-first:14.59 04:13:30 INFO - PID 17778 | Values: 155.0 118.0 117.0 159.0 119.0 118.0 122.0 120.0 143.0 122.0 04:13:30 INFO - PID 17778 | 04:13:30 INFO - PID 17778 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.00 stddev:2.57 (1.6%) stddev-sans-first:2.65 04:13:30 INFO - PID 17778 | Values: 163.0 163.0 164.0 163.0 163.0 164.0 167.0 168.0 170.0 163.0 04:13:30 INFO - PID 17778 | 04:13:30 INFO - PID 17778 | [#3] audio-fft Cycles:10 Average:78.70 Median:74.00 stddev:10.75 (14.5%) stddev-sans-first:11.27 04:13:30 INFO - PID 17778 | Values: 74.0 74.0 74.0 101.0 73.0 74.0 74.0 73.0 97.0 73.0 04:13:30 INFO - PID 17778 | 04:13:30 INFO - PID 17778 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:81.50 stddev:13.08 (16.0%) stddev-sans-first:13.63 04:13:30 INFO - PID 17778 | Values: 83.0 81.0 105.0 83.0 82.0 81.0 109.0 81.0 82.0 112.0 04:13:30 INFO - PID 17778 | 04:13:30 INFO - PID 17778 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:1.52 (1.3%) stddev-sans-first:1.62 04:13:30 INFO - PID 17778 | Values: 114.0 115.0 113.0 114.0 114.0 113.0 118.0 114.0 113.0 113.0 04:13:30 INFO - PID 17778 | 04:13:30 INFO - PID 17778 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 04:13:30 INFO - PID 17778 | Values: 150.0 149.0 150.0 149.0 149.0 148.0 148.0 149.0 148.0 149.0 04:13:30 INFO - PID 17778 | 04:13:30 INFO - PID 17778 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 04:13:30 INFO - PID 17778 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 04:13:30 INFO - PID 17778 | 04:13:30 INFO - PID 17778 | [#8] json-parse-financial Cycles:10 Average:48.50 Median:48.50 stddev:0.97 (2.0%) stddev-sans-first:0.87 04:13:30 INFO - PID 17778 | Values: 47.0 49.0 48.0 50.0 48.0 48.0 48.0 50.0 49.0 48.0 04:13:30 INFO - PID 17778 | 04:13:30 INFO - PID 17778 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:56.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 04:13:30 INFO - PID 17778 | Values: 56.0 55.0 55.0 56.0 55.0 55.0 56.0 56.0 56.0 56.0 04:13:30 INFO - PID 17778 | 04:13:30 INFO - PID 17778 | [#10] stanford-crypto-aes Cycles:10 Average:91.60 Median:85.50 stddev:16.62 (19.4%) stddev-sans-first:17.46 04:13:30 INFO - PID 17778 | Values: 85.0 94.0 84.0 90.0 85.0 86.0 86.0 85.0 138.0 83.0 04:13:30 INFO - PID 17778 | 04:13:30 INFO - PID 17778 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:127.50 stddev:2.97 (2.3%) stddev-sans-first:3.14 04:13:30 INFO - PID 17778 | Values: 127.0 126.0 127.0 128.0 126.0 125.0 128.0 125.0 132.0 134.0 04:13:30 INFO - PID 17778 | 04:13:30 INFO - PID 17778 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.10 Median:182.00 stddev:3.98 (2.2%) stddev-sans-first:3.56 04:13:30 INFO - PID 17778 | Values: 175.0 183.0 181.0 181.0 182.0 185.0 181.0 187.0 182.0 174.0 04:13:30 INFO - PID 17778 | 04:13:30 INFO - PID 17778 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:2.11 (3.2%) stddev-sans-first:2.22 04:13:30 INFO - PID 17778 | Values: 66.0 65.0 64.0 65.0 70.0 67.0 63.0 63.0 64.0 66.0 04:13:30 INFO - PID 17778 | -------- Summary: end -------- 04:13:30 INFO - PID 17778 | 04:13:31 INFO - TEST-INFO | 17778: exit 0 04:13:31 INFO - TEST-OK | kraken | took 90300ms 04:13:31 INFO - SUITE-END | took 1231s 04:13:31 INFO - Completed test suite (00:20:31) 04:13:31 INFO - javascript benchmark 04:13:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7820.778452170362, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3389.406853800585, 3391.7456190785683, 3418.1283772637976, 3419.9829000854993, 3423.8116903570326, 5821.126830975356, 5934.495567876736, 5940.554458415614, 5945.524358051356, 5987.850303742403, 5917.171595976567, 5955.88088238236, 6003.609765365259, 6050.727717252723, 6099.542534309922, 4987.0777666192325, 5226.764795584208, 5297.576193904488, 5320.228566857803, 5328.92006619901, 5352.384475785276, 5413.215083812845, 5418.187271909206, 5428.538574221196, 5437.238786569884, 5164.096283150471, 5193.324867767204, 5231.398389185254, 5245.186996015624, 5369.006733754268, 5281.498257665516, 5288.92066619001, 5291.28567643367, 5291.708956007418, 5333.040052790496, 5196.32447781786, 5227.869303267449, 5244.423113457517, 5249.343832020997, 5272.182811664198, 5839.270091238595, 5933.465988061095, 5958.344582095966, 5979.073243647242, 5982.491488223506, 6423.967880160616, 6526.086347911296, 6529.967350163266, 6543.214814222276, 6548.541602087856, 6574.901376479356, 6622.966885165543, 6628.0720699101685, 6630.071789949411, 6645.60126392418, 5897.793577224862, 6088.482478989247, 6104.633721976696, 6119.143319935212, 6121.051237058263, 6533.869322613521, 6632.502562307846, 6720.529562930548, 6728.158980127484, 6740.39336459721, 6173.166622505994, 6287.937120628735, 6291.716872740738, 6302.275238347557, 6340.302566717657, 6512.869742605121, 6545.14913061299, 6545.345465453512, 6556.049372840911, 6575.638339891352, 6201.751929922752, 6502.284748677642, 6512.479001679854, 6522.412982831473, 6523.836904077341, 6398.9040164397575, 6421.389967953037, 6427.742890284429, 6477.611343319416, 6493.577917435352, 4928.753562321869, 4941.975290123526, 4945.0, 4945.060438516671, 4956.975215123901, 4382.69321147523, 4390.53899340571, 4393.253146965024, 4414.050979039522, 4421.137878113737, 5993.940060599425, 6038.094285857069, 6055.545834062463, 6121.296050954108, 6132.754689812357, 6402.231732192166, 6432.292447830735, 6434.613923164625, 6436.485081193493, 6467.741290348334, 6015.488683461955, 6018.969905150446, 6024.277086749618, 6043.214382130383, 6054.636721796706, 5355.518003379714, 5380.596455265871, 5409.080456322435, 5438.347398312228, 5458.918116228259, 6590.143281373391, 6676.365745254193, 6698.66506674674, 6710.6309152997055, 6710.832229194211, 6450.870982580416, 6491.48068154537, 6503.772367967098, 6569.507286953402, 6612.0743095965645, 6575.079488871466, 6789.966050169717, 6838.555493892881, 6850.862982740417, 6862.039314495874, 6274.058891166179, 6340.873182536416, 6369.49044076482, 6396.0, 6398.90401643985, 6579.769708060195, 6602.570832895846, 6607.768728094494, 6608.008798680236, 6609.339066093545, 6149.954507733606, 6200.534959877937, 6258.4680302173, 6367.808965731036, 6388.68056597159, 6365.0, 6395.936040639534, 6400.199975003125, 6400.487960963019, 6402.391772781578, 6151.477124444294, 6212.937870621236, 6223.0, 6230.096635987666, 6292.0, 6302.797915043904, 6427.357264273535, 6429.4534964526665, 6432.453241474527, 6433.8713225736155, 6165.568410211422, 6195.96902015487, 6210.0, 6224.782132625336, 6233.376662333912], "value": 5916.9589022658065, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.8659241336558, 810.5177419435436, 828.8881001064856, 1150.8101163308054, 1159.9942000289998, 36024.0, 36717.26565468689, 36888.0, 37008.62991370089, 37031.25937481252, 39408.80295598525, 39518.20963580727, 39560.604393956055, 39725.20549589006, 39865.20269594606, 7135.25079866613, 7179.317964793337, 7269.636518174097, 7350.338469537741, 7354.6322683865865, 7045.823854403629, 7063.328983746535, 7085.0, 7108.147022357324, 7116.85766284674, 7084.57492550446, 7092.6808293626655, 7140.0, 7174.139103307611, 7186.676599553007, 7059.082319298484, 7071.7878463646175, 7118.822029449253, 7148.356647901714, 7154.534955227893, 7279.053723015974, 7309.269073092702, 7313.158986716542, 7323.0, 7323.377512911409, 37544.62455375439, 37643.058923526856, 37707.434388484195, 37758.81120594407, 37815.0, 3508.7193024557973, 3522.788632682047, 3528.752987290891, 3541.3448512025357, 3543.255916257589, 28791.0, 28883.42233155325, 28899.422011559862, 28903.42193156146, 28938.565921511195, 3329.051220402174, 3332.683395077464, 3355.0102719697747, 3359.8320083995945, 3369.7641165118453, 172369.0, 173056.13471932686, 181914.0, 206850.0, 207462.0, 44959.0, 45208.54791452109, 45227.0, 45262.32106518405, 45273.77363113163, 47070.76464617655, 47131.76434117876, 47228.52771472241, 47365.0, 47483.28775068377, 14575.635609109646, 14618.48835290781, 14699.55901322962, 14715.779263311058, 14717.852821471648, 11935.164538482397, 11949.342786146846, 11981.940090299493, 11986.101042421853, 12003.459844307026, 13732.176069435865, 13757.587272381845, 13851.307434628228, 13853.861461385459, 14014.0, 5587.27365442498, 5638.407967163471, 5691.9715401423555, 5746.224259724883, 5775.5668324875805, 1045.3936716704293, 1080.6379862746069, 1086.8858769829212, 1091.579741799413, 1091.8635170603675, 25086.623700644504, 25373.111941081974, 25397.11110111137, 25583.744162558138, 25590.0, 1175.418168006825, 1182.066167727503, 1182.6511179202157, 1189.2231639122745, 1192.3263356203718, 12917.483300667867, 13279.336033198302, 13457.461701532025, 13481.393337299845, 13528.120672156278, 250289.0, 250702.0, 252117.0, 252584.0, 252731.0, 51278.74360628173, 51394.0, 51431.485685143416, 51653.48346516562, 51660.0, 1488.977665335021, 1497.2364094312197, 1506.5630967019442, 1508.8566586174295, 1521.5359315408907, 24158.87920560386, 25299.241022769347, 29007.85496072506, 29540.556891647073, 30595.2351191222, 47244.0, 47345.0, 47484.7625761869, 47708.7614561925, 47754.0, 197011.0, 197561.0, 198010.0, 198030.0, 198175.0, 28427.43145137127, 28903.0, 31410.21474463157, 35569.64430355767, 37252.441213382364, 45123.32315015343, 45801.083978320916, 48087.0, 48115.5188448111, 48855.511444885095, 34368.48447273243, 34413.48379774355, 34428.31143377069, 34732.47901281432, 35673.46489802603, 34163.316733665684, 34731.652683473854, 34858.825705871306, 34960.0, 35141.64858351384, 41232.38151427791, 41303.0, 41308.79345603253, 41312.58687413087, 41435.0, 32490.512642310856, 32519.837400812845, 33465.665343346256, 34150.31699365949, 35404.0, 26822.59766103471, 28108.578371324038, 28128.156155314555, 28173.71826281711, 28312.66974841224], "value": 17187.323526117827, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.3888478360727, 434.4352341955457, 437.1082990698975, 460.8041582327511, 462.58367469277647, 18599.256029758828, 19698.803011969892, 20278.29025984091, 20392.184312627476, 20404.591908161845, 21625.134994600197, 22289.108435662554, 22714.77285227147, 22746.090156393766, 22895.313140605766, 5480.177973304007, 5739.655620662753, 5743.081107022877, 5745.683987380692, 5751.827445176651, 5523.088690366085, 5588.748506317225, 5680.204771332017, 5693.743781529841, 5695.0887857942735, 5691.971540142294, 5722.856928576777, 5723.084306510959, 5726.341470730857, 5747.971260143714, 5462.617616766828, 5551.555875529948, 5723.313202415716, 5727.312722473309, 5739.885202295973, 5097.592192624581, 5102.744862756885, 5106.64253502255, 5108.2848401223855, 5112.974435127838, 25110.49779004428, 25187.24438266855, 25782.48435031289, 25852.87073564639, 26004.34989125268, 2106.7577228618597, 2192.243675931801, 2193.3419974007734, 2196.121551379445, 2197.549502352014, 16909.154542272838, 17209.827901721073, 17325.306987720476, 17427.47717568475, 17603.823961760474, 2111.4088055344528, 2192.9561408771897, 2195.6596727507263, 2250.887455627212, 2300.6318988961684, 107593.0, 110230.44884775525, 113848.0, 115929.42035289854, 119001.0, 11998.940005299917, 12479.93760031194, 12787.488500459878, 12841.807372889414, 12851.742965140646, 17612.383566575107, 17612.735808962876, 17770.91114544419, 17775.200115994812, 17776.0, 8206.138355472709, 8388.454750441202, 8413.158684131538, 8435.367347448966, 8586.914130858737, 7537.0, 7570.545767253982, 7702.1912699166905, 7724.266194711493, 7779.260970207822, 7965.840683186304, 8033.638486268132, 8057.234562716532, 8112.0, 8152.959235203904, 2217.837608331896, 2222.333300010023, 2247.8538894971775, 2267.331137314496, 2394.457459004116, 990.8662330585423, 1033.3644808442905, 1036.461040259061, 1039.3867618105355, 1040.089921318846, 19421.0, 20079.49801254951, 20370.79629203689, 20411.0, 20416.285430009877, 1048.7220886465093, 1049.9317544359592, 1049.968500944973, 1053.752368193474, 1077.849101125843, 11045.991854574384, 11188.497861769321, 11245.873188441812, 11269.21115521922, 11324.0, 481154.0, 484591.0, 493116.0, 502265.0, 505098.0, 92534.0, 94962.52518737501, 95247.0, 95723.52138239403, 96079.0, 1173.5364531010202, 1175.8706542280343, 1179.0803173524664, 1188.4354931407513, 1191.8867707567767, 16793.91603041977, 17291.308347666454, 17483.0, 17586.82413175852, 17728.91135544314, 45866.2480251186, 46944.530554694014, 47401.28898066601, 47470.76264618655, 47985.5201447981, 56080.0, 56147.15779263396, 56359.0, 56378.71810640921, 57323.42676573181, 9589.664361747306, 9640.0, 9724.70825875225, 9870.0, 10041.347312424668, 15082.849171508144, 15138.167400792621, 15200.163990980602, 15716.607084822514, 15930.203489825231, 11945.163838531567, 12503.187292825936, 13363.732725345633, 13376.732465350444, 13377.331133443484, 12095.57665481704, 12200.328981906081, 12394.81407778902, 12397.380130993595, 12706.174098683556, 12177.634670959886, 12519.248845069325, 12557.0, 12847.100702950704, 13217.867821322048, 9643.710688679352, 9710.75723106928, 9765.365251258645, 9989.350692204984, 10035.498225088862, 11846.170768046153, 11884.702882427662, 12074.939625301817, 12091.334976576372, 12093.213941094153], "value": 10114.883033716267, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1290.2581015915848, 1317.479595559754, 1324.768165571026, 1331.2411925202632, 1345.4954392102961, 11422.0, 11603.187776855624, 11903.940480297608, 11910.82133767993, 11915.523379064849, 11724.355160466172, 11923.105767067484, 11928.165028448013, 11930.821037684442, 11931.224470409417, 2353.1999120299097, 2376.786089251967, 2384.3681424422457, 2398.568257713611, 2404.1345115758313, 2322.3033090072995, 2364.196173301077, 2375.1212051540956, 2376.4177776444794, 2388.5700573896693, 2178.346496051186, 2183.4323076000196, 2197.7142971413696, 2198.86806791593, 2203.0747086223823, 2234.0505285253867, 2291.862488250702, 2302.2632757517686, 2302.5740238055846, 2303.8502497337618, 1948.4641723526145, 2003.3689387842783, 2237.496563273267, 2265.76209498002, 2292.885355732207, 11165.274257173258, 11214.66356009321, 11246.0, 11251.381174035425, 11252.437378131142, 6274.592151510137, 6457.903131453032, 6488.351164883521, 6503.349665033506, 6511.3488651134985, 3550.928981420357, 3703.185299234191, 3777.2823163598828, 3793.848246070154, 3805.429185622179, 1215.0826126274694, 1244.9875501244962, 1250.0749445410422, 1277.572013375511, 1282.487005197919, 17502.649947000988, 17764.289428422846, 17782.199801008985, 17791.377301794506, 17800.109994500224, 5234.842954711365, 5304.124819404755, 5305.761240744176, 5417.726834193962, 5454.12733962572, 13000.739985200244, 13085.803712944313, 13088.803667944989, 13107.541236056692, 13146.868531314565, 6339.397757213057, 6435.03474478832, 6451.516136289797, 6475.838104047342, 6483.189601299838, 5952.345242023374, 6026.668533230714, 6042.305134909454, 6090.147379366892, 6152.8769424611255, 4222.451081359403, 4316.482022157361, 4317.611414972667, 4342.913141737147, 4360.65114790816, 1170.700522420113, 1207.7644859252362, 1209.0992210803008, 1216.2823933879054, 1217.7990631545695, 787.9054513458307, 807.3299161695778, 824.9917500825035, 832.5504227717086, 852.3096292003497, 5983.222181116427, 6090.23872015998, 6091.573589848668, 6116.3883611638485, 6215.96892015537, 600.8017354273079, 612.650789050246, 619.4208415131866, 622.956393052482, 625.8810825943148, 4207.810648520824, 4338.9566104338555, 4384.6273066789045, 4385.495667998221, 4408.647308215335, 14570.344334504973, 15444.227788610524, 15583.0, 15601.609959751097, 15614.921925390527, 14882.553523394316, 15455.30451129702, 15663.295151718201, 15693.21533923322, 15694.0, 9193.0, 9294.163525282622, 9358.906410935939, 9404.811903761887, 9454.621815127455, 6408.39120283591, 6692.0, 6757.391834734897, 6765.0, 6780.86438271222, 13603.387847547083, 13662.863371366158, 13677.931610341884, 13708.451661933412, 13755.17468951866, 13943.233122178377, 14087.15477071379, 14123.64690882736, 14158.50445234412, 14248.572542823731, 8942.284617230476, 9144.0, 9146.542672866197, 9149.261640288323, 9159.725208243763, 11074.39090850011, 11103.666889993314, 11165.832512512481, 11245.887541124484, 11266.830997535208, 8776.56117194125, 9037.77405564866, 9070.909290907006, 9076.09239076087, 9166.450012999241, 8782.253508451853, 8828.984666763405, 8885.244754195966, 8927.821443570961, 8970.0, 7727.42044346665, 7738.071431428265, 7789.221077892165, 7814.140444551209, 7842.960785196037, 6257.7184026719815, 6263.749450021948, 6281.905771413524, 6454.451371633276, 6462.386073323027, 5838.065909454637, 5884.529237661062, 5895.469407753323, 5910.231669882888, 6042.791441711587], "value": 5255.299410848528, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.16422765850217, 398.87435457830765, 400.4813766172806, 416.04932728714886, 425.8913976935882, 6006.579539432241, 6099.5120390368775, 6101.237345331828, 6139.478144357729, 6150.969245153768, 5919.200907877435, 5957.731902064406, 5971.402859714027, 5981.491573216271, 6024.427679370453, 4558.703684260512, 4561.566651168134, 4573.542645735433, 4575.24508456106, 4577.336286238494, 4526.434195725535, 4544.954550454486, 4569.0, 4585.174668559658, 4588.4723256825555, 4522.547745225467, 4559.974005848674, 4567.2920697291975, 4568.84009059683, 4576.748278844662, 4535.206338890681, 4542.295944128666, 4551.203539380628, 4554.703944243647, 4575.428071491064, 4025.5370632377358, 4202.390653355246, 4328.61042506176, 4373.322135069069, 4386.1008493258805, 5937.664025594207, 5950.8809823803285, 5962.910556341659, 5999.220101386792, 6003.369646187131, 5536.141898005815, 5666.971665141689, 5674.347450043257, 5674.460926212003, 5706.115552089392, 6387.393197646216, 6413.615183088983, 6425.261094974091, 6444.260049786578, 6469.4500967417825, 4894.41267047953, 4926.704397736112, 4936.679115857458, 4938.234573641092, 4970.738314067091, 6730.528862979593, 6755.729770809211, 6762.492813039042, 6770.559913605649, 6786.0499530065335, 5054.82308119214, 5072.340595722532, 5094.388673359221, 5101.642884998015, 5102.642815002989, 5044.284943119357, 5174.715390653475, 5193.870153246124, 5196.246544251062, 5201.569568368654, 5673.716344160132, 5680.375158732536, 5705.771769129188, 5712.942870571241, 5736.913946290809, 6451.387118223761, 6453.741850326029, 6482.12491313676, 6496.35036496356, 6518.478521718251, 1752.4129416645312, 1766.4435702753592, 1775.9112044397987, 1791.7222830461299, 1798.2357498063532, 1276.6489215465822, 1280.7118398360294, 1296.695276609996, 1297.5393735224047, 1310.316243626935, 6096.542759293071, 6098.573099882966, 6101.450869421773, 6132.478739307119, 6176.907346389808, 6460.806175814733, 6535.705893234815, 6558.409743123047, 6576.210854697467, 6579.638119903451, 5887.470127688529, 6002.459778619857, 6054.636721796706, 6054.66699331541, 6097.0, 3470.35798377301, 3472.913177170591, 3484.3728128936527, 3497.772644778132, 3502.0, 6491.253505846888, 6802.387785099365, 6835.965820170867, 6855.794326170223, 6868.484863635247, 6556.573822701509, 6664.86670266592, 6696.43080338167, 6717.0, 6733.797986060426, 6817.352351526696, 6848.6918088686125, 6850.45196384298, 6893.276205998298, 6895.0, 6374.74501019954, 6551.705173267119, 6562.212534495891, 6587.080686991232, 6624.271330153776, 6532.738690452328, 6569.047488114292, 6575.454768129582, 6581.701730107309, 6582.440492558187, 6841.836887728999, 6864.931350686429, 6887.965560172367, 6911.89632155508, 6924.169099708067, 4488.214562451492, 4576.977115114403, 4625.635437545865, 4667.416572928384, 4680.836170734008, 6634.4692424604955, 6636.13730215069, 6650.3682150195655, 6677.2988836173445, 6687.130673012477, 6287.308396076336, 6396.808095757135, 6400.295967443484, 6411.903821442589, 6423.197100362455, 6394.072859435263, 6394.360563943568, 6400.935990640034, 6448.613083215022, 6451.290358060516, 6250.593711408744, 6333.145025421509, 6387.4570661492435, 6422.197225346832, 6459.935400645933, 6368.542020585516, 6444.387783160592, 6458.031295305554, 6484.383983521558, 6488.475208326134, 6092.765338934953, 6200.720967556561, 6213.161223234805, 6235.314115447388, 6289.371062893674], "value": 4960.180364843456, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.2750507058852, 844.733908818722, 851.2891735400943, 860.5138096975209, 863.9524826134564, 16440.260188291526, 17068.317267309307, 17129.914350428247, 20329.0, 21083.894580527074, 19141.138648760803, 19329.226830926782, 19444.125014374353, 19460.12429440675, 19472.0, 970.941743495389, 976.3995142987047, 983.2330781990023, 986.7039888033597, 987.3138168972567, 1001.694483182629, 1008.6721815409984, 1009.8434742614907, 1011.8482227665872, 1014.0923873133542, 1032.9793404131913, 1047.5704960966004, 1048.1562342314435, 1048.3447845096814, 1050.1965996013018, 1033.0444338986445, 1033.9431331276776, 1034.270839058462, 1034.8447732840098, 1034.8965103489666, 761.0562902001534, 763.3206446262831, 763.5800309829627, 766.0424469413233, 772.891795148674, 17340.393086241922, 17432.389866354744, 17642.0, 19156.32952846644, 19305.710414343797, 17327.393541226123, 17703.822961770347, 19221.423357299165, 19527.218911243534, 19654.0, 12736.872631273662, 12762.489500419972, 12804.61586152417, 12820.0, 12830.166039207515, 3416.794992300445, 3433.759636825423, 3460.498227756986, 3473.70473509752, 3491.825408729553, 109869.45065274702, 114891.42554287259, 116617.0, 116826.83173168244, 117605.0, 14645.048071875508, 14973.775393369107, 15122.697546049018, 15127.54617361481, 15199.392024318904, 24266.150684726304, 24795.380115496897, 24993.375165621004, 27342.45315093727, 27435.31411714683, 8227.095019547965, 8422.747317580483, 8436.535990520457, 8462.02686691026, 8462.492250464991, 3928.823202955874, 3961.0, 4026.91946161081, 4048.2915489789757, 4050.513938327361, 4648.604868586141, 4707.0, 4715.03341814934, 4725.10223057618, 4734.857954261378, 872.520113937332, 902.444996327254, 904.3759805734154, 908.123660667459, 908.9045650206765, 661.8874791285493, 683.2279524137792, 692.9896051559231, 693.3967448319893, 695.3706895259797, 12537.811932821014, 12540.937295313648, 12881.35593220354, 12920.806187907188, 13669.248191349572, 676.9966150169217, 686.5331574529368, 689.648289352864, 694.7707256605308, 695.4123765418213, 5359.629117657346, 5385.071473769703, 5533.3083364579425, 5665.9716701417055, 5712.857178570569, 107459.46270268755, 108922.45538772256, 109963.0, 109967.45016275028, 110936.4453177745, 96755.51622241843, 98630.50684746531, 99175.0, 99669.50165249128, 99950.50024749829, 73883.63058184675, 79834.60082699549, 81205.0, 81454.59272703718, 84164.0, 11439.542418303176, 12228.816567751313, 12286.0, 12448.937755311166, 12534.937325313314, 37469.0, 37597.81201093977, 37760.244795104496, 37827.24345513129, 38207.0, 47291.05417891554, 47433.762831185624, 47482.28776568285, 48348.5165148344, 49022.75488622534, 16205.837941620905, 16645.25096370642, 16720.498385048468, 16731.91634041822, 16794.496165115066, 18877.811221887605, 18933.148008339384, 18960.241590336784, 19119.522011949255, 19291.61416771685, 17141.657166856345, 17632.471025869243, 17754.0, 18109.909450452662, 18114.27542898269, 17644.117794109985, 17673.911630441766, 17734.379296724554, 17760.28958841632, 18098.457046288633, 16600.0, 16831.242594083542, 16983.830161698224, 17036.659266814346, 17127.22927468242, 9964.950175249078, 10331.431771252654, 10535.31520451199, 10589.682309530726, 10872.836907446237, 11801.645950621494, 12146.453409596767, 12299.954503867271, 12325.198862073936, 12376.257424554555], "value": 8533.11888162865, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1499.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 110.0, 110.0, 110.0, 110.0, 112.0, 110.0, 110.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 118.0, 117.0, 159.0, 119.0, 118.0, 122.0, 120.0, 143.0, 122.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 163.0, 163.0, 164.0, 167.0, 168.0, 170.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 101.0, 73.0, 74.0, 74.0, 73.0, 97.0, 73.0], "value": 78.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 105.0, 83.0, 82.0, 81.0, 109.0, 81.0, 82.0, 112.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 114.0, 114.0, 113.0, 118.0, 114.0, 113.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 150.0, 149.0, 149.0, 148.0, 148.0, 149.0, 148.0, 149.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 49.0, 48.0, 50.0, 48.0, 48.0, 48.0, 50.0, 49.0, 48.0], "value": 48.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 56.0, 55.0, 55.0, 56.0, 56.0, 56.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 94.0, 84.0, 90.0, 85.0, 86.0, 86.0, 85.0, 138.0, 83.0], "value": 91.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 127.0, 128.0, 126.0, 125.0, 128.0, 125.0, 132.0, 134.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 183.0, 181.0, 181.0, 182.0, 185.0, 181.0, 187.0, 182.0, 174.0], "value": 181.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 65.0, 70.0, 67.0, 63.0, 63.0, 64.0, 66.0], "value": 65.3, "unit": "score"}]}]} 04:13:31 INFO - Return code: 0 04:13:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:13:31 INFO - # TBPL SUCCESS # 04:13:31 INFO - Running post-action listener: _resource_record_post_action 04:13:31 INFO - [mozharness: 2017-05-27 11:13:31.548042Z] Finished run-tests step (success) 04:13:31 INFO - Running post-run listener: _resource_record_post_run 04:13:31 INFO - Total resource usage - Wall time: 1249s; CPU: 13.0%; Read bytes: 4096; Write bytes: 424800256; Read time: 12; Write time: 304756 04:13:31 INFO - TinderboxPrint: CPU usage
12.6% 04:13:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:13:31 INFO - TinderboxPrint: I/O write bytes / time
424,800,256 / 304,756 04:13:31 INFO - TinderboxPrint: CPU idle
8,711.7 (87.4%) 04:13:31 INFO - TinderboxPrint: CPU user
1,202.4 (12.1%) 04:13:31 INFO - TinderboxPrint: Swap in / out
0 / 0 04:13:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103284736; Read time: 0; Write time: 100760 04:13:31 INFO - run-tests - Wall time: 1232s; CPU: 13.0%; Read bytes: 0; Write bytes: 321515520; Read time: 0; Write time: 203996 04:13:32 INFO - Running post-run listener: _upload_blobber_files 04:13:32 INFO - Blob upload gear active. 04:13:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:13:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:13:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:13:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:13:32 INFO - (blobuploader) - INFO - Open directory for files ... 04:13:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:13:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:13:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:33 INFO - (blobuploader) - INFO - Done attempting. 04:13:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:13:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:13:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:34 INFO - (blobuploader) - INFO - Done attempting. 04:13:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:13:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:13:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:34 INFO - (blobuploader) - INFO - Done attempting. 04:13:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:13:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:13:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:41 INFO - (blobuploader) - INFO - Done attempting. 04:13:41 INFO - (blobuploader) - INFO - Iteration through files over. 04:13:41 INFO - Return code: 0 04:13:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:13:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:13:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/261e67e5f00e2ece4e9dfece066bc42ed7e0cc3111e046864e8f5e0e8977b937e7d8389006f6246f85ed800c7d0639d3fd1b7048fca495ef46be5dcb0de67e02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e6b5583d8c233a3cc7ba7abfeb20ad45c0c2b220ce2b4b6f143e59a18ddefc869d95cf18e34dc77bf017ee55a49c5123df86ba96f5f8c9c4de9a0f5ceba2356", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/621d13d5cfd79759cba98cf64c2f465c96220f4553e7dee31521bfaa776a2b0002a25c398808ad6b454f5aa067fb40f0c7af332691faa154b0c0e9814f26c1db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07eefb9ca5b61885ac1b198dbd21d43751f4d94d2b142eb5c4bc4eb54bdbb971d3b0b6daed60c3d272819b86908aefac62d8e3d6e2ebfc934760620db46a8a05"} 04:13:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:13:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:13:41 INFO - Contents: 04:13:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/261e67e5f00e2ece4e9dfece066bc42ed7e0cc3111e046864e8f5e0e8977b937e7d8389006f6246f85ed800c7d0639d3fd1b7048fca495ef46be5dcb0de67e02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e6b5583d8c233a3cc7ba7abfeb20ad45c0c2b220ce2b4b6f143e59a18ddefc869d95cf18e34dc77bf017ee55a49c5123df86ba96f5f8c9c4de9a0f5ceba2356", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/621d13d5cfd79759cba98cf64c2f465c96220f4553e7dee31521bfaa776a2b0002a25c398808ad6b454f5aa067fb40f0c7af332691faa154b0c0e9814f26c1db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07eefb9ca5b61885ac1b198dbd21d43751f4d94d2b142eb5c4bc4eb54bdbb971d3b0b6daed60c3d272819b86908aefac62d8e3d6e2ebfc934760620db46a8a05"} 04:13:41 INFO - Running post-run listener: copy_logs_to_upload_dir 04:13:41 INFO - Copying logs to upload dir... 04:13:41 INFO - mkdir: /builds/slave/test/build/upload/logs 04:13:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1309.425340 ========= master_lag: -0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 49 secs) (at 2017-05-27 04:13:39.138998) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 04:13:39.143310) ========= 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=db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/261e67e5f00e2ece4e9dfece066bc42ed7e0cc3111e046864e8f5e0e8977b937e7d8389006f6246f85ed800c7d0639d3fd1b7048fca495ef46be5dcb0de67e02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e6b5583d8c233a3cc7ba7abfeb20ad45c0c2b220ce2b4b6f143e59a18ddefc869d95cf18e34dc77bf017ee55a49c5123df86ba96f5f8c9c4de9a0f5ceba2356", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/621d13d5cfd79759cba98cf64c2f465c96220f4553e7dee31521bfaa776a2b0002a25c398808ad6b454f5aa067fb40f0c7af332691faa154b0c0e9814f26c1db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07eefb9ca5b61885ac1b198dbd21d43751f4d94d2b142eb5c4bc4eb54bdbb971d3b0b6daed60c3d272819b86908aefac62d8e3d6e2ebfc934760620db46a8a05"} build_url:https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011171 build_url: 'https://queue.taskcluster.net/v1/task/FJoS62EEQEWW5osLeSA_bQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/261e67e5f00e2ece4e9dfece066bc42ed7e0cc3111e046864e8f5e0e8977b937e7d8389006f6246f85ed800c7d0639d3fd1b7048fca495ef46be5dcb0de67e02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6e6b5583d8c233a3cc7ba7abfeb20ad45c0c2b220ce2b4b6f143e59a18ddefc869d95cf18e34dc77bf017ee55a49c5123df86ba96f5f8c9c4de9a0f5ceba2356", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/621d13d5cfd79759cba98cf64c2f465c96220f4553e7dee31521bfaa776a2b0002a25c398808ad6b454f5aa067fb40f0c7af332691faa154b0c0e9814f26c1db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07eefb9ca5b61885ac1b198dbd21d43751f4d94d2b142eb5c4bc4eb54bdbb971d3b0b6daed60c3d272819b86908aefac62d8e3d6e2ebfc934760620db46a8a05"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 04:13:39.167810) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 04:13:39.171189) ========= 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=db7e7c15f3ca076d53731445000001ba-1495857805.951634-1880854016 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 04:13:39.251743) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 04:13:39.255063) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 04:13:39.255379) ========= ========= Total master_lag: 0.03 =========