builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1488733945.98 results: success (0) revision: a2ba330bcb09a059ffa492a77a5e4f0f6c543ffc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-05 09:12:25.984144) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-05 09:12:25.984579) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-05 09:12:25.984866) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-05 09:12:26.013193) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:12:26.013463) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-05 09:12:26-- 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% 46.5M=0s 2017-03-05 09:12:27 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136229 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:12:26.170402) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:12:26.170703) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019501 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:12:26.230165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:12:26.230479) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a2ba330bcb09a059ffa492a77a5e4f0f6c543ffc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a2ba330bcb09a059ffa492a77a5e4f0f6c543ffc --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-05 09:12:27,130 truncating revision to first 12 chars 2017-03-05 09:12:27,130 Setting DEBUG logging. 2017-03-05 09:12:27,130 attempt 1/10 2017-03-05 09:12:27,130 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a2ba330bcb09?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-05 09:12:27,541 unpacking tar archive at: mozilla-aurora-a2ba330bcb09/testing/mozharness/ program finished with exit code 0 elapsedTime=0.744784 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:12:26.988849) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-05 09:12:26.992235) ========= script_repo_revision: a2ba330bcb09a059ffa492a77a5e4f0f6c543ffc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-05 09:12:26.992658) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-05 09:12:26.992932) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-05 09:12:27.002738) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-03-05 09:12:27.003155) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:12:27 INFO - MultiFileLogger online at 20170305 09:12:27 in /builds/slave/test 09:12:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:12:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:12:28 INFO - {'append_to_log': False, 09:12:28 INFO - 'base_work_dir': '/builds/slave/test', 09:12:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:12:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:12:28 INFO - 'branch': 'Mozilla-Aurora', 09:12:28 INFO - 'buildbot_json_path': 'buildprops.json', 09:12:28 INFO - 'config_files': ('talos/linux_config.py',), 09:12:28 INFO - 'default_actions': ('clobber', 09:12:28 INFO - 'read-buildbot-config', 09:12:28 INFO - 'download-and-extract', 09:12:28 INFO - 'populate-webroot', 09:12:28 INFO - 'create-virtualenv', 09:12:28 INFO - 'install', 09:12:28 INFO - 'run-tests'), 09:12:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:12:28 INFO - 'download_minidump_stackwalk': True, 09:12:28 INFO - 'download_symbols': 'ondemand', 09:12:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:12:28 INFO - 'tooltool.py': '/tools/tooltool.py', 09:12:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:12:28 INFO - '/tools/misc-python/virtualenv.py')}, 09:12:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:12:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:12:28 INFO - 'installer_path': 'installer.exe', 09:12:28 INFO - 'log_level': 'info', 09:12:28 INFO - 'log_name': 'talos', 09:12:28 INFO - 'log_to_console': True, 09:12:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:12:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:12:28 INFO - 'opt_config_files': (), 09:12:28 INFO - 'pip_index': False, 09:12:28 INFO - 'sps_profile': False, 09:12:28 INFO - 'sps_profile_interval': 0, 09:12:28 INFO - 'suite': 'dromaeojs', 09:12:28 INFO - 'system_bits': '32', 09:12:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:12:28 INFO - 'title': 'talos-linux64-ix-068', 09:12:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:12:28 INFO - 'use_talos_json': True, 09:12:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:12:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:12:28 INFO - 'work_dir': 'build'} 09:12:28 INFO - [mozharness: 2017-03-05 17:12:28.004685Z] Running clobber step. 09:12:28 INFO - Running pre-action listener: _resource_record_pre_action 09:12:28 INFO - Running main action method: clobber 09:12:28 INFO - rmtree: /builds/slave/test/build 09:12:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:12:28 INFO - Running post-action listener: _resource_record_post_action 09:12:28 INFO - [mozharness: 2017-03-05 17:12:28.921263Z] Finished clobber step (success) 09:12:28 INFO - [mozharness: 2017-03-05 17:12:28.921363Z] Running read-buildbot-config step. 09:12:28 INFO - Running pre-action listener: _resource_record_pre_action 09:12:28 INFO - Running main action method: read_buildbot_config 09:12:28 INFO - Using buildbot properties: 09:12:28 INFO - { 09:12:28 INFO - "project": "", 09:12:28 INFO - "product": "firefox", 09:12:28 INFO - "who": "ffxbld@noreply.mozilla.org", 09:12:28 INFO - "installer_path": "public/build/target.tar.bz2", 09:12:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:12:28 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 09:12:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:12:28 INFO - "stage_platform": "linux64-pgo", 09:12:28 INFO - "basedir": "/builds/slave/test", 09:12:28 INFO - "buildnumber": 1089, 09:12:28 INFO - "platform": "ubuntu64_hw", 09:12:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:12:28 INFO - "slavebuilddir": "test", 09:12:28 INFO - "taskId": "RgLNIpLWQM-Z73qc9uL7BA", 09:12:28 INFO - "branch": "mozilla-aurora", 09:12:28 INFO - "script_repo_revision": "production", 09:12:28 INFO - "revision": "a2ba330bcb09a059ffa492a77a5e4f0f6c543ffc", 09:12:28 INFO - "slavename": "talos-linux64-ix-068", 09:12:28 INFO - "repo_path": "releases/mozilla-aurora" 09:12:28 INFO - } 09:12:28 INFO - Finding installer, test and symbols from parent task. 09:12:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RgLNIpLWQM-Z73qc9uL7BA'}, attempt #1 09:12:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RgLNIpLWQM-Z73qc9uL7BA'}, attempt #1 09:12:29 INFO - Task dependencies: A8mIfO6DSEWcH4iHPJIO4g 09:12:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g'}, attempt #1 09:12:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.tar.bz2 09:12:30 INFO - Set test_url: https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/test_packages.json 09:12:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.crashreporter-symbols.zip 09:12:30 INFO - Running post-action listener: _resource_record_post_action 09:12:30 INFO - [mozharness: 2017-03-05 17:12:30.404639Z] Finished read-buildbot-config step (success) 09:12:30 INFO - [mozharness: 2017-03-05 17:12:30.404856Z] Running download-and-extract step. 09:12:30 INFO - Running pre-action listener: _resource_record_pre_action 09:12:30 INFO - Running main action method: download_and_extract 09:12:30 INFO - mkdir: /builds/slave/test/build/tests 09:12: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')]} 09:12:30 INFO - trying https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.test_packages.json 09:12:30 INFO - Downloading https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:12:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:12:30 INFO - Downloaded 896 bytes. 09:12:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:12:30 INFO - Using the following test package requirements: 09:12:30 INFO - {u'common': [u'target.common.tests.zip'], 09:12:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:12:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:12:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:12:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:12:30 INFO - u'mozbase': [u'target.common.tests.zip'], 09:12:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:12:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:12:30 INFO - u'web-platform': [u'target.common.tests.zip', 09:12:30 INFO - u'target.web-platform.tests.zip'], 09:12:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:12:30 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:12:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.common.tests.zip 09:12:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:12:30 INFO - Fetch https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.common.tests.zip into memory 09:12:31 INFO - Expected file size: 21861032 09:12:31 INFO - Obtained file size: 21861032 09:12:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:12:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.common.tests.zip 09:12:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:12:35 INFO - Fetch https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.common.tests.zip into memory 09:12:36 INFO - Expected file size: 21861032 09:12:36 INFO - Obtained file size: 21861032 09:12:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.talos.tests.zip 09:12:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:12:41 INFO - Fetch https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.talos.tests.zip into memory 09:12:41 INFO - Expected file size: 14403650 09:12:41 INFO - Obtained file size: 14403650 09:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:42 INFO - trying https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.tar.bz2 09:12:42 INFO - Downloading https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:12:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:12:43 INFO - Downloaded 66210720 bytes. 09:12:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.tar.bz2 09:12:43 INFO - mkdir: /builds/slave/test/properties 09:12:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:12:43 INFO - Writing to file /builds/slave/test/properties/build_url 09:12:43 INFO - Contents: 09:12:43 INFO - build_url:https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.tar.bz2 09:12:43 INFO - Running post-action listener: _resource_record_post_action 09:12:43 INFO - Running post-action listener: set_extra_try_arguments 09:12:43 INFO - [mozharness: 2017-03-05 17:12:43.301967Z] Finished download-and-extract step (success) 09:12:43 INFO - [mozharness: 2017-03-05 17:12:43.302063Z] Running populate-webroot step. 09:12:43 INFO - Running pre-action listener: _resource_record_pre_action 09:12:43 INFO - Running main action method: populate_webroot 09:12:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:12:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:12:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:12:43 INFO - '--tppagecycles', 09:12:43 INFO - '7'], 09:12:43 INFO - 'tests': ['tsvgm']}}, 09:12:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:12:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:12:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:12:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:12:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:12:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:12:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:12:43 INFO - 'talos_options': ['--disable-e10s'], 09:12:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:12:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:12:43 INFO - 'talos_options': ['--disable-e10s'], 09:12:43 INFO - 'tests': ['damp', 'tps']}, 09:12:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:12:43 INFO - 'tests': ['damp', 'tps']}, 09:12:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:12:43 INFO - 'tests': ['dromaeo_dom']}, 09:12:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:12:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:12:43 INFO - 'tests': ['basic_compositor_video']}, 09:12:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:12:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:12:43 INFO - 'tests': ['a11yr', 09:12:43 INFO - 'ts_paint', 09:12:43 INFO - 'tpaint', 09:12:43 INFO - 'sessionrestore', 09:12:43 INFO - 'sessionrestore_no_auto_restore', 09:12:43 INFO - 'tabpaint']}, 09:12:43 INFO - 'other-e10s': {'tests': ['a11yr', 09:12:43 INFO - 'ts_paint', 09:12:43 INFO - 'tpaint', 09:12:43 INFO - 'sessionrestore', 09:12:43 INFO - 'sessionrestore_no_auto_restore', 09:12:43 INFO - 'tabpaint']}, 09:12:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:12:43 INFO - 'ts_paint', 09:12:43 INFO - 'tpaint', 09:12:43 INFO - 'sessionrestore', 09:12:43 INFO - 'sessionrestore_no_auto_restore', 09:12:43 INFO - 'tabpaint']}, 09:12:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:12:43 INFO - 'ts_paint', 09:12:43 INFO - 'tpaint', 09:12:43 INFO - 'sessionrestore', 09:12:43 INFO - 'sessionrestore_no_auto_restore', 09:12:43 INFO - 'tabpaint']}, 09:12:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:12:43 INFO - 'tests': ['a11yr', 09:12:43 INFO - 'ts_paint', 09:12:43 INFO - 'tpaint', 09:12:43 INFO - 'sessionrestore', 09:12:43 INFO - 'sessionrestore_no_auto_restore', 09:12:43 INFO - 'tabpaint']}, 09:12:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:12:43 INFO - 'tests': ['a11yr', 09:12:43 INFO - 'ts_paint', 09:12:43 INFO - 'tpaint', 09:12:43 INFO - 'sessionrestore', 09:12:43 INFO - 'sessionrestore_no_auto_restore', 09:12:43 INFO - 'tabpaint']}, 09:12:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:12:43 INFO - 'tests': ['tsvgx', 09:12:43 INFO - 'tsvgr_opacity', 09:12:43 INFO - 'tart', 09:12:43 INFO - 'tscrollx', 09:12:43 INFO - 'cart', 09:12:43 INFO - 'tsvg_static']}, 09:12:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:12:43 INFO - 'tsvgr_opacity', 09:12:43 INFO - 'tart', 09:12:43 INFO - 'tscrollx', 09:12:43 INFO - 'cart', 09:12:43 INFO - 'tsvg_static']}, 09:12:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:12:43 INFO - 'talos_options': ['--disable-e10s'], 09:12:43 INFO - 'tests': ['tp5o']}, 09:12:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:12:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:12:43 INFO - 'talos_options': ['--disable-e10s', 09:12:43 INFO - '--xperf_path', 09:12:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:43 INFO - 'tests': ['tp5n']}, 09:12:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:12:43 INFO - 'talos_options': ['--xperf_path', 09:12:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:43 INFO - 'tests': ['tp5n']}}, 09:12:43 INFO - 'talos.zip': {'path': '', 09:12:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:12:43 INFO - Running post-action listener: _resource_record_post_action 09:12:43 INFO - [mozharness: 2017-03-05 17:12:43.315076Z] Finished populate-webroot step (success) 09:12:43 INFO - [mozharness: 2017-03-05 17:12:43.315166Z] Running create-virtualenv step. 09:12:43 INFO - Running pre-action listener: _resource_record_pre_action 09:12:43 INFO - Running main action method: create_virtualenv 09:12:43 INFO - Creating virtualenv /builds/slave/test/build/venv 09:12:43 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 09:12:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:12:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:12:43 INFO - Using real prefix '/usr' 09:12:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:12:43 INFO - Installing distribute.............................................................................................................................................................................................done. 09:12:45 INFO - Installing pip.................done. 09:12:45 INFO - Return code: 0 09:12:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:12:46 INFO - Reading from file tmpfile_stdout 09:12:46 INFO - Output received: 09:12:46 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) 09:12:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:12: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')]} 09:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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')]} 09:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:46 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 0x18581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1968a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53850>, '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 0x1bc86d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', '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 09:12:46 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 09:12:46 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 09:12:46 INFO - Using env: {'DISPLAY': ':0', 09:12:46 INFO - 'HOME': '/home/cltbld', 09:12:46 INFO - 'LANG': 'en_US.UTF-8', 09:12:46 INFO - 'LANGUAGE': 'en_US:en', 09:12:46 INFO - 'LOGNAME': 'cltbld', 09:12:46 INFO - 'MAIL': '/var/mail/cltbld', 09:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:46 INFO - 'MOZ_NO_REMOTE': '1', 09:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:46 INFO - 'NO_EM_RESTART': '1', 09:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:46 INFO - 'PWD': '/builds/slave/test', 09:12:46 INFO - 'SHELL': '/bin/bash', 09:12:46 INFO - 'SHLVL': '1', 09:12:46 INFO - 'TERM': 'linux', 09:12:46 INFO - 'TMOUT': '86400', 09:12:46 INFO - 'USER': 'cltbld', 09:12:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', 09:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:46 INFO - '_': '/tools/buildbot/bin/python'} 09:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:46 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 09:12:46 INFO - Cleaning up... 09:12:46 INFO - Return code: 0 09:12:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:12: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')]} 09:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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')]} 09:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:46 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 0x18581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1968a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53850>, '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 0x1bc86d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', '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 09:12:46 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 09:12:46 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 09:12:46 INFO - Using env: {'DISPLAY': ':0', 09:12:46 INFO - 'HOME': '/home/cltbld', 09:12:46 INFO - 'LANG': 'en_US.UTF-8', 09:12:46 INFO - 'LANGUAGE': 'en_US:en', 09:12:46 INFO - 'LOGNAME': 'cltbld', 09:12:46 INFO - 'MAIL': '/var/mail/cltbld', 09:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:46 INFO - 'MOZ_NO_REMOTE': '1', 09:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:46 INFO - 'NO_EM_RESTART': '1', 09:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:46 INFO - 'PWD': '/builds/slave/test', 09:12:46 INFO - 'SHELL': '/bin/bash', 09:12:46 INFO - 'SHLVL': '1', 09:12:46 INFO - 'TERM': 'linux', 09:12:46 INFO - 'TMOUT': '86400', 09:12:46 INFO - 'USER': 'cltbld', 09:12:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', 09:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:46 INFO - '_': '/tools/buildbot/bin/python'} 09:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:46 INFO - Downloading/unpacking psutil>=3.1.1 09:12:46 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 09:12:46 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 09:12:46 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 09:12:46 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 09:12:46 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 09:12:46 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 09:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:12:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:12:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:12:48 INFO - Installing collected packages: psutil 09:12:48 INFO - Running setup.py install for psutil 09:12:48 INFO - building 'psutil._psutil_linux' extension 09:12:48 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 09:12:48 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 09:12:48 INFO - building 'psutil._psutil_posix' extension 09:12:48 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 09:12:49 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 09:12:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:12:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:12:49 INFO - Successfully installed psutil 09:12:49 INFO - Cleaning up... 09:12:49 INFO - Return code: 0 09:12:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:12: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')]} 09:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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')]} 09:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1968a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53850>, '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 0x1bc86d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', '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 09:12: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:12: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 mozsystemmonitor==0.3 09:12:49 INFO - Using env: {'DISPLAY': ':0', 09:12:49 INFO - 'HOME': '/home/cltbld', 09:12:49 INFO - 'LANG': 'en_US.UTF-8', 09:12:49 INFO - 'LANGUAGE': 'en_US:en', 09:12:49 INFO - 'LOGNAME': 'cltbld', 09:12:49 INFO - 'MAIL': '/var/mail/cltbld', 09:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:49 INFO - 'MOZ_NO_REMOTE': '1', 09:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:49 INFO - 'NO_EM_RESTART': '1', 09:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:49 INFO - 'PWD': '/builds/slave/test', 09:12:49 INFO - 'SHELL': '/bin/bash', 09:12:49 INFO - 'SHLVL': '1', 09:12:49 INFO - 'TERM': 'linux', 09:12:49 INFO - 'TMOUT': '86400', 09:12:49 INFO - 'USER': 'cltbld', 09:12:49 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', 09:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:49 INFO - '_': '/tools/buildbot/bin/python'} 09:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:12:49 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 09:12:49 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 09:12:49 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 09:12:49 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 09:12:49 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 09:12:49 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 09:12:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:12:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:12:51 INFO - Installing collected packages: mozsystemmonitor 09:12:51 INFO - Running setup.py install for mozsystemmonitor 09:12:51 INFO - Successfully installed mozsystemmonitor 09:12:51 INFO - Cleaning up... 09:12:51 INFO - Return code: 0 09:12:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:12:51 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')]} 09:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:51 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')]} 09:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:51 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 0x18581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1968a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53850>, '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 0x1bc86d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', '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 09:12:51 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 09:12:51 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 09:12:51 INFO - Using env: {'DISPLAY': ':0', 09:12:51 INFO - 'HOME': '/home/cltbld', 09:12:51 INFO - 'LANG': 'en_US.UTF-8', 09:12:51 INFO - 'LANGUAGE': 'en_US:en', 09:12:51 INFO - 'LOGNAME': 'cltbld', 09:12:51 INFO - 'MAIL': '/var/mail/cltbld', 09:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:51 INFO - 'MOZ_NO_REMOTE': '1', 09:12:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:51 INFO - 'NO_EM_RESTART': '1', 09:12:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:51 INFO - 'PWD': '/builds/slave/test', 09:12:51 INFO - 'SHELL': '/bin/bash', 09:12:51 INFO - 'SHLVL': '1', 09:12:51 INFO - 'TERM': 'linux', 09:12:51 INFO - 'TMOUT': '86400', 09:12:51 INFO - 'USER': 'cltbld', 09:12:51 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', 09:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:51 INFO - '_': '/tools/buildbot/bin/python'} 09:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:51 INFO - Downloading/unpacking jsonschema==2.5.1 09:12:51 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 09:12:51 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 09:12:51 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 09:12:51 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 09:12:51 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 09:12:51 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 09:12:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:12:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:12:53 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 09:12:53 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 09:12:53 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 09:12:53 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 09:12:53 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 09:12:53 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 09:12:54 INFO - Downloading functools32-3.2.3-2.tar.gz 09:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:12:54 INFO - warning: no files found matching '*.txt' 09:12:54 INFO - no previously-included directories found matching 'build' 09:12:54 INFO - no previously-included directories found matching 'dist' 09:12:54 INFO - no previously-included directories found matching '.git*' 09:12:54 INFO - Installing collected packages: jsonschema, functools32 09:12:54 INFO - Running setup.py install for functools32 09:12:54 INFO - warning: no files found matching '*.txt' 09:12:54 INFO - no previously-included directories found matching 'build' 09:12:54 INFO - no previously-included directories found matching 'dist' 09:12:54 INFO - no previously-included directories found matching '.git*' 09:12:54 INFO - Successfully installed jsonschema functools32 09:12:54 INFO - Cleaning up... 09:12:54 INFO - Return code: 0 09:12:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:12:54 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')]} 09:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:54 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')]} 09:12:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:54 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 0x18581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1968a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53850>, '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 0x1bc86d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', '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 09:12:54 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 09:12:54 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 09:12:54 INFO - Using env: {'DISPLAY': ':0', 09:12:54 INFO - 'HOME': '/home/cltbld', 09:12:54 INFO - 'LANG': 'en_US.UTF-8', 09:12:54 INFO - 'LANGUAGE': 'en_US:en', 09:12:54 INFO - 'LOGNAME': 'cltbld', 09:12:54 INFO - 'MAIL': '/var/mail/cltbld', 09:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:54 INFO - 'MOZ_NO_REMOTE': '1', 09:12:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:54 INFO - 'NO_EM_RESTART': '1', 09:12:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:54 INFO - 'PWD': '/builds/slave/test', 09:12:54 INFO - 'SHELL': '/bin/bash', 09:12:54 INFO - 'SHLVL': '1', 09:12:54 INFO - 'TERM': 'linux', 09:12:54 INFO - 'TMOUT': '86400', 09:12:54 INFO - 'USER': 'cltbld', 09:12:54 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', 09:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:54 INFO - '_': '/tools/buildbot/bin/python'} 09:12:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:12:54 INFO - Cleaning up... 09:12:54 INFO - Return code: 0 09:12:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:12:54 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')]} 09:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:54 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')]} 09:12:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:54 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 0x18581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1968a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53850>, '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 0x1bc86d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', '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 09:12:54 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 09:12:54 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 09:12:54 INFO - Using env: {'DISPLAY': ':0', 09:12:54 INFO - 'HOME': '/home/cltbld', 09:12:54 INFO - 'LANG': 'en_US.UTF-8', 09:12:54 INFO - 'LANGUAGE': 'en_US:en', 09:12:54 INFO - 'LOGNAME': 'cltbld', 09:12:54 INFO - 'MAIL': '/var/mail/cltbld', 09:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:54 INFO - 'MOZ_NO_REMOTE': '1', 09:12:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:54 INFO - 'NO_EM_RESTART': '1', 09:12:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:54 INFO - 'PWD': '/builds/slave/test', 09:12:54 INFO - 'SHELL': '/bin/bash', 09:12:54 INFO - 'SHLVL': '1', 09:12:54 INFO - 'TERM': 'linux', 09:12:54 INFO - 'TMOUT': '86400', 09:12:54 INFO - 'USER': 'cltbld', 09:12:54 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', 09:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:54 INFO - '_': '/tools/buildbot/bin/python'} 09:12:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:54 INFO - Downloading/unpacking blobuploader==1.2.4 09:12:54 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 09:12:54 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 09:12:54 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 09:12:54 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 09:12:54 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 09:12:54 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 09:12:56 INFO - Downloading blobuploader-1.2.4.tar.gz 09:12:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:12:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:12:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:12:57 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 09:12:57 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 09:12:57 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 09:12:57 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 09:12:57 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 09:12:57 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 09:12:57 INFO - Downloading docopt-0.6.1.tar.gz 09:12:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:12:57 INFO - Installing collected packages: blobuploader, requests, docopt 09:12:57 INFO - Running setup.py install for blobuploader 09:12:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:12:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:12:57 INFO - Running setup.py install for requests 09:12:58 INFO - Running setup.py install for docopt 09:12:58 INFO - Successfully installed blobuploader requests docopt 09:12:58 INFO - Cleaning up... 09:12:58 INFO - Return code: 0 09:12:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:58 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')]} 09:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:58 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')]} 09:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:58 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 0x18581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1968a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53850>, '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 0x1bc86d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', '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 09:12:58 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 09:12:58 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 09:12:58 INFO - Using env: {'DISPLAY': ':0', 09:12:58 INFO - 'HOME': '/home/cltbld', 09:12:58 INFO - 'LANG': 'en_US.UTF-8', 09:12:58 INFO - 'LANGUAGE': 'en_US:en', 09:12:58 INFO - 'LOGNAME': 'cltbld', 09:12:58 INFO - 'MAIL': '/var/mail/cltbld', 09:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:58 INFO - 'MOZ_NO_REMOTE': '1', 09:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:12:58 INFO - 'NO_EM_RESTART': '1', 09:12:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:58 INFO - 'PWD': '/builds/slave/test', 09:12:58 INFO - 'SHELL': '/bin/bash', 09:12:58 INFO - 'SHLVL': '1', 09:12:58 INFO - 'TERM': 'linux', 09:12:58 INFO - 'TMOUT': '86400', 09:12:58 INFO - 'USER': 'cltbld', 09:12:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', 09:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:58 INFO - '_': '/tools/buildbot/bin/python'} 09:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:12:58 INFO - Running setup.py (path:/tmp/pip-WxApoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:12:58 INFO - Running setup.py (path:/tmp/pip-CztGHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:12:58 INFO - Running setup.py (path:/tmp/pip-rSum2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:12:58 INFO - Running setup.py (path:/tmp/pip-LtoO0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:12:58 INFO - Running setup.py (path:/tmp/pip-rwUVtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:12:58 INFO - Running setup.py (path:/tmp/pip-aLW3fA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:12:58 INFO - Running setup.py (path:/tmp/pip-rKNRIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:12:58 INFO - Running setup.py (path:/tmp/pip-HiMfCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:12:59 INFO - Running setup.py (path:/tmp/pip-QFlX3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:12:59 INFO - Running setup.py (path:/tmp/pip-U2SS3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:12:59 INFO - Running setup.py (path:/tmp/pip-qx_Kol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:12:59 INFO - Running setup.py (path:/tmp/pip-mv6GD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:12:59 INFO - Running setup.py (path:/tmp/pip-nvRCfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:12:59 INFO - Running setup.py (path:/tmp/pip-wIcPVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:59 INFO - Running setup.py (path:/tmp/pip-8Drw5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:12:59 INFO - Running setup.py (path:/tmp/pip-rx1GH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:12:59 INFO - Running setup.py (path:/tmp/pip-_5ECu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:12:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:12:59 INFO - Running setup.py install for manifestparser 09:12:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:12:59 INFO - Running setup.py install for mozcrash 09:12:59 INFO - Running setup.py install for mozdebug 09:13:00 INFO - Running setup.py install for mozdevice 09:13:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:13:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:13:00 INFO - Running setup.py install for mozfile 09:13:00 INFO - Running setup.py install for mozhttpd 09:13:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:13:00 INFO - Running setup.py install for mozinfo 09:13:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:13:00 INFO - Running setup.py install for mozInstall 09:13:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:13:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:13:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:13:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:13:00 INFO - Running setup.py install for mozleak 09:13:00 INFO - Running setup.py install for mozlog 09:13:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:13:00 INFO - Running setup.py install for moznetwork 09:13:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:13:00 INFO - Running setup.py install for mozprocess 09:13:00 INFO - Running setup.py install for mozprofile 09:13:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:13:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:13:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:13:01 INFO - Running setup.py install for mozrunner 09:13:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:13:01 INFO - Running setup.py install for mozscreenshot 09:13:01 INFO - Running setup.py install for moztest 09:13:01 INFO - Running setup.py install for mozversion 09:13:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:13:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:13:01 INFO - Cleaning up... 09:13:01 INFO - Return code: 0 09:13:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:13:01 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')]} 09:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:01 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')]} 09:13:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:01 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 0x18581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1968a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53850>, '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 0x1bc86d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', '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 09:13:01 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 09:13:01 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 09:13:01 INFO - Using env: {'DISPLAY': ':0', 09:13:01 INFO - 'HOME': '/home/cltbld', 09:13:01 INFO - 'LANG': 'en_US.UTF-8', 09:13:01 INFO - 'LANGUAGE': 'en_US:en', 09:13:01 INFO - 'LOGNAME': 'cltbld', 09:13:01 INFO - 'MAIL': '/var/mail/cltbld', 09:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:01 INFO - 'MOZ_NO_REMOTE': '1', 09:13:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:01 INFO - 'NO_EM_RESTART': '1', 09:13:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:01 INFO - 'PWD': '/builds/slave/test', 09:13:01 INFO - 'SHELL': '/bin/bash', 09:13:01 INFO - 'SHLVL': '1', 09:13:01 INFO - 'TERM': 'linux', 09:13:01 INFO - 'TMOUT': '86400', 09:13:01 INFO - 'USER': 'cltbld', 09:13:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', 09:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:01 INFO - '_': '/tools/buildbot/bin/python'} 09:13:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:13:01 INFO - Running setup.py (path:/tmp/pip-2OjX1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:13:01 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)) 09:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:13:01 INFO - Running setup.py (path:/tmp/pip-xHZ9K4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:13:01 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)) 09:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:13:01 INFO - Running setup.py (path:/tmp/pip-lnvxkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:13:01 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)) 09:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:13:01 INFO - Running setup.py (path:/tmp/pip-uoHl4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 09:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:13:02 INFO - Running setup.py (path:/tmp/pip-L1GSI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:13:02 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)) 09:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:13:02 INFO - Running setup.py (path:/tmp/pip-d3ka45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:13:02 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)) 09:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:13:02 INFO - Running setup.py (path:/tmp/pip-1PubXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:13:02 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)) 09:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:13:02 INFO - Running setup.py (path:/tmp/pip-ePS981-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:13:02 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)) 09:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:13:02 INFO - Running setup.py (path:/tmp/pip-BNInsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:13:02 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)) 09:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:13:02 INFO - Running setup.py (path:/tmp/pip-EzcyKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:13:02 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)) 09:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:13:02 INFO - Running setup.py (path:/tmp/pip-289G4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:13:02 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)) 09:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:13:02 INFO - Running setup.py (path:/tmp/pip-GORmoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:13:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 09:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:13:02 INFO - Running setup.py (path:/tmp/pip-cjmprs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:13:02 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)) 09:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:13:02 INFO - Running setup.py (path:/tmp/pip-5Z6eZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:13:02 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)) 09:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:02 INFO - Running setup.py (path:/tmp/pip-TwAqdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:13:02 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)) 09:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:13:02 INFO - Running setup.py (path:/tmp/pip-gsOskC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:13:02 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)) 09:13:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:13:02 INFO - Running setup.py (path:/tmp/pip-nEOYT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:13:02 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)) 09:13:02 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)) 09:13:02 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)) 09:13:02 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)) 09:13:02 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:13:02 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:13:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:13:02 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 09:13:02 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 09:13:02 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 09:13:02 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 09:13:02 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 09:13:02 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 09:13:04 INFO - Downloading blessings-1.6.tar.gz 09:13:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:13:05 INFO - Installing collected packages: blessings 09:13:05 INFO - Running setup.py install for blessings 09:13:05 INFO - Successfully installed blessings 09:13:05 INFO - Cleaning up... 09:13:05 INFO - Return code: 0 09:13:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:13:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:13:05 INFO - Reading from file tmpfile_stdout 09:13:05 INFO - Current package versions: 09:13:05 INFO - argparse == 1.2.1 09:13:05 INFO - blessings == 1.6 09:13:05 INFO - blobuploader == 1.2.4 09:13:05 INFO - docopt == 0.6.1 09:13:05 INFO - functools32 == 3.2.3-2 09:13:05 INFO - jsonschema == 2.5.1 09:13:05 INFO - manifestparser == 1.1 09:13:05 INFO - mozInstall == 1.12 09:13:05 INFO - mozcrash == 1.0 09:13:05 INFO - mozdebug == 0.1 09:13:05 INFO - mozdevice == 0.49 09:13:05 INFO - mozfile == 1.2 09:13:05 INFO - mozhttpd == 0.7 09:13:05 INFO - mozinfo == 0.9 09:13:05 INFO - mozleak == 0.1 09:13:05 INFO - mozlog == 3.4 09:13:05 INFO - moznetwork == 0.27 09:13:05 INFO - mozprocess == 0.24 09:13:05 INFO - mozprofile == 0.28 09:13:05 INFO - mozrunner == 6.13 09:13:05 INFO - mozscreenshot == 0.1 09:13:05 INFO - mozsystemmonitor == 0.3 09:13:05 INFO - moztest == 0.8 09:13:05 INFO - mozversion == 1.4 09:13:05 INFO - psutil == 3.1.1 09:13:05 INFO - requests == 1.2.3 09:13:05 INFO - wsgiref == 0.1.2 09:13:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:13:05 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')]} 09:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:05 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')]} 09:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:05 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 0x18581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1968a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53850>, '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 0x1bc86d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', '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 09:13:05 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 09:13:05 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 09:13:05 INFO - Using env: {'DISPLAY': ':0', 09:13:05 INFO - 'HOME': '/home/cltbld', 09:13:05 INFO - 'LANG': 'en_US.UTF-8', 09:13:05 INFO - 'LANGUAGE': 'en_US:en', 09:13:05 INFO - 'LOGNAME': 'cltbld', 09:13:05 INFO - 'MAIL': '/var/mail/cltbld', 09:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:05 INFO - 'MOZ_NO_REMOTE': '1', 09:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:05 INFO - 'NO_EM_RESTART': '1', 09:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:05 INFO - 'PWD': '/builds/slave/test', 09:13:05 INFO - 'SHELL': '/bin/bash', 09:13:05 INFO - 'SHLVL': '1', 09:13:05 INFO - 'TERM': 'linux', 09:13:05 INFO - 'TMOUT': '86400', 09:13:05 INFO - 'USER': 'cltbld', 09:13:05 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', 09:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:05 INFO - '_': '/tools/buildbot/bin/python'} 09:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:05 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)) 09:13:05 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)) 09:13:05 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)) 09:13:05 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)) 09:13:05 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)) 09:13:05 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)) 09:13:05 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)) 09:13:05 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)) 09:13:05 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)) 09:13:05 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)) 09:13:05 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)) 09:13:05 INFO - Cleaning up... 09:13:05 INFO - Return code: 0 09:13:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:13:05 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')]} 09:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:13:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:05 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')]} 09:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:13:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:13:05 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 0x18581f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1968a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bca630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c53850>, '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 0x1bc86d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', '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 09:13:05 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 09:13:05 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 09:13:05 INFO - Using env: {'DISPLAY': ':0', 09:13:05 INFO - 'HOME': '/home/cltbld', 09:13:05 INFO - 'LANG': 'en_US.UTF-8', 09:13:05 INFO - 'LANGUAGE': 'en_US:en', 09:13:05 INFO - 'LOGNAME': 'cltbld', 09:13:05 INFO - 'MAIL': '/var/mail/cltbld', 09:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:05 INFO - 'MOZ_NO_REMOTE': '1', 09:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:05 INFO - 'NO_EM_RESTART': '1', 09:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:05 INFO - 'PWD': '/builds/slave/test', 09:13:05 INFO - 'SHELL': '/bin/bash', 09:13:05 INFO - 'SHLVL': '1', 09:13:05 INFO - 'TERM': 'linux', 09:13:05 INFO - 'TMOUT': '86400', 09:13:05 INFO - 'USER': 'cltbld', 09:13:05 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', 09:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:05 INFO - '_': '/tools/buildbot/bin/python'} 09:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:13:05 INFO - Cleaning up... 09:13:05 INFO - Return code: 0 09:13:05 INFO - Running post-action listener: _resource_record_post_action 09:13:05 INFO - Running post-action listener: _start_resource_monitoring 09:13:05 INFO - Starting resource monitoring. 09:13:05 INFO - [mozharness: 2017-03-05 17:13:05.970862Z] Finished create-virtualenv step (success) 09:13:05 INFO - [mozharness: 2017-03-05 17:13:05.971433Z] Running install step. 09:13:05 INFO - Running pre-action listener: _resource_record_pre_action 09:13:05 INFO - Running main action method: install 09:13:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:13:06 INFO - Reading from file tmpfile_stdout 09:13:06 INFO - Detecting whether we're running mozinstall >=1.0... 09:13:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:13:06 INFO - Reading from file tmpfile_stdout 09:13:06 INFO - Output received: 09:13:06 INFO - Usage: mozinstall [options] installer 09:13:06 INFO - Options: 09:13:06 INFO - -h, --help show this help message and exit 09:13:06 INFO - -d DEST, --destination=DEST 09:13:06 INFO - Directory to install application into. [default: 09:13:06 INFO - "/builds/slave/test"] 09:13:06 INFO - --app=APP Application being installed. [default: firefox] 09:13:06 INFO - mkdir: /builds/slave/test/build/application 09:13:06 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'] 09:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:13:22 INFO - Reading from file tmpfile_stdout 09:13:22 INFO - Output received: 09:13:22 INFO - /builds/slave/test/build/application/firefox/firefox 09:13:22 INFO - Running post-action listener: _resource_record_post_action 09:13:22 INFO - [mozharness: 2017-03-05 17:13:22.738010Z] Finished install step (success) 09:13:22 INFO - [mozharness: 2017-03-05 17:13:22.738283Z] Running run-tests step. 09:13:22 INFO - Running pre-action listener: _resource_record_pre_action 09:13:22 INFO - Running main action method: run_tests 09:13:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:13:22 INFO - Python 2.7.3 09:13:22 INFO - Return code: 0 09:13:22 INFO - grabbing minidump binary from tooltool 09:13:22 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')]} 09:13:22 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 0x1c53850>, '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 0x1bc86d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc8b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:13:22 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 09:13:22 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 09:13:22 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 09:13:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:13:22 INFO - Return code: 0 09:13:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:13:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:13:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:13:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:13:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:13:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:13:22 INFO - Using env: {'DISPLAY': ':0', 09:13:22 INFO - 'HOME': '/home/cltbld', 09:13:22 INFO - 'LANG': 'en_US.UTF-8', 09:13:22 INFO - 'LANGUAGE': 'en_US:en', 09:13:22 INFO - 'LOGNAME': 'cltbld', 09:13:22 INFO - 'MAIL': '/var/mail/cltbld', 09:13:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:13:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:22 INFO - 'MOZ_NO_REMOTE': '1', 09:13:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:13:22 INFO - 'NO_EM_RESTART': '1', 09:13:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:22 INFO - 'PWD': '/builds/slave/test', 09:13:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:13:22 INFO - 'SHELL': '/bin/bash', 09:13:22 INFO - 'SHLVL': '1', 09:13:22 INFO - 'TERM': 'linux', 09:13:22 INFO - 'TMOUT': '86400', 09:13:22 INFO - 'USER': 'cltbld', 09:13:22 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024', 09:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:22 INFO - '_': '/tools/buildbot/bin/python'} 09:13:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:13:23 INFO - mozversion application_buildid: 20170305161829 09:13:23 INFO - mozversion application_changeset: a2ba330bcb09a059ffa492a77a5e4f0f6c543ffc 09:13:23 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:13:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:13:23 INFO - mozversion application_name: Firefox 09:13:23 INFO - mozversion application_remotingname: firefox-dev 09:13:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:13:23 INFO - mozversion application_vendor: Mozilla 09:13:23 INFO - mozversion application_version: 53.0a2 09:13:23 INFO - mozversion platform_buildid: 20170305161829 09:13:23 INFO - mozversion platform_changeset: a2ba330bcb09a059ffa492a77a5e4f0f6c543ffc 09:13:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:13:23 INFO - mozversion platform_version: 53.0a2 09:13:23 INFO - using testdate: 1488734003 09:13:23 INFO - actual date: 1488734003 09:13:23 INFO - starting webserver on 'localhost:51355' 09:13:23 INFO - SUITE-START | Running 2 tests 09:13:23 INFO - TEST-START | dromaeo_css 09:13:23 INFO - operating with platform_type : linux_ 09:13:23 INFO - Initialising browser for dromaeo_css test... 09:13:23 INFO - TEST-INFO | started process 4848 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprHdJty/profile http://localhost:51355/getInfo.html) 09:13:27 INFO - PROCESS | 4848 | __metrics Screen width/height:1600/1200 09:13:27 INFO - PROCESS | 4848 | colorDepth:24 09:13:27 INFO - PROCESS | 4848 | Browser inner width/height: 1024/697 09:13:27 INFO - PROCESS | 4848 | __metrics 09:13:28 INFO - PROCESS | 4848 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:13:28 INFO - PROCESS | 4848 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:13:28 INFO - PROCESS | 4848 | console.error: PushService: 09:13:28 INFO - PROCESS | 4848 | stateChangeProcessEnqueue: Error transitioning state 09:13:28 INFO - PROCESS | 4848 | UnknownError 09:13:29 INFO - TEST-INFO | 4848: exit 0 09:13:29 INFO - Browser initialized. 09:13:29 INFO - Running cycle 1/1 for dromaeo_css test... 09:13:29 INFO - TEST-INFO | started process 4943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprHdJty/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:41 INFO - PROCESS | 4943 | RSS: Main: 138018816 09:13:41 INFO - PROCESS | 4943 | 09:16:41 INFO - PROCESS | 4943 | Cycle 1(1): loaded http://localhost:51355/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51355/tests/dromaeo/cssquery-ext.html) 09:16:42 INFO - PROCESS | 4943 | RSS: Main: 242053120 09:16:42 INFO - PROCESS | 4943 | 09:18:31 INFO - PROCESS | 4943 | ************************* 09:18:31 INFO - PROCESS | 4943 | A coding exception was thrown and uncaught in a Task. 09:18:31 INFO - PROCESS | 4943 | 09:18:31 ERROR - PROCESS | 4943 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:18:31 INFO - PROCESS | 4943 | Full stack: 09:18:31 INFO - PROCESS | 4943 | ************************* 09:19:45 INFO - PROCESS | 4943 | Cycle 1(1): loaded http://localhost:51355/tests/dromaeo/cssquery-ext.html (next: http://localhost:51355/tests/dromaeo/cssquery-jquery.html) 09:19:45 INFO - PROCESS | 4943 | RSS: Main: 229629952 09:19:45 INFO - PROCESS | 4943 | 09:22:47 INFO - PROCESS | 4943 | Cycle 1(1): loaded http://localhost:51355/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51355/tests/dromaeo/cssquery-mootools.html) 09:22:48 INFO - PROCESS | 4943 | RSS: Main: 204910592 09:22:48 INFO - PROCESS | 4943 | 09:25:49 INFO - PROCESS | 4943 | Cycle 1(1): loaded http://localhost:51355/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51355/tests/dromaeo/cssquery-prototype.html) 09:25:50 INFO - PROCESS | 4943 | RSS: Main: 224903168 09:25:50 INFO - PROCESS | 4943 | 09:28:53 INFO - PROCESS | 4943 | Cycle 1(1): loaded http://localhost:51355/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51355/tests/dromaeo/cssquery-yui.html) 09:28:53 INFO - PROCESS | 4943 | RSS: Main: 171933696 09:28:53 INFO - PROCESS | 4943 | 09:31:56 INFO - PROCESS | 4943 | Cycle 1(1): loaded http://localhost:51355/tests/dromaeo/cssquery-yui.html (next: http://localhost:51355/tests/dromaeo/cssquery-dojo.html) 09:31:56 INFO - PROCESS | 4943 | RSS: Main: 254386176 09:31:56 INFO - PROCESS | 4943 | 09:31:56 INFO - PROCESS | 4943 | __start_tp_report 09:31:56 INFO - PROCESS | 4943 | _x_x_mozilla_page_load 09:31:56 INFO - PROCESS | 4943 | _x_x_mozilla_page_load_details 09:31:56 INFO - PROCESS | 4943 | |i|pagename|runs| 09:31:56 INFO - PROCESS | 4943 | |0;dojo.html;3264.4940034294686;3309.023837967801;3323.601167859857;3335.132865454981;3356.093854659242;5352.759125839337;5446.046941785192;5471.042567550678;5481.232627432158;5487.314085739283;5431.103867861798;5491.862703432416;5503.3120859892515;5503.862403439916;5513.807016754405;4970.627202959783;5001.874953126165;5004.174311238641;5036.546710796028;5108.080545501808;4869.780859861297;4886.1204983103025;5021.924671129936;5071.061853557104;5077.771500282496;4940.629452791037;4944.505549445044;5003.499650034985;5048.343715317003;5075.162598171298;5006.3241462402475;5008.474110218447;5012.323336349583;5015.623828212881;5039.193729003342;4783.186858234074;4962.950370496285;4968.105740966625;4988.975055124737;5024.447310795809;5195.532402083831;5230.979958908015;5288.471152884719;5353.330833645794;5405.459454054602;5785.942140578582;5787.855303617401;5798.855028624276;5799.130130480419;5815.040518314473;5720.570957178186;5843.795467158629;5851.941480585225;5855.033919403293;5874.089516125007;5328.520433160996;5391.272178255964;5404.675719456766;5415.675059496364;5480.26016487773;5905.793297234576;5910.143029260733;5924.20023296858;5936.257967754031;5945.197398351167;5663.858403539862;5708.343540492813;5708.40061793514;5722.313322401255;5730.111832665943;5592.217089607459;5655.236543066716;5771.88456230873;5804.361520232771;5811.244538210006;5790.10253410722;5803.187553742479;5844.678542680108;5874.1776151338845;5888.175655408247;5830.795922142789;5834.649921004753;5837.036888913367;5840.561957853178;5850.3564607893095;4042.8787136385954;4075.91848163041;4091.4476545665952;4103.994521342291;4130.421740956269;3676.7058635309645;3692.464592634107;3706.4625629283605;3708.128589781399;3723.497327860704;5544.22380866679;5551.472610102034;5558.527525160407;5566.053770858964;5593.468620481048;5746.96554620164;5775.768969241183;5776.220210271644;5834.737436815353;5855.912161317584;5556.138798486241;5621.269234999506;5627.324721033502;5658.575606829504;5664.85837854057;4998.775055122528;5000.549950504399;5002.424721157114;5004.374453193351;5025.522575355335;5880.147378629989;5918.260217472816;6009.639421634716;6054.03135498327;6080.665563394055;5774.740136693943;5797.246357973437;5806.970965145148;5918.112283157388;5949.791757288474;6065.969670151798;6091.42131497507;6092.8781424372155;6116.29662588808;6117.388261174025;5575.665460072409;5798.478136967693;5802.071668533014;5803.709814509342;5813.56398270123;5701.486866182064;5872.853178670567;5905.320888097924;5915.024021036481;5916.822495325147;5705.7432415542235;5759.136129580596;5759.8560035999435;5761.366249712444;5762.337331206965;5687.175359572756;5763.36602973681;5765.625234359753;5778.306603207642;5779.942200577941;5554.166874968787;5591.4688104629995;5606.943930560806;5614.24207731951;5619.550435965031;5732.885342293214;5740.282464691913;5741.483266506035;5742.483176514133;5757.596968212352;5620.74706638194;5625.606207565431;5632.042552766122;5633.352164501135;5633.774649013993 09:31:56 INFO - PROCESS | 4943 | |1;ext.html;548.0909432008701;582.3419535924405;601.2424345324893;602.2411761180911;606.6269244414685;34903.30193396134;38362.808185959104;38791;45716.54283457164;46669.766651166785;48539;48829.51170488303;48889.26666100011;48929.755351223284;48974.75512622432;9219.861702074491;9375.624975000992;9376.249900008017;9413.341066125375;9413.341066125375;8838.602262898154;9074.86387704185;9078.319126065539;9301.441913485212;10871.184661150406;10999;11412.372319522423;11413.714657133554;11420.086393088533;11420.257683250562;11371.886281137165;11433.714157146054;11434.199606027581;11435.371054591995;11440.542378304857;11130.666080017612;11174.27367221128;11196.384198869058;11207.775844483065;11212.831807522894;46135.769321153515;46284.91717872704;46304;46317.30524042142;46357.76821115873;4324.416203812477;4424.823007079713;4427.29163333865;4533.9319910201375;4630.21286381316;31179.08632275808;31274.530882036786;31391.05826825176;31756.523652145235;32506.6749332506;4584.564466375689;4608.746518941457;4667.509911459282;4741.525847415231;4775.9731657693765;350324;352510.99999999744;352573.99999999744;353839;354654;56832.43167568354;57300;57426.7128664354;57576.71211643999;57701.13448298279;58457;58465.70767146222;58469.4153058464;58723;58765;18739.344122955903;18953.241870325033;19002.71495927562;19068.80931190698;19072.046397680337;14928.70142597142;14990.400383984737;15029.924850375679;15034.398624054915;15076.246187690791;16531.91734041322;16866.32534698623;16894.66210675804;17974.281028758964;18360.540986475444;6837.897431538531;7383.335499804936;7452.013172952445;7456.888146677804;7571.924280757122;1005.8692369991854;1009.5961615353917;1009.9192064634811;1016.5577973581516;1022.9283950123569;33906.49140262898;33970.77601069177;34228.14429639279;34326.485102723476;34635.653643463746;1084.360227465799;1183.3018519073787;1187.7386974865515;1213.6844420450745;1225.4852961756085;17245.482635520955;18273.81726182721;18307.81692183061;18371.26514939414;18448.35430759917;535906;539856;540634;542077;542094;63704.36295636984;64792.352076479576;64908.350916491174;64969.675151624884;65019.67490162519;1515.2272341106116;1527.633367991674;1529.8470152984612;1536.9385224590892;1567.0910871694389;32034.19914502156;33413.66345346159;33709;33711.494327584616;33909;56288.71855640696;56294.43705562892;56837.43162568322;56841.71579142078;56983.71508142599;428951;430239;430250;431784;432584;30200.5469917947;31422.528662070545;31431.842840785648;31438.056858294287;31454;52224;52929.47070529246;53084;53266.73366633297;54581.45418545764;43336.349954751335;43480.13039739251;43621.56378436175;43807.34288985604;45736.31395529003;43430;43791;44300.77849610731;44817;45500.089998200514;43070;43144.78427607842;43408.34887476754;43839.34240986451;44002.11995760131;35854.64145358618;37577.81211093927;38056.80971595124;38773;38981.6101838978;28616.284592885346;28913.132606021853;28947.421051579273;29044.56433153547;29075.85462072676 09:31:56 INFO - PROCESS | 4943 | |2;jquery.html;387.5388287937356;445.45431845988645;448.585058820591;449.6357950060451;450.25258071601127;19394.418167454965;20557.486062848435;20816.687749683766;20876;20985.47536311593;14485.130892146479;15403.306851191695;21415.785842141573;21931.561368772615;22117.778822211774;5616.550675945935;5787.305523337184;5798.478136967672;5802.013657678205;5802.303723553179;5509.531689806371;6909.896351554731;6946.957956306544;7054.153501579817;7061.89407158893;6796.524243302971;6898.034275201476;6970.965145174292;7018.789436316893;7043.5421697589745;6704.094947182117;6930.4109150722;6959.338862808025;6960.129983752056;6967.198772141192;6097.268327800648;6158.261008678987;6168.784092556739;6169.074638804171;6169.7532098716;14869.702605947929;14909.776353354708;23591.820408979653;23619;24386.512269754683;3028.6971302869756;3064.4024415239037;3066.5860108885463;3150.5904232449866;3163.73108285796;11382;11435.14236432271;11717.824232636518;12373.566925157666;16410.09744464054;1968.202877834465;2027.6147531969027;2035.7862424445516;2041.203930467119;2041.2855500574829;96477.5176124122;97939.51030244803;98779.50610246975;99049;100743;10606.946965265124;11102.666919992413;11151.163662725328;11632.767344653059;12368.75262494745;16702.08138552367;17319;17332.133393330536;17378.739318910226;18020.189091490913;9464.621415143318;9565.952170239105;9635.710928672152;9654.324197306261;9754.512274386252;9311.674091406769;9321.487318197429;9329;9431.104045115702;9540.379875308083;5301.867453313698;5304.416514183436;5394.9460505394445;5463.098588732894;5528.198411230349;2186.2238905188747;2188.3434969509403;2196.4728465168564;2225.688403623494;2248.134468229743;947.8293907096651;951.9857202141974;963.0995019656643;964.1563631822156;967.5404183013012;18333.89996600208;19841.30555430553;20217.797822021592;20905;21132.56975447843;938.877945867033;945.8013817098349;956.2445667922402;956.5552018311519;970.2383628851459;10966;11711;11751.588694395827;11796.70508237301;11907.88092119085;653348;656866;678201;686019;705192;85149;99544;109387.53062346851;110635.44682276699;114362;1087.478010554938;1112.1881026850444;1122.7032777142413;1123.915706322029;1129.288548214636;18057.548561286072;18061.819381806014;18426.447206583824;18445.077746112373;18667.533311667317;42331.1533769329;43556.12887742291;43592.56407435885;43866;45855.77072114618;62490;64450.67774661096;64841.35158648542;65345.673271633335;66217;6012.1582978382185;9528.19010384125;9566.186874115778;9771.560279787285;9812.852807207755;12942.482300707867;14310.284485775877;14544.85455145435;14831.40674373013;14901.329440175;12537.93731031339;12566.120371574269;12586.748265034832;12622.053345998904;12769;12374.381280935737;12513.374331283218;12570.308633025272;12618.684532886751;12769.106162568902;12199.207051541622;12413.75172496563;12480.313582752673;12624.431900564681;13050.34748262564;9490.145886870216;9639;9690.51547422612;9729.416235025921;9955;9174;11649.41752912334;11805.527778888749;11847.407629618658;12147.75704485923 09:31:56 INFO - PROCESS | 4943 | |3;mootools.html;1461.2328527523043;1468.6475245940974;1474.6460849396149;1503.0981411153302;1527.2516466931204;8286.461380010294;8833.07252738463;8837.955810220948;8843.734687959355;8850.33622478315;7748.1864404237585;7841.6079196040255;7891.408144389179;8078;8694.21752042316;2380.381100913762;2463.0640356664444;2472.8269021168526;2493.1523282084086;2497.1884137655243;2451.36264571211;2471.1104002559064;2488.950220995579;2490.8754562271906;2494.3140636324974;2461.6307553866973;2463.0640356664444;2484.24230609664;2488.664030355906;2489.962650560243;2325.662778897059;2340.8946597403074;2342.26218741096;2345.6598793174894;2345.882705864717;2364.8226383021342;2365.1249037855932;2423.903043878243;2428.720697119836;2434.57394955882;8754.912450875474;8819.029906710257;8830.337724670675;8840.469571825712;8843.513606751627;5273.499017593323;5412.864678383072;5452.263944367499;5453.836384908459;5464.23500709901;3372.1232479555247;3443.2252743132844;3547.875824346161;3599.892003239907;3631.164832088608;1238.4674589926328;1332.1607387346007;1355.4578168732487;1405.7680482720339;1463.8536146385277;11867.643970680894;11899.524019039229;11903.583374581935;11906.166568340219;11917.821232681517;4732.78330357056;4740;4759.571638552477;4804.543568361;4923.950760492349;10303.124234440007;10305.124064454605;10308.226882983807;10313.432761198206;10317.896821031844;5489.835304940858;5500.037493438632;5501.284832971688;5503.752331145028;5506.284183056177;4455.376247325377;4912.852614421573;5019.598432125421;5020.924686129711;5038.370203724535;3875.2249550090096;4124.8556300529335;4161.418660908836;4236.428082208924;4265.0616864289805;1367.2548461088531;1383.259955923576;1390.7496650602786;1391.5129704603307;1403.5648948825897;892.6964831957166;895.2927187521785;914.4239129348468;941.1435593609782;975.3270243532082;5828.504577110908;5832.358440571534;5967.850803729942;6111.35830737775;6438.45273151778;1056.772793849326;1080.6271836216492;1085.5549224817787;1102.0687519046394;1118.7091356247433;3954.4859168307935;4275.893102672396;4283.271843786564;4338.717983331074;4417.2269852775635;10295.279330446947;10461.372317660966;10499.475026248658;10532.57869685204;10591.258611897094;10210.183185345155;10231.7442063949;10351.327163734333;10396.116330112025;10464.21518386124;8112.269895709414;8122.837543249102;8293.21214484623;8307.210814972688;8318.168183181633;5878.441548052928;5899.321578018411;5990.670513121646;6025.246844144482;6027.336992930862;9243;9437.645731290148;9486.193673537826;9507.952460237932;9631.662891798753;9561.187299079656;9605.327627066039;9691.951540242253;9793.902060979584;9915.801683966425;7230.313120253568;7277.38142257914;7356.558606483628;7360.33756961876;7375.631218438949;8110.83778324442;8317.542535160625;8320;8324.6670133194;8332.875006874781;7478.962605186939;7538.3969282458365;7568.886466703114;7734.497257678458;7811.257930496594;7333.523320984119;7446;7486.663100160397;7501.362384197186;7541.4343924207005;6770.6614669265355;6860.691268892812;6865.485088618473;6866.313368663094;6868.175818901764;5271.89456210866;5335.919961200508;5350.384705758887;5377.112776392008;5469.9179512306555;5258.1849813279005;5365.463453654604;5392.083345831296;5408.864778380572;5497.752601133038 09:31:56 INFO - PROCESS | 4943 | |4;prototype.html;398.934175860983;411.07097958613537;412.7832887733939;413.19427117121603;414.90042389826453;4975.389906896758;5269.5520880725135;5338.946610533893;5376.9193462098;5389.8113566025195;5008.974955125219;5146.382434107903;5185.637005409623;5239.1093514102595;5302.867428314294;4289.678274129437;4302.161078589676;4317.13657268546;4334.956650433503;4347.13057388522;4346.826126954918;4364.192624364487;4366.607005369516;4379;4394.582514661102;4098.446709694183;4103.261412945669;4220.818170912149;4342.283523218665;4347.717398369112;4197.328427451624;4306.35404689296;4307.138572285556;4321.370049158706;4331.675124365669;3907.5310962684375;3911.4523966644692;3916.2167566486814;3927.960720392788;3928.626780455852;5036.320096786923;5148.716820574867;5156.20078887773;5197.298364720752;5214.556762675177;4881.585065269456;4892;4950.801967921278;4962.6526143169995;4963.528464795839;5517.006938751023;5562.608078526232;5565.41563135873;5592.832215033555;5645.23789288449;3872.845086196549;4069.1454794493193;4074.694397920168;4312.180685669713;4338.848140315074;5735.050082971768;5737.598368114233;5739.942600573982;5757.337906140764;5761.625494342897;4172.457580514514;4177.809324342547;4187.853425130106;4191.413202151702;4206.516250631216;4154.335306350969;4205.9789701051295;4208.6633069354375;4225.154969006211;4255.702100852911;4753.5008824072975;4763.1426343258545;4766.428028636586;4775.164346239394;4794.352762377034;5563.916541251884;5581.916271255935;5602.607817452821;5605.299337582802;5676.240365486629;1372.7302245422943;1416.3201663201721;1425.4796999095463;1430.3706369197728;1431.8854491640643;974.6004138303261;994.0258546624349;1000.4497526360473;1009.9293049486612;1011.2163073618005;5277.472252774692;5307.203919412119;5307.203919412119;5340.626156169031;5345.518903298722;5570.41510641385;5587.557891476286;5612.943870561324;5631.18347839561;5646.463585959327;5174.24973378858;5290.65610735301;5304.681719096867;5321.973390133025;5350.421625620451;2926.678065412803;2932.8533573321674;2937.397833444139;2943.9705602943695;2949.4690955627766;5731.541476681856;5757.712114394263;5759.596828221985;5768.44252051952;5785.756062446594;5519.613627046148;5567.749451274622;5642.661440313512;5643.943560564342;5646.717664116778;5711.6858572778065;5729.9713501432225;5740.741666625012;5751.884962300815;5760.654360738369;5290.550303224269;5483.533899618577;5492.258545096521;5576.693281869374;5585.916211256753;5402.216678581663;5405.702686352289;5414.7292635367285;5438.401775804579;5451.727413629382;5673.971630141823;5694.4590263924865;5708.942910570841;5775.306963164448;5779.190913272229;3920.5099362579676;4036.515618125726;4059.2084543513733;4168.8124034417915;4230.455883602402;5429.701366424884;5537.640053396516;5568.858384031345;5674.943250567607;5717.256756621613;5554.555635549227;5555.74995625981;5557.72211389437;5577.386487486455;5595.216669666332;5280.551153152025;5470.972645136749;5506.5870059744875;5537.612367134262;5559.6664200148125;5517.69652669107;5535.612507124462;5542.3903370630005;5543.972280138573;5548.334199895877;5608.831735047955;5614.466625670718;5633.521150702236;5635.802746903839;5647.209390685225;5218.4259731430275;5396.757145928521;5487.478689524489;5505.229267902417;5512.366077900932 09:31:56 INFO - PROCESS | 4943 | |5;yui.html;823.3948048184583;836.3518273338162;840.5209030852409;859.4370687199885;901.2024358442776;15471.69056618867;16378.181090945434;16458.423955161543;16512.25694843732;16537.83462165378;15875.920620396912;16271.267792949317;16362.672746545091;16404;16433.342666293363;696.6307856835886;706.883364244899;813.9552324622143;831.6673330667721;836.3016880904452;799.4084377560622;818.1818181818181;818.6888982186761;818.9262966333029;829.784256093414;867.8958524977012;869.1742844297911;870.6473878079356;871.4684042733927;871.5032431514039;734.566605702638;747.8691229034897;856.9614367353485;863.1282404771194;864.1962974433806;599.3347384403353;612.5895649914568;617.4072890025581;618.0852338538942;619.0559396919689;16087.678246435005;16107.597310067225;16729.83270167295;16934.407295744713;17025.48923532296;13913.30433478332;14346.56960291193;14347.282635868269;14369.209693466855;14709.70580588393;13526.526571569948;13535.120217185851;13560.254186019765;13727.313634318245;13912.165270083828;4679.461861885893;4680.789364478606;4690.460597031317;4889.853304400874;4896.608271338285;75004.62497687532;75654.99999999945;75776;77074.22925770727;79383;12317.199382040139;12454.439550220262;12465.93767031159;12541.18482298666;12623;23325.183618573268;23394.415139621306;23415.88292058529;23617.52764944726;23857.164999224944;7981.600919953979;8155.79610509742;8528.317734581342;8631.26634236097;8644.481331120152;4837.9032419351415;4888.780004899788;4930.161872481687;4987.077390682735;5022.924656130161;3929.0766669832565;4006.2187873364996;4036.4348991141264;4037.818298176589;4039.6970227233073;651.8761435327273;653.0987237612065;662.5031226580065;671.6205343980636;672.186654148476;837.8324335132997;855.5422848775875;864.6022829498376;875.59722527638;890.955452227386;10703;10804.513796879159;10877.564897404174;11387.658370248906;11427.200095993201;847.1147650705028;847.5126802088823;853.8249658819927;876.088867577712;877.1053525404179;5345.1714984177515;5399.730013499309;5435.701036443033;5449.86018970336;6074.3925607438905;60607.09089363575;61711.382886171465;61961.38038619556;63906;72760.63619681973;63729.36270637327;63855;63900.68049659815;65011.34988650148;65435.34564654388;58931.41068589345;58968.41031589715;59797.70101149466;60367.39632603706;61748;10438.164946804085;10996.505157268102;11005.61480348184;11160.330380177214;11162.944185279346;40818;41587.7920610395;41763;42039.3694094595;42631;48266.27600586064;50366.2445063317;51566.48433515767;52940.4705952951;54093.45906541042;13182.60452186436;13409;13428.328583570586;13509;13802.240876751473;14642.194679292315;14869.405223790927;14956.476523321631;14959.700805984037;14974.176420296988;14432.639184020483;14801.925990369979;15090.924545377204;15158.772618410512;15304.464343748361;14175.787363189354;14409;14429.278536073365;14441.711165776836;14645.487407941097;14175.929120354333;14559.34482948291;14620.415183392544;14651.853481465476;14664.633384165054;11317.830232546683;11520.366379848854;11788.410579471163;11806.46870890829;12384.56654017105;11335.829962550404;11460.885391145981;12120.27278363301;12286.32425216586;12334.50661973511 09:31:56 INFO - PROCESS | 4943 | __end_tp_report 09:31:56 INFO - PROCESS | 4943 | __start_cc_report 09:31:56 INFO - PROCESS | 4943 | _x_x_mozilla_cycle_collect,953 09:31:56 INFO - PROCESS | 4943 | __end_cc_report 09:31:56 INFO - PROCESS | 4943 | __startTimestamp1488735116667__endTimestamp 09:31:56 INFO - PROCESS | 4943 | 09:31:56 INFO - PROCESS | 4943 | ------- Summary: start ------- 09:31:56 INFO - PROCESS | 4943 | Number of tests: 6 09:31:56 INFO - PROCESS | 4943 | 09:31:56 INFO - PROCESS | 4943 | [#0] dojo.html Cycles:165 Average:5406.14 Median:5632.04 stddev:636.60 (11.3%) stddev-sans-first:615.98 09:31:56 INFO - PROCESS | 4943 | Values: 3264.5 3309.0 3323.6 3335.1 3356.1 5352.8 5446.0 5471.0 5481.2 5487.3 5431.1 5491.9 5503.3 5503.9 5513.8 4970.6 5001.9 5004.2 5036.5 5108.1 4869.8 4886.1 5021.9 5071.1 5077.8 4940.6 4944.5 5003.5 5048.3 5075.2 5006.3 5008.5 5012.3 5015.6 5039.2 4783.2 4963.0 4968.1 4989.0 5024.4 5195.5 5231.0 5288.5 5353.3 5405.5 5785.9 5787.9 5798.9 5799.1 5815.0 5720.6 5843.8 5851.9 5855.0 5874.1 5328.5 5391.3 5404.7 5415.7 5480.3 5905.8 5910.1 5924.2 5936.3 5945.2 5663.9 5708.3 5708.4 5722.3 5730.1 5592.2 5655.2 5771.9 5804.4 5811.2 5790.1 5803.2 5844.7 5874.2 5888.2 5830.8 5834.6 5837.0 5840.6 5850.4 4042.9 4075.9 4091.4 4104.0 4130.4 3676.7 3692.5 3706.5 3708.1 3723.5 5544.2 5551.5 5558.5 5566.1 5593.5 5747.0 5775.8 5776.2 5834.7 5855.9 5556.1 5621.3 5627.3 5658.6 5664.9 4998.8 5000.5 5002.4 5004.4 5025.5 5880.1 5918.3 6009.6 6054.0 6080.7 5774.7 5797.2 5807.0 5918.1 5949.8 6066.0 6091.4 6092.9 6116.3 6117.4 5575.7 5798.5 5802.1 5803.7 5813.6 5701.5 5872.9 5905.3 5915.0 5916.8 5705.7 5759.1 5759.9 5761.4 5762.3 5687.2 5763.4 5765.6 5778.3 5779.9 5554.2 5591.5 5606.9 5614.2 5619.6 5732.9 5740.3 5741.5 5742.5 5757.6 5620.7 5625.6 5632.0 5633.4 5633.8 09:31:56 INFO - PROCESS | 4943 | 09:31:56 INFO - PROCESS | 4943 | [#1] ext.html Cycles:180 Average:61725.48 Median:430244.50 stddev:118409.81 (27.5%) stddev-sans-first:118652.89 09:31:56 INFO - PROCESS | 4943 | Values: 548.1 582.3 601.2 602.2 606.6 34903.3 38362.8 38791.0 45716.5 46669.8 48539.0 48829.5 48889.3 48929.8 48974.8 9219.9 9375.6 9376.2 9413.3 9413.3 8838.6 9074.9 9078.3 9301.4 10871.2 10999.0 11412.4 11413.7 11420.1 11420.3 11371.9 11433.7 11434.2 11435.4 11440.5 11130.7 11174.3 11196.4 11207.8 11212.8 46135.8 46284.9 46304.0 46317.3 46357.8 4324.4 4424.8 4427.3 4533.9 4630.2 31179.1 31274.5 31391.1 31756.5 32506.7 4584.6 4608.7 4667.5 4741.5 4776.0 350324.0 352511.0 352574.0 353839.0 354654.0 56832.4 57300.0 57426.7 57576.7 57701.1 58457.0 58465.7 58469.4 58723.0 58765.0 18739.3 18953.2 19002.7 19068.8 19072.0 14928.7 14990.4 15029.9 15034.4 15076.2 16531.9 16866.3 16894.7 17974.3 18360.5 6837.9 7383.3 7452.0 7456.9 7571.9 1005.9 1009.6 1009.9 1016.6 1022.9 33906.5 33970.8 34228.1 34326.5 34635.7 1084.4 1183.3 1187.7 1213.7 1225.5 17245.5 18273.8 18307.8 18371.3 18448.4 535906.0 539856.0 540634.0 542077.0 542094.0 63704.4 64792.4 64908.4 64969.7 65019.7 1515.2 1527.6 1529.8 1536.9 1567.1 32034.2 33413.7 33709.0 33711.5 33909.0 56288.7 56294.4 56837.4 56841.7 56983.7 428951.0 430239.0 430250.0 431784.0 432584.0 30200.5 31422.5 31431.8 31438.1 31454.0 52224.0 52929.5 53084.0 53266.7 54581.5 43336.3 43480.1 43621.6 43807.3 45736.3 43430.0 43791.0 44300.8 44817.0 45500.1 43070.0 43144.8 43408.3 43839.3 44002.1 35854.6 37577.8 38056.8 38773.0 38981.6 28616.3 28913.1 28947.4 29044.6 29075.9 09:31:56 INFO - PROCESS | 4943 | 09:31:56 INFO - PROCESS | 4943 | [#2] jquery.html Cycles:180 Average:35772.53 Median:3108.59 stddev:111116.79 (3574.5%) stddev-sans-first:111396.73 09:31:56 INFO - PROCESS | 4943 | Values: 387.5 445.5 448.6 449.6 450.3 19394.4 20557.5 20816.7 20876.0 20985.5 14485.1 15403.3 21415.8 21931.6 22117.8 5616.6 5787.3 5798.5 5802.0 5802.3 5509.5 6909.9 6947.0 7054.2 7061.9 6796.5 6898.0 6971.0 7018.8 7043.5 6704.1 6930.4 6959.3 6960.1 6967.2 6097.3 6158.3 6168.8 6169.1 6169.8 14869.7 14909.8 23591.8 23619.0 24386.5 3028.7 3064.4 3066.6 3150.6 3163.7 11382.0 11435.1 11717.8 12373.6 16410.1 1968.2 2027.6 2035.8 2041.2 2041.3 96477.5 97939.5 98779.5 99049.0 100743.0 10606.9 11102.7 11151.2 11632.8 12368.8 16702.1 17319.0 17332.1 17378.7 18020.2 9464.6 9566.0 9635.7 9654.3 9754.5 9311.7 9321.5 9329.0 9431.1 9540.4 5301.9 5304.4 5394.9 5463.1 5528.2 2186.2 2188.3 2196.5 2225.7 2248.1 947.8 952.0 963.1 964.2 967.5 18333.9 19841.3 20217.8 20905.0 21132.6 938.9 945.8 956.2 956.6 970.2 10966.0 11711.0 11751.6 11796.7 11907.9 653348.0 656866.0 678201.0 686019.0 705192.0 85149.0 99544.0 109387.5 110635.4 114362.0 1087.5 1112.2 1122.7 1123.9 1129.3 18057.5 18061.8 18426.4 18445.1 18667.5 42331.2 43556.1 43592.6 43866.0 45855.8 62490.0 64450.7 64841.4 65345.7 66217.0 6012.2 9528.2 9566.2 9771.6 9812.9 12942.5 14310.3 14544.9 14831.4 14901.3 12537.9 12566.1 12586.7 12622.1 12769.0 12374.4 12513.4 12570.3 12618.7 12769.1 12199.2 12413.8 12480.3 12624.4 13050.3 9490.1 9639.0 9690.5 9729.4 9955.0 9174.0 11649.4 11805.5 11847.4 12147.8 09:31:56 INFO - PROCESS | 4943 | 09:31:56 INFO - PROCESS | 4943 | [#3] mootools.html Cycles:180 Average:5755.74 Median:5265.04 stddev:3112.19 (59.1%) stddev-sans-first:3104.18 09:31:56 INFO - PROCESS | 4943 | Values: 1461.2 1468.6 1474.6 1503.1 1527.3 8286.5 8833.1 8838.0 8843.7 8850.3 7748.2 7841.6 7891.4 8078.0 8694.2 2380.4 2463.1 2472.8 2493.2 2497.2 2451.4 2471.1 2489.0 2490.9 2494.3 2461.6 2463.1 2484.2 2488.7 2490.0 2325.7 2340.9 2342.3 2345.7 2345.9 2364.8 2365.1 2423.9 2428.7 2434.6 8754.9 8819.0 8830.3 8840.5 8843.5 5273.5 5412.9 5452.3 5453.8 5464.2 3372.1 3443.2 3547.9 3599.9 3631.2 1238.5 1332.2 1355.5 1405.8 1463.9 11867.6 11899.5 11903.6 11906.2 11917.8 4732.8 4740.0 4759.6 4804.5 4924.0 10303.1 10305.1 10308.2 10313.4 10317.9 5489.8 5500.0 5501.3 5503.8 5506.3 4455.4 4912.9 5019.6 5020.9 5038.4 3875.2 4124.9 4161.4 4236.4 4265.1 1367.3 1383.3 1390.7 1391.5 1403.6 892.7 895.3 914.4 941.1 975.3 5828.5 5832.4 5967.9 6111.4 6438.5 1056.8 1080.6 1085.6 1102.1 1118.7 3954.5 4275.9 4283.3 4338.7 4417.2 10295.3 10461.4 10499.5 10532.6 10591.3 10210.2 10231.7 10351.3 10396.1 10464.2 8112.3 8122.8 8293.2 8307.2 8318.2 5878.4 5899.3 5990.7 6025.2 6027.3 9243.0 9437.6 9486.2 9508.0 9631.7 9561.2 9605.3 9692.0 9793.9 9915.8 7230.3 7277.4 7356.6 7360.3 7375.6 8110.8 8317.5 8320.0 8324.7 8332.9 7479.0 7538.4 7568.9 7734.5 7811.3 7333.5 7446.0 7486.7 7501.4 7541.4 6770.7 6860.7 6865.5 6866.3 6868.2 5271.9 5335.9 5350.4 5377.1 5469.9 5258.2 5365.5 5392.1 5408.9 5497.8 09:31:56 INFO - PROCESS | 4943 | 09:31:56 INFO - PROCESS | 4943 | [#4] prototype.html Cycles:180 Average:4691.42 Median:5303.77 stddev:1327.63 (25.0%) stddev-sans-first:1291.68 09:31:56 INFO - PROCESS | 4943 | Values: 398.9 411.1 412.8 413.2 414.9 4975.4 5269.6 5338.9 5376.9 5389.8 5009.0 5146.4 5185.6 5239.1 5302.9 4289.7 4302.2 4317.1 4335.0 4347.1 4346.8 4364.2 4366.6 4379.0 4394.6 4098.4 4103.3 4220.8 4342.3 4347.7 4197.3 4306.4 4307.1 4321.4 4331.7 3907.5 3911.5 3916.2 3928.0 3928.6 5036.3 5148.7 5156.2 5197.3 5214.6 4881.6 4892.0 4950.8 4962.7 4963.5 5517.0 5562.6 5565.4 5592.8 5645.2 3872.8 4069.1 4074.7 4312.2 4338.8 5735.1 5737.6 5739.9 5757.3 5761.6 4172.5 4177.8 4187.9 4191.4 4206.5 4154.3 4206.0 4208.7 4225.2 4255.7 4753.5 4763.1 4766.4 4775.2 4794.4 5563.9 5581.9 5602.6 5605.3 5676.2 1372.7 1416.3 1425.5 1430.4 1431.9 974.6 994.0 1000.4 1009.9 1011.2 5277.5 5307.2 5307.2 5340.6 5345.5 5570.4 5587.6 5612.9 5631.2 5646.5 5174.2 5290.7 5304.7 5322.0 5350.4 2926.7 2932.9 2937.4 2944.0 2949.5 5731.5 5757.7 5759.6 5768.4 5785.8 5519.6 5567.7 5642.7 5643.9 5646.7 5711.7 5730.0 5740.7 5751.9 5760.7 5290.6 5483.5 5492.3 5576.7 5585.9 5402.2 5405.7 5414.7 5438.4 5451.7 5674.0 5694.5 5708.9 5775.3 5779.2 3920.5 4036.5 4059.2 4168.8 4230.5 5429.7 5537.6 5568.9 5674.9 5717.3 5554.6 5555.7 5557.7 5577.4 5595.2 5280.6 5471.0 5506.6 5537.6 5559.7 5517.7 5535.6 5542.4 5544.0 5548.3 5608.8 5614.5 5633.5 5635.8 5647.2 5218.4 5396.8 5487.5 5505.2 5512.4 09:31:56 INFO - PROCESS | 4943 | 09:31:56 INFO - PROCESS | 4943 | [#5] yui.html Cycles:180 Average:17337.07 Median:4680.13 stddev:20447.83 (436.9%) stddev-sans-first:20467.59 09:31:56 INFO - PROCESS | 4943 | Values: 823.4 836.4 840.5 859.4 901.2 15471.7 16378.2 16458.4 16512.3 16537.8 15875.9 16271.3 16362.7 16404.0 16433.3 696.6 706.9 814.0 831.7 836.3 799.4 818.2 818.7 818.9 829.8 867.9 869.2 870.6 871.5 871.5 734.6 747.9 857.0 863.1 864.2 599.3 612.6 617.4 618.1 619.1 16087.7 16107.6 16729.8 16934.4 17025.5 13913.3 14346.6 14347.3 14369.2 14709.7 13526.5 13535.1 13560.3 13727.3 13912.2 4679.5 4680.8 4690.5 4889.9 4896.6 75004.6 75655.0 75776.0 77074.2 79383.0 12317.2 12454.4 12465.9 12541.2 12623.0 23325.2 23394.4 23415.9 23617.5 23857.2 7981.6 8155.8 8528.3 8631.3 8644.5 4837.9 4888.8 4930.2 4987.1 5022.9 3929.1 4006.2 4036.4 4037.8 4039.7 651.9 653.1 662.5 671.6 672.2 837.8 855.5 864.6 875.6 891.0 10703.0 10804.5 10877.6 11387.7 11427.2 847.1 847.5 853.8 876.1 877.1 5345.2 5399.7 5435.7 5449.9 6074.4 60607.1 61711.4 61961.4 63906.0 72760.6 63729.4 63855.0 63900.7 65011.3 65435.3 58931.4 58968.4 59797.7 60367.4 61748.0 10438.2 10996.5 11005.6 11160.3 11162.9 40818.0 41587.8 41763.0 42039.4 42631.0 48266.3 50366.2 51566.5 52940.5 54093.5 13182.6 13409.0 13428.3 13509.0 13802.2 14642.2 14869.4 14956.5 14959.7 14974.2 14432.6 14801.9 15090.9 15158.8 15304.5 14175.8 14409.0 14429.3 14441.7 14645.5 14175.9 14559.3 14620.4 14651.9 14664.6 11317.8 11520.4 11788.4 11806.5 12384.6 11335.8 11460.9 12120.3 12286.3 12334.5 09:31:56 INFO - PROCESS | 4943 | -------- Summary: end -------- 09:31:56 INFO - PROCESS | 4943 | 09:31:57 INFO - TEST-INFO | 4943: exit 0 09:31:57 INFO - TEST-OK | dromaeo_css | took 1114443ms 09:31:57 INFO - TEST-START | kraken 09:31:57 INFO - operating with platform_type : linux_ 09:31:57 INFO - Initialising browser for kraken test... 09:31:57 INFO - TEST-INFO | started process 5262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3etFcg/profile http://localhost:51355/getInfo.html) 09:32:01 INFO - PROCESS | 5262 | __metrics Screen width/height:1600/1200 09:32:01 INFO - PROCESS | 5262 | colorDepth:24 09:32:01 INFO - PROCESS | 5262 | Browser inner width/height: 1024/697 09:32:01 INFO - PROCESS | 5262 | __metrics 09:32:02 INFO - PROCESS | 5262 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:32:02 INFO - PROCESS | 5262 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:32:03 INFO - TEST-INFO | 5262: exit 0 09:32:03 INFO - Browser initialized. 09:32:03 INFO - Running cycle 1/1 for kraken test... 09:32:03 INFO - TEST-INFO | started process 5352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3etFcg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:32:15 INFO - PROCESS | 5352 | RSS: Main: 138588160 09:32:15 INFO - PROCESS | 5352 | 09:32:17 INFO - PROCESS | 5352 | Cycle 1(1): loaded http://localhost:51355/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51355/tests/kraken/driver.html?testName=audio-beat-detection) 09:32:18 INFO - PROCESS | 5352 | RSS: Main: 181633024 09:32:18 INFO - PROCESS | 5352 | 09:32:21 INFO - PROCESS | 5352 | Cycle 1(1): loaded http://localhost:51355/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51355/tests/kraken/driver.html?testName=audio-dft) 09:32:21 INFO - PROCESS | 5352 | RSS: Main: 172937216 09:32:21 INFO - PROCESS | 5352 | 09:32:24 INFO - PROCESS | 5352 | Cycle 1(1): loaded http://localhost:51355/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51355/tests/kraken/driver.html?testName=audio-fft) 09:32:25 INFO - PROCESS | 5352 | RSS: Main: 263581696 09:32:25 INFO - PROCESS | 5352 | 09:32:27 INFO - PROCESS | 5352 | Cycle 1(1): loaded http://localhost:51355/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51355/tests/kraken/driver.html?testName=audio-oscillator) 09:32:27 INFO - PROCESS | 5352 | RSS: Main: 170082304 09:32:27 INFO - PROCESS | 5352 | 09:32:29 INFO - PROCESS | 5352 | Cycle 1(1): loaded http://localhost:51355/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51355/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:32:30 INFO - PROCESS | 5352 | RSS: Main: 172814336 09:32:30 INFO - PROCESS | 5352 | 09:32:33 INFO - PROCESS | 5352 | Cycle 1(1): loaded http://localhost:51355/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51355/tests/kraken/driver.html?testName=imaging-darkroom) 09:32:34 INFO - PROCESS | 5352 | RSS: Main: 211456000 09:32:34 INFO - PROCESS | 5352 | 09:32:37 INFO - PROCESS | 5352 | Cycle 1(1): loaded http://localhost:51355/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51355/tests/kraken/driver.html?testName=imaging-desaturate) 09:32:38 INFO - PROCESS | 5352 | RSS: Main: 209838080 09:32:38 INFO - PROCESS | 5352 | 09:32:40 INFO - PROCESS | 5352 | Cycle 1(1): loaded http://localhost:51355/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51355/tests/kraken/driver.html?testName=json-parse-financial) 09:32:41 INFO - PROCESS | 5352 | RSS: Main: 208683008 09:32:41 INFO - PROCESS | 5352 | 09:32:42 INFO - PROCESS | 5352 | Cycle 1(1): loaded http://localhost:51355/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51355/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:32:43 INFO - PROCESS | 5352 | RSS: Main: 170897408 09:32:43 INFO - PROCESS | 5352 | 09:32:45 INFO - PROCESS | 5352 | Cycle 1(1): loaded http://localhost:51355/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51355/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:32:45 INFO - PROCESS | 5352 | RSS: Main: 177856512 09:32:45 INFO - PROCESS | 5352 | 09:32:47 INFO - PROCESS | 5352 | Cycle 1(1): loaded http://localhost:51355/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51355/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:32:48 INFO - PROCESS | 5352 | RSS: Main: 187469824 09:32:48 INFO - PROCESS | 5352 | 09:32:50 INFO - PROCESS | 5352 | Cycle 1(1): loaded http://localhost:51355/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51355/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:32:51 INFO - PROCESS | 5352 | RSS: Main: 195166208 09:32:51 INFO - PROCESS | 5352 | 09:32:54 INFO - PROCESS | 5352 | Cycle 1(1): loaded http://localhost:51355/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51355/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:32:54 INFO - PROCESS | 5352 | RSS: Main: 192192512 09:32:54 INFO - PROCESS | 5352 | 09:32:56 INFO - PROCESS | 5352 | Cycle 1(1): loaded http://localhost:51355/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51355/tests/kraken/driver.html?testName=ai-astar) 09:32:56 INFO - PROCESS | 5352 | RSS: Main: 242016256 09:32:56 INFO - PROCESS | 5352 | 09:32:56 INFO - PROCESS | 5352 | __start_tp_report 09:32:56 INFO - PROCESS | 5352 | _x_x_mozilla_page_load 09:32:56 INFO - PROCESS | 5352 | _x_x_mozilla_page_load_details 09:32:56 INFO - PROCESS | 5352 | |i|pagename|runs| 09:32:56 INFO - PROCESS | 5352 | |0;ai-astar;111;113;112;111;111;111;110;112;111;112 09:32:56 INFO - PROCESS | 5352 | |1;audio-beat-detection;154;117;120;163;128;118;118;117;138;118 09:32:56 INFO - PROCESS | 5352 | |2;audio-dft;161;159;163;160;160;161;160;159;161;159 09:32:56 INFO - PROCESS | 5352 | |3;audio-fft;75;76;77;104;76;76;75;76;90;75 09:32:56 INFO - PROCESS | 5352 | |4;audio-oscillator;82;82;105;83;83;82;95;83;83;106 09:32:56 INFO - PROCESS | 5352 | |5;imaging-gaussian-blur;118;117;117;117;117;116;117;116;117;116 09:32:56 INFO - PROCESS | 5352 | |6;imaging-darkroom;147;147;147;145;149;148;148;148;148;147 09:32:56 INFO - PROCESS | 5352 | |7;imaging-desaturate;97;96;96;95;96;96;96;96;96;95 09:32:56 INFO - PROCESS | 5352 | |8;json-parse-financial;49;51;49;49;49;49;49;49;49;49 09:32:56 INFO - PROCESS | 5352 | |9;json-stringify-tinderbox;65;64;64;64;64;64;66;63;65;64 09:32:56 INFO - PROCESS | 5352 | |10;stanford-crypto-aes;75;83;75;77;79;76;79;75;80;74 09:32:56 INFO - PROCESS | 5352 | |11;stanford-crypto-ccm;120;129;122;119;125;125;126;118;161;120 09:32:56 INFO - PROCESS | 5352 | |12;stanford-crypto-pbkdf2;167;160;159;161;162;159;158;162;156;161 09:32:56 INFO - PROCESS | 5352 | |13;stanford-crypto-sha256-iterative;63;70;62;60;62;62;62;61;62;60 09:32:56 INFO - PROCESS | 5352 | __end_tp_report 09:32:56 INFO - PROCESS | 5352 | __start_cc_report 09:32:56 INFO - PROCESS | 5352 | _x_x_mozilla_cycle_collect,1501 09:32:56 INFO - PROCESS | 5352 | __end_cc_report 09:32:56 INFO - PROCESS | 5352 | __startTimestamp1488735176791__endTimestamp 09:32:56 INFO - PROCESS | 5352 | 09:32:56 INFO - PROCESS | 5352 | ------- Summary: start ------- 09:32:56 INFO - PROCESS | 5352 | Number of tests: 14 09:32:56 INFO - PROCESS | 5352 | 09:32:56 INFO - PROCESS | 5352 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.50 stddev:0.84 (0.8%) stddev-sans-first:0.88 09:32:56 INFO - PROCESS | 5352 | Values: 111.0 113.0 112.0 111.0 111.0 111.0 110.0 112.0 111.0 112.0 09:32:56 INFO - PROCESS | 5352 | 09:32:56 INFO - PROCESS | 5352 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:124.00 stddev:16.98 (13.7%) stddev-sans-first:15.44 09:32:56 INFO - PROCESS | 5352 | Values: 154.0 117.0 120.0 163.0 128.0 118.0 118.0 117.0 138.0 118.0 09:32:56 INFO - PROCESS | 5352 | 09:32:56 INFO - PROCESS | 5352 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:1.25 (0.8%) stddev-sans-first:1.30 09:32:56 INFO - PROCESS | 5352 | Values: 161.0 159.0 163.0 160.0 160.0 161.0 160.0 159.0 161.0 159.0 09:32:56 INFO - PROCESS | 5352 | 09:32:56 INFO - PROCESS | 5352 | [#3] audio-fft Cycles:10 Average:80.00 Median:76.00 stddev:9.57 (12.6%) stddev-sans-first:9.98 09:32:56 INFO - PROCESS | 5352 | Values: 75.0 76.0 77.0 104.0 76.0 76.0 75.0 76.0 90.0 75.0 09:32:56 INFO - PROCESS | 5352 | 09:32:56 INFO - PROCESS | 5352 | [#4] audio-oscillator Cycles:10 Average:88.40 Median:83.00 stddev:9.82 (11.8%) stddev-sans-first:10.14 09:32:56 INFO - PROCESS | 5352 | Values: 82.0 82.0 105.0 83.0 83.0 82.0 95.0 83.0 83.0 106.0 09:32:56 INFO - PROCESS | 5352 | 09:32:56 INFO - PROCESS | 5352 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 09:32:56 INFO - PROCESS | 5352 | Values: 118.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 09:32:56 INFO - PROCESS | 5352 | 09:32:56 INFO - PROCESS | 5352 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 09:32:56 INFO - PROCESS | 5352 | Values: 147.0 147.0 147.0 145.0 149.0 148.0 148.0 148.0 148.0 147.0 09:32:56 INFO - PROCESS | 5352 | 09:32:56 INFO - PROCESS | 5352 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 09:32:56 INFO - PROCESS | 5352 | Values: 97.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 09:32:56 INFO - PROCESS | 5352 | 09:32:56 INFO - PROCESS | 5352 | [#8] json-parse-financial Cycles:10 Average:49.20 Median:49.00 stddev:0.63 (1.3%) stddev-sans-first:0.67 09:32:56 INFO - PROCESS | 5352 | Values: 49.0 51.0 49.0 49.0 49.0 49.0 49.0 49.0 49.0 49.0 09:32:56 INFO - PROCESS | 5352 | 09:32:56 INFO - PROCESS | 5352 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 09:32:56 INFO - PROCESS | 5352 | Values: 65.0 64.0 64.0 64.0 64.0 64.0 66.0 63.0 65.0 64.0 09:32:56 INFO - PROCESS | 5352 | 09:32:56 INFO - PROCESS | 5352 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:78.00 stddev:2.87 (3.7%) stddev-sans-first:2.92 09:32:56 INFO - PROCESS | 5352 | Values: 75.0 83.0 75.0 77.0 79.0 76.0 79.0 75.0 80.0 74.0 09:32:56 INFO - PROCESS | 5352 | 09:32:56 INFO - PROCESS | 5352 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:125.00 stddev:12.62 (10.1%) stddev-sans-first:13.17 09:32:56 INFO - PROCESS | 5352 | Values: 120.0 129.0 122.0 119.0 125.0 125.0 126.0 118.0 161.0 120.0 09:32:56 INFO - PROCESS | 5352 | 09:32:56 INFO - PROCESS | 5352 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:161.00 stddev:2.95 (1.8%) stddev-sans-first:1.99 09:32:56 INFO - PROCESS | 5352 | Values: 167.0 160.0 159.0 161.0 162.0 159.0 158.0 162.0 156.0 161.0 09:32:56 INFO - PROCESS | 5352 | 09:32:56 INFO - PROCESS | 5352 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:2.84 (4.6%) stddev-sans-first:3.00 09:32:56 INFO - PROCESS | 5352 | Values: 63.0 70.0 62.0 60.0 62.0 62.0 62.0 61.0 62.0 60.0 09:32:56 INFO - PROCESS | 5352 | -------- Summary: end -------- 09:32:56 INFO - PROCESS | 5352 | 09:32:57 INFO - TEST-INFO | 5352: exit 0 09:32:57 INFO - TEST-OK | kraken | took 60445ms 09:32:57 INFO - SUITE-END | took 1174s 09:32:57 INFO - Completed test suite (00:19:34) 09:32:57 INFO - javascript benchmark 09:32:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3264.4940034294686, 3309.023837967801, 3323.601167859857, 3335.132865454981, 3356.093854659242, 5352.759125839337, 5446.046941785192, 5471.042567550678, 5481.232627432158, 5487.314085739283, 5431.103867861798, 5491.862703432416, 5503.3120859892515, 5503.862403439916, 5513.807016754405, 4970.627202959783, 5001.874953126165, 5004.174311238641, 5036.546710796028, 5108.080545501808, 4869.780859861297, 4886.1204983103025, 5021.924671129936, 5071.061853557104, 5077.771500282496, 4940.629452791037, 4944.505549445044, 5003.499650034985, 5048.343715317003, 5075.162598171298, 5006.3241462402475, 5008.474110218447, 5012.323336349583, 5015.623828212881, 5039.193729003342, 4783.186858234074, 4962.950370496285, 4968.105740966625, 4988.975055124737, 5024.447310795809, 5195.532402083831, 5230.979958908015, 5288.471152884719, 5353.330833645794, 5405.459454054602, 5785.942140578582, 5787.855303617401, 5798.855028624276, 5799.130130480419, 5815.040518314473, 5720.570957178186, 5843.795467158629, 5851.941480585225, 5855.033919403293, 5874.089516125007, 5328.520433160996, 5391.272178255964, 5404.675719456766, 5415.675059496364, 5480.26016487773, 5905.793297234576, 5910.143029260733, 5924.20023296858, 5936.257967754031, 5945.197398351167, 5663.858403539862, 5708.343540492813, 5708.40061793514, 5722.313322401255, 5730.111832665943, 5592.217089607459, 5655.236543066716, 5771.88456230873, 5804.361520232771, 5811.244538210006, 5790.10253410722, 5803.187553742479, 5844.678542680108, 5874.1776151338845, 5888.175655408247, 5830.795922142789, 5834.649921004753, 5837.036888913367, 5840.561957853178, 5850.3564607893095, 4042.8787136385954, 4075.91848163041, 4091.4476545665952, 4103.994521342291, 4130.421740956269, 3676.7058635309645, 3692.464592634107, 3706.4625629283605, 3708.128589781399, 3723.497327860704, 5544.22380866679, 5551.472610102034, 5558.527525160407, 5566.053770858964, 5593.468620481048, 5746.96554620164, 5775.768969241183, 5776.220210271644, 5834.737436815353, 5855.912161317584, 5556.138798486241, 5621.269234999506, 5627.324721033502, 5658.575606829504, 5664.85837854057, 4998.775055122528, 5000.549950504399, 5002.424721157114, 5004.374453193351, 5025.522575355335, 5880.147378629989, 5918.260217472816, 6009.639421634716, 6054.03135498327, 6080.665563394055, 5774.740136693943, 5797.246357973437, 5806.970965145148, 5918.112283157388, 5949.791757288474, 6065.969670151798, 6091.42131497507, 6092.8781424372155, 6116.29662588808, 6117.388261174025, 5575.665460072409, 5798.478136967693, 5802.071668533014, 5803.709814509342, 5813.56398270123, 5701.486866182064, 5872.853178670567, 5905.320888097924, 5915.024021036481, 5916.822495325147, 5705.7432415542235, 5759.136129580596, 5759.8560035999435, 5761.366249712444, 5762.337331206965, 5687.175359572756, 5763.36602973681, 5765.625234359753, 5778.306603207642, 5779.942200577941, 5554.166874968787, 5591.4688104629995, 5606.943930560806, 5614.24207731951, 5619.550435965031, 5732.885342293214, 5740.282464691913, 5741.483266506035, 5742.483176514133, 5757.596968212352, 5620.74706638194, 5625.606207565431, 5632.042552766122, 5633.352164501135, 5633.774649013993], "value": 5361.917261799618, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.0909432008701, 582.3419535924405, 601.2424345324893, 602.2411761180911, 606.6269244414685, 34903.30193396134, 38362.808185959104, 38791.0, 45716.54283457164, 46669.766651166785, 48539.0, 48829.51170488303, 48889.26666100011, 48929.755351223284, 48974.75512622432, 9219.861702074491, 9375.624975000992, 9376.249900008017, 9413.341066125375, 9413.341066125375, 8838.602262898154, 9074.86387704185, 9078.319126065539, 9301.441913485212, 10871.184661150406, 10999.0, 11412.372319522423, 11413.714657133554, 11420.086393088533, 11420.257683250562, 11371.886281137165, 11433.714157146054, 11434.199606027581, 11435.371054591995, 11440.542378304857, 11130.666080017612, 11174.27367221128, 11196.384198869058, 11207.775844483065, 11212.831807522894, 46135.769321153515, 46284.91717872704, 46304.0, 46317.30524042142, 46357.76821115873, 4324.416203812477, 4424.823007079713, 4427.29163333865, 4533.9319910201375, 4630.21286381316, 31179.08632275808, 31274.530882036786, 31391.05826825176, 31756.523652145235, 32506.6749332506, 4584.564466375689, 4608.746518941457, 4667.509911459282, 4741.525847415231, 4775.9731657693765, 350324.0, 352510.99999999744, 352573.99999999744, 353839.0, 354654.0, 56832.43167568354, 57300.0, 57426.7128664354, 57576.71211643999, 57701.13448298279, 58457.0, 58465.70767146222, 58469.4153058464, 58723.0, 58765.0, 18739.344122955903, 18953.241870325033, 19002.71495927562, 19068.80931190698, 19072.046397680337, 14928.70142597142, 14990.400383984737, 15029.924850375679, 15034.398624054915, 15076.246187690791, 16531.91734041322, 16866.32534698623, 16894.66210675804, 17974.281028758964, 18360.540986475444, 6837.897431538531, 7383.335499804936, 7452.013172952445, 7456.888146677804, 7571.924280757122, 1005.8692369991854, 1009.5961615353917, 1009.9192064634811, 1016.5577973581516, 1022.9283950123569, 33906.49140262898, 33970.77601069177, 34228.14429639279, 34326.485102723476, 34635.653643463746, 1084.360227465799, 1183.3018519073787, 1187.7386974865515, 1213.6844420450745, 1225.4852961756085, 17245.482635520955, 18273.81726182721, 18307.81692183061, 18371.26514939414, 18448.35430759917, 535906.0, 539856.0, 540634.0, 542077.0, 542094.0, 63704.36295636984, 64792.352076479576, 64908.350916491174, 64969.675151624884, 65019.67490162519, 1515.2272341106116, 1527.633367991674, 1529.8470152984612, 1536.9385224590892, 1567.0910871694389, 32034.19914502156, 33413.66345346159, 33709.0, 33711.494327584616, 33909.0, 56288.71855640696, 56294.43705562892, 56837.43162568322, 56841.71579142078, 56983.71508142599, 428951.0, 430239.0, 430250.0, 431784.0, 432584.0, 30200.5469917947, 31422.528662070545, 31431.842840785648, 31438.056858294287, 31454.0, 52224.0, 52929.47070529246, 53084.0, 53266.73366633297, 54581.45418545764, 43336.349954751335, 43480.13039739251, 43621.56378436175, 43807.34288985604, 45736.31395529003, 43430.0, 43791.0, 44300.77849610731, 44817.0, 45500.089998200514, 43070.0, 43144.78427607842, 43408.34887476754, 43839.34240986451, 44002.11995760131, 35854.64145358618, 37577.81211093927, 38056.80971595124, 38773.0, 38981.6101838978, 28616.284592885346, 28913.132606021853, 28947.421051579273, 29044.56433153547, 29075.85462072676], "value": 21536.421735267904, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.5388287937356, 445.45431845988645, 448.585058820591, 449.6357950060451, 450.25258071601127, 19394.418167454965, 20557.486062848435, 20816.687749683766, 20876.0, 20985.47536311593, 14485.130892146479, 15403.306851191695, 21415.785842141573, 21931.561368772615, 22117.778822211774, 5616.550675945935, 5787.305523337184, 5798.478136967672, 5802.013657678205, 5802.303723553179, 5509.531689806371, 6909.896351554731, 6946.957956306544, 7054.153501579817, 7061.89407158893, 6796.524243302971, 6898.034275201476, 6970.965145174292, 7018.789436316893, 7043.5421697589745, 6704.094947182117, 6930.4109150722, 6959.338862808025, 6960.129983752056, 6967.198772141192, 6097.268327800648, 6158.261008678987, 6168.784092556739, 6169.074638804171, 6169.7532098716, 14869.702605947929, 14909.776353354708, 23591.820408979653, 23619.0, 24386.512269754683, 3028.6971302869756, 3064.4024415239037, 3066.5860108885463, 3150.5904232449866, 3163.73108285796, 11382.0, 11435.14236432271, 11717.824232636518, 12373.566925157666, 16410.09744464054, 1968.202877834465, 2027.6147531969027, 2035.7862424445516, 2041.203930467119, 2041.2855500574829, 96477.5176124122, 97939.51030244803, 98779.50610246975, 99049.0, 100743.0, 10606.946965265124, 11102.666919992413, 11151.163662725328, 11632.767344653059, 12368.75262494745, 16702.08138552367, 17319.0, 17332.133393330536, 17378.739318910226, 18020.189091490913, 9464.621415143318, 9565.952170239105, 9635.710928672152, 9654.324197306261, 9754.512274386252, 9311.674091406769, 9321.487318197429, 9329.0, 9431.104045115702, 9540.379875308083, 5301.867453313698, 5304.416514183436, 5394.9460505394445, 5463.098588732894, 5528.198411230349, 2186.2238905188747, 2188.3434969509403, 2196.4728465168564, 2225.688403623494, 2248.134468229743, 947.8293907096651, 951.9857202141974, 963.0995019656643, 964.1563631822156, 967.5404183013012, 18333.89996600208, 19841.30555430553, 20217.797822021592, 20905.0, 21132.56975447843, 938.877945867033, 945.8013817098349, 956.2445667922402, 956.5552018311519, 970.2383628851459, 10966.0, 11711.0, 11751.588694395827, 11796.70508237301, 11907.88092119085, 653348.0, 656866.0, 678201.0, 686019.0, 705192.0, 85149.0, 99544.0, 109387.53062346851, 110635.44682276699, 114362.0, 1087.478010554938, 1112.1881026850444, 1122.7032777142413, 1123.915706322029, 1129.288548214636, 18057.548561286072, 18061.819381806014, 18426.447206583824, 18445.077746112373, 18667.533311667317, 42331.1533769329, 43556.12887742291, 43592.56407435885, 43866.0, 45855.77072114618, 62490.0, 64450.67774661096, 64841.35158648542, 65345.673271633335, 66217.0, 6012.1582978382185, 9528.19010384125, 9566.186874115778, 9771.560279787285, 9812.852807207755, 12942.482300707867, 14310.284485775877, 14544.85455145435, 14831.40674373013, 14901.329440175, 12537.93731031339, 12566.120371574269, 12586.748265034832, 12622.053345998904, 12769.0, 12374.381280935737, 12513.374331283218, 12570.308633025272, 12618.684532886751, 12769.106162568902, 12199.207051541622, 12413.75172496563, 12480.313582752673, 12624.431900564681, 13050.34748262564, 9490.145886870216, 9639.0, 9690.51547422612, 9729.416235025921, 9955.0, 9174.0, 11649.41752912334, 11805.527778888749, 11847.407629618658, 12147.75704485923], "value": 10130.994389149864, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1461.2328527523043, 1468.6475245940974, 1474.6460849396149, 1503.0981411153302, 1527.2516466931204, 8286.461380010294, 8833.07252738463, 8837.955810220948, 8843.734687959355, 8850.33622478315, 7748.1864404237585, 7841.6079196040255, 7891.408144389179, 8078.0, 8694.21752042316, 2380.381100913762, 2463.0640356664444, 2472.8269021168526, 2493.1523282084086, 2497.1884137655243, 2451.36264571211, 2471.1104002559064, 2488.950220995579, 2490.8754562271906, 2494.3140636324974, 2461.6307553866973, 2463.0640356664444, 2484.24230609664, 2488.664030355906, 2489.962650560243, 2325.662778897059, 2340.8946597403074, 2342.26218741096, 2345.6598793174894, 2345.882705864717, 2364.8226383021342, 2365.1249037855932, 2423.903043878243, 2428.720697119836, 2434.57394955882, 8754.912450875474, 8819.029906710257, 8830.337724670675, 8840.469571825712, 8843.513606751627, 5273.499017593323, 5412.864678383072, 5452.263944367499, 5453.836384908459, 5464.23500709901, 3372.1232479555247, 3443.2252743132844, 3547.875824346161, 3599.892003239907, 3631.164832088608, 1238.4674589926328, 1332.1607387346007, 1355.4578168732487, 1405.7680482720339, 1463.8536146385277, 11867.643970680894, 11899.524019039229, 11903.583374581935, 11906.166568340219, 11917.821232681517, 4732.78330357056, 4740.0, 4759.571638552477, 4804.543568361, 4923.950760492349, 10303.124234440007, 10305.124064454605, 10308.226882983807, 10313.432761198206, 10317.896821031844, 5489.835304940858, 5500.037493438632, 5501.284832971688, 5503.752331145028, 5506.284183056177, 4455.376247325377, 4912.852614421573, 5019.598432125421, 5020.924686129711, 5038.370203724535, 3875.2249550090096, 4124.8556300529335, 4161.418660908836, 4236.428082208924, 4265.0616864289805, 1367.2548461088531, 1383.259955923576, 1390.7496650602786, 1391.5129704603307, 1403.5648948825897, 892.6964831957166, 895.2927187521785, 914.4239129348468, 941.1435593609782, 975.3270243532082, 5828.504577110908, 5832.358440571534, 5967.850803729942, 6111.35830737775, 6438.45273151778, 1056.772793849326, 1080.6271836216492, 1085.5549224817787, 1102.0687519046394, 1118.7091356247433, 3954.4859168307935, 4275.893102672396, 4283.271843786564, 4338.717983331074, 4417.2269852775635, 10295.279330446947, 10461.372317660966, 10499.475026248658, 10532.57869685204, 10591.258611897094, 10210.183185345155, 10231.7442063949, 10351.327163734333, 10396.116330112025, 10464.21518386124, 8112.269895709414, 8122.837543249102, 8293.21214484623, 8307.210814972688, 8318.168183181633, 5878.441548052928, 5899.321578018411, 5990.670513121646, 6025.246844144482, 6027.336992930862, 9243.0, 9437.645731290148, 9486.193673537826, 9507.952460237932, 9631.662891798753, 9561.187299079656, 9605.327627066039, 9691.951540242253, 9793.902060979584, 9915.801683966425, 7230.313120253568, 7277.38142257914, 7356.558606483628, 7360.33756961876, 7375.631218438949, 8110.83778324442, 8317.542535160625, 8320.0, 8324.6670133194, 8332.875006874781, 7478.962605186939, 7538.3969282458365, 7568.886466703114, 7734.497257678458, 7811.257930496594, 7333.523320984119, 7446.0, 7486.663100160397, 7501.362384197186, 7541.4343924207005, 6770.6614669265355, 6860.691268892812, 6865.485088618473, 6866.313368663094, 6868.175818901764, 5271.89456210866, 5335.919961200508, 5350.384705758887, 5377.112776392008, 5469.9179512306555, 5258.1849813279005, 5365.463453654604, 5392.083345831296, 5408.864778380572, 5497.752601133038], "value": 4701.265742116487, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.934175860983, 411.07097958613537, 412.7832887733939, 413.19427117121603, 414.90042389826453, 4975.389906896758, 5269.5520880725135, 5338.946610533893, 5376.9193462098, 5389.8113566025195, 5008.974955125219, 5146.382434107903, 5185.637005409623, 5239.1093514102595, 5302.867428314294, 4289.678274129437, 4302.161078589676, 4317.13657268546, 4334.956650433503, 4347.13057388522, 4346.826126954918, 4364.192624364487, 4366.607005369516, 4379.0, 4394.582514661102, 4098.446709694183, 4103.261412945669, 4220.818170912149, 4342.283523218665, 4347.717398369112, 4197.328427451624, 4306.35404689296, 4307.138572285556, 4321.370049158706, 4331.675124365669, 3907.5310962684375, 3911.4523966644692, 3916.2167566486814, 3927.960720392788, 3928.626780455852, 5036.320096786923, 5148.716820574867, 5156.20078887773, 5197.298364720752, 5214.556762675177, 4881.585065269456, 4892.0, 4950.801967921278, 4962.6526143169995, 4963.528464795839, 5517.006938751023, 5562.608078526232, 5565.41563135873, 5592.832215033555, 5645.23789288449, 3872.845086196549, 4069.1454794493193, 4074.694397920168, 4312.180685669713, 4338.848140315074, 5735.050082971768, 5737.598368114233, 5739.942600573982, 5757.337906140764, 5761.625494342897, 4172.457580514514, 4177.809324342547, 4187.853425130106, 4191.413202151702, 4206.516250631216, 4154.335306350969, 4205.9789701051295, 4208.6633069354375, 4225.154969006211, 4255.702100852911, 4753.5008824072975, 4763.1426343258545, 4766.428028636586, 4775.164346239394, 4794.352762377034, 5563.916541251884, 5581.916271255935, 5602.607817452821, 5605.299337582802, 5676.240365486629, 1372.7302245422943, 1416.3201663201721, 1425.4796999095463, 1430.3706369197728, 1431.8854491640643, 974.6004138303261, 994.0258546624349, 1000.4497526360473, 1009.9293049486612, 1011.2163073618005, 5277.472252774692, 5307.203919412119, 5307.203919412119, 5340.626156169031, 5345.518903298722, 5570.41510641385, 5587.557891476286, 5612.943870561324, 5631.18347839561, 5646.463585959327, 5174.24973378858, 5290.65610735301, 5304.681719096867, 5321.973390133025, 5350.421625620451, 2926.678065412803, 2932.8533573321674, 2937.397833444139, 2943.9705602943695, 2949.4690955627766, 5731.541476681856, 5757.712114394263, 5759.596828221985, 5768.44252051952, 5785.756062446594, 5519.613627046148, 5567.749451274622, 5642.661440313512, 5643.943560564342, 5646.717664116778, 5711.6858572778065, 5729.9713501432225, 5740.741666625012, 5751.884962300815, 5760.654360738369, 5290.550303224269, 5483.533899618577, 5492.258545096521, 5576.693281869374, 5585.916211256753, 5402.216678581663, 5405.702686352289, 5414.7292635367285, 5438.401775804579, 5451.727413629382, 5673.971630141823, 5694.4590263924865, 5708.942910570841, 5775.306963164448, 5779.190913272229, 3920.5099362579676, 4036.515618125726, 4059.2084543513733, 4168.8124034417915, 4230.455883602402, 5429.701366424884, 5537.640053396516, 5568.858384031345, 5674.943250567607, 5717.256756621613, 5554.555635549227, 5555.74995625981, 5557.72211389437, 5577.386487486455, 5595.216669666332, 5280.551153152025, 5470.972645136749, 5506.5870059744875, 5537.612367134262, 5559.6664200148125, 5517.69652669107, 5535.612507124462, 5542.3903370630005, 5543.972280138573, 5548.334199895877, 5608.831735047955, 5614.466625670718, 5633.521150702236, 5635.802746903839, 5647.209390685225, 5218.4259731430275, 5396.757145928521, 5487.478689524489, 5505.229267902417, 5512.366077900932], "value": 4288.288920704998, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.3948048184583, 836.3518273338162, 840.5209030852409, 859.4370687199885, 901.2024358442776, 15471.69056618867, 16378.181090945434, 16458.423955161543, 16512.25694843732, 16537.83462165378, 15875.920620396912, 16271.267792949317, 16362.672746545091, 16404.0, 16433.342666293363, 696.6307856835886, 706.883364244899, 813.9552324622143, 831.6673330667721, 836.3016880904452, 799.4084377560622, 818.1818181818181, 818.6888982186761, 818.9262966333029, 829.784256093414, 867.8958524977012, 869.1742844297911, 870.6473878079356, 871.4684042733927, 871.5032431514039, 734.566605702638, 747.8691229034897, 856.9614367353485, 863.1282404771194, 864.1962974433806, 599.3347384403353, 612.5895649914568, 617.4072890025581, 618.0852338538942, 619.0559396919689, 16087.678246435005, 16107.597310067225, 16729.83270167295, 16934.407295744713, 17025.48923532296, 13913.30433478332, 14346.56960291193, 14347.282635868269, 14369.209693466855, 14709.70580588393, 13526.526571569948, 13535.120217185851, 13560.254186019765, 13727.313634318245, 13912.165270083828, 4679.461861885893, 4680.789364478606, 4690.460597031317, 4889.853304400874, 4896.608271338285, 75004.62497687532, 75654.99999999945, 75776.0, 77074.22925770727, 79383.0, 12317.199382040139, 12454.439550220262, 12465.93767031159, 12541.18482298666, 12623.0, 23325.183618573268, 23394.415139621306, 23415.88292058529, 23617.52764944726, 23857.164999224944, 7981.600919953979, 8155.79610509742, 8528.317734581342, 8631.26634236097, 8644.481331120152, 4837.9032419351415, 4888.780004899788, 4930.161872481687, 4987.077390682735, 5022.924656130161, 3929.0766669832565, 4006.2187873364996, 4036.4348991141264, 4037.818298176589, 4039.6970227233073, 651.8761435327273, 653.0987237612065, 662.5031226580065, 671.6205343980636, 672.186654148476, 837.8324335132997, 855.5422848775875, 864.6022829498376, 875.59722527638, 890.955452227386, 10703.0, 10804.513796879159, 10877.564897404174, 11387.658370248906, 11427.200095993201, 847.1147650705028, 847.5126802088823, 853.8249658819927, 876.088867577712, 877.1053525404179, 5345.1714984177515, 5399.730013499309, 5435.701036443033, 5449.86018970336, 6074.3925607438905, 60607.09089363575, 61711.382886171465, 61961.38038619556, 63906.0, 72760.63619681973, 63729.36270637327, 63855.0, 63900.68049659815, 65011.34988650148, 65435.34564654388, 58931.41068589345, 58968.41031589715, 59797.70101149466, 60367.39632603706, 61748.0, 10438.164946804085, 10996.505157268102, 11005.61480348184, 11160.330380177214, 11162.944185279346, 40818.0, 41587.7920610395, 41763.0, 42039.3694094595, 42631.0, 48266.27600586064, 50366.2445063317, 51566.48433515767, 52940.4705952951, 54093.45906541042, 13182.60452186436, 13409.0, 13428.328583570586, 13509.0, 13802.240876751473, 14642.194679292315, 14869.405223790927, 14956.476523321631, 14959.700805984037, 14974.176420296988, 14432.639184020483, 14801.925990369979, 15090.924545377204, 15158.772618410512, 15304.464343748361, 14175.787363189354, 14409.0, 14429.278536073365, 14441.711165776836, 14645.487407941097, 14175.929120354333, 14559.34482948291, 14620.415183392544, 14651.853481465476, 14664.633384165054, 11317.830232546683, 11520.366379848854, 11788.410579471163, 11806.46870890829, 12384.56654017105, 11335.829962550404, 11460.885391145981, 12120.27278363301, 12286.32425216586, 12334.50661973511], "value": 7618.944693764399, "unit": "score"}], "name": "dromaeo_css", "value": 7512.154846689123, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 112.0, 111.0, 111.0, 111.0, 110.0, 112.0, 111.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 117.0, 120.0, 163.0, 128.0, 118.0, 118.0, 117.0, 138.0, 118.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 163.0, 160.0, 160.0, 161.0, 160.0, 159.0, 161.0, 159.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 104.0, 76.0, 76.0, 75.0, 76.0, 90.0, 75.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 105.0, 83.0, 83.0, 82.0, 95.0, 83.0, 83.0, 106.0], "value": 88.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 145.0, 149.0, 148.0, 148.0, 148.0, 148.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 51.0, 49.0, 49.0, 49.0, 49.0, 49.0, 49.0, 49.0, 49.0], "value": 49.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 66.0, 63.0, 65.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 75.0, 77.0, 79.0, 76.0, 79.0, 75.0, 80.0, 74.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 129.0, 122.0, 119.0, 125.0, 125.0, 126.0, 118.0, 161.0, 120.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 160.0, 159.0, 161.0, 162.0, 159.0, 158.0, 162.0, 156.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 62.0, 60.0, 62.0, 62.0, 62.0, 61.0, 62.0, 60.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1469.5, "alertThreshold": 2.0}]} 09:32:58 INFO - Return code: 0 09:32:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:32:58 ERROR - # TBPL SUCCESS # 09:32:58 INFO - Running post-action listener: _resource_record_post_action 09:32:58 INFO - [mozharness: 2017-03-05 17:32:58.072911Z] Finished run-tests step (success) 09:32:58 INFO - Running post-run listener: _resource_record_post_run 09:32:58 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 3846144; Write bytes: 383279104; Read time: 264; Write time: 319144 09:32:58 INFO - TinderboxPrint: CPU usage
13.0% 09:32:58 INFO - TinderboxPrint: I/O read bytes / time
3,846,144 / 264 09:32:58 INFO - TinderboxPrint: I/O write bytes / time
383,279,104 / 319,144 09:32:58 INFO - TinderboxPrint: CPU idle
8,273.4 (87.0%) 09:32:58 INFO - TinderboxPrint: CPU user
1,192.8 (12.5%) 09:32:58 INFO - TinderboxPrint: Swap in / out
0 / 0 09:32:58 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109690880; Read time: 0; Write time: 140612 09:32:58 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 3846144; Write bytes: 255602688; Read time: 264; Write time: 173496 09:32:58 INFO - Running post-run listener: _upload_blobber_files 09:32:58 INFO - Blob upload gear active. 09:32:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:32:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:32:58 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:32:58 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:32:59 INFO - (blobuploader) - INFO - Open directory for files ... 09:32:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:32:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:33:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:00 INFO - (blobuploader) - INFO - Done attempting. 09:33:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:33:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:33:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:03 INFO - (blobuploader) - INFO - Done attempting. 09:33:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:33:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:33:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:04 INFO - (blobuploader) - INFO - Done attempting. 09:33:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:33:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:33:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:11 INFO - (blobuploader) - INFO - Done attempting. 09:33:11 INFO - (blobuploader) - INFO - Iteration through files over. 09:33:11 INFO - Return code: 0 09:33:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:33:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:33:11 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6353b27d0e0be9ff92336f4f263c31a4d81ca57018c6764f122490a12970f19d3d44ca003b9064dffddd438d1da29976f25455ae7e76ad88d4a9f5c505ba949e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bca78b23f2723188adde6fac54909c3617c23b71358edac9b45cc0f996cac1a42fcfd2888b016e78446fcdffb781891135c95402fe498d37550dc48b12f007c8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0120f55bc1fce11a129bacf10add6ab517ea68ad8c3f7a87ed86b92a615086fd302c5abbee515b02aee1f8b4d79ae1b865fb9aa9123017193ac04bd2ce14d363", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c41a1f9b57a3877f4389fd96f0a92c897db6a53a1d5a53a0a785bfd18b9997212d133fbe45d5bc4097cdc437fe341b9c4173db4ed91be644639c2a35d3da47ab"} 09:33:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:33:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:33:11 INFO - Contents: 09:33:11 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6353b27d0e0be9ff92336f4f263c31a4d81ca57018c6764f122490a12970f19d3d44ca003b9064dffddd438d1da29976f25455ae7e76ad88d4a9f5c505ba949e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bca78b23f2723188adde6fac54909c3617c23b71358edac9b45cc0f996cac1a42fcfd2888b016e78446fcdffb781891135c95402fe498d37550dc48b12f007c8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0120f55bc1fce11a129bacf10add6ab517ea68ad8c3f7a87ed86b92a615086fd302c5abbee515b02aee1f8b4d79ae1b865fb9aa9123017193ac04bd2ce14d363", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c41a1f9b57a3877f4389fd96f0a92c897db6a53a1d5a53a0a785bfd18b9997212d133fbe45d5bc4097cdc437fe341b9c4173db4ed91be644639c2a35d3da47ab"} 09:33:11 INFO - Running post-run listener: copy_logs_to_upload_dir 09:33:11 INFO - Copying logs to upload dir... 09:33:11 INFO - mkdir: /builds/slave/test/build/upload/logs 09:33:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.265573 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-03-05 09:33:10.269157) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-05 09:33:10.272776) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6353b27d0e0be9ff92336f4f263c31a4d81ca57018c6764f122490a12970f19d3d44ca003b9064dffddd438d1da29976f25455ae7e76ad88d4a9f5c505ba949e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bca78b23f2723188adde6fac54909c3617c23b71358edac9b45cc0f996cac1a42fcfd2888b016e78446fcdffb781891135c95402fe498d37550dc48b12f007c8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0120f55bc1fce11a129bacf10add6ab517ea68ad8c3f7a87ed86b92a615086fd302c5abbee515b02aee1f8b4d79ae1b865fb9aa9123017193ac04bd2ce14d363", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c41a1f9b57a3877f4389fd96f0a92c897db6a53a1d5a53a0a785bfd18b9997212d133fbe45d5bc4097cdc437fe341b9c4173db4ed91be644639c2a35d3da47ab"} build_url:https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011171 build_url: 'https://queue.taskcluster.net/v1/task/A8mIfO6DSEWcH4iHPJIO4g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6353b27d0e0be9ff92336f4f263c31a4d81ca57018c6764f122490a12970f19d3d44ca003b9064dffddd438d1da29976f25455ae7e76ad88d4a9f5c505ba949e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bca78b23f2723188adde6fac54909c3617c23b71358edac9b45cc0f996cac1a42fcfd2888b016e78446fcdffb781891135c95402fe498d37550dc48b12f007c8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0120f55bc1fce11a129bacf10add6ab517ea68ad8c3f7a87ed86b92a615086fd302c5abbee515b02aee1f8b4d79ae1b865fb9aa9123017193ac04bd2ce14d363", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c41a1f9b57a3877f4389fd96f0a92c897db6a53a1d5a53a0a785bfd18b9997212d133fbe45d5bc4097cdc437fe341b9c4173db4ed91be644639c2a35d3da47ab"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-05 09:33:10.299331) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:33:10.299869) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1488725909.290553-590872024 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004361 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:33:10.383243) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-05 09:33:10.383557) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-05 09:33:10.383909) ========= ========= Total master_lag: 0.17 =========