builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1471368930.47 results: success (0) buildid: 20160816091017 builduid: 366b7a4e0c0a40c2b9e1440e546cdc97 revision: af4cc6c04573fca495450725de702f7188dab6ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 10:35:30.469666) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 10:35:30.470136) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 10:35:30.470440) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 10:35:30.485072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 10:35:30.485410) ========= 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=fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 10:35:30-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-08-16 10:35:30 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121701 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 10:35:30.620981) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 10:35:30.621307) ========= 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=fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018807 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 10:35:30.671523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 10:35:30.671876) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev af4cc6c04573fca495450725de702f7188dab6ea --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev af4cc6c04573fca495450725de702f7188dab6ea --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=fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 10:35:30,751 truncating revision to first 12 chars 2016-08-16 10:35:30,751 Setting DEBUG logging. 2016-08-16 10:35:30,751 attempt 1/10 2016-08-16 10:35:30,751 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/af4cc6c04573?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 10:35:31,497 unpacking tar archive at: fx-team-af4cc6c04573/testing/mozharness/ program finished with exit code 0 elapsedTime=1.133130 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-16 10:35:31.817507) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 10:35:31.817833) ========= script_repo_revision: af4cc6c04573fca495450725de702f7188dab6ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 10:35:31.818244) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 10:35:31.818531) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 10:35:31.827773) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-16 10:35:31.828184) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:35:31 INFO - MultiFileLogger online at 20160816 10:35:31 in /builds/slave/test 10:35:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:35:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:35:31 INFO - {'append_to_log': False, 10:35:31 INFO - 'base_work_dir': '/builds/slave/test', 10:35:31 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:35:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:35:31 INFO - 'branch': 'Fx-Team-Non-PGO', 10:35:31 INFO - 'buildbot_json_path': 'buildprops.json', 10:35:31 INFO - 'config_files': ('talos/linux_config.py',), 10:35:31 INFO - 'default_actions': ('clobber', 10:35:31 INFO - 'read-buildbot-config', 10:35:31 INFO - 'download-and-extract', 10:35:31 INFO - 'populate-webroot', 10:35:31 INFO - 'create-virtualenv', 10:35:31 INFO - 'install', 10:35:31 INFO - 'run-tests'), 10:35:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:35:31 INFO - 'download_minidump_stackwalk': True, 10:35:31 INFO - 'download_symbols': 'ondemand', 10:35:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:35:31 INFO - 'tooltool.py': '/tools/tooltool.py', 10:35:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:35:31 INFO - '/tools/misc-python/virtualenv.py')}, 10:35:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:35:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:35:31 INFO - 'installer_path': 'installer.exe', 10:35:31 INFO - 'log_level': 'info', 10:35:31 INFO - 'log_name': 'talos', 10:35:31 INFO - 'log_to_console': True, 10:35:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:35:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:35:31 INFO - 'opt_config_files': (), 10:35:31 INFO - 'pip_index': False, 10:35:31 INFO - 'sps_profile': False, 10:35:31 INFO - 'sps_profile_interval': 0, 10:35:31 INFO - 'suite': 'dromaeojs', 10:35:31 INFO - 'system_bits': '32', 10:35:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:35:31 INFO - 'title': 'talos-linux64-ix-048', 10:35:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:35:31 INFO - 'use_talos_json': True, 10:35:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:35:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:35:31 INFO - 'work_dir': 'build'} 10:35:31 INFO - [mozharness: 2016-08-16 17:35:31.995722Z] Running clobber step. 10:35:31 INFO - Running pre-action listener: _resource_record_pre_action 10:35:31 INFO - Running main action method: clobber 10:35:31 INFO - rmtree: /builds/slave/test/build 10:35:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:35:32 INFO - Running post-action listener: _resource_record_post_action 10:35:32 INFO - [mozharness: 2016-08-16 17:35:32.446617Z] Finished clobber step (success) 10:35:32 INFO - [mozharness: 2016-08-16 17:35:32.446719Z] Running read-buildbot-config step. 10:35:32 INFO - Running pre-action listener: _resource_record_pre_action 10:35:32 INFO - Running main action method: read_buildbot_config 10:35:32 INFO - Using buildbot properties: 10:35:32 INFO - { 10:35:32 INFO - "project": "", 10:35:32 INFO - "product": "firefox", 10:35:32 INFO - "script_repo_revision": "production", 10:35:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:35:32 INFO - "repository": "", 10:35:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:35:32 INFO - "buildid": "20160816091017", 10:35:32 INFO - "pgo_build": "False", 10:35:32 INFO - "basedir": "/builds/slave/test", 10:35:32 INFO - "buildnumber": 3238, 10:35:32 INFO - "slavename": "talos-linux64-ix-048", 10:35:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:35:32 INFO - "platform": "ubuntu64_hw", 10:35:32 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 10:35:32 INFO - "branch": "fx-team", 10:35:32 INFO - "repo_path": "integration/fx-team", 10:35:32 INFO - "revision": "af4cc6c04573fca495450725de702f7188dab6ea", 10:35:32 INFO - "stage_platform": "linux64", 10:35:32 INFO - "builduid": "366b7a4e0c0a40c2b9e1440e546cdc97", 10:35:32 INFO - "slavebuilddir": "test" 10:35:32 INFO - } 10:35:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:35:32 INFO - Running post-action listener: _resource_record_post_action 10:35:32 INFO - [mozharness: 2016-08-16 17:35:32.449145Z] Finished read-buildbot-config step (success) 10:35:32 INFO - [mozharness: 2016-08-16 17:35:32.449234Z] Running download-and-extract step. 10:35:32 INFO - Running pre-action listener: _resource_record_pre_action 10:35:32 INFO - Running main action method: download_and_extract 10:35:32 INFO - mkdir: /builds/slave/test/build/tests 10:35:32 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')]} 10:35:32 INFO - trying https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:35:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:35:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:35:33 INFO - Downloaded 1361 bytes. 10:35:33 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:35:33 INFO - Using the following test package requirements: 10:35:33 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:35:33 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:35:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:35:33 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:35:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:35:33 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:35:33 INFO - u'jsshell-linux-x86_64.zip'], 10:35:33 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:35:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:35:33 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:35:33 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:35:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:35:33 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:35:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:35:33 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:35:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:35:33 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:35:33 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:35:33 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:33 INFO - trying https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:35:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:35:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:35:33 INFO - Downloaded 20265717 bytes. 10:35:33 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 10:35:38 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:35:38 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')]} 10:35:38 INFO - trying https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:35:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:35:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:35:38 INFO - Downloaded 20265717 bytes. 10:35:38 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 10:35: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')]} 10:35:43 INFO - trying https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:35:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:35:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:35:44 INFO - Downloaded 14413719 bytes. 10:35:44 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 10:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:44 INFO - trying https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:35:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:35:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:35:45 INFO - Downloaded 55632809 bytes. 10:35:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:35:45 INFO - mkdir: /builds/slave/test/properties 10:35:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:35:45 INFO - Writing to file /builds/slave/test/properties/build_url 10:35:45 INFO - Contents: 10:35:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:35:46 INFO - Running post-action listener: _resource_record_post_action 10:35:46 INFO - Running post-action listener: set_extra_try_arguments 10:35:46 INFO - [mozharness: 2016-08-16 17:35:46.427301Z] Finished download-and-extract step (success) 10:35:46 INFO - [mozharness: 2016-08-16 17:35:46.427526Z] Running populate-webroot step. 10:35:46 INFO - Running pre-action listener: _resource_record_pre_action 10:35:46 INFO - Running main action method: populate_webroot 10:35:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:35:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:35:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:35:46 INFO - '--tppagecycles', 10:35:46 INFO - '7'], 10:35:46 INFO - 'tests': ['tsvgm']}}, 10:35:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:35:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:35:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:35:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:35:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:35:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:35:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:46 INFO - 'talos_options': ['--disable-e10s'], 10:35:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:35:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:35:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:46 INFO - 'talos_options': ['--disable-e10s'], 10:35:46 INFO - 'tests': ['damp', 'tps']}, 10:35:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:46 INFO - 'tests': ['damp', 'tps']}, 10:35:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:35:46 INFO - 'tests': ['dromaeo_dom']}, 10:35:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:35:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:35:46 INFO - 'tests': ['basic_compositor_video']}, 10:35:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:35:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:35:46 INFO - 'tests': ['a11yr', 10:35:46 INFO - 'ts_paint', 10:35:46 INFO - 'tpaint', 10:35:46 INFO - 'sessionrestore', 10:35:46 INFO - 'sessionrestore_no_auto_restore', 10:35:46 INFO - 'tabpaint']}, 10:35:46 INFO - 'other-e10s': {'tests': ['a11yr', 10:35:46 INFO - 'ts_paint', 10:35:46 INFO - 'tpaint', 10:35:46 INFO - 'sessionrestore', 10:35:46 INFO - 'sessionrestore_no_auto_restore', 10:35:46 INFO - 'tabpaint']}, 10:35:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:35:46 INFO - 'ts_paint', 10:35:46 INFO - 'tpaint', 10:35:46 INFO - 'sessionrestore', 10:35:46 INFO - 'sessionrestore_no_auto_restore', 10:35:46 INFO - 'tabpaint']}, 10:35:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:35:46 INFO - 'ts_paint', 10:35:46 INFO - 'tpaint', 10:35:46 INFO - 'sessionrestore', 10:35:46 INFO - 'sessionrestore_no_auto_restore', 10:35:46 INFO - 'tabpaint']}, 10:35:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:35:46 INFO - 'tests': ['a11yr', 10:35:46 INFO - 'ts_paint', 10:35:46 INFO - 'tpaint', 10:35:46 INFO - 'sessionrestore', 10:35:46 INFO - 'sessionrestore_no_auto_restore', 10:35:46 INFO - 'tabpaint']}, 10:35:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:35:46 INFO - 'tests': ['a11yr', 10:35:46 INFO - 'ts_paint', 10:35:46 INFO - 'tpaint', 10:35:46 INFO - 'sessionrestore', 10:35:46 INFO - 'sessionrestore_no_auto_restore', 10:35:46 INFO - 'tabpaint']}, 10:35:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:35:46 INFO - 'tests': ['tsvgx', 10:35:46 INFO - 'tsvgr_opacity', 10:35:46 INFO - 'tart', 10:35:46 INFO - 'tscrollx', 10:35:46 INFO - 'cart']}, 10:35:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:35:46 INFO - 'tsvgr_opacity', 10:35:46 INFO - 'tart', 10:35:46 INFO - 'tscrollx', 10:35:46 INFO - 'cart']}, 10:35:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:46 INFO - 'talos_options': ['--disable-e10s'], 10:35:46 INFO - 'tests': ['tp5o']}, 10:35:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:46 INFO - 'tests': ['tp5o']}, 10:35:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:46 INFO - 'talos_options': ['--disable-e10s', 10:35:46 INFO - '--xperf_path', 10:35:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:35:46 INFO - 'tests': ['tp5n']}, 10:35:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:35:46 INFO - 'talos_options': ['--xperf_path', 10:35:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:35:46 INFO - 'tests': ['tp5n']}}, 10:35:46 INFO - 'talos.zip': {'path': '', 10:35:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:35:46 INFO - Running post-action listener: _resource_record_post_action 10:35:46 INFO - [mozharness: 2016-08-16 17:35:46.449748Z] Finished populate-webroot step (success) 10:35:46 INFO - [mozharness: 2016-08-16 17:35:46.449836Z] Running create-virtualenv step. 10:35:46 INFO - Running pre-action listener: _resource_record_pre_action 10:35:46 INFO - Running main action method: create_virtualenv 10:35:46 INFO - Creating virtualenv /builds/slave/test/build/venv 10:35:46 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 10:35:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:35:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:35:46 INFO - Using real prefix '/usr' 10:35:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:35:47 INFO - Installing distribute.............................................................................................................................................................................................done. 10:35:49 INFO - Installing pip.................done. 10:35:49 INFO - Return code: 0 10:35:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8604261f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111b090>, '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 0x111e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111ee40>, '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': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', '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 10:35:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:35:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:35:49 INFO - Using env: {'DISPLAY': ':0', 10:35:49 INFO - 'HOME': '/home/cltbld', 10:35:49 INFO - 'LANG': 'en_US.UTF-8', 10:35:49 INFO - 'LANGUAGE': 'en_US:en', 10:35:49 INFO - 'LOGNAME': 'cltbld', 10:35:49 INFO - 'MAIL': '/var/mail/cltbld', 10:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:49 INFO - 'MOZ_NO_REMOTE': '1', 10:35:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:49 INFO - 'NO_EM_RESTART': '1', 10:35:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:49 INFO - 'PWD': '/builds/slave/test', 10:35:49 INFO - 'SHELL': '/bin/bash', 10:35:49 INFO - 'SHLVL': '1', 10:35:49 INFO - 'TERM': 'linux', 10:35:49 INFO - 'TMOUT': '86400', 10:35:49 INFO - 'USER': 'cltbld', 10:35:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', 10:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:49 INFO - '_': '/tools/buildbot/bin/python'} 10:35:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:49 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 10:35:49 INFO - Cleaning up... 10:35:49 INFO - Return code: 0 10:35:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8604261f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111b090>, '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 0x111e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111ee40>, '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': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', '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 10:35:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:35:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:35:49 INFO - Using env: {'DISPLAY': ':0', 10:35:49 INFO - 'HOME': '/home/cltbld', 10:35:49 INFO - 'LANG': 'en_US.UTF-8', 10:35:49 INFO - 'LANGUAGE': 'en_US:en', 10:35:49 INFO - 'LOGNAME': 'cltbld', 10:35:49 INFO - 'MAIL': '/var/mail/cltbld', 10:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:49 INFO - 'MOZ_NO_REMOTE': '1', 10:35:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:49 INFO - 'NO_EM_RESTART': '1', 10:35:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:49 INFO - 'PWD': '/builds/slave/test', 10:35:49 INFO - 'SHELL': '/bin/bash', 10:35:49 INFO - 'SHLVL': '1', 10:35:49 INFO - 'TERM': 'linux', 10:35:49 INFO - 'TMOUT': '86400', 10:35:49 INFO - 'USER': 'cltbld', 10:35:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', 10:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:49 INFO - '_': '/tools/buildbot/bin/python'} 10:35:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:49 INFO - Downloading/unpacking psutil>=3.1.1 10:35: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 10:35: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 10:35: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 10:35: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 10:35: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 10:35: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 10:35:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:35:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:35:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:35:51 INFO - Installing collected packages: psutil 10:35:51 INFO - Running setup.py install for psutil 10:35:51 INFO - building 'psutil._psutil_linux' extension 10:35:51 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 10:35:51 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 10:35:51 INFO - building 'psutil._psutil_posix' extension 10:35:51 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 10:35:51 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 10:35:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:35:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:35:52 INFO - Successfully installed psutil 10:35:52 INFO - Cleaning up... 10:35:52 INFO - Return code: 0 10:35:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:35: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')]} 10:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35: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')]} 10:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:52 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 0x7f8604261f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111b090>, '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 0x111e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111ee40>, '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': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', '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 10:35:52 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 10:35:52 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 10:35:52 INFO - Using env: {'DISPLAY': ':0', 10:35:52 INFO - 'HOME': '/home/cltbld', 10:35:52 INFO - 'LANG': 'en_US.UTF-8', 10:35:52 INFO - 'LANGUAGE': 'en_US:en', 10:35:52 INFO - 'LOGNAME': 'cltbld', 10:35:52 INFO - 'MAIL': '/var/mail/cltbld', 10:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:52 INFO - 'MOZ_NO_REMOTE': '1', 10:35:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:52 INFO - 'NO_EM_RESTART': '1', 10:35:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:52 INFO - 'PWD': '/builds/slave/test', 10:35:52 INFO - 'SHELL': '/bin/bash', 10:35:52 INFO - 'SHLVL': '1', 10:35:52 INFO - 'TERM': 'linux', 10:35:52 INFO - 'TMOUT': '86400', 10:35:52 INFO - 'USER': 'cltbld', 10:35:52 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', 10:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:52 INFO - '_': '/tools/buildbot/bin/python'} 10:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:35:52 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 10:35:52 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 10:35:52 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 10:35:52 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 10:35:52 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 10:35:52 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 10:35:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:35:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:35:54 INFO - Installing collected packages: mozsystemmonitor 10:35:54 INFO - Running setup.py install for mozsystemmonitor 10:35:54 INFO - Successfully installed mozsystemmonitor 10:35:54 INFO - Cleaning up... 10:35:54 INFO - Return code: 0 10:35:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8604261f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111b090>, '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 0x111e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111ee40>, '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': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', '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 10:35:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:35:54 INFO - Using env: {'DISPLAY': ':0', 10:35:54 INFO - 'HOME': '/home/cltbld', 10:35:54 INFO - 'LANG': 'en_US.UTF-8', 10:35:54 INFO - 'LANGUAGE': 'en_US:en', 10:35:54 INFO - 'LOGNAME': 'cltbld', 10:35:54 INFO - 'MAIL': '/var/mail/cltbld', 10:35:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:54 INFO - 'MOZ_NO_REMOTE': '1', 10:35:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:54 INFO - 'NO_EM_RESTART': '1', 10:35:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:54 INFO - 'PWD': '/builds/slave/test', 10:35:54 INFO - 'SHELL': '/bin/bash', 10:35:54 INFO - 'SHLVL': '1', 10:35:54 INFO - 'TERM': 'linux', 10:35:54 INFO - 'TMOUT': '86400', 10:35:54 INFO - 'USER': 'cltbld', 10:35:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', 10:35:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:54 INFO - '_': '/tools/buildbot/bin/python'} 10:35:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:54 INFO - Downloading/unpacking jsonschema==2.5.1 10:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:35:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:35:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:35:56 INFO - Downloading functools32-3.2.3-2.tar.gz 10:35:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:35:56 INFO - warning: no files found matching '*.txt' 10:35:56 INFO - no previously-included directories found matching 'build' 10:35:56 INFO - no previously-included directories found matching 'dist' 10:35:56 INFO - no previously-included directories found matching '.git*' 10:35:56 INFO - Installing collected packages: jsonschema, functools32 10:35:56 INFO - Running setup.py install for functools32 10:35:56 INFO - warning: no files found matching '*.txt' 10:35:56 INFO - no previously-included directories found matching 'build' 10:35:56 INFO - no previously-included directories found matching 'dist' 10:35:56 INFO - no previously-included directories found matching '.git*' 10:35:56 INFO - Successfully installed jsonschema functools32 10:35:56 INFO - Cleaning up... 10:35:56 INFO - Return code: 0 10:35:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8604261f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111b090>, '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 0x111e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111ee40>, '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': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', '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 10:35:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:35:56 INFO - Using env: {'DISPLAY': ':0', 10:35:56 INFO - 'HOME': '/home/cltbld', 10:35:56 INFO - 'LANG': 'en_US.UTF-8', 10:35:56 INFO - 'LANGUAGE': 'en_US:en', 10:35:56 INFO - 'LOGNAME': 'cltbld', 10:35:56 INFO - 'MAIL': '/var/mail/cltbld', 10:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:56 INFO - 'MOZ_NO_REMOTE': '1', 10:35:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:56 INFO - 'NO_EM_RESTART': '1', 10:35:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:56 INFO - 'PWD': '/builds/slave/test', 10:35:56 INFO - 'SHELL': '/bin/bash', 10:35:56 INFO - 'SHLVL': '1', 10:35:56 INFO - 'TERM': 'linux', 10:35:56 INFO - 'TMOUT': '86400', 10:35:56 INFO - 'USER': 'cltbld', 10:35:56 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', 10:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:56 INFO - '_': '/tools/buildbot/bin/python'} 10:35:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:35:57 INFO - Cleaning up... 10:35:57 INFO - Return code: 0 10:35:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:35:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:35:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:35:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:35:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:35:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8604261f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111b090>, '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 0x111e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111ee40>, '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': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', '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 10:35:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:35:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:35:57 INFO - Using env: {'DISPLAY': ':0', 10:35:57 INFO - 'HOME': '/home/cltbld', 10:35:57 INFO - 'LANG': 'en_US.UTF-8', 10:35:57 INFO - 'LANGUAGE': 'en_US:en', 10:35:57 INFO - 'LOGNAME': 'cltbld', 10:35:57 INFO - 'MAIL': '/var/mail/cltbld', 10:35:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:35:57 INFO - 'MOZ_NO_REMOTE': '1', 10:35:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:35:57 INFO - 'NO_EM_RESTART': '1', 10:35:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:35:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:35:57 INFO - 'PWD': '/builds/slave/test', 10:35:57 INFO - 'SHELL': '/bin/bash', 10:35:57 INFO - 'SHLVL': '1', 10:35:57 INFO - 'TERM': 'linux', 10:35:57 INFO - 'TMOUT': '86400', 10:35:57 INFO - 'USER': 'cltbld', 10:35:57 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', 10:35:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:35:57 INFO - '_': '/tools/buildbot/bin/python'} 10:35:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:35:57 INFO - Downloading/unpacking blobuploader==1.2.4 10:35: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 10:35: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 10:35: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 10:35: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 10:35: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 10:35: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 10:35:59 INFO - Downloading blobuploader-1.2.4.tar.gz 10:35:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:35:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:35:59 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 10:35:59 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 10:35:59 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 10:35:59 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 10:35:59 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 10:35:59 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 10:35:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:35:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:35:59 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 10:35:59 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 10:35:59 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 10:35:59 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 10:35:59 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 10:35:59 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 10:35:59 INFO - Downloading docopt-0.6.1.tar.gz 10:35:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:35:59 INFO - Installing collected packages: blobuploader, requests, docopt 10:35:59 INFO - Running setup.py install for blobuploader 10:36:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:36:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:36:00 INFO - Running setup.py install for requests 10:36:00 INFO - Running setup.py install for docopt 10:36:00 INFO - Successfully installed blobuploader requests docopt 10:36:00 INFO - Cleaning up... 10:36:00 INFO - Return code: 0 10:36:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:36: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')]} 10:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36: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')]} 10:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:00 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 0x7f8604261f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111b090>, '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 0x111e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111ee40>, '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': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', '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 10:36:00 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 10:36:00 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 10:36:00 INFO - Using env: {'DISPLAY': ':0', 10:36:00 INFO - 'HOME': '/home/cltbld', 10:36:00 INFO - 'LANG': 'en_US.UTF-8', 10:36:00 INFO - 'LANGUAGE': 'en_US:en', 10:36:00 INFO - 'LOGNAME': 'cltbld', 10:36:00 INFO - 'MAIL': '/var/mail/cltbld', 10:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:00 INFO - 'MOZ_NO_REMOTE': '1', 10:36:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:00 INFO - 'NO_EM_RESTART': '1', 10:36:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:00 INFO - 'PWD': '/builds/slave/test', 10:36:00 INFO - 'SHELL': '/bin/bash', 10:36:00 INFO - 'SHLVL': '1', 10:36:00 INFO - 'TERM': 'linux', 10:36:00 INFO - 'TMOUT': '86400', 10:36:00 INFO - 'USER': 'cltbld', 10:36:00 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', 10:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:00 INFO - '_': '/tools/buildbot/bin/python'} 10:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:36:00 INFO - Running setup.py (path:/tmp/pip-MU1xok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:36:00 INFO - Running setup.py (path:/tmp/pip-kI9cE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:36:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:36:00 INFO - Running setup.py (path:/tmp/pip-RXASLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:36:01 INFO - Running setup.py (path:/tmp/pip-HECNMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:36:01 INFO - Running setup.py (path:/tmp/pip-pR_gV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:36:01 INFO - Running setup.py (path:/tmp/pip-CPqxdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:36:01 INFO - Running setup.py (path:/tmp/pip-zqJ4vB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:36:01 INFO - Running setup.py (path:/tmp/pip-yx9Mds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:36:01 INFO - Running setup.py (path:/tmp/pip-zW7nd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:36:01 INFO - Running setup.py (path:/tmp/pip-bpjrns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:36:01 INFO - Running setup.py (path:/tmp/pip-TFaccX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:36:01 INFO - Running setup.py (path:/tmp/pip-pLx2wi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:36:01 INFO - Running setup.py (path:/tmp/pip-ZH2APG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:36:01 INFO - Running setup.py (path:/tmp/pip-YgZo9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:36:01 INFO - Running setup.py (path:/tmp/pip-xbxlfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:36:01 INFO - Running setup.py (path:/tmp/pip-eDKUKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:36:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:36:01 INFO - Running setup.py (path:/tmp/pip-vit5hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:36:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:36:02 INFO - Running setup.py install for manifestparser 10:36:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:36:02 INFO - Running setup.py install for mozcrash 10:36:02 INFO - Running setup.py install for mozdebug 10:36:02 INFO - Running setup.py install for mozdevice 10:36:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:36:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:36:02 INFO - Running setup.py install for mozfile 10:36:02 INFO - Running setup.py install for mozhttpd 10:36:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:36:02 INFO - Running setup.py install for mozinfo 10:36:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:36:02 INFO - Running setup.py install for mozInstall 10:36:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:36:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:36:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:36:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:36:02 INFO - Running setup.py install for mozleak 10:36:02 INFO - Running setup.py install for mozlog 10:36:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:36:03 INFO - Running setup.py install for moznetwork 10:36:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:36:03 INFO - Running setup.py install for mozprocess 10:36:03 INFO - Running setup.py install for mozprofile 10:36:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:36:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:36:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:36:03 INFO - Running setup.py install for mozrunner 10:36:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:36:03 INFO - Running setup.py install for mozscreenshot 10:36:03 INFO - Running setup.py install for moztest 10:36:03 INFO - Running setup.py install for mozversion 10:36:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:36:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:36:03 INFO - Cleaning up... 10:36:03 INFO - Return code: 0 10:36:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:36:03 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')]} 10:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:03 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')]} 10:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:03 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 0x7f8604261f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111b090>, '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 0x111e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111ee40>, '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': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', '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 10:36:03 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 10:36:03 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 10:36:03 INFO - Using env: {'DISPLAY': ':0', 10:36:03 INFO - 'HOME': '/home/cltbld', 10:36:03 INFO - 'LANG': 'en_US.UTF-8', 10:36:03 INFO - 'LANGUAGE': 'en_US:en', 10:36:03 INFO - 'LOGNAME': 'cltbld', 10:36:03 INFO - 'MAIL': '/var/mail/cltbld', 10:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:03 INFO - 'MOZ_NO_REMOTE': '1', 10:36:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:03 INFO - 'NO_EM_RESTART': '1', 10:36:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:03 INFO - 'PWD': '/builds/slave/test', 10:36:03 INFO - 'SHELL': '/bin/bash', 10:36:03 INFO - 'SHLVL': '1', 10:36:03 INFO - 'TERM': 'linux', 10:36:03 INFO - 'TMOUT': '86400', 10:36:03 INFO - 'USER': 'cltbld', 10:36:03 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', 10:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:03 INFO - '_': '/tools/buildbot/bin/python'} 10:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:36:04 INFO - Running setup.py (path:/tmp/pip-VlVJ6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:36:04 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)) 10:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:36:04 INFO - Running setup.py (path:/tmp/pip-IOqy4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 10:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:36:04 INFO - Running setup.py (path:/tmp/pip-WCmTGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:36:04 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)) 10:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:36:04 INFO - Running setup.py (path:/tmp/pip-HHYHhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:36:04 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)) 10:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:36:04 INFO - Running setup.py (path:/tmp/pip-ofO4zR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:36:04 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)) 10:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:36:04 INFO - Running setup.py (path:/tmp/pip-4P_aF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:36:04 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)) 10:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:36:04 INFO - Running setup.py (path:/tmp/pip-jWAdtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:36:04 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)) 10:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:36:04 INFO - Running setup.py (path:/tmp/pip-NNd_95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:36:04 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)) 10:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:36:04 INFO - Running setup.py (path:/tmp/pip-vha6hQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:36:04 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)) 10:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:36:04 INFO - Running setup.py (path:/tmp/pip-03GEGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:36:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 10:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:36:04 INFO - Running setup.py (path:/tmp/pip-BDHCy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:36:04 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)) 10:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:36:04 INFO - Running setup.py (path:/tmp/pip-1cm7W4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:36:04 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)) 10:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:36:04 INFO - Running setup.py (path:/tmp/pip-c414mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:36:04 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)) 10:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:36:04 INFO - Running setup.py (path:/tmp/pip-iuC60b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 10:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:36:05 INFO - Running setup.py (path:/tmp/pip-RaZARu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:36:05 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)) 10:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:36:05 INFO - Running setup.py (path:/tmp/pip-GuI7AP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 10:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:36:05 INFO - Running setup.py (path:/tmp/pip-YfVBtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:36:05 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)) 10:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:36:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:36:05 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)) 10:36:05 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)) 10:36:05 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)) 10:36:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:07 INFO - Downloading blessings-1.6.tar.gz 10:36:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:36:07 INFO - Installing collected packages: blessings 10:36:07 INFO - Running setup.py install for blessings 10:36:07 INFO - Successfully installed blessings 10:36:07 INFO - Cleaning up... 10:36:07 INFO - Return code: 0 10:36:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:36:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:36:07 INFO - Reading from file tmpfile_stdout 10:36:07 INFO - Current package versions: 10:36:07 INFO - argparse == 1.2.1 10:36:07 INFO - blessings == 1.6 10:36:07 INFO - blobuploader == 1.2.4 10:36:07 INFO - docopt == 0.6.1 10:36:07 INFO - functools32 == 3.2.3-2 10:36:07 INFO - jsonschema == 2.5.1 10:36:07 INFO - manifestparser == 1.1 10:36:07 INFO - mozInstall == 1.12 10:36:07 INFO - mozcrash == 0.17 10:36:07 INFO - mozdebug == 0.1 10:36:07 INFO - mozdevice == 0.48 10:36:07 INFO - mozfile == 1.2 10:36:07 INFO - mozhttpd == 0.7 10:36:07 INFO - mozinfo == 0.9 10:36:07 INFO - mozleak == 0.1 10:36:07 INFO - mozlog == 3.3 10:36:07 INFO - moznetwork == 0.27 10:36:07 INFO - mozprocess == 0.23 10:36:07 INFO - mozprofile == 0.28 10:36:07 INFO - mozrunner == 6.12 10:36:07 INFO - mozscreenshot == 0.1 10:36:07 INFO - mozsystemmonitor == 0.3 10:36:07 INFO - moztest == 0.7 10:36:07 INFO - mozversion == 1.4 10:36:07 INFO - psutil == 3.1.1 10:36:07 INFO - requests == 1.2.3 10:36:07 INFO - wsgiref == 0.1.2 10:36:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:36:07 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')]} 10:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:07 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')]} 10:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:07 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 0x7f8604261f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111b090>, '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 0x111e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111ee40>, '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': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', '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 10:36:07 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 10:36:07 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 10:36:07 INFO - Using env: {'DISPLAY': ':0', 10:36:07 INFO - 'HOME': '/home/cltbld', 10:36:07 INFO - 'LANG': 'en_US.UTF-8', 10:36:07 INFO - 'LANGUAGE': 'en_US:en', 10:36:07 INFO - 'LOGNAME': 'cltbld', 10:36:07 INFO - 'MAIL': '/var/mail/cltbld', 10:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:07 INFO - 'MOZ_NO_REMOTE': '1', 10:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:07 INFO - 'NO_EM_RESTART': '1', 10:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:07 INFO - 'PWD': '/builds/slave/test', 10:36:07 INFO - 'SHELL': '/bin/bash', 10:36:07 INFO - 'SHLVL': '1', 10:36:07 INFO - 'TERM': 'linux', 10:36:07 INFO - 'TMOUT': '86400', 10:36:07 INFO - 'USER': 'cltbld', 10:36:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', 10:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:07 INFO - '_': '/tools/buildbot/bin/python'} 10:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:07 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)) 10:36:07 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)) 10:36:07 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)) 10:36:07 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)) 10:36:07 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)) 10:36:07 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)) 10:36:07 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)) 10:36:07 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)) 10:36:07 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)) 10:36:07 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)) 10:36:07 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)) 10:36:07 INFO - Cleaning up... 10:36:07 INFO - Return code: 0 10:36:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:36:07 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')]} 10:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:07 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')]} 10:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:07 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 0x7f8604261f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1121230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111b090>, '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 0x111e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111ee40>, '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': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', '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 10:36:07 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 10:36:07 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 10:36:07 INFO - Using env: {'DISPLAY': ':0', 10:36:07 INFO - 'HOME': '/home/cltbld', 10:36:07 INFO - 'LANG': 'en_US.UTF-8', 10:36:07 INFO - 'LANGUAGE': 'en_US:en', 10:36:07 INFO - 'LOGNAME': 'cltbld', 10:36:07 INFO - 'MAIL': '/var/mail/cltbld', 10:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:07 INFO - 'MOZ_NO_REMOTE': '1', 10:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:07 INFO - 'NO_EM_RESTART': '1', 10:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:07 INFO - 'PWD': '/builds/slave/test', 10:36:07 INFO - 'SHELL': '/bin/bash', 10:36:07 INFO - 'SHLVL': '1', 10:36:07 INFO - 'TERM': 'linux', 10:36:07 INFO - 'TMOUT': '86400', 10:36:07 INFO - 'USER': 'cltbld', 10:36:07 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', 10:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:07 INFO - '_': '/tools/buildbot/bin/python'} 10:36:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:36:08 INFO - Cleaning up... 10:36:08 INFO - Return code: 0 10:36:08 INFO - Running post-action listener: _resource_record_post_action 10:36:08 INFO - Running post-action listener: _start_resource_monitoring 10:36:08 INFO - Starting resource monitoring. 10:36:08 INFO - [mozharness: 2016-08-16 17:36:08.084900Z] Finished create-virtualenv step (success) 10:36:08 INFO - [mozharness: 2016-08-16 17:36:08.085417Z] Running install step. 10:36:08 INFO - Running pre-action listener: _resource_record_pre_action 10:36:08 INFO - Running main action method: install 10:36:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:36:08 INFO - Reading from file tmpfile_stdout 10:36:08 INFO - Detecting whether we're running mozinstall >=1.0... 10:36:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:36:08 INFO - Reading from file tmpfile_stdout 10:36:08 INFO - Output received: 10:36:08 INFO - Usage: mozinstall [options] installer 10:36:08 INFO - Options: 10:36:08 INFO - -h, --help show this help message and exit 10:36:08 INFO - -d DEST, --destination=DEST 10:36:08 INFO - Directory to install application into. [default: 10:36:08 INFO - "/builds/slave/test"] 10:36:08 INFO - --app=APP Application being installed. [default: firefox] 10:36:08 INFO - mkdir: /builds/slave/test/build/application 10:36:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:36:24 INFO - Reading from file tmpfile_stdout 10:36:24 INFO - Output received: 10:36:24 INFO - /builds/slave/test/build/application/firefox/firefox 10:36:24 INFO - Running post-action listener: _resource_record_post_action 10:36:24 INFO - [mozharness: 2016-08-16 17:36:24.408780Z] Finished install step (success) 10:36:24 INFO - [mozharness: 2016-08-16 17:36:24.409027Z] Running run-tests step. 10:36:24 INFO - Running pre-action listener: _resource_record_pre_action 10:36:24 INFO - Running main action method: run_tests 10:36:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:36:24 INFO - Python 2.7.3 10:36:24 INFO - Return code: 0 10:36:24 INFO - grabbing minidump binary from tooltool 10:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:36:24 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111b090>, '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 0x111e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x111ee40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:36:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:36:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:36:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:36:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:36:24 INFO - Return code: 0 10:36:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:36:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:36:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:36:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:36:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:36:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 10:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 10:36:24 INFO - Using env: {'DISPLAY': ':0', 10:36:24 INFO - 'HOME': '/home/cltbld', 10:36:24 INFO - 'LANG': 'en_US.UTF-8', 10:36:24 INFO - 'LANGUAGE': 'en_US:en', 10:36:24 INFO - 'LOGNAME': 'cltbld', 10:36:24 INFO - 'MAIL': '/var/mail/cltbld', 10:36:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:36:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:24 INFO - 'MOZ_NO_REMOTE': '1', 10:36:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:36:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:36:24 INFO - 'NO_EM_RESTART': '1', 10:36:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:24 INFO - 'PWD': '/builds/slave/test', 10:36:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:36:24 INFO - 'SHELL': '/bin/bash', 10:36:24 INFO - 'SHLVL': '1', 10:36:24 INFO - 'TERM': 'linux', 10:36:24 INFO - 'TMOUT': '86400', 10:36:24 INFO - 'USER': 'cltbld', 10:36:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087', 10:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:24 INFO - '_': '/tools/buildbot/bin/python'} 10:36:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 10:36:24 INFO - mozversion application_buildid: 20160816091017 10:36:24 INFO - mozversion application_changeset: af4cc6c04573fca495450725de702f7188dab6ea 10:36:24 INFO - mozversion application_display_name: Nightly 10:36:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:36:24 INFO - mozversion application_name: Firefox 10:36:24 INFO - mozversion application_remotingname: firefox 10:36:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:36:24 INFO - mozversion application_vendor: Mozilla 10:36:24 INFO - mozversion application_version: 51.0a1 10:36:24 INFO - mozversion platform_buildid: 20160816091017 10:36:24 INFO - mozversion platform_changeset: af4cc6c04573fca495450725de702f7188dab6ea 10:36:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:36:24 INFO - mozversion platform_version: 51.0a1 10:36:24 INFO - using testdate: 1471368984 10:36:24 INFO - actual date: 1471368984 10:36:24 INFO - starting webserver on 'localhost:60319' 10:36:24 INFO - SUITE-START | Running 2 tests 10:36:24 INFO - TEST-START | dromaeo_css 10:36:24 INFO - operating with platform_type : linux_ 10:36:24 INFO - Initialising browser for dromaeo_css test... 10:36:24 INFO - TEST-INFO | started process 24838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp24squL/profile http://localhost:60319/getInfo.html) 10:36:29 INFO - PROCESS | 24838 | __metrics Screen width/height:1600/1200 10:36:29 INFO - PROCESS | 24838 | colorDepth:24 10:36:29 INFO - PROCESS | 24838 | Browser inner width/height: 1024/697 10:36:29 INFO - PROCESS | 24838 | __metrics 10:36:29 INFO - PROCESS | 24838 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:36:29 INFO - PROCESS | 24838 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:36:30 INFO - PROCESS | 24838 | console.error: PushService: 10:36:30 INFO - PROCESS | 24838 | stateChangeProcessEnqueue: Error transitioning state 10:36:30 INFO - PROCESS | 24838 | UnknownError 10:36:30 INFO - TEST-INFO | 24838: exit 0 10:36:30 INFO - Browser initialized. 10:36:30 INFO - Running cycle 1/1 for dromaeo_css test... 10:36:30 INFO - TEST-INFO | started process 24920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp24squL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:36:42 INFO - PROCESS | 24920 | RSS: Main: 157147136 10:36:42 INFO - PROCESS | 24920 | 10:37:33 INFO - PROCESS | 24920 | 1471369053726 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:39:47 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:60319/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60319/tests/dromaeo/cssquery-ext.html) 10:39:48 INFO - PROCESS | 24920 | RSS: Main: 233742336 10:39:48 INFO - PROCESS | 24920 | 10:42:50 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:60319/tests/dromaeo/cssquery-ext.html (next: http://localhost:60319/tests/dromaeo/cssquery-jquery.html) 10:42:51 INFO - PROCESS | 24920 | RSS: Main: 243625984 10:42:51 INFO - PROCESS | 24920 | 10:45:53 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:60319/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60319/tests/dromaeo/cssquery-mootools.html) 10:45:54 INFO - PROCESS | 24920 | RSS: Main: 188612608 10:45:54 INFO - PROCESS | 24920 | 10:48:56 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:60319/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60319/tests/dromaeo/cssquery-prototype.html) 10:48:57 INFO - PROCESS | 24920 | RSS: Main: 232173568 10:48:57 INFO - PROCESS | 24920 | 10:52:00 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:60319/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60319/tests/dromaeo/cssquery-yui.html) 10:52:00 INFO - PROCESS | 24920 | RSS: Main: 189198336 10:52:00 INFO - PROCESS | 24920 | 10:55:03 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:60319/tests/dromaeo/cssquery-yui.html (next: http://localhost:60319/tests/dromaeo/cssquery-dojo.html) 10:55:03 INFO - PROCESS | 24920 | RSS: Main: 280301568 10:55:03 INFO - PROCESS | 24920 | 10:55:03 INFO - PROCESS | 24920 | __start_tp_report 10:55:03 INFO - PROCESS | 24920 | _x_x_mozilla_page_load 10:55:03 INFO - PROCESS | 24920 | _x_x_mozilla_page_load_details 10:55:03 INFO - PROCESS | 24920 | |i|pagename|runs| 10:55:03 INFO - PROCESS | 24920 | |0;dojo.html;2600.1029644772552;2610.0734239345043;2624.3307956471103;2636.815422920395;2650.3374156460886;4607.35497030416;4677.579017888389;4711.505291944348;4721.7639118044135;4725.14947309485;4688.648351373652;4754.453237877637;4758.833440829571;4759.809607615691;4818.012307476967;4327.4157988671595;4335.956640433595;4414.82340706373;4466.687331886753;4520.163769702615;4439.689221754463;4454.688171827974;4472.552744725518;4481.193385190664;4499.617532509724;4265.360195970598;4305.590968857985;4316.525182229952;4371.803268852909;4383.211022016036;4311.137772445523;4339.153864996327;4354.150940566591;4359.215341238576;4370.781460926941;4318.050028993648;4371.475422949266;4379.255526560492;4385.188740083095;4427.203103441379;4631.8147274109;4775.617950563947;4794.5684888359865;4835.6131509479155;4851.611871050342;5061.569766569846;5107.182850743863;5116.744162791882;5194.92207616886;5200.869978250536;5159.17453207485;5171;5188.974055129738;5229.215617657382;5242.711650859202;4652.13935421948;4717.716936983792;4862.41651001882;4869.342638743795;4869.537393947569;5176.5858731301405;5271;5271.525562699376;5274.472552744694;5320.840374788762;5038.3198268234055;5040.395152581714;5083.135866902636;5089.872753181126;5091.210862316347;5117.795288188505;5125.487451254845;5168.767405466763;5170.819021334235;5176.559992400613;4923.48303428142;5031.84904452867;5075.568576671024;5083.034223497523;5183.611229157828;5089.643724939293;5099.260607211933;5101.426189113159;5106.744662766847;5107.438181799999;4328.199283132631;4328.307470804656;4329.740215587075;4364.738115713068;4376.956230437719;3682.4844521766972;3716.3682174030478;3732.720045996561;3750.3624383854262;3759.3797023491366;4436.112777444459;4438;4447.266201076786;4456.955430445719;4479.924818043646;5172.5344718975475;5182.53357197854;5184.092783762826;5187.325647665854;5235.240890070994;4206.411102445599;4295.72077814941;4344.3049112142535;4429.7785110744335;4472.664550158686;4564.018735971782;4604.102200070954;4606.332081848113;4643.8374656886845;4648.3259927310355;4844.079624871263;4861.44093429246;4864.513548645107;4865.610751139971;4901.534354236342;4992.375953005729;5097.286379906742;5137.486251374982;5154.922676159936;5195.142801437872;4829.7585120743115;4854.320395144612;4858.222684370484;4877.439094504036;4883.145449546244;5052.873678158076;5090.287359769709;5091.185410334477;5096.413912400121;5139.537441630122;4938;5061.493850614909;5153.020926024044;5174.275601415729;5175.430702622783;4928.975355123202;4984.651074424901;4989.226669866177;5007.47421520735;5029.899402012013;4972.65191436596;4980.701157930535;4983.900321993612;5000.924986125284;5029.723365214948;4771.904561908673;4865.70805751656;4907.067657145131;4915.43472500667;4952.059108769322;5007.57435617962;5034;5046.747662616781;5062.848114556569;5084.618653600921;4916.213405855046;4919.729414882216;4925.310456536016;4925.458199598113;4967.82612608557 10:55:03 INFO - PROCESS | 24920 | |1;ext.html;551.5807985930692;572.687885102619;573.6672729816706;584.0771580902175;592.9021711417611;38954.80522597387;40451.79774101129;40493.392599111;42743;42764;37669;37952.81023594885;38136;38180.42729359062;38191.23617527655;7412.962185294063;7602.353799926999;7745.496542724705;7747.883781743279;7749.496282741604;7564.205758395345;7641.808954776147;7648.923510764905;9432.717018489457;9666.323357364987;9956.253281003917;10002.249831262649;10003.099721025106;10009.649662261822;10026.047525485068;9982.251331150193;9993.550290236957;10020.14828739558;10047.799044019115;10048.497575121215;9646.565904534313;9694.75763105928;9709.757256068655;9724.222062235005;9724.562394692255;37976;38122.23755524874;38140.42789358162;38178.61821381778;38197.80901095505;3136.9215769605944;3147.653758086609;3230.2072349845826;3364.596248450177;3462.6883580477624;29100.70899291001;29305.85347073251;29363.265918351997;29598;31022.379552408824;3310.867565297385;3328.7503437242062;3332.100332910101;3346.380919529895;3470.288590838897;247163;248625;249769;250870.99999999817;251184;27999.860000699868;51680.483195168315;52126.47873521292;52167.87062264165;52243;33341.665583473994;33393.83303083518;33417.49873751896;33440;33495.16262093467;12034;12062.215955963009;12122.515099396102;12197.146199765932;12266.81599776004;9217.815643687089;9277.350585459088;9295.395799273025;9310.301727370474;9312.580933857993;7303.342699156995;7382.22486638906;7392.519486233377;7656.80857978555;7674.194209608022;3060.8622611982514;3101.100680802542;3143.182772479172;3146.8269245191736;3147.669494703069;812.8658771302787;854.4915775113922;932.7481579973369;950.805084957582;1007.6221416968637;25665.61501577478;27885.302867428072;27915.720842791314;28635.57046644302;28721.856390717912;944.197432182653;970.9514524273758;988.3378136648463;1020.6626824571796;1052.5053224984244;14132.788008179885;15290.617734556725;15392.30734616945;15848.92075539638;16009.119498427466;386498;390901;392102;392118;392228;48232.517674822804;48351.75824120857;48607.5139248603;49072.509274907505;49082.75458622684;1186.3712232516953;1199.748052908899;1215.459120691284;1215.9574414895437;1218.5186851193728;27202.455950881267;28585.71414285914;28684.71315286904;29120;29379;42041.1591768169;42820.35769463398;42870.78564607157;42906.78546607247;42930.57069429391;345168;538008;556800;559274.4979427725;561360;37476.2504749898;37734.43398348972;37737.62262377341;38084.619153808104;38450.230995380494;41906.37140442957;42044.789776052145;42261;42354.152916942105;42713.1457370857;35931;35961.1009724759;36196.09509762277;36218.09454763652;36582.26835463329;36404.81797590995;36444.27111457809;36574.817125914204;37892;37969.4304585437;34159.82920085483;34450.13874653054;35036.824815876775;35836.641633584375;36134.09664758297;29966.400671986874;32247;32526;32581.674183258812;32956.83521582377;24568.385790355384;24599.508009839345;24704.752952470964;24896.37759056038;25005.499890002462 10:55:03 INFO - PROCESS | 24920 | |2;jquery.html;343.70613125777476;359.75716391435793;360.2345016839216;361.7088243963609;381.0891968196012;12577.056720745946;16028.919855400722;16193.35226590938;16297.674046519063;17243.827561724378;15285.235738213101;15440.382384704626;15443.69112617747;15722;15806.288717007734;4621.9369545004665;4853.733044682541;5007.349044624212;5042.3949126104735;5050.242463630467;4942.901141977159;5022.84931452057;5026.246063090529;5029.497050294978;5030.01914626648;4783.354247176621;4890.486498917616;4939;4990.75046247688;5004.199328107504;4939.506049395068;4951.925721114186;4966.950330496703;4967.279744437036;4982.60139188864;4256.638185754215;4415;4433.822647094113;4434.490033646108;4442.3336499525;18577.721334179998;19364.515887102792;20083.698744518842;20305.49236269105;20316.492087697927;1866.337450205171;2056.9280075197444;2245.6631505274177;2348.5655153796433;2389.6773935518654;9227.169554740105;9714.659986900424;9805.166560842337;10031.799364012679;12652.430640621102;1670.8579770719502;1748.195829918239;1774.2814160265114;1789.5883946692204;1856.7029275315886;68634;70103;70498.2950170502;71465.28534714639;73832.26167738362;9808.362456440309;10107.3430227035;10146.13757830578;10153.49232538385;10298.227632927561;13821.861781382258;13858;13862.445502180002;13867.722645547032;13867.930660346836;6786.762463313859;6966.164060312693;7013.333733295329;7072.434205263567;7228.060352154292;6464.127342808754;6464.482841372679;6528.151340325728;6676.732930682815;6693.564918280296;3939.7242193046213;4089.5297040840683;4172.728772629769;4310.719803212781;4457.465104187519;1744.3109971561162;1829.1677286834458;1843.2903332217193;1873.1664409337714;1888.9149988250563;777.6617171530403;784.4704824243613;810.3112354498746;823.9629216685264;894.351595093552;15803.920980395025;15858.52424427269;16054.678906421806;16283.348666053462;16326.75509867353;791.9881201781977;830.9501429914225;840.5629072882067;872.8385248729005;877.4296707140282;7450.403967682572;8960.775980600538;9377.671781487616;9492.525373731285;9678.661246856327;349222;355061;365314;365841;365957;75587.62206189043;76635.23364766281;83571;84074.57962710147;84557;900.4192295969063;927.2211342472356;934.275936149476;952.6903756279237;953.6376177052675;15054.473093441677;15360.001599895972;15502.457413990456;15845.207739613204;16281;25700.8714956424;33893.491597625565;34561.30877382489;36230.27539449144;36689.08277293089;50887.49112508827;51766.74116629393;53284.73357633187;53341.733291333294;54649.18026229689;7464.552126872405;7675.349799793072;7755.457118001686;7844.725434609762;7856.45004849655;9906.603735850485;11987.580434684744;12012.279263244232;12111.576094836639;12661.113722039738;9749.976252493387;9998.450085245382;10170.491475426052;10247.333923294962;10865.728356790827;9927.453990030617;10003.249756268164;10142.290039697446;10173.338732982333;10520.15838732915;10329.690109296733;10378.792424151323;10404.739881503023;10690.679279621623;10828.133749300194;7366.815829604303;7443;7503.9249607503225;7632.465727399029;7665.156832748282;9021.32340074484;9966.50167491637;10700.839487407851;10913.83629245546;11312.490937907978 10:55:03 INFO - PROCESS | 24920 | |3;mootools.html;1255.2029461292077;1309.5315330601813;1370.3764787021905;1410.2807568140245;1667.4580761252596;6597.439217666498;7669.884951725721;7870.173631768667;7877.80305492363;8055.677772889092;7888.684452621888;7904.841903161933;7985.680572777096;7986.281234688891;7998.600069996492;2193.254293540196;2219.1456289328644;2221.0449506712107;2221.378014156031;2225.221172589597;2130.084063852543;2151.62346589347;2196.5497073099978;2197.7582465928735;2200.4058904095887;2164.5995490834166;2176.086043861574;2183.770704076073;2186.0709198590616;2204.6582779669175;2141.2077531313435;2147.0874878176714;2147.5919575280723;2148.516583768655;2149.0651566568595;2050.7231523744404;2153.9784602153936;2154.7522034965864;2154.9892250538646;2160.654295312758;7803.102643196048;8049.356051515923;8088.272055515032;8117.431779775359;8125.512469251864;4397.164538737629;4562.064776720765;4568.817247310104;4605.815767369301;4617.21507343749;2902.782291328159;3015.9246018849485;3049.74077203438;3059.5257735051105;3060.785744997851;925.9814803703955;928.2249321816291;940.6190492850407;942.9952850235774;947.6020071569957;11022.063124634416;11039.83440248397;11063.225574209808;11067.833982490269;11150.330980141136;4136.152088821785;4156;4180.28935081037;4220.704550681423;4259.637930775857;8725.912740872636;8729.432586881832;8735.51954642488;8741;8751.343649226334;4524.23088075028;4526.6152377047665;4527.954720452819;4535.478419981679;4535.818567257339;3631.9092022699115;3996.9200615987515;4156.521999970042;4173.561776013536;4175.415441838145;3473.6700013498676;3476.7657481594174;3568.393373126523;3597.7661452005536;3612.6567976042234;1018.954147063384;1020.3877673396051;1028.665683652801;1034.5965073621294;1038.2368958815264;775.7246177606982;782.8042989252687;841.0622156295686;843.9282660973763;845.5560830564003;5043.344365232496;5123.615728820353;5138.3833939927445;5179.326687530673;5208.374995000624;418.6964450773165;422.2231094785609;428.34890965731915;431.2453206887946;432.09476147470997;3502.5972013218297;3640;3729.384651532521;3750.1187221003042;3771.867984620525;9518;9921.50392480373;10005.749856253651;10083.59665613382;10097.141742951932;9954.253430992705;9971.202303815677;10009.949950250202;10022.298439109338;10057.849132263022;7421.517601355895;7470.103587569418;7480.326770590673;7532.246775322534;7571.432142589218;5192.091384007708;5222.138347172674;5248.422673505987;5265.157574788015;5331.573474121983;8834.204921557091;8933.687320943736;9181.678641247792;9199.816003680024;9224.215941645036;9222.95388523053;9308.674196403093;9332.673356432493;9410.388324759142;9455;5802.245708057925;6219.253689557101;6383.36166383358;6440.967795161182;6443.226812782496;7616.3906887447765;7950.7217247396065;7964.402669799672;7975.481593696391;7978.800529986796;6843.7604683835825;6965;7068.823279418056;7110.075690160246;7159;6895.724171033303;6969.686364113526;6979.336962988508;7007.614581198083;7015.859682806417;6041.607295525777;6232.719527621359;6245.8750824982335;6278.497720182283;6295.779647712308;4529.954700452953;4638.420197475316;4674.719516829001;4758.214894542361;4786.736729479912;4339.435873336446;4515.593596576324;4526.728396296233;4616.561426664462;4648.140094082605 10:55:03 INFO - PROCESS | 24920 | |4;prototype.html;291.88616439588566;298.4910727210107;305.27344919092565;309.2516111011352;310.0172453322966;4896.951030489694;4901.068796928581;4910.582600478959;4912.164931961566;4928.901421971563;4610.9308360374625;4695.436547614283;4751.619870410367;4753.691010084342;4872.512748725126;3727.9440808387894;3732.9440058399146;3749.793761343125;3792.6965842732516;3819.178876541543;3790.9620903790883;3807.9048023799487;3813.3898576227807;3821.586013175129;3830.8467661293516;3556.5020897074432;3716.479692843004;3789.5073640426845;3799.5820459749407;3815.122521819983;3736.1220113273494;3738.056210770384;3739.420389839566;3742.5404092403983;3747.7938713370754;3279.426100432415;3284.967150328514;3288.621808492006;3295.752818538619;3298.455754800455;4665.230237010889;4670.7664616769025;4683.8360657376825;4686;4694.201985662446;4125.793710314472;4250.766207858566;4266.786660666954;4267.141015519609;4286.592773686495;5027.673201241908;5040.7731652075745;5051.747412629354;5052.494750524918;5056.191009438472;3582.6923173041914;3587.157018100744;3589.138606734391;3590.6588874057184;3593.2094939113354;5034.51481812866;5230.476952304815;5266.8683282917855;5285.973570132125;5295.735213239323;3622.7826330420257;3649.635036496329;3652.3060618482405;3658.9634103659155;3685.5208822852856;3721.1813401051727;3723.5345581802276;3741.326561218952;3750.3873334466443;3758.3235017697075;4295.613394794421;4295.6778241632;4296.183725092285;4297.892552686145;4299.710086973895;4816.518348165226;5022.824201152942;5052.696838189647;5059.949400506021;5139.743012849342;1279.8272233248579;1291.2897906151768;1292.3538230884558;1298.6169080121388;1299.0971274964;820.7865954851662;860.9182127697859;883.5008220355479;891.2468963725642;895.8611415230649;4452.9109417812115;4455.042165934275;4466.486354069259;4471.821127154943;4472.530384309601;5166.070107380632;5173.198154286091;5196.168613021899;5198.662086964335;5255.424841827554;4326.480822301344;4384.583464570861;4403.14138742942;4483.3947417098925;4494.460664720189;2729.3995321029342;2729.5769155780886;2738.4523095381005;2740.6985231624503;2755.3938133610573;4883.731394773322;4902.142125128088;4902.877428064256;4905.264210368402;4925.729084900293;5077.416097148801;5255.868603284872;5284.022455845681;5334.226537152092;5386.569074474032;4970.2296144097;4973.50264973507;4976.751162441863;4984.601231901512;4993.825216117419;5264.947350526446;5269.89460210786;5282.86044152119;5309.36287645485;5327.360716714019;4899.461059283547;5110.466859941928;5153;5158.561522270649;5185.262936916175;4973.626977976739;4975.164156430799;4978.950210497848;4982.800687972441;4983.134697548851;3712.294664013829;3725.403935370328;3735.1782607826235;3737.5328083989502;3738.158914244273;5124.719499822692;5191.117510023229;5230.869228269324;5232.4505926878655;5297.073012222922;5045.915128247444;5085.898282034264;5086.54221120101;5093.388793344822;5094.847154585368;5058.140116180185;5069.087564238473;5078.695278283315;5091.490850914879;5093.694378337312;4856.223004319292;4920.434150072788;4973.477784832685;4981.775820088177;5004.84985450437;4874.561289483963;4925.630577706758;5095;5116.539511443988;5123.257127716534;4957.702537847741;4966.279889416087;4966.627502937366;4980.551750342486;5004.324416203912 10:55:03 INFO - PROCESS | 24920 | |5;yui.html;617.6726335042428;684.2336583027011;707.4941416886928;732.582428016031;738.7968308715099;12235.938820305897;13346.332683365828;13355.998300127492;13377.59867203983;13423.127496712706;13786.724265514684;14504.709905801878;14533.128012319268;14832;14950;767.4282659418741;786.5713186313444;788.917163697812;789.1634867040955;789.3014682006408;627.8210709947666;754.0611938137027;784.525362155896;793.0443815202696;795.0380040151424;817.0562999735286;819.7704642700054;824.4929368438427;824.9133840946704;824.9752507424787;815.5473712089788;816.742726041301;816.8856360109589;816.9632366543519;817.8159914019358;485.1606720373738;493.5237495816554;494.3474613510168;595.9195508606326;596.4542443664042;10387.065164135189;11641.825372619418;11915.642530724092;12068.0345572354;12338.012958963262;12086.516539338416;12748;12859.935700321439;12958.740825183444;13439.798403023962;10469.895301046969;10500.2649814513;10620.628278010232;10685.198610104273;10714.517846696917;3294.3740689269202;3303.6035675719068;3313.966860331414;3388.457846744509;3496.9300613987834;67100;68709.65645171743;68845.31154688439;69184.6540767298;69337.95993060159;10311.948440257751;10501.579936802595;10508.054275115277;10627;10678.092362149304;18869.622607548048;19206.231750730094;19333.226670933003;19546.218151273788;19571.11929963155;6551.886179349522;6671.099401580725;6746.595204287759;6891.310868913169;7275.563466192046;3575.4994300797907;3683.1160521474653;3735.9813200933822;3740.85036598533;3749;2860.084772872661;2978.195887110468;2980.508216144312;2983.7463815575484;2990.386970671007;507.17330750875834;521.0932976620653;522.8875791704802;524.4676653197008;532.1804421191322;497.6715367857197;529.2986792499953;566.8752874367633;579.2411940358145;581.1079992211935;7680.692772289158;7890.566018868903;7971.255110890844;8021.919780802234;8185.713500027589;485.3665965914445;560.0954458549495;568.3577557360156;619.801663467695;624.4224092714221;3618.475321078429;3782.508273924372;3839.6928245740273;4135.6898232632675;4161.459010328638;102870.48564757129;105968.47015764871;107374.46312768386;110120;110124.4493777542;89204;91327.54336228277;91940.54029729808;92813;93657.53171234236;79413.20586794174;79581.05236845394;79957.20042799498;80004;80141.59929200317;7547.433942454228;7665.156832748505;7785.238923196906;8002.5598592077995;8099.676012959416;34319.4852077214;46384.95493378759;47308.2903756437;47724.522754772006;49547.00905981788;37799.05502362463;45953.540464594924;65292.67353663201;65536.67231664002;68123.65938170278;9596.66411675588;9787.559559819967;9831.115199632068;9891.406515609087;10321.432321222404;11210.383428911162;11260.324380537195;11356.54573817038;11471.598494052669;11596.130290228435;11003.724906877393;11279.379634120201;11597.420128993685;11640.243384180001;11977.161598688008;10392.480375981322;11169.162312826733;11390.772184556428;11594.536218551164;11641.133932306684;10268.691939241835;10369.896301036893;10573.8942610576;11946.401081086418;12045.518179273082;9602.231821454407;9732.221422286058;9821.214302855611;10078.193744500275;10334.79257037025;8269.917032067484;8538.829223415372;8584.613692383733;8980.640774368952;9673.322867399214 10:55:03 INFO - PROCESS | 24920 | __end_tp_report 10:55:03 INFO - PROCESS | 24920 | __start_cc_report 10:55:03 INFO - PROCESS | 24920 | _x_x_mozilla_cycle_collect,1023 10:55:03 INFO - PROCESS | 24920 | __end_cc_report 10:55:03 INFO - PROCESS | 24920 | __startTimestamp1471370103902__endTimestamp 10:55:03 INFO - PROCESS | 24920 | 10:55:03 INFO - PROCESS | 24920 | ------- Summary: start ------- 10:55:03 INFO - PROCESS | 24920 | Number of tests: 6 10:55:03 INFO - PROCESS | 24920 | 10:55:03 INFO - PROCESS | 24920 | [#0] dojo.html Cycles:165 Average:4730.74 Median:4869.34 stddev:514.47 (10.6%) stddev-sans-first:488.14 10:55:03 INFO - PROCESS | 24920 | Values: 2600.1 2610.1 2624.3 2636.8 2650.3 4607.4 4677.6 4711.5 4721.8 4725.1 4688.6 4754.5 4758.8 4759.8 4818.0 4327.4 4336.0 4414.8 4466.7 4520.2 4439.7 4454.7 4472.6 4481.2 4499.6 4265.4 4305.6 4316.5 4371.8 4383.2 4311.1 4339.2 4354.2 4359.2 4370.8 4318.1 4371.5 4379.3 4385.2 4427.2 4631.8 4775.6 4794.6 4835.6 4851.6 5061.6 5107.2 5116.7 5194.9 5200.9 5159.2 5171.0 5189.0 5229.2 5242.7 4652.1 4717.7 4862.4 4869.3 4869.5 5176.6 5271.0 5271.5 5274.5 5320.8 5038.3 5040.4 5083.1 5089.9 5091.2 5117.8 5125.5 5168.8 5170.8 5176.6 4923.5 5031.8 5075.6 5083.0 5183.6 5089.6 5099.3 5101.4 5106.7 5107.4 4328.2 4328.3 4329.7 4364.7 4377.0 3682.5 3716.4 3732.7 3750.4 3759.4 4436.1 4438.0 4447.3 4457.0 4479.9 5172.5 5182.5 5184.1 5187.3 5235.2 4206.4 4295.7 4344.3 4429.8 4472.7 4564.0 4604.1 4606.3 4643.8 4648.3 4844.1 4861.4 4864.5 4865.6 4901.5 4992.4 5097.3 5137.5 5154.9 5195.1 4829.8 4854.3 4858.2 4877.4 4883.1 5052.9 5090.3 5091.2 5096.4 5139.5 4938.0 5061.5 5153.0 5174.3 5175.4 4929.0 4984.7 4989.2 5007.5 5029.9 4972.7 4980.7 4983.9 5000.9 5029.7 4771.9 4865.7 4907.1 4915.4 4952.1 5007.6 5034.0 5046.7 5062.8 5084.6 4916.2 4919.7 4925.3 4925.5 4967.8 10:55:03 INFO - PROCESS | 24920 | 10:55:03 INFO - PROCESS | 24920 | [#1] ext.html Cycles:180 Average:52124.41 Median:37572.63 stddev:107137.19 (285.1%) stddev-sans-first:107367.77 10:55:03 INFO - PROCESS | 24920 | Values: 551.6 572.7 573.7 584.1 592.9 38954.8 40451.8 40493.4 42743.0 42764.0 37669.0 37952.8 38136.0 38180.4 38191.2 7413.0 7602.4 7745.5 7747.9 7749.5 7564.2 7641.8 7648.9 9432.7 9666.3 9956.3 10002.2 10003.1 10009.6 10026.0 9982.3 9993.6 10020.1 10047.8 10048.5 9646.6 9694.8 9709.8 9724.2 9724.6 37976.0 38122.2 38140.4 38178.6 38197.8 3136.9 3147.7 3230.2 3364.6 3462.7 29100.7 29305.9 29363.3 29598.0 31022.4 3310.9 3328.8 3332.1 3346.4 3470.3 247163.0 248625.0 249769.0 250871.0 251184.0 27999.9 51680.5 52126.5 52167.9 52243.0 33341.7 33393.8 33417.5 33440.0 33495.2 12034.0 12062.2 12122.5 12197.1 12266.8 9217.8 9277.4 9295.4 9310.3 9312.6 7303.3 7382.2 7392.5 7656.8 7674.2 3060.9 3101.1 3143.2 3146.8 3147.7 812.9 854.5 932.7 950.8 1007.6 25665.6 27885.3 27915.7 28635.6 28721.9 944.2 971.0 988.3 1020.7 1052.5 14132.8 15290.6 15392.3 15848.9 16009.1 386498.0 390901.0 392102.0 392118.0 392228.0 48232.5 48351.8 48607.5 49072.5 49082.8 1186.4 1199.7 1215.5 1216.0 1218.5 27202.5 28585.7 28684.7 29120.0 29379.0 42041.2 42820.4 42870.8 42906.8 42930.6 345168.0 538008.0 556800.0 559274.5 561360.0 37476.3 37734.4 37737.6 38084.6 38450.2 41906.4 42044.8 42261.0 42354.2 42713.1 35931.0 35961.1 36196.1 36218.1 36582.3 36404.8 36444.3 36574.8 37892.0 37969.4 34159.8 34450.1 35036.8 35836.6 36134.1 29966.4 32247.0 32526.0 32581.7 32956.8 24568.4 24599.5 24704.8 24896.4 25005.5 10:55:03 INFO - PROCESS | 24920 | 10:55:03 INFO - PROCESS | 24920 | [#2] jquery.html Cycles:180 Average:23419.03 Median:4424.41 stddev:59888.21 (1353.6%) stddev-sans-first:60031.15 10:55:03 INFO - PROCESS | 24920 | Values: 343.7 359.8 360.2 361.7 381.1 12577.1 16028.9 16193.4 16297.7 17243.8 15285.2 15440.4 15443.7 15722.0 15806.3 4621.9 4853.7 5007.3 5042.4 5050.2 4942.9 5022.8 5026.2 5029.5 5030.0 4783.4 4890.5 4939.0 4990.8 5004.2 4939.5 4951.9 4967.0 4967.3 4982.6 4256.6 4415.0 4433.8 4434.5 4442.3 18577.7 19364.5 20083.7 20305.5 20316.5 1866.3 2056.9 2245.7 2348.6 2389.7 9227.2 9714.7 9805.2 10031.8 12652.4 1670.9 1748.2 1774.3 1789.6 1856.7 68634.0 70103.0 70498.3 71465.3 73832.3 9808.4 10107.3 10146.1 10153.5 10298.2 13821.9 13858.0 13862.4 13867.7 13867.9 6786.8 6966.2 7013.3 7072.4 7228.1 6464.1 6464.5 6528.2 6676.7 6693.6 3939.7 4089.5 4172.7 4310.7 4457.5 1744.3 1829.2 1843.3 1873.2 1888.9 777.7 784.5 810.3 824.0 894.4 15803.9 15858.5 16054.7 16283.3 16326.8 792.0 831.0 840.6 872.8 877.4 7450.4 8960.8 9377.7 9492.5 9678.7 349222.0 355061.0 365314.0 365841.0 365957.0 75587.6 76635.2 83571.0 84074.6 84557.0 900.4 927.2 934.3 952.7 953.6 15054.5 15360.0 15502.5 15845.2 16281.0 25700.9 33893.5 34561.3 36230.3 36689.1 50887.5 51766.7 53284.7 53341.7 54649.2 7464.6 7675.3 7755.5 7844.7 7856.5 9906.6 11987.6 12012.3 12111.6 12661.1 9750.0 9998.5 10170.5 10247.3 10865.7 9927.5 10003.2 10142.3 10173.3 10520.2 10329.7 10378.8 10404.7 10690.7 10828.1 7366.8 7443.0 7503.9 7632.5 7665.2 9021.3 9966.5 10700.8 10913.8 11312.5 10:55:03 INFO - PROCESS | 24920 | 10:55:03 INFO - PROCESS | 24920 | [#3] mootools.html Cycles:180 Average:5173.21 Median:4627.82 stddev:2987.06 (64.5%) stddev-sans-first:2980.93 10:55:03 INFO - PROCESS | 24920 | Values: 1255.2 1309.5 1370.4 1410.3 1667.5 6597.4 7669.9 7870.2 7877.8 8055.7 7888.7 7904.8 7985.7 7986.3 7998.6 2193.3 2219.1 2221.0 2221.4 2225.2 2130.1 2151.6 2196.5 2197.8 2200.4 2164.6 2176.1 2183.8 2186.1 2204.7 2141.2 2147.1 2147.6 2148.5 2149.1 2050.7 2154.0 2154.8 2155.0 2160.7 7803.1 8049.4 8088.3 8117.4 8125.5 4397.2 4562.1 4568.8 4605.8 4617.2 2902.8 3015.9 3049.7 3059.5 3060.8 926.0 928.2 940.6 943.0 947.6 11022.1 11039.8 11063.2 11067.8 11150.3 4136.2 4156.0 4180.3 4220.7 4259.6 8725.9 8729.4 8735.5 8741.0 8751.3 4524.2 4526.6 4528.0 4535.5 4535.8 3631.9 3996.9 4156.5 4173.6 4175.4 3473.7 3476.8 3568.4 3597.8 3612.7 1019.0 1020.4 1028.7 1034.6 1038.2 775.7 782.8 841.1 843.9 845.6 5043.3 5123.6 5138.4 5179.3 5208.4 418.7 422.2 428.3 431.2 432.1 3502.6 3640.0 3729.4 3750.1 3771.9 9518.0 9921.5 10005.7 10083.6 10097.1 9954.3 9971.2 10009.9 10022.3 10057.8 7421.5 7470.1 7480.3 7532.2 7571.4 5192.1 5222.1 5248.4 5265.2 5331.6 8834.2 8933.7 9181.7 9199.8 9224.2 9223.0 9308.7 9332.7 9410.4 9455.0 5802.2 6219.3 6383.4 6441.0 6443.2 7616.4 7950.7 7964.4 7975.5 7978.8 6843.8 6965.0 7068.8 7110.1 7159.0 6895.7 6969.7 6979.3 7007.6 7015.9 6041.6 6232.7 6245.9 6278.5 6295.8 4530.0 4638.4 4674.7 4758.2 4786.7 4339.4 4515.6 4526.7 4616.6 4648.1 10:55:03 INFO - PROCESS | 24920 | 10:55:03 INFO - PROCESS | 24920 | [#4] prototype.html Cycles:180 Average:4203.76 Median:4864.37 stddev:1222.52 (25.1%) stddev-sans-first:1190.17 10:55:03 INFO - PROCESS | 24920 | Values: 291.9 298.5 305.3 309.3 310.0 4897.0 4901.1 4910.6 4912.2 4928.9 4610.9 4695.4 4751.6 4753.7 4872.5 3727.9 3732.9 3749.8 3792.7 3819.2 3791.0 3807.9 3813.4 3821.6 3830.8 3556.5 3716.5 3789.5 3799.6 3815.1 3736.1 3738.1 3739.4 3742.5 3747.8 3279.4 3285.0 3288.6 3295.8 3298.5 4665.2 4670.8 4683.8 4686.0 4694.2 4125.8 4250.8 4266.8 4267.1 4286.6 5027.7 5040.8 5051.7 5052.5 5056.2 3582.7 3587.2 3589.1 3590.7 3593.2 5034.5 5230.5 5266.9 5286.0 5295.7 3622.8 3649.6 3652.3 3659.0 3685.5 3721.2 3723.5 3741.3 3750.4 3758.3 4295.6 4295.7 4296.2 4297.9 4299.7 4816.5 5022.8 5052.7 5059.9 5139.7 1279.8 1291.3 1292.4 1298.6 1299.1 820.8 860.9 883.5 891.2 895.9 4452.9 4455.0 4466.5 4471.8 4472.5 5166.1 5173.2 5196.2 5198.7 5255.4 4326.5 4384.6 4403.1 4483.4 4494.5 2729.4 2729.6 2738.5 2740.7 2755.4 4883.7 4902.1 4902.9 4905.3 4925.7 5077.4 5255.9 5284.0 5334.2 5386.6 4970.2 4973.5 4976.8 4984.6 4993.8 5264.9 5269.9 5282.9 5309.4 5327.4 4899.5 5110.5 5153.0 5158.6 5185.3 4973.6 4975.2 4979.0 4982.8 4983.1 3712.3 3725.4 3735.2 3737.5 3738.2 5124.7 5191.1 5230.9 5232.5 5297.1 5045.9 5085.9 5086.5 5093.4 5094.8 5058.1 5069.1 5078.7 5091.5 5093.7 4856.2 4920.4 4973.5 4981.8 5004.8 4874.6 4925.6 5095.0 5116.5 5123.3 4957.7 4966.3 4966.6 4980.6 5004.3 10:55:03 INFO - PROCESS | 24920 | 10:55:03 INFO - PROCESS | 24920 | [#5] yui.html Cycles:180 Average:18279.24 Median:489.45 stddev:27308.80 (5579.5%) stddev-sans-first:27353.21 10:55:03 INFO - PROCESS | 24920 | Values: 617.7 684.2 707.5 732.6 738.8 12235.9 13346.3 13356.0 13377.6 13423.1 13786.7 14504.7 14533.1 14832.0 14950.0 767.4 786.6 788.9 789.2 789.3 627.8 754.1 784.5 793.0 795.0 817.1 819.8 824.5 824.9 825.0 815.5 816.7 816.9 817.0 817.8 485.2 493.5 494.3 595.9 596.5 10387.1 11641.8 11915.6 12068.0 12338.0 12086.5 12748.0 12859.9 12958.7 13439.8 10469.9 10500.3 10620.6 10685.2 10714.5 3294.4 3303.6 3314.0 3388.5 3496.9 67100.0 68709.7 68845.3 69184.7 69338.0 10311.9 10501.6 10508.1 10627.0 10678.1 18869.6 19206.2 19333.2 19546.2 19571.1 6551.9 6671.1 6746.6 6891.3 7275.6 3575.5 3683.1 3736.0 3740.9 3749.0 2860.1 2978.2 2980.5 2983.7 2990.4 507.2 521.1 522.9 524.5 532.2 497.7 529.3 566.9 579.2 581.1 7680.7 7890.6 7971.3 8021.9 8185.7 485.4 560.1 568.4 619.8 624.4 3618.5 3782.5 3839.7 4135.7 4161.5 102870.5 105968.5 107374.5 110120.0 110124.4 89204.0 91327.5 91940.5 92813.0 93657.5 79413.2 79581.1 79957.2 80004.0 80141.6 7547.4 7665.2 7785.2 8002.6 8099.7 34319.5 46385.0 47308.3 47724.5 49547.0 37799.1 45953.5 65292.7 65536.7 68123.7 9596.7 9787.6 9831.1 9891.4 10321.4 11210.4 11260.3 11356.5 11471.6 11596.1 11003.7 11279.4 11597.4 11640.2 11977.2 10392.5 11169.2 11390.8 11594.5 11641.1 10268.7 10369.9 10573.9 11946.4 12045.5 9602.2 9732.2 9821.2 10078.2 10334.8 8269.9 8538.8 8584.6 8980.6 9673.3 10:55:03 INFO - PROCESS | 24920 | -------- Summary: end -------- 10:55:03 INFO - PROCESS | 24920 | 10:55:04 INFO - TEST-INFO | 24920: exit 0 10:55:04 INFO - TEST-OK | dromaeo_css | took 1120088ms 10:55:04 INFO - TEST-START | kraken 10:55:04 INFO - operating with platform_type : linux_ 10:55:04 INFO - Initialising browser for kraken test... 10:55:04 INFO - TEST-INFO | started process 25221 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMwcwFN/profile http://localhost:60319/getInfo.html) 10:55:09 INFO - PROCESS | 25221 | __metrics Screen width/height:1600/1200 10:55:09 INFO - PROCESS | 25221 | colorDepth:24 10:55:09 INFO - PROCESS | 25221 | Browser inner width/height: 1024/697 10:55:09 INFO - PROCESS | 25221 | __metrics 10:55:09 INFO - PROCESS | 25221 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:55:09 INFO - PROCESS | 25221 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:55:10 INFO - PROCESS | 25221 | console.error: PushService: 10:55:10 INFO - PROCESS | 25221 | stateChangeProcessEnqueue: Error transitioning state 10:55:10 INFO - PROCESS | 25221 | UnknownError 10:55:10 INFO - TEST-INFO | 25221: exit 0 10:55:10 INFO - Browser initialized. 10:55:10 INFO - Running cycle 1/1 for kraken test... 10:55:10 INFO - TEST-INFO | started process 25302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMwcwFN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:55:22 INFO - PROCESS | 25302 | RSS: Main: 157478912 10:55:22 INFO - PROCESS | 25302 | 10:55:25 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:60319/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60319/tests/kraken/driver.html?testName=audio-beat-detection) 10:55:26 INFO - PROCESS | 25302 | RSS: Main: 205451264 10:55:26 INFO - PROCESS | 25302 | 10:55:29 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:60319/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60319/tests/kraken/driver.html?testName=audio-dft) 10:55:29 INFO - PROCESS | 25302 | RSS: Main: 196558848 10:55:29 INFO - PROCESS | 25302 | 10:55:33 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:60319/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60319/tests/kraken/driver.html?testName=audio-fft) 10:55:33 INFO - PROCESS | 25302 | RSS: Main: 277635072 10:55:33 INFO - PROCESS | 25302 | 10:55:35 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:60319/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60319/tests/kraken/driver.html?testName=audio-oscillator) 10:55:36 INFO - PROCESS | 25302 | RSS: Main: 187674624 10:55:36 INFO - PROCESS | 25302 | 10:55:38 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:60319/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60319/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:55:39 INFO - PROCESS | 25302 | RSS: Main: 192647168 10:55:39 INFO - PROCESS | 25302 | 10:55:42 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:60319/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60319/tests/kraken/driver.html?testName=imaging-darkroom) 10:55:43 INFO - PROCESS | 25302 | RSS: Main: 228679680 10:55:43 INFO - PROCESS | 25302 | 10:55:46 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:60319/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60319/tests/kraken/driver.html?testName=imaging-desaturate) 10:55:47 INFO - PROCESS | 25302 | RSS: Main: 222597120 10:55:47 INFO - PROCESS | 25302 | 10:55:50 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:60319/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60319/tests/kraken/driver.html?testName=json-parse-financial) 10:55:50 INFO - PROCESS | 25302 | RSS: Main: 225787904 10:55:50 INFO - PROCESS | 25302 | 10:55:52 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:60319/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60319/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:55:53 INFO - PROCESS | 25302 | RSS: Main: 189530112 10:55:53 INFO - PROCESS | 25302 | 10:55:55 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:60319/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60319/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:55:55 INFO - PROCESS | 25302 | RSS: Main: 197128192 10:55:55 INFO - PROCESS | 25302 | 10:55:57 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:60319/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60319/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:55:58 INFO - PROCESS | 25302 | RSS: Main: 194633728 10:55:58 INFO - PROCESS | 25302 | 10:56:01 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:60319/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60319/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:56:02 INFO - PROCESS | 25302 | RSS: Main: 189616128 10:56:02 INFO - PROCESS | 25302 | 10:56:05 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:60319/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60319/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:56:05 INFO - PROCESS | 25302 | RSS: Main: 192442368 10:56:05 INFO - PROCESS | 25302 | 10:56:07 INFO - PROCESS | 25302 | Cycle 1(1): loaded http://localhost:60319/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60319/tests/kraken/driver.html?testName=ai-astar) 10:56:07 INFO - PROCESS | 25302 | RSS: Main: 243544064 10:56:07 INFO - PROCESS | 25302 | 10:56:07 INFO - PROCESS | 25302 | __start_tp_report 10:56:07 INFO - PROCESS | 25302 | _x_x_mozilla_page_load 10:56:07 INFO - PROCESS | 25302 | _x_x_mozilla_page_load_details 10:56:07 INFO - PROCESS | 25302 | |i|pagename|runs| 10:56:07 INFO - PROCESS | 25302 | |0;ai-astar;106;117;115;115;111;116;114;115;115;113 10:56:07 INFO - PROCESS | 25302 | |1;audio-beat-detection;143;120;128;177;123;124;152;130;161;122 10:56:07 INFO - PROCESS | 25302 | |2;audio-dft;161;161;161;161;161;161;162;161;160;161 10:56:07 INFO - PROCESS | 25302 | |3;audio-fft;78;77;76;113;77;77;77;75;102;80 10:56:07 INFO - PROCESS | 25302 | |4;audio-oscillator;86;87;125;86;86;86;125;86;87;131 10:56:07 INFO - PROCESS | 25302 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 10:56:07 INFO - PROCESS | 25302 | |6;imaging-darkroom;147;147;147;149;148;149;146;148;146;147 10:56:07 INFO - PROCESS | 25302 | |7;imaging-desaturate;95;96;95;95;95;96;96;95;95;95 10:56:07 INFO - PROCESS | 25302 | |8;json-parse-financial;67;65;67;66;67;69;66;66;68;65 10:56:07 INFO - PROCESS | 25302 | |9;json-stringify-tinderbox;65;66;65;66;66;66;66;65;66;66 10:56:07 INFO - PROCESS | 25302 | |10;stanford-crypto-aes;84;85;88;81;81;81;82;81;84;81 10:56:07 INFO - PROCESS | 25302 | |11;stanford-crypto-ccm;132;142;148;141;132;133;130;135;163;132 10:56:07 INFO - PROCESS | 25302 | |12;stanford-crypto-pbkdf2;176;175;175;175;175;172;172;176;176;171 10:56:07 INFO - PROCESS | 25302 | |13;stanford-crypto-sha256-iterative;68;67;68;67;67;67;68;69;66;70 10:56:07 INFO - PROCESS | 25302 | __end_tp_report 10:56:07 INFO - PROCESS | 25302 | __start_cc_report 10:56:07 INFO - PROCESS | 25302 | _x_x_mozilla_cycle_collect,1966 10:56:07 INFO - PROCESS | 25302 | __end_cc_report 10:56:07 INFO - PROCESS | 25302 | __startTimestamp1471370167667__endTimestamp 10:56:07 INFO - PROCESS | 25302 | 10:56:07 INFO - PROCESS | 25302 | ------- Summary: start ------- 10:56:07 INFO - PROCESS | 25302 | Number of tests: 14 10:56:07 INFO - PROCESS | 25302 | 10:56:07 INFO - PROCESS | 25302 | [#0] ai-astar Cycles:10 Average:113.70 Median:115.00 stddev:3.16 (2.8%) stddev-sans-first:1.74 10:56:07 INFO - PROCESS | 25302 | Values: 106.0 117.0 115.0 115.0 111.0 116.0 114.0 115.0 115.0 113.0 10:56:07 INFO - PROCESS | 25302 | 10:56:07 INFO - PROCESS | 25302 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:136.50 stddev:19.54 (14.3%) stddev-sans-first:20.64 10:56:07 INFO - PROCESS | 25302 | Values: 143.0 120.0 128.0 177.0 123.0 124.0 152.0 130.0 161.0 122.0 10:56:07 INFO - PROCESS | 25302 | 10:56:07 INFO - PROCESS | 25302 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 10:56:07 INFO - PROCESS | 25302 | Values: 161.0 161.0 161.0 161.0 161.0 161.0 162.0 161.0 160.0 161.0 10:56:07 INFO - PROCESS | 25302 | 10:56:07 INFO - PROCESS | 25302 | [#3] audio-fft Cycles:10 Average:83.20 Median:77.00 stddev:13.13 (17.1%) stddev-sans-first:13.79 10:56:07 INFO - PROCESS | 25302 | Values: 78.0 77.0 76.0 113.0 77.0 77.0 77.0 75.0 102.0 80.0 10:56:07 INFO - PROCESS | 25302 | 10:56:07 INFO - PROCESS | 25302 | [#4] audio-oscillator Cycles:10 Average:98.50 Median:86.00 stddev:19.74 (23.0%) stddev-sans-first:20.41 10:56:07 INFO - PROCESS | 25302 | Values: 86.0 87.0 125.0 86.0 86.0 86.0 125.0 86.0 87.0 131.0 10:56:07 INFO - PROCESS | 25302 | 10:56:07 INFO - PROCESS | 25302 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:56:07 INFO - PROCESS | 25302 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 10:56:07 INFO - PROCESS | 25302 | 10:56:07 INFO - PROCESS | 25302 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 10:56:07 INFO - PROCESS | 25302 | Values: 147.0 147.0 147.0 149.0 148.0 149.0 146.0 148.0 146.0 147.0 10:56:07 INFO - PROCESS | 25302 | 10:56:07 INFO - PROCESS | 25302 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:56:07 INFO - PROCESS | 25302 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 10:56:07 INFO - PROCESS | 25302 | 10:56:07 INFO - PROCESS | 25302 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:67.00 stddev:1.26 (1.9%) stddev-sans-first:1.33 10:56:07 INFO - PROCESS | 25302 | Values: 67.0 65.0 67.0 66.0 67.0 69.0 66.0 66.0 68.0 65.0 10:56:07 INFO - PROCESS | 25302 | 10:56:07 INFO - PROCESS | 25302 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 10:56:07 INFO - PROCESS | 25302 | Values: 65.0 66.0 65.0 66.0 66.0 66.0 66.0 65.0 66.0 66.0 10:56:07 INFO - PROCESS | 25302 | 10:56:07 INFO - PROCESS | 25302 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:2.39 (2.9%) stddev-sans-first:2.50 10:56:07 INFO - PROCESS | 25302 | Values: 84.0 85.0 88.0 81.0 81.0 81.0 82.0 81.0 84.0 81.0 10:56:07 INFO - PROCESS | 25302 | 10:56:07 INFO - PROCESS | 25302 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:138.00 stddev:10.27 (7.4%) stddev-sans-first:10.60 10:56:07 INFO - PROCESS | 25302 | Values: 132.0 142.0 148.0 141.0 132.0 133.0 130.0 135.0 163.0 132.0 10:56:07 INFO - PROCESS | 25302 | 10:56:07 INFO - PROCESS | 25302 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:175.00 stddev:1.89 (1.1%) stddev-sans-first:1.90 10:56:07 INFO - PROCESS | 25302 | Values: 176.0 175.0 175.0 175.0 175.0 172.0 172.0 176.0 176.0 171.0 10:56:07 INFO - PROCESS | 25302 | 10:56:07 INFO - PROCESS | 25302 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.22 10:56:07 INFO - PROCESS | 25302 | Values: 68.0 67.0 68.0 67.0 67.0 67.0 68.0 69.0 66.0 70.0 10:56:07 INFO - PROCESS | 25302 | -------- Summary: end -------- 10:56:07 INFO - PROCESS | 25302 | 10:56:08 INFO - TEST-INFO | 25302: exit 0 10:56:08 INFO - TEST-OK | kraken | took 64038ms 10:56:08 INFO - SUITE-END | took 1184s 10:56:08 INFO - Completed test suite (00:19:44) 10:56:08 INFO - javascript benchmark 10:56:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2600.1029644772552, 2610.0734239345043, 2624.3307956471103, 2636.815422920395, 2650.3374156460886, 4607.35497030416, 4677.579017888389, 4711.505291944348, 4721.7639118044135, 4725.14947309485, 4688.648351373652, 4754.453237877637, 4758.833440829571, 4759.809607615691, 4818.012307476967, 4327.4157988671595, 4335.956640433595, 4414.82340706373, 4466.687331886753, 4520.163769702615, 4439.689221754463, 4454.688171827974, 4472.552744725518, 4481.193385190664, 4499.617532509724, 4265.360195970598, 4305.590968857985, 4316.525182229952, 4371.803268852909, 4383.211022016036, 4311.137772445523, 4339.153864996327, 4354.150940566591, 4359.215341238576, 4370.781460926941, 4318.050028993648, 4371.475422949266, 4379.255526560492, 4385.188740083095, 4427.203103441379, 4631.8147274109, 4775.617950563947, 4794.5684888359865, 4835.6131509479155, 4851.611871050342, 5061.569766569846, 5107.182850743863, 5116.744162791882, 5194.92207616886, 5200.869978250536, 5159.17453207485, 5171.0, 5188.974055129738, 5229.215617657382, 5242.711650859202, 4652.13935421948, 4717.716936983792, 4862.41651001882, 4869.342638743795, 4869.537393947569, 5176.5858731301405, 5271.0, 5271.525562699376, 5274.472552744694, 5320.840374788762, 5038.3198268234055, 5040.395152581714, 5083.135866902636, 5089.872753181126, 5091.210862316347, 5117.795288188505, 5125.487451254845, 5168.767405466763, 5170.819021334235, 5176.559992400613, 4923.48303428142, 5031.84904452867, 5075.568576671024, 5083.034223497523, 5183.611229157828, 5089.643724939293, 5099.260607211933, 5101.426189113159, 5106.744662766847, 5107.438181799999, 4328.199283132631, 4328.307470804656, 4329.740215587075, 4364.738115713068, 4376.956230437719, 3682.4844521766972, 3716.3682174030478, 3732.720045996561, 3750.3624383854262, 3759.3797023491366, 4436.112777444459, 4438.0, 4447.266201076786, 4456.955430445719, 4479.924818043646, 5172.5344718975475, 5182.53357197854, 5184.092783762826, 5187.325647665854, 5235.240890070994, 4206.411102445599, 4295.72077814941, 4344.3049112142535, 4429.7785110744335, 4472.664550158686, 4564.018735971782, 4604.102200070954, 4606.332081848113, 4643.8374656886845, 4648.3259927310355, 4844.079624871263, 4861.44093429246, 4864.513548645107, 4865.610751139971, 4901.534354236342, 4992.375953005729, 5097.286379906742, 5137.486251374982, 5154.922676159936, 5195.142801437872, 4829.7585120743115, 4854.320395144612, 4858.222684370484, 4877.439094504036, 4883.145449546244, 5052.873678158076, 5090.287359769709, 5091.185410334477, 5096.413912400121, 5139.537441630122, 4938.0, 5061.493850614909, 5153.020926024044, 5174.275601415729, 5175.430702622783, 4928.975355123202, 4984.651074424901, 4989.226669866177, 5007.47421520735, 5029.899402012013, 4972.65191436596, 4980.701157930535, 4983.900321993612, 5000.924986125284, 5029.723365214948, 4771.904561908673, 4865.70805751656, 4907.067657145131, 4915.43472500667, 4952.059108769322, 5007.57435617962, 5034.0, 5046.747662616781, 5062.848114556569, 5084.618653600921, 4916.213405855046, 4919.729414882216, 4925.310456536016, 4925.458199598113, 4967.82612608557], "value": 4696.531970871841, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.5807985930692, 572.687885102619, 573.6672729816706, 584.0771580902175, 592.9021711417611, 38954.80522597387, 40451.79774101129, 40493.392599111, 42743.0, 42764.0, 37669.0, 37952.81023594885, 38136.0, 38180.42729359062, 38191.23617527655, 7412.962185294063, 7602.353799926999, 7745.496542724705, 7747.883781743279, 7749.496282741604, 7564.205758395345, 7641.808954776147, 7648.923510764905, 9432.717018489457, 9666.323357364987, 9956.253281003917, 10002.249831262649, 10003.099721025106, 10009.649662261822, 10026.047525485068, 9982.251331150193, 9993.550290236957, 10020.14828739558, 10047.799044019115, 10048.497575121215, 9646.565904534313, 9694.75763105928, 9709.757256068655, 9724.222062235005, 9724.562394692255, 37976.0, 38122.23755524874, 38140.42789358162, 38178.61821381778, 38197.80901095505, 3136.9215769605944, 3147.653758086609, 3230.2072349845826, 3364.596248450177, 3462.6883580477624, 29100.70899291001, 29305.85347073251, 29363.265918351997, 29598.0, 31022.379552408824, 3310.867565297385, 3328.7503437242062, 3332.100332910101, 3346.380919529895, 3470.288590838897, 247163.0, 248625.0, 249769.0, 250870.99999999817, 251184.0, 27999.860000699868, 51680.483195168315, 52126.47873521292, 52167.87062264165, 52243.0, 33341.665583473994, 33393.83303083518, 33417.49873751896, 33440.0, 33495.16262093467, 12034.0, 12062.215955963009, 12122.515099396102, 12197.146199765932, 12266.81599776004, 9217.815643687089, 9277.350585459088, 9295.395799273025, 9310.301727370474, 9312.580933857993, 7303.342699156995, 7382.22486638906, 7392.519486233377, 7656.80857978555, 7674.194209608022, 3060.8622611982514, 3101.100680802542, 3143.182772479172, 3146.8269245191736, 3147.669494703069, 812.8658771302787, 854.4915775113922, 932.7481579973369, 950.805084957582, 1007.6221416968637, 25665.61501577478, 27885.302867428072, 27915.720842791314, 28635.57046644302, 28721.856390717912, 944.197432182653, 970.9514524273758, 988.3378136648463, 1020.6626824571796, 1052.5053224984244, 14132.788008179885, 15290.617734556725, 15392.30734616945, 15848.92075539638, 16009.119498427466, 386498.0, 390901.0, 392102.0, 392118.0, 392228.0, 48232.517674822804, 48351.75824120857, 48607.5139248603, 49072.509274907505, 49082.75458622684, 1186.3712232516953, 1199.748052908899, 1215.459120691284, 1215.9574414895437, 1218.5186851193728, 27202.455950881267, 28585.71414285914, 28684.71315286904, 29120.0, 29379.0, 42041.1591768169, 42820.35769463398, 42870.78564607157, 42906.78546607247, 42930.57069429391, 345168.0, 538008.0, 556800.0, 559274.4979427725, 561360.0, 37476.2504749898, 37734.43398348972, 37737.62262377341, 38084.619153808104, 38450.230995380494, 41906.37140442957, 42044.789776052145, 42261.0, 42354.152916942105, 42713.1457370857, 35931.0, 35961.1009724759, 36196.09509762277, 36218.09454763652, 36582.26835463329, 36404.81797590995, 36444.27111457809, 36574.817125914204, 37892.0, 37969.4304585437, 34159.82920085483, 34450.13874653054, 35036.824815876775, 35836.641633584375, 36134.09664758297, 29966.400671986874, 32247.0, 32526.0, 32581.674183258812, 32956.83521582377, 24568.385790355384, 24599.508009839345, 24704.752952470964, 24896.37759056038, 25005.499890002462], "value": 17092.61531127659, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.70613125777476, 359.75716391435793, 360.2345016839216, 361.7088243963609, 381.0891968196012, 12577.056720745946, 16028.919855400722, 16193.35226590938, 16297.674046519063, 17243.827561724378, 15285.235738213101, 15440.382384704626, 15443.69112617747, 15722.0, 15806.288717007734, 4621.9369545004665, 4853.733044682541, 5007.349044624212, 5042.3949126104735, 5050.242463630467, 4942.901141977159, 5022.84931452057, 5026.246063090529, 5029.497050294978, 5030.01914626648, 4783.354247176621, 4890.486498917616, 4939.0, 4990.75046247688, 5004.199328107504, 4939.506049395068, 4951.925721114186, 4966.950330496703, 4967.279744437036, 4982.60139188864, 4256.638185754215, 4415.0, 4433.822647094113, 4434.490033646108, 4442.3336499525, 18577.721334179998, 19364.515887102792, 20083.698744518842, 20305.49236269105, 20316.492087697927, 1866.337450205171, 2056.9280075197444, 2245.6631505274177, 2348.5655153796433, 2389.6773935518654, 9227.169554740105, 9714.659986900424, 9805.166560842337, 10031.799364012679, 12652.430640621102, 1670.8579770719502, 1748.195829918239, 1774.2814160265114, 1789.5883946692204, 1856.7029275315886, 68634.0, 70103.0, 70498.2950170502, 71465.28534714639, 73832.26167738362, 9808.362456440309, 10107.3430227035, 10146.13757830578, 10153.49232538385, 10298.227632927561, 13821.861781382258, 13858.0, 13862.445502180002, 13867.722645547032, 13867.930660346836, 6786.762463313859, 6966.164060312693, 7013.333733295329, 7072.434205263567, 7228.060352154292, 6464.127342808754, 6464.482841372679, 6528.151340325728, 6676.732930682815, 6693.564918280296, 3939.7242193046213, 4089.5297040840683, 4172.728772629769, 4310.719803212781, 4457.465104187519, 1744.3109971561162, 1829.1677286834458, 1843.2903332217193, 1873.1664409337714, 1888.9149988250563, 777.6617171530403, 784.4704824243613, 810.3112354498746, 823.9629216685264, 894.351595093552, 15803.920980395025, 15858.52424427269, 16054.678906421806, 16283.348666053462, 16326.75509867353, 791.9881201781977, 830.9501429914225, 840.5629072882067, 872.8385248729005, 877.4296707140282, 7450.403967682572, 8960.775980600538, 9377.671781487616, 9492.525373731285, 9678.661246856327, 349222.0, 355061.0, 365314.0, 365841.0, 365957.0, 75587.62206189043, 76635.23364766281, 83571.0, 84074.57962710147, 84557.0, 900.4192295969063, 927.2211342472356, 934.275936149476, 952.6903756279237, 953.6376177052675, 15054.473093441677, 15360.001599895972, 15502.457413990456, 15845.207739613204, 16281.0, 25700.8714956424, 33893.491597625565, 34561.30877382489, 36230.27539449144, 36689.08277293089, 50887.49112508827, 51766.74116629393, 53284.73357633187, 53341.733291333294, 54649.18026229689, 7464.552126872405, 7675.349799793072, 7755.457118001686, 7844.725434609762, 7856.45004849655, 9906.603735850485, 11987.580434684744, 12012.279263244232, 12111.576094836639, 12661.113722039738, 9749.976252493387, 9998.450085245382, 10170.491475426052, 10247.333923294962, 10865.728356790827, 9927.453990030617, 10003.249756268164, 10142.290039697446, 10173.338732982333, 10520.15838732915, 10329.690109296733, 10378.792424151323, 10404.739881503023, 10690.679279621623, 10828.133749300194, 7366.815829604303, 7443.0, 7503.9249607503225, 7632.465727399029, 7665.156832748282, 9021.32340074484, 9966.50167491637, 10700.839487407851, 10913.83629245546, 11312.490937907978], "value": 8029.929359995271, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1255.2029461292077, 1309.5315330601813, 1370.3764787021905, 1410.2807568140245, 1667.4580761252596, 6597.439217666498, 7669.884951725721, 7870.173631768667, 7877.80305492363, 8055.677772889092, 7888.684452621888, 7904.841903161933, 7985.680572777096, 7986.281234688891, 7998.600069996492, 2193.254293540196, 2219.1456289328644, 2221.0449506712107, 2221.378014156031, 2225.221172589597, 2130.084063852543, 2151.62346589347, 2196.5497073099978, 2197.7582465928735, 2200.4058904095887, 2164.5995490834166, 2176.086043861574, 2183.770704076073, 2186.0709198590616, 2204.6582779669175, 2141.2077531313435, 2147.0874878176714, 2147.5919575280723, 2148.516583768655, 2149.0651566568595, 2050.7231523744404, 2153.9784602153936, 2154.7522034965864, 2154.9892250538646, 2160.654295312758, 7803.102643196048, 8049.356051515923, 8088.272055515032, 8117.431779775359, 8125.512469251864, 4397.164538737629, 4562.064776720765, 4568.817247310104, 4605.815767369301, 4617.21507343749, 2902.782291328159, 3015.9246018849485, 3049.74077203438, 3059.5257735051105, 3060.785744997851, 925.9814803703955, 928.2249321816291, 940.6190492850407, 942.9952850235774, 947.6020071569957, 11022.063124634416, 11039.83440248397, 11063.225574209808, 11067.833982490269, 11150.330980141136, 4136.152088821785, 4156.0, 4180.28935081037, 4220.704550681423, 4259.637930775857, 8725.912740872636, 8729.432586881832, 8735.51954642488, 8741.0, 8751.343649226334, 4524.23088075028, 4526.6152377047665, 4527.954720452819, 4535.478419981679, 4535.818567257339, 3631.9092022699115, 3996.9200615987515, 4156.521999970042, 4173.561776013536, 4175.415441838145, 3473.6700013498676, 3476.7657481594174, 3568.393373126523, 3597.7661452005536, 3612.6567976042234, 1018.954147063384, 1020.3877673396051, 1028.665683652801, 1034.5965073621294, 1038.2368958815264, 775.7246177606982, 782.8042989252687, 841.0622156295686, 843.9282660973763, 845.5560830564003, 5043.344365232496, 5123.615728820353, 5138.3833939927445, 5179.326687530673, 5208.374995000624, 418.6964450773165, 422.2231094785609, 428.34890965731915, 431.2453206887946, 432.09476147470997, 3502.5972013218297, 3640.0, 3729.384651532521, 3750.1187221003042, 3771.867984620525, 9518.0, 9921.50392480373, 10005.749856253651, 10083.59665613382, 10097.141742951932, 9954.253430992705, 9971.202303815677, 10009.949950250202, 10022.298439109338, 10057.849132263022, 7421.517601355895, 7470.103587569418, 7480.326770590673, 7532.246775322534, 7571.432142589218, 5192.091384007708, 5222.138347172674, 5248.422673505987, 5265.157574788015, 5331.573474121983, 8834.204921557091, 8933.687320943736, 9181.678641247792, 9199.816003680024, 9224.215941645036, 9222.95388523053, 9308.674196403093, 9332.673356432493, 9410.388324759142, 9455.0, 5802.245708057925, 6219.253689557101, 6383.36166383358, 6440.967795161182, 6443.226812782496, 7616.3906887447765, 7950.7217247396065, 7964.402669799672, 7975.481593696391, 7978.800529986796, 6843.7604683835825, 6965.0, 7068.823279418056, 7110.075690160246, 7159.0, 6895.724171033303, 6969.686364113526, 6979.336962988508, 7007.614581198083, 7015.859682806417, 6041.607295525777, 6232.719527621359, 6245.8750824982335, 6278.497720182283, 6295.779647712308, 4529.954700452953, 4638.420197475316, 4674.719516829001, 4758.214894542361, 4786.736729479912, 4339.435873336446, 4515.593596576324, 4526.728396296233, 4616.561426664462, 4648.140094082605], "value": 4058.972426827504, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.88616439588566, 298.4910727210107, 305.27344919092565, 309.2516111011352, 310.0172453322966, 4896.951030489694, 4901.068796928581, 4910.582600478959, 4912.164931961566, 4928.901421971563, 4610.9308360374625, 4695.436547614283, 4751.619870410367, 4753.691010084342, 4872.512748725126, 3727.9440808387894, 3732.9440058399146, 3749.793761343125, 3792.6965842732516, 3819.178876541543, 3790.9620903790883, 3807.9048023799487, 3813.3898576227807, 3821.586013175129, 3830.8467661293516, 3556.5020897074432, 3716.479692843004, 3789.5073640426845, 3799.5820459749407, 3815.122521819983, 3736.1220113273494, 3738.056210770384, 3739.420389839566, 3742.5404092403983, 3747.7938713370754, 3279.426100432415, 3284.967150328514, 3288.621808492006, 3295.752818538619, 3298.455754800455, 4665.230237010889, 4670.7664616769025, 4683.8360657376825, 4686.0, 4694.201985662446, 4125.793710314472, 4250.766207858566, 4266.786660666954, 4267.141015519609, 4286.592773686495, 5027.673201241908, 5040.7731652075745, 5051.747412629354, 5052.494750524918, 5056.191009438472, 3582.6923173041914, 3587.157018100744, 3589.138606734391, 3590.6588874057184, 3593.2094939113354, 5034.51481812866, 5230.476952304815, 5266.8683282917855, 5285.973570132125, 5295.735213239323, 3622.7826330420257, 3649.635036496329, 3652.3060618482405, 3658.9634103659155, 3685.5208822852856, 3721.1813401051727, 3723.5345581802276, 3741.326561218952, 3750.3873334466443, 3758.3235017697075, 4295.613394794421, 4295.6778241632, 4296.183725092285, 4297.892552686145, 4299.710086973895, 4816.518348165226, 5022.824201152942, 5052.696838189647, 5059.949400506021, 5139.743012849342, 1279.8272233248579, 1291.2897906151768, 1292.3538230884558, 1298.6169080121388, 1299.0971274964, 820.7865954851662, 860.9182127697859, 883.5008220355479, 891.2468963725642, 895.8611415230649, 4452.9109417812115, 4455.042165934275, 4466.486354069259, 4471.821127154943, 4472.530384309601, 5166.070107380632, 5173.198154286091, 5196.168613021899, 5198.662086964335, 5255.424841827554, 4326.480822301344, 4384.583464570861, 4403.14138742942, 4483.3947417098925, 4494.460664720189, 2729.3995321029342, 2729.5769155780886, 2738.4523095381005, 2740.6985231624503, 2755.3938133610573, 4883.731394773322, 4902.142125128088, 4902.877428064256, 4905.264210368402, 4925.729084900293, 5077.416097148801, 5255.868603284872, 5284.022455845681, 5334.226537152092, 5386.569074474032, 4970.2296144097, 4973.50264973507, 4976.751162441863, 4984.601231901512, 4993.825216117419, 5264.947350526446, 5269.89460210786, 5282.86044152119, 5309.36287645485, 5327.360716714019, 4899.461059283547, 5110.466859941928, 5153.0, 5158.561522270649, 5185.262936916175, 4973.626977976739, 4975.164156430799, 4978.950210497848, 4982.800687972441, 4983.134697548851, 3712.294664013829, 3725.403935370328, 3735.1782607826235, 3737.5328083989502, 3738.158914244273, 5124.719499822692, 5191.117510023229, 5230.869228269324, 5232.4505926878655, 5297.073012222922, 5045.915128247444, 5085.898282034264, 5086.54221120101, 5093.388793344822, 5094.847154585368, 5058.140116180185, 5069.087564238473, 5078.695278283315, 5091.490850914879, 5093.694378337312, 4856.223004319292, 4920.434150072788, 4973.477784832685, 4981.775820088177, 5004.84985450437, 4874.561289483963, 4925.630577706758, 5095.0, 5116.539511443988, 5123.257127716534, 4957.702537847741, 4966.279889416087, 4966.627502937366, 4980.551750342486, 5004.324416203912], "value": 3816.901923083058, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.6726335042428, 684.2336583027011, 707.4941416886928, 732.582428016031, 738.7968308715099, 12235.938820305897, 13346.332683365828, 13355.998300127492, 13377.59867203983, 13423.127496712706, 13786.724265514684, 14504.709905801878, 14533.128012319268, 14832.0, 14950.0, 767.4282659418741, 786.5713186313444, 788.917163697812, 789.1634867040955, 789.3014682006408, 627.8210709947666, 754.0611938137027, 784.525362155896, 793.0443815202696, 795.0380040151424, 817.0562999735286, 819.7704642700054, 824.4929368438427, 824.9133840946704, 824.9752507424787, 815.5473712089788, 816.742726041301, 816.8856360109589, 816.9632366543519, 817.8159914019358, 485.1606720373738, 493.5237495816554, 494.3474613510168, 595.9195508606326, 596.4542443664042, 10387.065164135189, 11641.825372619418, 11915.642530724092, 12068.0345572354, 12338.012958963262, 12086.516539338416, 12748.0, 12859.935700321439, 12958.740825183444, 13439.798403023962, 10469.895301046969, 10500.2649814513, 10620.628278010232, 10685.198610104273, 10714.517846696917, 3294.3740689269202, 3303.6035675719068, 3313.966860331414, 3388.457846744509, 3496.9300613987834, 67100.0, 68709.65645171743, 68845.31154688439, 69184.6540767298, 69337.95993060159, 10311.948440257751, 10501.579936802595, 10508.054275115277, 10627.0, 10678.092362149304, 18869.622607548048, 19206.231750730094, 19333.226670933003, 19546.218151273788, 19571.11929963155, 6551.886179349522, 6671.099401580725, 6746.595204287759, 6891.310868913169, 7275.563466192046, 3575.4994300797907, 3683.1160521474653, 3735.9813200933822, 3740.85036598533, 3749.0, 2860.084772872661, 2978.195887110468, 2980.508216144312, 2983.7463815575484, 2990.386970671007, 507.17330750875834, 521.0932976620653, 522.8875791704802, 524.4676653197008, 532.1804421191322, 497.6715367857197, 529.2986792499953, 566.8752874367633, 579.2411940358145, 581.1079992211935, 7680.692772289158, 7890.566018868903, 7971.255110890844, 8021.919780802234, 8185.713500027589, 485.3665965914445, 560.0954458549495, 568.3577557360156, 619.801663467695, 624.4224092714221, 3618.475321078429, 3782.508273924372, 3839.6928245740273, 4135.6898232632675, 4161.459010328638, 102870.48564757129, 105968.47015764871, 107374.46312768386, 110120.0, 110124.4493777542, 89204.0, 91327.54336228277, 91940.54029729808, 92813.0, 93657.53171234236, 79413.20586794174, 79581.05236845394, 79957.20042799498, 80004.0, 80141.59929200317, 7547.433942454228, 7665.156832748505, 7785.238923196906, 8002.5598592077995, 8099.676012959416, 34319.4852077214, 46384.95493378759, 47308.2903756437, 47724.522754772006, 49547.00905981788, 37799.05502362463, 45953.540464594924, 65292.67353663201, 65536.67231664002, 68123.65938170278, 9596.66411675588, 9787.559559819967, 9831.115199632068, 9891.406515609087, 10321.432321222404, 11210.383428911162, 11260.324380537195, 11356.54573817038, 11471.598494052669, 11596.130290228435, 11003.724906877393, 11279.379634120201, 11597.420128993685, 11640.243384180001, 11977.161598688008, 10392.480375981322, 11169.162312826733, 11390.772184556428, 11594.536218551164, 11641.133932306684, 10268.691939241835, 10369.896301036893, 10573.8942610576, 11946.401081086418, 12045.518179273082, 9602.231821454407, 9732.221422286058, 9821.214302855611, 10078.193744500275, 10334.79257037025, 8269.917032067484, 8538.829223415372, 8584.613692383733, 8980.640774368952, 9673.322867399214], "value": 6491.973016657873, "unit": "score"}], "name": "dromaeo_css", "value": 6338.331864527142, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 115.0, 115.0, 111.0, 116.0, 114.0, 115.0, 115.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 120.0, 128.0, 177.0, 123.0, 124.0, 152.0, 130.0, 161.0, 122.0], "value": 138.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 161.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 76.0, 113.0, 77.0, 77.0, 77.0, 75.0, 102.0, 80.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 125.0, 86.0, 86.0, 86.0, 125.0, 86.0, 87.0, 131.0], "value": 98.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 149.0, 148.0, 149.0, 146.0, 148.0, 146.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 67.0, 66.0, 67.0, 69.0, 66.0, 66.0, 68.0, 65.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 88.0, 81.0, 81.0, 81.0, 82.0, 81.0, 84.0, 81.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 142.0, 148.0, 141.0, 132.0, 133.0, 130.0, 135.0, 163.0, 132.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 175.0, 175.0, 175.0, 175.0, 172.0, 172.0, 176.0, 176.0, 171.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 67.0, 67.0, 67.0, 68.0, 69.0, 66.0, 70.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1549.8999999999999, "alertThreshold": 2.0}]} 10:56:08 INFO - Return code: 0 10:56:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:56:08 INFO - # TBPL SUCCESS # 10:56:08 INFO - Running post-action listener: _resource_record_post_action 10:56:08 INFO - [mozharness: 2016-08-16 17:56:08.944909Z] Finished run-tests step (success) 10:56:08 INFO - Running post-run listener: _resource_record_post_run 10:56:09 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 402776064; Read time: 0; Write time: 356704 10:56:09 INFO - TinderboxPrint: CPU usage
13.0% 10:56:09 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:56:09 INFO - TinderboxPrint: I/O write bytes / time
402,776,064 / 356,704 10:56:09 INFO - TinderboxPrint: CPU idle
8,335.2 (87.0%) 10:56:09 INFO - TinderboxPrint: CPU user
1,197.0 (12.5%) 10:56:09 INFO - TinderboxPrint: Swap in / out
0 / 0 10:56:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 120881152; Read time: 0; Write time: 123244 10:56:09 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 281358336; Read time: 0; Write time: 233076 10:56:09 INFO - Running post-run listener: _upload_blobber_files 10:56:09 INFO - Blob upload gear active. 10:56:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:56:09 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 10:56:09 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:56:09 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:56:09 INFO - (blobuploader) - INFO - Open directory for files ... 10:56:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:56:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:56:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:56:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:56:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:56:15 INFO - (blobuploader) - INFO - Done attempting. 10:56:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:56:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:56:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:56:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:56:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:56:16 INFO - (blobuploader) - INFO - Done attempting. 10:56:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:56:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:56:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:56:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:56:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:56:16 INFO - (blobuploader) - INFO - Done attempting. 10:56:16 INFO - (blobuploader) - INFO - Iteration through files over. 10:56:16 INFO - Return code: 0 10:56:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:56:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:56:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84637d83207452b60c4edafea3a3c6461d9c0108e42186a7d1c9849f27b518a88302faadcd6cc592f363f1661cc78f9e6882d0693a097be551b732a8712823fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8ca0c6c8fc5882887829a20a376037e81eb133d233c112958320ce7f31244c18cd1d9409ec5b898ad3cb6587e269b8fb1c149e1f1e53be5f3c24ca1a1c5fdba7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12dac7229128386da602e07c029d7e46c9c70da00652488126c070f3aae5210ba5c2fd1f928a891ff232eda0e831b049fdf6e99e52f28d366b52d8cbdc24dc05"} 10:56:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:56:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:56:16 INFO - Contents: 10:56:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84637d83207452b60c4edafea3a3c6461d9c0108e42186a7d1c9849f27b518a88302faadcd6cc592f363f1661cc78f9e6882d0693a097be551b732a8712823fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8ca0c6c8fc5882887829a20a376037e81eb133d233c112958320ce7f31244c18cd1d9409ec5b898ad3cb6587e269b8fb1c149e1f1e53be5f3c24ca1a1c5fdba7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12dac7229128386da602e07c029d7e46c9c70da00652488126c070f3aae5210ba5c2fd1f928a891ff232eda0e831b049fdf6e99e52f28d366b52d8cbdc24dc05"} 10:56:16 INFO - Running post-run listener: copy_logs_to_upload_dir 10:56:16 INFO - Copying logs to upload dir... 10:56:16 INFO - mkdir: /builds/slave/test/build/upload/logs 10:56:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.154190 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-16 10:56:16.985639) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 10:56:16.988835) ========= 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=fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84637d83207452b60c4edafea3a3c6461d9c0108e42186a7d1c9849f27b518a88302faadcd6cc592f363f1661cc78f9e6882d0693a097be551b732a8712823fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8ca0c6c8fc5882887829a20a376037e81eb133d233c112958320ce7f31244c18cd1d9409ec5b898ad3cb6587e269b8fb1c149e1f1e53be5f3c24ca1a1c5fdba7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12dac7229128386da602e07c029d7e46c9c70da00652488126c070f3aae5210ba5c2fd1f928a891ff232eda0e831b049fdf6e99e52f28d366b52d8cbdc24dc05"} build_url:https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/Ivjj_owuQmOMdnlH_-X4vg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/84637d83207452b60c4edafea3a3c6461d9c0108e42186a7d1c9849f27b518a88302faadcd6cc592f363f1661cc78f9e6882d0693a097be551b732a8712823fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8ca0c6c8fc5882887829a20a376037e81eb133d233c112958320ce7f31244c18cd1d9409ec5b898ad3cb6587e269b8fb1c149e1f1e53be5f3c24ca1a1c5fdba7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/12dac7229128386da602e07c029d7e46c9c70da00652488126c070f3aae5210ba5c2fd1f928a891ff232eda0e831b049fdf6e99e52f28d366b52d8cbdc24dc05"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 10:56:17.017013) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 10:56:17.017578) ========= 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=fa44defc139c4ba8574fe040000001db-1471368929.365389-1208209087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 10:56:17.101415) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 10:56:17.101731) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 10:56:17.102033) ========= ========= Total master_lag: 0.16 =========