builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1487967508.29 results: success (0) buildid: 20170224103424 builduid: 06b7f7c1427c425d98f49a7e5dc3224b revision: b7bb31e5a851d6f8e142c39dc077e3774719eced ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-24 12:18:28.288607) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-24 12:18:28.289286) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-24 12:18:28.289726) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-24 12:18:28.307134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 12:18:28.307505) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-24 12:18:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2017-02-24 12:18:29 (43.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120158 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 12:18:28.442574) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 12:18:28.442858) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022575 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 12:18:28.492954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 12:18:28.493538) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b7bb31e5a851d6f8e142c39dc077e3774719eced --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b7bb31e5a851d6f8e142c39dc077e3774719eced --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=78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-24 12:18:29,279 truncating revision to first 12 chars 2017-02-24 12:18:29,279 Setting DEBUG logging. 2017-02-24 12:18:29,279 attempt 1/10 2017-02-24 12:18:29,279 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b7bb31e5a851?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-24 12:18:29,718 unpacking tar archive at: mozilla-beta-b7bb31e5a851/testing/mozharness/ program finished with exit code 0 elapsedTime=0.756080 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 12:18:29.265844) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-24 12:18:29.266365) ========= script_repo_revision: b7bb31e5a851d6f8e142c39dc077e3774719eced ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-24 12:18:29.267163) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-24 12:18:29.267653) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-24 12:18:29.279207) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-02-24 12:18:29.279732) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:18:30 INFO - MultiFileLogger online at 20170224 12:18:30 in /builds/slave/test 12:18:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:18:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:18:30 INFO - {'append_to_log': False, 12:18:30 INFO - 'base_work_dir': '/builds/slave/test', 12:18:30 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:18:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:18:30 INFO - 'branch': 'Mozilla-Beta', 12:18:30 INFO - 'buildbot_json_path': 'buildprops.json', 12:18:30 INFO - 'config_files': ('talos/linux_config.py',), 12:18:30 INFO - 'default_actions': ('clobber', 12:18:30 INFO - 'read-buildbot-config', 12:18:30 INFO - 'download-and-extract', 12:18:30 INFO - 'populate-webroot', 12:18:30 INFO - 'create-virtualenv', 12:18:30 INFO - 'install', 12:18:30 INFO - 'run-tests'), 12:18:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:18:30 INFO - 'download_minidump_stackwalk': True, 12:18:30 INFO - 'download_symbols': 'ondemand', 12:18:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:18:30 INFO - 'tooltool.py': '/tools/tooltool.py', 12:18:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:18:30 INFO - '/tools/misc-python/virtualenv.py')}, 12:18:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:18:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:18:30 INFO - 'installer_path': 'installer.exe', 12:18:30 INFO - 'log_level': 'info', 12:18:30 INFO - 'log_name': 'talos', 12:18:30 INFO - 'log_to_console': True, 12:18:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:18:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:18:30 INFO - 'opt_config_files': (), 12:18:30 INFO - 'pip_index': False, 12:18:30 INFO - 'sps_profile': False, 12:18:30 INFO - 'sps_profile_interval': 0, 12:18:30 INFO - 'suite': 'dromaeojs', 12:18:30 INFO - 'system_bits': '32', 12:18:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:18:30 INFO - 'title': 'talos-linux64-ix-019', 12:18:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:18:30 INFO - 'use_talos_json': True, 12:18:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:18:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:18:30 INFO - 'work_dir': 'build'} 12:18:30 INFO - [mozharness: 2017-02-24 20:18:30.156947Z] Running clobber step. 12:18:30 INFO - Running pre-action listener: _resource_record_pre_action 12:18:30 INFO - Running main action method: clobber 12:18:30 INFO - rmtree: /builds/slave/test/build 12:18:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:18:31 INFO - Running post-action listener: _resource_record_post_action 12:18:31 INFO - [mozharness: 2017-02-24 20:18:31.085526Z] Finished clobber step (success) 12:18:31 INFO - [mozharness: 2017-02-24 20:18:31.085627Z] Running read-buildbot-config step. 12:18:31 INFO - Running pre-action listener: _resource_record_pre_action 12:18:31 INFO - Running main action method: read_buildbot_config 12:18:31 INFO - Using buildbot properties: 12:18:31 INFO - { 12:18:31 INFO - "project": "", 12:18:31 INFO - "product": "firefox", 12:18:31 INFO - "script_repo_revision": "production", 12:18:31 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 12:18:31 INFO - "repository": "", 12:18:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 12:18:31 INFO - "buildid": "20170224103424", 12:18:31 INFO - "pgo_build": "True", 12:18:31 INFO - "basedir": "/builds/slave/test", 12:18:31 INFO - "buildnumber": 154, 12:18:31 INFO - "slavename": "talos-linux64-ix-019", 12:18:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:18:31 INFO - "platform": "ubuntu64_hw", 12:18:31 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:18:31 INFO - "branch": "mozilla-beta", 12:18:31 INFO - "repo_path": "releases/mozilla-beta", 12:18:31 INFO - "revision": "b7bb31e5a851d6f8e142c39dc077e3774719eced", 12:18:31 INFO - "stage_platform": "linux64-pgo", 12:18:31 INFO - "builduid": "06b7f7c1427c425d98f49a7e5dc3224b", 12:18:31 INFO - "slavebuilddir": "test" 12:18:31 INFO - } 12:18:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 12:18:31 INFO - Running post-action listener: _resource_record_post_action 12:18:31 INFO - [mozharness: 2017-02-24 20:18:31.088042Z] Finished read-buildbot-config step (success) 12:18:31 INFO - [mozharness: 2017-02-24 20:18:31.088130Z] Running download-and-extract step. 12:18:31 INFO - Running pre-action listener: _resource_record_pre_action 12:18:31 INFO - Running main action method: download_and_extract 12:18:31 INFO - mkdir: /builds/slave/test/build/tests 12:18:31 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')]} 12:18:31 INFO - trying https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 12:18:31 INFO - Downloading https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 12:18:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:18:31 INFO - Downloaded 1327 bytes. 12:18:31 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 12:18:31 INFO - Using the following test package requirements: 12:18:31 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 12:18:31 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:18:31 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:18:31 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:18:31 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 12:18:31 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:18:31 INFO - u'jsshell-linux-x86_64.zip'], 12:18:31 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:18:31 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:18:31 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 12:18:31 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:18:31 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 12:18:31 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:18:31 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 12:18:31 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:18:31 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:18:31 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:18:31 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:18:31 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:18:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 12:18:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:18:31 INFO - Fetch https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 12:18:32 INFO - Http code: 200 12:18:32 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 12:18:32 INFO - x-amz-cf-id: -gjZ00V0BXBxzGQbm-nhyddZbUjIQt9GDkSBH6DN-VVa0eJhIY_tFg== 12:18:32 INFO - x-amz-version-id: nFv8KkdjRznNiKBkACPOP4O7Y8VMCR3y 12:18:33 INFO - Expected file size: 21964176 12:18:33 INFO - Obtained file size: 21964176 12:18:37 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:18:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 12:18:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:18:37 INFO - Fetch https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 12:18:37 INFO - Http code: 200 12:18:37 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 12:18:37 INFO - x-amz-cf-id: GoHs8qPTmVZ8h5U5lmProGutVKZYcgJzrxuz0D84-0EuuYJgeqgTVg== 12:18:37 INFO - x-amz-version-id: nFv8KkdjRznNiKBkACPOP4O7Y8VMCR3y 12:18:38 INFO - Expected file size: 21964176 12:18:38 INFO - Obtained file size: 21964176 12:18:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 12:18:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:18:42 INFO - Fetch https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 12:18:43 INFO - Http code: 200 12:18:43 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 12:18:43 INFO - x-amz-cf-id: qa6PmkAWbeQOq4ddlNsnoDcScYIwTqIQWU7Ap965RkGe9j2VugJVnQ== 12:18:43 INFO - x-amz-version-id: M8XPUJ8gWa3sicSD3VHtUIQfZGtWmOub 12:18:44 INFO - Expected file size: 14402992 12:18:44 INFO - Obtained file size: 14402992 12:18: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')]} 12:18:44 INFO - trying https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:18:44 INFO - Downloading https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:18:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:18:46 INFO - Downloaded 57734335 bytes. 12:18:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:18:46 INFO - mkdir: /builds/slave/test/properties 12:18:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:18:46 INFO - Writing to file /builds/slave/test/properties/build_url 12:18:46 INFO - Contents: 12:18:46 INFO - build_url:https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:18:47 INFO - Running post-action listener: _resource_record_post_action 12:18:47 INFO - Running post-action listener: set_extra_try_arguments 12:18:47 INFO - [mozharness: 2017-02-24 20:18:47.422764Z] Finished download-and-extract step (success) 12:18:47 INFO - [mozharness: 2017-02-24 20:18:47.422991Z] Running populate-webroot step. 12:18:47 INFO - Running pre-action listener: _resource_record_pre_action 12:18:47 INFO - Running main action method: populate_webroot 12:18:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:18:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:18:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:18:47 INFO - '--tppagecycles', 12:18:47 INFO - '7'], 12:18:47 INFO - 'tests': ['tsvgm']}}, 12:18:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:18:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:18:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:18:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:18:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:47 INFO - 'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:18:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:18:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:47 INFO - 'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['damp', 'tps']}, 12:18:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:47 INFO - 'tests': ['damp', 'tps']}, 12:18:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['dromaeo_dom']}, 12:18:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:18:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['basic_compositor_video']}, 12:18:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:18:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['a11yr', 12:18:47 INFO - 'ts_paint', 12:18:47 INFO - 'tpaint', 12:18:47 INFO - 'sessionrestore', 12:18:47 INFO - 'sessionrestore_no_auto_restore', 12:18:47 INFO - 'tabpaint']}, 12:18:47 INFO - 'other-e10s': {'tests': ['a11yr', 12:18:47 INFO - 'ts_paint', 12:18:47 INFO - 'tpaint', 12:18:47 INFO - 'sessionrestore', 12:18:47 INFO - 'sessionrestore_no_auto_restore', 12:18:47 INFO - 'tabpaint']}, 12:18:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:18:47 INFO - 'ts_paint', 12:18:47 INFO - 'tpaint', 12:18:47 INFO - 'sessionrestore', 12:18:47 INFO - 'sessionrestore_no_auto_restore', 12:18:47 INFO - 'tabpaint']}, 12:18:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:18:47 INFO - 'ts_paint', 12:18:47 INFO - 'tpaint', 12:18:47 INFO - 'sessionrestore', 12:18:47 INFO - 'sessionrestore_no_auto_restore', 12:18:47 INFO - 'tabpaint']}, 12:18:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['a11yr', 12:18:47 INFO - 'ts_paint', 12:18:47 INFO - 'tpaint', 12:18:47 INFO - 'sessionrestore', 12:18:47 INFO - 'sessionrestore_no_auto_restore', 12:18:47 INFO - 'tabpaint']}, 12:18:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['a11yr', 12:18:47 INFO - 'ts_paint', 12:18:47 INFO - 'tpaint', 12:18:47 INFO - 'sessionrestore', 12:18:47 INFO - 'sessionrestore_no_auto_restore', 12:18:47 INFO - 'tabpaint']}, 12:18:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['tsvgx', 12:18:47 INFO - 'tsvgr_opacity', 12:18:47 INFO - 'tart', 12:18:47 INFO - 'tscrollx', 12:18:47 INFO - 'cart']}, 12:18:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:18:47 INFO - 'tsvgr_opacity', 12:18:47 INFO - 'tart', 12:18:47 INFO - 'tscrollx', 12:18:47 INFO - 'cart']}, 12:18:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:47 INFO - 'talos_options': ['--disable-e10s'], 12:18:47 INFO - 'tests': ['tp5o']}, 12:18:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:47 INFO - 'tests': ['tp5o']}, 12:18:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:47 INFO - 'talos_options': ['--disable-e10s', 12:18:47 INFO - '--xperf_path', 12:18:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:18:47 INFO - 'tests': ['tp5n']}, 12:18:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:47 INFO - 'talos_options': ['--xperf_path', 12:18:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:18:47 INFO - 'tests': ['tp5n']}}, 12:18:47 INFO - 'talos.zip': {'path': '', 12:18:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:18:47 INFO - Running post-action listener: _resource_record_post_action 12:18:47 INFO - [mozharness: 2017-02-24 20:18:47.442830Z] Finished populate-webroot step (success) 12:18:47 INFO - [mozharness: 2017-02-24 20:18:47.442918Z] Running create-virtualenv step. 12:18:47 INFO - Running pre-action listener: _resource_record_pre_action 12:18:47 INFO - Running main action method: create_virtualenv 12:18:47 INFO - Creating virtualenv /builds/slave/test/build/venv 12:18:47 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 12:18:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:18:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:18:47 INFO - Using real prefix '/usr' 12:18:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:18:48 INFO - Installing distribute.............................................................................................................................................................................................done. 12:18:50 INFO - Installing pip.................done. 12:18:50 INFO - Return code: 0 12:18:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:18:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:18:50 INFO - Reading from file tmpfile_stdout 12:18:50 INFO - Output received: 12:18:50 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) 12:18:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:18: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')]} 12:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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')]} 12:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:50 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 0x7f5f47655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f60>, '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 0x23f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f21d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', '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 12:18:50 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 12:18:50 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 12:18:50 INFO - Using env: {'DISPLAY': ':0', 12:18:50 INFO - 'HOME': '/home/cltbld', 12:18:50 INFO - 'LANG': 'en_US.UTF-8', 12:18:50 INFO - 'LANGUAGE': 'en_US:en', 12:18:50 INFO - 'LOGNAME': 'cltbld', 12:18:50 INFO - 'MAIL': '/var/mail/cltbld', 12:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:50 INFO - 'MOZ_NO_REMOTE': '1', 12:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:50 INFO - 'NO_EM_RESTART': '1', 12:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:50 INFO - 'PWD': '/builds/slave/test', 12:18:50 INFO - 'SHELL': '/bin/bash', 12:18:50 INFO - 'SHLVL': '1', 12:18:50 INFO - 'TERM': 'linux', 12:18:50 INFO - 'TMOUT': '86400', 12:18:50 INFO - 'USER': 'cltbld', 12:18:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', 12:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:50 INFO - '_': '/tools/buildbot/bin/python'} 12:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:50 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 12:18:50 INFO - Cleaning up... 12:18:50 INFO - Return code: 0 12:18:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:18: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')]} 12:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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')]} 12:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:50 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 0x7f5f47655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f60>, '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 0x23f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f21d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', '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 12:18:50 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 12:18:50 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 12:18:50 INFO - Using env: {'DISPLAY': ':0', 12:18:50 INFO - 'HOME': '/home/cltbld', 12:18:50 INFO - 'LANG': 'en_US.UTF-8', 12:18:50 INFO - 'LANGUAGE': 'en_US:en', 12:18:50 INFO - 'LOGNAME': 'cltbld', 12:18:50 INFO - 'MAIL': '/var/mail/cltbld', 12:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:50 INFO - 'MOZ_NO_REMOTE': '1', 12:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:50 INFO - 'NO_EM_RESTART': '1', 12:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:50 INFO - 'PWD': '/builds/slave/test', 12:18:50 INFO - 'SHELL': '/bin/bash', 12:18:50 INFO - 'SHLVL': '1', 12:18:50 INFO - 'TERM': 'linux', 12:18:50 INFO - 'TMOUT': '86400', 12:18:50 INFO - 'USER': 'cltbld', 12:18:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', 12:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:50 INFO - '_': '/tools/buildbot/bin/python'} 12:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:50 INFO - Downloading/unpacking psutil>=3.1.1 12:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:18:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:18:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:18:52 INFO - Installing collected packages: psutil 12:18:52 INFO - Running setup.py install for psutil 12:18:52 INFO - building 'psutil._psutil_linux' extension 12:18:52 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 12:18:53 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 12:18:53 INFO - building 'psutil._psutil_posix' extension 12:18:53 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 12:18:53 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 12:18:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:18:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:18:53 INFO - Successfully installed psutil 12:18:53 INFO - Cleaning up... 12:18:53 INFO - Return code: 0 12:18:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:18:53 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')]} 12:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:53 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')]} 12:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:53 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 0x7f5f47655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f60>, '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 0x23f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f21d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', '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 12:18:53 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 12:18:53 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 12:18:53 INFO - Using env: {'DISPLAY': ':0', 12:18:53 INFO - 'HOME': '/home/cltbld', 12:18:53 INFO - 'LANG': 'en_US.UTF-8', 12:18:53 INFO - 'LANGUAGE': 'en_US:en', 12:18:53 INFO - 'LOGNAME': 'cltbld', 12:18:53 INFO - 'MAIL': '/var/mail/cltbld', 12:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:53 INFO - 'MOZ_NO_REMOTE': '1', 12:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:53 INFO - 'NO_EM_RESTART': '1', 12:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:53 INFO - 'PWD': '/builds/slave/test', 12:18:53 INFO - 'SHELL': '/bin/bash', 12:18:53 INFO - 'SHLVL': '1', 12:18:53 INFO - 'TERM': 'linux', 12:18:53 INFO - 'TMOUT': '86400', 12:18:53 INFO - 'USER': 'cltbld', 12:18:53 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', 12:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:53 INFO - '_': '/tools/buildbot/bin/python'} 12:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:18:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:18:55 INFO - Installing collected packages: mozsystemmonitor 12:18:55 INFO - Running setup.py install for mozsystemmonitor 12:18:55 INFO - Successfully installed mozsystemmonitor 12:18:55 INFO - Cleaning up... 12:18:55 INFO - Return code: 0 12:18:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:18:55 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')]} 12:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:55 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')]} 12:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:55 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 0x7f5f47655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f60>, '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 0x23f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f21d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', '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 12:18:55 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 12:18:55 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 12:18:55 INFO - Using env: {'DISPLAY': ':0', 12:18:55 INFO - 'HOME': '/home/cltbld', 12:18:55 INFO - 'LANG': 'en_US.UTF-8', 12:18:55 INFO - 'LANGUAGE': 'en_US:en', 12:18:55 INFO - 'LOGNAME': 'cltbld', 12:18:55 INFO - 'MAIL': '/var/mail/cltbld', 12:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:55 INFO - 'MOZ_NO_REMOTE': '1', 12:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:55 INFO - 'NO_EM_RESTART': '1', 12:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:55 INFO - 'PWD': '/builds/slave/test', 12:18:55 INFO - 'SHELL': '/bin/bash', 12:18:55 INFO - 'SHLVL': '1', 12:18:55 INFO - 'TERM': 'linux', 12:18:55 INFO - 'TMOUT': '86400', 12:18:55 INFO - 'USER': 'cltbld', 12:18:55 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', 12:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:55 INFO - '_': '/tools/buildbot/bin/python'} 12:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:55 INFO - Downloading/unpacking jsonschema==2.5.1 12:18: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 12:18: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 12:18: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 12:18: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 12:18: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 12:18: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 12:18:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:18:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:58 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 12:18:58 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 12:18:58 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 12:18:58 INFO - Downloading functools32-3.2.3-2.tar.gz 12:18:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:18:58 INFO - warning: no files found matching '*.txt' 12:18:58 INFO - no previously-included directories found matching 'build' 12:18:58 INFO - no previously-included directories found matching 'dist' 12:18:58 INFO - no previously-included directories found matching '.git*' 12:18:58 INFO - Installing collected packages: jsonschema, functools32 12:18:58 INFO - Running setup.py install for functools32 12:18:58 INFO - warning: no files found matching '*.txt' 12:18:58 INFO - no previously-included directories found matching 'build' 12:18:58 INFO - no previously-included directories found matching 'dist' 12:18:58 INFO - no previously-included directories found matching '.git*' 12:18:58 INFO - Successfully installed jsonschema functools32 12:18:58 INFO - Cleaning up... 12:18:58 INFO - Return code: 0 12:18:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:18: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')]} 12:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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')]} 12:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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', '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 0x7f5f47655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f60>, '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 0x23f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f21d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', '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 12:18: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:18: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 functools32==3.2.3-2 12:18:58 INFO - Using env: {'DISPLAY': ':0', 12:18:58 INFO - 'HOME': '/home/cltbld', 12:18:58 INFO - 'LANG': 'en_US.UTF-8', 12:18:58 INFO - 'LANGUAGE': 'en_US:en', 12:18:58 INFO - 'LOGNAME': 'cltbld', 12:18:58 INFO - 'MAIL': '/var/mail/cltbld', 12:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:58 INFO - 'MOZ_NO_REMOTE': '1', 12:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:58 INFO - 'NO_EM_RESTART': '1', 12:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:58 INFO - 'PWD': '/builds/slave/test', 12:18:58 INFO - 'SHELL': '/bin/bash', 12:18:58 INFO - 'SHLVL': '1', 12:18:58 INFO - 'TERM': 'linux', 12:18:58 INFO - 'TMOUT': '86400', 12:18:58 INFO - 'USER': 'cltbld', 12:18:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', 12:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:58 INFO - '_': '/tools/buildbot/bin/python'} 12:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:18:58 INFO - Cleaning up... 12:18:58 INFO - Return code: 0 12:18:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:18: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')]} 12:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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')]} 12:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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', '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 0x7f5f47655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f60>, '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 0x23f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f21d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', '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 12:18: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:18: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 blobuploader==1.2.4 12:18:58 INFO - Using env: {'DISPLAY': ':0', 12:18:58 INFO - 'HOME': '/home/cltbld', 12:18:58 INFO - 'LANG': 'en_US.UTF-8', 12:18:58 INFO - 'LANGUAGE': 'en_US:en', 12:18:58 INFO - 'LOGNAME': 'cltbld', 12:18:58 INFO - 'MAIL': '/var/mail/cltbld', 12:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:58 INFO - 'MOZ_NO_REMOTE': '1', 12:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:58 INFO - 'NO_EM_RESTART': '1', 12:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:58 INFO - 'PWD': '/builds/slave/test', 12:18:58 INFO - 'SHELL': '/bin/bash', 12:18:58 INFO - 'SHLVL': '1', 12:18:58 INFO - 'TERM': 'linux', 12:18:58 INFO - 'TMOUT': '86400', 12:18:58 INFO - 'USER': 'cltbld', 12:18:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', 12:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:58 INFO - '_': '/tools/buildbot/bin/python'} 12:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:58 INFO - Downloading/unpacking blobuploader==1.2.4 12:18:58 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 12:18:58 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 12:18:58 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 12:18:58 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 12:18:58 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 12:18:58 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 12:19:00 INFO - Downloading blobuploader-1.2.4.tar.gz 12:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:19:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:19:01 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 12:19:01 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 12:19:01 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 12:19:01 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 12:19:01 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 12:19:01 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 12:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:19:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:19:01 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 12:19:01 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 12:19:01 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 12:19:01 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 12:19:01 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 12:19:01 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 12:19:01 INFO - Downloading docopt-0.6.1.tar.gz 12:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:19:01 INFO - Installing collected packages: blobuploader, requests, docopt 12:19:01 INFO - Running setup.py install for blobuploader 12:19:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:19:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:19:01 INFO - Running setup.py install for requests 12:19:02 INFO - Running setup.py install for docopt 12:19:02 INFO - Successfully installed blobuploader requests docopt 12:19:02 INFO - Cleaning up... 12:19:02 INFO - Return code: 0 12:19:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:02 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 0x7f5f47655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f60>, '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 0x23f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f21d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', '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 12:19:02 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 12:19:02 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 12:19:02 INFO - Using env: {'DISPLAY': ':0', 12:19:02 INFO - 'HOME': '/home/cltbld', 12:19:02 INFO - 'LANG': 'en_US.UTF-8', 12:19:02 INFO - 'LANGUAGE': 'en_US:en', 12:19:02 INFO - 'LOGNAME': 'cltbld', 12:19:02 INFO - 'MAIL': '/var/mail/cltbld', 12:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:02 INFO - 'MOZ_NO_REMOTE': '1', 12:19:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:02 INFO - 'NO_EM_RESTART': '1', 12:19:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:02 INFO - 'PWD': '/builds/slave/test', 12:19:02 INFO - 'SHELL': '/bin/bash', 12:19:02 INFO - 'SHLVL': '1', 12:19:02 INFO - 'TERM': 'linux', 12:19:02 INFO - 'TMOUT': '86400', 12:19:02 INFO - 'USER': 'cltbld', 12:19:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', 12:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:02 INFO - '_': '/tools/buildbot/bin/python'} 12:19:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:02 INFO - Running setup.py (path:/tmp/pip-7Hkxth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:02 INFO - Running setup.py (path:/tmp/pip-mkN75T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:02 INFO - Running setup.py (path:/tmp/pip-qc0xYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:02 INFO - Running setup.py (path:/tmp/pip-_t0052-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:02 INFO - Running setup.py (path:/tmp/pip-N_ViE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:02 INFO - Running setup.py (path:/tmp/pip-Vuyhtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:03 INFO - Running setup.py (path:/tmp/pip-8XhehR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:03 INFO - Running setup.py (path:/tmp/pip-oT9nzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:03 INFO - Running setup.py (path:/tmp/pip-DkgDiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:03 INFO - Running setup.py (path:/tmp/pip-W1EMPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:03 INFO - Running setup.py (path:/tmp/pip-iifP8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:03 INFO - Running setup.py (path:/tmp/pip-gMJDJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:03 INFO - Running setup.py (path:/tmp/pip-oNJ9hY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:03 INFO - Running setup.py (path:/tmp/pip-fZgzTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:03 INFO - Running setup.py (path:/tmp/pip-SgcoiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:03 INFO - Running setup.py (path:/tmp/pip-dOk0DP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:03 INFO - Running setup.py (path:/tmp/pip-Mi2nQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:19:03 INFO - Running setup.py install for manifestparser 12:19:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:19:03 INFO - Running setup.py install for mozcrash 12:19:04 INFO - Running setup.py install for mozdebug 12:19:04 INFO - Running setup.py install for mozdevice 12:19:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Running setup.py install for mozfile 12:19:04 INFO - Running setup.py install for mozhttpd 12:19:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Running setup.py install for mozinfo 12:19:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Running setup.py install for mozInstall 12:19:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Running setup.py install for mozleak 12:19:04 INFO - Running setup.py install for mozlog 12:19:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Running setup.py install for moznetwork 12:19:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Running setup.py install for mozprocess 12:19:05 INFO - Running setup.py install for mozprofile 12:19:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Running setup.py install for mozrunner 12:19:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Running setup.py install for mozscreenshot 12:19:05 INFO - Running setup.py install for moztest 12:19:05 INFO - Running setup.py install for mozversion 12:19:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:19:05 INFO - Cleaning up... 12:19:05 INFO - Return code: 0 12:19:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:05 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 0x7f5f47655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f60>, '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 0x23f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f21d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', '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 12:19:05 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 12:19:05 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 12:19:05 INFO - Using env: {'DISPLAY': ':0', 12:19:05 INFO - 'HOME': '/home/cltbld', 12:19:05 INFO - 'LANG': 'en_US.UTF-8', 12:19:05 INFO - 'LANGUAGE': 'en_US:en', 12:19:05 INFO - 'LOGNAME': 'cltbld', 12:19:05 INFO - 'MAIL': '/var/mail/cltbld', 12:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:05 INFO - 'MOZ_NO_REMOTE': '1', 12:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:05 INFO - 'NO_EM_RESTART': '1', 12:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:05 INFO - 'PWD': '/builds/slave/test', 12:19:05 INFO - 'SHELL': '/bin/bash', 12:19:05 INFO - 'SHLVL': '1', 12:19:05 INFO - 'TERM': 'linux', 12:19:05 INFO - 'TMOUT': '86400', 12:19:05 INFO - 'USER': 'cltbld', 12:19:05 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', 12:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:05 INFO - '_': '/tools/buildbot/bin/python'} 12:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:05 INFO - Running setup.py (path:/tmp/pip-kvkggX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:05 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)) 12:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:05 INFO - Running setup.py (path:/tmp/pip-DlzTBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:06 INFO - Running setup.py (path:/tmp/pip-Q5jJVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:06 INFO - Running setup.py (path:/tmp/pip-SKgJGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:06 INFO - Running setup.py (path:/tmp/pip-VNaeaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:06 INFO - Running setup.py (path:/tmp/pip-Pip8QT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:06 INFO - Running setup.py (path:/tmp/pip-b326R4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:06 INFO - Running setup.py (path:/tmp/pip-v4dIPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:06 INFO - Running setup.py (path:/tmp/pip-l_zPI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:06 INFO - Running setup.py (path:/tmp/pip-_vAdHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:06 INFO - Running setup.py (path:/tmp/pip-L8YOsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:06 INFO - Running setup.py (path:/tmp/pip-OrX6gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:06 INFO - Running setup.py (path:/tmp/pip-RbimgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:06 INFO - Running setup.py (path:/tmp/pip-wT8gmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:06 INFO - Running setup.py (path:/tmp/pip-CpLjov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:06 INFO - Running setup.py (path:/tmp/pip-PO6iVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:07 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)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:07 INFO - Running setup.py (path:/tmp/pip-lIxoiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:07 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)) 12:19:07 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)) 12:19:07 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)) 12:19:07 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)) 12:19:07 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:19:07 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:19:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:09 INFO - Downloading blessings-1.6.tar.gz 12:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:19:09 INFO - Installing collected packages: blessings 12:19:09 INFO - Running setup.py install for blessings 12:19:09 INFO - Successfully installed blessings 12:19:09 INFO - Cleaning up... 12:19:09 INFO - Return code: 0 12:19:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:19:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:09 INFO - Reading from file tmpfile_stdout 12:19:09 INFO - Current package versions: 12:19:09 INFO - argparse == 1.2.1 12:19:09 INFO - blessings == 1.6 12:19:09 INFO - blobuploader == 1.2.4 12:19:09 INFO - docopt == 0.6.1 12:19:09 INFO - functools32 == 3.2.3-2 12:19:09 INFO - jsonschema == 2.5.1 12:19:09 INFO - manifestparser == 1.1 12:19:09 INFO - mozInstall == 1.12 12:19:09 INFO - mozcrash == 1.0 12:19:09 INFO - mozdebug == 0.1 12:19:09 INFO - mozdevice == 0.48 12:19:09 INFO - mozfile == 1.2 12:19:09 INFO - mozhttpd == 0.7 12:19:09 INFO - mozinfo == 0.9 12:19:09 INFO - mozleak == 0.1 12:19:09 INFO - mozlog == 3.4 12:19:09 INFO - moznetwork == 0.27 12:19:09 INFO - mozprocess == 0.23 12:19:09 INFO - mozprofile == 0.28 12:19:09 INFO - mozrunner == 6.13 12:19:09 INFO - mozscreenshot == 0.1 12:19:09 INFO - mozsystemmonitor == 0.3 12:19:09 INFO - moztest == 0.8 12:19:09 INFO - mozversion == 1.4 12:19:09 INFO - psutil == 3.1.1 12:19:09 INFO - requests == 1.2.3 12:19:09 INFO - wsgiref == 0.1.2 12:19:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:09 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 0x7f5f47655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f60>, '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 0x23f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f21d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', '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 12:19:09 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 12:19:09 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 12:19:09 INFO - Using env: {'DISPLAY': ':0', 12:19:09 INFO - 'HOME': '/home/cltbld', 12:19:09 INFO - 'LANG': 'en_US.UTF-8', 12:19:09 INFO - 'LANGUAGE': 'en_US:en', 12:19:09 INFO - 'LOGNAME': 'cltbld', 12:19:09 INFO - 'MAIL': '/var/mail/cltbld', 12:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:09 INFO - 'MOZ_NO_REMOTE': '1', 12:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:09 INFO - 'NO_EM_RESTART': '1', 12:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:09 INFO - 'PWD': '/builds/slave/test', 12:19:09 INFO - 'SHELL': '/bin/bash', 12:19:09 INFO - 'SHLVL': '1', 12:19:09 INFO - 'TERM': 'linux', 12:19:09 INFO - 'TMOUT': '86400', 12:19:09 INFO - 'USER': 'cltbld', 12:19:09 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', 12:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:09 INFO - '_': '/tools/buildbot/bin/python'} 12:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:09 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)) 12:19:09 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)) 12:19:09 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)) 12:19:09 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)) 12:19:09 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)) 12:19:09 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)) 12:19:09 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)) 12:19:09 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)) 12:19:09 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)) 12:19:09 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)) 12:19:09 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)) 12:19:09 INFO - Cleaning up... 12:19:09 INFO - Return code: 0 12:19:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:09 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 0x7f5f47655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f0f60>, '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 0x23f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f21d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', '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 12:19:09 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 12:19:09 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 12:19:09 INFO - Using env: {'DISPLAY': ':0', 12:19:09 INFO - 'HOME': '/home/cltbld', 12:19:09 INFO - 'LANG': 'en_US.UTF-8', 12:19:09 INFO - 'LANGUAGE': 'en_US:en', 12:19:09 INFO - 'LOGNAME': 'cltbld', 12:19:09 INFO - 'MAIL': '/var/mail/cltbld', 12:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:09 INFO - 'MOZ_NO_REMOTE': '1', 12:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:09 INFO - 'NO_EM_RESTART': '1', 12:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:09 INFO - 'PWD': '/builds/slave/test', 12:19:09 INFO - 'SHELL': '/bin/bash', 12:19:09 INFO - 'SHLVL': '1', 12:19:09 INFO - 'TERM': 'linux', 12:19:09 INFO - 'TMOUT': '86400', 12:19:09 INFO - 'USER': 'cltbld', 12:19:09 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', 12:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:09 INFO - '_': '/tools/buildbot/bin/python'} 12:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:19:10 INFO - Cleaning up... 12:19:10 INFO - Return code: 0 12:19:10 INFO - Running post-action listener: _resource_record_post_action 12:19:10 INFO - Running post-action listener: _start_resource_monitoring 12:19:10 INFO - Starting resource monitoring. 12:19:10 INFO - [mozharness: 2017-02-24 20:19:10.102566Z] Finished create-virtualenv step (success) 12:19:10 INFO - [mozharness: 2017-02-24 20:19:10.103031Z] Running install step. 12:19:10 INFO - Running pre-action listener: _resource_record_pre_action 12:19:10 INFO - Running main action method: install 12:19:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:10 INFO - Reading from file tmpfile_stdout 12:19:10 INFO - Detecting whether we're running mozinstall >=1.0... 12:19:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:19:10 INFO - Reading from file tmpfile_stdout 12:19:10 INFO - Output received: 12:19:10 INFO - Usage: mozinstall [options] installer 12:19:10 INFO - Options: 12:19:10 INFO - -h, --help show this help message and exit 12:19:10 INFO - -d DEST, --destination=DEST 12:19:10 INFO - Directory to install application into. [default: 12:19:10 INFO - "/builds/slave/test"] 12:19:10 INFO - --app=APP Application being installed. [default: firefox] 12:19:10 INFO - mkdir: /builds/slave/test/build/application 12:19:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:19:24 INFO - Reading from file tmpfile_stdout 12:19:24 INFO - Output received: 12:19:24 INFO - /builds/slave/test/build/application/firefox/firefox 12:19:24 INFO - Running post-action listener: _resource_record_post_action 12:19:24 INFO - [mozharness: 2017-02-24 20:19:24.035164Z] Finished install step (success) 12:19:24 INFO - [mozharness: 2017-02-24 20:19:24.035409Z] Running run-tests step. 12:19:24 INFO - Running pre-action listener: _resource_record_pre_action 12:19:24 INFO - Running main action method: run_tests 12:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:19:24 INFO - Python 2.7.3 12:19:24 INFO - Return code: 0 12:19:24 INFO - grabbing minidump binary from tooltool 12:19:24 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')]} 12:19:24 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 0x23f0f60>, '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 0x23f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f21d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:19:24 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 12:19:24 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 12:19:24 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 12:19:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:19:24 INFO - Return code: 0 12:19:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:19:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:19:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:19:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:19:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:19:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 12:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 12:19:24 INFO - Using env: {'DISPLAY': ':0', 12:19:24 INFO - 'HOME': '/home/cltbld', 12:19:24 INFO - 'LANG': 'en_US.UTF-8', 12:19:24 INFO - 'LANGUAGE': 'en_US:en', 12:19:24 INFO - 'LOGNAME': 'cltbld', 12:19:24 INFO - 'MAIL': '/var/mail/cltbld', 12:19:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:19:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:24 INFO - 'MOZ_NO_REMOTE': '1', 12:19:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:19:24 INFO - 'NO_EM_RESTART': '1', 12:19:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:24 INFO - 'PWD': '/builds/slave/test', 12:19:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:19:24 INFO - 'SHELL': '/bin/bash', 12:19:24 INFO - 'SHLVL': '1', 12:19:24 INFO - 'TERM': 'linux', 12:19:24 INFO - 'TMOUT': '86400', 12:19:24 INFO - 'USER': 'cltbld', 12:19:24 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958', 12:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:24 INFO - '_': '/tools/buildbot/bin/python'} 12:19:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 12:19:24 INFO - mozversion application_buildid: 20170224103424 12:19:24 INFO - mozversion application_changeset: b7bb31e5a851d6f8e142c39dc077e3774719eced 12:19:24 INFO - mozversion application_display_name: Firefox 12:19:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:19:24 INFO - mozversion application_name: Firefox 12:19:24 INFO - mozversion application_remotingname: firefox 12:19:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:19:24 INFO - mozversion application_vendor: Mozilla 12:19:24 INFO - mozversion application_version: 52.0 12:19:24 INFO - mozversion platform_buildid: 20170224103424 12:19:24 INFO - mozversion platform_changeset: b7bb31e5a851d6f8e142c39dc077e3774719eced 12:19:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:19:24 INFO - mozversion platform_version: 52.0 12:19:24 INFO - using testdate: 1487967564 12:19:24 INFO - actual date: 1487967564 12:19:24 INFO - starting webserver on 'localhost:33507' 12:19:24 INFO - SUITE-START | Running 2 tests 12:19:24 INFO - TEST-START | dromaeo_css 12:19:24 INFO - operating with platform_type : linux_ 12:19:24 INFO - Initialising browser for dromaeo_css test... 12:19:24 INFO - TEST-INFO | started process 10250 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvKZkB0/profile http://localhost:33507/getInfo.html) 12:19:28 INFO - PROCESS | 10250 | __metrics Screen width/height:1600/1200 12:19:28 INFO - PROCESS | 10250 | colorDepth:24 12:19:28 INFO - PROCESS | 10250 | Browser inner width/height: 1024/697 12:19:28 INFO - PROCESS | 10250 | __metrics 12:19:29 INFO - PROCESS | 10250 | 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" 12:19:29 INFO - PROCESS | 10250 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:19:29 INFO - PROCESS | 10250 | console.error: PushService: 12:19:29 INFO - PROCESS | 10250 | stateChangeProcessEnqueue: Error transitioning state 12:19:30 INFO - PROCESS | 10250 | UnknownError 12:19:30 INFO - TEST-INFO | 10250: exit 0 12:19:30 INFO - Browser initialized. 12:19:30 INFO - Running cycle 1/1 for dromaeo_css test... 12:19:30 INFO - TEST-INFO | started process 10342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvKZkB0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:19:42 INFO - PROCESS | 10342 | RSS: Main: 141541376 12:19:42 INFO - PROCESS | 10342 | 12:22:44 INFO - PROCESS | 10342 | Cycle 1(1): loaded http://localhost:33507/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33507/tests/dromaeo/cssquery-ext.html) 12:22:45 INFO - PROCESS | 10342 | RSS: Main: 239673344 12:22:45 INFO - PROCESS | 10342 | 12:25:47 INFO - PROCESS | 10342 | Cycle 1(1): loaded http://localhost:33507/tests/dromaeo/cssquery-ext.html (next: http://localhost:33507/tests/dromaeo/cssquery-jquery.html) 12:25:48 INFO - PROCESS | 10342 | RSS: Main: 235249664 12:25:48 INFO - PROCESS | 10342 | 12:28:50 INFO - PROCESS | 10342 | Cycle 1(1): loaded http://localhost:33507/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33507/tests/dromaeo/cssquery-mootools.html) 12:28:50 INFO - PROCESS | 10342 | RSS: Main: 173576192 12:28:50 INFO - PROCESS | 10342 | 12:31:52 INFO - PROCESS | 10342 | Cycle 1(1): loaded http://localhost:33507/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33507/tests/dromaeo/cssquery-prototype.html) 12:31:53 INFO - PROCESS | 10342 | RSS: Main: 218767360 12:31:53 INFO - PROCESS | 10342 | 12:34:55 INFO - PROCESS | 10342 | Cycle 1(1): loaded http://localhost:33507/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33507/tests/dromaeo/cssquery-yui.html) 12:34:56 INFO - PROCESS | 10342 | RSS: Main: 176619520 12:34:56 INFO - PROCESS | 10342 | 12:37:58 INFO - PROCESS | 10342 | Cycle 1(1): loaded http://localhost:33507/tests/dromaeo/cssquery-yui.html (next: http://localhost:33507/tests/dromaeo/cssquery-dojo.html) 12:37:59 INFO - PROCESS | 10342 | RSS: Main: 260751360 12:37:59 INFO - PROCESS | 10342 | 12:37:59 INFO - PROCESS | 10342 | __start_tp_report 12:37:59 INFO - PROCESS | 10342 | _x_x_mozilla_page_load 12:37:59 INFO - PROCESS | 10342 | _x_x_mozilla_page_load_details 12:37:59 INFO - PROCESS | 10342 | |i|pagename|runs| 12:37:59 INFO - PROCESS | 10342 | |0;dojo.html;3125.515545090511;3166.414213370528;3174.8730050797967;3182.5226216067585;3204.8557814898327;5579.804706835262;5659.405762394951;5660.1792740052715;5664.915026274604;5664.943350566493;5566.109422492402;5619.241402410673;5624.100143976954;5636.520895723858;5638.859028524289;5049.065922804284;5076.111680455924;5110.514501122406;5130.563902068328;5170.560502357304;5033.144365457881;5043.167877300241;5106.974465127669;5163.7159956202395;5167.250748641445;5028.647994640377;5044.697318160904;5062.2406639004075;5094.057599344114;5097.260897169908;5086.77109530072;5150.742462876841;5151.871203219912;5164.561012313958;5177.45636708144;4885.2427873679635;5082.186850103965;5088.847334579968;5102.6428150029515;5136.460671629462;5421.83734487966;5439.292891924064;5508.20131080991;5539.972300138514;5591.217229587861;5802.274715660543;5837.5913686041995;5916.674582897939;5917.437843404869;5934.317553481319;5824.621399609012;5896.115582662592;5946.881062378771;5950.7917222896995;5971.940280597182;5413;5564.360098588673;5630.183623374629;5652.349979752299;5675.290588676416;6189.412005859436;6195.721192546346;6200.782972596027;6220;6224.284207316126;5788.797392091256;5841.7371218295275;5928.82213533586;5968;5981.730822113015;5777.075667893117;5803;5848.3274423441;5873.823785286449;5912.793052243151;5834.358220595731;5835.649861008353;5836.328822185418;5839.795607153729;5844.1818145459665;5674.035413979634;5783.537317014629;5845.824625261249;5849.239598852122;5868.031774757203;4518.344839998247;4577.130345234395;4651.046535460223;4652.069586082797;4701.576858082789;4084.897877553085;4111.424400583921;4137.358709400048;4150.335946248586;4154.189932963103;5735.4551317624755;5740;5742.196092547047;5755.65466072037;5760.0207964646115;5715.31416230055;5775.768969241268;5957.314908785545;6037.275526936795;6058.545609079337;5705.74324155414;5767.538596912237;5781.739821708034;5789.2763404574425;5796.275465566804;5154.9484505155215;5232.058229518723;5244.816431424882;5250.553702935217;5254.605904557174;6063.181470501426;6133.907991380043;6338.271098823694;6339.429451349401;6343.207099112611;5846.239988801429;5923.911141332969;5939.2575928009;5995.850103747442;6010.338862725184;6171.938280617316;6180.969095154495;6189.226346706661;6199.907001394892;6229.221347331583;5627.155926611041;5858.326292476419;5869.589128760946;5869.911951320819;5870.207521984648;5660.094384898396;5903.380145084876;5914.467697907209;5931.555133364928;6039.577229593886;5856.882862342814;5901.557383196363;5906.143609176559;5906.232189815297;5909.054551271776;5867.970660146842;5868.119782032729;5878.147668588116;5879.882402351844;5881.411858814085;5592.217089607377;5601.131824567198;5630.268065151504;5654.519365853948;5669.177969194526;5817.127430885401;5819.447152520504;5826.300843898759;5830.970845145916;5854.2389489366105;5499.780008799603;5541.141123125922;5679.233303503974;5689.886202276014;5696.658200507983 12:37:59 INFO - PROCESS | 10342 | |1;ext.html;556.9832905012851;601.3715667127852;618.0358640520788;651.3876955661677;658.9571677840937;33699.83150084249;36126.27747445049;36192.457113143326;36225.63774362256;36243.45634815473;46401.76799116;47478.0504389912;47557;50373.24440133401;50404;9141.31440141987;9269.490178040205;9270.25837932967;9288.117628825285;9290.721278361627;8515.19105684959;8737.650493980265;9132.3150763693;9229.446233226028;9231.3076519261;8718;10777.461126943661;11075.335479871193;11090.279131856443;11431.142664300169;11109.055730262937;11154.330740155616;11168.497417616227;11174.385408802513;11176.608818691388;10984.725381865517;10993.395363255018;11023.779524409547;11036.061934735557;11053.557857685682;43367.34948975768;43593.782031089955;43699.781501092606;43823.56176438227;43866.56133438657;3683.226522430293;3770.5286839145106;3785.734998550103;3967.3850553164307;4245.172191422674;32244.355112897847;32358.35283294321;32786.836065819756;33050.669493305;34082.147946301295;4376.124775045004;4449.933251001237;4460.598546130831;4463.96084314828;4498.100379923995;251441;252922;253031;253742;253766.99999999817;62020.069698954554;62502;62580;62606.68696656488;62620.686896565225;39712;40533.797331013746;40590.18819623591;64295.67852160709;64778.67610661917;18802.905985469984;18999.335023274118;19055.61888762217;19065.42803715891;19065.90467047656;13186.406611702496;13198.60404187876;13219.66950826237;13219.933900330629;13222.73554528904;17911.835730677463;18242.361517346828;19635.116419761143;20164.69752953707;20391.38825835227;7149.96425017882;7162.785116446515;7254.202037775841;7399.556026638419;7547.320741133324;1006.5068116622803;1041.7864337810731;1074.1299547366657;1105.9668209953554;1120.8486854274568;33227.83386083054;33387.83306083454;33520.329593407994;33588.83205584005;33623.32753344919;1125.128025780027;1131.5021390588115;1146.2778449576713;1149.971250718722;1183.2308999150448;17020.829791702174;17186.140692965302;17473.38843140484;17566.824331756776;17589.20848561792;464928;468756;469759;470480;471348;59516;59999.40000600025;60226.69886650539;60248;60277.69861150666;1261.306281545165;1318.1695531814896;1364.836219653648;1400.215879107703;1401.466256659705;30300.848495757382;33729.49405758965;34204.31591368208;34276.657233427344;34415;50984.74507627438;51615;51629.48370516247;51749;51758;370582;373337;374273;374517;374583;29623.96316128925;30547.54178687366;30744;30761.230969225053;30852.228694281923;47980.5201947976;48980;49047;49063.50936490589;49467;41538.58461415347;42073.15853682848;42627.5737242636;43380.34929476123;43746.34380484359;41865.37201941913;42158.36762448627;42323.57676423196;43076.56923430726;43465;42807.35788963106;42885.5711442894;43796.78101609471;43903.560964389944;44208.115837682424;35088;37141.43177849838;37736;37976.43035354527;38623.806880965414;28738.85630571834;28926.710732892403;29134;29152;29265.41469170647 12:37:59 INFO - PROCESS | 10342 | |2;jquery.html;403.68310875962356;413.37580253816725;413.40676129753786;419.4672765587703;433.18561105122365;18268.45194644161;19700.802991970075;19742.111604977774;19784.208631654717;20262;12913.677158071054;13187.538436154737;18739.906300468512;19935.800641993577;20045.599088018233;5315.973420132894;5402.513773760351;5485.6434331768505;5490.972545137289;5521.972390138044;4080.0411903202726;4272.978635106836;5463.863403414906;5510.724463776815;5520.530754885839;5863.179154918314;6114.724837382306;6150.753969841201;6238.625682459045;6241.9375806241815;6171.105189747484;6204.16243807087;6614.470842332602;6682.565633233824;6733.293004234534;6010.819675409744;6015.27816661999;6022.608530445507;6024.457798798129;6026.186464827279;14302.427902883872;15549.222538873011;21683;22487.100515979342;22632.547349052926;2359.9410014749596;2419.2137555294426;2639.2082375287528;2738.904438224726;2962.7629789616994;10497.632582859564;10529.157667386591;10758.408287544182;11060.612878549213;11064.834027489595;1974.328728232408;1997.4207479830832;2011.5775687105725;2057.8887400803546;2057.9176832926664;75687.62156189239;77435;78887;81540.18459815385;84920.57539712323;10969.62879640045;11232;11628.6511404658;11660.12549058824;11712.88287117135;16486.75269870953;16530.09084500364;16534.586635334213;16540.338386464406;16563.337466501445;8564.61459234336;8622.137786221328;8628.827423451496;8815.294776417872;8977.461352318882;8032.759017229376;8116;8129.796755081052;8146.533623947627;8345.916540834514;4970.2296144097;4974.825881094144;4999.450060493343;5022.171341728574;5030.84907452777;1833.6791061564172;2039.316828862318;2042.8978551072685;2095.968560471594;2106.7682554918947;936.8501039833594;967.9564419601135;978.848278516831;1014.2038499777786;1072.4905669806778;19332;19389.418317450498;19518.121684523947;19947.700784488243;20316.187352505734;987.4914419074182;1047.8375851742992;1066.0565399621391;1067.8749288915003;1084.0081325587;10221.233407494468;11083.445827708581;11187.272827266203;11193.608223712132;11244;467538;470695;473873;476733;479963;88752;88800;89754;90204.5489772547;90604;996.7622687067579;1003.9698809035741;1019.6125472320471;1024.2410354000835;1028.9639862604922;16541.751873722144;16731.247093881047;16943.406980755615;17766.378176763752;17788.3774067907;38253.42619860649;40371.79814100911;42485.15029699327;42891;43440.78279608582;55145.1728224085;56935;57610.423895760505;61062;61992.69003654953;5694.886102277848;6534.607923524603;6714;8166.387520936072;8325.125861784667;11450.885491144982;13312.800307995194;13479.730405391641;13790.517331893336;14055.929720351332;8473.364497662824;11515.53937842477;11825.231359961575;11913.22564033335;12236.327002014974;11541.711457213636;11571.016463600688;11633.47649355764;11895.524179033087;12000.939995299968;11897.167198296036;11996.520139194683;12089.51641934348;12183.573574925189;12350.876491234972;7946.7615971520945;8255.669773209245;8319.084900661044;8432.957835210786;9254.907450925404;9511.048895110434;11917.284962902253;11924.642260732191;12021.338826364634;12069.939650301692 12:37:59 INFO - PROCESS | 10342 | |3;mootools.html;1473.3885437543418;1516.0145905161644;1645.6461860699956;1760.771099757033;1826.853851691864;8482;8996.595153218113;9004.639814407432;9007.189352958232;9018.233450156727;7832.1776213497615;8066.193380661931;8069.112397636255;8259.545724985139;8846.646134154642;2355.7879790818824;2456.8403053801444;2463.0763463701114;2474.072222916406;2477.690288713911;2465.4822487277693;2503.161440917295;2524.1417917907906;2534.721180670125;2535.784458321045;2455.8894849731714;2458.840175388603;2483.453640199153;2484.2671411933525;2488.203774792067;2392.0670938334065;2409.71083469983;2412.1316326122583;2413.4690368118986;2414.37226321156;2358.681577986967;2397.3407312988893;2398.1606437746823;2399.8560086394873;2400;8862.734117976472;8889.911100889038;8981.550922453851;8982.595783189772;8986.820263594756;5458.4541545845495;5601.215829783833;5607.663540187602;5607.915881261784;5609.1305847593685;3405.863765449379;3415.453527435623;3612.8916132516065;3626.5648122225502;3627.4740162676526;1178.6522975722182;1184.5676328140253;1218.4882349413178;1238.0686129637793;1248.1200753468784;12396.380180991004;12410.503579856795;12461.065420093439;12463.5014599415;12501.562445314461;4723.659471874835;4828.2998965150555;4830.855074347775;4901.803927842918;4944.159492886218;10252.38485690861;10265.948670256601;10277.434741089312;10303.278770485995;10341.63804266847;5492.231087647732;5580.469855363734;5584;5585.3297604287745;5587.525060369833;4480.059187570581;4962.454130045692;5069.493050694901;5076.390833100052;5081.771320290596;3834.386498160281;4025.5571887092397;4153.937690934638;4170.457840480779;4218.050938538866;1264.5700461843016;1322.6362750243568;1324.529791923853;1333.839939207282;1337.358068127285;923.8244733500613;945.1304799584399;960.865478832964;972.3145182646359;993.7316924430363;5660.632058916157;6149.41580549847;6152.938470615326;6188.690565471708;6198.380161983856;999.160705007797;1003.0771690045176;1005.5575546759402;1023.9948800255951;1024.329064462778;3886.436466712311;4125.793710314472;4132.483439570054;4180.832766689298;4241.830326786894;10776.084032857138;10824.242303038869;10950.233483656068;11151.553937842558;11180.944095279472;10843.45782710877;11059.72350691223;11065.67211934573;11078.335299882034;11086.667399978014;8408.117147699526;8503.107173746668;8522.36082293818;8524.616392262364;8540.718892166225;5952.404759524013;5960.731767070405;6006.399360063959;6035.456808887221;6062.242219722535;9795.118439340493;9982.800343993225;9986.800263994824;10044.899551004397;10152.949235253776;10373;10452.007059329351;10496;10503.632372867218;10504.369737815756;7335.559866408033;7454.4781865268915;7456.291652293024;7459.067616547932;7472.439567032603;8223.506589604644;8366.205210504992;8465.746027619181;8652.178043085896;8669.479831210148;7337.963310183415;7339.2660733928315;7363.190049094703;7545.094588649397;7637.427192960439;7444.255574442513;7549.433792465477;7553.169151393452;7660.080790304976;7700.3454706350585;7138.928610713826;7164;7216.9278307216255;7222.819429514304;7229.09636295463;5223.2948551945;5252.185911183773;5311.893762124659;5436.673799572039;5493.478119578634;5261.316028916216;5270.920936186037;5285.973570132279;5318.1490961447535;5354.9464505354445 12:37:59 INFO - PROCESS | 10342 | |4;prototype.html;337.28663875902475;350.59681366428606;357.4691582999244;357.6905976330474;361.1530959899036;5538.532288943428;5577.247071645326;5588.776448942048;5610.13042978339;5619.157126431038;5203.375594928604;5248.212768084789;5258.947410525893;5346.492083252095;5448.3110235826825;4246.171996460676;4255.17024180285;4276.294411422112;4285.528591854893;4291.463567054118;4236.1104168124575;4239.915201695964;4253.2131555662145;4291.549387314334;4306.354046892975;4085.937656209392;4188;4199.866036170232;4227.344761561947;4232.132412855372;4195.6573896353175;4216.304309788897;4231.873043808675;4240.9151816963795;4246.171996460692;3784.9810750946344;3785.2240290740333;3798.1833905710405;3799.1831756172555;3799.8670046548236;5067.695938243681;5321.467853214686;5356.732163391854;5367.624266301361;5399.325084364455;4848.539388758062;4852.708837469763;4859.927101093451;4872.439669437989;4880.829170978998;5667.263255776723;5678.006348888928;5690;5691.402402747734;5700.800471983461;4054.736442131252;4082.632563069308;4108.98659656769;4161.9583804161875;4173.561776013536;5813.476787089182;5819.418058194189;5871.854988277288;5901.527877769769;5912.556558258148;4199.202151591188;4199.895002624898;4201.222773786859;4211.768352740567;4259.829606815692;4195.797206466629;4242.639375653042;4275.38006988991;4306.89232769177;4311.417958575615;4844.733539655353;4845.95154048455;4865.513448655106;4880.511948805091;4904.239842824368;5719.768330893032;5732.484076433057;5758.62568933018;5772.740226689809;5778.075507918713;1419.3754747910887;1434.651427657998;1437.9071905351798;1447.4282658349894;1461.9634509137356;964.5177411294353;986.2208855004609;992.4640694025289;992.8014397120605;996.4868092932146;5333.4666033634485;5348.839534813962;5357.437469065692;5378.2739330189925;5405.972970135203;5720.283914825535;5725.713714314267;5727.11229759388;5734.856628584235;5750.568707346965;5126.6923984561045;5311.229871668586;5355.598330125256;5378.51593356592;5378.515933565998;2997.985010074936;3009.6689364169924;3016.75865930725;3017.17027817352;3022.410629927187;5896.734646940898;5903.527717782567;5921.61509501881;5941.58408911372;5998.700064996733;5661.547076233891;5998.25021872266;6009.729562169713;6009.819705408845;6015.969920150459;6110.816675499742;6162.397776578122;6169.167162433104;6185.288691800501;6215.627062376362;5618.325800903917;5875.823725288248;5888.646681199141;5917.940820591739;5963.761449542143;5804.6201057566195;5805.809808989063;5832.475077243069;5851.912221316598;5862.589618726648;5823.330317013429;6112.847178820565;6153.2616086068165;6162.599431036968;6179.969100154471;4035.8699564122094;4124.7525148489985;4153.210889930903;4174.165166966558;4189.2459357315975;5654.434556544313;5781.277340332458;5872.916718722705;5945.316288626863;5958.553108516965;5824.417558244142;5826.70866456684;5831.154482599914;5831.754774411797;5833;5593.692346920959;5710.2291190690385;5748.54011679073;5802.47777700009;5819.82540523785;5655.321361436654;5671.120976248688;5672.12082127271;5677.261955945701;5706;5758.827235182951;5765.625234359753;5775.595708300379;5779.543693930147;5798.7089553730775;5409.323834520685;5552.7778888845605;5601.887962240651;5640.915386269127;5646.209530665792 12:37:59 INFO - PROCESS | 10342 | |5;yui.html;697.9197392299884;756.398663062865;762.1692355332686;824.9876251856227;840.4369072721274;14278.643033924158;15504.612384690388;15507.767383489228;15507.767383489243;15508;13708.794368084487;13795.655108622264;13801.51694690686;13826.585202443917;13856.584302470917;700.1493185779265;711.9679614417338;819.6311659753105;844.3498506150261;845.247729520727;846.5259454705384;847.7753395350237;847.9824210946888;848.3891598049395;850.8000619854329;887.786931136529;897.4032268541412;899.3120262998812;899.4872922434215;899.5502248875562;886.3219636977717;886.822635472908;887.4542156573693;887.8446271902424;888.3692578269437;661.4179522020592;661.7187695229508;662.2781168526282;662.3475876261926;662.536224642752;13792.724145517133;13959.232242226673;13959.511417100453;13964.092333998258;14366.784498232535;14404.567862964128;14916;15020.699586008328;15144.394224231017;15190.924045379703;11248.718782030433;11482.598109066143;11749.29504229749;11779.057675385948;12010;4073.8166782494563;4075.735077219971;4161.56303588125;4178.331466965271;4192.014876504019;65374.34625653778;65982.67008664974;66589.66705166444;67577;68498;10968.396738179477;11093.778124437466;11175.385353805455;11241.83137252942;11282.210245282915;19203.807961920204;19211.23155073809;19284.421467356;19290.71063934042;19290.903545482182;8225.95887020561;8342.374321925758;8359.58202089893;8434.831303374021;8592.742217733477;4070.1859628074503;4237.300845360481;4283.6144746972295;4309.892252693708;4389.517153113155;3329.500574913782;3430.519727238189;3433.1931995980926;3448.810315432625;3453.1194545391268;571.8598943258928;590.9852253693692;594.7323704333068;596.7463827873137;607.2925042325642;663.5521023309246;679.1748026148254;681.5910453727723;682.8566001139717;689.3175756001523;8783.91216087831;8873.467591944504;8943.463392196489;9199.448033118035;9240.491772952417;589.9174115623816;599.4814485470037;619.603453789575;625.8185126313409;706.2231545300128;4381.5618438155925;4499.702783841423;4613.169629466728;4696.342512048248;4881.902361952741;78564.21435785569;83562.58218708867;86661.56669216613;87269.25461490735;87320;75148.62425687946;77750.2224977743;78167.60916195497;79688.60155699184;79840.20159798444;69473.30526694769;69937.65031174812;72858;72988.63505682438;74750;9645.951770241103;9819.527070939415;9991.850122248026;10055.698329049848;10078.899211008089;32493.83753081314;32764.18089547685;35407.11482212862;39705.60294397019;47095;40342.59657403389;41438;56126.158107629235;60696.696516517135;61043;11662.183647144619;11852.822207667065;12038.217515861441;12190;12248.938755306166;13054.347282635641;13095.214287142802;13181.670458238621;13926.442942282196;14044.087134336236;12923.935380323039;13457.387420915518;13898;14345.784813227601;14476.348564314421;12642.620721378373;12955.740885182055;13000.479980800663;13217.14088584239;13417.932910335387;12683.492660293854;13057.28184949799;13061.477540898257;13123.081384303006;13280.136791108547;10199.643012494527;10262.486875656037;10311.587536498457;10356.430396328275;10512.842307365549;11164.274322169033;11450.768451275375;11505.94247028793;11766.235194712317;11770.3526306054 12:37:59 INFO - PROCESS | 10342 | __end_tp_report 12:37:59 INFO - PROCESS | 10342 | __start_cc_report 12:37:59 INFO - PROCESS | 10342 | _x_x_mozilla_cycle_collect,1025 12:37:59 INFO - PROCESS | 10342 | __end_cc_report 12:37:59 INFO - PROCESS | 10342 | __startTimestamp1487968679013__endTimestamp 12:37:59 INFO - PROCESS | 10342 | 12:37:59 INFO - PROCESS | 10342 | ------- Summary: start ------- 12:37:59 INFO - PROCESS | 10342 | Number of tests: 6 12:37:59 INFO - PROCESS | 10342 | 12:37:59 INFO - PROCESS | 10342 | [#0] dojo.html Cycles:165 Average:5537.41 Median:5742.20 stddev:620.48 (10.8%) stddev-sans-first:592.84 12:37:59 INFO - PROCESS | 10342 | Values: 3125.5 3166.4 3174.9 3182.5 3204.9 5579.8 5659.4 5660.2 5664.9 5664.9 5566.1 5619.2 5624.1 5636.5 5638.9 5049.1 5076.1 5110.5 5130.6 5170.6 5033.1 5043.2 5107.0 5163.7 5167.3 5028.6 5044.7 5062.2 5094.1 5097.3 5086.8 5150.7 5151.9 5164.6 5177.5 4885.2 5082.2 5088.8 5102.6 5136.5 5421.8 5439.3 5508.2 5540.0 5591.2 5802.3 5837.6 5916.7 5917.4 5934.3 5824.6 5896.1 5946.9 5950.8 5971.9 5413.0 5564.4 5630.2 5652.3 5675.3 6189.4 6195.7 6200.8 6220.0 6224.3 5788.8 5841.7 5928.8 5968.0 5981.7 5777.1 5803.0 5848.3 5873.8 5912.8 5834.4 5835.6 5836.3 5839.8 5844.2 5674.0 5783.5 5845.8 5849.2 5868.0 4518.3 4577.1 4651.0 4652.1 4701.6 4084.9 4111.4 4137.4 4150.3 4154.2 5735.5 5740.0 5742.2 5755.7 5760.0 5715.3 5775.8 5957.3 6037.3 6058.5 5705.7 5767.5 5781.7 5789.3 5796.3 5154.9 5232.1 5244.8 5250.6 5254.6 6063.2 6133.9 6338.3 6339.4 6343.2 5846.2 5923.9 5939.3 5995.9 6010.3 6171.9 6181.0 6189.2 6199.9 6229.2 5627.2 5858.3 5869.6 5869.9 5870.2 5660.1 5903.4 5914.5 5931.6 6039.6 5856.9 5901.6 5906.1 5906.2 5909.1 5868.0 5868.1 5878.1 5879.9 5881.4 5592.2 5601.1 5630.3 5654.5 5669.2 5817.1 5819.4 5826.3 5831.0 5854.2 5499.8 5541.1 5679.2 5689.9 5696.7 12:37:59 INFO - PROCESS | 10342 | 12:37:59 INFO - PROCESS | 10342 | [#1] ext.html Cycles:180 Average:54481.60 Median:374550.00 stddev:99046.92 (26.4%) stddev-sans-first:99242.02 12:37:59 INFO - PROCESS | 10342 | Values: 557.0 601.4 618.0 651.4 659.0 33699.8 36126.3 36192.5 36225.6 36243.5 46401.8 47478.1 47557.0 50373.2 50404.0 9141.3 9269.5 9270.3 9288.1 9290.7 8515.2 8737.7 9132.3 9229.4 9231.3 8718.0 10777.5 11075.3 11090.3 11431.1 11109.1 11154.3 11168.5 11174.4 11176.6 10984.7 10993.4 11023.8 11036.1 11053.6 43367.3 43593.8 43699.8 43823.6 43866.6 3683.2 3770.5 3785.7 3967.4 4245.2 32244.4 32358.4 32786.8 33050.7 34082.1 4376.1 4449.9 4460.6 4464.0 4498.1 251441.0 252922.0 253031.0 253742.0 253767.0 62020.1 62502.0 62580.0 62606.7 62620.7 39712.0 40533.8 40590.2 64295.7 64778.7 18802.9 18999.3 19055.6 19065.4 19065.9 13186.4 13198.6 13219.7 13219.9 13222.7 17911.8 18242.4 19635.1 20164.7 20391.4 7150.0 7162.8 7254.2 7399.6 7547.3 1006.5 1041.8 1074.1 1106.0 1120.8 33227.8 33387.8 33520.3 33588.8 33623.3 1125.1 1131.5 1146.3 1150.0 1183.2 17020.8 17186.1 17473.4 17566.8 17589.2 464928.0 468756.0 469759.0 470480.0 471348.0 59516.0 59999.4 60226.7 60248.0 60277.7 1261.3 1318.2 1364.8 1400.2 1401.5 30300.8 33729.5 34204.3 34276.7 34415.0 50984.7 51615.0 51629.5 51749.0 51758.0 370582.0 373337.0 374273.0 374517.0 374583.0 29624.0 30547.5 30744.0 30761.2 30852.2 47980.5 48980.0 49047.0 49063.5 49467.0 41538.6 42073.2 42627.6 43380.3 43746.3 41865.4 42158.4 42323.6 43076.6 43465.0 42807.4 42885.6 43796.8 43903.6 44208.1 35088.0 37141.4 37736.0 37976.4 38623.8 28738.9 28926.7 29134.0 29152.0 29265.4 12:37:59 INFO - PROCESS | 10342 | 12:37:59 INFO - PROCESS | 10342 | [#2] jquery.html Cycles:180 Average:28385.33 Median:2689.06 stddev:78143.09 (2906.0%) stddev-sans-first:78334.05 12:37:59 INFO - PROCESS | 10342 | Values: 403.7 413.4 413.4 419.5 433.2 18268.5 19700.8 19742.1 19784.2 20262.0 12913.7 13187.5 18739.9 19935.8 20045.6 5316.0 5402.5 5485.6 5491.0 5522.0 4080.0 4273.0 5463.9 5510.7 5520.5 5863.2 6114.7 6150.8 6238.6 6241.9 6171.1 6204.2 6614.5 6682.6 6733.3 6010.8 6015.3 6022.6 6024.5 6026.2 14302.4 15549.2 21683.0 22487.1 22632.5 2359.9 2419.2 2639.2 2738.9 2962.8 10497.6 10529.2 10758.4 11060.6 11064.8 1974.3 1997.4 2011.6 2057.9 2057.9 75687.6 77435.0 78887.0 81540.2 84920.6 10969.6 11232.0 11628.7 11660.1 11712.9 16486.8 16530.1 16534.6 16540.3 16563.3 8564.6 8622.1 8628.8 8815.3 8977.5 8032.8 8116.0 8129.8 8146.5 8345.9 4970.2 4974.8 4999.5 5022.2 5030.8 1833.7 2039.3 2042.9 2096.0 2106.8 936.9 968.0 978.8 1014.2 1072.5 19332.0 19389.4 19518.1 19947.7 20316.2 987.5 1047.8 1066.1 1067.9 1084.0 10221.2 11083.4 11187.3 11193.6 11244.0 467538.0 470695.0 473873.0 476733.0 479963.0 88752.0 88800.0 89754.0 90204.5 90604.0 996.8 1004.0 1019.6 1024.2 1029.0 16541.8 16731.2 16943.4 17766.4 17788.4 38253.4 40371.8 42485.2 42891.0 43440.8 55145.2 56935.0 57610.4 61062.0 61992.7 5694.9 6534.6 6714.0 8166.4 8325.1 11450.9 13312.8 13479.7 13790.5 14055.9 8473.4 11515.5 11825.2 11913.2 12236.3 11541.7 11571.0 11633.5 11895.5 12000.9 11897.2 11996.5 12089.5 12183.6 12350.9 7946.8 8255.7 8319.1 8433.0 9254.9 9511.0 11917.3 11924.6 12021.3 12069.9 12:37:59 INFO - PROCESS | 10342 | 12:37:59 INFO - PROCESS | 10342 | [#3] mootools.html Cycles:180 Average:5878.63 Median:4922.98 stddev:3268.97 (66.4%) stddev-sans-first:3261.37 12:37:59 INFO - PROCESS | 10342 | Values: 1473.4 1516.0 1645.6 1760.8 1826.9 8482.0 8996.6 9004.6 9007.2 9018.2 7832.2 8066.2 8069.1 8259.5 8846.6 2355.8 2456.8 2463.1 2474.1 2477.7 2465.5 2503.2 2524.1 2534.7 2535.8 2455.9 2458.8 2483.5 2484.3 2488.2 2392.1 2409.7 2412.1 2413.5 2414.4 2358.7 2397.3 2398.2 2399.9 2400.0 8862.7 8889.9 8981.6 8982.6 8986.8 5458.5 5601.2 5607.7 5607.9 5609.1 3405.9 3415.5 3612.9 3626.6 3627.5 1178.7 1184.6 1218.5 1238.1 1248.1 12396.4 12410.5 12461.1 12463.5 12501.6 4723.7 4828.3 4830.9 4901.8 4944.2 10252.4 10265.9 10277.4 10303.3 10341.6 5492.2 5580.5 5584.0 5585.3 5587.5 4480.1 4962.5 5069.5 5076.4 5081.8 3834.4 4025.6 4153.9 4170.5 4218.1 1264.6 1322.6 1324.5 1333.8 1337.4 923.8 945.1 960.9 972.3 993.7 5660.6 6149.4 6152.9 6188.7 6198.4 999.2 1003.1 1005.6 1024.0 1024.3 3886.4 4125.8 4132.5 4180.8 4241.8 10776.1 10824.2 10950.2 11151.6 11180.9 10843.5 11059.7 11065.7 11078.3 11086.7 8408.1 8503.1 8522.4 8524.6 8540.7 5952.4 5960.7 6006.4 6035.5 6062.2 9795.1 9982.8 9986.8 10044.9 10152.9 10373.0 10452.0 10496.0 10503.6 10504.4 7335.6 7454.5 7456.3 7459.1 7472.4 8223.5 8366.2 8465.7 8652.2 8669.5 7338.0 7339.3 7363.2 7545.1 7637.4 7444.3 7549.4 7553.2 7660.1 7700.3 7138.9 7164.0 7216.9 7222.8 7229.1 5223.3 5252.2 5311.9 5436.7 5493.5 5261.3 5270.9 5286.0 5318.1 5354.9 12:37:59 INFO - PROCESS | 10342 | 12:37:59 INFO - PROCESS | 10342 | [#4] prototype.html Cycles:180 Average:4809.37 Median:5493.42 stddev:1415.84 (25.8%) stddev-sans-first:1379.45 12:37:59 INFO - PROCESS | 10342 | Values: 337.3 350.6 357.5 357.7 361.2 5538.5 5577.2 5588.8 5610.1 5619.2 5203.4 5248.2 5258.9 5346.5 5448.3 4246.2 4255.2 4276.3 4285.5 4291.5 4236.1 4239.9 4253.2 4291.5 4306.4 4085.9 4188.0 4199.9 4227.3 4232.1 4195.7 4216.3 4231.9 4240.9 4246.2 3785.0 3785.2 3798.2 3799.2 3799.9 5067.7 5321.5 5356.7 5367.6 5399.3 4848.5 4852.7 4859.9 4872.4 4880.8 5667.3 5678.0 5690.0 5691.4 5700.8 4054.7 4082.6 4109.0 4162.0 4173.6 5813.5 5819.4 5871.9 5901.5 5912.6 4199.2 4199.9 4201.2 4211.8 4259.8 4195.8 4242.6 4275.4 4306.9 4311.4 4844.7 4846.0 4865.5 4880.5 4904.2 5719.8 5732.5 5758.6 5772.7 5778.1 1419.4 1434.7 1437.9 1447.4 1462.0 964.5 986.2 992.5 992.8 996.5 5333.5 5348.8 5357.4 5378.3 5406.0 5720.3 5725.7 5727.1 5734.9 5750.6 5126.7 5311.2 5355.6 5378.5 5378.5 2998.0 3009.7 3016.8 3017.2 3022.4 5896.7 5903.5 5921.6 5941.6 5998.7 5661.5 5998.3 6009.7 6009.8 6016.0 6110.8 6162.4 6169.2 6185.3 6215.6 5618.3 5875.8 5888.6 5917.9 5963.8 5804.6 5805.8 5832.5 5851.9 5862.6 5823.3 6112.8 6153.3 6162.6 6180.0 4035.9 4124.8 4153.2 4174.2 4189.2 5654.4 5781.3 5872.9 5945.3 5958.6 5824.4 5826.7 5831.2 5831.8 5833.0 5593.7 5710.2 5748.5 5802.5 5819.8 5655.3 5671.1 5672.1 5677.3 5706.0 5758.8 5765.6 5775.6 5779.5 5798.7 5409.3 5552.8 5601.9 5640.9 5646.2 12:37:59 INFO - PROCESS | 10342 | 12:37:59 INFO - PROCESS | 10342 | [#5] yui.html Cycles:180 Average:17467.11 Median:4296.75 stddev:23077.57 (537.1%) stddev-sans-first:23107.95 12:37:59 INFO - PROCESS | 10342 | Values: 697.9 756.4 762.2 825.0 840.4 14278.6 15504.6 15507.8 15507.8 15508.0 13708.8 13795.7 13801.5 13826.6 13856.6 700.1 712.0 819.6 844.3 845.2 846.5 847.8 848.0 848.4 850.8 887.8 897.4 899.3 899.5 899.6 886.3 886.8 887.5 887.8 888.4 661.4 661.7 662.3 662.3 662.5 13792.7 13959.2 13959.5 13964.1 14366.8 14404.6 14916.0 15020.7 15144.4 15190.9 11248.7 11482.6 11749.3 11779.1 12010.0 4073.8 4075.7 4161.6 4178.3 4192.0 65374.3 65982.7 66589.7 67577.0 68498.0 10968.4 11093.8 11175.4 11241.8 11282.2 19203.8 19211.2 19284.4 19290.7 19290.9 8226.0 8342.4 8359.6 8434.8 8592.7 4070.2 4237.3 4283.6 4309.9 4389.5 3329.5 3430.5 3433.2 3448.8 3453.1 571.9 591.0 594.7 596.7 607.3 663.6 679.2 681.6 682.9 689.3 8783.9 8873.5 8943.5 9199.4 9240.5 589.9 599.5 619.6 625.8 706.2 4381.6 4499.7 4613.2 4696.3 4881.9 78564.2 83562.6 86661.6 87269.3 87320.0 75148.6 77750.2 78167.6 79688.6 79840.2 69473.3 69937.7 72858.0 72988.6 74750.0 9646.0 9819.5 9991.9 10055.7 10078.9 32493.8 32764.2 35407.1 39705.6 47095.0 40342.6 41438.0 56126.2 60696.7 61043.0 11662.2 11852.8 12038.2 12190.0 12248.9 13054.3 13095.2 13181.7 13926.4 14044.1 12923.9 13457.4 13898.0 14345.8 14476.3 12642.6 12955.7 13000.5 13217.1 13417.9 12683.5 13057.3 13061.5 13123.1 13280.1 10199.6 10262.5 10311.6 10356.4 10512.8 11164.3 11450.8 11505.9 11766.2 11770.4 12:37:59 INFO - PROCESS | 10342 | -------- Summary: end -------- 12:37:59 INFO - PROCESS | 10342 | 12:37:59 INFO - TEST-INFO | 10342: exit 0 12:37:59 INFO - TEST-OK | dromaeo_css | took 1115445ms 12:37:59 INFO - TEST-START | kraken 12:37:59 INFO - operating with platform_type : linux_ 12:37:59 INFO - Initialising browser for kraken test... 12:37:59 INFO - TEST-INFO | started process 10647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZskTNJ/profile http://localhost:33507/getInfo.html) 12:38:03 INFO - PROCESS | 10647 | __metrics Screen width/height:1600/1200 12:38:03 INFO - PROCESS | 10647 | colorDepth:24 12:38:03 INFO - PROCESS | 10647 | Browser inner width/height: 1024/697 12:38:03 INFO - PROCESS | 10647 | __metrics 12:38:04 INFO - PROCESS | 10647 | 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" 12:38:04 INFO - PROCESS | 10647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:38:05 INFO - PROCESS | 10647 | console.error: PushService: 12:38:05 INFO - PROCESS | 10647 | stateChangeProcessEnqueue: Error transitioning state 12:38:05 INFO - PROCESS | 10647 | UnknownError 12:38:05 INFO - TEST-INFO | 10647: exit 0 12:38:05 INFO - Browser initialized. 12:38:05 INFO - Running cycle 1/1 for kraken test... 12:38:05 INFO - TEST-INFO | started process 10740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZskTNJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:38:17 INFO - PROCESS | 10740 | RSS: Main: 141017088 12:38:17 INFO - PROCESS | 10740 | 12:38:20 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:33507/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33507/tests/kraken/driver.html?testName=audio-beat-detection) 12:38:21 INFO - PROCESS | 10740 | RSS: Main: 182906880 12:38:21 INFO - PROCESS | 10740 | 12:38:23 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:33507/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33507/tests/kraken/driver.html?testName=audio-dft) 12:38:24 INFO - PROCESS | 10740 | RSS: Main: 172388352 12:38:24 INFO - PROCESS | 10740 | 12:38:26 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:33507/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33507/tests/kraken/driver.html?testName=audio-fft) 12:38:27 INFO - PROCESS | 10740 | RSS: Main: 263622656 12:38:27 INFO - PROCESS | 10740 | 12:38:29 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:33507/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33507/tests/kraken/driver.html?testName=audio-oscillator) 12:38:30 INFO - PROCESS | 10740 | RSS: Main: 170536960 12:38:30 INFO - PROCESS | 10740 | 12:38:32 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:33507/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33507/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:38:32 INFO - PROCESS | 10740 | RSS: Main: 173121536 12:38:32 INFO - PROCESS | 10740 | 12:38:35 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:33507/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33507/tests/kraken/driver.html?testName=imaging-darkroom) 12:38:36 INFO - PROCESS | 10740 | RSS: Main: 211296256 12:38:36 INFO - PROCESS | 10740 | 12:38:39 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:33507/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33507/tests/kraken/driver.html?testName=imaging-desaturate) 12:38:40 INFO - PROCESS | 10740 | RSS: Main: 210022400 12:38:40 INFO - PROCESS | 10740 | 12:38:42 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:33507/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33507/tests/kraken/driver.html?testName=json-parse-financial) 12:38:43 INFO - PROCESS | 10740 | RSS: Main: 208642048 12:38:43 INFO - PROCESS | 10740 | 12:38:45 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:33507/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33507/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:38:45 INFO - PROCESS | 10740 | RSS: Main: 171769856 12:38:45 INFO - PROCESS | 10740 | 12:38:47 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:33507/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33507/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:38:47 INFO - PROCESS | 10740 | RSS: Main: 178069504 12:38:47 INFO - PROCESS | 10740 | 12:38:49 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:33507/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33507/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:38:50 INFO - PROCESS | 10740 | RSS: Main: 187334656 12:38:50 INFO - PROCESS | 10740 | 12:38:53 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:33507/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33507/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:38:53 INFO - PROCESS | 10740 | RSS: Main: 195096576 12:38:53 INFO - PROCESS | 10740 | 12:38:56 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:33507/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33507/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:38:57 INFO - PROCESS | 10740 | RSS: Main: 192647168 12:38:57 INFO - PROCESS | 10740 | 12:38:58 INFO - PROCESS | 10740 | Cycle 1(1): loaded http://localhost:33507/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33507/tests/kraken/driver.html?testName=ai-astar) 12:38:58 INFO - PROCESS | 10740 | RSS: Main: 244191232 12:38:58 INFO - PROCESS | 10740 | 12:38:58 INFO - PROCESS | 10740 | __start_tp_report 12:38:58 INFO - PROCESS | 10740 | _x_x_mozilla_page_load 12:38:58 INFO - PROCESS | 10740 | _x_x_mozilla_page_load_details 12:38:58 INFO - PROCESS | 10740 | |i|pagename|runs| 12:38:58 INFO - PROCESS | 10740 | |0;ai-astar;100;111;112;112;114;113;111;111;110;112 12:38:58 INFO - PROCESS | 10740 | |1;audio-beat-detection;148;119;116;151;119;120;120;120;160;120 12:38:58 INFO - PROCESS | 10740 | |2;audio-dft;161;160;159;162;162;161;160;161;160;161 12:38:58 INFO - PROCESS | 10740 | |3;audio-fft;74;75;77;109;75;76;78;76;98;74 12:38:58 INFO - PROCESS | 10740 | |4;audio-oscillator;81;83;111;82;82;83;110;82;82;107 12:38:58 INFO - PROCESS | 10740 | |5;imaging-gaussian-blur;116;117;117;117;117;116;118;117;116;116 12:38:58 INFO - PROCESS | 10740 | |6;imaging-darkroom;145;146;145;146;146;145;145;146;145;145 12:38:58 INFO - PROCESS | 10740 | |7;imaging-desaturate;84;85;84;85;84;84;84;85;84;84 12:38:58 INFO - PROCESS | 10740 | |8;json-parse-financial;61;51;51;51;51;50;52;50;53;50 12:38:58 INFO - PROCESS | 10740 | |9;json-stringify-tinderbox;58;59;59;59;60;60;59;60;60;59 12:38:58 INFO - PROCESS | 10740 | |10;stanford-crypto-aes;76;75;81;76;82;75;75;75;81;74 12:38:58 INFO - PROCESS | 10740 | |11;stanford-crypto-ccm;130;123;125;130;129;122;122;121;167;124 12:38:58 INFO - PROCESS | 10740 | |12;stanford-crypto-pbkdf2;162;159;160;154;159;155;160;154;157;155 12:38:58 INFO - PROCESS | 10740 | |13;stanford-crypto-sha256-iterative;66;63;68;63;63;67;62;63;62;63 12:38:58 INFO - PROCESS | 10740 | __end_tp_report 12:38:58 INFO - PROCESS | 10740 | __start_cc_report 12:38:58 INFO - PROCESS | 10740 | _x_x_mozilla_cycle_collect,1597 12:38:58 INFO - PROCESS | 10740 | __end_cc_report 12:38:58 INFO - PROCESS | 10740 | __startTimestamp1487968738962__endTimestamp 12:38:58 INFO - PROCESS | 10740 | 12:38:58 INFO - PROCESS | 10740 | ------- Summary: start ------- 12:38:58 INFO - PROCESS | 10740 | Number of tests: 14 12:38:58 INFO - PROCESS | 10740 | 12:38:58 INFO - PROCESS | 10740 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.89 (3.5%) stddev-sans-first:1.20 12:38:58 INFO - PROCESS | 10740 | Values: 100.0 111.0 112.0 112.0 114.0 113.0 111.0 111.0 110.0 112.0 12:38:58 INFO - PROCESS | 10740 | 12:38:58 INFO - PROCESS | 10740 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:120.00 stddev:16.66 (13.9%) stddev-sans-first:16.24 12:38:58 INFO - PROCESS | 10740 | Values: 148.0 119.0 116.0 151.0 119.0 120.0 120.0 120.0 160.0 120.0 12:38:58 INFO - PROCESS | 10740 | 12:38:58 INFO - PROCESS | 10740 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 12:38:58 INFO - PROCESS | 10740 | Values: 161.0 160.0 159.0 162.0 162.0 161.0 160.0 161.0 160.0 161.0 12:38:58 INFO - PROCESS | 10740 | 12:38:58 INFO - PROCESS | 10740 | [#3] audio-fft Cycles:10 Average:81.20 Median:76.00 stddev:12.10 (15.9%) stddev-sans-first:12.55 12:38:58 INFO - PROCESS | 10740 | Values: 74.0 75.0 77.0 109.0 75.0 76.0 78.0 76.0 98.0 74.0 12:38:58 INFO - PROCESS | 10740 | 12:38:58 INFO - PROCESS | 10740 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:82.00 stddev:13.18 (16.1%) stddev-sans-first:13.55 12:38:58 INFO - PROCESS | 10740 | Values: 81.0 83.0 111.0 82.0 82.0 83.0 110.0 82.0 82.0 107.0 12:38:58 INFO - PROCESS | 10740 | 12:38:58 INFO - PROCESS | 10740 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 12:38:58 INFO - PROCESS | 10740 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 116.0 116.0 12:38:58 INFO - PROCESS | 10740 | 12:38:58 INFO - PROCESS | 10740 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 12:38:58 INFO - PROCESS | 10740 | Values: 145.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 12:38:58 INFO - PROCESS | 10740 | 12:38:58 INFO - PROCESS | 10740 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 12:38:58 INFO - PROCESS | 10740 | Values: 84.0 85.0 84.0 85.0 84.0 84.0 84.0 85.0 84.0 84.0 12:38:58 INFO - PROCESS | 10740 | 12:38:58 INFO - PROCESS | 10740 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:51.00 stddev:3.30 (6.5%) stddev-sans-first:1.00 12:38:58 INFO - PROCESS | 10740 | Values: 61.0 51.0 51.0 51.0 51.0 50.0 52.0 50.0 53.0 50.0 12:38:58 INFO - PROCESS | 10740 | 12:38:58 INFO - PROCESS | 10740 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.50 stddev:0.67 (1.1%) stddev-sans-first:0.53 12:38:58 INFO - PROCESS | 10740 | Values: 58.0 59.0 59.0 59.0 60.0 60.0 59.0 60.0 60.0 59.0 12:38:58 INFO - PROCESS | 10740 | 12:38:58 INFO - PROCESS | 10740 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:76.00 stddev:3.06 (4.0%) stddev-sans-first:3.22 12:38:58 INFO - PROCESS | 10740 | Values: 76.0 75.0 81.0 76.0 82.0 75.0 75.0 75.0 81.0 74.0 12:38:58 INFO - PROCESS | 10740 | 12:38:58 INFO - PROCESS | 10740 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:127.00 stddev:13.68 (10.8%) stddev-sans-first:14.51 12:38:58 INFO - PROCESS | 10740 | Values: 130.0 123.0 125.0 130.0 129.0 122.0 122.0 121.0 167.0 124.0 12:38:58 INFO - PROCESS | 10740 | 12:38:58 INFO - PROCESS | 10740 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.50 Median:159.00 stddev:2.88 (1.8%) stddev-sans-first:2.55 12:38:58 INFO - PROCESS | 10740 | Values: 162.0 159.0 160.0 154.0 159.0 155.0 160.0 154.0 157.0 155.0 12:38:58 INFO - PROCESS | 10740 | 12:38:58 INFO - PROCESS | 10740 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:63.00 stddev:2.16 (3.4%) stddev-sans-first:2.17 12:38:58 INFO - PROCESS | 10740 | Values: 66.0 63.0 68.0 63.0 63.0 67.0 62.0 63.0 62.0 63.0 12:38:58 INFO - PROCESS | 10740 | -------- Summary: end -------- 12:38:58 INFO - PROCESS | 10740 | 12:38:59 INFO - TEST-INFO | 10740: exit 0 12:38:59 INFO - TEST-OK | kraken | took 60229ms 12:38:59 INFO - SUITE-END | took 1175s 12:39:00 INFO - Completed test suite (00:19:35) 12:39:00 INFO - javascript benchmark 12:39:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3125.515545090511, 3166.414213370528, 3174.8730050797967, 3182.5226216067585, 3204.8557814898327, 5579.804706835262, 5659.405762394951, 5660.1792740052715, 5664.915026274604, 5664.943350566493, 5566.109422492402, 5619.241402410673, 5624.100143976954, 5636.520895723858, 5638.859028524289, 5049.065922804284, 5076.111680455924, 5110.514501122406, 5130.563902068328, 5170.560502357304, 5033.144365457881, 5043.167877300241, 5106.974465127669, 5163.7159956202395, 5167.250748641445, 5028.647994640377, 5044.697318160904, 5062.2406639004075, 5094.057599344114, 5097.260897169908, 5086.77109530072, 5150.742462876841, 5151.871203219912, 5164.561012313958, 5177.45636708144, 4885.2427873679635, 5082.186850103965, 5088.847334579968, 5102.6428150029515, 5136.460671629462, 5421.83734487966, 5439.292891924064, 5508.20131080991, 5539.972300138514, 5591.217229587861, 5802.274715660543, 5837.5913686041995, 5916.674582897939, 5917.437843404869, 5934.317553481319, 5824.621399609012, 5896.115582662592, 5946.881062378771, 5950.7917222896995, 5971.940280597182, 5413.0, 5564.360098588673, 5630.183623374629, 5652.349979752299, 5675.290588676416, 6189.412005859436, 6195.721192546346, 6200.782972596027, 6220.0, 6224.284207316126, 5788.797392091256, 5841.7371218295275, 5928.82213533586, 5968.0, 5981.730822113015, 5777.075667893117, 5803.0, 5848.3274423441, 5873.823785286449, 5912.793052243151, 5834.358220595731, 5835.649861008353, 5836.328822185418, 5839.795607153729, 5844.1818145459665, 5674.035413979634, 5783.537317014629, 5845.824625261249, 5849.239598852122, 5868.031774757203, 4518.344839998247, 4577.130345234395, 4651.046535460223, 4652.069586082797, 4701.576858082789, 4084.897877553085, 4111.424400583921, 4137.358709400048, 4150.335946248586, 4154.189932963103, 5735.4551317624755, 5740.0, 5742.196092547047, 5755.65466072037, 5760.0207964646115, 5715.31416230055, 5775.768969241268, 5957.314908785545, 6037.275526936795, 6058.545609079337, 5705.74324155414, 5767.538596912237, 5781.739821708034, 5789.2763404574425, 5796.275465566804, 5154.9484505155215, 5232.058229518723, 5244.816431424882, 5250.553702935217, 5254.605904557174, 6063.181470501426, 6133.907991380043, 6338.271098823694, 6339.429451349401, 6343.207099112611, 5846.239988801429, 5923.911141332969, 5939.2575928009, 5995.850103747442, 6010.338862725184, 6171.938280617316, 6180.969095154495, 6189.226346706661, 6199.907001394892, 6229.221347331583, 5627.155926611041, 5858.326292476419, 5869.589128760946, 5869.911951320819, 5870.207521984648, 5660.094384898396, 5903.380145084876, 5914.467697907209, 5931.555133364928, 6039.577229593886, 5856.882862342814, 5901.557383196363, 5906.143609176559, 5906.232189815297, 5909.054551271776, 5867.970660146842, 5868.119782032729, 5878.147668588116, 5879.882402351844, 5881.411858814085, 5592.217089607377, 5601.131824567198, 5630.268065151504, 5654.519365853948, 5669.177969194526, 5817.127430885401, 5819.447152520504, 5826.300843898759, 5830.970845145916, 5854.2389489366105, 5499.780008799603, 5541.141123125922, 5679.233303503974, 5689.886202276014, 5696.658200507983], "value": 5495.709924605548, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.9832905012851, 601.3715667127852, 618.0358640520788, 651.3876955661677, 658.9571677840937, 33699.83150084249, 36126.27747445049, 36192.457113143326, 36225.63774362256, 36243.45634815473, 46401.76799116, 47478.0504389912, 47557.0, 50373.24440133401, 50404.0, 9141.31440141987, 9269.490178040205, 9270.25837932967, 9288.117628825285, 9290.721278361627, 8515.19105684959, 8737.650493980265, 9132.3150763693, 9229.446233226028, 9231.3076519261, 8718.0, 10777.461126943661, 11075.335479871193, 11090.279131856443, 11431.142664300169, 11109.055730262937, 11154.330740155616, 11168.497417616227, 11174.385408802513, 11176.608818691388, 10984.725381865517, 10993.395363255018, 11023.779524409547, 11036.061934735557, 11053.557857685682, 43367.34948975768, 43593.782031089955, 43699.781501092606, 43823.56176438227, 43866.56133438657, 3683.226522430293, 3770.5286839145106, 3785.734998550103, 3967.3850553164307, 4245.172191422674, 32244.355112897847, 32358.35283294321, 32786.836065819756, 33050.669493305, 34082.147946301295, 4376.124775045004, 4449.933251001237, 4460.598546130831, 4463.96084314828, 4498.100379923995, 251441.0, 252922.0, 253031.0, 253742.0, 253766.99999999817, 62020.069698954554, 62502.0, 62580.0, 62606.68696656488, 62620.686896565225, 39712.0, 40533.797331013746, 40590.18819623591, 64295.67852160709, 64778.67610661917, 18802.905985469984, 18999.335023274118, 19055.61888762217, 19065.42803715891, 19065.90467047656, 13186.406611702496, 13198.60404187876, 13219.66950826237, 13219.933900330629, 13222.73554528904, 17911.835730677463, 18242.361517346828, 19635.116419761143, 20164.69752953707, 20391.38825835227, 7149.96425017882, 7162.785116446515, 7254.202037775841, 7399.556026638419, 7547.320741133324, 1006.5068116622803, 1041.7864337810731, 1074.1299547366657, 1105.9668209953554, 1120.8486854274568, 33227.83386083054, 33387.83306083454, 33520.329593407994, 33588.83205584005, 33623.32753344919, 1125.128025780027, 1131.5021390588115, 1146.2778449576713, 1149.971250718722, 1183.2308999150448, 17020.829791702174, 17186.140692965302, 17473.38843140484, 17566.824331756776, 17589.20848561792, 464928.0, 468756.0, 469759.0, 470480.0, 471348.0, 59516.0, 59999.40000600025, 60226.69886650539, 60248.0, 60277.69861150666, 1261.306281545165, 1318.1695531814896, 1364.836219653648, 1400.215879107703, 1401.466256659705, 30300.848495757382, 33729.49405758965, 34204.31591368208, 34276.657233427344, 34415.0, 50984.74507627438, 51615.0, 51629.48370516247, 51749.0, 51758.0, 370582.0, 373337.0, 374273.0, 374517.0, 374583.0, 29623.96316128925, 30547.54178687366, 30744.0, 30761.230969225053, 30852.228694281923, 47980.5201947976, 48980.0, 49047.0, 49063.50936490589, 49467.0, 41538.58461415347, 42073.15853682848, 42627.5737242636, 43380.34929476123, 43746.34380484359, 41865.37201941913, 42158.36762448627, 42323.57676423196, 43076.56923430726, 43465.0, 42807.35788963106, 42885.5711442894, 43796.78101609471, 43903.560964389944, 44208.115837682424, 35088.0, 37141.43177849838, 37736.0, 37976.43035354527, 38623.806880965414, 28738.85630571834, 28926.710732892403, 29134.0, 29152.0, 29265.41469170647], "value": 20540.57513322438, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.68310875962356, 413.37580253816725, 413.40676129753786, 419.4672765587703, 433.18561105122365, 18268.45194644161, 19700.802991970075, 19742.111604977774, 19784.208631654717, 20262.0, 12913.677158071054, 13187.538436154737, 18739.906300468512, 19935.800641993577, 20045.599088018233, 5315.973420132894, 5402.513773760351, 5485.6434331768505, 5490.972545137289, 5521.972390138044, 4080.0411903202726, 4272.978635106836, 5463.863403414906, 5510.724463776815, 5520.530754885839, 5863.179154918314, 6114.724837382306, 6150.753969841201, 6238.625682459045, 6241.9375806241815, 6171.105189747484, 6204.16243807087, 6614.470842332602, 6682.565633233824, 6733.293004234534, 6010.819675409744, 6015.27816661999, 6022.608530445507, 6024.457798798129, 6026.186464827279, 14302.427902883872, 15549.222538873011, 21683.0, 22487.100515979342, 22632.547349052926, 2359.9410014749596, 2419.2137555294426, 2639.2082375287528, 2738.904438224726, 2962.7629789616994, 10497.632582859564, 10529.157667386591, 10758.408287544182, 11060.612878549213, 11064.834027489595, 1974.328728232408, 1997.4207479830832, 2011.5775687105725, 2057.8887400803546, 2057.9176832926664, 75687.62156189239, 77435.0, 78887.0, 81540.18459815385, 84920.57539712323, 10969.62879640045, 11232.0, 11628.6511404658, 11660.12549058824, 11712.88287117135, 16486.75269870953, 16530.09084500364, 16534.586635334213, 16540.338386464406, 16563.337466501445, 8564.61459234336, 8622.137786221328, 8628.827423451496, 8815.294776417872, 8977.461352318882, 8032.759017229376, 8116.0, 8129.796755081052, 8146.533623947627, 8345.916540834514, 4970.2296144097, 4974.825881094144, 4999.450060493343, 5022.171341728574, 5030.84907452777, 1833.6791061564172, 2039.316828862318, 2042.8978551072685, 2095.968560471594, 2106.7682554918947, 936.8501039833594, 967.9564419601135, 978.848278516831, 1014.2038499777786, 1072.4905669806778, 19332.0, 19389.418317450498, 19518.121684523947, 19947.700784488243, 20316.187352505734, 987.4914419074182, 1047.8375851742992, 1066.0565399621391, 1067.8749288915003, 1084.0081325587, 10221.233407494468, 11083.445827708581, 11187.272827266203, 11193.608223712132, 11244.0, 467538.0, 470695.0, 473873.0, 476733.0, 479963.0, 88752.0, 88800.0, 89754.0, 90204.5489772547, 90604.0, 996.7622687067579, 1003.9698809035741, 1019.6125472320471, 1024.2410354000835, 1028.9639862604922, 16541.751873722144, 16731.247093881047, 16943.406980755615, 17766.378176763752, 17788.3774067907, 38253.42619860649, 40371.79814100911, 42485.15029699327, 42891.0, 43440.78279608582, 55145.1728224085, 56935.0, 57610.423895760505, 61062.0, 61992.69003654953, 5694.886102277848, 6534.607923524603, 6714.0, 8166.387520936072, 8325.125861784667, 11450.885491144982, 13312.800307995194, 13479.730405391641, 13790.517331893336, 14055.929720351332, 8473.364497662824, 11515.53937842477, 11825.231359961575, 11913.22564033335, 12236.327002014974, 11541.711457213636, 11571.016463600688, 11633.47649355764, 11895.524179033087, 12000.939995299968, 11897.167198296036, 11996.520139194683, 12089.51641934348, 12183.573574925189, 12350.876491234972, 7946.7615971520945, 8255.669773209245, 8319.084900661044, 8432.957835210786, 9254.907450925404, 9511.048895110434, 11917.284962902253, 11924.642260732191, 12021.338826364634, 12069.939650301692], "value": 9260.830050159228, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1473.3885437543418, 1516.0145905161644, 1645.6461860699956, 1760.771099757033, 1826.853851691864, 8482.0, 8996.595153218113, 9004.639814407432, 9007.189352958232, 9018.233450156727, 7832.1776213497615, 8066.193380661931, 8069.112397636255, 8259.545724985139, 8846.646134154642, 2355.7879790818824, 2456.8403053801444, 2463.0763463701114, 2474.072222916406, 2477.690288713911, 2465.4822487277693, 2503.161440917295, 2524.1417917907906, 2534.721180670125, 2535.784458321045, 2455.8894849731714, 2458.840175388603, 2483.453640199153, 2484.2671411933525, 2488.203774792067, 2392.0670938334065, 2409.71083469983, 2412.1316326122583, 2413.4690368118986, 2414.37226321156, 2358.681577986967, 2397.3407312988893, 2398.1606437746823, 2399.8560086394873, 2400.0, 8862.734117976472, 8889.911100889038, 8981.550922453851, 8982.595783189772, 8986.820263594756, 5458.4541545845495, 5601.215829783833, 5607.663540187602, 5607.915881261784, 5609.1305847593685, 3405.863765449379, 3415.453527435623, 3612.8916132516065, 3626.5648122225502, 3627.4740162676526, 1178.6522975722182, 1184.5676328140253, 1218.4882349413178, 1238.0686129637793, 1248.1200753468784, 12396.380180991004, 12410.503579856795, 12461.065420093439, 12463.5014599415, 12501.562445314461, 4723.659471874835, 4828.2998965150555, 4830.855074347775, 4901.803927842918, 4944.159492886218, 10252.38485690861, 10265.948670256601, 10277.434741089312, 10303.278770485995, 10341.63804266847, 5492.231087647732, 5580.469855363734, 5584.0, 5585.3297604287745, 5587.525060369833, 4480.059187570581, 4962.454130045692, 5069.493050694901, 5076.390833100052, 5081.771320290596, 3834.386498160281, 4025.5571887092397, 4153.937690934638, 4170.457840480779, 4218.050938538866, 1264.5700461843016, 1322.6362750243568, 1324.529791923853, 1333.839939207282, 1337.358068127285, 923.8244733500613, 945.1304799584399, 960.865478832964, 972.3145182646359, 993.7316924430363, 5660.632058916157, 6149.41580549847, 6152.938470615326, 6188.690565471708, 6198.380161983856, 999.160705007797, 1003.0771690045176, 1005.5575546759402, 1023.9948800255951, 1024.329064462778, 3886.436466712311, 4125.793710314472, 4132.483439570054, 4180.832766689298, 4241.830326786894, 10776.084032857138, 10824.242303038869, 10950.233483656068, 11151.553937842558, 11180.944095279472, 10843.45782710877, 11059.72350691223, 11065.67211934573, 11078.335299882034, 11086.667399978014, 8408.117147699526, 8503.107173746668, 8522.36082293818, 8524.616392262364, 8540.718892166225, 5952.404759524013, 5960.731767070405, 6006.399360063959, 6035.456808887221, 6062.242219722535, 9795.118439340493, 9982.800343993225, 9986.800263994824, 10044.899551004397, 10152.949235253776, 10373.0, 10452.007059329351, 10496.0, 10503.632372867218, 10504.369737815756, 7335.559866408033, 7454.4781865268915, 7456.291652293024, 7459.067616547932, 7472.439567032603, 8223.506589604644, 8366.205210504992, 8465.746027619181, 8652.178043085896, 8669.479831210148, 7337.963310183415, 7339.2660733928315, 7363.190049094703, 7545.094588649397, 7637.427192960439, 7444.255574442513, 7549.433792465477, 7553.169151393452, 7660.080790304976, 7700.3454706350585, 7138.928610713826, 7164.0, 7216.9278307216255, 7222.819429514304, 7229.09636295463, 5223.2948551945, 5252.185911183773, 5311.893762124659, 5436.673799572039, 5493.478119578634, 5261.316028916216, 5270.920936186037, 5285.973570132279, 5318.1490961447535, 5354.9464505354445], "value": 4752.733075738734, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.28663875902475, 350.59681366428606, 357.4691582999244, 357.6905976330474, 361.1530959899036, 5538.532288943428, 5577.247071645326, 5588.776448942048, 5610.13042978339, 5619.157126431038, 5203.375594928604, 5248.212768084789, 5258.947410525893, 5346.492083252095, 5448.3110235826825, 4246.171996460676, 4255.17024180285, 4276.294411422112, 4285.528591854893, 4291.463567054118, 4236.1104168124575, 4239.915201695964, 4253.2131555662145, 4291.549387314334, 4306.354046892975, 4085.937656209392, 4188.0, 4199.866036170232, 4227.344761561947, 4232.132412855372, 4195.6573896353175, 4216.304309788897, 4231.873043808675, 4240.9151816963795, 4246.171996460692, 3784.9810750946344, 3785.2240290740333, 3798.1833905710405, 3799.1831756172555, 3799.8670046548236, 5067.695938243681, 5321.467853214686, 5356.732163391854, 5367.624266301361, 5399.325084364455, 4848.539388758062, 4852.708837469763, 4859.927101093451, 4872.439669437989, 4880.829170978998, 5667.263255776723, 5678.006348888928, 5690.0, 5691.402402747734, 5700.800471983461, 4054.736442131252, 4082.632563069308, 4108.98659656769, 4161.9583804161875, 4173.561776013536, 5813.476787089182, 5819.418058194189, 5871.854988277288, 5901.527877769769, 5912.556558258148, 4199.202151591188, 4199.895002624898, 4201.222773786859, 4211.768352740567, 4259.829606815692, 4195.797206466629, 4242.639375653042, 4275.38006988991, 4306.89232769177, 4311.417958575615, 4844.733539655353, 4845.95154048455, 4865.513448655106, 4880.511948805091, 4904.239842824368, 5719.768330893032, 5732.484076433057, 5758.62568933018, 5772.740226689809, 5778.075507918713, 1419.3754747910887, 1434.651427657998, 1437.9071905351798, 1447.4282658349894, 1461.9634509137356, 964.5177411294353, 986.2208855004609, 992.4640694025289, 992.8014397120605, 996.4868092932146, 5333.4666033634485, 5348.839534813962, 5357.437469065692, 5378.2739330189925, 5405.972970135203, 5720.283914825535, 5725.713714314267, 5727.11229759388, 5734.856628584235, 5750.568707346965, 5126.6923984561045, 5311.229871668586, 5355.598330125256, 5378.51593356592, 5378.515933565998, 2997.985010074936, 3009.6689364169924, 3016.75865930725, 3017.17027817352, 3022.410629927187, 5896.734646940898, 5903.527717782567, 5921.61509501881, 5941.58408911372, 5998.700064996733, 5661.547076233891, 5998.25021872266, 6009.729562169713, 6009.819705408845, 6015.969920150459, 6110.816675499742, 6162.397776578122, 6169.167162433104, 6185.288691800501, 6215.627062376362, 5618.325800903917, 5875.823725288248, 5888.646681199141, 5917.940820591739, 5963.761449542143, 5804.6201057566195, 5805.809808989063, 5832.475077243069, 5851.912221316598, 5862.589618726648, 5823.330317013429, 6112.847178820565, 6153.2616086068165, 6162.599431036968, 6179.969100154471, 4035.8699564122094, 4124.7525148489985, 4153.210889930903, 4174.165166966558, 4189.2459357315975, 5654.434556544313, 5781.277340332458, 5872.916718722705, 5945.316288626863, 5958.553108516965, 5824.417558244142, 5826.70866456684, 5831.154482599914, 5831.754774411797, 5833.0, 5593.692346920959, 5710.2291190690385, 5748.54011679073, 5802.47777700009, 5819.82540523785, 5655.321361436654, 5671.120976248688, 5672.12082127271, 5677.261955945701, 5706.0, 5758.827235182951, 5765.625234359753, 5775.595708300379, 5779.543693930147, 5798.7089553730775, 5409.323834520685, 5552.7778888845605, 5601.887962240651, 5640.915386269127, 5646.209530665792], "value": 4361.379127698612, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.9197392299884, 756.398663062865, 762.1692355332686, 824.9876251856227, 840.4369072721274, 14278.643033924158, 15504.612384690388, 15507.767383489228, 15507.767383489243, 15508.0, 13708.794368084487, 13795.655108622264, 13801.51694690686, 13826.585202443917, 13856.584302470917, 700.1493185779265, 711.9679614417338, 819.6311659753105, 844.3498506150261, 845.247729520727, 846.5259454705384, 847.7753395350237, 847.9824210946888, 848.3891598049395, 850.8000619854329, 887.786931136529, 897.4032268541412, 899.3120262998812, 899.4872922434215, 899.5502248875562, 886.3219636977717, 886.822635472908, 887.4542156573693, 887.8446271902424, 888.3692578269437, 661.4179522020592, 661.7187695229508, 662.2781168526282, 662.3475876261926, 662.536224642752, 13792.724145517133, 13959.232242226673, 13959.511417100453, 13964.092333998258, 14366.784498232535, 14404.567862964128, 14916.0, 15020.699586008328, 15144.394224231017, 15190.924045379703, 11248.718782030433, 11482.598109066143, 11749.29504229749, 11779.057675385948, 12010.0, 4073.8166782494563, 4075.735077219971, 4161.56303588125, 4178.331466965271, 4192.014876504019, 65374.34625653778, 65982.67008664974, 66589.66705166444, 67577.0, 68498.0, 10968.396738179477, 11093.778124437466, 11175.385353805455, 11241.83137252942, 11282.210245282915, 19203.807961920204, 19211.23155073809, 19284.421467356, 19290.71063934042, 19290.903545482182, 8225.95887020561, 8342.374321925758, 8359.58202089893, 8434.831303374021, 8592.742217733477, 4070.1859628074503, 4237.300845360481, 4283.6144746972295, 4309.892252693708, 4389.517153113155, 3329.500574913782, 3430.519727238189, 3433.1931995980926, 3448.810315432625, 3453.1194545391268, 571.8598943258928, 590.9852253693692, 594.7323704333068, 596.7463827873137, 607.2925042325642, 663.5521023309246, 679.1748026148254, 681.5910453727723, 682.8566001139717, 689.3175756001523, 8783.91216087831, 8873.467591944504, 8943.463392196489, 9199.448033118035, 9240.491772952417, 589.9174115623816, 599.4814485470037, 619.603453789575, 625.8185126313409, 706.2231545300128, 4381.5618438155925, 4499.702783841423, 4613.169629466728, 4696.342512048248, 4881.902361952741, 78564.21435785569, 83562.58218708867, 86661.56669216613, 87269.25461490735, 87320.0, 75148.62425687946, 77750.2224977743, 78167.60916195497, 79688.60155699184, 79840.20159798444, 69473.30526694769, 69937.65031174812, 72858.0, 72988.63505682438, 74750.0, 9645.951770241103, 9819.527070939415, 9991.850122248026, 10055.698329049848, 10078.899211008089, 32493.83753081314, 32764.18089547685, 35407.11482212862, 39705.60294397019, 47095.0, 40342.59657403389, 41438.0, 56126.158107629235, 60696.696516517135, 61043.0, 11662.183647144619, 11852.822207667065, 12038.217515861441, 12190.0, 12248.938755306166, 13054.347282635641, 13095.214287142802, 13181.670458238621, 13926.442942282196, 14044.087134336236, 12923.935380323039, 13457.387420915518, 13898.0, 14345.784813227601, 14476.348564314421, 12642.620721378373, 12955.740885182055, 13000.479980800663, 13217.14088584239, 13417.932910335387, 12683.492660293854, 13057.28184949799, 13061.477540898257, 13123.081384303006, 13280.136791108547, 10199.643012494527, 10262.486875656037, 10311.587536498457, 10356.430396328275, 10512.842307365549, 11164.274322169033, 11450.768451275375, 11505.94247028793, 11766.235194712317, 11770.3526306054], "value": 7102.268080857909, "unit": "score"}], "name": "dromaeo_css", "value": 7320.638725911365, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 112.0, 112.0, 114.0, 113.0, 111.0, 111.0, 110.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 119.0, 116.0, 151.0, 119.0, 120.0, 120.0, 120.0, 160.0, 120.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 162.0, 162.0, 161.0, 160.0, 161.0, 160.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 109.0, 75.0, 76.0, 78.0, 76.0, 98.0, 74.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 111.0, 82.0, 82.0, 83.0, 110.0, 82.0, 82.0, 107.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 51.0, 51.0, 51.0, 51.0, 50.0, 52.0, 50.0, 53.0, 50.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 60.0, 60.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 81.0, 76.0, 82.0, 75.0, 75.0, 75.0, 81.0, 74.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 123.0, 125.0, 130.0, 129.0, 122.0, 122.0, 121.0, 167.0, 124.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 160.0, 154.0, 159.0, 155.0, 160.0, 154.0, 157.0, 155.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 68.0, 63.0, 63.0, 67.0, 62.0, 63.0, 62.0, 63.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1457.6, "alertThreshold": 2.0}]} 12:39:00 INFO - Return code: 0 12:39:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:39:00 INFO - # TBPL SUCCESS # 12:39:00 INFO - Running post-action listener: _resource_record_post_action 12:39:00 INFO - [mozharness: 2017-02-24 20:39:00.291781Z] Finished run-tests step (success) 12:39:00 INFO - Running post-run listener: _resource_record_post_run 12:39:00 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 321703936; Read time: 16; Write time: 237484 12:39:00 INFO - TinderboxPrint: CPU usage
13.0% 12:39:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 12:39:00 INFO - TinderboxPrint: I/O write bytes / time
321,703,936 / 237,484 12:39:00 INFO - TinderboxPrint: CPU idle
8,268.1 (87.0%) 12:39:00 INFO - TinderboxPrint: CPU user
1,188.7 (12.5%) 12:39:00 INFO - TinderboxPrint: Swap in / out
0 / 0 12:39:00 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 100888576; Read time: 0; Write time: 108996 12:39:00 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 220418048; Read time: 16; Write time: 128460 12:39:00 INFO - Running post-run listener: _upload_blobber_files 12:39:00 INFO - Blob upload gear active. 12:39:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:39:00 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 12:39:00 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:39:00 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:39:01 INFO - (blobuploader) - INFO - Open directory for files ... 12:39:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:39:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:39:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:02 INFO - (blobuploader) - INFO - Done attempting. 12:39:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:39:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:39:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:04 INFO - (blobuploader) - INFO - Done attempting. 12:39:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:39:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:39:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:07 INFO - (blobuploader) - INFO - Done attempting. 12:39:07 INFO - (blobuploader) - INFO - Iteration through files over. 12:39:07 INFO - Return code: 0 12:39:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:39:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:39:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aea3287871b57fb7e26133caea093b5a36fee8b24ac8e7d700da480dd31a5c5a9fa2d08fed2681df4411b30d880b8f392680817e995ff14cf30140cb030ac88b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/16bdce98b9e3d21ea7124d69d4c6dde0c936bbe9ba1b0d3b69cd134a994f1379c4282ac0d72dd09f47ca3c685d8deb6144ae40229b20ce1932140b96e16b64cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/487a8c919f443928bf9cf65ed3067d9802871333b459dac573f02e202bb58f9fe4d6623d2095d31b2dd5bda17fc795ef800c439fad26949d0c4c556427fdcffa"} 12:39:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:39:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:39:07 INFO - Contents: 12:39:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aea3287871b57fb7e26133caea093b5a36fee8b24ac8e7d700da480dd31a5c5a9fa2d08fed2681df4411b30d880b8f392680817e995ff14cf30140cb030ac88b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/16bdce98b9e3d21ea7124d69d4c6dde0c936bbe9ba1b0d3b69cd134a994f1379c4282ac0d72dd09f47ca3c685d8deb6144ae40229b20ce1932140b96e16b64cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/487a8c919f443928bf9cf65ed3067d9802871333b459dac573f02e202bb58f9fe4d6623d2095d31b2dd5bda17fc795ef800c439fad26949d0c4c556427fdcffa"} 12:39:07 INFO - Running post-run listener: copy_logs_to_upload_dir 12:39:07 INFO - Copying logs to upload dir... 12:39:07 INFO - mkdir: /builds/slave/test/build/upload/logs 12:39:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.316341 ========= master_lag: 0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-02-24 12:39:06.756819) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-24 12:39:06.760210) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958 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-Beta/sha512/aea3287871b57fb7e26133caea093b5a36fee8b24ac8e7d700da480dd31a5c5a9fa2d08fed2681df4411b30d880b8f392680817e995ff14cf30140cb030ac88b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/16bdce98b9e3d21ea7124d69d4c6dde0c936bbe9ba1b0d3b69cd134a994f1379c4282ac0d72dd09f47ca3c685d8deb6144ae40229b20ce1932140b96e16b64cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/487a8c919f443928bf9cf65ed3067d9802871333b459dac573f02e202bb58f9fe4d6623d2095d31b2dd5bda17fc795ef800c439fad26949d0c4c556427fdcffa"} build_url:https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/YQEE--02SC27Mf3B71Q-CQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aea3287871b57fb7e26133caea093b5a36fee8b24ac8e7d700da480dd31a5c5a9fa2d08fed2681df4411b30d880b8f392680817e995ff14cf30140cb030ac88b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/16bdce98b9e3d21ea7124d69d4c6dde0c936bbe9ba1b0d3b69cd134a994f1379c4282ac0d72dd09f47ca3c685d8deb6144ae40229b20ce1932140b96e16b64cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/487a8c919f443928bf9cf65ed3067d9802871333b459dac573f02e202bb58f9fe4d6623d2095d31b2dd5bda17fc795ef800c439fad26949d0c4c556427fdcffa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-24 12:39:06.784944) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 12:39:06.785263) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1487966450.33124-657453958 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-24 12:39:06.869092) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-24 12:39:06.869415) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-24 12:39:06.869711) ========= ========= Total master_lag: 0.31 =========