builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1470886048.22 results: success (0) buildid: 20160810173002 builduid: 456109daf319450bb6fde18e8cb67c8c revision: c4a79e57209adab8f38ca9ea9da8317bf748235a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:28.217616) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:28.218138) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:28.218481) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:28.255487) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:28.255933) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-10 20:27: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.1M=0s 2016-08-10 20:27:28 (41.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126436 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:28.398353) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:28.398747) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017005 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:28.448530) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:28.448927) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c4a79e57209adab8f38ca9ea9da8317bf748235a --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 c4a79e57209adab8f38ca9ea9da8317bf748235a --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=a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-10 20:27:28,884 truncating revision to first 12 chars 2016-08-10 20:27:28,884 Setting DEBUG logging. 2016-08-10 20:27:28,884 attempt 1/10 2016-08-10 20:27:28,884 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c4a79e57209a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 20:27:29,186 unpacking tar archive at: fx-team-c4a79e57209a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.658281 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:29.121647) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:29.122042) ========= script_repo_revision: c4a79e57209adab8f38ca9ea9da8317bf748235a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:29.122526) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:29.122847) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 20:27:29.134849) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-10 20:27:29.135290) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:27:29 INFO - MultiFileLogger online at 20160810 20:27:29 in /builds/slave/test 20:27:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:27:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:27:29 INFO - {'append_to_log': False, 20:27:29 INFO - 'base_work_dir': '/builds/slave/test', 20:27:29 INFO - 'blob_upload_branch': 'Fx-Team', 20:27:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:27:29 INFO - 'branch': 'Fx-Team', 20:27:29 INFO - 'buildbot_json_path': 'buildprops.json', 20:27:29 INFO - 'config_files': ('talos/linux_config.py',), 20:27:29 INFO - 'default_actions': ('clobber', 20:27:29 INFO - 'read-buildbot-config', 20:27:29 INFO - 'download-and-extract', 20:27:29 INFO - 'populate-webroot', 20:27:29 INFO - 'create-virtualenv', 20:27:29 INFO - 'install', 20:27:29 INFO - 'run-tests'), 20:27:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:27:29 INFO - 'download_minidump_stackwalk': True, 20:27:29 INFO - 'download_symbols': 'ondemand', 20:27:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:27:29 INFO - 'tooltool.py': '/tools/tooltool.py', 20:27:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:27:29 INFO - '/tools/misc-python/virtualenv.py')}, 20:27:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:27:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:27:29 INFO - 'installer_path': 'installer.exe', 20:27:29 INFO - 'log_level': 'info', 20:27:29 INFO - 'log_name': 'talos', 20:27:29 INFO - 'log_to_console': True, 20:27:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:27:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:27:29 INFO - 'opt_config_files': (), 20:27:29 INFO - 'pip_index': False, 20:27:29 INFO - 'sps_profile': False, 20:27:29 INFO - 'sps_profile_interval': 0, 20:27:29 INFO - 'suite': 'dromaeojs-e10s', 20:27:29 INFO - 'system_bits': '32', 20:27:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:27:29 INFO - 'title': 'talos-linux64-ix-064', 20:27:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:27:29 INFO - 'use_talos_json': True, 20:27:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:27:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:27:29 INFO - 'work_dir': 'build'} 20:27:29 INFO - [mozharness: 2016-08-11 03:27:29.657483Z] Running clobber step. 20:27:29 INFO - Running pre-action listener: _resource_record_pre_action 20:27:29 INFO - Running main action method: clobber 20:27:29 INFO - rmtree: /builds/slave/test/build 20:27:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:27:30 INFO - Running post-action listener: _resource_record_post_action 20:27:30 INFO - [mozharness: 2016-08-11 03:27:30.618152Z] Finished clobber step (success) 20:27:30 INFO - [mozharness: 2016-08-11 03:27:30.618252Z] Running read-buildbot-config step. 20:27:30 INFO - Running pre-action listener: _resource_record_pre_action 20:27:30 INFO - Running main action method: read_buildbot_config 20:27:30 INFO - Using buildbot properties: 20:27:30 INFO - { 20:27:30 INFO - "project": "", 20:27:30 INFO - "product": "firefox", 20:27:30 INFO - "script_repo_revision": "production", 20:27:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:27:30 INFO - "repository": "", 20:27:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:27:30 INFO - "buildid": "20160810173002", 20:27:30 INFO - "pgo_build": "True", 20:27:30 INFO - "basedir": "/builds/slave/test", 20:27:30 INFO - "buildnumber": 1038, 20:27:30 INFO - "slavename": "talos-linux64-ix-064", 20:27:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:27:30 INFO - "platform": "ubuntu64_hw", 20:27:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:27:30 INFO - "branch": "fx-team", 20:27:30 INFO - "repo_path": "integration/fx-team", 20:27:30 INFO - "revision": "c4a79e57209adab8f38ca9ea9da8317bf748235a", 20:27:30 INFO - "stage_platform": "linux64-pgo", 20:27:30 INFO - "builduid": "456109daf319450bb6fde18e8cb67c8c", 20:27:30 INFO - "slavebuilddir": "test" 20:27:30 INFO - } 20:27:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:27:30 INFO - Running post-action listener: _resource_record_post_action 20:27:30 INFO - [mozharness: 2016-08-11 03:27:30.620690Z] Finished read-buildbot-config step (success) 20:27:30 INFO - [mozharness: 2016-08-11 03:27:30.620778Z] Running download-and-extract step. 20:27:30 INFO - Running pre-action listener: _resource_record_pre_action 20:27:30 INFO - Running main action method: download_and_extract 20:27:30 INFO - mkdir: /builds/slave/test/build/tests 20:27: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')]} 20:27:30 INFO - trying https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:27:30 INFO - Downloading https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:27:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:27:31 INFO - Downloaded 1361 bytes. 20:27:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:27:31 INFO - Using the following test package requirements: 20:27:31 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:27:31 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:27:31 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:27:31 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:31 INFO - u'jsshell-linux-x86_64.zip'], 20:27:31 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:27:31 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:27:31 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:27:31 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:27:31 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:27:31 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:27:31 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:27:31 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:27:31 INFO - trying https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:27:31 INFO - Downloading https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:27:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:27:32 INFO - Downloaded 21832512 bytes. 20:27:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:27:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:27:33 INFO - Return code: 0 20:27:33 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 20:27:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:27:33 INFO - trying https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:27:33 INFO - Downloading https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:27:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:27:34 INFO - Downloaded 21832512 bytes. 20:27:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:27:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:27:35 INFO - Return code: 0 20:27: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')]} 20:27:35 INFO - trying https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:27:35 INFO - Downloading https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:27:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:27:36 INFO - Downloaded 14413719 bytes. 20:27:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:27:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:27:36 INFO - Return code: 0 20:27:36 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')]} 20:27:36 INFO - trying https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:27:36 INFO - Downloading https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:27:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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 20:27:38 INFO - Downloaded 59338728 bytes. 20:27:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:27:38 INFO - mkdir: /builds/slave/test/properties 20:27:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:27:38 INFO - Writing to file /builds/slave/test/properties/build_url 20:27:38 INFO - Contents: 20:27:38 INFO - build_url:https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:27:38 INFO - Running post-action listener: _resource_record_post_action 20:27:38 INFO - Running post-action listener: set_extra_try_arguments 20:27:38 INFO - [mozharness: 2016-08-11 03:27:38.957118Z] Finished download-and-extract step (success) 20:27:38 INFO - [mozharness: 2016-08-11 03:27:38.957439Z] Running populate-webroot step. 20:27:38 INFO - Running pre-action listener: _resource_record_pre_action 20:27:38 INFO - Running main action method: populate_webroot 20:27:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:27:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:27:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:27:38 INFO - '--tppagecycles', 20:27:38 INFO - '7'], 20:27:38 INFO - 'tests': ['tsvgm']}}, 20:27:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:27:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:27:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:27:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:27:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:27:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:27:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:27:38 INFO - 'talos_options': ['--disable-e10s'], 20:27:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:27:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:27:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:27:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:27:38 INFO - 'talos_options': ['--disable-e10s'], 20:27:38 INFO - 'tests': ['damp', 'tps']}, 20:27:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:27:38 INFO - 'tests': ['damp', 'tps']}, 20:27:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:27:38 INFO - 'tests': ['dromaeo_dom']}, 20:27:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:27:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:27:38 INFO - 'tests': ['basic_compositor_video']}, 20:27:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:27:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:27:38 INFO - 'tests': ['a11yr', 20:27:38 INFO - 'ts_paint', 20:27:38 INFO - 'tpaint', 20:27:38 INFO - 'sessionrestore', 20:27:38 INFO - 'sessionrestore_no_auto_restore', 20:27:38 INFO - 'tabpaint']}, 20:27:38 INFO - 'other-e10s': {'tests': ['a11yr', 20:27:38 INFO - 'ts_paint', 20:27:38 INFO - 'tpaint', 20:27:38 INFO - 'sessionrestore', 20:27:38 INFO - 'sessionrestore_no_auto_restore', 20:27:38 INFO - 'tabpaint']}, 20:27:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:27:38 INFO - 'ts_paint', 20:27:38 INFO - 'tpaint', 20:27:38 INFO - 'sessionrestore', 20:27:38 INFO - 'sessionrestore_no_auto_restore', 20:27:38 INFO - 'tabpaint']}, 20:27:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:27:38 INFO - 'ts_paint', 20:27:38 INFO - 'tpaint', 20:27:38 INFO - 'sessionrestore', 20:27:38 INFO - 'sessionrestore_no_auto_restore', 20:27:38 INFO - 'tabpaint']}, 20:27:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:27:38 INFO - 'tests': ['a11yr', 20:27:38 INFO - 'ts_paint', 20:27:38 INFO - 'tpaint', 20:27:38 INFO - 'sessionrestore', 20:27:38 INFO - 'sessionrestore_no_auto_restore', 20:27:38 INFO - 'tabpaint']}, 20:27:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:27:38 INFO - 'tests': ['a11yr', 20:27:38 INFO - 'ts_paint', 20:27:38 INFO - 'tpaint', 20:27:38 INFO - 'sessionrestore', 20:27:38 INFO - 'sessionrestore_no_auto_restore', 20:27:38 INFO - 'tabpaint']}, 20:27:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:27:38 INFO - 'tests': ['tsvgx', 20:27:38 INFO - 'tsvgr_opacity', 20:27:38 INFO - 'tart', 20:27:38 INFO - 'tscrollx', 20:27:38 INFO - 'cart']}, 20:27:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:27:38 INFO - 'tsvgr_opacity', 20:27:38 INFO - 'tart', 20:27:38 INFO - 'tscrollx', 20:27:38 INFO - 'cart']}, 20:27:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:27:38 INFO - 'talos_options': ['--disable-e10s'], 20:27:38 INFO - 'tests': ['tp5o']}, 20:27:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:27:38 INFO - 'tests': ['tp5o']}, 20:27:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:27:38 INFO - 'talos_options': ['--disable-e10s', 20:27:38 INFO - '--xperf_path', 20:27:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:27:38 INFO - 'tests': ['tp5n']}, 20:27:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:27:38 INFO - 'talos_options': ['--xperf_path', 20:27:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:27:38 INFO - 'tests': ['tp5n']}}, 20:27:38 INFO - 'talos.zip': {'path': '', 20:27:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:27:38 INFO - Running post-action listener: _resource_record_post_action 20:27:38 INFO - [mozharness: 2016-08-11 03:27:38.978356Z] Finished populate-webroot step (success) 20:27:38 INFO - [mozharness: 2016-08-11 03:27:38.978445Z] Running create-virtualenv step. 20:27:38 INFO - Running pre-action listener: _resource_record_pre_action 20:27:38 INFO - Running main action method: create_virtualenv 20:27:38 INFO - Creating virtualenv /builds/slave/test/build/venv 20:27:38 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 20:27:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:27:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:27:39 INFO - Using real prefix '/usr' 20:27:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:27:39 INFO - Installing distribute.............................................................................................................................................................................................done. 20:27:41 INFO - Installing pip.................done. 20:27:41 INFO - Return code: 0 20:27:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:27: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')]} 20:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27: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')]} 20:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:41 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 0xe79030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11383b0>, '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 0x11392b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1139740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', '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 20:27:41 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 20:27:41 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 20:27:41 INFO - Using env: {'DISPLAY': ':0', 20:27:41 INFO - 'HOME': '/home/cltbld', 20:27:41 INFO - 'LANG': 'en_US.UTF-8', 20:27:41 INFO - 'LANGUAGE': 'en_US:en', 20:27:41 INFO - 'LOGNAME': 'cltbld', 20:27:41 INFO - 'MAIL': '/var/mail/cltbld', 20:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:27:41 INFO - 'MOZ_NO_REMOTE': '1', 20:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:27:41 INFO - 'NO_EM_RESTART': '1', 20:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:27:41 INFO - 'PWD': '/builds/slave/test', 20:27:41 INFO - 'SHELL': '/bin/bash', 20:27:41 INFO - 'SHLVL': '1', 20:27:41 INFO - 'TERM': 'linux', 20:27:41 INFO - 'TMOUT': '86400', 20:27:41 INFO - 'USER': 'cltbld', 20:27:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', 20:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:27:41 INFO - '_': '/tools/buildbot/bin/python'} 20:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:27:41 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 20:27:41 INFO - Cleaning up... 20:27:41 INFO - Return code: 0 20:27:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:27: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')]} 20:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27: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')]} 20:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:41 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 0xe79030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11383b0>, '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 0x11392b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1139740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', '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 20:27:41 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 20:27:41 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 20:27:41 INFO - Using env: {'DISPLAY': ':0', 20:27:41 INFO - 'HOME': '/home/cltbld', 20:27:41 INFO - 'LANG': 'en_US.UTF-8', 20:27:41 INFO - 'LANGUAGE': 'en_US:en', 20:27:41 INFO - 'LOGNAME': 'cltbld', 20:27:41 INFO - 'MAIL': '/var/mail/cltbld', 20:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:27:41 INFO - 'MOZ_NO_REMOTE': '1', 20:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:27:41 INFO - 'NO_EM_RESTART': '1', 20:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:27:41 INFO - 'PWD': '/builds/slave/test', 20:27:41 INFO - 'SHELL': '/bin/bash', 20:27:41 INFO - 'SHLVL': '1', 20:27:41 INFO - 'TERM': 'linux', 20:27:41 INFO - 'TMOUT': '86400', 20:27:41 INFO - 'USER': 'cltbld', 20:27:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', 20:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:27:41 INFO - '_': '/tools/buildbot/bin/python'} 20:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:27:41 INFO - Downloading/unpacking psutil>=3.1.1 20:27:41 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 20:27:41 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 20:27:41 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 20:27:41 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 20:27:41 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 20:27:41 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 20:27:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:27:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:27:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:27:43 INFO - Installing collected packages: psutil 20:27:43 INFO - Running setup.py install for psutil 20:27:44 INFO - building 'psutil._psutil_linux' extension 20:27:44 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 20:27:44 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 20:27:44 INFO - building 'psutil._psutil_posix' extension 20:27:44 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 20:27:44 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 20:27:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:27:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:27:44 INFO - Successfully installed psutil 20:27:44 INFO - Cleaning up... 20:27:44 INFO - Return code: 0 20:27:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:27:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:27:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:27:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:27:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:44 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 0xe79030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11383b0>, '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 0x11392b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1139740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', '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 20:27:44 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 20:27:44 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 20:27:44 INFO - Using env: {'DISPLAY': ':0', 20:27:44 INFO - 'HOME': '/home/cltbld', 20:27:44 INFO - 'LANG': 'en_US.UTF-8', 20:27:44 INFO - 'LANGUAGE': 'en_US:en', 20:27:44 INFO - 'LOGNAME': 'cltbld', 20:27:44 INFO - 'MAIL': '/var/mail/cltbld', 20:27:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:27:44 INFO - 'MOZ_NO_REMOTE': '1', 20:27:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:27:44 INFO - 'NO_EM_RESTART': '1', 20:27:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:27:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:27:44 INFO - 'PWD': '/builds/slave/test', 20:27:44 INFO - 'SHELL': '/bin/bash', 20:27:44 INFO - 'SHLVL': '1', 20:27:44 INFO - 'TERM': 'linux', 20:27:44 INFO - 'TMOUT': '86400', 20:27:44 INFO - 'USER': 'cltbld', 20:27:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', 20:27:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:27:44 INFO - '_': '/tools/buildbot/bin/python'} 20:27:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:27:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:27:44 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 20:27:44 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 20:27:44 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 20:27:44 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 20:27:44 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 20:27:44 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 20:27:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:27:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:27:46 INFO - Installing collected packages: mozsystemmonitor 20:27:46 INFO - Running setup.py install for mozsystemmonitor 20:27:46 INFO - Successfully installed mozsystemmonitor 20:27:46 INFO - Cleaning up... 20:27:47 INFO - Return code: 0 20:27:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:27: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')]} 20:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:27:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27: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')]} 20:27:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:27:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27: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', '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 0xe79030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11383b0>, '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 0x11392b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1139740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', '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 20:27: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:27: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 jsonschema==2.5.1 20:27:47 INFO - Using env: {'DISPLAY': ':0', 20:27:47 INFO - 'HOME': '/home/cltbld', 20:27:47 INFO - 'LANG': 'en_US.UTF-8', 20:27:47 INFO - 'LANGUAGE': 'en_US:en', 20:27:47 INFO - 'LOGNAME': 'cltbld', 20:27:47 INFO - 'MAIL': '/var/mail/cltbld', 20:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:27:47 INFO - 'MOZ_NO_REMOTE': '1', 20:27:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:27:47 INFO - 'NO_EM_RESTART': '1', 20:27:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:27:47 INFO - 'PWD': '/builds/slave/test', 20:27:47 INFO - 'SHELL': '/bin/bash', 20:27:47 INFO - 'SHLVL': '1', 20:27:47 INFO - 'TERM': 'linux', 20:27:47 INFO - 'TMOUT': '86400', 20:27:47 INFO - 'USER': 'cltbld', 20:27:47 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', 20:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:27:47 INFO - '_': '/tools/buildbot/bin/python'} 20:27:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:27:47 INFO - Downloading/unpacking jsonschema==2.5.1 20:27:47 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 20:27:47 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 20:27:47 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 20:27:47 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 20:27:47 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 20:27:47 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 20:27:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:27:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:27:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:27:49 INFO - Downloading functools32-3.2.3-2.tar.gz 20:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:27:49 INFO - warning: no files found matching '*.txt' 20:27:49 INFO - no previously-included directories found matching 'build' 20:27:49 INFO - no previously-included directories found matching 'dist' 20:27:49 INFO - no previously-included directories found matching '.git*' 20:27:49 INFO - Installing collected packages: jsonschema, functools32 20:27:49 INFO - Running setup.py install for functools32 20:27:49 INFO - warning: no files found matching '*.txt' 20:27:49 INFO - no previously-included directories found matching 'build' 20:27:49 INFO - no previously-included directories found matching 'dist' 20:27:49 INFO - no previously-included directories found matching '.git*' 20:27:49 INFO - Successfully installed jsonschema functools32 20:27:49 INFO - Cleaning up... 20:27:49 INFO - Return code: 0 20:27:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:27:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:27:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe79030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11383b0>, '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 0x11392b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1139740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', '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 20:27:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:27:49 INFO - Using env: {'DISPLAY': ':0', 20:27:49 INFO - 'HOME': '/home/cltbld', 20:27:49 INFO - 'LANG': 'en_US.UTF-8', 20:27:49 INFO - 'LANGUAGE': 'en_US:en', 20:27:49 INFO - 'LOGNAME': 'cltbld', 20:27:49 INFO - 'MAIL': '/var/mail/cltbld', 20:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:27:49 INFO - 'MOZ_NO_REMOTE': '1', 20:27:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:27:49 INFO - 'NO_EM_RESTART': '1', 20:27:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:27:49 INFO - 'PWD': '/builds/slave/test', 20:27:49 INFO - 'SHELL': '/bin/bash', 20:27:49 INFO - 'SHLVL': '1', 20:27:49 INFO - 'TERM': 'linux', 20:27:49 INFO - 'TMOUT': '86400', 20:27:49 INFO - 'USER': 'cltbld', 20:27:49 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', 20:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:27:49 INFO - '_': '/tools/buildbot/bin/python'} 20:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:27:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:27:49 INFO - Cleaning up... 20:27:49 INFO - Return code: 0 20:27:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:27:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:27:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe79030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11383b0>, '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 0x11392b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1139740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', '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 20:27:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:27:49 INFO - Using env: {'DISPLAY': ':0', 20:27:49 INFO - 'HOME': '/home/cltbld', 20:27:49 INFO - 'LANG': 'en_US.UTF-8', 20:27:49 INFO - 'LANGUAGE': 'en_US:en', 20:27:49 INFO - 'LOGNAME': 'cltbld', 20:27:49 INFO - 'MAIL': '/var/mail/cltbld', 20:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:27:49 INFO - 'MOZ_NO_REMOTE': '1', 20:27:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:27:49 INFO - 'NO_EM_RESTART': '1', 20:27:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:27:49 INFO - 'PWD': '/builds/slave/test', 20:27:49 INFO - 'SHELL': '/bin/bash', 20:27:49 INFO - 'SHLVL': '1', 20:27:49 INFO - 'TERM': 'linux', 20:27:49 INFO - 'TMOUT': '86400', 20:27:49 INFO - 'USER': 'cltbld', 20:27:49 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', 20:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:27:49 INFO - '_': '/tools/buildbot/bin/python'} 20:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:27:50 INFO - Downloading/unpacking blobuploader==1.2.4 20:27:50 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 20:27:50 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 20:27:50 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 20:27:50 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 20:27:50 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 20:27:50 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 20:27:51 INFO - Downloading blobuploader-1.2.4.tar.gz 20:27:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:27:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:27:51 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 20:27:51 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 20:27:51 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 20:27:51 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 20:27:51 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 20:27:51 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 20:27:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:27:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:27: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 20:27: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 20:27: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 20:27: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 20:27: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 20:27: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 20:27:52 INFO - Downloading docopt-0.6.1.tar.gz 20:27:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:27:52 INFO - Installing collected packages: blobuploader, requests, docopt 20:27:52 INFO - Running setup.py install for blobuploader 20:27:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:27:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:27:52 INFO - Running setup.py install for requests 20:27:53 INFO - Running setup.py install for docopt 20:27:53 INFO - Successfully installed blobuploader requests docopt 20:27:53 INFO - Cleaning up... 20:27:53 INFO - Return code: 0 20:27:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:53 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 0xe79030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11383b0>, '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 0x11392b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1139740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', '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 20:27:53 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 20:27:53 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 20:27:53 INFO - Using env: {'DISPLAY': ':0', 20:27:53 INFO - 'HOME': '/home/cltbld', 20:27:53 INFO - 'LANG': 'en_US.UTF-8', 20:27:53 INFO - 'LANGUAGE': 'en_US:en', 20:27:53 INFO - 'LOGNAME': 'cltbld', 20:27:53 INFO - 'MAIL': '/var/mail/cltbld', 20:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:27:53 INFO - 'MOZ_NO_REMOTE': '1', 20:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:27:53 INFO - 'NO_EM_RESTART': '1', 20:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:27:53 INFO - 'PWD': '/builds/slave/test', 20:27:53 INFO - 'SHELL': '/bin/bash', 20:27:53 INFO - 'SHLVL': '1', 20:27:53 INFO - 'TERM': 'linux', 20:27:53 INFO - 'TMOUT': '86400', 20:27:53 INFO - 'USER': 'cltbld', 20:27:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', 20:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:27:53 INFO - '_': '/tools/buildbot/bin/python'} 20:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:27:53 INFO - Running setup.py (path:/tmp/pip-g6z32X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:27:53 INFO - Running setup.py (path:/tmp/pip-zJOuLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:27:53 INFO - Running setup.py (path:/tmp/pip-TBjAnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:27:53 INFO - Running setup.py (path:/tmp/pip-VPwEE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:27:53 INFO - Running setup.py (path:/tmp/pip-nPTkqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:27:53 INFO - Running setup.py (path:/tmp/pip-7YOpbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:27:53 INFO - Running setup.py (path:/tmp/pip-iUOitu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:27:54 INFO - Running setup.py (path:/tmp/pip-2vmAv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:27:54 INFO - Running setup.py (path:/tmp/pip-6kjr99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:27:54 INFO - Running setup.py (path:/tmp/pip-RKYmZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:27:54 INFO - Running setup.py (path:/tmp/pip-BeAAsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:27:54 INFO - Running setup.py (path:/tmp/pip-JqGNlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:27:54 INFO - Running setup.py (path:/tmp/pip-DGrP3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:27:54 INFO - Running setup.py (path:/tmp/pip-5qNZQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:27:54 INFO - Running setup.py (path:/tmp/pip-Yd10gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:27:54 INFO - Running setup.py (path:/tmp/pip-O3mcyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:27:54 INFO - Running setup.py (path:/tmp/pip-Tts_46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:27:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:27:54 INFO - Running setup.py install for manifestparser 20:27:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:27:54 INFO - Running setup.py install for mozcrash 20:27:54 INFO - Running setup.py install for mozdebug 20:27:55 INFO - Running setup.py install for mozdevice 20:27:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:27:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:27:55 INFO - Running setup.py install for mozfile 20:27:55 INFO - Running setup.py install for mozhttpd 20:27:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:27:55 INFO - Running setup.py install for mozinfo 20:27:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:27:55 INFO - Running setup.py install for mozInstall 20:27:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:27:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:27:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:27:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:27:55 INFO - Running setup.py install for mozleak 20:27:55 INFO - Running setup.py install for mozlog 20:27:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:27:55 INFO - Running setup.py install for moznetwork 20:27:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:27:55 INFO - Running setup.py install for mozprocess 20:27:55 INFO - Running setup.py install for mozprofile 20:27:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:27:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:27:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:27:56 INFO - Running setup.py install for mozrunner 20:27:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:27:56 INFO - Running setup.py install for mozscreenshot 20:27:56 INFO - Running setup.py install for moztest 20:27:56 INFO - Running setup.py install for mozversion 20:27:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:27:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:27:56 INFO - Cleaning up... 20:27:56 INFO - Return code: 0 20:27:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:27: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')]} 20:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27: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')]} 20:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:27:56 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 0xe79030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11383b0>, '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 0x11392b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1139740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', '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 20:27:56 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 20:27:56 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 20:27:56 INFO - Using env: {'DISPLAY': ':0', 20:27:56 INFO - 'HOME': '/home/cltbld', 20:27:56 INFO - 'LANG': 'en_US.UTF-8', 20:27:56 INFO - 'LANGUAGE': 'en_US:en', 20:27:56 INFO - 'LOGNAME': 'cltbld', 20:27:56 INFO - 'MAIL': '/var/mail/cltbld', 20:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:27:56 INFO - 'MOZ_NO_REMOTE': '1', 20:27:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:27:56 INFO - 'NO_EM_RESTART': '1', 20:27:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:27:56 INFO - 'PWD': '/builds/slave/test', 20:27:56 INFO - 'SHELL': '/bin/bash', 20:27:56 INFO - 'SHLVL': '1', 20:27:56 INFO - 'TERM': 'linux', 20:27:56 INFO - 'TMOUT': '86400', 20:27:56 INFO - 'USER': 'cltbld', 20:27:56 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', 20:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:27:56 INFO - '_': '/tools/buildbot/bin/python'} 20:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:27:56 INFO - Running setup.py (path:/tmp/pip-cW1Z1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:27:56 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)) 20:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:27:56 INFO - Running setup.py (path:/tmp/pip-n4fPBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:27:56 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)) 20:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:27:56 INFO - Running setup.py (path:/tmp/pip-D2S8EA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:27:56 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)) 20:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:27:56 INFO - Running setup.py (path:/tmp/pip-Qq6sOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:27:57 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)) 20:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:27:57 INFO - Running setup.py (path:/tmp/pip-jYTM8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:27:57 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)) 20:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:27:57 INFO - Running setup.py (path:/tmp/pip-ZWdftr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:27:57 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)) 20:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:27:57 INFO - Running setup.py (path:/tmp/pip-Xm2ZrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:27:57 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)) 20:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:27:57 INFO - Running setup.py (path:/tmp/pip-BzDkiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:27:57 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)) 20:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:27:57 INFO - Running setup.py (path:/tmp/pip-CtX3jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:27:57 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)) 20:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:27:57 INFO - Running setup.py (path:/tmp/pip-GUUShu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:27:57 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)) 20:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:27:57 INFO - Running setup.py (path:/tmp/pip-hggLXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:27:57 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)) 20:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:27:57 INFO - Running setup.py (path:/tmp/pip-WE7kY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:27:57 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)) 20:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:27:57 INFO - Running setup.py (path:/tmp/pip-stLcAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:27:57 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)) 20:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:27:57 INFO - Running setup.py (path:/tmp/pip-Xw5eaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:27:57 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)) 20:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:27:57 INFO - Running setup.py (path:/tmp/pip-39poL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:27:57 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)) 20:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:27:57 INFO - Running setup.py (path:/tmp/pip-4fKnWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:27:57 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)) 20:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:27:57 INFO - Running setup.py (path:/tmp/pip-q3_mHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:27:58 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)) 20:27:58 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)) 20:27:58 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)) 20:27:58 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)) 20:27:58 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)) 20:27:58 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)) 20:27:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:27:58 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 20:27:58 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 20:27:58 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 20:27:58 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 20:27:58 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 20:27:58 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 20:27:59 INFO - Downloading blessings-1.6.tar.gz 20:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:27:59 INFO - Installing collected packages: blessings 20:27:59 INFO - Running setup.py install for blessings 20:28:00 INFO - Successfully installed blessings 20:28:00 INFO - Cleaning up... 20:28:00 INFO - Return code: 0 20:28:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:28:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:28:00 INFO - Reading from file tmpfile_stdout 20:28:00 INFO - Current package versions: 20:28:00 INFO - argparse == 1.2.1 20:28:00 INFO - blessings == 1.6 20:28:00 INFO - blobuploader == 1.2.4 20:28:00 INFO - docopt == 0.6.1 20:28:00 INFO - functools32 == 3.2.3-2 20:28:00 INFO - jsonschema == 2.5.1 20:28:00 INFO - manifestparser == 1.1 20:28:00 INFO - mozInstall == 1.12 20:28:00 INFO - mozcrash == 0.17 20:28:00 INFO - mozdebug == 0.1 20:28:00 INFO - mozdevice == 0.48 20:28:00 INFO - mozfile == 1.2 20:28:00 INFO - mozhttpd == 0.7 20:28:00 INFO - mozinfo == 0.9 20:28:00 INFO - mozleak == 0.1 20:28:00 INFO - mozlog == 3.3 20:28:00 INFO - moznetwork == 0.27 20:28:00 INFO - mozprocess == 0.23 20:28:00 INFO - mozprofile == 0.28 20:28:00 INFO - mozrunner == 6.12 20:28:00 INFO - mozscreenshot == 0.1 20:28:00 INFO - mozsystemmonitor == 0.3 20:28:00 INFO - moztest == 0.7 20:28:00 INFO - mozversion == 1.4 20:28:00 INFO - psutil == 3.1.1 20:28:00 INFO - requests == 1.2.3 20:28:00 INFO - wsgiref == 0.1.2 20:28:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:28: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')]} 20:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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')]} 20:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:00 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 0xe79030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11383b0>, '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 0x11392b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1139740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', '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 20:28:00 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 20:28:00 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 20:28:00 INFO - Using env: {'DISPLAY': ':0', 20:28:00 INFO - 'HOME': '/home/cltbld', 20:28:00 INFO - 'LANG': 'en_US.UTF-8', 20:28:00 INFO - 'LANGUAGE': 'en_US:en', 20:28:00 INFO - 'LOGNAME': 'cltbld', 20:28:00 INFO - 'MAIL': '/var/mail/cltbld', 20:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:00 INFO - 'MOZ_NO_REMOTE': '1', 20:28:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:00 INFO - 'NO_EM_RESTART': '1', 20:28:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:00 INFO - 'PWD': '/builds/slave/test', 20:28:00 INFO - 'SHELL': '/bin/bash', 20:28:00 INFO - 'SHLVL': '1', 20:28:00 INFO - 'TERM': 'linux', 20:28:00 INFO - 'TMOUT': '86400', 20:28:00 INFO - 'USER': 'cltbld', 20:28:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', 20:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:00 INFO - '_': '/tools/buildbot/bin/python'} 20:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:00 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)) 20:28:00 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)) 20:28:00 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)) 20:28:00 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)) 20:28:00 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)) 20:28:00 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)) 20:28:00 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)) 20:28:00 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)) 20:28:00 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)) 20:28:00 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)) 20:28:00 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)) 20:28:00 INFO - Cleaning up... 20:28:00 INFO - Return code: 0 20:28:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:28: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')]} 20:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28: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')]} 20:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:28:00 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 0xe79030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11383b0>, '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 0x11392b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1139740>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', '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 20:28:00 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 20:28:00 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 20:28:00 INFO - Using env: {'DISPLAY': ':0', 20:28:00 INFO - 'HOME': '/home/cltbld', 20:28:00 INFO - 'LANG': 'en_US.UTF-8', 20:28:00 INFO - 'LANGUAGE': 'en_US:en', 20:28:00 INFO - 'LOGNAME': 'cltbld', 20:28:00 INFO - 'MAIL': '/var/mail/cltbld', 20:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:00 INFO - 'MOZ_NO_REMOTE': '1', 20:28:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:00 INFO - 'NO_EM_RESTART': '1', 20:28:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:00 INFO - 'PWD': '/builds/slave/test', 20:28:00 INFO - 'SHELL': '/bin/bash', 20:28:00 INFO - 'SHLVL': '1', 20:28:00 INFO - 'TERM': 'linux', 20:28:00 INFO - 'TMOUT': '86400', 20:28:00 INFO - 'USER': 'cltbld', 20:28:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', 20:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:00 INFO - '_': '/tools/buildbot/bin/python'} 20:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:28:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:28:00 INFO - Cleaning up... 20:28:00 INFO - Return code: 0 20:28:00 INFO - Running post-action listener: _resource_record_post_action 20:28:00 INFO - Running post-action listener: _start_resource_monitoring 20:28:00 INFO - Starting resource monitoring. 20:28:00 INFO - [mozharness: 2016-08-11 03:28:00.820849Z] Finished create-virtualenv step (success) 20:28:00 INFO - [mozharness: 2016-08-11 03:28:00.821290Z] Running install step. 20:28:00 INFO - Running pre-action listener: _resource_record_pre_action 20:28:00 INFO - Running main action method: install 20:28:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:28:01 INFO - Reading from file tmpfile_stdout 20:28:01 INFO - Detecting whether we're running mozinstall >=1.0... 20:28:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:28:01 INFO - Reading from file tmpfile_stdout 20:28:01 INFO - Output received: 20:28:01 INFO - Usage: mozinstall [options] installer 20:28:01 INFO - Options: 20:28:01 INFO - -h, --help show this help message and exit 20:28:01 INFO - -d DEST, --destination=DEST 20:28:01 INFO - Directory to install application into. [default: 20:28:01 INFO - "/builds/slave/test"] 20:28:01 INFO - --app=APP Application being installed. [default: firefox] 20:28:01 INFO - mkdir: /builds/slave/test/build/application 20:28:01 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'] 20:28:01 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 20:28:18 INFO - Reading from file tmpfile_stdout 20:28:18 INFO - Output received: 20:28:18 INFO - /builds/slave/test/build/application/firefox/firefox 20:28:18 INFO - Running post-action listener: _resource_record_post_action 20:28:18 INFO - [mozharness: 2016-08-11 03:28:18.023119Z] Finished install step (success) 20:28:18 INFO - [mozharness: 2016-08-11 03:28:18.023367Z] Running run-tests step. 20:28:18 INFO - Running pre-action listener: _resource_record_pre_action 20:28:18 INFO - Running main action method: run_tests 20:28:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:28:18 INFO - Python 2.7.3 20:28:18 INFO - Return code: 0 20:28:18 INFO - grabbing minidump binary from tooltool 20:28:18 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')]} 20:28:18 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 0x11383b0>, '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 0x11392b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1139740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:28:18 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 20:28:18 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 20:28:18 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 20:28:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:28:18 INFO - Return code: 0 20:28:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:28:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:28:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:28:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:28:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:28:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 20:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 20:28:18 INFO - Using env: {'DISPLAY': ':0', 20:28:18 INFO - 'HOME': '/home/cltbld', 20:28:18 INFO - 'LANG': 'en_US.UTF-8', 20:28:18 INFO - 'LANGUAGE': 'en_US:en', 20:28:18 INFO - 'LOGNAME': 'cltbld', 20:28:18 INFO - 'MAIL': '/var/mail/cltbld', 20:28:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:28:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:28:18 INFO - 'MOZ_NO_REMOTE': '1', 20:28:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:28:18 INFO - 'NO_EM_RESTART': '1', 20:28:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:28:18 INFO - 'PWD': '/builds/slave/test', 20:28:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:28:18 INFO - 'SHELL': '/bin/bash', 20:28:18 INFO - 'SHLVL': '1', 20:28:18 INFO - 'TERM': 'linux', 20:28:18 INFO - 'TMOUT': '86400', 20:28:18 INFO - 'USER': 'cltbld', 20:28:18 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022', 20:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:28:18 INFO - '_': '/tools/buildbot/bin/python'} 20:28:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 20:28:18 INFO - mozversion application_buildid: 20160810173002 20:28:18 INFO - mozversion application_changeset: c4a79e57209adab8f38ca9ea9da8317bf748235a 20:28:18 INFO - mozversion application_display_name: Nightly 20:28:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:28:18 INFO - mozversion application_name: Firefox 20:28:18 INFO - mozversion application_remotingname: firefox 20:28:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:28:18 INFO - mozversion application_vendor: Mozilla 20:28:18 INFO - mozversion application_version: 51.0a1 20:28:18 INFO - mozversion platform_buildid: 20160810173002 20:28:18 INFO - mozversion platform_changeset: c4a79e57209adab8f38ca9ea9da8317bf748235a 20:28:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:28:18 INFO - mozversion platform_version: 51.0a1 20:28:18 INFO - using testdate: 1470886098 20:28:18 INFO - actual date: 1470886098 20:28:18 INFO - starting webserver on 'localhost:51291' 20:28:18 INFO - SUITE-START | Running 2 tests 20:28:18 INFO - TEST-START | dromaeo_css 20:28:18 INFO - operating with platform_type : linux_ 20:28:18 INFO - Initialising browser for dromaeo_css test... 20:28:18 INFO - TEST-INFO | started process 14017 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppjq5kZ/profile http://localhost:51291/getInfo.html) 20:28:23 INFO - PROCESS | 14017 | __metrics Screen width/height:1600/1200 20:28:23 INFO - PROCESS | 14017 | colorDepth:24 20:28:23 INFO - PROCESS | 14017 | Browser inner width/height: 1024/697 20:28:23 INFO - PROCESS | 14017 | __metrics 20:28:24 ERROR - PROCESS | 14017 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 20:28:25 INFO - TEST-INFO | 14017: exit 0 20:28:25 INFO - Browser initialized. 20:28:25 INFO - Running cycle 1/1 for dromaeo_css test... 20:28:25 INFO - TEST-INFO | started process 14135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppjq5kZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:28:36 INFO - PROCESS | 14135 | RSS: Main: 162721792 20:28:36 INFO - PROCESS | 14135 | 20:29:26 INFO - PROCESS | 14135 | 1470886166522 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] 20:31:35 INFO - PROCESS | 14135 | Cycle 1(1): loaded http://localhost:51291/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51291/tests/dromaeo/cssquery-ext.html) 20:31:37 INFO - PROCESS | 14135 | RSS: Main: 167313408 20:31:37 INFO - PROCESS | 14135 | 20:34:39 INFO - PROCESS | 14135 | Cycle 1(1): loaded http://localhost:51291/tests/dromaeo/cssquery-ext.html (next: http://localhost:51291/tests/dromaeo/cssquery-jquery.html) 20:34:39 INFO - PROCESS | 14135 | RSS: Main: 165650432 20:34:39 INFO - PROCESS | 14135 | 20:37:41 INFO - PROCESS | 14135 | Cycle 1(1): loaded http://localhost:51291/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51291/tests/dromaeo/cssquery-mootools.html) 20:37:42 INFO - PROCESS | 14135 | RSS: Main: 168820736 20:37:42 INFO - PROCESS | 14135 | 20:40:44 INFO - PROCESS | 14135 | Cycle 1(1): loaded http://localhost:51291/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51291/tests/dromaeo/cssquery-prototype.html) 20:40:44 INFO - PROCESS | 14135 | RSS: Main: 163381248 20:40:44 INFO - PROCESS | 14135 | 20:43:47 INFO - PROCESS | 14135 | Cycle 1(1): loaded http://localhost:51291/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51291/tests/dromaeo/cssquery-yui.html) 20:43:48 INFO - PROCESS | 14135 | RSS: Main: 165302272 20:43:48 INFO - PROCESS | 14135 | 20:46:51 INFO - PROCESS | 14135 | Cycle 1(1): loaded http://localhost:51291/tests/dromaeo/cssquery-yui.html (next: http://localhost:51291/tests/dromaeo/cssquery-dojo.html) 20:46:51 INFO - PROCESS | 14135 | RSS: Main: 168759296 20:46:51 INFO - PROCESS | 14135 | 20:46:51 INFO - PROCESS | 14135 | __start_tp_report 20:46:51 INFO - PROCESS | 14135 | _x_x_mozilla_page_load 20:46:51 INFO - PROCESS | 14135 | _x_x_mozilla_page_load_details 20:46:51 INFO - PROCESS | 14135 | |i|pagename|runs| 20:46:51 INFO - PROCESS | 14135 | |0;dojo.html;3059.83170925599;3061.066374755699;3073.277779721765;3086.6758990306016;3097.225693576606;5377.784888604451;5426.375966763823;5489.945100548994;5510.614257002011;5533.197686335479;5398.433164517728;5437.401885792559;5450.700211488376;5454.209139674755;5484.698341591221;4930.383702037246;5010.173321401964;5010.198368261079;5097.541221290083;5184.585233181355;5037.924431133536;5050.671706339076;5084.745762711868;5130.640855140142;5137.383513978328;4904.509549045102;4941.604671626261;4948.1093403187415;4985.202367621199;5028.044671512437;4950.925736113925;4963.354763880709;4972.701637901738;4994.900101997976;5005.074061298671;4796.824777929395;4898.608111351084;4952.702837829742;4956.430010548761;4991.251312303184;5324.653897496651;5344.5724342052545;5393.271908292409;5405.135178371442;5452.182172674091;5778.566607504412;5780.913286300709;5782.045962416196;5782.653040817522;5816.47651711348;5722.2561067061015;5800.477956983849;5826.708664566797;5827.650340979512;5853.034249348852;5381.327334083239;5384.488473595002;5388.030154572136;5424.294841670558;5466.480684334982;5887.61730487517;5918.822435326947;5928.377520360386;5939;5955.166276721263;5611.074172761449;5710.200571919934;5729.398413166641;5729.713514324267;5736.799212027559;5725.885482290331;5726.026575482178;5763.394843541368;5784.248047753765;5833.708314584339;5726.541876649858;5754.482096611241;5754.798582049608;5757.337906140764;5769.538436925036;5572.749226284827;5701.657900525982;5784.843031393738;5793.536517078624;5800.854978625483;4442.822287108479;4456.866294011184;4497.302918047642;4502.3246513023305;4541.432320959814;3984.42225877252;3988.6210809973004;3989.740666856645;4027.2146931348107;4029.234445455354;5430.15832545956;5580.581456390787;5619.662820230799;5629.43705629442;5634.492895639412;5887.293524777054;5946.464818166386;5950.256217972754;5958.136070269787;5960.046392577254;5605.187247849039;5616.803411880564;5617.859553511195;5618.634788738719;5626.2967129108865;4853.733044682505;5044.394672639233;5046.091703493406;5097.235414687826;5152.3044389007;6021.066734656135;6026.939730602726;6059.60612560191;6119.663418511936;6139.386061393825;5851.21008663842;5858.7070646466655;5863.970680146572;5865.970670146622;5879.323877754113;5847.152162936435;6043.607165534227;6084.087386892002;6090.604110732788;6091.329953705177;5665.376808550974;5689.943100568941;5711.914321285267;5761.279840019997;5788.363280039276;5840.561957853093;5862.530997520103;5875.441833025856;5875.441833025856;5875.911861321998;5537;5637.408072152365;5716.571257155647;5724.914126288192;5734.254546908875;5643.3510146332055;5669.121286200645;5679.517241034393;5711.800086997101;5737.397573254748;5649.971750141223;5670.943290567042;5673.035583950821;5674.631148975303;5678.063119585222;5591.189277554813;5605.971970140124;5675.517581005661;5679.204911312337;5727.828165155052;5569.777208911761;5609.663420194802;5621.550275977994;5651.547876169814;5661.801836935688 20:46:51 INFO - PROCESS | 14135 | |1;ext.html;529.1388152717602;582.4612233683844;583.2796496327036;597.0208857473743;610.6885488400915;39236.803815980915;43174.13651726971;43176;43267.13465730687;43368.566314336844;43634.56365436345;43728.344074838904;44107.11785764283;44141.558584414146;44356;8890.110988901122;9001.23489503393;9007.594658240396;9033.322500812432;9067.410618309788;8918.73243802687;8951.910480895205;8993.505357205351;9001.909980900205;9016.819663606724;9044.954775226148;9082.591283392263;9082.818343633124;9092.772680683003;9136.26909847214;9001.144891235323;9043.09569043097;9056.683016094405;9071.228945539571;9073.863892041625;8812.07473215316;8892.15524525169;8893.288536917096;8896.288296936229;8913.331500137516;41740.1651966962;42281.15437691229;42350;42362.15275694469;42389.152216955794;3442.4492081266876;3572.857085716594;3692.2615476904725;3710.9814450927574;4208.180519052243;33648.83175584106;34009.48985765215;34171.487427688604;34289.14277143066;34461.31077378464;4274.166537525184;4278.807453664562;4300.220180020795;4410.713303635253;4466.508684044752;339049.3047534771;339343;343912;343944;345812;57355;57877;57884;57992;58007.129893051635;61547;61578;61609;61779.38220617826;61903.38096618976;16410.589735256715;16551.420700275434;16653.41713040062;16680.74978875318;16714.498565043068;12106.757864842653;12131.150819442732;12153.513859445524;12207.084468664885;12214;15580;16586.917065414596;16591.511273308857;16649.41727039572;16683.66428699983;6558.80323590293;6560.212774466999;6789.524733268722;6963.9303606964295;7000.884606350125;922.9123233292961;1000.5197505197546;1003.392947266893;1018.5467466977273;1076.208986394999;32794.50808237879;32969.17577060593;33122.21858800883;33258.8337058318;33283.167920802174;1114.6823155400673;1138.8519492466091;1149.4884776274646;1180.032373453777;1199.4962115911337;17092.91453542749;17171.484855454357;17245;17452.214650340764;17468.213930373164;541920;551035;552889;553260;554714;59319.703401482715;59675.104873426935;59686.70156649189;59712;59894.401055988885;1312.0946546882622;1348.2584578481992;1354.4040622126233;1356.2743931996138;1378.9724205515834;30303.393932121675;32516.83741581277;32560.67439325671;33120.50319245165;33200.1699957503;50707.74646126746;55184.17223741567;57121.43103543146;57176;61772;512729;516676;516989;520993;522248;28821.56767648445;28943.42113157767;28964.131076066908;29152.27119322034;29260.268493287836;48986.51013489819;49073.16975942215;50276.49723502718;50490.49509504858;50878.49121508738;41416.79291603523;42638;42983.78508107439;43371.783141085354;44059.55940440555;41913.58086419097;42089.57910420979;42191;43104.13791724085;43115.7844210777;41892.1621567573;42579.57420425756;43078.35382469328;43198;43306.78346608247;34850.47724284189;38178.42732358961;38783.224335513696;38822.4176637345;39106.80446597749;28306.575401368584;28801.435560864873;29086;29111.563326550542;29252.268693282836 20:46:51 INFO - PROCESS | 14135 | |2;jquery.html;382.8908761003113;388.6502148066738;393.44917116037544;395.72101668323836;416.96247337739595;18808.717869231954;19697.21211151552;20295.188192472284;20301.289454869082;20351.49121271971;18477.907610461927;19066.904665476653;19228.13473393697;19314.130864111114;19575.510612234702;5296.735163241842;5339.946600534003;5382.1926710993275;5400.513953744162;5415.458454154573;5434.184872269152;5439.238506609058;5456.645318054314;5471.042567550663;5482.369527504348;5483.287172667568;5675.404082571333;5781.306243250816;5851.824445266649;5900.232969713931;5741.569382296303;5921.289445266574;5922.822315330547;5926.733297001645;5931.347551769302;5123.718195499246;5181.922271165936;5236.293100431431;5259.81654127822;5301.0723123453245;14338.713225735426;14656.560303190921;19733.506662333413;24056.759432405626;24234.878825605934;2209.9447513812124;2337.777911098443;2369.9170529031576;2556.360909772557;2694.434168824549;10633.255672102956;10848.294860834021;10981.231313808037;11159.553617855276;11198;1947.7175809507685;2052.7126202331688;2070.1615845582564;2073.7304150460495;2074.48187820397;88262;91849.54075229648;92286;92338.5383073087;95743;10990.670279891616;11113.888861111285;11335.716607084889;11506.252093613888;11586.47860846264;16246.918765406097;16247.431339903047;16250.024998500128;16281.430149944932;16355.836441635669;8175.591220438954;8457.196566326189;8549.230569248673;8581.469933626475;8804.955975220082;8073.6770529178175;8267.917320826835;8281.21328473794;8582.09887961755;8609.096044915319;4513.571210735041;4545.499995000548;4737.123632128068;4954.083494553447;5019.598432125495;1989.731386262836;2006.2082663765495;2061.8247448967004;2067.131804642054;2084.114251443131;953.2612225525273;992.4293531219433;1071.7267096890243;1102.1733699725205;1109.367660433545;18546.44360669182;20229.190832366836;20980.89509552473;21135.26026589062;21186.258480953093;1000.8398656214971;1039.6984874386494;1042.525650828871;1060.411471633251;1126.2904370246692;10849.891501085045;11732.94133529327;11742.178047536761;11768.882311176778;11778.705532361759;474756;487627;494930;495304;505163;73067;90304;91372.5431372839;95842;100257;958.6692591056075;994.9701508954598;1013.285633628305;1021.5607288865859;1023.8054769593754;14648.34082466313;16680;17779.644407111526;17833.821661783215;18314;43833;43879.780601098064;44554;44950.20199191996;45160;58671.70664146652;60278.69860650669;62152;63009.68495157495;64930.02604961024;8350.791230219293;8601.526916019679;8638.82722345537;8765.254953329038;8854.822903542023;11417;13091.149075310075;13219.735605288033;13307.80038299407;13418.865811342152;11191.384473854016;11523.711907202387;11526.654200374001;11763.470643820878;12008.538249658624;11024.118070554498;11340.319580824847;11433;11560.768784624428;11695.415229238673;11422.800605936258;11566.65300041;11808.881911180779;11878.821817672915;12124.75750485003;8378.120297368689;8398.664053438039;8548.487090774574;8606.65573377058;8807.119288071142;8886.955565222133;11304.095672346028;11768.882311177122;11773.76452470963;12031.819522707341 20:46:51 INFO - PROCESS | 14135 | |3;mootools.html;1431.5275958933553;1488.7097016081862;1641.6060145565061;1737.0446254559988;1827.7989421163677;7960.402969777261;8551.871721924168;8737.257333126676;9328.160465558098;9388.530573471333;8844.204021638052;9105.226055785266;9124.04197559255;9124.589393477292;9142.314326425512;2289.2102224732485;2325.197806756666;2326.09282379872;2326.941826454335;2331.6152834782324;2298.482841360697;2328.592496313147;2405.2663937499055;2406.566817972764;2408.4460574067975;2393.5212957408503;2397.220903206456;2399.1483023526657;2408.614621660535;2413.034786085571;2244.0687114847483;2273.5111950930545;2276.556071566037;2281.2813963601498;2350.4476448034698;2261.4459457432868;2286.5769832581027;2286.634138537826;2290.89690963907;2296.402935236834;9076.36465447419;9205.263578913671;9223.216026637743;9228.215601673866;9229.676961306322;5017.322661440695;5122.487751224885;5162.5095615916425;5173.430922598511;5174.2238664200295;3231.8060916345094;3318.966810331914;3394.8472318745467;3478.1478537758157;3478.200013996795;1090.3839919842064;1143.0455569599394;1147.8507793986728;1150.246588484544;1153.7058050197145;12261.448234829453;12345.75308493834;12392.132550721453;12430.62708118749;12516.123871329011;4218.059692541466;4365.454318210223;4521.547845215518;4529.13946350199;4577.61090307321;10287.845682314772;10342.32774869631;10352.948235258926;10388;10416.895831041593;5175.922361164586;5233.659812112201;5240.633155679142;5252.29094072303;5255.448177941337;4308.67684923632;4666.2767271073035;4799.320237916701;4813.95186048142;4846.418429788378;3986.7807270599815;4039.7476782197027;4116.6912481564;4149.170165966819;4174.958250417518;1287.0540152987546;1323.556608536132;1324.1459258778034;1326.0518729108733;1326.204277433532;964.1611797736015;974.6491263145404;982.8722266105503;987.4272921705393;1018.9184865210765;6020.277566692025;6022.217111775529;6091.847703807441;6134.570580059353;6225.875482490415;439.05944151242977;439.3080897586314;442.24376316498507;453.3268096876136;458.48649512545495;4192.350185721218;4379.737215767064;4407.6914615976575;4467.977660111678;4555.430571178603;10567.577296908037;11087.445627718582;11092;11167.497462614201;11207.159463040305;11053.613123540797;11054.723631909266;11055.944720276508;11072.224944253987;11079.833802492969;7954.323882469939;8353.997520297724;8380.287675547524;8384.16158384169;8427.747167584983;6067.969660151671;6231.283402408781;6280.309165991646;6326.746930122928;6352.078948552342;10334.741631459274;10347.482625868826;10588.629397971034;10653.9467302663;10677.252592318464;10431.530581123716;10505.78988420212;10533;10619.628313009316;10668.786624267626;7282.308180722823;7845.960770196112;8038.83922321562;8082.434229603871;8225.753227403187;8892.421992570462;8938.68714594986;8977.820443591223;9003;9049.457032578066;7729.574873382018;7981.281684648409;7994.40041996841;8001.079875814356;8227.83544329122;7801.414893883095;7865.488743231672;7915.44591878563;7966.601669916597;7991.640376183202;7019.403350715246;7028.718851245892;7094.680739366844;7137.964310178416;7139.607321597155;5232.712200828991;5273.6572122811895;5361.678299302054;5423.4034256231;5482.17767334903;5193.662411943212;5213.40045894727;5301.655392399636;5330.360356757214;5438.23864658956 20:46:51 INFO - PROCESS | 14135 | |4;prototype.html;326.5442207556606;341.1981842669726;345.07691924103017;348.71579662574993;350.0880207060609;5268.710220937856;5399.514043736063;5402.594805389596;5469.507744303012;5476.945230547693;5405.162199859018;5412.431694672062;5417.295751552302;5447.291852059237;5447.319085114361;4280.785960701953;4316.374125751764;4330.198913201052;4332.350147477872;4333.263345231302;4221.345691417835;4266.632019229326;4292.871213863589;4319;4326.814958445981;4255.297875850496;4263.5523270056665;4273.957260427387;4280.507741609724;4286.164197981395;4264.23243816113;4272.423222864904;4273.487181538219;4310.978445107754;4320.697551171419;3668.413053911361;3842.290180869514;3855.267499175176;3856.9228615427814;3868.439076333944;5292.92060619091;5298.15229563268;5317.308749862493;5317.308749862532;5343.305370301875;4921.50784921505;4922.187839006559;4922.237053256715;4928.926066109011;4963.3299504566785;5496.725163741837;5650.915236271459;5735.770569177228;5737.942620573783;5746.79886203985;4127.215828992482;4133.834646614132;4136.048708796993;4138.358554424069;4156.337465014019;5917.940820591782;5937.139114828369;5948.851278718023;5991.161237426763;6013;4076.6534844538546;4225.57744225575;4232.470941132358;4267.658587313008;4271.273883439822;4288.785560721952;4288.978555107205;4318.481782186158;4327.545607711208;4336.457942757155;4911.16510193268;4943.629227807929;4944.552446538986;4963.528464795839;4964.553190212898;5609.990201763721;5789.507891829157;5841.795537156179;5853.765849365977;5866.1494083357675;1441.7332793433247;1460.4158336665419;1468.2291796806762;1469.544441223224;1471.6173794813426;918.5131880103556;939.7979434421633;962.9422234665942;965.6330594374093;968.9854652180223;4828.299896514985;4859.70841749489;4864.464908860023;4873.561379475794;4875.7074575525585;5130.384353877484;5136.126858434075;5139.7687104080405;5149.944261426399;5229.790808367698;4747.623189275071;4857.951420485821;4877.463479017305;4881.51184881509;4929;2709.4851978124093;2720.061578755326;2725.509408306484;2737.425140720431;2744.956916371806;5317.255584218213;5321.920171197435;5341.599380046512;5417.783288668409;5437.891242175135;4805.927911081337;5148.609875333714;5174.6119041071315;5287.788488460418;5301.814436494704;5275.788968441296;5305.840824775186;5321.866953326198;5353.984511616288;5367.838964831061;5088;5195.960807838372;5200.869978250574;5213.426523082534;5217.791058499071;5121.897562048813;5382.9192562112385;5819.272590926134;5835.299764028344;5866.823995280149;6165.136880836776;6179.752809887555;6183.3816618337805;6197.938020619917;6203.100550420074;3997.2205419942834;4088.12105397341;4154.480689913761;4163.271427500114;4195.41264223003;5867.090600956859;5873.647581145145;5888.411158884077;5907.881842363215;5932;5589.664620122806;5751.769929202952;5770.374479611683;5782.421757824352;5786.85532861665;5658.801941932013;5660.462256085665;5702;5703.885922281448;5726.599138060463;5708.143778433268;5731.226284451545;5752.30972283312;5753.424657534213;5767.250257466502;5548.861278468071;5732.828015159552;5737.483626473638;5778.855528611818;5812.5349972001295;5645.971770141123;5694.686792226467;5704.458076482893;5714.228579141763;5714.771409143754 20:46:51 INFO - PROCESS | 14135 | |5;yui.html;716.9964150179248;739.8890166475028;748.4536288509388;750.1785544828412;839.5844057191691;16340.91829540852;17291;17298.394556190535;17318.48044558662;17323.566910827234;14683.486077987272;14690.63273418165;14724.337404816783;14729.779053314209;14744.852551474482;461.9422572178478;771.7221800151941;794.8807678848161;802.5385403393043;810.7932477218301;804.8189157439588;816.2408959667507;816.3999460396633;817.0318172965056;818.3453237410077;861.5476874640801;862.3058437957442;862.6161358195606;863.0549548244662;863.995680021599;857.9227869491745;858.4034096303072;858.549261637639;858.8153546987396;860.2086080805674;623.5853157650157;624.7063879976404;625;625.5433533520555;627.5701144715885;15604.687906241925;15613.765793513106;15617.921910390489;15632.14023228722;15682.137482438462;15787.131707756069;15807.683846323123;15854.048757074612;15946.20268986546;16043.438479653156;12592.370381480889;12849.87150128496;12962.611121666365;13150.276734779583;13430.059895807297;3895.3962135868987;3970.1861118470933;3984.5417776955733;4001.7398869073418;4087.509498860126;90646;91185.54407227921;92049;93337;94014.52992735061;12325.938370308271;12337.753244935051;12346.81479777804;12383.62849114528;12510.74978500425;20995.370138895858;21085.051172697265;21128.894355528126;21171.470713231985;21236.150553977976;8866.601002954883;9063.864042039242;9168.61455568322;9467.147956683932;9507.57215925285;4915.139850526144;4964.205727083649;5045.268436076822;5129.692218466904;5143.228515722672;3689.741718079709;3780.584135745066;3795.8291876865605;3796.259729352805;3800.9809950950066;645.1097485470021;651.0689713709346;651.495091304243;652.6247407740474;673.518434319464;621.4438077920236;637.4358692557121;715.5778090926378;744.8547533231076;745.1505283976271;10096.949515252523;10422.322549034288;10632.787344253225;10941.56233750641;11084.334939903632;653.6568301641581;675.1290834823121;702.2450865319802;708.6810935079235;754.9811254718566;4732.337472753818;5084.237364395296;5145.819896303611;5209.921851172236;5216.243644671501;122271;135957.3202133983;136242;138906.305468472;139171;68247.65876170587;68492.657536713;108440.45779771051;118038.40980795214;120112;94878.52560737153;97167;97259.51370243104;101253.98746012594;102578;9795.657151999645;9874.308798384043;9898.901010990086;9933.850992235266;9941.602335906482;57075.714621426625;57498;58648;59801;60790;76611.61694191494;76639.61680191563;84804.57597711972;87287.01703863549;88284;13122;13477.932610337279;13512.87857203523;13648.65878353049;14055.22696251675;14223.359948802121;14572;14890.85109148938;15436.228188590301;15479.922600386926;13091.607251782461;13258.79389480202;13419.731605368033;13553.796693049415;13980.20493131568;13299.20204787716;13325.666858328232;13615.79576306376;13936.72126557443;14164.150150990974;12942.870571294166;13155.210687358789;13378.732425351243;13555.59333220005;13813.654658633615;10732.946335268585;10788.352698838095;10988.560457581607;11017.504212310625;11213.831792522955;10195.388276703421;10952.39761813076;11208.215424920178;11385;11551.191416600757 20:46:51 INFO - PROCESS | 14135 | __end_tp_report 20:46:51 INFO - PROCESS | 14135 | __start_cc_report 20:46:51 INFO - PROCESS | 14135 | _x_x_mozilla_cycle_collect,353 20:46:51 INFO - PROCESS | 14135 | __end_cc_report 20:46:51 INFO - PROCESS | 14135 | __startTimestamp1470887211426__endTimestamp 20:46:51 INFO - PROCESS | 14135 | 20:46:51 INFO - PROCESS | 14135 | ------- Summary: start ------- 20:46:51 INFO - PROCESS | 14135 | Number of tests: 6 20:46:51 INFO - PROCESS | 14135 | 20:46:51 INFO - PROCESS | 14135 | [#0] dojo.html Cycles:165 Average:5417.54 Median:5634.49 stddev:614.13 (10.9%) stddev-sans-first:587.50 20:46:51 INFO - PROCESS | 14135 | Values: 3059.8 3061.1 3073.3 3086.7 3097.2 5377.8 5426.4 5489.9 5510.6 5533.2 5398.4 5437.4 5450.7 5454.2 5484.7 4930.4 5010.2 5010.2 5097.5 5184.6 5037.9 5050.7 5084.7 5130.6 5137.4 4904.5 4941.6 4948.1 4985.2 5028.0 4950.9 4963.4 4972.7 4994.9 5005.1 4796.8 4898.6 4952.7 4956.4 4991.3 5324.7 5344.6 5393.3 5405.1 5452.2 5778.6 5780.9 5782.0 5782.7 5816.5 5722.3 5800.5 5826.7 5827.7 5853.0 5381.3 5384.5 5388.0 5424.3 5466.5 5887.6 5918.8 5928.4 5939.0 5955.2 5611.1 5710.2 5729.4 5729.7 5736.8 5725.9 5726.0 5763.4 5784.2 5833.7 5726.5 5754.5 5754.8 5757.3 5769.5 5572.7 5701.7 5784.8 5793.5 5800.9 4442.8 4456.9 4497.3 4502.3 4541.4 3984.4 3988.6 3989.7 4027.2 4029.2 5430.2 5580.6 5619.7 5629.4 5634.5 5887.3 5946.5 5950.3 5958.1 5960.0 5605.2 5616.8 5617.9 5618.6 5626.3 4853.7 5044.4 5046.1 5097.2 5152.3 6021.1 6026.9 6059.6 6119.7 6139.4 5851.2 5858.7 5864.0 5866.0 5879.3 5847.2 6043.6 6084.1 6090.6 6091.3 5665.4 5689.9 5711.9 5761.3 5788.4 5840.6 5862.5 5875.4 5875.4 5875.9 5537.0 5637.4 5716.6 5724.9 5734.3 5643.4 5669.1 5679.5 5711.8 5737.4 5650.0 5670.9 5673.0 5674.6 5678.1 5591.2 5606.0 5675.5 5679.2 5727.8 5569.8 5609.7 5621.6 5651.5 5661.8 20:46:51 INFO - PROCESS | 14135 | 20:46:51 INFO - PROCESS | 14135 | [#1] ext.html Cycles:180 Average:63202.27 Median:23689.29 stddev:127324.80 (537.5%) stddev-sans-first:127595.03 20:46:51 INFO - PROCESS | 14135 | Values: 529.1 582.5 583.3 597.0 610.7 39236.8 43174.1 43176.0 43267.1 43368.6 43634.6 43728.3 44107.1 44141.6 44356.0 8890.1 9001.2 9007.6 9033.3 9067.4 8918.7 8951.9 8993.5 9001.9 9016.8 9045.0 9082.6 9082.8 9092.8 9136.3 9001.1 9043.1 9056.7 9071.2 9073.9 8812.1 8892.2 8893.3 8896.3 8913.3 41740.2 42281.2 42350.0 42362.2 42389.2 3442.4 3572.9 3692.3 3711.0 4208.2 33648.8 34009.5 34171.5 34289.1 34461.3 4274.2 4278.8 4300.2 4410.7 4466.5 339049.3 339343.0 343912.0 343944.0 345812.0 57355.0 57877.0 57884.0 57992.0 58007.1 61547.0 61578.0 61609.0 61779.4 61903.4 16410.6 16551.4 16653.4 16680.7 16714.5 12106.8 12131.2 12153.5 12207.1 12214.0 15580.0 16586.9 16591.5 16649.4 16683.7 6558.8 6560.2 6789.5 6963.9 7000.9 922.9 1000.5 1003.4 1018.5 1076.2 32794.5 32969.2 33122.2 33258.8 33283.2 1114.7 1138.9 1149.5 1180.0 1199.5 17092.9 17171.5 17245.0 17452.2 17468.2 541920.0 551035.0 552889.0 553260.0 554714.0 59319.7 59675.1 59686.7 59712.0 59894.4 1312.1 1348.3 1354.4 1356.3 1379.0 30303.4 32516.8 32560.7 33120.5 33200.2 50707.7 55184.2 57121.4 57176.0 61772.0 512729.0 516676.0 516989.0 520993.0 522248.0 28821.6 28943.4 28964.1 29152.3 29260.3 48986.5 49073.2 50276.5 50490.5 50878.5 41416.8 42638.0 42983.8 43371.8 44059.6 41913.6 42089.6 42191.0 43104.1 43115.8 41892.2 42579.6 43078.4 43198.0 43306.8 34850.5 38178.4 38783.2 38822.4 39106.8 28306.6 28801.4 29086.0 29111.6 29252.3 20:46:51 INFO - PROCESS | 14135 | 20:46:51 INFO - PROCESS | 14135 | [#2] jquery.html Cycles:180 Average:29484.63 Median:2353.85 stddev:81301.19 (3454.0%) stddev-sans-first:81499.89 20:46:51 INFO - PROCESS | 14135 | Values: 382.9 388.7 393.4 395.7 417.0 18808.7 19697.2 20295.2 20301.3 20351.5 18477.9 19066.9 19228.1 19314.1 19575.5 5296.7 5339.9 5382.2 5400.5 5415.5 5434.2 5439.2 5456.6 5471.0 5482.4 5483.3 5675.4 5781.3 5851.8 5900.2 5741.6 5921.3 5922.8 5926.7 5931.3 5123.7 5181.9 5236.3 5259.8 5301.1 14338.7 14656.6 19733.5 24056.8 24234.9 2209.9 2337.8 2369.9 2556.4 2694.4 10633.3 10848.3 10981.2 11159.6 11198.0 1947.7 2052.7 2070.2 2073.7 2074.5 88262.0 91849.5 92286.0 92338.5 95743.0 10990.7 11113.9 11335.7 11506.3 11586.5 16246.9 16247.4 16250.0 16281.4 16355.8 8175.6 8457.2 8549.2 8581.5 8805.0 8073.7 8267.9 8281.2 8582.1 8609.1 4513.6 4545.5 4737.1 4954.1 5019.6 1989.7 2006.2 2061.8 2067.1 2084.1 953.3 992.4 1071.7 1102.2 1109.4 18546.4 20229.2 20980.9 21135.3 21186.3 1000.8 1039.7 1042.5 1060.4 1126.3 10849.9 11732.9 11742.2 11768.9 11778.7 474756.0 487627.0 494930.0 495304.0 505163.0 73067.0 90304.0 91372.5 95842.0 100257.0 958.7 995.0 1013.3 1021.6 1023.8 14648.3 16680.0 17779.6 17833.8 18314.0 43833.0 43879.8 44554.0 44950.2 45160.0 58671.7 60278.7 62152.0 63009.7 64930.0 8350.8 8601.5 8638.8 8765.3 8854.8 11417.0 13091.1 13219.7 13307.8 13418.9 11191.4 11523.7 11526.7 11763.5 12008.5 11024.1 11340.3 11433.0 11560.8 11695.4 11422.8 11566.7 11808.9 11878.8 12124.8 8378.1 8398.7 8548.5 8606.7 8807.1 8887.0 11304.1 11768.9 11773.8 12031.8 20:46:51 INFO - PROCESS | 14135 | 20:46:51 INFO - PROCESS | 14135 | [#3] mootools.html Cycles:180 Average:5906.84 Median:4494.76 stddev:3399.15 (75.6%) stddev-sans-first:3392.05 20:46:51 INFO - PROCESS | 14135 | Values: 1431.5 1488.7 1641.6 1737.0 1827.8 7960.4 8551.9 8737.3 9328.2 9388.5 8844.2 9105.2 9124.0 9124.6 9142.3 2289.2 2325.2 2326.1 2326.9 2331.6 2298.5 2328.6 2405.3 2406.6 2408.4 2393.5 2397.2 2399.1 2408.6 2413.0 2244.1 2273.5 2276.6 2281.3 2350.4 2261.4 2286.6 2286.6 2290.9 2296.4 9076.4 9205.3 9223.2 9228.2 9229.7 5017.3 5122.5 5162.5 5173.4 5174.2 3231.8 3319.0 3394.8 3478.1 3478.2 1090.4 1143.0 1147.9 1150.2 1153.7 12261.4 12345.8 12392.1 12430.6 12516.1 4218.1 4365.5 4521.5 4529.1 4577.6 10287.8 10342.3 10352.9 10388.0 10416.9 5175.9 5233.7 5240.6 5252.3 5255.4 4308.7 4666.3 4799.3 4814.0 4846.4 3986.8 4039.7 4116.7 4149.2 4175.0 1287.1 1323.6 1324.1 1326.1 1326.2 964.2 974.6 982.9 987.4 1018.9 6020.3 6022.2 6091.8 6134.6 6225.9 439.1 439.3 442.2 453.3 458.5 4192.4 4379.7 4407.7 4468.0 4555.4 10567.6 11087.4 11092.0 11167.5 11207.2 11053.6 11054.7 11055.9 11072.2 11079.8 7954.3 8354.0 8380.3 8384.2 8427.7 6068.0 6231.3 6280.3 6326.7 6352.1 10334.7 10347.5 10588.6 10653.9 10677.3 10431.5 10505.8 10533.0 10619.6 10668.8 7282.3 7846.0 8038.8 8082.4 8225.8 8892.4 8938.7 8977.8 9003.0 9049.5 7729.6 7981.3 7994.4 8001.1 8227.8 7801.4 7865.5 7915.4 7966.6 7991.6 7019.4 7028.7 7094.7 7138.0 7139.6 5232.7 5273.7 5361.7 5423.4 5482.2 5193.7 5213.4 5301.7 5330.4 5438.2 20:46:51 INFO - PROCESS | 14135 | 20:46:51 INFO - PROCESS | 14135 | [#4] prototype.html Cycles:180 Average:4690.69 Median:5207.15 stddev:1362.86 (26.2%) stddev-sans-first:1326.73 20:46:51 INFO - PROCESS | 14135 | Values: 326.5 341.2 345.1 348.7 350.1 5268.7 5399.5 5402.6 5469.5 5476.9 5405.2 5412.4 5417.3 5447.3 5447.3 4280.8 4316.4 4330.2 4332.4 4333.3 4221.3 4266.6 4292.9 4319.0 4326.8 4255.3 4263.6 4274.0 4280.5 4286.2 4264.2 4272.4 4273.5 4311.0 4320.7 3668.4 3842.3 3855.3 3856.9 3868.4 5292.9 5298.2 5317.3 5317.3 5343.3 4921.5 4922.2 4922.2 4928.9 4963.3 5496.7 5650.9 5735.8 5737.9 5746.8 4127.2 4133.8 4136.0 4138.4 4156.3 5917.9 5937.1 5948.9 5991.2 6013.0 4076.7 4225.6 4232.5 4267.7 4271.3 4288.8 4289.0 4318.5 4327.5 4336.5 4911.2 4943.6 4944.6 4963.5 4964.6 5610.0 5789.5 5841.8 5853.8 5866.1 1441.7 1460.4 1468.2 1469.5 1471.6 918.5 939.8 962.9 965.6 969.0 4828.3 4859.7 4864.5 4873.6 4875.7 5130.4 5136.1 5139.8 5149.9 5229.8 4747.6 4858.0 4877.5 4881.5 4929.0 2709.5 2720.1 2725.5 2737.4 2745.0 5317.3 5321.9 5341.6 5417.8 5437.9 4805.9 5148.6 5174.6 5287.8 5301.8 5275.8 5305.8 5321.9 5354.0 5367.8 5088.0 5196.0 5200.9 5213.4 5217.8 5121.9 5382.9 5819.3 5835.3 5866.8 6165.1 6179.8 6183.4 6197.9 6203.1 3997.2 4088.1 4154.5 4163.3 4195.4 5867.1 5873.6 5888.4 5907.9 5932.0 5589.7 5751.8 5770.4 5782.4 5786.9 5658.8 5660.5 5702.0 5703.9 5726.6 5708.1 5731.2 5752.3 5753.4 5767.3 5548.9 5732.8 5737.5 5778.9 5812.5 5646.0 5694.7 5704.5 5714.2 5714.8 20:46:51 INFO - PROCESS | 14135 | 20:46:51 INFO - PROCESS | 14135 | [#5] yui.html Cycles:180 Average:22741.30 Median:3932.79 stddev:33978.42 (864.0%) stddev-sans-first:34033.50 20:46:51 INFO - PROCESS | 14135 | Values: 717.0 739.9 748.5 750.2 839.6 16340.9 17291.0 17298.4 17318.5 17323.6 14683.5 14690.6 14724.3 14729.8 14744.9 461.9 771.7 794.9 802.5 810.8 804.8 816.2 816.4 817.0 818.3 861.5 862.3 862.6 863.1 864.0 857.9 858.4 858.5 858.8 860.2 623.6 624.7 625.0 625.5 627.6 15604.7 15613.8 15617.9 15632.1 15682.1 15787.1 15807.7 15854.0 15946.2 16043.4 12592.4 12849.9 12962.6 13150.3 13430.1 3895.4 3970.2 3984.5 4001.7 4087.5 90646.0 91185.5 92049.0 93337.0 94014.5 12325.9 12337.8 12346.8 12383.6 12510.7 20995.4 21085.1 21128.9 21171.5 21236.2 8866.6 9063.9 9168.6 9467.1 9507.6 4915.1 4964.2 5045.3 5129.7 5143.2 3689.7 3780.6 3795.8 3796.3 3801.0 645.1 651.1 651.5 652.6 673.5 621.4 637.4 715.6 744.9 745.2 10096.9 10422.3 10632.8 10941.6 11084.3 653.7 675.1 702.2 708.7 755.0 4732.3 5084.2 5145.8 5209.9 5216.2 122271.0 135957.3 136242.0 138906.3 139171.0 68247.7 68492.7 108440.5 118038.4 120112.0 94878.5 97167.0 97259.5 101254.0 102578.0 9795.7 9874.3 9898.9 9933.9 9941.6 57075.7 57498.0 58648.0 59801.0 60790.0 76611.6 76639.6 84804.6 87287.0 88284.0 13122.0 13477.9 13512.9 13648.7 14055.2 14223.4 14572.0 14890.9 15436.2 15479.9 13091.6 13258.8 13419.7 13553.8 13980.2 13299.2 13325.7 13615.8 13936.7 14164.2 12942.9 13155.2 13378.7 13555.6 13813.7 10732.9 10788.4 10988.6 11017.5 11213.8 10195.4 10952.4 11208.2 11385.0 11551.2 20:46:51 INFO - PROCESS | 14135 | -------- Summary: end -------- 20:46:51 INFO - PROCESS | 14135 | 20:46:52 INFO - TEST-INFO | 14135: exit 0 20:46:52 INFO - TEST-OK | dromaeo_css | took 1113894ms 20:46:52 INFO - TEST-START | kraken 20:46:52 INFO - operating with platform_type : linux_ 20:46:52 INFO - Initialising browser for kraken test... 20:46:52 INFO - TEST-INFO | started process 14381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOIxfh9/profile http://localhost:51291/getInfo.html) 20:46:56 INFO - PROCESS | 14381 | __metrics Screen width/height:1600/1200 20:46:56 INFO - PROCESS | 14381 | colorDepth:24 20:46:56 INFO - PROCESS | 14381 | Browser inner width/height: 1024/697 20:46:56 INFO - PROCESS | 14381 | __metrics 20:46:57 ERROR - PROCESS | 14381 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 20:46:58 INFO - TEST-INFO | 14381: exit 0 20:46:58 INFO - Browser initialized. 20:46:58 INFO - Running cycle 1/1 for kraken test... 20:46:58 INFO - TEST-INFO | started process 14499 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOIxfh9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:47:10 INFO - PROCESS | 14499 | RSS: Main: 163151872 20:47:10 INFO - PROCESS | 14499 | 20:47:12 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51291/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51291/tests/kraken/driver.html?testName=audio-beat-detection) 20:47:13 INFO - PROCESS | 14499 | RSS: Main: 168267776 20:47:13 INFO - PROCESS | 14499 | 20:47:16 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51291/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51291/tests/kraken/driver.html?testName=audio-dft) 20:47:17 INFO - PROCESS | 14499 | RSS: Main: 167251968 20:47:17 INFO - PROCESS | 14499 | 20:47:20 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51291/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51291/tests/kraken/driver.html?testName=audio-fft) 20:47:20 INFO - PROCESS | 14499 | RSS: Main: 163254272 20:47:20 INFO - PROCESS | 14499 | 20:47:22 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51291/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51291/tests/kraken/driver.html?testName=audio-oscillator) 20:47:23 INFO - PROCESS | 14499 | RSS: Main: 164478976 20:47:23 INFO - PROCESS | 14499 | 20:47:25 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51291/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51291/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:47:26 INFO - PROCESS | 14499 | RSS: Main: 164532224 20:47:26 INFO - PROCESS | 14499 | 20:47:29 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51291/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51291/tests/kraken/driver.html?testName=imaging-darkroom) 20:47:29 INFO - PROCESS | 14499 | RSS: Main: 164298752 20:47:29 INFO - PROCESS | 14499 | 20:47:33 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51291/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51291/tests/kraken/driver.html?testName=imaging-desaturate) 20:47:33 INFO - PROCESS | 14499 | RSS: Main: 162066432 20:47:33 INFO - PROCESS | 14499 | 20:47:36 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51291/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51291/tests/kraken/driver.html?testName=json-parse-financial) 20:47:37 INFO - PROCESS | 14499 | RSS: Main: 163577856 20:47:37 INFO - PROCESS | 14499 | 20:47:38 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51291/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51291/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:47:39 INFO - PROCESS | 14499 | RSS: Main: 164294656 20:47:39 INFO - PROCESS | 14499 | 20:47:41 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51291/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51291/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:47:42 INFO - PROCESS | 14499 | RSS: Main: 164257792 20:47:42 INFO - PROCESS | 14499 | 20:47:44 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51291/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51291/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:47:44 INFO - PROCESS | 14499 | RSS: Main: 164462592 20:47:44 INFO - PROCESS | 14499 | 20:47:47 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51291/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:47:48 INFO - PROCESS | 14499 | RSS: Main: 164524032 20:47:48 INFO - PROCESS | 14499 | 20:47:50 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:47:51 INFO - PROCESS | 14499 | RSS: Main: 164970496 20:47:51 INFO - PROCESS | 14499 | 20:47:53 INFO - PROCESS | 14499 | Cycle 1(1): loaded http://localhost:51291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51291/tests/kraken/driver.html?testName=ai-astar) 20:47:53 INFO - PROCESS | 14499 | RSS: Main: 165634048 20:47:53 INFO - PROCESS | 14499 | 20:47:53 INFO - PROCESS | 14499 | __start_tp_report 20:47:53 INFO - PROCESS | 14499 | _x_x_mozilla_page_load 20:47:53 INFO - PROCESS | 14499 | _x_x_mozilla_page_load_details 20:47:53 INFO - PROCESS | 14499 | |i|pagename|runs| 20:47:53 INFO - PROCESS | 14499 | |0;ai-astar;101;113;106;111;113;112;111;110;111;110 20:47:53 INFO - PROCESS | 14499 | |1;audio-beat-detection;151;122;142;175;120;145;153;123;184;120 20:47:53 INFO - PROCESS | 14499 | |2;audio-dft;164;165;163;162;162;166;169;164;161;162 20:47:53 INFO - PROCESS | 14499 | |3;audio-fft;79;75;76;184;76;77;75;75;185;76 20:47:53 INFO - PROCESS | 14499 | |4;audio-oscillator;85;83;151;85;84;85;137;85;85;152 20:47:53 INFO - PROCESS | 14499 | |5;imaging-gaussian-blur;117;117;118;118;117;121;118;117;117;118 20:47:53 INFO - PROCESS | 14499 | |6;imaging-darkroom;147;148;148;147;148;149;149;147;147;149 20:47:53 INFO - PROCESS | 14499 | |7;imaging-desaturate;100;97;96;95;95;96;96;96;96;95 20:47:53 INFO - PROCESS | 14499 | |8;json-parse-financial;53;57;52;52;51;51;52;52;53;53 20:47:53 INFO - PROCESS | 14499 | |9;json-stringify-tinderbox;61;62;61;61;63;61;61;61;62;62 20:47:53 INFO - PROCESS | 14499 | |10;stanford-crypto-aes;77;85;77;77;84;77;76;75;81;77 20:47:53 INFO - PROCESS | 14499 | |11;stanford-crypto-ccm;123;121;125;124;137;123;132;146;140;140 20:47:53 INFO - PROCESS | 14499 | |12;stanford-crypto-pbkdf2;163;161;157;175;158;161;165;163;158;158 20:47:53 INFO - PROCESS | 14499 | |13;stanford-crypto-sha256-iterative;67;65;67;65;67;67;65;66;63;64 20:47:53 INFO - PROCESS | 14499 | __end_tp_report 20:47:53 INFO - PROCESS | 14499 | __start_cc_report 20:47:53 INFO - PROCESS | 14499 | _x_x_mozilla_cycle_collect,859 20:47:53 INFO - PROCESS | 14499 | __end_cc_report 20:47:53 INFO - PROCESS | 14499 | __startTimestamp1470887273397__endTimestamp 20:47:53 INFO - PROCESS | 14499 | 20:47:53 INFO - PROCESS | 14499 | ------- Summary: start ------- 20:47:53 INFO - PROCESS | 14499 | Number of tests: 14 20:47:53 INFO - PROCESS | 14499 | 20:47:53 INFO - PROCESS | 14499 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.68 (3.3%) stddev-sans-first:2.11 20:47:53 INFO - PROCESS | 14499 | Values: 101.0 113.0 106.0 111.0 113.0 112.0 111.0 110.0 111.0 110.0 20:47:53 INFO - PROCESS | 14499 | 20:47:53 INFO - PROCESS | 14499 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:148.00 stddev:23.02 (15.6%) stddev-sans-first:24.26 20:47:53 INFO - PROCESS | 14499 | Values: 151.0 122.0 142.0 175.0 120.0 145.0 153.0 123.0 184.0 120.0 20:47:53 INFO - PROCESS | 14499 | 20:47:53 INFO - PROCESS | 14499 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:2.39 (1.5%) stddev-sans-first:2.54 20:47:53 INFO - PROCESS | 14499 | Values: 164.0 165.0 163.0 162.0 162.0 166.0 169.0 164.0 161.0 162.0 20:47:53 INFO - PROCESS | 14499 | 20:47:53 INFO - PROCESS | 14499 | [#3] audio-fft Cycles:10 Average:97.80 Median:76.00 stddev:45.71 (60.1%) stddev-sans-first:47.98 20:47:53 INFO - PROCESS | 14499 | Values: 79.0 75.0 76.0 184.0 76.0 77.0 75.0 75.0 185.0 76.0 20:47:53 INFO - PROCESS | 14499 | 20:47:53 INFO - PROCESS | 14499 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:85.00 stddev:30.26 (35.6%) stddev-sans-first:31.37 20:47:53 INFO - PROCESS | 14499 | Values: 85.0 83.0 151.0 85.0 84.0 85.0 137.0 85.0 85.0 152.0 20:47:53 INFO - PROCESS | 14499 | 20:47:53 INFO - PROCESS | 14499 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:1.23 (1.0%) stddev-sans-first:1.27 20:47:53 INFO - PROCESS | 14499 | Values: 117.0 117.0 118.0 118.0 117.0 121.0 118.0 117.0 117.0 118.0 20:47:53 INFO - PROCESS | 14499 | 20:47:53 INFO - PROCESS | 14499 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 20:47:53 INFO - PROCESS | 14499 | Values: 147.0 148.0 148.0 147.0 148.0 149.0 149.0 147.0 147.0 149.0 20:47:53 INFO - PROCESS | 14499 | 20:47:53 INFO - PROCESS | 14499 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.48 (1.5%) stddev-sans-first:0.67 20:47:53 INFO - PROCESS | 14499 | Values: 100.0 97.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 20:47:53 INFO - PROCESS | 14499 | 20:47:53 INFO - PROCESS | 14499 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:52.50 stddev:1.71 (3.3%) stddev-sans-first:1.81 20:47:53 INFO - PROCESS | 14499 | Values: 53.0 57.0 52.0 52.0 51.0 51.0 52.0 52.0 53.0 53.0 20:47:53 INFO - PROCESS | 14499 | 20:47:53 INFO - PROCESS | 14499 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 20:47:53 INFO - PROCESS | 14499 | Values: 61.0 62.0 61.0 61.0 63.0 61.0 61.0 61.0 62.0 62.0 20:47:53 INFO - PROCESS | 14499 | 20:47:53 INFO - PROCESS | 14499 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:77.00 stddev:3.47 (4.5%) stddev-sans-first:3.63 20:47:53 INFO - PROCESS | 14499 | Values: 77.0 85.0 77.0 77.0 84.0 77.0 76.0 75.0 81.0 77.0 20:47:53 INFO - PROCESS | 14499 | 20:47:53 INFO - PROCESS | 14499 | [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:134.50 stddev:9.05 (6.7%) stddev-sans-first:9.11 20:47:53 INFO - PROCESS | 14499 | Values: 123.0 121.0 125.0 124.0 137.0 123.0 132.0 146.0 140.0 140.0 20:47:53 INFO - PROCESS | 14499 | 20:47:53 INFO - PROCESS | 14499 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.00 stddev:5.32 (3.3%) stddev-sans-first:5.63 20:47:53 INFO - PROCESS | 14499 | Values: 163.0 161.0 157.0 175.0 158.0 161.0 165.0 163.0 158.0 158.0 20:47:53 INFO - PROCESS | 14499 | 20:47:53 INFO - PROCESS | 14499 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.50 stddev:1.43 (2.2%) stddev-sans-first:1.42 20:47:53 INFO - PROCESS | 14499 | Values: 67.0 65.0 67.0 65.0 67.0 67.0 65.0 66.0 63.0 64.0 20:47:53 INFO - PROCESS | 14499 | -------- Summary: end -------- 20:47:53 INFO - PROCESS | 14499 | 20:47:54 INFO - TEST-INFO | 14499: exit 0 20:47:54 INFO - TEST-OK | kraken | took 62193ms 20:47:54 INFO - SUITE-END | took 1176s 20:47:54 INFO - Completed test suite (00:19:36) 20:47:54 INFO - javascript benchmark 20:47:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7361.6345059968735, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3059.83170925599, 3061.066374755699, 3073.277779721765, 3086.6758990306016, 3097.225693576606, 5377.784888604451, 5426.375966763823, 5489.945100548994, 5510.614257002011, 5533.197686335479, 5398.433164517728, 5437.401885792559, 5450.700211488376, 5454.209139674755, 5484.698341591221, 4930.383702037246, 5010.173321401964, 5010.198368261079, 5097.541221290083, 5184.585233181355, 5037.924431133536, 5050.671706339076, 5084.745762711868, 5130.640855140142, 5137.383513978328, 4904.509549045102, 4941.604671626261, 4948.1093403187415, 4985.202367621199, 5028.044671512437, 4950.925736113925, 4963.354763880709, 4972.701637901738, 4994.900101997976, 5005.074061298671, 4796.824777929395, 4898.608111351084, 4952.702837829742, 4956.430010548761, 4991.251312303184, 5324.653897496651, 5344.5724342052545, 5393.271908292409, 5405.135178371442, 5452.182172674091, 5778.566607504412, 5780.913286300709, 5782.045962416196, 5782.653040817522, 5816.47651711348, 5722.2561067061015, 5800.477956983849, 5826.708664566797, 5827.650340979512, 5853.034249348852, 5381.327334083239, 5384.488473595002, 5388.030154572136, 5424.294841670558, 5466.480684334982, 5887.61730487517, 5918.822435326947, 5928.377520360386, 5939.0, 5955.166276721263, 5611.074172761449, 5710.200571919934, 5729.398413166641, 5729.713514324267, 5736.799212027559, 5725.885482290331, 5726.026575482178, 5763.394843541368, 5784.248047753765, 5833.708314584339, 5726.541876649858, 5754.482096611241, 5754.798582049608, 5757.337906140764, 5769.538436925036, 5572.749226284827, 5701.657900525982, 5784.843031393738, 5793.536517078624, 5800.854978625483, 4442.822287108479, 4456.866294011184, 4497.302918047642, 4502.3246513023305, 4541.432320959814, 3984.42225877252, 3988.6210809973004, 3989.740666856645, 4027.2146931348107, 4029.234445455354, 5430.15832545956, 5580.581456390787, 5619.662820230799, 5629.43705629442, 5634.492895639412, 5887.293524777054, 5946.464818166386, 5950.256217972754, 5958.136070269787, 5960.046392577254, 5605.187247849039, 5616.803411880564, 5617.859553511195, 5618.634788738719, 5626.2967129108865, 4853.733044682505, 5044.394672639233, 5046.091703493406, 5097.235414687826, 5152.3044389007, 6021.066734656135, 6026.939730602726, 6059.60612560191, 6119.663418511936, 6139.386061393825, 5851.21008663842, 5858.7070646466655, 5863.970680146572, 5865.970670146622, 5879.323877754113, 5847.152162936435, 6043.607165534227, 6084.087386892002, 6090.604110732788, 6091.329953705177, 5665.376808550974, 5689.943100568941, 5711.914321285267, 5761.279840019997, 5788.363280039276, 5840.561957853093, 5862.530997520103, 5875.441833025856, 5875.441833025856, 5875.911861321998, 5537.0, 5637.408072152365, 5716.571257155647, 5724.914126288192, 5734.254546908875, 5643.3510146332055, 5669.121286200645, 5679.517241034393, 5711.800086997101, 5737.397573254748, 5649.971750141223, 5670.943290567042, 5673.035583950821, 5674.631148975303, 5678.063119585222, 5591.189277554813, 5605.971970140124, 5675.517581005661, 5679.204911312337, 5727.828165155052, 5569.777208911761, 5609.663420194802, 5621.550275977994, 5651.547876169814, 5661.801836935688], "value": 5375.433712015515, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.1388152717602, 582.4612233683844, 583.2796496327036, 597.0208857473743, 610.6885488400915, 39236.803815980915, 43174.13651726971, 43176.0, 43267.13465730687, 43368.566314336844, 43634.56365436345, 43728.344074838904, 44107.11785764283, 44141.558584414146, 44356.0, 8890.110988901122, 9001.23489503393, 9007.594658240396, 9033.322500812432, 9067.410618309788, 8918.73243802687, 8951.910480895205, 8993.505357205351, 9001.909980900205, 9016.819663606724, 9044.954775226148, 9082.591283392263, 9082.818343633124, 9092.772680683003, 9136.26909847214, 9001.144891235323, 9043.09569043097, 9056.683016094405, 9071.228945539571, 9073.863892041625, 8812.07473215316, 8892.15524525169, 8893.288536917096, 8896.288296936229, 8913.331500137516, 41740.1651966962, 42281.15437691229, 42350.0, 42362.15275694469, 42389.152216955794, 3442.4492081266876, 3572.857085716594, 3692.2615476904725, 3710.9814450927574, 4208.180519052243, 33648.83175584106, 34009.48985765215, 34171.487427688604, 34289.14277143066, 34461.31077378464, 4274.166537525184, 4278.807453664562, 4300.220180020795, 4410.713303635253, 4466.508684044752, 339049.3047534771, 339343.0, 343912.0, 343944.0, 345812.0, 57355.0, 57877.0, 57884.0, 57992.0, 58007.129893051635, 61547.0, 61578.0, 61609.0, 61779.38220617826, 61903.38096618976, 16410.589735256715, 16551.420700275434, 16653.41713040062, 16680.74978875318, 16714.498565043068, 12106.757864842653, 12131.150819442732, 12153.513859445524, 12207.084468664885, 12214.0, 15580.0, 16586.917065414596, 16591.511273308857, 16649.41727039572, 16683.66428699983, 6558.80323590293, 6560.212774466999, 6789.524733268722, 6963.9303606964295, 7000.884606350125, 922.9123233292961, 1000.5197505197546, 1003.392947266893, 1018.5467466977273, 1076.208986394999, 32794.50808237879, 32969.17577060593, 33122.21858800883, 33258.8337058318, 33283.167920802174, 1114.6823155400673, 1138.8519492466091, 1149.4884776274646, 1180.032373453777, 1199.4962115911337, 17092.91453542749, 17171.484855454357, 17245.0, 17452.214650340764, 17468.213930373164, 541920.0, 551035.0, 552889.0, 553260.0, 554714.0, 59319.703401482715, 59675.104873426935, 59686.70156649189, 59712.0, 59894.401055988885, 1312.0946546882622, 1348.2584578481992, 1354.4040622126233, 1356.2743931996138, 1378.9724205515834, 30303.393932121675, 32516.83741581277, 32560.67439325671, 33120.50319245165, 33200.1699957503, 50707.74646126746, 55184.17223741567, 57121.43103543146, 57176.0, 61772.0, 512729.0, 516676.0, 516989.0, 520993.0, 522248.0, 28821.56767648445, 28943.42113157767, 28964.131076066908, 29152.27119322034, 29260.268493287836, 48986.51013489819, 49073.16975942215, 50276.49723502718, 50490.49509504858, 50878.49121508738, 41416.79291603523, 42638.0, 42983.78508107439, 43371.783141085354, 44059.55940440555, 41913.58086419097, 42089.57910420979, 42191.0, 43104.13791724085, 43115.7844210777, 41892.1621567573, 42579.57420425756, 43078.35382469328, 43198.0, 43306.78346608247, 34850.47724284189, 38178.42732358961, 38783.224335513696, 38822.4176637345, 39106.80446597749, 28306.575401368584, 28801.435560864873, 29086.0, 29111.563326550542, 29252.268693282836], "value": 20407.101045491945, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.8908761003113, 388.6502148066738, 393.44917116037544, 395.72101668323836, 416.96247337739595, 18808.717869231954, 19697.21211151552, 20295.188192472284, 20301.289454869082, 20351.49121271971, 18477.907610461927, 19066.904665476653, 19228.13473393697, 19314.130864111114, 19575.510612234702, 5296.735163241842, 5339.946600534003, 5382.1926710993275, 5400.513953744162, 5415.458454154573, 5434.184872269152, 5439.238506609058, 5456.645318054314, 5471.042567550663, 5482.369527504348, 5483.287172667568, 5675.404082571333, 5781.306243250816, 5851.824445266649, 5900.232969713931, 5741.569382296303, 5921.289445266574, 5922.822315330547, 5926.733297001645, 5931.347551769302, 5123.718195499246, 5181.922271165936, 5236.293100431431, 5259.81654127822, 5301.0723123453245, 14338.713225735426, 14656.560303190921, 19733.506662333413, 24056.759432405626, 24234.878825605934, 2209.9447513812124, 2337.777911098443, 2369.9170529031576, 2556.360909772557, 2694.434168824549, 10633.255672102956, 10848.294860834021, 10981.231313808037, 11159.553617855276, 11198.0, 1947.7175809507685, 2052.7126202331688, 2070.1615845582564, 2073.7304150460495, 2074.48187820397, 88262.0, 91849.54075229648, 92286.0, 92338.5383073087, 95743.0, 10990.670279891616, 11113.888861111285, 11335.716607084889, 11506.252093613888, 11586.47860846264, 16246.918765406097, 16247.431339903047, 16250.024998500128, 16281.430149944932, 16355.836441635669, 8175.591220438954, 8457.196566326189, 8549.230569248673, 8581.469933626475, 8804.955975220082, 8073.6770529178175, 8267.917320826835, 8281.21328473794, 8582.09887961755, 8609.096044915319, 4513.571210735041, 4545.499995000548, 4737.123632128068, 4954.083494553447, 5019.598432125495, 1989.731386262836, 2006.2082663765495, 2061.8247448967004, 2067.131804642054, 2084.114251443131, 953.2612225525273, 992.4293531219433, 1071.7267096890243, 1102.1733699725205, 1109.367660433545, 18546.44360669182, 20229.190832366836, 20980.89509552473, 21135.26026589062, 21186.258480953093, 1000.8398656214971, 1039.6984874386494, 1042.525650828871, 1060.411471633251, 1126.2904370246692, 10849.891501085045, 11732.94133529327, 11742.178047536761, 11768.882311176778, 11778.705532361759, 474756.0, 487627.0, 494930.0, 495304.0, 505163.0, 73067.0, 90304.0, 91372.5431372839, 95842.0, 100257.0, 958.6692591056075, 994.9701508954598, 1013.285633628305, 1021.5607288865859, 1023.8054769593754, 14648.34082466313, 16680.0, 17779.644407111526, 17833.821661783215, 18314.0, 43833.0, 43879.780601098064, 44554.0, 44950.20199191996, 45160.0, 58671.70664146652, 60278.69860650669, 62152.0, 63009.68495157495, 64930.02604961024, 8350.791230219293, 8601.526916019679, 8638.82722345537, 8765.254953329038, 8854.822903542023, 11417.0, 13091.149075310075, 13219.735605288033, 13307.80038299407, 13418.865811342152, 11191.384473854016, 11523.711907202387, 11526.654200374001, 11763.470643820878, 12008.538249658624, 11024.118070554498, 11340.319580824847, 11433.0, 11560.768784624428, 11695.415229238673, 11422.800605936258, 11566.65300041, 11808.881911180779, 11878.821817672915, 12124.75750485003, 8378.120297368689, 8398.664053438039, 8548.487090774574, 8606.65573377058, 8807.119288071142, 8886.955565222133, 11304.095672346028, 11768.882311177122, 11773.76452470963, 12031.819522707341], "value": 9344.055858758968, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.5275958933553, 1488.7097016081862, 1641.6060145565061, 1737.0446254559988, 1827.7989421163677, 7960.402969777261, 8551.871721924168, 8737.257333126676, 9328.160465558098, 9388.530573471333, 8844.204021638052, 9105.226055785266, 9124.04197559255, 9124.589393477292, 9142.314326425512, 2289.2102224732485, 2325.197806756666, 2326.09282379872, 2326.941826454335, 2331.6152834782324, 2298.482841360697, 2328.592496313147, 2405.2663937499055, 2406.566817972764, 2408.4460574067975, 2393.5212957408503, 2397.220903206456, 2399.1483023526657, 2408.614621660535, 2413.034786085571, 2244.0687114847483, 2273.5111950930545, 2276.556071566037, 2281.2813963601498, 2350.4476448034698, 2261.4459457432868, 2286.5769832581027, 2286.634138537826, 2290.89690963907, 2296.402935236834, 9076.36465447419, 9205.263578913671, 9223.216026637743, 9228.215601673866, 9229.676961306322, 5017.322661440695, 5122.487751224885, 5162.5095615916425, 5173.430922598511, 5174.2238664200295, 3231.8060916345094, 3318.966810331914, 3394.8472318745467, 3478.1478537758157, 3478.200013996795, 1090.3839919842064, 1143.0455569599394, 1147.8507793986728, 1150.246588484544, 1153.7058050197145, 12261.448234829453, 12345.75308493834, 12392.132550721453, 12430.62708118749, 12516.123871329011, 4218.059692541466, 4365.454318210223, 4521.547845215518, 4529.13946350199, 4577.61090307321, 10287.845682314772, 10342.32774869631, 10352.948235258926, 10388.0, 10416.895831041593, 5175.922361164586, 5233.659812112201, 5240.633155679142, 5252.29094072303, 5255.448177941337, 4308.67684923632, 4666.2767271073035, 4799.320237916701, 4813.95186048142, 4846.418429788378, 3986.7807270599815, 4039.7476782197027, 4116.6912481564, 4149.170165966819, 4174.958250417518, 1287.0540152987546, 1323.556608536132, 1324.1459258778034, 1326.0518729108733, 1326.204277433532, 964.1611797736015, 974.6491263145404, 982.8722266105503, 987.4272921705393, 1018.9184865210765, 6020.277566692025, 6022.217111775529, 6091.847703807441, 6134.570580059353, 6225.875482490415, 439.05944151242977, 439.3080897586314, 442.24376316498507, 453.3268096876136, 458.48649512545495, 4192.350185721218, 4379.737215767064, 4407.6914615976575, 4467.977660111678, 4555.430571178603, 10567.577296908037, 11087.445627718582, 11092.0, 11167.497462614201, 11207.159463040305, 11053.613123540797, 11054.723631909266, 11055.944720276508, 11072.224944253987, 11079.833802492969, 7954.323882469939, 8353.997520297724, 8380.287675547524, 8384.16158384169, 8427.747167584983, 6067.969660151671, 6231.283402408781, 6280.309165991646, 6326.746930122928, 6352.078948552342, 10334.741631459274, 10347.482625868826, 10588.629397971034, 10653.9467302663, 10677.252592318464, 10431.530581123716, 10505.78988420212, 10533.0, 10619.628313009316, 10668.786624267626, 7282.308180722823, 7845.960770196112, 8038.83922321562, 8082.434229603871, 8225.753227403187, 8892.421992570462, 8938.68714594986, 8977.820443591223, 9003.0, 9049.457032578066, 7729.574873382018, 7981.281684648409, 7994.40041996841, 8001.079875814356, 8227.83544329122, 7801.414893883095, 7865.488743231672, 7915.44591878563, 7966.601669916597, 7991.640376183202, 7019.403350715246, 7028.718851245892, 7094.680739366844, 7137.964310178416, 7139.607321597155, 5232.712200828991, 5273.6572122811895, 5361.678299302054, 5423.4034256231, 5482.17767334903, 5193.662411943212, 5213.40045894727, 5301.655392399636, 5330.360356757214, 5438.23864658956], "value": 4629.969146637432, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.5442207556606, 341.1981842669726, 345.07691924103017, 348.71579662574993, 350.0880207060609, 5268.710220937856, 5399.514043736063, 5402.594805389596, 5469.507744303012, 5476.945230547693, 5405.162199859018, 5412.431694672062, 5417.295751552302, 5447.291852059237, 5447.319085114361, 4280.785960701953, 4316.374125751764, 4330.198913201052, 4332.350147477872, 4333.263345231302, 4221.345691417835, 4266.632019229326, 4292.871213863589, 4319.0, 4326.814958445981, 4255.297875850496, 4263.5523270056665, 4273.957260427387, 4280.507741609724, 4286.164197981395, 4264.23243816113, 4272.423222864904, 4273.487181538219, 4310.978445107754, 4320.697551171419, 3668.413053911361, 3842.290180869514, 3855.267499175176, 3856.9228615427814, 3868.439076333944, 5292.92060619091, 5298.15229563268, 5317.308749862493, 5317.308749862532, 5343.305370301875, 4921.50784921505, 4922.187839006559, 4922.237053256715, 4928.926066109011, 4963.3299504566785, 5496.725163741837, 5650.915236271459, 5735.770569177228, 5737.942620573783, 5746.79886203985, 4127.215828992482, 4133.834646614132, 4136.048708796993, 4138.358554424069, 4156.337465014019, 5917.940820591782, 5937.139114828369, 5948.851278718023, 5991.161237426763, 6013.0, 4076.6534844538546, 4225.57744225575, 4232.470941132358, 4267.658587313008, 4271.273883439822, 4288.785560721952, 4288.978555107205, 4318.481782186158, 4327.545607711208, 4336.457942757155, 4911.16510193268, 4943.629227807929, 4944.552446538986, 4963.528464795839, 4964.553190212898, 5609.990201763721, 5789.507891829157, 5841.795537156179, 5853.765849365977, 5866.1494083357675, 1441.7332793433247, 1460.4158336665419, 1468.2291796806762, 1469.544441223224, 1471.6173794813426, 918.5131880103556, 939.7979434421633, 962.9422234665942, 965.6330594374093, 968.9854652180223, 4828.299896514985, 4859.70841749489, 4864.464908860023, 4873.561379475794, 4875.7074575525585, 5130.384353877484, 5136.126858434075, 5139.7687104080405, 5149.944261426399, 5229.790808367698, 4747.623189275071, 4857.951420485821, 4877.463479017305, 4881.51184881509, 4929.0, 2709.4851978124093, 2720.061578755326, 2725.509408306484, 2737.425140720431, 2744.956916371806, 5317.255584218213, 5321.920171197435, 5341.599380046512, 5417.783288668409, 5437.891242175135, 4805.927911081337, 5148.609875333714, 5174.6119041071315, 5287.788488460418, 5301.814436494704, 5275.788968441296, 5305.840824775186, 5321.866953326198, 5353.984511616288, 5367.838964831061, 5088.0, 5195.960807838372, 5200.869978250574, 5213.426523082534, 5217.791058499071, 5121.897562048813, 5382.9192562112385, 5819.272590926134, 5835.299764028344, 5866.823995280149, 6165.136880836776, 6179.752809887555, 6183.3816618337805, 6197.938020619917, 6203.100550420074, 3997.2205419942834, 4088.12105397341, 4154.480689913761, 4163.271427500114, 4195.41264223003, 5867.090600956859, 5873.647581145145, 5888.411158884077, 5907.881842363215, 5932.0, 5589.664620122806, 5751.769929202952, 5770.374479611683, 5782.421757824352, 5786.85532861665, 5658.801941932013, 5660.462256085665, 5702.0, 5703.885922281448, 5726.599138060463, 5708.143778433268, 5731.226284451545, 5752.30972283312, 5753.424657534213, 5767.250257466502, 5548.861278468071, 5732.828015159552, 5737.483626473638, 5778.855528611818, 5812.5349972001295, 5645.971770141123, 5694.686792226467, 5704.458076482893, 5714.228579141763, 5714.771409143754], "value": 4258.626192357961, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.9964150179248, 739.8890166475028, 748.4536288509388, 750.1785544828412, 839.5844057191691, 16340.91829540852, 17291.0, 17298.394556190535, 17318.48044558662, 17323.566910827234, 14683.486077987272, 14690.63273418165, 14724.337404816783, 14729.779053314209, 14744.852551474482, 461.9422572178478, 771.7221800151941, 794.8807678848161, 802.5385403393043, 810.7932477218301, 804.8189157439588, 816.2408959667507, 816.3999460396633, 817.0318172965056, 818.3453237410077, 861.5476874640801, 862.3058437957442, 862.6161358195606, 863.0549548244662, 863.995680021599, 857.9227869491745, 858.4034096303072, 858.549261637639, 858.8153546987396, 860.2086080805674, 623.5853157650157, 624.7063879976404, 625.0, 625.5433533520555, 627.5701144715885, 15604.687906241925, 15613.765793513106, 15617.921910390489, 15632.14023228722, 15682.137482438462, 15787.131707756069, 15807.683846323123, 15854.048757074612, 15946.20268986546, 16043.438479653156, 12592.370381480889, 12849.87150128496, 12962.611121666365, 13150.276734779583, 13430.059895807297, 3895.3962135868987, 3970.1861118470933, 3984.5417776955733, 4001.7398869073418, 4087.509498860126, 90646.0, 91185.54407227921, 92049.0, 93337.0, 94014.52992735061, 12325.938370308271, 12337.753244935051, 12346.81479777804, 12383.62849114528, 12510.74978500425, 20995.370138895858, 21085.051172697265, 21128.894355528126, 21171.470713231985, 21236.150553977976, 8866.601002954883, 9063.864042039242, 9168.61455568322, 9467.147956683932, 9507.57215925285, 4915.139850526144, 4964.205727083649, 5045.268436076822, 5129.692218466904, 5143.228515722672, 3689.741718079709, 3780.584135745066, 3795.8291876865605, 3796.259729352805, 3800.9809950950066, 645.1097485470021, 651.0689713709346, 651.495091304243, 652.6247407740474, 673.518434319464, 621.4438077920236, 637.4358692557121, 715.5778090926378, 744.8547533231076, 745.1505283976271, 10096.949515252523, 10422.322549034288, 10632.787344253225, 10941.56233750641, 11084.334939903632, 653.6568301641581, 675.1290834823121, 702.2450865319802, 708.6810935079235, 754.9811254718566, 4732.337472753818, 5084.237364395296, 5145.819896303611, 5209.921851172236, 5216.243644671501, 122271.0, 135957.3202133983, 136242.0, 138906.305468472, 139171.0, 68247.65876170587, 68492.657536713, 108440.45779771051, 118038.40980795214, 120112.0, 94878.52560737153, 97167.0, 97259.51370243104, 101253.98746012594, 102578.0, 9795.657151999645, 9874.308798384043, 9898.901010990086, 9933.850992235266, 9941.602335906482, 57075.714621426625, 57498.0, 58648.0, 59801.0, 60790.0, 76611.61694191494, 76639.61680191563, 84804.57597711972, 87287.01703863549, 88284.0, 13122.0, 13477.932610337279, 13512.87857203523, 13648.65878353049, 14055.22696251675, 14223.359948802121, 14572.0, 14890.85109148938, 15436.228188590301, 15479.922600386926, 13091.607251782461, 13258.79389480202, 13419.731605368033, 13553.796693049415, 13980.20493131568, 13299.20204787716, 13325.666858328232, 13615.79576306376, 13936.72126557443, 14164.150150990974, 12942.870571294166, 13155.210687358789, 13378.732425351243, 13555.59333220005, 13813.654658633615, 10732.946335268585, 10788.352698838095, 10988.560457581607, 11017.504212310625, 11213.831792522955, 10195.388276703421, 10952.39761813076, 11208.215424920178, 11385.0, 11551.191416600757], "value": 7874.484511062247, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 106.0, 111.0, 113.0, 112.0, 111.0, 110.0, 111.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 122.0, 142.0, 175.0, 120.0, 145.0, 153.0, 123.0, 184.0, 120.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 163.0, 162.0, 162.0, 166.0, 169.0, 164.0, 161.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 76.0, 184.0, 76.0, 77.0, 75.0, 75.0, 185.0, 76.0], "value": 97.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 151.0, 85.0, 84.0, 85.0, 137.0, 85.0, 85.0, 152.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 121.0, 118.0, 117.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 148.0, 149.0, 149.0, 147.0, 147.0, 149.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 97.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 57.0, 52.0, 52.0, 51.0, 51.0, 52.0, 52.0, 53.0, 53.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 63.0, 61.0, 61.0, 61.0, 62.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 85.0, 77.0, 77.0, 84.0, 77.0, 76.0, 75.0, 81.0, 77.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 121.0, 125.0, 124.0, 137.0, 123.0, 132.0, 146.0, 140.0, 140.0], "value": 131.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 157.0, 175.0, 158.0, 161.0, 165.0, 163.0, 158.0, 158.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 67.0, 65.0, 67.0, 67.0, 65.0, 66.0, 63.0, 64.0], "value": 65.6, "unit": "score"}]}]} 20:47:54 INFO - Return code: 0 20:47:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:47:54 ERROR - # TBPL SUCCESS # 20:47:54 INFO - Running post-action listener: _resource_record_post_action 20:47:54 INFO - [mozharness: 2016-08-11 03:47:54.712763Z] Finished run-tests step (success) 20:47:54 INFO - Running post-run listener: _resource_record_post_run 20:47:54 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 556130304; Read time: 16; Write time: 567752 20:47:54 INFO - TinderboxPrint: CPU usage
13.4% 20:47:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 20:47:54 INFO - TinderboxPrint: I/O write bytes / time
556,130,304 / 567,752 20:47:54 INFO - TinderboxPrint: CPU idle
8,241.9 (86.6%) 20:47:54 INFO - TinderboxPrint: CPU user
1,215.9 (12.8%) 20:47:54 INFO - TinderboxPrint: Swap in / out
0 / 0 20:47:54 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 264450048; Read time: 0; Write time: 365596 20:47:54 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 291274752; Read time: 0; Write time: 202064 20:47:55 INFO - Running post-run listener: _upload_blobber_files 20:47:55 INFO - Blob upload gear active. 20:47:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:47:55 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 20:47:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:47:55 INFO - (blobuploader) - INFO - Open directory for files ... 20:47:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:47:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:47:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:47:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:47:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:47:56 INFO - (blobuploader) - INFO - Done attempting. 20:47:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:47:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:47:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:48:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:48:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:48:01 INFO - (blobuploader) - INFO - Done attempting. 20:48:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:48:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:48:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:48:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:48:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:48:02 INFO - (blobuploader) - INFO - Done attempting. 20:48:02 INFO - (blobuploader) - INFO - Iteration through files over. 20:48:02 INFO - Return code: 0 20:48:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:48:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:48:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10b6cab0eb5cd9814858501657c2edb1e2142026e5713080ab99a298001a23df1d93a01a55a86b065d0765dc677bfe64efa0c58c29829b570026ac68e756d868", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1750f7e1f75ae586ffea2f98c2978caf40ee09adb9baf0c6266dea750c396bb87b6b8bf1f53f647ce190f31af99387d263ab8865156a13dadcb6f48f3e53a82", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/987bdf015deee89b981592fef4a33944a9cac599d754318c06cfce57d9b79288f7f4382a005ad22dfe38997541135f1af0cde702ff200b9d4e7602b7f259f415"} 20:48:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:48:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:48:02 INFO - Contents: 20:48:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10b6cab0eb5cd9814858501657c2edb1e2142026e5713080ab99a298001a23df1d93a01a55a86b065d0765dc677bfe64efa0c58c29829b570026ac68e756d868", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1750f7e1f75ae586ffea2f98c2978caf40ee09adb9baf0c6266dea750c396bb87b6b8bf1f53f647ce190f31af99387d263ab8865156a13dadcb6f48f3e53a82", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/987bdf015deee89b981592fef4a33944a9cac599d754318c06cfce57d9b79288f7f4382a005ad22dfe38997541135f1af0cde702ff200b9d4e7602b7f259f415"} 20:48:02 INFO - Running post-run listener: copy_logs_to_upload_dir 20:48:02 INFO - Copying logs to upload dir... 20:48:02 INFO - mkdir: /builds/slave/test/build/upload/logs 20:48:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.208356 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-10 20:48:02.335750) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 20:48:02.339893) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022 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/sha512/10b6cab0eb5cd9814858501657c2edb1e2142026e5713080ab99a298001a23df1d93a01a55a86b065d0765dc677bfe64efa0c58c29829b570026ac68e756d868", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1750f7e1f75ae586ffea2f98c2978caf40ee09adb9baf0c6266dea750c396bb87b6b8bf1f53f647ce190f31af99387d263ab8865156a13dadcb6f48f3e53a82", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/987bdf015deee89b981592fef4a33944a9cac599d754318c06cfce57d9b79288f7f4382a005ad22dfe38997541135f1af0cde702ff200b9d4e7602b7f259f415"} build_url:https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/JGD91j5rRZ6Al0RYLPhtMg/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/sha512/10b6cab0eb5cd9814858501657c2edb1e2142026e5713080ab99a298001a23df1d93a01a55a86b065d0765dc677bfe64efa0c58c29829b570026ac68e756d868", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e1750f7e1f75ae586ffea2f98c2978caf40ee09adb9baf0c6266dea750c396bb87b6b8bf1f53f647ce190f31af99387d263ab8865156a13dadcb6f48f3e53a82", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/987bdf015deee89b981592fef4a33944a9cac599d754318c06cfce57d9b79288f7f4382a005ad22dfe38997541135f1af0cde702ff200b9d4e7602b7f259f415"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 20:48:02.365466) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:48:02.365820) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1470883242.850217-891087022 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004718 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 20:48:02.449286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 20:48:02.449616) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 20:48:02.449926) ========= ========= Total master_lag: 0.15 =========