builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1471054648.17 results: success (0) buildid: 20160812164016 builduid: 2bd2613e071e472e969ba0e9380da997 revision: 1ba6215e84c3b34b928898331c3d444b3dd96ee3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 19:17:28.175118) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 19:17:28.175967) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 19:17:28.176483) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 19:17:28.223752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 19:17:28.224111) ========= 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=62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-12 19:17:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-08-12 19:17:28 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.194967 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 19:17:28.447779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 19:17:28.448145) ========= 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=62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016429 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 19:17:28.498587) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 19:17:28.498985) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1ba6215e84c3b34b928898331c3d444b3dd96ee3 --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 1ba6215e84c3b34b928898331c3d444b3dd96ee3 --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=62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-12 19:17:28,734 truncating revision to first 12 chars 2016-08-12 19:17:28,734 Setting DEBUG logging. 2016-08-12 19:17:28,734 attempt 1/10 2016-08-12 19:17:28,734 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1ba6215e84c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 19:17:29,003 unpacking tar archive at: fx-team-1ba6215e84c3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684678 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 19:17:29.198224) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 19:17:29.198624) ========= script_repo_revision: 1ba6215e84c3b34b928898331c3d444b3dd96ee3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 19:17:29.199080) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 19:17:29.199403) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 19:17:29.209622) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-08-12 19:17:29.209939) ========= /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=62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:17:29 INFO - MultiFileLogger online at 20160812 19:17:29 in /builds/slave/test 19:17:29 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 19:17:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:17:29 INFO - {'append_to_log': False, 19:17:29 INFO - 'base_work_dir': '/builds/slave/test', 19:17:29 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:17:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:17:29 INFO - 'branch': 'Fx-Team-Non-PGO', 19:17:29 INFO - 'buildbot_json_path': 'buildprops.json', 19:17:29 INFO - 'config_files': ('talos/linux_config.py',), 19:17:29 INFO - 'default_actions': ('clobber', 19:17:29 INFO - 'read-buildbot-config', 19:17:29 INFO - 'download-and-extract', 19:17:29 INFO - 'populate-webroot', 19:17:29 INFO - 'create-virtualenv', 19:17:29 INFO - 'install', 19:17:29 INFO - 'run-tests'), 19:17:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:17:29 INFO - 'download_minidump_stackwalk': True, 19:17:29 INFO - 'download_symbols': 'ondemand', 19:17:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:17:29 INFO - 'tooltool.py': '/tools/tooltool.py', 19:17:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:17:29 INFO - '/tools/misc-python/virtualenv.py')}, 19:17:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:17:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:17:29 INFO - 'installer_path': 'installer.exe', 19:17:29 INFO - 'log_level': 'info', 19:17:29 INFO - 'log_name': 'talos', 19:17:29 INFO - 'log_to_console': True, 19:17:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:17:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:17:29 INFO - 'opt_config_files': (), 19:17:29 INFO - 'pip_index': False, 19:17:29 INFO - 'sps_profile': False, 19:17:29 INFO - 'sps_profile_interval': 0, 19:17:29 INFO - 'suite': 'dromaeojs-e10s', 19:17:29 INFO - 'system_bits': '32', 19:17:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:17:29 INFO - 'title': 'talos-linux64-ix-018', 19:17:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:17:29 INFO - 'use_talos_json': True, 19:17:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:17:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:17:29 INFO - 'work_dir': 'build'} 19:17:29 INFO - [mozharness: 2016-08-13 02:17:29.626164Z] Running clobber step. 19:17:29 INFO - Running pre-action listener: _resource_record_pre_action 19:17:29 INFO - Running main action method: clobber 19:17:29 INFO - rmtree: /builds/slave/test/build 19:17:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:17:30 INFO - Running post-action listener: _resource_record_post_action 19:17:30 INFO - [mozharness: 2016-08-13 02:17:30.337982Z] Finished clobber step (success) 19:17:30 INFO - [mozharness: 2016-08-13 02:17:30.338082Z] Running read-buildbot-config step. 19:17:30 INFO - Running pre-action listener: _resource_record_pre_action 19:17:30 INFO - Running main action method: read_buildbot_config 19:17:30 INFO - Using buildbot properties: 19:17:30 INFO - { 19:17:30 INFO - "project": "", 19:17:30 INFO - "product": "firefox", 19:17:30 INFO - "script_repo_revision": "production", 19:17:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:17:30 INFO - "repository": "", 19:17:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 19:17:30 INFO - "buildid": "20160812164016", 19:17:30 INFO - "pgo_build": "False", 19:17:30 INFO - "basedir": "/builds/slave/test", 19:17:30 INFO - "buildnumber": 1751, 19:17:30 INFO - "slavename": "talos-linux64-ix-018", 19:17:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:17:30 INFO - "platform": "ubuntu64_hw", 19:17:30 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 19:17:30 INFO - "branch": "fx-team", 19:17:30 INFO - "repo_path": "integration/fx-team", 19:17:30 INFO - "revision": "1ba6215e84c3b34b928898331c3d444b3dd96ee3", 19:17:30 INFO - "stage_platform": "linux64", 19:17:30 INFO - "builduid": "2bd2613e071e472e969ba0e9380da997", 19:17:30 INFO - "slavebuilddir": "test" 19:17:30 INFO - } 19:17:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 19:17:30 INFO - Running post-action listener: _resource_record_post_action 19:17:30 INFO - [mozharness: 2016-08-13 02:17:30.340483Z] Finished read-buildbot-config step (success) 19:17:30 INFO - [mozharness: 2016-08-13 02:17:30.340571Z] Running download-and-extract step. 19:17:30 INFO - Running pre-action listener: _resource_record_pre_action 19:17:30 INFO - Running main action method: download_and_extract 19:17:30 INFO - mkdir: /builds/slave/test/build/tests 19:17:30 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')]} 19:17:30 INFO - trying https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:17:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/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 19:17:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/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 19:17:30 INFO - Downloaded 1361 bytes. 19:17:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:17:30 INFO - Using the following test package requirements: 19:17:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:17:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:17:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:17:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:30 INFO - u'jsshell-linux-x86_64.zip'], 19:17:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:17:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:17:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:17:30 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:17:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:17:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:17:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:17:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:17:30 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')]} 19:17:30 INFO - trying https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:17:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/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 19:17:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/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 19:17:31 INFO - Downloaded 20264523 bytes. 19:17:31 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 19:17:35 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 19:17: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')]} 19:17:35 INFO - trying https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:17:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/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 19:17:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/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 19:17:36 INFO - Downloaded 20264523 bytes. 19:17:37 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 19:17:41 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')]} 19:17:41 INFO - trying https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:17:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/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 19:17:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/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 19:17:42 INFO - Downloaded 14413719 bytes. 19:17:42 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 19:17:42 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')]} 19:17:42 INFO - trying https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:17:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/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 19:17:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/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 19:17:43 INFO - Downloaded 55614541 bytes. 19:17:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:17:43 INFO - mkdir: /builds/slave/test/properties 19:17:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:17:43 INFO - Writing to file /builds/slave/test/properties/build_url 19:17:43 INFO - Contents: 19:17:43 INFO - build_url:https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:17:44 INFO - Running post-action listener: _resource_record_post_action 19:17:44 INFO - Running post-action listener: set_extra_try_arguments 19:17:44 INFO - [mozharness: 2016-08-13 02:17:44.637247Z] Finished download-and-extract step (success) 19:17:44 INFO - [mozharness: 2016-08-13 02:17:44.637506Z] Running populate-webroot step. 19:17:44 INFO - Running pre-action listener: _resource_record_pre_action 19:17:44 INFO - Running main action method: populate_webroot 19:17:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:17:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:17:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:17:44 INFO - '--tppagecycles', 19:17:44 INFO - '7'], 19:17:44 INFO - 'tests': ['tsvgm']}}, 19:17:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:17:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:17:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:17:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:17:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:44 INFO - 'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:17:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:17:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:44 INFO - 'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['damp', 'tps']}, 19:17:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:44 INFO - 'tests': ['damp', 'tps']}, 19:17:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['dromaeo_dom']}, 19:17:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:17:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['basic_compositor_video']}, 19:17:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:17:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['a11yr', 19:17:44 INFO - 'ts_paint', 19:17:44 INFO - 'tpaint', 19:17:44 INFO - 'sessionrestore', 19:17:44 INFO - 'sessionrestore_no_auto_restore', 19:17:44 INFO - 'tabpaint']}, 19:17:44 INFO - 'other-e10s': {'tests': ['a11yr', 19:17:44 INFO - 'ts_paint', 19:17:44 INFO - 'tpaint', 19:17:44 INFO - 'sessionrestore', 19:17:44 INFO - 'sessionrestore_no_auto_restore', 19:17:44 INFO - 'tabpaint']}, 19:17:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:17:44 INFO - 'ts_paint', 19:17:44 INFO - 'tpaint', 19:17:44 INFO - 'sessionrestore', 19:17:44 INFO - 'sessionrestore_no_auto_restore', 19:17:44 INFO - 'tabpaint']}, 19:17:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:17:44 INFO - 'ts_paint', 19:17:44 INFO - 'tpaint', 19:17:44 INFO - 'sessionrestore', 19:17:44 INFO - 'sessionrestore_no_auto_restore', 19:17:44 INFO - 'tabpaint']}, 19:17:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['a11yr', 19:17:44 INFO - 'ts_paint', 19:17:44 INFO - 'tpaint', 19:17:44 INFO - 'sessionrestore', 19:17:44 INFO - 'sessionrestore_no_auto_restore', 19:17:44 INFO - 'tabpaint']}, 19:17:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['a11yr', 19:17:44 INFO - 'ts_paint', 19:17:44 INFO - 'tpaint', 19:17:44 INFO - 'sessionrestore', 19:17:44 INFO - 'sessionrestore_no_auto_restore', 19:17:44 INFO - 'tabpaint']}, 19:17:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['tsvgx', 19:17:44 INFO - 'tsvgr_opacity', 19:17:44 INFO - 'tart', 19:17:44 INFO - 'tscrollx', 19:17:44 INFO - 'cart']}, 19:17:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:17:44 INFO - 'tsvgr_opacity', 19:17:44 INFO - 'tart', 19:17:44 INFO - 'tscrollx', 19:17:44 INFO - 'cart']}, 19:17:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:44 INFO - 'talos_options': ['--disable-e10s'], 19:17:44 INFO - 'tests': ['tp5o']}, 19:17:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:44 INFO - 'tests': ['tp5o']}, 19:17:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:44 INFO - 'talos_options': ['--disable-e10s', 19:17:44 INFO - '--xperf_path', 19:17:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:17:44 INFO - 'tests': ['tp5n']}, 19:17:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:17:44 INFO - 'talos_options': ['--xperf_path', 19:17:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:17:44 INFO - 'tests': ['tp5n']}}, 19:17:44 INFO - 'talos.zip': {'path': '', 19:17:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:17:44 INFO - Running post-action listener: _resource_record_post_action 19:17:44 INFO - [mozharness: 2016-08-13 02:17:44.658211Z] Finished populate-webroot step (success) 19:17:44 INFO - [mozharness: 2016-08-13 02:17:44.658300Z] Running create-virtualenv step. 19:17:44 INFO - Running pre-action listener: _resource_record_pre_action 19:17:44 INFO - Running main action method: create_virtualenv 19:17:44 INFO - Creating virtualenv /builds/slave/test/build/venv 19:17:44 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 19:17:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:17:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:17:44 INFO - Using real prefix '/usr' 19:17:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:17:45 INFO - Installing distribute.............................................................................................................................................................................................done. 19:17:47 INFO - Installing pip.................done. 19:17:47 INFO - Return code: 0 19:17:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:17:47 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')]} 19:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:47 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')]} 19:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:47 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 0x7fe42753bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3090>, '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 0x22e69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6e40>, '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': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', '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 19:17:47 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 19:17:47 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 19:17:47 INFO - Using env: {'DISPLAY': ':0', 19:17:47 INFO - 'HOME': '/home/cltbld', 19:17:47 INFO - 'LANG': 'en_US.UTF-8', 19:17:47 INFO - 'LANGUAGE': 'en_US:en', 19:17:47 INFO - 'LOGNAME': 'cltbld', 19:17:47 INFO - 'MAIL': '/var/mail/cltbld', 19:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:47 INFO - 'MOZ_NO_REMOTE': '1', 19:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:47 INFO - 'NO_EM_RESTART': '1', 19:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:47 INFO - 'PWD': '/builds/slave/test', 19:17:47 INFO - 'SHELL': '/bin/bash', 19:17:47 INFO - 'SHLVL': '1', 19:17:47 INFO - 'TERM': 'linux', 19:17:47 INFO - 'TMOUT': '86400', 19:17:47 INFO - 'USER': 'cltbld', 19:17:47 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', 19:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:47 INFO - '_': '/tools/buildbot/bin/python'} 19:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:48 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 19:17:48 INFO - Cleaning up... 19:17:48 INFO - Return code: 0 19:17:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe42753bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3090>, '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 0x22e69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6e40>, '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': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', '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 19:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:17:48 INFO - Using env: {'DISPLAY': ':0', 19:17:48 INFO - 'HOME': '/home/cltbld', 19:17:48 INFO - 'LANG': 'en_US.UTF-8', 19:17:48 INFO - 'LANGUAGE': 'en_US:en', 19:17:48 INFO - 'LOGNAME': 'cltbld', 19:17:48 INFO - 'MAIL': '/var/mail/cltbld', 19:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:48 INFO - 'MOZ_NO_REMOTE': '1', 19:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:48 INFO - 'NO_EM_RESTART': '1', 19:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:48 INFO - 'PWD': '/builds/slave/test', 19:17:48 INFO - 'SHELL': '/bin/bash', 19:17:48 INFO - 'SHLVL': '1', 19:17:48 INFO - 'TERM': 'linux', 19:17:48 INFO - 'TMOUT': '86400', 19:17:48 INFO - 'USER': 'cltbld', 19:17:48 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', 19:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:48 INFO - '_': '/tools/buildbot/bin/python'} 19:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:48 INFO - Downloading/unpacking psutil>=3.1.1 19:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:17:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:17:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:17:50 INFO - Installing collected packages: psutil 19:17:50 INFO - Running setup.py install for psutil 19:17:50 INFO - building 'psutil._psutil_linux' extension 19:17:50 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 19:17:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:17:51 INFO - building 'psutil._psutil_posix' extension 19:17:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:17:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:17:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:17:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:17:51 INFO - Successfully installed psutil 19:17:51 INFO - Cleaning up... 19:17:52 INFO - Return code: 0 19:17:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe42753bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3090>, '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 0x22e69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6e40>, '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': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', '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 19:17:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:17:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:17:52 INFO - Using env: {'DISPLAY': ':0', 19:17:52 INFO - 'HOME': '/home/cltbld', 19:17:52 INFO - 'LANG': 'en_US.UTF-8', 19:17:52 INFO - 'LANGUAGE': 'en_US:en', 19:17:52 INFO - 'LOGNAME': 'cltbld', 19:17:52 INFO - 'MAIL': '/var/mail/cltbld', 19:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:52 INFO - 'MOZ_NO_REMOTE': '1', 19:17:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:52 INFO - 'NO_EM_RESTART': '1', 19:17:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:52 INFO - 'PWD': '/builds/slave/test', 19:17:52 INFO - 'SHELL': '/bin/bash', 19:17:52 INFO - 'SHLVL': '1', 19:17:52 INFO - 'TERM': 'linux', 19:17:52 INFO - 'TMOUT': '86400', 19:17:52 INFO - 'USER': 'cltbld', 19:17:52 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', 19:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:52 INFO - '_': '/tools/buildbot/bin/python'} 19:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:17:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:17:54 INFO - Installing collected packages: mozsystemmonitor 19:17:54 INFO - Running setup.py install for mozsystemmonitor 19:17:54 INFO - Successfully installed mozsystemmonitor 19:17:54 INFO - Cleaning up... 19:17:54 INFO - Return code: 0 19:17:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe42753bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3090>, '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 0x22e69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6e40>, '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': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', '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 19:17:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:17:54 INFO - Using env: {'DISPLAY': ':0', 19:17:54 INFO - 'HOME': '/home/cltbld', 19:17:54 INFO - 'LANG': 'en_US.UTF-8', 19:17:54 INFO - 'LANGUAGE': 'en_US:en', 19:17:54 INFO - 'LOGNAME': 'cltbld', 19:17:54 INFO - 'MAIL': '/var/mail/cltbld', 19:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:54 INFO - 'MOZ_NO_REMOTE': '1', 19:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:54 INFO - 'NO_EM_RESTART': '1', 19:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:54 INFO - 'PWD': '/builds/slave/test', 19:17:54 INFO - 'SHELL': '/bin/bash', 19:17:54 INFO - 'SHLVL': '1', 19:17:54 INFO - 'TERM': 'linux', 19:17:54 INFO - 'TMOUT': '86400', 19:17:54 INFO - 'USER': 'cltbld', 19:17:54 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', 19:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:54 INFO - '_': '/tools/buildbot/bin/python'} 19:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:54 INFO - Downloading/unpacking jsonschema==2.5.1 19:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:17:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:56 INFO - Downloading functools32-3.2.3-2.tar.gz 19:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:17:56 INFO - warning: no files found matching '*.txt' 19:17:56 INFO - no previously-included directories found matching 'build' 19:17:56 INFO - no previously-included directories found matching 'dist' 19:17:56 INFO - no previously-included directories found matching '.git*' 19:17:56 INFO - Installing collected packages: jsonschema, functools32 19:17:56 INFO - Running setup.py install for functools32 19:17:56 INFO - warning: no files found matching '*.txt' 19:17:56 INFO - no previously-included directories found matching 'build' 19:17:56 INFO - no previously-included directories found matching 'dist' 19:17:56 INFO - no previously-included directories found matching '.git*' 19:17:56 INFO - Successfully installed jsonschema functools32 19:17:56 INFO - Cleaning up... 19:17:56 INFO - Return code: 0 19:17:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe42753bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3090>, '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 0x22e69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6e40>, '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': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', '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 19:17:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:17:56 INFO - Using env: {'DISPLAY': ':0', 19:17:56 INFO - 'HOME': '/home/cltbld', 19:17:56 INFO - 'LANG': 'en_US.UTF-8', 19:17:56 INFO - 'LANGUAGE': 'en_US:en', 19:17:56 INFO - 'LOGNAME': 'cltbld', 19:17:56 INFO - 'MAIL': '/var/mail/cltbld', 19:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:56 INFO - 'MOZ_NO_REMOTE': '1', 19:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:56 INFO - 'NO_EM_RESTART': '1', 19:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:56 INFO - 'PWD': '/builds/slave/test', 19:17:56 INFO - 'SHELL': '/bin/bash', 19:17:56 INFO - 'SHLVL': '1', 19:17:56 INFO - 'TERM': 'linux', 19:17:56 INFO - 'TMOUT': '86400', 19:17:56 INFO - 'USER': 'cltbld', 19:17:56 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', 19:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:56 INFO - '_': '/tools/buildbot/bin/python'} 19:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:17:57 INFO - Cleaning up... 19:17:57 INFO - Return code: 0 19:17:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe42753bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3090>, '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 0x22e69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6e40>, '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': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', '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 19:17:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:17:57 INFO - Using env: {'DISPLAY': ':0', 19:17:57 INFO - 'HOME': '/home/cltbld', 19:17:57 INFO - 'LANG': 'en_US.UTF-8', 19:17:57 INFO - 'LANGUAGE': 'en_US:en', 19:17:57 INFO - 'LOGNAME': 'cltbld', 19:17:57 INFO - 'MAIL': '/var/mail/cltbld', 19:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:57 INFO - 'MOZ_NO_REMOTE': '1', 19:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:17:57 INFO - 'NO_EM_RESTART': '1', 19:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:57 INFO - 'PWD': '/builds/slave/test', 19:17:57 INFO - 'SHELL': '/bin/bash', 19:17:57 INFO - 'SHLVL': '1', 19:17:57 INFO - 'TERM': 'linux', 19:17:57 INFO - 'TMOUT': '86400', 19:17:57 INFO - 'USER': 'cltbld', 19:17:57 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', 19:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:57 INFO - '_': '/tools/buildbot/bin/python'} 19:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:57 INFO - Downloading/unpacking blobuploader==1.2.4 19:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:59 INFO - Downloading blobuploader-1.2.4.tar.gz 19:17:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:17:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:17:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:17:59 INFO - Downloading docopt-0.6.1.tar.gz 19:17:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:17:59 INFO - Installing collected packages: blobuploader, requests, docopt 19:17:59 INFO - Running setup.py install for blobuploader 19:18:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:18:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:18:00 INFO - Running setup.py install for requests 19:18:00 INFO - Running setup.py install for docopt 19:18:00 INFO - Successfully installed blobuploader requests docopt 19:18:00 INFO - Cleaning up... 19:18:00 INFO - Return code: 0 19:18:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18: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')]} 19:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18: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')]} 19:18:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe42753bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3090>, '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 0x22e69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6e40>, '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': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', '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 19:18:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:18:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:18:00 INFO - Using env: {'DISPLAY': ':0', 19:18:00 INFO - 'HOME': '/home/cltbld', 19:18:00 INFO - 'LANG': 'en_US.UTF-8', 19:18:00 INFO - 'LANGUAGE': 'en_US:en', 19:18:00 INFO - 'LOGNAME': 'cltbld', 19:18:00 INFO - 'MAIL': '/var/mail/cltbld', 19:18:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:00 INFO - 'MOZ_NO_REMOTE': '1', 19:18:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:00 INFO - 'NO_EM_RESTART': '1', 19:18:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:00 INFO - 'PWD': '/builds/slave/test', 19:18:00 INFO - 'SHELL': '/bin/bash', 19:18:00 INFO - 'SHLVL': '1', 19:18:00 INFO - 'TERM': 'linux', 19:18:00 INFO - 'TMOUT': '86400', 19:18:00 INFO - 'USER': 'cltbld', 19:18:00 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', 19:18:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:00 INFO - '_': '/tools/buildbot/bin/python'} 19:18:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:18:00 INFO - Running setup.py (path:/tmp/pip-S1COi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:18:00 INFO - Running setup.py (path:/tmp/pip-HO7KDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:18:00 INFO - Running setup.py (path:/tmp/pip-eFNbPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:18:00 INFO - Running setup.py (path:/tmp/pip-1LkKXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:18:01 INFO - Running setup.py (path:/tmp/pip-w7hsv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:18:01 INFO - Running setup.py (path:/tmp/pip-GwJl8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:18:01 INFO - Running setup.py (path:/tmp/pip-vGHHKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:18:01 INFO - Running setup.py (path:/tmp/pip-wVEEnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:18:01 INFO - Running setup.py (path:/tmp/pip-74hLkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:18:01 INFO - Running setup.py (path:/tmp/pip-MYfKWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:18:01 INFO - Running setup.py (path:/tmp/pip-kFN00m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:18:01 INFO - Running setup.py (path:/tmp/pip-rMjCJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:18:01 INFO - Running setup.py (path:/tmp/pip-38uO6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:18:01 INFO - Running setup.py (path:/tmp/pip-FoMsN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:01 INFO - Running setup.py (path:/tmp/pip-sbI36t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:18:01 INFO - Running setup.py (path:/tmp/pip-jSfj10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:18:01 INFO - Running setup.py (path:/tmp/pip-VJqko8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:18:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:18:01 INFO - Running setup.py install for manifestparser 19:18:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:18:02 INFO - Running setup.py install for mozcrash 19:18:02 INFO - Running setup.py install for mozdebug 19:18:02 INFO - Running setup.py install for mozdevice 19:18:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:18:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:18:02 INFO - Running setup.py install for mozfile 19:18:02 INFO - Running setup.py install for mozhttpd 19:18:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:18:02 INFO - Running setup.py install for mozinfo 19:18:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:18:02 INFO - Running setup.py install for mozInstall 19:18:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:18:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:18:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:18:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:18:02 INFO - Running setup.py install for mozleak 19:18:02 INFO - Running setup.py install for mozlog 19:18:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:18:03 INFO - Running setup.py install for moznetwork 19:18:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:18:03 INFO - Running setup.py install for mozprocess 19:18:03 INFO - Running setup.py install for mozprofile 19:18:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:18:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:18:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:18:03 INFO - Running setup.py install for mozrunner 19:18:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:18:03 INFO - Running setup.py install for mozscreenshot 19:18:03 INFO - Running setup.py install for moztest 19:18:03 INFO - Running setup.py install for mozversion 19:18:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:18:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:18:03 INFO - Cleaning up... 19:18:03 INFO - Return code: 0 19:18:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe42753bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3090>, '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 0x22e69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6e40>, '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': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', '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 19:18:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:18:03 INFO - Using env: {'DISPLAY': ':0', 19:18:03 INFO - 'HOME': '/home/cltbld', 19:18:03 INFO - 'LANG': 'en_US.UTF-8', 19:18:03 INFO - 'LANGUAGE': 'en_US:en', 19:18:03 INFO - 'LOGNAME': 'cltbld', 19:18:03 INFO - 'MAIL': '/var/mail/cltbld', 19:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:03 INFO - 'MOZ_NO_REMOTE': '1', 19:18:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:03 INFO - 'NO_EM_RESTART': '1', 19:18:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:03 INFO - 'PWD': '/builds/slave/test', 19:18:03 INFO - 'SHELL': '/bin/bash', 19:18:03 INFO - 'SHLVL': '1', 19:18:03 INFO - 'TERM': 'linux', 19:18:03 INFO - 'TMOUT': '86400', 19:18:03 INFO - 'USER': 'cltbld', 19:18:03 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', 19:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:03 INFO - '_': '/tools/buildbot/bin/python'} 19:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:18:04 INFO - Running setup.py (path:/tmp/pip-HBsnGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:18:04 INFO - Running setup.py (path:/tmp/pip-vfwmpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:18:04 INFO - Running setup.py (path:/tmp/pip-zFTVUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:18:04 INFO - Running setup.py (path:/tmp/pip-_K0QC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:18:04 INFO - Running setup.py (path:/tmp/pip-hivYO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:18:04 INFO - Running setup.py (path:/tmp/pip-_wUiw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:18:04 INFO - Running setup.py (path:/tmp/pip-MA9Mmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:18:04 INFO - Running setup.py (path:/tmp/pip-OBZV2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:18:04 INFO - Running setup.py (path:/tmp/pip-Zqpdjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:18:04 INFO - Running setup.py (path:/tmp/pip-7PVi7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:18:04 INFO - Running setup.py (path:/tmp/pip-tFImE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:18:04 INFO - Running setup.py (path:/tmp/pip-hlNMC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:18:04 INFO - Running setup.py (path:/tmp/pip-b_A5MW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:18:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:18:04 INFO - Running setup.py (path:/tmp/pip-B6XynA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:05 INFO - Running setup.py (path:/tmp/pip-dGPA5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:18:05 INFO - Running setup.py (path:/tmp/pip-jUrMgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:18:05 INFO - Running setup.py (path:/tmp/pip-g8V3H6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:18:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:18:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:18:07 INFO - Downloading blessings-1.6.tar.gz 19:18:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:18:07 INFO - Installing collected packages: blessings 19:18:07 INFO - Running setup.py install for blessings 19:18:07 INFO - Successfully installed blessings 19:18:07 INFO - Cleaning up... 19:18:07 INFO - Return code: 0 19:18:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:18:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:18:07 INFO - Reading from file tmpfile_stdout 19:18:07 INFO - Current package versions: 19:18:07 INFO - argparse == 1.2.1 19:18:07 INFO - blessings == 1.6 19:18:07 INFO - blobuploader == 1.2.4 19:18:07 INFO - docopt == 0.6.1 19:18:07 INFO - functools32 == 3.2.3-2 19:18:07 INFO - jsonschema == 2.5.1 19:18:07 INFO - manifestparser == 1.1 19:18:07 INFO - mozInstall == 1.12 19:18:07 INFO - mozcrash == 0.17 19:18:07 INFO - mozdebug == 0.1 19:18:07 INFO - mozdevice == 0.48 19:18:07 INFO - mozfile == 1.2 19:18:07 INFO - mozhttpd == 0.7 19:18:07 INFO - mozinfo == 0.9 19:18:07 INFO - mozleak == 0.1 19:18:07 INFO - mozlog == 3.3 19:18:07 INFO - moznetwork == 0.27 19:18:07 INFO - mozprocess == 0.23 19:18:07 INFO - mozprofile == 0.28 19:18:07 INFO - mozrunner == 6.12 19:18:07 INFO - mozscreenshot == 0.1 19:18:07 INFO - mozsystemmonitor == 0.3 19:18:07 INFO - moztest == 0.7 19:18:07 INFO - mozversion == 1.4 19:18:07 INFO - psutil == 3.1.1 19:18:07 INFO - requests == 1.2.3 19:18:07 INFO - wsgiref == 0.1.2 19:18:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe42753bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3090>, '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 0x22e69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6e40>, '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': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', '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 19:18:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:18:07 INFO - Using env: {'DISPLAY': ':0', 19:18:07 INFO - 'HOME': '/home/cltbld', 19:18:07 INFO - 'LANG': 'en_US.UTF-8', 19:18:07 INFO - 'LANGUAGE': 'en_US:en', 19:18:07 INFO - 'LOGNAME': 'cltbld', 19:18:07 INFO - 'MAIL': '/var/mail/cltbld', 19:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:07 INFO - 'MOZ_NO_REMOTE': '1', 19:18:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:07 INFO - 'NO_EM_RESTART': '1', 19:18:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:07 INFO - 'PWD': '/builds/slave/test', 19:18:07 INFO - 'SHELL': '/bin/bash', 19:18:07 INFO - 'SHLVL': '1', 19:18:07 INFO - 'TERM': 'linux', 19:18:07 INFO - 'TMOUT': '86400', 19:18:07 INFO - 'USER': 'cltbld', 19:18:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', 19:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:07 INFO - '_': '/tools/buildbot/bin/python'} 19:18:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:18:07 INFO - Cleaning up... 19:18:07 INFO - Return code: 0 19:18:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:18:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:18:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:18:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe42753bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e9230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3090>, '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 0x22e69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6e40>, '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': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', '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 19:18:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:18:07 INFO - Using env: {'DISPLAY': ':0', 19:18:07 INFO - 'HOME': '/home/cltbld', 19:18:07 INFO - 'LANG': 'en_US.UTF-8', 19:18:07 INFO - 'LANGUAGE': 'en_US:en', 19:18:07 INFO - 'LOGNAME': 'cltbld', 19:18:07 INFO - 'MAIL': '/var/mail/cltbld', 19:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:07 INFO - 'MOZ_NO_REMOTE': '1', 19:18:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:07 INFO - 'NO_EM_RESTART': '1', 19:18:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:07 INFO - 'PWD': '/builds/slave/test', 19:18:07 INFO - 'SHELL': '/bin/bash', 19:18:07 INFO - 'SHLVL': '1', 19:18:07 INFO - 'TERM': 'linux', 19:18:07 INFO - 'TMOUT': '86400', 19:18:07 INFO - 'USER': 'cltbld', 19:18:07 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', 19:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:07 INFO - '_': '/tools/buildbot/bin/python'} 19:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:18:08 INFO - Cleaning up... 19:18:08 INFO - Return code: 0 19:18:08 INFO - Running post-action listener: _resource_record_post_action 19:18:08 INFO - Running post-action listener: _start_resource_monitoring 19:18:08 INFO - Starting resource monitoring. 19:18:08 INFO - [mozharness: 2016-08-13 02:18:08.066726Z] Finished create-virtualenv step (success) 19:18:08 INFO - [mozharness: 2016-08-13 02:18:08.067729Z] Running install step. 19:18:08 INFO - Running pre-action listener: _resource_record_pre_action 19:18:08 INFO - Running main action method: install 19:18:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:18:08 INFO - Reading from file tmpfile_stdout 19:18:08 INFO - Detecting whether we're running mozinstall >=1.0... 19:18:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:18:08 INFO - Reading from file tmpfile_stdout 19:18:08 INFO - Output received: 19:18:08 INFO - Usage: mozinstall [options] installer 19:18:08 INFO - Options: 19:18:08 INFO - -h, --help show this help message and exit 19:18:08 INFO - -d DEST, --destination=DEST 19:18:08 INFO - Directory to install application into. [default: 19:18:08 INFO - "/builds/slave/test"] 19:18:08 INFO - --app=APP Application being installed. [default: firefox] 19:18:08 INFO - mkdir: /builds/slave/test/build/application 19:18:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:18:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:18:24 INFO - Reading from file tmpfile_stdout 19:18:24 INFO - Output received: 19:18:24 INFO - /builds/slave/test/build/application/firefox/firefox 19:18:24 INFO - Running post-action listener: _resource_record_post_action 19:18:24 INFO - [mozharness: 2016-08-13 02:18:24.377272Z] Finished install step (success) 19:18:24 INFO - [mozharness: 2016-08-13 02:18:24.377566Z] Running run-tests step. 19:18:24 INFO - Running pre-action listener: _resource_record_pre_action 19:18:24 INFO - Running main action method: run_tests 19:18:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:18:24 INFO - Python 2.7.3 19:18:24 INFO - Return code: 0 19:18:24 INFO - grabbing minidump binary from tooltool 19:18: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')]} 19:18:24 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e3090>, '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 0x22e69b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e6e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:18:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:18:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:18:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:18:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:18:24 INFO - Return code: 0 19:18:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:18:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:18:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:18:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:18:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:18:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 19:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 19:18:24 INFO - Using env: {'DISPLAY': ':0', 19:18:24 INFO - 'HOME': '/home/cltbld', 19:18:24 INFO - 'LANG': 'en_US.UTF-8', 19:18:24 INFO - 'LANGUAGE': 'en_US:en', 19:18:24 INFO - 'LOGNAME': 'cltbld', 19:18:24 INFO - 'MAIL': '/var/mail/cltbld', 19:18:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:18:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:18:24 INFO - 'MOZ_NO_REMOTE': '1', 19:18:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:18:24 INFO - 'NO_EM_RESTART': '1', 19:18:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:18:24 INFO - 'PWD': '/builds/slave/test', 19:18:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:18:24 INFO - 'SHELL': '/bin/bash', 19:18:24 INFO - 'SHLVL': '1', 19:18:24 INFO - 'TERM': 'linux', 19:18:24 INFO - 'TMOUT': '86400', 19:18:24 INFO - 'USER': 'cltbld', 19:18:24 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607', 19:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:18:24 INFO - '_': '/tools/buildbot/bin/python'} 19:18:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 19:18:24 INFO - mozversion application_buildid: 20160812164016 19:18:24 INFO - mozversion application_changeset: 1ba6215e84c3b34b928898331c3d444b3dd96ee3 19:18:24 INFO - mozversion application_display_name: Nightly 19:18:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:18:24 INFO - mozversion application_name: Firefox 19:18:24 INFO - mozversion application_remotingname: firefox 19:18:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:18:24 INFO - mozversion application_vendor: Mozilla 19:18:24 INFO - mozversion application_version: 51.0a1 19:18:24 INFO - mozversion platform_buildid: 20160812164016 19:18:24 INFO - mozversion platform_changeset: 1ba6215e84c3b34b928898331c3d444b3dd96ee3 19:18:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:18:24 INFO - mozversion platform_version: 51.0a1 19:18:24 INFO - using testdate: 1471054704 19:18:24 INFO - actual date: 1471054704 19:18:24 INFO - starting webserver on 'localhost:43489' 19:18:24 INFO - SUITE-START | Running 2 tests 19:18:24 INFO - TEST-START | dromaeo_css 19:18:24 INFO - operating with platform_type : linux_ 19:18:24 INFO - Initialising browser for dromaeo_css test... 19:18:24 INFO - TEST-INFO | started process 3371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5Qf7_6/profile http://localhost:43489/getInfo.html) 19:18:30 INFO - PROCESS | 3371 | __metrics Screen width/height:1600/1200 19:18:30 INFO - PROCESS | 3371 | colorDepth:24 19:18:30 INFO - PROCESS | 3371 | Browser inner width/height: 1024/697 19:18:30 INFO - PROCESS | 3371 | __metrics 19:18:31 ERROR - PROCESS | 3371 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 19:18:31 INFO - TEST-INFO | 3371: exit 0 19:18:31 INFO - Browser initialized. 19:18:31 INFO - Running cycle 1/1 for dromaeo_css test... 19:18:31 INFO - TEST-INFO | started process 3489 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5Qf7_6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:18:43 INFO - PROCESS | 3489 | RSS: Main: 163913728 19:18:43 INFO - PROCESS | 3489 | 19:19:33 INFO - PROCESS | 3489 | 1471054773597 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] 19:21:46 INFO - PROCESS | 3489 | Cycle 1(1): loaded http://localhost:43489/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43489/tests/dromaeo/cssquery-ext.html) 19:21:47 INFO - PROCESS | 3489 | RSS: Main: 164745216 19:21:47 INFO - PROCESS | 3489 | 19:24:50 INFO - PROCESS | 3489 | Cycle 1(1): loaded http://localhost:43489/tests/dromaeo/cssquery-ext.html (next: http://localhost:43489/tests/dromaeo/cssquery-jquery.html) 19:24:50 INFO - PROCESS | 3489 | RSS: Main: 166027264 19:24:50 INFO - PROCESS | 3489 | 19:27:52 INFO - PROCESS | 3489 | Cycle 1(1): loaded http://localhost:43489/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43489/tests/dromaeo/cssquery-mootools.html) 19:27:53 INFO - PROCESS | 3489 | RSS: Main: 167006208 19:27:53 INFO - PROCESS | 3489 | 19:30:55 INFO - PROCESS | 3489 | Cycle 1(1): loaded http://localhost:43489/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43489/tests/dromaeo/cssquery-prototype.html) 19:30:56 INFO - PROCESS | 3489 | RSS: Main: 164536320 19:30:56 INFO - PROCESS | 3489 | 19:33:58 INFO - PROCESS | 3489 | Cycle 1(1): loaded http://localhost:43489/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43489/tests/dromaeo/cssquery-yui.html) 19:33:59 INFO - PROCESS | 3489 | RSS: Main: 166776832 19:33:59 INFO - PROCESS | 3489 | 19:37:02 INFO - PROCESS | 3489 | Cycle 1(1): loaded http://localhost:43489/tests/dromaeo/cssquery-yui.html (next: http://localhost:43489/tests/dromaeo/cssquery-dojo.html) 19:37:02 INFO - PROCESS | 3489 | RSS: Main: 166473728 19:37:02 INFO - PROCESS | 3489 | 19:37:02 INFO - PROCESS | 3489 | __start_tp_report 19:37:02 INFO - PROCESS | 3489 | _x_x_mozilla_page_load 19:37:02 INFO - PROCESS | 3489 | _x_x_mozilla_page_load_details 19:37:02 INFO - PROCESS | 3489 | |i|pagename|runs| 19:37:02 INFO - PROCESS | 3489 | |0;dojo.html;2675.451532435851;2701.297662607722;2719.0755143251304;2730.604062410952;2738.4796888591154;4771.427428708551;4866.075445665326;4897.7551122443865;4942.357493525841;4951.207806750921;4757.167495688258;4795;4827.034593081389;4831.565159135677;4870.902581948368;4359.847405340814;4437.778111094449;4476.239039363316;4508.864734057984;4525.072360166175;4432.29083346663;4438.334249862514;4469.240229161051;4487.798049087799;4531.116432295704;4355.5644435556505;4385.802638881258;4429.291313389842;4437.534058923831;4447.288433850601;4412.05140894706;4415.492218394894;4423.314386270134;4435.600795928382;4478.39541661878;4462.531434199394;4465.732056076646;4469.44131983502;4510.120526497334;4514.300283456037;4686.789094490756;4742.0515896820425;4760.833370832004;4786.832460863888;4824.107540105092;5105.132127538327;5107.055194788976;5117.48825117489;5145.382554093533;5156.3296771419855;5135.794568217267;5181.145111056709;5195.064888320101;5198.324217851693;5200.401953775288;4816.855494335211;4855.150348688965;4859.684120532154;4882;4882.170031094723;5309.964556911365;5336;5337.786488540492;5340.546053585489;5387.730613469311;4931.852044438672;5039.672421292677;5094.2103973884105;5094.312267843868;5106.285120083191;5081.669691470042;5134.075866344094;5146.176611742103;5220.582353411718;5227.294315267466;5190.091733946544;5190.844274671766;5192.247124166975;5192.636515443958;5234.921476177784;5185.351831021122;5210.114280572312;5210.400803907599;5210.7915683373;5256.710880901587;4274.551172126882;4390.034192477649;4454.398656181439;4461.598456138963;4520.028193938319;3870.2066076454257;3886.855307647039;3889.5721470638773;3906.74606150605;3909;4371.475422949266;4493.1013797240685;4497.527759585262;4509.278515437514;4543.204939135638;5047.596192304681;5180.274761533388;5225.085610018232;5246.029484545371;5327.946720532745;4469.307257375112;4474.39595654589;4488.079943611552;4493.640508759291;4539.863804085882;4702.976485117552;4711.528847115261;4723.929141062887;4740.288956656529;4767.69010014348;4739.478657347689;4810.807567697253;4829.5653391193555;4848.0546293472435;4926.8768280793265;5171.896562068662;5175.560077393313;5207.453217412117;5222.843314700565;5228.843134705965;4851.830185943475;4852.402757409864;4875.658703890836;4883.169861123546;4883.291922671264;5030.4718004608985;5045.31888195089;5045.520675535819;5100.744962751922;5151.150060240018;5128.0000399921655;5156.845294641167;5179.896402072013;5192.065428222956;5194.68831870089;5044.268581055653;5048.621353398436;5057.8229761958155;5062.620303477181;5090.872728181825;4899.853004409873;4983.700977941335;5016.046951079284;5038.395392552917;5102.872428189325;4929.778159982738;4942.28336891156;4953.108440480748;4974.552290293891;5034.370703662043;5076.390833100052;5089.211172268304;5106.540411362995;5109.642325037212;5130.640855140105;4850.83022094225;4869.6347773917805;4885.218365061715;4911.140550403594;4941.061198372297 19:37:02 INFO - PROCESS | 3489 | |1;ext.html;542.6906663201975;560.5543592843686;561.5872333834631;577.0449905406552;580.46887098305;34269.82865085674;38589.80705096477;38620.806895965514;38663;38683.22633547327;37135.81432092836;37459.812700936454;37659.62340376595;37744.999999999935;37814.8109259454;7468;7650.808729781745;7651.23487651236;7659.425543084263;7660.387169026492;7515.985341978818;7550.7734767957045;7620.7713768586755;7622.047244094489;7623.58070306133;7603.087629484442;7636.847263054736;7648.694052237904;7682.462227644067;7702.537847729126;7604.163542010375;7640.961795191044;7654.464187506876;7657.808554786119;7663.310302072812;7404.777856664308;7442.962785186093;7475.887861682079;7480.438967077491;7489.251074892467;36588.63411365879;36971.630283697086;37044.629553704384;37047.25905481875;37169.44245836315;2330.685357476736;2937.3684657798676;2939.4415061138316;2986.970130298691;3015.7738169637146;27355.45289094227;27835.582466263022;28018.439631207464;28090;28425.422230214608;3324.3018966017166;3325.88359407422;3383.610884748261;3416.9658303416895;3422.8117453540044;233755;234347;234794;235848;235952.99999999828;31057.534136987964;31230.219244518616;31271.687283126877;31278;31291.217719557193;32093.197670058435;32098;32929.835350823094;33191.502127468106;35002;13942.163470191821;14076.788848167285;14092.295385230698;14104.224267665377;14149;10604.416757078434;10615.203859710553;10631.893681063246;10689.946550267354;10706.089982351432;17655;17656.91171544134;17829.821701783076;17837.554061148574;17868.46394608164;6834.179898412222;6862.759803406957;6884.173899132136;6938.757143499954;7025.789226323219;781.4334607409583;887.1350433327455;909.2453263791037;958.0946006024379;987.9950600246952;27492.45015099687;28110.85944570264;28620.856895715806;28863;29332.266693332836;969.3166317746113;969.7817990951979;1047.4161422979644;1051.9053285204368;1058.2486434631344;14824.851751482347;14911.179885106423;14972.775408368883;15095.54713358601;15172.544823655307;405940;410566;413991;414188;414574;47494.5250547497;47586.76206618945;47833.76083119562;47951.5204847954;48023.27965080526;1132.5356603792407;1181.5155786127818;1188.95838645647;1194.7192409783695;1209.5524655877382;25531;26692.733072669023;27421.17736467909;28182.29544261328;28230.576541351486;41972.79013604912;45681;46266;46379.30431043605;46507;368794;375710;375769.48461031175;375935;376009;24158.154464594358;25225.49549008973;38258;38575.42136867893;39008.21983560256;40493.19013619652;40671.38992915168;40807.59192408038;42000.57999419967;42441.36337954995;35283;36511;36586.8170659145;36770;37186.25627487489;34918.65081349255;35091.298174036885;35409.40657670463;35842.64157358393;35921.28157436889;33554.496682549296;34148.31703365869;34908.30183396267;35263.82368088246;35557.466638000966;30424.391512170074;33333.333333333685;33451.66548334583;33592.49611255882;33654.66345336515;22661.88669056644;24940.75059249457;25341.113061042775;25647.23058308254;25721.614175787752 19:37:02 INFO - PROCESS | 3489 | |2;jquery.html;361.43255089509483;361.4397683590435;362.66634696079603;369.6155997762327;383.53209084916426;16237.918810405947;16670.41653542125;17224.913875430622;17270.82729172708;17296.913515432436;16475.91762041191;16686.165691715425;16818;16954.152292385363;17096.230669619865;5011.974940125294;5266.078436273656;5267.3942496613;5269.604779641523;5271.947280527184;5173.249878767595;5254.4220135785035;5263.763130659129;5269.973650131744;5301.0988132017455;5557.944420555783;5663.7168141592965;5673.51775099115;5680.744366503517;5699;5275.155975044013;5578.63738856977;5651.660900345972;5672.574556908227;5682.403347648478;5477.643953143033;5489.39616642169;5491.588130890199;5495.972520137414;5496.560275178016;11562.248453850472;11617.244879082833;11899.345535995517;12334.32161231132;12470.501179952791;2073.720047793559;2091.1530830013867;2119.448943274744;2220.7890250426185;2352.282553821084;8794.472331660121;8876.778080547974;9293.117153870371;9669.951650241705;9805.852912206252;1701.1658339281446;1708.5813975576064;1721.500764778213;1726.47342560519;1731.6796392667397;66538.3346166537;70033;70465.2953470469;70702.29297707009;71594.64202679005;9860.901390986142;9891.944302835947;9925.553350099119;10097.192224622013;10098.949505252574;13525.053246272666;13537.323133843269;13545.187288762705;13559.322033898266;13570.982176336616;6712.328767123347;6841.350071743276;6990.266022067712;7036.9296307036275;7176.067111275501;6587.341265873471;6593.637349945799;6752.189737231563;6762.256151823295;6814.420774234147;4125.793710314472;4191.811368488426;4205.642520385741;4272.359146128044;4343.500497442771;1806.1872157529165;1860.6650802855345;1868.374094678271;1874.6906760384384;1882.8117188281062;793.5516433215215;832.3008672714949;861.224897592172;931.7856892914667;941.658137154552;16356.263968121462;16397.83602163987;16847.157642117843;17200.483985480456;17874;823.7158180427742;836.1262480707675;859.1923591823665;897.2821742605889;950.3300173377752;9489.098535639103;9640.662576809918;9968.80062398748;10028.348157369748;10138.949305253574;377581;388990;389457;390492;391859;77361.61319193481;77650;80243;80279;80560.59719701365;873.2097451806253;898.7618281155499;908.6547112097493;908.7909780750465;915.3683958068912;14965.476208333092;15115.924420377827;15425;15650.37398504047;15867.20663966774;36330.4550431749;36815.63184368229;37431.251374971805;37913;38745;50384;51468;52284.21573676474;52723;52911.73544132255;7554.697812087675;7590.924090759022;7608.96195519041;7855.8036049096945;7968.521888686697;8635.093315202064;9112.95443522778;11387.886121139014;12107.939460302641;12650;10398.58405663765;10411.47942602882;10425.687229383131;10858.891411085788;10912.727181820517;9874;9935.403875767477;10137.189024877845;10286.2799604027;10541.262111652417;9894.15899648538;10196.898031019595;10254.436006019741;10811.35131892089;10830.837537436788;7356.852862942818;7883.763487095396;10638.095761860328;10742.73143171427;11507.136964727511;7227.457940654367;7830.256125668053;7929.405294602812;8471.32229421657;10923 19:37:02 INFO - PROCESS | 3489 | |3;mootools.html;1134.9546018159274;1154.4689442856288;1283.1274733181435;1664.6337805682745;1666.3917670050428;6825.3857152856235;7334.376577990871;7573.659185336659;7924.603769811508;7930.960345198273;7713.961430192841;7998.360131189505;8016.67933282668;8021.117677055519;8032.236937490944;2148.9140434382607;2164.9783502165014;2178.2593918067855;2181.727284089489;2186.6282731935607;2076.397844625057;2101.6532272175073;2151.408362700262;2151.6880052392394;2151.8278537716947;2124.16095642222;2128.3295761834975;2195.023214669465;2199.285232299501;2199.846010779238;2064.752229732434;2076.9792302076935;2083.104265165978;2083.6353638113346;2086.2072412483158;2041.101915157326;2150.4623844038993;2152.461884528868;2154.526004279072;2156.223759446598;7972.760817175436;8055.798605034921;8083.595820209025;8102.473339232931;8110.945577075002;4504.324351347292;4656.208444564432;4670.906581868344;4687.765611719435;4688.249880019214;2893.8987135450157;3018.758499320049;3029.8939537116316;3035.134986528829;3096.736777373926;953.3850666320254;998.5706146357063;1004.1866088468364;1004.407399634212;1019.0828254570871;10294.639687610972;10346.379217246915;10358.53386597605;10359.689209323808;10401.53193106312;3915.5105611798526;4060.167665628598;4162.125953549788;4272.252355837716;4278.122984788111;8918.643254269757;8969.730908072768;8984.281257499384;8988.235999939947;9006.86489702655;4525.705829121162;4584.4957054723955;4593.724376537419;4597.7241365518175;4607.76961151941;3623.6557527035416;4107.753534787863;4181.310083836193;4188.748675079505;4217.957820421757;3551.6093229745225;3637.8544858205373;3655.981720091436;3657.305112028706;3756.530433695788;1167.5038108803724;1169.6198735411026;1191.892729654318;1198.5745060503396;1204.933728644933;830.1490971754;844.4757213230179;853.0573716043806;885.7564169853342;887.671561522241;5234.241035049972;5270.077736396115;5281.445448227958;5384.730763461811;5437.945620543823;398.71292669278074;400.679456434851;401.33779264213695;403.884892805549;404.2400287459616;3588.2285308658766;3614.6385361463645;3668.192997540537;3732.5147730794824;3792.6965842732516;9079.273658107335;9499.715008549754;9517.762055948657;9536.094071063239;9539.713808585753;9411.294152938557;9412.90587094134;9446.85829712555;9496.240300775922;9504.904950950402;6889.621070841052;7210.702073626798;7216.96391518039;7374.225706300868;7408;5287.524122828964;5498.615096943176;5588.86027849307;5596.216529685928;5696.715164241854;8934.955325223333;8954.731358059269;8963.910360896307;9042.276617870686;9082.772930676785;8971.461712297283;9106.95446522763;9109.271258299188;9111.225545828678;9238.122378374044;6080.118382834553;6624.867502650017;6714.6978385973725;6839.350261725128;6842.418394436529;7669.578173200527;7738.342240909361;7742.341900938483;7789.493682910593;7828.373730101464;6556.704948277244;6697.263301036979;6803.489738269551;6818.522703410714;6858.108445902001;6895.069165662772;6935.514513983972;6999.825004374931;7058.752943646948;7104.893426598708;5954.553408494294;6285.528585356208;6318.62088274705;6347.270063942521;6358.237011558643;4504.954950450585;4520.276755719201;4539.114872599944;4629.83795567167;4654.720716757005;4617.861464156081;4677.555632214934;4687.273472611751;4779.976100119477;4872.662226374803 19:37:02 INFO - PROCESS | 3489 | |4;prototype.html;296.46784022679276;303.9711227433394;309.4630815535047;309.69959139634545;317.4904278632796;4903.705777653343;5002.799328161243;5046.11692953733;5108.846734597963;5128.333316668833;5023.6734612250175;5047.394312682474;5049.778097637037;5067.493250674931;5071.112555302826;3972.9602703973023;3977.3835055566433;3980.5024371953505;3990.421388898608;3991.700622453313;3888.475055867464;3998.3202855514487;4000.1399699064696;4009.1781184857036;4023.4970628671417;3932.134930315326;3940.7241493095494;3943.073377756225;3945.8816235512836;3953.446517487554;3932.705047121449;3937.2912875682364;3956.3669812829808;3961.5048118984982;3973.662238709713;3269.9509507357407;3393.389189945809;3398;3500.2824420993634;3509.6841284284283;4839.491853355417;4880.389951256093;4881.365422495089;4892.877678058041;4923.9167383175645;4418.182636212311;4444;4446.7554284514335;4451.755153466558;4452.821887124511;5114.0496856035215;5192.506711862405;5249.527542521191;5301.151815709468;5308.628396012281;3673.1634182908547;3673.8530458781615;3685.2728980554466;3700.7224458165474;3701.9259614807825;5508.658820001483;5532.30846144232;5538.833834984957;5543.223948647193;5565.38780734123;3656.5794933582447;3761.661450469416;3766.642168993941;3771.340015497277;3775.2826962876966;3783.5838057813617;3826.598207188261;3832.3868181090893;3843.6348546888003;3846.3076646203394;4386.495553011381;4399.054203346232;4400.295952647561;4406.713563618355;4411.404460397869;5297.9404119176315;5301.151815709468;5309.283246761715;5312.5218730314455;5360.946390536044;1287.3434548380205;1318.2156616812981;1325.509561462265;1334.7197088611501;1335.472488367109;816.1185919207242;841.9621117049747;847.0259201917844;863.1670438027334;867.1588559097665;4093.3246014407887;4114.938275925863;4126.958730412717;4131.8967025824595;4192.790360481964;4828.155072862235;4840.298156767249;4850;4861.368022157097;4885.410732311881;4153.857689135451;4158.750474971512;4171.97914010428;4180.414741936132;4207.621314081747;2472.1043689079033;2535.6830396200476;2598.7525987525714;2603.3751899543972;2618.8035897307777;4530.207213737583;4545.181867263925;4546.590806827336;4546.818127274938;4603.309503574491;4910.379574740327;4912.754362281871;4937.851864444073;4954.628402869799;4972.651914366032;4621.128442980598;4769.642276829251;5134.5378915897745;5151;5220.895582088413;5559.165475393192;5564.4713752193475;5572.387037425799;5574.470425309589;5575.275214222125;5156.905856486078;5419.512243898068;5421.2681288025615;5430.755615997211;5466;5159.303494028408;5166.966606678604;5172.818951336685;5181.5595674368105;5184.896302074013;3613.765105268149;3785.6782173514457;3833.1183827719224;3851.1527463957887;3880.1075752576503;5413.83758487246;5417.268668729828;5446.918296225639;5449.754761035683;5474;5285.154375299933;5298.81454149103;5302.628815982845;5324.201369794562;5337;5078.568321692697;5288.858012504942;5304.9204261936875;5304.98410603968;5346.679199248058;5225.275659032434;5244.160934250502;5261.421243663118;5268.4994925482015;5275.393329767126;5353.437889021752;5392.352917649907;5392.811251606175;5399.406065332889;5404.162354835007;5105.566026887756;5212.374515058217;5220.869478263074;5258.316418865523;5267.631265811357 19:37:02 INFO - PROCESS | 3489 | |5;yui.html;637.4549759955238;678.1353773938229;679.585452873747;714.7998560403086;737.5095561451628;12337.753244935097;12898.290594017326;12963.351832408389;12983.285919274436;13027;12364;12399.56601518947;12413.689657758561;12432.751344973118;12451.501939922393;626.1859582542676;729.7299999000351;743.6765007221849;745.8694728422531;748.9662965166581;745.9850802983937;768.4697558684489;782.495290537603;786.7403756760284;795.6061749434039;790.5454363740844;796.8047828282079;798.078219656295;799.3285640062346;799.5562462833125;790.1861083084432;792.2711105782665;792.7423587334082;793.012699189507;794.0431779705441;590.2091197794975;592.4815786187087;593.554833874594;594.298727501548;595.4135176850798;12938.094333396666;12972.675683107904;12979.286139262336;12997.675058123528;13021.739565208643;12710.42803073864;13122.212667239995;13127.540536081191;13171.802422963663;13554.93222533891;10095.596176152945;10199.133073688745;10234.6417875374;10457.32027418223;10473.63342283024;3247.3018301065385;3280.1799550112473;3306.156929982863;3329.7336213102894;3354.4465163248033;59632;60725;61184.69407652933;61683;62413;9764.316497845224;9999.900001000042;10007;10144.340617859816;10180.694579162637;16179.514614561582;16921;20010.399688009384;20080.69878951817;20242.493937651678;7085.50401471892;7107.680154393065;7197.78406647791;7339.7064117435775;7346.265373462717;3607.4228123500116;3734.7945862977253;3779.2063666629765;3818.2363527294096;3897.279003384383;2961.600183975179;3046.055722725962;3076.6923307669504;3080.060581522612;3086.1975886269283;510.95656869165794;527.074983404131;528.7329898401283;531.7848715684719;541.3152362261742;499.71016810249967;568.8464114689011;601.6841158391792;619.8574327904607;625.6590158363703;7325.633718314063;7503.5988782458135;7659.885101723478;7813.257740514642;8005.439619226599;524.7428759907618;607.7872744539376;614.2107392001257;618.3414663383483;637.3976592120401;3494.006503951657;3651.6896063834342;3710.870119545803;3749.343864823645;3778.1499162688724;93306;99313.50343248238;100923;105249.47375263227;106053;65382.34617653858;71665.64167179131;75875.62062189654;85623;87365.12634873697;67123.66438167778;67645;68811.65594171998;69170;70440.94338584926;8142.267195952392;8723.956380218058;8850.424722393023;8957.910420895969;9020.819583608421;42430;43856;44194;44681;45660.77169614131;56177.157342639075;56391.43608563862;59848.40151598428;60777.69611151916;63701.681491592244;10883.727906802393;11326.943365283121;11385.772284554429;11488.36813975206;11555.133364997491;12734.363281835685;12974.870251297743;13044.478220871059;13332.133411328232;13545.86454135446;11762.882371176178;11916.582919597773;11916.642500724993;12535.749285014432;12662.493500259887;11532.423378831192;11708.297502149899;12054.638360849189;12160.209586376857;12361.381930903239;11003.119750420108;11606.187566870576;11819.231749936227;11867.58463453775;12150.878491215328;9509.286803489627;9826.508674566387;10008.749781255527;10216;10533.683989480327;9559.474228917476;10042.748931276485;10360.533775979948;10470.947645261725;10478.685639430829 19:37:02 INFO - PROCESS | 3489 | __end_tp_report 19:37:02 INFO - PROCESS | 3489 | __start_cc_report 19:37:02 INFO - PROCESS | 3489 | _x_x_mozilla_cycle_collect,347 19:37:02 INFO - PROCESS | 3489 | __end_cc_report 19:37:02 INFO - PROCESS | 3489 | __startTimestamp1471055822327__endTimestamp 19:37:02 INFO - PROCESS | 3489 | 19:37:02 INFO - PROCESS | 3489 | ------- Summary: start ------- 19:37:02 INFO - PROCESS | 3489 | Number of tests: 6 19:37:02 INFO - PROCESS | 3489 | 19:37:02 INFO - PROCESS | 3489 | [#0] dojo.html Cycles:165 Average:4787.17 Median:4883.29 stddev:495.58 (10.1%) stddev-sans-first:468.59 19:37:02 INFO - PROCESS | 3489 | Values: 2675.5 2701.3 2719.1 2730.6 2738.5 4771.4 4866.1 4897.8 4942.4 4951.2 4757.2 4795.0 4827.0 4831.6 4870.9 4359.8 4437.8 4476.2 4508.9 4525.1 4432.3 4438.3 4469.2 4487.8 4531.1 4355.6 4385.8 4429.3 4437.5 4447.3 4412.1 4415.5 4423.3 4435.6 4478.4 4462.5 4465.7 4469.4 4510.1 4514.3 4686.8 4742.1 4760.8 4786.8 4824.1 5105.1 5107.1 5117.5 5145.4 5156.3 5135.8 5181.1 5195.1 5198.3 5200.4 4816.9 4855.2 4859.7 4882.0 4882.2 5310.0 5336.0 5337.8 5340.5 5387.7 4931.9 5039.7 5094.2 5094.3 5106.3 5081.7 5134.1 5146.2 5220.6 5227.3 5190.1 5190.8 5192.2 5192.6 5234.9 5185.4 5210.1 5210.4 5210.8 5256.7 4274.6 4390.0 4454.4 4461.6 4520.0 3870.2 3886.9 3889.6 3906.7 3909.0 4371.5 4493.1 4497.5 4509.3 4543.2 5047.6 5180.3 5225.1 5246.0 5327.9 4469.3 4474.4 4488.1 4493.6 4539.9 4703.0 4711.5 4723.9 4740.3 4767.7 4739.5 4810.8 4829.6 4848.1 4926.9 5171.9 5175.6 5207.5 5222.8 5228.8 4851.8 4852.4 4875.7 4883.2 4883.3 5030.5 5045.3 5045.5 5100.7 5151.2 5128.0 5156.8 5179.9 5192.1 5194.7 5044.3 5048.6 5057.8 5062.6 5090.9 4899.9 4983.7 5016.0 5038.4 5102.9 4929.8 4942.3 4953.1 4974.6 5034.4 5076.4 5089.2 5106.5 5109.6 5130.6 4850.8 4869.6 4885.2 4911.1 4941.1 19:37:02 INFO - PROCESS | 3489 | 19:37:02 INFO - PROCESS | 3489 | [#1] ext.html Cycles:180 Average:47930.92 Median:35881.96 stddev:92277.45 (257.2%) stddev-sans-first:92467.72 19:37:02 INFO - PROCESS | 3489 | Values: 542.7 560.6 561.6 577.0 580.5 34269.8 38589.8 38620.8 38663.0 38683.2 37135.8 37459.8 37659.6 37745.0 37814.8 7468.0 7650.8 7651.2 7659.4 7660.4 7516.0 7550.8 7620.8 7622.0 7623.6 7603.1 7636.8 7648.7 7682.5 7702.5 7604.2 7641.0 7654.5 7657.8 7663.3 7404.8 7443.0 7475.9 7480.4 7489.3 36588.6 36971.6 37044.6 37047.3 37169.4 2330.7 2937.4 2939.4 2987.0 3015.8 27355.5 27835.6 28018.4 28090.0 28425.4 3324.3 3325.9 3383.6 3417.0 3422.8 233755.0 234347.0 234794.0 235848.0 235953.0 31057.5 31230.2 31271.7 31278.0 31291.2 32093.2 32098.0 32929.8 33191.5 35002.0 13942.2 14076.8 14092.3 14104.2 14149.0 10604.4 10615.2 10631.9 10689.9 10706.1 17655.0 17656.9 17829.8 17837.6 17868.5 6834.2 6862.8 6884.2 6938.8 7025.8 781.4 887.1 909.2 958.1 988.0 27492.5 28110.9 28620.9 28863.0 29332.3 969.3 969.8 1047.4 1051.9 1058.2 14824.9 14911.2 14972.8 15095.5 15172.5 405940.0 410566.0 413991.0 414188.0 414574.0 47494.5 47586.8 47833.8 47951.5 48023.3 1132.5 1181.5 1189.0 1194.7 1209.6 25531.0 26692.7 27421.2 28182.3 28230.6 41972.8 45681.0 46266.0 46379.3 46507.0 368794.0 375710.0 375769.5 375935.0 376009.0 24158.2 25225.5 38258.0 38575.4 39008.2 40493.2 40671.4 40807.6 42000.6 42441.4 35283.0 36511.0 36586.8 36770.0 37186.3 34918.7 35091.3 35409.4 35842.6 35921.3 33554.5 34148.3 34908.3 35263.8 35557.5 30424.4 33333.3 33451.7 33592.5 33654.7 22661.9 24940.8 25341.1 25647.2 25721.6 19:37:02 INFO - PROCESS | 3489 | 19:37:02 INFO - PROCESS | 3489 | [#2] jquery.html Cycles:180 Average:24124.17 Median:28320.62 stddev:64140.48 (226.5%) stddev-sans-first:64295.60 19:37:02 INFO - PROCESS | 3489 | Values: 361.4 361.4 362.7 369.6 383.5 16237.9 16670.4 17224.9 17270.8 17296.9 16475.9 16686.2 16818.0 16954.2 17096.2 5012.0 5266.1 5267.4 5269.6 5271.9 5173.2 5254.4 5263.8 5270.0 5301.1 5557.9 5663.7 5673.5 5680.7 5699.0 5275.2 5578.6 5651.7 5672.6 5682.4 5477.6 5489.4 5491.6 5496.0 5496.6 11562.2 11617.2 11899.3 12334.3 12470.5 2073.7 2091.2 2119.4 2220.8 2352.3 8794.5 8876.8 9293.1 9670.0 9805.9 1701.2 1708.6 1721.5 1726.5 1731.7 66538.3 70033.0 70465.3 70702.3 71594.6 9860.9 9891.9 9925.6 10097.2 10098.9 13525.1 13537.3 13545.2 13559.3 13571.0 6712.3 6841.4 6990.3 7036.9 7176.1 6587.3 6593.6 6752.2 6762.3 6814.4 4125.8 4191.8 4205.6 4272.4 4343.5 1806.2 1860.7 1868.4 1874.7 1882.8 793.6 832.3 861.2 931.8 941.7 16356.3 16397.8 16847.2 17200.5 17874.0 823.7 836.1 859.2 897.3 950.3 9489.1 9640.7 9968.8 10028.3 10138.9 377581.0 388990.0 389457.0 390492.0 391859.0 77361.6 77650.0 80243.0 80279.0 80560.6 873.2 898.8 908.7 908.8 915.4 14965.5 15115.9 15425.0 15650.4 15867.2 36330.5 36815.6 37431.3 37913.0 38745.0 50384.0 51468.0 52284.2 52723.0 52911.7 7554.7 7590.9 7609.0 7855.8 7968.5 8635.1 9113.0 11387.9 12107.9 12650.0 10398.6 10411.5 10425.7 10858.9 10912.7 9874.0 9935.4 10137.2 10286.3 10541.3 9894.2 10196.9 10254.4 10811.4 10830.8 7356.9 7883.8 10638.1 10742.7 11507.1 7227.5 7830.3 7929.4 8471.3 10923.0 19:37:02 INFO - PROCESS | 3489 | 19:37:02 INFO - PROCESS | 3489 | [#3] mootools.html Cycles:180 Average:5135.43 Median:4734.11 stddev:2885.05 (60.9%) stddev-sans-first:2877.48 19:37:02 INFO - PROCESS | 3489 | Values: 1135.0 1154.5 1283.1 1664.6 1666.4 6825.4 7334.4 7573.7 7924.6 7931.0 7714.0 7998.4 8016.7 8021.1 8032.2 2148.9 2165.0 2178.3 2181.7 2186.6 2076.4 2101.7 2151.4 2151.7 2151.8 2124.2 2128.3 2195.0 2199.3 2199.8 2064.8 2077.0 2083.1 2083.6 2086.2 2041.1 2150.5 2152.5 2154.5 2156.2 7972.8 8055.8 8083.6 8102.5 8110.9 4504.3 4656.2 4670.9 4687.8 4688.2 2893.9 3018.8 3029.9 3035.1 3096.7 953.4 998.6 1004.2 1004.4 1019.1 10294.6 10346.4 10358.5 10359.7 10401.5 3915.5 4060.2 4162.1 4272.3 4278.1 8918.6 8969.7 8984.3 8988.2 9006.9 4525.7 4584.5 4593.7 4597.7 4607.8 3623.7 4107.8 4181.3 4188.7 4218.0 3551.6 3637.9 3656.0 3657.3 3756.5 1167.5 1169.6 1191.9 1198.6 1204.9 830.1 844.5 853.1 885.8 887.7 5234.2 5270.1 5281.4 5384.7 5437.9 398.7 400.7 401.3 403.9 404.2 3588.2 3614.6 3668.2 3732.5 3792.7 9079.3 9499.7 9517.8 9536.1 9539.7 9411.3 9412.9 9446.9 9496.2 9504.9 6889.6 7210.7 7217.0 7374.2 7408.0 5287.5 5498.6 5588.9 5596.2 5696.7 8935.0 8954.7 8963.9 9042.3 9082.8 8971.5 9107.0 9109.3 9111.2 9238.1 6080.1 6624.9 6714.7 6839.4 6842.4 7669.6 7738.3 7742.3 7789.5 7828.4 6556.7 6697.3 6803.5 6818.5 6858.1 6895.1 6935.5 6999.8 7058.8 7104.9 5954.6 6285.5 6318.6 6347.3 6358.2 4505.0 4520.3 4539.1 4629.8 4654.7 4617.9 4677.6 4687.3 4780.0 4872.7 19:37:02 INFO - PROCESS | 3489 | 19:37:02 INFO - PROCESS | 3489 | [#4] prototype.html Cycles:180 Average:4302.68 Median:4855.68 stddev:1274.92 (26.3%) stddev-sans-first:1242.53 19:37:02 INFO - PROCESS | 3489 | Values: 296.5 304.0 309.5 309.7 317.5 4903.7 5002.8 5046.1 5108.8 5128.3 5023.7 5047.4 5049.8 5067.5 5071.1 3973.0 3977.4 3980.5 3990.4 3991.7 3888.5 3998.3 4000.1 4009.2 4023.5 3932.1 3940.7 3943.1 3945.9 3953.4 3932.7 3937.3 3956.4 3961.5 3973.7 3270.0 3393.4 3398.0 3500.3 3509.7 4839.5 4880.4 4881.4 4892.9 4923.9 4418.2 4444.0 4446.8 4451.8 4452.8 5114.0 5192.5 5249.5 5301.2 5308.6 3673.2 3673.9 3685.3 3700.7 3701.9 5508.7 5532.3 5538.8 5543.2 5565.4 3656.6 3761.7 3766.6 3771.3 3775.3 3783.6 3826.6 3832.4 3843.6 3846.3 4386.5 4399.1 4400.3 4406.7 4411.4 5297.9 5301.2 5309.3 5312.5 5360.9 1287.3 1318.2 1325.5 1334.7 1335.5 816.1 842.0 847.0 863.2 867.2 4093.3 4114.9 4127.0 4131.9 4192.8 4828.2 4840.3 4850.0 4861.4 4885.4 4153.9 4158.8 4172.0 4180.4 4207.6 2472.1 2535.7 2598.8 2603.4 2618.8 4530.2 4545.2 4546.6 4546.8 4603.3 4910.4 4912.8 4937.9 4954.6 4972.7 4621.1 4769.6 5134.5 5151.0 5220.9 5559.2 5564.5 5572.4 5574.5 5575.3 5156.9 5419.5 5421.3 5430.8 5466.0 5159.3 5167.0 5172.8 5181.6 5184.9 3613.8 3785.7 3833.1 3851.2 3880.1 5413.8 5417.3 5446.9 5449.8 5474.0 5285.2 5298.8 5302.6 5324.2 5337.0 5078.6 5288.9 5304.9 5305.0 5346.7 5225.3 5244.2 5261.4 5268.5 5275.4 5353.4 5392.4 5392.8 5399.4 5404.2 5105.6 5212.4 5220.9 5258.3 5267.6 19:37:02 INFO - PROCESS | 3489 | 19:37:02 INFO - PROCESS | 3489 | [#5] yui.html Cycles:180 Average:17383.11 Median:44437.50 stddev:24614.89 (55.4%) stddev-sans-first:24651.82 19:37:02 INFO - PROCESS | 3489 | Values: 637.5 678.1 679.6 714.8 737.5 12337.8 12898.3 12963.4 12983.3 13027.0 12364.0 12399.6 12413.7 12432.8 12451.5 626.2 729.7 743.7 745.9 749.0 746.0 768.5 782.5 786.7 795.6 790.5 796.8 798.1 799.3 799.6 790.2 792.3 792.7 793.0 794.0 590.2 592.5 593.6 594.3 595.4 12938.1 12972.7 12979.3 12997.7 13021.7 12710.4 13122.2 13127.5 13171.8 13554.9 10095.6 10199.1 10234.6 10457.3 10473.6 3247.3 3280.2 3306.2 3329.7 3354.4 59632.0 60725.0 61184.7 61683.0 62413.0 9764.3 9999.9 10007.0 10144.3 10180.7 16179.5 16921.0 20010.4 20080.7 20242.5 7085.5 7107.7 7197.8 7339.7 7346.3 3607.4 3734.8 3779.2 3818.2 3897.3 2961.6 3046.1 3076.7 3080.1 3086.2 511.0 527.1 528.7 531.8 541.3 499.7 568.8 601.7 619.9 625.7 7325.6 7503.6 7659.9 7813.3 8005.4 524.7 607.8 614.2 618.3 637.4 3494.0 3651.7 3710.9 3749.3 3778.1 93306.0 99313.5 100923.0 105249.5 106053.0 65382.3 71665.6 75875.6 85623.0 87365.1 67123.7 67645.0 68811.7 69170.0 70440.9 8142.3 8724.0 8850.4 8957.9 9020.8 42430.0 43856.0 44194.0 44681.0 45660.8 56177.2 56391.4 59848.4 60777.7 63701.7 10883.7 11326.9 11385.8 11488.4 11555.1 12734.4 12974.9 13044.5 13332.1 13545.9 11762.9 11916.6 11916.6 12535.7 12662.5 11532.4 11708.3 12054.6 12160.2 12361.4 11003.1 11606.2 11819.2 11867.6 12150.9 9509.3 9826.5 10008.7 10216.0 10533.7 9559.5 10042.7 10360.5 10470.9 10478.7 19:37:02 INFO - PROCESS | 3489 | -------- Summary: end -------- 19:37:02 INFO - PROCESS | 3489 | 19:37:03 INFO - TEST-INFO | 3489: exit 0 19:37:03 INFO - TEST-OK | dromaeo_css | took 1118299ms 19:37:03 INFO - TEST-START | kraken 19:37:03 INFO - operating with platform_type : linux_ 19:37:03 INFO - Initialising browser for kraken test... 19:37:03 INFO - TEST-INFO | started process 3838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5IYs7s/profile http://localhost:43489/getInfo.html) 19:37:07 INFO - PROCESS | 3838 | __metrics Screen width/height:1600/1200 19:37:07 INFO - PROCESS | 3838 | colorDepth:24 19:37:07 INFO - PROCESS | 3838 | Browser inner width/height: 1024/697 19:37:07 INFO - PROCESS | 3838 | __metrics 19:37:08 ERROR - PROCESS | 3838 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 19:37:09 INFO - TEST-INFO | 3838: exit 0 19:37:09 INFO - Browser initialized. 19:37:09 INFO - Running cycle 1/1 for kraken test... 19:37:09 INFO - TEST-INFO | started process 3961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5IYs7s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:37:20 INFO - PROCESS | 3961 | RSS: Main: 164859904 19:37:20 INFO - PROCESS | 3961 | 19:37:23 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:43489/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43489/tests/kraken/driver.html?testName=audio-beat-detection) 19:37:24 INFO - PROCESS | 3961 | RSS: Main: 169811968 19:37:24 INFO - PROCESS | 3961 | 19:37:27 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:43489/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43489/tests/kraken/driver.html?testName=audio-dft) 19:37:28 INFO - PROCESS | 3961 | RSS: Main: 168476672 19:37:28 INFO - PROCESS | 3961 | 19:37:31 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:43489/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43489/tests/kraken/driver.html?testName=audio-fft) 19:37:31 INFO - PROCESS | 3961 | RSS: Main: 165040128 19:37:31 INFO - PROCESS | 3961 | 19:37:33 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:43489/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43489/tests/kraken/driver.html?testName=audio-oscillator) 19:37:34 INFO - PROCESS | 3961 | RSS: Main: 165511168 19:37:34 INFO - PROCESS | 3961 | 19:37:36 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:43489/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43489/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:37:37 INFO - PROCESS | 3961 | RSS: Main: 165916672 19:37:37 INFO - PROCESS | 3961 | 19:37:40 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:43489/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43489/tests/kraken/driver.html?testName=imaging-darkroom) 19:37:41 INFO - PROCESS | 3961 | RSS: Main: 165986304 19:37:41 INFO - PROCESS | 3961 | 19:37:44 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:43489/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43489/tests/kraken/driver.html?testName=imaging-desaturate) 19:37:45 INFO - PROCESS | 3961 | RSS: Main: 163049472 19:37:45 INFO - PROCESS | 3961 | 19:37:48 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:43489/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43489/tests/kraken/driver.html?testName=json-parse-financial) 19:37:49 INFO - PROCESS | 3961 | RSS: Main: 165232640 19:37:49 INFO - PROCESS | 3961 | 19:37:50 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:43489/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43489/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:37:51 INFO - PROCESS | 3961 | RSS: Main: 165400576 19:37:51 INFO - PROCESS | 3961 | 19:37:53 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:43489/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43489/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:37:54 INFO - PROCESS | 3961 | RSS: Main: 165302272 19:37:54 INFO - PROCESS | 3961 | 19:37:56 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:43489/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43489/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:37:57 INFO - PROCESS | 3961 | RSS: Main: 165949440 19:37:57 INFO - PROCESS | 3961 | 19:37:59 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:43489/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:38:00 INFO - PROCESS | 3961 | RSS: Main: 166023168 19:38:00 INFO - PROCESS | 3961 | 19:38:03 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:43489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:38:04 INFO - PROCESS | 3961 | RSS: Main: 166092800 19:38:04 INFO - PROCESS | 3961 | 19:38:05 INFO - PROCESS | 3961 | Cycle 1(1): loaded http://localhost:43489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43489/tests/kraken/driver.html?testName=ai-astar) 19:38:06 INFO - PROCESS | 3961 | RSS: Main: 166621184 19:38:06 INFO - PROCESS | 3961 | 19:38:06 INFO - PROCESS | 3961 | __start_tp_report 19:38:06 INFO - PROCESS | 3961 | _x_x_mozilla_page_load 19:38:06 INFO - PROCESS | 3961 | _x_x_mozilla_page_load_details 19:38:06 INFO - PROCESS | 3961 | |i|pagename|runs| 19:38:06 INFO - PROCESS | 3961 | |0;ai-astar;108;115;113;116;115;116;121;116;115;116 19:38:06 INFO - PROCESS | 3961 | |1;audio-beat-detection;162;122;151;194;130;152;152;126;184;125 19:38:06 INFO - PROCESS | 3961 | |2;audio-dft;163;164;171;178;165;166;162;173;162;164 19:38:06 INFO - PROCESS | 3961 | |3;audio-fft;76;76;78;163;76;77;76;77;174;78 19:38:06 INFO - PROCESS | 3961 | |4;audio-oscillator;87;87;145;87;86;87;143;87;86;140 19:38:06 INFO - PROCESS | 3961 | |5;imaging-gaussian-blur;118;118;118;117;117;117;121;118;117;118 19:38:06 INFO - PROCESS | 3961 | |6;imaging-darkroom;148;149;147;147;146;147;149;149;147;147 19:38:06 INFO - PROCESS | 3961 | |7;imaging-desaturate;95;100;95;95;95;96;96;95;96;95 19:38:06 INFO - PROCESS | 3961 | |8;json-parse-financial;62;63;68;64;65;67;62;64;62;67 19:38:06 INFO - PROCESS | 3961 | |9;json-stringify-tinderbox;65;65;66;66;66;67;65;69;66;66 19:38:06 INFO - PROCESS | 3961 | |10;stanford-crypto-aes;94;91;87;86;82;83;90;83;83;86 19:38:06 INFO - PROCESS | 3961 | |11;stanford-crypto-ccm;146;143;155;138;145;138;136;137;165;146 19:38:06 INFO - PROCESS | 3961 | |12;stanford-crypto-pbkdf2;175;175;181;184;171;171;171;171;173;172 19:38:06 INFO - PROCESS | 3961 | |13;stanford-crypto-sha256-iterative;68;72;69;69;69;68;73;68;68;67 19:38:06 INFO - PROCESS | 3961 | __end_tp_report 19:38:06 INFO - PROCESS | 3961 | __start_cc_report 19:38:06 INFO - PROCESS | 3961 | _x_x_mozilla_cycle_collect,963 19:38:06 INFO - PROCESS | 3961 | __end_cc_report 19:38:06 INFO - PROCESS | 3961 | __startTimestamp1471055886106__endTimestamp 19:38:06 INFO - PROCESS | 3961 | 19:38:06 INFO - PROCESS | 3961 | ------- Summary: start ------- 19:38:06 INFO - PROCESS | 3961 | Number of tests: 14 19:38:06 INFO - PROCESS | 3961 | 19:38:06 INFO - PROCESS | 3961 | [#0] ai-astar Cycles:10 Average:115.10 Median:116.00 stddev:3.21 (2.8%) stddev-sans-first:2.15 19:38:06 INFO - PROCESS | 3961 | Values: 108.0 115.0 113.0 116.0 115.0 116.0 121.0 116.0 115.0 116.0 19:38:06 INFO - PROCESS | 3961 | 19:38:06 INFO - PROCESS | 3961 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:152.00 stddev:25.01 (16.5%) stddev-sans-first:26.13 19:38:06 INFO - PROCESS | 3961 | Values: 162.0 122.0 151.0 194.0 130.0 152.0 152.0 126.0 184.0 125.0 19:38:06 INFO - PROCESS | 3961 | 19:38:06 INFO - PROCESS | 3961 | [#2] audio-dft Cycles:10 Average:166.80 Median:165.50 stddev:5.39 (3.3%) stddev-sans-first:5.54 19:38:06 INFO - PROCESS | 3961 | Values: 163.0 164.0 171.0 178.0 165.0 166.0 162.0 173.0 162.0 164.0 19:38:06 INFO - PROCESS | 3961 | 19:38:06 INFO - PROCESS | 3961 | [#3] audio-fft Cycles:10 Average:95.10 Median:76.50 stddev:38.78 (50.7%) stddev-sans-first:40.51 19:38:06 INFO - PROCESS | 3961 | Values: 76.0 76.0 78.0 163.0 76.0 77.0 76.0 77.0 174.0 78.0 19:38:06 INFO - PROCESS | 3961 | 19:38:06 INFO - PROCESS | 3961 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:87.00 stddev:27.06 (31.1%) stddev-sans-first:28.03 19:38:06 INFO - PROCESS | 3961 | Values: 87.0 87.0 145.0 87.0 86.0 87.0 143.0 87.0 86.0 140.0 19:38:06 INFO - PROCESS | 3961 | 19:38:06 INFO - PROCESS | 3961 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.20 (1.0%) stddev-sans-first:1.27 19:38:06 INFO - PROCESS | 3961 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 121.0 118.0 117.0 118.0 19:38:06 INFO - PROCESS | 3961 | 19:38:06 INFO - PROCESS | 3961 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 19:38:06 INFO - PROCESS | 3961 | Values: 148.0 149.0 147.0 147.0 146.0 147.0 149.0 149.0 147.0 147.0 19:38:06 INFO - PROCESS | 3961 | 19:38:06 INFO - PROCESS | 3961 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:1.55 (1.6%) stddev-sans-first:1.62 19:38:06 INFO - PROCESS | 3961 | Values: 95.0 100.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 19:38:06 INFO - PROCESS | 3961 | 19:38:06 INFO - PROCESS | 3961 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.50 stddev:2.27 (3.5%) stddev-sans-first:2.24 19:38:06 INFO - PROCESS | 3961 | Values: 62.0 63.0 68.0 64.0 65.0 67.0 62.0 64.0 62.0 67.0 19:38:06 INFO - PROCESS | 3961 | 19:38:06 INFO - PROCESS | 3961 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 19:38:06 INFO - PROCESS | 3961 | Values: 65.0 65.0 66.0 66.0 66.0 67.0 65.0 69.0 66.0 66.0 19:38:06 INFO - PROCESS | 3961 | 19:38:06 INFO - PROCESS | 3961 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.50 stddev:4.03 (4.7%) stddev-sans-first:3.24 19:38:06 INFO - PROCESS | 3961 | Values: 94.0 91.0 87.0 86.0 82.0 83.0 90.0 83.0 83.0 86.0 19:38:06 INFO - PROCESS | 3961 | 19:38:06 INFO - PROCESS | 3961 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:145.50 stddev:9.12 (6.3%) stddev-sans-first:9.67 19:38:06 INFO - PROCESS | 3961 | Values: 146.0 143.0 155.0 138.0 145.0 138.0 136.0 137.0 165.0 146.0 19:38:06 INFO - PROCESS | 3961 | 19:38:06 INFO - PROCESS | 3961 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.40 Median:174.00 stddev:4.60 (2.6%) stddev-sans-first:4.87 19:38:06 INFO - PROCESS | 3961 | Values: 175.0 175.0 181.0 184.0 171.0 171.0 171.0 171.0 173.0 172.0 19:38:06 INFO - PROCESS | 3961 | 19:38:06 INFO - PROCESS | 3961 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:1.91 (2.8%) stddev-sans-first:1.99 19:38:06 INFO - PROCESS | 3961 | Values: 68.0 72.0 69.0 69.0 69.0 68.0 73.0 68.0 68.0 67.0 19:38:06 INFO - PROCESS | 3961 | -------- Summary: end -------- 19:38:06 INFO - PROCESS | 3961 | 19:38:07 INFO - TEST-INFO | 3961: exit 0 19:38:07 INFO - TEST-OK | kraken | took 64145ms 19:38:07 INFO - SUITE-END | took 1182s 19:38:07 INFO - Completed test suite (00:19:42) 19:38:07 INFO - javascript benchmark 19:38:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6385.582725779505, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2675.451532435851, 2701.297662607722, 2719.0755143251304, 2730.604062410952, 2738.4796888591154, 4771.427428708551, 4866.075445665326, 4897.7551122443865, 4942.357493525841, 4951.207806750921, 4757.167495688258, 4795.0, 4827.034593081389, 4831.565159135677, 4870.902581948368, 4359.847405340814, 4437.778111094449, 4476.239039363316, 4508.864734057984, 4525.072360166175, 4432.29083346663, 4438.334249862514, 4469.240229161051, 4487.798049087799, 4531.116432295704, 4355.5644435556505, 4385.802638881258, 4429.291313389842, 4437.534058923831, 4447.288433850601, 4412.05140894706, 4415.492218394894, 4423.314386270134, 4435.600795928382, 4478.39541661878, 4462.531434199394, 4465.732056076646, 4469.44131983502, 4510.120526497334, 4514.300283456037, 4686.789094490756, 4742.0515896820425, 4760.833370832004, 4786.832460863888, 4824.107540105092, 5105.132127538327, 5107.055194788976, 5117.48825117489, 5145.382554093533, 5156.3296771419855, 5135.794568217267, 5181.145111056709, 5195.064888320101, 5198.324217851693, 5200.401953775288, 4816.855494335211, 4855.150348688965, 4859.684120532154, 4882.0, 4882.170031094723, 5309.964556911365, 5336.0, 5337.786488540492, 5340.546053585489, 5387.730613469311, 4931.852044438672, 5039.672421292677, 5094.2103973884105, 5094.312267843868, 5106.285120083191, 5081.669691470042, 5134.075866344094, 5146.176611742103, 5220.582353411718, 5227.294315267466, 5190.091733946544, 5190.844274671766, 5192.247124166975, 5192.636515443958, 5234.921476177784, 5185.351831021122, 5210.114280572312, 5210.400803907599, 5210.7915683373, 5256.710880901587, 4274.551172126882, 4390.034192477649, 4454.398656181439, 4461.598456138963, 4520.028193938319, 3870.2066076454257, 3886.855307647039, 3889.5721470638773, 3906.74606150605, 3909.0, 4371.475422949266, 4493.1013797240685, 4497.527759585262, 4509.278515437514, 4543.204939135638, 5047.596192304681, 5180.274761533388, 5225.085610018232, 5246.029484545371, 5327.946720532745, 4469.307257375112, 4474.39595654589, 4488.079943611552, 4493.640508759291, 4539.863804085882, 4702.976485117552, 4711.528847115261, 4723.929141062887, 4740.288956656529, 4767.69010014348, 4739.478657347689, 4810.807567697253, 4829.5653391193555, 4848.0546293472435, 4926.8768280793265, 5171.896562068662, 5175.560077393313, 5207.453217412117, 5222.843314700565, 5228.843134705965, 4851.830185943475, 4852.402757409864, 4875.658703890836, 4883.169861123546, 4883.291922671264, 5030.4718004608985, 5045.31888195089, 5045.520675535819, 5100.744962751922, 5151.150060240018, 5128.0000399921655, 5156.845294641167, 5179.896402072013, 5192.065428222956, 5194.68831870089, 5044.268581055653, 5048.621353398436, 5057.8229761958155, 5062.620303477181, 5090.872728181825, 4899.853004409873, 4983.700977941335, 5016.046951079284, 5038.395392552917, 5102.872428189325, 4929.778159982738, 4942.28336891156, 4953.108440480748, 4974.552290293891, 5034.370703662043, 5076.390833100052, 5089.211172268304, 5106.540411362995, 5109.642325037212, 5130.640855140105, 4850.83022094225, 4869.6347773917805, 4885.218365061715, 4911.140550403594, 4941.061198372297], "value": 4755.889182686766, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.6906663201975, 560.5543592843686, 561.5872333834631, 577.0449905406552, 580.46887098305, 34269.82865085674, 38589.80705096477, 38620.806895965514, 38663.0, 38683.22633547327, 37135.81432092836, 37459.812700936454, 37659.62340376595, 37744.999999999935, 37814.8109259454, 7468.0, 7650.808729781745, 7651.23487651236, 7659.425543084263, 7660.387169026492, 7515.985341978818, 7550.7734767957045, 7620.7713768586755, 7622.047244094489, 7623.58070306133, 7603.087629484442, 7636.847263054736, 7648.694052237904, 7682.462227644067, 7702.537847729126, 7604.163542010375, 7640.961795191044, 7654.464187506876, 7657.808554786119, 7663.310302072812, 7404.777856664308, 7442.962785186093, 7475.887861682079, 7480.438967077491, 7489.251074892467, 36588.63411365879, 36971.630283697086, 37044.629553704384, 37047.25905481875, 37169.44245836315, 2330.685357476736, 2937.3684657798676, 2939.4415061138316, 2986.970130298691, 3015.7738169637146, 27355.45289094227, 27835.582466263022, 28018.439631207464, 28090.0, 28425.422230214608, 3324.3018966017166, 3325.88359407422, 3383.610884748261, 3416.9658303416895, 3422.8117453540044, 233755.0, 234347.0, 234794.0, 235848.0, 235952.99999999828, 31057.534136987964, 31230.219244518616, 31271.687283126877, 31278.0, 31291.217719557193, 32093.197670058435, 32098.0, 32929.835350823094, 33191.502127468106, 35002.0, 13942.163470191821, 14076.788848167285, 14092.295385230698, 14104.224267665377, 14149.0, 10604.416757078434, 10615.203859710553, 10631.893681063246, 10689.946550267354, 10706.089982351432, 17655.0, 17656.91171544134, 17829.821701783076, 17837.554061148574, 17868.46394608164, 6834.179898412222, 6862.759803406957, 6884.173899132136, 6938.757143499954, 7025.789226323219, 781.4334607409583, 887.1350433327455, 909.2453263791037, 958.0946006024379, 987.9950600246952, 27492.45015099687, 28110.85944570264, 28620.856895715806, 28863.0, 29332.266693332836, 969.3166317746113, 969.7817990951979, 1047.4161422979644, 1051.9053285204368, 1058.2486434631344, 14824.851751482347, 14911.179885106423, 14972.775408368883, 15095.54713358601, 15172.544823655307, 405940.0, 410566.0, 413991.0, 414188.0, 414574.0, 47494.5250547497, 47586.76206618945, 47833.76083119562, 47951.5204847954, 48023.27965080526, 1132.5356603792407, 1181.5155786127818, 1188.95838645647, 1194.7192409783695, 1209.5524655877382, 25531.0, 26692.733072669023, 27421.17736467909, 28182.29544261328, 28230.576541351486, 41972.79013604912, 45681.0, 46266.0, 46379.30431043605, 46507.0, 368794.0, 375710.0, 375769.48461031175, 375935.0, 376009.0, 24158.154464594358, 25225.49549008973, 38258.0, 38575.42136867893, 39008.21983560256, 40493.19013619652, 40671.38992915168, 40807.59192408038, 42000.57999419967, 42441.36337954995, 35283.0, 36511.0, 36586.8170659145, 36770.0, 37186.25627487489, 34918.65081349255, 35091.298174036885, 35409.40657670463, 35842.64157358393, 35921.28157436889, 33554.496682549296, 34148.31703365869, 34908.30183396267, 35263.82368088246, 35557.466638000966, 30424.391512170074, 33333.333333333685, 33451.66548334583, 33592.49611255882, 33654.66345336515, 22661.88669056644, 24940.75059249457, 25341.113061042775, 25647.23058308254, 25721.614175787752], "value": 16980.943302687185, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.43255089509483, 361.4397683590435, 362.66634696079603, 369.6155997762327, 383.53209084916426, 16237.918810405947, 16670.41653542125, 17224.913875430622, 17270.82729172708, 17296.913515432436, 16475.91762041191, 16686.165691715425, 16818.0, 16954.152292385363, 17096.230669619865, 5011.974940125294, 5266.078436273656, 5267.3942496613, 5269.604779641523, 5271.947280527184, 5173.249878767595, 5254.4220135785035, 5263.763130659129, 5269.973650131744, 5301.0988132017455, 5557.944420555783, 5663.7168141592965, 5673.51775099115, 5680.744366503517, 5699.0, 5275.155975044013, 5578.63738856977, 5651.660900345972, 5672.574556908227, 5682.403347648478, 5477.643953143033, 5489.39616642169, 5491.588130890199, 5495.972520137414, 5496.560275178016, 11562.248453850472, 11617.244879082833, 11899.345535995517, 12334.32161231132, 12470.501179952791, 2073.720047793559, 2091.1530830013867, 2119.448943274744, 2220.7890250426185, 2352.282553821084, 8794.472331660121, 8876.778080547974, 9293.117153870371, 9669.951650241705, 9805.852912206252, 1701.1658339281446, 1708.5813975576064, 1721.500764778213, 1726.47342560519, 1731.6796392667397, 66538.3346166537, 70033.0, 70465.2953470469, 70702.29297707009, 71594.64202679005, 9860.901390986142, 9891.944302835947, 9925.553350099119, 10097.192224622013, 10098.949505252574, 13525.053246272666, 13537.323133843269, 13545.187288762705, 13559.322033898266, 13570.982176336616, 6712.328767123347, 6841.350071743276, 6990.266022067712, 7036.9296307036275, 7176.067111275501, 6587.341265873471, 6593.637349945799, 6752.189737231563, 6762.256151823295, 6814.420774234147, 4125.793710314472, 4191.811368488426, 4205.642520385741, 4272.359146128044, 4343.500497442771, 1806.1872157529165, 1860.6650802855345, 1868.374094678271, 1874.6906760384384, 1882.8117188281062, 793.5516433215215, 832.3008672714949, 861.224897592172, 931.7856892914667, 941.658137154552, 16356.263968121462, 16397.83602163987, 16847.157642117843, 17200.483985480456, 17874.0, 823.7158180427742, 836.1262480707675, 859.1923591823665, 897.2821742605889, 950.3300173377752, 9489.098535639103, 9640.662576809918, 9968.80062398748, 10028.348157369748, 10138.949305253574, 377581.0, 388990.0, 389457.0, 390492.0, 391859.0, 77361.61319193481, 77650.0, 80243.0, 80279.0, 80560.59719701365, 873.2097451806253, 898.7618281155499, 908.6547112097493, 908.7909780750465, 915.3683958068912, 14965.476208333092, 15115.924420377827, 15425.0, 15650.37398504047, 15867.20663966774, 36330.4550431749, 36815.63184368229, 37431.251374971805, 37913.0, 38745.0, 50384.0, 51468.0, 52284.21573676474, 52723.0, 52911.73544132255, 7554.697812087675, 7590.924090759022, 7608.96195519041, 7855.8036049096945, 7968.521888686697, 8635.093315202064, 9112.95443522778, 11387.886121139014, 12107.939460302641, 12650.0, 10398.58405663765, 10411.47942602882, 10425.687229383131, 10858.891411085788, 10912.727181820517, 9874.0, 9935.403875767477, 10137.189024877845, 10286.2799604027, 10541.262111652417, 9894.15899648538, 10196.898031019595, 10254.436006019741, 10811.35131892089, 10830.837537436788, 7356.852862942818, 7883.763487095396, 10638.095761860328, 10742.73143171427, 11507.136964727511, 7227.457940654367, 7830.256125668053, 7929.405294602812, 8471.32229421657, 10923.0], "value": 8127.509986293613, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1134.9546018159274, 1154.4689442856288, 1283.1274733181435, 1664.6337805682745, 1666.3917670050428, 6825.3857152856235, 7334.376577990871, 7573.659185336659, 7924.603769811508, 7930.960345198273, 7713.961430192841, 7998.360131189505, 8016.67933282668, 8021.117677055519, 8032.236937490944, 2148.9140434382607, 2164.9783502165014, 2178.2593918067855, 2181.727284089489, 2186.6282731935607, 2076.397844625057, 2101.6532272175073, 2151.408362700262, 2151.6880052392394, 2151.8278537716947, 2124.16095642222, 2128.3295761834975, 2195.023214669465, 2199.285232299501, 2199.846010779238, 2064.752229732434, 2076.9792302076935, 2083.104265165978, 2083.6353638113346, 2086.2072412483158, 2041.101915157326, 2150.4623844038993, 2152.461884528868, 2154.526004279072, 2156.223759446598, 7972.760817175436, 8055.798605034921, 8083.595820209025, 8102.473339232931, 8110.945577075002, 4504.324351347292, 4656.208444564432, 4670.906581868344, 4687.765611719435, 4688.249880019214, 2893.8987135450157, 3018.758499320049, 3029.8939537116316, 3035.134986528829, 3096.736777373926, 953.3850666320254, 998.5706146357063, 1004.1866088468364, 1004.407399634212, 1019.0828254570871, 10294.639687610972, 10346.379217246915, 10358.53386597605, 10359.689209323808, 10401.53193106312, 3915.5105611798526, 4060.167665628598, 4162.125953549788, 4272.252355837716, 4278.122984788111, 8918.643254269757, 8969.730908072768, 8984.281257499384, 8988.235999939947, 9006.86489702655, 4525.705829121162, 4584.4957054723955, 4593.724376537419, 4597.7241365518175, 4607.76961151941, 3623.6557527035416, 4107.753534787863, 4181.310083836193, 4188.748675079505, 4217.957820421757, 3551.6093229745225, 3637.8544858205373, 3655.981720091436, 3657.305112028706, 3756.530433695788, 1167.5038108803724, 1169.6198735411026, 1191.892729654318, 1198.5745060503396, 1204.933728644933, 830.1490971754, 844.4757213230179, 853.0573716043806, 885.7564169853342, 887.671561522241, 5234.241035049972, 5270.077736396115, 5281.445448227958, 5384.730763461811, 5437.945620543823, 398.71292669278074, 400.679456434851, 401.33779264213695, 403.884892805549, 404.2400287459616, 3588.2285308658766, 3614.6385361463645, 3668.192997540537, 3732.5147730794824, 3792.6965842732516, 9079.273658107335, 9499.715008549754, 9517.762055948657, 9536.094071063239, 9539.713808585753, 9411.294152938557, 9412.90587094134, 9446.85829712555, 9496.240300775922, 9504.904950950402, 6889.621070841052, 7210.702073626798, 7216.96391518039, 7374.225706300868, 7408.0, 5287.524122828964, 5498.615096943176, 5588.86027849307, 5596.216529685928, 5696.715164241854, 8934.955325223333, 8954.731358059269, 8963.910360896307, 9042.276617870686, 9082.772930676785, 8971.461712297283, 9106.95446522763, 9109.271258299188, 9111.225545828678, 9238.122378374044, 6080.118382834553, 6624.867502650017, 6714.6978385973725, 6839.350261725128, 6842.418394436529, 7669.578173200527, 7738.342240909361, 7742.341900938483, 7789.493682910593, 7828.373730101464, 6556.704948277244, 6697.263301036979, 6803.489738269551, 6818.522703410714, 6858.108445902001, 6895.069165662772, 6935.514513983972, 6999.825004374931, 7058.752943646948, 7104.893426598708, 5954.553408494294, 6285.528585356208, 6318.62088274705, 6347.270063942521, 6358.237011558643, 4504.954950450585, 4520.276755719201, 4539.114872599944, 4629.83795567167, 4654.720716757005, 4617.861464156081, 4677.555632214934, 4687.273472611751, 4779.976100119477, 4872.662226374803], "value": 4063.163670764614, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.46784022679276, 303.9711227433394, 309.4630815535047, 309.69959139634545, 317.4904278632796, 4903.705777653343, 5002.799328161243, 5046.11692953733, 5108.846734597963, 5128.333316668833, 5023.6734612250175, 5047.394312682474, 5049.778097637037, 5067.493250674931, 5071.112555302826, 3972.9602703973023, 3977.3835055566433, 3980.5024371953505, 3990.421388898608, 3991.700622453313, 3888.475055867464, 3998.3202855514487, 4000.1399699064696, 4009.1781184857036, 4023.4970628671417, 3932.134930315326, 3940.7241493095494, 3943.073377756225, 3945.8816235512836, 3953.446517487554, 3932.705047121449, 3937.2912875682364, 3956.3669812829808, 3961.5048118984982, 3973.662238709713, 3269.9509507357407, 3393.389189945809, 3398.0, 3500.2824420993634, 3509.6841284284283, 4839.491853355417, 4880.389951256093, 4881.365422495089, 4892.877678058041, 4923.9167383175645, 4418.182636212311, 4444.0, 4446.7554284514335, 4451.755153466558, 4452.821887124511, 5114.0496856035215, 5192.506711862405, 5249.527542521191, 5301.151815709468, 5308.628396012281, 3673.1634182908547, 3673.8530458781615, 3685.2728980554466, 3700.7224458165474, 3701.9259614807825, 5508.658820001483, 5532.30846144232, 5538.833834984957, 5543.223948647193, 5565.38780734123, 3656.5794933582447, 3761.661450469416, 3766.642168993941, 3771.340015497277, 3775.2826962876966, 3783.5838057813617, 3826.598207188261, 3832.3868181090893, 3843.6348546888003, 3846.3076646203394, 4386.495553011381, 4399.054203346232, 4400.295952647561, 4406.713563618355, 4411.404460397869, 5297.9404119176315, 5301.151815709468, 5309.283246761715, 5312.5218730314455, 5360.946390536044, 1287.3434548380205, 1318.2156616812981, 1325.509561462265, 1334.7197088611501, 1335.472488367109, 816.1185919207242, 841.9621117049747, 847.0259201917844, 863.1670438027334, 867.1588559097665, 4093.3246014407887, 4114.938275925863, 4126.958730412717, 4131.8967025824595, 4192.790360481964, 4828.155072862235, 4840.298156767249, 4850.0, 4861.368022157097, 4885.410732311881, 4153.857689135451, 4158.750474971512, 4171.97914010428, 4180.414741936132, 4207.621314081747, 2472.1043689079033, 2535.6830396200476, 2598.7525987525714, 2603.3751899543972, 2618.8035897307777, 4530.207213737583, 4545.181867263925, 4546.590806827336, 4546.818127274938, 4603.309503574491, 4910.379574740327, 4912.754362281871, 4937.851864444073, 4954.628402869799, 4972.651914366032, 4621.128442980598, 4769.642276829251, 5134.5378915897745, 5151.0, 5220.895582088413, 5559.165475393192, 5564.4713752193475, 5572.387037425799, 5574.470425309589, 5575.275214222125, 5156.905856486078, 5419.512243898068, 5421.2681288025615, 5430.755615997211, 5466.0, 5159.303494028408, 5166.966606678604, 5172.818951336685, 5181.5595674368105, 5184.896302074013, 3613.765105268149, 3785.6782173514457, 3833.1183827719224, 3851.1527463957887, 3880.1075752576503, 5413.83758487246, 5417.268668729828, 5446.918296225639, 5449.754761035683, 5474.0, 5285.154375299933, 5298.81454149103, 5302.628815982845, 5324.201369794562, 5337.0, 5078.568321692697, 5288.858012504942, 5304.9204261936875, 5304.98410603968, 5346.679199248058, 5225.275659032434, 5244.160934250502, 5261.421243663118, 5268.4994925482015, 5275.393329767126, 5353.437889021752, 5392.352917649907, 5392.811251606175, 5399.406065332889, 5404.162354835007, 5105.566026887756, 5212.374515058217, 5220.869478263074, 5258.316418865523, 5267.631265811357], "value": 3895.959883666619, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.4549759955238, 678.1353773938229, 679.585452873747, 714.7998560403086, 737.5095561451628, 12337.753244935097, 12898.290594017326, 12963.351832408389, 12983.285919274436, 13027.0, 12364.0, 12399.56601518947, 12413.689657758561, 12432.751344973118, 12451.501939922393, 626.1859582542676, 729.7299999000351, 743.6765007221849, 745.8694728422531, 748.9662965166581, 745.9850802983937, 768.4697558684489, 782.495290537603, 786.7403756760284, 795.6061749434039, 790.5454363740844, 796.8047828282079, 798.078219656295, 799.3285640062346, 799.5562462833125, 790.1861083084432, 792.2711105782665, 792.7423587334082, 793.012699189507, 794.0431779705441, 590.2091197794975, 592.4815786187087, 593.554833874594, 594.298727501548, 595.4135176850798, 12938.094333396666, 12972.675683107904, 12979.286139262336, 12997.675058123528, 13021.739565208643, 12710.42803073864, 13122.212667239995, 13127.540536081191, 13171.802422963663, 13554.93222533891, 10095.596176152945, 10199.133073688745, 10234.6417875374, 10457.32027418223, 10473.63342283024, 3247.3018301065385, 3280.1799550112473, 3306.156929982863, 3329.7336213102894, 3354.4465163248033, 59632.0, 60725.0, 61184.69407652933, 61683.0, 62413.0, 9764.316497845224, 9999.900001000042, 10007.0, 10144.340617859816, 10180.694579162637, 16179.514614561582, 16921.0, 20010.399688009384, 20080.69878951817, 20242.493937651678, 7085.50401471892, 7107.680154393065, 7197.78406647791, 7339.7064117435775, 7346.265373462717, 3607.4228123500116, 3734.7945862977253, 3779.2063666629765, 3818.2363527294096, 3897.279003384383, 2961.600183975179, 3046.055722725962, 3076.6923307669504, 3080.060581522612, 3086.1975886269283, 510.95656869165794, 527.074983404131, 528.7329898401283, 531.7848715684719, 541.3152362261742, 499.71016810249967, 568.8464114689011, 601.6841158391792, 619.8574327904607, 625.6590158363703, 7325.633718314063, 7503.5988782458135, 7659.885101723478, 7813.257740514642, 8005.439619226599, 524.7428759907618, 607.7872744539376, 614.2107392001257, 618.3414663383483, 637.3976592120401, 3494.006503951657, 3651.6896063834342, 3710.870119545803, 3749.343864823645, 3778.1499162688724, 93306.0, 99313.50343248238, 100923.0, 105249.47375263227, 106053.0, 65382.34617653858, 71665.64167179131, 75875.62062189654, 85623.0, 87365.12634873697, 67123.66438167778, 67645.0, 68811.65594171998, 69170.0, 70440.94338584926, 8142.267195952392, 8723.956380218058, 8850.424722393023, 8957.910420895969, 9020.819583608421, 42430.0, 43856.0, 44194.0, 44681.0, 45660.77169614131, 56177.157342639075, 56391.43608563862, 59848.40151598428, 60777.69611151916, 63701.681491592244, 10883.727906802393, 11326.943365283121, 11385.772284554429, 11488.36813975206, 11555.133364997491, 12734.363281835685, 12974.870251297743, 13044.478220871059, 13332.133411328232, 13545.86454135446, 11762.882371176178, 11916.582919597773, 11916.642500724993, 12535.749285014432, 12662.493500259887, 11532.423378831192, 11708.297502149899, 12054.638360849189, 12160.209586376857, 12361.381930903239, 11003.119750420108, 11606.187566870576, 11819.231749936227, 11867.58463453775, 12150.878491215328, 9509.286803489627, 9826.508674566387, 10008.749781255527, 10216.0, 10533.683989480327, 9559.474228917476, 10042.748931276485, 10360.533775979948, 10470.947645261725, 10478.685639430829], "value": 6524.184007771912, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1597.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 113.0, 116.0, 115.0, 116.0, 121.0, 116.0, 115.0, 116.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 122.0, 151.0, 194.0, 130.0, 152.0, 152.0, 126.0, 184.0, 125.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 171.0, 178.0, 165.0, 166.0, 162.0, 173.0, 162.0, 164.0], "value": 166.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 163.0, 76.0, 77.0, 76.0, 77.0, 174.0, 78.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 145.0, 87.0, 86.0, 87.0, 143.0, 87.0, 86.0, 140.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 121.0, 118.0, 117.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 147.0, 146.0, 147.0, 149.0, 149.0, 147.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 68.0, 64.0, 65.0, 67.0, 62.0, 64.0, 62.0, 67.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 66.0, 67.0, 65.0, 69.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 91.0, 87.0, 86.0, 82.0, 83.0, 90.0, 83.0, 83.0, 86.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 143.0, 155.0, 138.0, 145.0, 138.0, 136.0, 137.0, 165.0, 146.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 181.0, 184.0, 171.0, 171.0, 171.0, 171.0, 173.0, 172.0], "value": 174.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 69.0, 69.0, 69.0, 68.0, 73.0, 68.0, 68.0, 67.0], "value": 69.1, "unit": "score"}]}]} 19:38:07 INFO - Return code: 0 19:38:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:38:07 ERROR - # TBPL SUCCESS # 19:38:07 INFO - Running post-action listener: _resource_record_post_action 19:38:07 INFO - [mozharness: 2016-08-13 02:38:07.402502Z] Finished run-tests step (success) 19:38:07 INFO - Running post-run listener: _resource_record_post_run 19:38:07 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 7630848; Write bytes: 290398208; Read time: 912; Write time: 256388 19:38:07 INFO - TinderboxPrint: CPU usage
13.4% 19:38:07 INFO - TinderboxPrint: I/O read bytes / time
7,630,848 / 912 19:38:07 INFO - TinderboxPrint: I/O write bytes / time
290,398,208 / 256,388 19:38:07 INFO - TinderboxPrint: CPU idle
8,284.3 (86.6%) 19:38:07 INFO - TinderboxPrint: CPU user
1,221.4 (12.8%) 19:38:07 INFO - TinderboxPrint: Swap in / out
0 / 0 19:38:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 8192; Write bytes: 91713536; Read time: 36; Write time: 66488 19:38:07 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 5386240; Write bytes: 198684672; Read time: 712; Write time: 189900 19:38:08 INFO - Running post-run listener: _upload_blobber_files 19:38:08 INFO - Blob upload gear active. 19:38:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:38:08 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 19:38:08 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'] 19:38:08 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 19:38:08 INFO - (blobuploader) - INFO - Open directory for files ... 19:38:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:38:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:38:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:09 INFO - (blobuploader) - INFO - Done attempting. 19:38:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:38:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:38:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:10 INFO - (blobuploader) - INFO - Done attempting. 19:38:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:38:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:38:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:38:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:38:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:38:20 INFO - (blobuploader) - INFO - Done attempting. 19:38:20 INFO - (blobuploader) - INFO - Iteration through files over. 19:38:20 INFO - Return code: 0 19:38:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:38:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:38:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6c645b8d8740f0459914c6c558b493a14ac303ddefe1ae89c1edbec20ad07bc6f818f9a53fe895165d3e817419f049be279696420f1c46c4f010a03fd23eda06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1b69b7acf52280785bd4cd0d9b28e4ed52a406b323a6e3b0e4305196979f6f36e548efb0c112689efce613ae68cd64b72e8cfc09a174994ec3f71ebf7f1b911", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cacd48a5416e852e580e731b8b3b41a470c9c5eaf5a735ef89e44c4a69a2ba70f0b9ed9bc86bb8f3a38e6f02476a14c388f65a9e8fb8e646d3ea9f3cc71f88d1"} 19:38:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:38:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:38:20 INFO - Contents: 19:38:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6c645b8d8740f0459914c6c558b493a14ac303ddefe1ae89c1edbec20ad07bc6f818f9a53fe895165d3e817419f049be279696420f1c46c4f010a03fd23eda06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1b69b7acf52280785bd4cd0d9b28e4ed52a406b323a6e3b0e4305196979f6f36e548efb0c112689efce613ae68cd64b72e8cfc09a174994ec3f71ebf7f1b911", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cacd48a5416e852e580e731b8b3b41a470c9c5eaf5a735ef89e44c4a69a2ba70f0b9ed9bc86bb8f3a38e6f02476a14c388f65a9e8fb8e646d3ea9f3cc71f88d1"} 19:38:20 INFO - Running post-run listener: copy_logs_to_upload_dir 19:38:20 INFO - Copying logs to upload dir... 19:38:20 INFO - mkdir: /builds/slave/test/build/upload/logs 19:38:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.442527 ========= master_lag: 0.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-08-12 19:38:20.913433) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 19:38:20.916760) ========= 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=62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607 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/6c645b8d8740f0459914c6c558b493a14ac303ddefe1ae89c1edbec20ad07bc6f818f9a53fe895165d3e817419f049be279696420f1c46c4f010a03fd23eda06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1b69b7acf52280785bd4cd0d9b28e4ed52a406b323a6e3b0e4305196979f6f36e548efb0c112689efce613ae68cd64b72e8cfc09a174994ec3f71ebf7f1b911", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cacd48a5416e852e580e731b8b3b41a470c9c5eaf5a735ef89e44c4a69a2ba70f0b9ed9bc86bb8f3a38e6f02476a14c388f65a9e8fb8e646d3ea9f3cc71f88d1"} build_url:https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/Vu4CINCrRt60Rdz_xbO96Q/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/6c645b8d8740f0459914c6c558b493a14ac303ddefe1ae89c1edbec20ad07bc6f818f9a53fe895165d3e817419f049be279696420f1c46c4f010a03fd23eda06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1b69b7acf52280785bd4cd0d9b28e4ed52a406b323a6e3b0e4305196979f6f36e548efb0c112689efce613ae68cd64b72e8cfc09a174994ec3f71ebf7f1b911", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cacd48a5416e852e580e731b8b3b41a470c9c5eaf5a735ef89e44c4a69a2ba70f0b9ed9bc86bb8f3a38e6f02476a14c388f65a9e8fb8e646d3ea9f3cc71f88d1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 19:38:20.942042) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 19:38:20.942398) ========= 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=62c568580acbfdaac3eec7be000001dc-1471054382.422982-1258549607 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 19:38:21.029059) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 19:38:21.029434) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 19:38:21.029760) ========= ========= Total master_lag: 0.43 =========