builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1488328337.68 results: success (0) revision: fc9372a2c3fb327567c00ef86ab6f051f8d17482 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-28 16:32:17.682737) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-28 16:32:17.683171) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-28 16:32:17.683436) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-28 16:32:17.699301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 16:32:17.699573) ========= 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=af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-28 16:32:17-- 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% 114M=0s 2017-02-28 16:32:18 (114 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118388 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 16:32:17.830803) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 16:32:17.831113) ========= 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=af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016771 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 16:32:17.880300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-28 16:32:17.880579) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fc9372a2c3fb327567c00ef86ab6f051f8d17482 --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 fc9372a2c3fb327567c00ef86ab6f051f8d17482 --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=af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-28 16:32:18,190 truncating revision to first 12 chars 2017-02-28 16:32:18,190 Setting DEBUG logging. 2017-02-28 16:32:18,190 attempt 1/10 2017-02-28 16:32:18,190 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fc9372a2c3fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-28 16:32:19,166 unpacking tar archive at: mozilla-aurora-fc9372a2c3fb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.372736 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-28 16:32:19.266307) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-28 16:32:19.266657) ========= script_repo_revision: fc9372a2c3fb327567c00ef86ab6f051f8d17482 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-28 16:32:19.267023) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-28 16:32:19.267320) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-28 16:32:19.276187) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-02-28 16:32:19.276505) ========= /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=af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:32:19 INFO - MultiFileLogger online at 20170228 16:32:19 in /builds/slave/test 16:32:19 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 16:32:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:32:19 INFO - {'append_to_log': False, 16:32:19 INFO - 'base_work_dir': '/builds/slave/test', 16:32:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 16:32:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:32:19 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 16:32:19 INFO - 'buildbot_json_path': 'buildprops.json', 16:32:19 INFO - 'config_files': ('talos/linux_config.py',), 16:32:19 INFO - 'default_actions': ('clobber', 16:32:19 INFO - 'read-buildbot-config', 16:32:19 INFO - 'download-and-extract', 16:32:19 INFO - 'populate-webroot', 16:32:19 INFO - 'create-virtualenv', 16:32:19 INFO - 'install', 16:32:19 INFO - 'run-tests'), 16:32:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:32:19 INFO - 'download_minidump_stackwalk': True, 16:32:19 INFO - 'download_symbols': 'ondemand', 16:32:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:32:19 INFO - 'tooltool.py': '/tools/tooltool.py', 16:32:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:32:19 INFO - '/tools/misc-python/virtualenv.py')}, 16:32:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:32:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:32:19 INFO - 'installer_path': 'installer.exe', 16:32:19 INFO - 'log_level': 'info', 16:32:19 INFO - 'log_name': 'talos', 16:32:19 INFO - 'log_to_console': True, 16:32:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:32:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:32:19 INFO - 'opt_config_files': (), 16:32:19 INFO - 'pip_index': False, 16:32:19 INFO - 'sps_profile': False, 16:32:19 INFO - 'sps_profile_interval': 0, 16:32:19 INFO - 'suite': 'dromaeojs', 16:32:19 INFO - 'system_bits': '32', 16:32:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:32:19 INFO - 'title': 'talos-linux64-ix-020', 16:32:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:32:19 INFO - 'use_talos_json': True, 16:32:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:32:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:32:19 INFO - 'work_dir': 'build'} 16:32:19 INFO - [mozharness: 2017-03-01 00:32:19.692557Z] Running clobber step. 16:32:19 INFO - Running pre-action listener: _resource_record_pre_action 16:32:19 INFO - Running main action method: clobber 16:32:19 INFO - rmtree: /builds/slave/test/build 16:32:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:32:20 INFO - Running post-action listener: _resource_record_post_action 16:32:20 INFO - [mozharness: 2017-03-01 00:32:20.732828Z] Finished clobber step (success) 16:32:20 INFO - [mozharness: 2017-03-01 00:32:20.732928Z] Running read-buildbot-config step. 16:32:20 INFO - Running pre-action listener: _resource_record_pre_action 16:32:20 INFO - Running main action method: read_buildbot_config 16:32:20 INFO - Using buildbot properties: 16:32:20 INFO - { 16:32:20 INFO - "project": "", 16:32:20 INFO - "product": "firefox", 16:32:20 INFO - "who": "michael@thelayzells.com", 16:32:20 INFO - "installer_path": "public/build/target.tar.bz2", 16:32:20 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 16:32:20 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 16:32:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 16:32:20 INFO - "stage_platform": "linux64", 16:32:20 INFO - "basedir": "/builds/slave/test", 16:32:20 INFO - "buildnumber": 49, 16:32:20 INFO - "platform": "ubuntu64_hw", 16:32:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:32:20 INFO - "slavebuilddir": "test", 16:32:20 INFO - "taskId": "YhwfRTcnTVCGKh_61flqag", 16:32:20 INFO - "branch": "mozilla-aurora", 16:32:20 INFO - "script_repo_revision": "production", 16:32:20 INFO - "revision": "fc9372a2c3fb327567c00ef86ab6f051f8d17482", 16:32:20 INFO - "slavename": "talos-linux64-ix-020", 16:32:20 INFO - "repo_path": "releases/mozilla-aurora" 16:32:20 INFO - } 16:32:20 INFO - Finding installer, test and symbols from parent task. 16:32:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YhwfRTcnTVCGKh_61flqag'}, attempt #1 16:32:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YhwfRTcnTVCGKh_61flqag'}, attempt #1 16:32:21 INFO - Task dependencies: bVi5ATPOT4qJUpdwoozyJw 16:32:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw'}, attempt #1 16:32:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.tar.bz2 16:32:22 INFO - Set test_url: https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/test_packages.json 16:32:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.crashreporter-symbols.zip 16:32:22 INFO - Running post-action listener: _resource_record_post_action 16:32:22 INFO - [mozharness: 2017-03-01 00:32:22.133556Z] Finished read-buildbot-config step (success) 16:32:22 INFO - [mozharness: 2017-03-01 00:32:22.133773Z] Running download-and-extract step. 16:32:22 INFO - Running pre-action listener: _resource_record_pre_action 16:32:22 INFO - Running main action method: download_and_extract 16:32:22 INFO - mkdir: /builds/slave/test/build/tests 16:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:22 INFO - trying https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.test_packages.json 16:32:22 INFO - Downloading https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:32:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:32:22 INFO - Downloaded 896 bytes. 16:32:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:32:22 INFO - Using the following test package requirements: 16:32:22 INFO - {u'common': [u'target.common.tests.zip'], 16:32:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:32:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:32:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:32:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:32:22 INFO - u'mozbase': [u'target.common.tests.zip'], 16:32:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:32:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:32:22 INFO - u'web-platform': [u'target.common.tests.zip', 16:32:22 INFO - u'target.web-platform.tests.zip'], 16:32:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:32:22 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:32:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.common.tests.zip 16:32:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:32:22 INFO - Fetch https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.common.tests.zip into memory 16:32:23 INFO - Expected file size: 21863283 16:32:23 INFO - Obtained file size: 21863283 16:32:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:32:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.common.tests.zip 16:32:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:32:27 INFO - Fetch https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.common.tests.zip into memory 16:32:28 INFO - Expected file size: 21863283 16:32:28 INFO - Obtained file size: 21863283 16:32:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.talos.tests.zip 16:32:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:32:32 INFO - Fetch https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.talos.tests.zip into memory 16:32:33 INFO - Expected file size: 14403472 16:32:33 INFO - Obtained file size: 14403472 16:32: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')]} 16:32:33 INFO - trying https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.tar.bz2 16:32:33 INFO - Downloading https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:32:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:32:34 INFO - Downloaded 66145310 bytes. 16:32:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.tar.bz2 16:32:34 INFO - mkdir: /builds/slave/test/properties 16:32:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:32:34 INFO - Writing to file /builds/slave/test/properties/build_url 16:32:34 INFO - Contents: 16:32:34 INFO - build_url:https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.tar.bz2 16:32:34 INFO - Running post-action listener: _resource_record_post_action 16:32:34 INFO - Running post-action listener: set_extra_try_arguments 16:32:34 INFO - [mozharness: 2017-03-01 00:32:34.925680Z] Finished download-and-extract step (success) 16:32:34 INFO - [mozharness: 2017-03-01 00:32:34.925775Z] Running populate-webroot step. 16:32:34 INFO - Running pre-action listener: _resource_record_pre_action 16:32:34 INFO - Running main action method: populate_webroot 16:32:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:32:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:32:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:32:34 INFO - '--tppagecycles', 16:32:34 INFO - '7'], 16:32:34 INFO - 'tests': ['tsvgm']}}, 16:32:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:32:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:32:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:32:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:32:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:32:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:32:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:32:34 INFO - 'talos_options': ['--disable-e10s'], 16:32:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:32:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:32:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:32:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:32:34 INFO - 'talos_options': ['--disable-e10s'], 16:32:34 INFO - 'tests': ['damp', 'tps']}, 16:32:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:32:34 INFO - 'tests': ['damp', 'tps']}, 16:32:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:32:34 INFO - 'tests': ['dromaeo_dom']}, 16:32:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:32:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:32:34 INFO - 'tests': ['basic_compositor_video']}, 16:32:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:32:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:32:34 INFO - 'tests': ['a11yr', 16:32:34 INFO - 'ts_paint', 16:32:34 INFO - 'tpaint', 16:32:34 INFO - 'sessionrestore', 16:32:34 INFO - 'sessionrestore_no_auto_restore', 16:32:34 INFO - 'tabpaint']}, 16:32:34 INFO - 'other-e10s': {'tests': ['a11yr', 16:32:34 INFO - 'ts_paint', 16:32:34 INFO - 'tpaint', 16:32:34 INFO - 'sessionrestore', 16:32:34 INFO - 'sessionrestore_no_auto_restore', 16:32:34 INFO - 'tabpaint']}, 16:32:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:32:34 INFO - 'ts_paint', 16:32:34 INFO - 'tpaint', 16:32:34 INFO - 'sessionrestore', 16:32:34 INFO - 'sessionrestore_no_auto_restore', 16:32:34 INFO - 'tabpaint']}, 16:32:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:32:34 INFO - 'ts_paint', 16:32:34 INFO - 'tpaint', 16:32:34 INFO - 'sessionrestore', 16:32:34 INFO - 'sessionrestore_no_auto_restore', 16:32:34 INFO - 'tabpaint']}, 16:32:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:32:34 INFO - 'tests': ['a11yr', 16:32:34 INFO - 'ts_paint', 16:32:34 INFO - 'tpaint', 16:32:34 INFO - 'sessionrestore', 16:32:34 INFO - 'sessionrestore_no_auto_restore', 16:32:34 INFO - 'tabpaint']}, 16:32:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:32:34 INFO - 'tests': ['a11yr', 16:32:34 INFO - 'ts_paint', 16:32:34 INFO - 'tpaint', 16:32:34 INFO - 'sessionrestore', 16:32:34 INFO - 'sessionrestore_no_auto_restore', 16:32:34 INFO - 'tabpaint']}, 16:32:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:32:34 INFO - 'tests': ['tsvgx', 16:32:34 INFO - 'tsvgr_opacity', 16:32:34 INFO - 'tart', 16:32:34 INFO - 'tscrollx', 16:32:34 INFO - 'cart', 16:32:34 INFO - 'tsvg_static']}, 16:32:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:32:34 INFO - 'tsvgr_opacity', 16:32:34 INFO - 'tart', 16:32:34 INFO - 'tscrollx', 16:32:34 INFO - 'cart', 16:32:34 INFO - 'tsvg_static']}, 16:32:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:32:34 INFO - 'talos_options': ['--disable-e10s'], 16:32:34 INFO - 'tests': ['tp5o']}, 16:32:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:32:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:32:34 INFO - 'talos_options': ['--disable-e10s', 16:32:34 INFO - '--xperf_path', 16:32:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:32:34 INFO - 'tests': ['tp5n']}, 16:32:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:32:34 INFO - 'talos_options': ['--xperf_path', 16:32:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:32:34 INFO - 'tests': ['tp5n']}}, 16:32:34 INFO - 'talos.zip': {'path': '', 16:32:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:32:34 INFO - Running post-action listener: _resource_record_post_action 16:32:34 INFO - [mozharness: 2017-03-01 00:32:34.938837Z] Finished populate-webroot step (success) 16:32:34 INFO - [mozharness: 2017-03-01 00:32:34.938927Z] Running create-virtualenv step. 16:32:34 INFO - Running pre-action listener: _resource_record_pre_action 16:32:34 INFO - Running main action method: create_virtualenv 16:32:34 INFO - Creating virtualenv /builds/slave/test/build/venv 16:32:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:32:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:32:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:32:35 INFO - Using real prefix '/usr' 16:32:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:32:35 INFO - Installing distribute.............................................................................................................................................................................................done. 16:32:37 INFO - Installing pip.................done. 16:32:37 INFO - Return code: 0 16:32:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:32:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:32:37 INFO - Reading from file tmpfile_stdout 16:32:37 INFO - Output received: 16:32:37 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:32:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19eb980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e8d00>, '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 0x19e9a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9eb0>, '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': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:32:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:32:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:32:37 INFO - Using env: {'DISPLAY': ':0', 16:32:37 INFO - 'HOME': '/home/cltbld', 16:32:37 INFO - 'LANG': 'en_US.UTF-8', 16:32:37 INFO - 'LANGUAGE': 'en_US:en', 16:32:37 INFO - 'LOGNAME': 'cltbld', 16:32:37 INFO - 'MAIL': '/var/mail/cltbld', 16:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:37 INFO - 'MOZ_NO_REMOTE': '1', 16:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:37 INFO - 'NO_EM_RESTART': '1', 16:32:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:37 INFO - 'PWD': '/builds/slave/test', 16:32:37 INFO - 'SHELL': '/bin/bash', 16:32:37 INFO - 'SHLVL': '1', 16:32:37 INFO - 'TERM': 'linux', 16:32:37 INFO - 'TMOUT': '86400', 16:32:37 INFO - 'USER': 'cltbld', 16:32:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 16:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:37 INFO - '_': '/tools/buildbot/bin/python'} 16:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:32:37 INFO - Cleaning up... 16:32:37 INFO - Return code: 0 16:32:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19eb980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e8d00>, '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 0x19e9a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9eb0>, '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': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:32:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:32:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:32:37 INFO - Using env: {'DISPLAY': ':0', 16:32:37 INFO - 'HOME': '/home/cltbld', 16:32:37 INFO - 'LANG': 'en_US.UTF-8', 16:32:37 INFO - 'LANGUAGE': 'en_US:en', 16:32:37 INFO - 'LOGNAME': 'cltbld', 16:32:37 INFO - 'MAIL': '/var/mail/cltbld', 16:32:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:37 INFO - 'MOZ_NO_REMOTE': '1', 16:32:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:37 INFO - 'NO_EM_RESTART': '1', 16:32:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:37 INFO - 'PWD': '/builds/slave/test', 16:32:37 INFO - 'SHELL': '/bin/bash', 16:32:37 INFO - 'SHLVL': '1', 16:32:37 INFO - 'TERM': 'linux', 16:32:37 INFO - 'TMOUT': '86400', 16:32:37 INFO - 'USER': 'cltbld', 16:32:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 16:32:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:37 INFO - '_': '/tools/buildbot/bin/python'} 16:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:38 INFO - Downloading/unpacking psutil>=3.1.1 16:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:32:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:41 INFO - Installing collected packages: psutil 16:32:41 INFO - Running setup.py install for psutil 16:32:41 INFO - building 'psutil._psutil_linux' extension 16:32:41 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 16:32:41 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 16:32:41 INFO - building 'psutil._psutil_posix' extension 16:32:41 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 16:32:41 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 16:32:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:41 INFO - Successfully installed psutil 16:32:41 INFO - Cleaning up... 16:32:41 INFO - Return code: 0 16:32:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32: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')]} 16:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:41 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 0x16791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19eb980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e8d00>, '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 0x19e9a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9eb0>, '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': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:32:41 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 16:32:41 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 16:32:41 INFO - Using env: {'DISPLAY': ':0', 16:32:41 INFO - 'HOME': '/home/cltbld', 16:32:41 INFO - 'LANG': 'en_US.UTF-8', 16:32:41 INFO - 'LANGUAGE': 'en_US:en', 16:32:41 INFO - 'LOGNAME': 'cltbld', 16:32:41 INFO - 'MAIL': '/var/mail/cltbld', 16:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:41 INFO - 'MOZ_NO_REMOTE': '1', 16:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:41 INFO - 'NO_EM_RESTART': '1', 16:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:41 INFO - 'PWD': '/builds/slave/test', 16:32:41 INFO - 'SHELL': '/bin/bash', 16:32:41 INFO - 'SHLVL': '1', 16:32:41 INFO - 'TERM': 'linux', 16:32:41 INFO - 'TMOUT': '86400', 16:32:41 INFO - 'USER': 'cltbld', 16:32:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 16:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:41 INFO - '_': '/tools/buildbot/bin/python'} 16:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:32:44 INFO - Installing collected packages: mozsystemmonitor 16:32:44 INFO - Running setup.py install for mozsystemmonitor 16:32:44 INFO - Successfully installed mozsystemmonitor 16:32:44 INFO - Cleaning up... 16:32:44 INFO - Return code: 0 16:32:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:44 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 0x16791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19eb980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e8d00>, '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 0x19e9a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9eb0>, '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': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:32:44 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 16:32:44 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 16:32:44 INFO - Using env: {'DISPLAY': ':0', 16:32:44 INFO - 'HOME': '/home/cltbld', 16:32:44 INFO - 'LANG': 'en_US.UTF-8', 16:32:44 INFO - 'LANGUAGE': 'en_US:en', 16:32:44 INFO - 'LOGNAME': 'cltbld', 16:32:44 INFO - 'MAIL': '/var/mail/cltbld', 16:32:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:44 INFO - 'MOZ_NO_REMOTE': '1', 16:32:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:44 INFO - 'NO_EM_RESTART': '1', 16:32:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:44 INFO - 'PWD': '/builds/slave/test', 16:32:44 INFO - 'SHELL': '/bin/bash', 16:32:44 INFO - 'SHLVL': '1', 16:32:44 INFO - 'TERM': 'linux', 16:32:44 INFO - 'TMOUT': '86400', 16:32:44 INFO - 'USER': 'cltbld', 16:32:44 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 16:32:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:44 INFO - '_': '/tools/buildbot/bin/python'} 16:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:44 INFO - Downloading/unpacking jsonschema==2.5.1 16:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:32:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:46 INFO - Downloading functools32-3.2.3-2.tar.gz 16:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:32:46 INFO - warning: no files found matching '*.txt' 16:32:46 INFO - no previously-included directories found matching 'build' 16:32:46 INFO - no previously-included directories found matching 'dist' 16:32:46 INFO - no previously-included directories found matching '.git*' 16:32:46 INFO - Installing collected packages: jsonschema, functools32 16:32:46 INFO - Running setup.py install for functools32 16:32:46 INFO - warning: no files found matching '*.txt' 16:32:46 INFO - no previously-included directories found matching 'build' 16:32:46 INFO - no previously-included directories found matching 'dist' 16:32:46 INFO - no previously-included directories found matching '.git*' 16:32:46 INFO - Successfully installed jsonschema functools32 16:32:46 INFO - Cleaning up... 16:32:46 INFO - Return code: 0 16:32:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19eb980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e8d00>, '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 0x19e9a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9eb0>, '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': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:32:46 INFO - Using env: {'DISPLAY': ':0', 16:32:46 INFO - 'HOME': '/home/cltbld', 16:32:46 INFO - 'LANG': 'en_US.UTF-8', 16:32:46 INFO - 'LANGUAGE': 'en_US:en', 16:32:46 INFO - 'LOGNAME': 'cltbld', 16:32:46 INFO - 'MAIL': '/var/mail/cltbld', 16:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:46 INFO - 'MOZ_NO_REMOTE': '1', 16:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:46 INFO - 'NO_EM_RESTART': '1', 16:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:46 INFO - 'PWD': '/builds/slave/test', 16:32:46 INFO - 'SHELL': '/bin/bash', 16:32:46 INFO - 'SHLVL': '1', 16:32:46 INFO - 'TERM': 'linux', 16:32:46 INFO - 'TMOUT': '86400', 16:32:46 INFO - 'USER': 'cltbld', 16:32:46 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 16:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:46 INFO - '_': '/tools/buildbot/bin/python'} 16:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:32:47 INFO - Cleaning up... 16:32:47 INFO - Return code: 0 16:32:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:47 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 0x16791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19eb980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e8d00>, '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 0x19e9a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9eb0>, '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': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:32:47 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 16:32:47 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 16:32:47 INFO - Using env: {'DISPLAY': ':0', 16:32:47 INFO - 'HOME': '/home/cltbld', 16:32:47 INFO - 'LANG': 'en_US.UTF-8', 16:32:47 INFO - 'LANGUAGE': 'en_US:en', 16:32:47 INFO - 'LOGNAME': 'cltbld', 16:32:47 INFO - 'MAIL': '/var/mail/cltbld', 16:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:47 INFO - 'MOZ_NO_REMOTE': '1', 16:32:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:47 INFO - 'NO_EM_RESTART': '1', 16:32:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:47 INFO - 'PWD': '/builds/slave/test', 16:32:47 INFO - 'SHELL': '/bin/bash', 16:32:47 INFO - 'SHLVL': '1', 16:32:47 INFO - 'TERM': 'linux', 16:32:47 INFO - 'TMOUT': '86400', 16:32:47 INFO - 'USER': 'cltbld', 16:32:47 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 16:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:47 INFO - '_': '/tools/buildbot/bin/python'} 16:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:47 INFO - Downloading/unpacking blobuploader==1.2.4 16:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:49 INFO - Downloading blobuploader-1.2.4.tar.gz 16:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:32:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:32:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:50 INFO - Downloading docopt-0.6.1.tar.gz 16:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:32:50 INFO - Installing collected packages: blobuploader, requests, docopt 16:32:50 INFO - Running setup.py install for blobuploader 16:32:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:32:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:32:50 INFO - Running setup.py install for requests 16:32:50 INFO - Running setup.py install for docopt 16:32:50 INFO - Successfully installed blobuploader requests docopt 16:32:50 INFO - Cleaning up... 16:32:50 INFO - Return code: 0 16:32:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:50 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 0x16791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19eb980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e8d00>, '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 0x19e9a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9eb0>, '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': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:32:50 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 16:32:50 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 16:32:50 INFO - Using env: {'DISPLAY': ':0', 16:32:50 INFO - 'HOME': '/home/cltbld', 16:32:50 INFO - 'LANG': 'en_US.UTF-8', 16:32:50 INFO - 'LANGUAGE': 'en_US:en', 16:32:50 INFO - 'LOGNAME': 'cltbld', 16:32:50 INFO - 'MAIL': '/var/mail/cltbld', 16:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:50 INFO - 'MOZ_NO_REMOTE': '1', 16:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:50 INFO - 'NO_EM_RESTART': '1', 16:32:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:50 INFO - 'PWD': '/builds/slave/test', 16:32:50 INFO - 'SHELL': '/bin/bash', 16:32:50 INFO - 'SHLVL': '1', 16:32:50 INFO - 'TERM': 'linux', 16:32:50 INFO - 'TMOUT': '86400', 16:32:50 INFO - 'USER': 'cltbld', 16:32:50 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 16:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:50 INFO - '_': '/tools/buildbot/bin/python'} 16:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:51 INFO - Running setup.py (path:/tmp/pip-UkvuDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:51 INFO - Running setup.py (path:/tmp/pip-sL2pXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:51 INFO - Running setup.py (path:/tmp/pip-R01Nfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:51 INFO - Running setup.py (path:/tmp/pip-P2MZIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:51 INFO - Running setup.py (path:/tmp/pip-gRurIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:51 INFO - Running setup.py (path:/tmp/pip-noIk_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:51 INFO - Running setup.py (path:/tmp/pip-cWMm0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:51 INFO - Running setup.py (path:/tmp/pip-5A2TS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:51 INFO - Running setup.py (path:/tmp/pip-Q8IrfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:51 INFO - Running setup.py (path:/tmp/pip-vTXS7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:51 INFO - Running setup.py (path:/tmp/pip-kzxqoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:51 INFO - Running setup.py (path:/tmp/pip-mH7sQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:51 INFO - Running setup.py (path:/tmp/pip-7IXhKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:51 INFO - Running setup.py (path:/tmp/pip-04GoEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:52 INFO - Running setup.py (path:/tmp/pip-PnlFnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:52 INFO - Running setup.py (path:/tmp/pip-zmycJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:52 INFO - Running setup.py (path:/tmp/pip-TqkUdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:32:52 INFO - Running setup.py install for manifestparser 16:32:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:32:52 INFO - Running setup.py install for mozcrash 16:32:52 INFO - Running setup.py install for mozdebug 16:32:52 INFO - Running setup.py install for mozdevice 16:32:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:32:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:32:52 INFO - Running setup.py install for mozfile 16:32:52 INFO - Running setup.py install for mozhttpd 16:32:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:32:52 INFO - Running setup.py install for mozinfo 16:32:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:32:52 INFO - Running setup.py install for mozInstall 16:32:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:32:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:32:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:32:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:32:53 INFO - Running setup.py install for mozleak 16:32:53 INFO - Running setup.py install for mozlog 16:32:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:32:53 INFO - Running setup.py install for moznetwork 16:32:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:32:53 INFO - Running setup.py install for mozprocess 16:32:53 INFO - Running setup.py install for mozprofile 16:32:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:32:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:32:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:32:53 INFO - Running setup.py install for mozrunner 16:32:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:32:53 INFO - Running setup.py install for mozscreenshot 16:32:53 INFO - Running setup.py install for moztest 16:32:53 INFO - Running setup.py install for mozversion 16:32:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:32:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:32:54 INFO - Cleaning up... 16:32:54 INFO - Return code: 0 16:32:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:54 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 0x16791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19eb980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e8d00>, '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 0x19e9a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9eb0>, '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': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:32:54 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 16:32:54 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 16:32:54 INFO - Using env: {'DISPLAY': ':0', 16:32:54 INFO - 'HOME': '/home/cltbld', 16:32:54 INFO - 'LANG': 'en_US.UTF-8', 16:32:54 INFO - 'LANGUAGE': 'en_US:en', 16:32:54 INFO - 'LOGNAME': 'cltbld', 16:32:54 INFO - 'MAIL': '/var/mail/cltbld', 16:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:54 INFO - 'MOZ_NO_REMOTE': '1', 16:32:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:54 INFO - 'NO_EM_RESTART': '1', 16:32:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:54 INFO - 'PWD': '/builds/slave/test', 16:32:54 INFO - 'SHELL': '/bin/bash', 16:32:54 INFO - 'SHLVL': '1', 16:32:54 INFO - 'TERM': 'linux', 16:32:54 INFO - 'TMOUT': '86400', 16:32:54 INFO - 'USER': 'cltbld', 16:32:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 16:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:54 INFO - '_': '/tools/buildbot/bin/python'} 16:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:54 INFO - Running setup.py (path:/tmp/pip-Q83v77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:54 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)) 16:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:54 INFO - Running setup.py (path:/tmp/pip-Zql8qW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:54 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)) 16:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:54 INFO - Running setup.py (path:/tmp/pip-ArMdRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:54 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)) 16:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:54 INFO - Running setup.py (path:/tmp/pip-Y2zx1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:54 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)) 16:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:54 INFO - Running setup.py (path:/tmp/pip-IV53pQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:54 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)) 16:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:54 INFO - Running setup.py (path:/tmp/pip-hNsihs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:54 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)) 16:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:54 INFO - Running setup.py (path:/tmp/pip-5wOPmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:54 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)) 16:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:54 INFO - Running setup.py (path:/tmp/pip-TGySdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:54 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)) 16:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:54 INFO - Running setup.py (path:/tmp/pip-ziBJoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:54 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)) 16:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:54 INFO - Running setup.py (path:/tmp/pip-ZaYKXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:55 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)) 16:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:55 INFO - Running setup.py (path:/tmp/pip-IVGj1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:55 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)) 16:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:55 INFO - Running setup.py (path:/tmp/pip-wcEcPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:55 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)) 16:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:55 INFO - Running setup.py (path:/tmp/pip-OFSrMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:55 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)) 16:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:55 INFO - Running setup.py (path:/tmp/pip-V2AdMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:55 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)) 16:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:55 INFO - Running setup.py (path:/tmp/pip-SOCW3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:55 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)) 16:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:55 INFO - Running setup.py (path:/tmp/pip-OgZs6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:55 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)) 16:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:55 INFO - Running setup.py (path:/tmp/pip-SB06Nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:55 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)) 16:32:55 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)) 16:32:55 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)) 16:32:55 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)) 16:32:55 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)) 16:32:55 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)) 16:32:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:32:57 INFO - Downloading blessings-1.6.tar.gz 16:32:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:32:57 INFO - Installing collected packages: blessings 16:32:57 INFO - Running setup.py install for blessings 16:32:57 INFO - Successfully installed blessings 16:32:57 INFO - Cleaning up... 16:32:57 INFO - Return code: 0 16:32:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:32:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:57 INFO - Reading from file tmpfile_stdout 16:32:57 INFO - Current package versions: 16:32:57 INFO - argparse == 1.2.1 16:32:57 INFO - blessings == 1.6 16:32:57 INFO - blobuploader == 1.2.4 16:32:57 INFO - docopt == 0.6.1 16:32:57 INFO - functools32 == 3.2.3-2 16:32:57 INFO - jsonschema == 2.5.1 16:32:57 INFO - manifestparser == 1.1 16:32:57 INFO - mozInstall == 1.12 16:32:57 INFO - mozcrash == 1.0 16:32:57 INFO - mozdebug == 0.1 16:32:57 INFO - mozdevice == 0.49 16:32:57 INFO - mozfile == 1.2 16:32:57 INFO - mozhttpd == 0.7 16:32:57 INFO - mozinfo == 0.9 16:32:57 INFO - mozleak == 0.1 16:32:57 INFO - mozlog == 3.4 16:32:57 INFO - moznetwork == 0.27 16:32:57 INFO - mozprocess == 0.24 16:32:57 INFO - mozprofile == 0.28 16:32:57 INFO - mozrunner == 6.13 16:32:57 INFO - mozscreenshot == 0.1 16:32:57 INFO - mozsystemmonitor == 0.3 16:32:57 INFO - moztest == 0.8 16:32:57 INFO - mozversion == 1.4 16:32:57 INFO - psutil == 3.1.1 16:32:57 INFO - requests == 1.2.3 16:32:57 INFO - wsgiref == 0.1.2 16:32:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32: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')]} 16:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:58 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 0x16791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19eb980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e8d00>, '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 0x19e9a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9eb0>, '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': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:32:58 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 16:32:58 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 16:32:58 INFO - Using env: {'DISPLAY': ':0', 16:32:58 INFO - 'HOME': '/home/cltbld', 16:32:58 INFO - 'LANG': 'en_US.UTF-8', 16:32:58 INFO - 'LANGUAGE': 'en_US:en', 16:32:58 INFO - 'LOGNAME': 'cltbld', 16:32:58 INFO - 'MAIL': '/var/mail/cltbld', 16:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:58 INFO - 'MOZ_NO_REMOTE': '1', 16:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:58 INFO - 'NO_EM_RESTART': '1', 16:32:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:58 INFO - 'PWD': '/builds/slave/test', 16:32:58 INFO - 'SHELL': '/bin/bash', 16:32:58 INFO - 'SHLVL': '1', 16:32:58 INFO - 'TERM': 'linux', 16:32:58 INFO - 'TMOUT': '86400', 16:32:58 INFO - 'USER': 'cltbld', 16:32:58 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 16:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:58 INFO - '_': '/tools/buildbot/bin/python'} 16:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:58 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)) 16:32:58 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)) 16:32:58 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)) 16:32:58 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)) 16:32:58 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)) 16:32:58 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)) 16:32:58 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)) 16:32:58 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)) 16:32:58 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)) 16:32:58 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)) 16:32:58 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)) 16:32:58 INFO - Cleaning up... 16:32:58 INFO - Return code: 0 16:32:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:32:58 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 0x16791f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1846a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19eb980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19e8d00>, '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 0x19e9a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9eb0>, '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': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:32:58 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 16:32:58 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 16:32:58 INFO - Using env: {'DISPLAY': ':0', 16:32:58 INFO - 'HOME': '/home/cltbld', 16:32:58 INFO - 'LANG': 'en_US.UTF-8', 16:32:58 INFO - 'LANGUAGE': 'en_US:en', 16:32:58 INFO - 'LOGNAME': 'cltbld', 16:32:58 INFO - 'MAIL': '/var/mail/cltbld', 16:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:58 INFO - 'MOZ_NO_REMOTE': '1', 16:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:58 INFO - 'NO_EM_RESTART': '1', 16:32:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:58 INFO - 'PWD': '/builds/slave/test', 16:32:58 INFO - 'SHELL': '/bin/bash', 16:32:58 INFO - 'SHLVL': '1', 16:32:58 INFO - 'TERM': 'linux', 16:32:58 INFO - 'TMOUT': '86400', 16:32:58 INFO - 'USER': 'cltbld', 16:32:58 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 16:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:58 INFO - '_': '/tools/buildbot/bin/python'} 16:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:32:58 INFO - Cleaning up... 16:32:58 INFO - Return code: 0 16:32:58 INFO - Running post-action listener: _resource_record_post_action 16:32:58 INFO - Running post-action listener: _start_resource_monitoring 16:32:58 INFO - Starting resource monitoring. 16:32:58 INFO - [mozharness: 2017-03-01 00:32:58.504833Z] Finished create-virtualenv step (success) 16:32:58 INFO - [mozharness: 2017-03-01 00:32:58.505312Z] Running install step. 16:32:58 INFO - Running pre-action listener: _resource_record_pre_action 16:32:58 INFO - Running main action method: install 16:32:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:58 INFO - Reading from file tmpfile_stdout 16:32:58 INFO - Detecting whether we're running mozinstall >=1.0... 16:32:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:32:58 INFO - Reading from file tmpfile_stdout 16:32:58 INFO - Output received: 16:32:58 INFO - Usage: mozinstall [options] installer 16:32:58 INFO - Options: 16:32:58 INFO - -h, --help show this help message and exit 16:32:58 INFO - -d DEST, --destination=DEST 16:32:58 INFO - Directory to install application into. [default: 16:32:58 INFO - "/builds/slave/test"] 16:32:58 INFO - --app=APP Application being installed. [default: firefox] 16:32:58 INFO - mkdir: /builds/slave/test/build/application 16:32:58 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'] 16:32:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:33:15 INFO - Reading from file tmpfile_stdout 16:33:15 INFO - Output received: 16:33:15 INFO - /builds/slave/test/build/application/firefox/firefox 16:33:15 INFO - Running post-action listener: _resource_record_post_action 16:33:15 INFO - [mozharness: 2017-03-01 00:33:15.275701Z] Finished install step (success) 16:33:15 INFO - [mozharness: 2017-03-01 00:33:15.275851Z] Running run-tests step. 16:33:15 INFO - Running pre-action listener: _resource_record_pre_action 16:33:15 INFO - Running main action method: run_tests 16:33:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:33:15 INFO - Python 2.7.3 16:33:15 INFO - Return code: 0 16:33:15 INFO - grabbing minidump binary from tooltool 16:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:33:15 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 0x19e8d00>, '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 0x19e9a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19e9eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:33:15 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 16:33:15 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 16:33:15 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 16:33:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:33:15 INFO - Return code: 0 16:33:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:33:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:33:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:33:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:33:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:33:15 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/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 16:33:15 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/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 16:33:15 INFO - Using env: {'DISPLAY': ':0', 16:33:15 INFO - 'HOME': '/home/cltbld', 16:33:15 INFO - 'LANG': 'en_US.UTF-8', 16:33:15 INFO - 'LANGUAGE': 'en_US:en', 16:33:15 INFO - 'LOGNAME': 'cltbld', 16:33:15 INFO - 'MAIL': '/var/mail/cltbld', 16:33:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:33:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:15 INFO - 'MOZ_NO_REMOTE': '1', 16:33:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:15 INFO - 'NO_EM_RESTART': '1', 16:33:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:15 INFO - 'PWD': '/builds/slave/test', 16:33:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:33:15 INFO - 'SHELL': '/bin/bash', 16:33:15 INFO - 'SHLVL': '1', 16:33:15 INFO - 'TERM': 'linux', 16:33:15 INFO - 'TMOUT': '86400', 16:33:15 INFO - 'USER': 'cltbld', 16:33:15 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976', 16:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:15 INFO - '_': '/tools/buildbot/bin/python'} 16:33:15 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/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 16:33:15 INFO - mozversion application_buildid: 20170228180114 16:33:15 INFO - mozversion application_changeset: fc9372a2c3fb327567c00ef86ab6f051f8d17482 16:33:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:33:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:33:15 INFO - mozversion application_name: Firefox 16:33:15 INFO - mozversion application_remotingname: firefox-dev 16:33:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:33:15 INFO - mozversion application_vendor: Mozilla 16:33:15 INFO - mozversion application_version: 53.0a2 16:33:15 INFO - mozversion platform_buildid: 20170228180114 16:33:15 INFO - mozversion platform_changeset: fc9372a2c3fb327567c00ef86ab6f051f8d17482 16:33:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:33:15 INFO - mozversion platform_version: 53.0a2 16:33:15 INFO - using testdate: 1488328395 16:33:15 INFO - actual date: 1488328395 16:33:15 INFO - starting webserver on 'localhost:36202' 16:33:15 INFO - SUITE-START | Running 2 tests 16:33:15 INFO - TEST-START | dromaeo_css 16:33:15 INFO - operating with platform_type : linux_ 16:33:15 INFO - Initialising browser for dromaeo_css test... 16:33:15 INFO - TEST-INFO | started process 5624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5UXbUk/profile http://localhost:36202/getInfo.html) 16:33:19 INFO - PROCESS | 5624 | __metrics Screen width/height:1600/1200 16:33:19 INFO - PROCESS | 5624 | colorDepth:24 16:33:19 INFO - PROCESS | 5624 | Browser inner width/height: 1024/697 16:33:19 INFO - PROCESS | 5624 | __metrics 16:33:20 INFO - PROCESS | 5624 | 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" 16:33:20 INFO - PROCESS | 5624 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:33:21 INFO - PROCESS | 5624 | console.error: PushService: 16:33:21 INFO - PROCESS | 5624 | stateChangeProcessEnqueue: Error transitioning state 16:33:21 INFO - PROCESS | 5624 | UnknownError 16:33:22 INFO - TEST-INFO | 5624: exit 0 16:33:22 INFO - Browser initialized. 16:33:22 INFO - Running cycle 1/1 for dromaeo_css test... 16:33:22 INFO - TEST-INFO | started process 5717 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5UXbUk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:33:33 INFO - PROCESS | 5717 | RSS: Main: 138293248 16:33:33 INFO - PROCESS | 5717 | 16:36:34 INFO - PROCESS | 5717 | Cycle 1(1): loaded http://localhost:36202/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36202/tests/dromaeo/cssquery-ext.html) 16:36:35 INFO - PROCESS | 5717 | RSS: Main: 245002240 16:36:35 INFO - PROCESS | 5717 | 16:38:23 INFO - PROCESS | 5717 | ************************* 16:38:23 INFO - PROCESS | 5717 | A coding exception was thrown and uncaught in a Task. 16:38:23 INFO - PROCESS | 5717 | 16:38:23 ERROR - PROCESS | 5717 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:38:24 INFO - PROCESS | 5717 | Full stack: 16:38:24 INFO - PROCESS | 5717 | ************************* 16:39:37 INFO - PROCESS | 5717 | Cycle 1(1): loaded http://localhost:36202/tests/dromaeo/cssquery-ext.html (next: http://localhost:36202/tests/dromaeo/cssquery-jquery.html) 16:39:38 INFO - PROCESS | 5717 | RSS: Main: 229642240 16:39:38 INFO - PROCESS | 5717 | 16:42:40 INFO - PROCESS | 5717 | Cycle 1(1): loaded http://localhost:36202/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36202/tests/dromaeo/cssquery-mootools.html) 16:42:40 INFO - PROCESS | 5717 | RSS: Main: 174039040 16:42:40 INFO - PROCESS | 5717 | 16:45:42 INFO - PROCESS | 5717 | Cycle 1(1): loaded http://localhost:36202/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36202/tests/dromaeo/cssquery-prototype.html) 16:45:43 INFO - PROCESS | 5717 | RSS: Main: 213397504 16:45:43 INFO - PROCESS | 5717 | 16:48:46 INFO - PROCESS | 5717 | Cycle 1(1): loaded http://localhost:36202/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36202/tests/dromaeo/cssquery-yui.html) 16:48:46 INFO - PROCESS | 5717 | RSS: Main: 172113920 16:48:46 INFO - PROCESS | 5717 | 16:51:48 INFO - PROCESS | 5717 | Cycle 1(1): loaded http://localhost:36202/tests/dromaeo/cssquery-yui.html (next: http://localhost:36202/tests/dromaeo/cssquery-dojo.html) 16:51:49 INFO - PROCESS | 5717 | RSS: Main: 263303168 16:51:49 INFO - PROCESS | 5717 | 16:51:49 INFO - PROCESS | 5717 | __start_tp_report 16:51:49 INFO - PROCESS | 5717 | _x_x_mozilla_page_load 16:51:49 INFO - PROCESS | 5717 | _x_x_mozilla_page_load_details 16:51:49 INFO - PROCESS | 5717 | |i|pagename|runs| 16:51:49 INFO - PROCESS | 5717 | |0;dojo.html;3290.6051273847143;3317.3862835375444;3324.5345651608777;3340.131565792893;3376.932461350773;5348.786048558058;5465.289512363387;5467.6172667913215;5468.535174510166;5471.616986810925;5381.865453363668;5398.082326004579;5399.460053994599;5411.945880541193;5442.6462279951875;4828.299896515012;4838.516148385169;4878.975605121987;4888.413390393158;4893.04585605807;4816.83141090062;4863.489333619955;4908.067467181242;4924.80300787968;4951.158303088484;4771.045790841828;4850.466448690659;4869.220924652056;4894.583960363356;4983.626228032894;4944.678595891273;4975.825846095406;4976.328195693572;4979.751012449363;5008.899822003539;4808.61531077513;4881;4895.485973972753;4940.036692844897;4962.87592810179;5329.25390445338;5364.517193452569;5428.701421421821;5441.483059109379;5508.504234618904;5843.065109582489;5900.763969441217;5906.409359064102;5907.261592300963;5910.497607703351;5955.7915472958675;5972.193753843262;5986.910196347058;5988.341282458926;5989.700514974277;5427.131658934591;5449.972750136224;5502.8349149525175;5530.976769297693;5597.99236137491;6071.241094863142;6075.635461872302;6077.301110372276;6081.452669259699;6105.572609917263;5789.623674461147;5842.795502157404;5845.357010728816;5847.239858818326;5853.678047707417;5765.164051212634;5766.567507436959;5787.855303617359;5797.449242321973;5953.493953014043;5843.941560584425;5850.3564607893095;5863.384344643836;5883.911741323884;5891.911621325684;5850.912236316459;5857.062869940789;5860.970695146497;5861.35525092248;5862.589618726648;4481.596656300949;4494.617957473652;4497.460304763449;4520.367148599199;4535.523770004168;4007.3788562772816;4038.8384464621085;4056.9391459128137;4069.918601627951;4071.5114186297833;5670.319561652545;5673.744681489343;5679.2333035040565;5679.630823996427;5681.545476361881;5631.211630371751;5661.7735290588735;5826.941730582725;5850.3272123705465;5911.290645122613;5658.349289831722;5669.291338582677;5681.744321505542;5686.317641883001;5711.371749107595;5046.419661738873;5054.418741844662;5054.82308119214;5055.090083784954;5086.669366491166;5955.40445955401;5999.5800293979;6030.276366836008;6055.212822333068;6059.6364218147055;5855.414458554281;5928.258967629046;5928.644281343133;5943.1679564861815;5976.581639285208;6144.262688477233;6159.19930409044;6169.043798211284;6169.043798211284;6171.753129874754;5549.889002219852;5569.665820050648;5785.132230165509;5845.824625261249;5846;5762.222100016612;5778.624389414675;5812.21535092757;5887.911681324698;5920.940790592039;5730.627509211888;5732.197492350991;5732.369439361751;5734.856628584319;5735.655860648374;5681.034224181816;5741.3971532988435;5748.252727145445;5753.280839895013;5756.68338241384;5644.717764111861;5649.096144616841;5697.54419646419;5700.25896633435;5796.739146738322;5733.799317023884;5784.797532086357;5785.392533783892;5793.217915581343;5795.507381872588;5664.838708064919;5668.914966275592;5671.858203544944;5677.630953987978;5680.602357834912 16:51:49 INFO - PROCESS | 5717 | |1;ext.html;576.1473019930503;614.0819474885046;625.8998560230364;632.6646877155107;660.2044536333718;36749.26501469969;46975;48518;48527.51472485279;53599.73200134004;50461;51041.74479127599;51104.488955110435;51109.488905110935;51112.74443627786;8543.017552981424;9315.021922698137;9503.904960950405;9506.096920792514;9512.524373781318;8662.13378662135;11023.283486573388;11309.208355415125;11339.943300283487;11778.352190629512;11499.19505634606;11527.135464840128;11551.595694150707;11567.710807229803;11571.710707232345;11279.210455268134;11315.547378104866;11331.603393881256;11353.716157096056;11354.489047992818;11246.156538259664;11261.887381126166;11310.660680179608;11325.943370283178;11333.659990200307;46604.300935486;46874.296885546406;46894;46957;47034.294485582745;4306.870793876189;4438.778061096932;4449.132419178261;4450.821967121311;4656.138614356355;31994.20014499656;32217.51673724896;32578.6742132578;32611.83694081538;33451.665483345096;4623.214053610861;4642.234031384817;4726.1020406122725;4735.1713450146435;4811.206150985084;388394;390168.04915975523;392221;393858;394206;62557.68721156456;63091.684541577;63134.68432657807;63357.36642633607;63597.36402636007;64963.35036649668;65122.67438662776;65309.346906531275;65435.67282163654;65535.67232163904;19373.418797435817;19574.21703131859;19612;19623.90188049079;19671.803281967284;13987.860121398859;14379.137251764927;14682.779758303634;14740.41038358475;14842.480513181987;18966;19767;19801.603967920848;19838.305659301855;19874;7110.3600675939415;7208.56748595086;7357.558546487228;7397.556146631219;7495.437842161859;997.0876647867266;1005.6128390569537;1006.6979906028308;1014.1227837920146;1020.811149937264;35916;35970.8201458991;36035.639643603754;36339.27321453556;36421;1193.2721040165493;1195.1039610868459;1212.9454174562165;1233.543588872123;1311.888489478386;17766.911165444348;18732.0227728075;18872.339468118826;18902.054897255082;18912.43262702121;542361;544603;546757;547820;550282;49551.752241238566;49572.25641615379;49617.25574116391;49798.502014979385;49894.501054988985;1508.4192585854305;1547.1877264436262;1554.3083327919194;1559.3918371834993;1576.4561226376882;33057.66942330546;34929.825350874096;34979.65020349764;35073.29853402867;35201;62156;62668.373316266254;62822;62925.37074629195;63088.36911630825;415172;415588;415830;416873;417000;28587;31135.688643114187;32273;32475.18812029718;33003.66996330006;53683;54424.183637246264;54486;55145;55872;44309;46191.538084618725;46752.532474674816;46918;47106.76446617745;44118;45102.32346514871;45725.77137114293;45821.31268031049;46340.30489542727;41424.792876035426;43074.13851723011;46052.07895842131;46123.30815037844;46564.06871862476;36584;38770.61229387783;39323.213535729694;39919.40120898247;39961.2007759849;28630.28424289326;36472.81763591165;38207.808960955015;39960.600393995686;40613.97388617609 16:51:49 INFO - PROCESS | 5717 | |2;jquery.html;448.40362318116905;451.76056689954316;452.26958462083724;457.8878174847162;473.44843257604913;20481.59036819263;22228;22255.888720556413;22881.08475660976;23258.4185395365;22230.11079556816;22538.774612253874;22659.093636254573;23629;24292.51414971704;6827.351401616838;7101.254368291333;7546.320831125197;7810.101838288612;7882;6585.440237579787;7920.881186782203;7987.680492780281;8044;8052.718154864581;7952.920470795276;7953.522788632672;7959.204079592024;7960.044794624653;7966.004249468817;7835.138134805167;7968.561729104897;7984.321332686729;8037.397195210324;8042.879356809653;7381.409487241008;7702.807429814244;7717.65270562826;7890.960545197295;7895.7236496722335;30092.8495357524;30208;30571.23571910698;30910.22724431885;30955.845220773976;3491.9301613967577;3609.187932715144;3645.9817700911326;3709.0356507308024;3720.3489389356755;17155.57111072221;17640.647187056187;17899;18004.729929051075;18279.360222392286;2225.187806450634;2280.441291883483;2287.656851472276;2360.5632957902844;2536.480021595587;120001;123483;123969;124705;125516;20858.37424877256;21228.78771212299;21270.787292127192;21818.454538636342;22150.446238844157;41755;42105.78947105306;42395;42532.57467425348;42567;9182.586783594754;9401.811963760687;9677.516124193762;9821.803563928825;9929.404235745878;9451.810963780823;9514;9560.808783824285;9730.562124704406;9730.902690973142;5382.569394448435;5467.6719396836315;5530.308711411074;5537;5632.183333416631;2118.142152428269;2170.2295685031904;2200.526886719363;2215.612267853119;2272.8068114210146;949.0888746803008;959.932804703678;963.349738926236;972.3533849989819;976.5410257179115;18561.90719046423;21469.355919322446;21629.24297649575;21790.673139902916;21914.23300184486;973.5570315506427;981.249344251648;981.2983716642635;990.7467054176473;999.4203362049993;11332.036776873892;11650.94174529139;12474.43865026076;12530.561430349893;12750.553730619384;723391;740608;743741;758439;760871;111946;112608;115596;116425.4178729101;119058;1175.0716933622514;1186.306010983567;1198.6823491774687;1205.0239306162036;1211.8969887559656;19213.61572768509;19550.120244588743;19628.901855490632;19628.901855491204;19797.40607781769;47411.76294118507;47806;47891.76054119707;47980.760096199294;48188.518114818406;62866.37133628605;64921.67539162274;64984;65886.67056664878;66091;7640.617969101634;8003.279704826594;8185.959070204611;8340.374471914509;8679.696210632597;12538.87461125377;14560.708785824436;14701;14714;15307.77038344448;12460.813087803872;12552.748945020865;12708.173968692005;12741.936290318488;12775.23348599087;11969.820452693042;12617.179883307555;12689.8096528554;12832.615021549369;13159.53941612039;12349.876501234872;12389.75220495603;12612.180208286432;12624.810627840407;12993.48026078984;8339.666413343399;8409.495430274203;8464.153584641486;8472.279856212292;8482.194191551793;11707.648770536898;11890.702732431759;11982.760344793229;12066.75866482683;12299.69250768738 16:51:49 INFO - PROCESS | 5717 | |3;mootools.html;1371.101928237004;1493.8207415110182;1518.559617710864;1520.3462511120215;1530.2195880101144;7390.704371825127;7924.207579242073;8195.18048195181;8197.385196110301;8410.158984101587;8220.712275070373;8298.543580103093;8305.294050005741;8308.91691083089;8317.168283171679;2117.7035215069905;2187.529681118559;2345.577795996724;2381.0475809676095;2385.8449200801892;2346.21401830387;2411.445367565461;2414.5774489464275;2430.6840110785574;2432.9391765205924;2293.7247530296386;2304.7925686688195;2305.9192928247517;2321.7097862767155;2321.7330007049154;2334.533093381322;2348.835581509295;2349.48311371498;2352.8117750579913;2356.187115445186;2203.2178576605393;2253.9549209015727;2255.7180352455944;2257.4694946687514;2257.7290725112925;8291.917080829175;8368.246857782768;8368.665253389858;8369.58152092393;8392.790180245482;5124.666896651705;5256.658317209369;5260.289860868772;5260.973695131538;5268.710220937847;3338.2488939988552;3421.623621401644;3424.434968230239;3460.740444466675;3465.3069386122875;1432.563068264179;1433.2332202271734;1469.8236211654669;1493.0892155784964;1499.4163948163898;11054.723631909186;11062.944685276603;11077.667669969915;11080.501377438035;11081.612143574936;4559.589636932692;4609.078184363141;4612;4674.462436819741;4715.669903106818;9079.45523268606;9217.815643687089;9230.953845230732;9232.815343693223;9237.353385262966;5260.9736951315;5264.552513036435;5269.104252277122;5270.736463176902;5276.736163191825;4659;4679.321498382784;4720.551547602972;4931.334269873593;4940.382452193476;3870.4581358609817;3954.9209015819524;3988.80055997199;4008.899777505586;4130.297849365615;1215.0583297944163;1222.8899399054128;1228.3796682675193;1237.6905773556612;1243.8942689871462;1020.1074060197327;1030.5465595138114;1042.3485321673954;1043.6347278452633;1050.7845891592206;5682.289713785777;5799.652020878761;5853.03424934881;5861.912071318934;6241.875162496724;648.6497291462651;655.894817232964;658.2265837640753;1034.8913364096811;1102.5148934468807;3979.6020397959974;4034.8184331705143;4089.0595163112653;4091.652209562161;4134.1731653668785;9672.371295865747;9961;9968.152707019839;9974;9977.25170612207;9607.231421486264;9687.806243875082;9843.163331116792;9875.851862222073;9905.059019393146;7784.3772498200005;7958.482698624686;7960.40296977729;7961.36309095271;7962.044554653363;5745.712714364348;5802.7098645066735;5841.269841269841;5857.648541087378;5918.201042859159;9169.77075573116;9179.816403671755;9210;9215.216706580015;9246.306527010636;8523.616437260214;9013;9475.099865512766;9479.099485548863;9484.905150948402;6717.093192418961;6930.757423490154;7028.50800443964;7075.787726368218;7219.639018049182;7859.724909628136;7971.44199906001;8075.788631705056;8123.106458289702;8171.83656326882;7293.234210407831;7353.926460735538;7356.154042285206;7400.851982960203;7455.254474552501;7213.891791623025;7238.6380680966795;7247.383972362198;7285;7287.708491660274;6666.733330666913;6667.599944003376;6689.698963546554;6728.697208625722;6764.323567643196;5046.9747651261505;5116.872078198075;5305.681659100466;5390.811321603725;5436.673799572039;5143.8456846294675;5168.9483105168465;5178.533931946143;5189.886068358955;5300.522952934254 16:51:49 INFO - PROCESS | 5717 | |4;prototype.html;424.27025516112275;425.20274485339985;426.846335319285;439.09108146137487;439.17873576412114;5131.948680513194;5292.36491621006;5319.601029922756;5395.298611180546;5404.378496472907;5223.791048358071;5234.973825130878;5289.285946397235;5292.338457692788;5305.8938821223555;4245.789949864282;4274.829006839723;4282.97858510707;4300.741955482681;4309.827606895736;3970.8610198643055;4093.5906409358977;4265.125649241898;4288.356746488021;4289.206496798087;4217.734679596124;4234.259004674185;4256.638185754215;4258.509521667407;4272.295071313245;4239.703220774547;4246.44796176495;4251.128518653669;4255.510616279105;4257.318359248111;3516.261585067139;3874.496315478998;3878.2825177342;3891.9297193271796;3906.4921560196995;5167.147420675584;5210.905709800946;5214.8174813881715;5218.008578370135;5241.86895327616;4828.251620998751;4842.636802239811;4851.393575803025;4852.539008794159;4868.075065737534;5428.185772134172;5579.581531385122;5581.7209139543265;5582.692951887645;5596.524295434893;4033.4151548025666;4039.717219794586;4042.2117687051036;4059.2490389278078;4081.7346872453195;5722.141678748179;5753.280839895013;5762.222100016486;5765.827025189251;5786.305643322744;4126.979365103155;4225.936610950838;4230.428892099589;4256.3828244904935;4262.46719160105;4261.890364269706;4281.914361712748;4291.442112525352;4293.677974151951;4318.719283246642;4801.51984801524;4806.519348065235;4809;4843.104025755247;4849;5517.668939863621;5558.03682199393;5627.352854421712;5634.746436410372;5655.236543066716;1355.0243824446384;1363.2979015806868;1389.7359501694646;1391.8656295119445;1392.470861072786;972.1590823937385;990.405756546081;994.3188915592842;998.55065220651;1011;5280.808464487195;5308.177232528887;5314.97342513285;5317.707526086102;5326.92009619856;5554.555635549146;5557.472040156179;5561.221428999943;5562.3047119110115;5581.320965936292;5190.506901844395;5305.31030965972;5345.545628621533;5353.411124776271;5516.172574113834;2935.6770755216908;2947.9976807885423;2961.555766635022;2962.5408061750463;2963.977427787453;5799.39106393831;5801.448862358069;5807.602552506831;5828.358880523139;5838.2702162229725;5540.667559946416;5619.887602247933;5651.265335506358;5682.829515114553;5687.630304030225;5694.487496125285;5718.483132873336;5760.8271751847515;5763.538916886639;5793.94206057934;5288.3918349390315;5493.116114040161;5537.916931246115;5581.246531718166;5606.18710286998;5507.796881247533;5515.951969125853;5550.530014143667;5586.469285417878;5600.383957764561;5857.94142058591;5859.92354014146;5867.237259156454;5876.382979787232;5887.234659494238;3950.3481925483125;4065.6747460203705;4067.288224560631;4083.775392353449;4173.353130264813;5560.277163968658;5620.747066382104;5634.549236061023;5638.746256418389;5666.405027472221;5361.973190134025;5547.805826796042;5606.467385598362;5611.3266408031295;5625.537360286273;5582.409013431153;5586.469285418041;5601.467860553241;5607.682194684327;5608.6073974821375;5314.388845282688;5581.553475721851;5583.720813959367;5599.636023658449;5635.718214089361;5611.074172761612;5642.576806739429;5646.153077038312;5647.870425914752;5660.009498337857;5408.347732289385;5553.278073850373;5567.109262517978;5576.525995290283;5590.133529302964 16:51:49 INFO - PROCESS | 5717 | |5;yui.html;823.3166471828383;834.937379696523;857.1942374168282;911.3620465674028;935.5228833295022;16628.251728672207;17377;17638.735418968692;17931.551711207227;18059.277628894844;15679.137647429387;15704.685906281897;16567.254473548688;16712.08083555404;16725.665486690257;716.9318914703094;837.3803385494751;857.4683696108391;861.4013260783757;862.2196911794836;735.6505659811601;821.3716506872247;845.0619812008665;854.6453221912899;855.1747563601124;880.0935036911991;881.6914080071988;881.7266647339313;882.355880207449;882.7042940614901;737.4911311195258;880.7665968518315;880.9735707928772;881.678187461572;881.9901213110984;557.6570409198314;629.2197674883158;643.3470027921663;650.7397041183565;653.2846533046306;16395.672086558323;16457.753133703005;16656;16716.24776885043;16772.66454670912;14990.250487475692;15469.690606187925;15662.608434789108;15877.20613969297;16078.5980350491;13128.146670466485;13502.189868607915;13726.087151819416;13808.309584520834;13836.723265534632;4568.931466028012;4605.171069207541;4614.8154073837;4668.509806470306;4678.064387122555;79956.60021699854;81141;81180.59409702972;81447.59276203641;81865;11914.940425297991;11949.88050119505;12085.335306558223;12158.817617735742;12226.021918246519;23633.172838950555;23770.524589508113;23924.162654307016;23932.52134957291;23938.162164324163;8958.68644597436;9067.138621830916;9083.955345135262;9258.259339252843;9323.487208203478;4635.188841952645;4680.789364478606;4702;4710.882227944328;4853.684510506806;3685.1155722626913;3724.1248306647917;3740.158464345555;3765.792881391495;3784.9243015140096;641.6503005861723;645.270843946347;648.4650163615037;653.3564439027554;654.3750718064238;708.3553965891015;710.7476845719696;713.1869668577825;719.129852878013;727.4107972542258;9984.650537231308;10355.119814815675;10757.731056723644;10787.54368160304;10979.121670266359;720.7729565187054;726.1975517053685;739.098300073909;739.6043116932416;741.3698356397127;4743.857684269477;4962.6774259673;5030.2957585938;5050.646454748133;5070.949290507047;82565;82811.5859420699;83592;85226;85248;71332.64333678299;73090.63454682799;74488;75143;76335.61832190804;65317.67341163264;66492;67065;67131;68972.65513672399;9654.613815447303;9819.85270220933;9968.352057116264;10004.649837255953;10042.648507302209;44581;44603.10793784171;45256.094878102915;45497.772511137235;45781.54218457773;54580.454195459126;56687.43312566821;56916.71541642431;57107.14339284997;57217.713911430175;11590.13074019435;11670.241434306743;11776.470058847544;11920.105992050458;12017.579384721494;13642.658933526343;13760.724785504033;13774.586762397144;13795.931020345235;13891.444342226601;12274.81587776202;12613.621591352274;12908.935455322664;12995.805062924253;13418.329083545588;11597.304161750322;11703.23928944616;11780.941095294469;12063.698407539881;12132.090093242865;12518.123731339083;12834.743305133657;12854.614361569167;12943.288119153536;13059.804102938273;10853.511591978222;10889.183311251847;10975.341479511255;11091.168162388014;11307.717307067389;10272.691819245136;10288.074073333435;10316.896831031594;10330.535125919201;10409 16:51:49 INFO - PROCESS | 5717 | __end_tp_report 16:51:49 INFO - PROCESS | 5717 | __start_cc_report 16:51:49 INFO - PROCESS | 5717 | _x_x_mozilla_cycle_collect,966 16:51:49 INFO - PROCESS | 5717 | __end_cc_report 16:51:49 INFO - PROCESS | 5717 | __startTimestamp1488329509042__endTimestamp 16:51:49 INFO - PROCESS | 5717 | 16:51:49 INFO - PROCESS | 5717 | ------- Summary: start ------- 16:51:49 INFO - PROCESS | 5717 | Number of tests: 6 16:51:49 INFO - PROCESS | 5717 | 16:51:49 INFO - PROCESS | 5717 | [#0] dojo.html Cycles:165 Average:5453.38 Median:5681.03 stddev:616.35 (10.8%) stddev-sans-first:594.42 16:51:49 INFO - PROCESS | 5717 | Values: 3290.6 3317.4 3324.5 3340.1 3376.9 5348.8 5465.3 5467.6 5468.5 5471.6 5381.9 5398.1 5399.5 5411.9 5442.6 4828.3 4838.5 4879.0 4888.4 4893.0 4816.8 4863.5 4908.1 4924.8 4951.2 4771.0 4850.5 4869.2 4894.6 4983.6 4944.7 4975.8 4976.3 4979.8 5008.9 4808.6 4881.0 4895.5 4940.0 4962.9 5329.3 5364.5 5428.7 5441.5 5508.5 5843.1 5900.8 5906.4 5907.3 5910.5 5955.8 5972.2 5986.9 5988.3 5989.7 5427.1 5450.0 5502.8 5531.0 5598.0 6071.2 6075.6 6077.3 6081.5 6105.6 5789.6 5842.8 5845.4 5847.2 5853.7 5765.2 5766.6 5787.9 5797.4 5953.5 5843.9 5850.4 5863.4 5883.9 5891.9 5850.9 5857.1 5861.0 5861.4 5862.6 4481.6 4494.6 4497.5 4520.4 4535.5 4007.4 4038.8 4056.9 4069.9 4071.5 5670.3 5673.7 5679.2 5679.6 5681.5 5631.2 5661.8 5826.9 5850.3 5911.3 5658.3 5669.3 5681.7 5686.3 5711.4 5046.4 5054.4 5054.8 5055.1 5086.7 5955.4 5999.6 6030.3 6055.2 6059.6 5855.4 5928.3 5928.6 5943.2 5976.6 6144.3 6159.2 6169.0 6169.0 6171.8 5549.9 5569.7 5785.1 5845.8 5846.0 5762.2 5778.6 5812.2 5887.9 5920.9 5730.6 5732.2 5732.4 5734.9 5735.7 5681.0 5741.4 5748.3 5753.3 5756.7 5644.7 5649.1 5697.5 5700.3 5796.7 5733.8 5784.8 5785.4 5793.2 5795.5 5664.8 5668.9 5671.9 5677.6 5680.6 16:51:49 INFO - PROCESS | 5717 | 16:51:49 INFO - PROCESS | 5717 | [#1] ext.html Cycles:180 Average:63580.70 Median:415380.00 stddev:120515.32 (29.0%) stddev-sans-first:120760.55 16:51:49 INFO - PROCESS | 5717 | Values: 576.1 614.1 625.9 632.7 660.2 36749.3 46975.0 48518.0 48527.5 53599.7 50461.0 51041.7 51104.5 51109.5 51112.7 8543.0 9315.0 9503.9 9506.1 9512.5 8662.1 11023.3 11309.2 11339.9 11778.4 11499.2 11527.1 11551.6 11567.7 11571.7 11279.2 11315.5 11331.6 11353.7 11354.5 11246.2 11261.9 11310.7 11325.9 11333.7 46604.3 46874.3 46894.0 46957.0 47034.3 4306.9 4438.8 4449.1 4450.8 4656.1 31994.2 32217.5 32578.7 32611.8 33451.7 4623.2 4642.2 4726.1 4735.2 4811.2 388394.0 390168.0 392221.0 393858.0 394206.0 62557.7 63091.7 63134.7 63357.4 63597.4 64963.4 65122.7 65309.3 65435.7 65535.7 19373.4 19574.2 19612.0 19623.9 19671.8 13987.9 14379.1 14682.8 14740.4 14842.5 18966.0 19767.0 19801.6 19838.3 19874.0 7110.4 7208.6 7357.6 7397.6 7495.4 997.1 1005.6 1006.7 1014.1 1020.8 35916.0 35970.8 36035.6 36339.3 36421.0 1193.3 1195.1 1212.9 1233.5 1311.9 17766.9 18732.0 18872.3 18902.1 18912.4 542361.0 544603.0 546757.0 547820.0 550282.0 49551.8 49572.3 49617.3 49798.5 49894.5 1508.4 1547.2 1554.3 1559.4 1576.5 33057.7 34929.8 34979.7 35073.3 35201.0 62156.0 62668.4 62822.0 62925.4 63088.4 415172.0 415588.0 415830.0 416873.0 417000.0 28587.0 31135.7 32273.0 32475.2 33003.7 53683.0 54424.2 54486.0 55145.0 55872.0 44309.0 46191.5 46752.5 46918.0 47106.8 44118.0 45102.3 45725.8 45821.3 46340.3 41424.8 43074.1 46052.1 46123.3 46564.1 36584.0 38770.6 39323.2 39919.4 39961.2 28630.3 36472.8 38207.8 39960.6 40614.0 16:51:49 INFO - PROCESS | 5717 | 16:51:49 INFO - PROCESS | 5717 | [#2] jquery.html Cycles:180 Average:40643.55 Median:3550.56 stddev:122634.09 (3453.9%) stddev-sans-first:122940.97 16:51:49 INFO - PROCESS | 5717 | Values: 448.4 451.8 452.3 457.9 473.4 20481.6 22228.0 22255.9 22881.1 23258.4 22230.1 22538.8 22659.1 23629.0 24292.5 6827.4 7101.3 7546.3 7810.1 7882.0 6585.4 7920.9 7987.7 8044.0 8052.7 7952.9 7953.5 7959.2 7960.0 7966.0 7835.1 7968.6 7984.3 8037.4 8042.9 7381.4 7702.8 7717.7 7891.0 7895.7 30092.8 30208.0 30571.2 30910.2 30955.8 3491.9 3609.2 3646.0 3709.0 3720.3 17155.6 17640.6 17899.0 18004.7 18279.4 2225.2 2280.4 2287.7 2360.6 2536.5 120001.0 123483.0 123969.0 124705.0 125516.0 20858.4 21228.8 21270.8 21818.5 22150.4 41755.0 42105.8 42395.0 42532.6 42567.0 9182.6 9401.8 9677.5 9821.8 9929.4 9451.8 9514.0 9560.8 9730.6 9730.9 5382.6 5467.7 5530.3 5537.0 5632.2 2118.1 2170.2 2200.5 2215.6 2272.8 949.1 959.9 963.3 972.4 976.5 18561.9 21469.4 21629.2 21790.7 21914.2 973.6 981.2 981.3 990.7 999.4 11332.0 11650.9 12474.4 12530.6 12750.6 723391.0 740608.0 743741.0 758439.0 760871.0 111946.0 112608.0 115596.0 116425.4 119058.0 1175.1 1186.3 1198.7 1205.0 1211.9 19213.6 19550.1 19628.9 19628.9 19797.4 47411.8 47806.0 47891.8 47980.8 48188.5 62866.4 64921.7 64984.0 65886.7 66091.0 7640.6 8003.3 8186.0 8340.4 8679.7 12538.9 14560.7 14701.0 14714.0 15307.8 12460.8 12552.7 12708.2 12741.9 12775.2 11969.8 12617.2 12689.8 12832.6 13159.5 12349.9 12389.8 12612.2 12624.8 12993.5 8339.7 8409.5 8464.2 8472.3 8482.2 11707.6 11890.7 11982.8 12066.8 12299.7 16:51:49 INFO - PROCESS | 5717 | 16:51:49 INFO - PROCESS | 5717 | [#3] mootools.html Cycles:180 Average:5514.96 Median:5269.92 stddev:2937.10 (55.7%) stddev-sans-first:2928.83 16:51:49 INFO - PROCESS | 5717 | Values: 1371.1 1493.8 1518.6 1520.3 1530.2 7390.7 7924.2 8195.2 8197.4 8410.2 8220.7 8298.5 8305.3 8308.9 8317.2 2117.7 2187.5 2345.6 2381.0 2385.8 2346.2 2411.4 2414.6 2430.7 2432.9 2293.7 2304.8 2305.9 2321.7 2321.7 2334.5 2348.8 2349.5 2352.8 2356.2 2203.2 2254.0 2255.7 2257.5 2257.7 8291.9 8368.2 8368.7 8369.6 8392.8 5124.7 5256.7 5260.3 5261.0 5268.7 3338.2 3421.6 3424.4 3460.7 3465.3 1432.6 1433.2 1469.8 1493.1 1499.4 11054.7 11062.9 11077.7 11080.5 11081.6 4559.6 4609.1 4612.0 4674.5 4715.7 9079.5 9217.8 9231.0 9232.8 9237.4 5261.0 5264.6 5269.1 5270.7 5276.7 4659.0 4679.3 4720.6 4931.3 4940.4 3870.5 3954.9 3988.8 4008.9 4130.3 1215.1 1222.9 1228.4 1237.7 1243.9 1020.1 1030.5 1042.3 1043.6 1050.8 5682.3 5799.7 5853.0 5861.9 6241.9 648.6 655.9 658.2 1034.9 1102.5 3979.6 4034.8 4089.1 4091.7 4134.2 9672.4 9961.0 9968.2 9974.0 9977.3 9607.2 9687.8 9843.2 9875.9 9905.1 7784.4 7958.5 7960.4 7961.4 7962.0 5745.7 5802.7 5841.3 5857.6 5918.2 9169.8 9179.8 9210.0 9215.2 9246.3 8523.6 9013.0 9475.1 9479.1 9484.9 6717.1 6930.8 7028.5 7075.8 7219.6 7859.7 7971.4 8075.8 8123.1 8171.8 7293.2 7353.9 7356.2 7400.9 7455.3 7213.9 7238.6 7247.4 7285.0 7287.7 6666.7 6667.6 6689.7 6728.7 6764.3 5047.0 5116.9 5305.7 5390.8 5436.7 5143.8 5168.9 5178.5 5189.9 5300.5 16:51:49 INFO - PROCESS | 5717 | 16:51:49 INFO - PROCESS | 5717 | [#4] prototype.html Cycles:180 Average:4704.54 Median:5318.65 stddev:1345.77 (25.3%) stddev-sans-first:1310.64 16:51:49 INFO - PROCESS | 5717 | Values: 424.3 425.2 426.8 439.1 439.2 5131.9 5292.4 5319.6 5395.3 5404.4 5223.8 5235.0 5289.3 5292.3 5305.9 4245.8 4274.8 4283.0 4300.7 4309.8 3970.9 4093.6 4265.1 4288.4 4289.2 4217.7 4234.3 4256.6 4258.5 4272.3 4239.7 4246.4 4251.1 4255.5 4257.3 3516.3 3874.5 3878.3 3891.9 3906.5 5167.1 5210.9 5214.8 5218.0 5241.9 4828.3 4842.6 4851.4 4852.5 4868.1 5428.2 5579.6 5581.7 5582.7 5596.5 4033.4 4039.7 4042.2 4059.2 4081.7 5722.1 5753.3 5762.2 5765.8 5786.3 4127.0 4225.9 4230.4 4256.4 4262.5 4261.9 4281.9 4291.4 4293.7 4318.7 4801.5 4806.5 4809.0 4843.1 4849.0 5517.7 5558.0 5627.4 5634.7 5655.2 1355.0 1363.3 1389.7 1391.9 1392.5 972.2 990.4 994.3 998.6 1011.0 5280.8 5308.2 5315.0 5317.7 5326.9 5554.6 5557.5 5561.2 5562.3 5581.3 5190.5 5305.3 5345.5 5353.4 5516.2 2935.7 2948.0 2961.6 2962.5 2964.0 5799.4 5801.4 5807.6 5828.4 5838.3 5540.7 5619.9 5651.3 5682.8 5687.6 5694.5 5718.5 5760.8 5763.5 5793.9 5288.4 5493.1 5537.9 5581.2 5606.2 5507.8 5516.0 5550.5 5586.5 5600.4 5857.9 5859.9 5867.2 5876.4 5887.2 3950.3 4065.7 4067.3 4083.8 4173.4 5560.3 5620.7 5634.5 5638.7 5666.4 5362.0 5547.8 5606.5 5611.3 5625.5 5582.4 5586.5 5601.5 5607.7 5608.6 5314.4 5581.6 5583.7 5599.6 5635.7 5611.1 5642.6 5646.2 5647.9 5660.0 5408.3 5553.3 5567.1 5576.5 5590.1 16:51:49 INFO - PROCESS | 5717 | 16:51:49 INFO - PROCESS | 5717 | [#5] yui.html Cycles:180 Average:18398.70 Median:4673.29 stddev:23662.44 (506.3%) stddev-sans-first:23692.02 16:51:49 INFO - PROCESS | 5717 | Values: 823.3 834.9 857.2 911.4 935.5 16628.3 17377.0 17638.7 17931.6 18059.3 15679.1 15704.7 16567.3 16712.1 16725.7 716.9 837.4 857.5 861.4 862.2 735.7 821.4 845.1 854.6 855.2 880.1 881.7 881.7 882.4 882.7 737.5 880.8 881.0 881.7 882.0 557.7 629.2 643.3 650.7 653.3 16395.7 16457.8 16656.0 16716.2 16772.7 14990.3 15469.7 15662.6 15877.2 16078.6 13128.1 13502.2 13726.1 13808.3 13836.7 4568.9 4605.2 4614.8 4668.5 4678.1 79956.6 81141.0 81180.6 81447.6 81865.0 11914.9 11949.9 12085.3 12158.8 12226.0 23633.2 23770.5 23924.2 23932.5 23938.2 8958.7 9067.1 9084.0 9258.3 9323.5 4635.2 4680.8 4702.0 4710.9 4853.7 3685.1 3724.1 3740.2 3765.8 3784.9 641.7 645.3 648.5 653.4 654.4 708.4 710.7 713.2 719.1 727.4 9984.7 10355.1 10757.7 10787.5 10979.1 720.8 726.2 739.1 739.6 741.4 4743.9 4962.7 5030.3 5050.6 5070.9 82565.0 82811.6 83592.0 85226.0 85248.0 71332.6 73090.6 74488.0 75143.0 76335.6 65317.7 66492.0 67065.0 67131.0 68972.7 9654.6 9819.9 9968.4 10004.6 10042.6 44581.0 44603.1 45256.1 45497.8 45781.5 54580.5 56687.4 56916.7 57107.1 57217.7 11590.1 11670.2 11776.5 11920.1 12017.6 13642.7 13760.7 13774.6 13795.9 13891.4 12274.8 12613.6 12908.9 12995.8 13418.3 11597.3 11703.2 11780.9 12063.7 12132.1 12518.1 12834.7 12854.6 12943.3 13059.8 10853.5 10889.2 10975.3 11091.2 11307.7 10272.7 10288.1 10316.9 10330.5 10409.0 16:51:49 INFO - PROCESS | 5717 | -------- Summary: end -------- 16:51:49 INFO - PROCESS | 5717 | 16:51:49 INFO - TEST-INFO | 5717: exit 0 16:51:49 INFO - TEST-OK | dromaeo_css | took 1114291ms 16:51:49 INFO - TEST-START | kraken 16:51:49 INFO - operating with platform_type : linux_ 16:51:49 INFO - Initialising browser for kraken test... 16:51:49 INFO - TEST-INFO | started process 6034 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTv8gqv/profile http://localhost:36202/getInfo.html) 16:51:54 INFO - PROCESS | 6034 | __metrics Screen width/height:1600/1200 16:51:54 INFO - PROCESS | 6034 | colorDepth:24 16:51:54 INFO - PROCESS | 6034 | Browser inner width/height: 1024/697 16:51:54 INFO - PROCESS | 6034 | __metrics 16:51:54 INFO - PROCESS | 6034 | 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" 16:51:54 INFO - PROCESS | 6034 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:51:55 INFO - TEST-INFO | 6034: exit 0 16:51:55 INFO - Browser initialized. 16:51:55 INFO - Running cycle 1/1 for kraken test... 16:51:55 INFO - TEST-INFO | started process 6130 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTv8gqv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:52:07 INFO - PROCESS | 6130 | RSS: Main: 137719808 16:52:07 INFO - PROCESS | 6130 | 16:52:10 INFO - PROCESS | 6130 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36202/tests/kraken/driver.html?testName=audio-beat-detection) 16:52:11 INFO - PROCESS | 6130 | RSS: Main: 180936704 16:52:11 INFO - PROCESS | 6130 | 16:52:13 INFO - PROCESS | 6130 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36202/tests/kraken/driver.html?testName=audio-dft) 16:52:14 INFO - PROCESS | 6130 | RSS: Main: 172265472 16:52:14 INFO - PROCESS | 6130 | 16:52:16 INFO - PROCESS | 6130 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36202/tests/kraken/driver.html?testName=audio-fft) 16:52:17 INFO - PROCESS | 6130 | RSS: Main: 264114176 16:52:17 INFO - PROCESS | 6130 | 16:52:19 INFO - PROCESS | 6130 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36202/tests/kraken/driver.html?testName=audio-oscillator) 16:52:20 INFO - PROCESS | 6130 | RSS: Main: 169811968 16:52:20 INFO - PROCESS | 6130 | 16:52:22 INFO - PROCESS | 6130 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36202/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:52:22 INFO - PROCESS | 6130 | RSS: Main: 172720128 16:52:22 INFO - PROCESS | 6130 | 16:52:25 INFO - PROCESS | 6130 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36202/tests/kraken/driver.html?testName=imaging-darkroom) 16:52:26 INFO - PROCESS | 6130 | RSS: Main: 211640320 16:52:26 INFO - PROCESS | 6130 | 16:52:29 INFO - PROCESS | 6130 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36202/tests/kraken/driver.html?testName=imaging-desaturate) 16:52:30 INFO - PROCESS | 6130 | RSS: Main: 210227200 16:52:30 INFO - PROCESS | 6130 | 16:52:33 INFO - PROCESS | 6130 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36202/tests/kraken/driver.html?testName=json-parse-financial) 16:52:33 INFO - PROCESS | 6130 | RSS: Main: 208433152 16:52:33 INFO - PROCESS | 6130 | 16:52:35 INFO - PROCESS | 6130 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36202/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:52:35 INFO - PROCESS | 6130 | RSS: Main: 170561536 16:52:35 INFO - PROCESS | 6130 | 16:52:37 INFO - PROCESS | 6130 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36202/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:52:38 INFO - PROCESS | 6130 | RSS: Main: 177188864 16:52:38 INFO - PROCESS | 6130 | 16:52:40 INFO - PROCESS | 6130 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36202/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:52:40 INFO - PROCESS | 6130 | RSS: Main: 186433536 16:52:40 INFO - PROCESS | 6130 | 16:52:43 INFO - PROCESS | 6130 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:52:44 INFO - PROCESS | 6130 | RSS: Main: 195952640 16:52:44 INFO - PROCESS | 6130 | 16:52:46 INFO - PROCESS | 6130 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:52:47 INFO - PROCESS | 6130 | RSS: Main: 192917504 16:52:47 INFO - PROCESS | 6130 | 16:52:48 INFO - PROCESS | 6130 | Cycle 1(1): loaded http://localhost:36202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36202/tests/kraken/driver.html?testName=ai-astar) 16:52:49 INFO - PROCESS | 6130 | RSS: Main: 245010432 16:52:49 INFO - PROCESS | 6130 | 16:52:49 INFO - PROCESS | 6130 | __start_tp_report 16:52:49 INFO - PROCESS | 6130 | _x_x_mozilla_page_load 16:52:49 INFO - PROCESS | 6130 | _x_x_mozilla_page_load_details 16:52:49 INFO - PROCESS | 6130 | |i|pagename|runs| 16:52:49 INFO - PROCESS | 6130 | |0;ai-astar;108;113;111;112;111;111;112;113;111;111 16:52:49 INFO - PROCESS | 6130 | |1;audio-beat-detection;142;115;121;169;119;120;116;115;136;125 16:52:49 INFO - PROCESS | 6130 | |2;audio-dft;160;160;160;159;160;160;160;159;160;159 16:52:49 INFO - PROCESS | 6130 | |3;audio-fft;77;74;75;121;75;75;75;76;105;75 16:52:49 INFO - PROCESS | 6130 | |4;audio-oscillator;82;82;100;83;82;82;97;83;83;98 16:52:49 INFO - PROCESS | 6130 | |5;imaging-gaussian-blur;117;116;118;117;117;117;117;117;118;116 16:52:49 INFO - PROCESS | 6130 | |6;imaging-darkroom;148;147;147;146;146;147;146;147;147;147 16:52:49 INFO - PROCESS | 6130 | |7;imaging-desaturate;95;96;96;95;95;95;95;95;95;95 16:52:49 INFO - PROCESS | 6130 | |8;json-parse-financial;48;48;49;49;51;48;49;49;50;49 16:52:49 INFO - PROCESS | 6130 | |9;json-stringify-tinderbox;63;63;64;63;63;63;63;63;63;64 16:52:49 INFO - PROCESS | 6130 | |10;stanford-crypto-aes;84;76;84;76;77;77;77;77;75;81 16:52:49 INFO - PROCESS | 6130 | |11;stanford-crypto-ccm;131;133;120;120;118;119;118;138;165;122 16:52:49 INFO - PROCESS | 6130 | |12;stanford-crypto-pbkdf2;161;158;157;157;157;157;165;164;156;154 16:52:49 INFO - PROCESS | 6130 | |13;stanford-crypto-sha256-iterative;61;61;60;61;61;65;60;60;58;59 16:52:49 INFO - PROCESS | 6130 | __end_tp_report 16:52:49 INFO - PROCESS | 6130 | __start_cc_report 16:52:49 INFO - PROCESS | 6130 | _x_x_mozilla_cycle_collect,1539 16:52:49 INFO - PROCESS | 6130 | __end_cc_report 16:52:49 INFO - PROCESS | 6130 | __startTimestamp1488329569143__endTimestamp 16:52:49 INFO - PROCESS | 6130 | 16:52:49 INFO - PROCESS | 6130 | ------- Summary: start ------- 16:52:49 INFO - PROCESS | 6130 | Number of tests: 14 16:52:49 INFO - PROCESS | 6130 | 16:52:49 INFO - PROCESS | 6130 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.50 stddev:1.42 (1.3%) stddev-sans-first:0.87 16:52:49 INFO - PROCESS | 6130 | Values: 108.0 113.0 111.0 112.0 111.0 111.0 112.0 113.0 111.0 111.0 16:52:49 INFO - PROCESS | 6130 | 16:52:49 INFO - PROCESS | 6130 | [#1] audio-beat-detection Cycles:10 Average:127.80 Median:123.00 stddev:17.08 (13.9%) stddev-sans-first:17.33 16:52:49 INFO - PROCESS | 6130 | Values: 142.0 115.0 121.0 169.0 119.0 120.0 116.0 115.0 136.0 125.0 16:52:49 INFO - PROCESS | 6130 | 16:52:49 INFO - PROCESS | 6130 | [#2] audio-dft Cycles:10 Average:159.70 Median:160.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 16:52:49 INFO - PROCESS | 6130 | Values: 160.0 160.0 160.0 159.0 160.0 160.0 160.0 159.0 160.0 159.0 16:52:49 INFO - PROCESS | 6130 | 16:52:49 INFO - PROCESS | 6130 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.00 stddev:16.38 (21.8%) stddev-sans-first:17.23 16:52:49 INFO - PROCESS | 6130 | Values: 77.0 74.0 75.0 121.0 75.0 75.0 75.0 76.0 105.0 75.0 16:52:49 INFO - PROCESS | 6130 | 16:52:49 INFO - PROCESS | 6130 | [#4] audio-oscillator Cycles:10 Average:87.20 Median:83.00 stddev:7.73 (9.3%) stddev-sans-first:7.97 16:52:49 INFO - PROCESS | 6130 | Values: 82.0 82.0 100.0 83.0 82.0 82.0 97.0 83.0 83.0 98.0 16:52:49 INFO - PROCESS | 6130 | 16:52:49 INFO - PROCESS | 6130 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 16:52:49 INFO - PROCESS | 6130 | Values: 117.0 116.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 116.0 16:52:49 INFO - PROCESS | 6130 | 16:52:49 INFO - PROCESS | 6130 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 16:52:49 INFO - PROCESS | 6130 | Values: 148.0 147.0 147.0 146.0 146.0 147.0 146.0 147.0 147.0 147.0 16:52:49 INFO - PROCESS | 6130 | 16:52:49 INFO - PROCESS | 6130 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:52:49 INFO - PROCESS | 6130 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:52:49 INFO - PROCESS | 6130 | 16:52:49 INFO - PROCESS | 6130 | [#8] json-parse-financial Cycles:10 Average:49.00 Median:49.00 stddev:0.94 (1.9%) stddev-sans-first:0.93 16:52:49 INFO - PROCESS | 6130 | Values: 48.0 48.0 49.0 49.0 51.0 48.0 49.0 49.0 50.0 49.0 16:52:49 INFO - PROCESS | 6130 | 16:52:49 INFO - PROCESS | 6130 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 16:52:49 INFO - PROCESS | 6130 | Values: 63.0 63.0 64.0 63.0 63.0 63.0 63.0 63.0 63.0 64.0 16:52:49 INFO - PROCESS | 6130 | 16:52:49 INFO - PROCESS | 6130 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:77.00 stddev:3.34 (4.3%) stddev-sans-first:2.86 16:52:49 INFO - PROCESS | 6130 | Values: 84.0 76.0 84.0 76.0 77.0 77.0 77.0 77.0 75.0 81.0 16:52:49 INFO - PROCESS | 6130 | 16:52:49 INFO - PROCESS | 6130 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:126.50 stddev:14.71 (11.6%) stddev-sans-first:15.57 16:52:49 INFO - PROCESS | 6130 | Values: 131.0 133.0 120.0 120.0 118.0 119.0 118.0 138.0 165.0 122.0 16:52:49 INFO - PROCESS | 6130 | 16:52:49 INFO - PROCESS | 6130 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.60 Median:157.50 stddev:3.57 (2.3%) stddev-sans-first:3.67 16:52:49 INFO - PROCESS | 6130 | Values: 161.0 158.0 157.0 157.0 157.0 157.0 165.0 164.0 156.0 154.0 16:52:49 INFO - PROCESS | 6130 | 16:52:49 INFO - PROCESS | 6130 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.60 Median:61.00 stddev:1.84 (3.0%) stddev-sans-first:1.94 16:52:49 INFO - PROCESS | 6130 | Values: 61.0 61.0 60.0 61.0 61.0 65.0 60.0 60.0 58.0 59.0 16:52:49 INFO - PROCESS | 6130 | -------- Summary: end -------- 16:52:49 INFO - PROCESS | 6130 | 16:52:50 INFO - TEST-INFO | 6130: exit 0 16:52:50 INFO - TEST-OK | kraken | took 60417ms 16:52:50 INFO - SUITE-END | took 1174s 16:52:50 INFO - Completed test suite (00:19:34) 16:52:50 INFO - javascript benchmark 16:52:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3290.6051273847143, 3317.3862835375444, 3324.5345651608777, 3340.131565792893, 3376.932461350773, 5348.786048558058, 5465.289512363387, 5467.6172667913215, 5468.535174510166, 5471.616986810925, 5381.865453363668, 5398.082326004579, 5399.460053994599, 5411.945880541193, 5442.6462279951875, 4828.299896515012, 4838.516148385169, 4878.975605121987, 4888.413390393158, 4893.04585605807, 4816.83141090062, 4863.489333619955, 4908.067467181242, 4924.80300787968, 4951.158303088484, 4771.045790841828, 4850.466448690659, 4869.220924652056, 4894.583960363356, 4983.626228032894, 4944.678595891273, 4975.825846095406, 4976.328195693572, 4979.751012449363, 5008.899822003539, 4808.61531077513, 4881.0, 4895.485973972753, 4940.036692844897, 4962.87592810179, 5329.25390445338, 5364.517193452569, 5428.701421421821, 5441.483059109379, 5508.504234618904, 5843.065109582489, 5900.763969441217, 5906.409359064102, 5907.261592300963, 5910.497607703351, 5955.7915472958675, 5972.193753843262, 5986.910196347058, 5988.341282458926, 5989.700514974277, 5427.131658934591, 5449.972750136224, 5502.8349149525175, 5530.976769297693, 5597.99236137491, 6071.241094863142, 6075.635461872302, 6077.301110372276, 6081.452669259699, 6105.572609917263, 5789.623674461147, 5842.795502157404, 5845.357010728816, 5847.239858818326, 5853.678047707417, 5765.164051212634, 5766.567507436959, 5787.855303617359, 5797.449242321973, 5953.493953014043, 5843.941560584425, 5850.3564607893095, 5863.384344643836, 5883.911741323884, 5891.911621325684, 5850.912236316459, 5857.062869940789, 5860.970695146497, 5861.35525092248, 5862.589618726648, 4481.596656300949, 4494.617957473652, 4497.460304763449, 4520.367148599199, 4535.523770004168, 4007.3788562772816, 4038.8384464621085, 4056.9391459128137, 4069.918601627951, 4071.5114186297833, 5670.319561652545, 5673.744681489343, 5679.2333035040565, 5679.630823996427, 5681.545476361881, 5631.211630371751, 5661.7735290588735, 5826.941730582725, 5850.3272123705465, 5911.290645122613, 5658.349289831722, 5669.291338582677, 5681.744321505542, 5686.317641883001, 5711.371749107595, 5046.419661738873, 5054.418741844662, 5054.82308119214, 5055.090083784954, 5086.669366491166, 5955.40445955401, 5999.5800293979, 6030.276366836008, 6055.212822333068, 6059.6364218147055, 5855.414458554281, 5928.258967629046, 5928.644281343133, 5943.1679564861815, 5976.581639285208, 6144.262688477233, 6159.19930409044, 6169.043798211284, 6169.043798211284, 6171.753129874754, 5549.889002219852, 5569.665820050648, 5785.132230165509, 5845.824625261249, 5846.0, 5762.222100016612, 5778.624389414675, 5812.21535092757, 5887.911681324698, 5920.940790592039, 5730.627509211888, 5732.197492350991, 5732.369439361751, 5734.856628584319, 5735.655860648374, 5681.034224181816, 5741.3971532988435, 5748.252727145445, 5753.280839895013, 5756.68338241384, 5644.717764111861, 5649.096144616841, 5697.54419646419, 5700.25896633435, 5796.739146738322, 5733.799317023884, 5784.797532086357, 5785.392533783892, 5793.217915581343, 5795.507381872588, 5664.838708064919, 5668.914966275592, 5671.858203544944, 5677.630953987978, 5680.602357834912], "value": 5413.146307466765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.1473019930503, 614.0819474885046, 625.8998560230364, 632.6646877155107, 660.2044536333718, 36749.26501469969, 46975.0, 48518.0, 48527.51472485279, 53599.73200134004, 50461.0, 51041.74479127599, 51104.488955110435, 51109.488905110935, 51112.74443627786, 8543.017552981424, 9315.021922698137, 9503.904960950405, 9506.096920792514, 9512.524373781318, 8662.13378662135, 11023.283486573388, 11309.208355415125, 11339.943300283487, 11778.352190629512, 11499.19505634606, 11527.135464840128, 11551.595694150707, 11567.710807229803, 11571.710707232345, 11279.210455268134, 11315.547378104866, 11331.603393881256, 11353.716157096056, 11354.489047992818, 11246.156538259664, 11261.887381126166, 11310.660680179608, 11325.943370283178, 11333.659990200307, 46604.300935486, 46874.296885546406, 46894.0, 46957.0, 47034.294485582745, 4306.870793876189, 4438.778061096932, 4449.132419178261, 4450.821967121311, 4656.138614356355, 31994.20014499656, 32217.51673724896, 32578.6742132578, 32611.83694081538, 33451.665483345096, 4623.214053610861, 4642.234031384817, 4726.1020406122725, 4735.1713450146435, 4811.206150985084, 388394.0, 390168.04915975523, 392221.0, 393858.0, 394206.0, 62557.68721156456, 63091.684541577, 63134.68432657807, 63357.36642633607, 63597.36402636007, 64963.35036649668, 65122.67438662776, 65309.346906531275, 65435.67282163654, 65535.67232163904, 19373.418797435817, 19574.21703131859, 19612.0, 19623.90188049079, 19671.803281967284, 13987.860121398859, 14379.137251764927, 14682.779758303634, 14740.41038358475, 14842.480513181987, 18966.0, 19767.0, 19801.603967920848, 19838.305659301855, 19874.0, 7110.3600675939415, 7208.56748595086, 7357.558546487228, 7397.556146631219, 7495.437842161859, 997.0876647867266, 1005.6128390569537, 1006.6979906028308, 1014.1227837920146, 1020.811149937264, 35916.0, 35970.8201458991, 36035.639643603754, 36339.27321453556, 36421.0, 1193.2721040165493, 1195.1039610868459, 1212.9454174562165, 1233.543588872123, 1311.888489478386, 17766.911165444348, 18732.0227728075, 18872.339468118826, 18902.054897255082, 18912.43262702121, 542361.0, 544603.0, 546757.0, 547820.0, 550282.0, 49551.752241238566, 49572.25641615379, 49617.25574116391, 49798.502014979385, 49894.501054988985, 1508.4192585854305, 1547.1877264436262, 1554.3083327919194, 1559.3918371834993, 1576.4561226376882, 33057.66942330546, 34929.825350874096, 34979.65020349764, 35073.29853402867, 35201.0, 62156.0, 62668.373316266254, 62822.0, 62925.37074629195, 63088.36911630825, 415172.0, 415588.0, 415830.0, 416873.0, 417000.0, 28587.0, 31135.688643114187, 32273.0, 32475.18812029718, 33003.66996330006, 53683.0, 54424.183637246264, 54486.0, 55145.0, 55872.0, 44309.0, 46191.538084618725, 46752.532474674816, 46918.0, 47106.76446617745, 44118.0, 45102.32346514871, 45725.77137114293, 45821.31268031049, 46340.30489542727, 41424.792876035426, 43074.13851723011, 46052.07895842131, 46123.30815037844, 46564.06871862476, 36584.0, 38770.61229387783, 39323.213535729694, 39919.40120898247, 39961.2007759849, 28630.28424289326, 36472.81763591165, 38207.808960955015, 39960.600393995686, 40613.97388617609], "value": 22296.200041132422, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.40362318116905, 451.76056689954316, 452.26958462083724, 457.8878174847162, 473.44843257604913, 20481.59036819263, 22228.0, 22255.888720556413, 22881.08475660976, 23258.4185395365, 22230.11079556816, 22538.774612253874, 22659.093636254573, 23629.0, 24292.51414971704, 6827.351401616838, 7101.254368291333, 7546.320831125197, 7810.101838288612, 7882.0, 6585.440237579787, 7920.881186782203, 7987.680492780281, 8044.0, 8052.718154864581, 7952.920470795276, 7953.522788632672, 7959.204079592024, 7960.044794624653, 7966.004249468817, 7835.138134805167, 7968.561729104897, 7984.321332686729, 8037.397195210324, 8042.879356809653, 7381.409487241008, 7702.807429814244, 7717.65270562826, 7890.960545197295, 7895.7236496722335, 30092.8495357524, 30208.0, 30571.23571910698, 30910.22724431885, 30955.845220773976, 3491.9301613967577, 3609.187932715144, 3645.9817700911326, 3709.0356507308024, 3720.3489389356755, 17155.57111072221, 17640.647187056187, 17899.0, 18004.729929051075, 18279.360222392286, 2225.187806450634, 2280.441291883483, 2287.656851472276, 2360.5632957902844, 2536.480021595587, 120001.0, 123483.0, 123969.0, 124705.0, 125516.0, 20858.37424877256, 21228.78771212299, 21270.787292127192, 21818.454538636342, 22150.446238844157, 41755.0, 42105.78947105306, 42395.0, 42532.57467425348, 42567.0, 9182.586783594754, 9401.811963760687, 9677.516124193762, 9821.803563928825, 9929.404235745878, 9451.810963780823, 9514.0, 9560.808783824285, 9730.562124704406, 9730.902690973142, 5382.569394448435, 5467.6719396836315, 5530.308711411074, 5537.0, 5632.183333416631, 2118.142152428269, 2170.2295685031904, 2200.526886719363, 2215.612267853119, 2272.8068114210146, 949.0888746803008, 959.932804703678, 963.349738926236, 972.3533849989819, 976.5410257179115, 18561.90719046423, 21469.355919322446, 21629.24297649575, 21790.673139902916, 21914.23300184486, 973.5570315506427, 981.249344251648, 981.2983716642635, 990.7467054176473, 999.4203362049993, 11332.036776873892, 11650.94174529139, 12474.43865026076, 12530.561430349893, 12750.553730619384, 723391.0, 740608.0, 743741.0, 758439.0, 760871.0, 111946.0, 112608.0, 115596.0, 116425.4178729101, 119058.0, 1175.0716933622514, 1186.306010983567, 1198.6823491774687, 1205.0239306162036, 1211.8969887559656, 19213.61572768509, 19550.120244588743, 19628.901855490632, 19628.901855491204, 19797.40607781769, 47411.76294118507, 47806.0, 47891.76054119707, 47980.760096199294, 48188.518114818406, 62866.37133628605, 64921.67539162274, 64984.0, 65886.67056664878, 66091.0, 7640.617969101634, 8003.279704826594, 8185.959070204611, 8340.374471914509, 8679.696210632597, 12538.87461125377, 14560.708785824436, 14701.0, 14714.0, 15307.77038344448, 12460.813087803872, 12552.748945020865, 12708.173968692005, 12741.936290318488, 12775.23348599087, 11969.820452693042, 12617.179883307555, 12689.8096528554, 12832.615021549369, 13159.53941612039, 12349.876501234872, 12389.75220495603, 12612.180208286432, 12624.810627840407, 12993.48026078984, 8339.666413343399, 8409.495430274203, 8464.153584641486, 8472.279856212292, 8482.194191551793, 11707.648770536898, 11890.702732431759, 11982.760344793229, 12066.75866482683, 12299.69250768738], "value": 11468.077411657114, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.101928237004, 1493.8207415110182, 1518.559617710864, 1520.3462511120215, 1530.2195880101144, 7390.704371825127, 7924.207579242073, 8195.18048195181, 8197.385196110301, 8410.158984101587, 8220.712275070373, 8298.543580103093, 8305.294050005741, 8308.91691083089, 8317.168283171679, 2117.7035215069905, 2187.529681118559, 2345.577795996724, 2381.0475809676095, 2385.8449200801892, 2346.21401830387, 2411.445367565461, 2414.5774489464275, 2430.6840110785574, 2432.9391765205924, 2293.7247530296386, 2304.7925686688195, 2305.9192928247517, 2321.7097862767155, 2321.7330007049154, 2334.533093381322, 2348.835581509295, 2349.48311371498, 2352.8117750579913, 2356.187115445186, 2203.2178576605393, 2253.9549209015727, 2255.7180352455944, 2257.4694946687514, 2257.7290725112925, 8291.917080829175, 8368.246857782768, 8368.665253389858, 8369.58152092393, 8392.790180245482, 5124.666896651705, 5256.658317209369, 5260.289860868772, 5260.973695131538, 5268.710220937847, 3338.2488939988552, 3421.623621401644, 3424.434968230239, 3460.740444466675, 3465.3069386122875, 1432.563068264179, 1433.2332202271734, 1469.8236211654669, 1493.0892155784964, 1499.4163948163898, 11054.723631909186, 11062.944685276603, 11077.667669969915, 11080.501377438035, 11081.612143574936, 4559.589636932692, 4609.078184363141, 4612.0, 4674.462436819741, 4715.669903106818, 9079.45523268606, 9217.815643687089, 9230.953845230732, 9232.815343693223, 9237.353385262966, 5260.9736951315, 5264.552513036435, 5269.104252277122, 5270.736463176902, 5276.736163191825, 4659.0, 4679.321498382784, 4720.551547602972, 4931.334269873593, 4940.382452193476, 3870.4581358609817, 3954.9209015819524, 3988.80055997199, 4008.899777505586, 4130.297849365615, 1215.0583297944163, 1222.8899399054128, 1228.3796682675193, 1237.6905773556612, 1243.8942689871462, 1020.1074060197327, 1030.5465595138114, 1042.3485321673954, 1043.6347278452633, 1050.7845891592206, 5682.289713785777, 5799.652020878761, 5853.03424934881, 5861.912071318934, 6241.875162496724, 648.6497291462651, 655.894817232964, 658.2265837640753, 1034.8913364096811, 1102.5148934468807, 3979.6020397959974, 4034.8184331705143, 4089.0595163112653, 4091.652209562161, 4134.1731653668785, 9672.371295865747, 9961.0, 9968.152707019839, 9974.0, 9977.25170612207, 9607.231421486264, 9687.806243875082, 9843.163331116792, 9875.851862222073, 9905.059019393146, 7784.3772498200005, 7958.482698624686, 7960.40296977729, 7961.36309095271, 7962.044554653363, 5745.712714364348, 5802.7098645066735, 5841.269841269841, 5857.648541087378, 5918.201042859159, 9169.77075573116, 9179.816403671755, 9210.0, 9215.216706580015, 9246.306527010636, 8523.616437260214, 9013.0, 9475.099865512766, 9479.099485548863, 9484.905150948402, 6717.093192418961, 6930.757423490154, 7028.50800443964, 7075.787726368218, 7219.639018049182, 7859.724909628136, 7971.44199906001, 8075.788631705056, 8123.106458289702, 8171.83656326882, 7293.234210407831, 7353.926460735538, 7356.154042285206, 7400.851982960203, 7455.254474552501, 7213.891791623025, 7238.6380680966795, 7247.383972362198, 7285.0, 7287.708491660274, 6666.733330666913, 6667.599944003376, 6689.698963546554, 6728.697208625722, 6764.323567643196, 5046.9747651261505, 5116.872078198075, 5305.681659100466, 5390.811321603725, 5436.673799572039, 5143.8456846294675, 5168.9483105168465, 5178.533931946143, 5189.886068358955, 5300.522952934254], "value": 4512.468458595035, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.27025516112275, 425.20274485339985, 426.846335319285, 439.09108146137487, 439.17873576412114, 5131.948680513194, 5292.36491621006, 5319.601029922756, 5395.298611180546, 5404.378496472907, 5223.791048358071, 5234.973825130878, 5289.285946397235, 5292.338457692788, 5305.8938821223555, 4245.789949864282, 4274.829006839723, 4282.97858510707, 4300.741955482681, 4309.827606895736, 3970.8610198643055, 4093.5906409358977, 4265.125649241898, 4288.356746488021, 4289.206496798087, 4217.734679596124, 4234.259004674185, 4256.638185754215, 4258.509521667407, 4272.295071313245, 4239.703220774547, 4246.44796176495, 4251.128518653669, 4255.510616279105, 4257.318359248111, 3516.261585067139, 3874.496315478998, 3878.2825177342, 3891.9297193271796, 3906.4921560196995, 5167.147420675584, 5210.905709800946, 5214.8174813881715, 5218.008578370135, 5241.86895327616, 4828.251620998751, 4842.636802239811, 4851.393575803025, 4852.539008794159, 4868.075065737534, 5428.185772134172, 5579.581531385122, 5581.7209139543265, 5582.692951887645, 5596.524295434893, 4033.4151548025666, 4039.717219794586, 4042.2117687051036, 4059.2490389278078, 4081.7346872453195, 5722.141678748179, 5753.280839895013, 5762.222100016486, 5765.827025189251, 5786.305643322744, 4126.979365103155, 4225.936610950838, 4230.428892099589, 4256.3828244904935, 4262.46719160105, 4261.890364269706, 4281.914361712748, 4291.442112525352, 4293.677974151951, 4318.719283246642, 4801.51984801524, 4806.519348065235, 4809.0, 4843.104025755247, 4849.0, 5517.668939863621, 5558.03682199393, 5627.352854421712, 5634.746436410372, 5655.236543066716, 1355.0243824446384, 1363.2979015806868, 1389.7359501694646, 1391.8656295119445, 1392.470861072786, 972.1590823937385, 990.405756546081, 994.3188915592842, 998.55065220651, 1011.0, 5280.808464487195, 5308.177232528887, 5314.97342513285, 5317.707526086102, 5326.92009619856, 5554.555635549146, 5557.472040156179, 5561.221428999943, 5562.3047119110115, 5581.320965936292, 5190.506901844395, 5305.31030965972, 5345.545628621533, 5353.411124776271, 5516.172574113834, 2935.6770755216908, 2947.9976807885423, 2961.555766635022, 2962.5408061750463, 2963.977427787453, 5799.39106393831, 5801.448862358069, 5807.602552506831, 5828.358880523139, 5838.2702162229725, 5540.667559946416, 5619.887602247933, 5651.265335506358, 5682.829515114553, 5687.630304030225, 5694.487496125285, 5718.483132873336, 5760.8271751847515, 5763.538916886639, 5793.94206057934, 5288.3918349390315, 5493.116114040161, 5537.916931246115, 5581.246531718166, 5606.18710286998, 5507.796881247533, 5515.951969125853, 5550.530014143667, 5586.469285417878, 5600.383957764561, 5857.94142058591, 5859.92354014146, 5867.237259156454, 5876.382979787232, 5887.234659494238, 3950.3481925483125, 4065.6747460203705, 4067.288224560631, 4083.775392353449, 4173.353130264813, 5560.277163968658, 5620.747066382104, 5634.549236061023, 5638.746256418389, 5666.405027472221, 5361.973190134025, 5547.805826796042, 5606.467385598362, 5611.3266408031295, 5625.537360286273, 5582.409013431153, 5586.469285418041, 5601.467860553241, 5607.682194684327, 5608.6073974821375, 5314.388845282688, 5581.553475721851, 5583.720813959367, 5599.636023658449, 5635.718214089361, 5611.074172761612, 5642.576806739429, 5646.153077038312, 5647.870425914752, 5660.009498337857, 5408.347732289385, 5553.278073850373, 5567.109262517978, 5576.525995290283, 5590.133529302964], "value": 4298.944926375505, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.3166471828383, 834.937379696523, 857.1942374168282, 911.3620465674028, 935.5228833295022, 16628.251728672207, 17377.0, 17638.735418968692, 17931.551711207227, 18059.277628894844, 15679.137647429387, 15704.685906281897, 16567.254473548688, 16712.08083555404, 16725.665486690257, 716.9318914703094, 837.3803385494751, 857.4683696108391, 861.4013260783757, 862.2196911794836, 735.6505659811601, 821.3716506872247, 845.0619812008665, 854.6453221912899, 855.1747563601124, 880.0935036911991, 881.6914080071988, 881.7266647339313, 882.355880207449, 882.7042940614901, 737.4911311195258, 880.7665968518315, 880.9735707928772, 881.678187461572, 881.9901213110984, 557.6570409198314, 629.2197674883158, 643.3470027921663, 650.7397041183565, 653.2846533046306, 16395.672086558323, 16457.753133703005, 16656.0, 16716.24776885043, 16772.66454670912, 14990.250487475692, 15469.690606187925, 15662.608434789108, 15877.20613969297, 16078.5980350491, 13128.146670466485, 13502.189868607915, 13726.087151819416, 13808.309584520834, 13836.723265534632, 4568.931466028012, 4605.171069207541, 4614.8154073837, 4668.509806470306, 4678.064387122555, 79956.60021699854, 81141.0, 81180.59409702972, 81447.59276203641, 81865.0, 11914.940425297991, 11949.88050119505, 12085.335306558223, 12158.817617735742, 12226.021918246519, 23633.172838950555, 23770.524589508113, 23924.162654307016, 23932.52134957291, 23938.162164324163, 8958.68644597436, 9067.138621830916, 9083.955345135262, 9258.259339252843, 9323.487208203478, 4635.188841952645, 4680.789364478606, 4702.0, 4710.882227944328, 4853.684510506806, 3685.1155722626913, 3724.1248306647917, 3740.158464345555, 3765.792881391495, 3784.9243015140096, 641.6503005861723, 645.270843946347, 648.4650163615037, 653.3564439027554, 654.3750718064238, 708.3553965891015, 710.7476845719696, 713.1869668577825, 719.129852878013, 727.4107972542258, 9984.650537231308, 10355.119814815675, 10757.731056723644, 10787.54368160304, 10979.121670266359, 720.7729565187054, 726.1975517053685, 739.098300073909, 739.6043116932416, 741.3698356397127, 4743.857684269477, 4962.6774259673, 5030.2957585938, 5050.646454748133, 5070.949290507047, 82565.0, 82811.5859420699, 83592.0, 85226.0, 85248.0, 71332.64333678299, 73090.63454682799, 74488.0, 75143.0, 76335.61832190804, 65317.67341163264, 66492.0, 67065.0, 67131.0, 68972.65513672399, 9654.613815447303, 9819.85270220933, 9968.352057116264, 10004.649837255953, 10042.648507302209, 44581.0, 44603.10793784171, 45256.094878102915, 45497.772511137235, 45781.54218457773, 54580.454195459126, 56687.43312566821, 56916.71541642431, 57107.14339284997, 57217.713911430175, 11590.13074019435, 11670.241434306743, 11776.470058847544, 11920.105992050458, 12017.579384721494, 13642.658933526343, 13760.724785504033, 13774.586762397144, 13795.931020345235, 13891.444342226601, 12274.81587776202, 12613.621591352274, 12908.935455322664, 12995.805062924253, 13418.329083545588, 11597.304161750322, 11703.23928944616, 11780.941095294469, 12063.698407539881, 12132.090093242865, 12518.123731339083, 12834.743305133657, 12854.614361569167, 12943.288119153536, 13059.804102938273, 10853.511591978222, 10889.183311251847, 10975.341479511255, 11091.168162388014, 11307.717307067389, 10272.691819245136, 10288.074073333435, 10316.896831031594, 10330.535125919201, 10409.0], "value": 7511.5894963179035, "unit": "score"}], "name": "dromaeo_css", "value": 7658.115655779506, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 113.0, 111.0, 112.0, 111.0, 111.0, 112.0, 113.0, 111.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 115.0, 121.0, 169.0, 119.0, 120.0, 116.0, 115.0, 136.0, 125.0], "value": 127.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 159.0, 160.0, 160.0, 160.0, 159.0, 160.0, 159.0], "value": 159.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 75.0, 121.0, 75.0, 75.0, 75.0, 76.0, 105.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 100.0, 83.0, 82.0, 82.0, 97.0, 83.0, 83.0, 98.0], "value": 87.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 49.0, 49.0, 51.0, 48.0, 49.0, 49.0, 50.0, 49.0], "value": 49.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 76.0, 84.0, 76.0, 77.0, 77.0, 77.0, 77.0, 75.0, 81.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 133.0, 120.0, 120.0, 118.0, 119.0, 118.0, 138.0, 165.0, 122.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 158.0, 157.0, 157.0, 157.0, 157.0, 165.0, 164.0, 156.0, 154.0], "value": 158.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 65.0, 60.0, 60.0, 58.0, 59.0], "value": 60.6, "unit": "score"}], "name": "kraken", "value": 1466.0, "alertThreshold": 2.0}]} 16:52:50 INFO - Return code: 0 16:52:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:52:50 ERROR - # TBPL SUCCESS # 16:52:50 INFO - Running post-action listener: _resource_record_post_action 16:52:50 INFO - [mozharness: 2017-03-01 00:52:50.472346Z] Finished run-tests step (success) 16:52:50 INFO - Running post-run listener: _resource_record_post_run 16:52:50 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 884736; Write bytes: 364830720; Read time: 136; Write time: 356084 16:52:50 INFO - TinderboxPrint: CPU usage
13.0% 16:52:50 INFO - TinderboxPrint: I/O read bytes / time
884,736 / 136 16:52:50 INFO - TinderboxPrint: I/O write bytes / time
364,830,720 / 356,084 16:52:50 INFO - TinderboxPrint: CPU idle
8,264.7 (86.9%) 16:52:50 INFO - TinderboxPrint: CPU user
1,193.3 (12.6%) 16:52:50 INFO - TinderboxPrint: Swap in / out
0 / 0 16:52:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110170112; Read time: 0; Write time: 153116 16:52:50 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 884736; Write bytes: 254660608; Read time: 136; Write time: 202968 16:52:51 INFO - Running post-run listener: _upload_blobber_files 16:52:51 INFO - Blob upload gear active. 16:52:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:52:51 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 16:52:51 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'] 16:52:51 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 16:52:51 INFO - (blobuploader) - INFO - Open directory for files ... 16:52:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:52:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:52:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:59 INFO - (blobuploader) - INFO - Done attempting. 16:52:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:52:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:53:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:53:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:53:00 INFO - (blobuploader) - INFO - Done attempting. 16:53:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:53:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:53:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:53:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:53:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:53:01 INFO - (blobuploader) - INFO - Done attempting. 16:53:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:53:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:53:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:53:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:53:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:53:02 INFO - (blobuploader) - INFO - Done attempting. 16:53:02 INFO - (blobuploader) - INFO - Iteration through files over. 16:53:02 INFO - Return code: 0 16:53:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:53:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:53:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5c50edfed1b3e11b0f217b330f3c9fa0bd26ea896e13ac0f1aa36dc805e3f0d44e1215e671ce213fb91aca2d36b8a409b8e71eb0492c471d5ae84eab411ae364", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/71f495f908a65cda8a3620b43247ff859a5769c7d0c78840444c2087ba66a66b79c57eaac126b9e18d3592c0d4e54d6e973461991a7aa73265850073bf77a53c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a27bf25321b7a7eeb0d024a2acb331f61f77d034b070d90f4c18bdf313c3607cdaaa973b48ddcafc5bf91dac80e2300293773d01170097d475de67afdf41f463", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/66dabef05de1d63437a04336dd718abde8a4b25f52f9d9f8c212b512731cbee6d85f6595822bb5a9fed0fb620403b2c9e09ab40dc46a5ef2b9f3c61cb00ab2d9"} 16:53:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:53:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:53:02 INFO - Contents: 16:53:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5c50edfed1b3e11b0f217b330f3c9fa0bd26ea896e13ac0f1aa36dc805e3f0d44e1215e671ce213fb91aca2d36b8a409b8e71eb0492c471d5ae84eab411ae364", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/71f495f908a65cda8a3620b43247ff859a5769c7d0c78840444c2087ba66a66b79c57eaac126b9e18d3592c0d4e54d6e973461991a7aa73265850073bf77a53c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a27bf25321b7a7eeb0d024a2acb331f61f77d034b070d90f4c18bdf313c3607cdaaa973b48ddcafc5bf91dac80e2300293773d01170097d475de67afdf41f463", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/66dabef05de1d63437a04336dd718abde8a4b25f52f9d9f8c212b512731cbee6d85f6595822bb5a9fed0fb620403b2c9e09ab40dc46a5ef2b9f3c61cb00ab2d9"} 16:53:02 INFO - Running post-run listener: copy_logs_to_upload_dir 16:53:02 INFO - Copying logs to upload dir... 16:53:02 INFO - mkdir: /builds/slave/test/build/upload/logs 16:53:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.549488 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-02-28 16:53:01.941209) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:01.945412) ========= 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=af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976 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/5c50edfed1b3e11b0f217b330f3c9fa0bd26ea896e13ac0f1aa36dc805e3f0d44e1215e671ce213fb91aca2d36b8a409b8e71eb0492c471d5ae84eab411ae364", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/71f495f908a65cda8a3620b43247ff859a5769c7d0c78840444c2087ba66a66b79c57eaac126b9e18d3592c0d4e54d6e973461991a7aa73265850073bf77a53c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a27bf25321b7a7eeb0d024a2acb331f61f77d034b070d90f4c18bdf313c3607cdaaa973b48ddcafc5bf91dac80e2300293773d01170097d475de67afdf41f463", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/66dabef05de1d63437a04336dd718abde8a4b25f52f9d9f8c212b512731cbee6d85f6595822bb5a9fed0fb620403b2c9e09ab40dc46a5ef2b9f3c61cb00ab2d9"} build_url:https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011447 build_url: 'https://queue.taskcluster.net/v1/task/bVi5ATPOT4qJUpdwoozyJw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5c50edfed1b3e11b0f217b330f3c9fa0bd26ea896e13ac0f1aa36dc805e3f0d44e1215e671ce213fb91aca2d36b8a409b8e71eb0492c471d5ae84eab411ae364", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/71f495f908a65cda8a3620b43247ff859a5769c7d0c78840444c2087ba66a66b79c57eaac126b9e18d3592c0d4e54d6e973461991a7aa73265850073bf77a53c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a27bf25321b7a7eeb0d024a2acb331f61f77d034b070d90f4c18bdf313c3607cdaaa973b48ddcafc5bf91dac80e2300293773d01170097d475de67afdf41f463", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/66dabef05de1d63437a04336dd718abde8a4b25f52f9d9f8c212b512731cbee6d85f6595822bb5a9fed0fb620403b2c9e09ab40dc46a5ef2b9f3c61cb00ab2d9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:01.972038) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:01.972483) ========= 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=af724c981e2a0f424dbabf99000001e7-1488328337.422714-1261042976 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:02.058473) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-28 16:53:02.058986) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-28 16:53:02.059500) ========= ========= Total master_lag: 0.27 =========