builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1494345049.96 results: success (0) revision: d715ee055ae7d09acf790e40b6742c5241c7501e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 08:50:49.960853) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 08:50:49.961297) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 08:50:49.961583) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 08:50:49.976776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 08:50:49.977103) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-09 08:50:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.0M=0s 2017-05-09 08:50:51 (34.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137217 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 08:50:50.129051) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 08:50:50.129458) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014378 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 08:50:50.181024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 08:50:50.181626) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d715ee055ae7d09acf790e40b6742c5241c7501e --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 d715ee055ae7d09acf790e40b6742c5241c7501e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-09 08:50:51,677 truncating revision to first 12 chars 2017-05-09 08:50:51,677 Setting DEBUG logging. 2017-05-09 08:50:51,678 attempt 1/10 2017-05-09 08:50:51,678 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d715ee055ae7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-09 08:50:52,149 unpacking tar archive at: mozilla-central-d715ee055ae7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.778134 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 08:50:50.974667) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 08:50:50.974994) ========= script_repo_revision: d715ee055ae7d09acf790e40b6742c5241c7501e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 08:50:50.975400) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 08:50:50.975691) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 08:50:50.985849) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-09 08:50:50.986191) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:50:52 INFO - MultiFileLogger online at 20170509 08:50:52 in /builds/slave/test 08:50:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:50:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:50:52 INFO - {'append_to_log': False, 08:50:52 INFO - 'base_work_dir': '/builds/slave/test', 08:50:52 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:50:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:50:52 INFO - 'branch': 'Firefox-Non-PGO', 08:50:52 INFO - 'buildbot_json_path': 'buildprops.json', 08:50:52 INFO - 'config_files': ('talos/linux_config.py',), 08:50:52 INFO - 'default_actions': ('clobber', 08:50:52 INFO - 'read-buildbot-config', 08:50:52 INFO - 'download-and-extract', 08:50:52 INFO - 'populate-webroot', 08:50:52 INFO - 'create-virtualenv', 08:50:52 INFO - 'install', 08:50:52 INFO - 'run-tests'), 08:50:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:50:52 INFO - 'download_minidump_stackwalk': True, 08:50:52 INFO - 'download_symbols': 'ondemand', 08:50:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:50:52 INFO - 'tooltool.py': '/tools/tooltool.py', 08:50:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:50:52 INFO - '/tools/misc-python/virtualenv.py')}, 08:50:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:50:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:50:52 INFO - 'gecko_profile': False, 08:50:52 INFO - 'gecko_profile_interval': 0, 08:50:52 INFO - 'installer_path': 'installer.exe', 08:50:52 INFO - 'log_level': 'info', 08:50:52 INFO - 'log_name': 'talos', 08:50:52 INFO - 'log_to_console': True, 08:50:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:50:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:50:52 INFO - 'opt_config_files': (), 08:50:52 INFO - 'pip_index': False, 08:50:52 INFO - 'suite': 'dromaeojs-e10s', 08:50:52 INFO - 'system_bits': '32', 08:50:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:50:52 INFO - 'title': 'talos-linux64-ix-068', 08:50:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:50:52 INFO - 'use_talos_json': True, 08:50:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:50:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:50:52 INFO - 'work_dir': 'build'} 08:50:52 INFO - [mozharness: 2017-05-09 15:50:52.581372Z] Running clobber step. 08:50:52 INFO - Running pre-action listener: _resource_record_pre_action 08:50:52 INFO - Running main action method: clobber 08:50:52 INFO - rmtree: /builds/slave/test/build 08:50:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:50:53 INFO - Running post-action listener: _resource_record_post_action 08:50:53 INFO - [mozharness: 2017-05-09 15:50:53.516603Z] Finished clobber step (success) 08:50:53 INFO - [mozharness: 2017-05-09 15:50:53.516704Z] Running read-buildbot-config step. 08:50:53 INFO - Running pre-action listener: _resource_record_pre_action 08:50:53 INFO - Running main action method: read_buildbot_config 08:50:53 INFO - Using buildbot properties: 08:50:53 INFO - { 08:50:53 INFO - "project": "", 08:50:53 INFO - "product": "firefox", 08:50:53 INFO - "who": "ffxbld@noreply.mozilla.org", 08:50:53 INFO - "installer_path": "public/build/target.tar.bz2", 08:50:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:50:53 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:50:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:50:53 INFO - "stage_platform": "linux64", 08:50:53 INFO - "basedir": "/builds/slave/test", 08:50:53 INFO - "buildnumber": 861, 08:50:53 INFO - "platform": "ubuntu64_hw", 08:50:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:50:53 INFO - "slavebuilddir": "test", 08:50:53 INFO - "taskId": "Kpa92e81ToKb6daiMTOGOg", 08:50:53 INFO - "branch": "mozilla-central", 08:50:53 INFO - "script_repo_revision": "production", 08:50:53 INFO - "revision": "d715ee055ae7d09acf790e40b6742c5241c7501e", 08:50:53 INFO - "slavename": "talos-linux64-ix-068", 08:50:53 INFO - "repo_path": "mozilla-central" 08:50:53 INFO - } 08:50:53 INFO - Finding installer, test and symbols from parent task. 08:50:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kpa92e81ToKb6daiMTOGOg'}, attempt #1 08:50:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kpa92e81ToKb6daiMTOGOg'}, attempt #1 08:50:54 INFO - Task dependencies: ZK9AKUeVQXOqHsezmnWD7g 08:50:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g'}, attempt #1 08:50:55 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.tar.bz2 08:50:55 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/test_packages.json 08:50:55 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.crashreporter-symbols.zip 08:50:55 INFO - Running post-action listener: _resource_record_post_action 08:50:55 INFO - [mozharness: 2017-05-09 15:50:55.002785Z] Finished read-buildbot-config step (success) 08:50:55 INFO - [mozharness: 2017-05-09 15:50:55.003001Z] Running download-and-extract step. 08:50:55 INFO - Running pre-action listener: _resource_record_pre_action 08:50:55 INFO - Running main action method: download_and_extract 08:50:55 INFO - mkdir: /builds/slave/test/build/tests 08:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:50:55 INFO - trying https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.test_packages.json 08:50:55 INFO - Downloading https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:50:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:50:55 INFO - Downloaded 986 bytes. 08:50:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:50:55 INFO - Using the following test package requirements: 08:50:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:50:55 INFO - u'common': [u'target.common.tests.zip'], 08:50:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:50:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:50:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:50:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:50:55 INFO - u'mozbase': [u'target.common.tests.zip'], 08:50:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:50:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:50:55 INFO - u'web-platform': [u'target.common.tests.zip', 08:50:55 INFO - u'target.web-platform.tests.zip'], 08:50:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:50:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:50:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.common.tests.zip 08:50:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:50:55 INFO - Fetch https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.common.tests.zip into memory 08:50:56 INFO - Content-Length response header: 58442181 08:50:56 INFO - Bytes received: 58442181 08:51:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:51:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.common.tests.zip 08:51:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:51:06 INFO - Fetch https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.common.tests.zip into memory 08:51:07 INFO - Content-Length response header: 58442181 08:51:07 INFO - Bytes received: 58442181 08:51:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.talos.tests.zip 08:51:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:51:18 INFO - Fetch https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.talos.tests.zip into memory 08:51:18 INFO - Content-Length response header: 14409362 08:51:18 INFO - Bytes received: 14409362 08:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:19 INFO - trying https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.tar.bz2 08:51:19 INFO - Downloading https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:51:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:51:20 INFO - Downloaded 62964471 bytes. 08:51:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.tar.bz2 08:51:20 INFO - mkdir: /builds/slave/test/properties 08:51:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:51:20 INFO - Writing to file /builds/slave/test/properties/build_url 08:51:20 INFO - Contents: 08:51:20 INFO - build_url:https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.tar.bz2 08:51:20 INFO - Running post-action listener: _resource_record_post_action 08:51:20 INFO - Running post-action listener: set_extra_try_arguments 08:51:20 INFO - [mozharness: 2017-05-09 15:51:20.309492Z] Finished download-and-extract step (success) 08:51:20 INFO - [mozharness: 2017-05-09 15:51:20.309588Z] Running populate-webroot step. 08:51:20 INFO - Running pre-action listener: _resource_record_pre_action 08:51:20 INFO - Running main action method: populate_webroot 08:51:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:51:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:51:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:51:20 INFO - '--tppagecycles', 08:51:20 INFO - '7'], 08:51:20 INFO - 'tests': ['tsvgm']}}, 08:51:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:51:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:51:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:51:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:51:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:51:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:51:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:51:20 INFO - 'talos_options': ['--disable-e10s'], 08:51:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:51:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:51:20 INFO - 'talos_options': ['--disable-e10s'], 08:51:20 INFO - 'tests': ['damp', 'tps']}, 08:51:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:51:20 INFO - 'tests': ['damp', 'tps']}, 08:51:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:51:20 INFO - 'tests': ['dromaeo_dom']}, 08:51:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:51:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:51:20 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:51:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:51:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:51:20 INFO - 'tests': ['a11yr', 08:51:20 INFO - 'ts_paint', 08:51:20 INFO - 'tpaint', 08:51:20 INFO - 'sessionrestore', 08:51:20 INFO - 'sessionrestore_no_auto_restore', 08:51:20 INFO - 'tabpaint']}, 08:51:20 INFO - 'other-e10s': {'tests': ['a11yr', 08:51:20 INFO - 'ts_paint', 08:51:20 INFO - 'tpaint', 08:51:20 INFO - 'sessionrestore', 08:51:20 INFO - 'sessionrestore_no_auto_restore', 08:51:20 INFO - 'tabpaint']}, 08:51:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:51:20 INFO - 'ts_paint', 08:51:20 INFO - 'tpaint', 08:51:20 INFO - 'sessionrestore', 08:51:20 INFO - 'sessionrestore_no_auto_restore', 08:51:20 INFO - 'tabpaint']}, 08:51:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:51:20 INFO - 'ts_paint', 08:51:20 INFO - 'tpaint', 08:51:20 INFO - 'sessionrestore', 08:51:20 INFO - 'sessionrestore_no_auto_restore', 08:51:20 INFO - 'tabpaint']}, 08:51:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:51:20 INFO - 'tests': ['a11yr', 08:51:20 INFO - 'ts_paint', 08:51:20 INFO - 'tpaint', 08:51:20 INFO - 'sessionrestore', 08:51:20 INFO - 'sessionrestore_no_auto_restore', 08:51:20 INFO - 'tabpaint']}, 08:51:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:51:20 INFO - 'tests': ['a11yr', 08:51:20 INFO - 'ts_paint', 08:51:20 INFO - 'tpaint', 08:51:20 INFO - 'sessionrestore', 08:51:20 INFO - 'sessionrestore_no_auto_restore', 08:51:20 INFO - 'tabpaint']}, 08:51:20 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:51:20 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:51:20 INFO - 'bloom_basic_ref']}, 08:51:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:51:20 INFO - 'tests': ['tsvgx', 08:51:20 INFO - 'tsvgr_opacity', 08:51:20 INFO - 'tart', 08:51:20 INFO - 'tscrollx', 08:51:20 INFO - 'cart', 08:51:20 INFO - 'tsvg_static']}, 08:51:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:51:20 INFO - 'tsvgr_opacity', 08:51:20 INFO - 'tart', 08:51:20 INFO - 'tscrollx', 08:51:20 INFO - 'cart', 08:51:20 INFO - 'tsvg_static']}, 08:51:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:51:20 INFO - 'talos_options': ['--disable-e10s'], 08:51:20 INFO - 'tests': ['tp5o']}, 08:51:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:51:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:51:20 INFO - 'talos_options': ['--disable-e10s', 08:51:20 INFO - '--xperf_path', 08:51:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:20 INFO - 'tests': ['tp5n']}, 08:51:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:51:20 INFO - 'talos_options': ['--xperf_path', 08:51:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:20 INFO - 'tests': ['tp5n']}}, 08:51:20 INFO - 'talos.zip': {'path': '', 08:51:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:51:20 INFO - Running post-action listener: _resource_record_post_action 08:51:20 INFO - [mozharness: 2017-05-09 15:51:20.323405Z] Finished populate-webroot step (success) 08:51:20 INFO - [mozharness: 2017-05-09 15:51:20.323494Z] Running create-virtualenv step. 08:51:20 INFO - Running pre-action listener: _resource_record_pre_action 08:51:20 INFO - Running main action method: create_virtualenv 08:51:20 INFO - Creating virtualenv /builds/slave/test/build/venv 08:51:20 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 08:51:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:51:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:51:20 INFO - Using real prefix '/usr' 08:51:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:51:20 INFO - Installing distribute.............................................................................................................................................................................................done. 08:51:22 INFO - Installing pip.................done. 08:51:22 INFO - Return code: 0 08:51:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:51:23 INFO - Reading from file tmpfile_stdout 08:51:23 INFO - Output received: 08:51:23 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) 08:51:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1f4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2117a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22baa30>, '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 0x22bb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bbca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', '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 08:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:51:23 INFO - Using env: {'DISPLAY': ':0', 08:51:23 INFO - 'HOME': '/home/cltbld', 08:51:23 INFO - 'LANG': 'en_US.UTF-8', 08:51:23 INFO - 'LANGUAGE': 'en_US:en', 08:51:23 INFO - 'LOGNAME': 'cltbld', 08:51:23 INFO - 'MAIL': '/var/mail/cltbld', 08:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:23 INFO - 'MOZ_NO_REMOTE': '1', 08:51:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:23 INFO - 'NO_EM_RESTART': '1', 08:51:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:23 INFO - 'PWD': '/builds/slave/test', 08:51:23 INFO - 'SHELL': '/bin/bash', 08:51:23 INFO - 'SHLVL': '1', 08:51:23 INFO - 'TERM': 'linux', 08:51:23 INFO - 'TMOUT': '86400', 08:51:23 INFO - 'USER': 'cltbld', 08:51:23 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', 08:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:23 INFO - '_': '/tools/buildbot/bin/python'} 08:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:23 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 08:51:23 INFO - Cleaning up... 08:51:23 INFO - Return code: 0 08:51:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1f4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2117a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22baa30>, '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 0x22bb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bbca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', '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 08:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:51:23 INFO - Using env: {'DISPLAY': ':0', 08:51:23 INFO - 'HOME': '/home/cltbld', 08:51:23 INFO - 'LANG': 'en_US.UTF-8', 08:51:23 INFO - 'LANGUAGE': 'en_US:en', 08:51:23 INFO - 'LOGNAME': 'cltbld', 08:51:23 INFO - 'MAIL': '/var/mail/cltbld', 08:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:23 INFO - 'MOZ_NO_REMOTE': '1', 08:51:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:23 INFO - 'NO_EM_RESTART': '1', 08:51:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:23 INFO - 'PWD': '/builds/slave/test', 08:51:23 INFO - 'SHELL': '/bin/bash', 08:51:23 INFO - 'SHLVL': '1', 08:51:23 INFO - 'TERM': 'linux', 08:51:23 INFO - 'TMOUT': '86400', 08:51:23 INFO - 'USER': 'cltbld', 08:51:23 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', 08:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:23 INFO - '_': '/tools/buildbot/bin/python'} 08:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:23 INFO - Downloading/unpacking psutil>=3.1.1 08:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:51:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:24 INFO - Installing collected packages: psutil 08:51:24 INFO - Running setup.py install for psutil 08:51:25 INFO - building 'psutil._psutil_linux' extension 08:51:25 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 08:51:25 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 08:51:25 INFO - building 'psutil._psutil_posix' extension 08:51:25 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 08:51:25 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 08:51:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:25 INFO - Successfully installed psutil 08:51:25 INFO - Cleaning up... 08:51:25 INFO - Return code: 0 08:51:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1f4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2117a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22baa30>, '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 0x22bb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bbca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', '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 08:51:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:51:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:51:25 INFO - Using env: {'DISPLAY': ':0', 08:51:25 INFO - 'HOME': '/home/cltbld', 08:51:25 INFO - 'LANG': 'en_US.UTF-8', 08:51:25 INFO - 'LANGUAGE': 'en_US:en', 08:51:25 INFO - 'LOGNAME': 'cltbld', 08:51:25 INFO - 'MAIL': '/var/mail/cltbld', 08:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:25 INFO - 'MOZ_NO_REMOTE': '1', 08:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:25 INFO - 'NO_EM_RESTART': '1', 08:51:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:25 INFO - 'PWD': '/builds/slave/test', 08:51:25 INFO - 'SHELL': '/bin/bash', 08:51:25 INFO - 'SHLVL': '1', 08:51:25 INFO - 'TERM': 'linux', 08:51:25 INFO - 'TMOUT': '86400', 08:51:25 INFO - 'USER': 'cltbld', 08:51:25 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', 08:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:25 INFO - '_': '/tools/buildbot/bin/python'} 08:51:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:51:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:51:27 INFO - Installing collected packages: mozsystemmonitor 08:51:27 INFO - Running setup.py install for mozsystemmonitor 08:51:27 INFO - Successfully installed mozsystemmonitor 08:51:27 INFO - Cleaning up... 08:51:27 INFO - Return code: 0 08:51:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:27 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1f4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2117a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22baa30>, '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 0x22bb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bbca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', '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 08:51:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:51:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:51:28 INFO - Using env: {'DISPLAY': ':0', 08:51:28 INFO - 'HOME': '/home/cltbld', 08:51:28 INFO - 'LANG': 'en_US.UTF-8', 08:51:28 INFO - 'LANGUAGE': 'en_US:en', 08:51:28 INFO - 'LOGNAME': 'cltbld', 08:51:28 INFO - 'MAIL': '/var/mail/cltbld', 08:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:28 INFO - 'MOZ_NO_REMOTE': '1', 08:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:28 INFO - 'NO_EM_RESTART': '1', 08:51:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:28 INFO - 'PWD': '/builds/slave/test', 08:51:28 INFO - 'SHELL': '/bin/bash', 08:51:28 INFO - 'SHLVL': '1', 08:51:28 INFO - 'TERM': 'linux', 08:51:28 INFO - 'TMOUT': '86400', 08:51:28 INFO - 'USER': 'cltbld', 08:51:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', 08:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:28 INFO - '_': '/tools/buildbot/bin/python'} 08:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:28 INFO - Downloading/unpacking jsonschema==2.5.1 08:51: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 08:51: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 08:51:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51: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 08:51: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 08:51:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:51:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:51: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 08:51: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 08:51:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51: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 08:51: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 08:51:29 INFO - Downloading functools32-3.2.3-2.tar.gz 08:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:51:29 INFO - warning: no files found matching '*.txt' 08:51:29 INFO - no previously-included directories found matching 'build' 08:51:29 INFO - no previously-included directories found matching 'dist' 08:51:29 INFO - no previously-included directories found matching '.git*' 08:51:29 INFO - Installing collected packages: jsonschema, functools32 08:51:29 INFO - Running setup.py install for functools32 08:51:29 INFO - warning: no files found matching '*.txt' 08:51:29 INFO - no previously-included directories found matching 'build' 08:51:29 INFO - no previously-included directories found matching 'dist' 08:51:29 INFO - no previously-included directories found matching '.git*' 08:51:29 INFO - Successfully installed jsonschema functools32 08:51:29 INFO - Cleaning up... 08:51:29 INFO - Return code: 0 08:51:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1f4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2117a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22baa30>, '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 0x22bb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bbca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', '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 08:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:51:29 INFO - Using env: {'DISPLAY': ':0', 08:51:29 INFO - 'HOME': '/home/cltbld', 08:51:29 INFO - 'LANG': 'en_US.UTF-8', 08:51:29 INFO - 'LANGUAGE': 'en_US:en', 08:51:29 INFO - 'LOGNAME': 'cltbld', 08:51:29 INFO - 'MAIL': '/var/mail/cltbld', 08:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:29 INFO - 'MOZ_NO_REMOTE': '1', 08:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:29 INFO - 'NO_EM_RESTART': '1', 08:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:29 INFO - 'PWD': '/builds/slave/test', 08:51:29 INFO - 'SHELL': '/bin/bash', 08:51:29 INFO - 'SHLVL': '1', 08:51:29 INFO - 'TERM': 'linux', 08:51:29 INFO - 'TMOUT': '86400', 08:51:29 INFO - 'USER': 'cltbld', 08:51:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', 08:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:29 INFO - '_': '/tools/buildbot/bin/python'} 08:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:51:29 INFO - Cleaning up... 08:51:29 INFO - Return code: 0 08:51:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1f4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2117a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22baa30>, '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 0x22bb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bbca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', '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 08:51:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:51:29 INFO - Using env: {'DISPLAY': ':0', 08:51:29 INFO - 'HOME': '/home/cltbld', 08:51:29 INFO - 'LANG': 'en_US.UTF-8', 08:51:29 INFO - 'LANGUAGE': 'en_US:en', 08:51:29 INFO - 'LOGNAME': 'cltbld', 08:51:29 INFO - 'MAIL': '/var/mail/cltbld', 08:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:29 INFO - 'MOZ_NO_REMOTE': '1', 08:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:29 INFO - 'NO_EM_RESTART': '1', 08:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:29 INFO - 'PWD': '/builds/slave/test', 08:51:29 INFO - 'SHELL': '/bin/bash', 08:51:29 INFO - 'SHLVL': '1', 08:51:29 INFO - 'TERM': 'linux', 08:51:29 INFO - 'TMOUT': '86400', 08:51:29 INFO - 'USER': 'cltbld', 08:51:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', 08:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:29 INFO - '_': '/tools/buildbot/bin/python'} 08:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:30 INFO - Downloading/unpacking blobuploader==1.2.4 08:51: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 08:51: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 08:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51: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 08:51: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 08:51:31 INFO - Downloading blobuploader-1.2.4.tar.gz 08:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:51:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:51: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 08:51: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 08:51:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51: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 08:51: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 08:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:51:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:51: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 08:51: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 08:51:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51: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 08:51: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 08:51:31 INFO - Downloading docopt-0.6.1.tar.gz 08:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:51:31 INFO - Installing collected packages: blobuploader, requests, docopt 08:51:31 INFO - Running setup.py install for blobuploader 08:51:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:51:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:51:32 INFO - Running setup.py install for requests 08:51:32 INFO - Running setup.py install for docopt 08:51:32 INFO - Successfully installed blobuploader requests docopt 08:51:32 INFO - Cleaning up... 08:51:32 INFO - Return code: 0 08:51:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:32 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1f4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2117a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22baa30>, '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 0x22bb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bbca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', '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 08:51:32 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:51:32 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:51:32 INFO - Using env: {'DISPLAY': ':0', 08:51:32 INFO - 'HOME': '/home/cltbld', 08:51:32 INFO - 'LANG': 'en_US.UTF-8', 08:51:32 INFO - 'LANGUAGE': 'en_US:en', 08:51:32 INFO - 'LOGNAME': 'cltbld', 08:51:32 INFO - 'MAIL': '/var/mail/cltbld', 08:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:32 INFO - 'MOZ_NO_REMOTE': '1', 08:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:32 INFO - 'NO_EM_RESTART': '1', 08:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:32 INFO - 'PWD': '/builds/slave/test', 08:51:32 INFO - 'SHELL': '/bin/bash', 08:51:32 INFO - 'SHLVL': '1', 08:51:32 INFO - 'TERM': 'linux', 08:51:32 INFO - 'TMOUT': '86400', 08:51:32 INFO - 'USER': 'cltbld', 08:51:32 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', 08:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:32 INFO - '_': '/tools/buildbot/bin/python'} 08:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:32 INFO - Running setup.py (path:/tmp/pip-TtPMFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:32 INFO - Running setup.py (path:/tmp/pip-ZUj0qK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:32 INFO - Running setup.py (path:/tmp/pip-QQ2iW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:32 INFO - Running setup.py (path:/tmp/pip-52o_53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:33 INFO - Running setup.py (path:/tmp/pip-B5wKoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:33 INFO - Running setup.py (path:/tmp/pip-GcG5On-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:33 INFO - Running setup.py (path:/tmp/pip-ifK_Fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:33 INFO - Running setup.py (path:/tmp/pip-1Zckyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:33 INFO - Running setup.py (path:/tmp/pip-yvOz9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:33 INFO - Running setup.py (path:/tmp/pip-xgzqsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:33 INFO - Running setup.py (path:/tmp/pip-x1AFZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:33 INFO - Running setup.py (path:/tmp/pip-i8PGu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:33 INFO - Running setup.py (path:/tmp/pip-VKVL3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:33 INFO - Running setup.py (path:/tmp/pip-HmBLUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:33 INFO - Running setup.py (path:/tmp/pip-Um2SYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:33 INFO - Running setup.py (path:/tmp/pip-Shcml5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:33 INFO - Running setup.py (path:/tmp/pip-Hm1vYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:51:33 INFO - Running setup.py install for manifestparser 08:51:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Running setup.py install for mozcrash 08:51:34 INFO - Running setup.py install for mozdebug 08:51:34 INFO - Running setup.py install for mozdevice 08:51:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Running setup.py install for mozfile 08:51:34 INFO - Running setup.py install for mozhttpd 08:51:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Running setup.py install for mozinfo 08:51:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Running setup.py install for mozInstall 08:51:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Running setup.py install for mozleak 08:51:34 INFO - Running setup.py install for mozlog 08:51:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:51:34 INFO - Running setup.py install for moznetwork 08:51:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:51:35 INFO - Running setup.py install for mozprocess 08:51:35 INFO - Running setup.py install for mozprofile 08:51:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:51:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:51:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:51:35 INFO - Running setup.py install for mozrunner 08:51:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:51:35 INFO - Running setup.py install for mozscreenshot 08:51:35 INFO - Running setup.py install for moztest 08:51:35 INFO - Running setup.py install for mozversion 08:51:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:51:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:51:35 INFO - Cleaning up... 08:51:35 INFO - Return code: 0 08:51:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:35 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1f4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2117a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22baa30>, '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 0x22bb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bbca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', '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 08:51:35 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:51:35 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:51:35 INFO - Using env: {'DISPLAY': ':0', 08:51:35 INFO - 'HOME': '/home/cltbld', 08:51:35 INFO - 'LANG': 'en_US.UTF-8', 08:51:35 INFO - 'LANGUAGE': 'en_US:en', 08:51:35 INFO - 'LOGNAME': 'cltbld', 08:51:35 INFO - 'MAIL': '/var/mail/cltbld', 08:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:35 INFO - 'MOZ_NO_REMOTE': '1', 08:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:35 INFO - 'NO_EM_RESTART': '1', 08:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:35 INFO - 'PWD': '/builds/slave/test', 08:51:35 INFO - 'SHELL': '/bin/bash', 08:51:35 INFO - 'SHLVL': '1', 08:51:35 INFO - 'TERM': 'linux', 08:51:35 INFO - 'TMOUT': '86400', 08:51:35 INFO - 'USER': 'cltbld', 08:51:35 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', 08:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:35 INFO - '_': '/tools/buildbot/bin/python'} 08:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:35 INFO - Running setup.py (path:/tmp/pip-O2fSAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:36 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)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:36 INFO - Running setup.py (path:/tmp/pip-m5D9r6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:36 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)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:36 INFO - Running setup.py (path:/tmp/pip-_SuJV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:36 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)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:36 INFO - Running setup.py (path:/tmp/pip-z2JuJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:36 INFO - Running setup.py (path:/tmp/pip-48YqoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:36 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)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:36 INFO - Running setup.py (path:/tmp/pip-dmNfVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:36 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)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:36 INFO - Running setup.py (path:/tmp/pip-2WKX_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:36 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)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:36 INFO - Running setup.py (path:/tmp/pip-LyPyAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:36 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)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:36 INFO - Running setup.py (path:/tmp/pip-Q3wi5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:36 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)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:36 INFO - Running setup.py (path:/tmp/pip-CYPdOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:36 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)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:36 INFO - Running setup.py (path:/tmp/pip-IiwFNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:36 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)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:36 INFO - Running setup.py (path:/tmp/pip-k5w2TZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:36 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)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:36 INFO - Running setup.py (path:/tmp/pip-bZxI_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:36 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)) 08:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:36 INFO - Running setup.py (path:/tmp/pip-QuDZck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:37 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)) 08:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:37 INFO - Running setup.py (path:/tmp/pip-nrSiwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:37 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)) 08:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:37 INFO - Running setup.py (path:/tmp/pip-lWaZLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:37 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)) 08:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:37 INFO - Running setup.py (path:/tmp/pip-oQSvlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:37 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)) 08:51:37 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)) 08:51:37 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)) 08:51:37 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)) 08:51:37 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:51:37 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:51:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:51:37 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 08:51:37 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 08:51:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:37 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 08:51:37 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 08:51:38 INFO - Downloading blessings-1.6.tar.gz 08:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:51:38 INFO - Installing collected packages: blessings 08:51:38 INFO - Running setup.py install for blessings 08:51:38 INFO - Successfully installed blessings 08:51:38 INFO - Cleaning up... 08:51:38 INFO - Return code: 0 08:51:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:51:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:38 INFO - Reading from file tmpfile_stdout 08:51:38 INFO - Current package versions: 08:51:38 INFO - argparse == 1.2.1 08:51:38 INFO - blessings == 1.6 08:51:38 INFO - blobuploader == 1.2.4 08:51:38 INFO - docopt == 0.6.1 08:51:38 INFO - functools32 == 3.2.3-2 08:51:38 INFO - jsonschema == 2.5.1 08:51:38 INFO - manifestparser == 1.1 08:51:38 INFO - mozInstall == 1.12 08:51:38 INFO - mozcrash == 1.0 08:51:38 INFO - mozdebug == 0.1 08:51:38 INFO - mozdevice == 0.50 08:51:38 INFO - mozfile == 1.2 08:51:38 INFO - mozhttpd == 0.7 08:51:38 INFO - mozinfo == 0.9 08:51:38 INFO - mozleak == 0.1 08:51:38 INFO - mozlog == 3.4 08:51:38 INFO - moznetwork == 0.27 08:51:38 INFO - mozprocess == 0.25 08:51:38 INFO - mozprofile == 0.28 08:51:38 INFO - mozrunner == 6.13 08:51:38 INFO - mozscreenshot == 0.1 08:51:38 INFO - mozsystemmonitor == 0.3 08:51:38 INFO - moztest == 0.8 08:51:38 INFO - mozversion == 1.4 08:51:38 INFO - psutil == 3.1.1 08:51:38 INFO - requests == 1.2.3 08:51:38 INFO - wsgiref == 0.1.2 08:51:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:38 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1f4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2117a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22baa30>, '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 0x22bb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bbca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', '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 08:51:38 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 08:51:38 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:51:38 INFO - Using env: {'DISPLAY': ':0', 08:51:38 INFO - 'HOME': '/home/cltbld', 08:51:38 INFO - 'LANG': 'en_US.UTF-8', 08:51:38 INFO - 'LANGUAGE': 'en_US:en', 08:51:38 INFO - 'LOGNAME': 'cltbld', 08:51:38 INFO - 'MAIL': '/var/mail/cltbld', 08:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:38 INFO - 'MOZ_NO_REMOTE': '1', 08:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:38 INFO - 'NO_EM_RESTART': '1', 08:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:38 INFO - 'PWD': '/builds/slave/test', 08:51:38 INFO - 'SHELL': '/bin/bash', 08:51:38 INFO - 'SHLVL': '1', 08:51:38 INFO - 'TERM': 'linux', 08:51:38 INFO - 'TMOUT': '86400', 08:51:38 INFO - 'USER': 'cltbld', 08:51:38 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', 08:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:38 INFO - '_': '/tools/buildbot/bin/python'} 08:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 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)) 08:51:39 INFO - Cleaning up... 08:51:39 INFO - Return code: 0 08:51:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:39 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x1f4b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2117a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22bd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22baa30>, '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 0x22bb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bbca0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', '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 08:51:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:51:39 INFO - Using env: {'DISPLAY': ':0', 08:51:39 INFO - 'HOME': '/home/cltbld', 08:51:39 INFO - 'LANG': 'en_US.UTF-8', 08:51:39 INFO - 'LANGUAGE': 'en_US:en', 08:51:39 INFO - 'LOGNAME': 'cltbld', 08:51:39 INFO - 'MAIL': '/var/mail/cltbld', 08:51:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:39 INFO - 'MOZ_NO_REMOTE': '1', 08:51:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:39 INFO - 'NO_EM_RESTART': '1', 08:51:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:39 INFO - 'PWD': '/builds/slave/test', 08:51:39 INFO - 'SHELL': '/bin/bash', 08:51:39 INFO - 'SHLVL': '1', 08:51:39 INFO - 'TERM': 'linux', 08:51:39 INFO - 'TMOUT': '86400', 08:51:39 INFO - 'USER': 'cltbld', 08:51:39 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', 08:51:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:39 INFO - '_': '/tools/buildbot/bin/python'} 08:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:51:39 INFO - Cleaning up... 08:51:39 INFO - Return code: 0 08:51:39 INFO - Running post-action listener: _resource_record_post_action 08:51:39 INFO - Running post-action listener: _start_resource_monitoring 08:51:39 INFO - Starting resource monitoring. 08:51:39 INFO - [mozharness: 2017-05-09 15:51:39.321715Z] Finished create-virtualenv step (success) 08:51:39 INFO - [mozharness: 2017-05-09 15:51:39.322431Z] Running install step. 08:51:39 INFO - Running pre-action listener: _resource_record_pre_action 08:51:39 INFO - Running main action method: install 08:51:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:39 INFO - Reading from file tmpfile_stdout 08:51:39 INFO - Detecting whether we're running mozinstall >=1.0... 08:51:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:51:39 INFO - Reading from file tmpfile_stdout 08:51:39 INFO - Output received: 08:51:39 INFO - Usage: mozinstall [options] installer 08:51:39 INFO - Options: 08:51:39 INFO - -h, --help show this help message and exit 08:51:39 INFO - -d DEST, --destination=DEST 08:51:39 INFO - Directory to install application into. [default: 08:51:39 INFO - "/builds/slave/test"] 08:51:39 INFO - --app=APP Application being installed. [default: firefox] 08:51:39 INFO - mkdir: /builds/slave/test/build/application 08:51:39 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'] 08:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:51:55 INFO - Reading from file tmpfile_stdout 08:51:55 INFO - Output received: 08:51:55 INFO - /builds/slave/test/build/application/firefox/firefox 08:51:55 INFO - Running post-action listener: _resource_record_post_action 08:51:55 INFO - [mozharness: 2017-05-09 15:51:55.378481Z] Finished install step (success) 08:51:55 INFO - [mozharness: 2017-05-09 15:51:55.378754Z] Running run-tests step. 08:51:55 INFO - Running pre-action listener: _resource_record_pre_action 08:51:55 INFO - Running main action method: run_tests 08:51:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:51:55 INFO - Python 2.7.3 08:51:55 INFO - Return code: 0 08:51:55 INFO - grabbing minidump binary from tooltool 08:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 08:51:55 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 0x22baa30>, '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 0x22bb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22bbca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:51:55 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 08:51:55 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 08:51:55 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 08:51:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:51:55 INFO - Return code: 0 08:51:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:51:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:51:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:51:55 INFO - ENV: RUST_BACKTRACE is now 1 08:51:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:51:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:51:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:51:55 INFO - Using env: {'DISPLAY': ':0', 08:51:55 INFO - 'HOME': '/home/cltbld', 08:51:55 INFO - 'LANG': 'en_US.UTF-8', 08:51:55 INFO - 'LANGUAGE': 'en_US:en', 08:51:55 INFO - 'LOGNAME': 'cltbld', 08:51:55 INFO - 'MAIL': '/var/mail/cltbld', 08:51:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:51:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:55 INFO - 'MOZ_NO_REMOTE': '1', 08:51:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:55 INFO - 'NO_EM_RESTART': '1', 08:51:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:55 INFO - 'PWD': '/builds/slave/test', 08:51:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:51:55 INFO - 'RUST_BACKTRACE': '1', 08:51:55 INFO - 'SHELL': '/bin/bash', 08:51:55 INFO - 'SHLVL': '1', 08:51:55 INFO - 'TERM': 'linux', 08:51:55 INFO - 'TMOUT': '86400', 08:51:55 INFO - 'USER': 'cltbld', 08:51:55 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338', 08:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:55 INFO - '_': '/tools/buildbot/bin/python'} 08:51:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:51:55 INFO - mozversion application_buildid: 20170509150440 08:51:55 INFO - mozversion application_changeset: d715ee055ae7d09acf790e40b6742c5241c7501e 08:51:55 INFO - mozversion application_display_name: Nightly 08:51:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:51:55 INFO - mozversion application_name: Firefox 08:51:55 INFO - mozversion application_remotingname: firefox 08:51:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:51:55 INFO - mozversion application_vendor: Mozilla 08:51:55 INFO - mozversion application_version: 55.0a1 08:51:55 INFO - mozversion platform_buildid: 20170509150440 08:51:55 INFO - mozversion platform_changeset: d715ee055ae7d09acf790e40b6742c5241c7501e 08:51:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:51:55 INFO - mozversion platform_version: 55.0a1 08:51:55 INFO - using testdate: 1494345115 08:51:55 INFO - actual date: 1494345115 08:51:55 INFO - starting webserver on 'localhost:40509' 08:51:55 INFO - SUITE-START | Running 2 tests 08:51:55 INFO - TEST-START | dromaeo_css 08:51:55 INFO - operating with platform_type : linux_ 08:51:55 INFO - Initialising browser for dromaeo_css test... 08:51:55 INFO - TEST-INFO | started process 30973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPrRCYn/profile http://localhost:40509/getInfo.html) 08:51:59 INFO - PID 30973 | __metrics Screen width/height:1600/1200 08:51:59 INFO - PID 30973 | colorDepth:24 08:51:59 INFO - PID 30973 | Browser inner width/height: 1024/695 08:51:59 INFO - PID 30973 | __metrics 08:52:01 INFO - TEST-INFO | 30973: exit 0 08:52:01 INFO - Browser initialized. 08:52:01 INFO - Running cycle 1/1 for dromaeo_css test... 08:52:01 INFO - TEST-INFO | started process 31144 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPrRCYn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:13 INFO - PID 31144 | RSS: Main: 155877376 08:52:13 INFO - PID 31144 | 08:55:18 INFO - PID 31144 | Cycle 1(1): loaded http://localhost:40509/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40509/tests/dromaeo/cssquery-ext.html) 08:55:21 INFO - PID 31144 | RSS: Main: 165982208 08:55:21 INFO - PID 31144 | 08:58:23 INFO - PID 31144 | Cycle 1(1): loaded http://localhost:40509/tests/dromaeo/cssquery-ext.html (next: http://localhost:40509/tests/dromaeo/cssquery-jquery.html) 08:58:23 INFO - PID 31144 | RSS: Main: 161185792 08:58:23 INFO - PID 31144 | 09:01:25 INFO - PID 31144 | Cycle 1(1): loaded http://localhost:40509/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40509/tests/dromaeo/cssquery-mootools.html) 09:01:26 INFO - PID 31144 | RSS: Main: 169553920 09:01:26 INFO - PID 31144 | 09:04:28 INFO - PID 31144 | Cycle 1(1): loaded http://localhost:40509/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40509/tests/dromaeo/cssquery-prototype.html) 09:04:28 INFO - PID 31144 | RSS: Main: 160452608 09:04:28 INFO - PID 31144 | 09:07:31 INFO - PID 31144 | Cycle 1(1): loaded http://localhost:40509/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40509/tests/dromaeo/cssquery-yui.html) 09:07:32 INFO - PID 31144 | RSS: Main: 164552704 09:07:32 INFO - PID 31144 | 09:10:34 INFO - PID 31144 | Cycle 1(1): loaded http://localhost:40509/tests/dromaeo/cssquery-yui.html (next: http://localhost:40509/tests/dromaeo/cssquery-dojo.html) 09:10:34 INFO - PID 31144 | RSS: Main: 168730624 09:10:34 INFO - PID 31144 | 09:10:34 INFO - PID 31144 | __start_tp_report 09:10:34 INFO - PID 31144 | _x_x_mozilla_page_load 09:10:34 INFO - PID 31144 | _x_x_mozilla_page_load_details 09:10:34 INFO - PID 31144 | |i|pagename|runs| 09:10:34 INFO - PID 31144 | |0;dojo.html;2710.647615809945;2729.727027297269;2734.740199681031;2758.2690586994445;2759.2136241171256;5266.236395722627;5325.733713314334;5326.573874090069;5345.545628621567;5352.545033672132;5336.67979921205;5345.839624811252;5363.356397232328;5457.754401051952;5470.097433923408;4666.76666166692;4748.1690704126895;4767.785449654756;4792.400949881265;4820.469748327681;4825.372701548794;4839.201531747258;4840.854774356775;4843.176659967814;4844.5155484451625;4679.532046795327;4705.106029854351;4745.667803253774;4754.595859351959;4828.130936431441;4721.173794585968;4736.194846876039;4741.857744267678;4771.427428708577;4795.280707893844;4629.768511574408;4674.789634466457;4698.976505117453;4702.31816386622;4718.457377401608;5207.3490813648295;5262.236975638511;5291.892079517229;5292.708901010443;5315.574754019669;5720.1991721159075;5725.312962444534;5733.283339582552;5735.569832262555;5738.713064346808;5702.287214098238;5704.258446401941;5711.114777209539;5715.142728590703;5754.798582049608;5253.763580638881;5308.336457942757;5313.256144139824;5317.042932272189;5317.042932272228;5891.499222566044;5913.46778789911;5961.582689211714;6000.369961154103;6005.669688167192;5644.322681278273;5703.800366987136;5709.857253568694;5710.314762228559;5715.114157305541;5717.2281741965135;5739.741711622987;5745.770169193269;5748.655080695172;5767.625104368202;5601.467860553241;5713.800016999468;5720.456556627114;5722.971385143131;5733.713314334266;5640.464155905182;5696.23100881384;5726.198332233491;5737.024705800024;5740.397258287903;4782.928256076161;4801.231802911518;4807.351007613997;4817.470078291385;4820.566149046533;4132.173565286895;4140.047789008545;4159.480064991876;4189.476315460567;4199.265128602482;4937.555619994146;4948.158813001798;4948.4309304429735;4957.256411538226;5003.174476211457;5717.399673034354;5731.054376027909;5736.942630573641;5781.624194427349;5799.739011744482;4952.702837829742;4975.825846095442;4976.751162441863;4982.10322142018;4984.725840078758;5178.119719647669;5178.378594568676;5187.455317191716;5219.42586315505;5224.346956630421;5290;5305.575553955597;5347.705876176692;5352.036633405946;5354.036273470657;5703.600747947604;5808.419158084158;5812.3025236971835;5821.185034095315;5873.882522349443;5336.759845807026;5336.946630533645;5356.410794812489;5377.758000889891;5380.246765452762;5669.262995810518;5682.602217844711;5790.7973220937065;5800.332961709458;5809.360970293349;5806.709664516673;5854.121881717776;5860.120981852586;5880.970595146997;5887.911681324698;5607.130894711327;5612.130119831432;5620.072688006433;5620.915686264628;5660.433956604306;5574.693391863487;5576;5598.916016259678;5604.971975140098;5608.635438696471;5432.538234249975;5461.590380721383;5483.040467918018;5485.149801780731;5486.6982315973;5585.408158674758;5594.720263986703;5613.326400831927;5632.380438151718;5645;5475.780968761205;5494.2582751328055;5588.804391846266;5594.4125866785025;5603.579731520071 09:10:34 INFO - PID 31144 | |1;ext.html;684.4045680258176;695.9756408525701;1035.5184839049841;1059.35908775191;1139.8062329404002;31288.374232515336;32118;32145.517817232732;32238.516422253626;32312.67687323132;29927;29944.85027574859;30188.54717179244;30240;30325;5159.664621799589;5328.094223981932;6449.871002579957;6578.309277525838;6812.114425124727;6850.451963842881;7003.5097543172;7013.158420989488;7017.473689473284;7019;6995.860082798341;7058.188308344529;7072.504924655276;7073.398761105313;7085.397741192005;7015.964920175392;7039.401650859683;7050.365467107934;7050.506464547484;7053.118360204974;6949.5830250184645;6967.965160174217;7007.369336759665;7012.929870701279;7015.754448594274;30013.699863001308;30345.393092138256;30471.238219044702;30522.236944076354;30557.08328750141;3061.4948533491947;3108.844557772125;3111.735502482292;3115.641701204368;3131.4519959007084;23898.283051508482;24003.51992960131;24310.270691879272;24331.513369732682;24341.026358945623;2977.6129103216444;2979.55306703994;2983.2690990707415;3005.1735772662473;3014.201236672284;141224.99999999898;141549.2922535391;142198;142293;142699.28650356786;37181.81409092991;39130.217395651925;39145;39232.2153556933;39830.203395931916;40373.798131009156;40811.38782918259;40870.38694419586;42810.35784463236;43555.12889742188;12324.876751232552;12373.319467429377;12439.440225189888;12447.439865206088;12456.190347627557;9830.852537211947;9854.852177217348;9856.457894815854;9859.781549151527;9876.901230987742;12580.748385032432;12632.115751897463;12664.87335126637;12770.489180432864;12845.550405735754;5296.735163241822;5316.229146773773;5338.9466105339225;5423.566114710814;5429.837104886859;886.1094599927161;916.1159481100769;927.0682963621517;928.7306681062416;934.7289286106953;20641.587168256552;21793.23723669664;24566.385840354134;26669.866650666623;26706.866465667936;971.9805603887883;972.6887396033202;975.2052077556768;979.6816034788723;988.41189492252;11597.304161750153;11735.295882247092;11738.471768770425;11763.117766167572;11831.645050648494;167563;167563;168014;168349;169322;40365.59634403677;40529.18941621151;40616.39075413871;40687;40864.38703419451;1199.1522727606525;1217.2392254840724;1231.3658465890073;1232.969175770613;1232.9815052774215;20198.697019544426;20387.310918488532;21277.78722212758;24493.632595510724;24948.12681556137;38680;38684.80657596807;38970.80514597409;39043.609563905135;39174.412383813695;153469;154113;154492;154812.22593886958;155132.2243388821;28994.420111598072;29386.853065734533;29414.793890457873;29475.905029971545;29511.704882950897;34593.13517162091;34732.65267347294;35389.646103539664;35782.64217357793;35919.46120808242;26753.464930700888;26996.865015674797;27049.59425608657;27703.030393936115;28436.132231899075;26473.735262647126;26581.867090664422;27472;28391.43217135687;28662.856685716437;29225.56161657534;29757.702422975493;30227.546586800774;30282.697173028868;30318.54522182125;32263;33767.15582110368;34118.82940585281;34154.658453416145;34984.825075874454;25762.87118564395;27935.720642794124;28292.717072829833;28419;28598 09:10:34 INFO - PID 31144 | |2;jquery.html;421.481577659479;422.2399680574964;424.57542457542456;425.1645516559959;453.65295548905095;16941.322347106117;17715.82284177158;17724.46826595204;18525.722114168297;19180.90409547954;19017.239310427565;19224.42326730197;19283.325083622076;19346.903265483652;19413.708794368096;5392.110301800199;5861.8827623447505;6135.141080248769;6136.202293701813;6183.969080154593;6030.66831324277;6123.448889599935;6125.663088530129;6132.938670613281;6161.045038019091;5965.403459654021;6146.631202127886;6152.32324444313;6179.104029915659;6182.567220294582;5928.140419639171;5997.790077347272;6060.575759696823;6084.6349219047;6108.267007959029;5890.322612899486;5922.615030023035;5928.051511758098;5954.761809527614;5970.13433052205;23264.302070937898;23866.28401147968;24238.515229695484;24422.26733198007;24759.50480990388;1725.05984238589;1748.466717651116;1750.422360620992;1752.9211185496683;1761.075435396427;16094.678106437806;16171.83828161715;16701.749473757904;16761.91619041897;16796.496105116865;1709.401709401712;1726.2749645149067;1730.0657644871753;1758.832910873465;1764.700000999833;88274.55862720645;88529;89042.5547872263;89506;91023.54488227516;17962.820371796377;18706.90646546786;18769.34307299238;18784;18850.71723924142;33584.83207583946;33898.37286610542;33906.66093339035;34065.82967085149;34216.82891585576;8523.147685231428;8627.799911022774;8656.567171641393;8729.650813967497;8946.68686595966;6863.725450982005;6875.896861547081;7024.543404678781;7058.258882817333;7082.681279342442;9047.230985366186;9196.838742895414;9445.66940157105;9580.120051379203;9622;3564.821758912044;3808.1622043151015;3908.882733517999;3995.800209989547;4004.6796256299426;842.3008902610818;843.8185790055045;868;880.5641207602278;893.5934149961752;17022.404215852384;17190.570235743955;17295.394661186798;17482.03848788329;18066.458006259832;884.6682494064726;885.9069797671152;886.3751055505853;898.0570401078841;909.286210324905;9327.626894924128;9641.758956026015;9735;9761.707148785548;9861.753456163653;335806;340478;342784;343424;343829;73955;75537.62231188809;77400.61299693465;77548.61225693836;78190.60904695553;1008.4907121903539;1031.2059714020163;1058.2433560004633;1064.164630764846;1065.1585247654266;14585.708285834437;14742.484013059491;14854.925725371304;14901.478448254258;15480.303386347416;37269.813650931574;37544.81227593954;38180.809095955454;38892.42964408686;39445.408318875816;45983.54016459793;46620.7668961653;46715;47031.294530581385;48996;7806.219378062148;8163.755087347389;10411.21915856329;10594.152467802403;10909.890901090888;11658.358790266617;11872.465739041936;12514;12559.43482543306;12707.93646031764;10223.131033862204;10449.21630877672;10776;10874.130069594255;10880;10014.549345279334;10213.84679229827;10325.535350909076;10432.739181520523;10596.417197054236;10857.67426977192;10996.28524145928;11004;11063.72340691489;11434.771304573696;8181.959090204511;8375.036870759941;8526.720991851023;8547.316214702685;8560.315174786127;10440.738981525523;10508.632197873038;10708.250422470352;10716.249862509549;10748.408837514013 09:10:34 INFO - PID 31144 | |3;mootools.html;1250.7123361626827;1320.353027016762;1321.762082825091;1322.3784821134066;1324.271650592174;9632.80734385312;9904.702858914245;10068.899311006888;10175.542100605471;10232.641857534969;10107.241956853228;10257.846132308021;10270.845937310927;10291.742706432324;10405;2261.570301642687;2284.64587988862;2294.816414686821;2303.562323158603;2308.226744040748;2147.119680930811;2189.6606026065983;2201.5486825200874;2205.151016858513;2207.9006444710026;2183.0612836480386;2214.3578362275002;2229.308914236584;2240.7535171131162;2241.9439514012115;2069.649998540431;2097.381272524609;2122.0238690202527;2122.564874200785;2125.914963401462;2072.9170833166654;2092.487340601562;2100.684897265407;2191.594555007329;2193.5503221839485;10113.646022389255;10230.693079207636;10384.221183411275;10407.53166107527;10418.21863360251;5598.720063996825;5808.97095514524;5832.445917637818;5835.533157347402;5861.17943487912;3151.2909595341093;3388.1868351595685;3388.711959483422;3441.1397150712323;3474.878379256739;1051.963181288659;1068.1614932278203;1078.4715489410212;1087.9673609791719;1099.3513826842122;14693.118412895154;14922.552323430315;14967.251637418085;15034.398624055024;15048.699026019418;4558;4686.179918514246;4908.4846091160625;4961.280614310905;4967.230079337708;10310.278280520291;10344.431056291825;10366.585336586451;10367.533460994273;10388.272820902464;5441.319835020622;5463.426340234298;5484.122540393598;5491.039068163055;5499.450054994549;4980.601551875841;5044.2937988681615;5101.413337466165;5131.204663277198;5191.532762051434;3753.399456087013;3812.7902965336616;3824.8852534424013;3844.461775351453;3931.9606803932165;1119.1326721790676;1122.4387806096952;1125.2573301620891;1135.8920902514249;1144.1819099343843;679.2596070283415;715.1132595581441;717.2074857282628;734.717133903451;735.724103461202;5368.4631536846;5373.76403427214;5499.130295699481;5570.58220633446;5617.578681598897;536.1207619503939;549.7443688684781;551.3631755322609;552.8700755322496;555.0314700847048;3727.4781530585738;3904.316744569689;3921.058945852975;3922.2351641429645;4405.977970110129;13008.089433739548;13546.59360219195;13583.049186556846;13590.524331648345;13613.591592252249;12862.356882155855;13267.867321326663;13295.601131966056;13318.733625327439;13324.866751332556;7493.887591686129;7703.576303303372;7719.150893401721;7729.574873382018;7733.2266773323345;5943.970280148572;5954.76180952757;6018.638881667114;6105.9084113737445;6175.44421002112;11563.36401497892;11794.941025294818;12065.81901271464;12202.267863928193;12249.203801752858;11886.524539018343;12189.207701499374;12201.69495762613;12375.814362784386;12408.193467424588;7664.31021208094;7883.408744344082;7985.680572777024;8002.51984880909;8002.51984880909;9037;9231.399959002643;9236.307276954121;9248.815023699623;9254.583543740413;7873.488223265469;7891.605419728876;8367.414281000272;8385.95807020961;8532;7930.920690793018;8020.598970051591;8032.357411406956;8051.355891528547;8212.917870821455;7121.4302855770375;7288.12542494904;7294.671739771829;7303.926960730325;7306.561606303639;5095.796168153232;5124.718140502308;5128.333316668809;5187.559057480156;5384.596155288447;5326.387465441524;5359.490848369399;5394.622376433769;5395.838124856261;5558.221848941071 09:10:34 INFO - PID 31144 | |4;prototype.html;365.79149884565794;387.08261420433575;387.80222086735773;388.20030736682435;390.8417091078114;5315.468453154683;5455.1544510600825;5496.340439147303;5595.552355811536;5618.859528511784;5329.413764485904;5425.6202065855305;5434.266374039504;5470.316210473691;5476.288082549273;4330.6142034548875;4366.345048242773;4374.78126093694;4375.562443755631;4382;4319.438472998506;4335.7181783184;4372.147431250907;4387.670924680646;4393.340998850166;4309.952772433085;4315.525292217853;4328.761918094504;4345.739255644656;4346.391505189276;4309.116631090619;4311.8706438806885;4335.674824388152;4345.565443455661;4359.10638319147;3888.4933457472926;3934.1148241645687;3959.7030222733124;3966.801659916993;3980.6315242430705;5360.544353729938;5376.327959005124;5380.569554435675;5396.271503347037;5399.815143263962;5173.482651734834;5178.300929374562;5182.507661772125;5188.948110518884;5192.61055420845;5537.446255374471;5772.682502462363;5807.764010855851;5903.970480147572;5921.230240068807;4362.8909277268;4377.102693947765;4380.474343078819;4395.692261562674;4433.312836510346;5972.731227094748;6136.631802091889;6161.938380616226;6178.227721534809;6230.532710046719;4303.139372125587;4314.094040251583;4327.091310824699;4328.783560821947;4340.283853164256;4394.934075988863;4399.604035636744;4414.448193975753;4415.278041563793;4418.293073108287;4922.095963381622;4969.2546118081855;4979.825706100269;5035.697858128524;5093.54158125763;5854.385289544622;5859.677717725566;5862.941370586324;5865.741689449593;5874.73563689635;1597.3770229610461;1620.554347554432;1622.9350825966828;1623.2046297314232;1626.7397216445313;1122.629532254354;1124.2748427264369;1125.93599048898;1135.7728454309172;1149.3046706742468;5050.621203409759;5069.366329208849;5069.847904562869;5101;5123.795048198105;6054.941319951237;6085.391460853968;6087.817365479043;6091.5735898487565;6098.14625952367;4936.432310284292;5023.2214006829;5042.873928151752;5092.312537807423;5107.8723031923755;3185.792923459968;3210.3258315753487;3212.5181222816764;3218.3563287342627;3226.5644138041534;5501.339839219319;5593.412691667317;5613.073842815971;5616.66300022;5640.717964101778;6170.475509581646;6182.258129024546;6212.049276593672;6222.417696655928;6232.883558220889;5489.258950041693;5594.216809646653;5594.804181853616;5619.578531610146;5648.096304591246;6030.276366836008;6030.427109424598;6051.5173782421825;6054.243219597551;6081.331053584191;5752.827415177551;5874.530037596896;5896.852578685567;5935.643861368331;5951.434613711691;5555.111182210827;5599.160125981135;5601.971990140023;5615.943840561706;5617;4031.0527026149416;4039.384246301503;4060.411240370189;4063.796810159421;4064.979675101724;5975.43233392827;6069.089636554552;6070.301915279622;6120.693965301806;6124.387561244018;5840.8247752567495;5845.210896528914;5858.824235272778;5878.911816322844;5886.323072846506;5690.829275121753;5850.94149058504;5857.355690873916;5866.325372582208;5867.647941123546;5705.857353566194;5728.455796699307;5762.164486149569;5762.740676669644;5773.826785196451;5902.291724993029;5912.970435147797;5925;5925.911111333247;5950.732217050329;5596.38439771633;5671.532883195823;5732.910746958065;5733.241409630081;5760.423957604374 09:10:34 INFO - PID 31144 | |5;yui.html;631.8294060603637;635.402721441845;713.8037039814051;715.8675645005675;737.8413641067172;13260.933695331521;13695.452181912724;13699.041067125305;14306.642333941656;16294.511164665078;15811.209439528006;15935.20323983802;16001.19994000301;16078.5980350491;16625.08562029088;890.8975467821218;906.2342320738965;907.8138981508774;910.635745701718;912.3886995712888;876.0626130040858;911.7674992876807;918.9172974432299;925.4956048953337;927.7958849053198;961;969.6218474794836;971.2424309038961;974.1086905481511;975.8145952269047;954.2699834626517;960.8606752020918;967.8548217767321;969.7866469376726;974.4640447753743;700.8913618389158;703.2405002597183;704.2359040441128;712.8289210589473;713.2332742302046;14108.294585270696;14267.500637477742;14290.64273393163;14330.426782928671;14331.140131592034;16036.278367473491;16213.756793648105;16610.086445245506;16640.167991600494;16815.327386904508;12771.936140319332;12841.357932103358;12939.417726202344;13016.219026858324;13088.083834131614;2715.334742987961;2740.931476713098;2750.2711781377952;2763.8894444222205;2771.016289217339;72644;74291.25708742898;74450.62774686146;75098.62450687822;75199;12281.263124212575;12412.069094817925;12416.937915310546;12446.751064978649;12546.372681365896;21765.78234217669;22090.226842060452;22341.329760107223;22368;22528.774712252667;5925.703714814242;5972.25346831646;6132.570720049643;6226.097215903668;6230.7507699691505;2891.7108289170915;2925.195571217932;2938.14793709826;2940.6765255821842;2945.558166275076;3457.567804024497;3492;3549.7337699672626;3569.0720412692885;3571.1072231942017;764.8432071425344;774.3379410603852;775.5966897213531;776.8912352270687;784.3098073695226;556.168528050567;579.2161865312572;581.760617378611;582.280615610471;582.7922400270044;9742.269329800294;10273.126784223276;10510.684679459628;10642.627508037182;10731.785364292671;560.1457776890275;561.3236050559067;562.353293712226;572.8252882870681;581.1863391252197;4274.422952901381;4412.558744125626;4412.889677758018;4420.646348292129;4550.362949187116;64464;64788.67605661941;64846.35153648497;66113;66466.33533664698;57261.71369143211;57881;57903.71048144732;60202.38785672874;61523.6923815378;51586.48413515817;51910.22134667983;51933.74033129886;52863.73568132212;53498.732506338;8599.355048371272;8651.653933842575;8678.652853886026;8745.431546949429;8750.343724220582;26492.205233843015;27435.31411714723;27831.16506504727;27990.160295191177;28758.424831502834;32284.83857580791;32383.352332952738;32830.83584582062;33234.83382583072;44618.330725038504;12147.271163730204;12172.817407739069;12236.632901012983;12417.06871984623;12459.439325230205;15377.69244615079;15530.378784848932;15742.370305187664;15945.920270398574;16227;12703.809442858179;12779.680507987374;13006.414711337824;13026.153300035467;13027.413766380347;14665.706685866437;14722.852771472577;14745.705085898437;14785.630359240675;15003.399864005754;13445;13538.187708737507;13659.863401366256;13669.111507751964;14023.088499247924;9968.651097211563;10194.082532571807;10380.532876020447;10468.68593942183;10876.45617719095;10260.384376937407;10671.092957098734;10895.182861285593;11119.05488033494;11352.432378381212 09:10:34 INFO - PID 31144 | __end_tp_report 09:10:34 INFO - PID 31144 | __start_cc_report 09:10:34 INFO - PID 31144 | _x_x_mozilla_cycle_collect,355 09:10:34 INFO - PID 31144 | __end_cc_report 09:10:34 INFO - PID 31144 | __startTimestamp1494346234508__endTimestamp 09:10:34 INFO - PID 31144 | 09:10:34 INFO - PID 31144 | ------- Summary: start ------- 09:10:34 INFO - PID 31144 | Number of tests: 6 09:10:34 INFO - PID 31144 | 09:10:34 INFO - PID 31144 | [#0] dojo.html Cycles:165 Average:5268.69 Median:5380.25 stddev:621.36 (11.5%) stddev-sans-first:589.97 09:10:34 INFO - PID 31144 | Values: 2710.6 2729.7 2734.7 2758.3 2759.2 5266.2 5325.7 5326.6 5345.5 5352.5 5336.7 5345.8 5363.4 5457.8 5470.1 4666.8 4748.2 4767.8 4792.4 4820.5 4825.4 4839.2 4840.9 4843.2 4844.5 4679.5 4705.1 4745.7 4754.6 4828.1 4721.2 4736.2 4741.9 4771.4 4795.3 4629.8 4674.8 4699.0 4702.3 4718.5 5207.3 5262.2 5291.9 5292.7 5315.6 5720.2 5725.3 5733.3 5735.6 5738.7 5702.3 5704.3 5711.1 5715.1 5754.8 5253.8 5308.3 5313.3 5317.0 5317.0 5891.5 5913.5 5961.6 6000.4 6005.7 5644.3 5703.8 5709.9 5710.3 5715.1 5717.2 5739.7 5745.8 5748.7 5767.6 5601.5 5713.8 5720.5 5723.0 5733.7 5640.5 5696.2 5726.2 5737.0 5740.4 4782.9 4801.2 4807.4 4817.5 4820.6 4132.2 4140.0 4159.5 4189.5 4199.3 4937.6 4948.2 4948.4 4957.3 5003.2 5717.4 5731.1 5736.9 5781.6 5799.7 4952.7 4975.8 4976.8 4982.1 4984.7 5178.1 5178.4 5187.5 5219.4 5224.3 5290.0 5305.6 5347.7 5352.0 5354.0 5703.6 5808.4 5812.3 5821.2 5873.9 5336.8 5336.9 5356.4 5377.8 5380.2 5669.3 5682.6 5790.8 5800.3 5809.4 5806.7 5854.1 5860.1 5881.0 5887.9 5607.1 5612.1 5620.1 5620.9 5660.4 5574.7 5576.0 5598.9 5605.0 5608.6 5432.5 5461.6 5483.0 5485.1 5486.7 5585.4 5594.7 5613.3 5632.4 5645.0 5475.8 5494.3 5588.8 5594.4 5603.6 09:10:34 INFO - PID 31144 | 09:10:34 INFO - PID 31144 | [#1] ext.html Cycles:180 Average:30422.51 Median:30496.74 stddev:39963.88 (131.0%) stddev-sans-first:40013.60 09:10:34 INFO - PID 31144 | Values: 684.4 696.0 1035.5 1059.4 1139.8 31288.4 32118.0 32145.5 32238.5 32312.7 29927.0 29944.9 30188.5 30240.0 30325.0 5159.7 5328.1 6449.9 6578.3 6812.1 6850.5 7003.5 7013.2 7017.5 7019.0 6995.9 7058.2 7072.5 7073.4 7085.4 7016.0 7039.4 7050.4 7050.5 7053.1 6949.6 6968.0 7007.4 7012.9 7015.8 30013.7 30345.4 30471.2 30522.2 30557.1 3061.5 3108.8 3111.7 3115.6 3131.5 23898.3 24003.5 24310.3 24331.5 24341.0 2977.6 2979.6 2983.3 3005.2 3014.2 141225.0 141549.3 142198.0 142293.0 142699.3 37181.8 39130.2 39145.0 39232.2 39830.2 40373.8 40811.4 40870.4 42810.4 43555.1 12324.9 12373.3 12439.4 12447.4 12456.2 9830.9 9854.9 9856.5 9859.8 9876.9 12580.7 12632.1 12664.9 12770.5 12845.6 5296.7 5316.2 5338.9 5423.6 5429.8 886.1 916.1 927.1 928.7 934.7 20641.6 21793.2 24566.4 26669.9 26706.9 972.0 972.7 975.2 979.7 988.4 11597.3 11735.3 11738.5 11763.1 11831.6 167563.0 167563.0 168014.0 168349.0 169322.0 40365.6 40529.2 40616.4 40687.0 40864.4 1199.2 1217.2 1231.4 1233.0 1233.0 20198.7 20387.3 21277.8 24493.6 24948.1 38680.0 38684.8 38970.8 39043.6 39174.4 153469.0 154113.0 154492.0 154812.2 155132.2 28994.4 29386.9 29414.8 29475.9 29511.7 34593.1 34732.7 35389.6 35782.6 35919.5 26753.5 26996.9 27049.6 27703.0 28436.1 26473.7 26581.9 27472.0 28391.4 28662.9 29225.6 29757.7 30227.5 30282.7 30318.5 32263.0 33767.2 34118.8 34154.7 34984.8 25762.9 27935.7 28292.7 28419.0 28598.0 09:10:34 INFO - PID 31144 | 09:10:34 INFO - PID 31144 | [#2] jquery.html Cycles:180 Average:25098.45 Median:20676.49 stddev:56962.21 (275.5%) stddev-sans-first:57091.87 09:10:34 INFO - PID 31144 | Values: 421.5 422.2 424.6 425.2 453.7 16941.3 17715.8 17724.5 18525.7 19180.9 19017.2 19224.4 19283.3 19346.9 19413.7 5392.1 5861.9 6135.1 6136.2 6184.0 6030.7 6123.4 6125.7 6132.9 6161.0 5965.4 6146.6 6152.3 6179.1 6182.6 5928.1 5997.8 6060.6 6084.6 6108.3 5890.3 5922.6 5928.1 5954.8 5970.1 23264.3 23866.3 24238.5 24422.3 24759.5 1725.1 1748.5 1750.4 1752.9 1761.1 16094.7 16171.8 16701.7 16761.9 16796.5 1709.4 1726.3 1730.1 1758.8 1764.7 88274.6 88529.0 89042.6 89506.0 91023.5 17962.8 18706.9 18769.3 18784.0 18850.7 33584.8 33898.4 33906.7 34065.8 34216.8 8523.1 8627.8 8656.6 8729.7 8946.7 6863.7 6875.9 7024.5 7058.3 7082.7 9047.2 9196.8 9445.7 9580.1 9622.0 3564.8 3808.2 3908.9 3995.8 4004.7 842.3 843.8 868.0 880.6 893.6 17022.4 17190.6 17295.4 17482.0 18066.5 884.7 885.9 886.4 898.1 909.3 9327.6 9641.8 9735.0 9761.7 9861.8 335806.0 340478.0 342784.0 343424.0 343829.0 73955.0 75537.6 77400.6 77548.6 78190.6 1008.5 1031.2 1058.2 1064.2 1065.2 14585.7 14742.5 14854.9 14901.5 15480.3 37269.8 37544.8 38180.8 38892.4 39445.4 45983.5 46620.8 46715.0 47031.3 48996.0 7806.2 8163.8 10411.2 10594.2 10909.9 11658.4 11872.5 12514.0 12559.4 12707.9 10223.1 10449.2 10776.0 10874.1 10880.0 10014.5 10213.8 10325.5 10432.7 10596.4 10857.7 10996.3 11004.0 11063.7 11434.8 8182.0 8375.0 8526.7 8547.3 8560.3 10440.7 10508.6 10708.3 10716.2 10748.4 09:10:34 INFO - PID 31144 | 09:10:34 INFO - PID 31144 | [#3] mootools.html Cycles:180 Average:6256.43 Median:3818.84 stddev:4021.84 (105.3%) stddev-sans-first:4015.53 09:10:34 INFO - PID 31144 | Values: 1250.7 1320.4 1321.8 1322.4 1324.3 9632.8 9904.7 10068.9 10175.5 10232.6 10107.2 10257.8 10270.8 10291.7 10405.0 2261.6 2284.6 2294.8 2303.6 2308.2 2147.1 2189.7 2201.5 2205.2 2207.9 2183.1 2214.4 2229.3 2240.8 2241.9 2069.6 2097.4 2122.0 2122.6 2125.9 2072.9 2092.5 2100.7 2191.6 2193.6 10113.6 10230.7 10384.2 10407.5 10418.2 5598.7 5809.0 5832.4 5835.5 5861.2 3151.3 3388.2 3388.7 3441.1 3474.9 1052.0 1068.2 1078.5 1088.0 1099.4 14693.1 14922.6 14967.3 15034.4 15048.7 4558.0 4686.2 4908.5 4961.3 4967.2 10310.3 10344.4 10366.6 10367.5 10388.3 5441.3 5463.4 5484.1 5491.0 5499.5 4980.6 5044.3 5101.4 5131.2 5191.5 3753.4 3812.8 3824.9 3844.5 3932.0 1119.1 1122.4 1125.3 1135.9 1144.2 679.3 715.1 717.2 734.7 735.7 5368.5 5373.8 5499.1 5570.6 5617.6 536.1 549.7 551.4 552.9 555.0 3727.5 3904.3 3921.1 3922.2 4406.0 13008.1 13546.6 13583.0 13590.5 13613.6 12862.4 13267.9 13295.6 13318.7 13324.9 7493.9 7703.6 7719.2 7729.6 7733.2 5944.0 5954.8 6018.6 6105.9 6175.4 11563.4 11794.9 12065.8 12202.3 12249.2 11886.5 12189.2 12201.7 12375.8 12408.2 7664.3 7883.4 7985.7 8002.5 8002.5 9037.0 9231.4 9236.3 9248.8 9254.6 7873.5 7891.6 8367.4 8386.0 8532.0 7930.9 8020.6 8032.4 8051.4 8212.9 7121.4 7288.1 7294.7 7303.9 7306.6 5095.8 5124.7 5128.3 5187.6 5384.6 5326.4 5359.5 5394.6 5395.8 5558.2 09:10:34 INFO - PID 31144 | 09:10:34 INFO - PID 31144 | [#4] prototype.html Cycles:180 Average:4871.73 Median:5398.04 stddev:1384.29 (25.6%) stddev-sans-first:1346.22 09:10:34 INFO - PID 31144 | Values: 365.8 387.1 387.8 388.2 390.8 5315.5 5455.2 5496.3 5595.6 5618.9 5329.4 5425.6 5434.3 5470.3 5476.3 4330.6 4366.3 4374.8 4375.6 4382.0 4319.4 4335.7 4372.1 4387.7 4393.3 4310.0 4315.5 4328.8 4345.7 4346.4 4309.1 4311.9 4335.7 4345.6 4359.1 3888.5 3934.1 3959.7 3966.8 3980.6 5360.5 5376.3 5380.6 5396.3 5399.8 5173.5 5178.3 5182.5 5188.9 5192.6 5537.4 5772.7 5807.8 5904.0 5921.2 4362.9 4377.1 4380.5 4395.7 4433.3 5972.7 6136.6 6161.9 6178.2 6230.5 4303.1 4314.1 4327.1 4328.8 4340.3 4394.9 4399.6 4414.4 4415.3 4418.3 4922.1 4969.3 4979.8 5035.7 5093.5 5854.4 5859.7 5862.9 5865.7 5874.7 1597.4 1620.6 1622.9 1623.2 1626.7 1122.6 1124.3 1125.9 1135.8 1149.3 5050.6 5069.4 5069.8 5101.0 5123.8 6054.9 6085.4 6087.8 6091.6 6098.1 4936.4 5023.2 5042.9 5092.3 5107.9 3185.8 3210.3 3212.5 3218.4 3226.6 5501.3 5593.4 5613.1 5616.7 5640.7 6170.5 6182.3 6212.0 6222.4 6232.9 5489.3 5594.2 5594.8 5619.6 5648.1 6030.3 6030.4 6051.5 6054.2 6081.3 5752.8 5874.5 5896.9 5935.6 5951.4 5555.1 5599.2 5602.0 5615.9 5617.0 4031.1 4039.4 4060.4 4063.8 4065.0 5975.4 6069.1 6070.3 6120.7 6124.4 5840.8 5845.2 5858.8 5878.9 5886.3 5690.8 5850.9 5857.4 5866.3 5867.6 5705.9 5728.5 5762.2 5762.7 5773.8 5902.3 5913.0 5925.0 5925.9 5950.7 5596.4 5671.5 5732.9 5733.2 5760.4 09:10:34 INFO - PID 31144 | 09:10:34 INFO - PID 31144 | [#5] yui.html Cycles:180 Average:15524.87 Median:33032.83 stddev:18749.57 (56.8%) stddev-sans-first:18768.81 09:10:34 INFO - PID 31144 | Values: 631.8 635.4 713.8 715.9 737.8 13260.9 13695.5 13699.0 14306.6 16294.5 15811.2 15935.2 16001.2 16078.6 16625.1 890.9 906.2 907.8 910.6 912.4 876.1 911.8 918.9 925.5 927.8 961.0 969.6 971.2 974.1 975.8 954.3 960.9 967.9 969.8 974.5 700.9 703.2 704.2 712.8 713.2 14108.3 14267.5 14290.6 14330.4 14331.1 16036.3 16213.8 16610.1 16640.2 16815.3 12771.9 12841.4 12939.4 13016.2 13088.1 2715.3 2740.9 2750.3 2763.9 2771.0 72644.0 74291.3 74450.6 75098.6 75199.0 12281.3 12412.1 12416.9 12446.8 12546.4 21765.8 22090.2 22341.3 22368.0 22528.8 5925.7 5972.3 6132.6 6226.1 6230.8 2891.7 2925.2 2938.1 2940.7 2945.6 3457.6 3492.0 3549.7 3569.1 3571.1 764.8 774.3 775.6 776.9 784.3 556.2 579.2 581.8 582.3 582.8 9742.3 10273.1 10510.7 10642.6 10731.8 560.1 561.3 562.4 572.8 581.2 4274.4 4412.6 4412.9 4420.6 4550.4 64464.0 64788.7 64846.4 66113.0 66466.3 57261.7 57881.0 57903.7 60202.4 61523.7 51586.5 51910.2 51933.7 52863.7 53498.7 8599.4 8651.7 8678.7 8745.4 8750.3 26492.2 27435.3 27831.2 27990.2 28758.4 32284.8 32383.4 32830.8 33234.8 44618.3 12147.3 12172.8 12236.6 12417.1 12459.4 15377.7 15530.4 15742.4 15945.9 16227.0 12703.8 12779.7 13006.4 13026.2 13027.4 14665.7 14722.9 14745.7 14785.6 15003.4 13445.0 13538.2 13659.9 13669.1 14023.1 9968.7 10194.1 10380.5 10468.7 10876.5 10260.4 10671.1 10895.2 11119.1 11352.4 09:10:34 INFO - PID 31144 | -------- Summary: end -------- 09:10:34 INFO - PID 31144 | 09:10:35 INFO - TEST-INFO | 31144: exit 0 09:10:35 INFO - TEST-OK | dromaeo_css | took 1119656ms 09:10:35 INFO - TEST-START | kraken 09:10:35 INFO - operating with platform_type : linux_ 09:10:35 INFO - Initialising browser for kraken test... 09:10:35 INFO - TEST-INFO | started process 31559 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph3sjvW/profile http://localhost:40509/getInfo.html) 09:10:39 INFO - PID 31559 | __metrics Screen width/height:1600/1200 09:10:39 INFO - PID 31559 | colorDepth:24 09:10:39 INFO - PID 31559 | Browser inner width/height: 1024/695 09:10:39 INFO - PID 31559 | __metrics 09:10:41 INFO - TEST-INFO | 31559: exit 0 09:10:41 INFO - Browser initialized. 09:10:41 INFO - Running cycle 1/1 for kraken test... 09:10:41 INFO - TEST-INFO | started process 31730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph3sjvW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:10:53 INFO - PID 31730 | RSS: Main: 155529216 09:10:53 INFO - PID 31730 | 09:10:55 INFO - PID 31730 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40509/tests/kraken/driver.html?testName=audio-beat-detection) 09:10:56 INFO - PID 31730 | RSS: Main: 161034240 09:10:56 INFO - PID 31730 | 09:10:59 INFO - PID 31730 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40509/tests/kraken/driver.html?testName=audio-dft) 09:11:00 INFO - PID 31730 | RSS: Main: 159920128 09:11:00 INFO - PID 31730 | 09:11:03 INFO - PID 31730 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40509/tests/kraken/driver.html?testName=audio-fft) 09:11:03 INFO - PID 31730 | RSS: Main: 156262400 09:11:03 INFO - PID 31730 | 09:11:05 INFO - PID 31730 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40509/tests/kraken/driver.html?testName=audio-oscillator) 09:11:06 INFO - PID 31730 | RSS: Main: 156626944 09:11:06 INFO - PID 31730 | 09:11:08 INFO - PID 31730 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40509/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:11:09 INFO - PID 31730 | RSS: Main: 157147136 09:11:09 INFO - PID 31730 | 09:11:12 INFO - PID 31730 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40509/tests/kraken/driver.html?testName=imaging-darkroom) 09:11:12 INFO - PID 31730 | RSS: Main: 162652160 09:11:12 INFO - PID 31730 | 09:11:16 INFO - PID 31730 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40509/tests/kraken/driver.html?testName=imaging-desaturate) 09:11:17 INFO - PID 31730 | RSS: Main: 160874496 09:11:17 INFO - PID 31730 | 09:11:19 INFO - PID 31730 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40509/tests/kraken/driver.html?testName=json-parse-financial) 09:11:20 INFO - PID 31730 | RSS: Main: 161812480 09:11:20 INFO - PID 31730 | 09:11:22 INFO - PID 31730 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40509/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:11:22 INFO - PID 31730 | RSS: Main: 162287616 09:11:22 INFO - PID 31730 | 09:11:24 INFO - PID 31730 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40509/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:11:25 INFO - PID 31730 | RSS: Main: 162365440 09:11:25 INFO - PID 31730 | 09:11:27 INFO - PID 31730 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40509/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:11:28 INFO - PID 31730 | RSS: Main: 162164736 09:11:28 INFO - PID 31730 | 09:11:30 INFO - PID 31730 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:11:31 INFO - PID 31730 | RSS: Main: 162566144 09:11:31 INFO - PID 31730 | 09:11:34 INFO - PID 31730 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:11:35 INFO - PID 31730 | RSS: Main: 162406400 09:11:35 INFO - PID 31730 | 09:11:37 INFO - PID 31730 | Cycle 1(1): loaded http://localhost:40509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40509/tests/kraken/driver.html?testName=ai-astar) 09:11:37 INFO - PID 31730 | RSS: Main: 163987456 09:11:37 INFO - PID 31730 | 09:11:37 INFO - PID 31730 | __start_tp_report 09:11:37 INFO - PID 31730 | _x_x_mozilla_page_load 09:11:37 INFO - PID 31730 | _x_x_mozilla_page_load_details 09:11:37 INFO - PID 31730 | |i|pagename|runs| 09:11:37 INFO - PID 31730 | |0;ai-astar;104;114;114;113;112;114;114;113;114;113 09:11:37 INFO - PID 31730 | |1;audio-beat-detection;154;124;125;172;132;124;125;131;151;124 09:11:37 INFO - PID 31730 | |2;audio-dft;166;166;162;163;167;169;169;163;163;167 09:11:37 INFO - PID 31730 | |3;audio-fft;75;78;78;113;76;75;78;75;100;80 09:11:37 INFO - PID 31730 | |4;audio-oscillator;86;85;102;84;84;83;96;84;84;103 09:11:37 INFO - PID 31730 | |5;imaging-gaussian-blur;114;114;114;114;115;114;114;113;115;114 09:11:37 INFO - PID 31730 | |6;imaging-darkroom;153;150;152;151;150;151;149;149;152;151 09:11:37 INFO - PID 31730 | |7;imaging-desaturate;95;95;94;94;94;94;95;95;95;94 09:11:37 INFO - PID 31730 | |8;json-parse-financial;58;53;53;53;56;57;56;56;57;54 09:11:37 INFO - PID 31730 | |9;json-stringify-tinderbox;56;55;58;55;56;55;56;56;56;57 09:11:37 INFO - PID 31730 | |10;stanford-crypto-aes;83;82;82;81;83;81;82;81;83;82 09:11:37 INFO - PID 31730 | |11;stanford-crypto-ccm;132;135;139;134;136;140;132;130;180;131 09:11:37 INFO - PID 31730 | |12;stanford-crypto-pbkdf2;184;195;193;196;199;198;195;189;209;201 09:11:37 INFO - PID 31730 | |13;stanford-crypto-sha256-iterative;74;76;76;71;74;70;70;73;77;70 09:11:37 INFO - PID 31730 | __end_tp_report 09:11:37 INFO - PID 31730 | __start_cc_report 09:11:37 INFO - PID 31730 | _x_x_mozilla_cycle_collect,853 09:11:37 INFO - PID 31730 | __end_cc_report 09:11:37 INFO - PID 31730 | __startTimestamp1494346297428__endTimestamp 09:11:37 INFO - PID 31730 | 09:11:37 INFO - PID 31730 | ------- Summary: start ------- 09:11:37 INFO - PID 31730 | Number of tests: 14 09:11:37 INFO - PID 31730 | 09:11:37 INFO - PID 31730 | [#0] ai-astar Cycles:10 Average:112.50 Median:114.00 stddev:3.06 (2.7%) stddev-sans-first:0.73 09:11:37 INFO - PID 31730 | Values: 104.0 114.0 114.0 113.0 112.0 114.0 114.0 113.0 114.0 113.0 09:11:37 INFO - PID 31730 | 09:11:37 INFO - PID 31730 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:131.50 stddev:16.86 (12.8%) stddev-sans-first:16.61 09:11:37 INFO - PID 31730 | Values: 154.0 124.0 125.0 172.0 132.0 124.0 125.0 131.0 151.0 124.0 09:11:37 INFO - PID 31730 | 09:11:37 INFO - PID 31730 | [#2] audio-dft Cycles:10 Average:165.50 Median:166.50 stddev:2.59 (1.6%) stddev-sans-first:2.74 09:11:37 INFO - PID 31730 | Values: 166.0 166.0 162.0 163.0 167.0 169.0 169.0 163.0 163.0 167.0 09:11:37 INFO - PID 31730 | 09:11:37 INFO - PID 31730 | [#3] audio-fft Cycles:10 Average:82.80 Median:77.00 stddev:12.97 (16.8%) stddev-sans-first:13.44 09:11:37 INFO - PID 31730 | Values: 75.0 78.0 78.0 113.0 76.0 75.0 78.0 75.0 100.0 80.0 09:11:37 INFO - PID 31730 | 09:11:37 INFO - PID 31730 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:84.00 stddev:7.99 (9.5%) stddev-sans-first:8.40 09:11:37 INFO - PID 31730 | Values: 86.0 85.0 102.0 84.0 84.0 83.0 96.0 84.0 84.0 103.0 09:11:37 INFO - PID 31730 | 09:11:37 INFO - PID 31730 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 09:11:37 INFO - PID 31730 | Values: 114.0 114.0 114.0 114.0 115.0 114.0 114.0 113.0 115.0 114.0 09:11:37 INFO - PID 31730 | 09:11:37 INFO - PID 31730 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:1.32 (0.9%) stddev-sans-first:1.13 09:11:37 INFO - PID 31730 | Values: 153.0 150.0 152.0 151.0 150.0 151.0 149.0 149.0 152.0 151.0 09:11:37 INFO - PID 31730 | 09:11:37 INFO - PID 31730 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 09:11:37 INFO - PID 31730 | Values: 95.0 95.0 94.0 94.0 94.0 94.0 95.0 95.0 95.0 94.0 09:11:37 INFO - PID 31730 | 09:11:37 INFO - PID 31730 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:1.89 (3.4%) stddev-sans-first:1.73 09:11:37 INFO - PID 31730 | Values: 58.0 53.0 53.0 53.0 56.0 57.0 56.0 56.0 57.0 54.0 09:11:37 INFO - PID 31730 | 09:11:37 INFO - PID 31730 | [#9] json-stringify-tinderbox Cycles:10 Average:56.00 Median:56.00 stddev:0.94 (1.7%) stddev-sans-first:1.00 09:11:37 INFO - PID 31730 | Values: 56.0 55.0 58.0 55.0 56.0 55.0 56.0 56.0 56.0 57.0 09:11:37 INFO - PID 31730 | 09:11:37 INFO - PID 31730 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:0.82 (1.0%) stddev-sans-first:0.78 09:11:37 INFO - PID 31730 | Values: 83.0 82.0 82.0 81.0 83.0 81.0 82.0 81.0 83.0 82.0 09:11:37 INFO - PID 31730 | 09:11:37 INFO - PID 31730 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:135.50 stddev:14.81 (10.9%) stddev-sans-first:15.50 09:11:37 INFO - PID 31730 | Values: 132.0 135.0 139.0 134.0 136.0 140.0 132.0 130.0 180.0 131.0 09:11:37 INFO - PID 31730 | 09:11:37 INFO - PID 31730 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.90 Median:197.00 stddev:6.76 (3.4%) stddev-sans-first:5.63 09:11:37 INFO - PID 31730 | Values: 184.0 195.0 193.0 196.0 199.0 198.0 195.0 189.0 209.0 201.0 09:11:37 INFO - PID 31730 | 09:11:37 INFO - PID 31730 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:74.00 stddev:2.73 (3.7%) stddev-sans-first:2.87 09:11:37 INFO - PID 31730 | Values: 74.0 76.0 76.0 71.0 74.0 70.0 70.0 73.0 77.0 70.0 09:11:37 INFO - PID 31730 | -------- Summary: end -------- 09:11:37 INFO - PID 31730 | 09:11:38 INFO - TEST-INFO | 31730: exit 0 09:11:38 INFO - TEST-OK | kraken | took 63264ms 09:11:38 INFO - SUITE-END | took 1182s 09:11:38 INFO - Completed test suite (00:19:42) 09:11:38 INFO - javascript benchmark 09:11:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6865.354906357896, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2710.647615809945, 2729.727027297269, 2734.740199681031, 2758.2690586994445, 2759.2136241171256, 5266.236395722627, 5325.733713314334, 5326.573874090069, 5345.545628621567, 5352.545033672132, 5336.67979921205, 5345.839624811252, 5363.356397232328, 5457.754401051952, 5470.097433923408, 4666.76666166692, 4748.1690704126895, 4767.785449654756, 4792.400949881265, 4820.469748327681, 4825.372701548794, 4839.201531747258, 4840.854774356775, 4843.176659967814, 4844.5155484451625, 4679.532046795327, 4705.106029854351, 4745.667803253774, 4754.595859351959, 4828.130936431441, 4721.173794585968, 4736.194846876039, 4741.857744267678, 4771.427428708577, 4795.280707893844, 4629.768511574408, 4674.789634466457, 4698.976505117453, 4702.31816386622, 4718.457377401608, 5207.3490813648295, 5262.236975638511, 5291.892079517229, 5292.708901010443, 5315.574754019669, 5720.1991721159075, 5725.312962444534, 5733.283339582552, 5735.569832262555, 5738.713064346808, 5702.287214098238, 5704.258446401941, 5711.114777209539, 5715.142728590703, 5754.798582049608, 5253.763580638881, 5308.336457942757, 5313.256144139824, 5317.042932272189, 5317.042932272228, 5891.499222566044, 5913.46778789911, 5961.582689211714, 6000.369961154103, 6005.669688167192, 5644.322681278273, 5703.800366987136, 5709.857253568694, 5710.314762228559, 5715.114157305541, 5717.2281741965135, 5739.741711622987, 5745.770169193269, 5748.655080695172, 5767.625104368202, 5601.467860553241, 5713.800016999468, 5720.456556627114, 5722.971385143131, 5733.713314334266, 5640.464155905182, 5696.23100881384, 5726.198332233491, 5737.024705800024, 5740.397258287903, 4782.928256076161, 4801.231802911518, 4807.351007613997, 4817.470078291385, 4820.566149046533, 4132.173565286895, 4140.047789008545, 4159.480064991876, 4189.476315460567, 4199.265128602482, 4937.555619994146, 4948.158813001798, 4948.4309304429735, 4957.256411538226, 5003.174476211457, 5717.399673034354, 5731.054376027909, 5736.942630573641, 5781.624194427349, 5799.739011744482, 4952.702837829742, 4975.825846095442, 4976.751162441863, 4982.10322142018, 4984.725840078758, 5178.119719647669, 5178.378594568676, 5187.455317191716, 5219.42586315505, 5224.346956630421, 5290.0, 5305.575553955597, 5347.705876176692, 5352.036633405946, 5354.036273470657, 5703.600747947604, 5808.419158084158, 5812.3025236971835, 5821.185034095315, 5873.882522349443, 5336.759845807026, 5336.946630533645, 5356.410794812489, 5377.758000889891, 5380.246765452762, 5669.262995810518, 5682.602217844711, 5790.7973220937065, 5800.332961709458, 5809.360970293349, 5806.709664516673, 5854.121881717776, 5860.120981852586, 5880.970595146997, 5887.911681324698, 5607.130894711327, 5612.130119831432, 5620.072688006433, 5620.915686264628, 5660.433956604306, 5574.693391863487, 5576.0, 5598.916016259678, 5604.971975140098, 5608.635438696471, 5432.538234249975, 5461.590380721383, 5483.040467918018, 5485.149801780731, 5486.6982315973, 5585.408158674758, 5594.720263986703, 5613.326400831927, 5632.380438151718, 5645.0, 5475.780968761205, 5494.2582751328055, 5588.804391846266, 5594.4125866785025, 5603.579731520071], "value": 5222.822032763472, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.4045680258176, 695.9756408525701, 1035.5184839049841, 1059.35908775191, 1139.8062329404002, 31288.374232515336, 32118.0, 32145.517817232732, 32238.516422253626, 32312.67687323132, 29927.0, 29944.85027574859, 30188.54717179244, 30240.0, 30325.0, 5159.664621799589, 5328.094223981932, 6449.871002579957, 6578.309277525838, 6812.114425124727, 6850.451963842881, 7003.5097543172, 7013.158420989488, 7017.473689473284, 7019.0, 6995.860082798341, 7058.188308344529, 7072.504924655276, 7073.398761105313, 7085.397741192005, 7015.964920175392, 7039.401650859683, 7050.365467107934, 7050.506464547484, 7053.118360204974, 6949.5830250184645, 6967.965160174217, 7007.369336759665, 7012.929870701279, 7015.754448594274, 30013.699863001308, 30345.393092138256, 30471.238219044702, 30522.236944076354, 30557.08328750141, 3061.4948533491947, 3108.844557772125, 3111.735502482292, 3115.641701204368, 3131.4519959007084, 23898.283051508482, 24003.51992960131, 24310.270691879272, 24331.513369732682, 24341.026358945623, 2977.6129103216444, 2979.55306703994, 2983.2690990707415, 3005.1735772662473, 3014.201236672284, 141224.99999999898, 141549.2922535391, 142198.0, 142293.0, 142699.28650356786, 37181.81409092991, 39130.217395651925, 39145.0, 39232.2153556933, 39830.203395931916, 40373.798131009156, 40811.38782918259, 40870.38694419586, 42810.35784463236, 43555.12889742188, 12324.876751232552, 12373.319467429377, 12439.440225189888, 12447.439865206088, 12456.190347627557, 9830.852537211947, 9854.852177217348, 9856.457894815854, 9859.781549151527, 9876.901230987742, 12580.748385032432, 12632.115751897463, 12664.87335126637, 12770.489180432864, 12845.550405735754, 5296.735163241822, 5316.229146773773, 5338.9466105339225, 5423.566114710814, 5429.837104886859, 886.1094599927161, 916.1159481100769, 927.0682963621517, 928.7306681062416, 934.7289286106953, 20641.587168256552, 21793.23723669664, 24566.385840354134, 26669.866650666623, 26706.866465667936, 971.9805603887883, 972.6887396033202, 975.2052077556768, 979.6816034788723, 988.41189492252, 11597.304161750153, 11735.295882247092, 11738.471768770425, 11763.117766167572, 11831.645050648494, 167563.0, 167563.0, 168014.0, 168349.0, 169322.0, 40365.59634403677, 40529.18941621151, 40616.39075413871, 40687.0, 40864.38703419451, 1199.1522727606525, 1217.2392254840724, 1231.3658465890073, 1232.969175770613, 1232.9815052774215, 20198.697019544426, 20387.310918488532, 21277.78722212758, 24493.632595510724, 24948.12681556137, 38680.0, 38684.80657596807, 38970.80514597409, 39043.609563905135, 39174.412383813695, 153469.0, 154113.0, 154492.0, 154812.22593886958, 155132.2243388821, 28994.420111598072, 29386.853065734533, 29414.793890457873, 29475.905029971545, 29511.704882950897, 34593.13517162091, 34732.65267347294, 35389.646103539664, 35782.64217357793, 35919.46120808242, 26753.464930700888, 26996.865015674797, 27049.59425608657, 27703.030393936115, 28436.132231899075, 26473.735262647126, 26581.867090664422, 27472.0, 28391.43217135687, 28662.856685716437, 29225.56161657534, 29757.702422975493, 30227.546586800774, 30282.697173028868, 30318.54522182125, 32263.0, 33767.15582110368, 34118.82940585281, 34154.658453416145, 34984.825075874454, 25762.87118564395, 27935.720642794124, 28292.717072829833, 28419.0, 28598.0], "value": 14706.860413394683, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.481577659479, 422.2399680574964, 424.57542457542456, 425.1645516559959, 453.65295548905095, 16941.322347106117, 17715.82284177158, 17724.46826595204, 18525.722114168297, 19180.90409547954, 19017.239310427565, 19224.42326730197, 19283.325083622076, 19346.903265483652, 19413.708794368096, 5392.110301800199, 5861.8827623447505, 6135.141080248769, 6136.202293701813, 6183.969080154593, 6030.66831324277, 6123.448889599935, 6125.663088530129, 6132.938670613281, 6161.045038019091, 5965.403459654021, 6146.631202127886, 6152.32324444313, 6179.104029915659, 6182.567220294582, 5928.140419639171, 5997.790077347272, 6060.575759696823, 6084.6349219047, 6108.267007959029, 5890.322612899486, 5922.615030023035, 5928.051511758098, 5954.761809527614, 5970.13433052205, 23264.302070937898, 23866.28401147968, 24238.515229695484, 24422.26733198007, 24759.50480990388, 1725.05984238589, 1748.466717651116, 1750.422360620992, 1752.9211185496683, 1761.075435396427, 16094.678106437806, 16171.83828161715, 16701.749473757904, 16761.91619041897, 16796.496105116865, 1709.401709401712, 1726.2749645149067, 1730.0657644871753, 1758.832910873465, 1764.700000999833, 88274.55862720645, 88529.0, 89042.5547872263, 89506.0, 91023.54488227516, 17962.820371796377, 18706.90646546786, 18769.34307299238, 18784.0, 18850.71723924142, 33584.83207583946, 33898.37286610542, 33906.66093339035, 34065.82967085149, 34216.82891585576, 8523.147685231428, 8627.799911022774, 8656.567171641393, 8729.650813967497, 8946.68686595966, 6863.725450982005, 6875.896861547081, 7024.543404678781, 7058.258882817333, 7082.681279342442, 9047.230985366186, 9196.838742895414, 9445.66940157105, 9580.120051379203, 9622.0, 3564.821758912044, 3808.1622043151015, 3908.882733517999, 3995.800209989547, 4004.6796256299426, 842.3008902610818, 843.8185790055045, 868.0, 880.5641207602278, 893.5934149961752, 17022.404215852384, 17190.570235743955, 17295.394661186798, 17482.03848788329, 18066.458006259832, 884.6682494064726, 885.9069797671152, 886.3751055505853, 898.0570401078841, 909.286210324905, 9327.626894924128, 9641.758956026015, 9735.0, 9761.707148785548, 9861.753456163653, 335806.0, 340478.0, 342784.0, 343424.0, 343829.0, 73955.0, 75537.62231188809, 77400.61299693465, 77548.61225693836, 78190.60904695553, 1008.4907121903539, 1031.2059714020163, 1058.2433560004633, 1064.164630764846, 1065.1585247654266, 14585.708285834437, 14742.484013059491, 14854.925725371304, 14901.478448254258, 15480.303386347416, 37269.813650931574, 37544.81227593954, 38180.809095955454, 38892.42964408686, 39445.408318875816, 45983.54016459793, 46620.7668961653, 46715.0, 47031.294530581385, 48996.0, 7806.219378062148, 8163.755087347389, 10411.21915856329, 10594.152467802403, 10909.890901090888, 11658.358790266617, 11872.465739041936, 12514.0, 12559.43482543306, 12707.93646031764, 10223.131033862204, 10449.21630877672, 10776.0, 10874.130069594255, 10880.0, 10014.549345279334, 10213.84679229827, 10325.535350909076, 10432.739181520523, 10596.417197054236, 10857.67426977192, 10996.28524145928, 11004.0, 11063.72340691489, 11434.771304573696, 8181.959090204511, 8375.036870759941, 8526.720991851023, 8547.316214702685, 8560.315174786127, 10440.738981525523, 10508.632197873038, 10708.250422470352, 10716.249862509549, 10748.408837514013], "value": 9585.89452760507, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1250.7123361626827, 1320.353027016762, 1321.762082825091, 1322.3784821134066, 1324.271650592174, 9632.80734385312, 9904.702858914245, 10068.899311006888, 10175.542100605471, 10232.641857534969, 10107.241956853228, 10257.846132308021, 10270.845937310927, 10291.742706432324, 10405.0, 2261.570301642687, 2284.64587988862, 2294.816414686821, 2303.562323158603, 2308.226744040748, 2147.119680930811, 2189.6606026065983, 2201.5486825200874, 2205.151016858513, 2207.9006444710026, 2183.0612836480386, 2214.3578362275002, 2229.308914236584, 2240.7535171131162, 2241.9439514012115, 2069.649998540431, 2097.381272524609, 2122.0238690202527, 2122.564874200785, 2125.914963401462, 2072.9170833166654, 2092.487340601562, 2100.684897265407, 2191.594555007329, 2193.5503221839485, 10113.646022389255, 10230.693079207636, 10384.221183411275, 10407.53166107527, 10418.21863360251, 5598.720063996825, 5808.97095514524, 5832.445917637818, 5835.533157347402, 5861.17943487912, 3151.2909595341093, 3388.1868351595685, 3388.711959483422, 3441.1397150712323, 3474.878379256739, 1051.963181288659, 1068.1614932278203, 1078.4715489410212, 1087.9673609791719, 1099.3513826842122, 14693.118412895154, 14922.552323430315, 14967.251637418085, 15034.398624055024, 15048.699026019418, 4558.0, 4686.179918514246, 4908.4846091160625, 4961.280614310905, 4967.230079337708, 10310.278280520291, 10344.431056291825, 10366.585336586451, 10367.533460994273, 10388.272820902464, 5441.319835020622, 5463.426340234298, 5484.122540393598, 5491.039068163055, 5499.450054994549, 4980.601551875841, 5044.2937988681615, 5101.413337466165, 5131.204663277198, 5191.532762051434, 3753.399456087013, 3812.7902965336616, 3824.8852534424013, 3844.461775351453, 3931.9606803932165, 1119.1326721790676, 1122.4387806096952, 1125.2573301620891, 1135.8920902514249, 1144.1819099343843, 679.2596070283415, 715.1132595581441, 717.2074857282628, 734.717133903451, 735.724103461202, 5368.4631536846, 5373.76403427214, 5499.130295699481, 5570.58220633446, 5617.578681598897, 536.1207619503939, 549.7443688684781, 551.3631755322609, 552.8700755322496, 555.0314700847048, 3727.4781530585738, 3904.316744569689, 3921.058945852975, 3922.2351641429645, 4405.977970110129, 13008.089433739548, 13546.59360219195, 13583.049186556846, 13590.524331648345, 13613.591592252249, 12862.356882155855, 13267.867321326663, 13295.601131966056, 13318.733625327439, 13324.866751332556, 7493.887591686129, 7703.576303303372, 7719.150893401721, 7729.574873382018, 7733.2266773323345, 5943.970280148572, 5954.76180952757, 6018.638881667114, 6105.9084113737445, 6175.44421002112, 11563.36401497892, 11794.941025294818, 12065.81901271464, 12202.267863928193, 12249.203801752858, 11886.524539018343, 12189.207701499374, 12201.69495762613, 12375.814362784386, 12408.193467424588, 7664.31021208094, 7883.408744344082, 7985.680572777024, 8002.51984880909, 8002.51984880909, 9037.0, 9231.399959002643, 9236.307276954121, 9248.815023699623, 9254.583543740413, 7873.488223265469, 7891.605419728876, 8367.414281000272, 8385.95807020961, 8532.0, 7930.920690793018, 8020.598970051591, 8032.357411406956, 8051.355891528547, 8212.917870821455, 7121.4302855770375, 7288.12542494904, 7294.671739771829, 7303.926960730325, 7306.561606303639, 5095.796168153232, 5124.718140502308, 5128.333316668809, 5187.559057480156, 5384.596155288447, 5326.387465441524, 5359.490848369399, 5394.622376433769, 5395.838124856261, 5558.221848941071], "value": 4678.636586904148, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.79149884565794, 387.08261420433575, 387.80222086735773, 388.20030736682435, 390.8417091078114, 5315.468453154683, 5455.1544510600825, 5496.340439147303, 5595.552355811536, 5618.859528511784, 5329.413764485904, 5425.6202065855305, 5434.266374039504, 5470.316210473691, 5476.288082549273, 4330.6142034548875, 4366.345048242773, 4374.78126093694, 4375.562443755631, 4382.0, 4319.438472998506, 4335.7181783184, 4372.147431250907, 4387.670924680646, 4393.340998850166, 4309.952772433085, 4315.525292217853, 4328.761918094504, 4345.739255644656, 4346.391505189276, 4309.116631090619, 4311.8706438806885, 4335.674824388152, 4345.565443455661, 4359.10638319147, 3888.4933457472926, 3934.1148241645687, 3959.7030222733124, 3966.801659916993, 3980.6315242430705, 5360.544353729938, 5376.327959005124, 5380.569554435675, 5396.271503347037, 5399.815143263962, 5173.482651734834, 5178.300929374562, 5182.507661772125, 5188.948110518884, 5192.61055420845, 5537.446255374471, 5772.682502462363, 5807.764010855851, 5903.970480147572, 5921.230240068807, 4362.8909277268, 4377.102693947765, 4380.474343078819, 4395.692261562674, 4433.312836510346, 5972.731227094748, 6136.631802091889, 6161.938380616226, 6178.227721534809, 6230.532710046719, 4303.139372125587, 4314.094040251583, 4327.091310824699, 4328.783560821947, 4340.283853164256, 4394.934075988863, 4399.604035636744, 4414.448193975753, 4415.278041563793, 4418.293073108287, 4922.095963381622, 4969.2546118081855, 4979.825706100269, 5035.697858128524, 5093.54158125763, 5854.385289544622, 5859.677717725566, 5862.941370586324, 5865.741689449593, 5874.73563689635, 1597.3770229610461, 1620.554347554432, 1622.9350825966828, 1623.2046297314232, 1626.7397216445313, 1122.629532254354, 1124.2748427264369, 1125.93599048898, 1135.7728454309172, 1149.3046706742468, 5050.621203409759, 5069.366329208849, 5069.847904562869, 5101.0, 5123.795048198105, 6054.941319951237, 6085.391460853968, 6087.817365479043, 6091.5735898487565, 6098.14625952367, 4936.432310284292, 5023.2214006829, 5042.873928151752, 5092.312537807423, 5107.8723031923755, 3185.792923459968, 3210.3258315753487, 3212.5181222816764, 3218.3563287342627, 3226.5644138041534, 5501.339839219319, 5593.412691667317, 5613.073842815971, 5616.66300022, 5640.717964101778, 6170.475509581646, 6182.258129024546, 6212.049276593672, 6222.417696655928, 6232.883558220889, 5489.258950041693, 5594.216809646653, 5594.804181853616, 5619.578531610146, 5648.096304591246, 6030.276366836008, 6030.427109424598, 6051.5173782421825, 6054.243219597551, 6081.331053584191, 5752.827415177551, 5874.530037596896, 5896.852578685567, 5935.643861368331, 5951.434613711691, 5555.111182210827, 5599.160125981135, 5601.971990140023, 5615.943840561706, 5617.0, 4031.0527026149416, 4039.384246301503, 4060.411240370189, 4063.796810159421, 4064.979675101724, 5975.43233392827, 6069.089636554552, 6070.301915279622, 6120.693965301806, 6124.387561244018, 5840.8247752567495, 5845.210896528914, 5858.824235272778, 5878.911816322844, 5886.323072846506, 5690.829275121753, 5850.94149058504, 5857.355690873916, 5866.325372582208, 5867.647941123546, 5705.857353566194, 5728.455796699307, 5762.164486149569, 5762.740676669644, 5773.826785196451, 5902.291724993029, 5912.970435147797, 5925.0, 5925.911111333247, 5950.732217050329, 5596.38439771633, 5671.532883195823, 5732.910746958065, 5733.241409630081, 5760.423957604374], "value": 4454.26523993229, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.8294060603637, 635.402721441845, 713.8037039814051, 715.8675645005675, 737.8413641067172, 13260.933695331521, 13695.452181912724, 13699.041067125305, 14306.642333941656, 16294.511164665078, 15811.209439528006, 15935.20323983802, 16001.19994000301, 16078.5980350491, 16625.08562029088, 890.8975467821218, 906.2342320738965, 907.8138981508774, 910.635745701718, 912.3886995712888, 876.0626130040858, 911.7674992876807, 918.9172974432299, 925.4956048953337, 927.7958849053198, 961.0, 969.6218474794836, 971.2424309038961, 974.1086905481511, 975.8145952269047, 954.2699834626517, 960.8606752020918, 967.8548217767321, 969.7866469376726, 974.4640447753743, 700.8913618389158, 703.2405002597183, 704.2359040441128, 712.8289210589473, 713.2332742302046, 14108.294585270696, 14267.500637477742, 14290.64273393163, 14330.426782928671, 14331.140131592034, 16036.278367473491, 16213.756793648105, 16610.086445245506, 16640.167991600494, 16815.327386904508, 12771.936140319332, 12841.357932103358, 12939.417726202344, 13016.219026858324, 13088.083834131614, 2715.334742987961, 2740.931476713098, 2750.2711781377952, 2763.8894444222205, 2771.016289217339, 72644.0, 74291.25708742898, 74450.62774686146, 75098.62450687822, 75199.0, 12281.263124212575, 12412.069094817925, 12416.937915310546, 12446.751064978649, 12546.372681365896, 21765.78234217669, 22090.226842060452, 22341.329760107223, 22368.0, 22528.774712252667, 5925.703714814242, 5972.25346831646, 6132.570720049643, 6226.097215903668, 6230.7507699691505, 2891.7108289170915, 2925.195571217932, 2938.14793709826, 2940.6765255821842, 2945.558166275076, 3457.567804024497, 3492.0, 3549.7337699672626, 3569.0720412692885, 3571.1072231942017, 764.8432071425344, 774.3379410603852, 775.5966897213531, 776.8912352270687, 784.3098073695226, 556.168528050567, 579.2161865312572, 581.760617378611, 582.280615610471, 582.7922400270044, 9742.269329800294, 10273.126784223276, 10510.684679459628, 10642.627508037182, 10731.785364292671, 560.1457776890275, 561.3236050559067, 562.353293712226, 572.8252882870681, 581.1863391252197, 4274.422952901381, 4412.558744125626, 4412.889677758018, 4420.646348292129, 4550.362949187116, 64464.0, 64788.67605661941, 64846.35153648497, 66113.0, 66466.33533664698, 57261.71369143211, 57881.0, 57903.71048144732, 60202.38785672874, 61523.6923815378, 51586.48413515817, 51910.22134667983, 51933.74033129886, 52863.73568132212, 53498.732506338, 8599.355048371272, 8651.653933842575, 8678.652853886026, 8745.431546949429, 8750.343724220582, 26492.205233843015, 27435.31411714723, 27831.16506504727, 27990.160295191177, 28758.424831502834, 32284.83857580791, 32383.352332952738, 32830.83584582062, 33234.83382583072, 44618.330725038504, 12147.271163730204, 12172.817407739069, 12236.632901012983, 12417.06871984623, 12459.439325230205, 15377.69244615079, 15530.378784848932, 15742.370305187664, 15945.920270398574, 16227.0, 12703.809442858179, 12779.680507987374, 13006.414711337824, 13026.153300035467, 13027.413766380347, 14665.706685866437, 14722.852771472577, 14745.705085898437, 14785.630359240675, 15003.399864005754, 13445.0, 13538.187708737507, 13659.863401366256, 13669.111507751964, 14023.088499247924, 9968.651097211563, 10194.082532571807, 10380.532876020447, 10468.68593942183, 10876.45617719095, 10260.384376937407, 10671.092957098734, 10895.182861285593, 11119.05488033494, 11352.432378381212], "value": 6823.266371406397, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 113.0, 112.0, 114.0, 114.0, 113.0, 114.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 125.0, 172.0, 132.0, 124.0, 125.0, 131.0, 151.0, 124.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 162.0, 163.0, 167.0, 169.0, 169.0, 163.0, 163.0, 167.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 78.0, 113.0, 76.0, 75.0, 78.0, 75.0, 100.0, 80.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 102.0, 84.0, 84.0, 83.0, 96.0, 84.0, 84.0, 103.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 113.0, 115.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 152.0, 151.0, 150.0, 151.0, 149.0, 149.0, 152.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 53.0, 53.0, 56.0, 57.0, 56.0, 56.0, 57.0, 54.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 58.0, 55.0, 56.0, 55.0, 56.0, 56.0, 56.0, 57.0], "value": 56.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 82.0, 81.0, 83.0, 81.0, 82.0, 81.0, 83.0, 82.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 135.0, 139.0, 134.0, 136.0, 140.0, 132.0, 130.0, 180.0, 131.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 195.0, 193.0, 196.0, 199.0, 198.0, 195.0, 189.0, 209.0, 201.0], "value": 195.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 71.0, 74.0, 70.0, 70.0, 73.0, 77.0, 70.0], "value": 73.1, "unit": "score"}]}]} 09:11:38 INFO - Return code: 0 09:11:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:11:38 INFO - # TBPL SUCCESS # 09:11:38 INFO - Running post-action listener: _resource_record_post_action 09:11:38 INFO - [mozharness: 2017-05-09 16:11:38.723478Z] Finished run-tests step (success) 09:11:38 INFO - Running post-run listener: _resource_record_post_run 09:11:38 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 365121536; Read time: 152; Write time: 236504 09:11:38 INFO - TinderboxPrint: CPU usage
13.3% 09:11:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 152 09:11:38 INFO - TinderboxPrint: I/O write bytes / time
365,121,536 / 236,504 09:11:38 INFO - TinderboxPrint: CPU idle
8,296.7 (86.7%) 09:11:38 INFO - TinderboxPrint: CPU user
1,216.3 (12.7%) 09:11:38 INFO - TinderboxPrint: Swap in / out
0 / 0 09:11:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99708928; Read time: 0; Write time: 86564 09:11:38 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 257441792; Read time: 152; Write time: 149104 09:11:39 INFO - Running post-run listener: _upload_blobber_files 09:11:39 INFO - Blob upload gear active. 09:11:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:11: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 09:11: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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:11: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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:11:39 INFO - (blobuploader) - INFO - Open directory for files ... 09:11:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:11:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:11:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:41 INFO - (blobuploader) - INFO - Done attempting. 09:11:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:11:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:11:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:42 INFO - (blobuploader) - INFO - Done attempting. 09:11:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:11:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:11:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:45 INFO - (blobuploader) - INFO - Done attempting. 09:11:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:11:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:11:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:45 INFO - (blobuploader) - INFO - Done attempting. 09:11:45 INFO - (blobuploader) - INFO - Iteration through files over. 09:11:45 INFO - Return code: 0 09:11:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:11:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:11:45 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dbbf4681ecc3885b3a9bbec0f9c54729dba0b58451c3478ff10fd60ba2b98946c6b512b8d071515ee4a2eac68f11504489df00e3b59120c7a72edd948f96a7ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ed5b7b274357ac14ef840a9615e1378e0fef2fa89623cd49df2e360cd22a05037592fb7ceb74fa015e8fce6253d4cba2fbf95ee38f2bd4bb2fba91acaaf6fe0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/182fc83dab5c190f8059771e489768dff7b1c8833de31beeb6c62737289c69a9982a0e3bf426baf78037ae0237739ca9102f7e272978cee1412a9d1c7c0df775", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/14756f6d4961e38bb2e7cc672f9074d60004d98794fe1fe59f48b0e9b74dea0cd72d84788ba32e8431ac9c9fb41008a1fdc157f8378f4103a2c8c61a465cabd7"} 09:11:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:11:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:11:45 INFO - Contents: 09:11:45 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dbbf4681ecc3885b3a9bbec0f9c54729dba0b58451c3478ff10fd60ba2b98946c6b512b8d071515ee4a2eac68f11504489df00e3b59120c7a72edd948f96a7ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ed5b7b274357ac14ef840a9615e1378e0fef2fa89623cd49df2e360cd22a05037592fb7ceb74fa015e8fce6253d4cba2fbf95ee38f2bd4bb2fba91acaaf6fe0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/182fc83dab5c190f8059771e489768dff7b1c8833de31beeb6c62737289c69a9982a0e3bf426baf78037ae0237739ca9102f7e272978cee1412a9d1c7c0df775", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/14756f6d4961e38bb2e7cc672f9074d60004d98794fe1fe59f48b0e9b74dea0cd72d84788ba32e8431ac9c9fb41008a1fdc157f8378f4103a2c8c61a465cabd7"} 09:11:45 INFO - Running post-run listener: copy_logs_to_upload_dir 09:11:45 INFO - Copying logs to upload dir... 09:11:45 INFO - mkdir: /builds/slave/test/build/upload/logs 09:11:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.539187 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-09 09:11:44.531308) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 09:11:44.535201) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338 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-Non-PGO/sha512/dbbf4681ecc3885b3a9bbec0f9c54729dba0b58451c3478ff10fd60ba2b98946c6b512b8d071515ee4a2eac68f11504489df00e3b59120c7a72edd948f96a7ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ed5b7b274357ac14ef840a9615e1378e0fef2fa89623cd49df2e360cd22a05037592fb7ceb74fa015e8fce6253d4cba2fbf95ee38f2bd4bb2fba91acaaf6fe0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/182fc83dab5c190f8059771e489768dff7b1c8833de31beeb6c62737289c69a9982a0e3bf426baf78037ae0237739ca9102f7e272978cee1412a9d1c7c0df775", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/14756f6d4961e38bb2e7cc672f9074d60004d98794fe1fe59f48b0e9b74dea0cd72d84788ba32e8431ac9c9fb41008a1fdc157f8378f4103a2c8c61a465cabd7"} build_url:https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/ZK9AKUeVQXOqHsezmnWD7g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dbbf4681ecc3885b3a9bbec0f9c54729dba0b58451c3478ff10fd60ba2b98946c6b512b8d071515ee4a2eac68f11504489df00e3b59120c7a72edd948f96a7ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7ed5b7b274357ac14ef840a9615e1378e0fef2fa89623cd49df2e360cd22a05037592fb7ceb74fa015e8fce6253d4cba2fbf95ee38f2bd4bb2fba91acaaf6fe0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/182fc83dab5c190f8059771e489768dff7b1c8833de31beeb6c62737289c69a9982a0e3bf426baf78037ae0237739ca9102f7e272978cee1412a9d1c7c0df775", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/14756f6d4961e38bb2e7cc672f9074d60004d98794fe1fe59f48b0e9b74dea0cd72d84788ba32e8431ac9c9fb41008a1fdc157f8378f4103a2c8c61a465cabd7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 09:11:44.563839) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 09:11:44.564566) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1494345050.681699-1866885338 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 09:11:44.645745) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 09:11:44.646128) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 09:11:44.646540) ========= ========= Total master_lag: 0.17 =========