builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-050 starttime: 1495873968.72 results: success (0) revision: 1c1bf54915bbf8cda82dbf7985e87b1c0ff30e4c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 01:32:48.723023) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 01:32:48.723551) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 01:32:48.723875) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 01:32:48.739854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 01:32:48.740139) ========= 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=6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-27 01:32: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% 45.6M=0s 2017-05-27 01:32:50 (45.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123632 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 01:32:48.876210) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 01:32:48.876509) ========= 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=6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021621 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 01:32:48.929442) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-27 01:32:48.929752) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1c1bf54915bbf8cda82dbf7985e87b1c0ff30e4c --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 1c1bf54915bbf8cda82dbf7985e87b1c0ff30e4c --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=6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-27 01:32:50,794 truncating revision to first 12 chars 2017-05-27 01:32:50,794 Setting DEBUG logging. 2017-05-27 01:32:50,794 attempt 1/10 2017-05-27 01:32:50,794 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1c1bf54915bb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-27 01:32:52,177 unpacking tar archive at: mozilla-central-1c1bf54915bb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.745062 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-27 01:32:50.694087) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 01:32:50.694394) ========= script_repo_revision: 1c1bf54915bbf8cda82dbf7985e87b1c0ff30e4c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 01:32:50.694752) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 01:32:50.695030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 01:32:50.705172) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-05-27 01:32:50.705447) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:32:52 INFO - MultiFileLogger online at 20170527 01:32:52 in /builds/slave/test 01:32:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 01:32:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:32:52 INFO - {'append_to_log': False, 01:32:52 INFO - 'base_work_dir': '/builds/slave/test', 01:32:52 INFO - 'blob_upload_branch': 'Firefox', 01:32:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:32:52 INFO - 'branch': 'Firefox', 01:32:52 INFO - 'buildbot_json_path': 'buildprops.json', 01:32:52 INFO - 'config_files': ('talos/linux_config.py',), 01:32:52 INFO - 'default_actions': ('clobber', 01:32:52 INFO - 'read-buildbot-config', 01:32:52 INFO - 'download-and-extract', 01:32:52 INFO - 'populate-webroot', 01:32:52 INFO - 'create-virtualenv', 01:32:52 INFO - 'install', 01:32:52 INFO - 'run-tests'), 01:32:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:32:52 INFO - 'download_minidump_stackwalk': True, 01:32:52 INFO - 'download_symbols': 'ondemand', 01:32:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:32:52 INFO - 'tooltool.py': '/tools/tooltool.py', 01:32:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:32:52 INFO - '/tools/misc-python/virtualenv.py')}, 01:32:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:32:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:32:52 INFO - 'gecko_profile': False, 01:32:52 INFO - 'gecko_profile_interval': 0, 01:32:52 INFO - 'installer_path': 'installer.exe', 01:32:52 INFO - 'log_level': 'info', 01:32:52 INFO - 'log_name': 'talos', 01:32:52 INFO - 'log_to_console': True, 01:32:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:32:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:32:52 INFO - 'opt_config_files': (), 01:32:52 INFO - 'pip_index': False, 01:32:52 INFO - 'suite': 'dromaeojs-e10s', 01:32:52 INFO - 'system_bits': '32', 01:32:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:32:52 INFO - 'title': 'talos-linux64-ix-050', 01:32:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:32:52 INFO - 'use_talos_json': True, 01:32:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:32:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:32:52 INFO - 'work_dir': 'build'} 01:32:52 INFO - [mozharness: 2017-05-27 08:32:52.651226Z] Running clobber step. 01:32:52 INFO - Running pre-action listener: _resource_record_pre_action 01:32:52 INFO - Running main action method: clobber 01:32:52 INFO - rmtree: /builds/slave/test/build 01:32:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:32:53 INFO - Running post-action listener: _resource_record_post_action 01:32:53 INFO - [mozharness: 2017-05-27 08:32:53.696399Z] Finished clobber step (success) 01:32:53 INFO - [mozharness: 2017-05-27 08:32:53.696499Z] Running read-buildbot-config step. 01:32:53 INFO - Running pre-action listener: _resource_record_pre_action 01:32:53 INFO - Running main action method: read_buildbot_config 01:32:53 INFO - Using buildbot properties: 01:32:53 INFO - { 01:32:53 INFO - "project": "", 01:32:53 INFO - "product": "firefox", 01:32:53 INFO - "who": "archaeopteryx@coole-files.de", 01:32:53 INFO - "installer_path": "public/build/target.tar.bz2", 01:32:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 01:32:53 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 01:32:53 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 01:32:53 INFO - "stage_platform": "linux64-stylo", 01:32:53 INFO - "basedir": "/builds/slave/test", 01:32:53 INFO - "buildnumber": 123, 01:32:53 INFO - "platform": "ubuntu64_hw_stylo", 01:32:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:32:53 INFO - "slavebuilddir": "test", 01:32:53 INFO - "taskId": "OzIP7WAZQH6qWmt6dsuRdA", 01:32:53 INFO - "branch": "mozilla-central", 01:32:53 INFO - "script_repo_revision": "production", 01:32:53 INFO - "revision": "1c1bf54915bbf8cda82dbf7985e87b1c0ff30e4c", 01:32:53 INFO - "slavename": "talos-linux64-ix-050", 01:32:53 INFO - "repo_path": "mozilla-central" 01:32:53 INFO - } 01:32:53 INFO - Finding installer, test and symbols from parent task. 01:32:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OzIP7WAZQH6qWmt6dsuRdA'}, attempt #1 01:32:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OzIP7WAZQH6qWmt6dsuRdA'}, attempt #1 01:32:54 INFO - Task dependencies: OzHpRs25QTOGeaoTcyDY-w 01:32:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w'}, attempt #1 01:32:55 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.tar.bz2 01:32:55 INFO - Set test_url: https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/test_packages.json 01:32:55 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.crashreporter-symbols.zip 01:32:55 INFO - Running post-action listener: _resource_record_post_action 01:32:55 INFO - [mozharness: 2017-05-27 08:32:55.068196Z] Finished read-buildbot-config step (success) 01:32:55 INFO - [mozharness: 2017-05-27 08:32:55.068416Z] Running download-and-extract step. 01:32:55 INFO - Running pre-action listener: _resource_record_pre_action 01:32:55 INFO - Running main action method: download_and_extract 01:32:55 INFO - mkdir: /builds/slave/test/build/tests 01:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:32:55 INFO - trying https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.test_packages.json 01:32:55 INFO - Downloading https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:32:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:32:55 INFO - Downloaded 986 bytes. 01:32:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:32:55 INFO - Using the following test package requirements: 01:32:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 01:32:55 INFO - u'common': [u'target.common.tests.zip'], 01:32:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:32:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:32:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:32:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:32:55 INFO - u'mozbase': [u'target.common.tests.zip'], 01:32:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:32:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:32:55 INFO - u'web-platform': [u'target.common.tests.zip', 01:32:55 INFO - u'target.web-platform.tests.zip'], 01:32:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:32:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:32:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.common.tests.zip 01:32:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:32:55 INFO - Fetch https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.common.tests.zip into memory 01:32:56 INFO - Content-Length response header: 63526719 01:32:56 INFO - Bytes received: 63526719 01:33:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:33:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.common.tests.zip 01:33:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:33:07 INFO - Fetch https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.common.tests.zip into memory 01:33:09 INFO - Content-Length response header: 63526719 01:33:09 INFO - Bytes received: 63526719 01:33:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.talos.tests.zip 01:33:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:33:21 INFO - Fetch https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.talos.tests.zip into memory 01:33:21 INFO - Content-Length response header: 14441221 01:33:21 INFO - Bytes received: 14441221 01:33: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')]} 01:33:22 INFO - trying https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.tar.bz2 01:33:22 INFO - Downloading https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:33:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:33:23 INFO - Downloaded 55753349 bytes. 01:33:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.tar.bz2 01:33:23 INFO - mkdir: /builds/slave/test/properties 01:33:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:33:23 INFO - Writing to file /builds/slave/test/properties/build_url 01:33:23 INFO - Contents: 01:33:23 INFO - build_url:https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.tar.bz2 01:33:23 INFO - Running post-action listener: _resource_record_post_action 01:33:23 INFO - Running post-action listener: set_extra_try_arguments 01:33:23 INFO - [mozharness: 2017-05-27 08:33:23.215575Z] Finished download-and-extract step (success) 01:33:23 INFO - [mozharness: 2017-05-27 08:33:23.215672Z] Running populate-webroot step. 01:33:23 INFO - Running pre-action listener: _resource_record_pre_action 01:33:23 INFO - Running main action method: populate_webroot 01:33:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:33:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:33:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:33:23 INFO - '--tppagecycles', 01:33:23 INFO - '7'], 01:33:23 INFO - 'tests': ['tsvgm']}}, 01:33:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:33:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:33:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:33:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:33:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:33:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:33:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:33:23 INFO - 'talos_options': ['--disable-e10s'], 01:33:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:33:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:33:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:33:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:33:23 INFO - 'talos_options': ['--disable-e10s'], 01:33:23 INFO - 'tests': ['damp', 'tps']}, 01:33:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:33:23 INFO - 'tests': ['damp', 'tps']}, 01:33:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:33:23 INFO - 'tests': ['dromaeo_dom']}, 01:33:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:33:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:33:23 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 01:33:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 01:33:23 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 01:33:23 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 01:33:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:33:23 INFO - 'tests': ['a11yr', 01:33:23 INFO - 'ts_paint', 01:33:23 INFO - 'tpaint', 01:33:23 INFO - 'sessionrestore', 01:33:23 INFO - 'sessionrestore_no_auto_restore', 01:33:23 INFO - 'tabpaint']}, 01:33:23 INFO - 'other-e10s': {'tests': ['a11yr', 01:33:23 INFO - 'ts_paint', 01:33:23 INFO - 'tpaint', 01:33:23 INFO - 'sessionrestore', 01:33:23 INFO - 'sessionrestore_no_auto_restore', 01:33:23 INFO - 'tabpaint']}, 01:33:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:33:23 INFO - 'ts_paint', 01:33:23 INFO - 'tpaint', 01:33:23 INFO - 'sessionrestore', 01:33:23 INFO - 'sessionrestore_no_auto_restore', 01:33:23 INFO - 'tabpaint']}, 01:33:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:33:23 INFO - 'ts_paint', 01:33:23 INFO - 'tpaint', 01:33:23 INFO - 'sessionrestore', 01:33:23 INFO - 'sessionrestore_no_auto_restore', 01:33:23 INFO - 'tabpaint']}, 01:33:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:33:23 INFO - 'tests': ['a11yr', 01:33:23 INFO - 'ts_paint', 01:33:23 INFO - 'tpaint', 01:33:23 INFO - 'sessionrestore', 01:33:23 INFO - 'sessionrestore_no_auto_restore', 01:33:23 INFO - 'tabpaint']}, 01:33:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:33:23 INFO - 'tests': ['a11yr', 01:33:23 INFO - 'ts_paint', 01:33:23 INFO - 'tpaint', 01:33:23 INFO - 'sessionrestore', 01:33:23 INFO - 'sessionrestore_no_auto_restore', 01:33:23 INFO - 'tabpaint']}, 01:33:23 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 01:33:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 01:33:23 INFO - 'bloom_basic_ref']}, 01:33:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:33:23 INFO - 'tests': ['tsvgx', 01:33:23 INFO - 'tsvgr_opacity', 01:33:23 INFO - 'tart', 01:33:23 INFO - 'tscrollx', 01:33:23 INFO - 'cart', 01:33:23 INFO - 'tsvg_static']}, 01:33:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:33:23 INFO - 'tsvgr_opacity', 01:33:23 INFO - 'tart', 01:33:23 INFO - 'tscrollx', 01:33:23 INFO - 'cart', 01:33:23 INFO - 'tsvg_static']}, 01:33:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:33:23 INFO - 'talos_options': ['--disable-e10s'], 01:33:23 INFO - 'tests': ['tp5o']}, 01:33:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:33:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:33:23 INFO - 'talos_options': ['--disable-e10s', 01:33:23 INFO - '--xperf_path', 01:33:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:33:23 INFO - 'tests': ['tp5n']}, 01:33:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:33:23 INFO - 'talos_options': ['--xperf_path', 01:33:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:33:23 INFO - 'tests': ['tp5n']}}, 01:33:23 INFO - 'talos.zip': {'path': '', 01:33:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:33:23 INFO - Running post-action listener: _resource_record_post_action 01:33:23 INFO - [mozharness: 2017-05-27 08:33:23.229604Z] Finished populate-webroot step (success) 01:33:23 INFO - [mozharness: 2017-05-27 08:33:23.229692Z] Running create-virtualenv step. 01:33:23 INFO - Running pre-action listener: _resource_record_pre_action 01:33:23 INFO - Running main action method: create_virtualenv 01:33:23 INFO - Creating virtualenv /builds/slave/test/build/venv 01:33: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 01:33:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:33:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:33:23 INFO - Using real prefix '/usr' 01:33:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:33:23 INFO - Installing distribute.............................................................................................................................................................................................done. 01:33:25 INFO - Installing pip.................done. 01:33:25 INFO - Return code: 0 01:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:33:26 INFO - Reading from file tmpfile_stdout 01:33:26 INFO - Output received: 01:33: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) 01:33:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33: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')]} 01:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33: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 0x1e821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f27a0>, '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 0x21f36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f3b30>, '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': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', '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 01:33: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 01:33: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 01:33:26 INFO - Using env: {'DISPLAY': ':0', 01:33:26 INFO - 'HOME': '/home/cltbld', 01:33:26 INFO - 'LANG': 'en_US.UTF-8', 01:33:26 INFO - 'LANGUAGE': 'en_US:en', 01:33:26 INFO - 'LOGNAME': 'cltbld', 01:33:26 INFO - 'MAIL': '/var/mail/cltbld', 01:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:26 INFO - 'MOZ_NO_REMOTE': '1', 01:33:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:26 INFO - 'NO_EM_RESTART': '1', 01:33:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:26 INFO - 'PWD': '/builds/slave/test', 01:33:26 INFO - 'SHELL': '/bin/bash', 01:33:26 INFO - 'SHLVL': '1', 01:33:26 INFO - 'TERM': 'linux', 01:33:26 INFO - 'TMOUT': '86400', 01:33:26 INFO - 'USER': 'cltbld', 01:33:26 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', 01:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:26 INFO - '_': '/tools/buildbot/bin/python'} 01:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33: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 01:33:26 INFO - Cleaning up... 01:33:26 INFO - Return code: 0 01:33:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33: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')]} 01:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33: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 0x1e821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f27a0>, '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 0x21f36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f3b30>, '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': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', '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 01:33: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 01:33: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 01:33:26 INFO - Using env: {'DISPLAY': ':0', 01:33:26 INFO - 'HOME': '/home/cltbld', 01:33:26 INFO - 'LANG': 'en_US.UTF-8', 01:33:26 INFO - 'LANGUAGE': 'en_US:en', 01:33:26 INFO - 'LOGNAME': 'cltbld', 01:33:26 INFO - 'MAIL': '/var/mail/cltbld', 01:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:26 INFO - 'MOZ_NO_REMOTE': '1', 01:33:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:26 INFO - 'NO_EM_RESTART': '1', 01:33:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:26 INFO - 'PWD': '/builds/slave/test', 01:33:26 INFO - 'SHELL': '/bin/bash', 01:33:26 INFO - 'SHLVL': '1', 01:33:26 INFO - 'TERM': 'linux', 01:33:26 INFO - 'TMOUT': '86400', 01:33:26 INFO - 'USER': 'cltbld', 01:33:26 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', 01:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:26 INFO - '_': '/tools/buildbot/bin/python'} 01:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:26 INFO - Downloading/unpacking psutil>=3.1.1 01:33: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 01:33: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 01:33: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 01:33: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 01:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:33:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:33:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:33:27 INFO - Installing collected packages: psutil 01:33:27 INFO - Running setup.py install for psutil 01:33:27 INFO - building 'psutil._psutil_linux' extension 01:33:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:33:27 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 01:33:27 INFO - building 'psutil._psutil_posix' extension 01:33:27 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 01:33: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 01:33:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:33:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:33:28 INFO - Successfully installed psutil 01:33:28 INFO - Cleaning up... 01:33:28 INFO - Return code: 0 01:33:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33: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')]} 01:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33: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 0x1e821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f27a0>, '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 0x21f36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f3b30>, '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': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', '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 01:33: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 01:33: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 01:33:28 INFO - Using env: {'DISPLAY': ':0', 01:33:28 INFO - 'HOME': '/home/cltbld', 01:33:28 INFO - 'LANG': 'en_US.UTF-8', 01:33:28 INFO - 'LANGUAGE': 'en_US:en', 01:33:28 INFO - 'LOGNAME': 'cltbld', 01:33:28 INFO - 'MAIL': '/var/mail/cltbld', 01:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:28 INFO - 'MOZ_NO_REMOTE': '1', 01:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:28 INFO - 'NO_EM_RESTART': '1', 01:33:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:28 INFO - 'PWD': '/builds/slave/test', 01:33:28 INFO - 'SHELL': '/bin/bash', 01:33:28 INFO - 'SHLVL': '1', 01:33:28 INFO - 'TERM': 'linux', 01:33:28 INFO - 'TMOUT': '86400', 01:33:28 INFO - 'USER': 'cltbld', 01:33:28 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', 01:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:28 INFO - '_': '/tools/buildbot/bin/python'} 01:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:33: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 01:33: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 01:33: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 01:33: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 01:33:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:33:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:33:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:33:29 INFO - Installing collected packages: mozsystemmonitor 01:33:29 INFO - Running setup.py install for mozsystemmonitor 01:33:29 INFO - Successfully installed mozsystemmonitor 01:33:29 INFO - Cleaning up... 01:33:29 INFO - Return code: 0 01:33:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:29 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 0x1e821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f27a0>, '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 0x21f36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f3b30>, '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': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', '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 01:33:29 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 01:33:29 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 01:33:29 INFO - Using env: {'DISPLAY': ':0', 01:33:29 INFO - 'HOME': '/home/cltbld', 01:33:29 INFO - 'LANG': 'en_US.UTF-8', 01:33:29 INFO - 'LANGUAGE': 'en_US:en', 01:33:29 INFO - 'LOGNAME': 'cltbld', 01:33:29 INFO - 'MAIL': '/var/mail/cltbld', 01:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:29 INFO - 'MOZ_NO_REMOTE': '1', 01:33:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:29 INFO - 'NO_EM_RESTART': '1', 01:33:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:29 INFO - 'PWD': '/builds/slave/test', 01:33:29 INFO - 'SHELL': '/bin/bash', 01:33:29 INFO - 'SHLVL': '1', 01:33:29 INFO - 'TERM': 'linux', 01:33:29 INFO - 'TMOUT': '86400', 01:33:29 INFO - 'USER': 'cltbld', 01:33:29 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', 01:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:29 INFO - '_': '/tools/buildbot/bin/python'} 01:33:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:29 INFO - Downloading/unpacking jsonschema==2.5.1 01:33:29 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 01:33:29 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 01:33:29 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 01:33:29 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 01:33:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:33:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:33: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 01:33: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 01:33: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 01:33: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 01:33:31 INFO - Downloading functools32-3.2.3-2.tar.gz 01:33:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:33:31 INFO - warning: no files found matching '*.txt' 01:33:31 INFO - no previously-included directories found matching 'build' 01:33:31 INFO - no previously-included directories found matching 'dist' 01:33:31 INFO - no previously-included directories found matching '.git*' 01:33:31 INFO - Installing collected packages: jsonschema, functools32 01:33:31 INFO - Running setup.py install for functools32 01:33:31 INFO - warning: no files found matching '*.txt' 01:33:31 INFO - no previously-included directories found matching 'build' 01:33:31 INFO - no previously-included directories found matching 'dist' 01:33:31 INFO - no previously-included directories found matching '.git*' 01:33:31 INFO - Successfully installed jsonschema functools32 01:33:31 INFO - Cleaning up... 01:33:31 INFO - Return code: 0 01:33:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33: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')]} 01:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33: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 0x1e821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f27a0>, '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 0x21f36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f3b30>, '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': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', '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 01:33: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 01:33: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 01:33:31 INFO - Using env: {'DISPLAY': ':0', 01:33:31 INFO - 'HOME': '/home/cltbld', 01:33:31 INFO - 'LANG': 'en_US.UTF-8', 01:33:31 INFO - 'LANGUAGE': 'en_US:en', 01:33:31 INFO - 'LOGNAME': 'cltbld', 01:33:31 INFO - 'MAIL': '/var/mail/cltbld', 01:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:31 INFO - 'MOZ_NO_REMOTE': '1', 01:33:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:31 INFO - 'NO_EM_RESTART': '1', 01:33:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:31 INFO - 'PWD': '/builds/slave/test', 01:33:31 INFO - 'SHELL': '/bin/bash', 01:33:31 INFO - 'SHLVL': '1', 01:33:31 INFO - 'TERM': 'linux', 01:33:31 INFO - 'TMOUT': '86400', 01:33:31 INFO - 'USER': 'cltbld', 01:33:31 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', 01:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:31 INFO - '_': '/tools/buildbot/bin/python'} 01:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:33:31 INFO - Cleaning up... 01:33:31 INFO - Return code: 0 01:33:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33: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')]} 01:33:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33: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 0x1e821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f27a0>, '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 0x21f36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f3b30>, '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': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', '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 01:33: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 01:33: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 01:33:31 INFO - Using env: {'DISPLAY': ':0', 01:33:31 INFO - 'HOME': '/home/cltbld', 01:33:31 INFO - 'LANG': 'en_US.UTF-8', 01:33:31 INFO - 'LANGUAGE': 'en_US:en', 01:33:31 INFO - 'LOGNAME': 'cltbld', 01:33:31 INFO - 'MAIL': '/var/mail/cltbld', 01:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:31 INFO - 'MOZ_NO_REMOTE': '1', 01:33:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:31 INFO - 'NO_EM_RESTART': '1', 01:33:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:31 INFO - 'PWD': '/builds/slave/test', 01:33:31 INFO - 'SHELL': '/bin/bash', 01:33:31 INFO - 'SHLVL': '1', 01:33:31 INFO - 'TERM': 'linux', 01:33:31 INFO - 'TMOUT': '86400', 01:33:31 INFO - 'USER': 'cltbld', 01:33:31 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', 01:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:31 INFO - '_': '/tools/buildbot/bin/python'} 01:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:31 INFO - Downloading/unpacking blobuploader==1.2.4 01:33: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 01:33: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 01:33: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 01:33: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 01:33:32 INFO - Downloading blobuploader-1.2.4.tar.gz 01:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:33:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:33: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 01:33: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 01:33: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 01:33: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 01:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:33:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:33: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 01:33: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 01:33: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 01:33: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 01:33:33 INFO - Downloading docopt-0.6.1.tar.gz 01:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:33:33 INFO - Installing collected packages: blobuploader, requests, docopt 01:33:33 INFO - Running setup.py install for blobuploader 01:33:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:33:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:33:33 INFO - Running setup.py install for requests 01:33:33 INFO - Running setup.py install for docopt 01:33:34 INFO - Successfully installed blobuploader requests docopt 01:33:34 INFO - Cleaning up... 01:33:34 INFO - Return code: 0 01:33:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33: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')]} 01:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33: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 0x1e821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f27a0>, '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 0x21f36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f3b30>, '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': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', '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 01:33: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 01:33: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 01:33:34 INFO - Using env: {'DISPLAY': ':0', 01:33:34 INFO - 'HOME': '/home/cltbld', 01:33:34 INFO - 'LANG': 'en_US.UTF-8', 01:33:34 INFO - 'LANGUAGE': 'en_US:en', 01:33:34 INFO - 'LOGNAME': 'cltbld', 01:33:34 INFO - 'MAIL': '/var/mail/cltbld', 01:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:34 INFO - 'MOZ_NO_REMOTE': '1', 01:33:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:34 INFO - 'NO_EM_RESTART': '1', 01:33:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:34 INFO - 'PWD': '/builds/slave/test', 01:33:34 INFO - 'SHELL': '/bin/bash', 01:33:34 INFO - 'SHLVL': '1', 01:33:34 INFO - 'TERM': 'linux', 01:33:34 INFO - 'TMOUT': '86400', 01:33:34 INFO - 'USER': 'cltbld', 01:33:34 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', 01:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:34 INFO - '_': '/tools/buildbot/bin/python'} 01:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:33:34 INFO - Running setup.py (path:/tmp/pip-5Z8Nlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:33:34 INFO - Running setup.py (path:/tmp/pip-vk8SPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:33:34 INFO - Running setup.py (path:/tmp/pip-onNfsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:33:34 INFO - Running setup.py (path:/tmp/pip-vj2uoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:33:34 INFO - Running setup.py (path:/tmp/pip-vs954K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:33:34 INFO - Running setup.py (path:/tmp/pip-ug4sMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:33:34 INFO - Running setup.py (path:/tmp/pip-KsEBoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:33:34 INFO - Running setup.py (path:/tmp/pip-mqqfTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:33:34 INFO - Running setup.py (path:/tmp/pip-knQLev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:33:34 INFO - Running setup.py (path:/tmp/pip-RUlaJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:33:35 INFO - Running setup.py (path:/tmp/pip-vUdqsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:33:35 INFO - Running setup.py (path:/tmp/pip-ldnWRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:33:35 INFO - Running setup.py (path:/tmp/pip-UgdyWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:33:35 INFO - Running setup.py (path:/tmp/pip-qt928x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:33:35 INFO - Running setup.py (path:/tmp/pip-4NIgp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:33:35 INFO - Running setup.py (path:/tmp/pip-wHiKxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:33:35 INFO - Running setup.py (path:/tmp/pip-PHexKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:33:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:33:35 INFO - Running setup.py install for manifestparser 01:33:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:33:35 INFO - Running setup.py install for mozcrash 01:33:35 INFO - Running setup.py install for mozdebug 01:33:35 INFO - Running setup.py install for mozdevice 01:33:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:33:35 INFO - Running setup.py install for mozfile 01:33:36 INFO - Running setup.py install for mozhttpd 01:33:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:33:36 INFO - Running setup.py install for mozinfo 01:33:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:33:36 INFO - Running setup.py install for mozInstall 01:33:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:33:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:33:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:33:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:33:36 INFO - Running setup.py install for mozleak 01:33:36 INFO - Running setup.py install for mozlog 01:33:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:33:36 INFO - Running setup.py install for moznetwork 01:33:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:33:36 INFO - Running setup.py install for mozprocess 01:33:36 INFO - Running setup.py install for mozprofile 01:33:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:33:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:33:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:33:36 INFO - Running setup.py install for mozrunner 01:33:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:33:36 INFO - Running setup.py install for mozscreenshot 01:33:37 INFO - Running setup.py install for moztest 01:33:37 INFO - Running setup.py install for mozversion 01:33:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:33:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:33:37 INFO - Cleaning up... 01:33:37 INFO - Return code: 0 01:33:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33: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')]} 01:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33: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 0x1e821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f27a0>, '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 0x21f36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f3b30>, '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': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', '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 01:33: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 01:33: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 01:33:37 INFO - Using env: {'DISPLAY': ':0', 01:33:37 INFO - 'HOME': '/home/cltbld', 01:33:37 INFO - 'LANG': 'en_US.UTF-8', 01:33:37 INFO - 'LANGUAGE': 'en_US:en', 01:33:37 INFO - 'LOGNAME': 'cltbld', 01:33:37 INFO - 'MAIL': '/var/mail/cltbld', 01:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:37 INFO - 'MOZ_NO_REMOTE': '1', 01:33:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:37 INFO - 'NO_EM_RESTART': '1', 01:33:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:37 INFO - 'PWD': '/builds/slave/test', 01:33:37 INFO - 'SHELL': '/bin/bash', 01:33:37 INFO - 'SHLVL': '1', 01:33:37 INFO - 'TERM': 'linux', 01:33:37 INFO - 'TMOUT': '86400', 01:33:37 INFO - 'USER': 'cltbld', 01:33:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', 01:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:37 INFO - '_': '/tools/buildbot/bin/python'} 01:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:33:37 INFO - Running setup.py (path:/tmp/pip-Sf8VB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:33: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)) 01:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:33:37 INFO - Running setup.py (path:/tmp/pip-xjSk68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:33:37 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)) 01:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:33:37 INFO - Running setup.py (path:/tmp/pip-jrrY6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:33:37 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)) 01:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:33:37 INFO - Running setup.py (path:/tmp/pip-iVkAJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:33:37 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)) 01:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:33:37 INFO - Running setup.py (path:/tmp/pip-mhSHuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:33:37 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)) 01:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:33:37 INFO - Running setup.py (path:/tmp/pip-b87258-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:33:37 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)) 01:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:33:37 INFO - Running setup.py (path:/tmp/pip-buJAee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:33: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)) 01:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:33:38 INFO - Running setup.py (path:/tmp/pip-EOoG7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:33: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)) 01:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:33:38 INFO - Running setup.py (path:/tmp/pip-07V5y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:33: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)) 01:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:33:38 INFO - Running setup.py (path:/tmp/pip-YDfOWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:33: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)) 01:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:33:38 INFO - Running setup.py (path:/tmp/pip-_RmFoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:33: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)) 01:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:33:38 INFO - Running setup.py (path:/tmp/pip-oNL8xK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:33: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)) 01:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:33:38 INFO - Running setup.py (path:/tmp/pip-2l1lOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:33: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)) 01:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:33:38 INFO - Running setup.py (path:/tmp/pip-J2aCPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:33: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)) 01:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:33:38 INFO - Running setup.py (path:/tmp/pip-r1p6GP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:33: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)) 01:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:33:38 INFO - Running setup.py (path:/tmp/pip-SaJPSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:33:38 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)) 01:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:33:38 INFO - Running setup.py (path:/tmp/pip-hrhW0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:33:38 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)) 01:33:38 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)) 01:33:38 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)) 01:33:38 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)) 01:33:38 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)) 01:33:38 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)) 01:33:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:33:38 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 01:33:38 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 01:33:38 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 01:33:38 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 01:33:39 INFO - Downloading blessings-1.6.tar.gz 01:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:33:39 INFO - Installing collected packages: blessings 01:33:39 INFO - Running setup.py install for blessings 01:33:40 INFO - Successfully installed blessings 01:33:40 INFO - Cleaning up... 01:33:40 INFO - Return code: 0 01:33:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:33:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:33:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:33:40 INFO - Reading from file tmpfile_stdout 01:33:40 INFO - Current package versions: 01:33:40 INFO - argparse == 1.2.1 01:33:40 INFO - blessings == 1.6 01:33:40 INFO - blobuploader == 1.2.4 01:33:40 INFO - docopt == 0.6.1 01:33:40 INFO - functools32 == 3.2.3-2 01:33:40 INFO - jsonschema == 2.5.1 01:33:40 INFO - manifestparser == 1.1 01:33:40 INFO - mozInstall == 1.12 01:33:40 INFO - mozcrash == 1.0 01:33:40 INFO - mozdebug == 0.1 01:33:40 INFO - mozdevice == 0.51 01:33:40 INFO - mozfile == 1.2 01:33:40 INFO - mozhttpd == 0.7 01:33:40 INFO - mozinfo == 0.9 01:33:40 INFO - mozleak == 0.1 01:33:40 INFO - mozlog == 3.4 01:33:40 INFO - moznetwork == 0.27 01:33:40 INFO - mozprocess == 0.25 01:33:40 INFO - mozprofile == 0.28 01:33:40 INFO - mozrunner == 6.13 01:33:40 INFO - mozscreenshot == 0.1 01:33:40 INFO - mozsystemmonitor == 0.3 01:33:40 INFO - moztest == 0.8 01:33:40 INFO - mozversion == 1.4 01:33:40 INFO - psutil == 3.1.1 01:33:40 INFO - requests == 1.2.3 01:33:40 INFO - wsgiref == 0.1.2 01:33:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:33: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')]} 01:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33: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')]} 01:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33: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 0x1e821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f27a0>, '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 0x21f36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f3b30>, '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': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', '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 01:33: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 01:33: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 01:33:40 INFO - Using env: {'DISPLAY': ':0', 01:33:40 INFO - 'HOME': '/home/cltbld', 01:33:40 INFO - 'LANG': 'en_US.UTF-8', 01:33:40 INFO - 'LANGUAGE': 'en_US:en', 01:33:40 INFO - 'LOGNAME': 'cltbld', 01:33:40 INFO - 'MAIL': '/var/mail/cltbld', 01:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:40 INFO - 'MOZ_NO_REMOTE': '1', 01:33:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:40 INFO - 'NO_EM_RESTART': '1', 01:33:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:40 INFO - 'PWD': '/builds/slave/test', 01:33:40 INFO - 'SHELL': '/bin/bash', 01:33:40 INFO - 'SHLVL': '1', 01:33:40 INFO - 'TERM': 'linux', 01:33:40 INFO - 'TMOUT': '86400', 01:33:40 INFO - 'USER': 'cltbld', 01:33:40 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', 01:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:40 INFO - '_': '/tools/buildbot/bin/python'} 01:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33: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)) 01:33: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)) 01:33: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)) 01:33: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)) 01:33: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)) 01:33: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)) 01:33: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)) 01:33: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)) 01:33: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)) 01:33:40 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 01:33: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 01:33: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 01:33: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 01:33: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 01:33:41 INFO - Downloading marionette_driver-1.4.0.tar.gz 01:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 01:33: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)) 01:33: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)) 01:33: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)) 01:33: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)) 01:33:41 INFO - Installing collected packages: marionette-driver 01:33:41 INFO - Running setup.py install for marionette-driver 01:33:41 INFO - Successfully installed marionette-driver 01:33:41 INFO - Cleaning up... 01:33:41 INFO - Return code: 0 01:33:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x204fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f27a0>, '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 0x21f36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f3b30>, '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': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', '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 01:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:33:41 INFO - Using env: {'DISPLAY': ':0', 01:33:41 INFO - 'HOME': '/home/cltbld', 01:33:41 INFO - 'LANG': 'en_US.UTF-8', 01:33:41 INFO - 'LANGUAGE': 'en_US:en', 01:33:41 INFO - 'LOGNAME': 'cltbld', 01:33:41 INFO - 'MAIL': '/var/mail/cltbld', 01:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:41 INFO - 'MOZ_NO_REMOTE': '1', 01:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:41 INFO - 'NO_EM_RESTART': '1', 01:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:41 INFO - 'PWD': '/builds/slave/test', 01:33:41 INFO - 'SHELL': '/bin/bash', 01:33:41 INFO - 'SHLVL': '1', 01:33:41 INFO - 'TERM': 'linux', 01:33:41 INFO - 'TMOUT': '86400', 01:33:41 INFO - 'USER': 'cltbld', 01:33:41 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', 01:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:41 INFO - '_': '/tools/buildbot/bin/python'} 01:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:33:42 INFO - Cleaning up... 01:33:42 INFO - Return code: 0 01:33:42 INFO - Running post-action listener: _resource_record_post_action 01:33:42 INFO - Running post-action listener: _start_resource_monitoring 01:33:42 INFO - Starting resource monitoring. 01:33:42 INFO - [mozharness: 2017-05-27 08:33:42.095360Z] Finished create-virtualenv step (success) 01:33:42 INFO - [mozharness: 2017-05-27 08:33:42.095824Z] Running install step. 01:33:42 INFO - Running pre-action listener: _resource_record_pre_action 01:33:42 INFO - Running main action method: install 01:33:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:33:42 INFO - Reading from file tmpfile_stdout 01:33:42 INFO - Detecting whether we're running mozinstall >=1.0... 01:33:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:33:42 INFO - Reading from file tmpfile_stdout 01:33:42 INFO - Output received: 01:33:42 INFO - Usage: mozinstall [options] installer 01:33:42 INFO - Options: 01:33:42 INFO - -h, --help show this help message and exit 01:33:42 INFO - -d DEST, --destination=DEST 01:33:42 INFO - Directory to install application into. [default: 01:33:42 INFO - "/builds/slave/test"] 01:33:42 INFO - --app=APP Application being installed. [default: firefox] 01:33:42 INFO - mkdir: /builds/slave/test/build/application 01:33: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'] 01:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:33:58 INFO - Reading from file tmpfile_stdout 01:33:58 INFO - Output received: 01:33:58 INFO - /builds/slave/test/build/application/firefox/firefox 01:33:58 INFO - Running post-action listener: _resource_record_post_action 01:33:58 INFO - [mozharness: 2017-05-27 08:33:58.437858Z] Finished install step (success) 01:33:58 INFO - [mozharness: 2017-05-27 08:33:58.438142Z] Running run-tests step. 01:33:58 INFO - Running pre-action listener: _resource_record_pre_action 01:33:58 INFO - Running main action method: run_tests 01:33:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:33:58 INFO - Python 2.7.3 01:33:58 INFO - Return code: 0 01:33:58 INFO - grabbing minidump binary from tooltool 01:33:58 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')]} 01:33:58 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 0x21f27a0>, '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 0x21f36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f3b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:33:58 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 01:33:58 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 01:33:58 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 01:33:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:33:58 INFO - Return code: 0 01:33:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:33:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:33:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:33:58 INFO - ENV: RUST_BACKTRACE is now 1 01:33:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:33:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:33:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 01:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 01:33:58 INFO - Using env: {'DISPLAY': ':0', 01:33:58 INFO - 'HOME': '/home/cltbld', 01:33:58 INFO - 'LANG': 'en_US.UTF-8', 01:33:58 INFO - 'LANGUAGE': 'en_US:en', 01:33:58 INFO - 'LOGNAME': 'cltbld', 01:33:58 INFO - 'MAIL': '/var/mail/cltbld', 01:33:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:33:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:58 INFO - 'MOZ_NO_REMOTE': '1', 01:33:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:33:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:58 INFO - 'NO_EM_RESTART': '1', 01:33:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:58 INFO - 'PWD': '/builds/slave/test', 01:33:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:33:58 INFO - 'RUST_BACKTRACE': '1', 01:33:58 INFO - 'SHELL': '/bin/bash', 01:33:58 INFO - 'SHLVL': '1', 01:33:58 INFO - 'TERM': 'linux', 01:33:58 INFO - 'TMOUT': '86400', 01:33:58 INFO - 'USER': 'cltbld', 01:33:58 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444', 01:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:58 INFO - '_': '/tools/buildbot/bin/python'} 01:33:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 01:33:58 INFO - mozversion application_buildid: 20170527075057 01:33:58 INFO - mozversion application_changeset: 1c1bf54915bbf8cda82dbf7985e87b1c0ff30e4c 01:33:58 INFO - mozversion application_display_name: Nightly 01:33:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:33:58 INFO - mozversion application_name: Firefox 01:33:58 INFO - mozversion application_remotingname: firefox 01:33:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:33:58 INFO - mozversion application_vendor: Mozilla 01:33:58 INFO - mozversion application_version: 55.0a1 01:33:58 INFO - mozversion platform_buildid: 20170527075057 01:33:58 INFO - mozversion platform_changeset: 1c1bf54915bbf8cda82dbf7985e87b1c0ff30e4c 01:33:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:33:58 INFO - mozversion platform_version: 55.0a1 01:33:58 INFO - using testdate: 1495874038 01:33:58 INFO - actual date: 1495874038 01:33:58 INFO - starting webserver on 'localhost:42379' 01:33:58 INFO - SUITE-START | Running 2 tests 01:33:58 INFO - TEST-START | dromaeo_css 01:33:58 INFO - operating with platform_type : linux_ 01:33:58 INFO - Initialising browser for dromaeo_css test... 01:33:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42379/getInfo.html -profile /tmp/tmpLyCWqo/profile 01:33:58 INFO - TEST-INFO | started process 2060 (/builds/slave/test/build/application/firefox/firefox http://localhost:42379/getInfo.html) 01:34:33 INFO - TEST-INFO | 2060: killed by SIGTERM 01:34:33 INFO - Browser initialized. 01:34:33 INFO - Running cycle 1/1 for dromaeo_css test... 01:34:33 INFO - TEST-INFO | started process 2282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLyCWqo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:34:45 INFO - PID 2282 | RSS: Main: 172273664 01:34:45 INFO - PID 2282 | 01:37:50 INFO - PID 2282 | Cycle 1(1): loaded http://localhost:42379/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42379/tests/dromaeo/cssquery-ext.html) 01:37:52 INFO - PID 2282 | RSS: Main: 172052480 01:37:52 INFO - PID 2282 | 01:40:54 INFO - PID 2282 | Cycle 1(1): loaded http://localhost:42379/tests/dromaeo/cssquery-ext.html (next: http://localhost:42379/tests/dromaeo/cssquery-jquery.html) 01:40:55 INFO - PID 2282 | RSS: Main: 176930816 01:40:55 INFO - PID 2282 | 01:43:57 INFO - PID 2282 | Cycle 1(1): loaded http://localhost:42379/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42379/tests/dromaeo/cssquery-mootools.html) 01:43:57 INFO - PID 2282 | RSS: Main: 174272512 01:43:57 INFO - PID 2282 | 01:46:59 INFO - PID 2282 | Cycle 1(1): loaded http://localhost:42379/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42379/tests/dromaeo/cssquery-prototype.html) 01:47:00 INFO - PID 2282 | RSS: Main: 179187712 01:47:00 INFO - PID 2282 | 01:50:03 INFO - PID 2282 | Cycle 1(1): loaded http://localhost:42379/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42379/tests/dromaeo/cssquery-yui.html) 01:50:03 INFO - PID 2282 | RSS: Main: 177889280 01:50:03 INFO - PID 2282 | 01:53:05 INFO - PID 2282 | Cycle 1(1): loaded http://localhost:42379/tests/dromaeo/cssquery-yui.html (next: http://localhost:42379/tests/dromaeo/cssquery-dojo.html) 01:53:05 INFO - PID 2282 | RSS: Main: 175718400 01:53:05 INFO - PID 2282 | 01:53:05 INFO - PID 2282 | __start_tp_report 01:53:05 INFO - PID 2282 | _x_x_mozilla_page_load 01:53:05 INFO - PID 2282 | _x_x_mozilla_page_load_details 01:53:05 INFO - PID 2282 | |i|pagename|runs| 01:53:05 INFO - PID 2282 | |0;dojo.html;2755.8484283364432;2757.4347258811945;2762.585612158176;2789.483945470088;2797.062983900392;5326.573874090073;5342.759575819087;5388.488093631104;5394.622376433646;5420.4850539198815;5355.946440535594;5358.223057656647;5406.756695948682;5445.019896418643;5493.945060549393;4455.799489022986;4698.096452366662;4746.738929358884;4787.54518320759;4799.112164249625;4800.591949684281;4840.467548569654;4865.781039853215;4893.730844803535;4894.8286809961655;4754.072955773626;4785.976070119662;4794.304825800275;4795.400574928134;4798.376211092535;4839.467658557556;4840.806367745286;4870.196417591093;4875.000624871928;4887.144749668793;4793.544613261734;4816.927746083811;4830.637702172316;4837.540433658832;4868.440129385095;5279.472052794728;5355.571554275688;5426.75579598919;5428.37573679028;5472.753726082336;5815.82552523425;5838.474537291621;5852.502537284336;5860.238169038041;5892.528597712173;5889.970550147222;5916.940830591682;5917.053271476543;5918.2898052234;5931.822045338604;5452.809151679712;5474.452554744574;5475.6440831345835;5478.123500239943;5486.31421072366;5820.068788993741;5912.3496415394275;5963.373845746221;6036.2756469223095;6077.3314935357075;5619.93221287954;5625.943740562624;5629.802956896489;5631.7747290108755;5658.971705141448;5702.344230413555;5714.342850572154;5715.885682286331;5721.056025755704;5752.165935939349;5675.517581005578;5691.8292451226525;5747.48272655463;5760.9918264304415;5764.308283005982;5756.366799652035;5795.420457954171;5798.971005145032;5813.418658134153;5822.621529600562;4801.591864691541;4808.206645903387;4810.7113573185725;4811.422629284508;4847.394075740533;4048.8785336439955;4125.401816736557;4129.545749967501;4133.6693064554765;4156.56356082613;4874.122657921537;4912.1158191525155;4936.679115857458;4960.652754307236;4968.701877887338;5898.174255604219;5923.289205295392;5933.970330148408;5936.762529498858;5937.673427961504;4941.258811178352;4956.182229932021;4960.809405742596;4962.280469331927;4989.401271847401;5057.519535644108;5131.7434128293435;5156.226566015128;5159.071367153873;5166.819161329336;5427.782888684566;5429.321334833146;5436.673799572039;5476.890462190813;5489.231507589021;5662.433756624469;5731.8853622928145;5741.74162162712;5747.971260143672;5753.482186603226;5451.918221226605;5476.09644408684;5477.67133971963;5486.643368181056;5488.9725551373585;5664.603477756682;5835.241418615723;5836.066229403275;5837.67892765902;5839.532837373085;5792.189093526826;5845.444682755132;5855.824325270249;5856.121581762599;5954.553408494467;5582.218489411404;5599.412061733622;5620.213170156263;5620.550355971594;5631.436856314336;5520.227168196536;5573.191887176417;5576.972115139399;5578.386377498553;5602.327720673382;5443.8094666686475;5473.0695781718;5528.308961379827;5537.169424586184;5539.169124631338;5694.971525142348;5702.030654788613;5712.571557133315;5781.103928891029;5784.479396854304;5506.421825708243;5509.47659972302;5509.807156749494;5514.062609356339;5566.304211973504 01:53:05 INFO - PID 2282 | |1;ext.html;645.6287634610101;705.7741522712731;724.847781965787;1213.9575114870975;1263.7725209462294;34259.31481370371;35023.824880875625;35096.2980740385;35099.298014039705;35131.82434087826;34297.82851085741;34299.31401371977;34566;34602;34735.65264347362;6445.129907462491;6558.344165583428;6652.434543063845;6771.8984215236815;6784.3554862288;6839.692213850389;6943.479239057066;6954.16550013999;6954.23503414624;6955.165380154389;6925.619090949996;6969.128858892638;6979.127609048869;6997.055397521346;7003.404710599605;6941.930580694179;6955.930440695579;6975.546589471668;6985.371316581482;6993.230744618088;6826.317368263183;6845.5550389224545;6849.965750171267;6866.862662746717;6874.828129296758;31968.840155799306;32022.839885800655;32115.678843211503;32170.678293217003;32185;2955.4089182163652;2980.9403811923858;2982.0457453614854;2982.1948074019892;2989.7159769821833;23663.526729465488;23791.167309144097;23842.40393990147;23851.284461466184;23889.163879264142;2994.655614604305;3058.388322335542;3058.4036112957983;3105.0374383941053;3121.4693502104697;142873;143098;144158;151736.2413187927;156327.99999999886;40551.59448405478;40555.59444405577;40605.18789624191;40752.1849563013;40844;41845.58154418478;41972;42024.57975420207;42090.57909420928;43787.34318985218;12696;12731.363431828371;12760.361981901053;12809;12834.80747788784;10089.09198172168;10138.645147419806;10206.795864082826;10222.846657300146;10393.896061039444;12689.682757931125;12908.935455322664;12978.740425191443;13004.089713719948;13069.477220911247;5254.632175747737;5305.151175811851;5326.760295786621;5356.223347614652;5376.8118115865755;848.6902280667512;894.5706061090713;898.0794685447469;909.2226146644524;930.1396208507103;20926.895365523076;21645.13419463204;21654.891725541587;21743.130274788833;22014.559708805733;977.4428575711776;978.1929907826072;980.9117179453883;994.3337963564429;1000.3897622450299;11167.274127181707;11183.440827958731;11383.373914434786;11407.885921140682;11500.94249528747;180064;181204;181236;181634.09182954;181840;40456.39315410271;40508.59491405107;40710;40808.183836323704;40842.38736418956;1189.4290740444635;1250.3498180945858;1252.1673087396962;1253.5612535612645;1255.3660401497368;20462.693059604415;20794.688079678515;21263.574728505653;21460.785392145877;21591.352259432242;30375.544366834074;35356;36761.81619091887;36870.26259474849;37197.25605487929;160365;160733;162450;162560;163411;28915.13254602365;29960;30444.543331850484;30511;30593.08220753381;35937;36752.26495470129;37015.81492092522;37081.443778343884;37737.62262377341;27255.182344529694;27372.315692107855;27457.862710687117;28610;28611;27578;27820;28261.293467663472;28476.43047139087;29433.411331773674;30968.535471967487;31183;31277.84361078271;31371.843140785062;31407;26643.600345994437;26951.595726063733;27815.44369112566;28153.57769633498;28330.2917427066;21109.89445052765;22308.66537001914;22418;22482.437939051;22546.323610291718 01:53:05 INFO - PID 2282 | |2;jquery.html;413.2994574196738;413.77862843378796;434.51551520055136;434.89997300620854;437.3680032353251;13274.867251327483;17236.48290551284;17822.376216832414;17890.91054544727;17904.37334693286;16047.839521604781;16057.759133612975;16235.107069111195;16501.83498165018;16675.332986680518;5383.246345511631;5558.638688485255;5563.666180029191;5584.91622625661;5587.608867379285;5290.55030322423;5437.184422336662;5464.808731694391;5481.424450432707;5494.642848214853;5434.456554344573;5448.863778405532;5458.099413596752;5467.781288748445;5484.369297530775;5215.817446389377;5370.113931201347;5379.354477462691;5382.4886635769535;5394.379646340682;4850.587700045465;4872.9512704873205;4872.975635121802;4873.853784386474;4898.461169271377;21339;21343.573128537344;21476.248331308485;21542.461438464008;21570.460738481663;1630.4700972184087;1665.4254282272595;1669.1320513332998;1670.1315316035593;1671.3314674130324;13816.447342106303;13967.511137110152;14196.077254978496;14228.502002429968;14236.644083897882;1982.2566537548419;2021.929232476871;2033.1257559249516;2044.182327069184;2052.7639321478073;90890;91459;93084;94179.52910235473;95244.76153811537;10549.736256593493;10720.195985300978;11088.971842476147;11132.888671113185;11204.719882003015;15406.768898466533;15427.922860385626;15446.227688615525;15448.38206471751;15555.844441555666;6998.230194678581;7250.746223882139;7617.923820761722;7881;7913.643886025143;7143.678534465961;7159.57042577447;7232.132144142736;7477.663505142282;7491.55050696949;6891.965540172267;6904.723811047602;6960.269171736996;7101.467389945775;7113.5376200547835;1925.459632294187;1926.9710954335696;1947.3476385410763;1952.7461430014291;2125.3836387447777;842.688205364007;872.8559787634969;875.9781005474914;876.68001179569;908.6728777640044;16899.66200676004;17173.656526869392;17198.828011719972;17241.827581724272;17971.101444927703;890.8351954888367;896.2426749396749;898.6001229452961;902.1700035966926;923.3951761596165;9162.22121119699;9418.717438476857;9563.952180239054;9603.519824008772;9640.566174522164;357172;373604;373613;375189;378656;74185.62907185538;74859.62570187222;77419;78302.60848695721;78944;1057.2176589323844;1065.1798115451058;1085.451846817368;1087.6628245243999;1095.424901926479;14329.140251584522;14546.709065818835;14597.270136493345;14701.779473308123;15143.469978550698;35385.82307088551;35429.82285088558;36549.26901462009;36770.63229367672;36904.44643330406;47595.524044759106;50841.745791270805;51326.48673513217;51656.96686066333;51855.22217166821;7957.403194760532;8036.4776289541;8155.469894456842;8382.371322150984;8507.78730531717;11373.14701397382;11565.59520416815;11779.116566257737;11931.926126648643;12994.350282486026;10418.947905260426;10643.361398316125;10658.89341106579;10766.407847568458;11038.392888391216;7961.8407631848195;8719.869201962103;8853;9544.665936692183;9552.85670714926;9952.701418957442;10105;10233.590656373663;10479.895201047892;11227.607033753779;8177.918220817715;8233.876491852747;8272.462289951134;8317.584120794058;8338.124496927978;10416.32293900894;10507.684769456928;10786.137109031102;10809.56761729522;11200 01:53:05 INFO - PID 2282 | |3;mootools.html;1250.431053870489;1288.2721262486693;1288.6456224538256;1293.473701032781;1306.3729409883258;10279.434631095286;10653.893461065387;10827.512761925713;10831;10928.617498387557;10556.524956376963;10725.731856703567;10744.462776861144;10753.247272690915;10778.676639700801;2052.8152466278034;2096.297740257016;2100.9264675736354;2103;2109.219588752164;1886.377495426506;1939.1758502636394;1945.22191123551;1958.5201625601746;1962.3916585858358;2005.0977060322841;2006.9197232110698;2049.9237900102416;2065.213590244443;2067.855250132491;2030.3198428526462;2042.9387118386398;2046.7441569803848;2051.866628669132;2055.6813693877475;1929.5851391950657;1954.6872500399868;1966.2135145941595;1974.1511150205406;2025.706272590481;10232.13026892715;10428.374297542172;10435.478226088666;10436.739081522946;10451.52968116429;5432;5570.387257401682;5614.606977511576;5634.71826408682;5655.095184770417;3168.3821654777325;3266.248762784573;3338.732901367909;3340.6659334066644;3350.7654464187517;1027.1166796554958;1053.7892421515728;1080.2762149359949;1102.6195962392962;1122.0518661730825;15413.922930385388;15608.687826243526;15688.921555392264;15756.369745210179;15816.130112843904;4651.232546629836;4779.880502987453;4872.367756801511;4872.6589138760655;4909.214525675875;13143.079984401;13180.143290686075;13191.142575732547;13195.60413187606;13241.536546221028;5575.860603484864;5684.914726279109;5688.089905615082;5692.629979051431;5707.200991861143;4974.801007959641;5113.846584602468;5123.077845987684;5126.7180305083575;5147.742612869341;3779.6976241900584;3803.448499967489;3847.788371639587;3861.015441062511;3908.511436070491;1074.8602681651334;1078.3637653784306;1085.3813326404031;1092.6885837536263;1098.752780624369;684.1448189762797;707.564847618721;710.3677726823131;718.0772707071493;720.9819754506075;5495;5556.055470570012;5584.97207513968;5603.691796951207;5652.208690783294;490.2132078014806;504.71483611759237;508.38485432626936;511.4195388234381;511.93600799900014;3422.2984288220855;3882.320593896057;3885.514310711161;3940.113474468279;4042.757434553936;13520.93239533796;13687.657808554666;13996.930015350063;14049.71900561983;14075.085119467201;13644;13766.518171863936;13787.793183102262;13905.652358690912;13912.652183695489;7260.564366138048;7569.697212111564;7576.28025337592;7609.239076092346;7620.542767433972;6022.66875321844;6189.412005859436;6236.407541283571;6236.501079913687;6253.687315634291;12392.380380980734;12592.622221333375;12635.747285054063;12700.87299126997;12723.300218487702;12501.687457813627;12778.169418987736;12809.61571152867;12958.092933494565;13029.08796384282;8435.83128337442;8670.132986701532;8682.52246126469;8685.088065753005;8685.739427817176;9800.11798938099;9923.851142232728;9924.354916930377;9942.453165075991;9944.906060333213;8051.51690898548;8176.550289734122;8507.617157227816;8564;8587;7688.384929205762;7708.768736937901;7727.574983375968;7749.380049596131;7794.454388192772;6965.199002114821;7051.541649792747;7109.60897150641;7139.107611548557;7145.678444469907;4648.651351148745;5036.773345199548;5147.6139289554185;5153.201253805666;5172.120739474223;5133.332666753298;5166.715830629351;5227.006868694936;5275.446078161891;5331.920021199608 01:53:05 INFO - PID 2282 | |4;prototype.html;335.92945481448896;340.3499316305856;343.9759216854821;346.13811609093364;349.8600559776089;5662.122371032491;5690.4594063563945;5696.515796157331;5699.857503562413;5713.342965558962;5541.667499950006;5541.695206763627;5548.667079975205;5563.666180029201;5564.8052318168875;3976.661983731379;4077.9184416311655;4096.30003548527;4126.514454796286;4143.875683729493;4113.429106808245;4126.9793651031705;4132.648724858375;4133.379993001059;4140.834366625331;4064.2887494688457;4072.5112986441522;4075.6331930126285;4084.530279017921;4085.1829634073156;4015.658669013152;4049.635532802062;4057;4081.3265811141127;4097.201045796071;3535.6641119093647;3545.8758943436856;3551.987683510213;3562.1806984393734;3562.964370356315;5361.0618141825025;5365.812196573102;5370.3287089113865;5376.435474275223;5377.677339359651;4691.061787642451;4763.3569468121705;4783.7129772213775;4807.759612019385;4810.831620893252;5775.855603609902;5818.359980402152;5818.41815818419;5839;5841.153032810219;3947.605239476058;3953.031507280735;3958.2875082485143;3962.821673024721;3972.6890126258268;5871.442212989759;6121.571489995702;6161.935751523245;6203.410675985774;6203.689815509251;4047.352423612208;4068.7965601719798;4078.388241763759;4087.8569250076102;4088.8160032798596;4125.824140120051;4130.421740956269;4138.772367519755;4142;4145.585441455831;4692.3811285106585;4758.214894542361;4766.451858036301;4783.95216047835;4796.592289655418;5849.590528663038;5872.148538461985;5882.911756323659;5883.794067207713;5887;1401.7196560687698;1408.1762169131173;1414.794854746056;1424.230915305744;1429.078244532271;881;923.1091996223677;943.3679434778714;946.0964778636386;948.8481842905102;5030.37120359955;5046.394432668103;5061.8228362007885;5066.08810414129;5086.397784697809;6048.727807248684;6064.363241859542;6066.514678825683;6069.754190949288;6100.786472473442;4940.827071052496;4944.453606392711;5005.27423523587;5024.447310795809;5037.3880358285;3213.453712868818;3239.8704051838135;3240.157559034668;3243.880861102963;3249.69127932846;5425.294711687534;5570.164475328733;5583.888322233533;5589.552835773128;5614.438556144434;6044.879102417927;6185.690715464209;6204.7828326008375;6210.534209934273;6215.316315205414;5561.777528898961;5575.972120139454;5596;5641.8589535261945;5648.548116150616;6046.12331211963;6051.969740151447;6088.847778805565;6113.755449782137;6143.84640383994;5759.913601296068;5892.970535147297;5932.555058370725;5948.2862056553495;5954.910676339771;5541.891621675762;5581.967336042845;5584.944150558443;5602.971985140048;5614.06314821386;3924;4055.4045410936433;4065.8576949806616;4070.552239253739;4080.7755573443746;6110.480609148272;6119.938800611937;6131.816045518642;6131.908021379593;6141.877162456815;5819.388964158702;5877.500412464989;5886.470217680258;5903.468687818117;5942.227510423617;5693.886122277614;5833.912491312719;5834.17042734265;5868.589198756046;5913;5786.061669340818;5794.464466916186;5800.767969281182;5814.476697097112;5827.446392592697;5811.692369216892;5914.728333408338;5924.585279030426;5933.2880054393745;5936.495397891055;5743.195952566561;5774.04728219839;5782.074868021096;5792.102224155263;5801.245838041028 01:53:05 INFO - PID 2282 | |5;yui.html;694.7498900395854;711.5232794028001;714.7319755091844;722.1767185408635;726.5713229194776;11930.64208073757;12511.12422130449;12563.434645440955;13210.40553175107;13233.404496797642;15401.3839446422;15841;15920.601984950383;15948.122853243067;15948.681026379465;890.4034297020979;904.5477261369315;905.5110240470138;905.7011186308536;905.8641203819413;905.3345790843724;906.8005038891466;907.2787134228304;909.231699214163;910.6175406329357;949.1931857920781;952.1858810716841;955.5413401567251;956.4643799472283;957.3490026781785;946.7159852044393;946.7869729310919;952.9618815247451;954.9618015279345;955.0878910640322;683.4054372695737;687.4843867099676;691.353584398589;691.9135108111486;692.0657112897599;13518.053736238468;13809.171449713049;13813.51652692161;13961.930190348983;14035;15623.375064997386;15669.921650391789;16046.1174635395;16161.272742726487;16276.430324938688;12070.577529786415;12299.877001229963;12432.564860229939;12516.624501264976;12674.239545627292;2992.4613569557473;2995.266159790843;3002.9549556756665;3007;3007.879684812605;74972;77245;78220.60889695572;80409;80619.5969020157;12469.563565275172;12777.488900443877;12820.80768788469;12879.549215777402;12989.740205196033;22522.887385562968;23222.767772322397;23575.7642423577;24484.755152448248;24552.631710524358;6229.190205273376;6445.2265728112925;6456.031595260749;6458.22501299847;6471.514636402195;2971.1235185620294;3017.260771111048;3023.682513336112;3033.8028028178096;3037.772167087477;3592.5329707137903;3792.222594368148;3793.387810180662;3794.5446546414605;3798.867039653654;724.69562783631;732.6300218389679;794.940379471542;841.3311417423163;846.3779122345071;559.490863314382;575.6747437697771;589.4076453164542;595.3183604772511;603.4599033864666;9512.86075595052;9711.56297966579;9746.31775775689;9802.852957205647;10057;547.1000204663306;557.4369886414751;559.0998492427188;562.8030189433747;564.3397225246472;4269.03946612016;4406.1187762447635;4406.867793966187;4448.154850578379;4590.862274131781;83076;84293.57853210694;84443.57778211069;84492;85320.14679853122;73939;74116.62941685366;74516.62741686257;76329.61835190789;76896.23103769003;65907.34092659011;66499.66750166219;67744.98382524266;67781;68478.65760671264;8734.606942687467;8776.122387761172;8779.912200877909;8809.339299552432;8861.556922153995;28288;29032.56451153192;29089;29632.555511667775;30303.848480757457;36821.63178368289;51655.74172129115;52098;53220;53229.73385133049;14404.279786010868;14631.85368146305;14823.851761482247;14903.776443353576;15088.773668394764;15554.377824886878;15640.530784076496;15675.608109797346;15679.764803527729;15880.205989700238;13638.113522620997;14288.918909487695;14616.634584135481;15383.38466461329;15665.765013524579;14797.556073317817;14838.554843354717;15043.473478428203;15123.697526049638;15276.236188190323;14122.929385353007;14132.293385330488;14358.066725662798;14366.640833979234;14559.41762329495;10759.408232547285;11054.447277635925;11074.667759967213;11194.720131996764;11483.48324325424;11939.880601193878;12424.130310878514;12494.875051249372;12508.687282817638;12625.305608191638 01:53:05 INFO - PID 2282 | __end_tp_report 01:53:05 INFO - PID 2282 | __start_cc_report 01:53:05 INFO - PID 2282 | _x_x_mozilla_cycle_collect,339 01:53:05 INFO - PID 2282 | __end_cc_report 01:53:05 INFO - PID 2282 | __startTimestamp1495875185776__endTimestamp 01:53:05 INFO - PID 2282 | 01:53:05 INFO - PID 2282 | ------- Summary: start ------- 01:53:05 INFO - PID 2282 | Number of tests: 6 01:53:05 INFO - PID 2282 | 01:53:05 INFO - PID 2282 | [#0] dojo.html Cycles:165 Average:5309.57 Median:5486.31 stddev:632.64 (11.5%) stddev-sans-first:602.03 01:53:05 INFO - PID 2282 | Values: 2755.8 2757.4 2762.6 2789.5 2797.1 5326.6 5342.8 5388.5 5394.6 5420.5 5355.9 5358.2 5406.8 5445.0 5493.9 4455.8 4698.1 4746.7 4787.5 4799.1 4800.6 4840.5 4865.8 4893.7 4894.8 4754.1 4786.0 4794.3 4795.4 4798.4 4839.5 4840.8 4870.2 4875.0 4887.1 4793.5 4816.9 4830.6 4837.5 4868.4 5279.5 5355.6 5426.8 5428.4 5472.8 5815.8 5838.5 5852.5 5860.2 5892.5 5890.0 5916.9 5917.1 5918.3 5931.8 5452.8 5474.5 5475.6 5478.1 5486.3 5820.1 5912.3 5963.4 6036.3 6077.3 5619.9 5625.9 5629.8 5631.8 5659.0 5702.3 5714.3 5715.9 5721.1 5752.2 5675.5 5691.8 5747.5 5761.0 5764.3 5756.4 5795.4 5799.0 5813.4 5822.6 4801.6 4808.2 4810.7 4811.4 4847.4 4048.9 4125.4 4129.5 4133.7 4156.6 4874.1 4912.1 4936.7 4960.7 4968.7 5898.2 5923.3 5934.0 5936.8 5937.7 4941.3 4956.2 4960.8 4962.3 4989.4 5057.5 5131.7 5156.2 5159.1 5166.8 5427.8 5429.3 5436.7 5476.9 5489.2 5662.4 5731.9 5741.7 5748.0 5753.5 5451.9 5476.1 5477.7 5486.6 5489.0 5664.6 5835.2 5836.1 5837.7 5839.5 5792.2 5845.4 5855.8 5856.1 5954.6 5582.2 5599.4 5620.2 5620.6 5631.4 5520.2 5573.2 5577.0 5578.4 5602.3 5443.8 5473.1 5528.3 5537.2 5539.2 5695.0 5702.0 5712.6 5781.1 5784.5 5506.4 5509.5 5509.8 5514.1 5566.3 01:53:05 INFO - PID 2282 | 01:53:05 INFO - PID 2282 | [#1] ext.html Cycles:180 Average:31081.15 Median:16825.74 stddev:42378.53 (251.9%) stddev-sans-first:42435.79 01:53:05 INFO - PID 2282 | Values: 645.6 705.8 724.8 1214.0 1263.8 34259.3 35023.8 35096.3 35099.3 35131.8 34297.8 34299.3 34566.0 34602.0 34735.7 6445.1 6558.3 6652.4 6771.9 6784.4 6839.7 6943.5 6954.2 6954.2 6955.2 6925.6 6969.1 6979.1 6997.1 7003.4 6941.9 6955.9 6975.5 6985.4 6993.2 6826.3 6845.6 6850.0 6866.9 6874.8 31968.8 32022.8 32115.7 32170.7 32185.0 2955.4 2980.9 2982.0 2982.2 2989.7 23663.5 23791.2 23842.4 23851.3 23889.2 2994.7 3058.4 3058.4 3105.0 3121.5 142873.0 143098.0 144158.0 151736.2 156328.0 40551.6 40555.6 40605.2 40752.2 40844.0 41845.6 41972.0 42024.6 42090.6 43787.3 12696.0 12731.4 12760.4 12809.0 12834.8 10089.1 10138.6 10206.8 10222.8 10393.9 12689.7 12908.9 12978.7 13004.1 13069.5 5254.6 5305.2 5326.8 5356.2 5376.8 848.7 894.6 898.1 909.2 930.1 20926.9 21645.1 21654.9 21743.1 22014.6 977.4 978.2 980.9 994.3 1000.4 11167.3 11183.4 11383.4 11407.9 11500.9 180064.0 181204.0 181236.0 181634.1 181840.0 40456.4 40508.6 40710.0 40808.2 40842.4 1189.4 1250.3 1252.2 1253.6 1255.4 20462.7 20794.7 21263.6 21460.8 21591.4 30375.5 35356.0 36761.8 36870.3 37197.3 160365.0 160733.0 162450.0 162560.0 163411.0 28915.1 29960.0 30444.5 30511.0 30593.1 35937.0 36752.3 37015.8 37081.4 37737.6 27255.2 27372.3 27457.9 28610.0 28611.0 27578.0 27820.0 28261.3 28476.4 29433.4 30968.5 31183.0 31277.8 31371.8 31407.0 26643.6 26951.6 27815.4 28153.6 28330.3 21109.9 22308.7 22418.0 22482.4 22546.3 01:53:05 INFO - PID 2282 | 01:53:05 INFO - PID 2282 | [#2] jquery.html Cycles:180 Average:24759.32 Median:424.15 stddev:62022.13 (14622.8%) stddev-sans-first:62169.18 01:53:05 INFO - PID 2282 | Values: 413.3 413.8 434.5 434.9 437.4 13274.9 17236.5 17822.4 17890.9 17904.4 16047.8 16057.8 16235.1 16501.8 16675.3 5383.2 5558.6 5563.7 5584.9 5587.6 5290.6 5437.2 5464.8 5481.4 5494.6 5434.5 5448.9 5458.1 5467.8 5484.4 5215.8 5370.1 5379.4 5382.5 5394.4 4850.6 4873.0 4873.0 4873.9 4898.5 21339.0 21343.6 21476.2 21542.5 21570.5 1630.5 1665.4 1669.1 1670.1 1671.3 13816.4 13967.5 14196.1 14228.5 14236.6 1982.3 2021.9 2033.1 2044.2 2052.8 90890.0 91459.0 93084.0 94179.5 95244.8 10549.7 10720.2 11089.0 11132.9 11204.7 15406.8 15427.9 15446.2 15448.4 15555.8 6998.2 7250.7 7617.9 7881.0 7913.6 7143.7 7159.6 7232.1 7477.7 7491.6 6892.0 6904.7 6960.3 7101.5 7113.5 1925.5 1927.0 1947.3 1952.7 2125.4 842.7 872.9 876.0 876.7 908.7 16899.7 17173.7 17198.8 17241.8 17971.1 890.8 896.2 898.6 902.2 923.4 9162.2 9418.7 9564.0 9603.5 9640.6 357172.0 373604.0 373613.0 375189.0 378656.0 74185.6 74859.6 77419.0 78302.6 78944.0 1057.2 1065.2 1085.5 1087.7 1095.4 14329.1 14546.7 14597.3 14701.8 15143.5 35385.8 35429.8 36549.3 36770.6 36904.4 47595.5 50841.7 51326.5 51657.0 51855.2 7957.4 8036.5 8155.5 8382.4 8507.8 11373.1 11565.6 11779.1 11931.9 12994.4 10418.9 10643.4 10658.9 10766.4 11038.4 7961.8 8719.9 8853.0 9544.7 9552.9 9952.7 10105.0 10233.6 10479.9 11227.6 8177.9 8233.9 8272.5 8317.6 8338.1 10416.3 10507.7 10786.1 10809.6 11200.0 01:53:05 INFO - PID 2282 | 01:53:05 INFO - PID 2282 | [#3] mootools.html Cycles:180 Average:6442.18 Median:3601.00 stddev:4352.81 (120.9%) stddev-sans-first:4347.54 01:53:05 INFO - PID 2282 | Values: 1250.4 1288.3 1288.6 1293.5 1306.4 10279.4 10653.9 10827.5 10831.0 10928.6 10556.5 10725.7 10744.5 10753.2 10778.7 2052.8 2096.3 2100.9 2103.0 2109.2 1886.4 1939.2 1945.2 1958.5 1962.4 2005.1 2006.9 2049.9 2065.2 2067.9 2030.3 2042.9 2046.7 2051.9 2055.7 1929.6 1954.7 1966.2 1974.2 2025.7 10232.1 10428.4 10435.5 10436.7 10451.5 5432.0 5570.4 5614.6 5634.7 5655.1 3168.4 3266.2 3338.7 3340.7 3350.8 1027.1 1053.8 1080.3 1102.6 1122.1 15413.9 15608.7 15688.9 15756.4 15816.1 4651.2 4779.9 4872.4 4872.7 4909.2 13143.1 13180.1 13191.1 13195.6 13241.5 5575.9 5684.9 5688.1 5692.6 5707.2 4974.8 5113.8 5123.1 5126.7 5147.7 3779.7 3803.4 3847.8 3861.0 3908.5 1074.9 1078.4 1085.4 1092.7 1098.8 684.1 707.6 710.4 718.1 721.0 5495.0 5556.1 5585.0 5603.7 5652.2 490.2 504.7 508.4 511.4 511.9 3422.3 3882.3 3885.5 3940.1 4042.8 13520.9 13687.7 13996.9 14049.7 14075.1 13644.0 13766.5 13787.8 13905.7 13912.7 7260.6 7569.7 7576.3 7609.2 7620.5 6022.7 6189.4 6236.4 6236.5 6253.7 12392.4 12592.6 12635.7 12700.9 12723.3 12501.7 12778.2 12809.6 12958.1 13029.1 8435.8 8670.1 8682.5 8685.1 8685.7 9800.1 9923.9 9924.4 9942.5 9944.9 8051.5 8176.6 8507.6 8564.0 8587.0 7688.4 7708.8 7727.6 7749.4 7794.5 6965.2 7051.5 7109.6 7139.1 7145.7 4648.7 5036.8 5147.6 5153.2 5172.1 5133.3 5166.7 5227.0 5275.4 5331.9 01:53:05 INFO - PID 2282 | 01:53:05 INFO - PID 2282 | [#4] prototype.html Cycles:180 Average:4787.24 Median:5562.72 stddev:1454.48 (26.1%) stddev-sans-first:1419.67 01:53:05 INFO - PID 2282 | Values: 335.9 340.3 344.0 346.1 349.9 5662.1 5690.5 5696.5 5699.9 5713.3 5541.7 5541.7 5548.7 5563.7 5564.8 3976.7 4077.9 4096.3 4126.5 4143.9 4113.4 4127.0 4132.6 4133.4 4140.8 4064.3 4072.5 4075.6 4084.5 4085.2 4015.7 4049.6 4057.0 4081.3 4097.2 3535.7 3545.9 3552.0 3562.2 3563.0 5361.1 5365.8 5370.3 5376.4 5377.7 4691.1 4763.4 4783.7 4807.8 4810.8 5775.9 5818.4 5818.4 5839.0 5841.2 3947.6 3953.0 3958.3 3962.8 3972.7 5871.4 6121.6 6161.9 6203.4 6203.7 4047.4 4068.8 4078.4 4087.9 4088.8 4125.8 4130.4 4138.8 4142.0 4145.6 4692.4 4758.2 4766.5 4784.0 4796.6 5849.6 5872.1 5882.9 5883.8 5887.0 1401.7 1408.2 1414.8 1424.2 1429.1 881.0 923.1 943.4 946.1 948.8 5030.4 5046.4 5061.8 5066.1 5086.4 6048.7 6064.4 6066.5 6069.8 6100.8 4940.8 4944.5 5005.3 5024.4 5037.4 3213.5 3239.9 3240.2 3243.9 3249.7 5425.3 5570.2 5583.9 5589.6 5614.4 6044.9 6185.7 6204.8 6210.5 6215.3 5561.8 5576.0 5596.0 5641.9 5648.5 6046.1 6052.0 6088.8 6113.8 6143.8 5759.9 5893.0 5932.6 5948.3 5954.9 5541.9 5582.0 5584.9 5603.0 5614.1 3924.0 4055.4 4065.9 4070.6 4080.8 6110.5 6119.9 6131.8 6131.9 6141.9 5819.4 5877.5 5886.5 5903.5 5942.2 5693.9 5833.9 5834.2 5868.6 5913.0 5786.1 5794.5 5800.8 5814.5 5827.4 5811.7 5914.7 5924.6 5933.3 5936.5 5743.2 5774.0 5782.1 5792.1 5801.2 01:53:05 INFO - PID 2282 | 01:53:05 INFO - PID 2282 | [#5] yui.html Cycles:180 Average:17641.79 Median:3796.71 stddev:23009.08 (606.0%) stddev-sans-first:23038.44 01:53:05 INFO - PID 2282 | Values: 694.7 711.5 714.7 722.2 726.6 11930.6 12511.1 12563.4 13210.4 13233.4 15401.4 15841.0 15920.6 15948.1 15948.7 890.4 904.5 905.5 905.7 905.9 905.3 906.8 907.3 909.2 910.6 949.2 952.2 955.5 956.5 957.3 946.7 946.8 953.0 955.0 955.1 683.4 687.5 691.4 691.9 692.1 13518.1 13809.2 13813.5 13961.9 14035.0 15623.4 15669.9 16046.1 16161.3 16276.4 12070.6 12299.9 12432.6 12516.6 12674.2 2992.5 2995.3 3003.0 3007.0 3007.9 74972.0 77245.0 78220.6 80409.0 80619.6 12469.6 12777.5 12820.8 12879.5 12989.7 22522.9 23222.8 23575.8 24484.8 24552.6 6229.2 6445.2 6456.0 6458.2 6471.5 2971.1 3017.3 3023.7 3033.8 3037.8 3592.5 3792.2 3793.4 3794.5 3798.9 724.7 732.6 794.9 841.3 846.4 559.5 575.7 589.4 595.3 603.5 9512.9 9711.6 9746.3 9802.9 10057.0 547.1 557.4 559.1 562.8 564.3 4269.0 4406.1 4406.9 4448.2 4590.9 83076.0 84293.6 84443.6 84492.0 85320.1 73939.0 74116.6 74516.6 76329.6 76896.2 65907.3 66499.7 67745.0 67781.0 68478.7 8734.6 8776.1 8779.9 8809.3 8861.6 28288.0 29032.6 29089.0 29632.6 30303.8 36821.6 51655.7 52098.0 53220.0 53229.7 14404.3 14631.9 14823.9 14903.8 15088.8 15554.4 15640.5 15675.6 15679.8 15880.2 13638.1 14288.9 14616.6 15383.4 15665.8 14797.6 14838.6 15043.5 15123.7 15276.2 14122.9 14132.3 14358.1 14366.6 14559.4 10759.4 11054.4 11074.7 11194.7 11483.5 11939.9 12424.1 12494.9 12508.7 12625.3 01:53:05 INFO - PID 2282 | -------- Summary: end -------- 01:53:05 INFO - PID 2282 | 01:53:06 INFO - TEST-INFO | 2282: exit 0 01:53:06 INFO - TEST-OK | dromaeo_css | took 1147873ms 01:53:06 INFO - TEST-START | kraken 01:53:06 INFO - operating with platform_type : linux_ 01:53:06 INFO - Initialising browser for kraken test... 01:53:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42379/getInfo.html -profile /tmp/tmpDRGGPX/profile 01:53:06 INFO - TEST-INFO | started process 2865 (/builds/slave/test/build/application/firefox/firefox http://localhost:42379/getInfo.html) 01:53:41 INFO - TEST-INFO | 2865: killed by SIGTERM 01:53:41 INFO - Browser initialized. 01:53:41 INFO - Running cycle 1/1 for kraken test... 01:53:41 INFO - TEST-INFO | started process 3119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDRGGPX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:53:53 INFO - PID 3119 | RSS: Main: 172675072 01:53:53 INFO - PID 3119 | 01:53:55 INFO - PID 3119 | Cycle 1(1): loaded http://localhost:42379/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42379/tests/kraken/driver.html?testName=audio-beat-detection) 01:53:56 INFO - PID 3119 | RSS: Main: 178495488 01:53:56 INFO - PID 3119 | 01:53:59 INFO - PID 3119 | Cycle 1(1): loaded http://localhost:42379/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42379/tests/kraken/driver.html?testName=audio-dft) 01:54:00 INFO - PID 3119 | RSS: Main: 177516544 01:54:00 INFO - PID 3119 | 01:54:03 INFO - PID 3119 | Cycle 1(1): loaded http://localhost:42379/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42379/tests/kraken/driver.html?testName=audio-fft) 01:54:03 INFO - PID 3119 | RSS: Main: 175091712 01:54:03 INFO - PID 3119 | 01:54:05 INFO - PID 3119 | Cycle 1(1): loaded http://localhost:42379/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42379/tests/kraken/driver.html?testName=audio-oscillator) 01:54:06 INFO - PID 3119 | RSS: Main: 175517696 01:54:06 INFO - PID 3119 | 01:54:08 INFO - PID 3119 | Cycle 1(1): loaded http://localhost:42379/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42379/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:54:09 INFO - PID 3119 | RSS: Main: 175489024 01:54:09 INFO - PID 3119 | 01:54:12 INFO - PID 3119 | Cycle 1(1): loaded http://localhost:42379/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42379/tests/kraken/driver.html?testName=imaging-darkroom) 01:54:13 INFO - PID 3119 | RSS: Main: 179716096 01:54:13 INFO - PID 3119 | 01:54:16 INFO - PID 3119 | Cycle 1(1): loaded http://localhost:42379/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42379/tests/kraken/driver.html?testName=imaging-desaturate) 01:54:17 INFO - PID 3119 | RSS: Main: 176443392 01:54:17 INFO - PID 3119 | 01:54:20 INFO - PID 3119 | Cycle 1(1): loaded http://localhost:42379/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42379/tests/kraken/driver.html?testName=json-parse-financial) 01:54:20 INFO - PID 3119 | RSS: Main: 176656384 01:54:20 INFO - PID 3119 | 01:54:22 INFO - PID 3119 | Cycle 1(1): loaded http://localhost:42379/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42379/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:54:23 INFO - PID 3119 | RSS: Main: 176619520 01:54:23 INFO - PID 3119 | 01:54:24 INFO - PID 3119 | Cycle 1(1): loaded http://localhost:42379/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42379/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:54:25 INFO - PID 3119 | RSS: Main: 176861184 01:54:25 INFO - PID 3119 | 01:54:27 INFO - PID 3119 | Cycle 1(1): loaded http://localhost:42379/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42379/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:54:28 INFO - PID 3119 | RSS: Main: 176832512 01:54:28 INFO - PID 3119 | 01:54:31 INFO - PID 3119 | Cycle 1(1): loaded http://localhost:42379/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:54:31 INFO - PID 3119 | RSS: Main: 176906240 01:54:31 INFO - PID 3119 | 01:54:35 INFO - PID 3119 | Cycle 1(1): loaded http://localhost:42379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:54:35 INFO - PID 3119 | RSS: Main: 176717824 01:54:35 INFO - PID 3119 | 01:54:37 INFO - PID 3119 | Cycle 1(1): loaded http://localhost:42379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42379/tests/kraken/driver.html?testName=ai-astar) 01:54:37 INFO - PID 3119 | RSS: Main: 178089984 01:54:37 INFO - PID 3119 | 01:54:37 INFO - PID 3119 | __start_tp_report 01:54:37 INFO - PID 3119 | _x_x_mozilla_page_load 01:54:37 INFO - PID 3119 | _x_x_mozilla_page_load_details 01:54:37 INFO - PID 3119 | |i|pagename|runs| 01:54:37 INFO - PID 3119 | |0;ai-astar;102;110;110;110;113;113;124;110;114;116 01:54:37 INFO - PID 3119 | |1;audio-beat-detection;156;124;134;173;124;122;124;124;149;123 01:54:37 INFO - PID 3119 | |2;audio-dft;168;164;163;163;167;173;169;164;163;164 01:54:37 INFO - PID 3119 | |3;audio-fft;74;74;75;110;78;75;74;73;102;75 01:54:37 INFO - PID 3119 | |4;audio-oscillator;86;85;105;84;83;83;106;83;83;108 01:54:37 INFO - PID 3119 | |5;imaging-gaussian-blur;113;114;116;117;119;114;114;115;115;118 01:54:37 INFO - PID 3119 | |6;imaging-darkroom;152;150;152;151;150;152;151;151;151;151 01:54:37 INFO - PID 3119 | |7;imaging-desaturate;95;96;94;95;95;95;94;95;96;94 01:54:37 INFO - PID 3119 | |8;json-parse-financial;54;55;56;54;54;54;55;56;59;55 01:54:37 INFO - PID 3119 | |9;json-stringify-tinderbox;56;56;56;56;57;56;59;56;60;56 01:54:37 INFO - PID 3119 | |10;stanford-crypto-aes;89;87;90;85;87;85;87;87;130;87 01:54:37 INFO - PID 3119 | |11;stanford-crypto-ccm;134;132;132;137;132;147;141;140;160;138 01:54:37 INFO - PID 3119 | |12;stanford-crypto-pbkdf2;189;196;194;195;196;196;194;202;195;194 01:54:37 INFO - PID 3119 | |13;stanford-crypto-sha256-iterative;74;74;73;75;72;75;74;75;72;72 01:54:37 INFO - PID 3119 | __end_tp_report 01:54:37 INFO - PID 3119 | __start_cc_report 01:54:37 INFO - PID 3119 | _x_x_mozilla_cycle_collect,869 01:54:37 INFO - PID 3119 | __end_cc_report 01:54:37 INFO - PID 3119 | __startTimestamp1495875277826__endTimestamp 01:54:37 INFO - PID 3119 | 01:54:37 INFO - PID 3119 | ------- Summary: start ------- 01:54:37 INFO - PID 3119 | Number of tests: 14 01:54:37 INFO - PID 3119 | 01:54:37 INFO - PID 3119 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:5.59 (5.0%) stddev-sans-first:4.56 01:54:37 INFO - PID 3119 | Values: 102.0 110.0 110.0 110.0 113.0 113.0 124.0 110.0 114.0 116.0 01:54:37 INFO - PID 3119 | 01:54:37 INFO - PID 3119 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:129.00 stddev:17.88 (13.9%) stddev-sans-first:17.33 01:54:37 INFO - PID 3119 | Values: 156.0 124.0 134.0 173.0 124.0 122.0 124.0 124.0 149.0 123.0 01:54:37 INFO - PID 3119 | 01:54:37 INFO - PID 3119 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.50 stddev:3.36 (2.0%) stddev-sans-first:3.47 01:54:37 INFO - PID 3119 | Values: 168.0 164.0 163.0 163.0 167.0 173.0 169.0 164.0 163.0 164.0 01:54:37 INFO - PID 3119 | 01:54:37 INFO - PID 3119 | [#3] audio-fft Cycles:10 Average:81.00 Median:74.50 stddev:13.37 (18.0%) stddev-sans-first:13.94 01:54:37 INFO - PID 3119 | Values: 74.0 74.0 75.0 110.0 78.0 75.0 74.0 73.0 102.0 75.0 01:54:37 INFO - PID 3119 | 01:54:37 INFO - PID 3119 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:83.00 stddev:10.93 (13.2%) stddev-sans-first:11.46 01:54:37 INFO - PID 3119 | Values: 86.0 85.0 105.0 84.0 83.0 83.0 106.0 83.0 83.0 108.0 01:54:37 INFO - PID 3119 | 01:54:37 INFO - PID 3119 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.50 stddev:1.96 (1.7%) stddev-sans-first:1.86 01:54:37 INFO - PID 3119 | Values: 113.0 114.0 116.0 117.0 119.0 114.0 114.0 115.0 115.0 118.0 01:54:37 INFO - PID 3119 | 01:54:37 INFO - PID 3119 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 01:54:37 INFO - PID 3119 | Values: 152.0 150.0 152.0 151.0 150.0 152.0 151.0 151.0 151.0 151.0 01:54:37 INFO - PID 3119 | 01:54:37 INFO - PID 3119 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 01:54:37 INFO - PID 3119 | Values: 95.0 96.0 94.0 95.0 95.0 95.0 94.0 95.0 96.0 94.0 01:54:37 INFO - PID 3119 | 01:54:37 INFO - PID 3119 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:1.55 (2.8%) stddev-sans-first:1.58 01:54:37 INFO - PID 3119 | Values: 54.0 55.0 56.0 54.0 54.0 54.0 55.0 56.0 59.0 55.0 01:54:37 INFO - PID 3119 | 01:54:37 INFO - PID 3119 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:56.00 stddev:1.48 (2.6%) stddev-sans-first:1.54 01:54:37 INFO - PID 3119 | Values: 56.0 56.0 56.0 56.0 57.0 56.0 59.0 56.0 60.0 56.0 01:54:37 INFO - PID 3119 | 01:54:37 INFO - PID 3119 | [#10] stanford-crypto-aes Cycles:10 Average:91.40 Median:87.00 stddev:13.65 (15.7%) stddev-sans-first:14.45 01:54:37 INFO - PID 3119 | Values: 89.0 87.0 90.0 85.0 87.0 85.0 87.0 87.0 130.0 87.0 01:54:37 INFO - PID 3119 | 01:54:37 INFO - PID 3119 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:139.00 stddev:8.73 (6.3%) stddev-sans-first:9.05 01:54:37 INFO - PID 3119 | Values: 134.0 132.0 132.0 137.0 132.0 147.0 141.0 140.0 160.0 138.0 01:54:37 INFO - PID 3119 | 01:54:37 INFO - PID 3119 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.10 Median:195.50 stddev:3.18 (1.6%) stddev-sans-first:2.49 01:54:37 INFO - PID 3119 | Values: 189.0 196.0 194.0 195.0 196.0 196.0 194.0 202.0 195.0 194.0 01:54:37 INFO - PID 3119 | 01:54:37 INFO - PID 3119 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:74.00 stddev:1.26 (1.7%) stddev-sans-first:1.33 01:54:37 INFO - PID 3119 | Values: 74.0 74.0 73.0 75.0 72.0 75.0 74.0 75.0 72.0 72.0 01:54:37 INFO - PID 3119 | -------- Summary: end -------- 01:54:37 INFO - PID 3119 | 01:54:38 INFO - TEST-INFO | 3119: exit 0 01:54:38 INFO - TEST-OK | kraken | took 92311ms 01:54:38 INFO - SUITE-END | took 1240s 01:54:38 INFO - Completed test suite (00:20:40) 01:54:38 INFO - javascript benchmark 01:54:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6782.808780811591, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2755.8484283364432, 2757.4347258811945, 2762.585612158176, 2789.483945470088, 2797.062983900392, 5326.573874090073, 5342.759575819087, 5388.488093631104, 5394.622376433646, 5420.4850539198815, 5355.946440535594, 5358.223057656647, 5406.756695948682, 5445.019896418643, 5493.945060549393, 4455.799489022986, 4698.096452366662, 4746.738929358884, 4787.54518320759, 4799.112164249625, 4800.591949684281, 4840.467548569654, 4865.781039853215, 4893.730844803535, 4894.8286809961655, 4754.072955773626, 4785.976070119662, 4794.304825800275, 4795.400574928134, 4798.376211092535, 4839.467658557556, 4840.806367745286, 4870.196417591093, 4875.000624871928, 4887.144749668793, 4793.544613261734, 4816.927746083811, 4830.637702172316, 4837.540433658832, 4868.440129385095, 5279.472052794728, 5355.571554275688, 5426.75579598919, 5428.37573679028, 5472.753726082336, 5815.82552523425, 5838.474537291621, 5852.502537284336, 5860.238169038041, 5892.528597712173, 5889.970550147222, 5916.940830591682, 5917.053271476543, 5918.2898052234, 5931.822045338604, 5452.809151679712, 5474.452554744574, 5475.6440831345835, 5478.123500239943, 5486.31421072366, 5820.068788993741, 5912.3496415394275, 5963.373845746221, 6036.2756469223095, 6077.3314935357075, 5619.93221287954, 5625.943740562624, 5629.802956896489, 5631.7747290108755, 5658.971705141448, 5702.344230413555, 5714.342850572154, 5715.885682286331, 5721.056025755704, 5752.165935939349, 5675.517581005578, 5691.8292451226525, 5747.48272655463, 5760.9918264304415, 5764.308283005982, 5756.366799652035, 5795.420457954171, 5798.971005145032, 5813.418658134153, 5822.621529600562, 4801.591864691541, 4808.206645903387, 4810.7113573185725, 4811.422629284508, 4847.394075740533, 4048.8785336439955, 4125.401816736557, 4129.545749967501, 4133.6693064554765, 4156.56356082613, 4874.122657921537, 4912.1158191525155, 4936.679115857458, 4960.652754307236, 4968.701877887338, 5898.174255604219, 5923.289205295392, 5933.970330148408, 5936.762529498858, 5937.673427961504, 4941.258811178352, 4956.182229932021, 4960.809405742596, 4962.280469331927, 4989.401271847401, 5057.519535644108, 5131.7434128293435, 5156.226566015128, 5159.071367153873, 5166.819161329336, 5427.782888684566, 5429.321334833146, 5436.673799572039, 5476.890462190813, 5489.231507589021, 5662.433756624469, 5731.8853622928145, 5741.74162162712, 5747.971260143672, 5753.482186603226, 5451.918221226605, 5476.09644408684, 5477.67133971963, 5486.643368181056, 5488.9725551373585, 5664.603477756682, 5835.241418615723, 5836.066229403275, 5837.67892765902, 5839.532837373085, 5792.189093526826, 5845.444682755132, 5855.824325270249, 5856.121581762599, 5954.553408494467, 5582.218489411404, 5599.412061733622, 5620.213170156263, 5620.550355971594, 5631.436856314336, 5520.227168196536, 5573.191887176417, 5576.972115139399, 5578.386377498553, 5602.327720673382, 5443.8094666686475, 5473.0695781718, 5528.308961379827, 5537.169424586184, 5539.169124631338, 5694.971525142348, 5702.030654788613, 5712.571557133315, 5781.103928891029, 5784.479396854304, 5506.421825708243, 5509.47659972302, 5509.807156749494, 5514.062609356339, 5566.304211973504], "value": 5262.69085002487, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.6287634610101, 705.7741522712731, 724.847781965787, 1213.9575114870975, 1263.7725209462294, 34259.31481370371, 35023.824880875625, 35096.2980740385, 35099.298014039705, 35131.82434087826, 34297.82851085741, 34299.31401371977, 34566.0, 34602.0, 34735.65264347362, 6445.129907462491, 6558.344165583428, 6652.434543063845, 6771.8984215236815, 6784.3554862288, 6839.692213850389, 6943.479239057066, 6954.16550013999, 6954.23503414624, 6955.165380154389, 6925.619090949996, 6969.128858892638, 6979.127609048869, 6997.055397521346, 7003.404710599605, 6941.930580694179, 6955.930440695579, 6975.546589471668, 6985.371316581482, 6993.230744618088, 6826.317368263183, 6845.5550389224545, 6849.965750171267, 6866.862662746717, 6874.828129296758, 31968.840155799306, 32022.839885800655, 32115.678843211503, 32170.678293217003, 32185.0, 2955.4089182163652, 2980.9403811923858, 2982.0457453614854, 2982.1948074019892, 2989.7159769821833, 23663.526729465488, 23791.167309144097, 23842.40393990147, 23851.284461466184, 23889.163879264142, 2994.655614604305, 3058.388322335542, 3058.4036112957983, 3105.0374383941053, 3121.4693502104697, 142873.0, 143098.0, 144158.0, 151736.2413187927, 156327.99999999886, 40551.59448405478, 40555.59444405577, 40605.18789624191, 40752.1849563013, 40844.0, 41845.58154418478, 41972.0, 42024.57975420207, 42090.57909420928, 43787.34318985218, 12696.0, 12731.363431828371, 12760.361981901053, 12809.0, 12834.80747788784, 10089.09198172168, 10138.645147419806, 10206.795864082826, 10222.846657300146, 10393.896061039444, 12689.682757931125, 12908.935455322664, 12978.740425191443, 13004.089713719948, 13069.477220911247, 5254.632175747737, 5305.151175811851, 5326.760295786621, 5356.223347614652, 5376.8118115865755, 848.6902280667512, 894.5706061090713, 898.0794685447469, 909.2226146644524, 930.1396208507103, 20926.895365523076, 21645.13419463204, 21654.891725541587, 21743.130274788833, 22014.559708805733, 977.4428575711776, 978.1929907826072, 980.9117179453883, 994.3337963564429, 1000.3897622450299, 11167.274127181707, 11183.440827958731, 11383.373914434786, 11407.885921140682, 11500.94249528747, 180064.0, 181204.0, 181236.0, 181634.09182954, 181840.0, 40456.39315410271, 40508.59491405107, 40710.0, 40808.183836323704, 40842.38736418956, 1189.4290740444635, 1250.3498180945858, 1252.1673087396962, 1253.5612535612645, 1255.3660401497368, 20462.693059604415, 20794.688079678515, 21263.574728505653, 21460.785392145877, 21591.352259432242, 30375.544366834074, 35356.0, 36761.81619091887, 36870.26259474849, 37197.25605487929, 160365.0, 160733.0, 162450.0, 162560.0, 163411.0, 28915.13254602365, 29960.0, 30444.543331850484, 30511.0, 30593.08220753381, 35937.0, 36752.26495470129, 37015.81492092522, 37081.443778343884, 37737.62262377341, 27255.182344529694, 27372.315692107855, 27457.862710687117, 28610.0, 28611.0, 27578.0, 27820.0, 28261.293467663472, 28476.43047139087, 29433.411331773674, 30968.535471967487, 31183.0, 31277.84361078271, 31371.843140785062, 31407.0, 26643.600345994437, 26951.595726063733, 27815.44369112566, 28153.57769633498, 28330.2917427066, 21109.89445052765, 22308.66537001914, 22418.0, 22482.437939051, 22546.323610291718], "value": 14707.008511603794, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.2994574196738, 413.77862843378796, 434.51551520055136, 434.89997300620854, 437.3680032353251, 13274.867251327483, 17236.48290551284, 17822.376216832414, 17890.91054544727, 17904.37334693286, 16047.839521604781, 16057.759133612975, 16235.107069111195, 16501.83498165018, 16675.332986680518, 5383.246345511631, 5558.638688485255, 5563.666180029191, 5584.91622625661, 5587.608867379285, 5290.55030322423, 5437.184422336662, 5464.808731694391, 5481.424450432707, 5494.642848214853, 5434.456554344573, 5448.863778405532, 5458.099413596752, 5467.781288748445, 5484.369297530775, 5215.817446389377, 5370.113931201347, 5379.354477462691, 5382.4886635769535, 5394.379646340682, 4850.587700045465, 4872.9512704873205, 4872.975635121802, 4873.853784386474, 4898.461169271377, 21339.0, 21343.573128537344, 21476.248331308485, 21542.461438464008, 21570.460738481663, 1630.4700972184087, 1665.4254282272595, 1669.1320513332998, 1670.1315316035593, 1671.3314674130324, 13816.447342106303, 13967.511137110152, 14196.077254978496, 14228.502002429968, 14236.644083897882, 1982.2566537548419, 2021.929232476871, 2033.1257559249516, 2044.182327069184, 2052.7639321478073, 90890.0, 91459.0, 93084.0, 94179.52910235473, 95244.76153811537, 10549.736256593493, 10720.195985300978, 11088.971842476147, 11132.888671113185, 11204.719882003015, 15406.768898466533, 15427.922860385626, 15446.227688615525, 15448.38206471751, 15555.844441555666, 6998.230194678581, 7250.746223882139, 7617.923820761722, 7881.0, 7913.643886025143, 7143.678534465961, 7159.57042577447, 7232.132144142736, 7477.663505142282, 7491.55050696949, 6891.965540172267, 6904.723811047602, 6960.269171736996, 7101.467389945775, 7113.5376200547835, 1925.459632294187, 1926.9710954335696, 1947.3476385410763, 1952.7461430014291, 2125.3836387447777, 842.688205364007, 872.8559787634969, 875.9781005474914, 876.68001179569, 908.6728777640044, 16899.66200676004, 17173.656526869392, 17198.828011719972, 17241.827581724272, 17971.101444927703, 890.8351954888367, 896.2426749396749, 898.6001229452961, 902.1700035966926, 923.3951761596165, 9162.22121119699, 9418.717438476857, 9563.952180239054, 9603.519824008772, 9640.566174522164, 357172.0, 373604.0, 373613.0, 375189.0, 378656.0, 74185.62907185538, 74859.62570187222, 77419.0, 78302.60848695721, 78944.0, 1057.2176589323844, 1065.1798115451058, 1085.451846817368, 1087.6628245243999, 1095.424901926479, 14329.140251584522, 14546.709065818835, 14597.270136493345, 14701.779473308123, 15143.469978550698, 35385.82307088551, 35429.82285088558, 36549.26901462009, 36770.63229367672, 36904.44643330406, 47595.524044759106, 50841.745791270805, 51326.48673513217, 51656.96686066333, 51855.22217166821, 7957.403194760532, 8036.4776289541, 8155.469894456842, 8382.371322150984, 8507.78730531717, 11373.14701397382, 11565.59520416815, 11779.116566257737, 11931.926126648643, 12994.350282486026, 10418.947905260426, 10643.361398316125, 10658.89341106579, 10766.407847568458, 11038.392888391216, 7961.8407631848195, 8719.869201962103, 8853.0, 9544.665936692183, 9552.85670714926, 9952.701418957442, 10105.0, 10233.590656373663, 10479.895201047892, 11227.607033753779, 8177.918220817715, 8233.876491852747, 8272.462289951134, 8317.584120794058, 8338.124496927978, 10416.32293900894, 10507.684769456928, 10786.137109031102, 10809.56761729522, 11200.0], "value": 8661.688318912382, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1250.431053870489, 1288.2721262486693, 1288.6456224538256, 1293.473701032781, 1306.3729409883258, 10279.434631095286, 10653.893461065387, 10827.512761925713, 10831.0, 10928.617498387557, 10556.524956376963, 10725.731856703567, 10744.462776861144, 10753.247272690915, 10778.676639700801, 2052.8152466278034, 2096.297740257016, 2100.9264675736354, 2103.0, 2109.219588752164, 1886.377495426506, 1939.1758502636394, 1945.22191123551, 1958.5201625601746, 1962.3916585858358, 2005.0977060322841, 2006.9197232110698, 2049.9237900102416, 2065.213590244443, 2067.855250132491, 2030.3198428526462, 2042.9387118386398, 2046.7441569803848, 2051.866628669132, 2055.6813693877475, 1929.5851391950657, 1954.6872500399868, 1966.2135145941595, 1974.1511150205406, 2025.706272590481, 10232.13026892715, 10428.374297542172, 10435.478226088666, 10436.739081522946, 10451.52968116429, 5432.0, 5570.387257401682, 5614.606977511576, 5634.71826408682, 5655.095184770417, 3168.3821654777325, 3266.248762784573, 3338.732901367909, 3340.6659334066644, 3350.7654464187517, 1027.1166796554958, 1053.7892421515728, 1080.2762149359949, 1102.6195962392962, 1122.0518661730825, 15413.922930385388, 15608.687826243526, 15688.921555392264, 15756.369745210179, 15816.130112843904, 4651.232546629836, 4779.880502987453, 4872.367756801511, 4872.6589138760655, 4909.214525675875, 13143.079984401, 13180.143290686075, 13191.142575732547, 13195.60413187606, 13241.536546221028, 5575.860603484864, 5684.914726279109, 5688.089905615082, 5692.629979051431, 5707.200991861143, 4974.801007959641, 5113.846584602468, 5123.077845987684, 5126.7180305083575, 5147.742612869341, 3779.6976241900584, 3803.448499967489, 3847.788371639587, 3861.015441062511, 3908.511436070491, 1074.8602681651334, 1078.3637653784306, 1085.3813326404031, 1092.6885837536263, 1098.752780624369, 684.1448189762797, 707.564847618721, 710.3677726823131, 718.0772707071493, 720.9819754506075, 5495.0, 5556.055470570012, 5584.97207513968, 5603.691796951207, 5652.208690783294, 490.2132078014806, 504.71483611759237, 508.38485432626936, 511.4195388234381, 511.93600799900014, 3422.2984288220855, 3882.320593896057, 3885.514310711161, 3940.113474468279, 4042.757434553936, 13520.93239533796, 13687.657808554666, 13996.930015350063, 14049.71900561983, 14075.085119467201, 13644.0, 13766.518171863936, 13787.793183102262, 13905.652358690912, 13912.652183695489, 7260.564366138048, 7569.697212111564, 7576.28025337592, 7609.239076092346, 7620.542767433972, 6022.66875321844, 6189.412005859436, 6236.407541283571, 6236.501079913687, 6253.687315634291, 12392.380380980734, 12592.622221333375, 12635.747285054063, 12700.87299126997, 12723.300218487702, 12501.687457813627, 12778.169418987736, 12809.61571152867, 12958.092933494565, 13029.08796384282, 8435.83128337442, 8670.132986701532, 8682.52246126469, 8685.088065753005, 8685.739427817176, 9800.11798938099, 9923.851142232728, 9924.354916930377, 9942.453165075991, 9944.906060333213, 8051.51690898548, 8176.550289734122, 8507.617157227816, 8564.0, 8587.0, 7688.384929205762, 7708.768736937901, 7727.574983375968, 7749.380049596131, 7794.454388192772, 6965.199002114821, 7051.541649792747, 7109.60897150641, 7139.107611548557, 7145.678444469907, 4648.651351148745, 5036.773345199548, 5147.6139289554185, 5153.201253805666, 5172.120739474223, 5133.332666753298, 5166.715830629351, 5227.006868694936, 5275.446078161891, 5331.920021199608], "value": 4683.857669780577, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.92945481448896, 340.3499316305856, 343.9759216854821, 346.13811609093364, 349.8600559776089, 5662.122371032491, 5690.4594063563945, 5696.515796157331, 5699.857503562413, 5713.342965558962, 5541.667499950006, 5541.695206763627, 5548.667079975205, 5563.666180029201, 5564.8052318168875, 3976.661983731379, 4077.9184416311655, 4096.30003548527, 4126.514454796286, 4143.875683729493, 4113.429106808245, 4126.9793651031705, 4132.648724858375, 4133.379993001059, 4140.834366625331, 4064.2887494688457, 4072.5112986441522, 4075.6331930126285, 4084.530279017921, 4085.1829634073156, 4015.658669013152, 4049.635532802062, 4057.0, 4081.3265811141127, 4097.201045796071, 3535.6641119093647, 3545.8758943436856, 3551.987683510213, 3562.1806984393734, 3562.964370356315, 5361.0618141825025, 5365.812196573102, 5370.3287089113865, 5376.435474275223, 5377.677339359651, 4691.061787642451, 4763.3569468121705, 4783.7129772213775, 4807.759612019385, 4810.831620893252, 5775.855603609902, 5818.359980402152, 5818.41815818419, 5839.0, 5841.153032810219, 3947.605239476058, 3953.031507280735, 3958.2875082485143, 3962.821673024721, 3972.6890126258268, 5871.442212989759, 6121.571489995702, 6161.935751523245, 6203.410675985774, 6203.689815509251, 4047.352423612208, 4068.7965601719798, 4078.388241763759, 4087.8569250076102, 4088.8160032798596, 4125.824140120051, 4130.421740956269, 4138.772367519755, 4142.0, 4145.585441455831, 4692.3811285106585, 4758.214894542361, 4766.451858036301, 4783.95216047835, 4796.592289655418, 5849.590528663038, 5872.148538461985, 5882.911756323659, 5883.794067207713, 5887.0, 1401.7196560687698, 1408.1762169131173, 1414.794854746056, 1424.230915305744, 1429.078244532271, 881.0, 923.1091996223677, 943.3679434778714, 946.0964778636386, 948.8481842905102, 5030.37120359955, 5046.394432668103, 5061.8228362007885, 5066.08810414129, 5086.397784697809, 6048.727807248684, 6064.363241859542, 6066.514678825683, 6069.754190949288, 6100.786472473442, 4940.827071052496, 4944.453606392711, 5005.27423523587, 5024.447310795809, 5037.3880358285, 3213.453712868818, 3239.8704051838135, 3240.157559034668, 3243.880861102963, 3249.69127932846, 5425.294711687534, 5570.164475328733, 5583.888322233533, 5589.552835773128, 5614.438556144434, 6044.879102417927, 6185.690715464209, 6204.7828326008375, 6210.534209934273, 6215.316315205414, 5561.777528898961, 5575.972120139454, 5596.0, 5641.8589535261945, 5648.548116150616, 6046.12331211963, 6051.969740151447, 6088.847778805565, 6113.755449782137, 6143.84640383994, 5759.913601296068, 5892.970535147297, 5932.555058370725, 5948.2862056553495, 5954.910676339771, 5541.891621675762, 5581.967336042845, 5584.944150558443, 5602.971985140048, 5614.06314821386, 3924.0, 4055.4045410936433, 4065.8576949806616, 4070.552239253739, 4080.7755573443746, 6110.480609148272, 6119.938800611937, 6131.816045518642, 6131.908021379593, 6141.877162456815, 5819.388964158702, 5877.500412464989, 5886.470217680258, 5903.468687818117, 5942.227510423617, 5693.886122277614, 5833.912491312719, 5834.17042734265, 5868.589198756046, 5913.0, 5786.061669340818, 5794.464466916186, 5800.767969281182, 5814.476697097112, 5827.446392592697, 5811.692369216892, 5914.728333408338, 5924.585279030426, 5933.2880054393745, 5936.495397891055, 5743.195952566561, 5774.04728219839, 5782.074868021096, 5792.102224155263, 5801.245838041028], "value": 4323.330397670792, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.7498900395854, 711.5232794028001, 714.7319755091844, 722.1767185408635, 726.5713229194776, 11930.64208073757, 12511.12422130449, 12563.434645440955, 13210.40553175107, 13233.404496797642, 15401.3839446422, 15841.0, 15920.601984950383, 15948.122853243067, 15948.681026379465, 890.4034297020979, 904.5477261369315, 905.5110240470138, 905.7011186308536, 905.8641203819413, 905.3345790843724, 906.8005038891466, 907.2787134228304, 909.231699214163, 910.6175406329357, 949.1931857920781, 952.1858810716841, 955.5413401567251, 956.4643799472283, 957.3490026781785, 946.7159852044393, 946.7869729310919, 952.9618815247451, 954.9618015279345, 955.0878910640322, 683.4054372695737, 687.4843867099676, 691.353584398589, 691.9135108111486, 692.0657112897599, 13518.053736238468, 13809.171449713049, 13813.51652692161, 13961.930190348983, 14035.0, 15623.375064997386, 15669.921650391789, 16046.1174635395, 16161.272742726487, 16276.430324938688, 12070.577529786415, 12299.877001229963, 12432.564860229939, 12516.624501264976, 12674.239545627292, 2992.4613569557473, 2995.266159790843, 3002.9549556756665, 3007.0, 3007.879684812605, 74972.0, 77245.0, 78220.60889695572, 80409.0, 80619.5969020157, 12469.563565275172, 12777.488900443877, 12820.80768788469, 12879.549215777402, 12989.740205196033, 22522.887385562968, 23222.767772322397, 23575.7642423577, 24484.755152448248, 24552.631710524358, 6229.190205273376, 6445.2265728112925, 6456.031595260749, 6458.22501299847, 6471.514636402195, 2971.1235185620294, 3017.260771111048, 3023.682513336112, 3033.8028028178096, 3037.772167087477, 3592.5329707137903, 3792.222594368148, 3793.387810180662, 3794.5446546414605, 3798.867039653654, 724.69562783631, 732.6300218389679, 794.940379471542, 841.3311417423163, 846.3779122345071, 559.490863314382, 575.6747437697771, 589.4076453164542, 595.3183604772511, 603.4599033864666, 9512.86075595052, 9711.56297966579, 9746.31775775689, 9802.852957205647, 10057.0, 547.1000204663306, 557.4369886414751, 559.0998492427188, 562.8030189433747, 564.3397225246472, 4269.03946612016, 4406.1187762447635, 4406.867793966187, 4448.154850578379, 4590.862274131781, 83076.0, 84293.57853210694, 84443.57778211069, 84492.0, 85320.14679853122, 73939.0, 74116.62941685366, 74516.62741686257, 76329.61835190789, 76896.23103769003, 65907.34092659011, 66499.66750166219, 67744.98382524266, 67781.0, 68478.65760671264, 8734.606942687467, 8776.122387761172, 8779.912200877909, 8809.339299552432, 8861.556922153995, 28288.0, 29032.56451153192, 29089.0, 29632.555511667775, 30303.848480757457, 36821.63178368289, 51655.74172129115, 52098.0, 53220.0, 53229.73385133049, 14404.279786010868, 14631.85368146305, 14823.851761482247, 14903.776443353576, 15088.773668394764, 15554.377824886878, 15640.530784076496, 15675.608109797346, 15679.764803527729, 15880.205989700238, 13638.113522620997, 14288.918909487695, 14616.634584135481, 15383.38466461329, 15665.765013524579, 14797.556073317817, 14838.554843354717, 15043.473478428203, 15123.697526049638, 15276.236188190323, 14122.929385353007, 14132.293385330488, 14358.066725662798, 14366.640833979234, 14559.41762329495, 10759.408232547285, 11054.447277635925, 11074.667759967213, 11194.720131996764, 11483.48324325424, 11939.880601193878, 12424.130310878514, 12494.875051249372, 12508.687282817638, 12625.305608191638], "value": 7172.4715626966, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 110.0, 110.0, 113.0, 113.0, 124.0, 110.0, 114.0, 116.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 134.0, 173.0, 124.0, 122.0, 124.0, 124.0, 149.0, 123.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 164.0, 163.0, 163.0, 167.0, 173.0, 169.0, 164.0, 163.0, 164.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 110.0, 78.0, 75.0, 74.0, 73.0, 102.0, 75.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 105.0, 84.0, 83.0, 83.0, 106.0, 83.0, 83.0, 108.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 116.0, 117.0, 119.0, 114.0, 114.0, 115.0, 115.0, 118.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 152.0, 151.0, 150.0, 152.0, 151.0, 151.0, 151.0, 151.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 54.0, 54.0, 54.0, 55.0, 56.0, 59.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 57.0, 56.0, 59.0, 56.0, 60.0, 56.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 90.0, 85.0, 87.0, 85.0, 87.0, 87.0, 130.0, 87.0], "value": 91.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 132.0, 137.0, 132.0, 147.0, 141.0, 140.0, 160.0, 138.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 196.0, 194.0, 195.0, 196.0, 196.0, 194.0, 202.0, 195.0, 194.0], "value": 195.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 75.0, 72.0, 75.0, 74.0, 75.0, 72.0, 72.0], "value": 73.6, "unit": "score"}]}]} 01:54:39 INFO - Return code: 0 01:54:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:54:39 INFO - # TBPL SUCCESS # 01:54:39 INFO - Running post-action listener: _resource_record_post_action 01:54:39 INFO - [mozharness: 2017-05-27 08:54:39.146511Z] Finished run-tests step (success) 01:54:39 INFO - Running post-run listener: _resource_record_post_run 01:54:39 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 4096; Write bytes: 415768576; Read time: 8; Write time: 263324 01:54:39 INFO - TinderboxPrint: CPU usage
12.7% 01:54:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 01:54:39 INFO - TinderboxPrint: I/O write bytes / time
415,768,576 / 263,324 01:54:39 INFO - TinderboxPrint: CPU idle
8,752.6 (87.3%) 01:54:39 INFO - TinderboxPrint: CPU user
1,220.2 (12.2%) 01:54:39 INFO - TinderboxPrint: Swap in / out
0 / 0 01:54:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105947136; Read time: 0; Write time: 99188 01:54:39 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 0; Write bytes: 309821440; Read time: 0; Write time: 164136 01:54:39 INFO - Running post-run listener: _upload_blobber_files 01:54:39 INFO - Blob upload gear active. 01:54:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:54:39 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 01:54:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:54:40 INFO - (blobuploader) - INFO - Open directory for files ... 01:54:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:54:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:54:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:54:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:54:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:54:41 INFO - (blobuploader) - INFO - Done attempting. 01:54:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:54:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:54:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:54:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:54:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:54:42 INFO - (blobuploader) - INFO - Done attempting. 01:54:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:54:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:54:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:54:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:54:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:54:47 INFO - (blobuploader) - INFO - Done attempting. 01:54:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:54:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:54:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:54:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:54:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:54:48 INFO - (blobuploader) - INFO - Done attempting. 01:54:48 INFO - (blobuploader) - INFO - Iteration through files over. 01:54:48 INFO - Return code: 0 01:54:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:54:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:54:48 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31d74b6546682cabeca97d80e0506eaaf1573f7b16886dff01b05839510c4d11ce7c1dc510543b2032ccac4ca4bb0645b30001e92b8206325309cf8c0611f079", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5792895ce9f59a21eb47e635ea95ac9a52e7bf3b73907b79f397aaaf1d3908cf713686e956fc5d902674c3cdaf05ea26c38431468c630eebb490ed8c8a8e24b9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69de1a34e99a00eb8e3a475f584e61b6399bccfc2474532c9eab688a62b705a31f6ef1a4d9052351d4e78d324d8b86079127b794bc1bc14c8250e32ce9739b9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2059eb44d1c336628209094404e6b04800c8df59e844dccb1d7f878a98a28a9f73ba12818cd4f960a0b960645282fb35ecc79c620a0fc2b58b3ce60feb8667b4"} 01:54:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:54:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:54:48 INFO - Contents: 01:54:48 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31d74b6546682cabeca97d80e0506eaaf1573f7b16886dff01b05839510c4d11ce7c1dc510543b2032ccac4ca4bb0645b30001e92b8206325309cf8c0611f079", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5792895ce9f59a21eb47e635ea95ac9a52e7bf3b73907b79f397aaaf1d3908cf713686e956fc5d902674c3cdaf05ea26c38431468c630eebb490ed8c8a8e24b9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69de1a34e99a00eb8e3a475f584e61b6399bccfc2474532c9eab688a62b705a31f6ef1a4d9052351d4e78d324d8b86079127b794bc1bc14c8250e32ce9739b9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2059eb44d1c336628209094404e6b04800c8df59e844dccb1d7f878a98a28a9f73ba12818cd4f960a0b960645282fb35ecc79c620a0fc2b58b3ce60feb8667b4"} 01:54:48 INFO - Running post-run listener: copy_logs_to_upload_dir 01:54:48 INFO - Copying logs to upload dir... 01:54:48 INFO - mkdir: /builds/slave/test/build/upload/logs 01:54:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1316.197808 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-05-27 01:54:46.951770) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 01:54:46.956349) ========= 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=6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31d74b6546682cabeca97d80e0506eaaf1573f7b16886dff01b05839510c4d11ce7c1dc510543b2032ccac4ca4bb0645b30001e92b8206325309cf8c0611f079", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5792895ce9f59a21eb47e635ea95ac9a52e7bf3b73907b79f397aaaf1d3908cf713686e956fc5d902674c3cdaf05ea26c38431468c630eebb490ed8c8a8e24b9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69de1a34e99a00eb8e3a475f584e61b6399bccfc2474532c9eab688a62b705a31f6ef1a4d9052351d4e78d324d8b86079127b794bc1bc14c8250e32ce9739b9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2059eb44d1c336628209094404e6b04800c8df59e844dccb1d7f878a98a28a9f73ba12818cd4f960a0b960645282fb35ecc79c620a0fc2b58b3ce60feb8667b4"} build_url:https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011377 build_url: 'https://queue.taskcluster.net/v1/task/OzHpRs25QTOGeaoTcyDY-w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31d74b6546682cabeca97d80e0506eaaf1573f7b16886dff01b05839510c4d11ce7c1dc510543b2032ccac4ca4bb0645b30001e92b8206325309cf8c0611f079", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5792895ce9f59a21eb47e635ea95ac9a52e7bf3b73907b79f397aaaf1d3908cf713686e956fc5d902674c3cdaf05ea26c38431468c630eebb490ed8c8a8e24b9", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69de1a34e99a00eb8e3a475f584e61b6399bccfc2474532c9eab688a62b705a31f6ef1a4d9052351d4e78d324d8b86079127b794bc1bc14c8250e32ce9739b9d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2059eb44d1c336628209094404e6b04800c8df59e844dccb1d7f878a98a28a9f73ba12818cd4f960a0b960645282fb35ecc79c620a0fc2b58b3ce60feb8667b4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 01:54:46.983781) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 01:54:46.984127) ========= 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=6dbc10da6d83fee962c624be000001a8-1495855450.684951-1709964444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 01:54:47.069928) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 01:54:47.070258) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 01:54:47.070584) ========= ========= Total master_lag: 0.21 =========