builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1472582368.83 results: success (0) buildid: 20160830083013 builduid: dc145c91d0a240ffa8fe62803315f36c revision: b18c8bcdc116eef8799880b7c50317bf54218474 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 11:39:28.834953) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 11:39:28.835622) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 11:39:28.836031) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 11:39:28.850460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 11:39:28.850753) ========= 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=923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-30 11:39:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-08-30 11:39:30 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144431 ========= master_lag: 0.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 11:39:29.292551) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 11:39:29.295909) ========= 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=923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016660 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 11:39:29.350145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 11:39:29.350477) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b18c8bcdc116eef8799880b7c50317bf54218474 --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 b18c8bcdc116eef8799880b7c50317bf54218474 --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=923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-30 11:39:30,261 truncating revision to first 12 chars 2016-08-30 11:39:30,261 Setting DEBUG logging. 2016-08-30 11:39:30,261 attempt 1/10 2016-08-30 11:39:30,261 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b18c8bcdc116?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 11:39:30,760 unpacking tar archive at: fx-team-b18c8bcdc116/testing/mozharness/ program finished with exit code 0 elapsedTime=0.778007 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 11:39:30.144118) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 11:39:30.144427) ========= script_repo_revision: b18c8bcdc116eef8799880b7c50317bf54218474 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 11:39:30.144830) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 11:39:30.145104) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 11:39:30.154083) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-30 11:39:30.154355) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:39:31 INFO - MultiFileLogger online at 20160830 11:39:31 in /builds/slave/test 11:39:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:39:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:39:31 INFO - {'append_to_log': False, 11:39:31 INFO - 'base_work_dir': '/builds/slave/test', 11:39:31 INFO - 'blob_upload_branch': 'Fx-Team', 11:39:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:39:31 INFO - 'branch': 'Fx-Team', 11:39:31 INFO - 'buildbot_json_path': 'buildprops.json', 11:39:31 INFO - 'config_files': ('talos/linux_config.py',), 11:39:31 INFO - 'default_actions': ('clobber', 11:39:31 INFO - 'read-buildbot-config', 11:39:31 INFO - 'download-and-extract', 11:39:31 INFO - 'populate-webroot', 11:39:31 INFO - 'create-virtualenv', 11:39:31 INFO - 'install', 11:39:31 INFO - 'run-tests'), 11:39:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:39:31 INFO - 'download_minidump_stackwalk': True, 11:39:31 INFO - 'download_symbols': 'ondemand', 11:39:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:39:31 INFO - 'tooltool.py': '/tools/tooltool.py', 11:39:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:39:31 INFO - '/tools/misc-python/virtualenv.py')}, 11:39:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:39:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:39:31 INFO - 'installer_path': 'installer.exe', 11:39:31 INFO - 'log_level': 'info', 11:39:31 INFO - 'log_name': 'talos', 11:39:31 INFO - 'log_to_console': True, 11:39:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:39:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:39:31 INFO - 'opt_config_files': (), 11:39:31 INFO - 'pip_index': False, 11:39:31 INFO - 'sps_profile': False, 11:39:31 INFO - 'sps_profile_interval': 0, 11:39:31 INFO - 'suite': 'dromaeojs', 11:39:31 INFO - 'system_bits': '32', 11:39:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:39:31 INFO - 'title': 'talos-linux64-ix-007', 11:39:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:39:31 INFO - 'use_talos_json': True, 11:39:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:39:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:39:31 INFO - 'work_dir': 'build'} 11:39:31 INFO - [mozharness: 2016-08-30 18:39:31.161881Z] Running clobber step. 11:39:31 INFO - Running pre-action listener: _resource_record_pre_action 11:39:31 INFO - Running main action method: clobber 11:39:31 INFO - rmtree: /builds/slave/test/build 11:39:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:39:32 INFO - Running post-action listener: _resource_record_post_action 11:39:32 INFO - [mozharness: 2016-08-30 18:39:32.145475Z] Finished clobber step (success) 11:39:32 INFO - [mozharness: 2016-08-30 18:39:32.145575Z] Running read-buildbot-config step. 11:39:32 INFO - Running pre-action listener: _resource_record_pre_action 11:39:32 INFO - Running main action method: read_buildbot_config 11:39:32 INFO - Using buildbot properties: 11:39:32 INFO - { 11:39:32 INFO - "project": "", 11:39:32 INFO - "product": "firefox", 11:39:32 INFO - "script_repo_revision": "production", 11:39:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:39:32 INFO - "repository": "", 11:39:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:39:32 INFO - "buildid": "20160830083013", 11:39:32 INFO - "pgo_build": "True", 11:39:32 INFO - "basedir": "/builds/slave/test", 11:39:32 INFO - "buildnumber": 1506, 11:39:32 INFO - "slavename": "talos-linux64-ix-007", 11:39:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:39:32 INFO - "platform": "ubuntu64_hw", 11:39:32 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:39:32 INFO - "branch": "fx-team", 11:39:32 INFO - "repo_path": "integration/fx-team", 11:39:32 INFO - "revision": "b18c8bcdc116eef8799880b7c50317bf54218474", 11:39:32 INFO - "stage_platform": "linux64-pgo", 11:39:32 INFO - "builduid": "dc145c91d0a240ffa8fe62803315f36c", 11:39:32 INFO - "slavebuilddir": "test" 11:39:32 INFO - } 11:39:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:39:32 INFO - Running post-action listener: _resource_record_post_action 11:39:32 INFO - [mozharness: 2016-08-30 18:39:32.148003Z] Finished read-buildbot-config step (success) 11:39:32 INFO - [mozharness: 2016-08-30 18:39:32.148094Z] Running download-and-extract step. 11:39:32 INFO - Running pre-action listener: _resource_record_pre_action 11:39:32 INFO - Running main action method: download_and_extract 11:39:32 INFO - mkdir: /builds/slave/test/build/tests 11:39: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')]} 11:39:32 INFO - trying https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:39:32 INFO - Downloading https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/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 11:39:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/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 11:39:32 INFO - Downloaded 1361 bytes. 11:39:32 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:39:32 INFO - Using the following test package requirements: 11:39:32 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:39:32 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:39:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:39:32 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:39:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:39:32 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:39:32 INFO - u'jsshell-linux-x86_64.zip'], 11:39:32 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:39:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:39:32 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:39:32 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:39:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:39:32 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:39:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:39:32 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:39:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:39:32 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:39:32 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:39:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:39: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')]} 11:39:32 INFO - trying https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:39:32 INFO - Downloading https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/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 11:39:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/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 11:39:33 INFO - Downloaded 21886963 bytes. 11:39: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 11:39:37 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 11:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:37 INFO - trying https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:39:37 INFO - Downloading https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/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 11:39:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/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 11:39:38 INFO - Downloaded 21886963 bytes. 11:39: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 11:39: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')]} 11:39:43 INFO - trying https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:39:43 INFO - Downloading https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/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 11:39:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/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 11:39:44 INFO - Downloaded 14413998 bytes. 11:39: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 11:39: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')]} 11:39:44 INFO - trying https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:39:44 INFO - Downloading https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/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 11:39:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/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 11:39:45 INFO - Downloaded 59736493 bytes. 11:39:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:39:45 INFO - mkdir: /builds/slave/test/properties 11:39:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:39:45 INFO - Writing to file /builds/slave/test/properties/build_url 11:39:45 INFO - Contents: 11:39:45 INFO - build_url:https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:39:46 INFO - Running post-action listener: _resource_record_post_action 11:39:46 INFO - Running post-action listener: set_extra_try_arguments 11:39:46 INFO - [mozharness: 2016-08-30 18:39:46.306401Z] Finished download-and-extract step (success) 11:39:46 INFO - [mozharness: 2016-08-30 18:39:46.306628Z] Running populate-webroot step. 11:39:46 INFO - Running pre-action listener: _resource_record_pre_action 11:39:46 INFO - Running main action method: populate_webroot 11:39:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:39:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:39:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:39:46 INFO - '--tppagecycles', 11:39:46 INFO - '7'], 11:39:46 INFO - 'tests': ['tsvgm']}}, 11:39:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:39:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:39:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:39:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:39:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:39:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:39:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:46 INFO - 'talos_options': ['--disable-e10s'], 11:39:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:39:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:39:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:46 INFO - 'talos_options': ['--disable-e10s'], 11:39:46 INFO - 'tests': ['damp', 'tps']}, 11:39:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:46 INFO - 'tests': ['damp', 'tps']}, 11:39:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:39:46 INFO - 'tests': ['dromaeo_dom']}, 11:39:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:39:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:39:46 INFO - 'tests': ['basic_compositor_video']}, 11:39:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:39:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:39:46 INFO - 'tests': ['a11yr', 11:39:46 INFO - 'ts_paint', 11:39:46 INFO - 'tpaint', 11:39:46 INFO - 'sessionrestore', 11:39:46 INFO - 'sessionrestore_no_auto_restore', 11:39:46 INFO - 'tabpaint']}, 11:39:46 INFO - 'other-e10s': {'tests': ['a11yr', 11:39:46 INFO - 'ts_paint', 11:39:46 INFO - 'tpaint', 11:39:46 INFO - 'sessionrestore', 11:39:46 INFO - 'sessionrestore_no_auto_restore', 11:39:46 INFO - 'tabpaint']}, 11:39:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:39:46 INFO - 'ts_paint', 11:39:46 INFO - 'tpaint', 11:39:46 INFO - 'sessionrestore', 11:39:46 INFO - 'sessionrestore_no_auto_restore', 11:39:46 INFO - 'tabpaint']}, 11:39:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:39:46 INFO - 'ts_paint', 11:39:46 INFO - 'tpaint', 11:39:46 INFO - 'sessionrestore', 11:39:46 INFO - 'sessionrestore_no_auto_restore', 11:39:46 INFO - 'tabpaint']}, 11:39:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:39:46 INFO - 'tests': ['a11yr', 11:39:46 INFO - 'ts_paint', 11:39:46 INFO - 'tpaint', 11:39:46 INFO - 'sessionrestore', 11:39:46 INFO - 'sessionrestore_no_auto_restore', 11:39:46 INFO - 'tabpaint']}, 11:39:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:39:46 INFO - 'tests': ['a11yr', 11:39:46 INFO - 'ts_paint', 11:39:46 INFO - 'tpaint', 11:39:46 INFO - 'sessionrestore', 11:39:46 INFO - 'sessionrestore_no_auto_restore', 11:39:46 INFO - 'tabpaint']}, 11:39:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:39:46 INFO - 'tests': ['tsvgx', 11:39:46 INFO - 'tsvgr_opacity', 11:39:46 INFO - 'tart', 11:39:46 INFO - 'tscrollx', 11:39:46 INFO - 'cart']}, 11:39:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:39:46 INFO - 'tsvgr_opacity', 11:39:46 INFO - 'tart', 11:39:46 INFO - 'tscrollx', 11:39:46 INFO - 'cart']}, 11:39:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:46 INFO - 'talos_options': ['--disable-e10s'], 11:39:46 INFO - 'tests': ['tp5o']}, 11:39:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:46 INFO - 'tests': ['tp5o']}, 11:39:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:46 INFO - 'talos_options': ['--disable-e10s', 11:39:46 INFO - '--xperf_path', 11:39:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:39:46 INFO - 'tests': ['tp5n']}, 11:39:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:46 INFO - 'talos_options': ['--xperf_path', 11:39:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:39:46 INFO - 'tests': ['tp5n']}}, 11:39:46 INFO - 'talos.zip': {'path': '', 11:39:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:39:46 INFO - Running post-action listener: _resource_record_post_action 11:39:46 INFO - [mozharness: 2016-08-30 18:39:46.326767Z] Finished populate-webroot step (success) 11:39:46 INFO - [mozharness: 2016-08-30 18:39:46.326857Z] Running create-virtualenv step. 11:39:46 INFO - Running pre-action listener: _resource_record_pre_action 11:39:46 INFO - Running main action method: create_virtualenv 11:39:46 INFO - Creating virtualenv /builds/slave/test/build/venv 11:39: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 11:39:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:39:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:39:46 INFO - Using real prefix '/usr' 11:39:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:39:46 INFO - Installing distribute.............................................................................................................................................................................................done. 11:39:48 INFO - Installing pip.................done. 11:39:48 INFO - Return code: 0 11:39:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9aa90df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c1370>, '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 0x14c48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c4d80>, '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': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', '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 11:39:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:39:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:39:48 INFO - Using env: {'DISPLAY': ':0', 11:39:48 INFO - 'HOME': '/home/cltbld', 11:39:48 INFO - 'LANG': 'en_US.UTF-8', 11:39:48 INFO - 'LANGUAGE': 'en_US:en', 11:39:48 INFO - 'LOGNAME': 'cltbld', 11:39:48 INFO - 'MAIL': '/var/mail/cltbld', 11:39:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:48 INFO - 'MOZ_NO_REMOTE': '1', 11:39:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:48 INFO - 'NO_EM_RESTART': '1', 11:39:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:48 INFO - 'PWD': '/builds/slave/test', 11:39:48 INFO - 'SHELL': '/bin/bash', 11:39:48 INFO - 'SHLVL': '1', 11:39:48 INFO - 'TERM': 'linux', 11:39:48 INFO - 'TMOUT': '86400', 11:39:48 INFO - 'USER': 'cltbld', 11:39:48 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', 11:39:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:48 INFO - '_': '/tools/buildbot/bin/python'} 11:39:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39: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 11:39:49 INFO - Cleaning up... 11:39:49 INFO - Return code: 0 11:39:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:39: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')]} 11:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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')]} 11:39:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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 0x7fc9aa90df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c1370>, '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 0x14c48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c4d80>, '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': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', '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 11:39: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 11:39: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 11:39:49 INFO - Using env: {'DISPLAY': ':0', 11:39:49 INFO - 'HOME': '/home/cltbld', 11:39:49 INFO - 'LANG': 'en_US.UTF-8', 11:39:49 INFO - 'LANGUAGE': 'en_US:en', 11:39:49 INFO - 'LOGNAME': 'cltbld', 11:39:49 INFO - 'MAIL': '/var/mail/cltbld', 11:39:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:49 INFO - 'MOZ_NO_REMOTE': '1', 11:39:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:49 INFO - 'NO_EM_RESTART': '1', 11:39:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:49 INFO - 'PWD': '/builds/slave/test', 11:39:49 INFO - 'SHELL': '/bin/bash', 11:39:49 INFO - 'SHLVL': '1', 11:39:49 INFO - 'TERM': 'linux', 11:39:49 INFO - 'TMOUT': '86400', 11:39:49 INFO - 'USER': 'cltbld', 11:39:49 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', 11:39:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:49 INFO - '_': '/tools/buildbot/bin/python'} 11:39:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:49 INFO - Downloading/unpacking psutil>=3.1.1 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:39:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:39:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:39:51 INFO - Installing collected packages: psutil 11:39:51 INFO - Running setup.py install for psutil 11:39:51 INFO - building 'psutil._psutil_linux' extension 11:39: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 11:39: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 11:39:51 INFO - building 'psutil._psutil_posix' extension 11:39: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 11:39: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 11:39:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:39:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:39:51 INFO - Successfully installed psutil 11:39:51 INFO - Cleaning up... 11:39:51 INFO - Return code: 0 11:39:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:39:51 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')]} 11:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:51 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')]} 11:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:51 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 0x7fc9aa90df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c1370>, '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 0x14c48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c4d80>, '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': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', '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 11:39:51 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 11:39:51 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 11:39:51 INFO - Using env: {'DISPLAY': ':0', 11:39:51 INFO - 'HOME': '/home/cltbld', 11:39:51 INFO - 'LANG': 'en_US.UTF-8', 11:39:51 INFO - 'LANGUAGE': 'en_US:en', 11:39:51 INFO - 'LOGNAME': 'cltbld', 11:39:51 INFO - 'MAIL': '/var/mail/cltbld', 11:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:51 INFO - 'MOZ_NO_REMOTE': '1', 11:39:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:51 INFO - 'NO_EM_RESTART': '1', 11:39:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:51 INFO - 'PWD': '/builds/slave/test', 11:39:51 INFO - 'SHELL': '/bin/bash', 11:39:51 INFO - 'SHLVL': '1', 11:39:51 INFO - 'TERM': 'linux', 11:39:51 INFO - 'TMOUT': '86400', 11:39:51 INFO - 'USER': 'cltbld', 11:39:51 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', 11:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:51 INFO - '_': '/tools/buildbot/bin/python'} 11:39:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:39:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:39:54 INFO - Installing collected packages: mozsystemmonitor 11:39:54 INFO - Running setup.py install for mozsystemmonitor 11:39:54 INFO - Successfully installed mozsystemmonitor 11:39:54 INFO - Cleaning up... 11:39:54 INFO - Return code: 0 11:39:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:39: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')]} 11:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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')]} 11:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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 0x7fc9aa90df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c1370>, '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 0x14c48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c4d80>, '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': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', '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 11:39: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 11:39: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 11:39:54 INFO - Using env: {'DISPLAY': ':0', 11:39:54 INFO - 'HOME': '/home/cltbld', 11:39:54 INFO - 'LANG': 'en_US.UTF-8', 11:39:54 INFO - 'LANGUAGE': 'en_US:en', 11:39:54 INFO - 'LOGNAME': 'cltbld', 11:39:54 INFO - 'MAIL': '/var/mail/cltbld', 11:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:54 INFO - 'MOZ_NO_REMOTE': '1', 11:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:54 INFO - 'NO_EM_RESTART': '1', 11:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:54 INFO - 'PWD': '/builds/slave/test', 11:39:54 INFO - 'SHELL': '/bin/bash', 11:39:54 INFO - 'SHLVL': '1', 11:39:54 INFO - 'TERM': 'linux', 11:39:54 INFO - 'TMOUT': '86400', 11:39:54 INFO - 'USER': 'cltbld', 11:39:54 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', 11:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:54 INFO - '_': '/tools/buildbot/bin/python'} 11:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:54 INFO - Downloading/unpacking jsonschema==2.5.1 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:39:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39:56 INFO - Downloading functools32-3.2.3-2.tar.gz 11:39:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:39:56 INFO - warning: no files found matching '*.txt' 11:39:56 INFO - no previously-included directories found matching 'build' 11:39:56 INFO - no previously-included directories found matching 'dist' 11:39:56 INFO - no previously-included directories found matching '.git*' 11:39:56 INFO - Installing collected packages: jsonschema, functools32 11:39:56 INFO - Running setup.py install for functools32 11:39:56 INFO - warning: no files found matching '*.txt' 11:39:56 INFO - no previously-included directories found matching 'build' 11:39:56 INFO - no previously-included directories found matching 'dist' 11:39:56 INFO - no previously-included directories found matching '.git*' 11:39:56 INFO - Successfully installed jsonschema functools32 11:39:56 INFO - Cleaning up... 11:39:56 INFO - Return code: 0 11:39:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:39: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')]} 11:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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')]} 11:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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 0x7fc9aa90df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c1370>, '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 0x14c48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c4d80>, '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': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', '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 11:39: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 11:39: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 11:39:56 INFO - Using env: {'DISPLAY': ':0', 11:39:56 INFO - 'HOME': '/home/cltbld', 11:39:56 INFO - 'LANG': 'en_US.UTF-8', 11:39:56 INFO - 'LANGUAGE': 'en_US:en', 11:39:56 INFO - 'LOGNAME': 'cltbld', 11:39:56 INFO - 'MAIL': '/var/mail/cltbld', 11:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:56 INFO - 'MOZ_NO_REMOTE': '1', 11:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:56 INFO - 'NO_EM_RESTART': '1', 11:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:56 INFO - 'PWD': '/builds/slave/test', 11:39:56 INFO - 'SHELL': '/bin/bash', 11:39:56 INFO - 'SHLVL': '1', 11:39:56 INFO - 'TERM': 'linux', 11:39:56 INFO - 'TMOUT': '86400', 11:39:56 INFO - 'USER': 'cltbld', 11:39:56 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', 11:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:56 INFO - '_': '/tools/buildbot/bin/python'} 11:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:39:56 INFO - Cleaning up... 11:39:57 INFO - Return code: 0 11:39:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:39: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')]} 11:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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')]} 11:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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 0x7fc9aa90df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c1370>, '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 0x14c48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c4d80>, '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': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', '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 11:39: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 11:39: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 11:39:57 INFO - Using env: {'DISPLAY': ':0', 11:39:57 INFO - 'HOME': '/home/cltbld', 11:39:57 INFO - 'LANG': 'en_US.UTF-8', 11:39:57 INFO - 'LANGUAGE': 'en_US:en', 11:39:57 INFO - 'LOGNAME': 'cltbld', 11:39:57 INFO - 'MAIL': '/var/mail/cltbld', 11:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:57 INFO - 'MOZ_NO_REMOTE': '1', 11:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:39:57 INFO - 'NO_EM_RESTART': '1', 11:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:57 INFO - 'PWD': '/builds/slave/test', 11:39:57 INFO - 'SHELL': '/bin/bash', 11:39:57 INFO - 'SHLVL': '1', 11:39:57 INFO - 'TERM': 'linux', 11:39:57 INFO - 'TMOUT': '86400', 11:39:57 INFO - 'USER': 'cltbld', 11:39:57 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', 11:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:57 INFO - '_': '/tools/buildbot/bin/python'} 11:39:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:57 INFO - Downloading/unpacking blobuploader==1.2.4 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39:59 INFO - Downloading blobuploader-1.2.4.tar.gz 11:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:39:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:39:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39:59 INFO - Downloading docopt-0.6.1.tar.gz 11:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:39:59 INFO - Installing collected packages: blobuploader, requests, docopt 11:39:59 INFO - Running setup.py install for blobuploader 11:39:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:39:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:39:59 INFO - Running setup.py install for requests 11:40:00 INFO - Running setup.py install for docopt 11:40:00 INFO - Successfully installed blobuploader requests docopt 11:40:00 INFO - Cleaning up... 11:40:00 INFO - Return code: 0 11:40:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40: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')]} 11:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40: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')]} 11:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40: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 0x7fc9aa90df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c1370>, '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 0x14c48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c4d80>, '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': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', '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 11:40: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 11:40: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 11:40:00 INFO - Using env: {'DISPLAY': ':0', 11:40:00 INFO - 'HOME': '/home/cltbld', 11:40:00 INFO - 'LANG': 'en_US.UTF-8', 11:40:00 INFO - 'LANGUAGE': 'en_US:en', 11:40:00 INFO - 'LOGNAME': 'cltbld', 11:40:00 INFO - 'MAIL': '/var/mail/cltbld', 11:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:00 INFO - 'MOZ_NO_REMOTE': '1', 11:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:00 INFO - 'NO_EM_RESTART': '1', 11:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:00 INFO - 'PWD': '/builds/slave/test', 11:40:00 INFO - 'SHELL': '/bin/bash', 11:40:00 INFO - 'SHLVL': '1', 11:40:00 INFO - 'TERM': 'linux', 11:40:00 INFO - 'TMOUT': '86400', 11:40:00 INFO - 'USER': 'cltbld', 11:40:00 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', 11:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:00 INFO - '_': '/tools/buildbot/bin/python'} 11:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:40:00 INFO - Running setup.py (path:/tmp/pip-Ow7ggs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:40:00 INFO - Running setup.py (path:/tmp/pip-Erzk3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:40:00 INFO - Running setup.py (path:/tmp/pip-LXRwDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:40:00 INFO - Running setup.py (path:/tmp/pip-s2X_mt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:40:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:40:00 INFO - Running setup.py (path:/tmp/pip-aQQFo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:40:01 INFO - Running setup.py (path:/tmp/pip-m4OvG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:40:01 INFO - Running setup.py (path:/tmp/pip-Y9x4Pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:40:01 INFO - Running setup.py (path:/tmp/pip-qzFsZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:40:01 INFO - Running setup.py (path:/tmp/pip-xZRFSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:40:01 INFO - Running setup.py (path:/tmp/pip-5fLQHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:40:01 INFO - Running setup.py (path:/tmp/pip-HlLiJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:40:01 INFO - Running setup.py (path:/tmp/pip-HpRp6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:40:01 INFO - Running setup.py (path:/tmp/pip-ArJB3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:40:01 INFO - Running setup.py (path:/tmp/pip-HrDIj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:01 INFO - Running setup.py (path:/tmp/pip-IJ4BiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:40:01 INFO - Running setup.py (path:/tmp/pip-teVYrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:40:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:40:01 INFO - Running setup.py (path:/tmp/pip-ukEw5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:40:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:40:01 INFO - Running setup.py install for manifestparser 11:40:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:40:01 INFO - Running setup.py install for mozcrash 11:40:02 INFO - Running setup.py install for mozdebug 11:40:02 INFO - Running setup.py install for mozdevice 11:40:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:40:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:40:02 INFO - Running setup.py install for mozfile 11:40:02 INFO - Running setup.py install for mozhttpd 11:40:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:40:02 INFO - Running setup.py install for mozinfo 11:40:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:40:02 INFO - Running setup.py install for mozInstall 11:40:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:40:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:40:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:40:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:40:02 INFO - Running setup.py install for mozleak 11:40:02 INFO - Running setup.py install for mozlog 11:40:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:40:02 INFO - Running setup.py install for moznetwork 11:40:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:40:03 INFO - Running setup.py install for mozprocess 11:40:03 INFO - Running setup.py install for mozprofile 11:40:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:40:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:40:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:40:03 INFO - Running setup.py install for mozrunner 11:40:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:40:03 INFO - Running setup.py install for mozscreenshot 11:40:03 INFO - Running setup.py install for moztest 11:40:03 INFO - Running setup.py install for mozversion 11:40:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:40:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:40:03 INFO - Cleaning up... 11:40:03 INFO - Return code: 0 11:40:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40: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')]} 11:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40: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')]} 11:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40: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 0x7fc9aa90df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c1370>, '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 0x14c48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c4d80>, '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': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', '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 11:40: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 11:40: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 11:40:03 INFO - Using env: {'DISPLAY': ':0', 11:40:03 INFO - 'HOME': '/home/cltbld', 11:40:03 INFO - 'LANG': 'en_US.UTF-8', 11:40:03 INFO - 'LANGUAGE': 'en_US:en', 11:40:03 INFO - 'LOGNAME': 'cltbld', 11:40:03 INFO - 'MAIL': '/var/mail/cltbld', 11:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:03 INFO - 'MOZ_NO_REMOTE': '1', 11:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:03 INFO - 'NO_EM_RESTART': '1', 11:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:03 INFO - 'PWD': '/builds/slave/test', 11:40:03 INFO - 'SHELL': '/bin/bash', 11:40:03 INFO - 'SHLVL': '1', 11:40:03 INFO - 'TERM': 'linux', 11:40:03 INFO - 'TMOUT': '86400', 11:40:03 INFO - 'USER': 'cltbld', 11:40:03 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', 11:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:03 INFO - '_': '/tools/buildbot/bin/python'} 11:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:40:03 INFO - Running setup.py (path:/tmp/pip-lSO9PN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:40:03 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)) 11:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:40:03 INFO - Running setup.py (path:/tmp/pip-QkH4vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:40: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)) 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:40:04 INFO - Running setup.py (path:/tmp/pip-ZoG5Xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:40: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)) 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:40:04 INFO - Running setup.py (path:/tmp/pip-faGZNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:40: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)) 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:40:04 INFO - Running setup.py (path:/tmp/pip-TEB2X7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:40: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)) 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:40:04 INFO - Running setup.py (path:/tmp/pip-JW2hUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:40: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)) 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:40:04 INFO - Running setup.py (path:/tmp/pip-INC5oG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:40: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)) 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:40:04 INFO - Running setup.py (path:/tmp/pip-qdkb9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:40: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)) 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:40:04 INFO - Running setup.py (path:/tmp/pip-EeVrzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:40: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)) 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:40:04 INFO - Running setup.py (path:/tmp/pip-FwT6d8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:40: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)) 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:40:04 INFO - Running setup.py (path:/tmp/pip-5PKOeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:40: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)) 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:40:04 INFO - Running setup.py (path:/tmp/pip-lvZscf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:40: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)) 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:40:04 INFO - Running setup.py (path:/tmp/pip-edcGm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:40: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)) 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:40:04 INFO - Running setup.py (path:/tmp/pip-AbxaWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:40:04 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)) 11:40:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:40:04 INFO - Running setup.py (path:/tmp/pip-MmEzrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:40: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)) 11:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:40:05 INFO - Running setup.py (path:/tmp/pip-aJl4A0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:40: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)) 11:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:40:05 INFO - Running setup.py (path:/tmp/pip-GVYlrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:40: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)) 11:40: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)) 11:40: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)) 11:40: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)) 11:40: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)) 11:40: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)) 11:40:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:40: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 11:40: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 11:40: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 11:40: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 11:40: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 11:40: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 11:40:07 INFO - Downloading blessings-1.6.tar.gz 11:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:40:07 INFO - Installing collected packages: blessings 11:40:07 INFO - Running setup.py install for blessings 11:40:07 INFO - Successfully installed blessings 11:40:07 INFO - Cleaning up... 11:40:07 INFO - Return code: 0 11:40:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:40:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:40:07 INFO - Reading from file tmpfile_stdout 11:40:07 INFO - Current package versions: 11:40:07 INFO - argparse == 1.2.1 11:40:07 INFO - blessings == 1.6 11:40:07 INFO - blobuploader == 1.2.4 11:40:07 INFO - docopt == 0.6.1 11:40:07 INFO - functools32 == 3.2.3-2 11:40:07 INFO - jsonschema == 2.5.1 11:40:07 INFO - manifestparser == 1.1 11:40:07 INFO - mozInstall == 1.12 11:40:07 INFO - mozcrash == 0.17 11:40:07 INFO - mozdebug == 0.1 11:40:07 INFO - mozdevice == 0.48 11:40:07 INFO - mozfile == 1.2 11:40:07 INFO - mozhttpd == 0.7 11:40:07 INFO - mozinfo == 0.9 11:40:07 INFO - mozleak == 0.1 11:40:07 INFO - mozlog == 3.3 11:40:07 INFO - moznetwork == 0.27 11:40:07 INFO - mozprocess == 0.23 11:40:07 INFO - mozprofile == 0.28 11:40:07 INFO - mozrunner == 6.12 11:40:07 INFO - mozscreenshot == 0.1 11:40:07 INFO - mozsystemmonitor == 0.3 11:40:07 INFO - moztest == 0.7 11:40:07 INFO - mozversion == 1.4 11:40:07 INFO - psutil == 3.1.1 11:40:07 INFO - requests == 1.2.3 11:40:07 INFO - wsgiref == 0.1.2 11:40:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:40: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')]} 11:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40: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')]} 11:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40: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 0x7fc9aa90df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c1370>, '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 0x14c48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c4d80>, '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': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', '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 11:40: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 11:40: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 11:40:07 INFO - Using env: {'DISPLAY': ':0', 11:40:07 INFO - 'HOME': '/home/cltbld', 11:40:07 INFO - 'LANG': 'en_US.UTF-8', 11:40:07 INFO - 'LANGUAGE': 'en_US:en', 11:40:07 INFO - 'LOGNAME': 'cltbld', 11:40:07 INFO - 'MAIL': '/var/mail/cltbld', 11:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:07 INFO - 'MOZ_NO_REMOTE': '1', 11:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:07 INFO - 'NO_EM_RESTART': '1', 11:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:07 INFO - 'PWD': '/builds/slave/test', 11:40:07 INFO - 'SHELL': '/bin/bash', 11:40:07 INFO - 'SHLVL': '1', 11:40:07 INFO - 'TERM': 'linux', 11:40:07 INFO - 'TMOUT': '86400', 11:40:07 INFO - 'USER': 'cltbld', 11:40:07 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', 11:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:07 INFO - '_': '/tools/buildbot/bin/python'} 11:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40: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)) 11:40: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)) 11:40: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)) 11:40: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)) 11:40: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)) 11:40: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)) 11:40: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)) 11:40: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)) 11:40: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)) 11:40: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)) 11:40: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)) 11:40:07 INFO - Cleaning up... 11:40:07 INFO - Return code: 0 11:40:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:40: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')]} 11:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40: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')]} 11:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:40: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 0x7fc9aa90df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c6850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c1370>, '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 0x14c48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c4d80>, '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': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', '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 11:40: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 11:40: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 11:40:07 INFO - Using env: {'DISPLAY': ':0', 11:40:07 INFO - 'HOME': '/home/cltbld', 11:40:07 INFO - 'LANG': 'en_US.UTF-8', 11:40:07 INFO - 'LANGUAGE': 'en_US:en', 11:40:07 INFO - 'LOGNAME': 'cltbld', 11:40:07 INFO - 'MAIL': '/var/mail/cltbld', 11:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:07 INFO - 'MOZ_NO_REMOTE': '1', 11:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:07 INFO - 'NO_EM_RESTART': '1', 11:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:07 INFO - 'PWD': '/builds/slave/test', 11:40:07 INFO - 'SHELL': '/bin/bash', 11:40:07 INFO - 'SHLVL': '1', 11:40:07 INFO - 'TERM': 'linux', 11:40:07 INFO - 'TMOUT': '86400', 11:40:07 INFO - 'USER': 'cltbld', 11:40:07 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', 11:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:07 INFO - '_': '/tools/buildbot/bin/python'} 11:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:40:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:40:07 INFO - Cleaning up... 11:40:07 INFO - Return code: 0 11:40:07 INFO - Running post-action listener: _resource_record_post_action 11:40:07 INFO - Running post-action listener: _start_resource_monitoring 11:40:07 INFO - Starting resource monitoring. 11:40:07 INFO - [mozharness: 2016-08-30 18:40:07.996076Z] Finished create-virtualenv step (success) 11:40:07 INFO - [mozharness: 2016-08-30 18:40:07.996582Z] Running install step. 11:40:07 INFO - Running pre-action listener: _resource_record_pre_action 11:40:07 INFO - Running main action method: install 11:40:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:40:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:40:08 INFO - Reading from file tmpfile_stdout 11:40:08 INFO - Detecting whether we're running mozinstall >=1.0... 11:40:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:40:08 INFO - Reading from file tmpfile_stdout 11:40:08 INFO - Output received: 11:40:08 INFO - Usage: mozinstall [options] installer 11:40:08 INFO - Options: 11:40:08 INFO - -h, --help show this help message and exit 11:40:08 INFO - -d DEST, --destination=DEST 11:40:08 INFO - Directory to install application into. [default: 11:40:08 INFO - "/builds/slave/test"] 11:40:08 INFO - --app=APP Application being installed. [default: firefox] 11:40:08 INFO - mkdir: /builds/slave/test/build/application 11:40: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'] 11:40: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 11:40:25 INFO - Reading from file tmpfile_stdout 11:40:25 INFO - Output received: 11:40:25 INFO - /builds/slave/test/build/application/firefox/firefox 11:40:25 INFO - Running post-action listener: _resource_record_post_action 11:40:25 INFO - [mozharness: 2016-08-30 18:40:25.869573Z] Finished install step (success) 11:40:25 INFO - [mozharness: 2016-08-30 18:40:25.869852Z] Running run-tests step. 11:40:25 INFO - Running pre-action listener: _resource_record_pre_action 11:40:25 INFO - Running main action method: run_tests 11:40:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:40:25 INFO - Python 2.7.3 11:40:25 INFO - Return code: 0 11:40:25 INFO - grabbing minidump binary from tooltool 11:40:25 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')]} 11:40:25 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 0x14c1370>, '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 0x14c48f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c4d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:40:25 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 11:40:25 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 11:40:25 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 11:40:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:40:25 INFO - Return code: 0 11:40:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:40:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:40:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:40:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:40:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:40:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 11:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 11:40:25 INFO - Using env: {'DISPLAY': ':0', 11:40:25 INFO - 'HOME': '/home/cltbld', 11:40:25 INFO - 'LANG': 'en_US.UTF-8', 11:40:25 INFO - 'LANGUAGE': 'en_US:en', 11:40:25 INFO - 'LOGNAME': 'cltbld', 11:40:25 INFO - 'MAIL': '/var/mail/cltbld', 11:40:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:40:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:25 INFO - 'MOZ_NO_REMOTE': '1', 11:40:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:40:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:40:25 INFO - 'NO_EM_RESTART': '1', 11:40:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:25 INFO - 'PWD': '/builds/slave/test', 11:40:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:40:25 INFO - 'SHELL': '/bin/bash', 11:40:25 INFO - 'SHLVL': '1', 11:40:25 INFO - 'TERM': 'linux', 11:40:25 INFO - 'TMOUT': '86400', 11:40:25 INFO - 'USER': 'cltbld', 11:40:25 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841', 11:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:25 INFO - '_': '/tools/buildbot/bin/python'} 11:40:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 11:40:26 INFO - mozversion application_buildid: 20160830083013 11:40:26 INFO - mozversion application_changeset: b18c8bcdc116eef8799880b7c50317bf54218474 11:40:26 INFO - mozversion application_display_name: Nightly 11:40:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:40:26 INFO - mozversion application_name: Firefox 11:40:26 INFO - mozversion application_remotingname: firefox 11:40:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:40:26 INFO - mozversion application_vendor: Mozilla 11:40:26 INFO - mozversion application_version: 51.0a1 11:40:26 INFO - mozversion platform_buildid: 20160830083013 11:40:26 INFO - mozversion platform_changeset: b18c8bcdc116eef8799880b7c50317bf54218474 11:40:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:40:26 INFO - mozversion platform_version: 51.0a1 11:40:26 INFO - using testdate: 1472582426 11:40:26 INFO - actual date: 1472582426 11:40:26 INFO - starting webserver on 'localhost:45302' 11:40:26 INFO - SUITE-START | Running 2 tests 11:40:26 INFO - TEST-START | dromaeo_css 11:40:26 INFO - operating with platform_type : linux_ 11:40:26 INFO - Initialising browser for dromaeo_css test... 11:40:26 INFO - TEST-INFO | started process 27946 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnXW5T2/profile http://localhost:45302/getInfo.html) 11:40:30 INFO - PROCESS | 27946 | __metrics Screen width/height:1600/1200 11:40:30 INFO - PROCESS | 27946 | colorDepth:24 11:40:30 INFO - PROCESS | 27946 | Browser inner width/height: 1024/697 11:40:30 INFO - PROCESS | 27946 | __metrics 11:40:30 INFO - PROCESS | 27946 | 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" 11:40:30 INFO - PROCESS | 27946 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:40:31 INFO - PROCESS | 27946 | console.error: PushService: 11:40:31 INFO - PROCESS | 27946 | stateChangeProcessEnqueue: Error transitioning state 11:40:31 INFO - PROCESS | 27946 | UnknownError 11:40:31 INFO - TEST-INFO | 27946: exit 0 11:40:31 INFO - Browser initialized. 11:40:31 INFO - Running cycle 1/1 for dromaeo_css test... 11:40:31 INFO - TEST-INFO | started process 28028 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnXW5T2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:43 INFO - PROCESS | 28028 | RSS: Main: 180584448 11:40:43 INFO - PROCESS | 28028 | 11:41:34 INFO - PROCESS | 28028 | 1472582494918 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] 11:43:44 INFO - PROCESS | 28028 | Cycle 1(1): loaded http://localhost:45302/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45302/tests/dromaeo/cssquery-ext.html) 11:43:45 INFO - PROCESS | 28028 | RSS: Main: 283406336 11:43:45 INFO - PROCESS | 28028 | 11:46:47 INFO - PROCESS | 28028 | Cycle 1(1): loaded http://localhost:45302/tests/dromaeo/cssquery-ext.html (next: http://localhost:45302/tests/dromaeo/cssquery-jquery.html) 11:46:48 INFO - PROCESS | 28028 | RSS: Main: 276471808 11:46:48 INFO - PROCESS | 28028 | 11:49:50 INFO - PROCESS | 28028 | Cycle 1(1): loaded http://localhost:45302/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45302/tests/dromaeo/cssquery-mootools.html) 11:49:51 INFO - PROCESS | 28028 | RSS: Main: 212402176 11:49:51 INFO - PROCESS | 28028 | 11:52:53 INFO - PROCESS | 28028 | Cycle 1(1): loaded http://localhost:45302/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45302/tests/dromaeo/cssquery-prototype.html) 11:52:53 INFO - PROCESS | 28028 | RSS: Main: 213766144 11:52:53 INFO - PROCESS | 28028 | 11:55:56 INFO - PROCESS | 28028 | Cycle 1(1): loaded http://localhost:45302/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45302/tests/dromaeo/cssquery-yui.html) 11:55:57 INFO - PROCESS | 28028 | RSS: Main: 214401024 11:55:57 INFO - PROCESS | 28028 | 11:59:00 INFO - PROCESS | 28028 | Cycle 1(1): loaded http://localhost:45302/tests/dromaeo/cssquery-yui.html (next: http://localhost:45302/tests/dromaeo/cssquery-dojo.html) 11:59:00 INFO - PROCESS | 28028 | RSS: Main: 308736000 11:59:00 INFO - PROCESS | 28028 | 11:59:00 INFO - PROCESS | 28028 | __start_tp_report 11:59:00 INFO - PROCESS | 28028 | _x_x_mozilla_page_load 11:59:00 INFO - PROCESS | 28028 | _x_x_mozilla_page_load_details 11:59:00 INFO - PROCESS | 28028 | |i|pagename|runs| 11:59:00 INFO - PROCESS | 28028 | |0;dojo.html;2880.078374920025;2913.9562906556394;2917.256099694578;2937.045460225426;2949.041561492515;5017.849464516061;5087.974560127203;5134.332536770219;5189.351331083614;5218.034663587239;5293.311869456975;5314.096603577392;5316.893662126765;5366.973165134169;5374.032674118657;4749.050189962021;4763.976180119094;4847.5394837490385;4847.903041939159;4926.359573255471;4914.262860570925;4927.704337739729;4963.057019166346;4980.87547811304;5010.624203184758;4685.601723853477;4714.38712967312;4795.880102997418;4852.441969173555;4905.8773530661665;4881.365422495089;4929.580985616227;4939.728314942677;4945.381827271591;4959.727215003173;4807.399075115611;4826.155422800995;4845.127876982142;4850.223964165716;4891.779869905863;5138.537531622134;5341.385740639837;5358.866028349284;5367;5367.919481207746;5628.183913332585;5632.183333416672;5684.54523638108;5753.395893431213;5760.423957604248;5691.630044047124;5707.74315155819;5708.400617935098;5715.571332150105;5721.7711291548285;5334.146536554172;5334.626576139672;5336.67979921206;5339.626226164209;5341.359036915556;5567.24842146305;5695.373508914016;5746.712664366849;5766.106253530709;5824.912626310609;5528.308961379827;5529.778808847682;5543.1408131739645;5569.136783798518;5571.749271282802;5605.8598535036135;5628.127640215773;5657.462541058593;5660.801871934463;5668.688222147822;5457.181422786613;5548.91676624851;5595.4124816894455;5602.803901863496;5671.51792097668;5598.132289495054;5601.63589366698;5607.186957891083;5609.326880774333;5615.634983726127;4290.420793192879;4296.082139427101;4299.699021068558;4309.978450107729;4350.825966961349;3713.2759111973446;3838.328292548793;3866.168773713665;3899.5515515716056;3954.4859168308512;5385.219143224211;5391.541718953855;5394.217838413487;5395.514403703685;5403.621746477787;5714.857128571736;5720.227769251098;5722;5722.856928576819;5775.8556036099435;5162.328897243335;5176.559992400613;5187.014467251211;5225.869353266199;5263.36839579253;4587.747673877969;4596.7931443085145;4605.424321959755;4645.907081858344;4649.837255696102;5685.658860468385;5687.800926967537;5688.829335119953;5695.345035320908;5750;5285.920711189412;5515.917261241165;5517.062099443185;5529.391766905717;5551.944480555143;5756.539476841926;5762.078067509178;5770.278715160605;5798.739056742541;5826.854328641818;5502.119660854244;5512.6692398456225;5512.889742205213;5520.06158952987;5540.722963851711;5456.263404440349;5602.13166959122;5618.129189975561;5649.915251271316;5671.801486947937;5554.944450555605;5577.3028371453565;5589.636673616202;5635.6618602883955;5664.915026274527;5555.944440555704;5565.0817615094675;5568.638038527482;5570.275864137636;5574.9442505574425;5225.399079105951;5477.4796394342475;5493.505584497414;5518.144687573433;5601.691906945157;5642.7460764266525;5660.773569057356;5661.745221464962;5665.433456654301;5709.0865461525955;5525.060739674345;5526.861828454321;5527.2538207341495;5532.557395408438;5534.695591742493 11:59:00 INFO - PROCESS | 28028 | |1;ext.html;532.5313723922948;557.4954666027246;585.6369051188262;592.2626330218875;629.9905501417477;31371.372572548564;41293.58706412935;42406.787966060125;42428.36357454633;42453.93865153377;44222.77888610552;44583.55416445834;44681.776591117;44715;44757.77621111898;8092.959535202316;8887.111288871125;9025.18773310402;9034.638614455447;9038.864417033717;10297.897021029807;10629.468526573679;10636.734081647983;10959.178061645369;10973.50619222137;10809.83785243222;10915.072218861405;10917.290376125526;10923.634545681789;10948.562057517729;10691.946540267289;10743.946280268548;10756.19328550362;10763.300385474959;10769.084627806646;10661;10728.624498142606;10735.731606709816;10736.516856741388;10740.73148171294;41418.58581414178;41716;41718.79140604308;41758.79120604408;41786;3583;3605.0266428064274;3679.908002299937;3733.1600389912323;3736.57029441615;31355.216119596964;31668.683313166803;32188.517172242435;32420.027399178063;32937.505937410955;4141.607300325962;4286.39990401344;4334.674899382559;4395.252807022814;4404.515503294635;335122;337910;338132;338713;338868.99999999756;36141;56355.15467267994;56761.43238567644;56765.43234567684;56796.432035679114;36943.445848312294;37049.444258336145;37170.25659486795;37219.813900930865;37369;15437.691246175014;15638.374465021272;15657.217139142997;15672.843271567366;15679.529614111367;11088.889111108947;11327.886721132849;12933.159344642569;13092.607221783363;13105.67235819093;8138.3896207784655;8201.71294004707;8346.916530834735;8555.187257210555;8585.399022068395;3297.1757060734817;3335.6997870191312;3362.9327413451592;3367.2760356523463;3401.829908504565;978.8531720241879;988.051470588229;990.3760630802692;1002.9598816047422;1039.8908114648004;30722.846385767927;30880.691193087783;31313.530297045563;31407.84296078505;31468.842655787033;1046.4453839465095;1059.6079450603327;1107.3909349857547;1123.084685980923;1158.2124155574122;15881.920590397205;16344.509664710078;16436.342546298016;16474.341026358812;16538.353863381803;576088;582604;582641;582894;583428;56843.33663277253;57616.71191644015;57619.42380576224;57648.71175644095;57672.13491797626;1309.2668105860748;1344.395022239996;1346.098114263446;1357.850636429992;1363.0458678924792;29082.854585726935;30452.84773576118;30528.236794080327;30608.234794130323;31133;48981;49291.753541232065;49410.505894940594;49445.752771235915;49447.75276123596;377765;378230;378418;378985;379299;26508.734912650627;26732.599011014463;28142.215823309678;29130.854345728134;29138;36089;39445.436046656876;46278;46742.06515869732;47667;39276.41085383664;40670.79664601658;41813.372799408644;41818.37272440977;42931.7853410731;40506;41151;41281.58718412778;42398;42406.78796605997;39062.804685976385;39207.60792392154;40252.7987360073;40390.79804600958;42712;32582.67417325891;36491.27017459689;37021.44467832931;37271.44092838664;37754.43368349422;27080;27475.587866181624;27511.31221719473;27618.86190569115;27775.583366249928 11:59:00 INFO - PROCESS | 28028 | |2;jquery.html;394.964453199212;396.1008510680755;400.0079802090815;402.4044414266886;419.31442092179276;12741.22229055022;18190.545236369082;20099.095540700666;20174.39476815696;20719.482012949684;15277.465288714897;15400.61498462539;15883.92058039711;18823.247070117213;19472.610547789034;5605.159226116074;5621.381648018725;5806.332271788735;5816.418358164192;5824.0390335594575;5642.266505354298;5740.167675687023;5747.626404283729;5779.537636989052;5791.276090488689;5563.13771365439;5749.281339832521;5755.971220143914;5760.884782304352;5763.337216220126;5745.741441635116;5879.088741245114;5917.970410147965;5923.851903702399;5924.792632257871;5569.387367389584;5682.54539636828;5729.656220626775;5738.282714660668;5745.425457454263;14336.856631433657;14562.199079050648;14568.562943111723;18054.548636284067;23136.53726925452;2326.453283478398;2373.2524254859663;2441.4628781668002;2832.3768770870583;2867.3405116823246;10373.429461379621;10566.471676416148;10739;12870.871291287061;13170.736585268336;1829.478598599406;1884.6042331110484;1896.2699360746074;1915.8136734358784;1962.9018549072632;83702.58148709217;85810.57094714486;87504.06199225096;88952;88953;10567.682969510926;10587.735306617396;11019.173561982883;11041.447927603587;11392;14714.779278310834;14765.852341476662;14768.261586920611;14799.778003329959;14865.479708210161;7541.095068591694;7799.3760499159935;7873.842523149619;7954.562499062491;8123.715669951642;7288.854222915512;7346.595937223504;7413.443991700644;7499.362554182846;7587.430942679322;4619.23782575878;4622.560856718606;4635.559621835921;4673.25227963531;4858.17411040124;1915.4636701723539;1923.7787654419922;1934.6227485640165;1970.8076613648823;1994.7107669387858;830.9376796740269;932.2122806228726;932.4218984229685;955.412421360858;1001.2240513602017;18385.724214136797;19742.90128549348;19922.978432964726;20013.699794503093;20066.89966550158;879.678917195232;927.6521304510809;936.8641546975787;952.8513202727804;967.3953778888194;10493.475326233658;10781.299215550964;10957.671269861758;11086.944565277283;11100.44497775108;471289;471348;484771;487729;492271;90207;91790.54104729433;91872.54063729639;92246.53876730573;92909;973.4256788494963;1009.8788145422596;1035.772130131385;1039.3036665434176;1041.8541404203418;16531.421400250932;16903.070331131905;17412.216450259515;17463.214155362784;17767.111644417986;42314.556971517544;42600.360994585724;42713;42940;43828.56171438245;53543.73228133834;57498.7125064372;57903.71048144901;57906;58641.82716345564;5364.195370694427;7907.604619769104;8475.279601233964;8572.228499435081;8954.686585969459;7239.746608868664;10028.64899728506;11168.771435141965;13222.206667599974;13704.040717149705;10857.619983300863;11114.944425277821;11537;11634;11893.286402815858;11457.942710286396;11695.12286578493;11881.940590296994;11890.34603096838;12135.635930922086;11425.200235983733;11608.12939029593;11614.6515604532;12275.447604857623;12345;8274.544900030556;8529.317654587741;8691.304695624462;8693;8778.868316975122;9785.608575656894;10681.252312338062;11089.33463992163;11596.884031159918;11969.940150299193 11:59:00 INFO - PROCESS | 28028 | |3;mootools.html;1239.6838806104442;1314.9013823963194;1315.7697402954486;1349.9932500337497;1747.1613625459786;7951.244631759981;8369.707060252886;8379.455335403201;8614.267787238077;8633.784155396103;8338.91661083389;8441.366897482698;8441.662333506667;8447;8453.154684531544;2320.466292752664;2331.5570041692026;2332.5334933013382;2338.2283846330756;2339.1462116327502;2294.070901284974;2346.9647955280598;2348.5655153796515;2351.1888398502488;2352.6000579901456;2305.07796881248;2317.559663663907;2319.257837491995;2355.316958082154;2355.8468699534474;2241.6413373860105;2272.363738153328;2272.4659704969317;2286.039863257436;2303.2053941390195;2268.6143355629583;2271.375371772759;2271.4775601611555;2274.101729816713;2276.1009401286565;8309.127541608104;8373.916260837375;8465.788355291106;8470.237678608955;8474.87287690679;4805.8558243252755;4978.477259887696;4982.352294201731;4987.351644286219;4997.950020499785;2977.3152174999655;3122.609673790776;3167.129039514129;3178.300773829754;3183.697548732867;1037.5331101004579;1049.2969710294121;1049.422817450407;1051.2220956492217;1078.2613909472036;11211.327320360722;11351.148663850245;11364.431778411046;11376.715582110432;11437.027852632536;4026.134381108076;4127.8968025798995;4139.482564679415;4295.420118284054;4302.698811083257;8829.558522074;8860.069692682304;8931.642734290686;8947.642094316154;8949.686760963465;4765.11845308619;4765.594924431392;4776.95223047772;4787.569118779326;4791.448983366888;3700.4634328022285;3821.904452388657;3917.196974620196;3922.392029235416;4428.82284708608;3533.717302615785;3648.2521083177885;3683.723720720957;3700.981495092561;3701.1672373715696;1097.8627671541058;1115.1524841120806;1115.9721006974892;1118.0440723181562;1124.7188202949262;938.8967213606497;968.8352979993418;983.257640481432;996.7009897030862;1001.884783249921;5571.554275657938;5652.519535839418;5654.802081927113;5770.798022069292;5927.407259274038;477.59404506169477;480.0782497604608;482.62596487721595;488.3821965214007;490.5045903637352;3923.352646813301;4047.251258517184;4070.3690927906223;4108.424820525129;4128.8348466061625;9957.502124893872;10247.84628230577;10334.379937203792;10341.37951722899;10371.585136594602;10262.794744105226;10266.538005789758;10270.743231419274;10291.94854025725;10295.485225738683;7745.806354841061;7749.612519374009;7794.103678077094;7794.6882124714375;7823.804404889924;5704.486596206361;5785.772477596071;5802.216700745515;5953.821385358447;6119.112728654409;9053.954730226307;9359.391639543408;9428.10433008863;9467.95266023693;9477.24182065447;9748.756281093029;9752.609895604097;9766.21870250364;9775.657851975147;9785.021497850443;6773.932260677528;6941.791746247621;6979;7060.8940865886025;7300.233475484997;8012.679492820222;8066.959665201871;8074.757757267292;8075.192480751878;8103.189681031849;7080.114985626797;7390.371818395497;7434.182239953709;7531.3974882008215;7565.924340756522;7030.086088808423;7038.753643622448;7193.352598266181;7223.747168849065;7493.175750667313;6644.435223006099;6781.694823732845;6786.796396108125;6815;6835.384815366641;4999.150144475375;5104.642675012862;5122.923156152735;5125.897482050413;5364.2490051393615;5118.610421836228;5153.484651534816;5364.597655175799;5379.892402152013;5397.59518036141 11:59:00 INFO - PROCESS | 28028 | |4;prototype.html;316.24733135138365;324.27848038115195;329.69173822476;331.5308837994237;334.5099429336023;5146.6140039497;5160.612954028444;5163.690178589287;5177.482251774821;5180.663256888304;5113.667611605243;5121.846344609658;5125.8462246132585;5130.743462826853;5151.665141765782;3956.4658771065824;4080.6123418275215;4080.7755573443596;4082.3876418537307;4099.323611604089;4060.776657283848;4087.5299340575766;4093.3246014407737;4099.7745124018165;4101.835926562949;4011.7994100295014;4019.618136277049;4052.9189416211657;4061.0862555924828;4062.614051665087;3805.1818858945185;3890.319194141014;4007.418924255981;4024.7987600620145;4027.416024676435;3541.7780865601326;3561.5013898054294;3563.5901871284873;3568.8750893718593;3569.1077230692326;5010.774515146791;5011.874703132415;5020.673656212334;5030.773615187325;5035.622328325354;4337;4390.802413891351;4516.90591944519;4523.864284071483;4537.342085397632;5244.606654500928;5286.6035047371215;5289.365276166846;5302.621318457191;5302.708351040691;3948.960510394888;3953.98023009886;3961.8019099045223;3963;3969.920601587981;5285;5539.390667026624;5544.722763861791;5550.72246387679;5560.304961879765;3895.6883449323986;3913.2369188008634;3933.8819835404984;3937.291287568265;3940.724149309578;3979.403089536535;3979.8010099495486;3981.044549308145;3988.8404463821703;4001.239764444804;4554.681172317973;4569.177548041318;4570.291604801261;4571.400009996474;4581.816727330869;5122.92315615266;5367.329083864517;5384.865378365572;5388.137897936312;5394.3796463406425;1363.6522686714825;1376.7040086381476;1377.793331000358;1379.6412932637586;1384.7161331926932;849.5752123938031;889.479654402182;899.8920129584492;900.4327273817584;914.6661468563926;4578.496365399803;4634.72191668501;4636.83771068011;4637.907241855211;4645.883852903637;4845.466998630148;4848.903021939612;4864.964761471931;4876.853694389174;4892.483330167659;4435.844745433894;4602.608778253886;4641.373414589055;4645.74448405341;4647.744374059459;2571.048711976543;2613.9607905881426;2771.6673999120235;2855.528837741749;2919;5662.13149660611;5670.149477578396;5672.205891175238;5677.120046392815;5698.715064246771;5386.649867758583;5603.327600687862;5608;5619.353774315924;5620.269364982608;5601.80393686219;5644;5678.801241956512;5699.173619825185;5703.942960570507;5452.781888724407;5500.202470641814;5507.228987941771;5522.723863806713;5526.668399896019;5266.78932842682;5418.972905135607;5458.263134476795;5479.424660410599;5479.753411096431;5616.241807355955;5624.803131890364;5649;5664.773409063591;5665.688387138747;3902.863399780994;3921.92156156881;3930.1157239620857;3933.4296527004;3959.703022273399;5333;5389.487998640123;5436.456354364532;5462.453754624506;5497.257870187474;5363.881266899631;5367.3827509836865;5381.919271211013;5382.892342153056;5385.703786291791;5359.169328754049;5359.437259087739;5363.865903352447;5375.784968601212;5376.247325374373;5038.949610503994;5318.494742999409;5319.840404787863;5345.358556973188;5347.459956520777;5332.413434522277;5398.514133727984;5405.459454054563;5410.621256512007;5416.539594134542;5034.924476132935;5218.895622087461;5220.373555173252;5251.711155886463;5265.604150111613 11:59:00 INFO - PROCESS | 28028 | |5;yui.html;728.5847067171711;746.1344839985618;759.2407592407592;816.9019717633881;825.3232349473433;14866.628334291649;15211.46759863405;15912.761308580351;16117.435889743861;16162.595935101628;15046;15428.845711542881;15443;15446.073235605843;15449;663.7643636509042;793.464411522223;800.2877439079239;816.0370762500247;819.4550623835142;811.6591031766673;823.0987069159291;825.896762904637;826.8553003224412;827.1976183102411;856.2422256303154;864.9870251946226;865.8484765166103;865.9307255419583;867.2281669314284;690.6822861483723;832.3590835056972;857.3012994409536;858.8625819868822;859.3640705877668;618.2797041446754;626.0890404461543;626.2735227136545;626.3454689849119;626.7743612299569;14459;14488.565343039725;14488.927555362261;14529.564113076625;14595.41618335276;13415.3963071662;13441.596752097452;14037.859621403757;14178.503752368617;14252.21612811295;12903;12943.569953962207;13052.869471305356;13092.607221783363;13180.934095329461;4203.936940945889;4237.5377549237355;4318.676099292534;4321.783910804447;4330.090680957002;79816.60091699562;79819;79860;80005.19994800036;80351.59824200842;10462.372257664565;10561.471926403648;10574.841377379345;11065.612703555498;11164.609238676607;19017.714734278998;20733.377998660064;20972.37082887516;21095;21148.365549033555;8073.7577872663915;8148.144444833326;8164.550949697824;8171.346292296602;8179.877301840477;4380.846670366522;4497.730136191839;4578;4643.907121857544;4653.534646535387;3155.731762800188;3266.803991760502;3271.2803183299634;3294.7364210863075;3307.9173020674675;562.6033646279363;571.0549041336594;571.2459553389486;576.8903908257417;587.2659176029963;605.0953824033011;646.424682032991;662.3839828959018;669.8291935556402;692.6190595172635;8382;8715.694950676696;8726.476411415335;8923.196912277926;9087.545622718837;490.5903570518657;532.305341529308;535.1384271323167;582.5921854701726;595.6396380190009;4135.627793498539;4361.498427680857;4591.747453890001;5059.848204553869;5104.285400043997;114669.42665286787;121005;122652.38673806573;123831.3808430952;123939.3803030979;85158;105228.47385763022;105787.47106264574;106569;108238;62813;80646;87931.7240965544;90653;91936;9323;9379.953100234728;9510.239180865652;9512.524373781422;9519.61921523159;52698.9460210786;53106.46893531015;53490.19764703455;55369.72315138399;56675.43324566867;46134;47239;47718;54944.45055549393;75514.62242688751;13367.331633418486;13438.865611343761;13557.457701691821;13748.450061997808;13894.513692021135;14590.854091459374;15062;15501.224938752792;15545.611359716098;15611.453599123975;14078;14707.41170353174;14770.556883293519;14878.702425951637;15033.624159396102;13115.606531804062;13349.66625834323;13853.376598053314;14194.503192388216;14594.562163135122;13483.325833708472;13610.93194534021;13985.790213147015;14023.158610483404;14661.413543458142;10438.269321147447;10445.895541044796;10487.94756026215;10569.577216911237;10700.250982431155;11179.888201117885;11390.711282865252;11596.304221746723;11627.244229125079;11694.649160525198 11:59:00 INFO - PROCESS | 28028 | __end_tp_report 11:59:00 INFO - PROCESS | 28028 | __start_cc_report 11:59:00 INFO - PROCESS | 28028 | _x_x_mozilla_cycle_collect,881 11:59:00 INFO - PROCESS | 28028 | __end_cc_report 11:59:00 INFO - PROCESS | 28028 | __startTimestamp1472583540426__endTimestamp 11:59:00 INFO - PROCESS | 28028 | 11:59:00 INFO - PROCESS | 28028 | ------- Summary: start ------- 11:59:00 INFO - PROCESS | 28028 | Number of tests: 6 11:59:00 INFO - PROCESS | 28028 | 11:59:00 INFO - PROCESS | 28028 | [#0] dojo.html Cycles:165 Average:5239.53 Median:5512.67 stddev:608.42 (11.0%) stddev-sans-first:581.45 11:59:00 INFO - PROCESS | 28028 | Values: 2880.1 2914.0 2917.3 2937.0 2949.0 5017.8 5088.0 5134.3 5189.4 5218.0 5293.3 5314.1 5316.9 5367.0 5374.0 4749.1 4764.0 4847.5 4847.9 4926.4 4914.3 4927.7 4963.1 4980.9 5010.6 4685.6 4714.4 4795.9 4852.4 4905.9 4881.4 4929.6 4939.7 4945.4 4959.7 4807.4 4826.2 4845.1 4850.2 4891.8 5138.5 5341.4 5358.9 5367.0 5367.9 5628.2 5632.2 5684.5 5753.4 5760.4 5691.6 5707.7 5708.4 5715.6 5721.8 5334.1 5334.6 5336.7 5339.6 5341.4 5567.2 5695.4 5746.7 5766.1 5824.9 5528.3 5529.8 5543.1 5569.1 5571.7 5605.9 5628.1 5657.5 5660.8 5668.7 5457.2 5548.9 5595.4 5602.8 5671.5 5598.1 5601.6 5607.2 5609.3 5615.6 4290.4 4296.1 4299.7 4310.0 4350.8 3713.3 3838.3 3866.2 3899.6 3954.5 5385.2 5391.5 5394.2 5395.5 5403.6 5714.9 5720.2 5722.0 5722.9 5775.9 5162.3 5176.6 5187.0 5225.9 5263.4 4587.7 4596.8 4605.4 4645.9 4649.8 5685.7 5687.8 5688.8 5695.3 5750.0 5285.9 5515.9 5517.1 5529.4 5551.9 5756.5 5762.1 5770.3 5798.7 5826.9 5502.1 5512.7 5512.9 5520.1 5540.7 5456.3 5602.1 5618.1 5649.9 5671.8 5554.9 5577.3 5589.6 5635.7 5664.9 5555.9 5565.1 5568.6 5570.3 5574.9 5225.4 5477.5 5493.5 5518.1 5601.7 5642.7 5660.8 5661.7 5665.4 5709.1 5525.1 5526.9 5527.3 5532.6 5534.7 11:59:00 INFO - PROCESS | 28028 | 11:59:00 INFO - PROCESS | 28028 | [#1] ext.html Cycles:180 Average:58115.54 Median:36982.45 stddev:118570.60 (320.6%) stddev-sans-first:118824.40 11:59:00 INFO - PROCESS | 28028 | Values: 532.5 557.5 585.6 592.3 630.0 31371.4 41293.6 42406.8 42428.4 42453.9 44222.8 44583.6 44681.8 44715.0 44757.8 8093.0 8887.1 9025.2 9034.6 9038.9 10297.9 10629.5 10636.7 10959.2 10973.5 10809.8 10915.1 10917.3 10923.6 10948.6 10691.9 10743.9 10756.2 10763.3 10769.1 10661.0 10728.6 10735.7 10736.5 10740.7 41418.6 41716.0 41718.8 41758.8 41786.0 3583.0 3605.0 3679.9 3733.2 3736.6 31355.2 31668.7 32188.5 32420.0 32937.5 4141.6 4286.4 4334.7 4395.3 4404.5 335122.0 337910.0 338132.0 338713.0 338869.0 36141.0 56355.2 56761.4 56765.4 56796.4 36943.4 37049.4 37170.3 37219.8 37369.0 15437.7 15638.4 15657.2 15672.8 15679.5 11088.9 11327.9 12933.2 13092.6 13105.7 8138.4 8201.7 8346.9 8555.2 8585.4 3297.2 3335.7 3362.9 3367.3 3401.8 978.9 988.1 990.4 1003.0 1039.9 30722.8 30880.7 31313.5 31407.8 31468.8 1046.4 1059.6 1107.4 1123.1 1158.2 15881.9 16344.5 16436.3 16474.3 16538.4 576088.0 582604.0 582641.0 582894.0 583428.0 56843.3 57616.7 57619.4 57648.7 57672.1 1309.3 1344.4 1346.1 1357.9 1363.0 29082.9 30452.8 30528.2 30608.2 31133.0 48981.0 49291.8 49410.5 49445.8 49447.8 377765.0 378230.0 378418.0 378985.0 379299.0 26508.7 26732.6 28142.2 29130.9 29138.0 36089.0 39445.4 46278.0 46742.1 47667.0 39276.4 40670.8 41813.4 41818.4 42931.8 40506.0 41151.0 41281.6 42398.0 42406.8 39062.8 39207.6 40252.8 40390.8 42712.0 32582.7 36491.3 37021.4 37271.4 37754.4 27080.0 27475.6 27511.3 27618.9 27775.6 11:59:00 INFO - PROCESS | 28028 | 11:59:00 INFO - PROCESS | 28028 | [#2] jquery.html Cycles:180 Average:28598.96 Median:401.21 stddev:79608.91 (19842.4%) stddev-sans-first:79804.07 11:59:00 INFO - PROCESS | 28028 | Values: 395.0 396.1 400.0 402.4 419.3 12741.2 18190.5 20099.1 20174.4 20719.5 15277.5 15400.6 15883.9 18823.2 19472.6 5605.2 5621.4 5806.3 5816.4 5824.0 5642.3 5740.2 5747.6 5779.5 5791.3 5563.1 5749.3 5756.0 5760.9 5763.3 5745.7 5879.1 5918.0 5923.9 5924.8 5569.4 5682.5 5729.7 5738.3 5745.4 14336.9 14562.2 14568.6 18054.5 23136.5 2326.5 2373.3 2441.5 2832.4 2867.3 10373.4 10566.5 10739.0 12870.9 13170.7 1829.5 1884.6 1896.3 1915.8 1962.9 83702.6 85810.6 87504.1 88952.0 88953.0 10567.7 10587.7 11019.2 11041.4 11392.0 14714.8 14765.9 14768.3 14799.8 14865.5 7541.1 7799.4 7873.8 7954.6 8123.7 7288.9 7346.6 7413.4 7499.4 7587.4 4619.2 4622.6 4635.6 4673.3 4858.2 1915.5 1923.8 1934.6 1970.8 1994.7 830.9 932.2 932.4 955.4 1001.2 18385.7 19742.9 19923.0 20013.7 20066.9 879.7 927.7 936.9 952.9 967.4 10493.5 10781.3 10957.7 11086.9 11100.4 471289.0 471348.0 484771.0 487729.0 492271.0 90207.0 91790.5 91872.5 92246.5 92909.0 973.4 1009.9 1035.8 1039.3 1041.9 16531.4 16903.1 17412.2 17463.2 17767.1 42314.6 42600.4 42713.0 42940.0 43828.6 53543.7 57498.7 57903.7 57906.0 58641.8 5364.2 7907.6 8475.3 8572.2 8954.7 7239.7 10028.6 11168.8 13222.2 13704.0 10857.6 11114.9 11537.0 11634.0 11893.3 11457.9 11695.1 11881.9 11890.3 12135.6 11425.2 11608.1 11614.7 12275.4 12345.0 8274.5 8529.3 8691.3 8693.0 8778.9 9785.6 10681.3 11089.3 11596.9 11969.9 11:59:00 INFO - PROCESS | 28028 | 11:59:00 INFO - PROCESS | 28028 | [#3] mootools.html Cycles:180 Average:5462.50 Median:2734.49 stddev:3086.43 (112.9%) stddev-sans-first:3078.77 11:59:00 INFO - PROCESS | 28028 | Values: 1239.7 1314.9 1315.8 1350.0 1747.2 7951.2 8369.7 8379.5 8614.3 8633.8 8338.9 8441.4 8441.7 8447.0 8453.2 2320.5 2331.6 2332.5 2338.2 2339.1 2294.1 2347.0 2348.6 2351.2 2352.6 2305.1 2317.6 2319.3 2355.3 2355.8 2241.6 2272.4 2272.5 2286.0 2303.2 2268.6 2271.4 2271.5 2274.1 2276.1 8309.1 8373.9 8465.8 8470.2 8474.9 4805.9 4978.5 4982.4 4987.4 4998.0 2977.3 3122.6 3167.1 3178.3 3183.7 1037.5 1049.3 1049.4 1051.2 1078.3 11211.3 11351.1 11364.4 11376.7 11437.0 4026.1 4127.9 4139.5 4295.4 4302.7 8829.6 8860.1 8931.6 8947.6 8949.7 4765.1 4765.6 4777.0 4787.6 4791.4 3700.5 3821.9 3917.2 3922.4 4428.8 3533.7 3648.3 3683.7 3701.0 3701.2 1097.9 1115.2 1116.0 1118.0 1124.7 938.9 968.8 983.3 996.7 1001.9 5571.6 5652.5 5654.8 5770.8 5927.4 477.6 480.1 482.6 488.4 490.5 3923.4 4047.3 4070.4 4108.4 4128.8 9957.5 10247.8 10334.4 10341.4 10371.6 10262.8 10266.5 10270.7 10291.9 10295.5 7745.8 7749.6 7794.1 7794.7 7823.8 5704.5 5785.8 5802.2 5953.8 6119.1 9054.0 9359.4 9428.1 9468.0 9477.2 9748.8 9752.6 9766.2 9775.7 9785.0 6773.9 6941.8 6979.0 7060.9 7300.2 8012.7 8067.0 8074.8 8075.2 8103.2 7080.1 7390.4 7434.2 7531.4 7565.9 7030.1 7038.8 7193.4 7223.7 7493.2 6644.4 6781.7 6786.8 6815.0 6835.4 4999.2 5104.6 5122.9 5125.9 5364.2 5118.6 5153.5 5364.6 5379.9 5397.6 11:59:00 INFO - PROCESS | 28028 | 11:59:00 INFO - PROCESS | 28028 | [#4] prototype.html Cycles:180 Average:4469.37 Median:5037.29 stddev:1307.38 (26.0%) stddev-sans-first:1273.34 11:59:00 INFO - PROCESS | 28028 | Values: 316.2 324.3 329.7 331.5 334.5 5146.6 5160.6 5163.7 5177.5 5180.7 5113.7 5121.8 5125.8 5130.7 5151.7 3956.5 4080.6 4080.8 4082.4 4099.3 4060.8 4087.5 4093.3 4099.8 4101.8 4011.8 4019.6 4052.9 4061.1 4062.6 3805.2 3890.3 4007.4 4024.8 4027.4 3541.8 3561.5 3563.6 3568.9 3569.1 5010.8 5011.9 5020.7 5030.8 5035.6 4337.0 4390.8 4516.9 4523.9 4537.3 5244.6 5286.6 5289.4 5302.6 5302.7 3949.0 3954.0 3961.8 3963.0 3969.9 5285.0 5539.4 5544.7 5550.7 5560.3 3895.7 3913.2 3933.9 3937.3 3940.7 3979.4 3979.8 3981.0 3988.8 4001.2 4554.7 4569.2 4570.3 4571.4 4581.8 5122.9 5367.3 5384.9 5388.1 5394.4 1363.7 1376.7 1377.8 1379.6 1384.7 849.6 889.5 899.9 900.4 914.7 4578.5 4634.7 4636.8 4637.9 4645.9 4845.5 4848.9 4865.0 4876.9 4892.5 4435.8 4602.6 4641.4 4645.7 4647.7 2571.0 2614.0 2771.7 2855.5 2919.0 5662.1 5670.1 5672.2 5677.1 5698.7 5386.6 5603.3 5608.0 5619.4 5620.3 5601.8 5644.0 5678.8 5699.2 5703.9 5452.8 5500.2 5507.2 5522.7 5526.7 5266.8 5419.0 5458.3 5479.4 5479.8 5616.2 5624.8 5649.0 5664.8 5665.7 3902.9 3921.9 3930.1 3933.4 3959.7 5333.0 5389.5 5436.5 5462.5 5497.3 5363.9 5367.4 5381.9 5382.9 5385.7 5359.2 5359.4 5363.9 5375.8 5376.2 5038.9 5318.5 5319.8 5345.4 5347.5 5332.4 5398.5 5405.5 5410.6 5416.5 5034.9 5218.9 5220.4 5251.7 5265.6 11:59:00 INFO - PROCESS | 28028 | 11:59:00 INFO - PROCESS | 28028 | [#5] yui.html Cycles:180 Average:20596.51 Median:4371.17 stddev:30131.76 (689.3%) stddev-sans-first:30179.36 11:59:00 INFO - PROCESS | 28028 | Values: 728.6 746.1 759.2 816.9 825.3 14866.6 15211.5 15912.8 16117.4 16162.6 15046.0 15428.8 15443.0 15446.1 15449.0 663.8 793.5 800.3 816.0 819.5 811.7 823.1 825.9 826.9 827.2 856.2 865.0 865.8 865.9 867.2 690.7 832.4 857.3 858.9 859.4 618.3 626.1 626.3 626.3 626.8 14459.0 14488.6 14488.9 14529.6 14595.4 13415.4 13441.6 14037.9 14178.5 14252.2 12903.0 12943.6 13052.9 13092.6 13180.9 4203.9 4237.5 4318.7 4321.8 4330.1 79816.6 79819.0 79860.0 80005.2 80351.6 10462.4 10561.5 10574.8 11065.6 11164.6 19017.7 20733.4 20972.4 21095.0 21148.4 8073.8 8148.1 8164.6 8171.3 8179.9 4380.8 4497.7 4578.0 4643.9 4653.5 3155.7 3266.8 3271.3 3294.7 3307.9 562.6 571.1 571.2 576.9 587.3 605.1 646.4 662.4 669.8 692.6 8382.0 8715.7 8726.5 8923.2 9087.5 490.6 532.3 535.1 582.6 595.6 4135.6 4361.5 4591.7 5059.8 5104.3 114669.4 121005.0 122652.4 123831.4 123939.4 85158.0 105228.5 105787.5 106569.0 108238.0 62813.0 80646.0 87931.7 90653.0 91936.0 9323.0 9380.0 9510.2 9512.5 9519.6 52698.9 53106.5 53490.2 55369.7 56675.4 46134.0 47239.0 47718.0 54944.5 75514.6 13367.3 13438.9 13557.5 13748.5 13894.5 14590.9 15062.0 15501.2 15545.6 15611.5 14078.0 14707.4 14770.6 14878.7 15033.6 13115.6 13349.7 13853.4 14194.5 14594.6 13483.3 13610.9 13985.8 14023.2 14661.4 10438.3 10445.9 10487.9 10569.6 10700.3 11179.9 11390.7 11596.3 11627.2 11694.6 11:59:00 INFO - PROCESS | 28028 | -------- Summary: end -------- 11:59:00 INFO - PROCESS | 28028 | 11:59:01 INFO - TEST-INFO | 28028: exit 0 11:59:01 INFO - TEST-OK | dromaeo_css | took 1115189ms 11:59:01 INFO - TEST-START | kraken 11:59:01 INFO - operating with platform_type : linux_ 11:59:01 INFO - Initialising browser for kraken test... 11:59:01 INFO - TEST-INFO | started process 28336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphQ7KXH/profile http://localhost:45302/getInfo.html) 11:59:05 INFO - PROCESS | 28336 | __metrics Screen width/height:1600/1200 11:59:05 INFO - PROCESS | 28336 | colorDepth:24 11:59:05 INFO - PROCESS | 28336 | Browser inner width/height: 1024/697 11:59:05 INFO - PROCESS | 28336 | __metrics 11:59:05 INFO - PROCESS | 28336 | 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" 11:59:05 INFO - PROCESS | 28336 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:59:06 INFO - PROCESS | 28336 | console.error: PushService: 11:59:06 INFO - PROCESS | 28336 | stateChangeProcessEnqueue: Error transitioning state 11:59:06 INFO - PROCESS | 28336 | UnknownError 11:59:06 INFO - TEST-INFO | 28336: exit 0 11:59:06 INFO - Browser initialized. 11:59:06 INFO - Running cycle 1/1 for kraken test... 11:59:06 INFO - TEST-INFO | started process 28417 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphQ7KXH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:59:18 INFO - PROCESS | 28417 | RSS: Main: 179449856 11:59:18 INFO - PROCESS | 28417 | 11:59:21 INFO - PROCESS | 28417 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45302/tests/kraken/driver.html?testName=audio-beat-detection) 11:59:22 INFO - PROCESS | 28417 | RSS: Main: 233402368 11:59:22 INFO - PROCESS | 28417 | 11:59:24 INFO - PROCESS | 28417 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45302/tests/kraken/driver.html?testName=audio-dft) 11:59:25 INFO - PROCESS | 28417 | RSS: Main: 223645696 11:59:25 INFO - PROCESS | 28417 | 11:59:28 INFO - PROCESS | 28417 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45302/tests/kraken/driver.html?testName=audio-fft) 11:59:29 INFO - PROCESS | 28417 | RSS: Main: 302264320 11:59:29 INFO - PROCESS | 28417 | 11:59:31 INFO - PROCESS | 28417 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45302/tests/kraken/driver.html?testName=audio-oscillator) 11:59:31 INFO - PROCESS | 28417 | RSS: Main: 211898368 11:59:31 INFO - PROCESS | 28417 | 11:59:34 INFO - PROCESS | 28417 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45302/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:59:34 INFO - PROCESS | 28417 | RSS: Main: 213508096 11:59:34 INFO - PROCESS | 28417 | 11:59:37 INFO - PROCESS | 28417 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45302/tests/kraken/driver.html?testName=imaging-darkroom) 11:59:38 INFO - PROCESS | 28417 | RSS: Main: 252362752 11:59:38 INFO - PROCESS | 28417 | 11:59:41 INFO - PROCESS | 28417 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45302/tests/kraken/driver.html?testName=imaging-desaturate) 11:59:42 INFO - PROCESS | 28417 | RSS: Main: 250802176 11:59:42 INFO - PROCESS | 28417 | 11:59:44 INFO - PROCESS | 28417 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45302/tests/kraken/driver.html?testName=json-parse-financial) 11:59:45 INFO - PROCESS | 28417 | RSS: Main: 250974208 11:59:45 INFO - PROCESS | 28417 | 11:59:47 INFO - PROCESS | 28417 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45302/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:59:47 INFO - PROCESS | 28417 | RSS: Main: 213430272 11:59:47 INFO - PROCESS | 28417 | 11:59:49 INFO - PROCESS | 28417 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45302/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:59:50 INFO - PROCESS | 28417 | RSS: Main: 219959296 11:59:50 INFO - PROCESS | 28417 | 11:59:52 INFO - PROCESS | 28417 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45302/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:59:52 INFO - PROCESS | 28417 | RSS: Main: 221741056 11:59:52 INFO - PROCESS | 28417 | 11:59:55 INFO - PROCESS | 28417 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:59:56 INFO - PROCESS | 28417 | RSS: Main: 223227904 11:59:56 INFO - PROCESS | 28417 | 11:59:58 INFO - PROCESS | 28417 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:59:59 INFO - PROCESS | 28417 | RSS: Main: 221392896 11:59:59 INFO - PROCESS | 28417 | 12:00:01 INFO - PROCESS | 28417 | Cycle 1(1): loaded http://localhost:45302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45302/tests/kraken/driver.html?testName=ai-astar) 12:00:01 INFO - PROCESS | 28417 | RSS: Main: 271814656 12:00:01 INFO - PROCESS | 28417 | 12:00:01 INFO - PROCESS | 28417 | __start_tp_report 12:00:01 INFO - PROCESS | 28417 | _x_x_mozilla_page_load 12:00:01 INFO - PROCESS | 28417 | _x_x_mozilla_page_load_details 12:00:01 INFO - PROCESS | 28417 | |i|pagename|runs| 12:00:01 INFO - PROCESS | 28417 | |0;ai-astar;113;114;132;113;113;112;112;113;110;111 12:00:01 INFO - PROCESS | 28417 | |1;audio-beat-detection;142;116;143;173;119;146;148;124;176;116 12:00:01 INFO - PROCESS | 28417 | |2;audio-dft;161;160;160;163;161;162;163;162;161;161 12:00:01 INFO - PROCESS | 28417 | |3;audio-fft;77;75;77;180;77;75;76;76;169;75 12:00:01 INFO - PROCESS | 28417 | |4;audio-oscillator;83;82;162;82;82;82;144;84;82;150 12:00:01 INFO - PROCESS | 28417 | |5;imaging-gaussian-blur;116;116;117;117;116;116;117;117;116;117 12:00:01 INFO - PROCESS | 28417 | |6;imaging-darkroom;146;146;146;146;147;147;146;146;147;146 12:00:01 INFO - PROCESS | 28417 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;96 12:00:01 INFO - PROCESS | 28417 | |8;json-parse-financial;51;50;51;51;53;52;52;53;51;53 12:00:01 INFO - PROCESS | 28417 | |9;json-stringify-tinderbox;63;64;62;63;62;63;62;62;62;62 12:00:01 INFO - PROCESS | 28417 | |10;stanford-crypto-aes;80;79;81;84;79;79;83;82;79;80 12:00:01 INFO - PROCESS | 28417 | |11;stanford-crypto-ccm;135;139;139;126;131;131;129;127;171;129 12:00:01 INFO - PROCESS | 28417 | |12;stanford-crypto-pbkdf2;167;163;169;162;163;163;166;164;162;161 12:00:01 INFO - PROCESS | 28417 | |13;stanford-crypto-sha256-iterative;67;66;67;73;65;67;65;65;63;64 12:00:01 INFO - PROCESS | 28417 | __end_tp_report 12:00:01 INFO - PROCESS | 28417 | __start_cc_report 12:00:01 INFO - PROCESS | 28417 | _x_x_mozilla_cycle_collect,1681 12:00:01 INFO - PROCESS | 28417 | __end_cc_report 12:00:01 INFO - PROCESS | 28417 | __startTimestamp1472583601338__endTimestamp 12:00:01 INFO - PROCESS | 28417 | 12:00:01 INFO - PROCESS | 28417 | ------- Summary: start ------- 12:00:01 INFO - PROCESS | 28417 | Number of tests: 14 12:00:01 INFO - PROCESS | 28417 | 12:00:01 INFO - PROCESS | 28417 | [#0] ai-astar Cycles:10 Average:114.30 Median:113.00 stddev:6.33 (5.6%) stddev-sans-first:6.69 12:00:01 INFO - PROCESS | 28417 | Values: 113.0 114.0 132.0 113.0 113.0 112.0 112.0 113.0 110.0 111.0 12:00:01 INFO - PROCESS | 28417 | 12:00:01 INFO - PROCESS | 28417 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:144.50 stddev:21.97 (15.2%) stddev-sans-first:23.30 12:00:01 INFO - PROCESS | 28417 | Values: 142.0 116.0 143.0 173.0 119.0 146.0 148.0 124.0 176.0 116.0 12:00:01 INFO - PROCESS | 28417 | 12:00:01 INFO - PROCESS | 28417 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 12:00:01 INFO - PROCESS | 28417 | Values: 161.0 160.0 160.0 163.0 161.0 162.0 163.0 162.0 161.0 161.0 12:00:01 INFO - PROCESS | 28417 | 12:00:01 INFO - PROCESS | 28417 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.00 stddev:41.62 (54.8%) stddev-sans-first:43.59 12:00:01 INFO - PROCESS | 28417 | Values: 77.0 75.0 77.0 180.0 77.0 75.0 76.0 76.0 169.0 75.0 12:00:01 INFO - PROCESS | 28417 | 12:00:01 INFO - PROCESS | 28417 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:82.00 stddev:33.89 (41.3%) stddev-sans-first:35.14 12:00:01 INFO - PROCESS | 28417 | Values: 83.0 82.0 162.0 82.0 82.0 82.0 144.0 84.0 82.0 150.0 12:00:01 INFO - PROCESS | 28417 | 12:00:01 INFO - PROCESS | 28417 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 12:00:01 INFO - PROCESS | 28417 | Values: 116.0 116.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 12:00:01 INFO - PROCESS | 28417 | 12:00:01 INFO - PROCESS | 28417 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 12:00:01 INFO - PROCESS | 28417 | Values: 146.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 12:00:01 INFO - PROCESS | 28417 | 12:00:01 INFO - PROCESS | 28417 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:00:01 INFO - PROCESS | 28417 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 12:00:01 INFO - PROCESS | 28417 | 12:00:01 INFO - PROCESS | 28417 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:1.06 (2.0%) stddev-sans-first:1.09 12:00:01 INFO - PROCESS | 28417 | Values: 51.0 50.0 51.0 51.0 53.0 52.0 52.0 53.0 51.0 53.0 12:00:01 INFO - PROCESS | 28417 | 12:00:01 INFO - PROCESS | 28417 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 12:00:01 INFO - PROCESS | 28417 | Values: 63.0 64.0 62.0 63.0 62.0 63.0 62.0 62.0 62.0 62.0 12:00:01 INFO - PROCESS | 28417 | 12:00:01 INFO - PROCESS | 28417 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.50 stddev:1.84 (2.3%) stddev-sans-first:1.94 12:00:01 INFO - PROCESS | 28417 | Values: 80.0 79.0 81.0 84.0 79.0 79.0 83.0 82.0 79.0 80.0 12:00:01 INFO - PROCESS | 28417 | 12:00:01 INFO - PROCESS | 28417 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:133.00 stddev:13.22 (9.9%) stddev-sans-first:14.02 12:00:01 INFO - PROCESS | 28417 | Values: 135.0 139.0 139.0 126.0 131.0 131.0 129.0 127.0 171.0 129.0 12:00:01 INFO - PROCESS | 28417 | 12:00:01 INFO - PROCESS | 28417 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.00 Median:163.50 stddev:2.54 (1.6%) stddev-sans-first:2.45 12:00:01 INFO - PROCESS | 28417 | Values: 167.0 163.0 169.0 162.0 163.0 163.0 166.0 164.0 162.0 161.0 12:00:01 INFO - PROCESS | 28417 | 12:00:01 INFO - PROCESS | 28417 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:2.74 (4.1%) stddev-sans-first:2.89 12:00:01 INFO - PROCESS | 28417 | Values: 67.0 66.0 67.0 73.0 65.0 67.0 65.0 65.0 63.0 64.0 12:00:01 INFO - PROCESS | 28417 | -------- Summary: end -------- 12:00:01 INFO - PROCESS | 28417 | 12:00:02 INFO - TEST-INFO | 28417: exit 0 12:00:02 INFO - TEST-OK | kraken | took 61149ms 12:00:02 INFO - SUITE-END | took 1176s 12:00:02 INFO - Completed test suite (00:19:36) 12:00:02 INFO - javascript benchmark 12:00:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2880.078374920025, 2913.9562906556394, 2917.256099694578, 2937.045460225426, 2949.041561492515, 5017.849464516061, 5087.974560127203, 5134.332536770219, 5189.351331083614, 5218.034663587239, 5293.311869456975, 5314.096603577392, 5316.893662126765, 5366.973165134169, 5374.032674118657, 4749.050189962021, 4763.976180119094, 4847.5394837490385, 4847.903041939159, 4926.359573255471, 4914.262860570925, 4927.704337739729, 4963.057019166346, 4980.87547811304, 5010.624203184758, 4685.601723853477, 4714.38712967312, 4795.880102997418, 4852.441969173555, 4905.8773530661665, 4881.365422495089, 4929.580985616227, 4939.728314942677, 4945.381827271591, 4959.727215003173, 4807.399075115611, 4826.155422800995, 4845.127876982142, 4850.223964165716, 4891.779869905863, 5138.537531622134, 5341.385740639837, 5358.866028349284, 5367.0, 5367.919481207746, 5628.183913332585, 5632.183333416672, 5684.54523638108, 5753.395893431213, 5760.423957604248, 5691.630044047124, 5707.74315155819, 5708.400617935098, 5715.571332150105, 5721.7711291548285, 5334.146536554172, 5334.626576139672, 5336.67979921206, 5339.626226164209, 5341.359036915556, 5567.24842146305, 5695.373508914016, 5746.712664366849, 5766.106253530709, 5824.912626310609, 5528.308961379827, 5529.778808847682, 5543.1408131739645, 5569.136783798518, 5571.749271282802, 5605.8598535036135, 5628.127640215773, 5657.462541058593, 5660.801871934463, 5668.688222147822, 5457.181422786613, 5548.91676624851, 5595.4124816894455, 5602.803901863496, 5671.51792097668, 5598.132289495054, 5601.63589366698, 5607.186957891083, 5609.326880774333, 5615.634983726127, 4290.420793192879, 4296.082139427101, 4299.699021068558, 4309.978450107729, 4350.825966961349, 3713.2759111973446, 3838.328292548793, 3866.168773713665, 3899.5515515716056, 3954.4859168308512, 5385.219143224211, 5391.541718953855, 5394.217838413487, 5395.514403703685, 5403.621746477787, 5714.857128571736, 5720.227769251098, 5722.0, 5722.856928576819, 5775.8556036099435, 5162.328897243335, 5176.559992400613, 5187.014467251211, 5225.869353266199, 5263.36839579253, 4587.747673877969, 4596.7931443085145, 4605.424321959755, 4645.907081858344, 4649.837255696102, 5685.658860468385, 5687.800926967537, 5688.829335119953, 5695.345035320908, 5750.0, 5285.920711189412, 5515.917261241165, 5517.062099443185, 5529.391766905717, 5551.944480555143, 5756.539476841926, 5762.078067509178, 5770.278715160605, 5798.739056742541, 5826.854328641818, 5502.119660854244, 5512.6692398456225, 5512.889742205213, 5520.06158952987, 5540.722963851711, 5456.263404440349, 5602.13166959122, 5618.129189975561, 5649.915251271316, 5671.801486947937, 5554.944450555605, 5577.3028371453565, 5589.636673616202, 5635.6618602883955, 5664.915026274527, 5555.944440555704, 5565.0817615094675, 5568.638038527482, 5570.275864137636, 5574.9442505574425, 5225.399079105951, 5477.4796394342475, 5493.505584497414, 5518.144687573433, 5601.691906945157, 5642.7460764266525, 5660.773569057356, 5661.745221464962, 5665.433456654301, 5709.0865461525955, 5525.060739674345, 5526.861828454321, 5527.2538207341495, 5532.557395408438, 5534.695591742493], "value": 5196.505672028156, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.5313723922948, 557.4954666027246, 585.6369051188262, 592.2626330218875, 629.9905501417477, 31371.372572548564, 41293.58706412935, 42406.787966060125, 42428.36357454633, 42453.93865153377, 44222.77888610552, 44583.55416445834, 44681.776591117, 44715.0, 44757.77621111898, 8092.959535202316, 8887.111288871125, 9025.18773310402, 9034.638614455447, 9038.864417033717, 10297.897021029807, 10629.468526573679, 10636.734081647983, 10959.178061645369, 10973.50619222137, 10809.83785243222, 10915.072218861405, 10917.290376125526, 10923.634545681789, 10948.562057517729, 10691.946540267289, 10743.946280268548, 10756.19328550362, 10763.300385474959, 10769.084627806646, 10661.0, 10728.624498142606, 10735.731606709816, 10736.516856741388, 10740.73148171294, 41418.58581414178, 41716.0, 41718.79140604308, 41758.79120604408, 41786.0, 3583.0, 3605.0266428064274, 3679.908002299937, 3733.1600389912323, 3736.57029441615, 31355.216119596964, 31668.683313166803, 32188.517172242435, 32420.027399178063, 32937.505937410955, 4141.607300325962, 4286.39990401344, 4334.674899382559, 4395.252807022814, 4404.515503294635, 335122.0, 337910.0, 338132.0, 338713.0, 338868.99999999756, 36141.0, 56355.15467267994, 56761.43238567644, 56765.43234567684, 56796.432035679114, 36943.445848312294, 37049.444258336145, 37170.25659486795, 37219.813900930865, 37369.0, 15437.691246175014, 15638.374465021272, 15657.217139142997, 15672.843271567366, 15679.529614111367, 11088.889111108947, 11327.886721132849, 12933.159344642569, 13092.607221783363, 13105.67235819093, 8138.3896207784655, 8201.71294004707, 8346.916530834735, 8555.187257210555, 8585.399022068395, 3297.1757060734817, 3335.6997870191312, 3362.9327413451592, 3367.2760356523463, 3401.829908504565, 978.8531720241879, 988.051470588229, 990.3760630802692, 1002.9598816047422, 1039.8908114648004, 30722.846385767927, 30880.691193087783, 31313.530297045563, 31407.84296078505, 31468.842655787033, 1046.4453839465095, 1059.6079450603327, 1107.3909349857547, 1123.084685980923, 1158.2124155574122, 15881.920590397205, 16344.509664710078, 16436.342546298016, 16474.341026358812, 16538.353863381803, 576088.0, 582604.0, 582641.0, 582894.0, 583428.0, 56843.33663277253, 57616.71191644015, 57619.42380576224, 57648.71175644095, 57672.13491797626, 1309.2668105860748, 1344.395022239996, 1346.098114263446, 1357.850636429992, 1363.0458678924792, 29082.854585726935, 30452.84773576118, 30528.236794080327, 30608.234794130323, 31133.0, 48981.0, 49291.753541232065, 49410.505894940594, 49445.752771235915, 49447.75276123596, 377765.0, 378230.0, 378418.0, 378985.0, 379299.0, 26508.734912650627, 26732.599011014463, 28142.215823309678, 29130.854345728134, 29138.0, 36089.0, 39445.436046656876, 46278.0, 46742.06515869732, 47667.0, 39276.41085383664, 40670.79664601658, 41813.372799408644, 41818.37272440977, 42931.7853410731, 40506.0, 41151.0, 41281.58718412778, 42398.0, 42406.78796605997, 39062.804685976385, 39207.60792392154, 40252.7987360073, 40390.79804600958, 42712.0, 32582.67417325891, 36491.27017459689, 37021.44467832931, 37271.44092838664, 37754.43368349422, 27080.0, 27475.587866181624, 27511.31221719473, 27618.86190569115, 27775.583366249928], "value": 19006.624277527724, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.964453199212, 396.1008510680755, 400.0079802090815, 402.4044414266886, 419.31442092179276, 12741.22229055022, 18190.545236369082, 20099.095540700666, 20174.39476815696, 20719.482012949684, 15277.465288714897, 15400.61498462539, 15883.92058039711, 18823.247070117213, 19472.610547789034, 5605.159226116074, 5621.381648018725, 5806.332271788735, 5816.418358164192, 5824.0390335594575, 5642.266505354298, 5740.167675687023, 5747.626404283729, 5779.537636989052, 5791.276090488689, 5563.13771365439, 5749.281339832521, 5755.971220143914, 5760.884782304352, 5763.337216220126, 5745.741441635116, 5879.088741245114, 5917.970410147965, 5923.851903702399, 5924.792632257871, 5569.387367389584, 5682.54539636828, 5729.656220626775, 5738.282714660668, 5745.425457454263, 14336.856631433657, 14562.199079050648, 14568.562943111723, 18054.548636284067, 23136.53726925452, 2326.453283478398, 2373.2524254859663, 2441.4628781668002, 2832.3768770870583, 2867.3405116823246, 10373.429461379621, 10566.471676416148, 10739.0, 12870.871291287061, 13170.736585268336, 1829.478598599406, 1884.6042331110484, 1896.2699360746074, 1915.8136734358784, 1962.9018549072632, 83702.58148709217, 85810.57094714486, 87504.06199225096, 88952.0, 88953.0, 10567.682969510926, 10587.735306617396, 11019.173561982883, 11041.447927603587, 11392.0, 14714.779278310834, 14765.852341476662, 14768.261586920611, 14799.778003329959, 14865.479708210161, 7541.095068591694, 7799.3760499159935, 7873.842523149619, 7954.562499062491, 8123.715669951642, 7288.854222915512, 7346.595937223504, 7413.443991700644, 7499.362554182846, 7587.430942679322, 4619.23782575878, 4622.560856718606, 4635.559621835921, 4673.25227963531, 4858.17411040124, 1915.4636701723539, 1923.7787654419922, 1934.6227485640165, 1970.8076613648823, 1994.7107669387858, 830.9376796740269, 932.2122806228726, 932.4218984229685, 955.412421360858, 1001.2240513602017, 18385.724214136797, 19742.90128549348, 19922.978432964726, 20013.699794503093, 20066.89966550158, 879.678917195232, 927.6521304510809, 936.8641546975787, 952.8513202727804, 967.3953778888194, 10493.475326233658, 10781.299215550964, 10957.671269861758, 11086.944565277283, 11100.44497775108, 471289.0, 471348.0, 484771.0, 487729.0, 492271.0, 90207.0, 91790.54104729433, 91872.54063729639, 92246.53876730573, 92909.0, 973.4256788494963, 1009.8788145422596, 1035.772130131385, 1039.3036665434176, 1041.8541404203418, 16531.421400250932, 16903.070331131905, 17412.216450259515, 17463.214155362784, 17767.111644417986, 42314.556971517544, 42600.360994585724, 42713.0, 42940.0, 43828.56171438245, 53543.73228133834, 57498.7125064372, 57903.71048144901, 57906.0, 58641.82716345564, 5364.195370694427, 7907.604619769104, 8475.279601233964, 8572.228499435081, 8954.686585969459, 7239.746608868664, 10028.64899728506, 11168.771435141965, 13222.206667599974, 13704.040717149705, 10857.619983300863, 11114.944425277821, 11537.0, 11634.0, 11893.286402815858, 11457.942710286396, 11695.12286578493, 11881.940590296994, 11890.34603096838, 12135.635930922086, 11425.200235983733, 11608.12939029593, 11614.6515604532, 12275.447604857623, 12345.0, 8274.544900030556, 8529.317654587741, 8691.304695624462, 8693.0, 8778.868316975122, 9785.608575656894, 10681.252312338062, 11089.33463992163, 11596.884031159918, 11969.940150299193], "value": 9038.62248563127, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1239.6838806104442, 1314.9013823963194, 1315.7697402954486, 1349.9932500337497, 1747.1613625459786, 7951.244631759981, 8369.707060252886, 8379.455335403201, 8614.267787238077, 8633.784155396103, 8338.91661083389, 8441.366897482698, 8441.662333506667, 8447.0, 8453.154684531544, 2320.466292752664, 2331.5570041692026, 2332.5334933013382, 2338.2283846330756, 2339.1462116327502, 2294.070901284974, 2346.9647955280598, 2348.5655153796515, 2351.1888398502488, 2352.6000579901456, 2305.07796881248, 2317.559663663907, 2319.257837491995, 2355.316958082154, 2355.8468699534474, 2241.6413373860105, 2272.363738153328, 2272.4659704969317, 2286.039863257436, 2303.2053941390195, 2268.6143355629583, 2271.375371772759, 2271.4775601611555, 2274.101729816713, 2276.1009401286565, 8309.127541608104, 8373.916260837375, 8465.788355291106, 8470.237678608955, 8474.87287690679, 4805.8558243252755, 4978.477259887696, 4982.352294201731, 4987.351644286219, 4997.950020499785, 2977.3152174999655, 3122.609673790776, 3167.129039514129, 3178.300773829754, 3183.697548732867, 1037.5331101004579, 1049.2969710294121, 1049.422817450407, 1051.2220956492217, 1078.2613909472036, 11211.327320360722, 11351.148663850245, 11364.431778411046, 11376.715582110432, 11437.027852632536, 4026.134381108076, 4127.8968025798995, 4139.482564679415, 4295.420118284054, 4302.698811083257, 8829.558522074, 8860.069692682304, 8931.642734290686, 8947.642094316154, 8949.686760963465, 4765.11845308619, 4765.594924431392, 4776.95223047772, 4787.569118779326, 4791.448983366888, 3700.4634328022285, 3821.904452388657, 3917.196974620196, 3922.392029235416, 4428.82284708608, 3533.717302615785, 3648.2521083177885, 3683.723720720957, 3700.981495092561, 3701.1672373715696, 1097.8627671541058, 1115.1524841120806, 1115.9721006974892, 1118.0440723181562, 1124.7188202949262, 938.8967213606497, 968.8352979993418, 983.257640481432, 996.7009897030862, 1001.884783249921, 5571.554275657938, 5652.519535839418, 5654.802081927113, 5770.798022069292, 5927.407259274038, 477.59404506169477, 480.0782497604608, 482.62596487721595, 488.3821965214007, 490.5045903637352, 3923.352646813301, 4047.251258517184, 4070.3690927906223, 4108.424820525129, 4128.8348466061625, 9957.502124893872, 10247.84628230577, 10334.379937203792, 10341.37951722899, 10371.585136594602, 10262.794744105226, 10266.538005789758, 10270.743231419274, 10291.94854025725, 10295.485225738683, 7745.806354841061, 7749.612519374009, 7794.103678077094, 7794.6882124714375, 7823.804404889924, 5704.486596206361, 5785.772477596071, 5802.216700745515, 5953.821385358447, 6119.112728654409, 9053.954730226307, 9359.391639543408, 9428.10433008863, 9467.95266023693, 9477.24182065447, 9748.756281093029, 9752.609895604097, 9766.21870250364, 9775.657851975147, 9785.021497850443, 6773.932260677528, 6941.791746247621, 6979.0, 7060.8940865886025, 7300.233475484997, 8012.679492820222, 8066.959665201871, 8074.757757267292, 8075.192480751878, 8103.189681031849, 7080.114985626797, 7390.371818395497, 7434.182239953709, 7531.3974882008215, 7565.924340756522, 7030.086088808423, 7038.753643622448, 7193.352598266181, 7223.747168849065, 7493.175750667313, 6644.435223006099, 6781.694823732845, 6786.796396108125, 6815.0, 6835.384815366641, 4999.150144475375, 5104.642675012862, 5122.923156152735, 5125.897482050413, 5364.2490051393615, 5118.610421836228, 5153.484651534816, 5364.597655175799, 5379.892402152013, 5397.59518036141], "value": 4323.2619552991355, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.24733135138365, 324.27848038115195, 329.69173822476, 331.5308837994237, 334.5099429336023, 5146.6140039497, 5160.612954028444, 5163.690178589287, 5177.482251774821, 5180.663256888304, 5113.667611605243, 5121.846344609658, 5125.8462246132585, 5130.743462826853, 5151.665141765782, 3956.4658771065824, 4080.6123418275215, 4080.7755573443596, 4082.3876418537307, 4099.323611604089, 4060.776657283848, 4087.5299340575766, 4093.3246014407737, 4099.7745124018165, 4101.835926562949, 4011.7994100295014, 4019.618136277049, 4052.9189416211657, 4061.0862555924828, 4062.614051665087, 3805.1818858945185, 3890.319194141014, 4007.418924255981, 4024.7987600620145, 4027.416024676435, 3541.7780865601326, 3561.5013898054294, 3563.5901871284873, 3568.8750893718593, 3569.1077230692326, 5010.774515146791, 5011.874703132415, 5020.673656212334, 5030.773615187325, 5035.622328325354, 4337.0, 4390.802413891351, 4516.90591944519, 4523.864284071483, 4537.342085397632, 5244.606654500928, 5286.6035047371215, 5289.365276166846, 5302.621318457191, 5302.708351040691, 3948.960510394888, 3953.98023009886, 3961.8019099045223, 3963.0, 3969.920601587981, 5285.0, 5539.390667026624, 5544.722763861791, 5550.72246387679, 5560.304961879765, 3895.6883449323986, 3913.2369188008634, 3933.8819835404984, 3937.291287568265, 3940.724149309578, 3979.403089536535, 3979.8010099495486, 3981.044549308145, 3988.8404463821703, 4001.239764444804, 4554.681172317973, 4569.177548041318, 4570.291604801261, 4571.400009996474, 4581.816727330869, 5122.92315615266, 5367.329083864517, 5384.865378365572, 5388.137897936312, 5394.3796463406425, 1363.6522686714825, 1376.7040086381476, 1377.793331000358, 1379.6412932637586, 1384.7161331926932, 849.5752123938031, 889.479654402182, 899.8920129584492, 900.4327273817584, 914.6661468563926, 4578.496365399803, 4634.72191668501, 4636.83771068011, 4637.907241855211, 4645.883852903637, 4845.466998630148, 4848.903021939612, 4864.964761471931, 4876.853694389174, 4892.483330167659, 4435.844745433894, 4602.608778253886, 4641.373414589055, 4645.74448405341, 4647.744374059459, 2571.048711976543, 2613.9607905881426, 2771.6673999120235, 2855.528837741749, 2919.0, 5662.13149660611, 5670.149477578396, 5672.205891175238, 5677.120046392815, 5698.715064246771, 5386.649867758583, 5603.327600687862, 5608.0, 5619.353774315924, 5620.269364982608, 5601.80393686219, 5644.0, 5678.801241956512, 5699.173619825185, 5703.942960570507, 5452.781888724407, 5500.202470641814, 5507.228987941771, 5522.723863806713, 5526.668399896019, 5266.78932842682, 5418.972905135607, 5458.263134476795, 5479.424660410599, 5479.753411096431, 5616.241807355955, 5624.803131890364, 5649.0, 5664.773409063591, 5665.688387138747, 3902.863399780994, 3921.92156156881, 3930.1157239620857, 3933.4296527004, 3959.703022273399, 5333.0, 5389.487998640123, 5436.456354364532, 5462.453754624506, 5497.257870187474, 5363.881266899631, 5367.3827509836865, 5381.919271211013, 5382.892342153056, 5385.703786291791, 5359.169328754049, 5359.437259087739, 5363.865903352447, 5375.784968601212, 5376.247325374373, 5038.949610503994, 5318.494742999409, 5319.840404787863, 5345.358556973188, 5347.459956520777, 5332.413434522277, 5398.514133727984, 5405.459454054563, 5410.621256512007, 5416.539594134542, 5034.924476132935, 5218.895622087461, 5220.373555173252, 5251.711155886463, 5265.604150111613], "value": 4054.605729058226, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.5847067171711, 746.1344839985618, 759.2407592407592, 816.9019717633881, 825.3232349473433, 14866.628334291649, 15211.46759863405, 15912.761308580351, 16117.435889743861, 16162.595935101628, 15046.0, 15428.845711542881, 15443.0, 15446.073235605843, 15449.0, 663.7643636509042, 793.464411522223, 800.2877439079239, 816.0370762500247, 819.4550623835142, 811.6591031766673, 823.0987069159291, 825.896762904637, 826.8553003224412, 827.1976183102411, 856.2422256303154, 864.9870251946226, 865.8484765166103, 865.9307255419583, 867.2281669314284, 690.6822861483723, 832.3590835056972, 857.3012994409536, 858.8625819868822, 859.3640705877668, 618.2797041446754, 626.0890404461543, 626.2735227136545, 626.3454689849119, 626.7743612299569, 14459.0, 14488.565343039725, 14488.927555362261, 14529.564113076625, 14595.41618335276, 13415.3963071662, 13441.596752097452, 14037.859621403757, 14178.503752368617, 14252.21612811295, 12903.0, 12943.569953962207, 13052.869471305356, 13092.607221783363, 13180.934095329461, 4203.936940945889, 4237.5377549237355, 4318.676099292534, 4321.783910804447, 4330.090680957002, 79816.60091699562, 79819.0, 79860.0, 80005.19994800036, 80351.59824200842, 10462.372257664565, 10561.471926403648, 10574.841377379345, 11065.612703555498, 11164.609238676607, 19017.714734278998, 20733.377998660064, 20972.37082887516, 21095.0, 21148.365549033555, 8073.7577872663915, 8148.144444833326, 8164.550949697824, 8171.346292296602, 8179.877301840477, 4380.846670366522, 4497.730136191839, 4578.0, 4643.907121857544, 4653.534646535387, 3155.731762800188, 3266.803991760502, 3271.2803183299634, 3294.7364210863075, 3307.9173020674675, 562.6033646279363, 571.0549041336594, 571.2459553389486, 576.8903908257417, 587.2659176029963, 605.0953824033011, 646.424682032991, 662.3839828959018, 669.8291935556402, 692.6190595172635, 8382.0, 8715.694950676696, 8726.476411415335, 8923.196912277926, 9087.545622718837, 490.5903570518657, 532.305341529308, 535.1384271323167, 582.5921854701726, 595.6396380190009, 4135.627793498539, 4361.498427680857, 4591.747453890001, 5059.848204553869, 5104.285400043997, 114669.42665286787, 121005.0, 122652.38673806573, 123831.3808430952, 123939.3803030979, 85158.0, 105228.47385763022, 105787.47106264574, 106569.0, 108238.0, 62813.0, 80646.0, 87931.7240965544, 90653.0, 91936.0, 9323.0, 9379.953100234728, 9510.239180865652, 9512.524373781422, 9519.61921523159, 52698.9460210786, 53106.46893531015, 53490.19764703455, 55369.72315138399, 56675.43324566867, 46134.0, 47239.0, 47718.0, 54944.45055549393, 75514.62242688751, 13367.331633418486, 13438.865611343761, 13557.457701691821, 13748.450061997808, 13894.513692021135, 14590.854091459374, 15062.0, 15501.224938752792, 15545.611359716098, 15611.453599123975, 14078.0, 14707.41170353174, 14770.556883293519, 14878.702425951637, 15033.624159396102, 13115.606531804062, 13349.66625834323, 13853.376598053314, 14194.503192388216, 14594.562163135122, 13483.325833708472, 13610.93194534021, 13985.790213147015, 14023.158610483404, 14661.413543458142, 10438.269321147447, 10445.895541044796, 10487.94756026215, 10569.577216911237, 10700.250982431155, 11179.888201117885, 11390.711282865252, 11596.304221746723, 11627.244229125079, 11694.649160525198], "value": 7423.126557970668, "unit": "score"}], "name": "dromaeo_css", "value": 6985.307530635994, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 132.0, 113.0, 113.0, 112.0, 112.0, 113.0, 110.0, 111.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 116.0, 143.0, 173.0, 119.0, 146.0, 148.0, 124.0, 176.0, 116.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 163.0, 161.0, 162.0, 163.0, 162.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 77.0, 180.0, 77.0, 75.0, 76.0, 76.0, 169.0, 75.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 162.0, 82.0, 82.0, 82.0, 144.0, 84.0, 82.0, 150.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 51.0, 53.0, 52.0, 52.0, 53.0, 51.0, 53.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 81.0, 84.0, 79.0, 79.0, 83.0, 82.0, 79.0, 80.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 139.0, 139.0, 126.0, 131.0, 131.0, 129.0, 127.0, 171.0, 129.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 169.0, 162.0, 163.0, 163.0, 166.0, 164.0, 162.0, 161.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 73.0, 65.0, 67.0, 65.0, 65.0, 63.0, 64.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1533.6, "alertThreshold": 2.0}]} 12:00:02 INFO - Return code: 0 12:00:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:00:02 INFO - # TBPL SUCCESS # 12:00:02 INFO - Running post-action listener: _resource_record_post_action 12:00:02 INFO - [mozharness: 2016-08-30 19:00:02.676511Z] Finished run-tests step (success) 12:00:02 INFO - Running post-run listener: _resource_record_post_run 12:00:02 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 425717760; Read time: 0; Write time: 259976 12:00:02 INFO - TinderboxPrint: CPU usage
13.0% 12:00:02 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:00:02 INFO - TinderboxPrint: I/O write bytes / time
425,717,760 / 259,976 12:00:02 INFO - TinderboxPrint: CPU idle
8,282.7 (86.9%) 12:00:02 INFO - TinderboxPrint: CPU user
1,194.0 (12.5%) 12:00:02 INFO - TinderboxPrint: Swap in / out
0 / 0 12:00:02 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 135294976; Read time: 0; Write time: 82800 12:00:02 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 290422784; Read time: 0; Write time: 177176 12:00:03 INFO - Running post-run listener: _upload_blobber_files 12:00:03 INFO - Blob upload gear active. 12:00:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:00:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:00:03 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:00:03 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:00:03 INFO - (blobuploader) - INFO - Open directory for files ... 12:00:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:00:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:00:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:05 INFO - (blobuploader) - INFO - Done attempting. 12:00:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:00:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:00:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:13 INFO - (blobuploader) - INFO - Done attempting. 12:00:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:00:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:00:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:00:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:14 INFO - (blobuploader) - INFO - Done attempting. 12:00:14 INFO - (blobuploader) - INFO - Iteration through files over. 12:00:14 INFO - Return code: 0 12:00:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:00:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:00:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/498a57c3e0a54d0e3a7c634041765d5f5a8c4122d41b5b4407182b503e1e39b45670cff1a7028e06a37bf8ce1c63f0008f4ae859a648ad3d6e6576f19a493c16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc9425aa506415adebdcf05ffad55ba36f77d11789a010701d1e2ad57e4f2e64ac8cd6cb11ad9727044406aad5dd26a6253379ef6345e022912afdf3edaa7b7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f3481d6736481aa678ccae64cf95cb2d2a51b3b17da7cfdad6c3902bbe6bbb85444bcdca1c0dd49ede5a2cee4351a64653e1e7c153ccb7caf7e45983318f034"} 12:00:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:00:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:00:14 INFO - Contents: 12:00:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/498a57c3e0a54d0e3a7c634041765d5f5a8c4122d41b5b4407182b503e1e39b45670cff1a7028e06a37bf8ce1c63f0008f4ae859a648ad3d6e6576f19a493c16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc9425aa506415adebdcf05ffad55ba36f77d11789a010701d1e2ad57e4f2e64ac8cd6cb11ad9727044406aad5dd26a6253379ef6345e022912afdf3edaa7b7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f3481d6736481aa678ccae64cf95cb2d2a51b3b17da7cfdad6c3902bbe6bbb85444bcdca1c0dd49ede5a2cee4351a64653e1e7c153ccb7caf7e45983318f034"} 12:00:14 INFO - Running post-run listener: copy_logs_to_upload_dir 12:00:14 INFO - Copying logs to upload dir... 12:00:14 INFO - mkdir: /builds/slave/test/build/upload/logs 12:00:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.197760 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-08-30 12:00:13.361869) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 12:00:13.365154) ========= 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=923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841 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/sha512/498a57c3e0a54d0e3a7c634041765d5f5a8c4122d41b5b4407182b503e1e39b45670cff1a7028e06a37bf8ce1c63f0008f4ae859a648ad3d6e6576f19a493c16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc9425aa506415adebdcf05ffad55ba36f77d11789a010701d1e2ad57e4f2e64ac8cd6cb11ad9727044406aad5dd26a6253379ef6345e022912afdf3edaa7b7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f3481d6736481aa678ccae64cf95cb2d2a51b3b17da7cfdad6c3902bbe6bbb85444bcdca1c0dd49ede5a2cee4351a64653e1e7c153ccb7caf7e45983318f034"} build_url:https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011288 build_url: 'https://queue.taskcluster.net/v1/task/bszOnNwiR4SpXJPInUk5CA/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/sha512/498a57c3e0a54d0e3a7c634041765d5f5a8c4122d41b5b4407182b503e1e39b45670cff1a7028e06a37bf8ce1c63f0008f4ae859a648ad3d6e6576f19a493c16", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc9425aa506415adebdcf05ffad55ba36f77d11789a010701d1e2ad57e4f2e64ac8cd6cb11ad9727044406aad5dd26a6253379ef6345e022912afdf3edaa7b7a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f3481d6736481aa678ccae64cf95cb2d2a51b3b17da7cfdad6c3902bbe6bbb85444bcdca1c0dd49ede5a2cee4351a64653e1e7c153ccb7caf7e45983318f034"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 12:00:13.390601) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 12:00:13.390977) ========= 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=923d835db2ba3686ebe126b700000192-1472582310.117419-1016408841 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 12:00:13.474691) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 12:00:13.475195) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 12:00:13.475715) ========= ========= Total master_lag: 0.45 =========