builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1486411881.8 results: success (0) buildid: 20170206101855 builduid: e7e74b7e86a44fc1b3528c0720eff052 revision: 501a3fa83897af9598adfd6f794b5d5ea82fe237 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 12:11:21.798200) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 12:11:21.798716) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 12:11:21.799022) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 12:11:21.815430) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 12:11:21.815708) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-06 12:11:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-02-06 12:11:22 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124496 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 12:11:21.953574) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 12:11:21.953880) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018603 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 12:11:22.003164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 12:11:22.003594) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 501a3fa83897af9598adfd6f794b5d5ea82fe237 --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 501a3fa83897af9598adfd6f794b5d5ea82fe237 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-06 12:11:22,305 truncating revision to first 12 chars 2017-02-06 12:11:22,305 Setting DEBUG logging. 2017-02-06 12:11:22,305 attempt 1/10 2017-02-06 12:11:22,305 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/501a3fa83897?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 12:11:23,109 unpacking tar archive at: mozilla-beta-501a3fa83897/testing/mozharness/ program finished with exit code 0 elapsedTime=1.066299 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 12:11:23.114825) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 12:11:23.115285) ========= script_repo_revision: 501a3fa83897af9598adfd6f794b5d5ea82fe237 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 12:11:23.115767) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 12:11:23.116048) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 12:11:23.124792) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-06 12:11:23.125092) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:11:23 INFO - MultiFileLogger online at 20170206 12:11:23 in /builds/slave/test 12:11:23 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:11:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:11:23 INFO - {'append_to_log': False, 12:11:23 INFO - 'base_work_dir': '/builds/slave/test', 12:11:23 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:11:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:11:23 INFO - 'branch': 'Mozilla-Beta', 12:11:23 INFO - 'buildbot_json_path': 'buildprops.json', 12:11:23 INFO - 'config_files': ('talos/linux_config.py',), 12:11:23 INFO - 'default_actions': ('clobber', 12:11:23 INFO - 'read-buildbot-config', 12:11:23 INFO - 'download-and-extract', 12:11:23 INFO - 'populate-webroot', 12:11:23 INFO - 'create-virtualenv', 12:11:23 INFO - 'install', 12:11:23 INFO - 'run-tests'), 12:11:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:11:23 INFO - 'download_minidump_stackwalk': True, 12:11:23 INFO - 'download_symbols': 'ondemand', 12:11:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:11:23 INFO - 'tooltool.py': '/tools/tooltool.py', 12:11:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:11:23 INFO - '/tools/misc-python/virtualenv.py')}, 12:11:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:11:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:11:23 INFO - 'installer_path': 'installer.exe', 12:11:23 INFO - 'log_level': 'info', 12:11:23 INFO - 'log_name': 'talos', 12:11:23 INFO - 'log_to_console': True, 12:11:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:11:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:11:23 INFO - 'opt_config_files': (), 12:11:23 INFO - 'pip_index': False, 12:11:23 INFO - 'sps_profile': False, 12:11:23 INFO - 'sps_profile_interval': 0, 12:11:23 INFO - 'suite': 'dromaeojs', 12:11:23 INFO - 'system_bits': '32', 12:11:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:11:23 INFO - 'title': 'talos-linux64-ix-041', 12:11:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:11:23 INFO - 'use_talos_json': True, 12:11:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:11:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:11:23 INFO - 'work_dir': 'build'} 12:11:23 INFO - [mozharness: 2017-02-06 20:11:23.487545Z] Running clobber step. 12:11:23 INFO - Running pre-action listener: _resource_record_pre_action 12:11:23 INFO - Running main action method: clobber 12:11:23 INFO - rmtree: /builds/slave/test/build 12:11:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:11:23 INFO - Running post-action listener: _resource_record_post_action 12:11:23 INFO - [mozharness: 2017-02-06 20:11:23.962668Z] Finished clobber step (success) 12:11:23 INFO - [mozharness: 2017-02-06 20:11:23.962769Z] Running read-buildbot-config step. 12:11:23 INFO - Running pre-action listener: _resource_record_pre_action 12:11:23 INFO - Running main action method: read_buildbot_config 12:11:23 INFO - Using buildbot properties: 12:11:23 INFO - { 12:11:23 INFO - "project": "", 12:11:23 INFO - "product": "firefox", 12:11:23 INFO - "script_repo_revision": "production", 12:11:23 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 12:11:23 INFO - "repository": "", 12:11:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 12:11:23 INFO - "buildid": "20170206101855", 12:11:23 INFO - "pgo_build": "True", 12:11:23 INFO - "basedir": "/builds/slave/test", 12:11:23 INFO - "buildnumber": 6, 12:11:23 INFO - "slavename": "talos-linux64-ix-041", 12:11:23 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:11:23 INFO - "platform": "ubuntu64_hw", 12:11:23 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:11:23 INFO - "branch": "mozilla-beta", 12:11:23 INFO - "repo_path": "releases/mozilla-beta", 12:11:23 INFO - "revision": "501a3fa83897af9598adfd6f794b5d5ea82fe237", 12:11:23 INFO - "stage_platform": "linux64-pgo", 12:11:23 INFO - "builduid": "e7e74b7e86a44fc1b3528c0720eff052", 12:11:23 INFO - "slavebuilddir": "test" 12:11:23 INFO - } 12:11:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 12:11:23 INFO - Running post-action listener: _resource_record_post_action 12:11:23 INFO - [mozharness: 2017-02-06 20:11:23.965246Z] Finished read-buildbot-config step (success) 12:11:23 INFO - [mozharness: 2017-02-06 20:11:23.965334Z] Running download-and-extract step. 12:11:23 INFO - Running pre-action listener: _resource_record_pre_action 12:11:23 INFO - Running main action method: download_and_extract 12:11:23 INFO - mkdir: /builds/slave/test/build/tests 12:11:23 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:11:23 INFO - trying https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 12:11:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/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:11:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/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:11:24 INFO - Downloaded 1327 bytes. 12:11:24 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 12:11:24 INFO - Using the following test package requirements: 12:11:24 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 12:11:24 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:11:24 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:11:24 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:11:24 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 12:11:24 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:11:24 INFO - u'jsshell-linux-x86_64.zip'], 12:11:24 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:11:24 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:11:24 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 12:11:24 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:11:24 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 12:11:24 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:11:24 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 12:11:24 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:11:24 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:11:24 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 12:11:24 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:11:24 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:11:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 12:11:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:11:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 12:11:25 INFO - Http code: 200 12:11:25 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 12:11:25 INFO - x-amz-cf-id: 5RJkkrXhECJ7f7cx_JIJnQaJjCui02MkD8KlsQqP0ZEm1-ToioogCw== 12:11:25 INFO - x-amz-version-id: JiCXNawBOYCSOEj81n.VcoNrOf9aWTeZ 12:11:25 INFO - Expected file size: 21955786 12:11:25 INFO - Obtained file size: 21955786 12:11:29 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:11:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 12:11:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:11:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 12:11:30 INFO - Http code: 200 12:11:30 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 12:11:30 INFO - x-amz-cf-id: mZIDyYzEwVP_EPMWkxFvS9UDlIIwXTKdiVvEHltIn7CqXBlMpbVh5Q== 12:11:30 INFO - x-amz-version-id: JiCXNawBOYCSOEj81n.VcoNrOf9aWTeZ 12:11:30 INFO - Expected file size: 21955786 12:11:30 INFO - Obtained file size: 21955786 12:11:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 12:11:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:11:34 INFO - Fetch https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 12:11:35 INFO - Http code: 200 12:11:35 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 12:11:35 INFO - x-amz-cf-id: XQtaeGpCTHBTubNtAvz8htwIlLUOFy1eyxRr9dVi-Tp5bcQqZB-dNQ== 12:11:35 INFO - x-amz-version-id: xw97BY3G9N2SH3.4scjZvldffdkbFy0f 12:11:35 INFO - Expected file size: 14403005 12:11:35 INFO - Obtained file size: 14403005 12:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:11:35 INFO - trying https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:11:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/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:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/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:11:36 INFO - Downloaded 57696954 bytes. 12:11:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:11:36 INFO - mkdir: /builds/slave/test/properties 12:11:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:11:36 INFO - Writing to file /builds/slave/test/properties/build_url 12:11:36 INFO - Contents: 12:11:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 12:11:37 INFO - Running post-action listener: _resource_record_post_action 12:11:37 INFO - Running post-action listener: set_extra_try_arguments 12:11:37 INFO - [mozharness: 2017-02-06 20:11:37.517660Z] Finished download-and-extract step (success) 12:11:37 INFO - [mozharness: 2017-02-06 20:11:37.517888Z] Running populate-webroot step. 12:11:37 INFO - Running pre-action listener: _resource_record_pre_action 12:11:37 INFO - Running main action method: populate_webroot 12:11:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:11:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:11:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:11:37 INFO - '--tppagecycles', 12:11:37 INFO - '7'], 12:11:37 INFO - 'tests': ['tsvgm']}}, 12:11:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:11:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:11:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:11:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:11:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:11:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:11:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:11:37 INFO - 'talos_options': ['--disable-e10s'], 12:11:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:11:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:11:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:11:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:11:37 INFO - 'talos_options': ['--disable-e10s'], 12:11:37 INFO - 'tests': ['damp', 'tps']}, 12:11:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:11:37 INFO - 'tests': ['damp', 'tps']}, 12:11:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:11:37 INFO - 'tests': ['dromaeo_dom']}, 12:11:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:11:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:11:37 INFO - 'tests': ['basic_compositor_video']}, 12:11:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:11:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:11:37 INFO - 'tests': ['a11yr', 12:11:37 INFO - 'ts_paint', 12:11:37 INFO - 'tpaint', 12:11:37 INFO - 'sessionrestore', 12:11:37 INFO - 'sessionrestore_no_auto_restore', 12:11:37 INFO - 'tabpaint']}, 12:11:37 INFO - 'other-e10s': {'tests': ['a11yr', 12:11:37 INFO - 'ts_paint', 12:11:37 INFO - 'tpaint', 12:11:37 INFO - 'sessionrestore', 12:11:37 INFO - 'sessionrestore_no_auto_restore', 12:11:37 INFO - 'tabpaint']}, 12:11:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:11:37 INFO - 'ts_paint', 12:11:37 INFO - 'tpaint', 12:11:37 INFO - 'sessionrestore', 12:11:37 INFO - 'sessionrestore_no_auto_restore', 12:11:37 INFO - 'tabpaint']}, 12:11:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:11:37 INFO - 'ts_paint', 12:11:37 INFO - 'tpaint', 12:11:37 INFO - 'sessionrestore', 12:11:37 INFO - 'sessionrestore_no_auto_restore', 12:11:37 INFO - 'tabpaint']}, 12:11:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:11:37 INFO - 'tests': ['a11yr', 12:11:37 INFO - 'ts_paint', 12:11:37 INFO - 'tpaint', 12:11:37 INFO - 'sessionrestore', 12:11:37 INFO - 'sessionrestore_no_auto_restore', 12:11:37 INFO - 'tabpaint']}, 12:11:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:11:37 INFO - 'tests': ['a11yr', 12:11:37 INFO - 'ts_paint', 12:11:37 INFO - 'tpaint', 12:11:37 INFO - 'sessionrestore', 12:11:37 INFO - 'sessionrestore_no_auto_restore', 12:11:37 INFO - 'tabpaint']}, 12:11:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:11:37 INFO - 'tests': ['tsvgx', 12:11:37 INFO - 'tsvgr_opacity', 12:11:37 INFO - 'tart', 12:11:37 INFO - 'tscrollx', 12:11:37 INFO - 'cart']}, 12:11:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:11:37 INFO - 'tsvgr_opacity', 12:11:37 INFO - 'tart', 12:11:37 INFO - 'tscrollx', 12:11:37 INFO - 'cart']}, 12:11:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:11:37 INFO - 'talos_options': ['--disable-e10s'], 12:11:37 INFO - 'tests': ['tp5o']}, 12:11:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:11:37 INFO - 'tests': ['tp5o']}, 12:11:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:11:37 INFO - 'talos_options': ['--disable-e10s', 12:11:37 INFO - '--xperf_path', 12:11:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:11:37 INFO - 'tests': ['tp5n']}, 12:11:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:11:37 INFO - 'talos_options': ['--xperf_path', 12:11:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:11:37 INFO - 'tests': ['tp5n']}}, 12:11:37 INFO - 'talos.zip': {'path': '', 12:11:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:11:37 INFO - Running post-action listener: _resource_record_post_action 12:11:37 INFO - [mozharness: 2017-02-06 20:11:37.534602Z] Finished populate-webroot step (success) 12:11:37 INFO - [mozharness: 2017-02-06 20:11:37.534690Z] Running create-virtualenv step. 12:11:37 INFO - Running pre-action listener: _resource_record_pre_action 12:11:37 INFO - Running main action method: create_virtualenv 12:11:37 INFO - Creating virtualenv /builds/slave/test/build/venv 12:11:37 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:11:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:11:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:11:37 INFO - Using real prefix '/usr' 12:11:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:11:38 INFO - Installing distribute.............................................................................................................................................................................................done. 12:11:40 INFO - Installing pip.................done. 12:11:40 INFO - Return code: 0 12:11:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:11:40 INFO - Reading from file tmpfile_stdout 12:11:40 INFO - Output received: 12:11:40 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:11:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f57c1b00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', '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:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:11:40 INFO - Using env: {'DISPLAY': ':0', 12:11:40 INFO - 'HOME': '/home/cltbld', 12:11:40 INFO - 'LANG': 'en_US.UTF-8', 12:11:40 INFO - 'LANGUAGE': 'en_US:en', 12:11:40 INFO - 'LOGNAME': 'cltbld', 12:11:40 INFO - 'MAIL': '/var/mail/cltbld', 12:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:40 INFO - 'MOZ_NO_REMOTE': '1', 12:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:40 INFO - 'NO_EM_RESTART': '1', 12:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:40 INFO - 'PWD': '/builds/slave/test', 12:11:40 INFO - 'SHELL': '/bin/bash', 12:11:40 INFO - 'SHLVL': '1', 12:11:40 INFO - 'TERM': 'linux', 12:11:40 INFO - 'TMOUT': '86400', 12:11:40 INFO - 'USER': 'cltbld', 12:11:40 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', 12:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:40 INFO - '_': '/tools/buildbot/bin/python'} 12:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:40 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:11:40 INFO - Cleaning up... 12:11:40 INFO - Return code: 0 12:11:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f57c1b00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', '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:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:11:40 INFO - Using env: {'DISPLAY': ':0', 12:11:40 INFO - 'HOME': '/home/cltbld', 12:11:40 INFO - 'LANG': 'en_US.UTF-8', 12:11:40 INFO - 'LANGUAGE': 'en_US:en', 12:11:40 INFO - 'LOGNAME': 'cltbld', 12:11:40 INFO - 'MAIL': '/var/mail/cltbld', 12:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:40 INFO - 'MOZ_NO_REMOTE': '1', 12:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:40 INFO - 'NO_EM_RESTART': '1', 12:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:40 INFO - 'PWD': '/builds/slave/test', 12:11:40 INFO - 'SHELL': '/bin/bash', 12:11:40 INFO - 'SHLVL': '1', 12:11:40 INFO - 'TERM': 'linux', 12:11:40 INFO - 'TMOUT': '86400', 12:11:40 INFO - 'USER': 'cltbld', 12:11:40 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', 12:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:40 INFO - '_': '/tools/buildbot/bin/python'} 12:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:40 INFO - Downloading/unpacking psutil>=3.1.1 12:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:11:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:11:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:11:42 INFO - Installing collected packages: psutil 12:11:42 INFO - Running setup.py install for psutil 12:11:42 INFO - building 'psutil._psutil_linux' extension 12:11:42 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:11:43 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:11:43 INFO - building 'psutil._psutil_posix' extension 12:11:43 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:11:43 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:11:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:11:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:11:43 INFO - Successfully installed psutil 12:11:43 INFO - Cleaning up... 12:11:43 INFO - Return code: 0 12:11:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:43 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 0x7f57c1b00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', '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:11:43 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:11:43 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:11:43 INFO - Using env: {'DISPLAY': ':0', 12:11:43 INFO - 'HOME': '/home/cltbld', 12:11:43 INFO - 'LANG': 'en_US.UTF-8', 12:11:43 INFO - 'LANGUAGE': 'en_US:en', 12:11:43 INFO - 'LOGNAME': 'cltbld', 12:11:43 INFO - 'MAIL': '/var/mail/cltbld', 12:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:43 INFO - 'MOZ_NO_REMOTE': '1', 12:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:43 INFO - 'NO_EM_RESTART': '1', 12:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:43 INFO - 'PWD': '/builds/slave/test', 12:11:43 INFO - 'SHELL': '/bin/bash', 12:11:43 INFO - 'SHLVL': '1', 12:11:43 INFO - 'TERM': 'linux', 12:11:43 INFO - 'TMOUT': '86400', 12:11:43 INFO - 'USER': 'cltbld', 12:11:43 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', 12:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:43 INFO - '_': '/tools/buildbot/bin/python'} 12:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:11:43 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:11:43 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:11:43 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:11:43 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:11:43 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:11:43 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:11:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:11:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:11:45 INFO - Installing collected packages: mozsystemmonitor 12:11:45 INFO - Running setup.py install for mozsystemmonitor 12:11:45 INFO - Successfully installed mozsystemmonitor 12:11:45 INFO - Cleaning up... 12:11:45 INFO - Return code: 0 12:11:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:11:45 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:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:45 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:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:45 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 0x7f57c1b00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', '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:11:45 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:11:45 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:11:45 INFO - Using env: {'DISPLAY': ':0', 12:11:45 INFO - 'HOME': '/home/cltbld', 12:11:45 INFO - 'LANG': 'en_US.UTF-8', 12:11:45 INFO - 'LANGUAGE': 'en_US:en', 12:11:45 INFO - 'LOGNAME': 'cltbld', 12:11:45 INFO - 'MAIL': '/var/mail/cltbld', 12:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:45 INFO - 'MOZ_NO_REMOTE': '1', 12:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:45 INFO - 'NO_EM_RESTART': '1', 12:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:45 INFO - 'PWD': '/builds/slave/test', 12:11:45 INFO - 'SHELL': '/bin/bash', 12:11:45 INFO - 'SHLVL': '1', 12:11:45 INFO - 'TERM': 'linux', 12:11:45 INFO - 'TMOUT': '86400', 12:11:45 INFO - 'USER': 'cltbld', 12:11:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', 12:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:45 INFO - '_': '/tools/buildbot/bin/python'} 12:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:46 INFO - Downloading/unpacking jsonschema==2.5.1 12:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:11:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:11:48 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:11:48 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:11:48 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:11:48 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:11:48 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:11:48 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:11:48 INFO - Downloading functools32-3.2.3-2.tar.gz 12:11:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:11:48 INFO - warning: no files found matching '*.txt' 12:11:48 INFO - no previously-included directories found matching 'build' 12:11:48 INFO - no previously-included directories found matching 'dist' 12:11:48 INFO - no previously-included directories found matching '.git*' 12:11:48 INFO - Installing collected packages: jsonschema, functools32 12:11:48 INFO - Running setup.py install for functools32 12:11:48 INFO - warning: no files found matching '*.txt' 12:11:48 INFO - no previously-included directories found matching 'build' 12:11:48 INFO - no previously-included directories found matching 'dist' 12:11:48 INFO - no previously-included directories found matching '.git*' 12:11:48 INFO - Successfully installed jsonschema functools32 12:11:48 INFO - Cleaning up... 12:11:48 INFO - Return code: 0 12:11:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:11:48 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:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:48 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:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:48 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 0x7f57c1b00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', '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:11:48 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:11:48 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:11:48 INFO - Using env: {'DISPLAY': ':0', 12:11:48 INFO - 'HOME': '/home/cltbld', 12:11:48 INFO - 'LANG': 'en_US.UTF-8', 12:11:48 INFO - 'LANGUAGE': 'en_US:en', 12:11:48 INFO - 'LOGNAME': 'cltbld', 12:11:48 INFO - 'MAIL': '/var/mail/cltbld', 12:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:48 INFO - 'MOZ_NO_REMOTE': '1', 12:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:48 INFO - 'NO_EM_RESTART': '1', 12:11:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:48 INFO - 'PWD': '/builds/slave/test', 12:11:48 INFO - 'SHELL': '/bin/bash', 12:11:48 INFO - 'SHLVL': '1', 12:11:48 INFO - 'TERM': 'linux', 12:11:48 INFO - 'TMOUT': '86400', 12:11:48 INFO - 'USER': 'cltbld', 12:11:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', 12:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:48 INFO - '_': '/tools/buildbot/bin/python'} 12:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:11:48 INFO - Cleaning up... 12:11:48 INFO - Return code: 0 12:11:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:11:48 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:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:48 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:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:48 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 0x7f57c1b00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', '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:11:48 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:11:48 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:11:48 INFO - Using env: {'DISPLAY': ':0', 12:11:48 INFO - 'HOME': '/home/cltbld', 12:11:48 INFO - 'LANG': 'en_US.UTF-8', 12:11:48 INFO - 'LANGUAGE': 'en_US:en', 12:11:48 INFO - 'LOGNAME': 'cltbld', 12:11:48 INFO - 'MAIL': '/var/mail/cltbld', 12:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:48 INFO - 'MOZ_NO_REMOTE': '1', 12:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:48 INFO - 'NO_EM_RESTART': '1', 12:11:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:48 INFO - 'PWD': '/builds/slave/test', 12:11:48 INFO - 'SHELL': '/bin/bash', 12:11:48 INFO - 'SHLVL': '1', 12:11:48 INFO - 'TERM': 'linux', 12:11:48 INFO - 'TMOUT': '86400', 12:11:48 INFO - 'USER': 'cltbld', 12:11:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', 12:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:48 INFO - '_': '/tools/buildbot/bin/python'} 12:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:49 INFO - Downloading/unpacking blobuploader==1.2.4 12:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:51 INFO - Downloading blobuploader-1.2.4.tar.gz 12:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:11:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:11:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:51 INFO - Downloading docopt-0.6.1.tar.gz 12:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:11:51 INFO - Installing collected packages: blobuploader, requests, docopt 12:11:51 INFO - Running setup.py install for blobuploader 12:11:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:11:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:11:51 INFO - Running setup.py install for requests 12:11:52 INFO - Running setup.py install for docopt 12:11:52 INFO - Successfully installed blobuploader requests docopt 12:11:52 INFO - Cleaning up... 12:11:52 INFO - Return code: 0 12:11:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:52 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 0x7f57c1b00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', '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:11:52 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:11:52 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:11:52 INFO - Using env: {'DISPLAY': ':0', 12:11:52 INFO - 'HOME': '/home/cltbld', 12:11:52 INFO - 'LANG': 'en_US.UTF-8', 12:11:52 INFO - 'LANGUAGE': 'en_US:en', 12:11:52 INFO - 'LOGNAME': 'cltbld', 12:11:52 INFO - 'MAIL': '/var/mail/cltbld', 12:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:52 INFO - 'MOZ_NO_REMOTE': '1', 12:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:52 INFO - 'NO_EM_RESTART': '1', 12:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:52 INFO - 'PWD': '/builds/slave/test', 12:11:52 INFO - 'SHELL': '/bin/bash', 12:11:52 INFO - 'SHLVL': '1', 12:11:52 INFO - 'TERM': 'linux', 12:11:52 INFO - 'TMOUT': '86400', 12:11:52 INFO - 'USER': 'cltbld', 12:11:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', 12:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:52 INFO - '_': '/tools/buildbot/bin/python'} 12:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:11:52 INFO - Running setup.py (path:/tmp/pip-Gqt7Ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:11:52 INFO - Running setup.py (path:/tmp/pip-DguqhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:11:52 INFO - Running setup.py (path:/tmp/pip-Z43Wz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:11:52 INFO - Running setup.py (path:/tmp/pip-Go2tDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:11:52 INFO - Running setup.py (path:/tmp/pip-z2vFeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:11:53 INFO - Running setup.py (path:/tmp/pip-V_NuqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:11:53 INFO - Running setup.py (path:/tmp/pip-bceIuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:11:53 INFO - Running setup.py (path:/tmp/pip-LT8Re2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:11:53 INFO - Running setup.py (path:/tmp/pip-QwB6KU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:11:53 INFO - Running setup.py (path:/tmp/pip-Yl4doN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:11:53 INFO - Running setup.py (path:/tmp/pip-PMRBtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:11:53 INFO - Running setup.py (path:/tmp/pip-cCaMhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:11:53 INFO - Running setup.py (path:/tmp/pip-jYBfEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:11:53 INFO - Running setup.py (path:/tmp/pip-3hPHa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:11:53 INFO - Running setup.py (path:/tmp/pip-Hw3QiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:11:53 INFO - Running setup.py (path:/tmp/pip-q8CCON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:11:53 INFO - Running setup.py (path:/tmp/pip-DVZXQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:11:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:11:53 INFO - Running setup.py install for manifestparser 12:11:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:11:54 INFO - Running setup.py install for mozcrash 12:11:54 INFO - Running setup.py install for mozdebug 12:11:54 INFO - Running setup.py install for mozdevice 12:11:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:11:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:11:54 INFO - Running setup.py install for mozfile 12:11:54 INFO - Running setup.py install for mozhttpd 12:11:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:11:54 INFO - Running setup.py install for mozinfo 12:11:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:11:54 INFO - Running setup.py install for mozInstall 12:11:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:11:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:11:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:11:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:11:54 INFO - Running setup.py install for mozleak 12:11:54 INFO - Running setup.py install for mozlog 12:11:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:11:54 INFO - Running setup.py install for moznetwork 12:11:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:11:55 INFO - Running setup.py install for mozprocess 12:11:55 INFO - Running setup.py install for mozprofile 12:11:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:11:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:11:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:11:55 INFO - Running setup.py install for mozrunner 12:11:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:11:55 INFO - Running setup.py install for mozscreenshot 12:11:55 INFO - Running setup.py install for moztest 12:11:55 INFO - Running setup.py install for mozversion 12:11:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:11:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:11:55 INFO - Cleaning up... 12:11:55 INFO - Return code: 0 12:11:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:11: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:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11: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:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:55 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 0x7f57c1b00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', '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:11:55 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:11:55 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:11:55 INFO - Using env: {'DISPLAY': ':0', 12:11:55 INFO - 'HOME': '/home/cltbld', 12:11:55 INFO - 'LANG': 'en_US.UTF-8', 12:11:55 INFO - 'LANGUAGE': 'en_US:en', 12:11:55 INFO - 'LOGNAME': 'cltbld', 12:11:55 INFO - 'MAIL': '/var/mail/cltbld', 12:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:55 INFO - 'MOZ_NO_REMOTE': '1', 12:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:55 INFO - 'NO_EM_RESTART': '1', 12:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:55 INFO - 'PWD': '/builds/slave/test', 12:11:55 INFO - 'SHELL': '/bin/bash', 12:11:55 INFO - 'SHLVL': '1', 12:11:55 INFO - 'TERM': 'linux', 12:11:55 INFO - 'TMOUT': '86400', 12:11:55 INFO - 'USER': 'cltbld', 12:11:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', 12:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:55 INFO - '_': '/tools/buildbot/bin/python'} 12:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:11:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:11:55 INFO - Running setup.py (path:/tmp/pip-g64c8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:11:56 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:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:11:56 INFO - Running setup.py (path:/tmp/pip-EtNEKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:11:56 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:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:11:56 INFO - Running setup.py (path:/tmp/pip-wfnxg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:11:56 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:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:11:56 INFO - Running setup.py (path:/tmp/pip-n65tUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:11:56 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:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:11:56 INFO - Running setup.py (path:/tmp/pip-L8poEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:11:56 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:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:11:56 INFO - Running setup.py (path:/tmp/pip-ZsQe10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:11:56 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:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:11:56 INFO - Running setup.py (path:/tmp/pip-9u1eS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:11:56 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:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:11:56 INFO - Running setup.py (path:/tmp/pip-XgS7mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:11:56 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:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:11:56 INFO - Running setup.py (path:/tmp/pip-opUM5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:11:56 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:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:11:56 INFO - Running setup.py (path:/tmp/pip-F5OLpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:11:56 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:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:11:56 INFO - Running setup.py (path:/tmp/pip-bQu_RF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:11:56 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:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:11:56 INFO - Running setup.py (path:/tmp/pip-aZIMmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:11:56 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:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:11:56 INFO - Running setup.py (path:/tmp/pip-TZznvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:11:56 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:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:11:56 INFO - Running setup.py (path:/tmp/pip-qXxSe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:11:56 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:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:11:56 INFO - Running setup.py (path:/tmp/pip-ZPxHHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:11:57 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:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:11:57 INFO - Running setup.py (path:/tmp/pip-rXBVjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:11:57 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:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:11:57 INFO - Running setup.py (path:/tmp/pip-KiAODS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:11:57 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:11:57 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:11:57 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:11:57 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:11:57 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:11:57 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:11:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:11: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:11: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:11: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:11:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11: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:11: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:11:59 INFO - Downloading blessings-1.6.tar.gz 12:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:11:59 INFO - Installing collected packages: blessings 12:11:59 INFO - Running setup.py install for blessings 12:11:59 INFO - Successfully installed blessings 12:11:59 INFO - Cleaning up... 12:11:59 INFO - Return code: 0 12:11:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:11:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:11:59 INFO - Reading from file tmpfile_stdout 12:11:59 INFO - Current package versions: 12:11:59 INFO - argparse == 1.2.1 12:11:59 INFO - blessings == 1.6 12:11:59 INFO - blobuploader == 1.2.4 12:11:59 INFO - docopt == 0.6.1 12:11:59 INFO - functools32 == 3.2.3-2 12:11:59 INFO - jsonschema == 2.5.1 12:11:59 INFO - manifestparser == 1.1 12:11:59 INFO - mozInstall == 1.12 12:11:59 INFO - mozcrash == 1.0 12:11:59 INFO - mozdebug == 0.1 12:11:59 INFO - mozdevice == 0.48 12:11:59 INFO - mozfile == 1.2 12:11:59 INFO - mozhttpd == 0.7 12:11:59 INFO - mozinfo == 0.9 12:11:59 INFO - mozleak == 0.1 12:11:59 INFO - mozlog == 3.4 12:11:59 INFO - moznetwork == 0.27 12:11:59 INFO - mozprocess == 0.23 12:11:59 INFO - mozprofile == 0.28 12:11:59 INFO - mozrunner == 6.13 12:11:59 INFO - mozscreenshot == 0.1 12:11:59 INFO - mozsystemmonitor == 0.3 12:11:59 INFO - moztest == 0.8 12:11:59 INFO - mozversion == 1.4 12:11:59 INFO - psutil == 3.1.1 12:11:59 INFO - requests == 1.2.3 12:11:59 INFO - wsgiref == 0.1.2 12:11:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:11:59 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:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:59 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:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:11:59 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 0x7f57c1b00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', '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:11:59 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:11:59 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:11:59 INFO - Using env: {'DISPLAY': ':0', 12:11:59 INFO - 'HOME': '/home/cltbld', 12:11:59 INFO - 'LANG': 'en_US.UTF-8', 12:11:59 INFO - 'LANGUAGE': 'en_US:en', 12:11:59 INFO - 'LOGNAME': 'cltbld', 12:11:59 INFO - 'MAIL': '/var/mail/cltbld', 12:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:59 INFO - 'MOZ_NO_REMOTE': '1', 12:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:11:59 INFO - 'NO_EM_RESTART': '1', 12:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:59 INFO - 'PWD': '/builds/slave/test', 12:11:59 INFO - 'SHELL': '/bin/bash', 12:11:59 INFO - 'SHLVL': '1', 12:11:59 INFO - 'TERM': 'linux', 12:11:59 INFO - 'TMOUT': '86400', 12:11:59 INFO - 'USER': 'cltbld', 12:11:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', 12:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:59 INFO - '_': '/tools/buildbot/bin/python'} 12:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:00 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:12:00 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:12:00 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:12:00 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:12:00 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:12:00 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:12:00 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:12:00 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:12:00 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:12:00 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:12:00 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:12:00 INFO - Cleaning up... 12:12:00 INFO - Return code: 0 12:12:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:12:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f57c1b00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b10ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', '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:12:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:12:00 INFO - Using env: {'DISPLAY': ':0', 12:12:00 INFO - 'HOME': '/home/cltbld', 12:12:00 INFO - 'LANG': 'en_US.UTF-8', 12:12:00 INFO - 'LANGUAGE': 'en_US:en', 12:12:00 INFO - 'LOGNAME': 'cltbld', 12:12:00 INFO - 'MAIL': '/var/mail/cltbld', 12:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:00 INFO - 'MOZ_NO_REMOTE': '1', 12:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:12:00 INFO - 'NO_EM_RESTART': '1', 12:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:00 INFO - 'PWD': '/builds/slave/test', 12:12:00 INFO - 'SHELL': '/bin/bash', 12:12:00 INFO - 'SHLVL': '1', 12:12:00 INFO - 'TERM': 'linux', 12:12:00 INFO - 'TMOUT': '86400', 12:12:00 INFO - 'USER': 'cltbld', 12:12:00 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', 12:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:00 INFO - '_': '/tools/buildbot/bin/python'} 12:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:12:00 INFO - Cleaning up... 12:12:00 INFO - Return code: 0 12:12:00 INFO - Running post-action listener: _resource_record_post_action 12:12:00 INFO - Running post-action listener: _start_resource_monitoring 12:12:00 INFO - Starting resource monitoring. 12:12:00 INFO - [mozharness: 2017-02-06 20:12:00.388422Z] Finished create-virtualenv step (success) 12:12:00 INFO - [mozharness: 2017-02-06 20:12:00.388926Z] Running install step. 12:12:00 INFO - Running pre-action listener: _resource_record_pre_action 12:12:00 INFO - Running main action method: install 12:12:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:12:00 INFO - Reading from file tmpfile_stdout 12:12:00 INFO - Detecting whether we're running mozinstall >=1.0... 12:12:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:12:00 INFO - Reading from file tmpfile_stdout 12:12:00 INFO - Output received: 12:12:00 INFO - Usage: mozinstall [options] installer 12:12:00 INFO - Options: 12:12:00 INFO - -h, --help show this help message and exit 12:12:00 INFO - -d DEST, --destination=DEST 12:12:00 INFO - Directory to install application into. [default: 12:12:00 INFO - "/builds/slave/test"] 12:12:00 INFO - --app=APP Application being installed. [default: firefox] 12:12:00 INFO - mkdir: /builds/slave/test/build/application 12:12:00 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:12:00 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:12:14 INFO - Reading from file tmpfile_stdout 12:12:14 INFO - Output received: 12:12:14 INFO - /builds/slave/test/build/application/firefox/firefox 12:12:14 INFO - Running post-action listener: _resource_record_post_action 12:12:14 INFO - [mozharness: 2017-02-06 20:12:14.314474Z] Finished install step (success) 12:12:14 INFO - [mozharness: 2017-02-06 20:12:14.314718Z] Running run-tests step. 12:12:14 INFO - Running pre-action listener: _resource_record_pre_action 12:12:14 INFO - Running main action method: run_tests 12:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:12:14 INFO - Python 2.7.3 12:12:14 INFO - Return code: 0 12:12:14 INFO - grabbing minidump binary from tooltool 12:12:14 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:12:14 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 0x1b0df60>, '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 0x1b0ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:12:14 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:12:14 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:12:14 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:12:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:12:14 INFO - Return code: 0 12:12:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:12:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:12:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:12:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:12:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:12:14 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/Jbxrd0rpQSu0mYWugw_o5Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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:12:14 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/Jbxrd0rpQSu0mYWugw_o5Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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:12:14 INFO - Using env: {'DISPLAY': ':0', 12:12:14 INFO - 'HOME': '/home/cltbld', 12:12:14 INFO - 'LANG': 'en_US.UTF-8', 12:12:14 INFO - 'LANGUAGE': 'en_US:en', 12:12:14 INFO - 'LOGNAME': 'cltbld', 12:12:14 INFO - 'MAIL': '/var/mail/cltbld', 12:12:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:12:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:12:14 INFO - 'MOZ_NO_REMOTE': '1', 12:12:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:12:14 INFO - 'NO_EM_RESTART': '1', 12:12:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:12:14 INFO - 'PWD': '/builds/slave/test', 12:12:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:12:14 INFO - 'SHELL': '/bin/bash', 12:12:14 INFO - 'SHLVL': '1', 12:12:14 INFO - 'TERM': 'linux', 12:12:14 INFO - 'TMOUT': '86400', 12:12:14 INFO - 'USER': 'cltbld', 12:12:14 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206', 12:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:12:14 INFO - '_': '/tools/buildbot/bin/python'} 12:12:14 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/Jbxrd0rpQSu0mYWugw_o5Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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:12:14 INFO - mozversion application_buildid: 20170206101855 12:12:14 INFO - mozversion application_changeset: 501a3fa83897af9598adfd6f794b5d5ea82fe237 12:12:14 INFO - mozversion application_display_name: Firefox 12:12:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:12:14 INFO - mozversion application_name: Firefox 12:12:14 INFO - mozversion application_remotingname: firefox 12:12:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:12:14 INFO - mozversion application_vendor: Mozilla 12:12:14 INFO - mozversion application_version: 52.0 12:12:14 INFO - mozversion platform_buildid: 20170206101855 12:12:14 INFO - mozversion platform_changeset: 501a3fa83897af9598adfd6f794b5d5ea82fe237 12:12:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:12:14 INFO - mozversion platform_version: 52.0 12:12:14 INFO - using testdate: 1486411934 12:12:14 INFO - actual date: 1486411934 12:12:14 INFO - starting webserver on 'localhost:48782' 12:12:14 INFO - SUITE-START | Running 2 tests 12:12:14 INFO - TEST-START | dromaeo_css 12:12:14 INFO - operating with platform_type : linux_ 12:12:14 INFO - Initialising browser for dromaeo_css test... 12:12:14 INFO - TEST-INFO | started process 5707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDFytnj/profile http://localhost:48782/getInfo.html) 12:12:18 INFO - PROCESS | 5707 | __metrics Screen width/height:1600/1200 12:12:18 INFO - PROCESS | 5707 | colorDepth:24 12:12:18 INFO - PROCESS | 5707 | Browser inner width/height: 1024/697 12:12:18 INFO - PROCESS | 5707 | __metrics 12:12:19 INFO - PROCESS | 5707 | 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:12:19 INFO - PROCESS | 5707 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:12:19 INFO - PROCESS | 5707 | console.error: PushService: 12:12:19 INFO - PROCESS | 5707 | stateChangeProcessEnqueue: Error transitioning state 12:12:19 INFO - PROCESS | 5707 | UnknownError 12:12:20 INFO - TEST-INFO | 5707: exit 0 12:12:20 INFO - Browser initialized. 12:12:20 INFO - Running cycle 1/1 for dromaeo_css test... 12:12:20 INFO - TEST-INFO | started process 5800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDFytnj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:12:31 INFO - PROCESS | 5800 | RSS: Main: 145170432 12:12:31 INFO - PROCESS | 5800 | 12:15:33 INFO - PROCESS | 5800 | Cycle 1(1): loaded http://localhost:48782/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48782/tests/dromaeo/cssquery-ext.html) 12:15:34 INFO - PROCESS | 5800 | RSS: Main: 246185984 12:15:34 INFO - PROCESS | 5800 | 12:18:36 INFO - PROCESS | 5800 | Cycle 1(1): loaded http://localhost:48782/tests/dromaeo/cssquery-ext.html (next: http://localhost:48782/tests/dromaeo/cssquery-jquery.html) 12:18:37 INFO - PROCESS | 5800 | RSS: Main: 223789056 12:18:37 INFO - PROCESS | 5800 | 12:21:39 INFO - PROCESS | 5800 | Cycle 1(1): loaded http://localhost:48782/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48782/tests/dromaeo/cssquery-mootools.html) 12:21:39 INFO - PROCESS | 5800 | RSS: Main: 219500544 12:21:39 INFO - PROCESS | 5800 | 12:24:41 INFO - PROCESS | 5800 | Cycle 1(1): loaded http://localhost:48782/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48782/tests/dromaeo/cssquery-prototype.html) 12:24:42 INFO - PROCESS | 5800 | RSS: Main: 218759168 12:24:42 INFO - PROCESS | 5800 | 12:27:44 INFO - PROCESS | 5800 | Cycle 1(1): loaded http://localhost:48782/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48782/tests/dromaeo/cssquery-yui.html) 12:27:45 INFO - PROCESS | 5800 | RSS: Main: 176476160 12:27:45 INFO - PROCESS | 5800 | 12:30:47 INFO - PROCESS | 5800 | Cycle 1(1): loaded http://localhost:48782/tests/dromaeo/cssquery-yui.html (next: http://localhost:48782/tests/dromaeo/cssquery-dojo.html) 12:30:47 INFO - PROCESS | 5800 | RSS: Main: 265441280 12:30:47 INFO - PROCESS | 5800 | 12:30:47 INFO - PROCESS | 5800 | __start_tp_report 12:30:47 INFO - PROCESS | 5800 | _x_x_mozilla_page_load 12:30:47 INFO - PROCESS | 5800 | _x_x_mozilla_page_load_details 12:30:47 INFO - PROCESS | 5800 | |i|pagename|runs| 12:30:47 INFO - PROCESS | 5800 | |0;dojo.html;3207.406629773491;3236.239483721325;3240.67593240676;3266.8856590019323;3288.473844184931;5593.748281327345;5693.743781529831;5710.343310519292;5711.200431939532;5722.055860782966;5705.714714264281;5756.251687280647;5761.596688231815;5764.423557644233;5764.740586673599;5188.455212202721;5207.6354655174155;5215.374155101393;5257.316548848664;5281.155015197569;5079;5085.669431486942;5132.589392848582;5298.284731561248;5308.009496438835;5178.352705911761;5253.711045892474;5263.947360526403;5266.7366631668265;5290.206469029637;5262.105442074857;5265.6840589564745;5285.7621407036395;5289.603279753996;5296;4957.677750946177;5051.873703157414;5172.431032586413;5179.663321884065;5248.239005344242;5482.17767334899;5530.336359636869;5538.75075621598;5544.667319960815;5591.860203494945;5990.281166260033;6003.519718422515;6013.458788709037;6047.667378294192;6074.757009719606;5875.500582450497;6131.417515336036;6140.754369825202;6155.076738489218;6163;5524.8342549723175;5640.8307750767135;5685.346185188673;5692.516136128475;5717.942820571741;6258.217722784652;6259.061140828912;6264.436200741864;6266.780662676784;6270.028145637433;5797.594168408255;6021.397860214031;6023.367546407651;6026.54800889935;6029.879402411927;5870.354261031283;6019.939800601938;6040.214772079602;6043.909341359883;6134.325224225332;6045.909311360333;6093.29927058394;6102.72537735803;6104.3590423005835;6114.327423983358;6085.087236914498;6110.5143811910975;6112.442689633966;6119.60364487372;6123.191113103742;4560.908781824412;4570.428696412949;4607.44710634726;4611.216093264153;4623.606993405531;4141.710080294411;4145.419641250227;4149.605787450188;4152.356384760367;4174.3321068628875;5708.971455142698;5713.457221563945;5725.484706376363;5727.312722473246;5731;5882.117682347682;5915.526757859361;5994.880102397928;6052.818415447544;6071.726772295257;5753.8561535961935;5755.539556835443;5761.4526619971875;5768.048272035067;5791.160281759121;5176.4047134580005;5181.326427564392;5189.740512974412;5190.03984262905;5251;6031.728572214261;6078.027515597483;6209.844753881189;6299.0866324382705;6317.96841015792;5936.703164841827;6110.771402862413;6114.205153330038;6118;6144.201253836973;6280.371962803683;6331.556791024584;6333.050042493479;6334.746610135543;6336.08126821599;5769.567282453749;5781.537477001913;5989.460948514655;5990.400959904149;5990.7903223386975;5978.551608629283;5998.520118390606;6014.03775395952;6098.359672234352;6122.755089796358;5902.881942361215;5933.110033495011;5935.762569497172;5938.524918006636;5948.40515948419;5642.689652069012;5935.139404786368;5936.910946335895;5946.881062378815;5950.9702451487465;5678.517326027334;5787.8553036174435;5794.768209271582;5813.651180929158;5926.733297001559;5952.970235148797;5956.5532585055425;5960.701964901824;5967.522598192221;5969.104634304889;5654;5688.317401911797;5733.770649174153;5806.361300256884;5810.5351571875 12:30:47 INFO - PROCESS | 5800 | |1;ext.html;583.224311665485;597.3429227849366;632.7911789109593;640.4364159539607;657.359074901971;32487.67512324876;33353.16617084574;35306.29387412254;44028.119437611305;45101.323480147825;44808.775956120175;45447;45521.54478455214;45560.54439455605;45597.31604025934;8808.77978050549;8952.8657070144;8953.015168331478;8961.462312261285;8961.910380896174;8286.83426331473;8475.83048339033;8771.342149338794;8868.33487488441;10498.527566259536;10869.782604347909;10941.179411544126;10967.067799237075;10981.61564345248;10988.615398461056;10701.625443109493;10765.192610554239;10777.137828973664;10777.191710621695;10786.406747628876;10607.946960265226;10692.98416650417;10696.251262411633;10698.197635177392;10698.786024279549;42741.78629106835;42762;42816.357754633704;42849.35725964113;43032.3545146823;3673.0633688409284;3695.8891233263043;3708.684761795251;3801.9809900950595;3826.521684789401;31468.37063258745;31750.364992700015;32079.19802004945;32139;32654;4356.302991521373;4384.298512238027;4417.403650507173;4427.275446117043;4434.60088592025;320365;321018;322005;323465;323537;57924.131138032964;58065.129023064685;58291;58302.7084864573;58344;35597.82201088978;35810.46284305737;35896;56090.158647620316;56129.43870561324;18540.629187416445;18625.53436164107;18639.254429822657;18647.067646617616;18705.53236169107;14349.713005739826;14455.421783128557;14461.276936153361;14471;14474.059186152866;17911.92528448297;18170.545736356697;18226.63546729058;18564.071796410124;19577.560526999932;7168.964155179295;7264;7323.487355885037;7326.413886889036;7396.631623149735;957.698325027614;1010.7473131717071;1013.2147585621202;1107.6676996900896;1132.8583927009124;32088.358232835213;35022.47466288008;35169.64830351664;35870.46194307088;36535.26929461396;1080.2654195147375;1080.9189310801721;1097.1003776903024;1125.7241975716001;1126.1947707389093;14594.489192878198;16707.749383759252;17703;17880.195391207428;18031.368902088365;506803;509942;511216;511528;511773;56603;57104.14343784846;57168.71415642895;57239;57251.14123288154;1392.1786146173806;1423.9572812815632;1439.6832696806687;1452.0271418149864;1464.8461911499353;31155.844220778752;32798.18004549905;33137.337253254314;33302.335813135374;33445.83277083599;51152;52312.738436307576;52491.47508524866;52506;52517.474825252786;416533;417257;419395;420858;423920;25372.873135634203;27552.586711198946;28273.293167670974;28762.712372876;28935.131946041653;46422.53577464317;46455.76772116118;46880.7655961718;46929.765351173024;47273.29090063721;39098.21803563856;39475.60524394834;39560.208795823346;40274.59725402708;40622;38834.6116538831;39235.60764392434;39253.41119883261;39864.60135398609;40477.595224047385;38879.6112038876;39013.609863900994;39994.2001159981;40209.39685904772;40256;33404.498932516515;35678.464823027156;35700.28599427945;36328.27343453063;36436.81781591075;26843;27141.321466963484;27212.183634490997;27383.178504644893;27763.305917352227 12:30:47 INFO - PROCESS | 5800 | |2;jquery.html;394.97897933841017;402.37832548712237;415.47442485256147;418.61487431562966;426.48821414302824;14772.926135369335;18675;19573.608527829434;20462.07920643571;20466.692999605;16168.434104806334;16617.169141542934;16799.328026878942;20049.398518044483;20303.187872485083;5772.855678608026;5882.529397648189;5987.371326010772;6039.486643635296;6040.48655864252;5945.346011938684;5953.196318497013;5977.193078934353;5981.760729570834;5992.221011268529;5684.488396044355;5845.298564172284;5851.531877449794;5854.004819180728;5863.149843272723;5721.513671337942;5782.45066718661;5807.041838096709;5841.85395365115;5848.619839710405;5162.896742065175;5187.870303242411;5193.948060519422;5196.662216955886;5197.168453047494;23041.078356865706;23564.293071207892;23575.528489430286;23608.763912361;23707.1702490412;2265.535565209128;2295.472041430464;2391.246757271454;2661.920142395712;3103.239706271978;10622.203334749925;10811.297265677784;10844.6204382847;10931.45342732868;11240.662780116609;1970.704394340846;1980.7524059492564;1987.3541099142692;1994.2122861469784;2009.3670493794555;81192;82451.5877420609;83087;83319.5834020826;83493.58253208817;11247.943760281147;11426.485808138654;11485.368304743151;11566.94216528912;11594.594189203506;16532.75200871988;16567.751483727752;16568.17159142038;16571.91714041422;16580.088095154642;7759.961200193963;8199.918000820035;8317.625706843206;8566.742997710078;8608.182222688834;7777.144514103444;8103.554304513191;8149.674013039531;8182.509049457051;8192.67229310821;4971.105201063843;5045.117104506697;5074.188129899198;5081.339425874687;5126.794928202905;1806.1125437555593;2045.7238272832976;2047.5495391013953;2053.7330147080784;2082.344061620615;908.504864848659;961.0581630002637;1037.1288117980932;1054.7310435838965;1078.439211609974;19598.804011959983;19609.509762256057;19749.802501974795;19756.11097500616;20288.391348259574;956.8756061712072;968.080323692495;990.2770977186694;1005.3415013166388;1013.8580598716186;11034.448277586089;11075.335479871233;11141.108711303077;11157.995780379804;11162.107031437628;448700;472941;478854;490230;491318;88514.55742721245;89416;91500.54249728842;92667;94078.05921940693;969.5297780576415;978.6819283732815;995.3032876986139;997.5959736306808;1000.2048371544639;16926.407575735284;17484.21321040531;17635.823641763418;17671.204795783964;17696.345449143108;40766;43347.783261083496;44005.11989760251;44080;44736.328955066354;62111.37888621056;63793.68103159455;63795.68102159645;64378;65245.67377163084;8526.403151779316;8541.444806087584;8651.048384677555;8697.130286971253;8730.607122679368;12096.395180241128;12105.576304829288;12275.2021118627;12351.19717218378;12740.74518509606;10669.46652667348;11006.229563930769;11175.608853690082;11191.776164476501;11336.319820810777;10420.218483613911;10566.735831603964;10813.729656758644;11002.119830413707;11094.889051109709;10400.115990140923;10670.413127278074;10709.785804284027;11295.71760705956;11326.603568875049;7607.12518060408;8095.757127286191;8338.124496927736;8630.050694423482;9094;10200.540975656262;10376.636817711344;10882.45587720595;10913.945430273116;11276.94361528187 12:30:47 INFO - PROCESS | 5800 | |3;mootools.html;1505.7364961131807;1519.7796319533668;1679.8068222154448;1781.8218178182176;1819.8089200633933;8579.613917373717;9068.09319068093;9072.59173337199;9078.682246121387;9080.228180604656;7266.055412796329;7407.037085178919;7454.5899975501325;7634.885476717854;8864.77838054049;2383.976160238397;2468.2965354873863;2478.120267305108;2487.4776296977657;2491.402063504755;2411.6261979393134;2451.779339859412;2468.0744720729726;2476.393283645509;2487.129504673368;2402.339356676919;2419.4314336130997;2420.394901274681;2425.0784701813286;2425.466397392571;2350.27141586108;2371.7983971362455;2373.537160253751;2374.442006128558;2378.5124049569795;2375.3467796355967;2383.296927406402;2393.258089992108;2393.4255778613183;2401.795847352977;8835.072317406708;8903.065178156265;8910.153535414125;8924.509151996637;8977.865332020025;5309.36287645485;5438.6736795791985;5446.1558458439;5447.891042179174;5448.264484294609;3208.3477009339977;3361.697447229761;3519.859205631797;3520.119970007498;3532.1875968527124;1100.834874768783;1167.200467679642;1204.151073493185;1212.0122100488074;1247.1332423965348;12600.495980160875;12643.620691379274;12656.177348472413;12674.74650506994;12691.238525688488;4748.562895484651;4779.378680771478;4826.131296366618;4908.828191013297;4911.950880491221;10541.472926353652;10543.94728026355;10554.050135487689;10555.84166237507;10556.155507559377;5498.037843377393;5507.779688812483;5510.173473978935;5513.062779327443;5513.917291240635;4303.935440968388;4994.375703037121;5001.44984051754;5046.44489106198;5059.873503162376;3645.070507020746;3833.3483307837732;3955.4066889966734;3971.0469487322835;3980.3432433648704;1287.575100216926;1295.501232025677;1304.3999760110266;1308.1627758234738;1315.6710822294426;889.2397000564554;929.330881765128;929.419113054341;938.6463887362465;954.4225743425267;5657.066584013592;5693.146028095736;5742.626729262584;5791.189233507313;5881.500072493886;952.1858810716876;962.259060523407;983.4246965525105;987.4322264697828;990.9405435673883;3662.4140137578393;3798.981005094957;3821.9617803821607;3870.767753934773;3871.4967054283325;10929.071028962468;11070.944645276722;11152.944235278934;11188.160887933438;11212.822653621415;10397.84403233952;10879.075278601249;11087.55649774;11105.83341249882;11110.61112861046;8330.66677332912;8518.318534517224;8524.36067294943;8541.273991710774;8543.700970466129;5726.599138060295;5728.742206600797;5859.384764599826;5908.409159084057;6056.0007598745715;9985.400875947467;10114.848277275994;10168.593256269962;10172.372420412994;10178.134858537107;10567.365958042543;10618.73453163677;10714.839277411002;10728.873468285718;10729.034386905216;7743.225677432211;7947.8807817883935;8052;8107.716229931924;8110.229528194812;8418;8583.613737381958;8704.60829262672;8710;8710.172533609297;7551.697932082655;7562.357199638092;7613.467057305936;7670.42471814605;7691.730789422343;7446.292602202782;7635.847283054419;7678.385729141543;7703.961480192564;7791.220877912164;6706.329367063255;6804.4556435484055;6811.284815094542;6812.62530560804;6814.977753337039;4948.851534453972;4951.232558953368;5004.4495105537635;5016.2224855147515;5137.33214682089;4853.538913803183;4911.9754401227765;4920.1389756791705;4989.750512474435;5206.791728330824 12:30:47 INFO - PROCESS | 5800 | |4;prototype.html;347.2776624620789;352.5557797175558;364.7082334132696;365.6014943711354;368.07429315272094;5211.45279745627;5307.469253074691;5376.784928602856;5424.4846739559725;5442.911417716457;5160.845174644757;5288.867778305545;5290.365156181254;5292.797857296338;5294.497022782839;4249.150169966004;4272.273713468702;4272.914541709164;4277.529471758104;4284.721493102938;4200.663946884242;4219.156168766259;4244.427002354673;4263.467066616673;4292.29177185764;4222.59885310895;4230.9479902247385;4231.809568569406;4241.151769646083;4246.936295955563;4215.69313512812;4221.282381995053;4224.043169781135;4232.703710740249;4264.997725534497;3842.7886466244345;3843.3466310726963;3848.3457812171996;3856.980715096435;3872.244912242114;4977.32806071183;5204.713740744258;5206;5209.765560549784;5250.159974404077;4800.135975524404;4806.2310030394965;4811.8075276988875;4824.324594556765;4832.251001094836;5364.597655175839;5561.249231353756;5563.833085007456;5587.44125587438;5590.385057643656;4094.28350038742;4094.303968325392;4097.91804163918;4102.651274641659;4127.484064491939;5735;5756.712164391805;5771.913421298642;5792.478676919098;5819.67991760453;4192.161567686475;4194.993201631586;4202.642775364067;4209.010882442623;4212.641925436311;4008.8797336079965;4149.730267532601;4165.083681590046;4166.91666166675;4169.749815011109;4707.929381059287;4714;4714.717116972993;4716.6698331116495;4716.811327546929;5576;5602.159676048625;5616.691081990448;5637.605367624309;5655.123455864347;1338.110156745753;1340.825692659948;1396.6103726791907;1420.3182472413093;1420.7300612883519;964.3876138651866;991.7917237380086;992.2437286003733;1000.9399436033862;1009.268280496634;5120.61595380348;5128.205128205134;5151.175811870083;5160.509751573594;5168.664036837594;5454.754536045887;5457.69982650958;5460.808871689472;5464.644798088111;5489.368722596872;5112.71880046601;5147.613928955343;5154.226865970059;5166.81916132941;5415.1335786274;2896.174590241771;2923.5760814681753;2930.2527855397166;2947.2779169103705;2947.778916581265;5732.942670573241;5734.197212390269;5762.481376676035;5763.567732420085;5772.826815195551;5516.255305533701;5606.196901549225;5626.1842032905;5637.378618942212;5642.6614403135945;5713.085906255063;5731.140328950607;5742.856428589235;5743.62666426681;5752.597318187771;5427.810026649048;5505.412456145606;5576.5817563683695;5586.748596313257;5595.776168953196;5443.374011988513;5466;5468.589855760913;5474.014677358114;5480.424555421623;5752.395998420273;5761.695321871285;5780.8554786129;5786.218860453785;5796.188533605215;3938.4879965604287;4072;4078.1639763848934;4179.686523510688;4185.602367775056;5488.231647569263;5669.858253543694;5674.914876276776;5682.77268909239;5702.230198923092;5440.972795135999;5500.752466138953;5568.777248909998;5587.161925711176;5587.329520457409;5567.66594004361;5573.581981351496;5590.496855283044;5598.916016259678;5602.075657516627;5340.172273297645;5496.1755736639825;5504.834854954358;5532.253145825423;5547.200167885012;5584.441555844383;5588.748506317144;5593.804216852391;5614.522765564972;5649.717514124195;5459.5632349412745;5464.836054918359;5478.780848766005;5492.945070549244;5495.890082198253 12:30:47 INFO - PROCESS | 5800 | |5;yui.html;791.3115589437194;793.3256731777985;809.6194788449428;814.2432998699195;890.9866352004725;13970.231637259947;14804.481843135492;15008.249587520608;15114.47099351523;15220;12988.155769874951;14156.362963666634;14165.92917035416;14277.643058923506;14293.857061429382;833.9916600833975;850.8936382952131;851.902031266403;854.5257382152903;855.7774978505603;856.1139220906363;856.5802756649259;857.8069934264803;858.9312854971619;859.4928991894781;907.8229745199689;908.604756930734;909.245326379107;909.3907082254905;909.5088652127843;896.0457113174448;899.0739538275554;900.4057322167338;901.5266984832949;902.0798785239085;655.2333769489709;659.5844617890698;659.782271850293;660.2308310817891;660.4221306356937;13282.402291896791;13345;13403.396847141901;13862.237576933265;14066.085704429179;12696.301703406309;13295.667608309774;13301.933490332583;13439.924806015495;13487.460501579924;11022.283551569202;11072.280301780358;11141.944290278578;11372.14708896836;11388.487518061707;4347.826086956518;4433.733975961452;4453.599176074136;4496.775161241925;4583.977080114611;62756;63352.68323658352;63389.32485894023;63406.36593634051;64794.676026620036;11146.944265278622;11303;11303.830442543369;11320.490577924013;11370.31778093317;18813.529661758294;19339.8066019338;19971.101300441514;20042.298519551747;20142.093605787773;8491.915080849236;8548.316134709208;8552.358573107042;8607.18231767981;8732.91267087321;4826.227803551415;4849.563539281411;4867.099586576494;4896.6572339935865;5037.546620804145;3480.634533373959;3619.529461170031;3626.1478552540134;3630.2920930418313;3630.673239408466;568.5054003017401;579.3771695427348;588.5732843688291;597.1758972617846;599.2060519811267;752.7929819299736;753.4349238071446;789.1910791438821;801.2628381888676;805.2189376304975;8950.597223124974;9703.223742100616;9878.901210987942;9952.850707239397;10180.083792458714;665.3446355339986;678.2031113441785;721.2571051816637;783.3106865958034;798.331487191772;4720.811167553328;4821.421429428491;4863.9513604864205;4942.481039490874;4969.726665033386;90871;91509.5424522873;91772;92218;95368.52315738377;78120;79428.6028569865;81963;84106.15893841106;85020;73214.63392683108;73773.26226737665;74529;75748;77947;9248.260139188984;9437.245020398488;9524.523773811143;9680.080392362714;9702.660406885725;50435.49564504308;50909.74545127251;51022.74488627533;51261.231081534555;51715;48382.5161748378;64456.67771661111;66811.33188668246;67616;67820;11511.36687482163;12471.251724896536;12515.624531264077;12556.246625202517;12820.743585128432;14240.857591423954;14536.491222807152;14576.635584110058;14888;15042.473513426978;13119.475220991053;13397.866021340053;14302.21337826388;14369.9281503596;15203.847961520243;13805.79291310611;13935.58193254204;14001.43994240219;14082.366293516612;15106.924465377602;12974.481020759442;13119;13196.274204918822;13924.443022278996;14026.368813403626;11328.886711132784;11580;11718.472668730099;12068.336241506802;12105.273683578662;11600.941995290306;11704.473298701409;11794.941025294818;12050.457729402022;12098.455569499218 12:30:47 INFO - PROCESS | 5800 | __end_tp_report 12:30:47 INFO - PROCESS | 5800 | __start_cc_report 12:30:47 INFO - PROCESS | 5800 | _x_x_mozilla_cycle_collect,1018 12:30:47 INFO - PROCESS | 5800 | __end_cc_report 12:30:47 INFO - PROCESS | 5800 | __startTimestamp1486413047875__endTimestamp 12:30:47 INFO - PROCESS | 5800 | 12:30:47 INFO - PROCESS | 5800 | ------- Summary: start ------- 12:30:47 INFO - PROCESS | 5800 | Number of tests: 6 12:30:47 INFO - PROCESS | 5800 | 12:30:47 INFO - PROCESS | 5800 | [#0] dojo.html Cycles:165 Average:5630.20 Median:5791.16 stddev:637.98 (11.0%) stddev-sans-first:610.97 12:30:47 INFO - PROCESS | 5800 | Values: 3207.4 3236.2 3240.7 3266.9 3288.5 5593.7 5693.7 5710.3 5711.2 5722.1 5705.7 5756.3 5761.6 5764.4 5764.7 5188.5 5207.6 5215.4 5257.3 5281.2 5079.0 5085.7 5132.6 5298.3 5308.0 5178.4 5253.7 5263.9 5266.7 5290.2 5262.1 5265.7 5285.8 5289.6 5296.0 4957.7 5051.9 5172.4 5179.7 5248.2 5482.2 5530.3 5538.8 5544.7 5591.9 5990.3 6003.5 6013.5 6047.7 6074.8 5875.5 6131.4 6140.8 6155.1 6163.0 5524.8 5640.8 5685.3 5692.5 5717.9 6258.2 6259.1 6264.4 6266.8 6270.0 5797.6 6021.4 6023.4 6026.5 6029.9 5870.4 6019.9 6040.2 6043.9 6134.3 6045.9 6093.3 6102.7 6104.4 6114.3 6085.1 6110.5 6112.4 6119.6 6123.2 4560.9 4570.4 4607.4 4611.2 4623.6 4141.7 4145.4 4149.6 4152.4 4174.3 5709.0 5713.5 5725.5 5727.3 5731.0 5882.1 5915.5 5994.9 6052.8 6071.7 5753.9 5755.5 5761.5 5768.0 5791.2 5176.4 5181.3 5189.7 5190.0 5251.0 6031.7 6078.0 6209.8 6299.1 6318.0 5936.7 6110.8 6114.2 6118.0 6144.2 6280.4 6331.6 6333.1 6334.7 6336.1 5769.6 5781.5 5989.5 5990.4 5990.8 5978.6 5998.5 6014.0 6098.4 6122.8 5902.9 5933.1 5935.8 5938.5 5948.4 5642.7 5935.1 5936.9 5946.9 5951.0 5678.5 5787.9 5794.8 5813.7 5926.7 5953.0 5956.6 5960.7 5967.5 5969.1 5654.0 5688.3 5733.8 5806.4 5810.5 12:30:47 INFO - PROCESS | 5800 | 12:30:47 INFO - PROCESS | 5800 | [#1] ext.html Cycles:180 Average:57892.72 Median:20104.17 stddev:112249.29 (558.3%) stddev-sans-first:112481.70 12:30:47 INFO - PROCESS | 5800 | Values: 583.2 597.3 632.8 640.4 657.4 32487.7 33353.2 35306.3 44028.1 45101.3 44808.8 45447.0 45521.5 45560.5 45597.3 8808.8 8952.9 8953.0 8961.5 8961.9 8286.8 8475.8 8771.3 8868.3 10498.5 10869.8 10941.2 10967.1 10981.6 10988.6 10701.6 10765.2 10777.1 10777.2 10786.4 10607.9 10693.0 10696.3 10698.2 10698.8 42741.8 42762.0 42816.4 42849.4 43032.4 3673.1 3695.9 3708.7 3802.0 3826.5 31468.4 31750.4 32079.2 32139.0 32654.0 4356.3 4384.3 4417.4 4427.3 4434.6 320365.0 321018.0 322005.0 323465.0 323537.0 57924.1 58065.1 58291.0 58302.7 58344.0 35597.8 35810.5 35896.0 56090.2 56129.4 18540.6 18625.5 18639.3 18647.1 18705.5 14349.7 14455.4 14461.3 14471.0 14474.1 17911.9 18170.5 18226.6 18564.1 19577.6 7169.0 7264.0 7323.5 7326.4 7396.6 957.7 1010.7 1013.2 1107.7 1132.9 32088.4 35022.5 35169.6 35870.5 36535.3 1080.3 1080.9 1097.1 1125.7 1126.2 14594.5 16707.7 17703.0 17880.2 18031.4 506803.0 509942.0 511216.0 511528.0 511773.0 56603.0 57104.1 57168.7 57239.0 57251.1 1392.2 1424.0 1439.7 1452.0 1464.8 31155.8 32798.2 33137.3 33302.3 33445.8 51152.0 52312.7 52491.5 52506.0 52517.5 416533.0 417257.0 419395.0 420858.0 423920.0 25372.9 27552.6 28273.3 28762.7 28935.1 46422.5 46455.8 46880.8 46929.8 47273.3 39098.2 39475.6 39560.2 40274.6 40622.0 38834.6 39235.6 39253.4 39864.6 40477.6 38879.6 39013.6 39994.2 40209.4 40256.0 33404.5 35678.5 35700.3 36328.3 36436.8 26843.0 27141.3 27212.2 27383.2 27763.3 12:30:47 INFO - PROCESS | 5800 | 12:30:47 INFO - PROCESS | 5800 | [#2] jquery.html Cycles:180 Average:28834.64 Median:1749.11 stddev:78765.12 (4503.2%) stddev-sans-first:78957.13 12:30:47 INFO - PROCESS | 5800 | Values: 395.0 402.4 415.5 418.6 426.5 14772.9 18675.0 19573.6 20462.1 20466.7 16168.4 16617.2 16799.3 20049.4 20303.2 5772.9 5882.5 5987.4 6039.5 6040.5 5945.3 5953.2 5977.2 5981.8 5992.2 5684.5 5845.3 5851.5 5854.0 5863.1 5721.5 5782.5 5807.0 5841.9 5848.6 5162.9 5187.9 5193.9 5196.7 5197.2 23041.1 23564.3 23575.5 23608.8 23707.2 2265.5 2295.5 2391.2 2661.9 3103.2 10622.2 10811.3 10844.6 10931.5 11240.7 1970.7 1980.8 1987.4 1994.2 2009.4 81192.0 82451.6 83087.0 83319.6 83493.6 11247.9 11426.5 11485.4 11566.9 11594.6 16532.8 16567.8 16568.2 16571.9 16580.1 7760.0 8199.9 8317.6 8566.7 8608.2 7777.1 8103.6 8149.7 8182.5 8192.7 4971.1 5045.1 5074.2 5081.3 5126.8 1806.1 2045.7 2047.5 2053.7 2082.3 908.5 961.1 1037.1 1054.7 1078.4 19598.8 19609.5 19749.8 19756.1 20288.4 956.9 968.1 990.3 1005.3 1013.9 11034.4 11075.3 11141.1 11158.0 11162.1 448700.0 472941.0 478854.0 490230.0 491318.0 88514.6 89416.0 91500.5 92667.0 94078.1 969.5 978.7 995.3 997.6 1000.2 16926.4 17484.2 17635.8 17671.2 17696.3 40766.0 43347.8 44005.1 44080.0 44736.3 62111.4 63793.7 63795.7 64378.0 65245.7 8526.4 8541.4 8651.0 8697.1 8730.6 12096.4 12105.6 12275.2 12351.2 12740.7 10669.5 11006.2 11175.6 11191.8 11336.3 10420.2 10566.7 10813.7 11002.1 11094.9 10400.1 10670.4 10709.8 11295.7 11326.6 7607.1 8095.8 8338.1 8630.1 9094.0 10200.5 10376.6 10882.5 10913.9 11276.9 12:30:47 INFO - PROCESS | 5800 | 12:30:47 INFO - PROCESS | 5800 | [#3] mootools.html Cycles:180 Average:5841.89 Median:4911.96 stddev:3332.69 (67.8%) stddev-sans-first:3326.11 12:30:47 INFO - PROCESS | 5800 | Values: 1505.7 1519.8 1679.8 1781.8 1819.8 8579.6 9068.1 9072.6 9078.7 9080.2 7266.1 7407.0 7454.6 7634.9 8864.8 2384.0 2468.3 2478.1 2487.5 2491.4 2411.6 2451.8 2468.1 2476.4 2487.1 2402.3 2419.4 2420.4 2425.1 2425.5 2350.3 2371.8 2373.5 2374.4 2378.5 2375.3 2383.3 2393.3 2393.4 2401.8 8835.1 8903.1 8910.2 8924.5 8977.9 5309.4 5438.7 5446.2 5447.9 5448.3 3208.3 3361.7 3519.9 3520.1 3532.2 1100.8 1167.2 1204.2 1212.0 1247.1 12600.5 12643.6 12656.2 12674.7 12691.2 4748.6 4779.4 4826.1 4908.8 4912.0 10541.5 10543.9 10554.1 10555.8 10556.2 5498.0 5507.8 5510.2 5513.1 5513.9 4303.9 4994.4 5001.4 5046.4 5059.9 3645.1 3833.3 3955.4 3971.0 3980.3 1287.6 1295.5 1304.4 1308.2 1315.7 889.2 929.3 929.4 938.6 954.4 5657.1 5693.1 5742.6 5791.2 5881.5 952.2 962.3 983.4 987.4 990.9 3662.4 3799.0 3822.0 3870.8 3871.5 10929.1 11070.9 11152.9 11188.2 11212.8 10397.8 10879.1 11087.6 11105.8 11110.6 8330.7 8518.3 8524.4 8541.3 8543.7 5726.6 5728.7 5859.4 5908.4 6056.0 9985.4 10114.8 10168.6 10172.4 10178.1 10567.4 10618.7 10714.8 10728.9 10729.0 7743.2 7947.9 8052.0 8107.7 8110.2 8418.0 8583.6 8704.6 8710.0 8710.2 7551.7 7562.4 7613.5 7670.4 7691.7 7446.3 7635.8 7678.4 7704.0 7791.2 6706.3 6804.5 6811.3 6812.6 6815.0 4948.9 4951.2 5004.4 5016.2 5137.3 4853.5 4912.0 4920.1 4989.8 5206.8 12:30:47 INFO - PROCESS | 5800 | 12:30:47 INFO - PROCESS | 5800 | [#4] prototype.html Cycles:180 Average:4674.78 Median:5293.65 stddev:1339.17 (25.3%) stddev-sans-first:1302.94 12:30:47 INFO - PROCESS | 5800 | Values: 347.3 352.6 364.7 365.6 368.1 5211.5 5307.5 5376.8 5424.5 5442.9 5160.8 5288.9 5290.4 5292.8 5294.5 4249.2 4272.3 4272.9 4277.5 4284.7 4200.7 4219.2 4244.4 4263.5 4292.3 4222.6 4230.9 4231.8 4241.2 4246.9 4215.7 4221.3 4224.0 4232.7 4265.0 3842.8 3843.3 3848.3 3857.0 3872.2 4977.3 5204.7 5206.0 5209.8 5250.2 4800.1 4806.2 4811.8 4824.3 4832.3 5364.6 5561.2 5563.8 5587.4 5590.4 4094.3 4094.3 4097.9 4102.7 4127.5 5735.0 5756.7 5771.9 5792.5 5819.7 4192.2 4195.0 4202.6 4209.0 4212.6 4008.9 4149.7 4165.1 4166.9 4169.7 4707.9 4714.0 4714.7 4716.7 4716.8 5576.0 5602.2 5616.7 5637.6 5655.1 1338.1 1340.8 1396.6 1420.3 1420.7 964.4 991.8 992.2 1000.9 1009.3 5120.6 5128.2 5151.2 5160.5 5168.7 5454.8 5457.7 5460.8 5464.6 5489.4 5112.7 5147.6 5154.2 5166.8 5415.1 2896.2 2923.6 2930.3 2947.3 2947.8 5732.9 5734.2 5762.5 5763.6 5772.8 5516.3 5606.2 5626.2 5637.4 5642.7 5713.1 5731.1 5742.9 5743.6 5752.6 5427.8 5505.4 5576.6 5586.7 5595.8 5443.4 5466.0 5468.6 5474.0 5480.4 5752.4 5761.7 5780.9 5786.2 5796.2 3938.5 4072.0 4078.2 4179.7 4185.6 5488.2 5669.9 5674.9 5682.8 5702.2 5441.0 5500.8 5568.8 5587.2 5587.3 5567.7 5573.6 5590.5 5598.9 5602.1 5340.2 5496.2 5504.8 5532.3 5547.2 5584.4 5588.7 5593.8 5614.5 5649.7 5459.6 5464.8 5478.8 5492.9 5495.9 12:30:47 INFO - PROCESS | 5800 | 12:30:47 INFO - PROCESS | 5800 | [#5] yui.html Cycles:180 Average:18600.95 Median:5003.64 stddev:24821.64 (496.1%) stddev-sans-first:24855.24 12:30:47 INFO - PROCESS | 5800 | Values: 791.3 793.3 809.6 814.2 891.0 13970.2 14804.5 15008.2 15114.5 15220.0 12988.2 14156.4 14165.9 14277.6 14293.9 834.0 850.9 851.9 854.5 855.8 856.1 856.6 857.8 858.9 859.5 907.8 908.6 909.2 909.4 909.5 896.0 899.1 900.4 901.5 902.1 655.2 659.6 659.8 660.2 660.4 13282.4 13345.0 13403.4 13862.2 14066.1 12696.3 13295.7 13301.9 13439.9 13487.5 11022.3 11072.3 11141.9 11372.1 11388.5 4347.8 4433.7 4453.6 4496.8 4584.0 62756.0 63352.7 63389.3 63406.4 64794.7 11146.9 11303.0 11303.8 11320.5 11370.3 18813.5 19339.8 19971.1 20042.3 20142.1 8491.9 8548.3 8552.4 8607.2 8732.9 4826.2 4849.6 4867.1 4896.7 5037.5 3480.6 3619.5 3626.1 3630.3 3630.7 568.5 579.4 588.6 597.2 599.2 752.8 753.4 789.2 801.3 805.2 8950.6 9703.2 9878.9 9952.9 10180.1 665.3 678.2 721.3 783.3 798.3 4720.8 4821.4 4864.0 4942.5 4969.7 90871.0 91509.5 91772.0 92218.0 95368.5 78120.0 79428.6 81963.0 84106.2 85020.0 73214.6 73773.3 74529.0 75748.0 77947.0 9248.3 9437.2 9524.5 9680.1 9702.7 50435.5 50909.7 51022.7 51261.2 51715.0 48382.5 64456.7 66811.3 67616.0 67820.0 11511.4 12471.3 12515.6 12556.2 12820.7 14240.9 14536.5 14576.6 14888.0 15042.5 13119.5 13397.9 14302.2 14369.9 15203.8 13805.8 13935.6 14001.4 14082.4 15106.9 12974.5 13119.0 13196.3 13924.4 14026.4 11328.9 11580.0 11718.5 12068.3 12105.3 11600.9 11704.5 11794.9 12050.5 12098.5 12:30:47 INFO - PROCESS | 5800 | -------- Summary: end -------- 12:30:47 INFO - PROCESS | 5800 | 12:30:48 INFO - TEST-INFO | 5800: exit 0 12:30:48 INFO - TEST-OK | dromaeo_css | took 1113954ms 12:30:48 INFO - TEST-START | kraken 12:30:48 INFO - operating with platform_type : linux_ 12:30:48 INFO - Initialising browser for kraken test... 12:30:48 INFO - TEST-INFO | started process 6109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBN8S6J/profile http://localhost:48782/getInfo.html) 12:30:52 INFO - PROCESS | 6109 | __metrics Screen width/height:1600/1200 12:30:52 INFO - PROCESS | 6109 | colorDepth:24 12:30:52 INFO - PROCESS | 6109 | Browser inner width/height: 1024/697 12:30:52 INFO - PROCESS | 6109 | __metrics 12:30:53 INFO - PROCESS | 6109 | 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:30:53 INFO - PROCESS | 6109 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:30:53 INFO - PROCESS | 6109 | console.error: PushService: 12:30:53 INFO - PROCESS | 6109 | stateChangeProcessEnqueue: Error transitioning state 12:30:53 INFO - PROCESS | 6109 | UnknownError 12:30:54 INFO - TEST-INFO | 6109: exit 0 12:30:54 INFO - Browser initialized. 12:30:54 INFO - Running cycle 1/1 for kraken test... 12:30:54 INFO - TEST-INFO | started process 6206 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBN8S6J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:31:06 INFO - PROCESS | 6206 | RSS: Main: 141692928 12:31:06 INFO - PROCESS | 6206 | 12:31:08 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48782/tests/kraken/driver.html?testName=audio-beat-detection) 12:31:09 INFO - PROCESS | 6206 | RSS: Main: 183619584 12:31:09 INFO - PROCESS | 6206 | 12:31:11 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48782/tests/kraken/driver.html?testName=audio-dft) 12:31:12 INFO - PROCESS | 6206 | RSS: Main: 173821952 12:31:12 INFO - PROCESS | 6206 | 12:31:15 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48782/tests/kraken/driver.html?testName=audio-fft) 12:31:15 INFO - PROCESS | 6206 | RSS: Main: 264396800 12:31:15 INFO - PROCESS | 6206 | 12:31:18 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48782/tests/kraken/driver.html?testName=audio-oscillator) 12:31:18 INFO - PROCESS | 6206 | RSS: Main: 170917888 12:31:18 INFO - PROCESS | 6206 | 12:31:20 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48782/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:31:21 INFO - PROCESS | 6206 | RSS: Main: 173375488 12:31:21 INFO - PROCESS | 6206 | 12:31:24 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48782/tests/kraken/driver.html?testName=imaging-darkroom) 12:31:24 INFO - PROCESS | 6206 | RSS: Main: 212979712 12:31:24 INFO - PROCESS | 6206 | 12:31:28 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48782/tests/kraken/driver.html?testName=imaging-desaturate) 12:31:28 INFO - PROCESS | 6206 | RSS: Main: 210976768 12:31:28 INFO - PROCESS | 6206 | 12:31:31 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48782/tests/kraken/driver.html?testName=json-parse-financial) 12:31:31 INFO - PROCESS | 6206 | RSS: Main: 209924096 12:31:31 INFO - PROCESS | 6206 | 12:31:33 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48782/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:31:34 INFO - PROCESS | 6206 | RSS: Main: 171655168 12:31:34 INFO - PROCESS | 6206 | 12:31:35 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:31:36 INFO - PROCESS | 6206 | RSS: Main: 179015680 12:31:36 INFO - PROCESS | 6206 | 12:31:38 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:31:38 INFO - PROCESS | 6206 | RSS: Main: 188542976 12:31:38 INFO - PROCESS | 6206 | 12:31:41 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:31:42 INFO - PROCESS | 6206 | RSS: Main: 196292608 12:31:42 INFO - PROCESS | 6206 | 12:31:44 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:31:45 INFO - PROCESS | 6206 | RSS: Main: 193478656 12:31:45 INFO - PROCESS | 6206 | 12:31:47 INFO - PROCESS | 6206 | Cycle 1(1): loaded http://localhost:48782/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48782/tests/kraken/driver.html?testName=ai-astar) 12:31:47 INFO - PROCESS | 6206 | RSS: Main: 245415936 12:31:47 INFO - PROCESS | 6206 | 12:31:47 INFO - PROCESS | 6206 | __start_tp_report 12:31:47 INFO - PROCESS | 6206 | _x_x_mozilla_page_load 12:31:47 INFO - PROCESS | 6206 | _x_x_mozilla_page_load_details 12:31:47 INFO - PROCESS | 6206 | |i|pagename|runs| 12:31:47 INFO - PROCESS | 6206 | |0;ai-astar;106;112;112;111;112;111;112;111;112;111 12:31:47 INFO - PROCESS | 6206 | |1;audio-beat-detection;157;119;120;157;121;122;120;118;144;119 12:31:47 INFO - PROCESS | 6206 | |2;audio-dft;160;160;160;160;159;159;159;161;160;159 12:31:47 INFO - PROCESS | 6206 | |3;audio-fft;75;76;76;109;76;74;75;75;95;74 12:31:47 INFO - PROCESS | 6206 | |4;audio-oscillator;82;82;115;81;81;81;103;81;81;112 12:31:47 INFO - PROCESS | 6206 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;116;117;116 12:31:47 INFO - PROCESS | 6206 | |6;imaging-darkroom;146;146;147;146;146;146;146;147;145;146 12:31:47 INFO - PROCESS | 6206 | |7;imaging-desaturate;85;85;85;85;85;84;85;84;84;84 12:31:47 INFO - PROCESS | 6206 | |8;json-parse-financial;51;49;59;49;49;49;49;50;50;49 12:31:47 INFO - PROCESS | 6206 | |9;json-stringify-tinderbox;58;59;58;58;59;59;59;58;58;58 12:31:47 INFO - PROCESS | 6206 | |10;stanford-crypto-aes;76;76;77;76;76;74;75;76;75;74 12:31:47 INFO - PROCESS | 6206 | |11;stanford-crypto-ccm;124;124;128;129;121;121;120;125;159;122 12:31:47 INFO - PROCESS | 6206 | |12;stanford-crypto-pbkdf2;156;158;159;159;157;155;159;158;159;157 12:31:47 INFO - PROCESS | 6206 | |13;stanford-crypto-sha256-iterative;62;63;64;62;64;64;63;66;66;60 12:31:47 INFO - PROCESS | 6206 | __end_tp_report 12:31:47 INFO - PROCESS | 6206 | __start_cc_report 12:31:47 INFO - PROCESS | 6206 | _x_x_mozilla_cycle_collect,1601 12:31:47 INFO - PROCESS | 6206 | __end_cc_report 12:31:47 INFO - PROCESS | 6206 | __startTimestamp1486413107368__endTimestamp 12:31:47 INFO - PROCESS | 6206 | 12:31:47 INFO - PROCESS | 6206 | ------- Summary: start ------- 12:31:47 INFO - PROCESS | 6206 | Number of tests: 14 12:31:47 INFO - PROCESS | 6206 | 12:31:47 INFO - PROCESS | 6206 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:1.83 (1.6%) stddev-sans-first:0.53 12:31:47 INFO - PROCESS | 6206 | Values: 106.0 112.0 112.0 111.0 112.0 111.0 112.0 111.0 112.0 111.0 12:31:47 INFO - PROCESS | 6206 | 12:31:47 INFO - PROCESS | 6206 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:121.50 stddev:16.28 (13.4%) stddev-sans-first:13.95 12:31:47 INFO - PROCESS | 6206 | Values: 157.0 119.0 120.0 157.0 121.0 122.0 120.0 118.0 144.0 119.0 12:31:47 INFO - PROCESS | 6206 | 12:31:47 INFO - PROCESS | 6206 | [#2] audio-dft Cycles:10 Average:159.70 Median:160.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 12:31:47 INFO - PROCESS | 6206 | Values: 160.0 160.0 160.0 160.0 159.0 159.0 159.0 161.0 160.0 159.0 12:31:47 INFO - PROCESS | 6206 | 12:31:47 INFO - PROCESS | 6206 | [#3] audio-fft Cycles:10 Average:80.50 Median:75.50 stddev:11.83 (15.7%) stddev-sans-first:12.37 12:31:47 INFO - PROCESS | 6206 | Values: 75.0 76.0 76.0 109.0 76.0 74.0 75.0 75.0 95.0 74.0 12:31:47 INFO - PROCESS | 6206 | 12:31:47 INFO - PROCESS | 6206 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:81.00 stddev:14.18 (17.5%) stddev-sans-first:14.75 12:31:47 INFO - PROCESS | 6206 | Values: 82.0 82.0 115.0 81.0 81.0 81.0 103.0 81.0 81.0 112.0 12:31:47 INFO - PROCESS | 6206 | 12:31:47 INFO - PROCESS | 6206 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 12:31:47 INFO - PROCESS | 6206 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 12:31:47 INFO - PROCESS | 6206 | 12:31:47 INFO - PROCESS | 6206 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 12:31:47 INFO - PROCESS | 6206 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 145.0 146.0 12:31:47 INFO - PROCESS | 6206 | 12:31:47 INFO - PROCESS | 6206 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 12:31:47 INFO - PROCESS | 6206 | Values: 85.0 85.0 85.0 85.0 85.0 84.0 85.0 84.0 84.0 84.0 12:31:47 INFO - PROCESS | 6206 | 12:31:47 INFO - PROCESS | 6206 | [#8] json-parse-financial Cycles:10 Average:50.40 Median:49.50 stddev:3.10 (6.3%) stddev-sans-first:3.28 12:31:47 INFO - PROCESS | 6206 | Values: 51.0 49.0 59.0 49.0 49.0 49.0 49.0 50.0 50.0 49.0 12:31:47 INFO - PROCESS | 6206 | 12:31:47 INFO - PROCESS | 6206 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 12:31:47 INFO - PROCESS | 6206 | Values: 58.0 59.0 58.0 58.0 59.0 59.0 59.0 58.0 58.0 58.0 12:31:47 INFO - PROCESS | 6206 | 12:31:47 INFO - PROCESS | 6206 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:76.00 stddev:0.97 (1.3%) stddev-sans-first:1.01 12:31:47 INFO - PROCESS | 6206 | Values: 76.0 76.0 77.0 76.0 76.0 74.0 75.0 76.0 75.0 74.0 12:31:47 INFO - PROCESS | 6206 | 12:31:47 INFO - PROCESS | 6206 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:124.50 stddev:11.53 (9.3%) stddev-sans-first:12.17 12:31:47 INFO - PROCESS | 6206 | Values: 124.0 124.0 128.0 129.0 121.0 121.0 120.0 125.0 159.0 122.0 12:31:47 INFO - PROCESS | 6206 | 12:31:47 INFO - PROCESS | 6206 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.70 Median:158.50 stddev:1.42 (0.9%) stddev-sans-first:1.36 12:31:47 INFO - PROCESS | 6206 | Values: 156.0 158.0 159.0 159.0 157.0 155.0 159.0 158.0 159.0 157.0 12:31:47 INFO - PROCESS | 6206 | 12:31:47 INFO - PROCESS | 6206 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:64.00 stddev:1.84 (2.9%) stddev-sans-first:1.88 12:31:47 INFO - PROCESS | 6206 | Values: 62.0 63.0 64.0 62.0 64.0 64.0 63.0 66.0 66.0 60.0 12:31:47 INFO - PROCESS | 6206 | -------- Summary: end -------- 12:31:47 INFO - PROCESS | 6206 | 12:31:48 INFO - TEST-INFO | 6206: exit 0 12:31:48 INFO - TEST-OK | kraken | took 60068ms 12:31:48 INFO - SUITE-END | took 1174s 12:31:49 INFO - Completed test suite (00:19:34) 12:31:49 INFO - javascript benchmark 12:31:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3207.406629773491, 3236.239483721325, 3240.67593240676, 3266.8856590019323, 3288.473844184931, 5593.748281327345, 5693.743781529831, 5710.343310519292, 5711.200431939532, 5722.055860782966, 5705.714714264281, 5756.251687280647, 5761.596688231815, 5764.423557644233, 5764.740586673599, 5188.455212202721, 5207.6354655174155, 5215.374155101393, 5257.316548848664, 5281.155015197569, 5079.0, 5085.669431486942, 5132.589392848582, 5298.284731561248, 5308.009496438835, 5178.352705911761, 5253.711045892474, 5263.947360526403, 5266.7366631668265, 5290.206469029637, 5262.105442074857, 5265.6840589564745, 5285.7621407036395, 5289.603279753996, 5296.0, 4957.677750946177, 5051.873703157414, 5172.431032586413, 5179.663321884065, 5248.239005344242, 5482.17767334899, 5530.336359636869, 5538.75075621598, 5544.667319960815, 5591.860203494945, 5990.281166260033, 6003.519718422515, 6013.458788709037, 6047.667378294192, 6074.757009719606, 5875.500582450497, 6131.417515336036, 6140.754369825202, 6155.076738489218, 6163.0, 5524.8342549723175, 5640.8307750767135, 5685.346185188673, 5692.516136128475, 5717.942820571741, 6258.217722784652, 6259.061140828912, 6264.436200741864, 6266.780662676784, 6270.028145637433, 5797.594168408255, 6021.397860214031, 6023.367546407651, 6026.54800889935, 6029.879402411927, 5870.354261031283, 6019.939800601938, 6040.214772079602, 6043.909341359883, 6134.325224225332, 6045.909311360333, 6093.29927058394, 6102.72537735803, 6104.3590423005835, 6114.327423983358, 6085.087236914498, 6110.5143811910975, 6112.442689633966, 6119.60364487372, 6123.191113103742, 4560.908781824412, 4570.428696412949, 4607.44710634726, 4611.216093264153, 4623.606993405531, 4141.710080294411, 4145.419641250227, 4149.605787450188, 4152.356384760367, 4174.3321068628875, 5708.971455142698, 5713.457221563945, 5725.484706376363, 5727.312722473246, 5731.0, 5882.117682347682, 5915.526757859361, 5994.880102397928, 6052.818415447544, 6071.726772295257, 5753.8561535961935, 5755.539556835443, 5761.4526619971875, 5768.048272035067, 5791.160281759121, 5176.4047134580005, 5181.326427564392, 5189.740512974412, 5190.03984262905, 5251.0, 6031.728572214261, 6078.027515597483, 6209.844753881189, 6299.0866324382705, 6317.96841015792, 5936.703164841827, 6110.771402862413, 6114.205153330038, 6118.0, 6144.201253836973, 6280.371962803683, 6331.556791024584, 6333.050042493479, 6334.746610135543, 6336.08126821599, 5769.567282453749, 5781.537477001913, 5989.460948514655, 5990.400959904149, 5990.7903223386975, 5978.551608629283, 5998.520118390606, 6014.03775395952, 6098.359672234352, 6122.755089796358, 5902.881942361215, 5933.110033495011, 5935.762569497172, 5938.524918006636, 5948.40515948419, 5642.689652069012, 5935.139404786368, 5936.910946335895, 5946.881062378815, 5950.9702451487465, 5678.517326027334, 5787.8553036174435, 5794.768209271582, 5813.651180929158, 5926.733297001559, 5952.970235148797, 5956.5532585055425, 5960.701964901824, 5967.522598192221, 5969.104634304889, 5654.0, 5688.317401911797, 5733.770649174153, 5806.361300256884, 5810.5351571875], "value": 5587.008923483556, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.224311665485, 597.3429227849366, 632.7911789109593, 640.4364159539607, 657.359074901971, 32487.67512324876, 33353.16617084574, 35306.29387412254, 44028.119437611305, 45101.323480147825, 44808.775956120175, 45447.0, 45521.54478455214, 45560.54439455605, 45597.31604025934, 8808.77978050549, 8952.8657070144, 8953.015168331478, 8961.462312261285, 8961.910380896174, 8286.83426331473, 8475.83048339033, 8771.342149338794, 8868.33487488441, 10498.527566259536, 10869.782604347909, 10941.179411544126, 10967.067799237075, 10981.61564345248, 10988.615398461056, 10701.625443109493, 10765.192610554239, 10777.137828973664, 10777.191710621695, 10786.406747628876, 10607.946960265226, 10692.98416650417, 10696.251262411633, 10698.197635177392, 10698.786024279549, 42741.78629106835, 42762.0, 42816.357754633704, 42849.35725964113, 43032.3545146823, 3673.0633688409284, 3695.8891233263043, 3708.684761795251, 3801.9809900950595, 3826.521684789401, 31468.37063258745, 31750.364992700015, 32079.19802004945, 32139.0, 32654.0, 4356.302991521373, 4384.298512238027, 4417.403650507173, 4427.275446117043, 4434.60088592025, 320365.0, 321018.0, 322005.0, 323465.0, 323537.0, 57924.131138032964, 58065.129023064685, 58291.0, 58302.7084864573, 58344.0, 35597.82201088978, 35810.46284305737, 35896.0, 56090.158647620316, 56129.43870561324, 18540.629187416445, 18625.53436164107, 18639.254429822657, 18647.067646617616, 18705.53236169107, 14349.713005739826, 14455.421783128557, 14461.276936153361, 14471.0, 14474.059186152866, 17911.92528448297, 18170.545736356697, 18226.63546729058, 18564.071796410124, 19577.560526999932, 7168.964155179295, 7264.0, 7323.487355885037, 7326.413886889036, 7396.631623149735, 957.698325027614, 1010.7473131717071, 1013.2147585621202, 1107.6676996900896, 1132.8583927009124, 32088.358232835213, 35022.47466288008, 35169.64830351664, 35870.46194307088, 36535.26929461396, 1080.2654195147375, 1080.9189310801721, 1097.1003776903024, 1125.7241975716001, 1126.1947707389093, 14594.489192878198, 16707.749383759252, 17703.0, 17880.195391207428, 18031.368902088365, 506803.0, 509942.0, 511216.0, 511528.0, 511773.0, 56603.0, 57104.14343784846, 57168.71415642895, 57239.0, 57251.14123288154, 1392.1786146173806, 1423.9572812815632, 1439.6832696806687, 1452.0271418149864, 1464.8461911499353, 31155.844220778752, 32798.18004549905, 33137.337253254314, 33302.335813135374, 33445.83277083599, 51152.0, 52312.738436307576, 52491.47508524866, 52506.0, 52517.474825252786, 416533.0, 417257.0, 419395.0, 420858.0, 423920.0, 25372.873135634203, 27552.586711198946, 28273.293167670974, 28762.712372876, 28935.131946041653, 46422.53577464317, 46455.76772116118, 46880.7655961718, 46929.765351173024, 47273.29090063721, 39098.21803563856, 39475.60524394834, 39560.208795823346, 40274.59725402708, 40622.0, 38834.6116538831, 39235.60764392434, 39253.41119883261, 39864.60135398609, 40477.595224047385, 38879.6112038876, 39013.609863900994, 39994.2001159981, 40209.39685904772, 40256.0, 33404.498932516515, 35678.464823027156, 35700.28599427945, 36328.27343453063, 36436.81781591075, 26843.0, 27141.321466963484, 27212.183634490997, 27383.178504644893, 27763.305917352227], "value": 20303.77621955332, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.97897933841017, 402.37832548712237, 415.47442485256147, 418.61487431562966, 426.48821414302824, 14772.926135369335, 18675.0, 19573.608527829434, 20462.07920643571, 20466.692999605, 16168.434104806334, 16617.169141542934, 16799.328026878942, 20049.398518044483, 20303.187872485083, 5772.855678608026, 5882.529397648189, 5987.371326010772, 6039.486643635296, 6040.48655864252, 5945.346011938684, 5953.196318497013, 5977.193078934353, 5981.760729570834, 5992.221011268529, 5684.488396044355, 5845.298564172284, 5851.531877449794, 5854.004819180728, 5863.149843272723, 5721.513671337942, 5782.45066718661, 5807.041838096709, 5841.85395365115, 5848.619839710405, 5162.896742065175, 5187.870303242411, 5193.948060519422, 5196.662216955886, 5197.168453047494, 23041.078356865706, 23564.293071207892, 23575.528489430286, 23608.763912361, 23707.1702490412, 2265.535565209128, 2295.472041430464, 2391.246757271454, 2661.920142395712, 3103.239706271978, 10622.203334749925, 10811.297265677784, 10844.6204382847, 10931.45342732868, 11240.662780116609, 1970.704394340846, 1980.7524059492564, 1987.3541099142692, 1994.2122861469784, 2009.3670493794555, 81192.0, 82451.5877420609, 83087.0, 83319.5834020826, 83493.58253208817, 11247.943760281147, 11426.485808138654, 11485.368304743151, 11566.94216528912, 11594.594189203506, 16532.75200871988, 16567.751483727752, 16568.17159142038, 16571.91714041422, 16580.088095154642, 7759.961200193963, 8199.918000820035, 8317.625706843206, 8566.742997710078, 8608.182222688834, 7777.144514103444, 8103.554304513191, 8149.674013039531, 8182.509049457051, 8192.67229310821, 4971.105201063843, 5045.117104506697, 5074.188129899198, 5081.339425874687, 5126.794928202905, 1806.1125437555593, 2045.7238272832976, 2047.5495391013953, 2053.7330147080784, 2082.344061620615, 908.504864848659, 961.0581630002637, 1037.1288117980932, 1054.7310435838965, 1078.439211609974, 19598.804011959983, 19609.509762256057, 19749.802501974795, 19756.11097500616, 20288.391348259574, 956.8756061712072, 968.080323692495, 990.2770977186694, 1005.3415013166388, 1013.8580598716186, 11034.448277586089, 11075.335479871233, 11141.108711303077, 11157.995780379804, 11162.107031437628, 448700.0, 472941.0, 478854.0, 490230.0, 491318.0, 88514.55742721245, 89416.0, 91500.54249728842, 92667.0, 94078.05921940693, 969.5297780576415, 978.6819283732815, 995.3032876986139, 997.5959736306808, 1000.2048371544639, 16926.407575735284, 17484.21321040531, 17635.823641763418, 17671.204795783964, 17696.345449143108, 40766.0, 43347.783261083496, 44005.11989760251, 44080.0, 44736.328955066354, 62111.37888621056, 63793.68103159455, 63795.68102159645, 64378.0, 65245.67377163084, 8526.403151779316, 8541.444806087584, 8651.048384677555, 8697.130286971253, 8730.607122679368, 12096.395180241128, 12105.576304829288, 12275.2021118627, 12351.19717218378, 12740.74518509606, 10669.46652667348, 11006.229563930769, 11175.608853690082, 11191.776164476501, 11336.319820810777, 10420.218483613911, 10566.735831603964, 10813.729656758644, 11002.119830413707, 11094.889051109709, 10400.115990140923, 10670.413127278074, 10709.785804284027, 11295.71760705956, 11326.603568875049, 7607.12518060408, 8095.757127286191, 8338.124496927736, 8630.050694423482, 9094.0, 10200.540975656262, 10376.636817711344, 10882.45587720595, 10913.945430273116, 11276.94361528187], "value": 9279.581163639172, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1505.7364961131807, 1519.7796319533668, 1679.8068222154448, 1781.8218178182176, 1819.8089200633933, 8579.613917373717, 9068.09319068093, 9072.59173337199, 9078.682246121387, 9080.228180604656, 7266.055412796329, 7407.037085178919, 7454.5899975501325, 7634.885476717854, 8864.77838054049, 2383.976160238397, 2468.2965354873863, 2478.120267305108, 2487.4776296977657, 2491.402063504755, 2411.6261979393134, 2451.779339859412, 2468.0744720729726, 2476.393283645509, 2487.129504673368, 2402.339356676919, 2419.4314336130997, 2420.394901274681, 2425.0784701813286, 2425.466397392571, 2350.27141586108, 2371.7983971362455, 2373.537160253751, 2374.442006128558, 2378.5124049569795, 2375.3467796355967, 2383.296927406402, 2393.258089992108, 2393.4255778613183, 2401.795847352977, 8835.072317406708, 8903.065178156265, 8910.153535414125, 8924.509151996637, 8977.865332020025, 5309.36287645485, 5438.6736795791985, 5446.1558458439, 5447.891042179174, 5448.264484294609, 3208.3477009339977, 3361.697447229761, 3519.859205631797, 3520.119970007498, 3532.1875968527124, 1100.834874768783, 1167.200467679642, 1204.151073493185, 1212.0122100488074, 1247.1332423965348, 12600.495980160875, 12643.620691379274, 12656.177348472413, 12674.74650506994, 12691.238525688488, 4748.562895484651, 4779.378680771478, 4826.131296366618, 4908.828191013297, 4911.950880491221, 10541.472926353652, 10543.94728026355, 10554.050135487689, 10555.84166237507, 10556.155507559377, 5498.037843377393, 5507.779688812483, 5510.173473978935, 5513.062779327443, 5513.917291240635, 4303.935440968388, 4994.375703037121, 5001.44984051754, 5046.44489106198, 5059.873503162376, 3645.070507020746, 3833.3483307837732, 3955.4066889966734, 3971.0469487322835, 3980.3432433648704, 1287.575100216926, 1295.501232025677, 1304.3999760110266, 1308.1627758234738, 1315.6710822294426, 889.2397000564554, 929.330881765128, 929.419113054341, 938.6463887362465, 954.4225743425267, 5657.066584013592, 5693.146028095736, 5742.626729262584, 5791.189233507313, 5881.500072493886, 952.1858810716876, 962.259060523407, 983.4246965525105, 987.4322264697828, 990.9405435673883, 3662.4140137578393, 3798.981005094957, 3821.9617803821607, 3870.767753934773, 3871.4967054283325, 10929.071028962468, 11070.944645276722, 11152.944235278934, 11188.160887933438, 11212.822653621415, 10397.84403233952, 10879.075278601249, 11087.55649774, 11105.83341249882, 11110.61112861046, 8330.66677332912, 8518.318534517224, 8524.36067294943, 8541.273991710774, 8543.700970466129, 5726.599138060295, 5728.742206600797, 5859.384764599826, 5908.409159084057, 6056.0007598745715, 9985.400875947467, 10114.848277275994, 10168.593256269962, 10172.372420412994, 10178.134858537107, 10567.365958042543, 10618.73453163677, 10714.839277411002, 10728.873468285718, 10729.034386905216, 7743.225677432211, 7947.8807817883935, 8052.0, 8107.716229931924, 8110.229528194812, 8418.0, 8583.613737381958, 8704.60829262672, 8710.0, 8710.172533609297, 7551.697932082655, 7562.357199638092, 7613.467057305936, 7670.42471814605, 7691.730789422343, 7446.292602202782, 7635.847283054419, 7678.385729141543, 7703.961480192564, 7791.220877912164, 6706.329367063255, 6804.4556435484055, 6811.284815094542, 6812.62530560804, 6814.977753337039, 4948.851534453972, 4951.232558953368, 5004.4495105537635, 5016.2224855147515, 5137.33214682089, 4853.538913803183, 4911.9754401227765, 4920.1389756791705, 4989.750512474435, 5206.791728330824], "value": 4689.521468795553, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.2776624620789, 352.5557797175558, 364.7082334132696, 365.6014943711354, 368.07429315272094, 5211.45279745627, 5307.469253074691, 5376.784928602856, 5424.4846739559725, 5442.911417716457, 5160.845174644757, 5288.867778305545, 5290.365156181254, 5292.797857296338, 5294.497022782839, 4249.150169966004, 4272.273713468702, 4272.914541709164, 4277.529471758104, 4284.721493102938, 4200.663946884242, 4219.156168766259, 4244.427002354673, 4263.467066616673, 4292.29177185764, 4222.59885310895, 4230.9479902247385, 4231.809568569406, 4241.151769646083, 4246.936295955563, 4215.69313512812, 4221.282381995053, 4224.043169781135, 4232.703710740249, 4264.997725534497, 3842.7886466244345, 3843.3466310726963, 3848.3457812171996, 3856.980715096435, 3872.244912242114, 4977.32806071183, 5204.713740744258, 5206.0, 5209.765560549784, 5250.159974404077, 4800.135975524404, 4806.2310030394965, 4811.8075276988875, 4824.324594556765, 4832.251001094836, 5364.597655175839, 5561.249231353756, 5563.833085007456, 5587.44125587438, 5590.385057643656, 4094.28350038742, 4094.303968325392, 4097.91804163918, 4102.651274641659, 4127.484064491939, 5735.0, 5756.712164391805, 5771.913421298642, 5792.478676919098, 5819.67991760453, 4192.161567686475, 4194.993201631586, 4202.642775364067, 4209.010882442623, 4212.641925436311, 4008.8797336079965, 4149.730267532601, 4165.083681590046, 4166.91666166675, 4169.749815011109, 4707.929381059287, 4714.0, 4714.717116972993, 4716.6698331116495, 4716.811327546929, 5576.0, 5602.159676048625, 5616.691081990448, 5637.605367624309, 5655.123455864347, 1338.110156745753, 1340.825692659948, 1396.6103726791907, 1420.3182472413093, 1420.7300612883519, 964.3876138651866, 991.7917237380086, 992.2437286003733, 1000.9399436033862, 1009.268280496634, 5120.61595380348, 5128.205128205134, 5151.175811870083, 5160.509751573594, 5168.664036837594, 5454.754536045887, 5457.69982650958, 5460.808871689472, 5464.644798088111, 5489.368722596872, 5112.71880046601, 5147.613928955343, 5154.226865970059, 5166.81916132941, 5415.1335786274, 2896.174590241771, 2923.5760814681753, 2930.2527855397166, 2947.2779169103705, 2947.778916581265, 5732.942670573241, 5734.197212390269, 5762.481376676035, 5763.567732420085, 5772.826815195551, 5516.255305533701, 5606.196901549225, 5626.1842032905, 5637.378618942212, 5642.6614403135945, 5713.085906255063, 5731.140328950607, 5742.856428589235, 5743.62666426681, 5752.597318187771, 5427.810026649048, 5505.412456145606, 5576.5817563683695, 5586.748596313257, 5595.776168953196, 5443.374011988513, 5466.0, 5468.589855760913, 5474.014677358114, 5480.424555421623, 5752.395998420273, 5761.695321871285, 5780.8554786129, 5786.218860453785, 5796.188533605215, 3938.4879965604287, 4072.0, 4078.1639763848934, 4179.686523510688, 4185.602367775056, 5488.231647569263, 5669.858253543694, 5674.914876276776, 5682.77268909239, 5702.230198923092, 5440.972795135999, 5500.752466138953, 5568.777248909998, 5587.161925711176, 5587.329520457409, 5567.66594004361, 5573.581981351496, 5590.496855283044, 5598.916016259678, 5602.075657516627, 5340.172273297645, 5496.1755736639825, 5504.834854954358, 5532.253145825423, 5547.200167885012, 5584.441555844383, 5588.748506317144, 5593.804216852391, 5614.522765564972, 5649.717514124195, 5459.5632349412745, 5464.836054918359, 5478.780848766005, 5492.945070549244, 5495.890082198253], "value": 4254.9060744540875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.3115589437194, 793.3256731777985, 809.6194788449428, 814.2432998699195, 890.9866352004725, 13970.231637259947, 14804.481843135492, 15008.249587520608, 15114.47099351523, 15220.0, 12988.155769874951, 14156.362963666634, 14165.92917035416, 14277.643058923506, 14293.857061429382, 833.9916600833975, 850.8936382952131, 851.902031266403, 854.5257382152903, 855.7774978505603, 856.1139220906363, 856.5802756649259, 857.8069934264803, 858.9312854971619, 859.4928991894781, 907.8229745199689, 908.604756930734, 909.245326379107, 909.3907082254905, 909.5088652127843, 896.0457113174448, 899.0739538275554, 900.4057322167338, 901.5266984832949, 902.0798785239085, 655.2333769489709, 659.5844617890698, 659.782271850293, 660.2308310817891, 660.4221306356937, 13282.402291896791, 13345.0, 13403.396847141901, 13862.237576933265, 14066.085704429179, 12696.301703406309, 13295.667608309774, 13301.933490332583, 13439.924806015495, 13487.460501579924, 11022.283551569202, 11072.280301780358, 11141.944290278578, 11372.14708896836, 11388.487518061707, 4347.826086956518, 4433.733975961452, 4453.599176074136, 4496.775161241925, 4583.977080114611, 62756.0, 63352.68323658352, 63389.32485894023, 63406.36593634051, 64794.676026620036, 11146.944265278622, 11303.0, 11303.830442543369, 11320.490577924013, 11370.31778093317, 18813.529661758294, 19339.8066019338, 19971.101300441514, 20042.298519551747, 20142.093605787773, 8491.915080849236, 8548.316134709208, 8552.358573107042, 8607.18231767981, 8732.91267087321, 4826.227803551415, 4849.563539281411, 4867.099586576494, 4896.6572339935865, 5037.546620804145, 3480.634533373959, 3619.529461170031, 3626.1478552540134, 3630.2920930418313, 3630.673239408466, 568.5054003017401, 579.3771695427348, 588.5732843688291, 597.1758972617846, 599.2060519811267, 752.7929819299736, 753.4349238071446, 789.1910791438821, 801.2628381888676, 805.2189376304975, 8950.597223124974, 9703.223742100616, 9878.901210987942, 9952.850707239397, 10180.083792458714, 665.3446355339986, 678.2031113441785, 721.2571051816637, 783.3106865958034, 798.331487191772, 4720.811167553328, 4821.421429428491, 4863.9513604864205, 4942.481039490874, 4969.726665033386, 90871.0, 91509.5424522873, 91772.0, 92218.0, 95368.52315738377, 78120.0, 79428.6028569865, 81963.0, 84106.15893841106, 85020.0, 73214.63392683108, 73773.26226737665, 74529.0, 75748.0, 77947.0, 9248.260139188984, 9437.245020398488, 9524.523773811143, 9680.080392362714, 9702.660406885725, 50435.49564504308, 50909.74545127251, 51022.74488627533, 51261.231081534555, 51715.0, 48382.5161748378, 64456.67771661111, 66811.33188668246, 67616.0, 67820.0, 11511.36687482163, 12471.251724896536, 12515.624531264077, 12556.246625202517, 12820.743585128432, 14240.857591423954, 14536.491222807152, 14576.635584110058, 14888.0, 15042.473513426978, 13119.475220991053, 13397.866021340053, 14302.21337826388, 14369.9281503596, 15203.847961520243, 13805.79291310611, 13935.58193254204, 14001.43994240219, 14082.366293516612, 15106.924465377602, 12974.481020759442, 13119.0, 13196.274204918822, 13924.443022278996, 14026.368813403626, 11328.886711132784, 11580.0, 11718.472668730099, 12068.336241506802, 12105.273683578662, 11600.941995290306, 11704.473298701409, 11794.941025294818, 12050.457729402022, 12098.455569499218], "value": 7442.13127675491, "unit": "score"}], "name": "dromaeo_css", "value": 7339.628049749662, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 112.0, 111.0, 112.0, 111.0, 112.0, 111.0, 112.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 119.0, 120.0, 157.0, 121.0, 122.0, 120.0, 118.0, 144.0, 119.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 159.0, 159.0, 159.0, 161.0, 160.0, 159.0], "value": 159.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 109.0, 76.0, 74.0, 75.0, 75.0, 95.0, 74.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 115.0, 81.0, 81.0, 81.0, 103.0, 81.0, 81.0, 112.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 59.0, 49.0, 49.0, 49.0, 49.0, 50.0, 50.0, 49.0], "value": 50.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 59.0, 59.0, 59.0, 58.0, 58.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 76.0, 76.0, 74.0, 75.0, 76.0, 75.0, 74.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 124.0, 128.0, 129.0, 121.0, 121.0, 120.0, 125.0, 159.0, 122.0], "value": 127.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 158.0, 159.0, 159.0, 157.0, 155.0, 159.0, 158.0, 159.0, 157.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 62.0, 64.0, 64.0, 63.0, 66.0, 66.0, 60.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1450.8000000000002, "alertThreshold": 2.0}]} 12:31:49 INFO - Return code: 0 12:31:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:31:49 INFO - # TBPL SUCCESS # 12:31:49 INFO - Running post-action listener: _resource_record_post_action 12:31:49 INFO - [mozharness: 2017-02-06 20:31:49.206776Z] Finished run-tests step (success) 12:31:49 INFO - Running post-run listener: _resource_record_post_run 12:31:49 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 321765376; Read time: 16; Write time: 186044 12:31:49 INFO - TinderboxPrint: CPU usage
12.9% 12:31:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 12:31:49 INFO - TinderboxPrint: I/O write bytes / time
321,765,376 / 186,044 12:31:49 INFO - TinderboxPrint: CPU idle
8,255.0 (87.0%) 12:31:49 INFO - TinderboxPrint: CPU user
1,186.3 (12.5%) 12:31:49 INFO - TinderboxPrint: Swap in / out
0 / 0 12:31:49 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101060608; Read time: 0; Write time: 75000 12:31:49 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 220704768; Read time: 16; Write time: 111044 12:31:49 INFO - Running post-run listener: _upload_blobber_files 12:31:49 INFO - Blob upload gear active. 12:31:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:31:49 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:31:49 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:31:49 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:31:50 INFO - (blobuploader) - INFO - Open directory for files ... 12:31:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:31:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:31:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:31:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:31:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:31:53 INFO - (blobuploader) - INFO - Done attempting. 12:31:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:31:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:31:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:31:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:31:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:31:54 INFO - (blobuploader) - INFO - Done attempting. 12:31:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:31:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:31:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:31:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:31:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:31:55 INFO - (blobuploader) - INFO - Done attempting. 12:31:55 INFO - (blobuploader) - INFO - Iteration through files over. 12:31:55 INFO - Return code: 0 12:31:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:31:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:31:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08181e18862b7661b798053c62a894a39e8770790837521440f29b8a6e59f219aa831ff5a2ae7f98e3d171b5be5d095a4a50383c55bbe232718959414b54b19f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/48504553fcd33ed2f204c69bd0faa7a03a5132fcb14b96adc1108f89e9e84970b865d2234ead3e2a367ffe87542c638b7d9785308bec0b3c7bc2f529b3f09b3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0f518088def0ec4db7a7ac69c2b9456eefbd883da06e7c7430a190a92ffc60181083aa8c495cb537128a64f20e2195abce4db88684672322ff7fa9e6ca95d52b"} 12:31:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:31:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:31:55 INFO - Contents: 12:31:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08181e18862b7661b798053c62a894a39e8770790837521440f29b8a6e59f219aa831ff5a2ae7f98e3d171b5be5d095a4a50383c55bbe232718959414b54b19f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/48504553fcd33ed2f204c69bd0faa7a03a5132fcb14b96adc1108f89e9e84970b865d2234ead3e2a367ffe87542c638b7d9785308bec0b3c7bc2f529b3f09b3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0f518088def0ec4db7a7ac69c2b9456eefbd883da06e7c7430a190a92ffc60181083aa8c495cb537128a64f20e2195abce4db88684672322ff7fa9e6ca95d52b"} 12:31:55 INFO - Running post-run listener: copy_logs_to_upload_dir 12:31:55 INFO - Copying logs to upload dir... 12:31:55 INFO - mkdir: /builds/slave/test/build/upload/logs 12:31:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.186188 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-06 12:31:55.324674) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 12:31:55.328626) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206 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/08181e18862b7661b798053c62a894a39e8770790837521440f29b8a6e59f219aa831ff5a2ae7f98e3d171b5be5d095a4a50383c55bbe232718959414b54b19f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/48504553fcd33ed2f204c69bd0faa7a03a5132fcb14b96adc1108f89e9e84970b865d2234ead3e2a367ffe87542c638b7d9785308bec0b3c7bc2f529b3f09b3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0f518088def0ec4db7a7ac69c2b9456eefbd883da06e7c7430a190a92ffc60181083aa8c495cb537128a64f20e2195abce4db88684672322ff7fa9e6ca95d52b"} build_url:https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011397 build_url: 'https://queue.taskcluster.net/v1/task/Jbxrd0rpQSu0mYWugw_o5Q/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/08181e18862b7661b798053c62a894a39e8770790837521440f29b8a6e59f219aa831ff5a2ae7f98e3d171b5be5d095a4a50383c55bbe232718959414b54b19f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/48504553fcd33ed2f204c69bd0faa7a03a5132fcb14b96adc1108f89e9e84970b865d2234ead3e2a367ffe87542c638b7d9785308bec0b3c7bc2f529b3f09b3c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0f518088def0ec4db7a7ac69c2b9456eefbd883da06e7c7430a190a92ffc60181083aa8c495cb537128a64f20e2195abce4db88684672322ff7fa9e6ca95d52b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 12:31:55.354009) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 12:31:55.354328) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1486411881.416579-430904206 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 12:31:55.437042) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 12:31:55.437375) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 12:31:55.437657) ========= ========= Total master_lag: 0.19 =========