builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1472575498.89 results: success (0) buildid: 20160830065621 builduid: a730868a64b54429a50884c6ee4274ec revision: b18c8bcdc116eef8799880b7c50317bf54218474 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 09:44:58.890249) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 09:44:58.890714) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 09:44:58.890992) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 09:44:58.905446) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 09:44:58.905748) ========= 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=14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-30 09:44:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-08-30 09:44:59 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118191 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 09:44:59.037859) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 09:44:59.038204) ========= 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=14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017257 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 09:44:59.088084) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 09:44:59.088453) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b18c8bcdc116eef8799880b7c50317bf54218474 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b18c8bcdc116eef8799880b7c50317bf54218474 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-30 09:44:59,129 truncating revision to first 12 chars 2016-08-30 09:44:59,129 Setting DEBUG logging. 2016-08-30 09:44:59,129 attempt 1/10 2016-08-30 09:44:59,129 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b18c8bcdc116?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 09:44:59,455 unpacking tar archive at: fx-team-b18c8bcdc116/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638843 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 09:44:59.740667) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 09:44:59.740987) ========= script_repo_revision: b18c8bcdc116eef8799880b7c50317bf54218474 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 09:44:59.741380) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 09:44:59.741643) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 09:44:59.750290) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-30 09:44:59.750563) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:44:59 INFO - MultiFileLogger online at 20160830 09:44:59 in /builds/slave/test 09:44:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:44:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:44:59 INFO - {'append_to_log': False, 09:44:59 INFO - 'base_work_dir': '/builds/slave/test', 09:44:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:44:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:44:59 INFO - 'branch': 'Fx-Team-Non-PGO', 09:44:59 INFO - 'buildbot_json_path': 'buildprops.json', 09:44:59 INFO - 'config_files': ('talos/linux_config.py',), 09:44:59 INFO - 'default_actions': ('clobber', 09:44:59 INFO - 'read-buildbot-config', 09:44:59 INFO - 'download-and-extract', 09:44:59 INFO - 'populate-webroot', 09:44:59 INFO - 'create-virtualenv', 09:44:59 INFO - 'install', 09:44:59 INFO - 'run-tests'), 09:44:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:44:59 INFO - 'download_minidump_stackwalk': True, 09:44:59 INFO - 'download_symbols': 'ondemand', 09:44:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:44:59 INFO - 'tooltool.py': '/tools/tooltool.py', 09:44:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:44:59 INFO - '/tools/misc-python/virtualenv.py')}, 09:44:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:44:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:44:59 INFO - 'installer_path': 'installer.exe', 09:44:59 INFO - 'log_level': 'info', 09:44:59 INFO - 'log_name': 'talos', 09:44:59 INFO - 'log_to_console': True, 09:44:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:44:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:44:59 INFO - 'opt_config_files': (), 09:44:59 INFO - 'pip_index': False, 09:44:59 INFO - 'sps_profile': False, 09:44:59 INFO - 'sps_profile_interval': 0, 09:44:59 INFO - 'suite': 'dromaeojs-e10s', 09:44:59 INFO - 'system_bits': '32', 09:44:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:44:59 INFO - 'title': 'talos-linux64-ix-036', 09:44:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:44:59 INFO - 'use_talos_json': True, 09:44:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:44:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:44:59 INFO - 'work_dir': 'build'} 09:44:59 INFO - [mozharness: 2016-08-30 16:44:59.879329Z] Running clobber step. 09:44:59 INFO - Running pre-action listener: _resource_record_pre_action 09:44:59 INFO - Running main action method: clobber 09:44:59 INFO - rmtree: /builds/slave/test/build 09:44:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:45:00 INFO - Running post-action listener: _resource_record_post_action 09:45:00 INFO - [mozharness: 2016-08-30 16:45:00.334336Z] Finished clobber step (success) 09:45:00 INFO - [mozharness: 2016-08-30 16:45:00.334438Z] Running read-buildbot-config step. 09:45:00 INFO - Running pre-action listener: _resource_record_pre_action 09:45:00 INFO - Running main action method: read_buildbot_config 09:45:00 INFO - Using buildbot properties: 09:45:00 INFO - { 09:45:00 INFO - "project": "", 09:45:00 INFO - "product": "firefox", 09:45:00 INFO - "script_repo_revision": "production", 09:45:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:45:00 INFO - "repository": "", 09:45:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:45:00 INFO - "buildid": "20160830065621", 09:45:00 INFO - "pgo_build": "False", 09:45:00 INFO - "basedir": "/builds/slave/test", 09:45:00 INFO - "buildnumber": 1553, 09:45:00 INFO - "slavename": "talos-linux64-ix-036", 09:45:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:45:00 INFO - "platform": "ubuntu64_hw", 09:45:00 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 09:45:00 INFO - "branch": "fx-team", 09:45:00 INFO - "repo_path": "integration/fx-team", 09:45:00 INFO - "revision": "b18c8bcdc116eef8799880b7c50317bf54218474", 09:45:00 INFO - "stage_platform": "linux64", 09:45:00 INFO - "builduid": "a730868a64b54429a50884c6ee4274ec", 09:45:00 INFO - "slavebuilddir": "test" 09:45:00 INFO - } 09:45:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 09:45:00 INFO - Running post-action listener: _resource_record_post_action 09:45:00 INFO - [mozharness: 2016-08-30 16:45:00.336892Z] Finished read-buildbot-config step (success) 09:45:00 INFO - [mozharness: 2016-08-30 16:45:00.336982Z] Running download-and-extract step. 09:45:00 INFO - Running pre-action listener: _resource_record_pre_action 09:45:00 INFO - Running main action method: download_and_extract 09:45:00 INFO - mkdir: /builds/slave/test/build/tests 09:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:00 INFO - trying https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:45:00 INFO - Downloading https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 09:45:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 09:45:00 INFO - Downloaded 1361 bytes. 09:45:00 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:45:00 INFO - Using the following test package requirements: 09:45:00 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:45:00 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:45:00 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:45:00 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:00 INFO - u'jsshell-linux-x86_64.zip'], 09:45:00 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:45:00 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:45:00 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:45:00 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:45:00 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:45:00 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:45:00 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:45:00 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:00 INFO - trying https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:45:00 INFO - Downloading https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 09:45:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 09:45:01 INFO - Downloaded 20315467 bytes. 09:45:01 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 09:45:06 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 09:45:06 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')]} 09:45:06 INFO - trying https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:45:06 INFO - Downloading https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 09:45:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 09:45:06 INFO - Downloaded 20315467 bytes. 09:45:06 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 09:45:11 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')]} 09:45:11 INFO - trying https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:45:11 INFO - Downloading https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 09:45:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 09:45:12 INFO - Downloaded 14413998 bytes. 09:45:12 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 09:45: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')]} 09:45:12 INFO - trying https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:45:12 INFO - Downloading https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 09:45:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/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 09:45:13 INFO - Downloaded 55850750 bytes. 09:45:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:45:13 INFO - mkdir: /builds/slave/test/properties 09:45:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:45:13 INFO - Writing to file /builds/slave/test/properties/build_url 09:45:13 INFO - Contents: 09:45:13 INFO - build_url:https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:45:14 INFO - Running post-action listener: _resource_record_post_action 09:45:14 INFO - Running post-action listener: set_extra_try_arguments 09:45:14 INFO - [mozharness: 2016-08-30 16:45:14.362371Z] Finished download-and-extract step (success) 09:45:14 INFO - [mozharness: 2016-08-30 16:45:14.362600Z] Running populate-webroot step. 09:45:14 INFO - Running pre-action listener: _resource_record_pre_action 09:45:14 INFO - Running main action method: populate_webroot 09:45:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:45:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:45:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:45:14 INFO - '--tppagecycles', 09:45:14 INFO - '7'], 09:45:14 INFO - 'tests': ['tsvgm']}}, 09:45:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:45:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:45:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:45:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:45:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:14 INFO - 'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:14 INFO - 'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['damp', 'tps']}, 09:45:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:14 INFO - 'tests': ['damp', 'tps']}, 09:45:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['dromaeo_dom']}, 09:45:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:45:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['basic_compositor_video']}, 09:45:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:45:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['a11yr', 09:45:14 INFO - 'ts_paint', 09:45:14 INFO - 'tpaint', 09:45:14 INFO - 'sessionrestore', 09:45:14 INFO - 'sessionrestore_no_auto_restore', 09:45:14 INFO - 'tabpaint']}, 09:45:14 INFO - 'other-e10s': {'tests': ['a11yr', 09:45:14 INFO - 'ts_paint', 09:45:14 INFO - 'tpaint', 09:45:14 INFO - 'sessionrestore', 09:45:14 INFO - 'sessionrestore_no_auto_restore', 09:45:14 INFO - 'tabpaint']}, 09:45:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:45:14 INFO - 'ts_paint', 09:45:14 INFO - 'tpaint', 09:45:14 INFO - 'sessionrestore', 09:45:14 INFO - 'sessionrestore_no_auto_restore', 09:45:14 INFO - 'tabpaint']}, 09:45:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:45:14 INFO - 'ts_paint', 09:45:14 INFO - 'tpaint', 09:45:14 INFO - 'sessionrestore', 09:45:14 INFO - 'sessionrestore_no_auto_restore', 09:45:14 INFO - 'tabpaint']}, 09:45:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['a11yr', 09:45:14 INFO - 'ts_paint', 09:45:14 INFO - 'tpaint', 09:45:14 INFO - 'sessionrestore', 09:45:14 INFO - 'sessionrestore_no_auto_restore', 09:45:14 INFO - 'tabpaint']}, 09:45:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['a11yr', 09:45:14 INFO - 'ts_paint', 09:45:14 INFO - 'tpaint', 09:45:14 INFO - 'sessionrestore', 09:45:14 INFO - 'sessionrestore_no_auto_restore', 09:45:14 INFO - 'tabpaint']}, 09:45:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['tsvgx', 09:45:14 INFO - 'tsvgr_opacity', 09:45:14 INFO - 'tart', 09:45:14 INFO - 'tscrollx', 09:45:14 INFO - 'cart']}, 09:45:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:45:14 INFO - 'tsvgr_opacity', 09:45:14 INFO - 'tart', 09:45:14 INFO - 'tscrollx', 09:45:14 INFO - 'cart']}, 09:45:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:14 INFO - 'talos_options': ['--disable-e10s'], 09:45:14 INFO - 'tests': ['tp5o']}, 09:45:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:14 INFO - 'tests': ['tp5o']}, 09:45:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:14 INFO - 'talos_options': ['--disable-e10s', 09:45:14 INFO - '--xperf_path', 09:45:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:14 INFO - 'tests': ['tp5n']}, 09:45:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:14 INFO - 'talos_options': ['--xperf_path', 09:45:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:14 INFO - 'tests': ['tp5n']}}, 09:45:14 INFO - 'talos.zip': {'path': '', 09:45:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:45:14 INFO - Running post-action listener: _resource_record_post_action 09:45:14 INFO - [mozharness: 2016-08-30 16:45:14.382484Z] Finished populate-webroot step (success) 09:45:14 INFO - [mozharness: 2016-08-30 16:45:14.382574Z] Running create-virtualenv step. 09:45:14 INFO - Running pre-action listener: _resource_record_pre_action 09:45:14 INFO - Running main action method: create_virtualenv 09:45:14 INFO - Creating virtualenv /builds/slave/test/build/venv 09:45:14 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 09:45:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:45:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:45:14 INFO - Using real prefix '/usr' 09:45:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:45:15 INFO - Installing distribute.............................................................................................................................................................................................done. 09:45:16 INFO - Installing pip.................done. 09:45:16 INFO - Return code: 0 09:45:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:45: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')]} 09:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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')]} 09:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4bfb0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea3090>, '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 0xea69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea6e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', '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 09:45: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', 'pip>=1.5'] in /builds/slave/test/build 09:45: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 pip>=1.5 09:45:16 INFO - Using env: {'DISPLAY': ':0', 09:45:16 INFO - 'HOME': '/home/cltbld', 09:45:16 INFO - 'LANG': 'en_US.UTF-8', 09:45:16 INFO - 'LANGUAGE': 'en_US:en', 09:45:16 INFO - 'LOGNAME': 'cltbld', 09:45:16 INFO - 'MAIL': '/var/mail/cltbld', 09:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:16 INFO - 'MOZ_NO_REMOTE': '1', 09:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:16 INFO - 'NO_EM_RESTART': '1', 09:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:16 INFO - 'PWD': '/builds/slave/test', 09:45:16 INFO - 'SHELL': '/bin/bash', 09:45:16 INFO - 'SHLVL': '1', 09:45:16 INFO - 'TERM': 'linux', 09:45:16 INFO - 'TMOUT': '86400', 09:45:16 INFO - 'USER': 'cltbld', 09:45:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', 09:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:16 INFO - '_': '/tools/buildbot/bin/python'} 09:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:17 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 09:45:17 INFO - Cleaning up... 09:45:17 INFO - Return code: 0 09:45:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:45: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')]} 09:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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')]} 09:45:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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', '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 0x7f4bfb0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea3090>, '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 0xea69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea6e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', '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 09:45: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', 'psutil>=3.1.1'] in /builds/slave/test/build 09:45: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 psutil>=3.1.1 09:45:17 INFO - Using env: {'DISPLAY': ':0', 09:45:17 INFO - 'HOME': '/home/cltbld', 09:45:17 INFO - 'LANG': 'en_US.UTF-8', 09:45:17 INFO - 'LANGUAGE': 'en_US:en', 09:45:17 INFO - 'LOGNAME': 'cltbld', 09:45:17 INFO - 'MAIL': '/var/mail/cltbld', 09:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:17 INFO - 'MOZ_NO_REMOTE': '1', 09:45:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:17 INFO - 'NO_EM_RESTART': '1', 09:45:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:17 INFO - 'PWD': '/builds/slave/test', 09:45:17 INFO - 'SHELL': '/bin/bash', 09:45:17 INFO - 'SHLVL': '1', 09:45:17 INFO - 'TERM': 'linux', 09:45:17 INFO - 'TMOUT': '86400', 09:45:17 INFO - 'USER': 'cltbld', 09:45:17 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', 09:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:17 INFO - '_': '/tools/buildbot/bin/python'} 09:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:17 INFO - Downloading/unpacking psutil>=3.1.1 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:45:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:19 INFO - Installing collected packages: psutil 09:45:19 INFO - Running setup.py install for psutil 09:45:19 INFO - building 'psutil._psutil_linux' extension 09:45:19 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 09:45:19 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 09:45:19 INFO - building 'psutil._psutil_posix' extension 09:45:19 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 09:45:19 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 09:45:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:19 INFO - Successfully installed psutil 09:45:19 INFO - Cleaning up... 09:45:19 INFO - Return code: 0 09:45:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:45:19 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')]} 09:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:19 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')]} 09:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:19 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 0x7f4bfb0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea3090>, '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 0xea69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea6e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', '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 09:45:19 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 09:45:19 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 09:45:19 INFO - Using env: {'DISPLAY': ':0', 09:45:19 INFO - 'HOME': '/home/cltbld', 09:45:19 INFO - 'LANG': 'en_US.UTF-8', 09:45:19 INFO - 'LANGUAGE': 'en_US:en', 09:45:19 INFO - 'LOGNAME': 'cltbld', 09:45:19 INFO - 'MAIL': '/var/mail/cltbld', 09:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:19 INFO - 'MOZ_NO_REMOTE': '1', 09:45:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:19 INFO - 'NO_EM_RESTART': '1', 09:45:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:19 INFO - 'PWD': '/builds/slave/test', 09:45:19 INFO - 'SHELL': '/bin/bash', 09:45:19 INFO - 'SHLVL': '1', 09:45:19 INFO - 'TERM': 'linux', 09:45:19 INFO - 'TMOUT': '86400', 09:45:19 INFO - 'USER': 'cltbld', 09:45:19 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', 09:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:19 INFO - '_': '/tools/buildbot/bin/python'} 09:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:45:20 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 09:45:20 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 09:45:20 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 09:45:20 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 09:45:20 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 09:45:20 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 09:45:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:45:22 INFO - Installing collected packages: mozsystemmonitor 09:45:22 INFO - Running setup.py install for mozsystemmonitor 09:45:22 INFO - Successfully installed mozsystemmonitor 09:45:22 INFO - Cleaning up... 09:45:22 INFO - Return code: 0 09:45:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:45:22 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')]} 09:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:22 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')]} 09:45:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:22 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 0x7f4bfb0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea3090>, '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 0xea69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea6e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', '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 09:45:22 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 09:45:22 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 09:45:22 INFO - Using env: {'DISPLAY': ':0', 09:45:22 INFO - 'HOME': '/home/cltbld', 09:45:22 INFO - 'LANG': 'en_US.UTF-8', 09:45:22 INFO - 'LANGUAGE': 'en_US:en', 09:45:22 INFO - 'LOGNAME': 'cltbld', 09:45:22 INFO - 'MAIL': '/var/mail/cltbld', 09:45:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:22 INFO - 'MOZ_NO_REMOTE': '1', 09:45:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:22 INFO - 'NO_EM_RESTART': '1', 09:45:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:22 INFO - 'PWD': '/builds/slave/test', 09:45:22 INFO - 'SHELL': '/bin/bash', 09:45:22 INFO - 'SHLVL': '1', 09:45:22 INFO - 'TERM': 'linux', 09:45:22 INFO - 'TMOUT': '86400', 09:45:22 INFO - 'USER': 'cltbld', 09:45:22 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', 09:45:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:22 INFO - '_': '/tools/buildbot/bin/python'} 09:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:22 INFO - Downloading/unpacking jsonschema==2.5.1 09:45:22 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 09:45:22 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 09:45:22 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 09:45:22 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 09:45:22 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 09:45:22 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 09:45:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:45:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:45:24 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 09:45:24 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 09:45:24 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 09:45:24 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 09:45:24 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 09:45:24 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 09:45:24 INFO - Downloading functools32-3.2.3-2.tar.gz 09:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:45:24 INFO - warning: no files found matching '*.txt' 09:45:24 INFO - no previously-included directories found matching 'build' 09:45:24 INFO - no previously-included directories found matching 'dist' 09:45:24 INFO - no previously-included directories found matching '.git*' 09:45:24 INFO - Installing collected packages: jsonschema, functools32 09:45:24 INFO - Running setup.py install for functools32 09:45:24 INFO - warning: no files found matching '*.txt' 09:45:24 INFO - no previously-included directories found matching 'build' 09:45:24 INFO - no previously-included directories found matching 'dist' 09:45:24 INFO - no previously-included directories found matching '.git*' 09:45:24 INFO - Successfully installed jsonschema functools32 09:45:24 INFO - Cleaning up... 09:45:24 INFO - Return code: 0 09:45:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:24 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 0x7f4bfb0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea3090>, '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 0xea69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea6e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', '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 09:45:24 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 09:45:24 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 09:45:24 INFO - Using env: {'DISPLAY': ':0', 09:45:24 INFO - 'HOME': '/home/cltbld', 09:45:24 INFO - 'LANG': 'en_US.UTF-8', 09:45:24 INFO - 'LANGUAGE': 'en_US:en', 09:45:24 INFO - 'LOGNAME': 'cltbld', 09:45:24 INFO - 'MAIL': '/var/mail/cltbld', 09:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:24 INFO - 'MOZ_NO_REMOTE': '1', 09:45:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:24 INFO - 'NO_EM_RESTART': '1', 09:45:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:24 INFO - 'PWD': '/builds/slave/test', 09:45:24 INFO - 'SHELL': '/bin/bash', 09:45:24 INFO - 'SHLVL': '1', 09:45:24 INFO - 'TERM': 'linux', 09:45:24 INFO - 'TMOUT': '86400', 09:45:24 INFO - 'USER': 'cltbld', 09:45:24 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', 09:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:24 INFO - '_': '/tools/buildbot/bin/python'} 09:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:45:24 INFO - Cleaning up... 09:45:24 INFO - Return code: 0 09:45:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:24 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 0x7f4bfb0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea3090>, '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 0xea69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea6e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', '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 09:45:24 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 09:45:24 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 09:45:24 INFO - Using env: {'DISPLAY': ':0', 09:45:24 INFO - 'HOME': '/home/cltbld', 09:45:24 INFO - 'LANG': 'en_US.UTF-8', 09:45:24 INFO - 'LANGUAGE': 'en_US:en', 09:45:24 INFO - 'LOGNAME': 'cltbld', 09:45:24 INFO - 'MAIL': '/var/mail/cltbld', 09:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:24 INFO - 'MOZ_NO_REMOTE': '1', 09:45:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:24 INFO - 'NO_EM_RESTART': '1', 09:45:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:24 INFO - 'PWD': '/builds/slave/test', 09:45:24 INFO - 'SHELL': '/bin/bash', 09:45:24 INFO - 'SHLVL': '1', 09:45:24 INFO - 'TERM': 'linux', 09:45:24 INFO - 'TMOUT': '86400', 09:45:24 INFO - 'USER': 'cltbld', 09:45:24 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', 09:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:24 INFO - '_': '/tools/buildbot/bin/python'} 09:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:25 INFO - Downloading/unpacking blobuploader==1.2.4 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45:27 INFO - Downloading blobuploader-1.2.4.tar.gz 09:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:45:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:45:27 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 09:45:27 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 09:45:27 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 09:45:27 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 09:45:27 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 09:45:27 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 09:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:45:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:45:27 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 09:45:27 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 09:45:27 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 09:45:27 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 09:45:27 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 09:45:27 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 09:45:27 INFO - Downloading docopt-0.6.1.tar.gz 09:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:45:27 INFO - Installing collected packages: blobuploader, requests, docopt 09:45:27 INFO - Running setup.py install for blobuploader 09:45:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:45:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:45:27 INFO - Running setup.py install for requests 09:45:28 INFO - Running setup.py install for docopt 09:45:28 INFO - Successfully installed blobuploader requests docopt 09:45:28 INFO - Cleaning up... 09:45:28 INFO - Return code: 0 09:45:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:28 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')]} 09:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:28 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')]} 09:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:28 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 0x7f4bfb0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea3090>, '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 0xea69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea6e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', '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 09:45:28 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 09:45:28 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 09:45:28 INFO - Using env: {'DISPLAY': ':0', 09:45:28 INFO - 'HOME': '/home/cltbld', 09:45:28 INFO - 'LANG': 'en_US.UTF-8', 09:45:28 INFO - 'LANGUAGE': 'en_US:en', 09:45:28 INFO - 'LOGNAME': 'cltbld', 09:45:28 INFO - 'MAIL': '/var/mail/cltbld', 09:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:28 INFO - 'MOZ_NO_REMOTE': '1', 09:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:28 INFO - 'NO_EM_RESTART': '1', 09:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:28 INFO - 'PWD': '/builds/slave/test', 09:45:28 INFO - 'SHELL': '/bin/bash', 09:45:28 INFO - 'SHLVL': '1', 09:45:28 INFO - 'TERM': 'linux', 09:45:28 INFO - 'TMOUT': '86400', 09:45:28 INFO - 'USER': 'cltbld', 09:45:28 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', 09:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:28 INFO - '_': '/tools/buildbot/bin/python'} 09:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:28 INFO - Running setup.py (path:/tmp/pip-PJMy3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:28 INFO - Running setup.py (path:/tmp/pip-SOk1uN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:28 INFO - Running setup.py (path:/tmp/pip-qwDPSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:28 INFO - Running setup.py (path:/tmp/pip-uTgqE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:28 INFO - Running setup.py (path:/tmp/pip-ewzVyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:28 INFO - Running setup.py (path:/tmp/pip-8xozAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:29 INFO - Running setup.py (path:/tmp/pip-tu_QQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:29 INFO - Running setup.py (path:/tmp/pip-9B9Tz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:29 INFO - Running setup.py (path:/tmp/pip-2dhBM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:29 INFO - Running setup.py (path:/tmp/pip-nyA8LW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:29 INFO - Running setup.py (path:/tmp/pip-qddlUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:29 INFO - Running setup.py (path:/tmp/pip-jci20Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:29 INFO - Running setup.py (path:/tmp/pip-hfc0sS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:29 INFO - Running setup.py (path:/tmp/pip-zs3uv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:29 INFO - Running setup.py (path:/tmp/pip-yaZ6f1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:29 INFO - Running setup.py (path:/tmp/pip-Hpv8my-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:29 INFO - Running setup.py (path:/tmp/pip-IC3sRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:45:29 INFO - Running setup.py install for manifestparser 09:45:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:45:29 INFO - Running setup.py install for mozcrash 09:45:30 INFO - Running setup.py install for mozdebug 09:45:30 INFO - Running setup.py install for mozdevice 09:45:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:45:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:45:30 INFO - Running setup.py install for mozfile 09:45:30 INFO - Running setup.py install for mozhttpd 09:45:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:45:30 INFO - Running setup.py install for mozinfo 09:45:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:45:30 INFO - Running setup.py install for mozInstall 09:45:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:45:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:45:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:45:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:45:30 INFO - Running setup.py install for mozleak 09:45:30 INFO - Running setup.py install for mozlog 09:45:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:45:30 INFO - Running setup.py install for moznetwork 09:45:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:45:30 INFO - Running setup.py install for mozprocess 09:45:31 INFO - Running setup.py install for mozprofile 09:45:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:45:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:45:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:45:31 INFO - Running setup.py install for mozrunner 09:45:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:45:31 INFO - Running setup.py install for mozscreenshot 09:45:31 INFO - Running setup.py install for moztest 09:45:31 INFO - Running setup.py install for mozversion 09:45:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:45:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:45:31 INFO - Cleaning up... 09:45:31 INFO - Return code: 0 09:45:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:31 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 0x7f4bfb0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea3090>, '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 0xea69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea6e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', '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 09:45:31 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 09:45:31 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 09:45:31 INFO - Using env: {'DISPLAY': ':0', 09:45:31 INFO - 'HOME': '/home/cltbld', 09:45:31 INFO - 'LANG': 'en_US.UTF-8', 09:45:31 INFO - 'LANGUAGE': 'en_US:en', 09:45:31 INFO - 'LOGNAME': 'cltbld', 09:45:31 INFO - 'MAIL': '/var/mail/cltbld', 09:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:31 INFO - 'MOZ_NO_REMOTE': '1', 09:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:31 INFO - 'NO_EM_RESTART': '1', 09:45:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:31 INFO - 'PWD': '/builds/slave/test', 09:45:31 INFO - 'SHELL': '/bin/bash', 09:45:31 INFO - 'SHLVL': '1', 09:45:31 INFO - 'TERM': 'linux', 09:45:31 INFO - 'TMOUT': '86400', 09:45:31 INFO - 'USER': 'cltbld', 09:45:31 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', 09:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:31 INFO - '_': '/tools/buildbot/bin/python'} 09:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:31 INFO - Running setup.py (path:/tmp/pip-FNO8Bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:31 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)) 09:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:31 INFO - Running setup.py (path:/tmp/pip-cVFH_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:32 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)) 09:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:32 INFO - Running setup.py (path:/tmp/pip-u53WSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:32 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)) 09:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:32 INFO - Running setup.py (path:/tmp/pip-BJH893-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:32 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)) 09:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:32 INFO - Running setup.py (path:/tmp/pip-HcvI3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:32 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)) 09:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:32 INFO - Running setup.py (path:/tmp/pip-ZkoI1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:32 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)) 09:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:32 INFO - Running setup.py (path:/tmp/pip-gnksky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:32 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)) 09:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:32 INFO - Running setup.py (path:/tmp/pip-NXygtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:32 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)) 09:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:32 INFO - Running setup.py (path:/tmp/pip-wK9cLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:32 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)) 09:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:32 INFO - Running setup.py (path:/tmp/pip-rSvjDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:32 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)) 09:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:32 INFO - Running setup.py (path:/tmp/pip-kqrjNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:32 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)) 09:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:32 INFO - Running setup.py (path:/tmp/pip-CwZmrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:32 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)) 09:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:32 INFO - Running setup.py (path:/tmp/pip-wms4Bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:32 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)) 09:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:32 INFO - Running setup.py (path:/tmp/pip-iedPRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:32 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)) 09:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:32 INFO - Running setup.py (path:/tmp/pip-JqcamD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:32 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)) 09:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:33 INFO - Running setup.py (path:/tmp/pip-1CNxnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:33 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)) 09:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:33 INFO - Running setup.py (path:/tmp/pip-AMuBNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:33 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)) 09:45:33 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)) 09:45:33 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)) 09:45:33 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)) 09:45:33 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)) 09:45:33 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)) 09:45:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:45:33 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 09:45:33 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 09:45:33 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 09:45:33 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 09:45:33 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 09:45:33 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 09:45:35 INFO - Downloading blessings-1.6.tar.gz 09:45:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:45:35 INFO - Installing collected packages: blessings 09:45:35 INFO - Running setup.py install for blessings 09:45:35 INFO - Successfully installed blessings 09:45:35 INFO - Cleaning up... 09:45:35 INFO - Return code: 0 09:45:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:45:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:35 INFO - Reading from file tmpfile_stdout 09:45:35 INFO - Current package versions: 09:45:35 INFO - argparse == 1.2.1 09:45:35 INFO - blessings == 1.6 09:45:35 INFO - blobuploader == 1.2.4 09:45:35 INFO - docopt == 0.6.1 09:45:35 INFO - functools32 == 3.2.3-2 09:45:35 INFO - jsonschema == 2.5.1 09:45:35 INFO - manifestparser == 1.1 09:45:35 INFO - mozInstall == 1.12 09:45:35 INFO - mozcrash == 0.17 09:45:35 INFO - mozdebug == 0.1 09:45:35 INFO - mozdevice == 0.48 09:45:35 INFO - mozfile == 1.2 09:45:35 INFO - mozhttpd == 0.7 09:45:35 INFO - mozinfo == 0.9 09:45:35 INFO - mozleak == 0.1 09:45:35 INFO - mozlog == 3.3 09:45:35 INFO - moznetwork == 0.27 09:45:35 INFO - mozprocess == 0.23 09:45:35 INFO - mozprofile == 0.28 09:45:35 INFO - mozrunner == 6.12 09:45:35 INFO - mozscreenshot == 0.1 09:45:35 INFO - mozsystemmonitor == 0.3 09:45:35 INFO - moztest == 0.7 09:45:35 INFO - mozversion == 1.4 09:45:35 INFO - psutil == 3.1.1 09:45:35 INFO - requests == 1.2.3 09:45:35 INFO - wsgiref == 0.1.2 09:45:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:35 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 0x7f4bfb0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea3090>, '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 0xea69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea6e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', '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 09:45:35 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 09:45:35 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 09:45:35 INFO - Using env: {'DISPLAY': ':0', 09:45:35 INFO - 'HOME': '/home/cltbld', 09:45:35 INFO - 'LANG': 'en_US.UTF-8', 09:45:35 INFO - 'LANGUAGE': 'en_US:en', 09:45:35 INFO - 'LOGNAME': 'cltbld', 09:45:35 INFO - 'MAIL': '/var/mail/cltbld', 09:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:35 INFO - 'MOZ_NO_REMOTE': '1', 09:45:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:35 INFO - 'NO_EM_RESTART': '1', 09:45:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:35 INFO - 'PWD': '/builds/slave/test', 09:45:35 INFO - 'SHELL': '/bin/bash', 09:45:35 INFO - 'SHLVL': '1', 09:45:35 INFO - 'TERM': 'linux', 09:45:35 INFO - 'TMOUT': '86400', 09:45:35 INFO - 'USER': 'cltbld', 09:45:35 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', 09:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:35 INFO - '_': '/tools/buildbot/bin/python'} 09:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:35 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)) 09:45:35 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)) 09:45:35 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)) 09:45:35 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)) 09:45:35 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)) 09:45:35 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)) 09:45:35 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)) 09:45:35 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)) 09:45:35 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)) 09:45:35 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)) 09:45:35 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)) 09:45:35 INFO - Cleaning up... 09:45:35 INFO - Return code: 0 09:45:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:35 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 0x7f4bfb0d0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xea9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea3090>, '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 0xea69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea6e40>, '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': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', '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 09:45:35 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 09:45:35 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 09:45:35 INFO - Using env: {'DISPLAY': ':0', 09:45:35 INFO - 'HOME': '/home/cltbld', 09:45:35 INFO - 'LANG': 'en_US.UTF-8', 09:45:35 INFO - 'LANGUAGE': 'en_US:en', 09:45:35 INFO - 'LOGNAME': 'cltbld', 09:45:35 INFO - 'MAIL': '/var/mail/cltbld', 09:45:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:35 INFO - 'MOZ_NO_REMOTE': '1', 09:45:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:35 INFO - 'NO_EM_RESTART': '1', 09:45:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:35 INFO - 'PWD': '/builds/slave/test', 09:45:35 INFO - 'SHELL': '/bin/bash', 09:45:35 INFO - 'SHLVL': '1', 09:45:35 INFO - 'TERM': 'linux', 09:45:35 INFO - 'TMOUT': '86400', 09:45:35 INFO - 'USER': 'cltbld', 09:45:35 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', 09:45:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:35 INFO - '_': '/tools/buildbot/bin/python'} 09:45:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:45:35 INFO - Cleaning up... 09:45:35 INFO - Return code: 0 09:45:35 INFO - Running post-action listener: _resource_record_post_action 09:45:35 INFO - Running post-action listener: _start_resource_monitoring 09:45:35 INFO - Starting resource monitoring. 09:45:35 INFO - [mozharness: 2016-08-30 16:45:35.938012Z] Finished create-virtualenv step (success) 09:45:35 INFO - [mozharness: 2016-08-30 16:45:35.938513Z] Running install step. 09:45:35 INFO - Running pre-action listener: _resource_record_pre_action 09:45:35 INFO - Running main action method: install 09:45:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:36 INFO - Reading from file tmpfile_stdout 09:45:36 INFO - Detecting whether we're running mozinstall >=1.0... 09:45:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:45:36 INFO - Reading from file tmpfile_stdout 09:45:36 INFO - Output received: 09:45:36 INFO - Usage: mozinstall [options] installer 09:45:36 INFO - Options: 09:45:36 INFO - -h, --help show this help message and exit 09:45:36 INFO - -d DEST, --destination=DEST 09:45:36 INFO - Directory to install application into. [default: 09:45:36 INFO - "/builds/slave/test"] 09:45:36 INFO - --app=APP Application being installed. [default: firefox] 09:45:36 INFO - mkdir: /builds/slave/test/build/application 09:45:36 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'] 09:45:36 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 09:45:53 INFO - Reading from file tmpfile_stdout 09:45:53 INFO - Output received: 09:45:53 INFO - /builds/slave/test/build/application/firefox/firefox 09:45:53 INFO - Running post-action listener: _resource_record_post_action 09:45:53 INFO - [mozharness: 2016-08-30 16:45:53.061569Z] Finished install step (success) 09:45:53 INFO - [mozharness: 2016-08-30 16:45:53.061850Z] Running run-tests step. 09:45:53 INFO - Running pre-action listener: _resource_record_pre_action 09:45:53 INFO - Running main action method: run_tests 09:45:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:45:53 INFO - Python 2.7.3 09:45:53 INFO - Return code: 0 09:45:53 INFO - grabbing minidump binary from tooltool 09:45: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')]} 09:45:53 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 0xea3090>, '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 0xea69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xea6e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:45:53 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 09:45:53 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 09:45:53 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 09:45:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:45:53 INFO - Return code: 0 09:45:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:45:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:45:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:45:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:45:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:45:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:45:53 INFO - Using env: {'DISPLAY': ':0', 09:45:53 INFO - 'HOME': '/home/cltbld', 09:45:53 INFO - 'LANG': 'en_US.UTF-8', 09:45:53 INFO - 'LANGUAGE': 'en_US:en', 09:45:53 INFO - 'LOGNAME': 'cltbld', 09:45:53 INFO - 'MAIL': '/var/mail/cltbld', 09:45:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:45:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:53 INFO - 'MOZ_NO_REMOTE': '1', 09:45:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:45:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:53 INFO - 'NO_EM_RESTART': '1', 09:45:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:53 INFO - 'PWD': '/builds/slave/test', 09:45:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:45:53 INFO - 'SHELL': '/bin/bash', 09:45:53 INFO - 'SHLVL': '1', 09:45:53 INFO - 'TERM': 'linux', 09:45:53 INFO - 'TMOUT': '86400', 09:45:53 INFO - 'USER': 'cltbld', 09:45:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258', 09:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:53 INFO - '_': '/tools/buildbot/bin/python'} 09:45:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:45:53 INFO - mozversion application_buildid: 20160830065621 09:45:53 INFO - mozversion application_changeset: b18c8bcdc116eef8799880b7c50317bf54218474 09:45:53 INFO - mozversion application_display_name: Nightly 09:45:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:45:53 INFO - mozversion application_name: Firefox 09:45:53 INFO - mozversion application_remotingname: firefox 09:45:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:45:53 INFO - mozversion application_vendor: Mozilla 09:45:53 INFO - mozversion application_version: 51.0a1 09:45:53 INFO - mozversion platform_buildid: 20160830065621 09:45:53 INFO - mozversion platform_changeset: b18c8bcdc116eef8799880b7c50317bf54218474 09:45:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:45:53 INFO - mozversion platform_version: 51.0a1 09:45:53 INFO - using testdate: 1472575553 09:45:53 INFO - actual date: 1472575553 09:45:53 INFO - starting webserver on 'localhost:36627' 09:45:53 INFO - SUITE-START | Running 2 tests 09:45:53 INFO - TEST-START | dromaeo_css 09:45:53 INFO - operating with platform_type : linux_ 09:45:53 INFO - Initialising browser for dromaeo_css test... 09:45:53 INFO - TEST-INFO | started process 25382 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQcfSG9/profile http://localhost:36627/getInfo.html) 09:45:58 INFO - PROCESS | 25382 | __metrics Screen width/height:1600/1200 09:45:58 INFO - PROCESS | 25382 | colorDepth:24 09:45:58 INFO - PROCESS | 25382 | Browser inner width/height: 1024/697 09:45:58 INFO - PROCESS | 25382 | __metrics 09:45:58 ERROR - PROCESS | 25382 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 09:46:00 INFO - TEST-INFO | 25382: exit 0 09:46:00 INFO - Browser initialized. 09:46:00 INFO - Running cycle 1/1 for dromaeo_css test... 09:46:00 INFO - TEST-INFO | started process 25500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQcfSG9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:12 INFO - PROCESS | 25500 | RSS: Main: 192720896 09:46:12 INFO - PROCESS | 25500 | 09:47:02 INFO - PROCESS | 25500 | 1472575622077 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] 09:49:14 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:36627/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36627/tests/dromaeo/cssquery-ext.html) 09:49:16 INFO - PROCESS | 25500 | RSS: Main: 210288640 09:49:16 INFO - PROCESS | 25500 | 09:52:18 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:36627/tests/dromaeo/cssquery-ext.html (next: http://localhost:36627/tests/dromaeo/cssquery-jquery.html) 09:52:19 INFO - PROCESS | 25500 | RSS: Main: 205049856 09:52:19 INFO - PROCESS | 25500 | 09:55:21 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:36627/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36627/tests/dromaeo/cssquery-mootools.html) 09:55:22 INFO - PROCESS | 25500 | RSS: Main: 201699328 09:55:22 INFO - PROCESS | 25500 | 09:58:24 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:36627/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36627/tests/dromaeo/cssquery-prototype.html) 09:58:24 INFO - PROCESS | 25500 | RSS: Main: 195420160 09:58:24 INFO - PROCESS | 25500 | 10:01:27 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:36627/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36627/tests/dromaeo/cssquery-yui.html) 10:01:28 INFO - PROCESS | 25500 | RSS: Main: 199610368 10:01:28 INFO - PROCESS | 25500 | 10:04:31 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:36627/tests/dromaeo/cssquery-yui.html (next: http://localhost:36627/tests/dromaeo/cssquery-dojo.html) 10:04:31 INFO - PROCESS | 25500 | RSS: Main: 199335936 10:04:31 INFO - PROCESS | 25500 | 10:04:31 INFO - PROCESS | 25500 | __start_tp_report 10:04:31 INFO - PROCESS | 25500 | _x_x_mozilla_page_load 10:04:31 INFO - PROCESS | 25500 | _x_x_mozilla_page_load_details 10:04:31 INFO - PROCESS | 25500 | |i|pagename|runs| 10:04:31 INFO - PROCESS | 25500 | |0;dojo.html;2641.8018648601355;2644.153870761356;2653.880575374108;2673.091149009337;2695.6360891279674;4593.402857628504;4682.555157260059;4773.737444440559;4818.566329030386;4826.71039737616;4676.672632915689;4676.883077923054;4689.155951928651;4744.003759210561;4791.185498465261;4256.553061928499;4372.5627437256335;4428.269335559628;4434.556544345556;4459.375687403766;4110.445089912853;4459.108178364324;4487.708298960557;4497.932531012054;4536.727796332214;4231.555686652888;4308.332208507655;4323.113761678848;4357.302831546937;4380.9780951095045;4376.912461750779;4380.430544029287;4387.034852332482;4432.401625780511;4435.112977404532;4317.611414972636;4344.91310173798;4362.47650281965;4362.563743625644;4412.117576484684;4594.793234304464;4710.74090924999;4780.163471392527;4785.593224575915;4835.782389792468;5113.769880355393;5129.512696293846;5138.511841375063;5148.330717006766;5168.224766285088;5163.096458119851;5163.845084647466;5169.689818610896;5177.37871455424;5220.26916231724;4661.883452913637;4724.4094488188975;4767.809287628456;4795.448523419782;4796.736179510125;5244.842654720364;5246.895062098737;5250.921236181461;5251.081060814342;5270.631055826132;5036.924446133311;5049.343585333957;5050.267711181858;5057.216131499624;5105.361829771278;4907.7300748458465;5006.3992320921;5071.822486212965;5076.82231121909;5129.487051294841;5019.67372120811;5055.16589762685;5061.13960626687;5078.847634570969;5146.4853514648985;5056.342675452168;5063.949360506422;5072.923906141411;5079.619028572872;5090.821821236239;4180.874573762792;4209.852655157055;4250.171216612731;4269.359596060615;4275.828966841354;3762.416825392014;3775.207206486614;3788.3938569828697;3818.6181381862148;3826.6556009959236;4476.932846007313;4476.955230447719;4477.440319960005;4515.096980603892;4548.090381923628;4993.450720420751;5098;5133.666311689728;5152.330197074356;5163.535281824654;4459.397981272552;4474.149911516802;4481.462224533077;4518.887027824265;4530.728156310632;4576.336431217454;4597.3793537872625;4604.0331530379;4609.861704148881;4664;4681.461631912373;4778.976105119452;4837.201861692782;4847.80608775645;4865.294532292868;5123.23151527259;5140.717260550556;5140.717260550556;5144.742762861917;5191.22131680251;4839.661223714306;4840.83057093;4843.685160464559;4851.175300198904;4889.462159162418;4939.086269040239;4977.303177555217;5031.823886163967;5038.345015148007;5070.2141168119;5095.592352611856;5117.104506711236;5122.154844450624;5127.513021223804;5130.413690343631;4988.152014157675;4988.301637770787;4993.700377977333;5004.17431123875;5040.420351659606;4806.134895718665;4941.085899108676;4989.401271847401;5012.624053195952;5088.0078384714625;4922.778474968563;4922.926156107733;4930.9506904930495;4932.136876046749;4945.4807245238735;5043.218301163325;5052.72210028452;5057.671251368649;5058.721770302669;5115.130427827204;4791.329213910125;4842.201036828884;4888.9755551222015;4891.33966914462;4925.704457732548 10:04:31 INFO - PROCESS | 25500 | |1;ext.html;537.7472587883695;546.9890602187955;560.5683623609818;567.5799908068028;574.4743559642927;33640.83179584102;37659.81170094149;37744.43383349252;37768.622313776854;37786.4332035019;37906.620933790655;37929.810350948275;38201;38434.42348364777;38555.807220963856;7564.9787278717495;7695.8076048098965;7696.769096927102;7710.653020614058;7728.459007869451;7616.695332186706;7663.770086897374;7674.155842857282;7690.961545192266;7709.267619576131;7624.695012199505;7681.846363072736;7681.884771728429;7685.03937007874;7720.1121870985;7645.61771911405;7657.578833164173;7658.2724641159;7667.233276672344;7672.271134242238;7540.434467414966;7593.354564861993;7595.5442673439775;7599.088109426849;7599.696012159562;36113;36191;36198.45702314441;36214.8189259052;36504.63495365039;2849.586809912572;3005.1735772662473;3050.7864449488543;3213.929013311859;3357.3788849062757;27564.86217568899;27807.304817379525;27865.721342786717;27991.580126298122;29200.41599168026;3471.3096802452774;3581.4448760442174;3642.36258654737;3667.8716244931297;3682.797446140488;251580;252736;254415;254981.7250913752;256484;55761.981421672244;56189;56449.43550564524;56634;56638;32659;33710.49434258488;33939.66060339365;35473.82263088668;35544;13565.321733913264;13822.792658110136;13833.239171845646;13859.722805543832;13920.51278205258;10358;10547.208959328082;10559.260851740459;10559.260851740459;10586.947065264625;18173.36393226257;18253.087345632666;18294.817051829577;18320.908395458206;18497.53756156107;7140.5358651687475;7148.714051437988;7184.317489838457;7365.8158546036775;7416.480846340704;717.3758829818091;813.4590497319334;905.0313777362364;957.9845363914274;978.1538968791943;25787.35531611687;27838.582421263698;27892.8398246321;28092.157235282975;28157.859210703817;850.3452341696859;903.1014140929685;917.2982668258787;920.963161473547;1042.2443728296923;13878.861211387959;14538.24170114129;14789.630259243606;14859.182744949132;14985.175815330262;376669;380504;382312;383238;383776;47050.294245586345;47717.761411192725;47792.28311575329;47852.28221576679;47931.041379172224;1094.6606551968914;1134.9659510214706;1138.8234823602354;1140.1164097824087;1146.587228597704;26129.60805587956;26680.466390672467;27371.315717106434;27806;28015;40742.79628601838;40887.795561022;40898.38652420157;40940.79529602333;41219;338310;340177;340258;340467;340821;24180.274591762274;24576.754232457446;25313.49373012566;25324;26611.33471663224;40587.59412405838;40873.18253634851;40886.59113408947;41348.379774302804;42004.159916802106;34400.311993760486;34666.306673866886;34815;35171;35172.648273516934;34427.82786086053;34455.483167753;34789.30421391609;34946.30107397787;35241.82379088088;30819.69180308258;34850;34901;34992;35600;29173.562396563644;32449.35101298008;32543.837280813445;32667;32721.18197045093;23734;24390.878045609657;24577.079163193084;24898.253052408458;25068.498630026934 10:04:31 INFO - PROCESS | 25500 | |2;jquery.html;341.1454306961062;351.9859205631775;356.25364860617003;357.5191367610563;373.29447344518866;15973;16966.660666786673;17078.82921170791;17392.04343761094;17524.82475175248;15313.157776322298;15630.218489075529;15783.92108039461;15789.368425262976;15810.367585296603;4696.694714843524;5005.374328208974;5020.97489512552;5031.144705400073;5048.268001139851;3626.673599376056;5093.79624815007;5765.884682306351;6054.5459090568165;6071.878562428748;6114.663693496856;6127.234095738033;6136.723847426854;6147.170132032185;6153.538484613649;5203.765830537635;5454.7272636368225;5509.146082357241;5562.694051827148;5584.078627026536;5236.266922630834;5240.633155679104;5315.441878602768;5371.973140134274;5391.191321301836;12207.75584488314;12391.194572352768;12468.43892024861;12472.189307695062;12483.625491235278;1714.459945117284;1744.1017875793975;1778.5642517583146;1817.9909100454545;2014.4359579317816;8756.255718263956;8974.641014359418;9593.808123837483;9627.470489123096;10210.9489452553;1638.1645360865925;1703.4804384662673;1725.8446739793478;1744.345870298638;1754.4035028090511;65766.67116664434;66455.66772166156;66586.33413665801;66685;67715;9674.75813104664;9779.559919803625;9903.950480247553;10137.746556336151;10138.898611013796;13355.53255636048;13355.599332020054;13388.531401400904;13391.263480508665;13421.463141474233;6661;6857.177138743383;6876.828079297958;6899.689513971884;7067.22260551339;6472.773452929125;6531.640759758259;6630.900536491957;6709.899351509731;6712.83217919556;3947.6052394760295;4148.896277593024;4205.684573656988;4220.134872351161;4312.223799716018;1662.7339625659836;1664.750287456891;1680.15992003998;1724.8533874620546;1767.7184041569758;747.4991755523812;789.6249281591313;860.4579115157536;884.2307192742227;888.9466632001971;16449.342026319053;16452.34190632385;16743.58141046459;16891.577710557336;16973.91513042427;779.5673401262354;834.1283358889974;837.6063250272363;867.9696210632598;895.8521843895815;9018.278537716968;9116.544172791466;9355.4386736796;9520.285978551636;9618.855717164248;385887;395704;396046;396198;397215;71505.6424717873;71633.64183179155;73299.26700732924;74605;75303.24696753072;883.9823203535893;887.7159309021051;908.1735620585367;920.9723708288763;921.7511271956535;14667.559973200821;14713.190774507504;14894.106353618818;15079.924600376928;15298.235088245765;35459.82270088633;35960.64039359573;36093.819530902176;36215.45676814902;36510;48063.75968120137;49178;49745.502544974086;50114.498855010985;50331.74834125806;7068.257832927468;7192.280771922975;7353.926460735538;7434.176561693409;7533.510321829063;9946.30375873711;11621.302721836717;11652.88347116518;11720;12341.50633974667;9813.607455701693;9861.704148875546;9915.65295214664;9944.35361701516;10577.62978295756;4403.229434848953;9783.867904358847;10175.185985121321;10400.711843394442;10450.738731531468;9756.707298781048;9989;10016.198704103508;10159.238057145596;10646.467676615983;7107.715691372287;7209.639518023973;7361.8159546011775;7374.557526548424;7445.255474452728;8847.20375166238;10043.799124017332;10185;10225.488725563544;10411.94794026025 10:04:31 INFO - PROCESS | 25500 | |3;mootools.html;1323.1135139456567;1351.513455156144;1403.670137517683;1638.737801951688;1672.996202278633;6481.870362592746;6747.831304217397;7069.4697897657625;7244.203137654854;7261.60061196634;7402.852557853541;7482.62586870657;7485.588292643903;7555.735549255777;7582.545047297166;2169.59862425451;2197.7142971413696;2201.471646804763;2202.394341556077;2205.492736670567;2115.968260476094;2167.729033870766;2181.094845639058;2182.2471247419694;2183.3449965010514;2162.2540223622905;2165.0473791531754;2167.5881582499273;2171.543975765091;2195.8133558647455;2124.1715730864976;2130.893455327235;2133.264023911748;2135.284679632325;2142.4536743130557;2058.938231853032;2103.085157956294;2108.4307237046064;2109.1352545456443;2111.4299139232476;7290.161631412349;7320.780376588711;7401.111866576045;7407.333339999426;7453.739119130859;4189.874303770892;4318.5465526119615;4321.351797230409;4326.394304797331;4333.1766964276685;2686.5164270431314;2769.667639883227;2781.2490627530656;2806.803523753338;2857.7428031477266;877.368294827723;925.1581061234311;927.6660402255183;935.4948327902924;940.8823897012874;9814.411135331831;9892.90107098927;9896.901030989742;9924.900750992541;9949.154321882648;3800.9049773755323;3943.580311088006;4077.734947228421;4079;4100.2414553307135;8555.27280181179;8567.785805354915;8580.442271252348;8592.656293748305;8602.61288242018;4288.142371525707;4308.590683885026;4311.676624253194;4312.137572485515;4313.611774940207;3630.128769095398;3731.0858839584475;3839.3281175794123;3897.4738410314812;3900.4539364488996;3482.233908540117;3562.251927095339;3562.5724913010085;3590;3667.7615954962844;1139.4872307461676;1143.3768596115137;1157.6237722739975;1176.8705442401329;1184.5557915781583;770.2951799103869;796.482286513759;808.9676412943534;809.3039985612369;812.2973627812019;4777.570018698264;4845.515448455197;4913.361263035854;4968.205087186033;5105.9489405106215;379.6962430055944;389.33229511388106;397.15208030854336;403.0568469780727;407.4275642721921;3383.5939687237687;3405.3189362127673;3408.931821363559;3425.1265927188906;3528.3119791640383;8511.702090426928;8905.465672059698;8924.910750892537;8943.955280223558;8949.59726812295;8872.24585910192;8913.55432228386;8918.866217006751;8931.866022009675;8932.553372331358;6872.381485666214;6919.169699636076;6935.133108361455;6940.028396024561;6943.51395402317;4863.221884498464;4878.853469434609;5008.248762685626;5042.697438153723;5117.8720531987;7905.683772649029;8093.473924194908;8095.23095305945;8192.795180120545;8362.498250105013;8258.298044666271;8293.543855088028;8338.833223335378;8370.790730231793;8379.790505237173;5575.77696892136;5968.194293770285;6107.236595425572;6122.234720659918;6141.201643786279;7102.573845569283;7110.431165506644;7144.964275178799;7162.104736907887;7166.856662866609;5986.161937328865;6022.247219097613;6031.366706495754;6139.201903752483;6191.504679625529;6111.113888486234;6130.386961304012;6134.846628834315;6147.170132032297;6156.322804491592;5806.025951176452;5924.52603791687;5928.614640048383;5937.139114828239;5937.732802023833;4161.8335266589;4233.449651545279;4323.740575565476;4327.459067616548;4394.934075988926;4237.194932962727;4238.152369526046;4261.446012018542;4330.198913201068;4372.300431930876 10:04:31 INFO - PROCESS | 25500 | |4;prototype.html;289.4139367780246;289.5193977996526;299.74970899299075;301.82192506421205;302.30771533189;4793.424789025322;4919.237518184678;5027.32131162293;5032.396112466505;5045.738565358665;4901.754912254382;4935.82724604638;4939.271255060736;4955;4966.180580204271;3919.5492518360325;3920.3727403615426;3921.2353591049755;3925.862594809182;3942.369220924653;3671.541057367829;3922.8234729437245;3925;3939.8424063037446;3943;3817.351050321452;3836.6547010769027;3841.7118716096265;3845.8461661533506;3852.961470385302;3781.773093614392;3816.370298900692;3829.2341531693496;3831.7126215533945;3832.885013449601;3356.456030226099;3361.4957756336503;3362.8150451725146;3364.4112280351087;3365.1418888183357;4713.670043096985;4818.34952281441;4826.951730482685;4860.756962151878;4866.902661946777;4337.891552711176;4350.260455722535;4361.869143925655;4362.8691139265875;4366.454193225847;5161.5870730341485;5172.172452407634;5176.265950906451;5182.4299327073995;5187.247849061902;3546.343926373629;3613.421852503613;3629.8548058077645;3631.5460567429072;3645.179834537208;5338.3593968724;5410.91883621746;5411.702356370398;5414.620976531644;5419.729013549346;3731.776093434403;3737.4954381158195;3740.6446387593137;3740.8129593520216;3741.5510138782975;3784.735068545175;3787.1289603391374;3790.753601015925;3799.9430008549894;3808.314503389361;4225.366195070764;4299.613034826881;4338.262495375794;4350.412694286294;4356.259435895905;5189.546926860485;5193.2989046479;5201.973990130025;5207.5833933286;5214.895702085937;1242.428482897859;1275.8022506511506;1299.8895093917124;1310.1614966421498;1315.8420589880843;869.2046777198918;886.8536691445968;896.6727144592177;903.8192361527721;906.8821053263033;4558.475775285819;4594.356790049395;4598.126355992351;4599.310103484504;4600.102979918884;5352.678839269656;5358.27663265462;5360.705161216092;5364.195370694349;5366.597505187126;4385.062008454343;4603.286490593963;4607.778938581278;4612.584867361887;4613.815447382134;2504.7620476054744;2509.0716434919195;2528.84826910386;2530.8987640494543;2536.1757428835704;4420.381146639473;4454.331850222427;4497.166784925476;4504.301833215857;4508.188526065274;4590.449146102489;4754.644926196018;4771.427428708508;4773.856784296477;4797.864950097173;4351.238533256667;4453.354263631691;4453.51011388747;4454.933176002362;4471.754053527087;4614.300634129072;4631.328457373729;4660.580547750718;4678.625709943264;4713.457952335525;4593.6554758392585;4604.746738929391;4607.723536587815;4623.976880115712;4652.93020604698;4308.956910430856;4412.6249268811225;4428.911421771611;4459.955400446084;4499.955000449953;3372.1673794013145;3391.880679375751;3393.9151521212166;3407.4377727674655;3446.844891979917;4677.7193368398;4688.9296660549435;4689.249720044776;4712.104700106968;5106.514881086291;5082.644214904921;5166.199239117943;5195.246689230116;5202.933398653343;5209.71346575942;5150.665206761549;5166.483351664803;5170.991656626921;5180.533751962342;5208.348956380452;4892.706437613754;5093.339594271349;5115.79536818538;5121.871953201051;5140.252314213186;5243.187305967581;5245.7114858683135;5250.921236181384;5260.368755749335;5265.341832270966;5148.794048238178;5156;5156.355455568054;5157.381114266312;5161.716105614228 10:04:31 INFO - PROCESS | 25500 | |5;yui.html;576.2595065341036;622.0668996505241;639.0701529274905;640.5004096804494;719.3994059731045;12582.937085314572;13253.072284940057;13613.7957930631;13899.513517026906;13912.234827084507;12660.43028063737;12713.872861271384;12768.106232563725;12768.42542085606;12785.872141278585;602.8342205893392;731.5939653492296;748.7304570354668;750.5459197185706;753.7701001194633;726.8110291324267;749.0187853911366;754.8565772503234;757.0725860820506;758.3781299334548;802.7110240313483;804.7907544038534;804.8430556041574;805.7139715401037;806.2985202873508;796.1282395776644;797.8763291689797;805.6092794994423;806.7983004248938;806.8749343851713;580.9419058094156;587.967661778602;588.0737837905316;588.1178232651024;589.0927970924771;12823.87176128236;12856.807147892789;12877;12884.54904078362;12889.097763156582;13391.598252052454;13430;13636.65908352299;13704.588862334047;13982.370793314325;9915.553800079013;9995.050470205319;10014.89985100147;10109.747256318577;10111.090001899864;3270.329582435595;3297.7196938260277;3305.5041743738393;3337.8664853405835;3349.279904820475;63134.36865631331;64444.71110577809;66018;66684.6665766668;67811.32188678099;9610.615575376907;9715.02849715037;9839.852402213972;9875.358101723365;9939.155171810477;18369;18445.631087378446;18463.630727385378;18513.7222941656;18707.251709931723;6034.426729460694;6041.879162416815;6072.119542666289;6110.633361998294;6217.253929528395;3818.84724611018;3823.6749876260274;3847.211321679049;3848.9037774055873;3849.4995650565806;2832.079574138413;2921.517949538345;2923.6491621005616;2929.721676440735;2931.5456104303867;453.36302494994584;462.5836746927725;466.8179410030091;474.12997150229717;478.5716783478837;397.1283033740911;436.05158779654124;462.17732436263503;473.5241082711921;503.7481259370315;7179.210286868441;7613.467057305936;7714.3057124857905;7888.73780195166;7977.601119944095;420.3820384035463;484.7309743092547;501.65135231014824;503.4009528660882;510.5296745373301;3555.6977656899453;3739.139997800521;3819.598942111094;3832.463455116286;3910.511186101737;98166.50916745371;102870.48564757279;106168.46915765372;106794.46602766936;107277.463612683;48224.51775482271;51350.74324628353;52099.47900521022;58561.4143858556;83765.58117209375;75160.99999999891;77088;77273.61363193148;77527;78966.6051669738;6678.198616166092;6827;6973.721051157897;7024.578525288499;7389.926100738924;31494.842525788143;35590.46614300736;42511.787441062595;42785.57214427816;43667.78166109149;52214.47785522248;52783.30516863936;59320;62920.68539657273;64760;9632.373895696757;9834.409935403899;10072.446015469219;10166.8474972874;10884.346939183357;11275.548978041115;11410.543578256777;11418.771624567627;11458;11805.527778888749;10308.433036183082;10434.321769084985;10744.892551074388;10758.246922715334;10826;10032.498375081363;10109.292349535463;10361.119304859172;10382.896171038194;10520.316179448311;9309.627614895327;10509.369437833755;10559.683209503728;11031.889681103086;11909.40452977365;9195.816083678423;9235.861462077939;9520.761980950254;9566.330356874952;9844.60621575129;9410.153086222273;9950.800983980425;10016.549255283384;10019;10045.49772511386 10:04:31 INFO - PROCESS | 25500 | __end_tp_report 10:04:31 INFO - PROCESS | 25500 | __start_cc_report 10:04:31 INFO - PROCESS | 25500 | _x_x_mozilla_cycle_collect,353 10:04:31 INFO - PROCESS | 25500 | __end_cc_report 10:04:31 INFO - PROCESS | 25500 | __startTimestamp1472576671327__endTimestamp 10:04:31 INFO - PROCESS | 25500 | 10:04:31 INFO - PROCESS | 25500 | ------- Summary: start ------- 10:04:31 INFO - PROCESS | 25500 | Number of tests: 6 10:04:31 INFO - PROCESS | 25500 | 10:04:31 INFO - PROCESS | 25500 | [#0] dojo.html Cycles:165 Average:4721.89 Median:4842.20 stddev:499.59 (10.3%) stddev-sans-first:473.73 10:04:31 INFO - PROCESS | 25500 | Values: 2641.8 2644.2 2653.9 2673.1 2695.6 4593.4 4682.6 4773.7 4818.6 4826.7 4676.7 4676.9 4689.2 4744.0 4791.2 4256.6 4372.6 4428.3 4434.6 4459.4 4110.4 4459.1 4487.7 4497.9 4536.7 4231.6 4308.3 4323.1 4357.3 4381.0 4376.9 4380.4 4387.0 4432.4 4435.1 4317.6 4344.9 4362.5 4362.6 4412.1 4594.8 4710.7 4780.2 4785.6 4835.8 5113.8 5129.5 5138.5 5148.3 5168.2 5163.1 5163.8 5169.7 5177.4 5220.3 4661.9 4724.4 4767.8 4795.4 4796.7 5244.8 5246.9 5250.9 5251.1 5270.6 5036.9 5049.3 5050.3 5057.2 5105.4 4907.7 5006.4 5071.8 5076.8 5129.5 5019.7 5055.2 5061.1 5078.8 5146.5 5056.3 5063.9 5072.9 5079.6 5090.8 4180.9 4209.9 4250.2 4269.4 4275.8 3762.4 3775.2 3788.4 3818.6 3826.7 4476.9 4477.0 4477.4 4515.1 4548.1 4993.5 5098.0 5133.7 5152.3 5163.5 4459.4 4474.1 4481.5 4518.9 4530.7 4576.3 4597.4 4604.0 4609.9 4664.0 4681.5 4779.0 4837.2 4847.8 4865.3 5123.2 5140.7 5140.7 5144.7 5191.2 4839.7 4840.8 4843.7 4851.2 4889.5 4939.1 4977.3 5031.8 5038.3 5070.2 5095.6 5117.1 5122.2 5127.5 5130.4 4988.2 4988.3 4993.7 5004.2 5040.4 4806.1 4941.1 4989.4 5012.6 5088.0 4922.8 4922.9 4931.0 4932.1 4945.5 5043.2 5052.7 5057.7 5058.7 5115.1 4791.3 4842.2 4889.0 4891.3 4925.7 10:04:31 INFO - PROCESS | 25500 | 10:04:31 INFO - PROCESS | 25500 | [#1] ext.html Cycles:180 Average:46898.85 Median:35508.91 stddev:86820.77 (244.5%) stddev-sans-first:86994.55 10:04:31 INFO - PROCESS | 25500 | Values: 537.7 547.0 560.6 567.6 574.5 33640.8 37659.8 37744.4 37768.6 37786.4 37906.6 37929.8 38201.0 38434.4 38555.8 7565.0 7695.8 7696.8 7710.7 7728.5 7616.7 7663.8 7674.2 7691.0 7709.3 7624.7 7681.8 7681.9 7685.0 7720.1 7645.6 7657.6 7658.3 7667.2 7672.3 7540.4 7593.4 7595.5 7599.1 7599.7 36113.0 36191.0 36198.5 36214.8 36504.6 2849.6 3005.2 3050.8 3213.9 3357.4 27564.9 27807.3 27865.7 27991.6 29200.4 3471.3 3581.4 3642.4 3667.9 3682.8 251580.0 252736.0 254415.0 254981.7 256484.0 55762.0 56189.0 56449.4 56634.0 56638.0 32659.0 33710.5 33939.7 35473.8 35544.0 13565.3 13822.8 13833.2 13859.7 13920.5 10358.0 10547.2 10559.3 10559.3 10586.9 18173.4 18253.1 18294.8 18320.9 18497.5 7140.5 7148.7 7184.3 7365.8 7416.5 717.4 813.5 905.0 958.0 978.2 25787.4 27838.6 27892.8 28092.2 28157.9 850.3 903.1 917.3 921.0 1042.2 13878.9 14538.2 14789.6 14859.2 14985.2 376669.0 380504.0 382312.0 383238.0 383776.0 47050.3 47717.8 47792.3 47852.3 47931.0 1094.7 1135.0 1138.8 1140.1 1146.6 26129.6 26680.5 27371.3 27806.0 28015.0 40742.8 40887.8 40898.4 40940.8 41219.0 338310.0 340177.0 340258.0 340467.0 340821.0 24180.3 24576.8 25313.5 25324.0 26611.3 40587.6 40873.2 40886.6 41348.4 42004.2 34400.3 34666.3 34815.0 35171.0 35172.6 34427.8 34455.5 34789.3 34946.3 35241.8 30819.7 34850.0 34901.0 34992.0 35600.0 29173.6 32449.4 32543.8 32667.0 32721.2 23734.0 24390.9 24577.1 24898.3 25068.5 10:04:31 INFO - PROCESS | 25500 | 10:04:31 INFO - PROCESS | 25500 | [#2] jquery.html Cycles:180 Average:23794.90 Median:27567.74 stddev:64975.05 (235.7%) stddev-sans-first:65133.46 10:04:31 INFO - PROCESS | 25500 | Values: 341.1 352.0 356.3 357.5 373.3 15973.0 16966.7 17078.8 17392.0 17524.8 15313.2 15630.2 15783.9 15789.4 15810.4 4696.7 5005.4 5021.0 5031.1 5048.3 3626.7 5093.8 5765.9 6054.5 6071.9 6114.7 6127.2 6136.7 6147.2 6153.5 5203.8 5454.7 5509.1 5562.7 5584.1 5236.3 5240.6 5315.4 5372.0 5391.2 12207.8 12391.2 12468.4 12472.2 12483.6 1714.5 1744.1 1778.6 1818.0 2014.4 8756.3 8974.6 9593.8 9627.5 10210.9 1638.2 1703.5 1725.8 1744.3 1754.4 65766.7 66455.7 66586.3 66685.0 67715.0 9674.8 9779.6 9904.0 10137.7 10138.9 13355.5 13355.6 13388.5 13391.3 13421.5 6661.0 6857.2 6876.8 6899.7 7067.2 6472.8 6531.6 6630.9 6709.9 6712.8 3947.6 4148.9 4205.7 4220.1 4312.2 1662.7 1664.8 1680.2 1724.9 1767.7 747.5 789.6 860.5 884.2 888.9 16449.3 16452.3 16743.6 16891.6 16973.9 779.6 834.1 837.6 868.0 895.9 9018.3 9116.5 9355.4 9520.3 9618.9 385887.0 395704.0 396046.0 396198.0 397215.0 71505.6 71633.6 73299.3 74605.0 75303.2 884.0 887.7 908.2 921.0 921.8 14667.6 14713.2 14894.1 15079.9 15298.2 35459.8 35960.6 36093.8 36215.5 36510.0 48063.8 49178.0 49745.5 50114.5 50331.7 7068.3 7192.3 7353.9 7434.2 7533.5 9946.3 11621.3 11652.9 11720.0 12341.5 9813.6 9861.7 9915.7 9944.4 10577.6 4403.2 9783.9 10175.2 10400.7 10450.7 9756.7 9989.0 10016.2 10159.2 10646.5 7107.7 7209.6 7361.8 7374.6 7445.3 8847.2 10043.8 10185.0 10225.5 10411.9 10:04:31 INFO - PROCESS | 25500 | 10:04:31 INFO - PROCESS | 25500 | [#3] mootools.html Cycles:180 Average:4802.22 Median:4988.23 stddev:2652.76 (53.2%) stddev-sans-first:2647.32 10:04:31 INFO - PROCESS | 25500 | Values: 1323.1 1351.5 1403.7 1638.7 1673.0 6481.9 6747.8 7069.5 7244.2 7261.6 7402.9 7482.6 7485.6 7555.7 7582.5 2169.6 2197.7 2201.5 2202.4 2205.5 2116.0 2167.7 2181.1 2182.2 2183.3 2162.3 2165.0 2167.6 2171.5 2195.8 2124.2 2130.9 2133.3 2135.3 2142.5 2058.9 2103.1 2108.4 2109.1 2111.4 7290.2 7320.8 7401.1 7407.3 7453.7 4189.9 4318.5 4321.4 4326.4 4333.2 2686.5 2769.7 2781.2 2806.8 2857.7 877.4 925.2 927.7 935.5 940.9 9814.4 9892.9 9896.9 9924.9 9949.2 3800.9 3943.6 4077.7 4079.0 4100.2 8555.3 8567.8 8580.4 8592.7 8602.6 4288.1 4308.6 4311.7 4312.1 4313.6 3630.1 3731.1 3839.3 3897.5 3900.5 3482.2 3562.3 3562.6 3590.0 3667.8 1139.5 1143.4 1157.6 1176.9 1184.6 770.3 796.5 809.0 809.3 812.3 4777.6 4845.5 4913.4 4968.2 5105.9 379.7 389.3 397.2 403.1 407.4 3383.6 3405.3 3408.9 3425.1 3528.3 8511.7 8905.5 8924.9 8944.0 8949.6 8872.2 8913.6 8918.9 8931.9 8932.6 6872.4 6919.2 6935.1 6940.0 6943.5 4863.2 4878.9 5008.2 5042.7 5117.9 7905.7 8093.5 8095.2 8192.8 8362.5 8258.3 8293.5 8338.8 8370.8 8379.8 5575.8 5968.2 6107.2 6122.2 6141.2 7102.6 7110.4 7145.0 7162.1 7166.9 5986.2 6022.2 6031.4 6139.2 6191.5 6111.1 6130.4 6134.8 6147.2 6156.3 5806.0 5924.5 5928.6 5937.1 5937.7 4161.8 4233.4 4323.7 4327.5 4394.9 4237.2 4238.2 4261.4 4330.2 4372.3 10:04:31 INFO - PROCESS | 25500 | 10:04:31 INFO - PROCESS | 25500 | [#4] prototype.html Cycles:180 Average:4166.93 Median:4598.72 stddev:1210.66 (26.3%) stddev-sans-first:1178.56 10:04:31 INFO - PROCESS | 25500 | Values: 289.4 289.5 299.7 301.8 302.3 4793.4 4919.2 5027.3 5032.4 5045.7 4901.8 4935.8 4939.3 4955.0 4966.2 3919.5 3920.4 3921.2 3925.9 3942.4 3671.5 3922.8 3925.0 3939.8 3943.0 3817.4 3836.7 3841.7 3845.8 3853.0 3781.8 3816.4 3829.2 3831.7 3832.9 3356.5 3361.5 3362.8 3364.4 3365.1 4713.7 4818.3 4827.0 4860.8 4866.9 4337.9 4350.3 4361.9 4362.9 4366.5 5161.6 5172.2 5176.3 5182.4 5187.2 3546.3 3613.4 3629.9 3631.5 3645.2 5338.4 5410.9 5411.7 5414.6 5419.7 3731.8 3737.5 3740.6 3740.8 3741.6 3784.7 3787.1 3790.8 3799.9 3808.3 4225.4 4299.6 4338.3 4350.4 4356.3 5189.5 5193.3 5202.0 5207.6 5214.9 1242.4 1275.8 1299.9 1310.2 1315.8 869.2 886.9 896.7 903.8 906.9 4558.5 4594.4 4598.1 4599.3 4600.1 5352.7 5358.3 5360.7 5364.2 5366.6 4385.1 4603.3 4607.8 4612.6 4613.8 2504.8 2509.1 2528.8 2530.9 2536.2 4420.4 4454.3 4497.2 4504.3 4508.2 4590.4 4754.6 4771.4 4773.9 4797.9 4351.2 4453.4 4453.5 4454.9 4471.8 4614.3 4631.3 4660.6 4678.6 4713.5 4593.7 4604.7 4607.7 4624.0 4652.9 4309.0 4412.6 4428.9 4460.0 4500.0 3372.2 3391.9 3393.9 3407.4 3446.8 4677.7 4688.9 4689.2 4712.1 5106.5 5082.6 5166.2 5195.2 5202.9 5209.7 5150.7 5166.5 5171.0 5180.5 5208.3 4892.7 5093.3 5115.8 5121.9 5140.3 5243.2 5245.7 5250.9 5260.4 5265.3 5148.8 5156.0 5156.4 5157.4 5161.7 10:04:31 INFO - PROCESS | 25500 | 10:04:31 INFO - PROCESS | 25500 | [#5] yui.html Cycles:180 Average:16869.33 Median:476.35 stddev:24628.02 (5170.1%) stddev-sans-first:24666.72 10:04:31 INFO - PROCESS | 25500 | Values: 576.3 622.1 639.1 640.5 719.4 12582.9 13253.1 13613.8 13899.5 13912.2 12660.4 12713.9 12768.1 12768.4 12785.9 602.8 731.6 748.7 750.5 753.8 726.8 749.0 754.9 757.1 758.4 802.7 804.8 804.8 805.7 806.3 796.1 797.9 805.6 806.8 806.9 580.9 588.0 588.1 588.1 589.1 12823.9 12856.8 12877.0 12884.5 12889.1 13391.6 13430.0 13636.7 13704.6 13982.4 9915.6 9995.1 10014.9 10109.7 10111.1 3270.3 3297.7 3305.5 3337.9 3349.3 63134.4 64444.7 66018.0 66684.7 67811.3 9610.6 9715.0 9839.9 9875.4 9939.2 18369.0 18445.6 18463.6 18513.7 18707.3 6034.4 6041.9 6072.1 6110.6 6217.3 3818.8 3823.7 3847.2 3848.9 3849.5 2832.1 2921.5 2923.6 2929.7 2931.5 453.4 462.6 466.8 474.1 478.6 397.1 436.1 462.2 473.5 503.7 7179.2 7613.5 7714.3 7888.7 7977.6 420.4 484.7 501.7 503.4 510.5 3555.7 3739.1 3819.6 3832.5 3910.5 98166.5 102870.5 106168.5 106794.5 107277.5 48224.5 51350.7 52099.5 58561.4 83765.6 75161.0 77088.0 77273.6 77527.0 78966.6 6678.2 6827.0 6973.7 7024.6 7389.9 31494.8 35590.5 42511.8 42785.6 43667.8 52214.5 52783.3 59320.0 62920.7 64760.0 9632.4 9834.4 10072.4 10166.8 10884.3 11275.5 11410.5 11418.8 11458.0 11805.5 10308.4 10434.3 10744.9 10758.2 10826.0 10032.5 10109.3 10361.1 10382.9 10520.3 9309.6 10509.4 10559.7 11031.9 11909.4 9195.8 9235.9 9520.8 9566.3 9844.6 9410.2 9950.8 10016.5 10019.0 10045.5 10:04:31 INFO - PROCESS | 25500 | -------- Summary: end -------- 10:04:31 INFO - PROCESS | 25500 | 10:04:32 INFO - TEST-INFO | 25500: exit 0 10:04:32 INFO - TEST-OK | dromaeo_css | took 1119053ms 10:04:32 INFO - TEST-START | kraken 10:04:32 INFO - operating with platform_type : linux_ 10:04:32 INFO - Initialising browser for kraken test... 10:04:32 INFO - TEST-INFO | started process 25861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYQe3mP/profile http://localhost:36627/getInfo.html) 10:04:37 INFO - PROCESS | 25861 | __metrics Screen width/height:1600/1200 10:04:37 INFO - PROCESS | 25861 | colorDepth:24 10:04:37 INFO - PROCESS | 25861 | Browser inner width/height: 1024/697 10:04:37 INFO - PROCESS | 25861 | __metrics 10:04:37 ERROR - PROCESS | 25861 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 10:04:38 INFO - TEST-INFO | 25861: exit 0 10:04:38 INFO - Browser initialized. 10:04:38 INFO - Running cycle 1/1 for kraken test... 10:04:38 INFO - TEST-INFO | started process 25979 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYQe3mP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:04:51 INFO - PROCESS | 25979 | RSS: Main: 192692224 10:04:51 INFO - PROCESS | 25979 | 10:04:53 INFO - PROCESS | 25979 | Cycle 1(1): loaded http://localhost:36627/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36627/tests/kraken/driver.html?testName=audio-beat-detection) 10:04:54 INFO - PROCESS | 25979 | RSS: Main: 205795328 10:04:54 INFO - PROCESS | 25979 | 10:04:57 INFO - PROCESS | 25979 | Cycle 1(1): loaded http://localhost:36627/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36627/tests/kraken/driver.html?testName=audio-dft) 10:04:58 INFO - PROCESS | 25979 | RSS: Main: 204664832 10:04:58 INFO - PROCESS | 25979 | 10:05:01 INFO - PROCESS | 25979 | Cycle 1(1): loaded http://localhost:36627/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36627/tests/kraken/driver.html?testName=audio-fft) 10:05:01 INFO - PROCESS | 25979 | RSS: Main: 196915200 10:05:01 INFO - PROCESS | 25979 | 10:05:04 INFO - PROCESS | 25979 | Cycle 1(1): loaded http://localhost:36627/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36627/tests/kraken/driver.html?testName=audio-oscillator) 10:05:04 INFO - PROCESS | 25979 | RSS: Main: 197525504 10:05:04 INFO - PROCESS | 25979 | 10:05:06 INFO - PROCESS | 25979 | Cycle 1(1): loaded http://localhost:36627/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36627/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:05:07 INFO - PROCESS | 25979 | RSS: Main: 197976064 10:05:07 INFO - PROCESS | 25979 | 10:05:10 INFO - PROCESS | 25979 | Cycle 1(1): loaded http://localhost:36627/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36627/tests/kraken/driver.html?testName=imaging-darkroom) 10:05:11 INFO - PROCESS | 25979 | RSS: Main: 198221824 10:05:11 INFO - PROCESS | 25979 | 10:05:14 INFO - PROCESS | 25979 | Cycle 1(1): loaded http://localhost:36627/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36627/tests/kraken/driver.html?testName=imaging-desaturate) 10:05:15 INFO - PROCESS | 25979 | RSS: Main: 195596288 10:05:15 INFO - PROCESS | 25979 | 10:05:18 INFO - PROCESS | 25979 | Cycle 1(1): loaded http://localhost:36627/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36627/tests/kraken/driver.html?testName=json-parse-financial) 10:05:19 INFO - PROCESS | 25979 | RSS: Main: 197140480 10:05:19 INFO - PROCESS | 25979 | 10:05:20 INFO - PROCESS | 25979 | Cycle 1(1): loaded http://localhost:36627/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36627/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:05:21 INFO - PROCESS | 25979 | RSS: Main: 197476352 10:05:21 INFO - PROCESS | 25979 | 10:05:23 INFO - PROCESS | 25979 | Cycle 1(1): loaded http://localhost:36627/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36627/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:05:24 INFO - PROCESS | 25979 | RSS: Main: 197500928 10:05:24 INFO - PROCESS | 25979 | 10:05:26 INFO - PROCESS | 25979 | Cycle 1(1): loaded http://localhost:36627/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36627/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:05:27 INFO - PROCESS | 25979 | RSS: Main: 197459968 10:05:27 INFO - PROCESS | 25979 | 10:05:29 INFO - PROCESS | 25979 | Cycle 1(1): loaded http://localhost:36627/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36627/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:05:30 INFO - PROCESS | 25979 | RSS: Main: 198156288 10:05:30 INFO - PROCESS | 25979 | 10:05:33 INFO - PROCESS | 25979 | Cycle 1(1): loaded http://localhost:36627/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36627/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:05:34 INFO - PROCESS | 25979 | RSS: Main: 198492160 10:05:34 INFO - PROCESS | 25979 | 10:05:35 INFO - PROCESS | 25979 | Cycle 1(1): loaded http://localhost:36627/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36627/tests/kraken/driver.html?testName=ai-astar) 10:05:36 INFO - PROCESS | 25979 | RSS: Main: 199577600 10:05:36 INFO - PROCESS | 25979 | 10:05:36 INFO - PROCESS | 25979 | __start_tp_report 10:05:36 INFO - PROCESS | 25979 | _x_x_mozilla_page_load 10:05:36 INFO - PROCESS | 25979 | _x_x_mozilla_page_load_details 10:05:36 INFO - PROCESS | 25979 | |i|pagename|runs| 10:05:36 INFO - PROCESS | 25979 | |0;ai-astar;109;115;117;115;116;115;115;115;115;133 10:05:36 INFO - PROCESS | 25979 | |1;audio-beat-detection;156;130;151;190;125;159;152;126;194;126 10:05:36 INFO - PROCESS | 25979 | |2;audio-dft;165;170;163;162;162;163;163;161;163;163 10:05:36 INFO - PROCESS | 25979 | |3;audio-fft;78;77;76;170;79;76;78;78;156;77 10:05:36 INFO - PROCESS | 25979 | |4;audio-oscillator;84;84;150;84;84;85;139;83;84;147 10:05:36 INFO - PROCESS | 25979 | |5;imaging-gaussian-blur;118;118;119;120;119;119;120;118;117;120 10:05:36 INFO - PROCESS | 25979 | |6;imaging-darkroom;149;148;149;148;149;148;149;149;148;149 10:05:36 INFO - PROCESS | 25979 | |7;imaging-desaturate;97;97;97;98;96;96;96;97;96;96 10:05:36 INFO - PROCESS | 25979 | |8;json-parse-financial;64;65;65;65;64;66;64;66;65;65 10:05:36 INFO - PROCESS | 25979 | |9;json-stringify-tinderbox;65;68;66;67;67;66;66;66;69;66 10:05:36 INFO - PROCESS | 25979 | |10;stanford-crypto-aes;84;88;87;86;86;84;85;83;83;83 10:05:36 INFO - PROCESS | 25979 | |11;stanford-crypto-ccm;147;138;133;142;141;142;134;146;182;151 10:05:36 INFO - PROCESS | 25979 | |12;stanford-crypto-pbkdf2;177;175;174;177;177;177;175;179;177;174 10:05:36 INFO - PROCESS | 25979 | |13;stanford-crypto-sha256-iterative;71;70;70;70;70;69;71;73;70;67 10:05:36 INFO - PROCESS | 25979 | __end_tp_report 10:05:36 INFO - PROCESS | 25979 | __start_cc_report 10:05:36 INFO - PROCESS | 25979 | _x_x_mozilla_cycle_collect,889 10:05:36 INFO - PROCESS | 25979 | __end_cc_report 10:05:36 INFO - PROCESS | 25979 | __startTimestamp1472576736138__endTimestamp 10:05:36 INFO - PROCESS | 25979 | 10:05:36 INFO - PROCESS | 25979 | ------- Summary: start ------- 10:05:36 INFO - PROCESS | 25979 | Number of tests: 14 10:05:36 INFO - PROCESS | 25979 | 10:05:36 INFO - PROCESS | 25979 | [#0] ai-astar Cycles:10 Average:116.50 Median:115.00 stddev:6.17 (5.4%) stddev-sans-first:5.92 10:05:36 INFO - PROCESS | 25979 | Values: 109.0 115.0 117.0 115.0 116.0 115.0 115.0 115.0 115.0 133.0 10:05:36 INFO - PROCESS | 25979 | 10:05:36 INFO - PROCESS | 25979 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:154.00 stddev:25.44 (16.5%) stddev-sans-first:26.92 10:05:36 INFO - PROCESS | 25979 | Values: 156.0 130.0 151.0 190.0 125.0 159.0 152.0 126.0 194.0 126.0 10:05:36 INFO - PROCESS | 25979 | 10:05:36 INFO - PROCESS | 25979 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:2.51 (1.5%) stddev-sans-first:2.60 10:05:36 INFO - PROCESS | 25979 | Values: 165.0 170.0 163.0 162.0 162.0 163.0 163.0 161.0 163.0 163.0 10:05:36 INFO - PROCESS | 25979 | 10:05:36 INFO - PROCESS | 25979 | [#3] audio-fft Cycles:10 Average:94.50 Median:77.50 stddev:36.27 (46.8%) stddev-sans-first:37.97 10:05:36 INFO - PROCESS | 25979 | Values: 78.0 77.0 76.0 170.0 79.0 76.0 78.0 78.0 156.0 77.0 10:05:36 INFO - PROCESS | 25979 | 10:05:36 INFO - PROCESS | 25979 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:84.00 stddev:29.75 (35.4%) stddev-sans-first:30.80 10:05:36 INFO - PROCESS | 25979 | Values: 84.0 84.0 150.0 84.0 84.0 85.0 139.0 83.0 84.0 147.0 10:05:36 INFO - PROCESS | 25979 | 10:05:36 INFO - PROCESS | 25979 | [#5] imaging-gaussian-blur Cycles:10 Average:118.80 Median:119.00 stddev:1.03 (0.9%) stddev-sans-first:1.05 10:05:36 INFO - PROCESS | 25979 | Values: 118.0 118.0 119.0 120.0 119.0 119.0 120.0 118.0 117.0 120.0 10:05:36 INFO - PROCESS | 25979 | 10:05:36 INFO - PROCESS | 25979 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 10:05:36 INFO - PROCESS | 25979 | Values: 149.0 148.0 149.0 148.0 149.0 148.0 149.0 149.0 148.0 149.0 10:05:36 INFO - PROCESS | 25979 | 10:05:36 INFO - PROCESS | 25979 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 10:05:36 INFO - PROCESS | 25979 | Values: 97.0 97.0 97.0 98.0 96.0 96.0 96.0 97.0 96.0 96.0 10:05:36 INFO - PROCESS | 25979 | 10:05:36 INFO - PROCESS | 25979 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 10:05:36 INFO - PROCESS | 25979 | Values: 64.0 65.0 65.0 65.0 64.0 66.0 64.0 66.0 65.0 65.0 10:05:36 INFO - PROCESS | 25979 | 10:05:36 INFO - PROCESS | 25979 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:66.50 stddev:1.17 (1.8%) stddev-sans-first:1.09 10:05:36 INFO - PROCESS | 25979 | Values: 65.0 68.0 66.0 67.0 67.0 66.0 66.0 66.0 69.0 66.0 10:05:36 INFO - PROCESS | 25979 | 10:05:36 INFO - PROCESS | 25979 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.50 stddev:1.79 (2.1%) stddev-sans-first:1.87 10:05:36 INFO - PROCESS | 25979 | Values: 84.0 88.0 87.0 86.0 86.0 84.0 85.0 83.0 83.0 83.0 10:05:36 INFO - PROCESS | 25979 | 10:05:36 INFO - PROCESS | 25979 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:144.00 stddev:13.96 (9.7%) stddev-sans-first:14.80 10:05:36 INFO - PROCESS | 25979 | Values: 147.0 138.0 133.0 142.0 141.0 142.0 134.0 146.0 182.0 151.0 10:05:36 INFO - PROCESS | 25979 | 10:05:36 INFO - PROCESS | 25979 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.20 Median:177.00 stddev:1.62 (0.9%) stddev-sans-first:1.69 10:05:36 INFO - PROCESS | 25979 | Values: 177.0 175.0 174.0 177.0 177.0 177.0 175.0 179.0 177.0 174.0 10:05:36 INFO - PROCESS | 25979 | 10:05:36 INFO - PROCESS | 25979 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:1.52 (2.2%) stddev-sans-first:1.58 10:05:36 INFO - PROCESS | 25979 | Values: 71.0 70.0 70.0 70.0 70.0 69.0 71.0 73.0 70.0 67.0 10:05:36 INFO - PROCESS | 25979 | -------- Summary: end -------- 10:05:36 INFO - PROCESS | 25979 | 10:05:37 INFO - TEST-INFO | 25979: exit 0 10:05:37 INFO - TEST-OK | kraken | took 64927ms 10:05:37 INFO - SUITE-END | took 1183s 10:05:37 INFO - Completed test suite (00:19:44) 10:05:37 INFO - javascript benchmark 10:05:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6195.369446533735, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2641.8018648601355, 2644.153870761356, 2653.880575374108, 2673.091149009337, 2695.6360891279674, 4593.402857628504, 4682.555157260059, 4773.737444440559, 4818.566329030386, 4826.71039737616, 4676.672632915689, 4676.883077923054, 4689.155951928651, 4744.003759210561, 4791.185498465261, 4256.553061928499, 4372.5627437256335, 4428.269335559628, 4434.556544345556, 4459.375687403766, 4110.445089912853, 4459.108178364324, 4487.708298960557, 4497.932531012054, 4536.727796332214, 4231.555686652888, 4308.332208507655, 4323.113761678848, 4357.302831546937, 4380.9780951095045, 4376.912461750779, 4380.430544029287, 4387.034852332482, 4432.401625780511, 4435.112977404532, 4317.611414972636, 4344.91310173798, 4362.47650281965, 4362.563743625644, 4412.117576484684, 4594.793234304464, 4710.74090924999, 4780.163471392527, 4785.593224575915, 4835.782389792468, 5113.769880355393, 5129.512696293846, 5138.511841375063, 5148.330717006766, 5168.224766285088, 5163.096458119851, 5163.845084647466, 5169.689818610896, 5177.37871455424, 5220.26916231724, 4661.883452913637, 4724.4094488188975, 4767.809287628456, 4795.448523419782, 4796.736179510125, 5244.842654720364, 5246.895062098737, 5250.921236181461, 5251.081060814342, 5270.631055826132, 5036.924446133311, 5049.343585333957, 5050.267711181858, 5057.216131499624, 5105.361829771278, 4907.7300748458465, 5006.3992320921, 5071.822486212965, 5076.82231121909, 5129.487051294841, 5019.67372120811, 5055.16589762685, 5061.13960626687, 5078.847634570969, 5146.4853514648985, 5056.342675452168, 5063.949360506422, 5072.923906141411, 5079.619028572872, 5090.821821236239, 4180.874573762792, 4209.852655157055, 4250.171216612731, 4269.359596060615, 4275.828966841354, 3762.416825392014, 3775.207206486614, 3788.3938569828697, 3818.6181381862148, 3826.6556009959236, 4476.932846007313, 4476.955230447719, 4477.440319960005, 4515.096980603892, 4548.090381923628, 4993.450720420751, 5098.0, 5133.666311689728, 5152.330197074356, 5163.535281824654, 4459.397981272552, 4474.149911516802, 4481.462224533077, 4518.887027824265, 4530.728156310632, 4576.336431217454, 4597.3793537872625, 4604.0331530379, 4609.861704148881, 4664.0, 4681.461631912373, 4778.976105119452, 4837.201861692782, 4847.80608775645, 4865.294532292868, 5123.23151527259, 5140.717260550556, 5140.717260550556, 5144.742762861917, 5191.22131680251, 4839.661223714306, 4840.83057093, 4843.685160464559, 4851.175300198904, 4889.462159162418, 4939.086269040239, 4977.303177555217, 5031.823886163967, 5038.345015148007, 5070.2141168119, 5095.592352611856, 5117.104506711236, 5122.154844450624, 5127.513021223804, 5130.413690343631, 4988.152014157675, 4988.301637770787, 4993.700377977333, 5004.17431123875, 5040.420351659606, 4806.134895718665, 4941.085899108676, 4989.401271847401, 5012.624053195952, 5088.0078384714625, 4922.778474968563, 4922.926156107733, 4930.9506904930495, 4932.136876046749, 4945.4807245238735, 5043.218301163325, 5052.72210028452, 5057.671251368649, 5058.721770302669, 5115.130427827204, 4791.329213910125, 4842.201036828884, 4888.9755551222015, 4891.33966914462, 4925.704457732548], "value": 4689.802029688434, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.7472587883695, 546.9890602187955, 560.5683623609818, 567.5799908068028, 574.4743559642927, 33640.83179584102, 37659.81170094149, 37744.43383349252, 37768.622313776854, 37786.4332035019, 37906.620933790655, 37929.810350948275, 38201.0, 38434.42348364777, 38555.807220963856, 7564.9787278717495, 7695.8076048098965, 7696.769096927102, 7710.653020614058, 7728.459007869451, 7616.695332186706, 7663.770086897374, 7674.155842857282, 7690.961545192266, 7709.267619576131, 7624.695012199505, 7681.846363072736, 7681.884771728429, 7685.03937007874, 7720.1121870985, 7645.61771911405, 7657.578833164173, 7658.2724641159, 7667.233276672344, 7672.271134242238, 7540.434467414966, 7593.354564861993, 7595.5442673439775, 7599.088109426849, 7599.696012159562, 36113.0, 36191.0, 36198.45702314441, 36214.8189259052, 36504.63495365039, 2849.586809912572, 3005.1735772662473, 3050.7864449488543, 3213.929013311859, 3357.3788849062757, 27564.86217568899, 27807.304817379525, 27865.721342786717, 27991.580126298122, 29200.41599168026, 3471.3096802452774, 3581.4448760442174, 3642.36258654737, 3667.8716244931297, 3682.797446140488, 251580.0, 252736.0, 254415.0, 254981.7250913752, 256484.0, 55761.981421672244, 56189.0, 56449.43550564524, 56634.0, 56638.0, 32659.0, 33710.49434258488, 33939.66060339365, 35473.82263088668, 35544.0, 13565.321733913264, 13822.792658110136, 13833.239171845646, 13859.722805543832, 13920.51278205258, 10358.0, 10547.208959328082, 10559.260851740459, 10559.260851740459, 10586.947065264625, 18173.36393226257, 18253.087345632666, 18294.817051829577, 18320.908395458206, 18497.53756156107, 7140.5358651687475, 7148.714051437988, 7184.317489838457, 7365.8158546036775, 7416.480846340704, 717.3758829818091, 813.4590497319334, 905.0313777362364, 957.9845363914274, 978.1538968791943, 25787.35531611687, 27838.582421263698, 27892.8398246321, 28092.157235282975, 28157.859210703817, 850.3452341696859, 903.1014140929685, 917.2982668258787, 920.963161473547, 1042.2443728296923, 13878.861211387959, 14538.24170114129, 14789.630259243606, 14859.182744949132, 14985.175815330262, 376669.0, 380504.0, 382312.0, 383238.0, 383776.0, 47050.294245586345, 47717.761411192725, 47792.28311575329, 47852.28221576679, 47931.041379172224, 1094.6606551968914, 1134.9659510214706, 1138.8234823602354, 1140.1164097824087, 1146.587228597704, 26129.60805587956, 26680.466390672467, 27371.315717106434, 27806.0, 28015.0, 40742.79628601838, 40887.795561022, 40898.38652420157, 40940.79529602333, 41219.0, 338310.0, 340177.0, 340258.0, 340467.0, 340821.0, 24180.274591762274, 24576.754232457446, 25313.49373012566, 25324.0, 26611.33471663224, 40587.59412405838, 40873.18253634851, 40886.59113408947, 41348.379774302804, 42004.159916802106, 34400.311993760486, 34666.306673866886, 34815.0, 35171.0, 35172.648273516934, 34427.82786086053, 34455.483167753, 34789.30421391609, 34946.30107397787, 35241.82379088088, 30819.69180308258, 34850.0, 34901.0, 34992.0, 35600.0, 29173.562396563644, 32449.35101298008, 32543.837280813445, 32667.0, 32721.18197045093, 23734.0, 24390.878045609657, 24577.079163193084, 24898.253052408458, 25068.498630026934], "value": 16983.281624600004, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.1454306961062, 351.9859205631775, 356.25364860617003, 357.5191367610563, 373.29447344518866, 15973.0, 16966.660666786673, 17078.82921170791, 17392.04343761094, 17524.82475175248, 15313.157776322298, 15630.218489075529, 15783.92108039461, 15789.368425262976, 15810.367585296603, 4696.694714843524, 5005.374328208974, 5020.97489512552, 5031.144705400073, 5048.268001139851, 3626.673599376056, 5093.79624815007, 5765.884682306351, 6054.5459090568165, 6071.878562428748, 6114.663693496856, 6127.234095738033, 6136.723847426854, 6147.170132032185, 6153.538484613649, 5203.765830537635, 5454.7272636368225, 5509.146082357241, 5562.694051827148, 5584.078627026536, 5236.266922630834, 5240.633155679104, 5315.441878602768, 5371.973140134274, 5391.191321301836, 12207.75584488314, 12391.194572352768, 12468.43892024861, 12472.189307695062, 12483.625491235278, 1714.459945117284, 1744.1017875793975, 1778.5642517583146, 1817.9909100454545, 2014.4359579317816, 8756.255718263956, 8974.641014359418, 9593.808123837483, 9627.470489123096, 10210.9489452553, 1638.1645360865925, 1703.4804384662673, 1725.8446739793478, 1744.345870298638, 1754.4035028090511, 65766.67116664434, 66455.66772166156, 66586.33413665801, 66685.0, 67715.0, 9674.75813104664, 9779.559919803625, 9903.950480247553, 10137.746556336151, 10138.898611013796, 13355.53255636048, 13355.599332020054, 13388.531401400904, 13391.263480508665, 13421.463141474233, 6661.0, 6857.177138743383, 6876.828079297958, 6899.689513971884, 7067.22260551339, 6472.773452929125, 6531.640759758259, 6630.900536491957, 6709.899351509731, 6712.83217919556, 3947.6052394760295, 4148.896277593024, 4205.684573656988, 4220.134872351161, 4312.223799716018, 1662.7339625659836, 1664.750287456891, 1680.15992003998, 1724.8533874620546, 1767.7184041569758, 747.4991755523812, 789.6249281591313, 860.4579115157536, 884.2307192742227, 888.9466632001971, 16449.342026319053, 16452.34190632385, 16743.58141046459, 16891.577710557336, 16973.91513042427, 779.5673401262354, 834.1283358889974, 837.6063250272363, 867.9696210632598, 895.8521843895815, 9018.278537716968, 9116.544172791466, 9355.4386736796, 9520.285978551636, 9618.855717164248, 385887.0, 395704.0, 396046.0, 396198.0, 397215.0, 71505.6424717873, 71633.64183179155, 73299.26700732924, 74605.0, 75303.24696753072, 883.9823203535893, 887.7159309021051, 908.1735620585367, 920.9723708288763, 921.7511271956535, 14667.559973200821, 14713.190774507504, 14894.106353618818, 15079.924600376928, 15298.235088245765, 35459.82270088633, 35960.64039359573, 36093.819530902176, 36215.45676814902, 36510.0, 48063.75968120137, 49178.0, 49745.502544974086, 50114.498855010985, 50331.74834125806, 7068.257832927468, 7192.280771922975, 7353.926460735538, 7434.176561693409, 7533.510321829063, 9946.30375873711, 11621.302721836717, 11652.88347116518, 11720.0, 12341.50633974667, 9813.607455701693, 9861.704148875546, 9915.65295214664, 9944.35361701516, 10577.62978295756, 4403.229434848953, 9783.867904358847, 10175.185985121321, 10400.711843394442, 10450.738731531468, 9756.707298781048, 9989.0, 10016.198704103508, 10159.238057145596, 10646.467676615983, 7107.715691372287, 7209.639518023973, 7361.8159546011775, 7374.557526548424, 7445.255474452728, 8847.20375166238, 10043.799124017332, 10185.0, 10225.488725563544, 10411.94794026025], "value": 7890.291326498834, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.1135139456567, 1351.513455156144, 1403.670137517683, 1638.737801951688, 1672.996202278633, 6481.870362592746, 6747.831304217397, 7069.4697897657625, 7244.203137654854, 7261.60061196634, 7402.852557853541, 7482.62586870657, 7485.588292643903, 7555.735549255777, 7582.545047297166, 2169.59862425451, 2197.7142971413696, 2201.471646804763, 2202.394341556077, 2205.492736670567, 2115.968260476094, 2167.729033870766, 2181.094845639058, 2182.2471247419694, 2183.3449965010514, 2162.2540223622905, 2165.0473791531754, 2167.5881582499273, 2171.543975765091, 2195.8133558647455, 2124.1715730864976, 2130.893455327235, 2133.264023911748, 2135.284679632325, 2142.4536743130557, 2058.938231853032, 2103.085157956294, 2108.4307237046064, 2109.1352545456443, 2111.4299139232476, 7290.161631412349, 7320.780376588711, 7401.111866576045, 7407.333339999426, 7453.739119130859, 4189.874303770892, 4318.5465526119615, 4321.351797230409, 4326.394304797331, 4333.1766964276685, 2686.5164270431314, 2769.667639883227, 2781.2490627530656, 2806.803523753338, 2857.7428031477266, 877.368294827723, 925.1581061234311, 927.6660402255183, 935.4948327902924, 940.8823897012874, 9814.411135331831, 9892.90107098927, 9896.901030989742, 9924.900750992541, 9949.154321882648, 3800.9049773755323, 3943.580311088006, 4077.734947228421, 4079.0, 4100.2414553307135, 8555.27280181179, 8567.785805354915, 8580.442271252348, 8592.656293748305, 8602.61288242018, 4288.142371525707, 4308.590683885026, 4311.676624253194, 4312.137572485515, 4313.611774940207, 3630.128769095398, 3731.0858839584475, 3839.3281175794123, 3897.4738410314812, 3900.4539364488996, 3482.233908540117, 3562.251927095339, 3562.5724913010085, 3590.0, 3667.7615954962844, 1139.4872307461676, 1143.3768596115137, 1157.6237722739975, 1176.8705442401329, 1184.5557915781583, 770.2951799103869, 796.482286513759, 808.9676412943534, 809.3039985612369, 812.2973627812019, 4777.570018698264, 4845.515448455197, 4913.361263035854, 4968.205087186033, 5105.9489405106215, 379.6962430055944, 389.33229511388106, 397.15208030854336, 403.0568469780727, 407.4275642721921, 3383.5939687237687, 3405.3189362127673, 3408.931821363559, 3425.1265927188906, 3528.3119791640383, 8511.702090426928, 8905.465672059698, 8924.910750892537, 8943.955280223558, 8949.59726812295, 8872.24585910192, 8913.55432228386, 8918.866217006751, 8931.866022009675, 8932.553372331358, 6872.381485666214, 6919.169699636076, 6935.133108361455, 6940.028396024561, 6943.51395402317, 4863.221884498464, 4878.853469434609, 5008.248762685626, 5042.697438153723, 5117.8720531987, 7905.683772649029, 8093.473924194908, 8095.23095305945, 8192.795180120545, 8362.498250105013, 8258.298044666271, 8293.543855088028, 8338.833223335378, 8370.790730231793, 8379.790505237173, 5575.77696892136, 5968.194293770285, 6107.236595425572, 6122.234720659918, 6141.201643786279, 7102.573845569283, 7110.431165506644, 7144.964275178799, 7162.104736907887, 7166.856662866609, 5986.161937328865, 6022.247219097613, 6031.366706495754, 6139.201903752483, 6191.504679625529, 6111.113888486234, 6130.386961304012, 6134.846628834315, 6147.170132032297, 6156.322804491592, 5806.025951176452, 5924.52603791687, 5928.614640048383, 5937.139114828239, 5937.732802023833, 4161.8335266589, 4233.449651545279, 4323.740575565476, 4327.459067616548, 4394.934075988926, 4237.194932962727, 4238.152369526046, 4261.446012018542, 4330.198913201068, 4372.300431930876], "value": 3845.0557238706783, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.4139367780246, 289.5193977996526, 299.74970899299075, 301.82192506421205, 302.30771533189, 4793.424789025322, 4919.237518184678, 5027.32131162293, 5032.396112466505, 5045.738565358665, 4901.754912254382, 4935.82724604638, 4939.271255060736, 4955.0, 4966.180580204271, 3919.5492518360325, 3920.3727403615426, 3921.2353591049755, 3925.862594809182, 3942.369220924653, 3671.541057367829, 3922.8234729437245, 3925.0, 3939.8424063037446, 3943.0, 3817.351050321452, 3836.6547010769027, 3841.7118716096265, 3845.8461661533506, 3852.961470385302, 3781.773093614392, 3816.370298900692, 3829.2341531693496, 3831.7126215533945, 3832.885013449601, 3356.456030226099, 3361.4957756336503, 3362.8150451725146, 3364.4112280351087, 3365.1418888183357, 4713.670043096985, 4818.34952281441, 4826.951730482685, 4860.756962151878, 4866.902661946777, 4337.891552711176, 4350.260455722535, 4361.869143925655, 4362.8691139265875, 4366.454193225847, 5161.5870730341485, 5172.172452407634, 5176.265950906451, 5182.4299327073995, 5187.247849061902, 3546.343926373629, 3613.421852503613, 3629.8548058077645, 3631.5460567429072, 3645.179834537208, 5338.3593968724, 5410.91883621746, 5411.702356370398, 5414.620976531644, 5419.729013549346, 3731.776093434403, 3737.4954381158195, 3740.6446387593137, 3740.8129593520216, 3741.5510138782975, 3784.735068545175, 3787.1289603391374, 3790.753601015925, 3799.9430008549894, 3808.314503389361, 4225.366195070764, 4299.613034826881, 4338.262495375794, 4350.412694286294, 4356.259435895905, 5189.546926860485, 5193.2989046479, 5201.973990130025, 5207.5833933286, 5214.895702085937, 1242.428482897859, 1275.8022506511506, 1299.8895093917124, 1310.1614966421498, 1315.8420589880843, 869.2046777198918, 886.8536691445968, 896.6727144592177, 903.8192361527721, 906.8821053263033, 4558.475775285819, 4594.356790049395, 4598.126355992351, 4599.310103484504, 4600.102979918884, 5352.678839269656, 5358.27663265462, 5360.705161216092, 5364.195370694349, 5366.597505187126, 4385.062008454343, 4603.286490593963, 4607.778938581278, 4612.584867361887, 4613.815447382134, 2504.7620476054744, 2509.0716434919195, 2528.84826910386, 2530.8987640494543, 2536.1757428835704, 4420.381146639473, 4454.331850222427, 4497.166784925476, 4504.301833215857, 4508.188526065274, 4590.449146102489, 4754.644926196018, 4771.427428708508, 4773.856784296477, 4797.864950097173, 4351.238533256667, 4453.354263631691, 4453.51011388747, 4454.933176002362, 4471.754053527087, 4614.300634129072, 4631.328457373729, 4660.580547750718, 4678.625709943264, 4713.457952335525, 4593.6554758392585, 4604.746738929391, 4607.723536587815, 4623.976880115712, 4652.93020604698, 4308.956910430856, 4412.6249268811225, 4428.911421771611, 4459.955400446084, 4499.955000449953, 3372.1673794013145, 3391.880679375751, 3393.9151521212166, 3407.4377727674655, 3446.844891979917, 4677.7193368398, 4688.9296660549435, 4689.249720044776, 4712.104700106968, 5106.514881086291, 5082.644214904921, 5166.199239117943, 5195.246689230116, 5202.933398653343, 5209.71346575942, 5150.665206761549, 5166.483351664803, 5170.991656626921, 5180.533751962342, 5208.348956380452, 4892.706437613754, 5093.339594271349, 5115.79536818538, 5121.871953201051, 5140.252314213186, 5243.187305967581, 5245.7114858683135, 5250.921236181384, 5260.368755749335, 5265.341832270966, 5148.794048238178, 5156.0, 5156.355455568054, 5157.381114266312, 5161.716105614228], "value": 3784.603091299071, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.2595065341036, 622.0668996505241, 639.0701529274905, 640.5004096804494, 719.3994059731045, 12582.937085314572, 13253.072284940057, 13613.7957930631, 13899.513517026906, 13912.234827084507, 12660.43028063737, 12713.872861271384, 12768.106232563725, 12768.42542085606, 12785.872141278585, 602.8342205893392, 731.5939653492296, 748.7304570354668, 750.5459197185706, 753.7701001194633, 726.8110291324267, 749.0187853911366, 754.8565772503234, 757.0725860820506, 758.3781299334548, 802.7110240313483, 804.7907544038534, 804.8430556041574, 805.7139715401037, 806.2985202873508, 796.1282395776644, 797.8763291689797, 805.6092794994423, 806.7983004248938, 806.8749343851713, 580.9419058094156, 587.967661778602, 588.0737837905316, 588.1178232651024, 589.0927970924771, 12823.87176128236, 12856.807147892789, 12877.0, 12884.54904078362, 12889.097763156582, 13391.598252052454, 13430.0, 13636.65908352299, 13704.588862334047, 13982.370793314325, 9915.553800079013, 9995.050470205319, 10014.89985100147, 10109.747256318577, 10111.090001899864, 3270.329582435595, 3297.7196938260277, 3305.5041743738393, 3337.8664853405835, 3349.279904820475, 63134.36865631331, 64444.71110577809, 66018.0, 66684.6665766668, 67811.32188678099, 9610.615575376907, 9715.02849715037, 9839.852402213972, 9875.358101723365, 9939.155171810477, 18369.0, 18445.631087378446, 18463.630727385378, 18513.7222941656, 18707.251709931723, 6034.426729460694, 6041.879162416815, 6072.119542666289, 6110.633361998294, 6217.253929528395, 3818.84724611018, 3823.6749876260274, 3847.211321679049, 3848.9037774055873, 3849.4995650565806, 2832.079574138413, 2921.517949538345, 2923.6491621005616, 2929.721676440735, 2931.5456104303867, 453.36302494994584, 462.5836746927725, 466.8179410030091, 474.12997150229717, 478.5716783478837, 397.1283033740911, 436.05158779654124, 462.17732436263503, 473.5241082711921, 503.7481259370315, 7179.210286868441, 7613.467057305936, 7714.3057124857905, 7888.73780195166, 7977.601119944095, 420.3820384035463, 484.7309743092547, 501.65135231014824, 503.4009528660882, 510.5296745373301, 3555.6977656899453, 3739.139997800521, 3819.598942111094, 3832.463455116286, 3910.511186101737, 98166.50916745371, 102870.48564757279, 106168.46915765372, 106794.46602766936, 107277.463612683, 48224.51775482271, 51350.74324628353, 52099.47900521022, 58561.4143858556, 83765.58117209375, 75160.99999999891, 77088.0, 77273.61363193148, 77527.0, 78966.6051669738, 6678.198616166092, 6827.0, 6973.721051157897, 7024.578525288499, 7389.926100738924, 31494.842525788143, 35590.46614300736, 42511.787441062595, 42785.57214427816, 43667.78166109149, 52214.47785522248, 52783.30516863936, 59320.0, 62920.68539657273, 64760.0, 9632.373895696757, 9834.409935403899, 10072.446015469219, 10166.8474972874, 10884.346939183357, 11275.548978041115, 11410.543578256777, 11418.771624567627, 11458.0, 11805.527778888749, 10308.433036183082, 10434.321769084985, 10744.892551074388, 10758.246922715334, 10826.0, 10032.498375081363, 10109.292349535463, 10361.119304859172, 10382.896171038194, 10520.316179448311, 9309.627614895327, 10509.369437833755, 10559.683209503728, 11031.889681103086, 11909.40452977365, 9195.816083678423, 9235.861462077939, 9520.761980950254, 9566.330356874952, 9844.60621575129, 9410.153086222273, 9950.800983980425, 10016.549255283384, 10019.0, 10045.49772511386], "value": 6182.449375418224, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1600.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 117.0, 115.0, 116.0, 115.0, 115.0, 115.0, 115.0, 133.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 151.0, 190.0, 125.0, 159.0, 152.0, 126.0, 194.0, 126.0], "value": 150.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 170.0, 163.0, 162.0, 162.0, 163.0, 163.0, 161.0, 163.0, 163.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 76.0, 170.0, 79.0, 76.0, 78.0, 78.0, 156.0, 77.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 150.0, 84.0, 84.0, 85.0, 139.0, 83.0, 84.0, 147.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 120.0, 119.0, 119.0, 120.0, 118.0, 117.0, 120.0], "value": 118.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 148.0, 149.0, 148.0, 149.0, 149.0, 148.0, 149.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 98.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 64.0, 66.0, 64.0, 66.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 66.0, 67.0, 67.0, 66.0, 66.0, 66.0, 69.0, 66.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 88.0, 87.0, 86.0, 86.0, 84.0, 85.0, 83.0, 83.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 138.0, 133.0, 142.0, 141.0, 142.0, 134.0, 146.0, 182.0, 151.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 175.0, 174.0, 177.0, 177.0, 177.0, 175.0, 179.0, 177.0, 174.0], "value": 176.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 70.0, 70.0, 69.0, 71.0, 73.0, 70.0, 67.0], "value": 70.1, "unit": "score"}]}]} 10:05:37 INFO - Return code: 0 10:05:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:05:37 ERROR - # TBPL SUCCESS # 10:05:37 INFO - Running post-action listener: _resource_record_post_action 10:05:37 INFO - [mozharness: 2016-08-30 17:05:37.961617Z] Finished run-tests step (success) 10:05:37 INFO - Running post-run listener: _resource_record_post_run 10:05:38 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 8192; Write bytes: 406880256; Read time: 16; Write time: 337476 10:05:38 INFO - TinderboxPrint: CPU usage
13.5% 10:05:38 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 10:05:38 INFO - TinderboxPrint: I/O write bytes / time
406,880,256 / 337,476 10:05:38 INFO - TinderboxPrint: CPU idle
8,287.2 (86.5%) 10:05:38 INFO - TinderboxPrint: CPU user
1,226.5 (12.8%) 10:05:38 INFO - TinderboxPrint: Swap in / out
0 / 0 10:05:38 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114507776; Read time: 0; Write time: 127756 10:05:38 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292016128; Read time: 4; Write time: 209676 10:05:38 INFO - Running post-run listener: _upload_blobber_files 10:05:38 INFO - Blob upload gear active. 10:05:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:05:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:05:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:05:39 INFO - (blobuploader) - INFO - Open directory for files ... 10:05:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:05:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:05:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:39 INFO - (blobuploader) - INFO - Done attempting. 10:05:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:05:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:05:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:40 INFO - (blobuploader) - INFO - Done attempting. 10:05:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:05:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:05:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:45 INFO - (blobuploader) - INFO - Done attempting. 10:05:45 INFO - (blobuploader) - INFO - Iteration through files over. 10:05:45 INFO - Return code: 0 10:05:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:05:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:05:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/020a48d645b56b6cff3aec9f50499e4b34f0d1aaf2046d6e57d717a0e0c91a5d1c3eea64009064d68bea5a4fbb7e07589b25544f608eaa2ca66c92b0bef61a6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c4066eaf00179478305fd0112e2cfc41a10c2990d49072d26bb0ca4d74ae0bc61aaa4825ba8b6ac8790d189e613ed99c28cd79a71251facf64c066b7c4c5228", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6f5560290633737dfa1ced1a033949d976e9cfe64c8227692040f998bfa7767a27e6c981850fd293d0c1071778d70c5378492633a936fa9f749e4ddc67b2a23"} 10:05:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:05:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:05:45 INFO - Contents: 10:05:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/020a48d645b56b6cff3aec9f50499e4b34f0d1aaf2046d6e57d717a0e0c91a5d1c3eea64009064d68bea5a4fbb7e07589b25544f608eaa2ca66c92b0bef61a6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c4066eaf00179478305fd0112e2cfc41a10c2990d49072d26bb0ca4d74ae0bc61aaa4825ba8b6ac8790d189e613ed99c28cd79a71251facf64c066b7c4c5228", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6f5560290633737dfa1ced1a033949d976e9cfe64c8227692040f998bfa7767a27e6c981850fd293d0c1071778d70c5378492633a936fa9f749e4ddc67b2a23"} 10:05:45 INFO - Running post-run listener: copy_logs_to_upload_dir 10:05:45 INFO - Copying logs to upload dir... 10:05:45 INFO - mkdir: /builds/slave/test/build/upload/logs 10:05:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.671393 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-30 10:05:45.440356) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 10:05:45.443501) ========= 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=14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/020a48d645b56b6cff3aec9f50499e4b34f0d1aaf2046d6e57d717a0e0c91a5d1c3eea64009064d68bea5a4fbb7e07589b25544f608eaa2ca66c92b0bef61a6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c4066eaf00179478305fd0112e2cfc41a10c2990d49072d26bb0ca4d74ae0bc61aaa4825ba8b6ac8790d189e613ed99c28cd79a71251facf64c066b7c4c5228", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6f5560290633737dfa1ced1a033949d976e9cfe64c8227692040f998bfa7767a27e6c981850fd293d0c1071778d70c5378492633a936fa9f749e4ddc67b2a23"} build_url:https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/XBOddpQWTCSS6QyaUAm_rw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/020a48d645b56b6cff3aec9f50499e4b34f0d1aaf2046d6e57d717a0e0c91a5d1c3eea64009064d68bea5a4fbb7e07589b25544f608eaa2ca66c92b0bef61a6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0c4066eaf00179478305fd0112e2cfc41a10c2990d49072d26bb0ca4d74ae0bc61aaa4825ba8b6ac8790d189e613ed99c28cd79a71251facf64c066b7c4c5228", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6f5560290633737dfa1ced1a033949d976e9cfe64c8227692040f998bfa7767a27e6c981850fd293d0c1071778d70c5378492633a936fa9f749e4ddc67b2a23"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 10:05:45.468796) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 10:05:45.469142) ========= 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=14ef55db36f7623abb31b9cf000001d5-1472575498.143294-1274606258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 10:05:45.555097) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 10:05:45.555431) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 10:05:45.555739) ========= ========= Total master_lag: 0.17 =========