builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1494547118.09 results: success (0) revision: 7e0e20683d5ab7ac8238251fa411ef3027daa22e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 16:58:38.093999) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 16:58:38.094503) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 16:58:38.094882) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 16:58:38.112445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 16:58:38.112714) ========= 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=03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-11 16:58:38-- 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% 102M=0s 2017-05-11 16:58:38 (102 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108221 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 16:58:38.234282) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 16:58:38.237609) ========= 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=03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019238 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 16:58:38.286872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-11 16:58:38.287177) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7e0e20683d5ab7ac8238251fa411ef3027daa22e --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 7e0e20683d5ab7ac8238251fa411ef3027daa22e --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=03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-11 16:58:38,686 truncating revision to first 12 chars 2017-05-11 16:58:38,686 Setting DEBUG logging. 2017-05-11 16:58:38,686 attempt 1/10 2017-05-11 16:58:38,686 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7e0e20683d5a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-11 16:58:39,802 unpacking tar archive at: mozilla-central-7e0e20683d5a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.473778 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-11 16:58:39.777157) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 16:58:39.780648) ========= script_repo_revision: 7e0e20683d5ab7ac8238251fa411ef3027daa22e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 16:58:39.781084) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 16:58:39.781371) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 16:58:39.792169) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 37 mins, 36 secs) (at 2017-05-11 16:58:39.792493) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:58:40 INFO - MultiFileLogger online at 20170511 16:58:40 in /builds/slave/test 16:58:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:58:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:58:40 INFO - {'append_to_log': False, 16:58:40 INFO - 'base_work_dir': '/builds/slave/test', 16:58:40 INFO - 'blob_upload_branch': 'Firefox', 16:58:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:58:40 INFO - 'branch': 'Firefox', 16:58:40 INFO - 'buildbot_json_path': 'buildprops.json', 16:58:40 INFO - 'config_files': ('talos/linux_config.py',), 16:58:40 INFO - 'default_actions': ('clobber', 16:58:40 INFO - 'read-buildbot-config', 16:58:40 INFO - 'download-and-extract', 16:58:40 INFO - 'populate-webroot', 16:58:40 INFO - 'create-virtualenv', 16:58:40 INFO - 'install', 16:58:40 INFO - 'run-tests'), 16:58:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:58:40 INFO - 'download_minidump_stackwalk': True, 16:58:40 INFO - 'download_symbols': 'ondemand', 16:58:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:58:40 INFO - 'tooltool.py': '/tools/tooltool.py', 16:58:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:58:40 INFO - '/tools/misc-python/virtualenv.py')}, 16:58:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:58:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:58:40 INFO - 'gecko_profile': False, 16:58:40 INFO - 'gecko_profile_interval': 0, 16:58:40 INFO - 'installer_path': 'installer.exe', 16:58:40 INFO - 'log_level': 'info', 16:58:40 INFO - 'log_name': 'talos', 16:58:40 INFO - 'log_to_console': True, 16:58:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:58:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:58:40 INFO - 'opt_config_files': (), 16:58:40 INFO - 'pip_index': False, 16:58:40 INFO - 'suite': 'dromaeojs', 16:58:40 INFO - 'system_bits': '32', 16:58:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:58:40 INFO - 'title': 'talos-linux64-ix-047', 16:58:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:58:40 INFO - 'use_talos_json': True, 16:58:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:58:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:58:40 INFO - 'work_dir': 'build'} 16:58:40 INFO - [mozharness: 2017-05-11 23:58:40.290784Z] Running clobber step. 16:58:40 INFO - Running pre-action listener: _resource_record_pre_action 16:58:40 INFO - Running main action method: clobber 16:58:40 INFO - rmtree: /builds/slave/test/build 16:58:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:58:41 INFO - Running post-action listener: _resource_record_post_action 16:58:41 INFO - [mozharness: 2017-05-11 23:58:41.785790Z] Finished clobber step (success) 16:58:41 INFO - [mozharness: 2017-05-11 23:58:41.785889Z] Running read-buildbot-config step. 16:58:41 INFO - Running pre-action listener: _resource_record_pre_action 16:58:41 INFO - Running main action method: read_buildbot_config 16:58:41 INFO - Using buildbot properties: 16:58:41 INFO - { 16:58:41 INFO - "project": "", 16:58:41 INFO - "product": "firefox", 16:58:41 INFO - "who": "eakhgari@mozilla.com", 16:58:41 INFO - "installer_path": "public/build/target.tar.bz2", 16:58:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:58:41 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:58:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 16:58:41 INFO - "stage_platform": "linux64-pgo", 16:58:41 INFO - "basedir": "/builds/slave/test", 16:58:41 INFO - "buildnumber": 175, 16:58:41 INFO - "platform": "ubuntu64_hw", 16:58:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:58:41 INFO - "slavebuilddir": "test", 16:58:41 INFO - "taskId": "AoFvJiBORUiUVZeqi6lx0g", 16:58:41 INFO - "branch": "mozilla-central", 16:58:41 INFO - "script_repo_revision": "production", 16:58:41 INFO - "revision": "7e0e20683d5ab7ac8238251fa411ef3027daa22e", 16:58:41 INFO - "slavename": "talos-linux64-ix-047", 16:58:41 INFO - "repo_path": "mozilla-central" 16:58:41 INFO - } 16:58:41 INFO - Finding installer, test and symbols from parent task. 16:58:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AoFvJiBORUiUVZeqi6lx0g'}, attempt #1 16:58:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AoFvJiBORUiUVZeqi6lx0g'}, attempt #1 16:58:42 INFO - Task dependencies: FTdaE7bQTb-8Gl47CAk35A 16:58:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A'}, attempt #1 16:58:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.tar.bz2 16:58:43 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/test_packages.json 16:58:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.crashreporter-symbols.zip 16:58:43 INFO - Running post-action listener: _resource_record_post_action 16:58:43 INFO - [mozharness: 2017-05-11 23:58:43.162862Z] Finished read-buildbot-config step (success) 16:58:43 INFO - [mozharness: 2017-05-11 23:58:43.163077Z] Running download-and-extract step. 16:58:43 INFO - Running pre-action listener: _resource_record_pre_action 16:58:43 INFO - Running main action method: download_and_extract 16:58:43 INFO - mkdir: /builds/slave/test/build/tests 16:58:43 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')]} 16:58:43 INFO - trying https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.test_packages.json 16:58:43 INFO - Downloading https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:58:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:58:43 INFO - Downloaded 986 bytes. 16:58:43 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:58:43 INFO - Using the following test package requirements: 16:58:43 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:58:43 INFO - u'common': [u'target.common.tests.zip'], 16:58:43 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:58:43 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:58:43 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:58:43 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:58:43 INFO - u'mozbase': [u'target.common.tests.zip'], 16:58:43 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:58:43 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:58:43 INFO - u'web-platform': [u'target.common.tests.zip', 16:58:43 INFO - u'target.web-platform.tests.zip'], 16:58:43 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:58:43 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:58:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.common.tests.zip 16:58:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:58:43 INFO - Fetch https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.common.tests.zip into memory 16:58:44 INFO - Content-Length response header: 60736518 16:58:44 INFO - Bytes received: 60736518 16:58:54 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:58:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.common.tests.zip 16:58:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:58:54 INFO - Fetch https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.common.tests.zip into memory 16:58:56 INFO - Content-Length response header: 60736518 16:58:56 INFO - Bytes received: 60736518 16:59:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.talos.tests.zip 16:59:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:59:06 INFO - Fetch https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.talos.tests.zip into memory 16:59:07 INFO - Content-Length response header: 14409411 16:59:07 INFO - Bytes received: 14409411 16:59:07 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')]} 16:59:07 INFO - trying https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.tar.bz2 16:59:07 INFO - Downloading https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:59:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:59:08 INFO - Downloaded 68430431 bytes. 16:59:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.tar.bz2 16:59:08 INFO - mkdir: /builds/slave/test/properties 16:59:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:59:08 INFO - Writing to file /builds/slave/test/properties/build_url 16:59:08 INFO - Contents: 16:59:08 INFO - build_url:https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.tar.bz2 16:59:08 INFO - Running post-action listener: _resource_record_post_action 16:59:08 INFO - Running post-action listener: set_extra_try_arguments 16:59:08 INFO - [mozharness: 2017-05-11 23:59:08.983499Z] Finished download-and-extract step (success) 16:59:08 INFO - [mozharness: 2017-05-11 23:59:08.983596Z] Running populate-webroot step. 16:59:08 INFO - Running pre-action listener: _resource_record_pre_action 16:59:08 INFO - Running main action method: populate_webroot 16:59:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:59:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:59:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:59:08 INFO - '--tppagecycles', 16:59:08 INFO - '7'], 16:59:08 INFO - 'tests': ['tsvgm']}}, 16:59:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:59:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:59:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:59:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:59:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:59:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:59:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:59:08 INFO - 'talos_options': ['--disable-e10s'], 16:59:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:59:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:59:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:59:08 INFO - 'talos_options': ['--disable-e10s'], 16:59:08 INFO - 'tests': ['damp', 'tps']}, 16:59:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:59:08 INFO - 'tests': ['damp', 'tps']}, 16:59:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:59:08 INFO - 'tests': ['dromaeo_dom']}, 16:59:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:59:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:59:08 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:59:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:59:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:59:08 INFO - 'tests': ['a11yr', 16:59:08 INFO - 'ts_paint', 16:59:08 INFO - 'tpaint', 16:59:08 INFO - 'sessionrestore', 16:59:08 INFO - 'sessionrestore_no_auto_restore', 16:59:08 INFO - 'tabpaint']}, 16:59:08 INFO - 'other-e10s': {'tests': ['a11yr', 16:59:08 INFO - 'ts_paint', 16:59:08 INFO - 'tpaint', 16:59:08 INFO - 'sessionrestore', 16:59:08 INFO - 'sessionrestore_no_auto_restore', 16:59:08 INFO - 'tabpaint']}, 16:59:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:59:08 INFO - 'ts_paint', 16:59:08 INFO - 'tpaint', 16:59:08 INFO - 'sessionrestore', 16:59:08 INFO - 'sessionrestore_no_auto_restore', 16:59:08 INFO - 'tabpaint']}, 16:59:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:59:08 INFO - 'ts_paint', 16:59:08 INFO - 'tpaint', 16:59:08 INFO - 'sessionrestore', 16:59:08 INFO - 'sessionrestore_no_auto_restore', 16:59:08 INFO - 'tabpaint']}, 16:59:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:59:08 INFO - 'tests': ['a11yr', 16:59:08 INFO - 'ts_paint', 16:59:08 INFO - 'tpaint', 16:59:08 INFO - 'sessionrestore', 16:59:08 INFO - 'sessionrestore_no_auto_restore', 16:59:08 INFO - 'tabpaint']}, 16:59:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:59:08 INFO - 'tests': ['a11yr', 16:59:08 INFO - 'ts_paint', 16:59:08 INFO - 'tpaint', 16:59:08 INFO - 'sessionrestore', 16:59:08 INFO - 'sessionrestore_no_auto_restore', 16:59:08 INFO - 'tabpaint']}, 16:59:08 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:59:08 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:59:08 INFO - 'bloom_basic_ref']}, 16:59:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:59:08 INFO - 'tests': ['tsvgx', 16:59:08 INFO - 'tsvgr_opacity', 16:59:08 INFO - 'tart', 16:59:08 INFO - 'tscrollx', 16:59:08 INFO - 'cart', 16:59:08 INFO - 'tsvg_static']}, 16:59:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:59:08 INFO - 'tsvgr_opacity', 16:59:08 INFO - 'tart', 16:59:08 INFO - 'tscrollx', 16:59:08 INFO - 'cart', 16:59:08 INFO - 'tsvg_static']}, 16:59:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:59:08 INFO - 'talos_options': ['--disable-e10s'], 16:59:08 INFO - 'tests': ['tp5o']}, 16:59:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:59:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:59:08 INFO - 'talos_options': ['--disable-e10s', 16:59:08 INFO - '--xperf_path', 16:59:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:08 INFO - 'tests': ['tp5n']}, 16:59:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:59:08 INFO - 'talos_options': ['--xperf_path', 16:59:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:59:08 INFO - 'tests': ['tp5n']}}, 16:59:08 INFO - 'talos.zip': {'path': '', 16:59:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:59:08 INFO - Running post-action listener: _resource_record_post_action 16:59:08 INFO - [mozharness: 2017-05-11 23:59:08.997082Z] Finished populate-webroot step (success) 16:59:08 INFO - [mozharness: 2017-05-11 23:59:08.997170Z] Running create-virtualenv step. 16:59:08 INFO - Running pre-action listener: _resource_record_pre_action 16:59:08 INFO - Running main action method: create_virtualenv 16:59:08 INFO - Creating virtualenv /builds/slave/test/build/venv 16:59:08 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 16:59:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:59:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:59:09 INFO - Using real prefix '/usr' 16:59:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:59:09 INFO - Installing distribute.............................................................................................................................................................................................done. 16:59:11 INFO - Installing pip.................done. 16:59:11 INFO - Return code: 0 16:59:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:59:11 INFO - Reading from file tmpfile_stdout 16:59:11 INFO - Output received: 16:59:11 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) 16:59:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:59:11 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')]} 16:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:11 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')]} 16:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:11 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 0xe651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d4a30>, '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 0x11d57f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d5ca0>, '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': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', '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 16:59:11 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 16:59:11 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 16:59:11 INFO - Using env: {'DISPLAY': ':0', 16:59:11 INFO - 'HOME': '/home/cltbld', 16:59:11 INFO - 'LANG': 'en_US.UTF-8', 16:59:11 INFO - 'LANGUAGE': 'en_US:en', 16:59:11 INFO - 'LOGNAME': 'cltbld', 16:59:11 INFO - 'MAIL': '/var/mail/cltbld', 16:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:11 INFO - 'MOZ_NO_REMOTE': '1', 16:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:11 INFO - 'NO_EM_RESTART': '1', 16:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:11 INFO - 'PWD': '/builds/slave/test', 16:59:11 INFO - 'SHELL': '/bin/bash', 16:59:11 INFO - 'SHLVL': '1', 16:59:11 INFO - 'TERM': 'linux', 16:59:11 INFO - 'TMOUT': '86400', 16:59:11 INFO - 'USER': 'cltbld', 16:59:11 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', 16:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:11 INFO - '_': '/tools/buildbot/bin/python'} 16:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:11 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 16:59:11 INFO - Cleaning up... 16:59:11 INFO - Return code: 0 16:59:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:59:11 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')]} 16:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:11 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')]} 16:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:59:12 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 0xe651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d4a30>, '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 0x11d57f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d5ca0>, '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': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', '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 16:59:12 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 16:59:12 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 16:59:12 INFO - Using env: {'DISPLAY': ':0', 16:59:12 INFO - 'HOME': '/home/cltbld', 16:59:12 INFO - 'LANG': 'en_US.UTF-8', 16:59:12 INFO - 'LANGUAGE': 'en_US:en', 16:59:12 INFO - 'LOGNAME': 'cltbld', 16:59:12 INFO - 'MAIL': '/var/mail/cltbld', 16:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:12 INFO - 'MOZ_NO_REMOTE': '1', 16:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:59:12 INFO - 'NO_EM_RESTART': '1', 16:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:12 INFO - 'PWD': '/builds/slave/test', 16:59:12 INFO - 'SHELL': '/bin/bash', 16:59:12 INFO - 'SHLVL': '1', 16:59:12 INFO - 'TERM': 'linux', 16:59:12 INFO - 'TMOUT': '86400', 16:59:12 INFO - 'USER': 'cltbld', 16:59:12 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', 16:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:12 INFO - '_': '/tools/buildbot/bin/python'} 16:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:59:12 INFO - Downloading/unpacking psutil>=3.1.1 16:59:12 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 16:59:12 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 16:59:12 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 16:59:12 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 16:59:12 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 16:59:12 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 17:01:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:01:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:01:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:01:19 INFO - Installing collected packages: psutil 17:01:19 INFO - Running setup.py install for psutil 17:01:19 INFO - building 'psutil._psutil_linux' extension 17:01:19 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 17:01:19 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 17:01:19 INFO - building 'psutil._psutil_posix' extension 17:01:19 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 17:01:20 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 17:01:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:01:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:01:20 INFO - Successfully installed psutil 17:01:20 INFO - Cleaning up... 17:01:20 INFO - Return code: 0 17:01:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:01:20 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')]} 17:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:01:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:20 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')]} 17:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:01:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:01:20 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 0xe651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d4a30>, '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 0x11d57f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d5ca0>, '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': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', '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 17:01:20 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 17:01:20 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 17:01:20 INFO - Using env: {'DISPLAY': ':0', 17:01:20 INFO - 'HOME': '/home/cltbld', 17:01:20 INFO - 'LANG': 'en_US.UTF-8', 17:01:20 INFO - 'LANGUAGE': 'en_US:en', 17:01:20 INFO - 'LOGNAME': 'cltbld', 17:01:20 INFO - 'MAIL': '/var/mail/cltbld', 17:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:01:20 INFO - 'MOZ_NO_REMOTE': '1', 17:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:01:20 INFO - 'NO_EM_RESTART': '1', 17:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:01:20 INFO - 'PWD': '/builds/slave/test', 17:01:20 INFO - 'SHELL': '/bin/bash', 17:01:20 INFO - 'SHLVL': '1', 17:01:20 INFO - 'TERM': 'linux', 17:01:20 INFO - 'TMOUT': '86400', 17:01:20 INFO - 'USER': 'cltbld', 17:01:20 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', 17:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:01:20 INFO - '_': '/tools/buildbot/bin/python'} 17:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:01:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:01:20 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 17:01:20 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 17:01:20 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 17:01:20 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 17:01:20 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 17:01:20 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 17:03:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:03:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:03:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:03:27 INFO - Installing collected packages: mozsystemmonitor 17:03:27 INFO - Running setup.py install for mozsystemmonitor 17:03:27 INFO - Successfully installed mozsystemmonitor 17:03:27 INFO - Cleaning up... 17:03:28 INFO - Return code: 0 17:03:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:03:28 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')]} 17:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:03:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:28 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')]} 17:03:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:03:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:03:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0xe651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d4a30>, '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 0x11d57f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d5ca0>, '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': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', '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 17:03:28 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 17:03:28 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 17:03:28 INFO - Using env: {'DISPLAY': ':0', 17:03:28 INFO - 'HOME': '/home/cltbld', 17:03:28 INFO - 'LANG': 'en_US.UTF-8', 17:03:28 INFO - 'LANGUAGE': 'en_US:en', 17:03:28 INFO - 'LOGNAME': 'cltbld', 17:03:28 INFO - 'MAIL': '/var/mail/cltbld', 17:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:28 INFO - 'MOZ_NO_REMOTE': '1', 17:03:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:28 INFO - 'NO_EM_RESTART': '1', 17:03:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:28 INFO - 'PWD': '/builds/slave/test', 17:03:28 INFO - 'SHELL': '/bin/bash', 17:03:28 INFO - 'SHLVL': '1', 17:03:28 INFO - 'TERM': 'linux', 17:03:28 INFO - 'TMOUT': '86400', 17:03:28 INFO - 'USER': 'cltbld', 17:03:28 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', 17:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:28 INFO - '_': '/tools/buildbot/bin/python'} 17:03:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:03:28 INFO - Downloading/unpacking jsonschema==2.5.1 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:03: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 17:05:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:05:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:05:35 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 17:05:35 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 17:05:35 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 17:05:35 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 17:05:35 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 17:05:35 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 17:07:41 INFO - Downloading functools32-3.2.3-2.tar.gz 17:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:07:41 INFO - warning: no files found matching '*.txt' 17:07:41 INFO - no previously-included directories found matching 'build' 17:07:41 INFO - no previously-included directories found matching 'dist' 17:07:41 INFO - no previously-included directories found matching '.git*' 17:07:41 INFO - Installing collected packages: jsonschema, functools32 17:07:42 INFO - Running setup.py install for functools32 17:07:42 INFO - warning: no files found matching '*.txt' 17:07:42 INFO - no previously-included directories found matching 'build' 17:07:42 INFO - no previously-included directories found matching 'dist' 17:07:42 INFO - no previously-included directories found matching '.git*' 17:07:42 INFO - Successfully installed jsonschema functools32 17:07:42 INFO - Cleaning up... 17:07:42 INFO - Return code: 0 17:07:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:07:42 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')]} 17:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:42 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')]} 17:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0xe651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d4a30>, '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 0x11d57f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d5ca0>, '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': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', '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 17:07:42 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 17:07:42 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 17:07:42 INFO - Using env: {'DISPLAY': ':0', 17:07:42 INFO - 'HOME': '/home/cltbld', 17:07:42 INFO - 'LANG': 'en_US.UTF-8', 17:07:42 INFO - 'LANGUAGE': 'en_US:en', 17:07:42 INFO - 'LOGNAME': 'cltbld', 17:07:42 INFO - 'MAIL': '/var/mail/cltbld', 17:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:42 INFO - 'MOZ_NO_REMOTE': '1', 17:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:42 INFO - 'NO_EM_RESTART': '1', 17:07:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:42 INFO - 'PWD': '/builds/slave/test', 17:07:42 INFO - 'SHELL': '/bin/bash', 17:07:42 INFO - 'SHLVL': '1', 17:07:42 INFO - 'TERM': 'linux', 17:07:42 INFO - 'TMOUT': '86400', 17:07:42 INFO - 'USER': 'cltbld', 17:07:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', 17:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:42 INFO - '_': '/tools/buildbot/bin/python'} 17:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:07:42 INFO - Cleaning up... 17:07:42 INFO - Return code: 0 17:07:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:07:42 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')]} 17:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:42 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')]} 17:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0xe651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d4a30>, '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 0x11d57f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d5ca0>, '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': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', '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 17:07:42 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 17:07:42 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 17:07:42 INFO - Using env: {'DISPLAY': ':0', 17:07:42 INFO - 'HOME': '/home/cltbld', 17:07:42 INFO - 'LANG': 'en_US.UTF-8', 17:07:42 INFO - 'LANGUAGE': 'en_US:en', 17:07:42 INFO - 'LOGNAME': 'cltbld', 17:07:42 INFO - 'MAIL': '/var/mail/cltbld', 17:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:42 INFO - 'MOZ_NO_REMOTE': '1', 17:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:42 INFO - 'NO_EM_RESTART': '1', 17:07:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:42 INFO - 'PWD': '/builds/slave/test', 17:07:42 INFO - 'SHELL': '/bin/bash', 17:07:42 INFO - 'SHLVL': '1', 17:07:42 INFO - 'TERM': 'linux', 17:07:42 INFO - 'TMOUT': '86400', 17:07:42 INFO - 'USER': 'cltbld', 17:07:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', 17:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:42 INFO - '_': '/tools/buildbot/bin/python'} 17:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:42 INFO - Downloading/unpacking blobuploader==1.2.4 17:07:42 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 17:07:42 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 17:07:42 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 17:07:42 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 17:07:42 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 17:07:42 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 17:09:50 INFO - Downloading blobuploader-1.2.4.tar.gz 17:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:09:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:50 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 17:09:50 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 17:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:11:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:11:56 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 17:11:56 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 17:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:11:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:14:03 INFO - Downloading docopt-0.6.1.tar.gz 17:14:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:14:03 INFO - Installing collected packages: blobuploader, requests, docopt 17:14:03 INFO - Running setup.py install for blobuploader 17:14:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:14:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:14:03 INFO - Running setup.py install for requests 17:14:03 INFO - Running setup.py install for docopt 17:14:03 INFO - Successfully installed blobuploader requests docopt 17:14:03 INFO - Cleaning up... 17:14:03 INFO - Return code: 0 17:14:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:14:03 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')]} 17:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:03 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')]} 17:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:03 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 0xe651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d4a30>, '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 0x11d57f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d5ca0>, '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': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', '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 17:14:03 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 17:14:03 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 17:14:03 INFO - Using env: {'DISPLAY': ':0', 17:14:03 INFO - 'HOME': '/home/cltbld', 17:14:03 INFO - 'LANG': 'en_US.UTF-8', 17:14:03 INFO - 'LANGUAGE': 'en_US:en', 17:14:03 INFO - 'LOGNAME': 'cltbld', 17:14:03 INFO - 'MAIL': '/var/mail/cltbld', 17:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:03 INFO - 'MOZ_NO_REMOTE': '1', 17:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:03 INFO - 'NO_EM_RESTART': '1', 17:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:03 INFO - 'PWD': '/builds/slave/test', 17:14:03 INFO - 'SHELL': '/bin/bash', 17:14:03 INFO - 'SHLVL': '1', 17:14:03 INFO - 'TERM': 'linux', 17:14:03 INFO - 'TMOUT': '86400', 17:14:03 INFO - 'USER': 'cltbld', 17:14:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', 17:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:03 INFO - '_': '/tools/buildbot/bin/python'} 17:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:14:04 INFO - Running setup.py (path:/tmp/pip-fxME9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:14:04 INFO - Running setup.py (path:/tmp/pip-4BChuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:14:04 INFO - Running setup.py (path:/tmp/pip-kyUVYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:14:04 INFO - Running setup.py (path:/tmp/pip-PsOXZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:14:04 INFO - Running setup.py (path:/tmp/pip-05fX9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:14:04 INFO - Running setup.py (path:/tmp/pip-1hLZWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:14:04 INFO - Running setup.py (path:/tmp/pip-1oYI3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:14:04 INFO - Running setup.py (path:/tmp/pip-hxkeFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:14:04 INFO - Running setup.py (path:/tmp/pip-DL2BWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:14:04 INFO - Running setup.py (path:/tmp/pip-hcRzqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:14:04 INFO - Running setup.py (path:/tmp/pip-0HYsU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:14:04 INFO - Running setup.py (path:/tmp/pip-MT5uGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:14:04 INFO - Running setup.py (path:/tmp/pip-lYbAd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:14:05 INFO - Running setup.py (path:/tmp/pip-2Tr59Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:05 INFO - Running setup.py (path:/tmp/pip-_tqvUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:14:05 INFO - Running setup.py (path:/tmp/pip-hPJkAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:14:05 INFO - Running setup.py (path:/tmp/pip-0cNbk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:14:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:14:05 INFO - Running setup.py install for manifestparser 17:14:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:14:05 INFO - Running setup.py install for mozcrash 17:14:05 INFO - Running setup.py install for mozdebug 17:14:05 INFO - Running setup.py install for mozdevice 17:14:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:14:05 INFO - Running setup.py install for mozfile 17:14:05 INFO - Running setup.py install for mozhttpd 17:14:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:14:05 INFO - Running setup.py install for mozinfo 17:14:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:14:06 INFO - Running setup.py install for mozInstall 17:14:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:14:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:14:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:14:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:14:06 INFO - Running setup.py install for mozleak 17:14:06 INFO - Running setup.py install for mozlog 17:14:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:14:06 INFO - Running setup.py install for moznetwork 17:14:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:14:06 INFO - Running setup.py install for mozprocess 17:14:06 INFO - Running setup.py install for mozprofile 17:14:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:14:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:14:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:14:06 INFO - Running setup.py install for mozrunner 17:14:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:14:06 INFO - Running setup.py install for mozscreenshot 17:14:06 INFO - Running setup.py install for moztest 17:14:06 INFO - Running setup.py install for mozversion 17:14:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:14:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:14:07 INFO - Cleaning up... 17:14:07 INFO - Return code: 0 17:14:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:14:07 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')]} 17:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:07 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')]} 17:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:14:07 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 0xe651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d4a30>, '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 0x11d57f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d5ca0>, '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': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', '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 17:14:07 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 17:14:07 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 17:14:07 INFO - Using env: {'DISPLAY': ':0', 17:14:07 INFO - 'HOME': '/home/cltbld', 17:14:07 INFO - 'LANG': 'en_US.UTF-8', 17:14:07 INFO - 'LANGUAGE': 'en_US:en', 17:14:07 INFO - 'LOGNAME': 'cltbld', 17:14:07 INFO - 'MAIL': '/var/mail/cltbld', 17:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:07 INFO - 'MOZ_NO_REMOTE': '1', 17:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:07 INFO - 'NO_EM_RESTART': '1', 17:14:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:07 INFO - 'PWD': '/builds/slave/test', 17:14:07 INFO - 'SHELL': '/bin/bash', 17:14:07 INFO - 'SHLVL': '1', 17:14:07 INFO - 'TERM': 'linux', 17:14:07 INFO - 'TMOUT': '86400', 17:14:07 INFO - 'USER': 'cltbld', 17:14:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', 17:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:07 INFO - '_': '/tools/buildbot/bin/python'} 17:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:14:07 INFO - Running setup.py (path:/tmp/pip-gDpcLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:14:07 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)) 17:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:14:07 INFO - Running setup.py (path:/tmp/pip-Wcncwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:14:07 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)) 17:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:14:07 INFO - Running setup.py (path:/tmp/pip-KRISxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:14:07 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)) 17:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:14:07 INFO - Running setup.py (path:/tmp/pip-ebIVYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:14:07 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)) 17:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:14:07 INFO - Running setup.py (path:/tmp/pip-hYbpSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:14:07 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)) 17:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:14:07 INFO - Running setup.py (path:/tmp/pip-z_3Pzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:14:07 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)) 17:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:14:07 INFO - Running setup.py (path:/tmp/pip-uqpTt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:14:07 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)) 17:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:14:07 INFO - Running setup.py (path:/tmp/pip-MIlVuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:14:07 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)) 17:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:14:07 INFO - Running setup.py (path:/tmp/pip-rcZxj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:14:07 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)) 17:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:14:07 INFO - Running setup.py (path:/tmp/pip-SjxlLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:14:08 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)) 17:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:14:08 INFO - Running setup.py (path:/tmp/pip-H5ZdAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:14:08 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)) 17:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:14:08 INFO - Running setup.py (path:/tmp/pip-oIrNAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:14:08 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)) 17:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:14:08 INFO - Running setup.py (path:/tmp/pip-8ReuCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:14:08 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)) 17:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:14:08 INFO - Running setup.py (path:/tmp/pip-ordIOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:14:08 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)) 17:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:08 INFO - Running setup.py (path:/tmp/pip-ZECY33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:14:08 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)) 17:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:14:08 INFO - Running setup.py (path:/tmp/pip-VGZRzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:14:08 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)) 17:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:14:08 INFO - Running setup.py (path:/tmp/pip-xUI4yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:14:08 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)) 17:14:08 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)) 17:14:08 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)) 17:14:08 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)) 17:14:08 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)) 17:14:08 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)) 17:14:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:14:08 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 17:14:08 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 17:14:08 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 17:14:08 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 17:14:08 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 17:14:08 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 17:16:15 INFO - Downloading blessings-1.6.tar.gz 17:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:16:15 INFO - Installing collected packages: blessings 17:16:15 INFO - Running setup.py install for blessings 17:16:16 INFO - Successfully installed blessings 17:16:16 INFO - Cleaning up... 17:16:16 INFO - Return code: 0 17:16:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:16 INFO - Reading from file tmpfile_stdout 17:16:16 INFO - Current package versions: 17:16:16 INFO - argparse == 1.2.1 17:16:16 INFO - blessings == 1.6 17:16:16 INFO - blobuploader == 1.2.4 17:16:16 INFO - docopt == 0.6.1 17:16:16 INFO - functools32 == 3.2.3-2 17:16:16 INFO - jsonschema == 2.5.1 17:16:16 INFO - manifestparser == 1.1 17:16:16 INFO - mozInstall == 1.12 17:16:16 INFO - mozcrash == 1.0 17:16:16 INFO - mozdebug == 0.1 17:16:16 INFO - mozdevice == 0.50 17:16:16 INFO - mozfile == 1.2 17:16:16 INFO - mozhttpd == 0.7 17:16:16 INFO - mozinfo == 0.9 17:16:16 INFO - mozleak == 0.1 17:16:16 INFO - mozlog == 3.4 17:16:16 INFO - moznetwork == 0.27 17:16:16 INFO - mozprocess == 0.25 17:16:16 INFO - mozprofile == 0.28 17:16:16 INFO - mozrunner == 6.13 17:16:16 INFO - mozscreenshot == 0.1 17:16:16 INFO - mozsystemmonitor == 0.3 17:16:16 INFO - moztest == 0.8 17:16:16 INFO - mozversion == 1.4 17:16:16 INFO - psutil == 3.1.1 17:16:16 INFO - requests == 1.2.3 17:16:16 INFO - wsgiref == 0.1.2 17:16:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:16:16 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')]} 17:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:16 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')]} 17:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:16 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 0xe651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d4a30>, '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 0x11d57f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d5ca0>, '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': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', '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 17:16:16 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 17:16:16 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 17:16:16 INFO - Using env: {'DISPLAY': ':0', 17:16:16 INFO - 'HOME': '/home/cltbld', 17:16:16 INFO - 'LANG': 'en_US.UTF-8', 17:16:16 INFO - 'LANGUAGE': 'en_US:en', 17:16:16 INFO - 'LOGNAME': 'cltbld', 17:16:16 INFO - 'MAIL': '/var/mail/cltbld', 17:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:16 INFO - 'MOZ_NO_REMOTE': '1', 17:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:16 INFO - 'NO_EM_RESTART': '1', 17:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:16 INFO - 'PWD': '/builds/slave/test', 17:16:16 INFO - 'SHELL': '/bin/bash', 17:16:16 INFO - 'SHLVL': '1', 17:16:16 INFO - 'TERM': 'linux', 17:16:16 INFO - 'TMOUT': '86400', 17:16:16 INFO - 'USER': 'cltbld', 17:16:16 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', 17:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:16 INFO - '_': '/tools/buildbot/bin/python'} 17:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:16 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)) 17:16:16 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)) 17:16:16 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)) 17:16:16 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)) 17:16:16 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)) 17:16:16 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)) 17:16:16 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)) 17:16:16 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)) 17:16:16 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)) 17:16:16 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)) 17:16:16 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)) 17:16:16 INFO - Cleaning up... 17:16:16 INFO - Return code: 0 17:16:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:16:16 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')]} 17:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:16 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')]} 17:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:16 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 0xe651f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1031a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d4a30>, '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 0x11d57f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d5ca0>, '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': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', '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 17:16:16 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 17:16:16 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 17:16:16 INFO - Using env: {'DISPLAY': ':0', 17:16:16 INFO - 'HOME': '/home/cltbld', 17:16:16 INFO - 'LANG': 'en_US.UTF-8', 17:16:16 INFO - 'LANGUAGE': 'en_US:en', 17:16:16 INFO - 'LOGNAME': 'cltbld', 17:16:16 INFO - 'MAIL': '/var/mail/cltbld', 17:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:16 INFO - 'MOZ_NO_REMOTE': '1', 17:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:16 INFO - 'NO_EM_RESTART': '1', 17:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:16 INFO - 'PWD': '/builds/slave/test', 17:16:16 INFO - 'SHELL': '/bin/bash', 17:16:16 INFO - 'SHLVL': '1', 17:16:16 INFO - 'TERM': 'linux', 17:16:16 INFO - 'TMOUT': '86400', 17:16:16 INFO - 'USER': 'cltbld', 17:16:16 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', 17:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:16 INFO - '_': '/tools/buildbot/bin/python'} 17:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:16:16 INFO - Cleaning up... 17:16:16 INFO - Return code: 0 17:16:16 INFO - Running post-action listener: _resource_record_post_action 17:16:16 INFO - Running post-action listener: _start_resource_monitoring 17:16:16 INFO - Starting resource monitoring. 17:16:16 INFO - [mozharness: 2017-05-12 00:16:16.785709Z] Finished create-virtualenv step (success) 17:16:16 INFO - [mozharness: 2017-05-12 00:16:16.786182Z] Running install step. 17:16:16 INFO - Running pre-action listener: _resource_record_pre_action 17:16:16 INFO - Running main action method: install 17:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:16:16 INFO - Reading from file tmpfile_stdout 17:16:16 INFO - Detecting whether we're running mozinstall >=1.0... 17:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:16:17 INFO - Reading from file tmpfile_stdout 17:16:17 INFO - Output received: 17:16:17 INFO - Usage: mozinstall [options] installer 17:16:17 INFO - Options: 17:16:17 INFO - -h, --help show this help message and exit 17:16:17 INFO - -d DEST, --destination=DEST 17:16:17 INFO - Directory to install application into. [default: 17:16:17 INFO - "/builds/slave/test"] 17:16:17 INFO - --app=APP Application being installed. [default: firefox] 17:16:17 INFO - mkdir: /builds/slave/test/build/application 17:16:17 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'] 17:16:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:16:34 INFO - Reading from file tmpfile_stdout 17:16:34 INFO - Output received: 17:16:34 INFO - /builds/slave/test/build/application/firefox/firefox 17:16:34 INFO - Running post-action listener: _resource_record_post_action 17:16:34 INFO - [mozharness: 2017-05-12 00:16:34.113468Z] Finished install step (success) 17:16:34 INFO - [mozharness: 2017-05-12 00:16:34.113750Z] Running run-tests step. 17:16:34 INFO - Running pre-action listener: _resource_record_pre_action 17:16:34 INFO - Running main action method: run_tests 17:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:16:34 INFO - Python 2.7.3 17:16:34 INFO - Return code: 0 17:16:34 INFO - grabbing minidump binary from tooltool 17:16:34 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')]} 17:16:34 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 0x11d4a30>, '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 0x11d57f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d5ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:16:34 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 17:16:34 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 17:16:34 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 17:16:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:16:34 INFO - Return code: 0 17:16:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:16:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:16:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:16:34 INFO - ENV: RUST_BACKTRACE is now 1 17:16:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:16:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:16:34 INFO - Using env: {'DISPLAY': ':0', 17:16:34 INFO - 'HOME': '/home/cltbld', 17:16:34 INFO - 'LANG': 'en_US.UTF-8', 17:16:34 INFO - 'LANGUAGE': 'en_US:en', 17:16:34 INFO - 'LOGNAME': 'cltbld', 17:16:34 INFO - 'MAIL': '/var/mail/cltbld', 17:16:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:16:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:34 INFO - 'MOZ_NO_REMOTE': '1', 17:16:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:16:34 INFO - 'NO_EM_RESTART': '1', 17:16:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:34 INFO - 'PWD': '/builds/slave/test', 17:16:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:16:34 INFO - 'RUST_BACKTRACE': '1', 17:16:34 INFO - 'SHELL': '/bin/bash', 17:16:34 INFO - 'SHLVL': '1', 17:16:34 INFO - 'TERM': 'linux', 17:16:34 INFO - 'TMOUT': '86400', 17:16:34 INFO - 'USER': 'cltbld', 17:16:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125', 17:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:34 INFO - '_': '/tools/buildbot/bin/python'} 17:16:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:16:34 INFO - mozversion application_buildid: 20170511230109 17:16:34 INFO - mozversion application_changeset: 7e0e20683d5ab7ac8238251fa411ef3027daa22e 17:16:34 INFO - mozversion application_display_name: Nightly 17:16:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:16:34 INFO - mozversion application_name: Firefox 17:16:34 INFO - mozversion application_remotingname: firefox 17:16:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:16:34 INFO - mozversion application_vendor: Mozilla 17:16:34 INFO - mozversion application_version: 55.0a1 17:16:34 INFO - mozversion platform_buildid: 20170511230109 17:16:34 INFO - mozversion platform_changeset: 7e0e20683d5ab7ac8238251fa411ef3027daa22e 17:16:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:16:34 INFO - mozversion platform_version: 55.0a1 17:16:34 INFO - using testdate: 1494548194 17:16:34 INFO - actual date: 1494548194 17:16:34 INFO - starting webserver on 'localhost:49379' 17:16:34 INFO - SUITE-START | Running 2 tests 17:16:34 INFO - TEST-START | dromaeo_css 17:16:34 INFO - operating with platform_type : linux_ 17:16:34 INFO - Initialising browser for dromaeo_css test... 17:16:34 INFO - TEST-INFO | started process 24972 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8c_0O_/profile http://localhost:49379/getInfo.html) 17:16:37 INFO - PID 24972 | __metrics Screen width/height:1600/1200 17:16:37 INFO - PID 24972 | colorDepth:24 17:16:37 INFO - PID 24972 | Browser inner width/height: 1024/695 17:16:37 INFO - PID 24972 | __metrics 17:16:38 INFO - PID 24972 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:16:38 INFO - PID 24972 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:16:39 INFO - TEST-INFO | 24972: exit 0 17:16:39 INFO - Browser initialized. 17:16:39 INFO - Running cycle 1/1 for dromaeo_css test... 17:16:39 INFO - TEST-INFO | started process 25072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8c_0O_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:51 INFO - PID 25072 | RSS: Main: 144953344 17:16:51 INFO - PID 25072 | 17:19:53 INFO - PID 25072 | Cycle 1(1): loaded http://localhost:49379/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49379/tests/dromaeo/cssquery-ext.html) 17:19:55 INFO - PID 25072 | RSS: Main: 280997888 17:19:55 INFO - PID 25072 | 17:22:57 INFO - PID 25072 | Cycle 1(1): loaded http://localhost:49379/tests/dromaeo/cssquery-ext.html (next: http://localhost:49379/tests/dromaeo/cssquery-jquery.html) 17:22:57 INFO - PID 25072 | RSS: Main: 225656832 17:22:57 INFO - PID 25072 | 17:25:59 INFO - PID 25072 | Cycle 1(1): loaded http://localhost:49379/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49379/tests/dromaeo/cssquery-mootools.html) 17:26:00 INFO - PID 25072 | RSS: Main: 176541696 17:26:00 INFO - PID 25072 | 17:29:02 INFO - PID 25072 | Cycle 1(1): loaded http://localhost:49379/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49379/tests/dromaeo/cssquery-prototype.html) 17:29:02 INFO - PID 25072 | RSS: Main: 191336448 17:29:02 INFO - PID 25072 | 17:32:05 INFO - PID 25072 | Cycle 1(1): loaded http://localhost:49379/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49379/tests/dromaeo/cssquery-yui.html) 17:32:05 INFO - PID 25072 | RSS: Main: 177532928 17:32:05 INFO - PID 25072 | 17:35:07 INFO - PID 25072 | Cycle 1(1): loaded http://localhost:49379/tests/dromaeo/cssquery-yui.html (next: http://localhost:49379/tests/dromaeo/cssquery-dojo.html) 17:35:07 INFO - PID 25072 | RSS: Main: 264597504 17:35:07 INFO - PID 25072 | 17:35:07 INFO - PID 25072 | __start_tp_report 17:35:07 INFO - PID 25072 | _x_x_mozilla_page_load 17:35:07 INFO - PID 25072 | _x_x_mozilla_page_load_details 17:35:07 INFO - PID 25072 | |i|pagename|runs| 17:35:07 INFO - PID 25072 | |0;dojo.html;3359.47928071149;3361.394948909196;3362.9327413451715;3397.2016576104597;3435.5362026126463;5621.353544342402;5752.108423194401;5864.970675146624;5902.350741418446;5910.202122713433;5792;5830.125481177814;5834.649921004742;5862.73617687204;5964.642121472704;4736.7631618418945;4987.077390682717;5127.102757017526;5142.280080788692;5190.688558686472;5175;5191.057696598295;5257.053730328558;5257.36911570612;5269.420363759983;5079.2635067915135;5130.794768209267;5143.099957507458;5155.7679904404395;5227.163653815409;5190.584753219733;5193.246979188034;5199.948000519984;5207.4011488678525;5258.342707161605;5156.381234251876;5195.688258704452;5216.061109000379;5219.530242278175;5245.973770131163;5614.3543492498475;5693.3452652945025;5693.743781529841;5703.657780533182;5845.298564172284;6125.601835880653;6134.050719465777;6138.953131165798;6139.001538246358;6146.108814221958;6173.69131543421;6176.042713379434;6220.284667263278;6287.52843536732;6327.17746692927;5860.765569377219;5872.17789509469;5917.497012753878;5941.22764040672;5953.791617293374;6403.039544068427;6470.191226096738;6470.870582588322;6471.385218404244;6485.221773387224;6021.3677563856045;6111.388861113853;6112.2665280165775;6143.293521245025;6249.25008998923;6315.652639104894;6335.619862808154;6338.334474880164;6346.650934198571;6357.4914006879335;6341.619502829845;6341.904871426932;6346.11154438379;6346.587471814318;6351.079093531412;6044.818655440344;6141.907871381933;6348.746050158034;6353.682315884187;6356.9364306357265;4808.759562021885;4860.854174374775;4869.780859861315;4897.020595880838;4911.140550403665;4287.914241715148;4288.120935208275;4290.37789520524;4304.440422745086;4333.653307735373;5709.857253568611;5966.134910437962;5977.953858074819;5987.221661184019;6031.487323577545;6119.204503414528;6150.04674275488;6200.596961197508;6303.842403939938;6332.936670633327;5960.940390596125;5961.076033214858;5992.520598352208;6021.5182785377065;6023.337432882379;5534.1145416733125;5545.889082218333;5546.223528705985;5548.167774833807;5552.472515111058;6312.3056463788025;6406.775762848278;6613.239477459962;6709.29552397001;6711.060451536789;6158.107074474086;6287.779927702509;6306.873862522815;6316.778912738032;6320.115183874169;6688.3646053624825;6709.429698475489;6712.295209002984;6714.6642667865435;6718.563293385914;6041.214642096499;6171.444569988723;6281.089242059968;6291.937080629318;6297.559170857996;6123.008104567321;6163.8150855474405;6289.622622642656;6292.2134733158355;6298.0867774171575;5971.910421343597;6192.411720886508;6195.690215489298;6204.100405441276;6204.13142160107;6041.972864612939;6058.3335833057445;6099.75600975956;6115.6662951758;6129.328227221949;6158.32258451561;6171.56799024064;6178.752849886134;6187.071939208975;6195.845103872259;5956.642601443928;6038.818835434944;6066.332703402534;6120.721420533169;6124.167343420691;6041.486473649789;6052.061930400795;6054.788082417094;6055.091736239599;6083.574149809471 17:35:07 INFO - PID 25072 | |1;ext.html;741.4402126394572;797.6849144587887;820.2535692519808;1110.4003837927519;1129.949152288147;29339.41321173575;36955.445668315;37629.43555846665;37782.24435511295;37794;40453.79773101138;40814.38778418326;40888.18223635526;40902.59097409025;40903;5674.886502269952;5789.710514474259;7283.453740969422;7379.5203311784835;7383.704651813921;7191.352778249957;7379.59412232327;7381.852362952738;7381.926180738177;7386.593737344444;7433.1080270367365;7521.210272921319;7521.849563008736;7523.322900938914;7527;5707.942920570783;5870.618409803392;7400.222976587462;7448.888266676031;7458.328750412435;5790;7189.137303523611;7352.228016058344;7353.742619008362;7360.043194384749;37061;37419.81290093532;37428.81285593555;37456.25087498262;37468.62531374679;3506.7720598161295;3550.2012047289413;3552.0409489437966;3553.5558055243096;3554;28876.711232887614;28883.711162888314;28946.27634309159;28969.85515072432;28979.855100724573;3794.1842503861526;3794.6584807367194;3827.349350610403;3848.3650197717343;3849.345611246095;189817;189921;190117;190299;190704;48932.61741208464;48957;48984.51015489871;49050.50949490531;49073;51681.74159129256;51788.223176652384;52039;52049.739751301;52131.73934130381;14078.577642670736;14127.576172714835;14209.644758881112;14212.64468388278;14212.644683882985;9283.350165488486;9446.244300455946;10879.945600272107;11247;11252.49363778632;13127.803082953764;13148.934255328662;13154.868451315555;13309.73380532384;13311.80032299497;5250.947490525123;5286.920696189561;5355.678659280456;5373.274607927958;5412.702301373462;1075.542894269932;1094.9671509854718;1095.7370231144628;1100.8733995590449;1104.6354702948008;25812.612810807852;25914;25985.350366240997;26062.609060864103;26166.73833261643;1195.665213740154;1200.6458094862037;1206.5776978057609;1216.5012344938532;1222.6148763139583;12900.741985160244;13658.180509169482;13886.236257005961;13891.097078689852;13914.373853176632;222885;223419;224234;224758;225494;51544.74227628838;51605.22592161121;51658;51765;51845.48154518482;1504.120089747488;1506.540505145919;1526;1536.078352988198;1536.1167328785768;23976.760232397453;25201.873990630662;25236.495270094863;25267.661711251872;25676.358091047874;38700;38737;38808.417873732484;38821.22357552889;38866;198208;198465;198755;198979;199142;29545.409091818474;29959.550606740482;34017.31965360729;34191;34303.485447718806;38013.61986380101;39304.60695393124;40074.39888401735;41192.38211426771;41840.1631967365;31001.224969375045;31075.223119422197;31134.844325778227;31326.843365783025;31607;30956.535651964787;31216.843915780275;31632;31888.840555797073;31996;36588.634113658525;37091;37121.25757484889;37143.6285637151;37145;29486.557701634923;29754;30286.242843929078;30553.694463055086;30890.382192355577;24086.759132408453;24500;25031.249062528153;25262.87368563219;25344.493110138064 17:35:07 INFO - PID 25072 | |2;jquery.html;441.5385921711811;442.9247028005239;448.15075432056244;455.6992385025883;459.4647235970093;18321.450356489328;19143.61712765744;19962.30131945382;20015;20272.8986355068;21009;21436.57126857466;21621.567568648617;21623.243186488475;21721.67417488735;5401.621886467949;5529.723513824313;5545.861353466155;5548.972255138739;5556.6943818089985;4208.789560521962;5440.619156659035;5577.69322687252;5596.776128954837;5617.831465056055;5572.3870374258795;5576.609637325389;5577.9163312550345;5581.107022876341;5581.2186293918885;5468.699221542814;5517.117261238182;5529.198266251411;5535.750891209906;5544.667319960795;5029.647924645276;5055.823046193365;5063.341765570489;5067.847964561069;5068.847934561969;25938.092166774262;25987;26360.077397291196;26393.07624233162;26483.205503834917;2170.1427935965207;2175.3039027511204;2200.504886400547;2202.41635966469;2202.7136472258503;16602.25289861959;16930.49208523734;16964.7097641818;17033.48899533016;17109.82890171095;2129.073852874005;2187.147012665062;2226.5435585705054;2234.765349638281;2238.8656680599215;93520;101742;115785.42107289494;116084;116505;12482.188657737219;12583.622491325275;12650.177738446971;12743.68140796469;12913.612591622266;18135.63728725418;18159.092045397676;18169.45491635253;18198.363057293194;18209.362672306404;7871.567063811545;8212.58937053145;8247.21651443112;8298.585070746438;8320.625571849281;7189.89215161773;7221.74723884672;7247.383972362408;7439.4420418468835;7468.551886886804;8013.599320034092;8154.266116049584;8173.918260817316;8371.246587807127;8395.874061889077;2203.746569144569;2220.2784095169136;2250.324902529235;2273.204378467556;2309.8960546775434;1038.3354653022072;1056.8309070548676;1074.6775967209962;1079.7192729890285;1112.0269763956537;20337;20699.58600827975;20770.896145519175;20901.79098209029;21062.491636558058;1061.543536279392;1070.2347821307803;1083.4853444613902;1087.5758454202867;1091.6506717850211;10947.246746517398;11183.496742646601;11374;11394.373309467894;11448;450211;451599;464511;470631;470690.5861882743;90828;93389.5330523343;93446.53276733572;93578.53210734039;93598;1178.7583545373177;1186.9228500147462;1222.376587940157;1223.8592561855323;1230.501646833034;17124.914375428045;17303.653926921645;17351.7397239039;17403;18042.2783088675;43234.56765432431;43356.34965475583;43563.56436435595;43710.56289437065;44276;52347.47652523426;52696;53598.196027058846;53833.57748901231;55551;9418.670346537838;9551.904480955101;9657.32398732082;9708.980557041692;9742.512874356396;14613.19627420502;14965.176915269765;15131.54605361841;15161.09033457996;15646.452374166849;12737.808932866199;12859.0998630095;13499.190048597116;13806.87548051483;13942.721145576828;10275.332103413255;12874.420651070537;12927.96576273877;13192.076554641082;13614.455421783017;12118.515259389525;13124.606261812161;13361.933190333986;14032.929835350758;14043.929780351033;14419.78370324467;14442.783358249844;14446;14593.343299551758;14621.634459138606;12701.301428421526;12836.679083022998;12848.229106253655;12919.677008074874;13011.284379359226 17:35:07 INFO - PID 25072 | |3;mootools.html;1352.4725357110726;1406.3038795796083;1415.2711353652865;1422.8861691064722;1428.1930709149333;11113.72215694607;11583;11588.768224635513;11593.130515211351;11594.014508766764;11214;11433.771324573503;11654.650360489199;11748.11889108316;11786.35175065371;2356.587597170497;2390.8924098415614;2395.101836811196;2395.6646069550275;2395.6646069550275;1768.107105911513;2315.340128063502;2383.118246248882;2394.916177933773;2401.1595941420537;2059.567490826928;2349.459624286415;2442.560339138954;2443.1204766284122;2448.0942051440993;2336.4742932840145;2351.8588884666888;2357.6109941859745;2360.33910505058;2364.7871691547757;2298.0463107810237;2334.0080465802134;2352.3413444235644;2353.0470159585393;2357.210334537932;10903;10997.12023038155;10997.725056873562;11013;11347.943260283728;6532.477401807844;6729.427998620124;6754.223264324616;6760.594364338155;6769.627670478122;3722.1625134344827;3804.125051238203;3815.7328986970647;3830.80845957701;4022.5776293489057;1349.5006847466402;1353.2759973414177;1392.8676775706392;1413.342795600051;1420.7726763717756;17751.201195946214;17874.106294685214;17890.463286101436;17892.373766918226;17896.284148634168;5284.943011397736;5350.625456218105;5469.1249400096585;5511.366192887869;5609.046462101453;12697.619071427873;12698.365081745877;12738.235705857678;12741.745165096647;12745;6404.775832845828;6411.198600174978;6420.325865784025;6424.068510066108;6425.582337148164;5980.5215582754145;6047.15339852421;6083.969580152071;6084.239470066242;6105.389461053948;4273.273543497613;4321.416608757841;4341.82632694695;4392.209402307615;4426.800793964279;1050.4380156616173;1077.6120596585224;1208.6072026591394;1208.6132437619876;1222.5598784437595;864;885.9955700221458;893.9240164586083;903.0878812399524;932.342698397628;7130.358267755927;7152.141742990874;7180.640967951686;7269.091363579552;7318.670659820321;654.4894981914115;661.566673828643;670.8289386206486;676.5196710335618;768.0015979226982;4558.749268790249;4668.159731248408;4671.11248862715;4715.104130215248;4752.334673145762;14810.259487025822;14912.552623421314;15485.303161357766;15535;15621;15335.386584536494;15369.231538423033;15376.384944602314;15519.146446945526;15524.068555886683;9034.954825225963;9173.908260917438;9397.436153830791;9408.811823763623;9488.38325508826;7237.457190710823;7360.374368178765;7435.7025718970635;7445.813854653677;7679.846403072019;13637.727245454837;13728.519501817787;13871.375788089359;14150.716985660434;14180.787288190479;14148.363323650254;14241.64395890111;14306.785398218826;14470.710585788436;14554;9424.340296179202;9699.418034917928;9700.5149742514;9702.466364350028;9710.951445242728;10748.731281718019;11006.669799906016;11088;11088.889111108785;11096.61161859331;9454.385464944757;9564.426134431957;9600.183984361129;9615.51922403863;9819.85270220933;9091.681791137544;9113.453192808453;9138.040505747067;9147.313951453534;9274.44353338802;8161.632726527439;8263.710770123016;8285.088640249447;8286.668533258602;8295.04606970206;6157.907631385443;6181.9690901547;6217.751289948352;6265.4361107500545;6381.1704478417505;6222.657753823583;6238.844028899314;6421.93578064232;6477.870442591027;6527.771527996498 17:35:07 INFO - PID 25072 | |4;prototype.html;395.15831279374925;408.96932730045256;412.58072231523556;426.64162103832774;428.2762131996925;5848.210491583635;5861.941380586193;5862.794802181925;5887.2346594942655;5898.882022359556;5633.507120613031;5783.843231353736;5792.218050563172;5795.333536643277;5830.475257226849;4585.908281834361;4588.967482316485;4597.954020459794;4633.675642705012;4639.628829693634;4589.839355622554;4611.861644150681;4625.907481850361;4628;4644.349791029259;4471.66462515311;4592.517785632511;4612.930806037912;4621.613515945203;4633.447794988683;4620.7227566345955;4630.629549636021;4632.189366860786;4634.2121839287065;4643.303504474322;4255.893602659928;4256.4679415073115;4256.616904478612;4257.467311767761;4262.65898728101;5577.414371490976;5625.606207565472;5667.914981275284;5695.914561281584;5725.971370143165;5471.644343117685;5497.890042199174;5508.6970216638065;5517.586181036399;5520.420355862657;6041.546883983675;6199;6209.394868948555;6249.218847644044;6249.437550620466;4749.738764367993;4764;4769.475357710649;4781.493829443749;4798.760061996886;6220.688965551704;6318.74725010999;6330.746770129189;6478.352164783531;6522.608643481359;4844.95155048452;4855.475152920461;4857.975710121426;4863.392075990501;4869.415670119608;4906.484819094015;4938;4945.357103576512;4945.431275403303;4969.229769385751;5316.229146773773;5404.648697834628;5439;5460.535854452337;5474.124140137559;6169.784057557964;6180.47465965389;6217.316095229521;6228.28374736902;6236.532260080512;1654.793150856143;1693.7374706920448;1694.8644108471292;1699.430690718623;1700.9149542522825;1192.8628207756046;1224.9877501224873;1227.9140460167703;1228.7358217983176;1230.477047254913;5921.246620321571;5953.166556682068;5953.672548009901;5965.671888046112;5982.700864956735;6193.194884665055;6292.671711466786;6301.464375528039;6315.96842015787;6326.4622507087415;5827.4172582741385;5904.143899134601;5937.52499800015;5942.910856337158;5945.16767652529;3282.2286762610765;3295.967040329614;3324.1191084362663;3328.700416962485;3334.583177102862;6498.707558159894;6583.144191255202;6583.210014798255;6597.373249541286;6629.270780214172;6446.29090800021;6476.35236476358;6491.221053473613;6495.610263384212;6513.250976137805;6523.836904077341;6582.341765823379;6616.536842420985;6617.764630636397;6645.734170633121;6280.214973128359;6284.748610055546;6285.277193122666;6299.464545513682;6319.873602527831;5865.208196893364;5905.940940590711;6197.628142311476;6280;6296.150019747275;6570.671466426564;6658.267590565131;6665.366790154928;6665.900011499928;6677.395815632005;4889.731064791471;4899.191633380452;4899.265110233494;4899.387576552931;4908.9263661045825;6144.907826382697;6374.649394283359;6406.5515413920575;6429.678516074271;6435.2599451063725;6185.886540422587;6192.349803270772;6206.596571222856;6207.317195108625;6209.137258822245;6038;6141.8464538385115;6200;6205.720742566505;6233.688315584112;6199.442050215322;6208;6212.4408803207925;6215.689215539114;6247.312795592572;6139.877202455837;6199.535034872493;6233.812985610439;6257.843553911189;6275.466585340298;6009.188759517409;6036.698165091816;6050.183225264709;6066.332703402711;6070.3929607038945 17:35:07 INFO - PID 25072 | |5;yui.html;827.4580150001751;846.6105591427943;854.3464249848867;855.67056683177;864.1056506515757;15606.687866242683;16083.195840207987;16109;16125.919370403146;16135.031898086123;18241.270349186016;18556.35052773153;18971.90514047431;19098.331558395457;19138.808611913875;1004.7387679203423;1038.169464428458;1039.8024375368693;1040.0951172479954;1040.6773900090996;1014.8477728340771;1017.8778546574422;1018.0989824005734;1019.8470229465565;1020.112502123154;1072.1208608940672;1073.951672174754;1074.511097450658;1074.5809134437575;1074.6399956014745;1070;1074.5486895503868;1075.4300220882944;1075.4568942683973;1075.6289080267295;779.1390513482634;781.5584194929846;783.0525064671754;784.5292824305428;785.4148659248839;17123.571910702332;17381.478555643353;18029;18230;18278.36025739106;18520.62958740831;18693.62612747751;19111.808881911144;19272.22911083555;19304.71042934357;13986.30068496571;14318.42726290947;14344.354504047344;14486.49297274601;14497.782533262009;3345.1469875181915;3363.1592101974506;3382.3404436134965;3386.8306584670668;3587.0852932502307;85983;86339.56830215809;87899;88111.55944220303;90210;13081.869181308066;13451.932740336235;13590.252536110609;13592;13616.727665446635;23594;23627.40931476727;23639.527209455715;24329.39176520566;24349;8034.754613034989;8117.634706438224;8120.431569790058;8141.470804397695;8151.755447336589;3966.127451960622;4007.8396864125693;4018.6985976051915;4070.75575465473;4080.775557344315;4168.187203495289;4248.87253382399;4250.362445633118;4253.63844073251;4256.084941737541;818.9836203275901;823.2343920154314;833.4707460762338;833.5998720614018;833.7040350675544;715.1561157833702;720.481253497481;722.3065856777447;740.7370383513775;758.0675768804401;11203.271787333797;12204.32876191818;12403.881636031816;12450.937745311398;12534;701.7929710735345;724.6340597998083;727.3780917315725;734.2510639148146;748.5359077372065;5155.664881782672;5220.765065572058;5384.5692344612335;5396.541293990055;5420.945790542123;78726;79762.60118699369;80862.57412277641;81660.59169704233;82296.58851705703;71848;72556.63721681463;72669;73423.26576734272;75249.24750752423;39552.40671389931;63759.99999999907;63991;64124.67937660375;65459.672701636184;12071.75856482883;12788.552400665933;12830.871691282968;12874.549390771279;12897.677558061123;32538.674613253563;32860.50709239411;33901.49147762835;34181.4109518497;35102.29795404027;40081.599184007784;40249.798751006056;40773;40969.38545921754;41401;16590.66818663644;16607.584810379838;16871.240794164536;16964.406245781338;17013.574660633087;18894.3386981455;18898;18945.14746836368;19016.904915475334;19822.801771982096;18245.452636420927;18274.086295684898;18296.26814927388;18623.627527449105;19062.33281835129;16777.916110419857;16971.830281697024;17644.73532896982;17863.106844657974;18083.18625661822;17107.7433838495;17505.38731144404;17968.011759352838;18143.909280453514;18272.543186420447;12295.200811947196;12476.251424914533;12511.249325040526;12635.93682031584;13147.079704420981;13573.592792215853;14286.928565357106;14329.355179017179;14367.20980346091;14376.856231437552 17:35:07 INFO - PID 25072 | __end_tp_report 17:35:07 INFO - PID 25072 | __start_cc_report 17:35:07 INFO - PID 25072 | _x_x_mozilla_cycle_collect,1386 17:35:07 INFO - PID 25072 | __end_cc_report 17:35:07 INFO - PID 25072 | __startTimestamp1494549307765__endTimestamp 17:35:07 INFO - PID 25072 | 17:35:07 INFO - PID 25072 | ------- Summary: start ------- 17:35:07 INFO - PID 25072 | Number of tests: 6 17:35:07 INFO - PID 25072 | 17:35:07 INFO - PID 25072 | [#0] dojo.html Cycles:165 Average:5811.67 Median:6044.82 stddev:688.98 (11.4%) stddev-sans-first:663.70 17:35:07 INFO - PID 25072 | Values: 3359.5 3361.4 3362.9 3397.2 3435.5 5621.4 5752.1 5865.0 5902.4 5910.2 5792.0 5830.1 5834.6 5862.7 5964.6 4736.8 4987.1 5127.1 5142.3 5190.7 5175.0 5191.1 5257.1 5257.4 5269.4 5079.3 5130.8 5143.1 5155.8 5227.2 5190.6 5193.2 5199.9 5207.4 5258.3 5156.4 5195.7 5216.1 5219.5 5246.0 5614.4 5693.3 5693.7 5703.7 5845.3 6125.6 6134.1 6139.0 6139.0 6146.1 6173.7 6176.0 6220.3 6287.5 6327.2 5860.8 5872.2 5917.5 5941.2 5953.8 6403.0 6470.2 6470.9 6471.4 6485.2 6021.4 6111.4 6112.3 6143.3 6249.3 6315.7 6335.6 6338.3 6346.7 6357.5 6341.6 6341.9 6346.1 6346.6 6351.1 6044.8 6141.9 6348.7 6353.7 6356.9 4808.8 4860.9 4869.8 4897.0 4911.1 4287.9 4288.1 4290.4 4304.4 4333.7 5709.9 5966.1 5978.0 5987.2 6031.5 6119.2 6150.0 6200.6 6303.8 6332.9 5960.9 5961.1 5992.5 6021.5 6023.3 5534.1 5545.9 5546.2 5548.2 5552.5 6312.3 6406.8 6613.2 6709.3 6711.1 6158.1 6287.8 6306.9 6316.8 6320.1 6688.4 6709.4 6712.3 6714.7 6718.6 6041.2 6171.4 6281.1 6291.9 6297.6 6123.0 6163.8 6289.6 6292.2 6298.1 5971.9 6192.4 6195.7 6204.1 6204.1 6042.0 6058.3 6099.8 6115.7 6129.3 6158.3 6171.6 6178.8 6187.1 6195.8 5956.6 6038.8 6066.3 6120.7 6124.2 6041.5 6052.1 6054.8 6055.1 6083.6 17:35:07 INFO - PID 25072 | 17:35:07 INFO - PID 25072 | [#1] ext.html Cycles:180 Average:36945.72 Median:18905.13 stddev:53129.06 (281.0%) stddev-sans-first:53208.55 17:35:07 INFO - PID 25072 | Values: 741.4 797.7 820.3 1110.4 1129.9 29339.4 36955.4 37629.4 37782.2 37794.0 40453.8 40814.4 40888.2 40902.6 40903.0 5674.9 5789.7 7283.5 7379.5 7383.7 7191.4 7379.6 7381.9 7381.9 7386.6 7433.1 7521.2 7521.8 7523.3 7527.0 5707.9 5870.6 7400.2 7448.9 7458.3 5790.0 7189.1 7352.2 7353.7 7360.0 37061.0 37419.8 37428.8 37456.3 37468.6 3506.8 3550.2 3552.0 3553.6 3554.0 28876.7 28883.7 28946.3 28969.9 28979.9 3794.2 3794.7 3827.3 3848.4 3849.3 189817.0 189921.0 190117.0 190299.0 190704.0 48932.6 48957.0 48984.5 49050.5 49073.0 51681.7 51788.2 52039.0 52049.7 52131.7 14078.6 14127.6 14209.6 14212.6 14212.6 9283.4 9446.2 10879.9 11247.0 11252.5 13127.8 13148.9 13154.9 13309.7 13311.8 5250.9 5286.9 5355.7 5373.3 5412.7 1075.5 1095.0 1095.7 1100.9 1104.6 25812.6 25914.0 25985.4 26062.6 26166.7 1195.7 1200.6 1206.6 1216.5 1222.6 12900.7 13658.2 13886.2 13891.1 13914.4 222885.0 223419.0 224234.0 224758.0 225494.0 51544.7 51605.2 51658.0 51765.0 51845.5 1504.1 1506.5 1526.0 1536.1 1536.1 23976.8 25201.9 25236.5 25267.7 25676.4 38700.0 38737.0 38808.4 38821.2 38866.0 198208.0 198465.0 198755.0 198979.0 199142.0 29545.4 29959.6 34017.3 34191.0 34303.5 38013.6 39304.6 40074.4 41192.4 41840.2 31001.2 31075.2 31134.8 31326.8 31607.0 30956.5 31216.8 31632.0 31888.8 31996.0 36588.6 37091.0 37121.3 37143.6 37145.0 29486.6 29754.0 30286.2 30553.7 30890.4 24086.8 24500.0 25031.2 25262.9 25344.5 17:35:07 INFO - PID 25072 | 17:35:07 INFO - PID 25072 | [#2] jquery.html Cycles:180 Average:29929.71 Median:11948.49 stddev:76755.44 (642.4%) stddev-sans-first:76938.83 17:35:07 INFO - PID 25072 | Values: 441.5 442.9 448.2 455.7 459.5 18321.5 19143.6 19962.3 20015.0 20272.9 21009.0 21436.6 21621.6 21623.2 21721.7 5401.6 5529.7 5545.9 5549.0 5556.7 4208.8 5440.6 5577.7 5596.8 5617.8 5572.4 5576.6 5577.9 5581.1 5581.2 5468.7 5517.1 5529.2 5535.8 5544.7 5029.6 5055.8 5063.3 5067.8 5068.8 25938.1 25987.0 26360.1 26393.1 26483.2 2170.1 2175.3 2200.5 2202.4 2202.7 16602.3 16930.5 16964.7 17033.5 17109.8 2129.1 2187.1 2226.5 2234.8 2238.9 93520.0 101742.0 115785.4 116084.0 116505.0 12482.2 12583.6 12650.2 12743.7 12913.6 18135.6 18159.1 18169.5 18198.4 18209.4 7871.6 8212.6 8247.2 8298.6 8320.6 7189.9 7221.7 7247.4 7439.4 7468.6 8013.6 8154.3 8173.9 8371.2 8395.9 2203.7 2220.3 2250.3 2273.2 2309.9 1038.3 1056.8 1074.7 1079.7 1112.0 20337.0 20699.6 20770.9 20901.8 21062.5 1061.5 1070.2 1083.5 1087.6 1091.7 10947.2 11183.5 11374.0 11394.4 11448.0 450211.0 451599.0 464511.0 470631.0 470690.6 90828.0 93389.5 93446.5 93578.5 93598.0 1178.8 1186.9 1222.4 1223.9 1230.5 17124.9 17303.7 17351.7 17403.0 18042.3 43234.6 43356.3 43563.6 43710.6 44276.0 52347.5 52696.0 53598.2 53833.6 55551.0 9418.7 9551.9 9657.3 9709.0 9742.5 14613.2 14965.2 15131.5 15161.1 15646.5 12737.8 12859.1 13499.2 13806.9 13942.7 10275.3 12874.4 12928.0 13192.1 13614.5 12118.5 13124.6 13361.9 14032.9 14043.9 14419.8 14442.8 14446.0 14593.3 14621.6 12701.3 12836.7 12848.2 12919.7 13011.3 17:35:07 INFO - PID 25072 | 17:35:07 INFO - PID 25072 | [#3] mootools.html Cycles:180 Average:7294.28 Median:3763.14 stddev:4722.53 (125.5%) stddev-sans-first:4714.67 17:35:07 INFO - PID 25072 | Values: 1352.5 1406.3 1415.3 1422.9 1428.2 11113.7 11583.0 11588.8 11593.1 11594.0 11214.0 11433.8 11654.7 11748.1 11786.4 2356.6 2390.9 2395.1 2395.7 2395.7 1768.1 2315.3 2383.1 2394.9 2401.2 2059.6 2349.5 2442.6 2443.1 2448.1 2336.5 2351.9 2357.6 2360.3 2364.8 2298.0 2334.0 2352.3 2353.0 2357.2 10903.0 10997.1 10997.7 11013.0 11347.9 6532.5 6729.4 6754.2 6760.6 6769.6 3722.2 3804.1 3815.7 3830.8 4022.6 1349.5 1353.3 1392.9 1413.3 1420.8 17751.2 17874.1 17890.5 17892.4 17896.3 5284.9 5350.6 5469.1 5511.4 5609.0 12697.6 12698.4 12738.2 12741.7 12745.0 6404.8 6411.2 6420.3 6424.1 6425.6 5980.5 6047.2 6084.0 6084.2 6105.4 4273.3 4321.4 4341.8 4392.2 4426.8 1050.4 1077.6 1208.6 1208.6 1222.6 864.0 886.0 893.9 903.1 932.3 7130.4 7152.1 7180.6 7269.1 7318.7 654.5 661.6 670.8 676.5 768.0 4558.7 4668.2 4671.1 4715.1 4752.3 14810.3 14912.6 15485.3 15535.0 15621.0 15335.4 15369.2 15376.4 15519.1 15524.1 9035.0 9173.9 9397.4 9408.8 9488.4 7237.5 7360.4 7435.7 7445.8 7679.8 13637.7 13728.5 13871.4 14150.7 14180.8 14148.4 14241.6 14306.8 14470.7 14554.0 9424.3 9699.4 9700.5 9702.5 9711.0 10748.7 11006.7 11088.0 11088.9 11096.6 9454.4 9564.4 9600.2 9615.5 9819.9 9091.7 9113.5 9138.0 9147.3 9274.4 8161.6 8263.7 8285.1 8286.7 8295.0 6157.9 6182.0 6217.8 6265.4 6381.2 6222.7 6238.8 6421.9 6477.9 6527.8 17:35:07 INFO - PID 25072 | 17:35:07 INFO - PID 25072 | [#4] prototype.html Cycles:180 Average:5274.28 Median:5893.06 stddev:1491.98 (25.3%) stddev-sans-first:1450.52 17:35:07 INFO - PID 25072 | Values: 395.2 409.0 412.6 426.6 428.3 5848.2 5861.9 5862.8 5887.2 5898.9 5633.5 5783.8 5792.2 5795.3 5830.5 4585.9 4589.0 4598.0 4633.7 4639.6 4589.8 4611.9 4625.9 4628.0 4644.3 4471.7 4592.5 4612.9 4621.6 4633.4 4620.7 4630.6 4632.2 4634.2 4643.3 4255.9 4256.5 4256.6 4257.5 4262.7 5577.4 5625.6 5667.9 5695.9 5726.0 5471.6 5497.9 5508.7 5517.6 5520.4 6041.5 6199.0 6209.4 6249.2 6249.4 4749.7 4764.0 4769.5 4781.5 4798.8 6220.7 6318.7 6330.7 6478.4 6522.6 4845.0 4855.5 4858.0 4863.4 4869.4 4906.5 4938.0 4945.4 4945.4 4969.2 5316.2 5404.6 5439.0 5460.5 5474.1 6169.8 6180.5 6217.3 6228.3 6236.5 1654.8 1693.7 1694.9 1699.4 1700.9 1192.9 1225.0 1227.9 1228.7 1230.5 5921.2 5953.2 5953.7 5965.7 5982.7 6193.2 6292.7 6301.5 6316.0 6326.5 5827.4 5904.1 5937.5 5942.9 5945.2 3282.2 3296.0 3324.1 3328.7 3334.6 6498.7 6583.1 6583.2 6597.4 6629.3 6446.3 6476.4 6491.2 6495.6 6513.3 6523.8 6582.3 6616.5 6617.8 6645.7 6280.2 6284.7 6285.3 6299.5 6319.9 5865.2 5905.9 6197.6 6280.0 6296.2 6570.7 6658.3 6665.4 6665.9 6677.4 4889.7 4899.2 4899.3 4899.4 4908.9 6144.9 6374.6 6406.6 6429.7 6435.3 6185.9 6192.3 6206.6 6207.3 6209.1 6038.0 6141.8 6200.0 6205.7 6233.7 6199.4 6208.0 6212.4 6215.7 6247.3 6139.9 6199.5 6233.8 6257.8 6275.5 6009.2 6036.7 6050.2 6066.3 6070.4 17:35:07 INFO - PID 25072 | 17:35:07 INFO - PID 25072 | [#5] yui.html Cycles:180 Average:18699.50 Median:19125.31 stddev:22461.38 (117.4%) stddev-sans-first:22484.30 17:35:07 INFO - PID 25072 | Values: 827.5 846.6 854.3 855.7 864.1 15606.7 16083.2 16109.0 16125.9 16135.0 18241.3 18556.4 18971.9 19098.3 19138.8 1004.7 1038.2 1039.8 1040.1 1040.7 1014.8 1017.9 1018.1 1019.8 1020.1 1072.1 1074.0 1074.5 1074.6 1074.6 1070.0 1074.5 1075.4 1075.5 1075.6 779.1 781.6 783.1 784.5 785.4 17123.6 17381.5 18029.0 18230.0 18278.4 18520.6 18693.6 19111.8 19272.2 19304.7 13986.3 14318.4 14344.4 14486.5 14497.8 3345.1 3363.2 3382.3 3386.8 3587.1 85983.0 86339.6 87899.0 88111.6 90210.0 13081.9 13451.9 13590.3 13592.0 13616.7 23594.0 23627.4 23639.5 24329.4 24349.0 8034.8 8117.6 8120.4 8141.5 8151.8 3966.1 4007.8 4018.7 4070.8 4080.8 4168.2 4248.9 4250.4 4253.6 4256.1 819.0 823.2 833.5 833.6 833.7 715.2 720.5 722.3 740.7 758.1 11203.3 12204.3 12403.9 12450.9 12534.0 701.8 724.6 727.4 734.3 748.5 5155.7 5220.8 5384.6 5396.5 5420.9 78726.0 79762.6 80862.6 81660.6 82296.6 71848.0 72556.6 72669.0 73423.3 75249.2 39552.4 63760.0 63991.0 64124.7 65459.7 12071.8 12788.6 12830.9 12874.5 12897.7 32538.7 32860.5 33901.5 34181.4 35102.3 40081.6 40249.8 40773.0 40969.4 41401.0 16590.7 16607.6 16871.2 16964.4 17013.6 18894.3 18898.0 18945.1 19016.9 19822.8 18245.5 18274.1 18296.3 18623.6 19062.3 16777.9 16971.8 17644.7 17863.1 18083.2 17107.7 17505.4 17968.0 18143.9 18272.5 12295.2 12476.3 12511.2 12635.9 13147.1 13573.6 14286.9 14329.4 14367.2 14376.9 17:35:07 INFO - PID 25072 | -------- Summary: end -------- 17:35:07 INFO - PID 25072 | 17:35:08 INFO - TEST-INFO | 25072: exit 0 17:35:08 INFO - TEST-OK | dromaeo_css | took 1114246ms 17:35:08 INFO - TEST-START | kraken 17:35:08 INFO - operating with platform_type : linux_ 17:35:08 INFO - Initialising browser for kraken test... 17:35:08 INFO - TEST-INFO | started process 25402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxyHbvD/profile http://localhost:49379/getInfo.html) 17:35:12 INFO - PID 25402 | __metrics Screen width/height:1600/1200 17:35:12 INFO - PID 25402 | colorDepth:24 17:35:12 INFO - PID 25402 | Browser inner width/height: 1024/695 17:35:12 INFO - PID 25402 | __metrics 17:35:13 INFO - PID 25402 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:35:13 INFO - PID 25402 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:35:14 INFO - TEST-INFO | 25402: exit 0 17:35:14 INFO - Browser initialized. 17:35:14 INFO - Running cycle 1/1 for kraken test... 17:35:14 INFO - TEST-INFO | started process 25499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxyHbvD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:25 INFO - PID 25499 | RSS: Main: 144338944 17:35:25 INFO - PID 25499 | 17:35:28 INFO - PID 25499 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49379/tests/kraken/driver.html?testName=audio-beat-detection) 17:35:29 INFO - PID 25499 | RSS: Main: 216920064 17:35:29 INFO - PID 25499 | 17:35:31 INFO - PID 25499 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49379/tests/kraken/driver.html?testName=audio-dft) 17:35:32 INFO - PID 25499 | RSS: Main: 178413568 17:35:32 INFO - PID 25499 | 17:35:35 INFO - PID 25499 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49379/tests/kraken/driver.html?testName=audio-fft) 17:35:35 INFO - PID 25499 | RSS: Main: 258842624 17:35:35 INFO - PID 25499 | 17:35:37 INFO - PID 25499 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49379/tests/kraken/driver.html?testName=audio-oscillator) 17:35:38 INFO - PID 25499 | RSS: Main: 171335680 17:35:38 INFO - PID 25499 | 17:35:40 INFO - PID 25499 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49379/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:35:41 INFO - PID 25499 | RSS: Main: 173903872 17:35:41 INFO - PID 25499 | 17:35:44 INFO - PID 25499 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49379/tests/kraken/driver.html?testName=imaging-darkroom) 17:35:44 INFO - PID 25499 | RSS: Main: 234160128 17:35:44 INFO - PID 25499 | 17:35:48 INFO - PID 25499 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49379/tests/kraken/driver.html?testName=imaging-desaturate) 17:35:48 INFO - PID 25499 | RSS: Main: 255774720 17:35:48 INFO - PID 25499 | 17:35:51 INFO - PID 25499 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49379/tests/kraken/driver.html?testName=json-parse-financial) 17:35:51 INFO - PID 25499 | RSS: Main: 270557184 17:35:51 INFO - PID 25499 | 17:35:53 INFO - PID 25499 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49379/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:35:53 INFO - PID 25499 | RSS: Main: 197713920 17:35:53 INFO - PID 25499 | 17:35:55 INFO - PID 25499 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:35:56 INFO - PID 25499 | RSS: Main: 202166272 17:35:56 INFO - PID 25499 | 17:35:58 INFO - PID 25499 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:35:58 INFO - PID 25499 | RSS: Main: 212758528 17:35:58 INFO - PID 25499 | 17:36:01 INFO - PID 25499 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:36:02 INFO - PID 25499 | RSS: Main: 216391680 17:36:02 INFO - PID 25499 | 17:36:04 INFO - PID 25499 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:36:05 INFO - PID 25499 | RSS: Main: 216834048 17:36:05 INFO - PID 25499 | 17:36:07 INFO - PID 25499 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49379/tests/kraken/driver.html?testName=ai-astar) 17:36:07 INFO - PID 25499 | RSS: Main: 267620352 17:36:07 INFO - PID 25499 | 17:36:07 INFO - PID 25499 | __start_tp_report 17:36:07 INFO - PID 25499 | _x_x_mozilla_page_load 17:36:07 INFO - PID 25499 | _x_x_mozilla_page_load_details 17:36:07 INFO - PID 25499 | |i|pagename|runs| 17:36:07 INFO - PID 25499 | |0;ai-astar;108;109;107;109;108;108;109;109;108;109 17:36:07 INFO - PID 25499 | |1;audio-beat-detection;149;117;117;177;126;121;120;120;141;115 17:36:07 INFO - PID 25499 | |2;audio-dft;161;163;162;161;161;162;162;161;160;162 17:36:07 INFO - PID 25499 | |3;audio-fft;75;73;74;121;73;73;76;74;105;75 17:36:07 INFO - PID 25499 | |4;audio-oscillator;84;81;108;82;82;81;96;81;81;109 17:36:07 INFO - PID 25499 | |5;imaging-gaussian-blur;113;113;113;113;113;113;113;113;113;113 17:36:07 INFO - PID 25499 | |6;imaging-darkroom;148;147;146;147;147;147;147;147;147;147 17:36:07 INFO - PID 25499 | |7;imaging-desaturate;94;94;93;93;94;94;93;94;93;94 17:36:07 INFO - PID 25499 | |8;json-parse-financial;45;45;48;45;48;48;49;46;46;47 17:36:07 INFO - PID 25499 | |9;json-stringify-tinderbox;53;54;54;53;54;54;54;54;54;54 17:36:07 INFO - PID 25499 | |10;stanford-crypto-aes;78;78;78;77;79;79;79;79;77;78 17:36:07 INFO - PID 25499 | |11;stanford-crypto-ccm;136;134;123;124;123;126;122;123;201;128 17:36:07 INFO - PID 25499 | |12;stanford-crypto-pbkdf2;182;179;181;170;181;182;178;178;183;178 17:36:07 INFO - PID 25499 | |13;stanford-crypto-sha256-iterative;66;63;64;64;65;64;63;65;64;63 17:36:07 INFO - PID 25499 | __end_tp_report 17:36:07 INFO - PID 25499 | __start_cc_report 17:36:07 INFO - PID 25499 | _x_x_mozilla_cycle_collect,1639 17:36:07 INFO - PID 25499 | __end_cc_report 17:36:07 INFO - PID 25499 | __startTimestamp1494549367430__endTimestamp 17:36:07 INFO - PID 25499 | 17:36:07 INFO - PID 25499 | ------- Summary: start ------- 17:36:07 INFO - PID 25499 | Number of tests: 14 17:36:07 INFO - PID 25499 | 17:36:07 INFO - PID 25499 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 17:36:07 INFO - PID 25499 | Values: 108.0 109.0 107.0 109.0 108.0 108.0 109.0 109.0 108.0 109.0 17:36:07 INFO - PID 25499 | 17:36:07 INFO - PID 25499 | [#1] audio-beat-detection Cycles:10 Average:130.30 Median:123.50 stddev:19.86 (16.1%) stddev-sans-first:19.88 17:36:07 INFO - PID 25499 | Values: 149.0 117.0 117.0 177.0 126.0 121.0 120.0 120.0 141.0 115.0 17:36:07 INFO - PID 25499 | 17:36:07 INFO - PID 25499 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 17:36:07 INFO - PID 25499 | Values: 161.0 163.0 162.0 161.0 161.0 162.0 162.0 161.0 160.0 162.0 17:36:07 INFO - PID 25499 | 17:36:07 INFO - PID 25499 | [#3] audio-fft Cycles:10 Average:81.90 Median:74.00 stddev:16.85 (22.8%) stddev-sans-first:17.68 17:36:07 INFO - PID 25499 | Values: 75.0 73.0 74.0 121.0 73.0 73.0 76.0 74.0 105.0 75.0 17:36:07 INFO - PID 25499 | 17:36:07 INFO - PID 25499 | [#4] audio-oscillator Cycles:10 Average:88.50 Median:81.50 stddev:11.48 (14.1%) stddev-sans-first:12.06 17:36:07 INFO - PID 25499 | Values: 84.0 81.0 108.0 82.0 82.0 81.0 96.0 81.0 81.0 109.0 17:36:07 INFO - PID 25499 | 17:36:07 INFO - PID 25499 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:113.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:36:07 INFO - PID 25499 | Values: 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 17:36:07 INFO - PID 25499 | 17:36:07 INFO - PID 25499 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 17:36:07 INFO - PID 25499 | Values: 148.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 147.0 17:36:07 INFO - PID 25499 | 17:36:07 INFO - PID 25499 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:36:07 INFO - PID 25499 | Values: 94.0 94.0 93.0 93.0 94.0 94.0 93.0 94.0 93.0 94.0 17:36:07 INFO - PID 25499 | 17:36:07 INFO - PID 25499 | [#8] json-parse-financial Cycles:10 Average:46.70 Median:47.50 stddev:1.49 (3.1%) stddev-sans-first:1.45 17:36:07 INFO - PID 25499 | Values: 45.0 45.0 48.0 45.0 48.0 48.0 49.0 46.0 46.0 47.0 17:36:07 INFO - PID 25499 | 17:36:07 INFO - PID 25499 | [#9] json-stringify-tinderbox Cycles:10 Average:53.80 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.33 17:36:07 INFO - PID 25499 | Values: 53.0 54.0 54.0 53.0 54.0 54.0 54.0 54.0 54.0 54.0 17:36:07 INFO - PID 25499 | 17:36:07 INFO - PID 25499 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:78.50 stddev:0.79 (1.0%) stddev-sans-first:0.83 17:36:07 INFO - PID 25499 | Values: 78.0 78.0 78.0 77.0 79.0 79.0 79.0 79.0 77.0 78.0 17:36:07 INFO - PID 25499 | 17:36:07 INFO - PID 25499 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:127.00 stddev:24.04 (18.9%) stddev-sans-first:25.48 17:36:07 INFO - PID 25499 | Values: 136.0 134.0 123.0 124.0 123.0 126.0 122.0 123.0 201.0 128.0 17:36:07 INFO - PID 25499 | 17:36:07 INFO - PID 25499 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.20 Median:181.00 stddev:3.74 (2.1%) stddev-sans-first:3.82 17:36:07 INFO - PID 25499 | Values: 182.0 179.0 181.0 170.0 181.0 182.0 178.0 178.0 183.0 178.0 17:36:07 INFO - PID 25499 | 17:36:07 INFO - PID 25499 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:0.99 (1.6%) stddev-sans-first:0.78 17:36:07 INFO - PID 25499 | Values: 66.0 63.0 64.0 64.0 65.0 64.0 63.0 65.0 64.0 63.0 17:36:07 INFO - PID 25499 | -------- Summary: end -------- 17:36:07 INFO - PID 25499 | 17:36:08 INFO - TEST-INFO | 25499: exit 0 17:36:08 INFO - TEST-OK | kraken | took 59889ms 17:36:08 INFO - SUITE-END | took 1174s 17:36:08 INFO - Completed test suite (00:19:34) 17:36:08 INFO - javascript benchmark 17:36:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7709.12902104916, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3359.47928071149, 3361.394948909196, 3362.9327413451715, 3397.2016576104597, 3435.5362026126463, 5621.353544342402, 5752.108423194401, 5864.970675146624, 5902.350741418446, 5910.202122713433, 5792.0, 5830.125481177814, 5834.649921004742, 5862.73617687204, 5964.642121472704, 4736.7631618418945, 4987.077390682717, 5127.102757017526, 5142.280080788692, 5190.688558686472, 5175.0, 5191.057696598295, 5257.053730328558, 5257.36911570612, 5269.420363759983, 5079.2635067915135, 5130.794768209267, 5143.099957507458, 5155.7679904404395, 5227.163653815409, 5190.584753219733, 5193.246979188034, 5199.948000519984, 5207.4011488678525, 5258.342707161605, 5156.381234251876, 5195.688258704452, 5216.061109000379, 5219.530242278175, 5245.973770131163, 5614.3543492498475, 5693.3452652945025, 5693.743781529841, 5703.657780533182, 5845.298564172284, 6125.601835880653, 6134.050719465777, 6138.953131165798, 6139.001538246358, 6146.108814221958, 6173.69131543421, 6176.042713379434, 6220.284667263278, 6287.52843536732, 6327.17746692927, 5860.765569377219, 5872.17789509469, 5917.497012753878, 5941.22764040672, 5953.791617293374, 6403.039544068427, 6470.191226096738, 6470.870582588322, 6471.385218404244, 6485.221773387224, 6021.3677563856045, 6111.388861113853, 6112.2665280165775, 6143.293521245025, 6249.25008998923, 6315.652639104894, 6335.619862808154, 6338.334474880164, 6346.650934198571, 6357.4914006879335, 6341.619502829845, 6341.904871426932, 6346.11154438379, 6346.587471814318, 6351.079093531412, 6044.818655440344, 6141.907871381933, 6348.746050158034, 6353.682315884187, 6356.9364306357265, 4808.759562021885, 4860.854174374775, 4869.780859861315, 4897.020595880838, 4911.140550403665, 4287.914241715148, 4288.120935208275, 4290.37789520524, 4304.440422745086, 4333.653307735373, 5709.857253568611, 5966.134910437962, 5977.953858074819, 5987.221661184019, 6031.487323577545, 6119.204503414528, 6150.04674275488, 6200.596961197508, 6303.842403939938, 6332.936670633327, 5960.940390596125, 5961.076033214858, 5992.520598352208, 6021.5182785377065, 6023.337432882379, 5534.1145416733125, 5545.889082218333, 5546.223528705985, 5548.167774833807, 5552.472515111058, 6312.3056463788025, 6406.775762848278, 6613.239477459962, 6709.29552397001, 6711.060451536789, 6158.107074474086, 6287.779927702509, 6306.873862522815, 6316.778912738032, 6320.115183874169, 6688.3646053624825, 6709.429698475489, 6712.295209002984, 6714.6642667865435, 6718.563293385914, 6041.214642096499, 6171.444569988723, 6281.089242059968, 6291.937080629318, 6297.559170857996, 6123.008104567321, 6163.8150855474405, 6289.622622642656, 6292.2134733158355, 6298.0867774171575, 5971.910421343597, 6192.411720886508, 6195.690215489298, 6204.100405441276, 6204.13142160107, 6041.972864612939, 6058.3335833057445, 6099.75600975956, 6115.6662951758, 6129.328227221949, 6158.32258451561, 6171.56799024064, 6178.752849886134, 6187.071939208975, 6195.845103872259, 5956.642601443928, 6038.818835434944, 6066.332703402534, 6120.721420533169, 6124.167343420691, 6041.486473649789, 6052.061930400795, 6054.788082417094, 6055.091736239599, 6083.574149809471], "value": 5764.024205116165, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.4402126394572, 797.6849144587887, 820.2535692519808, 1110.4003837927519, 1129.949152288147, 29339.41321173575, 36955.445668315, 37629.43555846665, 37782.24435511295, 37794.0, 40453.79773101138, 40814.38778418326, 40888.18223635526, 40902.59097409025, 40903.0, 5674.886502269952, 5789.710514474259, 7283.453740969422, 7379.5203311784835, 7383.704651813921, 7191.352778249957, 7379.59412232327, 7381.852362952738, 7381.926180738177, 7386.593737344444, 7433.1080270367365, 7521.210272921319, 7521.849563008736, 7523.322900938914, 7527.0, 5707.942920570783, 5870.618409803392, 7400.222976587462, 7448.888266676031, 7458.328750412435, 5790.0, 7189.137303523611, 7352.228016058344, 7353.742619008362, 7360.043194384749, 37061.0, 37419.81290093532, 37428.81285593555, 37456.25087498262, 37468.62531374679, 3506.7720598161295, 3550.2012047289413, 3552.0409489437966, 3553.5558055243096, 3554.0, 28876.711232887614, 28883.711162888314, 28946.27634309159, 28969.85515072432, 28979.855100724573, 3794.1842503861526, 3794.6584807367194, 3827.349350610403, 3848.3650197717343, 3849.345611246095, 189817.0, 189921.0, 190117.0, 190299.0, 190704.0, 48932.61741208464, 48957.0, 48984.51015489871, 49050.50949490531, 49073.0, 51681.74159129256, 51788.223176652384, 52039.0, 52049.739751301, 52131.73934130381, 14078.577642670736, 14127.576172714835, 14209.644758881112, 14212.64468388278, 14212.644683882985, 9283.350165488486, 9446.244300455946, 10879.945600272107, 11247.0, 11252.49363778632, 13127.803082953764, 13148.934255328662, 13154.868451315555, 13309.73380532384, 13311.80032299497, 5250.947490525123, 5286.920696189561, 5355.678659280456, 5373.274607927958, 5412.702301373462, 1075.542894269932, 1094.9671509854718, 1095.7370231144628, 1100.8733995590449, 1104.6354702948008, 25812.612810807852, 25914.0, 25985.350366240997, 26062.609060864103, 26166.73833261643, 1195.665213740154, 1200.6458094862037, 1206.5776978057609, 1216.5012344938532, 1222.6148763139583, 12900.741985160244, 13658.180509169482, 13886.236257005961, 13891.097078689852, 13914.373853176632, 222885.0, 223419.0, 224234.0, 224758.0, 225494.0, 51544.74227628838, 51605.22592161121, 51658.0, 51765.0, 51845.48154518482, 1504.120089747488, 1506.540505145919, 1526.0, 1536.078352988198, 1536.1167328785768, 23976.760232397453, 25201.873990630662, 25236.495270094863, 25267.661711251872, 25676.358091047874, 38700.0, 38737.0, 38808.417873732484, 38821.22357552889, 38866.0, 198208.0, 198465.0, 198755.0, 198979.0, 199142.0, 29545.409091818474, 29959.550606740482, 34017.31965360729, 34191.0, 34303.485447718806, 38013.61986380101, 39304.60695393124, 40074.39888401735, 41192.38211426771, 41840.1631967365, 31001.224969375045, 31075.223119422197, 31134.844325778227, 31326.843365783025, 31607.0, 30956.535651964787, 31216.843915780275, 31632.0, 31888.840555797073, 31996.0, 36588.634113658525, 37091.0, 37121.25757484889, 37143.6285637151, 37145.0, 29486.557701634923, 29754.0, 30286.242843929078, 30553.694463055086, 30890.382192355577, 24086.759132408453, 24500.0, 25031.249062528153, 25262.87368563219, 25344.493110138064], "value": 16678.08803291867, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.5385921711811, 442.9247028005239, 448.15075432056244, 455.6992385025883, 459.4647235970093, 18321.450356489328, 19143.61712765744, 19962.30131945382, 20015.0, 20272.8986355068, 21009.0, 21436.57126857466, 21621.567568648617, 21623.243186488475, 21721.67417488735, 5401.621886467949, 5529.723513824313, 5545.861353466155, 5548.972255138739, 5556.6943818089985, 4208.789560521962, 5440.619156659035, 5577.69322687252, 5596.776128954837, 5617.831465056055, 5572.3870374258795, 5576.609637325389, 5577.9163312550345, 5581.107022876341, 5581.2186293918885, 5468.699221542814, 5517.117261238182, 5529.198266251411, 5535.750891209906, 5544.667319960795, 5029.647924645276, 5055.823046193365, 5063.341765570489, 5067.847964561069, 5068.847934561969, 25938.092166774262, 25987.0, 26360.077397291196, 26393.07624233162, 26483.205503834917, 2170.1427935965207, 2175.3039027511204, 2200.504886400547, 2202.41635966469, 2202.7136472258503, 16602.25289861959, 16930.49208523734, 16964.7097641818, 17033.48899533016, 17109.82890171095, 2129.073852874005, 2187.147012665062, 2226.5435585705054, 2234.765349638281, 2238.8656680599215, 93520.0, 101742.0, 115785.42107289494, 116084.0, 116505.0, 12482.188657737219, 12583.622491325275, 12650.177738446971, 12743.68140796469, 12913.612591622266, 18135.63728725418, 18159.092045397676, 18169.45491635253, 18198.363057293194, 18209.362672306404, 7871.567063811545, 8212.58937053145, 8247.21651443112, 8298.585070746438, 8320.625571849281, 7189.89215161773, 7221.74723884672, 7247.383972362408, 7439.4420418468835, 7468.551886886804, 8013.599320034092, 8154.266116049584, 8173.918260817316, 8371.246587807127, 8395.874061889077, 2203.746569144569, 2220.2784095169136, 2250.324902529235, 2273.204378467556, 2309.8960546775434, 1038.3354653022072, 1056.8309070548676, 1074.6775967209962, 1079.7192729890285, 1112.0269763956537, 20337.0, 20699.58600827975, 20770.896145519175, 20901.79098209029, 21062.491636558058, 1061.543536279392, 1070.2347821307803, 1083.4853444613902, 1087.5758454202867, 1091.6506717850211, 10947.246746517398, 11183.496742646601, 11374.0, 11394.373309467894, 11448.0, 450211.0, 451599.0, 464511.0, 470631.0, 470690.5861882743, 90828.0, 93389.5330523343, 93446.53276733572, 93578.53210734039, 93598.0, 1178.7583545373177, 1186.9228500147462, 1222.376587940157, 1223.8592561855323, 1230.501646833034, 17124.914375428045, 17303.653926921645, 17351.7397239039, 17403.0, 18042.2783088675, 43234.56765432431, 43356.34965475583, 43563.56436435595, 43710.56289437065, 44276.0, 52347.47652523426, 52696.0, 53598.196027058846, 53833.57748901231, 55551.0, 9418.670346537838, 9551.904480955101, 9657.32398732082, 9708.980557041692, 9742.512874356396, 14613.19627420502, 14965.176915269765, 15131.54605361841, 15161.09033457996, 15646.452374166849, 12737.808932866199, 12859.0998630095, 13499.190048597116, 13806.87548051483, 13942.721145576828, 10275.332103413255, 12874.420651070537, 12927.96576273877, 13192.076554641082, 13614.455421783017, 12118.515259389525, 13124.606261812161, 13361.933190333986, 14032.929835350758, 14043.929780351033, 14419.78370324467, 14442.783358249844, 14446.0, 14593.343299551758, 14621.634459138606, 12701.301428421526, 12836.679083022998, 12848.229106253655, 12919.677008074874, 13011.284379359226], "value": 10162.025357378307, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.4725357110726, 1406.3038795796083, 1415.2711353652865, 1422.8861691064722, 1428.1930709149333, 11113.72215694607, 11583.0, 11588.768224635513, 11593.130515211351, 11594.014508766764, 11214.0, 11433.771324573503, 11654.650360489199, 11748.11889108316, 11786.35175065371, 2356.587597170497, 2390.8924098415614, 2395.101836811196, 2395.6646069550275, 2395.6646069550275, 1768.107105911513, 2315.340128063502, 2383.118246248882, 2394.916177933773, 2401.1595941420537, 2059.567490826928, 2349.459624286415, 2442.560339138954, 2443.1204766284122, 2448.0942051440993, 2336.4742932840145, 2351.8588884666888, 2357.6109941859745, 2360.33910505058, 2364.7871691547757, 2298.0463107810237, 2334.0080465802134, 2352.3413444235644, 2353.0470159585393, 2357.210334537932, 10903.0, 10997.12023038155, 10997.725056873562, 11013.0, 11347.943260283728, 6532.477401807844, 6729.427998620124, 6754.223264324616, 6760.594364338155, 6769.627670478122, 3722.1625134344827, 3804.125051238203, 3815.7328986970647, 3830.80845957701, 4022.5776293489057, 1349.5006847466402, 1353.2759973414177, 1392.8676775706392, 1413.342795600051, 1420.7726763717756, 17751.201195946214, 17874.106294685214, 17890.463286101436, 17892.373766918226, 17896.284148634168, 5284.943011397736, 5350.625456218105, 5469.1249400096585, 5511.366192887869, 5609.046462101453, 12697.619071427873, 12698.365081745877, 12738.235705857678, 12741.745165096647, 12745.0, 6404.775832845828, 6411.198600174978, 6420.325865784025, 6424.068510066108, 6425.582337148164, 5980.5215582754145, 6047.15339852421, 6083.969580152071, 6084.239470066242, 6105.389461053948, 4273.273543497613, 4321.416608757841, 4341.82632694695, 4392.209402307615, 4426.800793964279, 1050.4380156616173, 1077.6120596585224, 1208.6072026591394, 1208.6132437619876, 1222.5598784437595, 864.0, 885.9955700221458, 893.9240164586083, 903.0878812399524, 932.342698397628, 7130.358267755927, 7152.141742990874, 7180.640967951686, 7269.091363579552, 7318.670659820321, 654.4894981914115, 661.566673828643, 670.8289386206486, 676.5196710335618, 768.0015979226982, 4558.749268790249, 4668.159731248408, 4671.11248862715, 4715.104130215248, 4752.334673145762, 14810.259487025822, 14912.552623421314, 15485.303161357766, 15535.0, 15621.0, 15335.386584536494, 15369.231538423033, 15376.384944602314, 15519.146446945526, 15524.068555886683, 9034.954825225963, 9173.908260917438, 9397.436153830791, 9408.811823763623, 9488.38325508826, 7237.457190710823, 7360.374368178765, 7435.7025718970635, 7445.813854653677, 7679.846403072019, 13637.727245454837, 13728.519501817787, 13871.375788089359, 14150.716985660434, 14180.787288190479, 14148.363323650254, 14241.64395890111, 14306.785398218826, 14470.710585788436, 14554.0, 9424.340296179202, 9699.418034917928, 9700.5149742514, 9702.466364350028, 9710.951445242728, 10748.731281718019, 11006.669799906016, 11088.0, 11088.889111108785, 11096.61161859331, 9454.385464944757, 9564.426134431957, 9600.183984361129, 9615.51922403863, 9819.85270220933, 9091.681791137544, 9113.453192808453, 9138.040505747067, 9147.313951453534, 9274.44353338802, 8161.632726527439, 8263.710770123016, 8285.088640249447, 8286.668533258602, 8295.04606970206, 6157.907631385443, 6181.9690901547, 6217.751289948352, 6265.4361107500545, 6381.1704478417505, 6222.657753823583, 6238.844028899314, 6421.93578064232, 6477.870442591027, 6527.771527996498], "value": 5415.010242064452, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.15831279374925, 408.96932730045256, 412.58072231523556, 426.64162103832774, 428.2762131996925, 5848.210491583635, 5861.941380586193, 5862.794802181925, 5887.2346594942655, 5898.882022359556, 5633.507120613031, 5783.843231353736, 5792.218050563172, 5795.333536643277, 5830.475257226849, 4585.908281834361, 4588.967482316485, 4597.954020459794, 4633.675642705012, 4639.628829693634, 4589.839355622554, 4611.861644150681, 4625.907481850361, 4628.0, 4644.349791029259, 4471.66462515311, 4592.517785632511, 4612.930806037912, 4621.613515945203, 4633.447794988683, 4620.7227566345955, 4630.629549636021, 4632.189366860786, 4634.2121839287065, 4643.303504474322, 4255.893602659928, 4256.4679415073115, 4256.616904478612, 4257.467311767761, 4262.65898728101, 5577.414371490976, 5625.606207565472, 5667.914981275284, 5695.914561281584, 5725.971370143165, 5471.644343117685, 5497.890042199174, 5508.6970216638065, 5517.586181036399, 5520.420355862657, 6041.546883983675, 6199.0, 6209.394868948555, 6249.218847644044, 6249.437550620466, 4749.738764367993, 4764.0, 4769.475357710649, 4781.493829443749, 4798.760061996886, 6220.688965551704, 6318.74725010999, 6330.746770129189, 6478.352164783531, 6522.608643481359, 4844.95155048452, 4855.475152920461, 4857.975710121426, 4863.392075990501, 4869.415670119608, 4906.484819094015, 4938.0, 4945.357103576512, 4945.431275403303, 4969.229769385751, 5316.229146773773, 5404.648697834628, 5439.0, 5460.535854452337, 5474.124140137559, 6169.784057557964, 6180.47465965389, 6217.316095229521, 6228.28374736902, 6236.532260080512, 1654.793150856143, 1693.7374706920448, 1694.8644108471292, 1699.430690718623, 1700.9149542522825, 1192.8628207756046, 1224.9877501224873, 1227.9140460167703, 1228.7358217983176, 1230.477047254913, 5921.246620321571, 5953.166556682068, 5953.672548009901, 5965.671888046112, 5982.700864956735, 6193.194884665055, 6292.671711466786, 6301.464375528039, 6315.96842015787, 6326.4622507087415, 5827.4172582741385, 5904.143899134601, 5937.52499800015, 5942.910856337158, 5945.16767652529, 3282.2286762610765, 3295.967040329614, 3324.1191084362663, 3328.700416962485, 3334.583177102862, 6498.707558159894, 6583.144191255202, 6583.210014798255, 6597.373249541286, 6629.270780214172, 6446.29090800021, 6476.35236476358, 6491.221053473613, 6495.610263384212, 6513.250976137805, 6523.836904077341, 6582.341765823379, 6616.536842420985, 6617.764630636397, 6645.734170633121, 6280.214973128359, 6284.748610055546, 6285.277193122666, 6299.464545513682, 6319.873602527831, 5865.208196893364, 5905.940940590711, 6197.628142311476, 6280.0, 6296.150019747275, 6570.671466426564, 6658.267590565131, 6665.366790154928, 6665.900011499928, 6677.395815632005, 4889.731064791471, 4899.191633380452, 4899.265110233494, 4899.387576552931, 4908.9263661045825, 6144.907826382697, 6374.649394283359, 6406.5515413920575, 6429.678516074271, 6435.2599451063725, 6185.886540422587, 6192.349803270772, 6206.596571222856, 6207.317195108625, 6209.137258822245, 6038.0, 6141.8464538385115, 6200.0, 6205.720742566505, 6233.688315584112, 6199.442050215322, 6208.0, 6212.4408803207925, 6215.689215539114, 6247.312795592572, 6139.877202455837, 6199.535034872493, 6233.812985610439, 6257.843553911189, 6275.466585340298, 6009.188759517409, 6036.698165091816, 6050.183225264709, 6066.332703402711, 6070.3929607038945], "value": 4819.81651089876, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.4580150001751, 846.6105591427943, 854.3464249848867, 855.67056683177, 864.1056506515757, 15606.687866242683, 16083.195840207987, 16109.0, 16125.919370403146, 16135.031898086123, 18241.270349186016, 18556.35052773153, 18971.90514047431, 19098.331558395457, 19138.808611913875, 1004.7387679203423, 1038.169464428458, 1039.8024375368693, 1040.0951172479954, 1040.6773900090996, 1014.8477728340771, 1017.8778546574422, 1018.0989824005734, 1019.8470229465565, 1020.112502123154, 1072.1208608940672, 1073.951672174754, 1074.511097450658, 1074.5809134437575, 1074.6399956014745, 1070.0, 1074.5486895503868, 1075.4300220882944, 1075.4568942683973, 1075.6289080267295, 779.1390513482634, 781.5584194929846, 783.0525064671754, 784.5292824305428, 785.4148659248839, 17123.571910702332, 17381.478555643353, 18029.0, 18230.0, 18278.36025739106, 18520.62958740831, 18693.62612747751, 19111.808881911144, 19272.22911083555, 19304.71042934357, 13986.30068496571, 14318.42726290947, 14344.354504047344, 14486.49297274601, 14497.782533262009, 3345.1469875181915, 3363.1592101974506, 3382.3404436134965, 3386.8306584670668, 3587.0852932502307, 85983.0, 86339.56830215809, 87899.0, 88111.55944220303, 90210.0, 13081.869181308066, 13451.932740336235, 13590.252536110609, 13592.0, 13616.727665446635, 23594.0, 23627.40931476727, 23639.527209455715, 24329.39176520566, 24349.0, 8034.754613034989, 8117.634706438224, 8120.431569790058, 8141.470804397695, 8151.755447336589, 3966.127451960622, 4007.8396864125693, 4018.6985976051915, 4070.75575465473, 4080.775557344315, 4168.187203495289, 4248.87253382399, 4250.362445633118, 4253.63844073251, 4256.084941737541, 818.9836203275901, 823.2343920154314, 833.4707460762338, 833.5998720614018, 833.7040350675544, 715.1561157833702, 720.481253497481, 722.3065856777447, 740.7370383513775, 758.0675768804401, 11203.271787333797, 12204.32876191818, 12403.881636031816, 12450.937745311398, 12534.0, 701.7929710735345, 724.6340597998083, 727.3780917315725, 734.2510639148146, 748.5359077372065, 5155.664881782672, 5220.765065572058, 5384.5692344612335, 5396.541293990055, 5420.945790542123, 78726.0, 79762.60118699369, 80862.57412277641, 81660.59169704233, 82296.58851705703, 71848.0, 72556.63721681463, 72669.0, 73423.26576734272, 75249.24750752423, 39552.40671389931, 63759.99999999907, 63991.0, 64124.67937660375, 65459.672701636184, 12071.75856482883, 12788.552400665933, 12830.871691282968, 12874.549390771279, 12897.677558061123, 32538.674613253563, 32860.50709239411, 33901.49147762835, 34181.4109518497, 35102.29795404027, 40081.599184007784, 40249.798751006056, 40773.0, 40969.38545921754, 41401.0, 16590.66818663644, 16607.584810379838, 16871.240794164536, 16964.406245781338, 17013.574660633087, 18894.3386981455, 18898.0, 18945.14746836368, 19016.904915475334, 19822.801771982096, 18245.452636420927, 18274.086295684898, 18296.26814927388, 18623.627527449105, 19062.33281835129, 16777.916110419857, 16971.830281697024, 17644.73532896982, 17863.106844657974, 18083.18625661822, 17107.7433838495, 17505.38731144404, 17968.011759352838, 18143.909280453514, 18272.543186420447, 12295.200811947196, 12476.251424914533, 12511.249325040526, 12635.93682031584, 13147.079704420981, 13573.592792215853, 14286.928565357106, 14329.355179017179, 14367.20980346091, 14376.856231437552], "value": 8232.288802766656, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1480.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 107.0, 109.0, 108.0, 108.0, 109.0, 109.0, 108.0, 109.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 117.0, 177.0, 126.0, 121.0, 120.0, 120.0, 141.0, 115.0], "value": 130.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 161.0, 161.0, 162.0, 162.0, 161.0, 160.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 121.0, 73.0, 73.0, 76.0, 74.0, 105.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 108.0, 82.0, 82.0, 81.0, 96.0, 81.0, 81.0, 109.0], "value": 88.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 45.0, 48.0, 45.0, 48.0, 48.0, 49.0, 46.0, 46.0, 47.0], "value": 46.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 77.0, 79.0, 79.0, 79.0, 79.0, 77.0, 78.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 123.0, 124.0, 123.0, 126.0, 122.0, 123.0, 201.0, 128.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 179.0, 181.0, 170.0, 181.0, 182.0, 178.0, 178.0, 183.0, 178.0], "value": 179.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 64.0, 64.0, 65.0, 64.0, 63.0, 65.0, 64.0, 63.0], "value": 64.1, "unit": "score"}]}]} 17:36:08 INFO - Return code: 0 17:36:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:36:08 INFO - # TBPL SUCCESS # 17:36:08 INFO - Running post-action listener: _resource_record_post_action 17:36:08 INFO - [mozharness: 2017-05-12 00:36:08.767498Z] Finished run-tests step (success) 17:36:08 INFO - Running post-run listener: _resource_record_post_run 17:36:08 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 259661824; Read time: 0; Write time: 143912 17:36:08 INFO - TinderboxPrint: CPU usage
12.9% 17:36:08 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:36:08 INFO - TinderboxPrint: I/O write bytes / time
259,661,824 / 143,912 17:36:08 INFO - TinderboxPrint: CPU idle
8,282.6 (87.1%) 17:36:08 INFO - TinderboxPrint: CPU user
1,181.5 (12.4%) 17:36:08 INFO - TinderboxPrint: Swap in / out
0 / 0 17:36:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 397312; Read time: 0; Write time: 56 17:36:08 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 259264512; Read time: 0; Write time: 143856 17:36:09 INFO - Running post-run listener: _upload_blobber_files 17:36:09 INFO - Blob upload gear active. 17:36:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:36:09 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 17:36:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:36:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:36:09 INFO - (blobuploader) - INFO - Open directory for files ... 17:36:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:36:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:36:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:13 INFO - (blobuploader) - INFO - Done attempting. 17:36:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:36:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:36:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:15 INFO - (blobuploader) - INFO - Done attempting. 17:36:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:36:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:36:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:15 INFO - (blobuploader) - INFO - Done attempting. 17:36:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:36:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:36:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:36:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:36:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:36:16 INFO - (blobuploader) - INFO - Done attempting. 17:36:16 INFO - (blobuploader) - INFO - Iteration through files over. 17:36:16 INFO - Return code: 0 17:36:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:36:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:36:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8417cccf18894d62abf23d9fb55767cfcd352f4081c328235450a249092b8073896413c470ba2b16ac3182009f9ef7ca11012151de11a3452b7752fab3d5c4ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21f09693da4c32c60714adc2b9bda28ca36861ef18b5f534c57cfc4af0828e8c2c6daa92a1fab66e9853c221a8d072c634e99a7d676d3743ceedebb1ad930dd1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a44c0931ddbbb8e83cb4fb510ca2b913201413bded50a76e70b2d7969324e25a198399822298fa582a51b75059fffbe8ec5996b20adaa6b6ad2d6433d252f968", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74168192f21363b85c4dc9f1103701cb0e3ae6c20684a3c80c94a535d91b7a06711222e90ab2569c8b860db48958b3285d8cff2df12291558efbad0ed26f2174"} 17:36:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:36:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:36:16 INFO - Contents: 17:36:16 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8417cccf18894d62abf23d9fb55767cfcd352f4081c328235450a249092b8073896413c470ba2b16ac3182009f9ef7ca11012151de11a3452b7752fab3d5c4ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21f09693da4c32c60714adc2b9bda28ca36861ef18b5f534c57cfc4af0828e8c2c6daa92a1fab66e9853c221a8d072c634e99a7d676d3743ceedebb1ad930dd1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a44c0931ddbbb8e83cb4fb510ca2b913201413bded50a76e70b2d7969324e25a198399822298fa582a51b75059fffbe8ec5996b20adaa6b6ad2d6433d252f968", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74168192f21363b85c4dc9f1103701cb0e3ae6c20684a3c80c94a535d91b7a06711222e90ab2569c8b860db48958b3285d8cff2df12291558efbad0ed26f2174"} 17:36:16 INFO - Running post-run listener: copy_logs_to_upload_dir 17:36:16 INFO - Copying logs to upload dir... 17:36:16 INFO - mkdir: /builds/slave/test/build/upload/logs 17:36:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2256.516413 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 37 mins, 36 secs) (at 2017-05-11 17:36:16.350410) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 17:36:16.354800) ========= 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=03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8417cccf18894d62abf23d9fb55767cfcd352f4081c328235450a249092b8073896413c470ba2b16ac3182009f9ef7ca11012151de11a3452b7752fab3d5c4ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21f09693da4c32c60714adc2b9bda28ca36861ef18b5f534c57cfc4af0828e8c2c6daa92a1fab66e9853c221a8d072c634e99a7d676d3743ceedebb1ad930dd1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a44c0931ddbbb8e83cb4fb510ca2b913201413bded50a76e70b2d7969324e25a198399822298fa582a51b75059fffbe8ec5996b20adaa6b6ad2d6433d252f968", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74168192f21363b85c4dc9f1103701cb0e3ae6c20684a3c80c94a535d91b7a06711222e90ab2569c8b860db48958b3285d8cff2df12291558efbad0ed26f2174"} build_url:https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://queue.taskcluster.net/v1/task/FTdaE7bQTb-8Gl47CAk35A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8417cccf18894d62abf23d9fb55767cfcd352f4081c328235450a249092b8073896413c470ba2b16ac3182009f9ef7ca11012151de11a3452b7752fab3d5c4ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21f09693da4c32c60714adc2b9bda28ca36861ef18b5f534c57cfc4af0828e8c2c6daa92a1fab66e9853c221a8d072c634e99a7d676d3743ceedebb1ad930dd1", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a44c0931ddbbb8e83cb4fb510ca2b913201413bded50a76e70b2d7969324e25a198399822298fa582a51b75059fffbe8ec5996b20adaa6b6ad2d6433d252f968", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/74168192f21363b85c4dc9f1103701cb0e3ae6c20684a3c80c94a535d91b7a06711222e90ab2569c8b860db48958b3285d8cff2df12291558efbad0ed26f2174"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 17:36:16.382782) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 17:36:16.383140) ========= 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=03627c79f6bb3d1578c4a402000001ba-1494547117.581230-460895125 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 17:36:16.465010) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 17:36:16.468397) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 17:36:16.468776) ========= ========= Total master_lag: 0.20 =========