builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-060 starttime: 1487351257.87 results: success (0) revision: 9a78c5da4fc8855bfe7c3d3234bd3c6e413b4517 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-17 09:07:37.866866) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-17 09:07:37.867305) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-17 09:07:37.867592) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-17 09:07:37.883748) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:07:37.884028) ========= 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=337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-17 09:07:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2017-02-17 09:07:38 (113 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.253863 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:07:38.151162) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:07:38.151492) ========= 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=337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019192 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:07:38.201162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:07:38.201508) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9a78c5da4fc8855bfe7c3d3234bd3c6e413b4517 --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 9a78c5da4fc8855bfe7c3d3234bd3c6e413b4517 --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=337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-17 09:07:38,462 truncating revision to first 12 chars 2017-02-17 09:07:38,462 Setting DEBUG logging. 2017-02-17 09:07:38,462 attempt 1/10 2017-02-17 09:07:38,462 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9a78c5da4fc8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-17 09:07:39,005 unpacking tar archive at: mozilla-aurora-9a78c5da4fc8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.825135 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:07:39.039472) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-17 09:07:39.039882) ========= script_repo_revision: 9a78c5da4fc8855bfe7c3d3234bd3c6e413b4517 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-17 09:07:39.040287) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-17 09:07:39.040567) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-17 09:07:39.049829) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-17 09:07:39.050369) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:07:39 INFO - MultiFileLogger online at 20170217 09:07:39 in /builds/slave/test 09:07:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 09:07:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:07:39 INFO - {'append_to_log': False, 09:07:39 INFO - 'base_work_dir': '/builds/slave/test', 09:07:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 09:07:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:07:39 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 09:07:39 INFO - 'buildbot_json_path': 'buildprops.json', 09:07:39 INFO - 'config_files': ('talos/linux_config.py',), 09:07:39 INFO - 'default_actions': ('clobber', 09:07:39 INFO - 'read-buildbot-config', 09:07:39 INFO - 'download-and-extract', 09:07:39 INFO - 'populate-webroot', 09:07:39 INFO - 'create-virtualenv', 09:07:39 INFO - 'install', 09:07:39 INFO - 'run-tests'), 09:07:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:07:39 INFO - 'download_minidump_stackwalk': True, 09:07:39 INFO - 'download_symbols': 'ondemand', 09:07:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:07:39 INFO - 'tooltool.py': '/tools/tooltool.py', 09:07:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:07:39 INFO - '/tools/misc-python/virtualenv.py')}, 09:07:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:07:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:07:39 INFO - 'installer_path': 'installer.exe', 09:07:39 INFO - 'log_level': 'info', 09:07:39 INFO - 'log_name': 'talos', 09:07:39 INFO - 'log_to_console': True, 09:07:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:07:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:07:39 INFO - 'opt_config_files': (), 09:07:39 INFO - 'pip_index': False, 09:07:39 INFO - 'sps_profile': False, 09:07:39 INFO - 'sps_profile_interval': 0, 09:07:39 INFO - 'suite': 'dromaeojs', 09:07:39 INFO - 'system_bits': '32', 09:07:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:07:39 INFO - 'title': 'talos-linux64-ix-060', 09:07:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:07:39 INFO - 'use_talos_json': True, 09:07:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:07:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:07:39 INFO - 'work_dir': 'build'} 09:07:39 INFO - [mozharness: 2017-02-17 17:07:39.414372Z] Running clobber step. 09:07:39 INFO - Running pre-action listener: _resource_record_pre_action 09:07:39 INFO - Running main action method: clobber 09:07:39 INFO - rmtree: /builds/slave/test/build 09:07:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:07:39 INFO - Running post-action listener: _resource_record_post_action 09:07:39 INFO - [mozharness: 2017-02-17 17:07:39.872282Z] Finished clobber step (success) 09:07:39 INFO - [mozharness: 2017-02-17 17:07:39.872384Z] Running read-buildbot-config step. 09:07:39 INFO - Running pre-action listener: _resource_record_pre_action 09:07:39 INFO - Running main action method: read_buildbot_config 09:07:39 INFO - Using buildbot properties: 09:07:39 INFO - { 09:07:39 INFO - "project": "", 09:07:39 INFO - "product": "firefox", 09:07:39 INFO - "who": "cbook@mozilla.com", 09:07:39 INFO - "installer_path": "public/build/target.tar.bz2", 09:07:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:07:39 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 09:07:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 09:07:39 INFO - "stage_platform": "linux64", 09:07:39 INFO - "basedir": "/builds/slave/test", 09:07:39 INFO - "buildnumber": 35, 09:07:39 INFO - "platform": "ubuntu64_hw", 09:07:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:07:39 INFO - "slavebuilddir": "test", 09:07:39 INFO - "taskId": "NdqFpbzZQP2MO05YoNZiEw", 09:07:39 INFO - "branch": "mozilla-aurora", 09:07:39 INFO - "script_repo_revision": "production", 09:07:39 INFO - "revision": "9a78c5da4fc8855bfe7c3d3234bd3c6e413b4517", 09:07:39 INFO - "slavename": "talos-linux64-ix-060", 09:07:39 INFO - "repo_path": "releases/mozilla-aurora" 09:07:39 INFO - } 09:07:39 INFO - Finding installer, test and symbols from parent task. 09:07:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NdqFpbzZQP2MO05YoNZiEw'}, attempt #1 09:07:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NdqFpbzZQP2MO05YoNZiEw'}, attempt #1 09:07:40 INFO - Task dependencies: HZ_7y5YJQvWDNRRI7UEIQw 09:07:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw'}, attempt #1 09:07:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.tar.bz2 09:07:41 INFO - Set test_url: https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/test_packages.json 09:07:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.crashreporter-symbols.zip 09:07:41 INFO - Running post-action listener: _resource_record_post_action 09:07:41 INFO - [mozharness: 2017-02-17 17:07:41.314466Z] Finished read-buildbot-config step (success) 09:07:41 INFO - [mozharness: 2017-02-17 17:07:41.314717Z] Running download-and-extract step. 09:07:41 INFO - Running pre-action listener: _resource_record_pre_action 09:07:41 INFO - Running main action method: download_and_extract 09:07:41 INFO - mkdir: /builds/slave/test/build/tests 09:07:41 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:07:41 INFO - trying https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.test_packages.json 09:07:41 INFO - Downloading https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:07:41 INFO - Downloaded 896 bytes. 09:07:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:07:41 INFO - Using the following test package requirements: 09:07:41 INFO - {u'common': [u'target.common.tests.zip'], 09:07:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:07:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:07:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:07:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:07:41 INFO - u'mozbase': [u'target.common.tests.zip'], 09:07:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:07:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:07:41 INFO - u'web-platform': [u'target.common.tests.zip', 09:07:41 INFO - u'target.web-platform.tests.zip'], 09:07:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:07:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:07:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.common.tests.zip 09:07:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:07:41 INFO - Fetch https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.common.tests.zip into memory 09:07:42 INFO - Expected file size: 21859126 09:07:42 INFO - Obtained file size: 21859126 09:07:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:07:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.common.tests.zip 09:07:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:07:46 INFO - Fetch https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.common.tests.zip into memory 09:07:47 INFO - Expected file size: 21859126 09:07:47 INFO - Obtained file size: 21859126 09:07:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.talos.tests.zip 09:07:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:07:52 INFO - Fetch https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.talos.tests.zip into memory 09:07:52 INFO - Expected file size: 14403485 09:07:52 INFO - Obtained file size: 14403485 09:07:52 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:07:52 INFO - trying https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.tar.bz2 09:07:52 INFO - Downloading https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:07:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:07:54 INFO - Downloaded 66050329 bytes. 09:07:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.tar.bz2 09:07:54 INFO - mkdir: /builds/slave/test/properties 09:07:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:07:54 INFO - Writing to file /builds/slave/test/properties/build_url 09:07:54 INFO - Contents: 09:07:54 INFO - build_url:https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.tar.bz2 09:07:54 INFO - Running post-action listener: _resource_record_post_action 09:07:54 INFO - Running post-action listener: set_extra_try_arguments 09:07:54 INFO - [mozharness: 2017-02-17 17:07:54.144585Z] Finished download-and-extract step (success) 09:07:54 INFO - [mozharness: 2017-02-17 17:07:54.144681Z] Running populate-webroot step. 09:07:54 INFO - Running pre-action listener: _resource_record_pre_action 09:07:54 INFO - Running main action method: populate_webroot 09:07:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:07:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:07:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:07:54 INFO - '--tppagecycles', 09:07:54 INFO - '7'], 09:07:54 INFO - 'tests': ['tsvgm']}}, 09:07:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:07:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:07:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:07:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:07:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:07:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:07:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:07:54 INFO - 'talos_options': ['--disable-e10s'], 09:07:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:07:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:07:54 INFO - 'talos_options': ['--disable-e10s'], 09:07:54 INFO - 'tests': ['damp', 'tps']}, 09:07:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:07:54 INFO - 'tests': ['damp', 'tps']}, 09:07:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:07:54 INFO - 'tests': ['dromaeo_dom']}, 09:07:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:07:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:07:54 INFO - 'tests': ['basic_compositor_video']}, 09:07:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:07:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:07:54 INFO - 'tests': ['a11yr', 09:07:54 INFO - 'ts_paint', 09:07:54 INFO - 'tpaint', 09:07:54 INFO - 'sessionrestore', 09:07:54 INFO - 'sessionrestore_no_auto_restore', 09:07:54 INFO - 'tabpaint']}, 09:07:54 INFO - 'other-e10s': {'tests': ['a11yr', 09:07:54 INFO - 'ts_paint', 09:07:54 INFO - 'tpaint', 09:07:54 INFO - 'sessionrestore', 09:07:54 INFO - 'sessionrestore_no_auto_restore', 09:07:54 INFO - 'tabpaint']}, 09:07:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:07:54 INFO - 'ts_paint', 09:07:54 INFO - 'tpaint', 09:07:54 INFO - 'sessionrestore', 09:07:54 INFO - 'sessionrestore_no_auto_restore', 09:07:54 INFO - 'tabpaint']}, 09:07:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:07:54 INFO - 'ts_paint', 09:07:54 INFO - 'tpaint', 09:07:54 INFO - 'sessionrestore', 09:07:54 INFO - 'sessionrestore_no_auto_restore', 09:07:54 INFO - 'tabpaint']}, 09:07:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:07:54 INFO - 'tests': ['a11yr', 09:07:54 INFO - 'ts_paint', 09:07:54 INFO - 'tpaint', 09:07:54 INFO - 'sessionrestore', 09:07:54 INFO - 'sessionrestore_no_auto_restore', 09:07:54 INFO - 'tabpaint']}, 09:07:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:07:54 INFO - 'tests': ['a11yr', 09:07:54 INFO - 'ts_paint', 09:07:54 INFO - 'tpaint', 09:07:54 INFO - 'sessionrestore', 09:07:54 INFO - 'sessionrestore_no_auto_restore', 09:07:54 INFO - 'tabpaint']}, 09:07:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:07:54 INFO - 'tests': ['tsvgx', 09:07:54 INFO - 'tsvgr_opacity', 09:07:54 INFO - 'tart', 09:07:54 INFO - 'tscrollx', 09:07:54 INFO - 'cart', 09:07:54 INFO - 'tsvg_static']}, 09:07:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:07:54 INFO - 'tsvgr_opacity', 09:07:54 INFO - 'tart', 09:07:54 INFO - 'tscrollx', 09:07:54 INFO - 'cart', 09:07:54 INFO - 'tsvg_static']}, 09:07:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:07:54 INFO - 'talos_options': ['--disable-e10s'], 09:07:54 INFO - 'tests': ['tp5o']}, 09:07:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:07:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:07:54 INFO - 'talos_options': ['--disable-e10s', 09:07:54 INFO - '--xperf_path', 09:07:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:54 INFO - 'tests': ['tp5n']}, 09:07:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:07:54 INFO - 'talos_options': ['--xperf_path', 09:07:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:54 INFO - 'tests': ['tp5n']}}, 09:07:54 INFO - 'talos.zip': {'path': '', 09:07:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:07:54 INFO - Running post-action listener: _resource_record_post_action 09:07:54 INFO - [mozharness: 2017-02-17 17:07:54.157763Z] Finished populate-webroot step (success) 09:07:54 INFO - [mozharness: 2017-02-17 17:07:54.157854Z] Running create-virtualenv step. 09:07:54 INFO - Running pre-action listener: _resource_record_pre_action 09:07:54 INFO - Running main action method: create_virtualenv 09:07:54 INFO - Creating virtualenv /builds/slave/test/build/venv 09:07:54 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:07:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:07:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:07:54 INFO - Using real prefix '/usr' 09:07:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:07:54 INFO - Installing distribute.............................................................................................................................................................................................done. 09:07:56 INFO - Installing pip.................done. 09:07:56 INFO - Return code: 0 09:07:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:07:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:07:56 INFO - Reading from file tmpfile_stdout 09:07:56 INFO - Output received: 09:07:56 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:07:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:07:56 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:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:56 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:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:56 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 0xa141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd86980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd83d00>, '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 0xd84a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd84eb0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', '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:07:56 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:07:56 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:07:56 INFO - Using env: {'DISPLAY': ':0', 09:07:56 INFO - 'HOME': '/home/cltbld', 09:07:56 INFO - 'LANG': 'en_US.UTF-8', 09:07:56 INFO - 'LANGUAGE': 'en_US:en', 09:07:56 INFO - 'LOGNAME': 'cltbld', 09:07:56 INFO - 'MAIL': '/var/mail/cltbld', 09:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:56 INFO - 'MOZ_NO_REMOTE': '1', 09:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:56 INFO - 'NO_EM_RESTART': '1', 09:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:56 INFO - 'PWD': '/builds/slave/test', 09:07:56 INFO - 'SHELL': '/bin/bash', 09:07:56 INFO - 'SHLVL': '1', 09:07:56 INFO - 'TERM': 'linux', 09:07:56 INFO - 'TMOUT': '86400', 09:07:56 INFO - 'USER': 'cltbld', 09:07:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', 09:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:56 INFO - '_': '/tools/buildbot/bin/python'} 09:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:57 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:07:57 INFO - Cleaning up... 09:07:57 INFO - Return code: 0 09:07:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:07:57 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:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:57 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:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:57 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 0xa141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd86980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd83d00>, '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 0xd84a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd84eb0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', '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:07:57 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:07:57 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:07:57 INFO - Using env: {'DISPLAY': ':0', 09:07:57 INFO - 'HOME': '/home/cltbld', 09:07:57 INFO - 'LANG': 'en_US.UTF-8', 09:07:57 INFO - 'LANGUAGE': 'en_US:en', 09:07:57 INFO - 'LOGNAME': 'cltbld', 09:07:57 INFO - 'MAIL': '/var/mail/cltbld', 09:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:57 INFO - 'MOZ_NO_REMOTE': '1', 09:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:57 INFO - 'NO_EM_RESTART': '1', 09:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:07:57 INFO - 'PWD': '/builds/slave/test', 09:07:57 INFO - 'SHELL': '/bin/bash', 09:07:57 INFO - 'SHLVL': '1', 09:07:57 INFO - 'TERM': 'linux', 09:07:57 INFO - 'TMOUT': '86400', 09:07:57 INFO - 'USER': 'cltbld', 09:07:57 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', 09:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:57 INFO - '_': '/tools/buildbot/bin/python'} 09:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:57 INFO - Downloading/unpacking psutil>=3.1.1 09:07: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:07: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:07: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:07: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:07: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:07: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:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:07:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:59 INFO - Installing collected packages: psutil 09:07:59 INFO - Running setup.py install for psutil 09:07:59 INFO - building 'psutil._psutil_linux' extension 09:07:59 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:07:59 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:07:59 INFO - building 'psutil._psutil_posix' extension 09:07:59 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:07:59 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:07:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:08:00 INFO - Successfully installed psutil 09:08:00 INFO - Cleaning up... 09:08:00 INFO - Return code: 0 09:08:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:08:00 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:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:00 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:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:00 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 0xa141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd86980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd83d00>, '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 0xd84a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd84eb0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', '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:08:00 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:08:00 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:08:00 INFO - Using env: {'DISPLAY': ':0', 09:08:00 INFO - 'HOME': '/home/cltbld', 09:08:00 INFO - 'LANG': 'en_US.UTF-8', 09:08:00 INFO - 'LANGUAGE': 'en_US:en', 09:08:00 INFO - 'LOGNAME': 'cltbld', 09:08:00 INFO - 'MAIL': '/var/mail/cltbld', 09:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:00 INFO - 'MOZ_NO_REMOTE': '1', 09:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:00 INFO - 'NO_EM_RESTART': '1', 09:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:00 INFO - 'PWD': '/builds/slave/test', 09:08:00 INFO - 'SHELL': '/bin/bash', 09:08:00 INFO - 'SHLVL': '1', 09:08:00 INFO - 'TERM': 'linux', 09:08:00 INFO - 'TMOUT': '86400', 09:08:00 INFO - 'USER': 'cltbld', 09:08:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', 09:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:00 INFO - '_': '/tools/buildbot/bin/python'} 09:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:08:00 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:08:00 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:08:00 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:08:00 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:08:00 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:08:00 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:08:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:08:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:08:02 INFO - Installing collected packages: mozsystemmonitor 09:08:02 INFO - Running setup.py install for mozsystemmonitor 09:08:02 INFO - Successfully installed mozsystemmonitor 09:08:02 INFO - Cleaning up... 09:08:02 INFO - Return code: 0 09:08:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:08:02 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:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:02 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:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:02 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 0xa141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd86980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd83d00>, '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 0xd84a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd84eb0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', '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:08:02 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:08:02 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:08:02 INFO - Using env: {'DISPLAY': ':0', 09:08:02 INFO - 'HOME': '/home/cltbld', 09:08:02 INFO - 'LANG': 'en_US.UTF-8', 09:08:02 INFO - 'LANGUAGE': 'en_US:en', 09:08:02 INFO - 'LOGNAME': 'cltbld', 09:08:02 INFO - 'MAIL': '/var/mail/cltbld', 09:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:02 INFO - 'MOZ_NO_REMOTE': '1', 09:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:02 INFO - 'NO_EM_RESTART': '1', 09:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:02 INFO - 'PWD': '/builds/slave/test', 09:08:02 INFO - 'SHELL': '/bin/bash', 09:08:02 INFO - 'SHLVL': '1', 09:08:02 INFO - 'TERM': 'linux', 09:08:02 INFO - 'TMOUT': '86400', 09:08:02 INFO - 'USER': 'cltbld', 09:08:02 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', 09:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:02 INFO - '_': '/tools/buildbot/bin/python'} 09:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:02 INFO - Downloading/unpacking jsonschema==2.5.1 09:08: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:08: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:08: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:08: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:08: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:08: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:08:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:08:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 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:08:04 INFO - Downloading functools32-3.2.3-2.tar.gz 09:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:08:04 INFO - warning: no files found matching '*.txt' 09:08:04 INFO - no previously-included directories found matching 'build' 09:08:04 INFO - no previously-included directories found matching 'dist' 09:08:04 INFO - no previously-included directories found matching '.git*' 09:08:05 INFO - Installing collected packages: jsonschema, functools32 09:08:05 INFO - Running setup.py install for functools32 09:08:05 INFO - warning: no files found matching '*.txt' 09:08:05 INFO - no previously-included directories found matching 'build' 09:08:05 INFO - no previously-included directories found matching 'dist' 09:08:05 INFO - no previously-included directories found matching '.git*' 09:08:05 INFO - Successfully installed jsonschema functools32 09:08:05 INFO - Cleaning up... 09:08:05 INFO - Return code: 0 09:08:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:08: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:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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', '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 0xa141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd86980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd83d00>, '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 0xd84a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd84eb0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', '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:08: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:08: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 functools32==3.2.3-2 09:08:05 INFO - Using env: {'DISPLAY': ':0', 09:08:05 INFO - 'HOME': '/home/cltbld', 09:08:05 INFO - 'LANG': 'en_US.UTF-8', 09:08:05 INFO - 'LANGUAGE': 'en_US:en', 09:08:05 INFO - 'LOGNAME': 'cltbld', 09:08:05 INFO - 'MAIL': '/var/mail/cltbld', 09:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:05 INFO - 'MOZ_NO_REMOTE': '1', 09:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:05 INFO - 'NO_EM_RESTART': '1', 09:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:05 INFO - 'PWD': '/builds/slave/test', 09:08:05 INFO - 'SHELL': '/bin/bash', 09:08:05 INFO - 'SHLVL': '1', 09:08:05 INFO - 'TERM': 'linux', 09:08:05 INFO - 'TMOUT': '86400', 09:08:05 INFO - 'USER': 'cltbld', 09:08:05 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', 09:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:05 INFO - '_': '/tools/buildbot/bin/python'} 09:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:08:05 INFO - Cleaning up... 09:08:05 INFO - Return code: 0 09:08:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:08: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:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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', '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 0xa141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd86980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd83d00>, '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 0xd84a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd84eb0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', '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:08: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:08: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 blobuploader==1.2.4 09:08:05 INFO - Using env: {'DISPLAY': ':0', 09:08:05 INFO - 'HOME': '/home/cltbld', 09:08:05 INFO - 'LANG': 'en_US.UTF-8', 09:08:05 INFO - 'LANGUAGE': 'en_US:en', 09:08:05 INFO - 'LOGNAME': 'cltbld', 09:08:05 INFO - 'MAIL': '/var/mail/cltbld', 09:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:05 INFO - 'MOZ_NO_REMOTE': '1', 09:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:05 INFO - 'NO_EM_RESTART': '1', 09:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:05 INFO - 'PWD': '/builds/slave/test', 09:08:05 INFO - 'SHELL': '/bin/bash', 09:08:05 INFO - 'SHLVL': '1', 09:08:05 INFO - 'TERM': 'linux', 09:08:05 INFO - 'TMOUT': '86400', 09:08:05 INFO - 'USER': 'cltbld', 09:08:05 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', 09:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:05 INFO - '_': '/tools/buildbot/bin/python'} 09:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:05 INFO - Downloading/unpacking blobuploader==1.2.4 09:08:05 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:08:05 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:08:05 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:08:05 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:08:05 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:08:05 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:08:07 INFO - Downloading blobuploader-1.2.4.tar.gz 09:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:08:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:08:07 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:08:07 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:08:07 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:08:07 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:08:07 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:08:07 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:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:08:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:08 INFO - Downloading docopt-0.6.1.tar.gz 09:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:08:08 INFO - Installing collected packages: blobuploader, requests, docopt 09:08:08 INFO - Running setup.py install for blobuploader 09:08:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:08:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:08:08 INFO - Running setup.py install for requests 09:08:08 INFO - Running setup.py install for docopt 09:08:08 INFO - Successfully installed blobuploader requests docopt 09:08:08 INFO - Cleaning up... 09:08:09 INFO - Return code: 0 09:08:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:08:09 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:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:09 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:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:09 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 0xa141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd86980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd83d00>, '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 0xd84a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd84eb0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', '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:08:09 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:08:09 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:08:09 INFO - Using env: {'DISPLAY': ':0', 09:08:09 INFO - 'HOME': '/home/cltbld', 09:08:09 INFO - 'LANG': 'en_US.UTF-8', 09:08:09 INFO - 'LANGUAGE': 'en_US:en', 09:08:09 INFO - 'LOGNAME': 'cltbld', 09:08:09 INFO - 'MAIL': '/var/mail/cltbld', 09:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:09 INFO - 'MOZ_NO_REMOTE': '1', 09:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:09 INFO - 'NO_EM_RESTART': '1', 09:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:09 INFO - 'PWD': '/builds/slave/test', 09:08:09 INFO - 'SHELL': '/bin/bash', 09:08:09 INFO - 'SHLVL': '1', 09:08:09 INFO - 'TERM': 'linux', 09:08:09 INFO - 'TMOUT': '86400', 09:08:09 INFO - 'USER': 'cltbld', 09:08:09 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', 09:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:09 INFO - '_': '/tools/buildbot/bin/python'} 09:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:08:09 INFO - Running setup.py (path:/tmp/pip-Ge8BbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:08:09 INFO - Running setup.py (path:/tmp/pip-DU6RMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:08:09 INFO - Running setup.py (path:/tmp/pip-NgTahz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:08:09 INFO - Running setup.py (path:/tmp/pip-QOtH9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:08:09 INFO - Running setup.py (path:/tmp/pip-o9NA0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:08:09 INFO - Running setup.py (path:/tmp/pip-l__2Wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:08:09 INFO - Running setup.py (path:/tmp/pip-gugB76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:08:09 INFO - Running setup.py (path:/tmp/pip-PCwnCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:08:09 INFO - Running setup.py (path:/tmp/pip-59gYFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:08:09 INFO - Running setup.py (path:/tmp/pip-i9Yh7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:08:09 INFO - Running setup.py (path:/tmp/pip-xnXDuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:08:10 INFO - Running setup.py (path:/tmp/pip-HChjog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:08:10 INFO - Running setup.py (path:/tmp/pip-FJ0FjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:08:10 INFO - Running setup.py (path:/tmp/pip-qBZAei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:10 INFO - Running setup.py (path:/tmp/pip-YnIgHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:08:10 INFO - Running setup.py (path:/tmp/pip-VstcQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:08:10 INFO - Running setup.py (path:/tmp/pip-i_6WCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:08:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:08:10 INFO - Running setup.py install for manifestparser 09:08:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:08:10 INFO - Running setup.py install for mozcrash 09:08:10 INFO - Running setup.py install for mozdebug 09:08:10 INFO - Running setup.py install for mozdevice 09:08:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:08:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:08:10 INFO - Running setup.py install for mozfile 09:08:11 INFO - Running setup.py install for mozhttpd 09:08:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:08:11 INFO - Running setup.py install for mozinfo 09:08:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:08:11 INFO - Running setup.py install for mozInstall 09:08:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:08:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:08:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:08:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:08:11 INFO - Running setup.py install for mozleak 09:08:11 INFO - Running setup.py install for mozlog 09:08:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:08:11 INFO - Running setup.py install for moznetwork 09:08:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:08:11 INFO - Running setup.py install for mozprocess 09:08:11 INFO - Running setup.py install for mozprofile 09:08:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:08:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:08:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:08:11 INFO - Running setup.py install for mozrunner 09:08:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:08:11 INFO - Running setup.py install for mozscreenshot 09:08:12 INFO - Running setup.py install for moztest 09:08:12 INFO - Running setup.py install for mozversion 09:08:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:08:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:08:12 INFO - Cleaning up... 09:08:12 INFO - Return code: 0 09:08:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:08:12 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:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:12 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:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:12 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 0xa141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd86980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd83d00>, '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 0xd84a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd84eb0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', '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:08:12 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:08:12 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:08:12 INFO - Using env: {'DISPLAY': ':0', 09:08:12 INFO - 'HOME': '/home/cltbld', 09:08:12 INFO - 'LANG': 'en_US.UTF-8', 09:08:12 INFO - 'LANGUAGE': 'en_US:en', 09:08:12 INFO - 'LOGNAME': 'cltbld', 09:08:12 INFO - 'MAIL': '/var/mail/cltbld', 09:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:12 INFO - 'MOZ_NO_REMOTE': '1', 09:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:12 INFO - 'NO_EM_RESTART': '1', 09:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:12 INFO - 'PWD': '/builds/slave/test', 09:08:12 INFO - 'SHELL': '/bin/bash', 09:08:12 INFO - 'SHLVL': '1', 09:08:12 INFO - 'TERM': 'linux', 09:08:12 INFO - 'TMOUT': '86400', 09:08:12 INFO - 'USER': 'cltbld', 09:08:12 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', 09:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:12 INFO - '_': '/tools/buildbot/bin/python'} 09:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:08:12 INFO - Running setup.py (path:/tmp/pip-57GJPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:08:12 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:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:08:12 INFO - Running setup.py (path:/tmp/pip-rX6G20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:08:12 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:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:08:12 INFO - Running setup.py (path:/tmp/pip-Ca8FL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:08:12 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:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:08:12 INFO - Running setup.py (path:/tmp/pip-KAJNPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:08:12 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:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:08:12 INFO - Running setup.py (path:/tmp/pip-JYarvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:08:12 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:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:08:12 INFO - Running setup.py (path:/tmp/pip-xvnusH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:08:12 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:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:08:12 INFO - Running setup.py (path:/tmp/pip-sd_lpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:08:13 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:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:08:13 INFO - Running setup.py (path:/tmp/pip-sh0o6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:08:13 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:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:08:13 INFO - Running setup.py (path:/tmp/pip-JimxI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:08:13 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:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:08:13 INFO - Running setup.py (path:/tmp/pip-JfZUZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:08:13 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:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:08:13 INFO - Running setup.py (path:/tmp/pip-IbiI1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:08:13 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:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:08:13 INFO - Running setup.py (path:/tmp/pip-ktHrfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:08:13 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:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:08:13 INFO - Running setup.py (path:/tmp/pip-7SQK_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:08:13 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:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:08:13 INFO - Running setup.py (path:/tmp/pip-FuN9ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:08:13 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:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:13 INFO - Running setup.py (path:/tmp/pip-ERUkBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:08:13 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:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:08:13 INFO - Running setup.py (path:/tmp/pip-38o8Bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:08:13 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:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:08:13 INFO - Running setup.py (path:/tmp/pip-ujdlCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:08:13 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:08:13 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:08:13 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:08:13 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:08:13 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:08:13 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:08:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:08:13 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:08:13 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:08:13 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:08:13 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:08:13 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:08:13 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:08:15 INFO - Downloading blessings-1.6.tar.gz 09:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:08:15 INFO - Installing collected packages: blessings 09:08:15 INFO - Running setup.py install for blessings 09:08:15 INFO - Successfully installed blessings 09:08:15 INFO - Cleaning up... 09:08:16 INFO - Return code: 0 09:08:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:08:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:08:16 INFO - Reading from file tmpfile_stdout 09:08:16 INFO - Current package versions: 09:08:16 INFO - argparse == 1.2.1 09:08:16 INFO - blessings == 1.6 09:08:16 INFO - blobuploader == 1.2.4 09:08:16 INFO - docopt == 0.6.1 09:08:16 INFO - functools32 == 3.2.3-2 09:08:16 INFO - jsonschema == 2.5.1 09:08:16 INFO - manifestparser == 1.1 09:08:16 INFO - mozInstall == 1.12 09:08:16 INFO - mozcrash == 1.0 09:08:16 INFO - mozdebug == 0.1 09:08:16 INFO - mozdevice == 0.49 09:08:16 INFO - mozfile == 1.2 09:08:16 INFO - mozhttpd == 0.7 09:08:16 INFO - mozinfo == 0.9 09:08:16 INFO - mozleak == 0.1 09:08:16 INFO - mozlog == 3.4 09:08:16 INFO - moznetwork == 0.27 09:08:16 INFO - mozprocess == 0.24 09:08:16 INFO - mozprofile == 0.28 09:08:16 INFO - mozrunner == 6.13 09:08:16 INFO - mozscreenshot == 0.1 09:08:16 INFO - mozsystemmonitor == 0.3 09:08:16 INFO - moztest == 0.8 09:08:16 INFO - mozversion == 1.4 09:08:16 INFO - psutil == 3.1.1 09:08:16 INFO - requests == 1.2.3 09:08:16 INFO - wsgiref == 0.1.2 09:08:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd86980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd83d00>, '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 0xd84a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd84eb0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', '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:08:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:08:16 INFO - Using env: {'DISPLAY': ':0', 09:08:16 INFO - 'HOME': '/home/cltbld', 09:08:16 INFO - 'LANG': 'en_US.UTF-8', 09:08:16 INFO - 'LANGUAGE': 'en_US:en', 09:08:16 INFO - 'LOGNAME': 'cltbld', 09:08:16 INFO - 'MAIL': '/var/mail/cltbld', 09:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:16 INFO - 'MOZ_NO_REMOTE': '1', 09:08:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:16 INFO - 'NO_EM_RESTART': '1', 09:08:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:16 INFO - 'PWD': '/builds/slave/test', 09:08:16 INFO - 'SHELL': '/bin/bash', 09:08:16 INFO - 'SHLVL': '1', 09:08:16 INFO - 'TERM': 'linux', 09:08:16 INFO - 'TMOUT': '86400', 09:08:16 INFO - 'USER': 'cltbld', 09:08:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', 09:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:16 INFO - '_': '/tools/buildbot/bin/python'} 09:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:08:16 INFO - Cleaning up... 09:08:16 INFO - Return code: 0 09:08:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa141f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xbe1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd86980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd83d00>, '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 0xd84a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd84eb0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', '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:08:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:08:16 INFO - Using env: {'DISPLAY': ':0', 09:08:16 INFO - 'HOME': '/home/cltbld', 09:08:16 INFO - 'LANG': 'en_US.UTF-8', 09:08:16 INFO - 'LANGUAGE': 'en_US:en', 09:08:16 INFO - 'LOGNAME': 'cltbld', 09:08:16 INFO - 'MAIL': '/var/mail/cltbld', 09:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:16 INFO - 'MOZ_NO_REMOTE': '1', 09:08:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:16 INFO - 'NO_EM_RESTART': '1', 09:08:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:16 INFO - 'PWD': '/builds/slave/test', 09:08:16 INFO - 'SHELL': '/bin/bash', 09:08:16 INFO - 'SHLVL': '1', 09:08:16 INFO - 'TERM': 'linux', 09:08:16 INFO - 'TMOUT': '86400', 09:08:16 INFO - 'USER': 'cltbld', 09:08:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', 09:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:16 INFO - '_': '/tools/buildbot/bin/python'} 09:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:08:16 INFO - Cleaning up... 09:08:16 INFO - Return code: 0 09:08:16 INFO - Running post-action listener: _resource_record_post_action 09:08:16 INFO - Running post-action listener: _start_resource_monitoring 09:08:16 INFO - Starting resource monitoring. 09:08:16 INFO - [mozharness: 2017-02-17 17:08:16.738652Z] Finished create-virtualenv step (success) 09:08:16 INFO - [mozharness: 2017-02-17 17:08:16.739195Z] Running install step. 09:08:16 INFO - Running pre-action listener: _resource_record_pre_action 09:08:16 INFO - Running main action method: install 09:08:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:08:16 INFO - Reading from file tmpfile_stdout 09:08:16 INFO - Detecting whether we're running mozinstall >=1.0... 09:08:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:08:17 INFO - Reading from file tmpfile_stdout 09:08:17 INFO - Output received: 09:08:17 INFO - Usage: mozinstall [options] installer 09:08:17 INFO - Options: 09:08:17 INFO - -h, --help show this help message and exit 09:08:17 INFO - -d DEST, --destination=DEST 09:08:17 INFO - Directory to install application into. [default: 09:08:17 INFO - "/builds/slave/test"] 09:08:17 INFO - --app=APP Application being installed. [default: firefox] 09:08:17 INFO - mkdir: /builds/slave/test/build/application 09:08:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:08:33 INFO - Reading from file tmpfile_stdout 09:08:33 INFO - Output received: 09:08:33 INFO - /builds/slave/test/build/application/firefox/firefox 09:08:33 INFO - Running post-action listener: _resource_record_post_action 09:08:33 INFO - [mozharness: 2017-02-17 17:08:33.470322Z] Finished install step (success) 09:08:33 INFO - [mozharness: 2017-02-17 17:08:33.470595Z] Running run-tests step. 09:08:33 INFO - Running pre-action listener: _resource_record_pre_action 09:08:33 INFO - Running main action method: run_tests 09:08:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:08:33 INFO - Python 2.7.3 09:08:33 INFO - Return code: 0 09:08:33 INFO - grabbing minidump binary from tooltool 09:08:33 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:08:33 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 0xd83d00>, '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 0xd84a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd84eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:08:33 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:08:33 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:08:33 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:08:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:08:33 INFO - Return code: 0 09:08:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:08:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:08:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:08:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:08:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:08:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-060 --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:08:33 INFO - Using env: {'DISPLAY': ':0', 09:08:33 INFO - 'HOME': '/home/cltbld', 09:08:33 INFO - 'LANG': 'en_US.UTF-8', 09:08:33 INFO - 'LANGUAGE': 'en_US:en', 09:08:33 INFO - 'LOGNAME': 'cltbld', 09:08:33 INFO - 'MAIL': '/var/mail/cltbld', 09:08:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:08:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:33 INFO - 'MOZ_NO_REMOTE': '1', 09:08:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:33 INFO - 'NO_EM_RESTART': '1', 09:08:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:08:33 INFO - 'PWD': '/builds/slave/test', 09:08:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:08:33 INFO - 'SHELL': '/bin/bash', 09:08:33 INFO - 'SHLVL': '1', 09:08:33 INFO - 'TERM': 'linux', 09:08:33 INFO - 'TMOUT': '86400', 09:08:33 INFO - 'USER': 'cltbld', 09:08:33 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369', 09:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:33 INFO - '_': '/tools/buildbot/bin/python'} 09:08:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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:08:33 INFO - mozversion application_buildid: 20170217161030 09:08:33 INFO - mozversion application_changeset: 9a78c5da4fc8855bfe7c3d3234bd3c6e413b4517 09:08:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:08:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:08:33 INFO - mozversion application_name: Firefox 09:08:33 INFO - mozversion application_remotingname: firefox-dev 09:08:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:08:33 INFO - mozversion application_vendor: Mozilla 09:08:33 INFO - mozversion application_version: 53.0a2 09:08:33 INFO - mozversion platform_buildid: 20170217161030 09:08:33 INFO - mozversion platform_changeset: 9a78c5da4fc8855bfe7c3d3234bd3c6e413b4517 09:08:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:08:33 INFO - mozversion platform_version: 53.0a2 09:08:33 INFO - using testdate: 1487351313 09:08:33 INFO - actual date: 1487351313 09:08:33 INFO - starting webserver on 'localhost:58180' 09:08:33 INFO - SUITE-START | Running 2 tests 09:08:33 INFO - TEST-START | dromaeo_css 09:08:33 INFO - operating with platform_type : linux_ 09:08:33 INFO - Initialising browser for dromaeo_css test... 09:08:33 INFO - TEST-INFO | started process 2244 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyJOBw9/profile http://localhost:58180/getInfo.html) 09:08:37 INFO - PROCESS | 2244 | __metrics Screen width/height:1600/1200 09:08:37 INFO - PROCESS | 2244 | colorDepth:24 09:08:37 INFO - PROCESS | 2244 | Browser inner width/height: 1024/697 09:08:37 INFO - PROCESS | 2244 | __metrics 09:08:38 INFO - PROCESS | 2244 | 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:08:38 INFO - PROCESS | 2244 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:08:39 INFO - TEST-INFO | 2244: exit 0 09:08:39 INFO - Browser initialized. 09:08:39 INFO - Running cycle 1/1 for dromaeo_css test... 09:08:39 INFO - TEST-INFO | started process 2337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyJOBw9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:51 INFO - PROCESS | 2337 | RSS: Main: 138752000 09:08:51 INFO - PROCESS | 2337 | 09:11:51 INFO - PROCESS | 2337 | Cycle 1(1): loaded http://localhost:58180/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58180/tests/dromaeo/cssquery-ext.html) 09:11:52 INFO - PROCESS | 2337 | RSS: Main: 241197056 09:11:52 INFO - PROCESS | 2337 | 09:13:41 INFO - PROCESS | 2337 | ************************* 09:13:41 INFO - PROCESS | 2337 | A coding exception was thrown and uncaught in a Task. 09:13:41 INFO - PROCESS | 2337 | 09:13:41 ERROR - PROCESS | 2337 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:13:41 INFO - PROCESS | 2337 | Full stack: 09:13:41 INFO - PROCESS | 2337 | ************************* 09:14:55 INFO - PROCESS | 2337 | Cycle 1(1): loaded http://localhost:58180/tests/dromaeo/cssquery-ext.html (next: http://localhost:58180/tests/dromaeo/cssquery-jquery.html) 09:14:55 INFO - PROCESS | 2337 | RSS: Main: 226263040 09:14:55 INFO - PROCESS | 2337 | 09:17:57 INFO - PROCESS | 2337 | Cycle 1(1): loaded http://localhost:58180/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58180/tests/dromaeo/cssquery-mootools.html) 09:17:57 INFO - PROCESS | 2337 | RSS: Main: 197328896 09:17:57 INFO - PROCESS | 2337 | 09:20:59 INFO - PROCESS | 2337 | Cycle 1(1): loaded http://localhost:58180/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58180/tests/dromaeo/cssquery-prototype.html) 09:21:00 INFO - PROCESS | 2337 | RSS: Main: 198512640 09:21:00 INFO - PROCESS | 2337 | 09:24:02 INFO - PROCESS | 2337 | Cycle 1(1): loaded http://localhost:58180/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58180/tests/dromaeo/cssquery-yui.html) 09:24:03 INFO - PROCESS | 2337 | RSS: Main: 174370816 09:24:03 INFO - PROCESS | 2337 | 09:27:06 INFO - PROCESS | 2337 | Cycle 1(1): loaded http://localhost:58180/tests/dromaeo/cssquery-yui.html (next: http://localhost:58180/tests/dromaeo/cssquery-dojo.html) 09:27:06 INFO - PROCESS | 2337 | RSS: Main: 262418432 09:27:06 INFO - PROCESS | 2337 | 09:27:06 INFO - PROCESS | 2337 | __start_tp_report 09:27:06 INFO - PROCESS | 2337 | _x_x_mozilla_page_load 09:27:06 INFO - PROCESS | 2337 | _x_x_mozilla_page_load_details 09:27:06 INFO - PROCESS | 2337 | |i|pagename|runs| 09:27:06 INFO - PROCESS | 2337 | |0;dojo.html;3148.41754275459;3162.2884850908536;3184.172115250035;3187.3943950649373;3203.3913556424277;5206.661566998143;5272.578193744501;5294.364676238847;5295.046891559523;5325;5365.651232669874;5385.730713464321;5399.460053994599;5413.106837371829;5413.83758487246;4936.3829521309835;4947.060058588866;4951.084049450863;4970.055689419017;5000.674956127858;4907.730074845882;4918.557329840313;4959.032988567231;5017.096922553938;5018.774155163008;4932.309476673268;4950.331705219804;4981.053599816023;5028.069807085682;5068.391792984847;5055.848324550269;5062.341895553554;5062.392512898476;5062.569681577052;5090.287359769598;4845.685030473008;4973.850784476472;4978.203487442028;5014.749262536859;5048.747562621854;5177.922331165036;5231.267622532849;5241.9213711794355;5242.501962313574;5304.2839216706025;5662.575306851962;5669.801556945528;5671.943280567224;5677.233573467571;5678.063119585264;5661.943380566183;5699.629524080963;5723.942760572382;5742.425757424224;5744.080947048494;5305.761240744176;5353.491418315292;5382.6232163748555;5406.107992181324;5439.428859969726;5918.348981612019;5920.8815823684145;5948.643081415129;5953.077273022688;5977.282726072812;5713.314402271754;5723.313202415737;5727.6849773262875;5730.7421166047625;5749.655020698688;5636.830895073154;5689.118186681071;5689.544836413077;5718.857028574235;5755.798547050833;5735.426457354231;5776.104703770922;5786.88426231473;5789.392113828072;5824.679642619697;5775.5668324875805;5786.42135786418;5793.2179155814265;5794.507466865363;5798.82603521895;4335.653147748172;4425.800838962255;4434.667399945017;4480.171168333869;4518.728876267434;3970.543387510473;4003.3594624859884;4011.6389524942897;4031.314676505001;4039;5617.045102332613;5626.043572592669;5630.662160270397;5650.7739690412745;5661.179129026351;5666.46168613981;5671.120976248688;5673.092305231144;5674;5830.125481177773;5518.696471694096;5570.693611851387;5574.442555744474;5576.191452239403;5589.245451864028;4913.901721965541;4917.336159618406;4921.9507804922205;4937.580305673986;4954.355933728592;5878.265216847894;5938;5950.642961422329;6006.939930600725;6015.819525414245;5774.04728219839;5812.593118481665;5825.970870145622;5874.911876321773;5916.526677865846;6074.088886667036;6100.054491553638;6124.14262003311;6125;6125.84685382869;5559.305086864142;5706.4864162225595;5751.252337196138;5759.539236861125;5761.991651460894;5709.200711900255;5748;5804.071348584206;5807.535397168301;5877.94122058774;5670.574706896917;5709.058005429058;5716.54267658578;5721.8569535761935;5731.541476681772;5699.601027928005;5707.600467967202;5719.370869204301;5731.656100633975;5733.082706766897;5457.399686034612;5480.835574932758;5522.30971128609;5552.69460179694;5558.861028474321;5658.981383351036;5665.575081868794;5669.064604340402;5671.602987790815;5684.545236380997;5530;5536.750846211849;5542.224088627515;5543.25166102571;5543.307086614173 09:27:06 INFO - PROCESS | 2337 | |1;ext.html;564.4512118243802;574.5317566183561;610.4963405190719;629.0941044895353;655.9803205903825;35582;46389.76805115974;47709.28436073453;47718.522814771844;47925.04149917004;50198.49801501984;50653;50663.24005139926;50677.74661126689;50819;8978.955105224464;9217.44695318283;9245.121713437213;9441.763955901122;9456.669016584421;11014.118870490382;11308.37803920784;11324.490397932072;11711.23876948;11713.180077394585;11388.886111138907;11469.827952580717;11471.885281147206;11473.598424055159;11479;11416.315021098719;11470.770584588345;11492.482838272297;11495.885041149608;11500.539978400853;11168;11237.157213209042;11251.0436612888;11252;11255.718607034807;45116.3232551512;45515.54484455179;45626.54373456256;45700.3144952826;45723.77138114321;4320.762358070305;4403.867883963486;4434.334849772527;4523.819047238107;4587.082583483283;34152.14619634504;34261.486077708854;34513.48229776556;34884.30231395358;35710.28579428423;4587.885302867422;4648.3957085578995;4667.22990706533;4673.6027437667835;4689.929651055237;251649;252695;252966;253607;256654;67752;67985;68089;68105.31894681089;68216.6589167051;70304.2969570308;70577;70598;70644.64677676579;70686.64656676684;19863.801361986196;20437.489062773253;20467.28364507265;20490.795092048887;20499.28252511155;14698.926505367619;15089.320980555902;15090.24548772557;15602.375904963674;16136.515904522883;18212;18530.722039169425;18588.535286617942;18616.627667446573;18677.252909883453;6386.616802991835;6395.392437718409;6402.711877965503;6563.7702680405955;6617.8014659560295;961.5384615384654;970.3741086998846;974.1281553010016;975.6341371985505;993.319576090366;31722.365552688818;31731.20671983219;32142.517862232085;32271;32425.02861884706;1121.8317252412203;1158.6581958322315;1179.775842589905;1179.823026546008;1184.680136363177;17490.737638935425;17649.7352539712;17718.645627087386;17750.733738993924;17804.46586602404;498332;500735;502207;502320;504858;68071;68127.65936170287;68167.93244304018;68177;68291.31708682948;1577.928993195309;1611.9838801612068;1637.5414883832545;1660.2694814281676;1680.7730956320984;31975.840120799247;34992;35781.28437431289;35855.46216806802;36022;60627.69686151541;62884;63055;63074.68462657657;63115;461363;470356;470630;471673;471903;48187;48465.5153448461;49148.50851491439;49638.50361496483;49939.75030124826;53894.730526348685;54175;54360.18459723186;54399.45600543944;56063;43822.34266486069;44284;45375;46488.302675460574;46817.2977405346;44683;45572.54427455815;45965.310520341554;46834;47009.2948605778;44969;46228;46276;46936.826579334425;47023.764881175375;37388.626113738515;39499.80250098731;39755.80122099371;40093.59906400899;40197.79901100476;29667.703322967358;29730.851345743133;29763;30017;30135.246618834706 09:27:06 INFO - PROCESS | 2337 | |2;jquery.html;401.9939700904485;432.2371015158244;436.0096161024921;443.583031949967;457.56302730892;19360;21547;21558.461038474026;22445.55108897821;23380;21645.350639480803;22954.770452295474;22961.77038229617;23028.65457018146;23094.538109237805;4210.242156411837;4259.424977628027;4263.381809637601;4265.232258193524;4310.892227694301;5948.524118070544;6063.48460380866;6115.4190351916495;6208;6212.75148994042;6071.3625069367745;6075.392460753934;6083.482903953147;6084.634921904678;6085.330613632497;6036.547258955552;6077.483413909823;6080.452759251666;6310.9684451577905;6354.777582784626;6235.812925612194;6237.282712488031;6241.157443745127;6276.811695649138;6281.748730050793;25516.234512964642;25794.484110317877;25963;26157.869210654015;26455.470890582274;2869.856507174633;2872.8850845966135;2884.8269103853627;2899.4635992341487;2922.0357282096857;10054.69835904924;10276.280660353777;10801.513931873085;10842.674719758419;11354.71613209668;2047.488127968008;2076.3874656976227;2113.788621137889;2207.3046990198036;2221.666749987499;97847.51076244573;98511;98561.5071924643;99675;101388.49305753497;12281.631551053482;12567.748645027048;12578.496860125675;12602.180858244184;12955.222686638832;18188.36340728068;18197.54506137357;18201.544961376072;18243.635127297646;18250.63498730018;9576.664816731382;9606.951965240129;9674.70975870725;9728.221742260603;9836.655717049869;9252.121048500381;9271.119243671841;9295.72112836616;9304.813903722023;9554.378965367368;5070.771815268248;5199.246109314204;5430.67415955044;5453.15476101205;5510.669359838423;2101.401100686297;2146.549224662807;2153.913843446276;2158.7625361210253;2182.057968408118;886.8182022685334;892.2193081054078;895.1138373010673;901.2699713232303;906.6464079009191;19947.501312467306;20557;20765.273215437388;20793.480162995744;20918.372448826558;907.6823111910778;912.1881525442361;920.8618707193974;927.9814403711888;929.159111004542;11044.834327485094;11385.487653055467;11484.827727584094;11528.59649912249;11630.302181869114;666495;695731;698611;699121;711955;103562.48218759008;106626;107973;109077;112504.43747781208;1095.2278643556433;1100.779844031197;1129.0515966588105;1136.6760473265244;1140.8060629692973;17146;17675.29298828084;17685.85131894505;17798.288068477115;17956.19197136106;45151.52272216175;45164;45805.31292030556;45979.54020459753;46740.29889551728;57844.71077644753;60191.699041504515;60592.6970365163;60725.39274607374;61784;8295.875561866456;8977.37158398932;9362.531873406166;9541.618335266512;9721.125098740864;8396.958015209884;9740.561674724797;13886.93056534711;14068.648283792578;14491.20298383599;12287.631371058882;12344.62966111018;12468.625941221779;12565.371731413576;12657.430415631503;11610.70973225676;11712.180147389601;11763.478053435265;11780.705482362666;12184.268943863397;12587.622371328875;12723.427445764777;12754.362281885684;12807.29559874216;12875.613731588068;8901.198892099743;9060.275177985877;9191.586378612845;9551.14039736427;9647.469389183661;11588.78317776655;12231.388430578258;12532.561360352343;12645.810312845499;12701.745965080832 09:27:06 INFO - PROCESS | 2337 | |3;mootools.html;1484.6362641152919;1503.4512402972919;1506.1791323728567;1509.298176347998;1515.3559737111725;8315.667373305068;8897.777555561113;8901.732948011562;8904.198622124008;8916;7688.077430708323;7957.124716281204;7970.92029079709;8152.062512811029;8706.172913573217;2361.197192954395;2464.778169964703;2468.0374653885;2490.7882829959476;2503.6244563315468;2470.8270421070533;2480.131953816159;2495.1765917247358;2501.3621526510715;2511.7864981476596;2456.1894574790276;2485.3289611804803;2495.8252922295446;2505.0480817289404;2520;2348.189874493297;2356.3873392917794;2371.8576885386933;2379.7501262367377;2380.238323736405;2363.61000434928;2392.868392238426;2393.9162129325564;2395.197608801054;2395.9041638334447;8646.178613031752;8745.081766414498;8746.212840844355;8747.912520874774;8769.956150219272;5083.872903177413;5206.140986737184;5210.218467229908;5210.947890521084;5215.530602245778;3223.2747631782895;3351.581052368454;3456.585209774818;3483.2336885885065;3486.7210623150086;1413.6112569043491;1420.6732451536204;1439.9136051836924;1453.9200343981076;1490.1506141499349;11599.362035088066;11607.709807254887;11641.592544260995;11659.125565582615;11755.412229388496;4672.462666793294;4685.929711054337;4724.480307166209;4870.659053866266;4883.682560633548;10275.486225688686;10282.691519254286;10283.280170388001;10283.588656453807;10286.228532860065;5468.179773033997;5492.176173573916;5525.336959564878;5559.33288005442;5568.359638641527;4960.454350021495;5017.949820501822;5027.748612569357;5065.392152941597;5117.257997590403;4192.874213773592;4258.467691538558;4276.593723596254;4328.437303150633;4334.956650433518;1339.0760375340983;1366.719822436398;1374.9175049497062;1385.9792103118461;1390.720537105865;991.5141580625442;1011.6863772230485;1018.7962407518526;1024.262530977695;1030.2015937648382;5740.42595740431;5745.385849438496;5830.941690583039;5865;6033.064874944391;564.2551831582354;565.2736233939369;570.1590154522047;573.6586730895111;577.5697105656313;3801.790901500444;3830.7221536157517;3923.509561304837;3949.4668219790533;3965.7620542767527;10099.69700908974;10409.479526023668;10504.947475262576;10557.63048293306;10570.471476426303;10187.643432479828;10409.635662751767;10428.113610343054;10463.790724185626;10466.372017678963;8076.8384632307025;8081.515109093473;8178.100408955011;8182;8189.22202390772;5660.575456840836;5773.826785196451;5794.681292528951;5794.739236734441;5902.291724993029;9444;9489.76275593088;9507.714768556954;9620;9645.131938125602;8478.109798471072;9428.10433008863;9629.711108666472;9637.614495420105;9769.511524423893;6719.260881302955;7504.812379690551;7509.47433679659;7514.0607424071995;7778.338841198562;8402.32781377476;8402.831943360976;8426.157384261525;8438.198371154731;8505.617247224014;7584.696612135453;7616.162222155448;7624.771256862303;7632.236776322324;7799.5320280783335;6999.720011199699;7049.330313620198;7071.575705457689;7120.430365570845;7133.322334378226;6808.863822723617;6817.257019224113;6818.31816818334;6908.689108990208;6918.965405172942;5122.590192784493;5176.4047134580005;5200.479952004921;5207.817726379559;5221;4971.65198436106;5068.189089745623;5076.956816459969;5182.611304152279;5243.764030618555 09:27:06 INFO - PROCESS | 2337 | |4;prototype.html;378.1661436532446;382.9310724069666;385.8610900075972;398.4561074133807;399.63832731378096;5107.565856902159;5197.610179236553;5305.177697456896;5314.89370212596;5394.1639045947895;5192.350956130484;5243.187305967572;5278.6568873023225;5284.233786101013;5305.230741542484;4269.34312036552;4298.290782020978;4308.849190278341;4313.676474264443;4327.329263964075;4245.957540424587;4294.742315461067;4312.611864932155;4316.244657184996;4324;4261.893452663678;4273.252180868351;4278.807453664577;4280.59334363235;4304.375865499501;4255.787210639455;4266.871993840159;4268.722533035343;4273.2735434975975;4281.957180428218;3829.5787463379006;3902.746321489094;3907.824147913322;3909.6285852843935;3923.4311024901517;5174.379074511083;5177.773557370329;5181.35233095863;5196.558292545101;5225.477452254782;4862.489438608965;4864.686534635629;4909.5090490950615;4920.277902734015;4920.778564964585;5291.682499050031;5501.669899805985;5515.972420137914;5517.5585953124055;5523.7790488380415;4028.8187031583648;4058.9649639342074;4076.184763047402;4078.245524577933;4078.2659121358142;5701.714914254312;5727.398623144593;5760.913586296209;5770.653760774367;5800.651960882318;4056.6551843093666;4155.376693495939;4170.791460427027;4183.456150700389;4184.4141820145205;4190.455240818674;4201.558836322203;4229.386738922901;4229.577042295746;4255.340422234497;4726.385569875963;4746.59653929413;4751.121042607059;4756.857294281177;4802.207635740134;5487.972560137174;5529.751161197675;5559.11054231321;5561.360443548962;5621.269234999506;1411.400154934149;1411.6894283257873;1416.504223521759;1417.2842714429353;1422.7936949142315;956.5217391304348;971.9271054670928;988.204495381225;991.3506653142204;996.2329006664828;5389.245505629215;5394.649347792381;5406.837265093994;5407.242985981966;5409.83770486886;5537.280153580009;5545.362283337387;5545.861353466195;5563.7774489019985;5566.2207290979295;5099.566536844335;5343.893122137535;5356.276902618097;5375.81184658535;5378.489043540857;2920.240737408247;2940.823550586929;2941.3087924337765;2944.9411011779644;2986.5669477926012;5766.452187042224;5794.5364370851075;5869;5896;5906.49794767441;5492.972535137299;5817.301923769175;5846;5850.531957443394;5850.922922362585;5988.951933411636;6005.3694362091355;6008.939910600838;6037.275526936795;6071.025197653206;5528.80649177293;5704.771809127588;5714.714264286852;5737.569682273763;5772.538196944319;5627.831165065055;5650.0959846424375;5660.151097253907;5665.716714164193;5691.089425691869;5884.37800917022;5995.940040599538;5999.700014999145;6033.818985430444;6042.486388657014;3893.591172926802;4017.3572228444477;4068.145689405258;4097.610726980932;4142.2958097124165;5687.630304030225;5719.399463056319;5719.542436604978;5721.885562288648;5728.255326807655;5564.8330550083565;5572.331320241435;5578.77684892616;5581.860453488695;5592.7762889483965;5442.156465747816;5506.752196151103;5514.834554963358;5543.584231182758;5565.916511252415;5511.917321240105;5518.558515318685;5521.751521181476;5523.944760552504;5537.501624853782;5437.619366644297;5494.80768173112;5563.693996830213;5587.804426845041;5595.006671430765;5404.59465540094;5431.782728690808;5437.238786569963;5439.129739241703;5450.31871016123 09:27:06 INFO - PROCESS | 2337 | |5;yui.html;820.6307161777198;823.0822632764466;838.0571856661256;907.133687328601;915.5468043318556;15600.141992190425;17641;17750;17948.91025544872;17973.999999999985;15260.618484537865;15386.61533461664;15428.845711542881;15470.922645386758;15499.69000619987;704.102269606251;841.8568843296654;851.1105894340399;851.382747508058;851.5061264466625;745.124478737484;751.6166754954958;752.4657493179849;795.7891158842912;834.7871292820353;894.7852515396323;902.2601466797229;902.8690839828221;903.737916004358;904.5070436612062;898.2050884966786;898.4339865884483;898.9235914947204;899.0290486274807;899.0470101692194;542.7394850471795;571.3144226927703;631.204682100552;663.2439019517753;663.4559661077918;16568.83431165685;17507;17534.561635959202;17540.473785786446;17557.56106097345;14259;15233.61915952099;15326.77009844842;15736.763948540782;16615.83384166167;13261.403236854365;13269.402876870565;13358.532451364254;13414.530491432753;13416.530421435204;4034.4553485279407;4037.192561487714;4063.227986682521;4096.672266218696;4136.21411931732;79349.99999999942;79642.6017869907;81011;81354.59322703349;83245;11357.148213883991;11515.827262591069;11626.1861669684;11684.065274777997;11706.239094458833;21919.452013699465;22069.448263793212;22256.77743222547;22268.777312226994;22276.66585001226;8512.829743405096;8603.698870539502;8819.338549608805;8898.688545900863;9056.592453339616;4851.126797176472;4985.925211121836;5023.472535383732;5028.069807085701;5088.287639730441;3884.0678237222864;3993.7803420812133;3996.4205190247253;3997.360422332413;3998.640122388999;697.3340459860821;702.360851625029;707.2149913595905;715.6028404235595;716.4411758828122;613.9140520327157;630.3822254190918;643.1510406263687;657.1227411405827;660.3429587560408;10169.983001699919;10295.227857910537;10323.63867264642;10838.837417438745;10839.458027098613;757.7158565537924;759.0853022108346;767.8809784483414;773.2731232641299;777.6461709921972;4814.855554333376;4859.854204373874;4881.316615673809;4890.828820991248;4908.705477671351;82095;82885.58557207175;84235;84770.5761471201;86066.56966715127;56308;58398;72297.27702723011;73833.63083184657;74325.25674743291;60409;60801.695991520646;61696.38303616906;61720.69139654273;62320.37679623236;10379.896201038195;10628.202884783517;10779.89220107789;10841.132709383388;10844.295120817122;40803.59196407998;40808.571699991546;41607.37588936108;41774.16451670889;42324.36513452239;49306;52460.73769631128;53590.732046339515;53824.46175538195;53932;12761.298128603015;12816.166949148275;12853.16454430459;12961.092723509264;12987.610371688865;14068.78896816569;14130.222837744022;14143.151410915378;14188.148711077369;14197.574072777834;13284.933575332061;13456.46174153062;13482.123661961941;13688.315584220949;13798.379072941943;11301.71745706364;12702.491900324254;12882.03384746129;13205.603831885059;13408.731825363633;12124.75750485003;12461.813072803734;12496.687582810502;12505.624831255076;12639.557615483414;10170.953303824965;10280.434576098387;10541.631042913461;10545.9472702636;10679.14566834667;10157.9492102539;10175.643852465128;10207.7448063799;10226.437545935045;10251.179905607683 09:27:06 INFO - PROCESS | 2337 | __end_tp_report 09:27:06 INFO - PROCESS | 2337 | __start_cc_report 09:27:06 INFO - PROCESS | 2337 | _x_x_mozilla_cycle_collect,945 09:27:06 INFO - PROCESS | 2337 | __end_cc_report 09:27:06 INFO - PROCESS | 2337 | __startTimestamp1487352426269__endTimestamp 09:27:06 INFO - PROCESS | 2337 | 09:27:06 INFO - PROCESS | 2337 | ------- Summary: start ------- 09:27:06 INFO - PROCESS | 2337 | Number of tests: 6 09:27:06 INFO - PROCESS | 2337 | 09:27:06 INFO - PROCESS | 2337 | [#0] dojo.html Cycles:165 Average:5381.71 Median:5626.04 stddev:595.52 (10.6%) stddev-sans-first:570.99 09:27:06 INFO - PROCESS | 2337 | Values: 3148.4 3162.3 3184.2 3187.4 3203.4 5206.7 5272.6 5294.4 5295.0 5325.0 5365.7 5385.7 5399.5 5413.1 5413.8 4936.4 4947.1 4951.1 4970.1 5000.7 4907.7 4918.6 4959.0 5017.1 5018.8 4932.3 4950.3 4981.1 5028.1 5068.4 5055.8 5062.3 5062.4 5062.6 5090.3 4845.7 4973.9 4978.2 5014.7 5048.7 5177.9 5231.3 5241.9 5242.5 5304.3 5662.6 5669.8 5671.9 5677.2 5678.1 5661.9 5699.6 5723.9 5742.4 5744.1 5305.8 5353.5 5382.6 5406.1 5439.4 5918.3 5920.9 5948.6 5953.1 5977.3 5713.3 5723.3 5727.7 5730.7 5749.7 5636.8 5689.1 5689.5 5718.9 5755.8 5735.4 5776.1 5786.9 5789.4 5824.7 5775.6 5786.4 5793.2 5794.5 5798.8 4335.7 4425.8 4434.7 4480.2 4518.7 3970.5 4003.4 4011.6 4031.3 4039.0 5617.0 5626.0 5630.7 5650.8 5661.2 5666.5 5671.1 5673.1 5674.0 5830.1 5518.7 5570.7 5574.4 5576.2 5589.2 4913.9 4917.3 4922.0 4937.6 4954.4 5878.3 5938.0 5950.6 6006.9 6015.8 5774.0 5812.6 5826.0 5874.9 5916.5 6074.1 6100.1 6124.1 6125.0 6125.8 5559.3 5706.5 5751.3 5759.5 5762.0 5709.2 5748.0 5804.1 5807.5 5877.9 5670.6 5709.1 5716.5 5721.9 5731.5 5699.6 5707.6 5719.4 5731.7 5733.1 5457.4 5480.8 5522.3 5552.7 5558.9 5659.0 5665.6 5669.1 5671.6 5684.5 5530.0 5536.8 5542.2 5543.3 5543.3 09:27:06 INFO - PROCESS | 2337 | 09:27:06 INFO - PROCESS | 2337 | [#1] ext.html Cycles:180 Average:60940.10 Median:45445.27 stddev:111727.00 (245.8%) stddev-sans-first:111948.47 09:27:06 INFO - PROCESS | 2337 | Values: 564.5 574.5 610.5 629.1 656.0 35582.0 46389.8 47709.3 47718.5 47925.0 50198.5 50653.0 50663.2 50677.7 50819.0 8979.0 9217.4 9245.1 9441.8 9456.7 11014.1 11308.4 11324.5 11711.2 11713.2 11388.9 11469.8 11471.9 11473.6 11479.0 11416.3 11470.8 11492.5 11495.9 11500.5 11168.0 11237.2 11251.0 11252.0 11255.7 45116.3 45515.5 45626.5 45700.3 45723.8 4320.8 4403.9 4434.3 4523.8 4587.1 34152.1 34261.5 34513.5 34884.3 35710.3 4587.9 4648.4 4667.2 4673.6 4689.9 251649.0 252695.0 252966.0 253607.0 256654.0 67752.0 67985.0 68089.0 68105.3 68216.7 70304.3 70577.0 70598.0 70644.6 70686.6 19863.8 20437.5 20467.3 20490.8 20499.3 14698.9 15089.3 15090.2 15602.4 16136.5 18212.0 18530.7 18588.5 18616.6 18677.3 6386.6 6395.4 6402.7 6563.8 6617.8 961.5 970.4 974.1 975.6 993.3 31722.4 31731.2 32142.5 32271.0 32425.0 1121.8 1158.7 1179.8 1179.8 1184.7 17490.7 17649.7 17718.6 17750.7 17804.5 498332.0 500735.0 502207.0 502320.0 504858.0 68071.0 68127.7 68167.9 68177.0 68291.3 1577.9 1612.0 1637.5 1660.3 1680.8 31975.8 34992.0 35781.3 35855.5 36022.0 60627.7 62884.0 63055.0 63074.7 63115.0 461363.0 470356.0 470630.0 471673.0 471903.0 48187.0 48465.5 49148.5 49638.5 49939.8 53894.7 54175.0 54360.2 54399.5 56063.0 43822.3 44284.0 45375.0 46488.3 46817.3 44683.0 45572.5 45965.3 46834.0 47009.3 44969.0 46228.0 46276.0 46936.8 47023.8 37388.6 39499.8 39755.8 40093.6 40197.8 29667.7 29730.9 29763.0 30017.0 30135.2 09:27:06 INFO - PROCESS | 2337 | 09:27:06 INFO - PROCESS | 2337 | [#2] jquery.html Cycles:180 Average:36465.13 Median:2878.86 stddev:114117.71 (3964.0%) stddev-sans-first:114405.71 09:27:06 INFO - PROCESS | 2337 | Values: 402.0 432.2 436.0 443.6 457.6 19360.0 21547.0 21558.5 22445.6 23380.0 21645.4 22954.8 22961.8 23028.7 23094.5 4210.2 4259.4 4263.4 4265.2 4310.9 5948.5 6063.5 6115.4 6208.0 6212.8 6071.4 6075.4 6083.5 6084.6 6085.3 6036.5 6077.5 6080.5 6311.0 6354.8 6235.8 6237.3 6241.2 6276.8 6281.7 25516.2 25794.5 25963.0 26157.9 26455.5 2869.9 2872.9 2884.8 2899.5 2922.0 10054.7 10276.3 10801.5 10842.7 11354.7 2047.5 2076.4 2113.8 2207.3 2221.7 97847.5 98511.0 98561.5 99675.0 101388.5 12281.6 12567.7 12578.5 12602.2 12955.2 18188.4 18197.5 18201.5 18243.6 18250.6 9576.7 9607.0 9674.7 9728.2 9836.7 9252.1 9271.1 9295.7 9304.8 9554.4 5070.8 5199.2 5430.7 5453.2 5510.7 2101.4 2146.5 2153.9 2158.8 2182.1 886.8 892.2 895.1 901.3 906.6 19947.5 20557.0 20765.3 20793.5 20918.4 907.7 912.2 920.9 928.0 929.2 11044.8 11385.5 11484.8 11528.6 11630.3 666495.0 695731.0 698611.0 699121.0 711955.0 103562.5 106626.0 107973.0 109077.0 112504.4 1095.2 1100.8 1129.1 1136.7 1140.8 17146.0 17675.3 17685.9 17798.3 17956.2 45151.5 45164.0 45805.3 45979.5 46740.3 57844.7 60191.7 60592.7 60725.4 61784.0 8295.9 8977.4 9362.5 9541.6 9721.1 8397.0 9740.6 13886.9 14068.6 14491.2 12287.6 12344.6 12468.6 12565.4 12657.4 11610.7 11712.2 11763.5 11780.7 12184.3 12587.6 12723.4 12754.4 12807.3 12875.6 8901.2 9060.3 9191.6 9551.1 9647.5 11588.8 12231.4 12532.6 12645.8 12701.7 09:27:06 INFO - PROCESS | 2337 | 09:27:06 INFO - PROCESS | 2337 | [#3] mootools.html Cycles:180 Average:5693.62 Median:5080.41 stddev:3110.38 (61.2%) stddev-sans-first:3103.02 09:27:06 INFO - PROCESS | 2337 | Values: 1484.6 1503.5 1506.2 1509.3 1515.4 8315.7 8897.8 8901.7 8904.2 8916.0 7688.1 7957.1 7970.9 8152.1 8706.2 2361.2 2464.8 2468.0 2490.8 2503.6 2470.8 2480.1 2495.2 2501.4 2511.8 2456.2 2485.3 2495.8 2505.0 2520.0 2348.2 2356.4 2371.9 2379.8 2380.2 2363.6 2392.9 2393.9 2395.2 2395.9 8646.2 8745.1 8746.2 8747.9 8770.0 5083.9 5206.1 5210.2 5210.9 5215.5 3223.3 3351.6 3456.6 3483.2 3486.7 1413.6 1420.7 1439.9 1453.9 1490.2 11599.4 11607.7 11641.6 11659.1 11755.4 4672.5 4685.9 4724.5 4870.7 4883.7 10275.5 10282.7 10283.3 10283.6 10286.2 5468.2 5492.2 5525.3 5559.3 5568.4 4960.5 5017.9 5027.7 5065.4 5117.3 4192.9 4258.5 4276.6 4328.4 4335.0 1339.1 1366.7 1374.9 1386.0 1390.7 991.5 1011.7 1018.8 1024.3 1030.2 5740.4 5745.4 5830.9 5865.0 6033.1 564.3 565.3 570.2 573.7 577.6 3801.8 3830.7 3923.5 3949.5 3965.8 10099.7 10409.5 10504.9 10557.6 10570.5 10187.6 10409.6 10428.1 10463.8 10466.4 8076.8 8081.5 8178.1 8182.0 8189.2 5660.6 5773.8 5794.7 5794.7 5902.3 9444.0 9489.8 9507.7 9620.0 9645.1 8478.1 9428.1 9629.7 9637.6 9769.5 6719.3 7504.8 7509.5 7514.1 7778.3 8402.3 8402.8 8426.2 8438.2 8505.6 7584.7 7616.2 7624.8 7632.2 7799.5 6999.7 7049.3 7071.6 7120.4 7133.3 6808.9 6817.3 6818.3 6908.7 6919.0 5122.6 5176.4 5200.5 5207.8 5221.0 4971.7 5068.2 5077.0 5182.6 5243.8 09:27:06 INFO - PROCESS | 2337 | 09:27:06 INFO - PROCESS | 2337 | [#4] prototype.html Cycles:180 Average:4720.71 Median:5391.70 stddev:1359.19 (25.2%) stddev-sans-first:1323.34 09:27:06 INFO - PROCESS | 2337 | Values: 378.2 382.9 385.9 398.5 399.6 5107.6 5197.6 5305.2 5314.9 5394.2 5192.4 5243.2 5278.7 5284.2 5305.2 4269.3 4298.3 4308.8 4313.7 4327.3 4246.0 4294.7 4312.6 4316.2 4324.0 4261.9 4273.3 4278.8 4280.6 4304.4 4255.8 4266.9 4268.7 4273.3 4282.0 3829.6 3902.7 3907.8 3909.6 3923.4 5174.4 5177.8 5181.4 5196.6 5225.5 4862.5 4864.7 4909.5 4920.3 4920.8 5291.7 5501.7 5516.0 5517.6 5523.8 4028.8 4059.0 4076.2 4078.2 4078.3 5701.7 5727.4 5760.9 5770.7 5800.7 4056.7 4155.4 4170.8 4183.5 4184.4 4190.5 4201.6 4229.4 4229.6 4255.3 4726.4 4746.6 4751.1 4756.9 4802.2 5488.0 5529.8 5559.1 5561.4 5621.3 1411.4 1411.7 1416.5 1417.3 1422.8 956.5 971.9 988.2 991.4 996.2 5389.2 5394.6 5406.8 5407.2 5409.8 5537.3 5545.4 5545.9 5563.8 5566.2 5099.6 5343.9 5356.3 5375.8 5378.5 2920.2 2940.8 2941.3 2944.9 2986.6 5766.5 5794.5 5869.0 5896.0 5906.5 5493.0 5817.3 5846.0 5850.5 5850.9 5989.0 6005.4 6008.9 6037.3 6071.0 5528.8 5704.8 5714.7 5737.6 5772.5 5627.8 5650.1 5660.2 5665.7 5691.1 5884.4 5995.9 5999.7 6033.8 6042.5 3893.6 4017.4 4068.1 4097.6 4142.3 5687.6 5719.4 5719.5 5721.9 5728.3 5564.8 5572.3 5578.8 5581.9 5592.8 5442.2 5506.8 5514.8 5543.6 5565.9 5511.9 5518.6 5521.8 5523.9 5537.5 5437.6 5494.8 5563.7 5587.8 5595.0 5404.6 5431.8 5437.2 5439.1 5450.3 09:27:06 INFO - PROCESS | 2337 | 09:27:06 INFO - PROCESS | 2337 | [#5] yui.html Cycles:180 Average:17814.24 Median:4116.44 stddev:22642.34 (550.0%) stddev-sans-first:22669.90 09:27:06 INFO - PROCESS | 2337 | Values: 820.6 823.1 838.1 907.1 915.5 15600.1 17641.0 17750.0 17948.9 17974.0 15260.6 15386.6 15428.8 15470.9 15499.7 704.1 841.9 851.1 851.4 851.5 745.1 751.6 752.5 795.8 834.8 894.8 902.3 902.9 903.7 904.5 898.2 898.4 898.9 899.0 899.0 542.7 571.3 631.2 663.2 663.5 16568.8 17507.0 17534.6 17540.5 17557.6 14259.0 15233.6 15326.8 15736.8 16615.8 13261.4 13269.4 13358.5 13414.5 13416.5 4034.5 4037.2 4063.2 4096.7 4136.2 79350.0 79642.6 81011.0 81354.6 83245.0 11357.1 11515.8 11626.2 11684.1 11706.2 21919.5 22069.4 22256.8 22268.8 22276.7 8512.8 8603.7 8819.3 8898.7 9056.6 4851.1 4985.9 5023.5 5028.1 5088.3 3884.1 3993.8 3996.4 3997.4 3998.6 697.3 702.4 707.2 715.6 716.4 613.9 630.4 643.2 657.1 660.3 10170.0 10295.2 10323.6 10838.8 10839.5 757.7 759.1 767.9 773.3 777.6 4814.9 4859.9 4881.3 4890.8 4908.7 82095.0 82885.6 84235.0 84770.6 86066.6 56308.0 58398.0 72297.3 73833.6 74325.3 60409.0 60801.7 61696.4 61720.7 62320.4 10379.9 10628.2 10779.9 10841.1 10844.3 40803.6 40808.6 41607.4 41774.2 42324.4 49306.0 52460.7 53590.7 53824.5 53932.0 12761.3 12816.2 12853.2 12961.1 12987.6 14068.8 14130.2 14143.2 14188.1 14197.6 13284.9 13456.5 13482.1 13688.3 13798.4 11301.7 12702.5 12882.0 13205.6 13408.7 12124.8 12461.8 12496.7 12505.6 12639.6 10171.0 10280.4 10541.6 10545.9 10679.1 10157.9 10175.6 10207.7 10226.4 10251.2 09:27:06 INFO - PROCESS | 2337 | -------- Summary: end -------- 09:27:06 INFO - PROCESS | 2337 | 09:27:07 INFO - TEST-INFO | 2337: exit 0 09:27:07 INFO - TEST-OK | dromaeo_css | took 1113323ms 09:27:07 INFO - TEST-START | kraken 09:27:07 INFO - operating with platform_type : linux_ 09:27:07 INFO - Initialising browser for kraken test... 09:27:07 INFO - TEST-INFO | started process 2824 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPOqjLz/profile http://localhost:58180/getInfo.html) 09:27:10 INFO - PROCESS | 2824 | __metrics Screen width/height:1600/1200 09:27:10 INFO - PROCESS | 2824 | colorDepth:24 09:27:10 INFO - PROCESS | 2824 | Browser inner width/height: 1024/697 09:27:10 INFO - PROCESS | 2824 | __metrics 09:27:11 INFO - PROCESS | 2824 | 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:27:11 INFO - PROCESS | 2824 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:27:12 INFO - TEST-INFO | 2824: exit 0 09:27:12 INFO - Browser initialized. 09:27:12 INFO - Running cycle 1/1 for kraken test... 09:27:12 INFO - TEST-INFO | started process 2943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPOqjLz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:27:24 INFO - PROCESS | 2943 | RSS: Main: 139255808 09:27:24 INFO - PROCESS | 2943 | 09:27:27 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:58180/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58180/tests/kraken/driver.html?testName=audio-beat-detection) 09:27:28 INFO - PROCESS | 2943 | RSS: Main: 183123968 09:27:28 INFO - PROCESS | 2943 | 09:27:30 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:58180/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58180/tests/kraken/driver.html?testName=audio-dft) 09:27:31 INFO - PROCESS | 2943 | RSS: Main: 172883968 09:27:31 INFO - PROCESS | 2943 | 09:27:33 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:58180/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58180/tests/kraken/driver.html?testName=audio-fft) 09:27:34 INFO - PROCESS | 2943 | RSS: Main: 264404992 09:27:34 INFO - PROCESS | 2943 | 09:27:36 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:58180/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58180/tests/kraken/driver.html?testName=audio-oscillator) 09:27:37 INFO - PROCESS | 2943 | RSS: Main: 170676224 09:27:37 INFO - PROCESS | 2943 | 09:27:39 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:58180/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58180/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:27:39 INFO - PROCESS | 2943 | RSS: Main: 172990464 09:27:39 INFO - PROCESS | 2943 | 09:27:42 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:58180/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58180/tests/kraken/driver.html?testName=imaging-darkroom) 09:27:43 INFO - PROCESS | 2943 | RSS: Main: 212316160 09:27:43 INFO - PROCESS | 2943 | 09:27:46 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:58180/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58180/tests/kraken/driver.html?testName=imaging-desaturate) 09:27:47 INFO - PROCESS | 2943 | RSS: Main: 210956288 09:27:47 INFO - PROCESS | 2943 | 09:27:50 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:58180/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58180/tests/kraken/driver.html?testName=json-parse-financial) 09:27:50 INFO - PROCESS | 2943 | RSS: Main: 208637952 09:27:50 INFO - PROCESS | 2943 | 09:27:52 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:58180/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58180/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:27:52 INFO - PROCESS | 2943 | RSS: Main: 171446272 09:27:52 INFO - PROCESS | 2943 | 09:27:54 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:58180/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58180/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:27:55 INFO - PROCESS | 2943 | RSS: Main: 178114560 09:27:55 INFO - PROCESS | 2943 | 09:27:57 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:58180/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58180/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:27:57 INFO - PROCESS | 2943 | RSS: Main: 186986496 09:27:57 INFO - PROCESS | 2943 | 09:28:00 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:58180/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:28:00 INFO - PROCESS | 2943 | RSS: Main: 197079040 09:28:00 INFO - PROCESS | 2943 | 09:28:03 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:58180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:28:04 INFO - PROCESS | 2943 | RSS: Main: 193421312 09:28:04 INFO - PROCESS | 2943 | 09:28:05 INFO - PROCESS | 2943 | Cycle 1(1): loaded http://localhost:58180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58180/tests/kraken/driver.html?testName=ai-astar) 09:28:06 INFO - PROCESS | 2943 | RSS: Main: 245239808 09:28:06 INFO - PROCESS | 2943 | 09:28:06 INFO - PROCESS | 2943 | __start_tp_report 09:28:06 INFO - PROCESS | 2943 | _x_x_mozilla_page_load 09:28:06 INFO - PROCESS | 2943 | _x_x_mozilla_page_load_details 09:28:06 INFO - PROCESS | 2943 | |i|pagename|runs| 09:28:06 INFO - PROCESS | 2943 | |0;ai-astar;111;113;112;113;112;111;112;113;111;112 09:28:06 INFO - PROCESS | 2943 | |1;audio-beat-detection;140;117;123;156;119;118;118;119;142;117 09:28:06 INFO - PROCESS | 2943 | |2;audio-dft;160;159;159;159;160;162;161;161;160;160 09:28:06 INFO - PROCESS | 2943 | |3;audio-fft;75;75;77;107;75;76;77;75;104;75 09:28:06 INFO - PROCESS | 2943 | |4;audio-oscillator;83;83;103;84;83;84;93;83;82;100 09:28:06 INFO - PROCESS | 2943 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;117 09:28:06 INFO - PROCESS | 2943 | |6;imaging-darkroom;146;146;146;147;146;146;146;146;145;145 09:28:06 INFO - PROCESS | 2943 | |7;imaging-desaturate;97;96;97;96;96;96;96;96;96;96 09:28:06 INFO - PROCESS | 2943 | |8;json-parse-financial;50;49;49;55;48;49;51;52;50;49 09:28:06 INFO - PROCESS | 2943 | |9;json-stringify-tinderbox;64;64;64;64;64;64;64;64;64;63 09:28:06 INFO - PROCESS | 2943 | |10;stanford-crypto-aes;77;82;77;77;77;76;76;76;79;75 09:28:06 INFO - PROCESS | 2943 | |11;stanford-crypto-ccm;130;122;121;122;126;122;122;119;156;122 09:28:06 INFO - PROCESS | 2943 | |12;stanford-crypto-pbkdf2;160;163;165;165;162;160;157;158;160;159 09:28:06 INFO - PROCESS | 2943 | |13;stanford-crypto-sha256-iterative;61;66;61;61;62;66;60;69;63;59 09:28:06 INFO - PROCESS | 2943 | __end_tp_report 09:28:06 INFO - PROCESS | 2943 | __start_cc_report 09:28:06 INFO - PROCESS | 2943 | _x_x_mozilla_cycle_collect,1542 09:28:06 INFO - PROCESS | 2943 | __end_cc_report 09:28:06 INFO - PROCESS | 2943 | __startTimestamp1487352486171__endTimestamp 09:28:06 INFO - PROCESS | 2943 | 09:28:06 INFO - PROCESS | 2943 | ------- Summary: start ------- 09:28:06 INFO - PROCESS | 2943 | Number of tests: 14 09:28:06 INFO - PROCESS | 2943 | 09:28:06 INFO - PROCESS | 2943 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 09:28:06 INFO - PROCESS | 2943 | Values: 111.0 113.0 112.0 113.0 112.0 111.0 112.0 113.0 111.0 112.0 09:28:06 INFO - PROCESS | 2943 | 09:28:06 INFO - PROCESS | 2943 | [#1] audio-beat-detection Cycles:10 Average:126.90 Median:121.00 stddev:13.91 (11.5%) stddev-sans-first:13.92 09:28:06 INFO - PROCESS | 2943 | Values: 140.0 117.0 123.0 156.0 119.0 118.0 118.0 119.0 142.0 117.0 09:28:06 INFO - PROCESS | 2943 | 09:28:06 INFO - PROCESS | 2943 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 09:28:06 INFO - PROCESS | 2943 | Values: 160.0 159.0 159.0 159.0 160.0 162.0 161.0 161.0 160.0 160.0 09:28:06 INFO - PROCESS | 2943 | 09:28:06 INFO - PROCESS | 2943 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.00 stddev:12.64 (16.9%) stddev-sans-first:13.18 09:28:06 INFO - PROCESS | 2943 | Values: 75.0 75.0 77.0 107.0 75.0 76.0 77.0 75.0 104.0 75.0 09:28:06 INFO - PROCESS | 2943 | 09:28:06 INFO - PROCESS | 2943 | [#4] audio-oscillator Cycles:10 Average:87.80 Median:83.00 stddev:7.90 (9.5%) stddev-sans-first:8.19 09:28:06 INFO - PROCESS | 2943 | Values: 83.0 83.0 103.0 84.0 83.0 84.0 93.0 83.0 82.0 100.0 09:28:06 INFO - PROCESS | 2943 | 09:28:06 INFO - PROCESS | 2943 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 09:28:06 INFO - PROCESS | 2943 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 09:28:06 INFO - PROCESS | 2943 | 09:28:06 INFO - PROCESS | 2943 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 09:28:06 INFO - PROCESS | 2943 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 145.0 145.0 09:28:06 INFO - PROCESS | 2943 | 09:28:06 INFO - PROCESS | 2943 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 09:28:06 INFO - PROCESS | 2943 | Values: 97.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 09:28:06 INFO - PROCESS | 2943 | 09:28:06 INFO - PROCESS | 2943 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:50.00 stddev:2.04 (4.1%) stddev-sans-first:2.17 09:28:06 INFO - PROCESS | 2943 | Values: 50.0 49.0 49.0 55.0 48.0 49.0 51.0 52.0 50.0 49.0 09:28:06 INFO - PROCESS | 2943 | 09:28:06 INFO - PROCESS | 2943 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 09:28:06 INFO - PROCESS | 2943 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 63.0 09:28:06 INFO - PROCESS | 2943 | 09:28:06 INFO - PROCESS | 2943 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.00 stddev:1.99 (2.6%) stddev-sans-first:2.11 09:28:06 INFO - PROCESS | 2943 | Values: 77.0 82.0 77.0 77.0 77.0 76.0 76.0 76.0 79.0 75.0 09:28:06 INFO - PROCESS | 2943 | 09:28:06 INFO - PROCESS | 2943 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:122.00 stddev:10.90 (8.9%) stddev-sans-first:11.48 09:28:06 INFO - PROCESS | 2943 | Values: 130.0 122.0 121.0 122.0 126.0 122.0 122.0 119.0 156.0 122.0 09:28:06 INFO - PROCESS | 2943 | 09:28:06 INFO - PROCESS | 2943 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.00 stddev:2.77 (1.7%) stddev-sans-first:2.92 09:28:06 INFO - PROCESS | 2943 | Values: 160.0 163.0 165.0 165.0 162.0 160.0 157.0 158.0 160.0 159.0 09:28:06 INFO - PROCESS | 2943 | 09:28:06 INFO - PROCESS | 2943 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.50 stddev:3.19 (5.1%) stddev-sans-first:3.32 09:28:06 INFO - PROCESS | 2943 | Values: 61.0 66.0 61.0 61.0 62.0 66.0 60.0 69.0 63.0 59.0 09:28:06 INFO - PROCESS | 2943 | -------- Summary: end -------- 09:28:06 INFO - PROCESS | 2943 | 09:28:07 INFO - TEST-INFO | 2943: exit 0 09:28:07 INFO - TEST-OK | kraken | took 60203ms 09:28:07 INFO - SUITE-END | took 1173s 09:28:07 INFO - Completed test suite (00:19:33) 09:28:07 INFO - javascript benchmark 09:28:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3148.41754275459, 3162.2884850908536, 3184.172115250035, 3187.3943950649373, 3203.3913556424277, 5206.661566998143, 5272.578193744501, 5294.364676238847, 5295.046891559523, 5325.0, 5365.651232669874, 5385.730713464321, 5399.460053994599, 5413.106837371829, 5413.83758487246, 4936.3829521309835, 4947.060058588866, 4951.084049450863, 4970.055689419017, 5000.674956127858, 4907.730074845882, 4918.557329840313, 4959.032988567231, 5017.096922553938, 5018.774155163008, 4932.309476673268, 4950.331705219804, 4981.053599816023, 5028.069807085682, 5068.391792984847, 5055.848324550269, 5062.341895553554, 5062.392512898476, 5062.569681577052, 5090.287359769598, 4845.685030473008, 4973.850784476472, 4978.203487442028, 5014.749262536859, 5048.747562621854, 5177.922331165036, 5231.267622532849, 5241.9213711794355, 5242.501962313574, 5304.2839216706025, 5662.575306851962, 5669.801556945528, 5671.943280567224, 5677.233573467571, 5678.063119585264, 5661.943380566183, 5699.629524080963, 5723.942760572382, 5742.425757424224, 5744.080947048494, 5305.761240744176, 5353.491418315292, 5382.6232163748555, 5406.107992181324, 5439.428859969726, 5918.348981612019, 5920.8815823684145, 5948.643081415129, 5953.077273022688, 5977.282726072812, 5713.314402271754, 5723.313202415737, 5727.6849773262875, 5730.7421166047625, 5749.655020698688, 5636.830895073154, 5689.118186681071, 5689.544836413077, 5718.857028574235, 5755.798547050833, 5735.426457354231, 5776.104703770922, 5786.88426231473, 5789.392113828072, 5824.679642619697, 5775.5668324875805, 5786.42135786418, 5793.2179155814265, 5794.507466865363, 5798.82603521895, 4335.653147748172, 4425.800838962255, 4434.667399945017, 4480.171168333869, 4518.728876267434, 3970.543387510473, 4003.3594624859884, 4011.6389524942897, 4031.314676505001, 4039.0, 5617.045102332613, 5626.043572592669, 5630.662160270397, 5650.7739690412745, 5661.179129026351, 5666.46168613981, 5671.120976248688, 5673.092305231144, 5674.0, 5830.125481177773, 5518.696471694096, 5570.693611851387, 5574.442555744474, 5576.191452239403, 5589.245451864028, 4913.901721965541, 4917.336159618406, 4921.9507804922205, 4937.580305673986, 4954.355933728592, 5878.265216847894, 5938.0, 5950.642961422329, 6006.939930600725, 6015.819525414245, 5774.04728219839, 5812.593118481665, 5825.970870145622, 5874.911876321773, 5916.526677865846, 6074.088886667036, 6100.054491553638, 6124.14262003311, 6125.0, 6125.84685382869, 5559.305086864142, 5706.4864162225595, 5751.252337196138, 5759.539236861125, 5761.991651460894, 5709.200711900255, 5748.0, 5804.071348584206, 5807.535397168301, 5877.94122058774, 5670.574706896917, 5709.058005429058, 5716.54267658578, 5721.8569535761935, 5731.541476681772, 5699.601027928005, 5707.600467967202, 5719.370869204301, 5731.656100633975, 5733.082706766897, 5457.399686034612, 5480.835574932758, 5522.30971128609, 5552.69460179694, 5558.861028474321, 5658.981383351036, 5665.575081868794, 5669.064604340402, 5671.602987790815, 5684.545236380997, 5530.0, 5536.750846211849, 5542.224088627515, 5543.25166102571, 5543.307086614173], "value": 5342.629922948013, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.4512118243802, 574.5317566183561, 610.4963405190719, 629.0941044895353, 655.9803205903825, 35582.0, 46389.76805115974, 47709.28436073453, 47718.522814771844, 47925.04149917004, 50198.49801501984, 50653.0, 50663.24005139926, 50677.74661126689, 50819.0, 8978.955105224464, 9217.44695318283, 9245.121713437213, 9441.763955901122, 9456.669016584421, 11014.118870490382, 11308.37803920784, 11324.490397932072, 11711.23876948, 11713.180077394585, 11388.886111138907, 11469.827952580717, 11471.885281147206, 11473.598424055159, 11479.0, 11416.315021098719, 11470.770584588345, 11492.482838272297, 11495.885041149608, 11500.539978400853, 11168.0, 11237.157213209042, 11251.0436612888, 11252.0, 11255.718607034807, 45116.3232551512, 45515.54484455179, 45626.54373456256, 45700.3144952826, 45723.77138114321, 4320.762358070305, 4403.867883963486, 4434.334849772527, 4523.819047238107, 4587.082583483283, 34152.14619634504, 34261.486077708854, 34513.48229776556, 34884.30231395358, 35710.28579428423, 4587.885302867422, 4648.3957085578995, 4667.22990706533, 4673.6027437667835, 4689.929651055237, 251649.0, 252695.0, 252966.0, 253607.0, 256654.0, 67752.0, 67985.0, 68089.0, 68105.31894681089, 68216.6589167051, 70304.2969570308, 70577.0, 70598.0, 70644.64677676579, 70686.64656676684, 19863.801361986196, 20437.489062773253, 20467.28364507265, 20490.795092048887, 20499.28252511155, 14698.926505367619, 15089.320980555902, 15090.24548772557, 15602.375904963674, 16136.515904522883, 18212.0, 18530.722039169425, 18588.535286617942, 18616.627667446573, 18677.252909883453, 6386.616802991835, 6395.392437718409, 6402.711877965503, 6563.7702680405955, 6617.8014659560295, 961.5384615384654, 970.3741086998846, 974.1281553010016, 975.6341371985505, 993.319576090366, 31722.365552688818, 31731.20671983219, 32142.517862232085, 32271.0, 32425.02861884706, 1121.8317252412203, 1158.6581958322315, 1179.775842589905, 1179.823026546008, 1184.680136363177, 17490.737638935425, 17649.7352539712, 17718.645627087386, 17750.733738993924, 17804.46586602404, 498332.0, 500735.0, 502207.0, 502320.0, 504858.0, 68071.0, 68127.65936170287, 68167.93244304018, 68177.0, 68291.31708682948, 1577.928993195309, 1611.9838801612068, 1637.5414883832545, 1660.2694814281676, 1680.7730956320984, 31975.840120799247, 34992.0, 35781.28437431289, 35855.46216806802, 36022.0, 60627.69686151541, 62884.0, 63055.0, 63074.68462657657, 63115.0, 461363.0, 470356.0, 470630.0, 471673.0, 471903.0, 48187.0, 48465.5153448461, 49148.50851491439, 49638.50361496483, 49939.75030124826, 53894.730526348685, 54175.0, 54360.18459723186, 54399.45600543944, 56063.0, 43822.34266486069, 44284.0, 45375.0, 46488.302675460574, 46817.2977405346, 44683.0, 45572.54427455815, 45965.310520341554, 46834.0, 47009.2948605778, 44969.0, 46228.0, 46276.0, 46936.826579334425, 47023.764881175375, 37388.626113738515, 39499.80250098731, 39755.80122099371, 40093.59906400899, 40197.79901100476, 29667.703322967358, 29730.851345743133, 29763.0, 30017.0, 30135.246618834706], "value": 22330.20007133318, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.9939700904485, 432.2371015158244, 436.0096161024921, 443.583031949967, 457.56302730892, 19360.0, 21547.0, 21558.461038474026, 22445.55108897821, 23380.0, 21645.350639480803, 22954.770452295474, 22961.77038229617, 23028.65457018146, 23094.538109237805, 4210.242156411837, 4259.424977628027, 4263.381809637601, 4265.232258193524, 4310.892227694301, 5948.524118070544, 6063.48460380866, 6115.4190351916495, 6208.0, 6212.75148994042, 6071.3625069367745, 6075.392460753934, 6083.482903953147, 6084.634921904678, 6085.330613632497, 6036.547258955552, 6077.483413909823, 6080.452759251666, 6310.9684451577905, 6354.777582784626, 6235.812925612194, 6237.282712488031, 6241.157443745127, 6276.811695649138, 6281.748730050793, 25516.234512964642, 25794.484110317877, 25963.0, 26157.869210654015, 26455.470890582274, 2869.856507174633, 2872.8850845966135, 2884.8269103853627, 2899.4635992341487, 2922.0357282096857, 10054.69835904924, 10276.280660353777, 10801.513931873085, 10842.674719758419, 11354.71613209668, 2047.488127968008, 2076.3874656976227, 2113.788621137889, 2207.3046990198036, 2221.666749987499, 97847.51076244573, 98511.0, 98561.5071924643, 99675.0, 101388.49305753497, 12281.631551053482, 12567.748645027048, 12578.496860125675, 12602.180858244184, 12955.222686638832, 18188.36340728068, 18197.54506137357, 18201.544961376072, 18243.635127297646, 18250.63498730018, 9576.664816731382, 9606.951965240129, 9674.70975870725, 9728.221742260603, 9836.655717049869, 9252.121048500381, 9271.119243671841, 9295.72112836616, 9304.813903722023, 9554.378965367368, 5070.771815268248, 5199.246109314204, 5430.67415955044, 5453.15476101205, 5510.669359838423, 2101.401100686297, 2146.549224662807, 2153.913843446276, 2158.7625361210253, 2182.057968408118, 886.8182022685334, 892.2193081054078, 895.1138373010673, 901.2699713232303, 906.6464079009191, 19947.501312467306, 20557.0, 20765.273215437388, 20793.480162995744, 20918.372448826558, 907.6823111910778, 912.1881525442361, 920.8618707193974, 927.9814403711888, 929.159111004542, 11044.834327485094, 11385.487653055467, 11484.827727584094, 11528.59649912249, 11630.302181869114, 666495.0, 695731.0, 698611.0, 699121.0, 711955.0, 103562.48218759008, 106626.0, 107973.0, 109077.0, 112504.43747781208, 1095.2278643556433, 1100.779844031197, 1129.0515966588105, 1136.6760473265244, 1140.8060629692973, 17146.0, 17675.29298828084, 17685.85131894505, 17798.288068477115, 17956.19197136106, 45151.52272216175, 45164.0, 45805.31292030556, 45979.54020459753, 46740.29889551728, 57844.71077644753, 60191.699041504515, 60592.6970365163, 60725.39274607374, 61784.0, 8295.875561866456, 8977.37158398932, 9362.531873406166, 9541.618335266512, 9721.125098740864, 8396.958015209884, 9740.561674724797, 13886.93056534711, 14068.648283792578, 14491.20298383599, 12287.631371058882, 12344.62966111018, 12468.625941221779, 12565.371731413576, 12657.430415631503, 11610.70973225676, 11712.180147389601, 11763.478053435265, 11780.705482362666, 12184.268943863397, 12587.622371328875, 12723.427445764777, 12754.362281885684, 12807.29559874216, 12875.613731588068, 8901.198892099743, 9060.275177985877, 9191.586378612845, 9551.14039736427, 9647.469389183661, 11588.78317776655, 12231.388430578258, 12532.561360352343, 12645.810312845499, 12701.745965080832], "value": 10000.383125734583, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1484.6362641152919, 1503.4512402972919, 1506.1791323728567, 1509.298176347998, 1515.3559737111725, 8315.667373305068, 8897.777555561113, 8901.732948011562, 8904.198622124008, 8916.0, 7688.077430708323, 7957.124716281204, 7970.92029079709, 8152.062512811029, 8706.172913573217, 2361.197192954395, 2464.778169964703, 2468.0374653885, 2490.7882829959476, 2503.6244563315468, 2470.8270421070533, 2480.131953816159, 2495.1765917247358, 2501.3621526510715, 2511.7864981476596, 2456.1894574790276, 2485.3289611804803, 2495.8252922295446, 2505.0480817289404, 2520.0, 2348.189874493297, 2356.3873392917794, 2371.8576885386933, 2379.7501262367377, 2380.238323736405, 2363.61000434928, 2392.868392238426, 2393.9162129325564, 2395.197608801054, 2395.9041638334447, 8646.178613031752, 8745.081766414498, 8746.212840844355, 8747.912520874774, 8769.956150219272, 5083.872903177413, 5206.140986737184, 5210.218467229908, 5210.947890521084, 5215.530602245778, 3223.2747631782895, 3351.581052368454, 3456.585209774818, 3483.2336885885065, 3486.7210623150086, 1413.6112569043491, 1420.6732451536204, 1439.9136051836924, 1453.9200343981076, 1490.1506141499349, 11599.362035088066, 11607.709807254887, 11641.592544260995, 11659.125565582615, 11755.412229388496, 4672.462666793294, 4685.929711054337, 4724.480307166209, 4870.659053866266, 4883.682560633548, 10275.486225688686, 10282.691519254286, 10283.280170388001, 10283.588656453807, 10286.228532860065, 5468.179773033997, 5492.176173573916, 5525.336959564878, 5559.33288005442, 5568.359638641527, 4960.454350021495, 5017.949820501822, 5027.748612569357, 5065.392152941597, 5117.257997590403, 4192.874213773592, 4258.467691538558, 4276.593723596254, 4328.437303150633, 4334.956650433518, 1339.0760375340983, 1366.719822436398, 1374.9175049497062, 1385.9792103118461, 1390.720537105865, 991.5141580625442, 1011.6863772230485, 1018.7962407518526, 1024.262530977695, 1030.2015937648382, 5740.42595740431, 5745.385849438496, 5830.941690583039, 5865.0, 6033.064874944391, 564.2551831582354, 565.2736233939369, 570.1590154522047, 573.6586730895111, 577.5697105656313, 3801.790901500444, 3830.7221536157517, 3923.509561304837, 3949.4668219790533, 3965.7620542767527, 10099.69700908974, 10409.479526023668, 10504.947475262576, 10557.63048293306, 10570.471476426303, 10187.643432479828, 10409.635662751767, 10428.113610343054, 10463.790724185626, 10466.372017678963, 8076.8384632307025, 8081.515109093473, 8178.100408955011, 8182.0, 8189.22202390772, 5660.575456840836, 5773.826785196451, 5794.681292528951, 5794.739236734441, 5902.291724993029, 9444.0, 9489.76275593088, 9507.714768556954, 9620.0, 9645.131938125602, 8478.109798471072, 9428.10433008863, 9629.711108666472, 9637.614495420105, 9769.511524423893, 6719.260881302955, 7504.812379690551, 7509.47433679659, 7514.0607424071995, 7778.338841198562, 8402.32781377476, 8402.831943360976, 8426.157384261525, 8438.198371154731, 8505.617247224014, 7584.696612135453, 7616.162222155448, 7624.771256862303, 7632.236776322324, 7799.5320280783335, 6999.720011199699, 7049.330313620198, 7071.575705457689, 7120.430365570845, 7133.322334378226, 6808.863822723617, 6817.257019224113, 6818.31816818334, 6908.689108990208, 6918.965405172942, 5122.590192784493, 5176.4047134580005, 5200.479952004921, 5207.817726379559, 5221.0, 4971.65198436106, 5068.189089745623, 5076.956816459969, 5182.611304152279, 5243.764030618555], "value": 4597.566260019651, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.1661436532446, 382.9310724069666, 385.8610900075972, 398.4561074133807, 399.63832731378096, 5107.565856902159, 5197.610179236553, 5305.177697456896, 5314.89370212596, 5394.1639045947895, 5192.350956130484, 5243.187305967572, 5278.6568873023225, 5284.233786101013, 5305.230741542484, 4269.34312036552, 4298.290782020978, 4308.849190278341, 4313.676474264443, 4327.329263964075, 4245.957540424587, 4294.742315461067, 4312.611864932155, 4316.244657184996, 4324.0, 4261.893452663678, 4273.252180868351, 4278.807453664577, 4280.59334363235, 4304.375865499501, 4255.787210639455, 4266.871993840159, 4268.722533035343, 4273.2735434975975, 4281.957180428218, 3829.5787463379006, 3902.746321489094, 3907.824147913322, 3909.6285852843935, 3923.4311024901517, 5174.379074511083, 5177.773557370329, 5181.35233095863, 5196.558292545101, 5225.477452254782, 4862.489438608965, 4864.686534635629, 4909.5090490950615, 4920.277902734015, 4920.778564964585, 5291.682499050031, 5501.669899805985, 5515.972420137914, 5517.5585953124055, 5523.7790488380415, 4028.8187031583648, 4058.9649639342074, 4076.184763047402, 4078.245524577933, 4078.2659121358142, 5701.714914254312, 5727.398623144593, 5760.913586296209, 5770.653760774367, 5800.651960882318, 4056.6551843093666, 4155.376693495939, 4170.791460427027, 4183.456150700389, 4184.4141820145205, 4190.455240818674, 4201.558836322203, 4229.386738922901, 4229.577042295746, 4255.340422234497, 4726.385569875963, 4746.59653929413, 4751.121042607059, 4756.857294281177, 4802.207635740134, 5487.972560137174, 5529.751161197675, 5559.11054231321, 5561.360443548962, 5621.269234999506, 1411.400154934149, 1411.6894283257873, 1416.504223521759, 1417.2842714429353, 1422.7936949142315, 956.5217391304348, 971.9271054670928, 988.204495381225, 991.3506653142204, 996.2329006664828, 5389.245505629215, 5394.649347792381, 5406.837265093994, 5407.242985981966, 5409.83770486886, 5537.280153580009, 5545.362283337387, 5545.861353466195, 5563.7774489019985, 5566.2207290979295, 5099.566536844335, 5343.893122137535, 5356.276902618097, 5375.81184658535, 5378.489043540857, 2920.240737408247, 2940.823550586929, 2941.3087924337765, 2944.9411011779644, 2986.5669477926012, 5766.452187042224, 5794.5364370851075, 5869.0, 5896.0, 5906.49794767441, 5492.972535137299, 5817.301923769175, 5846.0, 5850.531957443394, 5850.922922362585, 5988.951933411636, 6005.3694362091355, 6008.939910600838, 6037.275526936795, 6071.025197653206, 5528.80649177293, 5704.771809127588, 5714.714264286852, 5737.569682273763, 5772.538196944319, 5627.831165065055, 5650.0959846424375, 5660.151097253907, 5665.716714164193, 5691.089425691869, 5884.37800917022, 5995.940040599538, 5999.700014999145, 6033.818985430444, 6042.486388657014, 3893.591172926802, 4017.3572228444477, 4068.145689405258, 4097.610726980932, 4142.2958097124165, 5687.630304030225, 5719.399463056319, 5719.542436604978, 5721.885562288648, 5728.255326807655, 5564.8330550083565, 5572.331320241435, 5578.77684892616, 5581.860453488695, 5592.7762889483965, 5442.156465747816, 5506.752196151103, 5514.834554963358, 5543.584231182758, 5565.916511252415, 5511.917321240105, 5518.558515318685, 5521.751521181476, 5523.944760552504, 5537.501624853782, 5437.619366644297, 5494.80768173112, 5563.693996830213, 5587.804426845041, 5595.006671430765, 5404.59465540094, 5431.782728690808, 5437.238786569963, 5439.129739241703, 5450.31871016123], "value": 4301.327323679312, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.6307161777198, 823.0822632764466, 838.0571856661256, 907.133687328601, 915.5468043318556, 15600.141992190425, 17641.0, 17750.0, 17948.91025544872, 17973.999999999985, 15260.618484537865, 15386.61533461664, 15428.845711542881, 15470.922645386758, 15499.69000619987, 704.102269606251, 841.8568843296654, 851.1105894340399, 851.382747508058, 851.5061264466625, 745.124478737484, 751.6166754954958, 752.4657493179849, 795.7891158842912, 834.7871292820353, 894.7852515396323, 902.2601466797229, 902.8690839828221, 903.737916004358, 904.5070436612062, 898.2050884966786, 898.4339865884483, 898.9235914947204, 899.0290486274807, 899.0470101692194, 542.7394850471795, 571.3144226927703, 631.204682100552, 663.2439019517753, 663.4559661077918, 16568.83431165685, 17507.0, 17534.561635959202, 17540.473785786446, 17557.56106097345, 14259.0, 15233.61915952099, 15326.77009844842, 15736.763948540782, 16615.83384166167, 13261.403236854365, 13269.402876870565, 13358.532451364254, 13414.530491432753, 13416.530421435204, 4034.4553485279407, 4037.192561487714, 4063.227986682521, 4096.672266218696, 4136.21411931732, 79349.99999999942, 79642.6017869907, 81011.0, 81354.59322703349, 83245.0, 11357.148213883991, 11515.827262591069, 11626.1861669684, 11684.065274777997, 11706.239094458833, 21919.452013699465, 22069.448263793212, 22256.77743222547, 22268.777312226994, 22276.66585001226, 8512.829743405096, 8603.698870539502, 8819.338549608805, 8898.688545900863, 9056.592453339616, 4851.126797176472, 4985.925211121836, 5023.472535383732, 5028.069807085701, 5088.287639730441, 3884.0678237222864, 3993.7803420812133, 3996.4205190247253, 3997.360422332413, 3998.640122388999, 697.3340459860821, 702.360851625029, 707.2149913595905, 715.6028404235595, 716.4411758828122, 613.9140520327157, 630.3822254190918, 643.1510406263687, 657.1227411405827, 660.3429587560408, 10169.983001699919, 10295.227857910537, 10323.63867264642, 10838.837417438745, 10839.458027098613, 757.7158565537924, 759.0853022108346, 767.8809784483414, 773.2731232641299, 777.6461709921972, 4814.855554333376, 4859.854204373874, 4881.316615673809, 4890.828820991248, 4908.705477671351, 82095.0, 82885.58557207175, 84235.0, 84770.5761471201, 86066.56966715127, 56308.0, 58398.0, 72297.27702723011, 73833.63083184657, 74325.25674743291, 60409.0, 60801.695991520646, 61696.38303616906, 61720.69139654273, 62320.37679623236, 10379.896201038195, 10628.202884783517, 10779.89220107789, 10841.132709383388, 10844.295120817122, 40803.59196407998, 40808.571699991546, 41607.37588936108, 41774.16451670889, 42324.36513452239, 49306.0, 52460.73769631128, 53590.732046339515, 53824.46175538195, 53932.0, 12761.298128603015, 12816.166949148275, 12853.16454430459, 12961.092723509264, 12987.610371688865, 14068.78896816569, 14130.222837744022, 14143.151410915378, 14188.148711077369, 14197.574072777834, 13284.933575332061, 13456.46174153062, 13482.123661961941, 13688.315584220949, 13798.379072941943, 11301.71745706364, 12702.491900324254, 12882.03384746129, 13205.603831885059, 13408.731825363633, 12124.75750485003, 12461.813072803734, 12496.687582810502, 12505.624831255076, 12639.557615483414, 10170.953303824965, 10280.434576098387, 10541.631042913461, 10545.9472702636, 10679.14566834667, 10157.9492102539, 10175.643852465128, 10207.7448063799, 10226.437545935045, 10251.179905607683], "value": 7434.141204217675, "unit": "score"}], "name": "dromaeo_css", "value": 7481.911398666152, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 112.0, 113.0, 112.0, 111.0, 112.0, 113.0, 111.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 117.0, 123.0, 156.0, 119.0, 118.0, 118.0, 119.0, 142.0, 117.0], "value": 126.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 159.0, 159.0, 160.0, 162.0, 161.0, 161.0, 160.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 107.0, 75.0, 76.0, 77.0, 75.0, 104.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 103.0, 84.0, 83.0, 84.0, 93.0, 83.0, 82.0, 100.0], "value": 87.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 55.0, 48.0, 49.0, 51.0, 52.0, 50.0, 49.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 82.0, 77.0, 77.0, 77.0, 76.0, 76.0, 76.0, 79.0, 75.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 122.0, 121.0, 122.0, 126.0, 122.0, 122.0, 119.0, 156.0, 122.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 165.0, 165.0, 162.0, 160.0, 157.0, 158.0, 160.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 66.0, 61.0, 61.0, 62.0, 66.0, 60.0, 69.0, 63.0, 59.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1468.6000000000001, "alertThreshold": 2.0}]} 09:28:07 INFO - Return code: 0 09:28:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:28:07 ERROR - # TBPL SUCCESS # 09:28:07 INFO - Running post-action listener: _resource_record_post_action 09:28:07 INFO - [mozharness: 2017-02-17 17:28:07.472827Z] Finished run-tests step (success) 09:28:07 INFO - Running post-run listener: _resource_record_post_run 09:28:07 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 364646400; Read time: 12; Write time: 221528 09:28:07 INFO - TinderboxPrint: CPU usage
13.0% 09:28:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:28:07 INFO - TinderboxPrint: I/O write bytes / time
364,646,400 / 221,528 09:28:07 INFO - TinderboxPrint: CPU idle
8,263.1 (87.0%) 09:28:07 INFO - TinderboxPrint: CPU user
1,189.7 (12.5%) 09:28:07 INFO - TinderboxPrint: Swap in / out
0 / 0 09:28:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110137344; Read time: 0; Write time: 102800 09:28:07 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 254509056; Read time: 12; Write time: 118728 09:28:08 INFO - Running post-run listener: _upload_blobber_files 09:28:08 INFO - Blob upload gear active. 09:28:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:28:08 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:28:08 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:28:08 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:28:08 INFO - (blobuploader) - INFO - Open directory for files ... 09:28:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:28:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:28:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:28:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:28:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:28:09 INFO - (blobuploader) - INFO - Done attempting. 09:28:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:28:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:28:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:28:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:28:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:28:10 INFO - (blobuploader) - INFO - Done attempting. 09:28:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:28:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:28:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:28:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:28:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:28:11 INFO - (blobuploader) - INFO - Done attempting. 09:28:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:28:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:28:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:28:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:28:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:28:14 INFO - (blobuploader) - INFO - Done attempting. 09:28:14 INFO - (blobuploader) - INFO - Iteration through files over. 09:28:14 INFO - Return code: 0 09:28:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:28:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:28:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b1643631bfc7f93540a04ff80cd7a038cdf2807652974876ffb2acfc3ff8720547d589862e86461eb36286178c53d866b317650d82c941964891cd187977c3bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9699b957307e8ecd5b72d8b0a8113194a6f7703f77d09d71d8fb61bd03d8c739f1d76005841b96d5ce8a3462c11f01a92596699656a2e001b4e43e15eff2e834", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/582a64f099759938dfd2cdb2ac89a1c9aebfdd375f6d511337414925f77252bb4ec2a828d00210117a9806ecdfea8644c9d9a4b9a612bcb0afa9eaf248b7b081", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/79f7021bdc128dab8bba6b5a47ca06adcd021d3d8c99500fbae6c3d724b3901f59431c5031eabbae2d145e56d2ee50fd453c95f186004ff990424cf605a73721"} 09:28:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:28:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:28:14 INFO - Contents: 09:28:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b1643631bfc7f93540a04ff80cd7a038cdf2807652974876ffb2acfc3ff8720547d589862e86461eb36286178c53d866b317650d82c941964891cd187977c3bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9699b957307e8ecd5b72d8b0a8113194a6f7703f77d09d71d8fb61bd03d8c739f1d76005841b96d5ce8a3462c11f01a92596699656a2e001b4e43e15eff2e834", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/582a64f099759938dfd2cdb2ac89a1c9aebfdd375f6d511337414925f77252bb4ec2a828d00210117a9806ecdfea8644c9d9a4b9a612bcb0afa9eaf248b7b081", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/79f7021bdc128dab8bba6b5a47ca06adcd021d3d8c99500fbae6c3d724b3901f59431c5031eabbae2d145e56d2ee50fd453c95f186004ff990424cf605a73721"} 09:28:14 INFO - Running post-run listener: copy_logs_to_upload_dir 09:28:14 INFO - Copying logs to upload dir... 09:28:14 INFO - mkdir: /builds/slave/test/build/upload/logs 09:28:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.857303 ========= master_lag: 0.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-17 09:28:14.240248) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-17 09:28:14.245256) ========= 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=337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b1643631bfc7f93540a04ff80cd7a038cdf2807652974876ffb2acfc3ff8720547d589862e86461eb36286178c53d866b317650d82c941964891cd187977c3bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9699b957307e8ecd5b72d8b0a8113194a6f7703f77d09d71d8fb61bd03d8c739f1d76005841b96d5ce8a3462c11f01a92596699656a2e001b4e43e15eff2e834", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/582a64f099759938dfd2cdb2ac89a1c9aebfdd375f6d511337414925f77252bb4ec2a828d00210117a9806ecdfea8644c9d9a4b9a612bcb0afa9eaf248b7b081", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/79f7021bdc128dab8bba6b5a47ca06adcd021d3d8c99500fbae6c3d724b3901f59431c5031eabbae2d145e56d2ee50fd453c95f186004ff990424cf605a73721"} build_url:https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011358 build_url: 'https://queue.taskcluster.net/v1/task/HZ_7y5YJQvWDNRRI7UEIQw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b1643631bfc7f93540a04ff80cd7a038cdf2807652974876ffb2acfc3ff8720547d589862e86461eb36286178c53d866b317650d82c941964891cd187977c3bd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9699b957307e8ecd5b72d8b0a8113194a6f7703f77d09d71d8fb61bd03d8c739f1d76005841b96d5ce8a3462c11f01a92596699656a2e001b4e43e15eff2e834", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/582a64f099759938dfd2cdb2ac89a1c9aebfdd375f6d511337414925f77252bb4ec2a828d00210117a9806ecdfea8644c9d9a4b9a612bcb0afa9eaf248b7b081", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/79f7021bdc128dab8bba6b5a47ca06adcd021d3d8c99500fbae6c3d724b3901f59431c5031eabbae2d145e56d2ee50fd453c95f186004ff990424cf605a73721"}' ========= master_lag: 0.08 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-17 09:28:14.334698) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:28:14.335032) ========= 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=337fe3f4b1febe37b85fccc40000019e-1487351257.454799-396393369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:28:14.351219) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-17 09:28:14.351547) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-17 09:28:14.351839) ========= ========= Total master_lag: 0.48 =========