builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1472753330.84 results: success (0) buildid: 20160901083012 builduid: efe5c9308569439094c42b733c299957 revision: aa1a7886af087c5c13cd087ac1c67dac7e553492 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 11:08:50.837342) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 11:08:50.838113) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 11:08:50.839129) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 11:08:50.882415) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 11:08:50.883017) ========= 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=d2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 11:08:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-09-01 11:08:51 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124919 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 11:08:51.032148) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 11:08:51.032734) ========= 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=d2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023201 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 11:08:51.093714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 11:08:51.094309) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev aa1a7886af087c5c13cd087ac1c67dac7e553492 --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 aa1a7886af087c5c13cd087ac1c67dac7e553492 --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=d2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 11:08:51,234 truncating revision to first 12 chars 2016-09-01 11:08:51,234 Setting DEBUG logging. 2016-09-01 11:08:51,234 attempt 1/10 2016-09-01 11:08:51,234 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/aa1a7886af08?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 11:08:51,552 unpacking tar archive at: fx-team-aa1a7886af08/testing/mozharness/ program finished with exit code 0 elapsedTime=0.713509 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 11:08:51.828017) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 11:08:51.828328) ========= script_repo_revision: aa1a7886af087c5c13cd087ac1c67dac7e553492 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 11:08:51.828749) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 11:08:51.829043) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 11:08:51.840820) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-01 11:08:51.841125) ========= /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=d2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:08:52 INFO - MultiFileLogger online at 20160901 11:08:52 in /builds/slave/test 11:08:52 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:08:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:08:52 INFO - {'append_to_log': False, 11:08:52 INFO - 'base_work_dir': '/builds/slave/test', 11:08:52 INFO - 'blob_upload_branch': 'Fx-Team', 11:08:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:08:52 INFO - 'branch': 'Fx-Team', 11:08:52 INFO - 'buildbot_json_path': 'buildprops.json', 11:08:52 INFO - 'config_files': ('talos/linux_config.py',), 11:08:52 INFO - 'default_actions': ('clobber', 11:08:52 INFO - 'read-buildbot-config', 11:08:52 INFO - 'download-and-extract', 11:08:52 INFO - 'populate-webroot', 11:08:52 INFO - 'create-virtualenv', 11:08:52 INFO - 'install', 11:08:52 INFO - 'run-tests'), 11:08:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:08:52 INFO - 'download_minidump_stackwalk': True, 11:08:52 INFO - 'download_symbols': 'ondemand', 11:08:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:08:52 INFO - 'tooltool.py': '/tools/tooltool.py', 11:08:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:08:52 INFO - '/tools/misc-python/virtualenv.py')}, 11:08:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:08:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:08:52 INFO - 'installer_path': 'installer.exe', 11:08:52 INFO - 'log_level': 'info', 11:08:52 INFO - 'log_name': 'talos', 11:08:52 INFO - 'log_to_console': True, 11:08:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:08:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:08:52 INFO - 'opt_config_files': (), 11:08:52 INFO - 'pip_index': False, 11:08:52 INFO - 'sps_profile': False, 11:08:52 INFO - 'sps_profile_interval': 0, 11:08:52 INFO - 'suite': 'dromaeojs', 11:08:52 INFO - 'system_bits': '32', 11:08:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:08:52 INFO - 'title': 'talos-linux64-ix-043', 11:08:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:08:52 INFO - 'use_talos_json': True, 11:08:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:08:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:08:52 INFO - 'work_dir': 'build'} 11:08:52 INFO - [mozharness: 2016-09-01 18:08:52.074312Z] Running clobber step. 11:08:52 INFO - Running pre-action listener: _resource_record_pre_action 11:08:52 INFO - Running main action method: clobber 11:08:52 INFO - rmtree: /builds/slave/test/build 11:08:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:08:52 INFO - Running post-action listener: _resource_record_post_action 11:08:52 INFO - [mozharness: 2016-09-01 18:08:52.539973Z] Finished clobber step (success) 11:08:52 INFO - [mozharness: 2016-09-01 18:08:52.540074Z] Running read-buildbot-config step. 11:08:52 INFO - Running pre-action listener: _resource_record_pre_action 11:08:52 INFO - Running main action method: read_buildbot_config 11:08:52 INFO - Using buildbot properties: 11:08:52 INFO - { 11:08:52 INFO - "project": "", 11:08:52 INFO - "product": "firefox", 11:08:52 INFO - "script_repo_revision": "production", 11:08:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:08:52 INFO - "repository": "", 11:08:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:08:52 INFO - "buildid": "20160901083012", 11:08:52 INFO - "pgo_build": "True", 11:08:52 INFO - "basedir": "/builds/slave/test", 11:08:52 INFO - "buildnumber": 1519, 11:08:52 INFO - "slavename": "talos-linux64-ix-043", 11:08:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:08:52 INFO - "platform": "ubuntu64_hw", 11:08:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:08:52 INFO - "branch": "fx-team", 11:08:52 INFO - "repo_path": "integration/fx-team", 11:08:52 INFO - "revision": "aa1a7886af087c5c13cd087ac1c67dac7e553492", 11:08:52 INFO - "stage_platform": "linux64-pgo", 11:08:52 INFO - "builduid": "efe5c9308569439094c42b733c299957", 11:08:52 INFO - "slavebuilddir": "test" 11:08:52 INFO - } 11:08:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:08:52 INFO - Running post-action listener: _resource_record_post_action 11:08:52 INFO - [mozharness: 2016-09-01 18:08:52.542552Z] Finished read-buildbot-config step (success) 11:08:52 INFO - [mozharness: 2016-09-01 18:08:52.542643Z] Running download-and-extract step. 11:08:52 INFO - Running pre-action listener: _resource_record_pre_action 11:08:52 INFO - Running main action method: download_and_extract 11:08:52 INFO - mkdir: /builds/slave/test/build/tests 11:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:52 INFO - trying https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:08:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/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:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/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:08:53 INFO - Downloaded 1361 bytes. 11:08:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:08:53 INFO - Using the following test package requirements: 11:08:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:08:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:08:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:08:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:53 INFO - u'jsshell-linux-x86_64.zip'], 11:08:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:08:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:08:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:08:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:08:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:08:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:08:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:08:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:53 INFO - trying https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:08:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/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:08:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/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:08:53 INFO - Downloaded 21905498 bytes. 11:08:53 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:08:58 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:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:08:58 INFO - trying https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:08:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/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:08:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/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:08:59 INFO - Downloaded 21905498 bytes. 11:08:59 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:09: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:09:03 INFO - trying https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:09:03 INFO - Downloading https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/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:09:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/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:09:04 INFO - Downloaded 14413998 bytes. 11:09:04 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:09:04 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:09:04 INFO - trying https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:09:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/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:09:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/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:09:05 INFO - Downloaded 59720269 bytes. 11:09:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:09:05 INFO - mkdir: /builds/slave/test/properties 11:09:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:09:05 INFO - Writing to file /builds/slave/test/properties/build_url 11:09:05 INFO - Contents: 11:09:05 INFO - build_url:https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:09:06 INFO - Running post-action listener: _resource_record_post_action 11:09:06 INFO - Running post-action listener: set_extra_try_arguments 11:09:06 INFO - [mozharness: 2016-09-01 18:09:06.512187Z] Finished download-and-extract step (success) 11:09:06 INFO - [mozharness: 2016-09-01 18:09:06.512488Z] Running populate-webroot step. 11:09:06 INFO - Running pre-action listener: _resource_record_pre_action 11:09:06 INFO - Running main action method: populate_webroot 11:09:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:09:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:09:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:09:06 INFO - '--tppagecycles', 11:09:06 INFO - '7'], 11:09:06 INFO - 'tests': ['tsvgm']}}, 11:09:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:09:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:09:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:09:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:09:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:06 INFO - 'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:06 INFO - 'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['damp', 'tps']}, 11:09:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:06 INFO - 'tests': ['damp', 'tps']}, 11:09:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['dromaeo_dom']}, 11:09:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:09:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['basic_compositor_video']}, 11:09:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:09:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['a11yr', 11:09:06 INFO - 'ts_paint', 11:09:06 INFO - 'tpaint', 11:09:06 INFO - 'sessionrestore', 11:09:06 INFO - 'sessionrestore_no_auto_restore', 11:09:06 INFO - 'tabpaint']}, 11:09:06 INFO - 'other-e10s': {'tests': ['a11yr', 11:09:06 INFO - 'ts_paint', 11:09:06 INFO - 'tpaint', 11:09:06 INFO - 'sessionrestore', 11:09:06 INFO - 'sessionrestore_no_auto_restore', 11:09:06 INFO - 'tabpaint']}, 11:09:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:09:06 INFO - 'ts_paint', 11:09:06 INFO - 'tpaint', 11:09:06 INFO - 'sessionrestore', 11:09:06 INFO - 'sessionrestore_no_auto_restore', 11:09:06 INFO - 'tabpaint']}, 11:09:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:09:06 INFO - 'ts_paint', 11:09:06 INFO - 'tpaint', 11:09:06 INFO - 'sessionrestore', 11:09:06 INFO - 'sessionrestore_no_auto_restore', 11:09:06 INFO - 'tabpaint']}, 11:09:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['a11yr', 11:09:06 INFO - 'ts_paint', 11:09:06 INFO - 'tpaint', 11:09:06 INFO - 'sessionrestore', 11:09:06 INFO - 'sessionrestore_no_auto_restore', 11:09:06 INFO - 'tabpaint']}, 11:09:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['a11yr', 11:09:06 INFO - 'ts_paint', 11:09:06 INFO - 'tpaint', 11:09:06 INFO - 'sessionrestore', 11:09:06 INFO - 'sessionrestore_no_auto_restore', 11:09:06 INFO - 'tabpaint']}, 11:09:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['tsvgx', 11:09:06 INFO - 'tsvgr_opacity', 11:09:06 INFO - 'tart', 11:09:06 INFO - 'tscrollx', 11:09:06 INFO - 'cart']}, 11:09:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:09:06 INFO - 'tsvgr_opacity', 11:09:06 INFO - 'tart', 11:09:06 INFO - 'tscrollx', 11:09:06 INFO - 'cart']}, 11:09:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:06 INFO - 'talos_options': ['--disable-e10s'], 11:09:06 INFO - 'tests': ['tp5o']}, 11:09:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:06 INFO - 'tests': ['tp5o']}, 11:09:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:06 INFO - 'talos_options': ['--disable-e10s', 11:09:06 INFO - '--xperf_path', 11:09:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:06 INFO - 'tests': ['tp5n']}, 11:09:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:06 INFO - 'talos_options': ['--xperf_path', 11:09:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:06 INFO - 'tests': ['tp5n']}}, 11:09:06 INFO - 'talos.zip': {'path': '', 11:09:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:09:06 INFO - Running post-action listener: _resource_record_post_action 11:09:06 INFO - [mozharness: 2016-09-01 18:09:06.533224Z] Finished populate-webroot step (success) 11:09:06 INFO - [mozharness: 2016-09-01 18:09:06.533318Z] Running create-virtualenv step. 11:09:06 INFO - Running pre-action listener: _resource_record_pre_action 11:09:06 INFO - Running main action method: create_virtualenv 11:09:06 INFO - Creating virtualenv /builds/slave/test/build/venv 11:09:06 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:09:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:09:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:09:06 INFO - Using real prefix '/usr' 11:09:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:09:07 INFO - Installing distribute.............................................................................................................................................................................................done. 11:09:09 INFO - Installing pip.................done. 11:09:09 INFO - Return code: 0 11:09:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb5b634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1300850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fb370>, '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 0x12fe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12fed80>, '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': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', '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:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:09:09 INFO - Using env: {'DISPLAY': ':0', 11:09:09 INFO - 'HOME': '/home/cltbld', 11:09:09 INFO - 'LANG': 'en_US.UTF-8', 11:09:09 INFO - 'LANGUAGE': 'en_US:en', 11:09:09 INFO - 'LOGNAME': 'cltbld', 11:09:09 INFO - 'MAIL': '/var/mail/cltbld', 11:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:09 INFO - 'MOZ_NO_REMOTE': '1', 11:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:09 INFO - 'NO_EM_RESTART': '1', 11:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:09 INFO - 'PWD': '/builds/slave/test', 11:09:09 INFO - 'SHELL': '/bin/bash', 11:09:09 INFO - 'SHLVL': '1', 11:09:09 INFO - 'TERM': 'linux', 11:09:09 INFO - 'TMOUT': '86400', 11:09:09 INFO - 'USER': 'cltbld', 11:09:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', 11:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:09 INFO - '_': '/tools/buildbot/bin/python'} 11:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:09 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:09:09 INFO - Cleaning up... 11:09:09 INFO - Return code: 0 11:09:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7feb5b634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1300850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fb370>, '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 0x12fe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12fed80>, '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': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', '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:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:09:09 INFO - Using env: {'DISPLAY': ':0', 11:09:09 INFO - 'HOME': '/home/cltbld', 11:09:09 INFO - 'LANG': 'en_US.UTF-8', 11:09:09 INFO - 'LANGUAGE': 'en_US:en', 11:09:09 INFO - 'LOGNAME': 'cltbld', 11:09:09 INFO - 'MAIL': '/var/mail/cltbld', 11:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:09 INFO - 'MOZ_NO_REMOTE': '1', 11:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:09 INFO - 'NO_EM_RESTART': '1', 11:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:09 INFO - 'PWD': '/builds/slave/test', 11:09:09 INFO - 'SHELL': '/bin/bash', 11:09:09 INFO - 'SHLVL': '1', 11:09:09 INFO - 'TERM': 'linux', 11:09:09 INFO - 'TMOUT': '86400', 11:09:09 INFO - 'USER': 'cltbld', 11:09:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', 11:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:09 INFO - '_': '/tools/buildbot/bin/python'} 11:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:09 INFO - Downloading/unpacking psutil>=3.1.1 11:09:09 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:09:09 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:09:09 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:09:09 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:09:09 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:09:09 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:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:09:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:11 INFO - Installing collected packages: psutil 11:09:11 INFO - Running setup.py install for psutil 11:09:11 INFO - building 'psutil._psutil_linux' extension 11:09:11 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:09:11 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:09:11 INFO - building 'psutil._psutil_posix' extension 11:09:11 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:09:11 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:09:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:11 INFO - Successfully installed psutil 11:09:11 INFO - Cleaning up... 11:09:12 INFO - Return code: 0 11:09:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:09:12 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:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:12 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:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:12 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 0x7feb5b634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1300850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fb370>, '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 0x12fe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12fed80>, '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': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', '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:09:12 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:09:12 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:09:12 INFO - Using env: {'DISPLAY': ':0', 11:09:12 INFO - 'HOME': '/home/cltbld', 11:09:12 INFO - 'LANG': 'en_US.UTF-8', 11:09:12 INFO - 'LANGUAGE': 'en_US:en', 11:09:12 INFO - 'LOGNAME': 'cltbld', 11:09:12 INFO - 'MAIL': '/var/mail/cltbld', 11:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:12 INFO - 'MOZ_NO_REMOTE': '1', 11:09:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:12 INFO - 'NO_EM_RESTART': '1', 11:09:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:12 INFO - 'PWD': '/builds/slave/test', 11:09:12 INFO - 'SHELL': '/bin/bash', 11:09:12 INFO - 'SHLVL': '1', 11:09:12 INFO - 'TERM': 'linux', 11:09:12 INFO - 'TMOUT': '86400', 11:09:12 INFO - 'USER': 'cltbld', 11:09:12 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', 11:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:12 INFO - '_': '/tools/buildbot/bin/python'} 11:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:09:12 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:09:12 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:09:12 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:09:12 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:09:12 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:09:12 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:09:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:09:14 INFO - Installing collected packages: mozsystemmonitor 11:09:14 INFO - Running setup.py install for mozsystemmonitor 11:09:14 INFO - Successfully installed mozsystemmonitor 11:09:14 INFO - Cleaning up... 11:09:14 INFO - Return code: 0 11:09:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:14 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 0x7feb5b634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1300850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fb370>, '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 0x12fe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12fed80>, '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': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', '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:09:14 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:09:14 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:09:14 INFO - Using env: {'DISPLAY': ':0', 11:09:14 INFO - 'HOME': '/home/cltbld', 11:09:14 INFO - 'LANG': 'en_US.UTF-8', 11:09:14 INFO - 'LANGUAGE': 'en_US:en', 11:09:14 INFO - 'LOGNAME': 'cltbld', 11:09:14 INFO - 'MAIL': '/var/mail/cltbld', 11:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:14 INFO - 'MOZ_NO_REMOTE': '1', 11:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:14 INFO - 'NO_EM_RESTART': '1', 11:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:14 INFO - 'PWD': '/builds/slave/test', 11:09:14 INFO - 'SHELL': '/bin/bash', 11:09:14 INFO - 'SHLVL': '1', 11:09:14 INFO - 'TERM': 'linux', 11:09:14 INFO - 'TMOUT': '86400', 11:09:14 INFO - 'USER': 'cltbld', 11:09:14 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', 11:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:14 INFO - '_': '/tools/buildbot/bin/python'} 11:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:14 INFO - Downloading/unpacking jsonschema==2.5.1 11:09:14 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:09:14 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:09:14 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:09:14 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:09:14 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:09:14 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:09:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:09:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:09:16 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:09:16 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:09:16 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:09:16 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:09:16 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:09:16 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:09:16 INFO - Downloading functools32-3.2.3-2.tar.gz 11:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:09:16 INFO - warning: no files found matching '*.txt' 11:09:16 INFO - no previously-included directories found matching 'build' 11:09:16 INFO - no previously-included directories found matching 'dist' 11:09:16 INFO - no previously-included directories found matching '.git*' 11:09:16 INFO - Installing collected packages: jsonschema, functools32 11:09:16 INFO - Running setup.py install for functools32 11:09:16 INFO - warning: no files found matching '*.txt' 11:09:16 INFO - no previously-included directories found matching 'build' 11:09:16 INFO - no previously-included directories found matching 'dist' 11:09:16 INFO - no previously-included directories found matching '.git*' 11:09:16 INFO - Successfully installed jsonschema functools32 11:09:16 INFO - Cleaning up... 11:09:16 INFO - Return code: 0 11:09:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:09:16 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:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:16 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:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:16 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 0x7feb5b634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1300850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fb370>, '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 0x12fe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12fed80>, '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': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', '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:09:16 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:09:16 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:09:16 INFO - Using env: {'DISPLAY': ':0', 11:09:16 INFO - 'HOME': '/home/cltbld', 11:09:16 INFO - 'LANG': 'en_US.UTF-8', 11:09:16 INFO - 'LANGUAGE': 'en_US:en', 11:09:16 INFO - 'LOGNAME': 'cltbld', 11:09:16 INFO - 'MAIL': '/var/mail/cltbld', 11:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:16 INFO - 'MOZ_NO_REMOTE': '1', 11:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:16 INFO - 'NO_EM_RESTART': '1', 11:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:16 INFO - 'PWD': '/builds/slave/test', 11:09:16 INFO - 'SHELL': '/bin/bash', 11:09:16 INFO - 'SHLVL': '1', 11:09:16 INFO - 'TERM': 'linux', 11:09:16 INFO - 'TMOUT': '86400', 11:09:16 INFO - 'USER': 'cltbld', 11:09:16 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', 11:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:16 INFO - '_': '/tools/buildbot/bin/python'} 11:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:09:17 INFO - Cleaning up... 11:09:17 INFO - Return code: 0 11:09:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:09:17 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:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:17 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:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:17 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 0x7feb5b634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1300850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fb370>, '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 0x12fe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12fed80>, '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': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', '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:09:17 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:09:17 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:09:17 INFO - Using env: {'DISPLAY': ':0', 11:09:17 INFO - 'HOME': '/home/cltbld', 11:09:17 INFO - 'LANG': 'en_US.UTF-8', 11:09:17 INFO - 'LANGUAGE': 'en_US:en', 11:09:17 INFO - 'LOGNAME': 'cltbld', 11:09:17 INFO - 'MAIL': '/var/mail/cltbld', 11:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:17 INFO - 'MOZ_NO_REMOTE': '1', 11:09:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:17 INFO - 'NO_EM_RESTART': '1', 11:09:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:17 INFO - 'PWD': '/builds/slave/test', 11:09:17 INFO - 'SHELL': '/bin/bash', 11:09:17 INFO - 'SHLVL': '1', 11:09:17 INFO - 'TERM': 'linux', 11:09:17 INFO - 'TMOUT': '86400', 11:09:17 INFO - 'USER': 'cltbld', 11:09:17 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', 11:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:17 INFO - '_': '/tools/buildbot/bin/python'} 11:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:17 INFO - Downloading/unpacking blobuploader==1.2.4 11:09:17 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:09:17 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:09:17 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:09:17 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:09:17 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:09:17 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:09:19 INFO - Downloading blobuploader-1.2.4.tar.gz 11:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:09:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:09:19 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:09:19 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:09:19 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:09:19 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:09:19 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:09:19 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:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:09:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:09:19 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:09:19 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:09:19 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:09:19 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:09:19 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:09:19 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:09:19 INFO - Downloading docopt-0.6.1.tar.gz 11:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:09:20 INFO - Installing collected packages: blobuploader, requests, docopt 11:09:20 INFO - Running setup.py install for blobuploader 11:09:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:09:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:09:20 INFO - Running setup.py install for requests 11:09:20 INFO - Running setup.py install for docopt 11:09:20 INFO - Successfully installed blobuploader requests docopt 11:09:20 INFO - Cleaning up... 11:09:20 INFO - Return code: 0 11:09:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:20 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:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:20 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:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:20 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 0x7feb5b634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1300850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fb370>, '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 0x12fe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12fed80>, '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': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', '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:09:20 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:09:20 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:09:20 INFO - Using env: {'DISPLAY': ':0', 11:09:20 INFO - 'HOME': '/home/cltbld', 11:09:20 INFO - 'LANG': 'en_US.UTF-8', 11:09:20 INFO - 'LANGUAGE': 'en_US:en', 11:09:20 INFO - 'LOGNAME': 'cltbld', 11:09:20 INFO - 'MAIL': '/var/mail/cltbld', 11:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:20 INFO - 'MOZ_NO_REMOTE': '1', 11:09:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:20 INFO - 'NO_EM_RESTART': '1', 11:09:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:20 INFO - 'PWD': '/builds/slave/test', 11:09:20 INFO - 'SHELL': '/bin/bash', 11:09:20 INFO - 'SHLVL': '1', 11:09:20 INFO - 'TERM': 'linux', 11:09:20 INFO - 'TMOUT': '86400', 11:09:20 INFO - 'USER': 'cltbld', 11:09:20 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', 11:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:20 INFO - '_': '/tools/buildbot/bin/python'} 11:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:20 INFO - Running setup.py (path:/tmp/pip-vU9SJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:20 INFO - Running setup.py (path:/tmp/pip-83yBDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:21 INFO - Running setup.py (path:/tmp/pip-YJWopp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:21 INFO - Running setup.py (path:/tmp/pip-jp2kyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:21 INFO - Running setup.py (path:/tmp/pip-xneYES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:21 INFO - Running setup.py (path:/tmp/pip-Cezdxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:21 INFO - Running setup.py (path:/tmp/pip-JXdGXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:21 INFO - Running setup.py (path:/tmp/pip-0gUDmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:21 INFO - Running setup.py (path:/tmp/pip-tQSe0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:21 INFO - Running setup.py (path:/tmp/pip-gtNCSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:21 INFO - Running setup.py (path:/tmp/pip-zUoHoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:21 INFO - Running setup.py (path:/tmp/pip-faPzLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:21 INFO - Running setup.py (path:/tmp/pip-1Y6gP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:21 INFO - Running setup.py (path:/tmp/pip-1j4pW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:21 INFO - Running setup.py (path:/tmp/pip-n16sYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:21 INFO - Running setup.py (path:/tmp/pip-yXCxTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:22 INFO - Running setup.py (path:/tmp/pip-DlojgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:09:22 INFO - Running setup.py install for manifestparser 11:09:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:09:22 INFO - Running setup.py install for mozcrash 11:09:22 INFO - Running setup.py install for mozdebug 11:09:22 INFO - Running setup.py install for mozdevice 11:09:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:09:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:09:22 INFO - Running setup.py install for mozfile 11:09:22 INFO - Running setup.py install for mozhttpd 11:09:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:09:22 INFO - Running setup.py install for mozinfo 11:09:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:09:22 INFO - Running setup.py install for mozInstall 11:09:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:09:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:09:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:09:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:09:22 INFO - Running setup.py install for mozleak 11:09:22 INFO - Running setup.py install for mozlog 11:09:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:09:23 INFO - Running setup.py install for moznetwork 11:09:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:09:23 INFO - Running setup.py install for mozprocess 11:09:23 INFO - Running setup.py install for mozprofile 11:09:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:09:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:09:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:09:23 INFO - Running setup.py install for mozrunner 11:09:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:09:23 INFO - Running setup.py install for mozscreenshot 11:09:23 INFO - Running setup.py install for moztest 11:09:23 INFO - Running setup.py install for mozversion 11:09:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:09:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:09:23 INFO - Cleaning up... 11:09:23 INFO - Return code: 0 11:09:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:23 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 0x7feb5b634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1300850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fb370>, '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 0x12fe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12fed80>, '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': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', '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:09:23 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:09:23 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:09:23 INFO - Using env: {'DISPLAY': ':0', 11:09:23 INFO - 'HOME': '/home/cltbld', 11:09:23 INFO - 'LANG': 'en_US.UTF-8', 11:09:23 INFO - 'LANGUAGE': 'en_US:en', 11:09:23 INFO - 'LOGNAME': 'cltbld', 11:09:23 INFO - 'MAIL': '/var/mail/cltbld', 11:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:23 INFO - 'MOZ_NO_REMOTE': '1', 11:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:23 INFO - 'NO_EM_RESTART': '1', 11:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:23 INFO - 'PWD': '/builds/slave/test', 11:09:23 INFO - 'SHELL': '/bin/bash', 11:09:23 INFO - 'SHLVL': '1', 11:09:23 INFO - 'TERM': 'linux', 11:09:23 INFO - 'TMOUT': '86400', 11:09:23 INFO - 'USER': 'cltbld', 11:09:23 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', 11:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:23 INFO - '_': '/tools/buildbot/bin/python'} 11:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:24 INFO - Running setup.py (path:/tmp/pip-kAtJEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:24 INFO - Running setup.py (path:/tmp/pip-M3E2vV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:24 INFO - Running setup.py (path:/tmp/pip-M_pmAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:24 INFO - Running setup.py (path:/tmp/pip-13s11L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:24 INFO - Running setup.py (path:/tmp/pip-P9aIih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:24 INFO - Running setup.py (path:/tmp/pip-5O4SER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:24 INFO - Running setup.py (path:/tmp/pip-qGOa4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:24 INFO - Running setup.py (path:/tmp/pip-4mxf_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:24 INFO - Running setup.py (path:/tmp/pip-i7e7Pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:24 INFO - Running setup.py (path:/tmp/pip-RH_vnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:24 INFO - Running setup.py (path:/tmp/pip-481W5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:24 INFO - Running setup.py (path:/tmp/pip-_wLWLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:24 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:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:24 INFO - Running setup.py (path:/tmp/pip-bEn6Dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:25 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:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:25 INFO - Running setup.py (path:/tmp/pip-so86WP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:25 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:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:25 INFO - Running setup.py (path:/tmp/pip-b2O1AC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:25 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:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:25 INFO - Running setup.py (path:/tmp/pip-RUB12X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:25 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:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:25 INFO - Running setup.py (path:/tmp/pip-w265dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:27 INFO - Downloading blessings-1.6.tar.gz 11:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:09:27 INFO - Installing collected packages: blessings 11:09:27 INFO - Running setup.py install for blessings 11:09:27 INFO - Successfully installed blessings 11:09:27 INFO - Cleaning up... 11:09:27 INFO - Return code: 0 11:09:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:09:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:09:27 INFO - Reading from file tmpfile_stdout 11:09:27 INFO - Current package versions: 11:09:27 INFO - argparse == 1.2.1 11:09:27 INFO - blessings == 1.6 11:09:27 INFO - blobuploader == 1.2.4 11:09:27 INFO - docopt == 0.6.1 11:09:27 INFO - functools32 == 3.2.3-2 11:09:27 INFO - jsonschema == 2.5.1 11:09:27 INFO - manifestparser == 1.1 11:09:27 INFO - mozInstall == 1.12 11:09:27 INFO - mozcrash == 0.17 11:09:27 INFO - mozdebug == 0.1 11:09:27 INFO - mozdevice == 0.48 11:09:27 INFO - mozfile == 1.2 11:09:27 INFO - mozhttpd == 0.7 11:09:27 INFO - mozinfo == 0.9 11:09:27 INFO - mozleak == 0.1 11:09:27 INFO - mozlog == 3.3 11:09:27 INFO - moznetwork == 0.27 11:09:27 INFO - mozprocess == 0.23 11:09:27 INFO - mozprofile == 0.28 11:09:27 INFO - mozrunner == 6.12 11:09:27 INFO - mozscreenshot == 0.1 11:09:27 INFO - mozsystemmonitor == 0.3 11:09:27 INFO - moztest == 0.7 11:09:27 INFO - mozversion == 1.4 11:09:27 INFO - psutil == 3.1.1 11:09:27 INFO - requests == 1.2.3 11:09:27 INFO - wsgiref == 0.1.2 11:09:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:27 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:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:27 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:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:27 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 0x7feb5b634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1300850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fb370>, '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 0x12fe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12fed80>, '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': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', '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:09:27 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:09:27 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:09:27 INFO - Using env: {'DISPLAY': ':0', 11:09:27 INFO - 'HOME': '/home/cltbld', 11:09:27 INFO - 'LANG': 'en_US.UTF-8', 11:09:27 INFO - 'LANGUAGE': 'en_US:en', 11:09:27 INFO - 'LOGNAME': 'cltbld', 11:09:27 INFO - 'MAIL': '/var/mail/cltbld', 11:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:27 INFO - 'MOZ_NO_REMOTE': '1', 11:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:27 INFO - 'NO_EM_RESTART': '1', 11:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:27 INFO - 'PWD': '/builds/slave/test', 11:09:27 INFO - 'SHELL': '/bin/bash', 11:09:27 INFO - 'SHLVL': '1', 11:09:27 INFO - 'TERM': 'linux', 11:09:27 INFO - 'TMOUT': '86400', 11:09:27 INFO - 'USER': 'cltbld', 11:09:27 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', 11:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:27 INFO - '_': '/tools/buildbot/bin/python'} 11:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:27 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:09:27 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:09:27 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:09:27 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:09:27 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:09:27 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:09:27 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:09:27 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:09:27 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:09:27 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:09:27 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:09:27 INFO - Cleaning up... 11:09:27 INFO - Return code: 0 11:09:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:09:27 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:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:27 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:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:27 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 0x7feb5b634f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1300850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12fb370>, '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 0x12fe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12fed80>, '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': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', '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:09:27 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:09:27 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:09:27 INFO - Using env: {'DISPLAY': ':0', 11:09:27 INFO - 'HOME': '/home/cltbld', 11:09:27 INFO - 'LANG': 'en_US.UTF-8', 11:09:27 INFO - 'LANGUAGE': 'en_US:en', 11:09:27 INFO - 'LOGNAME': 'cltbld', 11:09:27 INFO - 'MAIL': '/var/mail/cltbld', 11:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:27 INFO - 'MOZ_NO_REMOTE': '1', 11:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:27 INFO - 'NO_EM_RESTART': '1', 11:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:27 INFO - 'PWD': '/builds/slave/test', 11:09:27 INFO - 'SHELL': '/bin/bash', 11:09:27 INFO - 'SHLVL': '1', 11:09:27 INFO - 'TERM': 'linux', 11:09:27 INFO - 'TMOUT': '86400', 11:09:27 INFO - 'USER': 'cltbld', 11:09:27 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', 11:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:27 INFO - '_': '/tools/buildbot/bin/python'} 11:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:09:28 INFO - Cleaning up... 11:09:28 INFO - Return code: 0 11:09:28 INFO - Running post-action listener: _resource_record_post_action 11:09:28 INFO - Running post-action listener: _start_resource_monitoring 11:09:28 INFO - Starting resource monitoring. 11:09:28 INFO - [mozharness: 2016-09-01 18:09:28.162099Z] Finished create-virtualenv step (success) 11:09:28 INFO - [mozharness: 2016-09-01 18:09:28.162559Z] Running install step. 11:09:28 INFO - Running pre-action listener: _resource_record_pre_action 11:09:28 INFO - Running main action method: install 11:09:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:09:28 INFO - Reading from file tmpfile_stdout 11:09:28 INFO - Detecting whether we're running mozinstall >=1.0... 11:09:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:09:28 INFO - Reading from file tmpfile_stdout 11:09:28 INFO - Output received: 11:09:28 INFO - Usage: mozinstall [options] installer 11:09:28 INFO - Options: 11:09:28 INFO - -h, --help show this help message and exit 11:09:28 INFO - -d DEST, --destination=DEST 11:09:28 INFO - Directory to install application into. [default: 11:09:28 INFO - "/builds/slave/test"] 11:09:28 INFO - --app=APP Application being installed. [default: firefox] 11:09:28 INFO - mkdir: /builds/slave/test/build/application 11:09:28 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:09:28 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:09:45 INFO - Reading from file tmpfile_stdout 11:09:45 INFO - Output received: 11:09:45 INFO - /builds/slave/test/build/application/firefox/firefox 11:09:45 INFO - Running post-action listener: _resource_record_post_action 11:09:45 INFO - [mozharness: 2016-09-01 18:09:45.450983Z] Finished install step (success) 11:09:45 INFO - [mozharness: 2016-09-01 18:09:45.451324Z] Running run-tests step. 11:09:45 INFO - Running pre-action listener: _resource_record_pre_action 11:09:45 INFO - Running main action method: run_tests 11:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:09:45 INFO - Python 2.7.3 11:09:45 INFO - Return code: 0 11:09:45 INFO - grabbing minidump binary from tooltool 11:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:09:45 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 0x12fb370>, '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 0x12fe8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12fed80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:09:45 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:09:45 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:09:45 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:09:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:09:45 INFO - Return code: 0 11:09:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:09:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:09:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:09:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:09:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:09:45 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/Y2u0Olu_QA-kAXK8JCkH1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:09:45 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/Y2u0Olu_QA-kAXK8JCkH1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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:09:45 INFO - Using env: {'DISPLAY': ':0', 11:09:45 INFO - 'HOME': '/home/cltbld', 11:09:45 INFO - 'LANG': 'en_US.UTF-8', 11:09:45 INFO - 'LANGUAGE': 'en_US:en', 11:09:45 INFO - 'LOGNAME': 'cltbld', 11:09:45 INFO - 'MAIL': '/var/mail/cltbld', 11:09:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:09:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:45 INFO - 'MOZ_NO_REMOTE': '1', 11:09:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:09:45 INFO - 'NO_EM_RESTART': '1', 11:09:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:45 INFO - 'PWD': '/builds/slave/test', 11:09:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:09:45 INFO - 'SHELL': '/bin/bash', 11:09:45 INFO - 'SHLVL': '1', 11:09:45 INFO - 'TERM': 'linux', 11:09:45 INFO - 'TMOUT': '86400', 11:09:45 INFO - 'USER': 'cltbld', 11:09:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230', 11:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:45 INFO - '_': '/tools/buildbot/bin/python'} 11:09:45 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/Y2u0Olu_QA-kAXK8JCkH1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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:09:45 INFO - mozversion application_buildid: 20160901083012 11:09:45 INFO - mozversion application_changeset: aa1a7886af087c5c13cd087ac1c67dac7e553492 11:09:45 INFO - mozversion application_display_name: Nightly 11:09:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:09:45 INFO - mozversion application_name: Firefox 11:09:45 INFO - mozversion application_remotingname: firefox 11:09:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:09:45 INFO - mozversion application_vendor: Mozilla 11:09:45 INFO - mozversion application_version: 51.0a1 11:09:45 INFO - mozversion platform_buildid: 20160901083012 11:09:45 INFO - mozversion platform_changeset: aa1a7886af087c5c13cd087ac1c67dac7e553492 11:09:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:09:45 INFO - mozversion platform_version: 51.0a1 11:09:45 INFO - using testdate: 1472753385 11:09:45 INFO - actual date: 1472753385 11:09:45 INFO - starting webserver on 'localhost:51735' 11:09:45 INFO - SUITE-START | Running 2 tests 11:09:45 INFO - TEST-START | dromaeo_css 11:09:45 INFO - operating with platform_type : linux_ 11:09:45 INFO - Initialising browser for dromaeo_css test... 11:09:45 INFO - TEST-INFO | started process 20762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM9wSDq/profile http://localhost:51735/getInfo.html) 11:09:50 INFO - PROCESS | 20762 | __metrics Screen width/height:1600/1200 11:09:50 INFO - PROCESS | 20762 | colorDepth:24 11:09:50 INFO - PROCESS | 20762 | Browser inner width/height: 1024/697 11:09:50 INFO - PROCESS | 20762 | __metrics 11:09:50 INFO - PROCESS | 20762 | 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:09:50 INFO - PROCESS | 20762 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:09:51 INFO - PROCESS | 20762 | console.error: PushService: 11:09:51 INFO - PROCESS | 20762 | stateChangeProcessEnqueue: Error transitioning state 11:09:51 INFO - PROCESS | 20762 | UnknownError 11:09:52 INFO - TEST-INFO | 20762: exit 0 11:09:52 INFO - Browser initialized. 11:09:52 INFO - Running cycle 1/1 for dromaeo_css test... 11:09:52 INFO - TEST-INFO | started process 20846 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM9wSDq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:10:04 INFO - PROCESS | 20846 | RSS: Main: 180232192 11:10:04 INFO - PROCESS | 20846 | 11:10:56 INFO - PROCESS | 20846 | 1472753456052 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:13:05 INFO - PROCESS | 20846 | Cycle 1(1): loaded http://localhost:51735/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51735/tests/dromaeo/cssquery-ext.html) 11:13:06 INFO - PROCESS | 20846 | RSS: Main: 301375488 11:13:06 INFO - PROCESS | 20846 | 11:16:09 INFO - PROCESS | 20846 | Cycle 1(1): loaded http://localhost:51735/tests/dromaeo/cssquery-ext.html (next: http://localhost:51735/tests/dromaeo/cssquery-jquery.html) 11:16:09 INFO - PROCESS | 20846 | RSS: Main: 271409152 11:16:09 INFO - PROCESS | 20846 | 11:19:11 INFO - PROCESS | 20846 | Cycle 1(1): loaded http://localhost:51735/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51735/tests/dromaeo/cssquery-mootools.html) 11:19:12 INFO - PROCESS | 20846 | RSS: Main: 212779008 11:19:12 INFO - PROCESS | 20846 | 11:22:14 INFO - PROCESS | 20846 | Cycle 1(1): loaded http://localhost:51735/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51735/tests/dromaeo/cssquery-prototype.html) 11:22:14 INFO - PROCESS | 20846 | RSS: Main: 249692160 11:22:14 INFO - PROCESS | 20846 | 11:25:17 INFO - PROCESS | 20846 | Cycle 1(1): loaded http://localhost:51735/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51735/tests/dromaeo/cssquery-yui.html) 11:25:18 INFO - PROCESS | 20846 | RSS: Main: 215416832 11:25:18 INFO - PROCESS | 20846 | 11:28:21 INFO - PROCESS | 20846 | Cycle 1(1): loaded http://localhost:51735/tests/dromaeo/cssquery-yui.html (next: http://localhost:51735/tests/dromaeo/cssquery-dojo.html) 11:28:21 INFO - PROCESS | 20846 | RSS: Main: 302428160 11:28:21 INFO - PROCESS | 20846 | 11:28:21 INFO - PROCESS | 20846 | __start_tp_report 11:28:21 INFO - PROCESS | 20846 | _x_x_mozilla_page_load 11:28:21 INFO - PROCESS | 20846 | _x_x_mozilla_page_load_details 11:28:21 INFO - PROCESS | 20846 | |i|pagename|runs| 11:28:21 INFO - PROCESS | 20846 | |0;dojo.html;3034.651015133259;3040.4375190589744;3076.292452735869;3092.4279008383464;3125.5780469636593;5255.921161182585;5275.393329767078;5328.520433161015;5388.299521062261;5431.321084864392;5285.947140528594;5310.283111779909;5345.1447768357075;5375.220593014011;5391.81128660497;4751.453582837966;4805.663603547753;4838.661293709441;4850.514948505139;5071.1886098224295;5012.924806127893;5024.522670346311;5027.494893092076;5062.670926389791;5079.111155547783;4774.594159496412;4785.617150627942;4830.396200474923;4897.240927656219;4901.975490122527;4742.2886567014875;4758.191107511731;4762.714237145782;4830.251311046758;4871.488493708145;4750.714957102585;4783.569478746929;4788.928166077511;4801.039792041605;4850.417949846006;5162.896742065138;5215.113430716788;5272.630915835893;5277.551408130275;5351.464853514617;5618.494335509783;5634.549236061105;5639.887202255932;5640.5487560995025;5714.771409143629;5603.187537807036;5674.063779476382;5674.716264186774;5680.091185410314;5682.403347648478;5113.463086375914;5264.078786212397;5295.391030031557;5298.099323115041;5317.548008419328;5830.271216097988;5845.064789633639;5855.853603659943;5881.852953676193;5914.852128696817;5586.497215250566;5593.74828132735;5596.188552659842;5610.971945140248;5613.663180209201;5522.088855338824;5663.150527420919;5675.801346952837;5683.119116536944;5717.285339332583;5730.169125476783;5741.770329186869;5742.052561327418;5776.653400795965;5808.5933984621515;5693.202951586781;5728.312602487728;5730.1404789281105;5732.369439361667;5755.453231942959;4233.428487154257;4325.286327755948;4338.783060846945;4400.603945644907;4449.998750281161;3868.593797651206;3873.205992771475;3907.27715372657;3919;3937.842486300573;5384.057789886754;5387.057264978692;5398.541124004425;5406.243125962368;5467.043267428184;5531.529819965268;5623.606347555714;5631.63394379364;5704.8859022819315;5719.48524632785;5354.544863686552;5354.8661283467445;5355.973220133875;5379.892402151935;5397.487238712316;4815.566599006036;4820.517948205222;4837.32277481153;4839.080574690797;4887.853364399074;5670.858228544319;5804.955108080586;5815.651060936358;5822.446867547576;5839.503642190291;5667.093265077568;5675.148727690879;5677.659340439587;5721.170430287668;5740.68426236561;5875.735591898289;5880.500157486662;5881.17663527098;5886.646801191942;5894.086416605433;5319.654222475527;5484.670919744828;5525;5582.944170558242;5594.580406469449;5653;5655;5665.150227465913;5704.686242256716;5726.341470730753;5494.917576236439;5553.4724201200825;5554.91667624994;5572.582056345871;5575.581831362583;5354.250404943233;5528.502434780728;5542.806001789918;5542.944570554243;5574.08027675429;5556.333240011225;5559.9444005561045;5560.36055853582;5609.074502707171;5635.718214089361;5652.7738890443925;5685.403032681509;5700.942990570041;5705;5707.315122185364;5254.343207099113;5261;5421.349438067299;5554.222408862844;5567.777288908398 11:28:21 INFO - PROCESS | 20846 | |1;ext.html;566.3798141035567;600.96093753906;622.4802290087775;630.9305976342605;640.5804198250148;32023.83988080059;46093.539064609344;47329;47384.76307618466;47436.525634743644;44929;45261.32108018382;45302.32046519296;45373;45404.77297613516;7963.243491868292;8881.95559022204;9027.864582031274;9033.322500812432;9039.954800226022;10525.315854469472;10822.24244302899;10828.837567436456;11012.17408694347;11018.834717479243;10917.126629869592;11010.229283950126;11016;11028.172887033465;11032.062274706619;8139.79650508742;10685.679429617125;10738.946305268462;10813.513391897384;10838.891611083907;10341.948290258575;10768.084712799422;10786.08318292946;10787.137029037658;10789.784204315869;42099.579004209874;42523.57476425227;42545.1490970182;42547.36178957318;42548.36177457341;3601.603823579404;3658.2700941634475;3742.6631603155847;3872.457855900176;3947.4276229946786;32073;32253.51619725706;32341;32366.352672946643;32620.347593048242;4174.186033723395;4321.0709697415205;4339.761313127777;4343.435353404069;4390.736555806629;337988.99999999756;338150;338520;340302;340680;32739.672603273662;33239.83380083084;58862.41137588569;59303.11045334324;59404.40595593989;37152;37336.25327493435;37567;37617;37622.247555049296;14182.645433864029;14306.928465357607;14310.713785724436;14312;14325.713485730226;11114.833277500844;11152;11323.207375483636;12049.819252711217;12133.21134126279;8449.873251901226;8492.363072769567;8493.915060849313;8585.82828343442;8605.569721513899;3284.1953721338423;3311.9172020699193;3322.850471728778;3351.379994700988;3358.0019888166503;995.1938929467154;1011.6610935336597;1012.3773879064322;1064.1008347945974;1120.9831852522218;31505.8424707875;31613.683863161074;31664.208394789854;32694;32911.67088329134;1045.153425725165;1119.776044791045;1124.359115304285;1157.8784227656142;1169.2049406403557;15794.21028948548;16681.582960426087;16774.916125419295;16830.158492075592;16980.32078716862;455459;457324;457391;458104;459077;54479;54866.725666372215;55002.44997549973;55059.72470137704;55102.173467398025;1227.6623928419756;1334.3928512526777;1349.27813619713;1383.0456984680538;1390.9860901390857;31559.684403156592;33011.33977320488;33789.493157603145;34002.14994625055;34116.658833412344;50633.49366506435;51367.48632513777;51403.74298128486;51441.485585145165;51466.36802687776;415539;416798;417574;419499;419634;27949.720502795524;29083.56374654424;29131;29992.25019374533;30074;47581.762091189325;47713;48110.759446202544;48454;49654.751726241135;40334.12412033248;40342.59657403389;40785.79607101945;41730.37404438875;42393.576064240195;40346.59653403546;40784.388234175916;41097.794511027256;42239;42658.78670606751;40084.39873401843;40219;40693;41232.1753564933;41712.79143604262;34825.65174348224;36913;37428.93051648782;37706.8114659425;37803;27728.445431090862;27817;27978.440431190855;28144.43711125807;28148.85925570359 11:28:21 INFO - PROCESS | 20846 | |2;jquery.html;368.4933216826863;387.40920096852307;392.37808074202394;392.6132759232156;415.8918681142904;16699.74950375745;19151.808481915177;19302.517437064063;20428.795712042876;20766.27318043869;18651;19476.415707528762;19581.51046223845;19874.40376788695;19981.100850461728;5556.583256255777;5793.391693872146;5956.374580669032;6006.219191505098;6024.548158888079;5915.438033386843;5942.168096466498;5976.103584462322;5980.700964951735;5984.3716409777;5573.164025396182;5784.334801497839;5808.477237048664;5817.767289308423;5955.9702201488935;5615.073512870372;5794.5943783935145;5817.243758311435;5819.30168379795;5827.854303642401;5172.655109671475;5206.661566998133;5224.582033437354;5234;5237.554807841338;23149.7685023151;23627.054917803267;23896.88051559731;23942.52114957691;24015.63976540353;2486.539990101837;2503.887325070358;2555.1440267510407;2562.5515534781525;2858.442603692281;13901.652458688513;14713.70572588553;14833.554993350217;14863.628409289855;15534.61163470911;1876.2588777432838;1878.7275845002534;1897.667908116088;1911.0922311901736;1955.6479833629942;80816;80909;81649.18350816476;82523.5873820633;82889.18317040362;9866.851997220047;9961.551730172016;9986.001399859955;10036.34763740369;10881.891181088087;14625.92687036558;14653.12081275127;14660.413583456755;14677.633059173393;14685.486007989883;7828.138904720477;7920.5247685139075;7988.600569971478;8183.263506284463;8193.918060819315;7804.84390312202;7825.413094017971;7888.605569721491;8036.035675718834;8075.475094118863;6383.202099737533;6506.653644243682;6558.311377305315;6638.601683898982;6671.566348187353;1789.2216885654523;1799.7210432383001;1810.5835657798516;1821.1440622907212;1845.6250093680026;441.8343121329501;465.48563836960346;907.4301458476872;992.3450522655013;1103.3490240757992;11944.701382465508;12059.879401205875;12141.332226727614;12161.69595760113;12164.14850960442;463.67311045712694;470.35091573628176;474.5776259129378;477.87097483679213;480.94469136049804;6160.7535698571555;6379.585326953826;6467.611943283418;6489.1888513935755;6493.577917435352;433825;449922;491076;494743;497947;78654.606726966;86856;96424;99783;101026;471.72168420631994;476.2403965674743;476.976151192439;477.10304627301144;482.43314105925396;10993.61522346714;11511.079113671054;11556.942215289206;11646.126540509325;11735.530578776754;43449.56550434455;43612.34581481217;43725.562744372146;44051.559484404745;45687.771561141984;60275.69862150837;60371;60859.39140608715;61043.38956610377;61546.384536154066;8139.4709343892455;8297.917020829957;8466.66133354659;8592.441491303045;8793.296536276954;11029.283096598696;11625.18623696333;11833;12534.247945122957;12706.18814355671;11030;11454.484548195185;11463.770724585629;11756.470958807045;12064.75870482568;11363.488643010918;11604.361760102938;11639.6508104757;11720.589779357682;12319.876801231872;11260.268082574607;11764.411779410824;11908.761824763284;11990.40047997614;12358.505659773868;8010.759677209693;8409.2431681149;8428.157184281523;8734.825303493768;8756.78108047304;11666.343953092435;11865.40672966331;11955.76088478243;11978.161528692908;12003.219790713576 11:28:21 INFO - PROCESS | 20846 | |3;mootools.html;1476.0627001853823;1502.7670711039789;1654.7435147552126;1742.468547093136;1806.376800003999;8182.91817081829;8791.64833406663;8802.735917922473;8807.559622018898;8808.383413161073;7186.35322820946;8242.464239824421;8464.788380290496;8485.618147183377;8608.26829719473;2400.5558971590267;2421.503591763684;2422.1401402502124;2430.3924018995253;2435.659007738918;2395.0659242895285;2395.832291739579;2431.9756802432016;2449.155041510676;2450.2281781238853;2398.6521954316613;2401.555712193241;2418.830681852271;2425.1754403502805;2430.8176886733477;2359.2096647623066;2372.063035101134;2378.1914149189274;2386.6539351793895;2391.9521609567796;2330.8462311155918;2334.159702507096;2334.1830359374253;2345.57779599672;2345.683332750074;8588.141185881424;8608.139186081404;8683.869741953877;8688.652453901836;8707.34694897879;5023.949760502384;5148.639595228336;5153.793848246103;5163.922541161885;5166.250893620441;3234.4663130583426;3397.286569820341;3447.620761716209;3463.1515278756615;3475.548178736748;1083.6748975307455;1107.141964977141;1119.9888001119966;1135.454981608824;1136.323887287063;11807.114466414967;11858.940705296505;11884.10869184806;11955.402229888557;11960.34218118003;4360.171567402183;4535.31970204472;4641.721496710208;4688.226442636927;4721.102990431807;10021.699349019542;10029.197664186848;10032.247581431422;10041.347312424668;10048.145907597936;5292.655977361459;5330.520253177233;5338.039152952506;5346.732663366816;5350.0904846176245;4122.876313710593;4154.314538101179;4272.316429371285;4801;4903.901921961541;3877.8836634901;4053.2704113259897;4093.959060409358;4127.050778320943;4158.438610787565;1311.672081979505;1342.664333916521;1359.5581436033328;1363.9454421823214;1368.0970559430727;979.1921664626711;980.2501086668705;994.2145704893198;999.4453078541334;1006.1648831469862;5776.7002424455;5836.970815145897;5915.970420147872;5932.851678708067;5998.310194327621;436.44571394329023;437.76798296902695;440.2252036415931;450.0436572283897;450.7250577147937;4212.831486740557;4222.535521092677;4227.534971153171;4233;4235.470566179228;10127.493625318704;10539.209559283085;10563.419011954262;10569.841452378221;10570.048695617432;10434.634787782543;10467.895321046844;10478.847326794046;10486.056254937092;10494.422806745702;7733.110692270461;8092.150324215991;8118.2693557580105;8285.212904773916;8287.12985136552;5978.940210597838;6047.516198704181;6151.538634602333;6171.3828617139725;6332.240131184103;9579.952100239454;9738.853917191389;9978.700638980552;9982.900170998488;10055.648052318134;9740.561674724513;9830.4101753895;10058.49707514636;10078.647247346307;10080.69757907264;7103.112110986127;7291.453141014551;7361.26387361281;7651.234876512304;7770.7668769934735;8303.211194936472;8311.95844020776;8393.496390216607;8402.159784021549;8406.87389689143;7086.50394472382;7438.814029649302;7535.886961695469;7580.810479738051;7716.2669546393;7046.154461464657;7139.500234983501;7303.63481825896;7438.442116841366;7493.70025198986;6667.433268172065;6691.130153080068;6703.128593282842;6716.731330746716;6730.93269067303;5017.448080711192;5096.362954630671;5136.768845402041;5148.871278217925;5182.922256166236;4969.676970996874;5090.338256026841;5222.451642577626;5301.5493683037375;5324.8136315228785 11:28:21 INFO - PROCESS | 20846 | |4;prototype.html;302.6655545622089;317.25128696276784;318.1568842567198;318.49359518365793;321.5755203131867;5061.9876024795;5217.686938783676;5242.475752424755;5290.867728306789;5302.1781623848265;5243.711595862226;5272.8154514592;5288.286081379013;5288.312519372476;5295.867603309919;4152.709310348277;4157.771322577257;4162.458880345551;4173.916521669573;4174.666026717855;3963.9405408918888;4103.384492326145;4161.687873409506;4171.040660648053;4172.687048471362;4077.103037331797;4079.796010199493;4093.385992101179;4099.856505022325;4115.464989551354;4075.286824805662;4079.4084857695766;4092.1406504634065;4097.713160078795;4099.836006559734;3463.510690403126;3523.136831476279;3575.6245594212755;3581.459972211948;3593.2454184621;5175.611829112794;5178.844634660966;5184.637075404723;5191.974040129813;5198.9740051299505;4632.119897219518;4637.489876113625;4638.791254393526;4657.790399432034;4694.647901407408;5359.008583412081;5459.69971651559;5483.7806487740445;5487;5518.448155184489;3905.7070719696135;3910.608939106095;3910.687145028391;3915.647591716731;3919.4708714323488;5716.142578613241;5757.309122905236;5773.6431938494425;5773.653580785166;5777.480026797609;3915.451836742858;3949.6840252779707;3950.5654378018394;4000;4029.7783621901076;4031.899202519902;4033.5361433435532;4038.2932986727205;4064.207479541461;4074.898127546835;4693.882652933704;4711.929321060187;4717.78769955346;4722.268048452495;4725.929111063337;5347.465253474621;5590.329160500766;5609.102543593087;5632.436756324335;5638.802641907513;1307.3528603341406;1371.9588412347646;1389.8818600419077;1391.7703578909568;1393.958181254564;916.1617120334952;937.6765016069445;949.9550494456043;953.1374106433689;956.6269155029544;5313.920291195635;5314.92027619586;5315.554844771448;5321.414644389114;5329.840104796862;5590.217369568264;5597.972010139923;5600.915986260209;5602.775888964396;5605.159226116115;5119.539241468286;5343.7060961647485;5361.651492652965;5412.539934105645;5420.566354691615;2986.7759918006236;3023.712747289004;3026.44010857992;3030.863611137504;3038.9848050759606;5865.853353666193;5872.120921305142;5914.290285165722;5915.970420147872;5932.783779325228;5570.857974115296;5741.85645358861;5782.566307526952;5801.549612596851;5807.88384232313;5874.530037596982;5877.853053673607;5896.439838215363;5917.46742793142;5962.4633782959745;5422.593305502182;5664.830055098354;5735.139729040678;5747.339056008613;5757.3954734753925;5618.2134501170685;5619.494245517923;5621.297337832771;5644.153376993484;5657.161422537774;5834.620749651429;5845;5847.795327163699;5849.268841394825;5913.29040515141;3959.9010024749614;4068.5727998559723;4097.815598298143;4114.732542384735;4115.609017143366;5437.945620543902;5659.3491748447805;5699.829005129853;5701.429857014431;5707.143928410772;5466.671999680032;5532.391436942014;5552.194931734956;5553.611247212656;5634.211210430461;5526.50261476469;5584.497395234448;5601.7759289629585;5617.550595952396;5626;5307.256984022317;5543.722813859372;5552.833414997556;5559.861003474945;5587.441255874543;5661.858453538694;5662.235598194191;5662.603617746719;5666.603337766317;5672;5446.400895901527;5546.861328466821;5597.356304024926;5614.466625670555;5625.746841392229 11:28:21 INFO - PROCESS | 20846 | |5;yui.html;716.1835507521427;745.0575022596415;746.3022074360473;762.0208032678009;792.2671528835825;14697.485588004422;15098.396064157434;15137.621559461018;15171.924140379282;15435.768463473029;15365.154916479589;15381.615459613515;15479.767803482957;15487.070775753462;15503;673.2896793882452;801.3549092980148;815.0138332617511;815.3477218225426;815.9592020398986;791.2048391366668;809.9433039687224;810.5744484145841;815.4943934760457;816.9223923727266;861.9094995025526;864.9005364383114;865.4807115730574;871.3856731004627;871.6861929705301;694.3958755882364;823.7611092783086;864.6541383446609;865.0873328638253;865.6277800545763;615.2401783797008;615.2924137242162;615.7690865925279;616;616.3589866538795;15735;15748.921255393765;15776.76334854978;15781.13203773792;15790;14595.854041459555;14732.55802325932;15001.549953501413;15022.323995420233;15369.385224591002;13475.797863032063;13566.321683915863;13622.727545449035;13793.517226897011;14624.12255264677;4444.111177764427;4446.288593824973;4455.086707225011;4527.479339875924;4545.477270113946;84120.15879841184;84582.5770871154;86141;86361.56819215926;86461.56769216177;11784.234024788362;11804.46879890407;11839.704007399712;11956.043516518657;12560.623181304576;23331.416714582272;23491.295261142193;23495.295141145452;23501.294961151194;23875;8795.340349473816;8878.334124940655;8925.353220554982;8959.73120806377;9117.366601771937;4716.88207794801;4718.88202794926;4895.73073480962;4923.236898280772;4978.800847966113;3383.4417321142228;3493.737969652286;3505.053635518396;3516.613172551017;3521.7710848794745;579.3366595248417;581.3721181124375;582.0715958046908;599.0624672387786;613.9907901381483;630.6184758221302;642.5534253693731;644.3073695777058;672.3914857054374;680.1941989294162;8407.411481196257;9222.907770922338;9244.676436324697;9372.8594071089;9684.322097453252;628.924529056507;655.8622689235218;672.4015626092781;678.2166597579803;693.552658535252;4361.651067914623;4586.555621653751;4746.311784791186;4931.630127740434;5286.682799032071;71616.64191679009;73148;73531;75157;119903;84645;87216.56391718001;87440.5627971856;109283;109374;71288.64355678292;85129.57435212785;89390.55304723435;89880;90528;9406.895724410791;10188.235882308709;10223.948880255848;10287.125594324267;10396.688099357032;52284.738576306874;52947.20579191238;53907.46092539181;54583.72708136434;55462;73222.26777732368;74307.62846185734;79795;80396;80636;13042.347882606022;13141.868581314448;13324.733505329645;13324.733505330032;13479.932600336935;15183.848161518243;15255.389784408499;15618.687626247638;15727.528174154793;15747.763783543027;13522;13631.727365452834;13658.292713410823;13820.170789752647;14395.640108997359;13571.592852214055;13640.79538806899;14096.50662226817;14428.134311941318;15032.3548999533;13472.259025753285;13851.235564385943;13999.51001714935;14051;14353.92823035878;11218.439078046229;11387.910958393875;11391.715207119889;11712.121590880888;12078.818817717916;11682.88317116818;11771.23486973344;11924.565182703034;12050.457729402022;12065.698357540781 11:28:21 INFO - PROCESS | 20846 | __end_tp_report 11:28:21 INFO - PROCESS | 20846 | __start_cc_report 11:28:21 INFO - PROCESS | 20846 | _x_x_mozilla_cycle_collect,924 11:28:21 INFO - PROCESS | 20846 | __end_cc_report 11:28:21 INFO - PROCESS | 20846 | __startTimestamp1472754501317__endTimestamp 11:28:21 INFO - PROCESS | 20846 | 11:28:21 INFO - PROCESS | 20846 | ------- Summary: start ------- 11:28:21 INFO - PROCESS | 20846 | Number of tests: 6 11:28:21 INFO - PROCESS | 20846 | 11:28:21 INFO - PROCESS | 20846 | [#0] dojo.html Cycles:165 Average:5282.50 Median:5522.09 stddev:597.20 (10.8%) stddev-sans-first:572.40 11:28:21 INFO - PROCESS | 20846 | Values: 3034.7 3040.4 3076.3 3092.4 3125.6 5255.9 5275.4 5328.5 5388.3 5431.3 5285.9 5310.3 5345.1 5375.2 5391.8 4751.5 4805.7 4838.7 4850.5 5071.2 5012.9 5024.5 5027.5 5062.7 5079.1 4774.6 4785.6 4830.4 4897.2 4902.0 4742.3 4758.2 4762.7 4830.3 4871.5 4750.7 4783.6 4788.9 4801.0 4850.4 5162.9 5215.1 5272.6 5277.6 5351.5 5618.5 5634.5 5639.9 5640.5 5714.8 5603.2 5674.1 5674.7 5680.1 5682.4 5113.5 5264.1 5295.4 5298.1 5317.5 5830.3 5845.1 5855.9 5881.9 5914.9 5586.5 5593.7 5596.2 5611.0 5613.7 5522.1 5663.2 5675.8 5683.1 5717.3 5730.2 5741.8 5742.1 5776.7 5808.6 5693.2 5728.3 5730.1 5732.4 5755.5 4233.4 4325.3 4338.8 4400.6 4450.0 3868.6 3873.2 3907.3 3919.0 3937.8 5384.1 5387.1 5398.5 5406.2 5467.0 5531.5 5623.6 5631.6 5704.9 5719.5 5354.5 5354.9 5356.0 5379.9 5397.5 4815.6 4820.5 4837.3 4839.1 4887.9 5670.9 5805.0 5815.7 5822.4 5839.5 5667.1 5675.1 5677.7 5721.2 5740.7 5875.7 5880.5 5881.2 5886.6 5894.1 5319.7 5484.7 5525.0 5582.9 5594.6 5653.0 5655.0 5665.2 5704.7 5726.3 5494.9 5553.5 5554.9 5572.6 5575.6 5354.3 5528.5 5542.8 5542.9 5574.1 5556.3 5559.9 5560.4 5609.1 5635.7 5652.8 5685.4 5700.9 5705.0 5707.3 5254.3 5261.0 5421.3 5554.2 5567.8 11:28:21 INFO - PROCESS | 20846 | 11:28:21 INFO - PROCESS | 20846 | [#1] ext.html Cycles:180 Average:56112.55 Median:37244.13 stddev:107768.37 (289.4%) stddev-sans-first:107989.99 11:28:21 INFO - PROCESS | 20846 | Values: 566.4 601.0 622.5 630.9 640.6 32023.8 46093.5 47329.0 47384.8 47436.5 44929.0 45261.3 45302.3 45373.0 45404.8 7963.2 8882.0 9027.9 9033.3 9040.0 10525.3 10822.2 10828.8 11012.2 11018.8 10917.1 11010.2 11016.0 11028.2 11032.1 8139.8 10685.7 10738.9 10813.5 10838.9 10341.9 10768.1 10786.1 10787.1 10789.8 42099.6 42523.6 42545.1 42547.4 42548.4 3601.6 3658.3 3742.7 3872.5 3947.4 32073.0 32253.5 32341.0 32366.4 32620.3 4174.2 4321.1 4339.8 4343.4 4390.7 337989.0 338150.0 338520.0 340302.0 340680.0 32739.7 33239.8 58862.4 59303.1 59404.4 37152.0 37336.3 37567.0 37617.0 37622.2 14182.6 14306.9 14310.7 14312.0 14325.7 11114.8 11152.0 11323.2 12049.8 12133.2 8449.9 8492.4 8493.9 8585.8 8605.6 3284.2 3311.9 3322.9 3351.4 3358.0 995.2 1011.7 1012.4 1064.1 1121.0 31505.8 31613.7 31664.2 32694.0 32911.7 1045.2 1119.8 1124.4 1157.9 1169.2 15794.2 16681.6 16774.9 16830.2 16980.3 455459.0 457324.0 457391.0 458104.0 459077.0 54479.0 54866.7 55002.4 55059.7 55102.2 1227.7 1334.4 1349.3 1383.0 1391.0 31559.7 33011.3 33789.5 34002.1 34116.7 50633.5 51367.5 51403.7 51441.5 51466.4 415539.0 416798.0 417574.0 419499.0 419634.0 27949.7 29083.6 29131.0 29992.3 30074.0 47581.8 47713.0 48110.8 48454.0 49654.8 40334.1 40342.6 40785.8 41730.4 42393.6 40346.6 40784.4 41097.8 42239.0 42658.8 40084.4 40219.0 40693.0 41232.2 41712.8 34825.7 36913.0 37428.9 37706.8 37803.0 27728.4 27817.0 27978.4 28144.4 28148.9 11:28:21 INFO - PROCESS | 20846 | 11:28:21 INFO - PROCESS | 20846 | [#2] jquery.html Cycles:180 Average:28340.14 Median:247804.89 stddev:78448.44 (31.7%) stddev-sans-first:78640.40 11:28:21 INFO - PROCESS | 20846 | Values: 368.5 387.4 392.4 392.6 415.9 16699.7 19151.8 19302.5 20428.8 20766.3 18651.0 19476.4 19581.5 19874.4 19981.1 5556.6 5793.4 5956.4 6006.2 6024.5 5915.4 5942.2 5976.1 5980.7 5984.4 5573.2 5784.3 5808.5 5817.8 5956.0 5615.1 5794.6 5817.2 5819.3 5827.9 5172.7 5206.7 5224.6 5234.0 5237.6 23149.8 23627.1 23896.9 23942.5 24015.6 2486.5 2503.9 2555.1 2562.6 2858.4 13901.7 14713.7 14833.6 14863.6 15534.6 1876.3 1878.7 1897.7 1911.1 1955.6 80816.0 80909.0 81649.2 82523.6 82889.2 9866.9 9961.6 9986.0 10036.3 10881.9 14625.9 14653.1 14660.4 14677.6 14685.5 7828.1 7920.5 7988.6 8183.3 8193.9 7804.8 7825.4 7888.6 8036.0 8075.5 6383.2 6506.7 6558.3 6638.6 6671.6 1789.2 1799.7 1810.6 1821.1 1845.6 441.8 465.5 907.4 992.3 1103.3 11944.7 12059.9 12141.3 12161.7 12164.1 463.7 470.4 474.6 477.9 480.9 6160.8 6379.6 6467.6 6489.2 6493.6 433825.0 449922.0 491076.0 494743.0 497947.0 78654.6 86856.0 96424.0 99783.0 101026.0 471.7 476.2 477.0 477.1 482.4 10993.6 11511.1 11556.9 11646.1 11735.5 43449.6 43612.3 43725.6 44051.6 45687.8 60275.7 60371.0 60859.4 61043.4 61546.4 8139.5 8297.9 8466.7 8592.4 8793.3 11029.3 11625.2 11833.0 12534.2 12706.2 11030.0 11454.5 11463.8 11756.5 12064.8 11363.5 11604.4 11639.7 11720.6 12319.9 11260.3 11764.4 11908.8 11990.4 12358.5 8010.8 8409.2 8428.2 8734.8 8756.8 11666.3 11865.4 11955.8 11978.2 12003.2 11:28:21 INFO - PROCESS | 20846 | 11:28:21 INFO - PROCESS | 20846 | [#3] mootools.html Cycles:180 Average:5684.07 Median:4664.97 stddev:3173.10 (68.0%) stddev-sans-first:3166.24 11:28:21 INFO - PROCESS | 20846 | Values: 1476.1 1502.8 1654.7 1742.5 1806.4 8182.9 8791.6 8802.7 8807.6 8808.4 7186.4 8242.5 8464.8 8485.6 8608.3 2400.6 2421.5 2422.1 2430.4 2435.7 2395.1 2395.8 2432.0 2449.2 2450.2 2398.7 2401.6 2418.8 2425.2 2430.8 2359.2 2372.1 2378.2 2386.7 2392.0 2330.8 2334.2 2334.2 2345.6 2345.7 8588.1 8608.1 8683.9 8688.7 8707.3 5023.9 5148.6 5153.8 5163.9 5166.3 3234.5 3397.3 3447.6 3463.2 3475.5 1083.7 1107.1 1120.0 1135.5 1136.3 11807.1 11858.9 11884.1 11955.4 11960.3 4360.2 4535.3 4641.7 4688.2 4721.1 10021.7 10029.2 10032.2 10041.3 10048.1 5292.7 5330.5 5338.0 5346.7 5350.1 4122.9 4154.3 4272.3 4801.0 4903.9 3877.9 4053.3 4094.0 4127.1 4158.4 1311.7 1342.7 1359.6 1363.9 1368.1 979.2 980.3 994.2 999.4 1006.2 5776.7 5837.0 5916.0 5932.9 5998.3 436.4 437.8 440.2 450.0 450.7 4212.8 4222.5 4227.5 4233.0 4235.5 10127.5 10539.2 10563.4 10569.8 10570.0 10434.6 10467.9 10478.8 10486.1 10494.4 7733.1 8092.2 8118.3 8285.2 8287.1 5978.9 6047.5 6151.5 6171.4 6332.2 9580.0 9738.9 9978.7 9982.9 10055.6 9740.6 9830.4 10058.5 10078.6 10080.7 7103.1 7291.5 7361.3 7651.2 7770.8 8303.2 8312.0 8393.5 8402.2 8406.9 7086.5 7438.8 7535.9 7580.8 7716.3 7046.2 7139.5 7303.6 7438.4 7493.7 6667.4 6691.1 6703.1 6716.7 6730.9 5017.4 5096.4 5136.8 5148.9 5182.9 4969.7 5090.3 5222.5 5301.5 5324.8 11:28:21 INFO - PROCESS | 20846 | 11:28:21 INFO - PROCESS | 20846 | [#4] prototype.html Cycles:180 Average:4665.91 Median:5325.63 stddev:1385.51 (26.0%) stddev-sans-first:1350.14 11:28:21 INFO - PROCESS | 20846 | Values: 302.7 317.3 318.2 318.5 321.6 5062.0 5217.7 5242.5 5290.9 5302.2 5243.7 5272.8 5288.3 5288.3 5295.9 4152.7 4157.8 4162.5 4173.9 4174.7 3963.9 4103.4 4161.7 4171.0 4172.7 4077.1 4079.8 4093.4 4099.9 4115.5 4075.3 4079.4 4092.1 4097.7 4099.8 3463.5 3523.1 3575.6 3581.5 3593.2 5175.6 5178.8 5184.6 5192.0 5199.0 4632.1 4637.5 4638.8 4657.8 4694.6 5359.0 5459.7 5483.8 5487.0 5518.4 3905.7 3910.6 3910.7 3915.6 3919.5 5716.1 5757.3 5773.6 5773.7 5777.5 3915.5 3949.7 3950.6 4000.0 4029.8 4031.9 4033.5 4038.3 4064.2 4074.9 4693.9 4711.9 4717.8 4722.3 4725.9 5347.5 5590.3 5609.1 5632.4 5638.8 1307.4 1372.0 1389.9 1391.8 1394.0 916.2 937.7 950.0 953.1 956.6 5313.9 5314.9 5315.6 5321.4 5329.8 5590.2 5598.0 5600.9 5602.8 5605.2 5119.5 5343.7 5361.7 5412.5 5420.6 2986.8 3023.7 3026.4 3030.9 3039.0 5865.9 5872.1 5914.3 5916.0 5932.8 5570.9 5741.9 5782.6 5801.5 5807.9 5874.5 5877.9 5896.4 5917.5 5962.5 5422.6 5664.8 5735.1 5747.3 5757.4 5618.2 5619.5 5621.3 5644.2 5657.2 5834.6 5845.0 5847.8 5849.3 5913.3 3959.9 4068.6 4097.8 4114.7 4115.6 5437.9 5659.3 5699.8 5701.4 5707.1 5466.7 5532.4 5552.2 5553.6 5634.2 5526.5 5584.5 5601.8 5617.6 5626.0 5307.3 5543.7 5552.8 5559.9 5587.4 5661.9 5662.2 5662.6 5666.6 5672.0 5446.4 5546.9 5597.4 5614.5 5625.7 11:28:21 INFO - PROCESS | 20846 | 11:28:21 INFO - PROCESS | 20846 | [#5] yui.html Cycles:180 Average:20490.75 Median:4732.60 stddev:28148.47 (594.8%) stddev-sans-first:28188.27 11:28:21 INFO - PROCESS | 20846 | Values: 716.2 745.1 746.3 762.0 792.3 14697.5 15098.4 15137.6 15171.9 15435.8 15365.2 15381.6 15479.8 15487.1 15503.0 673.3 801.4 815.0 815.3 816.0 791.2 809.9 810.6 815.5 816.9 861.9 864.9 865.5 871.4 871.7 694.4 823.8 864.7 865.1 865.6 615.2 615.3 615.8 616.0 616.4 15735.0 15748.9 15776.8 15781.1 15790.0 14595.9 14732.6 15001.5 15022.3 15369.4 13475.8 13566.3 13622.7 13793.5 14624.1 4444.1 4446.3 4455.1 4527.5 4545.5 84120.2 84582.6 86141.0 86361.6 86461.6 11784.2 11804.5 11839.7 11956.0 12560.6 23331.4 23491.3 23495.3 23501.3 23875.0 8795.3 8878.3 8925.4 8959.7 9117.4 4716.9 4718.9 4895.7 4923.2 4978.8 3383.4 3493.7 3505.1 3516.6 3521.8 579.3 581.4 582.1 599.1 614.0 630.6 642.6 644.3 672.4 680.2 8407.4 9222.9 9244.7 9372.9 9684.3 628.9 655.9 672.4 678.2 693.6 4361.7 4586.6 4746.3 4931.6 5286.7 71616.6 73148.0 73531.0 75157.0 119903.0 84645.0 87216.6 87440.6 109283.0 109374.0 71288.6 85129.6 89390.6 89880.0 90528.0 9406.9 10188.2 10223.9 10287.1 10396.7 52284.7 52947.2 53907.5 54583.7 55462.0 73222.3 74307.6 79795.0 80396.0 80636.0 13042.3 13141.9 13324.7 13324.7 13479.9 15183.8 15255.4 15618.7 15727.5 15747.8 13522.0 13631.7 13658.3 13820.2 14395.6 13571.6 13640.8 14096.5 14428.1 15032.4 13472.3 13851.2 13999.5 14051.0 14353.9 11218.4 11387.9 11391.7 11712.1 12078.8 11682.9 11771.2 11924.6 12050.5 12065.7 11:28:21 INFO - PROCESS | 20846 | -------- Summary: end -------- 11:28:21 INFO - PROCESS | 20846 | 11:28:22 INFO - TEST-INFO | 20846: exit 0 11:28:22 INFO - TEST-OK | dromaeo_css | took 1116595ms 11:28:22 INFO - TEST-START | kraken 11:28:22 INFO - operating with platform_type : linux_ 11:28:22 INFO - Initialising browser for kraken test... 11:28:22 INFO - TEST-INFO | started process 21160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY5H5BO/profile http://localhost:51735/getInfo.html) 11:28:26 INFO - PROCESS | 21160 | __metrics Screen width/height:1600/1200 11:28:26 INFO - PROCESS | 21160 | colorDepth:24 11:28:26 INFO - PROCESS | 21160 | Browser inner width/height: 1024/697 11:28:26 INFO - PROCESS | 21160 | __metrics 11:28:27 INFO - PROCESS | 21160 | 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:28:27 INFO - PROCESS | 21160 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:28:28 INFO - PROCESS | 21160 | console.error: PushService: 11:28:28 INFO - PROCESS | 21160 | stateChangeProcessEnqueue: Error transitioning state 11:28:28 INFO - PROCESS | 21160 | UnknownError 11:28:28 INFO - TEST-INFO | 21160: exit 0 11:28:28 INFO - Browser initialized. 11:28:28 INFO - Running cycle 1/1 for kraken test... 11:28:28 INFO - TEST-INFO | started process 21242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY5H5BO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:28:40 INFO - PROCESS | 21242 | RSS: Main: 180363264 11:28:40 INFO - PROCESS | 21242 | 11:28:43 INFO - PROCESS | 21242 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51735/tests/kraken/driver.html?testName=audio-beat-detection) 11:28:44 INFO - PROCESS | 21242 | RSS: Main: 233525248 11:28:44 INFO - PROCESS | 21242 | 11:28:46 INFO - PROCESS | 21242 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51735/tests/kraken/driver.html?testName=audio-dft) 11:28:47 INFO - PROCESS | 21242 | RSS: Main: 225427456 11:28:47 INFO - PROCESS | 21242 | 11:28:50 INFO - PROCESS | 21242 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51735/tests/kraken/driver.html?testName=audio-fft) 11:28:51 INFO - PROCESS | 21242 | RSS: Main: 301694976 11:28:51 INFO - PROCESS | 21242 | 11:28:53 INFO - PROCESS | 21242 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51735/tests/kraken/driver.html?testName=audio-oscillator) 11:28:53 INFO - PROCESS | 21242 | RSS: Main: 211881984 11:28:53 INFO - PROCESS | 21242 | 11:28:56 INFO - PROCESS | 21242 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51735/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:28:56 INFO - PROCESS | 21242 | RSS: Main: 213729280 11:28:56 INFO - PROCESS | 21242 | 11:28:59 INFO - PROCESS | 21242 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51735/tests/kraken/driver.html?testName=imaging-darkroom) 11:29:00 INFO - PROCESS | 21242 | RSS: Main: 252715008 11:29:00 INFO - PROCESS | 21242 | 11:29:03 INFO - PROCESS | 21242 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51735/tests/kraken/driver.html?testName=imaging-desaturate) 11:29:04 INFO - PROCESS | 21242 | RSS: Main: 251469824 11:29:04 INFO - PROCESS | 21242 | 11:29:07 INFO - PROCESS | 21242 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51735/tests/kraken/driver.html?testName=json-parse-financial) 11:29:07 INFO - PROCESS | 21242 | RSS: Main: 251371520 11:29:07 INFO - PROCESS | 21242 | 11:29:09 INFO - PROCESS | 21242 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51735/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:29:09 INFO - PROCESS | 21242 | RSS: Main: 213942272 11:29:09 INFO - PROCESS | 21242 | 11:29:11 INFO - PROCESS | 21242 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:29:12 INFO - PROCESS | 21242 | RSS: Main: 220794880 11:29:12 INFO - PROCESS | 21242 | 11:29:14 INFO - PROCESS | 21242 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:29:14 INFO - PROCESS | 21242 | RSS: Main: 222490624 11:29:14 INFO - PROCESS | 21242 | 11:29:17 INFO - PROCESS | 21242 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:29:18 INFO - PROCESS | 21242 | RSS: Main: 223506432 11:29:18 INFO - PROCESS | 21242 | 11:29:20 INFO - PROCESS | 21242 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:29:21 INFO - PROCESS | 21242 | RSS: Main: 221560832 11:29:21 INFO - PROCESS | 21242 | 11:29:23 INFO - PROCESS | 21242 | Cycle 1(1): loaded http://localhost:51735/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51735/tests/kraken/driver.html?testName=ai-astar) 11:29:23 INFO - PROCESS | 21242 | RSS: Main: 273031168 11:29:23 INFO - PROCESS | 21242 | 11:29:23 INFO - PROCESS | 21242 | __start_tp_report 11:29:23 INFO - PROCESS | 21242 | _x_x_mozilla_page_load 11:29:23 INFO - PROCESS | 21242 | _x_x_mozilla_page_load_details 11:29:23 INFO - PROCESS | 21242 | |i|pagename|runs| 11:29:23 INFO - PROCESS | 21242 | |0;ai-astar;114;112;131;113;112;111;114;111;112;111 11:29:23 INFO - PROCESS | 21242 | |1;audio-beat-detection;147;120;150;203;120;147;149;124;183;124 11:29:23 INFO - PROCESS | 21242 | |2;audio-dft;162;161;161;162;162;162;161;162;161;161 11:29:23 INFO - PROCESS | 21242 | |3;audio-fft;76;78;75;169;76;76;76;77;166;77 11:29:23 INFO - PROCESS | 21242 | |4;audio-oscillator;83;82;155;81;82;81;148;82;82;134 11:29:23 INFO - PROCESS | 21242 | |5;imaging-gaussian-blur;117;116;117;118;117;116;117;117;117;117 11:29:23 INFO - PROCESS | 21242 | |6;imaging-darkroom;145;145;145;145;145;146;149;147;148;148 11:29:23 INFO - PROCESS | 21242 | |7;imaging-desaturate;95;96;95;96;95;95;94;95;95;94 11:29:23 INFO - PROCESS | 21242 | |8;json-parse-financial;52;52;53;53;54;53;53;53;54;52 11:29:23 INFO - PROCESS | 21242 | |9;json-stringify-tinderbox;61;62;61;61;62;61;62;63;62;62 11:29:23 INFO - PROCESS | 21242 | |10;stanford-crypto-aes;79;87;78;79;79;79;78;78;77;87 11:29:23 INFO - PROCESS | 21242 | |11;stanford-crypto-ccm;130;123;126;125;132;135;133;125;184;138 11:29:23 INFO - PROCESS | 21242 | |12;stanford-crypto-pbkdf2;165;167;164;164;163;163;162;161;160;162 11:29:23 INFO - PROCESS | 21242 | |13;stanford-crypto-sha256-iterative;68;68;67;63;64;65;65;68;71;67 11:29:23 INFO - PROCESS | 21242 | __end_tp_report 11:29:23 INFO - PROCESS | 21242 | __start_cc_report 11:29:23 INFO - PROCESS | 21242 | _x_x_mozilla_cycle_collect,1737 11:29:23 INFO - PROCESS | 21242 | __end_cc_report 11:29:23 INFO - PROCESS | 21242 | __startTimestamp1472754563399__endTimestamp 11:29:23 INFO - PROCESS | 21242 | 11:29:23 INFO - PROCESS | 21242 | ------- Summary: start ------- 11:29:23 INFO - PROCESS | 21242 | Number of tests: 14 11:29:23 INFO - PROCESS | 21242 | 11:29:23 INFO - PROCESS | 21242 | [#0] ai-astar Cycles:10 Average:114.10 Median:112.50 stddev:6.05 (5.4%) stddev-sans-first:6.41 11:29:23 INFO - PROCESS | 21242 | Values: 114.0 112.0 131.0 113.0 112.0 111.0 114.0 111.0 112.0 111.0 11:29:23 INFO - PROCESS | 21242 | 11:29:23 INFO - PROCESS | 21242 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:148.00 stddev:27.81 (18.8%) stddev-sans-first:29.50 11:29:23 INFO - PROCESS | 21242 | Values: 147.0 120.0 150.0 203.0 120.0 147.0 149.0 124.0 183.0 124.0 11:29:23 INFO - PROCESS | 21242 | 11:29:23 INFO - PROCESS | 21242 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 11:29:23 INFO - PROCESS | 21242 | Values: 162.0 161.0 161.0 162.0 162.0 162.0 161.0 162.0 161.0 161.0 11:29:23 INFO - PROCESS | 21242 | 11:29:23 INFO - PROCESS | 21242 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:38.44 (50.6%) stddev-sans-first:40.17 11:29:23 INFO - PROCESS | 21242 | Values: 76.0 78.0 75.0 169.0 76.0 76.0 76.0 77.0 166.0 77.0 11:29:23 INFO - PROCESS | 21242 | 11:29:23 INFO - PROCESS | 21242 | [#4] audio-oscillator Cycles:10 Average:101.00 Median:82.00 stddev:31.24 (38.1%) stddev-sans-first:32.45 11:29:23 INFO - PROCESS | 21242 | Values: 83.0 82.0 155.0 81.0 82.0 81.0 148.0 82.0 82.0 134.0 11:29:23 INFO - PROCESS | 21242 | 11:29:23 INFO - PROCESS | 21242 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 11:29:23 INFO - PROCESS | 21242 | Values: 117.0 116.0 117.0 118.0 117.0 116.0 117.0 117.0 117.0 117.0 11:29:23 INFO - PROCESS | 21242 | 11:29:23 INFO - PROCESS | 21242 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:1.57 (1.1%) stddev-sans-first:1.59 11:29:23 INFO - PROCESS | 21242 | Values: 145.0 145.0 145.0 145.0 145.0 146.0 149.0 147.0 148.0 148.0 11:29:23 INFO - PROCESS | 21242 | 11:29:23 INFO - PROCESS | 21242 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 11:29:23 INFO - PROCESS | 21242 | Values: 95.0 96.0 95.0 96.0 95.0 95.0 94.0 95.0 95.0 94.0 11:29:23 INFO - PROCESS | 21242 | 11:29:23 INFO - PROCESS | 21242 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.74 (1.4%) stddev-sans-first:0.71 11:29:23 INFO - PROCESS | 21242 | Values: 52.0 52.0 53.0 53.0 54.0 53.0 53.0 53.0 54.0 52.0 11:29:23 INFO - PROCESS | 21242 | 11:29:23 INFO - PROCESS | 21242 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 11:29:23 INFO - PROCESS | 21242 | Values: 61.0 62.0 61.0 61.0 62.0 61.0 62.0 63.0 62.0 62.0 11:29:23 INFO - PROCESS | 21242 | 11:29:23 INFO - PROCESS | 21242 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.00 stddev:3.70 (4.7%) stddev-sans-first:3.90 11:29:23 INFO - PROCESS | 21242 | Values: 79.0 87.0 78.0 79.0 79.0 79.0 78.0 78.0 77.0 87.0 11:29:23 INFO - PROCESS | 21242 | 11:29:23 INFO - PROCESS | 21242 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:132.50 stddev:17.87 (13.5%) stddev-sans-first:18.85 11:29:23 INFO - PROCESS | 21242 | Values: 130.0 123.0 126.0 125.0 132.0 135.0 133.0 125.0 184.0 138.0 11:29:23 INFO - PROCESS | 21242 | 11:29:23 INFO - PROCESS | 21242 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:163.50 stddev:2.02 (1.2%) stddev-sans-first:2.03 11:29:23 INFO - PROCESS | 21242 | Values: 165.0 167.0 164.0 164.0 163.0 163.0 162.0 161.0 160.0 162.0 11:29:23 INFO - PROCESS | 21242 | 11:29:23 INFO - PROCESS | 21242 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.50 stddev:2.37 (3.5%) stddev-sans-first:2.46 11:29:23 INFO - PROCESS | 21242 | Values: 68.0 68.0 67.0 63.0 64.0 65.0 65.0 68.0 71.0 67.0 11:29:23 INFO - PROCESS | 21242 | -------- Summary: end -------- 11:29:23 INFO - PROCESS | 21242 | 11:29:24 INFO - TEST-INFO | 21242: exit 0 11:29:24 INFO - TEST-OK | kraken | took 62276ms 11:29:24 INFO - SUITE-END | took 1178s 11:29:25 INFO - Completed test suite (00:19:39) 11:29:25 INFO - javascript benchmark 11:29:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3034.651015133259, 3040.4375190589744, 3076.292452735869, 3092.4279008383464, 3125.5780469636593, 5255.921161182585, 5275.393329767078, 5328.520433161015, 5388.299521062261, 5431.321084864392, 5285.947140528594, 5310.283111779909, 5345.1447768357075, 5375.220593014011, 5391.81128660497, 4751.453582837966, 4805.663603547753, 4838.661293709441, 4850.514948505139, 5071.1886098224295, 5012.924806127893, 5024.522670346311, 5027.494893092076, 5062.670926389791, 5079.111155547783, 4774.594159496412, 4785.617150627942, 4830.396200474923, 4897.240927656219, 4901.975490122527, 4742.2886567014875, 4758.191107511731, 4762.714237145782, 4830.251311046758, 4871.488493708145, 4750.714957102585, 4783.569478746929, 4788.928166077511, 4801.039792041605, 4850.417949846006, 5162.896742065138, 5215.113430716788, 5272.630915835893, 5277.551408130275, 5351.464853514617, 5618.494335509783, 5634.549236061105, 5639.887202255932, 5640.5487560995025, 5714.771409143629, 5603.187537807036, 5674.063779476382, 5674.716264186774, 5680.091185410314, 5682.403347648478, 5113.463086375914, 5264.078786212397, 5295.391030031557, 5298.099323115041, 5317.548008419328, 5830.271216097988, 5845.064789633639, 5855.853603659943, 5881.852953676193, 5914.852128696817, 5586.497215250566, 5593.74828132735, 5596.188552659842, 5610.971945140248, 5613.663180209201, 5522.088855338824, 5663.150527420919, 5675.801346952837, 5683.119116536944, 5717.285339332583, 5730.169125476783, 5741.770329186869, 5742.052561327418, 5776.653400795965, 5808.5933984621515, 5693.202951586781, 5728.312602487728, 5730.1404789281105, 5732.369439361667, 5755.453231942959, 4233.428487154257, 4325.286327755948, 4338.783060846945, 4400.603945644907, 4449.998750281161, 3868.593797651206, 3873.205992771475, 3907.27715372657, 3919.0, 3937.842486300573, 5384.057789886754, 5387.057264978692, 5398.541124004425, 5406.243125962368, 5467.043267428184, 5531.529819965268, 5623.606347555714, 5631.63394379364, 5704.8859022819315, 5719.48524632785, 5354.544863686552, 5354.8661283467445, 5355.973220133875, 5379.892402151935, 5397.487238712316, 4815.566599006036, 4820.517948205222, 4837.32277481153, 4839.080574690797, 4887.853364399074, 5670.858228544319, 5804.955108080586, 5815.651060936358, 5822.446867547576, 5839.503642190291, 5667.093265077568, 5675.148727690879, 5677.659340439587, 5721.170430287668, 5740.68426236561, 5875.735591898289, 5880.500157486662, 5881.17663527098, 5886.646801191942, 5894.086416605433, 5319.654222475527, 5484.670919744828, 5525.0, 5582.944170558242, 5594.580406469449, 5653.0, 5655.0, 5665.150227465913, 5704.686242256716, 5726.341470730753, 5494.917576236439, 5553.4724201200825, 5554.91667624994, 5572.582056345871, 5575.581831362583, 5354.250404943233, 5528.502434780728, 5542.806001789918, 5542.944570554243, 5574.08027675429, 5556.333240011225, 5559.9444005561045, 5560.36055853582, 5609.074502707171, 5635.718214089361, 5652.7738890443925, 5685.403032681509, 5700.942990570041, 5705.0, 5707.315122185364, 5254.343207099113, 5261.0, 5421.349438067299, 5554.222408862844, 5567.777288908398], "value": 5242.340295928302, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.3798141035567, 600.96093753906, 622.4802290087775, 630.9305976342605, 640.5804198250148, 32023.83988080059, 46093.539064609344, 47329.0, 47384.76307618466, 47436.525634743644, 44929.0, 45261.32108018382, 45302.32046519296, 45373.0, 45404.77297613516, 7963.243491868292, 8881.95559022204, 9027.864582031274, 9033.322500812432, 9039.954800226022, 10525.315854469472, 10822.24244302899, 10828.837567436456, 11012.17408694347, 11018.834717479243, 10917.126629869592, 11010.229283950126, 11016.0, 11028.172887033465, 11032.062274706619, 8139.79650508742, 10685.679429617125, 10738.946305268462, 10813.513391897384, 10838.891611083907, 10341.948290258575, 10768.084712799422, 10786.08318292946, 10787.137029037658, 10789.784204315869, 42099.579004209874, 42523.57476425227, 42545.1490970182, 42547.36178957318, 42548.36177457341, 3601.603823579404, 3658.2700941634475, 3742.6631603155847, 3872.457855900176, 3947.4276229946786, 32073.0, 32253.51619725706, 32341.0, 32366.352672946643, 32620.347593048242, 4174.186033723395, 4321.0709697415205, 4339.761313127777, 4343.435353404069, 4390.736555806629, 337988.99999999756, 338150.0, 338520.0, 340302.0, 340680.0, 32739.672603273662, 33239.83380083084, 58862.41137588569, 59303.11045334324, 59404.40595593989, 37152.0, 37336.25327493435, 37567.0, 37617.0, 37622.247555049296, 14182.645433864029, 14306.928465357607, 14310.713785724436, 14312.0, 14325.713485730226, 11114.833277500844, 11152.0, 11323.207375483636, 12049.819252711217, 12133.21134126279, 8449.873251901226, 8492.363072769567, 8493.915060849313, 8585.82828343442, 8605.569721513899, 3284.1953721338423, 3311.9172020699193, 3322.850471728778, 3351.379994700988, 3358.0019888166503, 995.1938929467154, 1011.6610935336597, 1012.3773879064322, 1064.1008347945974, 1120.9831852522218, 31505.8424707875, 31613.683863161074, 31664.208394789854, 32694.0, 32911.67088329134, 1045.153425725165, 1119.776044791045, 1124.359115304285, 1157.8784227656142, 1169.2049406403557, 15794.21028948548, 16681.582960426087, 16774.916125419295, 16830.158492075592, 16980.32078716862, 455459.0, 457324.0, 457391.0, 458104.0, 459077.0, 54479.0, 54866.725666372215, 55002.44997549973, 55059.72470137704, 55102.173467398025, 1227.6623928419756, 1334.3928512526777, 1349.27813619713, 1383.0456984680538, 1390.9860901390857, 31559.684403156592, 33011.33977320488, 33789.493157603145, 34002.14994625055, 34116.658833412344, 50633.49366506435, 51367.48632513777, 51403.74298128486, 51441.485585145165, 51466.36802687776, 415539.0, 416798.0, 417574.0, 419499.0, 419634.0, 27949.720502795524, 29083.56374654424, 29131.0, 29992.25019374533, 30074.0, 47581.762091189325, 47713.0, 48110.759446202544, 48454.0, 49654.751726241135, 40334.12412033248, 40342.59657403389, 40785.79607101945, 41730.37404438875, 42393.576064240195, 40346.59653403546, 40784.388234175916, 41097.794511027256, 42239.0, 42658.78670606751, 40084.39873401843, 40219.0, 40693.0, 41232.1753564933, 41712.79143604262, 34825.65174348224, 36913.0, 37428.93051648782, 37706.8114659425, 37803.0, 27728.445431090862, 27817.0, 27978.440431190855, 28144.43711125807, 28148.85925570359], "value": 19125.666035617374, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.4933216826863, 387.40920096852307, 392.37808074202394, 392.6132759232156, 415.8918681142904, 16699.74950375745, 19151.808481915177, 19302.517437064063, 20428.795712042876, 20766.27318043869, 18651.0, 19476.415707528762, 19581.51046223845, 19874.40376788695, 19981.100850461728, 5556.583256255777, 5793.391693872146, 5956.374580669032, 6006.219191505098, 6024.548158888079, 5915.438033386843, 5942.168096466498, 5976.103584462322, 5980.700964951735, 5984.3716409777, 5573.164025396182, 5784.334801497839, 5808.477237048664, 5817.767289308423, 5955.9702201488935, 5615.073512870372, 5794.5943783935145, 5817.243758311435, 5819.30168379795, 5827.854303642401, 5172.655109671475, 5206.661566998133, 5224.582033437354, 5234.0, 5237.554807841338, 23149.7685023151, 23627.054917803267, 23896.88051559731, 23942.52114957691, 24015.63976540353, 2486.539990101837, 2503.887325070358, 2555.1440267510407, 2562.5515534781525, 2858.442603692281, 13901.652458688513, 14713.70572588553, 14833.554993350217, 14863.628409289855, 15534.61163470911, 1876.2588777432838, 1878.7275845002534, 1897.667908116088, 1911.0922311901736, 1955.6479833629942, 80816.0, 80909.0, 81649.18350816476, 82523.5873820633, 82889.18317040362, 9866.851997220047, 9961.551730172016, 9986.001399859955, 10036.34763740369, 10881.891181088087, 14625.92687036558, 14653.12081275127, 14660.413583456755, 14677.633059173393, 14685.486007989883, 7828.138904720477, 7920.5247685139075, 7988.600569971478, 8183.263506284463, 8193.918060819315, 7804.84390312202, 7825.413094017971, 7888.605569721491, 8036.035675718834, 8075.475094118863, 6383.202099737533, 6506.653644243682, 6558.311377305315, 6638.601683898982, 6671.566348187353, 1789.2216885654523, 1799.7210432383001, 1810.5835657798516, 1821.1440622907212, 1845.6250093680026, 441.8343121329501, 465.48563836960346, 907.4301458476872, 992.3450522655013, 1103.3490240757992, 11944.701382465508, 12059.879401205875, 12141.332226727614, 12161.69595760113, 12164.14850960442, 463.67311045712694, 470.35091573628176, 474.5776259129378, 477.87097483679213, 480.94469136049804, 6160.7535698571555, 6379.585326953826, 6467.611943283418, 6489.1888513935755, 6493.577917435352, 433825.0, 449922.0, 491076.0, 494743.0, 497947.0, 78654.606726966, 86856.0, 96424.0, 99783.0, 101026.0, 471.72168420631994, 476.2403965674743, 476.976151192439, 477.10304627301144, 482.43314105925396, 10993.61522346714, 11511.079113671054, 11556.942215289206, 11646.126540509325, 11735.530578776754, 43449.56550434455, 43612.34581481217, 43725.562744372146, 44051.559484404745, 45687.771561141984, 60275.69862150837, 60371.0, 60859.39140608715, 61043.38956610377, 61546.384536154066, 8139.4709343892455, 8297.917020829957, 8466.66133354659, 8592.441491303045, 8793.296536276954, 11029.283096598696, 11625.18623696333, 11833.0, 12534.247945122957, 12706.18814355671, 11030.0, 11454.484548195185, 11463.770724585629, 11756.470958807045, 12064.75870482568, 11363.488643010918, 11604.361760102938, 11639.6508104757, 11720.589779357682, 12319.876801231872, 11260.268082574607, 11764.411779410824, 11908.761824763284, 11990.40047997614, 12358.505659773868, 8010.759677209693, 8409.2431681149, 8428.157184281523, 8734.825303493768, 8756.78108047304, 11666.343953092435, 11865.40672966331, 11955.76088478243, 11978.161528692908, 12003.219790713576], "value": 8597.385786160441, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1476.0627001853823, 1502.7670711039789, 1654.7435147552126, 1742.468547093136, 1806.376800003999, 8182.91817081829, 8791.64833406663, 8802.735917922473, 8807.559622018898, 8808.383413161073, 7186.35322820946, 8242.464239824421, 8464.788380290496, 8485.618147183377, 8608.26829719473, 2400.5558971590267, 2421.503591763684, 2422.1401402502124, 2430.3924018995253, 2435.659007738918, 2395.0659242895285, 2395.832291739579, 2431.9756802432016, 2449.155041510676, 2450.2281781238853, 2398.6521954316613, 2401.555712193241, 2418.830681852271, 2425.1754403502805, 2430.8176886733477, 2359.2096647623066, 2372.063035101134, 2378.1914149189274, 2386.6539351793895, 2391.9521609567796, 2330.8462311155918, 2334.159702507096, 2334.1830359374253, 2345.57779599672, 2345.683332750074, 8588.141185881424, 8608.139186081404, 8683.869741953877, 8688.652453901836, 8707.34694897879, 5023.949760502384, 5148.639595228336, 5153.793848246103, 5163.922541161885, 5166.250893620441, 3234.4663130583426, 3397.286569820341, 3447.620761716209, 3463.1515278756615, 3475.548178736748, 1083.6748975307455, 1107.141964977141, 1119.9888001119966, 1135.454981608824, 1136.323887287063, 11807.114466414967, 11858.940705296505, 11884.10869184806, 11955.402229888557, 11960.34218118003, 4360.171567402183, 4535.31970204472, 4641.721496710208, 4688.226442636927, 4721.102990431807, 10021.699349019542, 10029.197664186848, 10032.247581431422, 10041.347312424668, 10048.145907597936, 5292.655977361459, 5330.520253177233, 5338.039152952506, 5346.732663366816, 5350.0904846176245, 4122.876313710593, 4154.314538101179, 4272.316429371285, 4801.0, 4903.901921961541, 3877.8836634901, 4053.2704113259897, 4093.959060409358, 4127.050778320943, 4158.438610787565, 1311.672081979505, 1342.664333916521, 1359.5581436033328, 1363.9454421823214, 1368.0970559430727, 979.1921664626711, 980.2501086668705, 994.2145704893198, 999.4453078541334, 1006.1648831469862, 5776.7002424455, 5836.970815145897, 5915.970420147872, 5932.851678708067, 5998.310194327621, 436.44571394329023, 437.76798296902695, 440.2252036415931, 450.0436572283897, 450.7250577147937, 4212.831486740557, 4222.535521092677, 4227.534971153171, 4233.0, 4235.470566179228, 10127.493625318704, 10539.209559283085, 10563.419011954262, 10569.841452378221, 10570.048695617432, 10434.634787782543, 10467.895321046844, 10478.847326794046, 10486.056254937092, 10494.422806745702, 7733.110692270461, 8092.150324215991, 8118.2693557580105, 8285.212904773916, 8287.12985136552, 5978.940210597838, 6047.516198704181, 6151.538634602333, 6171.3828617139725, 6332.240131184103, 9579.952100239454, 9738.853917191389, 9978.700638980552, 9982.900170998488, 10055.648052318134, 9740.561674724513, 9830.4101753895, 10058.49707514636, 10078.647247346307, 10080.69757907264, 7103.112110986127, 7291.453141014551, 7361.26387361281, 7651.234876512304, 7770.7668769934735, 8303.211194936472, 8311.95844020776, 8393.496390216607, 8402.159784021549, 8406.87389689143, 7086.50394472382, 7438.814029649302, 7535.886961695469, 7580.810479738051, 7716.2669546393, 7046.154461464657, 7139.500234983501, 7303.63481825896, 7438.442116841366, 7493.70025198986, 6667.433268172065, 6691.130153080068, 6703.128593282842, 6716.731330746716, 6730.93269067303, 5017.448080711192, 5096.362954630671, 5136.768845402041, 5148.871278217925, 5182.922256166236, 4969.676970996874, 5090.338256026841, 5222.451642577626, 5301.5493683037375, 5324.8136315228785], "value": 4521.942675066088, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.6655545622089, 317.25128696276784, 318.1568842567198, 318.49359518365793, 321.5755203131867, 5061.9876024795, 5217.686938783676, 5242.475752424755, 5290.867728306789, 5302.1781623848265, 5243.711595862226, 5272.8154514592, 5288.286081379013, 5288.312519372476, 5295.867603309919, 4152.709310348277, 4157.771322577257, 4162.458880345551, 4173.916521669573, 4174.666026717855, 3963.9405408918888, 4103.384492326145, 4161.687873409506, 4171.040660648053, 4172.687048471362, 4077.103037331797, 4079.796010199493, 4093.385992101179, 4099.856505022325, 4115.464989551354, 4075.286824805662, 4079.4084857695766, 4092.1406504634065, 4097.713160078795, 4099.836006559734, 3463.510690403126, 3523.136831476279, 3575.6245594212755, 3581.459972211948, 3593.2454184621, 5175.611829112794, 5178.844634660966, 5184.637075404723, 5191.974040129813, 5198.9740051299505, 4632.119897219518, 4637.489876113625, 4638.791254393526, 4657.790399432034, 4694.647901407408, 5359.008583412081, 5459.69971651559, 5483.7806487740445, 5487.0, 5518.448155184489, 3905.7070719696135, 3910.608939106095, 3910.687145028391, 3915.647591716731, 3919.4708714323488, 5716.142578613241, 5757.309122905236, 5773.6431938494425, 5773.653580785166, 5777.480026797609, 3915.451836742858, 3949.6840252779707, 3950.5654378018394, 4000.0, 4029.7783621901076, 4031.899202519902, 4033.5361433435532, 4038.2932986727205, 4064.207479541461, 4074.898127546835, 4693.882652933704, 4711.929321060187, 4717.78769955346, 4722.268048452495, 4725.929111063337, 5347.465253474621, 5590.329160500766, 5609.102543593087, 5632.436756324335, 5638.802641907513, 1307.3528603341406, 1371.9588412347646, 1389.8818600419077, 1391.7703578909568, 1393.958181254564, 916.1617120334952, 937.6765016069445, 949.9550494456043, 953.1374106433689, 956.6269155029544, 5313.920291195635, 5314.92027619586, 5315.554844771448, 5321.414644389114, 5329.840104796862, 5590.217369568264, 5597.972010139923, 5600.915986260209, 5602.775888964396, 5605.159226116115, 5119.539241468286, 5343.7060961647485, 5361.651492652965, 5412.539934105645, 5420.566354691615, 2986.7759918006236, 3023.712747289004, 3026.44010857992, 3030.863611137504, 3038.9848050759606, 5865.853353666193, 5872.120921305142, 5914.290285165722, 5915.970420147872, 5932.783779325228, 5570.857974115296, 5741.85645358861, 5782.566307526952, 5801.549612596851, 5807.88384232313, 5874.530037596982, 5877.853053673607, 5896.439838215363, 5917.46742793142, 5962.4633782959745, 5422.593305502182, 5664.830055098354, 5735.139729040678, 5747.339056008613, 5757.3954734753925, 5618.2134501170685, 5619.494245517923, 5621.297337832771, 5644.153376993484, 5657.161422537774, 5834.620749651429, 5845.0, 5847.795327163699, 5849.268841394825, 5913.29040515141, 3959.9010024749614, 4068.5727998559723, 4097.815598298143, 4114.732542384735, 4115.609017143366, 5437.945620543902, 5659.3491748447805, 5699.829005129853, 5701.429857014431, 5707.143928410772, 5466.671999680032, 5532.391436942014, 5552.194931734956, 5553.611247212656, 5634.211210430461, 5526.50261476469, 5584.497395234448, 5601.7759289629585, 5617.550595952396, 5626.0, 5307.256984022317, 5543.722813859372, 5552.833414997556, 5559.861003474945, 5587.441255874543, 5661.858453538694, 5662.235598194191, 5662.603617746719, 5666.603337766317, 5672.0, 5446.400895901527, 5546.861328466821, 5597.356304024926, 5614.466625670555, 5625.746841392229], "value": 4217.962026682723, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.1835507521427, 745.0575022596415, 746.3022074360473, 762.0208032678009, 792.2671528835825, 14697.485588004422, 15098.396064157434, 15137.621559461018, 15171.924140379282, 15435.768463473029, 15365.154916479589, 15381.615459613515, 15479.767803482957, 15487.070775753462, 15503.0, 673.2896793882452, 801.3549092980148, 815.0138332617511, 815.3477218225426, 815.9592020398986, 791.2048391366668, 809.9433039687224, 810.5744484145841, 815.4943934760457, 816.9223923727266, 861.9094995025526, 864.9005364383114, 865.4807115730574, 871.3856731004627, 871.6861929705301, 694.3958755882364, 823.7611092783086, 864.6541383446609, 865.0873328638253, 865.6277800545763, 615.2401783797008, 615.2924137242162, 615.7690865925279, 616.0, 616.3589866538795, 15735.0, 15748.921255393765, 15776.76334854978, 15781.13203773792, 15790.0, 14595.854041459555, 14732.55802325932, 15001.549953501413, 15022.323995420233, 15369.385224591002, 13475.797863032063, 13566.321683915863, 13622.727545449035, 13793.517226897011, 14624.12255264677, 4444.111177764427, 4446.288593824973, 4455.086707225011, 4527.479339875924, 4545.477270113946, 84120.15879841184, 84582.5770871154, 86141.0, 86361.56819215926, 86461.56769216177, 11784.234024788362, 11804.46879890407, 11839.704007399712, 11956.043516518657, 12560.623181304576, 23331.416714582272, 23491.295261142193, 23495.295141145452, 23501.294961151194, 23875.0, 8795.340349473816, 8878.334124940655, 8925.353220554982, 8959.73120806377, 9117.366601771937, 4716.88207794801, 4718.88202794926, 4895.73073480962, 4923.236898280772, 4978.800847966113, 3383.4417321142228, 3493.737969652286, 3505.053635518396, 3516.613172551017, 3521.7710848794745, 579.3366595248417, 581.3721181124375, 582.0715958046908, 599.0624672387786, 613.9907901381483, 630.6184758221302, 642.5534253693731, 644.3073695777058, 672.3914857054374, 680.1941989294162, 8407.411481196257, 9222.907770922338, 9244.676436324697, 9372.8594071089, 9684.322097453252, 628.924529056507, 655.8622689235218, 672.4015626092781, 678.2166597579803, 693.552658535252, 4361.651067914623, 4586.555621653751, 4746.311784791186, 4931.630127740434, 5286.682799032071, 71616.64191679009, 73148.0, 73531.0, 75157.0, 119903.0, 84645.0, 87216.56391718001, 87440.5627971856, 109283.0, 109374.0, 71288.64355678292, 85129.57435212785, 89390.55304723435, 89880.0, 90528.0, 9406.895724410791, 10188.235882308709, 10223.948880255848, 10287.125594324267, 10396.688099357032, 52284.738576306874, 52947.20579191238, 53907.46092539181, 54583.72708136434, 55462.0, 73222.26777732368, 74307.62846185734, 79795.0, 80396.0, 80636.0, 13042.347882606022, 13141.868581314448, 13324.733505329645, 13324.733505330032, 13479.932600336935, 15183.848161518243, 15255.389784408499, 15618.687626247638, 15727.528174154793, 15747.763783543027, 13522.0, 13631.727365452834, 13658.292713410823, 13820.170789752647, 14395.640108997359, 13571.592852214055, 13640.79538806899, 14096.50662226817, 14428.134311941318, 15032.3548999533, 13472.259025753285, 13851.235564385943, 13999.51001714935, 14051.0, 14353.92823035878, 11218.439078046229, 11387.910958393875, 11391.715207119889, 11712.121590880888, 12078.818817717916, 11682.88317116818, 11771.23486973344, 11924.565182703034, 12050.457729402022, 12065.698357540781], "value": 7650.983614216914, "unit": "score"}], "name": "dromaeo_css", "value": 7078.634379818339, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 131.0, 113.0, 112.0, 111.0, 114.0, 111.0, 112.0, 111.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 120.0, 150.0, 203.0, 120.0, 147.0, 149.0, 124.0, 183.0, 124.0], "value": 146.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 162.0, 162.0, 161.0, 162.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 75.0, 169.0, 76.0, 76.0, 76.0, 77.0, 166.0, 77.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 155.0, 81.0, 82.0, 81.0, 148.0, 82.0, 82.0, 134.0], "value": 101.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 149.0, 147.0, 148.0, 148.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 53.0, 54.0, 53.0, 53.0, 53.0, 54.0, 52.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0, 63.0, 62.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 87.0, 78.0, 79.0, 79.0, 79.0, 78.0, 78.0, 77.0, 87.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 123.0, 126.0, 125.0, 132.0, 135.0, 133.0, 125.0, 184.0, 138.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 164.0, 164.0, 163.0, 163.0, 162.0, 161.0, 160.0, 162.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 63.0, 64.0, 65.0, 65.0, 68.0, 71.0, 67.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1535.5999999999997, "alertThreshold": 2.0}]} 11:29:25 INFO - Return code: 0 11:29:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:29:25 INFO - # TBPL SUCCESS # 11:29:25 INFO - Running post-action listener: _resource_record_post_action 11:29:25 INFO - [mozharness: 2016-09-01 18:29:25.194584Z] Finished run-tests step (success) 11:29:25 INFO - Running post-run listener: _resource_record_post_run 11:29:25 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 418148352; Read time: 8; Write time: 409328 11:29:25 INFO - TinderboxPrint: CPU usage
13.0% 11:29:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:29:25 INFO - TinderboxPrint: I/O write bytes / time
418,148,352 / 409,328 11:29:25 INFO - TinderboxPrint: CPU idle
8,297.5 (86.9%) 11:29:25 INFO - TinderboxPrint: CPU user
1,194.7 (12.5%) 11:29:25 INFO - TinderboxPrint: Swap in / out
0 / 0 11:29:25 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 128831488; Read time: 0; Write time: 120080 11:29:25 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288718848; Read time: 0; Write time: 289196 11:29:25 INFO - Running post-run listener: _upload_blobber_files 11:29:25 INFO - Blob upload gear active. 11:29:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:29:25 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 11:29:25 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'] 11:29:25 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 11:29:26 INFO - (blobuploader) - INFO - Open directory for files ... 11:29:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:29:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:29:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:29 INFO - (blobuploader) - INFO - Done attempting. 11:29:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:29:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:29:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:30 INFO - (blobuploader) - INFO - Done attempting. 11:29:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:29:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:29:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:29:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:29:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:29:31 INFO - (blobuploader) - INFO - Done attempting. 11:29:31 INFO - (blobuploader) - INFO - Iteration through files over. 11:29:31 INFO - Return code: 0 11:29:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:29:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:29:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/396d2eb15554c280cef1d32043662cdd50f61e645983aef3642f3d61369837e9b2531d75831f8fa847d440b08a740c7659332660ff304ac69c441646b95f55be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5725a116cfc9583c432b9016efebfb1fcdcaf5b4cc11f23fc2d3a988eeff218238b8c165447a7a3469ecbc70fbda330e7e8e01aa9c90557922a306971cd9a377", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94369712d811e97a931f129c51474eee381071770c3edade89df84e3e22a185186c173dbde0165cffa41594f55d7256ecb7425095a3c68d27f7702617bd779a9"} 11:29:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:29:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:29:31 INFO - Contents: 11:29:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/396d2eb15554c280cef1d32043662cdd50f61e645983aef3642f3d61369837e9b2531d75831f8fa847d440b08a740c7659332660ff304ac69c441646b95f55be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5725a116cfc9583c432b9016efebfb1fcdcaf5b4cc11f23fc2d3a988eeff218238b8c165447a7a3469ecbc70fbda330e7e8e01aa9c90557922a306971cd9a377", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94369712d811e97a931f129c51474eee381071770c3edade89df84e3e22a185186c173dbde0165cffa41594f55d7256ecb7425095a3c68d27f7702617bd779a9"} 11:29:31 INFO - Running post-run listener: copy_logs_to_upload_dir 11:29:31 INFO - Copying logs to upload dir... 11:29:31 INFO - mkdir: /builds/slave/test/build/upload/logs 11:29:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.303690 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-01 11:29:31.160363) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 11:29:31.164091) ========= 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=d2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230 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/396d2eb15554c280cef1d32043662cdd50f61e645983aef3642f3d61369837e9b2531d75831f8fa847d440b08a740c7659332660ff304ac69c441646b95f55be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5725a116cfc9583c432b9016efebfb1fcdcaf5b4cc11f23fc2d3a988eeff218238b8c165447a7a3469ecbc70fbda330e7e8e01aa9c90557922a306971cd9a377", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94369712d811e97a931f129c51474eee381071770c3edade89df84e3e22a185186c173dbde0165cffa41594f55d7256ecb7425095a3c68d27f7702617bd779a9"} build_url:https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011369 build_url: 'https://queue.taskcluster.net/v1/task/Y2u0Olu_QA-kAXK8JCkH1A/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/396d2eb15554c280cef1d32043662cdd50f61e645983aef3642f3d61369837e9b2531d75831f8fa847d440b08a740c7659332660ff304ac69c441646b95f55be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5725a116cfc9583c432b9016efebfb1fcdcaf5b4cc11f23fc2d3a988eeff218238b8c165447a7a3469ecbc70fbda330e7e8e01aa9c90557922a306971cd9a377", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94369712d811e97a931f129c51474eee381071770c3edade89df84e3e22a185186c173dbde0165cffa41594f55d7256ecb7425095a3c68d27f7702617bd779a9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 11:29:31.189837) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 11:29:31.190213) ========= 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=d2a8c569965ab8367867b893000001a1-1472752907.792094-1941088230 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 11:29:31.274768) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 11:29:31.275114) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 11:29:31.275431) ========= ========= Total master_lag: 0.19 =========