builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1494334682.02 results: success (0) revision: b0ff0c5c0a35a1ee9f19cec2bae5cc2cd5772db6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 05:58:02.020628) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 05:58:02.021099) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 05:58:02.021374) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 05:58:02.037255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 05:58:02.037725) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-09 05:58:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 230M=0s 2017-05-09 05:58:02 (230 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.156115 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 05:58:02.211648) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 05:58:02.211982) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014712 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 05:58:02.262092) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-09 05:58:02.262421) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b0ff0c5c0a35a1ee9f19cec2bae5cc2cd5772db6 --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 b0ff0c5c0a35a1ee9f19cec2bae5cc2cd5772db6 --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=516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-09 05:58:02,667 truncating revision to first 12 chars 2017-05-09 05:58:02,667 Setting DEBUG logging. 2017-05-09 05:58:02,667 attempt 1/10 2017-05-09 05:58:02,667 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b0ff0c5c0a35?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-09 05:58:03,582 unpacking tar archive at: mozilla-central-b0ff0c5c0a35/testing/mozharness/ program finished with exit code 0 elapsedTime=1.266854 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-09 05:58:03.548609) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 05:58:03.548973) ========= script_repo_revision: b0ff0c5c0a35a1ee9f19cec2bae5cc2cd5772db6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 05:58:03.549346) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 05:58:03.549624) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 05:58:03.560129) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-05-09 05:58:03.560493) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:58:04 INFO - MultiFileLogger online at 20170509 05:58:04 in /builds/slave/test 05:58:04 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 05:58:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:58:04 INFO - {'append_to_log': False, 05:58:04 INFO - 'base_work_dir': '/builds/slave/test', 05:58:04 INFO - 'blob_upload_branch': 'Firefox', 05:58:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:58:04 INFO - 'branch': 'Firefox', 05:58:04 INFO - 'buildbot_json_path': 'buildprops.json', 05:58:04 INFO - 'config_files': ('talos/linux_config.py',), 05:58:04 INFO - 'default_actions': ('clobber', 05:58:04 INFO - 'read-buildbot-config', 05:58:04 INFO - 'download-and-extract', 05:58:04 INFO - 'populate-webroot', 05:58:04 INFO - 'create-virtualenv', 05:58:04 INFO - 'install', 05:58:04 INFO - 'run-tests'), 05:58:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:58:04 INFO - 'download_minidump_stackwalk': True, 05:58:04 INFO - 'download_symbols': 'ondemand', 05:58:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:58:04 INFO - 'tooltool.py': '/tools/tooltool.py', 05:58:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:58:04 INFO - '/tools/misc-python/virtualenv.py')}, 05:58:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:58:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:58:04 INFO - 'gecko_profile': False, 05:58:04 INFO - 'gecko_profile_interval': 0, 05:58:04 INFO - 'installer_path': 'installer.exe', 05:58:04 INFO - 'log_level': 'info', 05:58:04 INFO - 'log_name': 'talos', 05:58:04 INFO - 'log_to_console': True, 05:58:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:58:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:58:04 INFO - 'opt_config_files': (), 05:58:04 INFO - 'pip_index': False, 05:58:04 INFO - 'suite': 'dromaeojs', 05:58:04 INFO - 'system_bits': '32', 05:58:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:58:04 INFO - 'title': 'talos-linux64-ix-061', 05:58:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:58:04 INFO - 'use_talos_json': True, 05:58:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:58:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:58:04 INFO - 'work_dir': 'build'} 05:58:04 INFO - [mozharness: 2017-05-09 12:58:04.063568Z] Running clobber step. 05:58:04 INFO - Running pre-action listener: _resource_record_pre_action 05:58:04 INFO - Running main action method: clobber 05:58:04 INFO - rmtree: /builds/slave/test/build 05:58:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:58:04 INFO - Running post-action listener: _resource_record_post_action 05:58:04 INFO - [mozharness: 2017-05-09 12:58:04.985238Z] Finished clobber step (success) 05:58:04 INFO - [mozharness: 2017-05-09 12:58:04.985339Z] Running read-buildbot-config step. 05:58:04 INFO - Running pre-action listener: _resource_record_pre_action 05:58:04 INFO - Running main action method: read_buildbot_config 05:58:04 INFO - Using buildbot properties: 05:58:04 INFO - { 05:58:04 INFO - "project": "", 05:58:04 INFO - "product": "firefox", 05:58:04 INFO - "who": "cbook@mozilla.com", 05:58:04 INFO - "installer_path": "public/build/target.tar.bz2", 05:58:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:58:04 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:58:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:58:04 INFO - "stage_platform": "linux64-pgo", 05:58:04 INFO - "basedir": "/builds/slave/test", 05:58:04 INFO - "buildnumber": 188, 05:58:04 INFO - "platform": "ubuntu64_hw", 05:58:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:58:04 INFO - "slavebuilddir": "test", 05:58:04 INFO - "taskId": "PVglWahxRCW3M8L_tslG1g", 05:58:04 INFO - "branch": "mozilla-central", 05:58:04 INFO - "script_repo_revision": "production", 05:58:04 INFO - "revision": "b0ff0c5c0a35a1ee9f19cec2bae5cc2cd5772db6", 05:58:04 INFO - "slavename": "talos-linux64-ix-061", 05:58:04 INFO - "repo_path": "mozilla-central" 05:58:04 INFO - } 05:58:04 INFO - Finding installer, test and symbols from parent task. 05:58:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PVglWahxRCW3M8L_tslG1g'}, attempt #1 05:58:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PVglWahxRCW3M8L_tslG1g'}, attempt #1 05:58:05 INFO - Task dependencies: ZG9cuXMySYayScnfsZg2AA 05:58:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA'}, attempt #1 05:58:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.tar.bz2 05:58:06 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/test_packages.json 05:58:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.crashreporter-symbols.zip 05:58:06 INFO - Running post-action listener: _resource_record_post_action 05:58:06 INFO - [mozharness: 2017-05-09 12:58:06.342575Z] Finished read-buildbot-config step (success) 05:58:06 INFO - [mozharness: 2017-05-09 12:58:06.342792Z] Running download-and-extract step. 05:58:06 INFO - Running pre-action listener: _resource_record_pre_action 05:58:06 INFO - Running main action method: download_and_extract 05:58:06 INFO - mkdir: /builds/slave/test/build/tests 05:58:06 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')]} 05:58:06 INFO - trying https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.test_packages.json 05:58:06 INFO - Downloading https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:58:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:58:06 INFO - Downloaded 986 bytes. 05:58:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:58:06 INFO - Using the following test package requirements: 05:58:06 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:58:06 INFO - u'common': [u'target.common.tests.zip'], 05:58:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:58:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:58:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:58:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:58:06 INFO - u'mozbase': [u'target.common.tests.zip'], 05:58:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:58:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:58:06 INFO - u'web-platform': [u'target.common.tests.zip', 05:58:06 INFO - u'target.web-platform.tests.zip'], 05:58:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:58:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:58:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.common.tests.zip 05:58:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:58:06 INFO - Fetch https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.common.tests.zip into memory 05:58:08 INFO - Content-Length response header: 60567052 05:58:08 INFO - Bytes received: 60567052 05:58:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:58:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.common.tests.zip 05:58:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:58:17 INFO - Fetch https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.common.tests.zip into memory 05:58:19 INFO - Content-Length response header: 60567052 05:58:19 INFO - Bytes received: 60567052 05:58:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.talos.tests.zip 05:58:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:58:29 INFO - Fetch https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.talos.tests.zip into memory 05:58:30 INFO - Content-Length response header: 14409362 05:58:30 INFO - Bytes received: 14409362 05:58:30 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')]} 05:58:30 INFO - trying https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.tar.bz2 05:58:30 INFO - Downloading https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:58:32 INFO - Downloaded 63789057 bytes. 05:58:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.tar.bz2 05:58:32 INFO - mkdir: /builds/slave/test/properties 05:58:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:32 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:32 INFO - Contents: 05:58:32 INFO - build_url:https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.tar.bz2 05:58:32 INFO - Running post-action listener: _resource_record_post_action 05:58:32 INFO - Running post-action listener: set_extra_try_arguments 05:58:32 INFO - [mozharness: 2017-05-09 12:58:32.055159Z] Finished download-and-extract step (success) 05:58:32 INFO - [mozharness: 2017-05-09 12:58:32.055256Z] Running populate-webroot step. 05:58:32 INFO - Running pre-action listener: _resource_record_pre_action 05:58:32 INFO - Running main action method: populate_webroot 05:58:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:58:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:58:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:58:32 INFO - '--tppagecycles', 05:58:32 INFO - '7'], 05:58:32 INFO - 'tests': ['tsvgm']}}, 05:58:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:58:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:58:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:58:32 INFO - 'talos_options': ['--disable-e10s'], 05:58:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:58:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:58:32 INFO - 'talos_options': ['--disable-e10s'], 05:58:32 INFO - 'tests': ['damp', 'tps']}, 05:58:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:58:32 INFO - 'tests': ['damp', 'tps']}, 05:58:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:58:32 INFO - 'tests': ['dromaeo_dom']}, 05:58:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:58:32 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:58:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:58:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:58:32 INFO - 'tests': ['a11yr', 05:58:32 INFO - 'ts_paint', 05:58:32 INFO - 'tpaint', 05:58:32 INFO - 'sessionrestore', 05:58:32 INFO - 'sessionrestore_no_auto_restore', 05:58:32 INFO - 'tabpaint']}, 05:58:32 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:32 INFO - 'ts_paint', 05:58:32 INFO - 'tpaint', 05:58:32 INFO - 'sessionrestore', 05:58:32 INFO - 'sessionrestore_no_auto_restore', 05:58:32 INFO - 'tabpaint']}, 05:58:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:58:32 INFO - 'ts_paint', 05:58:32 INFO - 'tpaint', 05:58:32 INFO - 'sessionrestore', 05:58:32 INFO - 'sessionrestore_no_auto_restore', 05:58:32 INFO - 'tabpaint']}, 05:58:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:58:32 INFO - 'ts_paint', 05:58:32 INFO - 'tpaint', 05:58:32 INFO - 'sessionrestore', 05:58:32 INFO - 'sessionrestore_no_auto_restore', 05:58:32 INFO - 'tabpaint']}, 05:58:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:58:32 INFO - 'tests': ['a11yr', 05:58:32 INFO - 'ts_paint', 05:58:32 INFO - 'tpaint', 05:58:32 INFO - 'sessionrestore', 05:58:32 INFO - 'sessionrestore_no_auto_restore', 05:58:32 INFO - 'tabpaint']}, 05:58:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:58:32 INFO - 'tests': ['a11yr', 05:58:32 INFO - 'ts_paint', 05:58:32 INFO - 'tpaint', 05:58:32 INFO - 'sessionrestore', 05:58:32 INFO - 'sessionrestore_no_auto_restore', 05:58:32 INFO - 'tabpaint']}, 05:58:32 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:58:32 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:58:32 INFO - 'bloom_basic_ref']}, 05:58:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:58:32 INFO - 'tests': ['tsvgx', 05:58:32 INFO - 'tsvgr_opacity', 05:58:32 INFO - 'tart', 05:58:32 INFO - 'tscrollx', 05:58:32 INFO - 'cart', 05:58:32 INFO - 'tsvg_static']}, 05:58:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:32 INFO - 'tsvgr_opacity', 05:58:32 INFO - 'tart', 05:58:32 INFO - 'tscrollx', 05:58:32 INFO - 'cart', 05:58:32 INFO - 'tsvg_static']}, 05:58:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:58:32 INFO - 'talos_options': ['--disable-e10s'], 05:58:32 INFO - 'tests': ['tp5o']}, 05:58:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:58:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:58:32 INFO - 'talos_options': ['--disable-e10s', 05:58:32 INFO - '--xperf_path', 05:58:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:32 INFO - 'tests': ['tp5n']}, 05:58:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:58:32 INFO - 'talos_options': ['--xperf_path', 05:58:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:32 INFO - 'tests': ['tp5n']}}, 05:58:32 INFO - 'talos.zip': {'path': '', 05:58:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:58:32 INFO - Running post-action listener: _resource_record_post_action 05:58:32 INFO - [mozharness: 2017-05-09 12:58:32.068964Z] Finished populate-webroot step (success) 05:58:32 INFO - [mozharness: 2017-05-09 12:58:32.069053Z] Running create-virtualenv step. 05:58:32 INFO - Running pre-action listener: _resource_record_pre_action 05:58:32 INFO - Running main action method: create_virtualenv 05:58:32 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:32 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 05:58:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:58:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:32 INFO - Using real prefix '/usr' 05:58:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:32 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:34 INFO - Installing pip.................done. 05:58:34 INFO - Return code: 0 05:58:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:58:34 INFO - Reading from file tmpfile_stdout 05:58:34 INFO - Output received: 05:58:34 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) 05:58:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:34 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 0x19f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d64770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d61a30>, '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 0x1d627f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62ca0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', '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 05:58:34 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 05:58:34 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 05:58:34 INFO - Using env: {'DISPLAY': ':0', 05:58:34 INFO - 'HOME': '/home/cltbld', 05:58:34 INFO - 'LANG': 'en_US.UTF-8', 05:58:34 INFO - 'LANGUAGE': 'en_US:en', 05:58:34 INFO - 'LOGNAME': 'cltbld', 05:58:34 INFO - 'MAIL': '/var/mail/cltbld', 05:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:34 INFO - 'MOZ_NO_REMOTE': '1', 05:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:34 INFO - 'NO_EM_RESTART': '1', 05:58:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:34 INFO - 'PWD': '/builds/slave/test', 05:58:34 INFO - 'SHELL': '/bin/bash', 05:58:34 INFO - 'SHLVL': '1', 05:58:34 INFO - 'TERM': 'linux', 05:58:34 INFO - 'TMOUT': '86400', 05:58:34 INFO - 'USER': 'cltbld', 05:58:34 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', 05:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:34 INFO - '_': '/tools/buildbot/bin/python'} 05:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:35 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 05:58:35 INFO - Cleaning up... 05:58:35 INFO - Return code: 0 05:58:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:35 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 0x19f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d64770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d61a30>, '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 0x1d627f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62ca0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', '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 05:58:35 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 05:58:35 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 05:58:35 INFO - Using env: {'DISPLAY': ':0', 05:58:35 INFO - 'HOME': '/home/cltbld', 05:58:35 INFO - 'LANG': 'en_US.UTF-8', 05:58:35 INFO - 'LANGUAGE': 'en_US:en', 05:58:35 INFO - 'LOGNAME': 'cltbld', 05:58:35 INFO - 'MAIL': '/var/mail/cltbld', 05:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:35 INFO - 'MOZ_NO_REMOTE': '1', 05:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:35 INFO - 'NO_EM_RESTART': '1', 05:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:35 INFO - 'PWD': '/builds/slave/test', 05:58:35 INFO - 'SHELL': '/bin/bash', 05:58:35 INFO - 'SHLVL': '1', 05:58:35 INFO - 'TERM': 'linux', 05:58:35 INFO - 'TMOUT': '86400', 05:58:35 INFO - 'USER': 'cltbld', 05:58:35 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', 05:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:35 INFO - '_': '/tools/buildbot/bin/python'} 05:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:35 INFO - Downloading/unpacking psutil>=3.1.1 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:36 INFO - Installing collected packages: psutil 05:58:36 INFO - Running setup.py install for psutil 05:58:36 INFO - building 'psutil._psutil_linux' extension 05:58:36 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 05:58:36 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 05:58:36 INFO - building 'psutil._psutil_posix' extension 05:58:36 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 05:58:36 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 05:58:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:36 INFO - Successfully installed psutil 05:58:36 INFO - Cleaning up... 05:58:37 INFO - Return code: 0 05:58:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:58:37 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')]} 05:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:37 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')]} 05:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:37 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 0x19f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d64770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d61a30>, '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 0x1d627f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62ca0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', '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 05:58:37 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 05:58:37 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 05:58:37 INFO - Using env: {'DISPLAY': ':0', 05:58:37 INFO - 'HOME': '/home/cltbld', 05:58:37 INFO - 'LANG': 'en_US.UTF-8', 05:58:37 INFO - 'LANGUAGE': 'en_US:en', 05:58:37 INFO - 'LOGNAME': 'cltbld', 05:58:37 INFO - 'MAIL': '/var/mail/cltbld', 05:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:37 INFO - 'MOZ_NO_REMOTE': '1', 05:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:37 INFO - 'NO_EM_RESTART': '1', 05:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:37 INFO - 'PWD': '/builds/slave/test', 05:58:37 INFO - 'SHELL': '/bin/bash', 05:58:37 INFO - 'SHLVL': '1', 05:58:37 INFO - 'TERM': 'linux', 05:58:37 INFO - 'TMOUT': '86400', 05:58:37 INFO - 'USER': 'cltbld', 05:58:37 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', 05:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:37 INFO - '_': '/tools/buildbot/bin/python'} 05:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:58:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:58:38 INFO - Installing collected packages: mozsystemmonitor 05:58:38 INFO - Running setup.py install for mozsystemmonitor 05:58:38 INFO - Successfully installed mozsystemmonitor 05:58:38 INFO - Cleaning up... 05:58:38 INFO - Return code: 0 05:58:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:38 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 0x19f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d64770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d61a30>, '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 0x1d627f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62ca0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', '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 05:58:38 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 05:58:38 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 05:58:38 INFO - Using env: {'DISPLAY': ':0', 05:58:38 INFO - 'HOME': '/home/cltbld', 05:58:38 INFO - 'LANG': 'en_US.UTF-8', 05:58:38 INFO - 'LANGUAGE': 'en_US:en', 05:58:38 INFO - 'LOGNAME': 'cltbld', 05:58:38 INFO - 'MAIL': '/var/mail/cltbld', 05:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:38 INFO - 'MOZ_NO_REMOTE': '1', 05:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:38 INFO - 'NO_EM_RESTART': '1', 05:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:38 INFO - 'PWD': '/builds/slave/test', 05:58:38 INFO - 'SHELL': '/bin/bash', 05:58:38 INFO - 'SHLVL': '1', 05:58:38 INFO - 'TERM': 'linux', 05:58:38 INFO - 'TMOUT': '86400', 05:58:38 INFO - 'USER': 'cltbld', 05:58:38 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', 05:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:38 INFO - '_': '/tools/buildbot/bin/python'} 05:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:38 INFO - Downloading/unpacking jsonschema==2.5.1 05:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:38 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 05:58:38 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 05:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:58:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:39 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 05:58:39 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 05:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:40 INFO - Downloading functools32-3.2.3-2.tar.gz 05:58:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:58:40 INFO - warning: no files found matching '*.txt' 05:58:40 INFO - no previously-included directories found matching 'build' 05:58:40 INFO - no previously-included directories found matching 'dist' 05:58:40 INFO - no previously-included directories found matching '.git*' 05:58:40 INFO - Installing collected packages: jsonschema, functools32 05:58:40 INFO - Running setup.py install for functools32 05:58:40 INFO - warning: no files found matching '*.txt' 05:58:40 INFO - no previously-included directories found matching 'build' 05:58:40 INFO - no previously-included directories found matching 'dist' 05:58:40 INFO - no previously-included directories found matching '.git*' 05:58:40 INFO - Successfully installed jsonschema functools32 05:58:40 INFO - Cleaning up... 05:58:40 INFO - Return code: 0 05:58:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:58:40 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')]} 05:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:40 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')]} 05:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:40 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 0x19f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d64770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d61a30>, '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 0x1d627f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62ca0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', '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 05:58:40 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 05:58:40 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 05:58:40 INFO - Using env: {'DISPLAY': ':0', 05:58:40 INFO - 'HOME': '/home/cltbld', 05:58:40 INFO - 'LANG': 'en_US.UTF-8', 05:58:40 INFO - 'LANGUAGE': 'en_US:en', 05:58:40 INFO - 'LOGNAME': 'cltbld', 05:58:40 INFO - 'MAIL': '/var/mail/cltbld', 05:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:40 INFO - 'MOZ_NO_REMOTE': '1', 05:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:40 INFO - 'NO_EM_RESTART': '1', 05:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:40 INFO - 'PWD': '/builds/slave/test', 05:58:40 INFO - 'SHELL': '/bin/bash', 05:58:40 INFO - 'SHLVL': '1', 05:58:40 INFO - 'TERM': 'linux', 05:58:40 INFO - 'TMOUT': '86400', 05:58:40 INFO - 'USER': 'cltbld', 05:58:40 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', 05:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:40 INFO - '_': '/tools/buildbot/bin/python'} 05:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:58:40 INFO - Cleaning up... 05:58:40 INFO - Return code: 0 05:58:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:58:40 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')]} 05:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:40 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')]} 05:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:40 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 0x19f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d64770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d61a30>, '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 0x1d627f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62ca0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', '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 05:58:40 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 05:58:40 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 05:58:40 INFO - Using env: {'DISPLAY': ':0', 05:58:40 INFO - 'HOME': '/home/cltbld', 05:58:40 INFO - 'LANG': 'en_US.UTF-8', 05:58:40 INFO - 'LANGUAGE': 'en_US:en', 05:58:40 INFO - 'LOGNAME': 'cltbld', 05:58:40 INFO - 'MAIL': '/var/mail/cltbld', 05:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:40 INFO - 'MOZ_NO_REMOTE': '1', 05:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:40 INFO - 'NO_EM_RESTART': '1', 05:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:40 INFO - 'PWD': '/builds/slave/test', 05:58:40 INFO - 'SHELL': '/bin/bash', 05:58:40 INFO - 'SHLVL': '1', 05:58:40 INFO - 'TERM': 'linux', 05:58:40 INFO - 'TMOUT': '86400', 05:58:40 INFO - 'USER': 'cltbld', 05:58:40 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', 05:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:40 INFO - '_': '/tools/buildbot/bin/python'} 05:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:40 INFO - Downloading/unpacking blobuploader==1.2.4 05:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:40 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 05:58:40 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 05:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:41 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:58:41 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 05:58:41 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 05:58:41 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 05:58:41 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 05:58:41 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 05:58:41 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 05:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:58:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:42 INFO - Downloading docopt-0.6.1.tar.gz 05:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:42 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:42 INFO - Running setup.py install for blobuploader 05:58:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:58:42 INFO - Running setup.py install for requests 05:58:42 INFO - Running setup.py install for docopt 05:58:43 INFO - Successfully installed blobuploader requests docopt 05:58:43 INFO - Cleaning up... 05:58:43 INFO - Return code: 0 05:58:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05: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')]} 05:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05: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')]} 05:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:43 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 0x19f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d64770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d61a30>, '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 0x1d627f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62ca0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', '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 05:58:43 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 05:58:43 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 05:58:43 INFO - Using env: {'DISPLAY': ':0', 05:58:43 INFO - 'HOME': '/home/cltbld', 05:58:43 INFO - 'LANG': 'en_US.UTF-8', 05:58:43 INFO - 'LANGUAGE': 'en_US:en', 05:58:43 INFO - 'LOGNAME': 'cltbld', 05:58:43 INFO - 'MAIL': '/var/mail/cltbld', 05:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:43 INFO - 'MOZ_NO_REMOTE': '1', 05:58:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:43 INFO - 'NO_EM_RESTART': '1', 05:58:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:43 INFO - 'PWD': '/builds/slave/test', 05:58:43 INFO - 'SHELL': '/bin/bash', 05:58:43 INFO - 'SHLVL': '1', 05:58:43 INFO - 'TERM': 'linux', 05:58:43 INFO - 'TMOUT': '86400', 05:58:43 INFO - 'USER': 'cltbld', 05:58:43 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', 05:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:43 INFO - '_': '/tools/buildbot/bin/python'} 05:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:43 INFO - Running setup.py (path:/tmp/pip-laIrUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:43 INFO - Running setup.py (path:/tmp/pip-0CWAEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:43 INFO - Running setup.py (path:/tmp/pip-4wgo2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:43 INFO - Running setup.py (path:/tmp/pip-jE7E1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:43 INFO - Running setup.py (path:/tmp/pip-hBiVSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:43 INFO - Running setup.py (path:/tmp/pip-KIRlGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:43 INFO - Running setup.py (path:/tmp/pip-FszaFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:43 INFO - Running setup.py (path:/tmp/pip-Mo7d5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:43 INFO - Running setup.py (path:/tmp/pip-izWdt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:43 INFO - Running setup.py (path:/tmp/pip-pIHiQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:43 INFO - Running setup.py (path:/tmp/pip-cYdLdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:44 INFO - Running setup.py (path:/tmp/pip-nbe5iN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:44 INFO - Running setup.py (path:/tmp/pip-Omc0rG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:44 INFO - Running setup.py (path:/tmp/pip-FP48FD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:44 INFO - Running setup.py (path:/tmp/pip-k7xFzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:44 INFO - Running setup.py (path:/tmp/pip-hoRMIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:44 INFO - Running setup.py (path:/tmp/pip-wZ4QHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:44 INFO - Running setup.py install for manifestparser 05:58:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:44 INFO - Running setup.py install for mozcrash 05:58:44 INFO - Running setup.py install for mozdebug 05:58:44 INFO - Running setup.py install for mozdevice 05:58:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:44 INFO - Running setup.py install for mozfile 05:58:44 INFO - Running setup.py install for mozhttpd 05:58:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:45 INFO - Running setup.py install for mozinfo 05:58:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:45 INFO - Running setup.py install for mozInstall 05:58:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:45 INFO - Running setup.py install for mozleak 05:58:45 INFO - Running setup.py install for mozlog 05:58:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:45 INFO - Running setup.py install for moznetwork 05:58:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:45 INFO - Running setup.py install for mozprocess 05:58:45 INFO - Running setup.py install for mozprofile 05:58:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:58:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:58:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:58:45 INFO - Running setup.py install for mozrunner 05:58:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:58:45 INFO - Running setup.py install for mozscreenshot 05:58:46 INFO - Running setup.py install for moztest 05:58:46 INFO - Running setup.py install for mozversion 05:58:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:58:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:58:46 INFO - Cleaning up... 05:58:46 INFO - Return code: 0 05:58:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:46 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')]} 05:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:46 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')]} 05:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:46 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 0x19f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d64770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d61a30>, '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 0x1d627f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62ca0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', '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 05:58:46 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 05:58:46 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 05:58:46 INFO - Using env: {'DISPLAY': ':0', 05:58:46 INFO - 'HOME': '/home/cltbld', 05:58:46 INFO - 'LANG': 'en_US.UTF-8', 05:58:46 INFO - 'LANGUAGE': 'en_US:en', 05:58:46 INFO - 'LOGNAME': 'cltbld', 05:58:46 INFO - 'MAIL': '/var/mail/cltbld', 05:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:46 INFO - 'MOZ_NO_REMOTE': '1', 05:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:46 INFO - 'NO_EM_RESTART': '1', 05:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:46 INFO - 'PWD': '/builds/slave/test', 05:58:46 INFO - 'SHELL': '/bin/bash', 05:58:46 INFO - 'SHLVL': '1', 05:58:46 INFO - 'TERM': 'linux', 05:58:46 INFO - 'TMOUT': '86400', 05:58:46 INFO - 'USER': 'cltbld', 05:58:46 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', 05:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:46 INFO - '_': '/tools/buildbot/bin/python'} 05:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:46 INFO - Running setup.py (path:/tmp/pip-Dnk7ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:46 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)) 05:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:46 INFO - Running setup.py (path:/tmp/pip-K7IssL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:46 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)) 05:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:46 INFO - Running setup.py (path:/tmp/pip-BpJMRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:46 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)) 05:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:46 INFO - Running setup.py (path:/tmp/pip-LzpcGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:46 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)) 05:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:46 INFO - Running setup.py (path:/tmp/pip-YimV1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:46 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)) 05:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:46 INFO - Running setup.py (path:/tmp/pip-LJWNAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:46 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)) 05:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:46 INFO - Running setup.py (path:/tmp/pip-b5Bjf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:47 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)) 05:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:47 INFO - Running setup.py (path:/tmp/pip-ENsV8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:47 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)) 05:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:47 INFO - Running setup.py (path:/tmp/pip-jLPKed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:47 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)) 05:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:47 INFO - Running setup.py (path:/tmp/pip-oAqCXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:47 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)) 05:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:47 INFO - Running setup.py (path:/tmp/pip-aYxflt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:47 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)) 05:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:47 INFO - Running setup.py (path:/tmp/pip-HcLcDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:47 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)) 05:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:47 INFO - Running setup.py (path:/tmp/pip-ZrC8Sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:47 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)) 05:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:47 INFO - Running setup.py (path:/tmp/pip-_7CXAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:47 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)) 05:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:47 INFO - Running setup.py (path:/tmp/pip-lL_w2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:47 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)) 05:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:47 INFO - Running setup.py (path:/tmp/pip-VLYaeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:47 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)) 05:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:47 INFO - Running setup.py (path:/tmp/pip-aJov8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:47 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)) 05:58:47 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)) 05:58:47 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)) 05:58:47 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)) 05:58:47 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)) 05:58:47 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)) 05:58:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:47 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 05:58:47 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 05:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:48 INFO - Downloading blessings-1.6.tar.gz 05:58:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:58:48 INFO - Installing collected packages: blessings 05:58:48 INFO - Running setup.py install for blessings 05:58:49 INFO - Successfully installed blessings 05:58:49 INFO - Cleaning up... 05:58:49 INFO - Return code: 0 05:58:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:58:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:49 INFO - Reading from file tmpfile_stdout 05:58:49 INFO - Current package versions: 05:58:49 INFO - argparse == 1.2.1 05:58:49 INFO - blessings == 1.6 05:58:49 INFO - blobuploader == 1.2.4 05:58:49 INFO - docopt == 0.6.1 05:58:49 INFO - functools32 == 3.2.3-2 05:58:49 INFO - jsonschema == 2.5.1 05:58:49 INFO - manifestparser == 1.1 05:58:49 INFO - mozInstall == 1.12 05:58:49 INFO - mozcrash == 1.0 05:58:49 INFO - mozdebug == 0.1 05:58:49 INFO - mozdevice == 0.50 05:58:49 INFO - mozfile == 1.2 05:58:49 INFO - mozhttpd == 0.7 05:58:49 INFO - mozinfo == 0.9 05:58:49 INFO - mozleak == 0.1 05:58:49 INFO - mozlog == 3.4 05:58:49 INFO - moznetwork == 0.27 05:58:49 INFO - mozprocess == 0.25 05:58:49 INFO - mozprofile == 0.28 05:58:49 INFO - mozrunner == 6.13 05:58:49 INFO - mozscreenshot == 0.1 05:58:49 INFO - mozsystemmonitor == 0.3 05:58:49 INFO - moztest == 0.8 05:58:49 INFO - mozversion == 1.4 05:58:49 INFO - psutil == 3.1.1 05:58:49 INFO - requests == 1.2.3 05:58:49 INFO - wsgiref == 0.1.2 05:58:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:49 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')]} 05:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:49 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')]} 05:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:49 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 0x19f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d64770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d61a30>, '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 0x1d627f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62ca0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', '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 05:58:49 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 05:58:49 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 05:58:49 INFO - Using env: {'DISPLAY': ':0', 05:58:49 INFO - 'HOME': '/home/cltbld', 05:58:49 INFO - 'LANG': 'en_US.UTF-8', 05:58:49 INFO - 'LANGUAGE': 'en_US:en', 05:58:49 INFO - 'LOGNAME': 'cltbld', 05:58:49 INFO - 'MAIL': '/var/mail/cltbld', 05:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:49 INFO - 'MOZ_NO_REMOTE': '1', 05:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:49 INFO - 'NO_EM_RESTART': '1', 05:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:49 INFO - 'PWD': '/builds/slave/test', 05:58:49 INFO - 'SHELL': '/bin/bash', 05:58:49 INFO - 'SHLVL': '1', 05:58:49 INFO - 'TERM': 'linux', 05:58:49 INFO - 'TMOUT': '86400', 05:58:49 INFO - 'USER': 'cltbld', 05:58:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', 05:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:49 INFO - '_': '/tools/buildbot/bin/python'} 05:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:49 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)) 05:58:49 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)) 05:58:49 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)) 05:58:49 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)) 05:58:49 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)) 05:58:49 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)) 05:58:49 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)) 05:58:49 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)) 05:58:49 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)) 05:58:49 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)) 05:58:49 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)) 05:58:49 INFO - Cleaning up... 05:58:49 INFO - Return code: 0 05:58:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:58:49 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')]} 05:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:49 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')]} 05:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x19f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d64770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d61a30>, '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 0x1d627f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62ca0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', '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 05:58:49 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 05:58:49 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 05:58:49 INFO - Using env: {'DISPLAY': ':0', 05:58:49 INFO - 'HOME': '/home/cltbld', 05:58:49 INFO - 'LANG': 'en_US.UTF-8', 05:58:49 INFO - 'LANGUAGE': 'en_US:en', 05:58:49 INFO - 'LOGNAME': 'cltbld', 05:58:49 INFO - 'MAIL': '/var/mail/cltbld', 05:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:49 INFO - 'MOZ_NO_REMOTE': '1', 05:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:49 INFO - 'NO_EM_RESTART': '1', 05:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:49 INFO - 'PWD': '/builds/slave/test', 05:58:49 INFO - 'SHELL': '/bin/bash', 05:58:49 INFO - 'SHLVL': '1', 05:58:49 INFO - 'TERM': 'linux', 05:58:49 INFO - 'TMOUT': '86400', 05:58:49 INFO - 'USER': 'cltbld', 05:58:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', 05:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:49 INFO - '_': '/tools/buildbot/bin/python'} 05:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:58:49 INFO - Cleaning up... 05:58:49 INFO - Return code: 0 05:58:49 INFO - Running post-action listener: _resource_record_post_action 05:58:49 INFO - Running post-action listener: _start_resource_monitoring 05:58:49 INFO - Starting resource monitoring. 05:58:49 INFO - [mozharness: 2017-05-09 12:58:49.772971Z] Finished create-virtualenv step (success) 05:58:49 INFO - [mozharness: 2017-05-09 12:58:49.773439Z] Running install step. 05:58:49 INFO - Running pre-action listener: _resource_record_pre_action 05:58:49 INFO - Running main action method: install 05:58:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:49 INFO - Reading from file tmpfile_stdout 05:58:49 INFO - Detecting whether we're running mozinstall >=1.0... 05:58:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:58:50 INFO - Reading from file tmpfile_stdout 05:58:50 INFO - Output received: 05:58:50 INFO - Usage: mozinstall [options] installer 05:58:50 INFO - Options: 05:58:50 INFO - -h, --help show this help message and exit 05:58:50 INFO - -d DEST, --destination=DEST 05:58:50 INFO - Directory to install application into. [default: 05:58:50 INFO - "/builds/slave/test"] 05:58:50 INFO - --app=APP Application being installed. [default: firefox] 05:58:50 INFO - mkdir: /builds/slave/test/build/application 05:58:50 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'] 05:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:59:06 INFO - Reading from file tmpfile_stdout 05:59:06 INFO - Output received: 05:59:06 INFO - /builds/slave/test/build/application/firefox/firefox 05:59:06 INFO - Running post-action listener: _resource_record_post_action 05:59:06 INFO - [mozharness: 2017-05-09 12:59:06.236017Z] Finished install step (success) 05:59:06 INFO - [mozharness: 2017-05-09 12:59:06.236342Z] Running run-tests step. 05:59:06 INFO - Running pre-action listener: _resource_record_pre_action 05:59:06 INFO - Running main action method: run_tests 05:59:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:59:06 INFO - Python 2.7.3 05:59:06 INFO - Return code: 0 05:59:06 INFO - grabbing minidump binary from tooltool 05:59:06 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')]} 05:59:06 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 0x1d61a30>, '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 0x1d627f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:59:06 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 05:59:06 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 05:59:06 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 05:59:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:59:06 INFO - Return code: 0 05:59:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:59:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:59:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:59:06 INFO - ENV: RUST_BACKTRACE is now 1 05:59:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:59:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:59:06 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/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 05:59:06 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/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 05:59:06 INFO - Using env: {'DISPLAY': ':0', 05:59:06 INFO - 'HOME': '/home/cltbld', 05:59:06 INFO - 'LANG': 'en_US.UTF-8', 05:59:06 INFO - 'LANGUAGE': 'en_US:en', 05:59:06 INFO - 'LOGNAME': 'cltbld', 05:59:06 INFO - 'MAIL': '/var/mail/cltbld', 05:59:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:59:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:06 INFO - 'MOZ_NO_REMOTE': '1', 05:59:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:06 INFO - 'NO_EM_RESTART': '1', 05:59:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:06 INFO - 'PWD': '/builds/slave/test', 05:59:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:59:06 INFO - 'RUST_BACKTRACE': '1', 05:59:06 INFO - 'SHELL': '/bin/bash', 05:59:06 INFO - 'SHLVL': '1', 05:59:06 INFO - 'TERM': 'linux', 05:59:06 INFO - 'TMOUT': '86400', 05:59:06 INFO - 'USER': 'cltbld', 05:59:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824', 05:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:06 INFO - '_': '/tools/buildbot/bin/python'} 05:59:06 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/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 05:59:06 INFO - mozversion application_buildid: 20170509120348 05:59:06 INFO - mozversion application_changeset: b0ff0c5c0a35a1ee9f19cec2bae5cc2cd5772db6 05:59:06 INFO - mozversion application_display_name: Nightly 05:59:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:59:06 INFO - mozversion application_name: Firefox 05:59:06 INFO - mozversion application_remotingname: firefox 05:59:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:59:06 INFO - mozversion application_vendor: Mozilla 05:59:06 INFO - mozversion application_version: 55.0a1 05:59:06 INFO - mozversion platform_buildid: 20170509120348 05:59:06 INFO - mozversion platform_changeset: b0ff0c5c0a35a1ee9f19cec2bae5cc2cd5772db6 05:59:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:59:06 INFO - mozversion platform_version: 55.0a1 05:59:06 INFO - using testdate: 1494334746 05:59:06 INFO - actual date: 1494334746 05:59:06 INFO - starting webserver on 'localhost:32856' 05:59:06 INFO - SUITE-START | Running 2 tests 05:59:06 INFO - TEST-START | dromaeo_css 05:59:06 INFO - operating with platform_type : linux_ 05:59:06 INFO - Initialising browser for dromaeo_css test... 05:59:06 INFO - TEST-INFO | started process 16450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpREwjXh/profile http://localhost:32856/getInfo.html) 05:59:10 INFO - PID 16450 | __metrics Screen width/height:1600/1200 05:59:10 INFO - PID 16450 | colorDepth:24 05:59:10 INFO - PID 16450 | Browser inner width/height: 1024/695 05:59:10 INFO - PID 16450 | __metrics 05:59:11 INFO - PID 16450 | 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" 05:59:11 INFO - PID 16450 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:59:12 INFO - TEST-INFO | 16450: exit 0 05:59:12 INFO - Browser initialized. 05:59:12 INFO - Running cycle 1/1 for dromaeo_css test... 05:59:12 INFO - TEST-INFO | started process 16546 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpREwjXh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:24 INFO - PID 16546 | RSS: Main: 149721088 05:59:24 INFO - PID 16546 | 06:02:27 INFO - PID 16546 | Cycle 1(1): loaded http://localhost:32856/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32856/tests/dromaeo/cssquery-ext.html) 06:02:28 INFO - PID 16546 | RSS: Main: 258424832 06:02:28 INFO - PID 16546 | 06:05:30 INFO - PID 16546 | Cycle 1(1): loaded http://localhost:32856/tests/dromaeo/cssquery-ext.html (next: http://localhost:32856/tests/dromaeo/cssquery-jquery.html) 06:05:31 INFO - PID 16546 | RSS: Main: 221855744 06:05:31 INFO - PID 16546 | 06:08:32 INFO - PID 16546 | Cycle 1(1): loaded http://localhost:32856/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32856/tests/dromaeo/cssquery-mootools.html) 06:08:33 INFO - PID 16546 | RSS: Main: 175120384 06:08:33 INFO - PID 16546 | 06:11:35 INFO - PID 16546 | Cycle 1(1): loaded http://localhost:32856/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32856/tests/dromaeo/cssquery-prototype.html) 06:11:35 INFO - PID 16546 | RSS: Main: 173645824 06:11:35 INFO - PID 16546 | 06:14:38 INFO - PID 16546 | Cycle 1(1): loaded http://localhost:32856/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32856/tests/dromaeo/cssquery-yui.html) 06:14:39 INFO - PID 16546 | RSS: Main: 173662208 06:14:39 INFO - PID 16546 | 06:17:40 INFO - PID 16546 | Cycle 1(1): loaded http://localhost:32856/tests/dromaeo/cssquery-yui.html (next: http://localhost:32856/tests/dromaeo/cssquery-dojo.html) 06:17:41 INFO - PID 16546 | RSS: Main: 268967936 06:17:41 INFO - PID 16546 | 06:17:41 INFO - PID 16546 | __start_tp_report 06:17:41 INFO - PID 16546 | _x_x_mozilla_page_load 06:17:41 INFO - PID 16546 | _x_x_mozilla_page_load_details 06:17:41 INFO - PID 16546 | |i|pagename|runs| 06:17:41 INFO - PID 16546 | |0;dojo.html;3298.060052884928;3341;3352.2625022495045;3368.326334733054;3383.323335332934;5670.461306175906;5837.38707435719;5839.6496210227415;5868.119782032692;5874.559408044398;5880.3237627672725;5899.6165249258875;5931.051031834907;5965.284165900087;5986;4751.31105989633;5062.873428164288;5196.714180720059;5243.239730239113;5247.16045432729;5202.0376230397305;5258.974499972507;5309.256704061435;5325.600579956499;5328.866778330534;5072.72100034498;5162.638615296931;5211.24436956643;5280.973595132;5292.126799078147;5233.21501774733;5242.23987521811;5243.895122097537;5246.921296180561;5293.444188360244;5198.896022079575;5241.240020197089;5243.737813109367;5249.343832020997;5268.762905669254;5677.233573467612;5749.626274292157;5775.711214439261;5777.826665200051;5889.8822023559715;6167.013277875519;6313.936860631381;6389.968050159766;6395.680215989229;6402.551821372505;6364.140840986453;6366.363363663643;6370.522210834206;6376.617402955838;6382.234131904155;5839.854003649943;5849.590528662995;5902.409759024106;5905.055191169392;5912.408759124053;6231.22109736283;6317.368263173646;6406.711697973602;6559.114519539897;6565.737370505126;6058.21243238385;6095.655667372612;6144.846378840565;6208.596441231396;6214.1921550198185;6260.686965651699;6354.555181137369;6386.329435409308;6399.264084630234;6401;6377.266614339411;6382.489400847921;6388;6388.073729309317;6389.520785941073;6111.964830093352;6198.318184999646;6313.273973493016;6329.335419780857;6369.14016607752;4776.665633405628;4806.423229212447;4815.2054910939305;4846.176150054499;4859.441164266084;4242.257604919127;4281.764502952367;4289.0992891492515;4310.719803212781;4318.913621727611;5795.594308398456;5866.882662346815;5877.412258774174;5965.343812180657;5968.671723055274;6159.81520554384;6220.720067596969;6432.0351947207355;6451.838704032437;6452;5994.67029313392;5995.880082398327;6003.009503431885;6004.159417681528;6007.969960150172;5547.334319881559;5549.223108764776;5552.861178470571;5555.50000499957;5555.972220138873;6408.2630497492455;6437.871242575122;6585.078089067439;6707.429868461236;6719.160104986877;6429.517786165963;6472.579282346821;6476.255230648536;6477.935220647733;6483.610983341015;6624.635645039376;6707.496937729592;6740.966295168493;6744.527883048139;6752.763653272112;6075.574709770273;6110.26676798787;6161.969190154021;6281.96859015702;6294.15028971083;6328.557001010069;6340.556161068866;6366.299707032315;6393.1369265148605;6394.328595497405;6060.272767267956;6134.6625935573975;6134.877302454015;6202.28673702512;6202.472789812736;6063.363346848518;6218.502519798496;6258.092576576462;6258.217722784652;6266.811995640138;6019.909701354571;6080.908786368296;6110.297315808739;6194.938050619436;6218.875622487615;6257.812265632038;6258.342873998165;6261.24865016201;6286.497080233662;6295.96852015737;6061.727222275096;6063.818085457443;6064.7877324295205;6075.058365953284;6089.360617135314 06:17:41 INFO - PID 16546 | |1;ext.html;749.9362554182894;802.8233788566515;828.3787159630277;1090.8472813806075;1105.36441546111;29909.55135672964;30820.691793082035;30832.84583577082;37077.81461092691;37866.43200351997;39356.212875742465;39712;39818.20363592726;39829.60170398295;39859;5653.434656534334;7168.749093781718;7305.196428392873;7308.5614863108385;7311.634418279092;5782.710864456782;5887.8233652990475;5890.145928840316;7068.39918606919;7272.745453909114;7360.558366498;7401.481896267236;7406.703731850719;7410.110786705576;7417.629118544078;7314.634268286564;7346.081739782528;7373.33639972405;7375.926240737631;7377.446691498106;5639.774409023634;5805;6970.79087627372;7212.350888420067;7227.096612923385;35945;36218.63781362205;36272.45591316132;36279.09302267464;36286.63713362859;3442.604100528421;3483.3555792178527;3486.6687664672068;3487.930241395183;3491.7032052275586;28198;28271.15186544407;28275.57586636202;28417.431651367064;28464.573031404547;3646.6535679110443;3648.3068217038676;3650.653187947141;3651.7991510466913;3663.1757854482794;180225;180269;180756;180990;181079.9999999987;47450.76274618605;47623;47631.76184119057;47637.28544071842;47654.5234547657;49609.25586116211;49710;49711.75144124256;49801.25298120531;49903.25145122826;14376.634219749107;14416.567502974927;14468.927655361656;14477.710445791025;14490.203038832755;11631.53473861053;11652.242604230698;11655.59205427806;11659.24214926044;11673.941630291794;11751;11837;14610.926945365418;14747.77878331826;14978.17620030887;5840.153177789197;5901.996660567714;5991.310999235056;6014.1580178775;6059.4546490815155;1037.4397825174321;1067.9946600266949;1070.4540684250933;1083.5232497700986;1085.4193006741355;26961.59557606598;26998.802680802433;27171.592426113624;27188.728112719014;27219.455610888068;1149.735560821016;1160.3733983648735;1161.4691338331547;1163.2962057954985;1193.176708071428;13515.729685406237;13638.93180534091;13727.656808579866;13942.37259323333;13947.930260348836;260172;261952;262034;262067;262164;52844;53313.73343133259;53321.46678533243;53346.73326633342;53362.466375336524;1454.127523485921;1464.436192066041;1478.9556313310618;1499.2204053892133;1506.3221550302408;24204.15285465;25449.61825572655;25657.358566035997;25696.357591060372;25771.098011569506;38904.41643375295;39291;39312.803435982634;39321.41017884791;39354.2129157421;203937;205442;206022;206041;206213;29682.40635187241;34845.825770870986;35185.648143518236;35240.295194096485;35241.94274171779;35878.103047424025;41391.1721765569;41956.79021604872;42171.57828421677;42199.7890010548;29212.56181157327;30965;31108.377832443675;31143.532847007766;32070.67929320677;30406.391872162876;30631;30664.233394165323;30954.53568196524;31697.207569810016;35654;36102;36154;36259;36546.45180322351;29499.410011799213;29594.556081659222;29910.401791964476;29940.401191976474;30291.091267262018;23100.306990790305;24716.876415617808;24785.62821557642;24893.253202403957;24979.845331581357 06:17:41 INFO - PID 16546 | |2;jquery.html;436.2256993835941;436.9104333611606;444.6131865277209;457.3368615507513;462.55132521454186;18724.25102995882;19523;19929.701054484194;20087.694299870516;20119.29582464614;21058.684119738216;21804.127834886625;21848.672269915965;22005.559888802214;22675;5284.44513326101;5505.6696598204035;5522.889542209174;5525.309336332958;5533.446655334475;5375.039324075312;5442.455754424545;5473.890522189554;5495.6153069285165;5507.889842203153;5439.5104440600335;5455.563554915597;5468.671879687212;5468.781248750045;5468.890622187554;5265.289185959904;5426.565874730012;5447.945520544784;5461.481159289861;5464.0711079116645;4977.253411988195;4986.252062190664;4988.127077761414;4998.525434996648;4998.675086119427;24948.750512494826;25323.873380633162;25387.746122538723;25492.490150196893;25503.36241593975;2146.0557354763855;2177.7277840269967;2179.5967745967046;2180.5420861619077;2181.4655409424636;16518.917405412896;17326.913365433218;17363.21865516055;17459;17465.47603571882;2131.690904818808;2162.556675881456;2200.2189222825828;2228.5542891421783;2244.438890277431;91602;93879.53060234724;115516.42241788821;115966.42016789946;116547.41726291315;12339.75320493585;12401.193922395016;12480.251184928933;12486.75026499465;12730.68173295675;17844.91077544604;17911.641767164583;17995.640087198182;18003.0998450077;18025;8809.647614095364;9002.549872506479;9071;9164.129407706258;9177.632894684139;8184.877226841602;8193.918060819435;8246.340292776564;8453.323734101257;8462.19609137131;7880.684772609146;7932.492826362973;7985.321247693895;8131.59342032896;8185.3042491387705;2113.492761737172;2185.606590813669;2194.5610877824497;2199.7580266170708;2214.6013717531;1046.9738256543494;1052.494802494807;1056.3820165203288;1074.9408782517037;1075.639660713654;19505.317313893946;21055.8947205263;21061.262855799974;21294.36116916495;21381.144754209967;1080.8108580998294;1084.6312253833576;1097.3690128176172;1102.5424448853637;1104.364990130662;10557.841632375521;11457.427128643534;11473;11553.36456494884;11614.593489227836;501113;502708;504920;511977;512216;82329.58835205785;92315.53842230747;95545;97471.51264243634;98203;1212.8423304970474;1227.8526576810661;1265.4052595280205;1267.7211013577182;1270.7394984028251;20574.074166662238;20628.896855515628;20998;21098.156073756876;21393.67909481328;43432.49565165217;43993.340099899164;44111.55888441075;44311.33532996943;44848.77575612101;54058.45941540534;56577.43422565722;57459.42540574541;57832.71083644723;58572;8626.309895208242;8641.222289993932;8756.168164024408;8821.294296456139;8866.113388661082;12176.147669663038;12183.512659493876;12388.81416778731;12556;12664.873351266739;11794.46924888365;11887.643370698894;12016.579419720269;12052.578159764365;12429.627111186679;10063.446510441996;10187.949060254652;10241.334313269614;10276.383416995004;10428.739281518023;11184.664460066211;11297.378644174649;11775.76448471043;11850.822237666269;11867.109966752356;8910.287177025693;9001.36990410665;9100.726978190665;9315.487648179414;9388;11385.316880987168;11428.94285528567;11622.360770157384;11714;11809.110542313188 06:17:41 INFO - PID 16546 | |3;mootools.html;1358.3344161360933;1400.7688731359326;1419.16978567538;1420.1337184317565;1423.1176670464313;10620;11196.048335891439;11257.6622701319;11258.155638327118;11264.267822591535;10777.5688972441;11339.092872570196;11361.829572556398;11375.544978200884;11378;2315.4211447138214;2354.540864531417;2355;2359.4573248152933;2362.598358279088;2011.4569066352076;2301.7122859642545;2363.279199844047;2373.46597015671;2374.679418278536;2009.889456079915;2243.7644047375034;2312.710911136108;2332.416895776056;2335.1359996801207;2275.385645875621;2305.446692793734;2310.572544079342;2311.040918019037;2314.2363020203293;2270.818334533233;2278.293728944033;2285.108807565051;2286.542691461714;2288.565172617214;11048.944755276252;11197.16021298406;11213.046891014274;11249.718757031058;11260.718482037933;6195.659238741868;6404.903926441107;6409.262934762515;6413.198350206224;6415.711292991827;3857.787821669807;4070.328395814687;4122.649574786146;4140.192662430827;4181.707280490367;1355.302019459979;1362.2984163155982;1408.528143072072;1419.0846903747129;1422.4736847366437;16676.58308542284;16772.916135419367;16785.412510562073;16793.496195114167;16795.580110497212;5255.369355677343;5291.841244762663;5372.811951581676;5449.5640348772;5521.309836270466;12021.879781202251;12023.098267629963;12027.458764355624;12027.75944481123;12035.097367697457;6298.1812364392335;6309.968450157719;6315.210598675166;6318.810435686937;6319.9368006320265;5865.384134665884;5933.317668468095;5965;5971.910421343683;6010.398960103955;4191.455110835572;4223.21870453967;4277.165952639206;4300.956990430118;4354.608085272341;1107.5071593140974;1155.7110722319421;1210.509743553862;1252.2236213547658;1262.6149024547417;846.3567688556618;866.7833041739565;881.4226681523612;890.528020149322;907.5552979040355;6839.555428897106;7012.7545535906;7035.47233957445;7065.43476521877;7288.526245794006;638.6615094000188;640.4428147511695;647.0779139725872;647.2879832184559;755.4938191411658;4498.59512643857;4504.707194032443;4555.157295900269;4560;4714.269288260325;14947.252637368305;15375.615609609626;15540.689186216212;15560;15567.532974010797;14703;15308.387664493519;15309.770353444706;15339.156346401054;15385.538433847003;9291.396059256127;9439.103285187895;9457.534082217267;9465.952670236606;9536.23710103204;6933.37599616037;7197.676104575411;7221.494495385273;7267.600281984542;7337.229590892879;13236.735265294832;13306.268155251553;13332.333383330988;13686;13714.93142534281;13654.249016304198;13803.654908627364;13811.723765524834;13916;13990;9517.809643807224;9540.141387275178;9563.187129094105;9625.71122866315;9648.372855764354;10291.742706432398;10330.380177189392;10376.533056012648;10383.428911409945;10392.06471417576;9183.586738596645;9276.72169834906;9360;9425.905740942777;9538;9135.954320228622;9170.862437063315;9195.54022298869;9319.161275484968;9368.859467107863;8355.665773368997;8524.573771311285;8525.104863989192;8545.145485451654;8551.786205344915;5517.834464966058;5584.4136365681015;5589.636673616202;5722.2561067061015;5892.204552385373;5700.914486282626;5732.111522713986;5740.483356497935;5834.066549352084;5916.142159386779 06:17:41 INFO - PID 16546 | |4;prototype.html;417.36768795275157;421.1829051639819;423.09668856990316;428.9335153051276;431.3229716665425;5637.887242255152;5764.596478246519;5797.565182611305;5816.912746308803;5834.5040671542865;5578.86052848679;5626.943730562693;5710.428957104287;5722.284714410699;5761.942380576193;4276.42268293781;4370.082282720632;4405.933910991338;4419.9337009944875;4427.225235583776;4400.62594679451;4405.1586726561345;4405.603495685387;4411.404460397854;4421.6904816662845;4374.300111982067;4377.146456440995;4380.189664911985;4403.3174857897075;4403.911921761563;4324.610785029363;4352.434183556117;4382;4398.494173170095;4401.295792673173;3821.5032045833864;3828.10039640687;3832.463455116286;3835.060410199491;3838.193979264358;5650.6892120933335;5652.943470565283;5653.349864765563;5653.802116925888;5684.37471878093;5092.523168281194;5111.361079865017;5139.537441630234;5141.048905952373;5146.327443580813;6091.208142941434;6110.663913484756;6112.877742445126;6113.296970848321;6115.235595550556;4323.156984388045;4324.567543245682;4326.069894972596;4326.437563116806;4332.133573285324;6110.63336199825;6237.968810155966;6256.249250089927;6433.774817881352;6451.709673064724;4285.742855428622;4364.62900653448;4368.628666563378;4398.846040388571;4409.757463339547;4472.731636101845;4476.529964353696;4480.350349199348;4482.906794311914;4485.125400546862;4853.223484242504;4898.39550822226;5129.9743501282255;5133.383993920754;5152.510511501401;6083.330833608299;6125.295591007002;6129.233845769279;6135;6148;1517.6357674158123;1534.8258582184637;1537.2697968465113;1543.4829332173622;1544.8764098872064;1018.4754851251612;1020.3622735790132;1028.2647906746713;1035.9015893490107;1046.827273499864;5903.409659034062;5912.793052243151;5913.9112913306335;5932.940670593325;5964.880702385928;6098.874641965377;6304.495640348761;6310.716017779211;6344.111824344595;6352.396522330371;5852.473277405054;5880.647161170344;5885.176075349455;5891.055951535983;5917.260342457193;3322.451795453723;3354.2452948086484;3355.580552430946;3360.1599600099976;3366.4108780963234;6328.17733694626;6507.446867016262;6637.435817955431;6666.100076489709;6666.166729158856;6485.221773387224;6507.186601674791;6541.542092053605;6542.476601871839;6549.410553050248;6307.274663413675;6550.574212676161;6571.34286571339;6604.14146160996;6669.699863506057;6301.369863013845;6312.873742525216;6318.557700961072;6344.143540622142;6356.523260755369;6018.608790428608;6260.186175797117;6267.1539342188225;6315.336889626523;6315.368463153648;6294.874102517832;6371.39471750183;6385.87228255423;6525.184351956005;6557.540972132096;4842.927356089591;4889.975550122369;4917.041176970456;4923.778429970588;4931.408231012301;6155.507559395148;6281.528885333527;6376.649284289409;6395.42441180296;6397.584157029778;6157.722902469489;6165.876682466415;6185.752569897154;6202.4417802398;6215;5968.462838344396;6158.107074474266;6164.551330437254;6208.441240288395;6209.130721699056;6143.662098584621;6173.178912220816;6180.938190618036;6193.690315484298;6199.938000619936;6155.169052178077;6208.286047104641;6229.750809967732;6232.906506402498;6233.501319894307;5750.137479378127;5929.644221346733;5974.581779275409;5995.160677505066;6051.969740151271 06:17:41 INFO - PID 16546 | |5;yui.html;856.9982457088665;877.0308808766313;879.5778026547262;882.9514376709278;891.2424439226656;14755.336009879555;15557.844421555781;15560.610984725388;15561.688766224668;15572.844271557282;16087;16869.74695379567;17099.57251068721;17101.486955391327;17127.31490740372;1001.7095042437684;1033.0908800255802;1033.5090831854884;1034.3948789957883;1035.4615599888054;953.7138858342504;1023.4166525080707;1034.6947650443099;1036.6579028920476;1037.4086770540757;1084.4577711144427;1085.8968398002178;1087.2335003822286;1087.526925787285;1088.3306766338685;1071.4428497181423;1078.6925726168004;1081.1404933078181;1081.967540973772;1084.376483521974;790.1979490816825;794.6265255329986;796.9083555391088;797.1112209885994;797.1749239537052;15799.131047792367;15853.682926341524;15887.761683574756;16631.002139871645;16854.157292135344;18383.90808045951;18494.16776245072;18536.62926741471;18615.162317695736;18901;14487.71024579513;14693.92653036728;14697.77953330701;14839.332230049673;14878;3422.110251334671;3438.6045604755523;3445.3798316303055;3446.5002574626787;3449.448088305859;93625;93799;94988.52505737427;95100;95515.52242238744;14112.435502579987;14201.644958875904;14335.211563363906;14355;14371.640708982359;26044.08845690392;26286.6057009145;26461.338466538105;26602;26667.86666066696;7899.289063984269;7950.6422211000645;7967.960160199162;7975.8404831903035;8272.462289951134;3981.0843505993785;4085.3259212230246;4086.0806318578084;4087.8773636790943;4094.344904815215;4285.528591854893;4314.201872653569;4337.696361254745;4345.760983145894;4356.172327257811;880.4937161132247;896.8609865470862;898.3217670658742;898.3352319283683;899.2895612466209;713.3045280851233;714.1323292200002;723.8552289542113;731.1226528166222;754.5435011817772;10623.52194151265;11252.66242012741;11574.71063223426;11633.76732465346;12143.574974875837;719.4460265595462;733.4059411876398;745.2956955676942;755.5731011978214;761.0296871488786;5184.300119483897;5372;5402.189671549299;5405.21624364465;5477.014137455217;81291.59354203191;84412;84886;84987;85444.57277713696;71156.64421677859;71607.64196178986;72026;74163.62918185374;74623;63608;64795;64977.35022649808;67070.32929670738;67534.99999999901;10106.14097801695;10175.236857235588;10233.283670143019;10344.637937672145;10400.323978941344;36509;36916.261674766894;37603;37907;38083;43462.56537434712;44192;44377;44961.1007779836;45920;17116.572085697957;17653.205605747517;17659.293628254727;17738.467845964642;17832.10839457996;18349.541261468035;19079.427617170953;19237.711434328216;19306;19474;15384.307706153473;16043.919780401024;16093.275802588678;16524.504264872074;16952.237149328557;15741.763873542135;15787.447439339569;15812.367505299659;15873.603159921095;16103.67792644117;15975.28111234974;16120.113393763455;16187.67624647477;16303.103329317002;16465.91767041157;13165.144265622705;13329;13347.799783003456;13365;13481.797773033608;13296.534621288596;13456.192628442324;13694.93152534231;13706.52027179044;13706.794398083837 06:17:41 INFO - PID 16546 | __end_tp_report 06:17:41 INFO - PID 16546 | __start_cc_report 06:17:41 INFO - PID 16546 | _x_x_mozilla_cycle_collect,1073 06:17:41 INFO - PID 16546 | __end_cc_report 06:17:41 INFO - PID 16546 | __startTimestamp1494335861211__endTimestamp 06:17:41 INFO - PID 16546 | 06:17:41 INFO - PID 16546 | ------- Summary: start ------- 06:17:41 INFO - PID 16546 | Number of tests: 6 06:17:41 INFO - PID 16546 | 06:17:41 INFO - PID 16546 | [#0] dojo.html Cycles:165 Average:5852.85 Median:6075.06 stddev:709.22 (11.7%) stddev-sans-first:682.49 06:17:41 INFO - PID 16546 | Values: 3298.1 3341.0 3352.3 3368.3 3383.3 5670.5 5837.4 5839.6 5868.1 5874.6 5880.3 5899.6 5931.1 5965.3 5986.0 4751.3 5062.9 5196.7 5243.2 5247.2 5202.0 5259.0 5309.3 5325.6 5328.9 5072.7 5162.6 5211.2 5281.0 5292.1 5233.2 5242.2 5243.9 5246.9 5293.4 5198.9 5241.2 5243.7 5249.3 5268.8 5677.2 5749.6 5775.7 5777.8 5889.9 6167.0 6313.9 6390.0 6395.7 6402.6 6364.1 6366.4 6370.5 6376.6 6382.2 5839.9 5849.6 5902.4 5905.1 5912.4 6231.2 6317.4 6406.7 6559.1 6565.7 6058.2 6095.7 6144.8 6208.6 6214.2 6260.7 6354.6 6386.3 6399.3 6401.0 6377.3 6382.5 6388.0 6388.1 6389.5 6112.0 6198.3 6313.3 6329.3 6369.1 4776.7 4806.4 4815.2 4846.2 4859.4 4242.3 4281.8 4289.1 4310.7 4318.9 5795.6 5866.9 5877.4 5965.3 5968.7 6159.8 6220.7 6432.0 6451.8 6452.0 5994.7 5995.9 6003.0 6004.2 6008.0 5547.3 5549.2 5552.9 5555.5 5556.0 6408.3 6437.9 6585.1 6707.4 6719.2 6429.5 6472.6 6476.3 6477.9 6483.6 6624.6 6707.5 6741.0 6744.5 6752.8 6075.6 6110.3 6162.0 6282.0 6294.2 6328.6 6340.6 6366.3 6393.1 6394.3 6060.3 6134.7 6134.9 6202.3 6202.5 6063.4 6218.5 6258.1 6258.2 6266.8 6019.9 6080.9 6110.3 6194.9 6218.9 6257.8 6258.3 6261.2 6286.5 6296.0 6061.7 6063.8 6064.8 6075.1 6089.4 06:17:41 INFO - PID 16546 | 06:17:41 INFO - PID 16546 | [#1] ext.html Cycles:180 Average:37792.64 Median:17756.64 stddev:56875.79 (320.3%) stddev-sans-first:56967.34 06:17:41 INFO - PID 16546 | Values: 749.9 802.8 828.4 1090.8 1105.4 29909.6 30820.7 30832.8 37077.8 37866.4 39356.2 39712.0 39818.2 39829.6 39859.0 5653.4 7168.7 7305.2 7308.6 7311.6 5782.7 5887.8 5890.1 7068.4 7272.7 7360.6 7401.5 7406.7 7410.1 7417.6 7314.6 7346.1 7373.3 7375.9 7377.4 5639.8 5805.0 6970.8 7212.4 7227.1 35945.0 36218.6 36272.5 36279.1 36286.6 3442.6 3483.4 3486.7 3487.9 3491.7 28198.0 28271.2 28275.6 28417.4 28464.6 3646.7 3648.3 3650.7 3651.8 3663.2 180225.0 180269.0 180756.0 180990.0 181080.0 47450.8 47623.0 47631.8 47637.3 47654.5 49609.3 49710.0 49711.8 49801.3 49903.3 14376.6 14416.6 14468.9 14477.7 14490.2 11631.5 11652.2 11655.6 11659.2 11673.9 11751.0 11837.0 14610.9 14747.8 14978.2 5840.2 5902.0 5991.3 6014.2 6059.5 1037.4 1068.0 1070.5 1083.5 1085.4 26961.6 26998.8 27171.6 27188.7 27219.5 1149.7 1160.4 1161.5 1163.3 1193.2 13515.7 13638.9 13727.7 13942.4 13947.9 260172.0 261952.0 262034.0 262067.0 262164.0 52844.0 53313.7 53321.5 53346.7 53362.5 1454.1 1464.4 1479.0 1499.2 1506.3 24204.2 25449.6 25657.4 25696.4 25771.1 38904.4 39291.0 39312.8 39321.4 39354.2 203937.0 205442.0 206022.0 206041.0 206213.0 29682.4 34845.8 35185.6 35240.3 35241.9 35878.1 41391.2 41956.8 42171.6 42199.8 29212.6 30965.0 31108.4 31143.5 32070.7 30406.4 30631.0 30664.2 30954.5 31697.2 35654.0 36102.0 36154.0 36259.0 36546.5 29499.4 29594.6 29910.4 29940.4 30291.1 23100.3 24716.9 24785.6 24893.3 24979.8 06:17:41 INFO - PID 16546 | 06:17:41 INFO - PID 16546 | [#2] jquery.html Cycles:180 Average:30930.63 Median:2197.16 stddev:83920.30 (3819.5%) stddev-sans-first:84124.49 06:17:41 INFO - PID 16546 | Values: 436.2 436.9 444.6 457.3 462.6 18724.3 19523.0 19929.7 20087.7 20119.3 21058.7 21804.1 21848.7 22005.6 22675.0 5284.4 5505.7 5522.9 5525.3 5533.4 5375.0 5442.5 5473.9 5495.6 5507.9 5439.5 5455.6 5468.7 5468.8 5468.9 5265.3 5426.6 5447.9 5461.5 5464.1 4977.3 4986.3 4988.1 4998.5 4998.7 24948.8 25323.9 25387.7 25492.5 25503.4 2146.1 2177.7 2179.6 2180.5 2181.5 16518.9 17326.9 17363.2 17459.0 17465.5 2131.7 2162.6 2200.2 2228.6 2244.4 91602.0 93879.5 115516.4 115966.4 116547.4 12339.8 12401.2 12480.3 12486.8 12730.7 17844.9 17911.6 17995.6 18003.1 18025.0 8809.6 9002.5 9071.0 9164.1 9177.6 8184.9 8193.9 8246.3 8453.3 8462.2 7880.7 7932.5 7985.3 8131.6 8185.3 2113.5 2185.6 2194.6 2199.8 2214.6 1047.0 1052.5 1056.4 1074.9 1075.6 19505.3 21055.9 21061.3 21294.4 21381.1 1080.8 1084.6 1097.4 1102.5 1104.4 10557.8 11457.4 11473.0 11553.4 11614.6 501113.0 502708.0 504920.0 511977.0 512216.0 82329.6 92315.5 95545.0 97471.5 98203.0 1212.8 1227.9 1265.4 1267.7 1270.7 20574.1 20628.9 20998.0 21098.2 21393.7 43432.5 43993.3 44111.6 44311.3 44848.8 54058.5 56577.4 57459.4 57832.7 58572.0 8626.3 8641.2 8756.2 8821.3 8866.1 12176.1 12183.5 12388.8 12556.0 12664.9 11794.5 11887.6 12016.6 12052.6 12429.6 10063.4 10187.9 10241.3 10276.4 10428.7 11184.7 11297.4 11775.8 11850.8 11867.1 8910.3 9001.4 9100.7 9315.5 9388.0 11385.3 11428.9 11622.4 11714.0 11809.1 06:17:41 INFO - PID 16546 | 06:17:41 INFO - PID 16546 | [#3] mootools.html Cycles:180 Average:7120.18 Median:3964.06 stddev:4579.47 (115.5%) stddev-sans-first:4571.85 06:17:41 INFO - PID 16546 | Values: 1358.3 1400.8 1419.2 1420.1 1423.1 10620.0 11196.0 11257.7 11258.2 11264.3 10777.6 11339.1 11361.8 11375.5 11378.0 2315.4 2354.5 2355.0 2359.5 2362.6 2011.5 2301.7 2363.3 2373.5 2374.7 2009.9 2243.8 2312.7 2332.4 2335.1 2275.4 2305.4 2310.6 2311.0 2314.2 2270.8 2278.3 2285.1 2286.5 2288.6 11048.9 11197.2 11213.0 11249.7 11260.7 6195.7 6404.9 6409.3 6413.2 6415.7 3857.8 4070.3 4122.6 4140.2 4181.7 1355.3 1362.3 1408.5 1419.1 1422.5 16676.6 16772.9 16785.4 16793.5 16795.6 5255.4 5291.8 5372.8 5449.6 5521.3 12021.9 12023.1 12027.5 12027.8 12035.1 6298.2 6310.0 6315.2 6318.8 6319.9 5865.4 5933.3 5965.0 5971.9 6010.4 4191.5 4223.2 4277.2 4301.0 4354.6 1107.5 1155.7 1210.5 1252.2 1262.6 846.4 866.8 881.4 890.5 907.6 6839.6 7012.8 7035.5 7065.4 7288.5 638.7 640.4 647.1 647.3 755.5 4498.6 4504.7 4555.2 4560.0 4714.3 14947.3 15375.6 15540.7 15560.0 15567.5 14703.0 15308.4 15309.8 15339.2 15385.5 9291.4 9439.1 9457.5 9466.0 9536.2 6933.4 7197.7 7221.5 7267.6 7337.2 13236.7 13306.3 13332.3 13686.0 13714.9 13654.2 13803.7 13811.7 13916.0 13990.0 9517.8 9540.1 9563.2 9625.7 9648.4 10291.7 10330.4 10376.5 10383.4 10392.1 9183.6 9276.7 9360.0 9425.9 9538.0 9136.0 9170.9 9195.5 9319.2 9368.9 8355.7 8524.6 8525.1 8545.1 8551.8 5517.8 5584.4 5589.6 5722.3 5892.2 5700.9 5732.1 5740.5 5834.1 5916.1 06:17:41 INFO - PID 16546 | 06:17:41 INFO - PID 16546 | [#4] prototype.html Cycles:180 Average:5146.71 Median:5843.49 stddev:1535.59 (26.3%) stddev-sans-first:1498.31 06:17:41 INFO - PID 16546 | Values: 417.4 421.2 423.1 428.9 431.3 5637.9 5764.6 5797.6 5816.9 5834.5 5578.9 5626.9 5710.4 5722.3 5761.9 4276.4 4370.1 4405.9 4419.9 4427.2 4400.6 4405.2 4405.6 4411.4 4421.7 4374.3 4377.1 4380.2 4403.3 4403.9 4324.6 4352.4 4382.0 4398.5 4401.3 3821.5 3828.1 3832.5 3835.1 3838.2 5650.7 5652.9 5653.3 5653.8 5684.4 5092.5 5111.4 5139.5 5141.0 5146.3 6091.2 6110.7 6112.9 6113.3 6115.2 4323.2 4324.6 4326.1 4326.4 4332.1 6110.6 6238.0 6256.2 6433.8 6451.7 4285.7 4364.6 4368.6 4398.8 4409.8 4472.7 4476.5 4480.4 4482.9 4485.1 4853.2 4898.4 5130.0 5133.4 5152.5 6083.3 6125.3 6129.2 6135.0 6148.0 1517.6 1534.8 1537.3 1543.5 1544.9 1018.5 1020.4 1028.3 1035.9 1046.8 5903.4 5912.8 5913.9 5932.9 5964.9 6098.9 6304.5 6310.7 6344.1 6352.4 5852.5 5880.6 5885.2 5891.1 5917.3 3322.5 3354.2 3355.6 3360.2 3366.4 6328.2 6507.4 6637.4 6666.1 6666.2 6485.2 6507.2 6541.5 6542.5 6549.4 6307.3 6550.6 6571.3 6604.1 6669.7 6301.4 6312.9 6318.6 6344.1 6356.5 6018.6 6260.2 6267.2 6315.3 6315.4 6294.9 6371.4 6385.9 6525.2 6557.5 4842.9 4890.0 4917.0 4923.8 4931.4 6155.5 6281.5 6376.6 6395.4 6397.6 6157.7 6165.9 6185.8 6202.4 6215.0 5968.5 6158.1 6164.6 6208.4 6209.1 6143.7 6173.2 6180.9 6193.7 6199.9 6155.2 6208.3 6229.8 6232.9 6233.5 5750.1 5929.6 5974.6 5995.2 6052.0 06:17:41 INFO - PID 16546 | 06:17:41 INFO - PID 16546 | [#5] yui.html Cycles:180 Average:19127.82 Median:19158.57 stddev:23812.74 (124.3%) stddev-sans-first:23840.01 06:17:41 INFO - PID 16546 | Values: 857.0 877.0 879.6 883.0 891.2 14755.3 15557.8 15560.6 15561.7 15572.8 16087.0 16869.7 17099.6 17101.5 17127.3 1001.7 1033.1 1033.5 1034.4 1035.5 953.7 1023.4 1034.7 1036.7 1037.4 1084.5 1085.9 1087.2 1087.5 1088.3 1071.4 1078.7 1081.1 1082.0 1084.4 790.2 794.6 796.9 797.1 797.2 15799.1 15853.7 15887.8 16631.0 16854.2 18383.9 18494.2 18536.6 18615.2 18901.0 14487.7 14693.9 14697.8 14839.3 14878.0 3422.1 3438.6 3445.4 3446.5 3449.4 93625.0 93799.0 94988.5 95100.0 95515.5 14112.4 14201.6 14335.2 14355.0 14371.6 26044.1 26286.6 26461.3 26602.0 26667.9 7899.3 7950.6 7968.0 7975.8 8272.5 3981.1 4085.3 4086.1 4087.9 4094.3 4285.5 4314.2 4337.7 4345.8 4356.2 880.5 896.9 898.3 898.3 899.3 713.3 714.1 723.9 731.1 754.5 10623.5 11252.7 11574.7 11633.8 12143.6 719.4 733.4 745.3 755.6 761.0 5184.3 5372.0 5402.2 5405.2 5477.0 81291.6 84412.0 84886.0 84987.0 85444.6 71156.6 71607.6 72026.0 74163.6 74623.0 63608.0 64795.0 64977.4 67070.3 67535.0 10106.1 10175.2 10233.3 10344.6 10400.3 36509.0 36916.3 37603.0 37907.0 38083.0 43462.6 44192.0 44377.0 44961.1 45920.0 17116.6 17653.2 17659.3 17738.5 17832.1 18349.5 19079.4 19237.7 19306.0 19474.0 15384.3 16043.9 16093.3 16524.5 16952.2 15741.8 15787.4 15812.4 15873.6 16103.7 15975.3 16120.1 16187.7 16303.1 16465.9 13165.1 13329.0 13347.8 13365.0 13481.8 13296.5 13456.2 13694.9 13706.5 13706.8 06:17:41 INFO - PID 16546 | -------- Summary: end -------- 06:17:41 INFO - PID 16546 | 06:17:41 INFO - TEST-INFO | 16546: exit 0 06:17:42 INFO - TEST-OK | dromaeo_css | took 1115481ms 06:17:42 INFO - TEST-START | kraken 06:17:42 INFO - operating with platform_type : linux_ 06:17:42 INFO - Initialising browser for kraken test... 06:17:42 INFO - TEST-INFO | started process 16883 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkVp68F/profile http://localhost:32856/getInfo.html) 06:17:46 INFO - PID 16883 | __metrics Screen width/height:1600/1200 06:17:46 INFO - PID 16883 | colorDepth:24 06:17:46 INFO - PID 16883 | Browser inner width/height: 1024/695 06:17:46 INFO - PID 16883 | __metrics 06:17:47 INFO - PID 16883 | 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" 06:17:47 INFO - PID 16883 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:17:48 INFO - TEST-INFO | 16883: exit 0 06:17:48 INFO - Browser initialized. 06:17:48 INFO - Running cycle 1/1 for kraken test... 06:17:48 INFO - TEST-INFO | started process 16979 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkVp68F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:18:00 INFO - PID 16979 | RSS: Main: 149667840 06:18:00 INFO - PID 16979 | 06:18:02 INFO - PID 16979 | Cycle 1(1): loaded http://localhost:32856/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32856/tests/kraken/driver.html?testName=audio-beat-detection) 06:18:03 INFO - PID 16979 | RSS: Main: 222212096 06:18:03 INFO - PID 16979 | 06:18:06 INFO - PID 16979 | Cycle 1(1): loaded http://localhost:32856/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32856/tests/kraken/driver.html?testName=audio-dft) 06:18:06 INFO - PID 16979 | RSS: Main: 183136256 06:18:06 INFO - PID 16979 | 06:18:09 INFO - PID 16979 | Cycle 1(1): loaded http://localhost:32856/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32856/tests/kraken/driver.html?testName=audio-fft) 06:18:10 INFO - PID 16979 | RSS: Main: 263868416 06:18:10 INFO - PID 16979 | 06:18:12 INFO - PID 16979 | Cycle 1(1): loaded http://localhost:32856/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32856/tests/kraken/driver.html?testName=audio-oscillator) 06:18:12 INFO - PID 16979 | RSS: Main: 174764032 06:18:12 INFO - PID 16979 | 06:18:14 INFO - PID 16979 | Cycle 1(1): loaded http://localhost:32856/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32856/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:18:15 INFO - PID 16979 | RSS: Main: 178487296 06:18:15 INFO - PID 16979 | 06:18:18 INFO - PID 16979 | Cycle 1(1): loaded http://localhost:32856/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32856/tests/kraken/driver.html?testName=imaging-darkroom) 06:18:18 INFO - PID 16979 | RSS: Main: 239710208 06:18:18 INFO - PID 16979 | 06:18:22 INFO - PID 16979 | Cycle 1(1): loaded http://localhost:32856/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32856/tests/kraken/driver.html?testName=imaging-desaturate) 06:18:22 INFO - PID 16979 | RSS: Main: 262008832 06:18:22 INFO - PID 16979 | 06:18:25 INFO - PID 16979 | Cycle 1(1): loaded http://localhost:32856/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32856/tests/kraken/driver.html?testName=json-parse-financial) 06:18:26 INFO - PID 16979 | RSS: Main: 279023616 06:18:26 INFO - PID 16979 | 06:18:27 INFO - PID 16979 | Cycle 1(1): loaded http://localhost:32856/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32856/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:28 INFO - PID 16979 | RSS: Main: 202940416 06:18:28 INFO - PID 16979 | 06:18:29 INFO - PID 16979 | Cycle 1(1): loaded http://localhost:32856/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32856/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:18:30 INFO - PID 16979 | RSS: Main: 208433152 06:18:30 INFO - PID 16979 | 06:18:32 INFO - PID 16979 | Cycle 1(1): loaded http://localhost:32856/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32856/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:18:33 INFO - PID 16979 | RSS: Main: 216899584 06:18:33 INFO - PID 16979 | 06:18:35 INFO - PID 16979 | Cycle 1(1): loaded http://localhost:32856/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:18:36 INFO - PID 16979 | RSS: Main: 226643968 06:18:36 INFO - PID 16979 | 06:18:39 INFO - PID 16979 | Cycle 1(1): loaded http://localhost:32856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:18:39 INFO - PID 16979 | RSS: Main: 221757440 06:18:39 INFO - PID 16979 | 06:18:41 INFO - PID 16979 | Cycle 1(1): loaded http://localhost:32856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32856/tests/kraken/driver.html?testName=ai-astar) 06:18:41 INFO - PID 16979 | RSS: Main: 272166912 06:18:41 INFO - PID 16979 | 06:18:41 INFO - PID 16979 | __start_tp_report 06:18:41 INFO - PID 16979 | _x_x_mozilla_page_load 06:18:41 INFO - PID 16979 | _x_x_mozilla_page_load_details 06:18:41 INFO - PID 16979 | |i|pagename|runs| 06:18:41 INFO - PID 16979 | |0;ai-astar;108;110;109;109;110;110;109;109;111;110 06:18:41 INFO - PID 16979 | |1;audio-beat-detection;145;120;122;179;118;116;117;116;141;122 06:18:41 INFO - PID 16979 | |2;audio-dft;161;162;161;161;161;160;159;160;160;161 06:18:41 INFO - PID 16979 | |3;audio-fft;74;73;72;109;74;74;73;75;102;75 06:18:41 INFO - PID 16979 | |4;audio-oscillator;82;83;107;83;84;81;97;81;82;109 06:18:41 INFO - PID 16979 | |5;imaging-gaussian-blur;113;114;113;113;113;112;113;113;113;113 06:18:41 INFO - PID 16979 | |6;imaging-darkroom;148;148;147;148;148;147;146;148;149;147 06:18:41 INFO - PID 16979 | |7;imaging-desaturate;94;94;94;94;94;94;95;94;94;94 06:18:41 INFO - PID 16979 | |8;json-parse-financial;46;46;47;46;47;46;47;48;47;48 06:18:41 INFO - PID 16979 | |9;json-stringify-tinderbox;55;55;54;55;57;55;55;55;54;54 06:18:41 INFO - PID 16979 | |10;stanford-crypto-aes;81;81;80;82;86;83;82;81;82;81 06:18:41 INFO - PID 16979 | |11;stanford-crypto-ccm;135;125;123;125;122;124;123;137;183;127 06:18:41 INFO - PID 16979 | |12;stanford-crypto-pbkdf2;183;184;174;183;189;176;187;182;185;172 06:18:41 INFO - PID 16979 | |13;stanford-crypto-sha256-iterative;66;64;76;64;66;66;66;64;64;65 06:18:41 INFO - PID 16979 | __end_tp_report 06:18:41 INFO - PID 16979 | __start_cc_report 06:18:41 INFO - PID 16979 | _x_x_mozilla_cycle_collect,1668 06:18:41 INFO - PID 16979 | __end_cc_report 06:18:41 INFO - PID 16979 | __startTimestamp1494335921807__endTimestamp 06:18:41 INFO - PID 16979 | 06:18:41 INFO - PID 16979 | ------- Summary: start ------- 06:18:41 INFO - PID 16979 | Number of tests: 14 06:18:41 INFO - PID 16979 | 06:18:41 INFO - PID 16979 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:0.85 (0.8%) stddev-sans-first:0.71 06:18:41 INFO - PID 16979 | Values: 108.0 110.0 109.0 109.0 110.0 110.0 109.0 109.0 111.0 110.0 06:18:41 INFO - PID 16979 | 06:18:41 INFO - PID 16979 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:122.00 stddev:20.22 (16.6%) stddev-sans-first:20.66 06:18:41 INFO - PID 16979 | Values: 145.0 120.0 122.0 179.0 118.0 116.0 117.0 116.0 141.0 122.0 06:18:41 INFO - PID 16979 | 06:18:41 INFO - PID 16979 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.84 (0.5%) stddev-sans-first:0.88 06:18:41 INFO - PID 16979 | Values: 161.0 162.0 161.0 161.0 161.0 160.0 159.0 160.0 160.0 161.0 06:18:41 INFO - PID 16979 | 06:18:41 INFO - PID 16979 | [#3] audio-fft Cycles:10 Average:80.10 Median:74.00 stddev:13.52 (18.3%) stddev-sans-first:14.16 06:18:41 INFO - PID 16979 | Values: 74.0 73.0 72.0 109.0 74.0 74.0 73.0 75.0 102.0 75.0 06:18:41 INFO - PID 16979 | 06:18:41 INFO - PID 16979 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:82.50 stddev:11.11 (13.5%) stddev-sans-first:11.50 06:18:41 INFO - PID 16979 | Values: 82.0 83.0 107.0 83.0 84.0 81.0 97.0 81.0 82.0 109.0 06:18:41 INFO - PID 16979 | 06:18:41 INFO - PID 16979 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:113.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 06:18:41 INFO - PID 16979 | Values: 113.0 114.0 113.0 113.0 113.0 112.0 113.0 113.0 113.0 113.0 06:18:41 INFO - PID 16979 | 06:18:41 INFO - PID 16979 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 06:18:41 INFO - PID 16979 | Values: 148.0 148.0 147.0 148.0 148.0 147.0 146.0 148.0 149.0 147.0 06:18:41 INFO - PID 16979 | 06:18:41 INFO - PID 16979 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:18:41 INFO - PID 16979 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 06:18:41 INFO - PID 16979 | 06:18:41 INFO - PID 16979 | [#8] json-parse-financial Cycles:10 Average:46.80 Median:47.00 stddev:0.79 (1.7%) stddev-sans-first:0.78 06:18:41 INFO - PID 16979 | Values: 46.0 46.0 47.0 46.0 47.0 46.0 47.0 48.0 47.0 48.0 06:18:41 INFO - PID 16979 | 06:18:41 INFO - PID 16979 | [#9] json-stringify-tinderbox Cycles:10 Average:54.90 Median:55.00 stddev:0.88 (1.6%) stddev-sans-first:0.93 06:18:41 INFO - PID 16979 | Values: 55.0 55.0 54.0 55.0 57.0 55.0 55.0 55.0 54.0 54.0 06:18:41 INFO - PID 16979 | 06:18:41 INFO - PID 16979 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:1.66 (2.0%) stddev-sans-first:1.73 06:18:41 INFO - PID 16979 | Values: 81.0 81.0 80.0 82.0 86.0 83.0 82.0 81.0 82.0 81.0 06:18:41 INFO - PID 16979 | 06:18:41 INFO - PID 16979 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:126.00 stddev:18.51 (14.7%) stddev-sans-first:19.61 06:18:41 INFO - PID 16979 | Values: 135.0 125.0 123.0 125.0 122.0 124.0 123.0 137.0 183.0 127.0 06:18:41 INFO - PID 16979 | 06:18:41 INFO - PID 16979 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.50 Median:183.50 stddev:5.64 (3.1%) stddev-sans-first:5.96 06:18:41 INFO - PID 16979 | Values: 183.0 184.0 174.0 183.0 189.0 176.0 187.0 182.0 185.0 172.0 06:18:41 INFO - PID 16979 | 06:18:41 INFO - PID 16979 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:3.60 (5.5%) stddev-sans-first:3.82 06:18:41 INFO - PID 16979 | Values: 66.0 64.0 76.0 64.0 66.0 66.0 66.0 64.0 64.0 65.0 06:18:41 INFO - PID 16979 | -------- Summary: end -------- 06:18:41 INFO - PID 16979 | 06:18:43 INFO - TEST-INFO | 16979: exit 0 06:18:43 INFO - TEST-OK | kraken | took 61113ms 06:18:43 INFO - SUITE-END | took 1176s 06:18:43 INFO - Completed test suite (00:19:36) 06:18:43 INFO - javascript benchmark 06:18:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7622.687515755138, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3298.060052884928, 3341.0, 3352.2625022495045, 3368.326334733054, 3383.323335332934, 5670.461306175906, 5837.38707435719, 5839.6496210227415, 5868.119782032692, 5874.559408044398, 5880.3237627672725, 5899.6165249258875, 5931.051031834907, 5965.284165900087, 5986.0, 4751.31105989633, 5062.873428164288, 5196.714180720059, 5243.239730239113, 5247.16045432729, 5202.0376230397305, 5258.974499972507, 5309.256704061435, 5325.600579956499, 5328.866778330534, 5072.72100034498, 5162.638615296931, 5211.24436956643, 5280.973595132, 5292.126799078147, 5233.21501774733, 5242.23987521811, 5243.895122097537, 5246.921296180561, 5293.444188360244, 5198.896022079575, 5241.240020197089, 5243.737813109367, 5249.343832020997, 5268.762905669254, 5677.233573467612, 5749.626274292157, 5775.711214439261, 5777.826665200051, 5889.8822023559715, 6167.013277875519, 6313.936860631381, 6389.968050159766, 6395.680215989229, 6402.551821372505, 6364.140840986453, 6366.363363663643, 6370.522210834206, 6376.617402955838, 6382.234131904155, 5839.854003649943, 5849.590528662995, 5902.409759024106, 5905.055191169392, 5912.408759124053, 6231.22109736283, 6317.368263173646, 6406.711697973602, 6559.114519539897, 6565.737370505126, 6058.21243238385, 6095.655667372612, 6144.846378840565, 6208.596441231396, 6214.1921550198185, 6260.686965651699, 6354.555181137369, 6386.329435409308, 6399.264084630234, 6401.0, 6377.266614339411, 6382.489400847921, 6388.0, 6388.073729309317, 6389.520785941073, 6111.964830093352, 6198.318184999646, 6313.273973493016, 6329.335419780857, 6369.14016607752, 4776.665633405628, 4806.423229212447, 4815.2054910939305, 4846.176150054499, 4859.441164266084, 4242.257604919127, 4281.764502952367, 4289.0992891492515, 4310.719803212781, 4318.913621727611, 5795.594308398456, 5866.882662346815, 5877.412258774174, 5965.343812180657, 5968.671723055274, 6159.81520554384, 6220.720067596969, 6432.0351947207355, 6451.838704032437, 6452.0, 5994.67029313392, 5995.880082398327, 6003.009503431885, 6004.159417681528, 6007.969960150172, 5547.334319881559, 5549.223108764776, 5552.861178470571, 5555.50000499957, 5555.972220138873, 6408.2630497492455, 6437.871242575122, 6585.078089067439, 6707.429868461236, 6719.160104986877, 6429.517786165963, 6472.579282346821, 6476.255230648536, 6477.935220647733, 6483.610983341015, 6624.635645039376, 6707.496937729592, 6740.966295168493, 6744.527883048139, 6752.763653272112, 6075.574709770273, 6110.26676798787, 6161.969190154021, 6281.96859015702, 6294.15028971083, 6328.557001010069, 6340.556161068866, 6366.299707032315, 6393.1369265148605, 6394.328595497405, 6060.272767267956, 6134.6625935573975, 6134.877302454015, 6202.28673702512, 6202.472789812736, 6063.363346848518, 6218.502519798496, 6258.092576576462, 6258.217722784652, 6266.811995640138, 6019.909701354571, 6080.908786368296, 6110.297315808739, 6194.938050619436, 6218.875622487615, 6257.812265632038, 6258.342873998165, 6261.24865016201, 6286.497080233662, 6295.96852015737, 6061.727222275096, 6063.818085457443, 6064.7877324295205, 6075.058365953284, 6089.360617135314], "value": 5802.338537108352, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.9362554182894, 802.8233788566515, 828.3787159630277, 1090.8472813806075, 1105.36441546111, 29909.55135672964, 30820.691793082035, 30832.84583577082, 37077.81461092691, 37866.43200351997, 39356.212875742465, 39712.0, 39818.20363592726, 39829.60170398295, 39859.0, 5653.434656534334, 7168.749093781718, 7305.196428392873, 7308.5614863108385, 7311.634418279092, 5782.710864456782, 5887.8233652990475, 5890.145928840316, 7068.39918606919, 7272.745453909114, 7360.558366498, 7401.481896267236, 7406.703731850719, 7410.110786705576, 7417.629118544078, 7314.634268286564, 7346.081739782528, 7373.33639972405, 7375.926240737631, 7377.446691498106, 5639.774409023634, 5805.0, 6970.79087627372, 7212.350888420067, 7227.096612923385, 35945.0, 36218.63781362205, 36272.45591316132, 36279.09302267464, 36286.63713362859, 3442.604100528421, 3483.3555792178527, 3486.6687664672068, 3487.930241395183, 3491.7032052275586, 28198.0, 28271.15186544407, 28275.57586636202, 28417.431651367064, 28464.573031404547, 3646.6535679110443, 3648.3068217038676, 3650.653187947141, 3651.7991510466913, 3663.1757854482794, 180225.0, 180269.0, 180756.0, 180990.0, 181079.9999999987, 47450.76274618605, 47623.0, 47631.76184119057, 47637.28544071842, 47654.5234547657, 49609.25586116211, 49710.0, 49711.75144124256, 49801.25298120531, 49903.25145122826, 14376.634219749107, 14416.567502974927, 14468.927655361656, 14477.710445791025, 14490.203038832755, 11631.53473861053, 11652.242604230698, 11655.59205427806, 11659.24214926044, 11673.941630291794, 11751.0, 11837.0, 14610.926945365418, 14747.77878331826, 14978.17620030887, 5840.153177789197, 5901.996660567714, 5991.310999235056, 6014.1580178775, 6059.4546490815155, 1037.4397825174321, 1067.9946600266949, 1070.4540684250933, 1083.5232497700986, 1085.4193006741355, 26961.59557606598, 26998.802680802433, 27171.592426113624, 27188.728112719014, 27219.455610888068, 1149.735560821016, 1160.3733983648735, 1161.4691338331547, 1163.2962057954985, 1193.176708071428, 13515.729685406237, 13638.93180534091, 13727.656808579866, 13942.37259323333, 13947.930260348836, 260172.0, 261952.0, 262034.0, 262067.0, 262164.0, 52844.0, 53313.73343133259, 53321.46678533243, 53346.73326633342, 53362.466375336524, 1454.127523485921, 1464.436192066041, 1478.9556313310618, 1499.2204053892133, 1506.3221550302408, 24204.15285465, 25449.61825572655, 25657.358566035997, 25696.357591060372, 25771.098011569506, 38904.41643375295, 39291.0, 39312.803435982634, 39321.41017884791, 39354.2129157421, 203937.0, 205442.0, 206022.0, 206041.0, 206213.0, 29682.40635187241, 34845.825770870986, 35185.648143518236, 35240.295194096485, 35241.94274171779, 35878.103047424025, 41391.1721765569, 41956.79021604872, 42171.57828421677, 42199.7890010548, 29212.56181157327, 30965.0, 31108.377832443675, 31143.532847007766, 32070.67929320677, 30406.391872162876, 30631.0, 30664.233394165323, 30954.53568196524, 31697.207569810016, 35654.0, 36102.0, 36154.0, 36259.0, 36546.45180322351, 29499.410011799213, 29594.556081659222, 29910.401791964476, 29940.401191976474, 30291.091267262018, 23100.306990790305, 24716.876415617808, 24785.62821557642, 24893.253202403957, 24979.845331581357], "value": 16682.23147890886, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.2256993835941, 436.9104333611606, 444.6131865277209, 457.3368615507513, 462.55132521454186, 18724.25102995882, 19523.0, 19929.701054484194, 20087.694299870516, 20119.29582464614, 21058.684119738216, 21804.127834886625, 21848.672269915965, 22005.559888802214, 22675.0, 5284.44513326101, 5505.6696598204035, 5522.889542209174, 5525.309336332958, 5533.446655334475, 5375.039324075312, 5442.455754424545, 5473.890522189554, 5495.6153069285165, 5507.889842203153, 5439.5104440600335, 5455.563554915597, 5468.671879687212, 5468.781248750045, 5468.890622187554, 5265.289185959904, 5426.565874730012, 5447.945520544784, 5461.481159289861, 5464.0711079116645, 4977.253411988195, 4986.252062190664, 4988.127077761414, 4998.525434996648, 4998.675086119427, 24948.750512494826, 25323.873380633162, 25387.746122538723, 25492.490150196893, 25503.36241593975, 2146.0557354763855, 2177.7277840269967, 2179.5967745967046, 2180.5420861619077, 2181.4655409424636, 16518.917405412896, 17326.913365433218, 17363.21865516055, 17459.0, 17465.47603571882, 2131.690904818808, 2162.556675881456, 2200.2189222825828, 2228.5542891421783, 2244.438890277431, 91602.0, 93879.53060234724, 115516.42241788821, 115966.42016789946, 116547.41726291315, 12339.75320493585, 12401.193922395016, 12480.251184928933, 12486.75026499465, 12730.68173295675, 17844.91077544604, 17911.641767164583, 17995.640087198182, 18003.0998450077, 18025.0, 8809.647614095364, 9002.549872506479, 9071.0, 9164.129407706258, 9177.632894684139, 8184.877226841602, 8193.918060819435, 8246.340292776564, 8453.323734101257, 8462.19609137131, 7880.684772609146, 7932.492826362973, 7985.321247693895, 8131.59342032896, 8185.3042491387705, 2113.492761737172, 2185.606590813669, 2194.5610877824497, 2199.7580266170708, 2214.6013717531, 1046.9738256543494, 1052.494802494807, 1056.3820165203288, 1074.9408782517037, 1075.639660713654, 19505.317313893946, 21055.8947205263, 21061.262855799974, 21294.36116916495, 21381.144754209967, 1080.8108580998294, 1084.6312253833576, 1097.3690128176172, 1102.5424448853637, 1104.364990130662, 10557.841632375521, 11457.427128643534, 11473.0, 11553.36456494884, 11614.593489227836, 501113.0, 502708.0, 504920.0, 511977.0, 512216.0, 82329.58835205785, 92315.53842230747, 95545.0, 97471.51264243634, 98203.0, 1212.8423304970474, 1227.8526576810661, 1265.4052595280205, 1267.7211013577182, 1270.7394984028251, 20574.074166662238, 20628.896855515628, 20998.0, 21098.156073756876, 21393.67909481328, 43432.49565165217, 43993.340099899164, 44111.55888441075, 44311.33532996943, 44848.77575612101, 54058.45941540534, 56577.43422565722, 57459.42540574541, 57832.71083644723, 58572.0, 8626.309895208242, 8641.222289993932, 8756.168164024408, 8821.294296456139, 8866.113388661082, 12176.147669663038, 12183.512659493876, 12388.81416778731, 12556.0, 12664.873351266739, 11794.46924888365, 11887.643370698894, 12016.579419720269, 12052.578159764365, 12429.627111186679, 10063.446510441996, 10187.949060254652, 10241.334313269614, 10276.383416995004, 10428.739281518023, 11184.664460066211, 11297.378644174649, 11775.76448471043, 11850.822237666269, 11867.109966752356, 8910.287177025693, 9001.36990410665, 9100.726978190665, 9315.487648179414, 9388.0, 11385.316880987168, 11428.94285528567, 11622.360770157384, 11714.0, 11809.110542313188], "value": 9931.213171104295, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.3344161360933, 1400.7688731359326, 1419.16978567538, 1420.1337184317565, 1423.1176670464313, 10620.0, 11196.048335891439, 11257.6622701319, 11258.155638327118, 11264.267822591535, 10777.5688972441, 11339.092872570196, 11361.829572556398, 11375.544978200884, 11378.0, 2315.4211447138214, 2354.540864531417, 2355.0, 2359.4573248152933, 2362.598358279088, 2011.4569066352076, 2301.7122859642545, 2363.279199844047, 2373.46597015671, 2374.679418278536, 2009.889456079915, 2243.7644047375034, 2312.710911136108, 2332.416895776056, 2335.1359996801207, 2275.385645875621, 2305.446692793734, 2310.572544079342, 2311.040918019037, 2314.2363020203293, 2270.818334533233, 2278.293728944033, 2285.108807565051, 2286.542691461714, 2288.565172617214, 11048.944755276252, 11197.16021298406, 11213.046891014274, 11249.718757031058, 11260.718482037933, 6195.659238741868, 6404.903926441107, 6409.262934762515, 6413.198350206224, 6415.711292991827, 3857.787821669807, 4070.328395814687, 4122.649574786146, 4140.192662430827, 4181.707280490367, 1355.302019459979, 1362.2984163155982, 1408.528143072072, 1419.0846903747129, 1422.4736847366437, 16676.58308542284, 16772.916135419367, 16785.412510562073, 16793.496195114167, 16795.580110497212, 5255.369355677343, 5291.841244762663, 5372.811951581676, 5449.5640348772, 5521.309836270466, 12021.879781202251, 12023.098267629963, 12027.458764355624, 12027.75944481123, 12035.097367697457, 6298.1812364392335, 6309.968450157719, 6315.210598675166, 6318.810435686937, 6319.9368006320265, 5865.384134665884, 5933.317668468095, 5965.0, 5971.910421343683, 6010.398960103955, 4191.455110835572, 4223.21870453967, 4277.165952639206, 4300.956990430118, 4354.608085272341, 1107.5071593140974, 1155.7110722319421, 1210.509743553862, 1252.2236213547658, 1262.6149024547417, 846.3567688556618, 866.7833041739565, 881.4226681523612, 890.528020149322, 907.5552979040355, 6839.555428897106, 7012.7545535906, 7035.47233957445, 7065.43476521877, 7288.526245794006, 638.6615094000188, 640.4428147511695, 647.0779139725872, 647.2879832184559, 755.4938191411658, 4498.59512643857, 4504.707194032443, 4555.157295900269, 4560.0, 4714.269288260325, 14947.252637368305, 15375.615609609626, 15540.689186216212, 15560.0, 15567.532974010797, 14703.0, 15308.387664493519, 15309.770353444706, 15339.156346401054, 15385.538433847003, 9291.396059256127, 9439.103285187895, 9457.534082217267, 9465.952670236606, 9536.23710103204, 6933.37599616037, 7197.676104575411, 7221.494495385273, 7267.600281984542, 7337.229590892879, 13236.735265294832, 13306.268155251553, 13332.333383330988, 13686.0, 13714.93142534281, 13654.249016304198, 13803.654908627364, 13811.723765524834, 13916.0, 13990.0, 9517.809643807224, 9540.141387275178, 9563.187129094105, 9625.71122866315, 9648.372855764354, 10291.742706432398, 10330.380177189392, 10376.533056012648, 10383.428911409945, 10392.06471417576, 9183.586738596645, 9276.72169834906, 9360.0, 9425.905740942777, 9538.0, 9135.954320228622, 9170.862437063315, 9195.54022298869, 9319.161275484968, 9368.859467107863, 8355.665773368997, 8524.573771311285, 8525.104863989192, 8545.145485451654, 8551.786205344915, 5517.834464966058, 5584.4136365681015, 5589.636673616202, 5722.2561067061015, 5892.204552385373, 5700.914486282626, 5732.111522713986, 5740.483356497935, 5834.066549352084, 5916.142159386779], "value": 5308.043110663344, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.36768795275157, 421.1829051639819, 423.09668856990316, 428.9335153051276, 431.3229716665425, 5637.887242255152, 5764.596478246519, 5797.565182611305, 5816.912746308803, 5834.5040671542865, 5578.86052848679, 5626.943730562693, 5710.428957104287, 5722.284714410699, 5761.942380576193, 4276.42268293781, 4370.082282720632, 4405.933910991338, 4419.9337009944875, 4427.225235583776, 4400.62594679451, 4405.1586726561345, 4405.603495685387, 4411.404460397854, 4421.6904816662845, 4374.300111982067, 4377.146456440995, 4380.189664911985, 4403.3174857897075, 4403.911921761563, 4324.610785029363, 4352.434183556117, 4382.0, 4398.494173170095, 4401.295792673173, 3821.5032045833864, 3828.10039640687, 3832.463455116286, 3835.060410199491, 3838.193979264358, 5650.6892120933335, 5652.943470565283, 5653.349864765563, 5653.802116925888, 5684.37471878093, 5092.523168281194, 5111.361079865017, 5139.537441630234, 5141.048905952373, 5146.327443580813, 6091.208142941434, 6110.663913484756, 6112.877742445126, 6113.296970848321, 6115.235595550556, 4323.156984388045, 4324.567543245682, 4326.069894972596, 4326.437563116806, 4332.133573285324, 6110.63336199825, 6237.968810155966, 6256.249250089927, 6433.774817881352, 6451.709673064724, 4285.742855428622, 4364.62900653448, 4368.628666563378, 4398.846040388571, 4409.757463339547, 4472.731636101845, 4476.529964353696, 4480.350349199348, 4482.906794311914, 4485.125400546862, 4853.223484242504, 4898.39550822226, 5129.9743501282255, 5133.383993920754, 5152.510511501401, 6083.330833608299, 6125.295591007002, 6129.233845769279, 6135.0, 6148.0, 1517.6357674158123, 1534.8258582184637, 1537.2697968465113, 1543.4829332173622, 1544.8764098872064, 1018.4754851251612, 1020.3622735790132, 1028.2647906746713, 1035.9015893490107, 1046.827273499864, 5903.409659034062, 5912.793052243151, 5913.9112913306335, 5932.940670593325, 5964.880702385928, 6098.874641965377, 6304.495640348761, 6310.716017779211, 6344.111824344595, 6352.396522330371, 5852.473277405054, 5880.647161170344, 5885.176075349455, 5891.055951535983, 5917.260342457193, 3322.451795453723, 3354.2452948086484, 3355.580552430946, 3360.1599600099976, 3366.4108780963234, 6328.17733694626, 6507.446867016262, 6637.435817955431, 6666.100076489709, 6666.166729158856, 6485.221773387224, 6507.186601674791, 6541.542092053605, 6542.476601871839, 6549.410553050248, 6307.274663413675, 6550.574212676161, 6571.34286571339, 6604.14146160996, 6669.699863506057, 6301.369863013845, 6312.873742525216, 6318.557700961072, 6344.143540622142, 6356.523260755369, 6018.608790428608, 6260.186175797117, 6267.1539342188225, 6315.336889626523, 6315.368463153648, 6294.874102517832, 6371.39471750183, 6385.87228255423, 6525.184351956005, 6557.540972132096, 4842.927356089591, 4889.975550122369, 4917.041176970456, 4923.778429970588, 4931.408231012301, 6155.507559395148, 6281.528885333527, 6376.649284289409, 6395.42441180296, 6397.584157029778, 6157.722902469489, 6165.876682466415, 6185.752569897154, 6202.4417802398, 6215.0, 5968.462838344396, 6158.107074474266, 6164.551330437254, 6208.441240288395, 6209.130721699056, 6143.662098584621, 6173.178912220816, 6180.938190618036, 6193.690315484298, 6199.938000619936, 6155.169052178077, 6208.286047104641, 6229.750809967732, 6232.906506402498, 6233.501319894307, 5750.137479378127, 5929.644221346733, 5974.581779275409, 5995.160677505066, 6051.969740151271], "value": 4672.944236628337, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [856.9982457088665, 877.0308808766313, 879.5778026547262, 882.9514376709278, 891.2424439226656, 14755.336009879555, 15557.844421555781, 15560.610984725388, 15561.688766224668, 15572.844271557282, 16087.0, 16869.74695379567, 17099.57251068721, 17101.486955391327, 17127.31490740372, 1001.7095042437684, 1033.0908800255802, 1033.5090831854884, 1034.3948789957883, 1035.4615599888054, 953.7138858342504, 1023.4166525080707, 1034.6947650443099, 1036.6579028920476, 1037.4086770540757, 1084.4577711144427, 1085.8968398002178, 1087.2335003822286, 1087.526925787285, 1088.3306766338685, 1071.4428497181423, 1078.6925726168004, 1081.1404933078181, 1081.967540973772, 1084.376483521974, 790.1979490816825, 794.6265255329986, 796.9083555391088, 797.1112209885994, 797.1749239537052, 15799.131047792367, 15853.682926341524, 15887.761683574756, 16631.002139871645, 16854.157292135344, 18383.90808045951, 18494.16776245072, 18536.62926741471, 18615.162317695736, 18901.0, 14487.71024579513, 14693.92653036728, 14697.77953330701, 14839.332230049673, 14878.0, 3422.110251334671, 3438.6045604755523, 3445.3798316303055, 3446.5002574626787, 3449.448088305859, 93625.0, 93799.0, 94988.52505737427, 95100.0, 95515.52242238744, 14112.435502579987, 14201.644958875904, 14335.211563363906, 14355.0, 14371.640708982359, 26044.08845690392, 26286.6057009145, 26461.338466538105, 26602.0, 26667.86666066696, 7899.289063984269, 7950.6422211000645, 7967.960160199162, 7975.8404831903035, 8272.462289951134, 3981.0843505993785, 4085.3259212230246, 4086.0806318578084, 4087.8773636790943, 4094.344904815215, 4285.528591854893, 4314.201872653569, 4337.696361254745, 4345.760983145894, 4356.172327257811, 880.4937161132247, 896.8609865470862, 898.3217670658742, 898.3352319283683, 899.2895612466209, 713.3045280851233, 714.1323292200002, 723.8552289542113, 731.1226528166222, 754.5435011817772, 10623.52194151265, 11252.66242012741, 11574.71063223426, 11633.76732465346, 12143.574974875837, 719.4460265595462, 733.4059411876398, 745.2956955676942, 755.5731011978214, 761.0296871488786, 5184.300119483897, 5372.0, 5402.189671549299, 5405.21624364465, 5477.014137455217, 81291.59354203191, 84412.0, 84886.0, 84987.0, 85444.57277713696, 71156.64421677859, 71607.64196178986, 72026.0, 74163.62918185374, 74623.0, 63608.0, 64795.0, 64977.35022649808, 67070.32929670738, 67534.99999999901, 10106.14097801695, 10175.236857235588, 10233.283670143019, 10344.637937672145, 10400.323978941344, 36509.0, 36916.261674766894, 37603.0, 37907.0, 38083.0, 43462.56537434712, 44192.0, 44377.0, 44961.1007779836, 45920.0, 17116.572085697957, 17653.205605747517, 17659.293628254727, 17738.467845964642, 17832.10839457996, 18349.541261468035, 19079.427617170953, 19237.711434328216, 19306.0, 19474.0, 15384.307706153473, 16043.919780401024, 16093.275802588678, 16524.504264872074, 16952.237149328557, 15741.763873542135, 15787.447439339569, 15812.367505299659, 15873.603159921095, 16103.67792644117, 15975.28111234974, 16120.113393763455, 16187.67624647477, 16303.103329317002, 16465.91767041157, 13165.144265622705, 13329.0, 13347.799783003456, 13365.0, 13481.797773033608, 13296.534621288596, 13456.192628442324, 13694.93152534231, 13706.52027179044, 13706.794398083837], "value": 8226.854992920538, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1487.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 111.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 120.0, 122.0, 179.0, 118.0, 116.0, 117.0, 116.0, 141.0, 122.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 161.0, 160.0, 159.0, 160.0, 160.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 109.0, 74.0, 74.0, 73.0, 75.0, 102.0, 75.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 107.0, 83.0, 84.0, 81.0, 97.0, 81.0, 82.0, 109.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 113.0, 112.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, 148.0, 147.0, 148.0, 148.0, 147.0, 146.0, 148.0, 149.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 46.0, 47.0, 46.0, 47.0, 46.0, 47.0, 48.0, 47.0, 48.0], "value": 46.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 55.0, 57.0, 55.0, 55.0, 55.0, 54.0, 54.0], "value": 54.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 80.0, 82.0, 86.0, 83.0, 82.0, 81.0, 82.0, 81.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 125.0, 123.0, 125.0, 122.0, 124.0, 123.0, 137.0, 183.0, 127.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 174.0, 183.0, 189.0, 176.0, 187.0, 182.0, 185.0, 172.0], "value": 181.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 76.0, 64.0, 66.0, 66.0, 66.0, 64.0, 64.0, 65.0], "value": 66.1, "unit": "score"}]}]} 06:18:43 INFO - Return code: 0 06:18:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:18:43 INFO - # TBPL SUCCESS # 06:18:43 INFO - Running post-action listener: _resource_record_post_action 06:18:43 INFO - [mozharness: 2017-05-09 13:18:43.607004Z] Finished run-tests step (success) 06:18:43 INFO - Running post-run listener: _resource_record_post_run 06:18:43 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 143360; Write bytes: 383451136; Read time: 20; Write time: 340216 06:18:43 INFO - TinderboxPrint: CPU usage
12.9% 06:18:43 INFO - TinderboxPrint: I/O read bytes / time
143,360 / 20 06:18:43 INFO - TinderboxPrint: I/O write bytes / time
383,451,136 / 340,216 06:18:43 INFO - TinderboxPrint: CPU idle
8,295.4 (87.1%) 06:18:43 INFO - TinderboxPrint: CPU user
1,181.6 (12.4%) 06:18:43 INFO - TinderboxPrint: Swap in / out
0 / 0 06:18:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 122200064; Read time: 0; Write time: 144288 06:18:43 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 143360; Write bytes: 260669440; Read time: 20; Write time: 195892 06:18:44 INFO - Running post-run listener: _upload_blobber_files 06:18:44 INFO - Blob upload gear active. 06:18:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:18:44 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 06:18:44 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'] 06:18:44 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 06:18:44 INFO - (blobuploader) - INFO - Open directory for files ... 06:18:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:18:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:18:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:45 INFO - (blobuploader) - INFO - Done attempting. 06:18:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:18:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:18:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:46 INFO - (blobuploader) - INFO - Done attempting. 06:18:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:18:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:18:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:49 INFO - (blobuploader) - INFO - Done attempting. 06:18:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:18:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:18:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:50 INFO - (blobuploader) - INFO - Done attempting. 06:18:50 INFO - (blobuploader) - INFO - Iteration through files over. 06:18:50 INFO - Return code: 0 06:18:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:18:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:18:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b936cc8a3df44ddb6343c25ed3866d01456a299f8b690e3d087c015d1b5b7354874c06ea536f940c740d3416fbb0ef15384459b66fe6127ea7a50e01a53b0da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fd63e0028965d5810e16cfdb53c97b848571683ef8cb741a50d7916f896398bc23f0585e7c6c5e12c472b81d6c56556023e1fb0b4f20964146e8d4c16fe6dc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a0d0a22319b43818ce447eeebcdf2d7306555da9d62c8d392ce27c57d13c8d10d93bb4af88aa149eda6d486bdd67f449b2f6a018ef31c5d60de92786da4af30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/945016f71a2f97b1635b76aa0f64986514144f6a6793e165294476827c88a9e97f2f8d0967bb07c3d8a101e4a68516051dd7df322217c7a0e615ecd1b1b29161"} 06:18:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:18:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:18:50 INFO - Contents: 06:18:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b936cc8a3df44ddb6343c25ed3866d01456a299f8b690e3d087c015d1b5b7354874c06ea536f940c740d3416fbb0ef15384459b66fe6127ea7a50e01a53b0da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fd63e0028965d5810e16cfdb53c97b848571683ef8cb741a50d7916f896398bc23f0585e7c6c5e12c472b81d6c56556023e1fb0b4f20964146e8d4c16fe6dc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a0d0a22319b43818ce447eeebcdf2d7306555da9d62c8d392ce27c57d13c8d10d93bb4af88aa149eda6d486bdd67f449b2f6a018ef31c5d60de92786da4af30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/945016f71a2f97b1635b76aa0f64986514144f6a6793e165294476827c88a9e97f2f8d0967bb07c3d8a101e4a68516051dd7df322217c7a0e615ecd1b1b29161"} 06:18:50 INFO - Running post-run listener: copy_logs_to_upload_dir 06:18:50 INFO - Copying logs to upload dir... 06:18:50 INFO - mkdir: /builds/slave/test/build/upload/logs 06:18:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.485881 ========= master_lag: -0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-05-09 06:18:49.936559) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 06:18:49.939084) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b936cc8a3df44ddb6343c25ed3866d01456a299f8b690e3d087c015d1b5b7354874c06ea536f940c740d3416fbb0ef15384459b66fe6127ea7a50e01a53b0da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fd63e0028965d5810e16cfdb53c97b848571683ef8cb741a50d7916f896398bc23f0585e7c6c5e12c472b81d6c56556023e1fb0b4f20964146e8d4c16fe6dc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a0d0a22319b43818ce447eeebcdf2d7306555da9d62c8d392ce27c57d13c8d10d93bb4af88aa149eda6d486bdd67f449b2f6a018ef31c5d60de92786da4af30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/945016f71a2f97b1635b76aa0f64986514144f6a6793e165294476827c88a9e97f2f8d0967bb07c3d8a101e4a68516051dd7df322217c7a0e615ecd1b1b29161"} build_url:https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/ZG9cuXMySYayScnfsZg2AA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b936cc8a3df44ddb6343c25ed3866d01456a299f8b690e3d087c015d1b5b7354874c06ea536f940c740d3416fbb0ef15384459b66fe6127ea7a50e01a53b0da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fd63e0028965d5810e16cfdb53c97b848571683ef8cb741a50d7916f896398bc23f0585e7c6c5e12c472b81d6c56556023e1fb0b4f20964146e8d4c16fe6dc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a0d0a22319b43818ce447eeebcdf2d7306555da9d62c8d392ce27c57d13c8d10d93bb4af88aa149eda6d486bdd67f449b2f6a018ef31c5d60de92786da4af30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/945016f71a2f97b1635b76aa0f64986514144f6a6793e165294476827c88a9e97f2f8d0967bb07c3d8a101e4a68516051dd7df322217c7a0e615ecd1b1b29161"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 06:18:49.975714) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 06:18:49.976146) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1494334681.326641-609174824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 06:18:50.060509) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 06:18:50.060900) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 06:18:50.086013) ========= ========= Total master_lag: 0.07 =========