builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 starttime: 1470720564.46 results: success (0) buildid: 20160808222905 builduid: 436689911b494678bc4feb40132fe672 revision: e283da610b05190190d77fc6573895e12c78b05e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 22:29:24.463635) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 22:29:24.464195) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 22:29:24.464489) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 22:29:24.513361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 22:29:24.513662) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-08 22:29:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-08-08 22:29:24 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080802 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 22:29:24.609378) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 22:29:24.609683) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015628 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 22:29:24.663950) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 22:29:24.664271) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e283da610b05190190d77fc6573895e12c78b05e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev e283da610b05190190d77fc6573895e12c78b05e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-08 22:29:24,895 truncating revision to first 12 chars 2016-08-08 22:29:24,895 Setting DEBUG logging. 2016-08-08 22:29:24,895 attempt 1/10 2016-08-08 22:29:24,895 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/e283da610b05?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 22:29:26,103 unpacking tar archive at: mozilla-inbound-e283da610b05/testing/mozharness/ program finished with exit code 0 elapsedTime=1.547363 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 22:29:26.224647) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 22:29:26.224927) ========= script_repo_revision: e283da610b05190190d77fc6573895e12c78b05e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 22:29:26.225302) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 22:29:26.225580) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 22:29:26.234165) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-08-08 22:29:26.234456) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:29:26 INFO - MultiFileLogger online at 20160808 22:29:26 in /builds/slave/test 22:29:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:29:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:29:26 INFO - {'append_to_log': False, 22:29:26 INFO - 'base_work_dir': '/builds/slave/test', 22:29:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:29:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:29:26 INFO - 'branch': 'Mozilla-Inbound', 22:29:26 INFO - 'buildbot_json_path': 'buildprops.json', 22:29:26 INFO - 'config_files': ('talos/linux_config.py',), 22:29:26 INFO - 'default_actions': ('clobber', 22:29:26 INFO - 'read-buildbot-config', 22:29:26 INFO - 'download-and-extract', 22:29:26 INFO - 'populate-webroot', 22:29:26 INFO - 'create-virtualenv', 22:29:26 INFO - 'install', 22:29:26 INFO - 'run-tests'), 22:29:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:29:26 INFO - 'download_minidump_stackwalk': True, 22:29:26 INFO - 'download_symbols': 'ondemand', 22:29:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:29:26 INFO - 'tooltool.py': '/tools/tooltool.py', 22:29:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:29:26 INFO - '/tools/misc-python/virtualenv.py')}, 22:29:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:29:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:29:26 INFO - 'installer_path': 'installer.exe', 22:29:26 INFO - 'log_level': 'info', 22:29:26 INFO - 'log_name': 'talos', 22:29:26 INFO - 'log_to_console': True, 22:29:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:29:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:29:26 INFO - 'opt_config_files': (), 22:29:26 INFO - 'pip_index': False, 22:29:26 INFO - 'sps_profile': False, 22:29:26 INFO - 'sps_profile_interval': 0, 22:29:26 INFO - 'suite': 'dromaeojs-e10s', 22:29:26 INFO - 'system_bits': '32', 22:29:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:29:26 INFO - 'title': 'talos-linux64-ix-036', 22:29:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:29:26 INFO - 'use_talos_json': True, 22:29:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:29:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:29:26 INFO - 'work_dir': 'build'} 22:29:26 INFO - [mozharness: 2016-08-09 05:29:26.557893Z] Running clobber step. 22:29:26 INFO - Running pre-action listener: _resource_record_pre_action 22:29:26 INFO - Running main action method: clobber 22:29:26 INFO - rmtree: /builds/slave/test/build 22:29:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:29:27 INFO - Running post-action listener: _resource_record_post_action 22:29:27 INFO - [mozharness: 2016-08-09 05:29:27.535974Z] Finished clobber step (success) 22:29:27 INFO - [mozharness: 2016-08-09 05:29:27.536074Z] Running read-buildbot-config step. 22:29:27 INFO - Running pre-action listener: _resource_record_pre_action 22:29:27 INFO - Running main action method: read_buildbot_config 22:29:27 INFO - Using buildbot properties: 22:29:27 INFO - { 22:29:27 INFO - "project": "", 22:29:27 INFO - "product": "firefox", 22:29:27 INFO - "script_repo_revision": "production", 22:29:27 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 22:29:27 INFO - "repository": "", 22:29:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 22:29:27 INFO - "buildid": "20160808222905", 22:29:27 INFO - "stage_platform": "linux64-pgo", 22:29:27 INFO - "basedir": "/builds/slave/test", 22:29:27 INFO - "buildnumber": 970, 22:29:27 INFO - "platform": "ubuntu64_hw", 22:29:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:29:27 INFO - "slavebuilddir": "test", 22:29:27 INFO - "branch": "mozilla-inbound", 22:29:27 INFO - "revision": "e283da610b05190190d77fc6573895e12c78b05e", 22:29:27 INFO - "slavename": "talos-linux64-ix-036", 22:29:27 INFO - "builduid": "436689911b494678bc4feb40132fe672", 22:29:27 INFO - "repo_path": "integration/mozilla-inbound" 22:29:27 INFO - } 22:29:27 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 22:29:27 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/firefox-51.0a1.en-US.linux-x86_64.test_packages.json. 22:29:27 INFO - Running post-action listener: _resource_record_post_action 22:29:27 INFO - [mozharness: 2016-08-09 05:29:27.538458Z] Finished read-buildbot-config step (success) 22:29:27 INFO - [mozharness: 2016-08-09 05:29:27.538546Z] Running download-and-extract step. 22:29:27 INFO - Running pre-action listener: _resource_record_pre_action 22:29:27 INFO - Running main action method: download_and_extract 22:29:27 INFO - mkdir: /builds/slave/test/build/tests 22:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:29:27 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:29:27 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/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 22:29:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/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 22:29:27 INFO - Downloaded 1361 bytes. 22:29:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:29:27 INFO - Using the following test package requirements: 22:29:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 22:29:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:29:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:29:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:27 INFO - u'jsshell-linux-x86_64.zip'], 22:29:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:29:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 22:29:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:29:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:29:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:29:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:29:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:29:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:29:27 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:29:27 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/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 22:29:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/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 22:29:27 INFO - Downloaded 21830668 bytes. 22:29:27 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'] 22:29:27 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 22:29:29 INFO - Return code: 0 22:29:29 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 22:29:29 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')]} 22:29:29 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:29:29 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/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 22:29:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/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 22:29:29 INFO - Downloaded 21830668 bytes. 22:29:29 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'] 22:29:29 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 22:29:30 INFO - Return code: 0 22:29: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')]} 22:29:30 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 22:29:30 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/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 22:29:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/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 22:29:31 INFO - Downloaded 14413723 bytes. 22:29:31 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'] 22:29:31 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 22:29:31 INFO - Return code: 0 22:29: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')]} 22:29:31 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:29:31 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/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 22:29:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/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 22:29:32 INFO - Downloaded 59349216 bytes. 22:29:32 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:29:32 INFO - mkdir: /builds/slave/test/properties 22:29:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:29:32 INFO - Writing to file /builds/slave/test/properties/build_url 22:29:32 INFO - Contents: 22:29:32 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:29:32 INFO - Running post-action listener: _resource_record_post_action 22:29:32 INFO - Running post-action listener: set_extra_try_arguments 22:29:32 INFO - [mozharness: 2016-08-09 05:29:32.294597Z] Finished download-and-extract step (success) 22:29:32 INFO - [mozharness: 2016-08-09 05:29:32.294833Z] Running populate-webroot step. 22:29:32 INFO - Running pre-action listener: _resource_record_pre_action 22:29:32 INFO - Running main action method: populate_webroot 22:29:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:29:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:29:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:29:32 INFO - '--tppagecycles', 22:29:32 INFO - '7'], 22:29:32 INFO - 'tests': ['tsvgm']}}, 22:29:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:29:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:29:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:29:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:29:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:29:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:29:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:32 INFO - 'talos_options': ['--disable-e10s'], 22:29:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:29:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:29:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:32 INFO - 'talos_options': ['--disable-e10s'], 22:29:32 INFO - 'tests': ['damp', 'tps']}, 22:29:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:32 INFO - 'tests': ['damp', 'tps']}, 22:29:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:29:32 INFO - 'tests': ['dromaeo_dom']}, 22:29:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:29:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:29:32 INFO - 'tests': ['basic_compositor_video']}, 22:29:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:29:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:29:32 INFO - 'tests': ['a11yr', 22:29:32 INFO - 'ts_paint', 22:29:32 INFO - 'tpaint', 22:29:32 INFO - 'sessionrestore', 22:29:32 INFO - 'sessionrestore_no_auto_restore', 22:29:32 INFO - 'tabpaint']}, 22:29:32 INFO - 'other-e10s': {'tests': ['a11yr', 22:29:32 INFO - 'ts_paint', 22:29:32 INFO - 'tpaint', 22:29:32 INFO - 'sessionrestore', 22:29:32 INFO - 'sessionrestore_no_auto_restore', 22:29:32 INFO - 'tabpaint']}, 22:29:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:29:32 INFO - 'ts_paint', 22:29:32 INFO - 'tpaint', 22:29:32 INFO - 'sessionrestore', 22:29:32 INFO - 'sessionrestore_no_auto_restore', 22:29:32 INFO - 'tabpaint']}, 22:29:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:29:32 INFO - 'ts_paint', 22:29:32 INFO - 'tpaint', 22:29:32 INFO - 'sessionrestore', 22:29:32 INFO - 'sessionrestore_no_auto_restore', 22:29:32 INFO - 'tabpaint']}, 22:29:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:29:32 INFO - 'tests': ['a11yr', 22:29:32 INFO - 'ts_paint', 22:29:32 INFO - 'tpaint', 22:29:32 INFO - 'sessionrestore', 22:29:32 INFO - 'sessionrestore_no_auto_restore', 22:29:32 INFO - 'tabpaint']}, 22:29:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:29:32 INFO - 'tests': ['a11yr', 22:29:32 INFO - 'ts_paint', 22:29:32 INFO - 'tpaint', 22:29:32 INFO - 'sessionrestore', 22:29:32 INFO - 'sessionrestore_no_auto_restore', 22:29:32 INFO - 'tabpaint']}, 22:29:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:29:32 INFO - 'tests': ['tsvgx', 22:29:32 INFO - 'tsvgr_opacity', 22:29:32 INFO - 'tart', 22:29:32 INFO - 'tscrollx', 22:29:32 INFO - 'cart']}, 22:29:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:29:32 INFO - 'tsvgr_opacity', 22:29:32 INFO - 'tart', 22:29:32 INFO - 'tscrollx', 22:29:32 INFO - 'cart']}, 22:29:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:32 INFO - 'talos_options': ['--disable-e10s'], 22:29:32 INFO - 'tests': ['tp5o']}, 22:29:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:32 INFO - 'tests': ['tp5o']}, 22:29:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:32 INFO - 'talos_options': ['--disable-e10s', 22:29:32 INFO - '--xperf_path', 22:29:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:29:32 INFO - 'tests': ['tp5n']}, 22:29:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:32 INFO - 'talos_options': ['--xperf_path', 22:29:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:29:32 INFO - 'tests': ['tp5n']}}, 22:29:32 INFO - 'talos.zip': {'path': '', 22:29:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:29:32 INFO - Running post-action listener: _resource_record_post_action 22:29:32 INFO - [mozharness: 2016-08-09 05:29:32.312366Z] Finished populate-webroot step (success) 22:29:32 INFO - [mozharness: 2016-08-09 05:29:32.312456Z] Running create-virtualenv step. 22:29:32 INFO - Running pre-action listener: _resource_record_pre_action 22:29:32 INFO - Running main action method: create_virtualenv 22:29:32 INFO - Creating virtualenv /builds/slave/test/build/venv 22:29:32 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 22:29:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:29:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:29:32 INFO - Using real prefix '/usr' 22:29:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:29:32 INFO - Installing distribute.............................................................................................................................................................................................done. 22:29:34 INFO - Installing pip.................done. 22:29:35 INFO - Return code: 0 22:29:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:29: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')]} 22:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29: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')]} 22:29:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289c570>, '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 0x289d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289d900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', '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 22:29:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:29:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:29:35 INFO - Using env: {'DISPLAY': ':0', 22:29:35 INFO - 'HOME': '/home/cltbld', 22:29:35 INFO - 'LANG': 'en_US.UTF-8', 22:29:35 INFO - 'LANGUAGE': 'en_US:en', 22:29:35 INFO - 'LOGNAME': 'cltbld', 22:29:35 INFO - 'MAIL': '/var/mail/cltbld', 22:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:35 INFO - 'MOZ_NO_REMOTE': '1', 22:29:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:35 INFO - 'NO_EM_RESTART': '1', 22:29:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:35 INFO - 'PWD': '/builds/slave/test', 22:29:35 INFO - 'SHELL': '/bin/bash', 22:29:35 INFO - 'SHLVL': '1', 22:29:35 INFO - 'TERM': 'linux', 22:29:35 INFO - 'TMOUT': '86400', 22:29:35 INFO - 'USER': 'cltbld', 22:29:35 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', 22:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:35 INFO - '_': '/tools/buildbot/bin/python'} 22:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:35 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 22:29:35 INFO - Cleaning up... 22:29:35 INFO - Return code: 0 22:29:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:29: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')]} 22:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29: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')]} 22:29:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289c570>, '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 0x289d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289d900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', '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 22:29:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:29:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:29:35 INFO - Using env: {'DISPLAY': ':0', 22:29:35 INFO - 'HOME': '/home/cltbld', 22:29:35 INFO - 'LANG': 'en_US.UTF-8', 22:29:35 INFO - 'LANGUAGE': 'en_US:en', 22:29:35 INFO - 'LOGNAME': 'cltbld', 22:29:35 INFO - 'MAIL': '/var/mail/cltbld', 22:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:35 INFO - 'MOZ_NO_REMOTE': '1', 22:29:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:35 INFO - 'NO_EM_RESTART': '1', 22:29:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:35 INFO - 'PWD': '/builds/slave/test', 22:29:35 INFO - 'SHELL': '/bin/bash', 22:29:35 INFO - 'SHLVL': '1', 22:29:35 INFO - 'TERM': 'linux', 22:29:35 INFO - 'TMOUT': '86400', 22:29:35 INFO - 'USER': 'cltbld', 22:29:35 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', 22:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:35 INFO - '_': '/tools/buildbot/bin/python'} 22:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:35 INFO - Downloading/unpacking psutil>=3.1.1 22:29:35 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 22:29:35 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 22:29:35 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 22:29:35 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 22:29:35 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 22:29:35 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 22:29:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:29:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:29:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:29:37 INFO - Installing collected packages: psutil 22:29:37 INFO - Running setup.py install for psutil 22:29:37 INFO - building 'psutil._psutil_linux' extension 22:29:37 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 22:29:37 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 22:29:37 INFO - building 'psutil._psutil_posix' extension 22:29:37 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 22:29:37 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 22:29:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:29:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:29:37 INFO - Successfully installed psutil 22:29:37 INFO - Cleaning up... 22:29:37 INFO - Return code: 0 22:29:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:37 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 0x25de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289c570>, '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 0x289d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289d900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', '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 22:29:37 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 22:29:37 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 22:29:37 INFO - Using env: {'DISPLAY': ':0', 22:29:37 INFO - 'HOME': '/home/cltbld', 22:29:37 INFO - 'LANG': 'en_US.UTF-8', 22:29:37 INFO - 'LANGUAGE': 'en_US:en', 22:29:37 INFO - 'LOGNAME': 'cltbld', 22:29:37 INFO - 'MAIL': '/var/mail/cltbld', 22:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:37 INFO - 'MOZ_NO_REMOTE': '1', 22:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:37 INFO - 'NO_EM_RESTART': '1', 22:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:37 INFO - 'PWD': '/builds/slave/test', 22:29:37 INFO - 'SHELL': '/bin/bash', 22:29:37 INFO - 'SHLVL': '1', 22:29:37 INFO - 'TERM': 'linux', 22:29:37 INFO - 'TMOUT': '86400', 22:29:37 INFO - 'USER': 'cltbld', 22:29:37 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', 22:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:37 INFO - '_': '/tools/buildbot/bin/python'} 22:29:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:29:38 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 22:29:38 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 22:29:38 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 22:29:38 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 22:29:38 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 22:29:38 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 22:29:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:29:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:29:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:29:40 INFO - Installing collected packages: mozsystemmonitor 22:29:40 INFO - Running setup.py install for mozsystemmonitor 22:29:40 INFO - Successfully installed mozsystemmonitor 22:29:40 INFO - Cleaning up... 22:29:40 INFO - Return code: 0 22:29:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:29:40 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')]} 22:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:40 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')]} 22:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:40 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 0x25de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289c570>, '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 0x289d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289d900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', '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 22:29:40 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 22:29:40 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 22:29:40 INFO - Using env: {'DISPLAY': ':0', 22:29:40 INFO - 'HOME': '/home/cltbld', 22:29:40 INFO - 'LANG': 'en_US.UTF-8', 22:29:40 INFO - 'LANGUAGE': 'en_US:en', 22:29:40 INFO - 'LOGNAME': 'cltbld', 22:29:40 INFO - 'MAIL': '/var/mail/cltbld', 22:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:40 INFO - 'MOZ_NO_REMOTE': '1', 22:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:40 INFO - 'NO_EM_RESTART': '1', 22:29:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:40 INFO - 'PWD': '/builds/slave/test', 22:29:40 INFO - 'SHELL': '/bin/bash', 22:29:40 INFO - 'SHLVL': '1', 22:29:40 INFO - 'TERM': 'linux', 22:29:40 INFO - 'TMOUT': '86400', 22:29:40 INFO - 'USER': 'cltbld', 22:29:40 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', 22:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:40 INFO - '_': '/tools/buildbot/bin/python'} 22:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:40 INFO - Downloading/unpacking jsonschema==2.5.1 22:29:40 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 22:29:40 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 22:29:40 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 22:29:40 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 22:29:40 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 22:29:40 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 22:29:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:29:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:29:42 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 22:29:42 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 22:29:42 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 22:29:42 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 22:29:42 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 22:29:42 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 22:29:42 INFO - Downloading functools32-3.2.3-2.tar.gz 22:29:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:29:42 INFO - warning: no files found matching '*.txt' 22:29:42 INFO - no previously-included directories found matching 'build' 22:29:42 INFO - no previously-included directories found matching 'dist' 22:29:42 INFO - no previously-included directories found matching '.git*' 22:29:42 INFO - Installing collected packages: jsonschema, functools32 22:29:42 INFO - Running setup.py install for functools32 22:29:42 INFO - warning: no files found matching '*.txt' 22:29:42 INFO - no previously-included directories found matching 'build' 22:29:42 INFO - no previously-included directories found matching 'dist' 22:29:42 INFO - no previously-included directories found matching '.git*' 22:29:42 INFO - Successfully installed jsonschema functools32 22:29:42 INFO - Cleaning up... 22:29:42 INFO - Return code: 0 22:29:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:42 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 0x25de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289c570>, '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 0x289d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289d900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', '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 22:29:42 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 22:29:42 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 22:29:42 INFO - Using env: {'DISPLAY': ':0', 22:29:42 INFO - 'HOME': '/home/cltbld', 22:29:42 INFO - 'LANG': 'en_US.UTF-8', 22:29:42 INFO - 'LANGUAGE': 'en_US:en', 22:29:42 INFO - 'LOGNAME': 'cltbld', 22:29:42 INFO - 'MAIL': '/var/mail/cltbld', 22:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:42 INFO - 'MOZ_NO_REMOTE': '1', 22:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:42 INFO - 'NO_EM_RESTART': '1', 22:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:42 INFO - 'PWD': '/builds/slave/test', 22:29:42 INFO - 'SHELL': '/bin/bash', 22:29:42 INFO - 'SHLVL': '1', 22:29:42 INFO - 'TERM': 'linux', 22:29:42 INFO - 'TMOUT': '86400', 22:29:42 INFO - 'USER': 'cltbld', 22:29:42 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', 22:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:42 INFO - '_': '/tools/buildbot/bin/python'} 22:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:29:43 INFO - Cleaning up... 22:29:43 INFO - Return code: 0 22:29:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:29:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:43 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 0x25de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289c570>, '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 0x289d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289d900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', '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 22:29:43 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 22:29:43 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 22:29:43 INFO - Using env: {'DISPLAY': ':0', 22:29:43 INFO - 'HOME': '/home/cltbld', 22:29:43 INFO - 'LANG': 'en_US.UTF-8', 22:29:43 INFO - 'LANGUAGE': 'en_US:en', 22:29:43 INFO - 'LOGNAME': 'cltbld', 22:29:43 INFO - 'MAIL': '/var/mail/cltbld', 22:29:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:43 INFO - 'MOZ_NO_REMOTE': '1', 22:29:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:43 INFO - 'NO_EM_RESTART': '1', 22:29:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:43 INFO - 'PWD': '/builds/slave/test', 22:29:43 INFO - 'SHELL': '/bin/bash', 22:29:43 INFO - 'SHLVL': '1', 22:29:43 INFO - 'TERM': 'linux', 22:29:43 INFO - 'TMOUT': '86400', 22:29:43 INFO - 'USER': 'cltbld', 22:29:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', 22:29:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:43 INFO - '_': '/tools/buildbot/bin/python'} 22:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:43 INFO - Downloading/unpacking blobuploader==1.2.4 22:29:43 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 22:29:43 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 22:29:43 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 22:29:43 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 22:29:43 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 22:29:43 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 22:29:45 INFO - Downloading blobuploader-1.2.4.tar.gz 22:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:29:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:29:45 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 22:29:45 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 22:29:45 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 22:29:45 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 22:29:45 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 22:29:45 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 22:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:29:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:29:45 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 22:29:45 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 22:29:45 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 22:29:45 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 22:29:45 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 22:29:45 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 22:29:45 INFO - Downloading docopt-0.6.1.tar.gz 22:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:29:45 INFO - Installing collected packages: blobuploader, requests, docopt 22:29:45 INFO - Running setup.py install for blobuploader 22:29:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:29:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:29:46 INFO - Running setup.py install for requests 22:29:46 INFO - Running setup.py install for docopt 22:29:46 INFO - Successfully installed blobuploader requests docopt 22:29:46 INFO - Cleaning up... 22:29:46 INFO - Return code: 0 22:29:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:29:46 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')]} 22:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:46 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')]} 22:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:46 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 0x25de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289c570>, '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 0x289d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289d900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', '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 22:29:46 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 22:29:46 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 22:29:46 INFO - Using env: {'DISPLAY': ':0', 22:29:46 INFO - 'HOME': '/home/cltbld', 22:29:46 INFO - 'LANG': 'en_US.UTF-8', 22:29:46 INFO - 'LANGUAGE': 'en_US:en', 22:29:46 INFO - 'LOGNAME': 'cltbld', 22:29:46 INFO - 'MAIL': '/var/mail/cltbld', 22:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:46 INFO - 'MOZ_NO_REMOTE': '1', 22:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:46 INFO - 'NO_EM_RESTART': '1', 22:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:46 INFO - 'PWD': '/builds/slave/test', 22:29:46 INFO - 'SHELL': '/bin/bash', 22:29:46 INFO - 'SHLVL': '1', 22:29:46 INFO - 'TERM': 'linux', 22:29:46 INFO - 'TMOUT': '86400', 22:29:46 INFO - 'USER': 'cltbld', 22:29:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', 22:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:46 INFO - '_': '/tools/buildbot/bin/python'} 22:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:29:46 INFO - Running setup.py (path:/tmp/pip-YHqGZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:29:46 INFO - Running setup.py (path:/tmp/pip-dqTTsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:29:46 INFO - Running setup.py (path:/tmp/pip-llOOfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:29:46 INFO - Running setup.py (path:/tmp/pip-HQrTL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:29:47 INFO - Running setup.py (path:/tmp/pip-Gs19dJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:29:47 INFO - Running setup.py (path:/tmp/pip-1avsRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:29:47 INFO - Running setup.py (path:/tmp/pip-PpAeqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:29:47 INFO - Running setup.py (path:/tmp/pip-ipwSqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:29:47 INFO - Running setup.py (path:/tmp/pip-L02Us7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:29:47 INFO - Running setup.py (path:/tmp/pip-mPtlqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:29:47 INFO - Running setup.py (path:/tmp/pip-gppax0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:29:47 INFO - Running setup.py (path:/tmp/pip-UDdwUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:29:47 INFO - Running setup.py (path:/tmp/pip-TZsAY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:29:47 INFO - Running setup.py (path:/tmp/pip-HJ8L5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:29:47 INFO - Running setup.py (path:/tmp/pip-eXTtLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:29:47 INFO - Running setup.py (path:/tmp/pip-MIYcYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:29:47 INFO - Running setup.py (path:/tmp/pip-HBFwpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:29:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:29:47 INFO - Running setup.py install for manifestparser 22:29:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:29:48 INFO - Running setup.py install for mozcrash 22:29:48 INFO - Running setup.py install for mozdebug 22:29:48 INFO - Running setup.py install for mozdevice 22:29:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:29:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:29:48 INFO - Running setup.py install for mozfile 22:29:48 INFO - Running setup.py install for mozhttpd 22:29:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:29:48 INFO - Running setup.py install for mozinfo 22:29:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:29:48 INFO - Running setup.py install for mozInstall 22:29:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:29:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:29:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:29:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:29:48 INFO - Running setup.py install for mozleak 22:29:48 INFO - Running setup.py install for mozlog 22:29:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:29:49 INFO - Running setup.py install for moznetwork 22:29:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:29:49 INFO - Running setup.py install for mozprocess 22:29:49 INFO - Running setup.py install for mozprofile 22:29:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:29:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:29:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:29:49 INFO - Running setup.py install for mozrunner 22:29:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:29:49 INFO - Running setup.py install for mozscreenshot 22:29:49 INFO - Running setup.py install for moztest 22:29:49 INFO - Running setup.py install for mozversion 22:29:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:29:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:29:49 INFO - Cleaning up... 22:29:49 INFO - Return code: 0 22:29:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:29: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')]} 22:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29: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')]} 22:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:49 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 0x25de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289c570>, '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 0x289d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289d900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', '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 22:29:49 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 22:29:49 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 22:29:49 INFO - Using env: {'DISPLAY': ':0', 22:29:49 INFO - 'HOME': '/home/cltbld', 22:29:49 INFO - 'LANG': 'en_US.UTF-8', 22:29:49 INFO - 'LANGUAGE': 'en_US:en', 22:29:49 INFO - 'LOGNAME': 'cltbld', 22:29:49 INFO - 'MAIL': '/var/mail/cltbld', 22:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:49 INFO - 'MOZ_NO_REMOTE': '1', 22:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:49 INFO - 'NO_EM_RESTART': '1', 22:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:49 INFO - 'PWD': '/builds/slave/test', 22:29:49 INFO - 'SHELL': '/bin/bash', 22:29:49 INFO - 'SHLVL': '1', 22:29:49 INFO - 'TERM': 'linux', 22:29:49 INFO - 'TMOUT': '86400', 22:29:49 INFO - 'USER': 'cltbld', 22:29:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', 22:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:49 INFO - '_': '/tools/buildbot/bin/python'} 22:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:29:49 INFO - Running setup.py (path:/tmp/pip-pClj6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:29:50 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)) 22:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:29:50 INFO - Running setup.py (path:/tmp/pip-23dPwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:29:50 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)) 22:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:29:50 INFO - Running setup.py (path:/tmp/pip-UZgmx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:29:50 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)) 22:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:29:50 INFO - Running setup.py (path:/tmp/pip-NZRGOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:29:50 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)) 22:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:29:50 INFO - Running setup.py (path:/tmp/pip-CHoWcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:29:50 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)) 22:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:29:50 INFO - Running setup.py (path:/tmp/pip-ha_Xa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:29:50 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)) 22:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:29:50 INFO - Running setup.py (path:/tmp/pip-_G6t3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:29:50 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)) 22:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:29:50 INFO - Running setup.py (path:/tmp/pip-MhmJU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:29:50 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)) 22:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:29:50 INFO - Running setup.py (path:/tmp/pip-suYLcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:29:50 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)) 22:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:29:50 INFO - Running setup.py (path:/tmp/pip-fhL7xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:29:50 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)) 22:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:29:50 INFO - Running setup.py (path:/tmp/pip-12s34I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:29:50 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)) 22:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:29:50 INFO - Running setup.py (path:/tmp/pip-xz2zU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:29:50 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)) 22:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:29:50 INFO - Running setup.py (path:/tmp/pip-Y_mbHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:29:50 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)) 22:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:29:50 INFO - Running setup.py (path:/tmp/pip-fxtMt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:29:51 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)) 22:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:29:51 INFO - Running setup.py (path:/tmp/pip-QnkwNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:29:51 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)) 22:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:29:51 INFO - Running setup.py (path:/tmp/pip-06zI0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:29:51 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)) 22:29:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:29:51 INFO - Running setup.py (path:/tmp/pip-XtSyeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:29:51 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)) 22:29:51 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)) 22:29:51 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)) 22:29:51 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)) 22:29:51 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)) 22:29:51 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)) 22:29:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:29: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 22:29: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 22:29: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 22:29: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 22:29: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 22:29: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 22:29:53 INFO - Downloading blessings-1.6.tar.gz 22:29:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:29:53 INFO - Installing collected packages: blessings 22:29:53 INFO - Running setup.py install for blessings 22:29:53 INFO - Successfully installed blessings 22:29:53 INFO - Cleaning up... 22:29:53 INFO - Return code: 0 22:29:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:29:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:29:53 INFO - Reading from file tmpfile_stdout 22:29:53 INFO - Current package versions: 22:29:53 INFO - argparse == 1.2.1 22:29:53 INFO - blessings == 1.6 22:29:53 INFO - blobuploader == 1.2.4 22:29:53 INFO - docopt == 0.6.1 22:29:53 INFO - functools32 == 3.2.3-2 22:29:53 INFO - jsonschema == 2.5.1 22:29:53 INFO - manifestparser == 1.1 22:29:53 INFO - mozInstall == 1.12 22:29:53 INFO - mozcrash == 0.17 22:29:53 INFO - mozdebug == 0.1 22:29:53 INFO - mozdevice == 0.48 22:29:53 INFO - mozfile == 1.2 22:29:53 INFO - mozhttpd == 0.7 22:29:53 INFO - mozinfo == 0.9 22:29:53 INFO - mozleak == 0.1 22:29:53 INFO - mozlog == 3.3 22:29:53 INFO - moznetwork == 0.27 22:29:53 INFO - mozprocess == 0.23 22:29:53 INFO - mozprofile == 0.28 22:29:53 INFO - mozrunner == 6.12 22:29:53 INFO - mozscreenshot == 0.1 22:29:53 INFO - mozsystemmonitor == 0.3 22:29:53 INFO - moztest == 0.7 22:29:53 INFO - mozversion == 1.4 22:29:53 INFO - psutil == 3.1.1 22:29:53 INFO - requests == 1.2.3 22:29:53 INFO - wsgiref == 0.1.2 22:29:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:29: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')]} 22:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29: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')]} 22:29:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:53 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 0x25de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289c570>, '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 0x289d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289d900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', '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 22:29:53 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 22:29:53 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 22:29:53 INFO - Using env: {'DISPLAY': ':0', 22:29:53 INFO - 'HOME': '/home/cltbld', 22:29:53 INFO - 'LANG': 'en_US.UTF-8', 22:29:53 INFO - 'LANGUAGE': 'en_US:en', 22:29:53 INFO - 'LOGNAME': 'cltbld', 22:29:53 INFO - 'MAIL': '/var/mail/cltbld', 22:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:53 INFO - 'MOZ_NO_REMOTE': '1', 22:29:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:53 INFO - 'NO_EM_RESTART': '1', 22:29:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:53 INFO - 'PWD': '/builds/slave/test', 22:29:53 INFO - 'SHELL': '/bin/bash', 22:29:53 INFO - 'SHLVL': '1', 22:29:53 INFO - 'TERM': 'linux', 22:29:53 INFO - 'TMOUT': '86400', 22:29:53 INFO - 'USER': 'cltbld', 22:29:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', 22:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:53 INFO - '_': '/tools/buildbot/bin/python'} 22:29:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:53 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)) 22:29:53 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)) 22:29:53 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)) 22:29:53 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)) 22:29:53 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)) 22:29:53 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)) 22:29:53 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)) 22:29:53 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)) 22:29:53 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)) 22:29:53 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)) 22:29:53 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)) 22:29:53 INFO - Cleaning up... 22:29:53 INFO - Return code: 0 22:29:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:29: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')]} 22:29:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:29:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29: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')]} 22:29:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:29:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:29:53 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 0x25de030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289c570>, '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 0x289d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289d900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', '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 22:29:53 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 22:29:53 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 22:29:53 INFO - Using env: {'DISPLAY': ':0', 22:29:53 INFO - 'HOME': '/home/cltbld', 22:29:53 INFO - 'LANG': 'en_US.UTF-8', 22:29:53 INFO - 'LANGUAGE': 'en_US:en', 22:29:53 INFO - 'LOGNAME': 'cltbld', 22:29:53 INFO - 'MAIL': '/var/mail/cltbld', 22:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:53 INFO - 'MOZ_NO_REMOTE': '1', 22:29:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:29:53 INFO - 'NO_EM_RESTART': '1', 22:29:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:53 INFO - 'PWD': '/builds/slave/test', 22:29:53 INFO - 'SHELL': '/bin/bash', 22:29:53 INFO - 'SHLVL': '1', 22:29:53 INFO - 'TERM': 'linux', 22:29:53 INFO - 'TMOUT': '86400', 22:29:53 INFO - 'USER': 'cltbld', 22:29:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', 22:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:53 INFO - '_': '/tools/buildbot/bin/python'} 22:29:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:29:53 INFO - Cleaning up... 22:29:54 INFO - Return code: 0 22:29:54 INFO - Running post-action listener: _resource_record_post_action 22:29:54 INFO - Running post-action listener: _start_resource_monitoring 22:29:54 INFO - Starting resource monitoring. 22:29:54 INFO - [mozharness: 2016-08-09 05:29:54.026412Z] Finished create-virtualenv step (success) 22:29:54 INFO - [mozharness: 2016-08-09 05:29:54.026845Z] Running install step. 22:29:54 INFO - Running pre-action listener: _resource_record_pre_action 22:29:54 INFO - Running main action method: install 22:29:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:29:54 INFO - Reading from file tmpfile_stdout 22:29:54 INFO - Detecting whether we're running mozinstall >=1.0... 22:29:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:29:54 INFO - Reading from file tmpfile_stdout 22:29:54 INFO - Output received: 22:29:54 INFO - Usage: mozinstall [options] installer 22:29:54 INFO - Options: 22:29:54 INFO - -h, --help show this help message and exit 22:29:54 INFO - -d DEST, --destination=DEST 22:29:54 INFO - Directory to install application into. [default: 22:29:54 INFO - "/builds/slave/test"] 22:29:54 INFO - --app=APP Application being installed. [default: firefox] 22:29:54 INFO - mkdir: /builds/slave/test/build/application 22:29:54 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'] 22:29:54 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 22:30:11 INFO - Reading from file tmpfile_stdout 22:30:11 INFO - Output received: 22:30:11 INFO - /builds/slave/test/build/application/firefox/firefox 22:30:11 INFO - Running post-action listener: _resource_record_post_action 22:30:11 INFO - [mozharness: 2016-08-09 05:30:11.254321Z] Finished install step (success) 22:30:11 INFO - [mozharness: 2016-08-09 05:30:11.254611Z] Running run-tests step. 22:30:11 INFO - Running pre-action listener: _resource_record_pre_action 22:30:11 INFO - Running main action method: run_tests 22:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:30:11 INFO - Python 2.7.3 22:30:11 INFO - Return code: 0 22:30:11 INFO - grabbing minidump binary from tooltool 22:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:30:11 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 0x289c570>, '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 0x289d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289d900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:30:11 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 22:30:11 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 22:30:11 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 22:30:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:30:11 INFO - Return code: 0 22:30:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:30:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:30:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:30:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:30:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:30:11 INFO - Using env: {'DISPLAY': ':0', 22:30:11 INFO - 'HOME': '/home/cltbld', 22:30:11 INFO - 'LANG': 'en_US.UTF-8', 22:30:11 INFO - 'LANGUAGE': 'en_US:en', 22:30:11 INFO - 'LOGNAME': 'cltbld', 22:30:11 INFO - 'MAIL': '/var/mail/cltbld', 22:30:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:30:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:11 INFO - 'MOZ_NO_REMOTE': '1', 22:30:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:11 INFO - 'NO_EM_RESTART': '1', 22:30:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:11 INFO - 'PWD': '/builds/slave/test', 22:30:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:30:11 INFO - 'SHELL': '/bin/bash', 22:30:11 INFO - 'SHLVL': '1', 22:30:11 INFO - 'TERM': 'linux', 22:30:11 INFO - 'TMOUT': '86400', 22:30:11 INFO - 'USER': 'cltbld', 22:30:11 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260', 22:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:11 INFO - '_': '/tools/buildbot/bin/python'} 22:30:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:30:11 INFO - mozversion application_buildid: 20160808193039 22:30:11 INFO - mozversion application_changeset: e283da610b05190190d77fc6573895e12c78b05e 22:30:11 INFO - mozversion application_display_name: Nightly 22:30:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:30:11 INFO - mozversion application_name: Firefox 22:30:11 INFO - mozversion application_remotingname: firefox 22:30:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:30:11 INFO - mozversion application_vendor: Mozilla 22:30:11 INFO - mozversion application_version: 51.0a1 22:30:11 INFO - mozversion platform_buildid: 20160808193039 22:30:11 INFO - mozversion platform_changeset: e283da610b05190190d77fc6573895e12c78b05e 22:30:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:30:11 INFO - mozversion platform_version: 51.0a1 22:30:11 INFO - using testdate: 1470720611 22:30:11 INFO - actual date: 1470720611 22:30:11 INFO - starting webserver on 'localhost:52099' 22:30:11 INFO - SUITE-START | Running 2 tests 22:30:11 INFO - TEST-START | dromaeo_css 22:30:11 INFO - operating with platform_type : linux_ 22:30:11 INFO - Initialising browser for dromaeo_css test... 22:30:11 INFO - TEST-INFO | started process 20786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoMTwpH/profile http://localhost:52099/getInfo.html) 22:30:16 INFO - PROCESS | 20786 | __metrics Screen width/height:1600/1200 22:30:16 INFO - PROCESS | 20786 | colorDepth:24 22:30:16 INFO - PROCESS | 20786 | Browser inner width/height: 1024/697 22:30:16 INFO - PROCESS | 20786 | __metrics 22:30:16 ERROR - PROCESS | 20786 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 22:30:17 INFO - TEST-INFO | 20786: exit 0 22:30:17 INFO - Browser initialized. 22:30:17 INFO - Running cycle 1/1 for dromaeo_css test... 22:30:17 INFO - TEST-INFO | started process 20906 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoMTwpH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:30:29 INFO - PROCESS | 20906 | RSS: Main: 163213312 22:30:29 INFO - PROCESS | 20906 | 22:31:19 INFO - PROCESS | 20906 | 1470720679027 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] 22:33:28 INFO - PROCESS | 20906 | Cycle 1(1): loaded http://localhost:52099/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52099/tests/dromaeo/cssquery-ext.html) 22:33:29 INFO - PROCESS | 20906 | RSS: Main: 166486016 22:33:29 INFO - PROCESS | 20906 | 22:36:31 INFO - PROCESS | 20906 | Cycle 1(1): loaded http://localhost:52099/tests/dromaeo/cssquery-ext.html (next: http://localhost:52099/tests/dromaeo/cssquery-jquery.html) 22:36:32 INFO - PROCESS | 20906 | RSS: Main: 165781504 22:36:32 INFO - PROCESS | 20906 | 22:39:34 INFO - PROCESS | 20906 | Cycle 1(1): loaded http://localhost:52099/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52099/tests/dromaeo/cssquery-mootools.html) 22:39:34 INFO - PROCESS | 20906 | RSS: Main: 168923136 22:39:34 INFO - PROCESS | 20906 | 22:42:36 INFO - PROCESS | 20906 | Cycle 1(1): loaded http://localhost:52099/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52099/tests/dromaeo/cssquery-prototype.html) 22:42:37 INFO - PROCESS | 20906 | RSS: Main: 163766272 22:42:37 INFO - PROCESS | 20906 | 22:45:39 INFO - PROCESS | 20906 | Cycle 1(1): loaded http://localhost:52099/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52099/tests/dromaeo/cssquery-yui.html) 22:45:40 INFO - PROCESS | 20906 | RSS: Main: 165953536 22:45:40 INFO - PROCESS | 20906 | 22:48:43 INFO - PROCESS | 20906 | Cycle 1(1): loaded http://localhost:52099/tests/dromaeo/cssquery-yui.html (next: http://localhost:52099/tests/dromaeo/cssquery-dojo.html) 22:48:43 INFO - PROCESS | 20906 | RSS: Main: 168759296 22:48:43 INFO - PROCESS | 20906 | 22:48:43 INFO - PROCESS | 20906 | __start_tp_report 22:48:43 INFO - PROCESS | 20906 | _x_x_mozilla_page_load 22:48:43 INFO - PROCESS | 20906 | _x_x_mozilla_page_load_details 22:48:43 INFO - PROCESS | 20906 | |i|pagename|runs| 22:48:43 INFO - PROCESS | 20906 | |0;dojo.html;3065.7240848323654;3080.3069309405373;3099.163225928999;3105.456545104606;3106.798058126222;5310.8406747797535;5350.89298214036;5368.221607866857;5382.569394448445;5463.043967305715;5306.177542480922;5340.652857564256;5357.062514060033;5382.434844341346;5434.510894019538;4811.133995880731;4881.707097574139;4929.112759703252;5003.699778013312;5031.77357018935;4930.654854160192;4993.700377977315;5036.84889453317;5041.546260836524;5078.5937125029905;4884.633652476061;4926.605871530269;4959.851204463872;4972.204447288453;5055.823046193403;4996.400431948189;5006.724630145341;5021.297018417425;5024.070546948826;5053.216751403538;4950.851474455772;4961.950380496185;4965.379327584052;4975.875603109951;5037.773300201499;5221.13851214553;5315.6013299002725;5398.595105367113;5462.126059830408;5523.585731070186;5852.092925596539;5865.677387743673;5869.354371019184;5871.970640146772;5882.411758824126;5862.589618726691;5875.706214689249;5876.942150412924;5884.0585506318785;5894.440028197314;5205.193195054735;5294.258803767476;5297.49673780994;5342.839714808562;5425.26758887553;5840.649561026352;5849.239598852122;5865.472107510259;5872.559558033165;5883.852903677443;5565.749541270652;5585.469380408855;5593.161025846156;5624.91562626561;5628.662280263197;5564.276644036249;5621.353544342453;5628.296462942132;5650.26546548946;5662.5753068520025;5672.319321681424;5746.827595172152;5752.568557358215;5755.194272801811;5808.796692115756;5776.537876969833;5802.448767367094;5822.243108395882;5839.883202335929;5847.678377689268;4353.216421044179;4387.758673273001;4392.055708022726;4483.349914262414;4522.095580883836;3939.27123482151;3956.8219430125714;3973.6821054315587;3973.900652483653;3980.5223373195404;5491.588130890199;5568.526675232651;5570.693611851306;5581.441855814467;5585.357683866326;5658.943410565924;5684.062129748628;5717.256756621613;5780.393058728857;5837.095250236135;5551.916721249185;5566.944330556643;5567.972160139173;5570.025245582007;5601.383847776741;4931.0630980113665;4941.901161976741;4985.326980857538;4992.450830408652;4995.825146119869;5876.324222714357;5979.551533634908;5983.730732116978;5991.2510936132985;5997.220361352996;5797.275340582427;5834.474897259267;5847.649141051551;5869.236999190078;5881.911771323519;6033.939660603338;6047.274327080779;6057.787977420945;6059;6065.302490213682;5435.891282174413;5608.327000759935;5647.915281270702;5709.314882214161;5719.8570035749435;5736.827895163152;5749.942500575108;5808.07070868659;5809.709514524341;5817.650940943557;5617.9719101404235;5637.802676906289;5648.011597970257;5663.5469162467725;5664.745086471036;5458.181272809111;5589.217509548585;5637.718114094361;5653.236813030353;5656.264685590847;5562.9986602411955;5590.413006634408;5620.971895140498;5650.773969041193;5676.801311954062;5609.411011843861;5657.179708942263;5703.429657034263;5726.713664316684;5764.510016648632;5334.359876814652;5462.945370546403;5483.177523371367;5591.245181900392;5614.354349249726 22:48:43 INFO - PROCESS | 20906 | |1;ext.html;549.8160302538365;567.2144080448577;576.9019266724657;601.5548494114354;613.6808859393113;36848.26303473932;41086.38370424442;41112.17775644489;41236.38145427821;41311.38032929501;42245;42668;42699.57300426995;42855.571444285546;42876.57123428765;8644.265237454823;8811.427257228292;8822.073682263366;8833.867491987625;8844.336674749387;8597.871031934526;8697.130286971316;8703.651853925836;8730.345224108185;8757.912420875773;8776.64893404263;8781.604827782734;8801.867971980426;8827.33794965377;8859.512726800023;8722.956385218096;8746.956265218665;8757.211850933414;8815.559222038937;8822.867656985087;8708.95492540899;8710.47737135774;8730.126987301282;8761.824763504757;8762.649494020232;40674.593254067375;40924;40958.59041409607;41154.58845411537;41331.38002929959;3389.5085212644276;3405.6594340565994;3465.7747246428903;3481.529993450877;3495.4582039783872;29923.25191870199;32184.839075804706;32333.51499727506;32660;32918.341633167205;4364.956350436487;4380.540043295472;4473.753943533105;4498.077894031716;4623.838165664186;343862;345380;346104;346221;346793;58353.70823145942;59147;59352.70323648354;59448.40551594515;59569;62049.37950620436;62328.68835655793;62810;62851.685741571;62914;14992.625184370478;15211.695766084838;15250.847491524943;15259.694806103817;15652.843471565138;11775.764484710258;11779.705507362385;11815;11818.940905295418;11915.165938384403;19134;19181.904090479456;19190.712139317922;19293.710594341097;19443.90278048629;7239.8552028960175;7250.039961636888;7395.2235015323695;7470.925290747132;7548.66031028605;937.1378331934636;937.6296362936602;956.6890760502864;1011.4942528735633;1084.951177197028;30469.23826904301;30537.541936870966;30702.846485767874;30785;31142.532862006636;1073.355986408149;1129.4691494997337;1161.488944864257;1172.4196522721309;1176.1355403778216;15856.44502442409;16467.917660411622;16482;16583.336666533203;16808.74786878198;546998;552741;553264;553744;554395;57061.71469142628;57213.71393143007;57407.42592574021;57430.42569574251;57501.712491437276;1287.6909541709922;1337.9933100334435;1338.3709656461447;1345.6703107738472;1346.1250187378087;29997.070404631842;31189.8440507796;31542.211444714067;31865.840670797425;32032.83983580067;49276.507234927194;49348.75325623349;49349;49484.257736133266;49559;453773;454438;454934;454941;457183;28036.43927121487;28709;28922;29030.854845725637;29126.41747165087;47593.762031189624;47944;48529;48853.5114648849;49296.75351623219;40069.59930400775;40382.39426408665;41690.374644380965;41902.79048604737;42424.42352706759;40726.79636601798;40758;40761.96190190419;41589.58410415857;42030.789846050575;40628;40913.795431022656;41938;42057.369139462324;45157.77421112874;31124.22189445282;34895.476567850994;36119;36300.81849590735;36583.69536417258;27360.179194624194;27461.45077098487;27603.476800503795;27729;27761.583576246776 22:48:43 INFO - PROCESS | 20906 | |2;jquery.html;399.47469078162214;406.5893447617905;409.4636026804886;413.7806962309976;432.87879393769737;18623.627527449444;19381.224751009944;19944.50138746532;20208.39374818756;20406.387808365736;10424.374537527734;10438.634647787329;10685.78628427431;11409.31544107354;11533.480993355299;5083.491650834924;5260.263563101169;5265.921011184835;5271.288376069239;5282.920756188661;5255.211718242256;5792.362840087587;5812.912806307909;5828.0966450200285;5832.329282132567;5609.80365687201;5764.971175144139;5767.538596912237;5804.216430781833;5815.360310365856;5781.653100813944;6121.816345509642;6170.105334726484;6243.157173781527;6247.781327653511;5340.492653197979;5412.5940554458575;5429.511343979021;5433.7283135843445;5479.698616576086;22828;22899.88550057239;23311.533769324687;23601.645975310385;23904.641430378557;2133.370655656585;2253.3240027991537;2594.5200137974534;2675.5451573232403;2699.35215548269;10179.18566514677;10411.583536658525;12171.452284647123;13426.530071447452;13990.930045349809;1856.9322639482352;1897.7248298996706;1898.4589392023206;1922.4617107209863;1942.7280180774703;78631.606841966;81052;81268.18731812666;83025.58487207585;84478.57760711218;10872.238943273895;11171.83242251367;11210;11617.244879082833;11624.488816453806;15820.76268855968;15882.808789340846;15885.205739712968;15899.602509937344;15956.521304360887;7822.530648161129;7936.682532698743;7940.563269020144;7947.086085100172;8205.220504052106;7284.745033923788;7307.19620841707;7423.331900129015;7638.274363935418;7725.343345815556;4778.474367819537;4883.34074899891;4886.389201349832;4979.30289759434;5030.170021946411;1994.9925287729893;2068.2244158440585;2069.3378119001777;2094.74863016439;2103.4846462616756;924.4314746430897;959.6785076999283;1015.8527013582989;1018.5467466977273;1046.8482070099792;19353.322633707754;19698.70451943222;19703.901480492506;19708.31020914261;19943.102560384526;975.4439969217619;995.2386424385351;1012.5494155101056;1017.2014968249888;1036.9533370998324;10546.630867919586;10591;10984.176186786022;11020.338779673086;11124.777504449865;383820;415418;416517;416726;419366;91044.54477727569;92062;92274.61588076185;93368.53315733378;94646.5267673671;992.7418871093568;1009.4952523738131;1019.3323373190572;1045.1951996962448;1048.8741351037925;17091.316347345968;17489.125543722508;18158.546036348667;18463.353782617545;18656.533586659898;43268.78365608152;44191.55808441874;44327.670169894955;44599.10801784011;45109.548904510535;56190;58600;61770.38229617646;62756.686216568625;63282;7015.158181018311;7207.747728829466;7477.476576639583;7668.57822819728;8003.5197888126895;7296.4162866969455;11656.708582285512;12804.359782010675;12932.41804118798;13768.655783605089;12015.519379224734;12336.321502317458;12435.937820311203;12631;12940.935295323463;11824.940875295568;12271.202371845802;12348.81476777831;12407.193532420364;12448.190867593577;11830.645080647595;12348;12363.814542781685;12415.93792031034;12684.23894566329;7295.270472952662;7469.290417410337;7717.80705482345;7831.412644051833;7858.921410785819;11616.477258523219;11834.112441566745;11987.460564274803;12072.879271207526;12140.635780926234 22:48:43 INFO - PROCESS | 20906 | |3;mootools.html;1468.7870258812472;1491.179851081905;1604.783354247177;1683.4108062178232;1741.45144279552;8061.91938080619;8357.91642083579;8612.181842724938;9320;9332.440053596789;8126.1873812618705;8336.291415229713;8393.118722534138;8431.325493960483;8434.53610051447;2261.762514935933;2299.793018628323;2301.2750983440246;2307.4692820651176;2307.8038366738765;2106.273335699189;2128.031745555776;2130.360891732482;2152.5049238675115;2284.805791507724;2239.6562062762373;2262.558801033799;2281.7147856517936;2284.0635339510804;2326.2439707095177;2189.179057853305;2273.0453209651905;2285.828562857784;2295.437617783637;2295.8979689749012;2189.1134090693295;2200.1859312054644;2205.195103787122;2208.293346129239;2212.037763572835;8672;8778.780530486789;8809.295256379473;8817.118288171196;8832.55837208137;5091.23631455281;5154.768035438415;5208.036513245024;5221.686698798084;5235.79576697358;3308.371409432224;3389.7796643218358;3439.329330780499;3453.1021934297014;3494.947575786365;1135.182668478694;1136.8237923121928;1150.3787954504558;1154.0767386091177;1165.8134698448293;12968.157069790434;12971.5459958901;12981.286029268387;12992.155509891827;13000.804987925188;4446.644268458515;4557.225271703818;4718.363020992191;4743.762811859393;4745.454272758677;10829.620963266405;10880.78238435227;10882.673519794418;10934.890651093547;10941.45292735376;5245.449227831099;5265.842024739264;5275.261463395128;5289.68261904287;5299.947000529945;4196.643285320782;4655.138799322136;4779.02030083839;4820.855374338776;4826.32431459596;4081.2449696806184;4144.896377590524;4193.161367726406;4210.32634778434;4233.216854881856;1253.235526328957;1261.2279746955542;1293.5213970830853;1293.8188653588504;1333.5599252246736;910.9908900911039;948.3266880514774;964.1997142371955;994.3337963564285;1032.902625542948;6140.232470941132;6288.465480434123;6316.589421687576;6347.39699728525;6444.903326450107;418.9601987811153;420.0632589325821;422.9894252643709;439.03631528794625;442.98228070876803;4274.465691788527;4312.956870431318;4404.185225733249;4452.643788496913;4584.839530616412;10969.890301097046;11406.543738250377;11471.680756712918;11495.310281383145;11522.07823374128;11358.886411135949;11373.090152787758;11379;11398.430078496041;11438.94280528592;8031.959840200761;8239.588020598947;8291.129431409736;8364.121767214476;8588;6088.8782224356155;6118.632882027093;6266.404691554295;6280.623162610258;6376.171097757262;10111.848322275024;10814.35113893169;10885.346879187275;10885.619003334845;10918.126549875831;10251.692449226535;10777.08394786452;10791.892081079088;10810.783784324112;10876.966688164928;7103.751368702071;7622.31399174077;7688.6540105696495;7860.135385107519;7969.242921922408;8479.830403391774;8543;8551.74344769658;8571.485710857369;8571.742847714579;7437.590932498764;7479.439042071976;7569.1295501018085;7805.9609701953395;8188.877166842383;7649.847003060019;7792.064952205772;7811.257930496594;7812.84374312522;8187.321599072295;6748.156480439945;6897.068895699016;6897.62063086515;6944.722211111701;6956.40870526011;5393.487618676219;5467.480589344006;5623.522000629992;5700.771969121189;5834.066549352084;5278.81524146653;5310.761015754378;5316.308879845596;5320.467953204648;5421.5933804964 22:48:43 INFO - PROCESS | 20906 | |4;prototype.html;330.9553210316608;336.3139196040078;338.30815981318204;340.4654692133351;345.33522968286076;5346.315910488193;5443.591730620199;5480.013597552444;5510.614257002011;5517.889642207158;5373.704446255454;5448.237246785453;5483.561315094793;5485.286912701353;5491.945080549193;4316.661834831212;4343.326784348431;4343.869683909487;4352.39066530686;4357.433533640622;4075.1849630073957;4281.764502952336;4286.207051695431;4324.37296591994;4375.190589740892;4272.850450234242;4276.4440622719;4279.358096285551;4301.376300436435;4303.935440968388;4293.441852559178;4297.087795930796;4319.287317592593;4322.654187664979;4351.303791393362;3693.9261214775825;3779.5842457329672;3782.6217378262227;3809.1619843634357;3820.6752426043818;5329.760160792774;5335.413104558495;5340.439253878365;5352.190100197388;5356.946430535684;4872.634552408584;4875.756212189376;4908.631852611068;4910.238912968495;4938.407391113054;5517.399954013331;5640.351359593658;5642.4357564243655;5660.943390566124;5666.660000399989;4103.343465045608;4121.711480196387;4123.402106694542;4159.064210552631;4159.563245859172;5843.766249350064;5940.732667029951;5958.5828991970575;5961.552883533753;6018.518518518552;4225.056474021984;4234.470691163605;4239.27932251518;4239.533651298355;4255.468066491689;4296.6347860432215;4309.482862056573;4313.41768861206;4316.179925814085;4321.178975994614;4903.411590609078;4903.754812259373;4917.704937703749;4919.926201106986;4960.181570040975;5501.202325662756;5585.413531579125;5766.769329226868;5782.681952492653;5789.53683705311;1458.875995540391;1477.2761346940138;1485.68057867559;1490.3740429019838;1494.305148106136;916.2669864108686;938.1697197979837;949.6011675096476;970.6798753694969;973.3527204408989;4843.515648435199;4872.244802055687;4903.289023091703;4929.545783993731;4935.062338155811;5217.921426358391;5220.3735551734035;5226.890000449726;5257.684538927677;5264.394594621591;4718.528147185254;4938.555530002317;5012.7994880205115;5023.422306434807;5025.346704928409;2748.670159580823;2756;2767.9308017299727;2769.515334816399;2775.292300463369;5357.357117145967;5410.945890541044;5413.53984911287;5426.484483974016;5437.9124175165125;5280.234366016906;5321.210910180868;5598.524125449382;6024.789132380433;6039.4262545058145;6206.534509911775;6218.502519798405;6227.194113707064;6231.470325022424;6239.688015599293;5616.382197958303;5954.838806432704;5956.851078723066;5973.940260597338;5985.730642121028;5849.356570777126;5861.0915308127305;5864.882702346014;5888.146218798164;5905.320888097924;6192.256929168529;6235.438810506895;6243.750249989949;6244.250689917239;6281.309056003927;4093.2427500912427;4216.325387937915;4224.324108142682;4233.1956928183545;4257.531671516069;5815.3603103657715;5879.5002424794375;5915.260592425947;5933.169356290036;5945.821625351246;5789.855253618524;5809.36097029318;5834.445727656036;5837.956715149664;5846.619969701956;5783.8554036149435;5797.449242321973;5797.565182611405;5834.533237341087;5837.620554663933;5570.387257401601;5687.289088863892;5698.458646428583;5701.258836351248;5791.362950075572;5784.190213370048;5805.593608447368;5847.327557330961;5862.384449632727;5894.174815525744;5399.299220745453;5637.308807357695;5683.7442315095095;5696.344920334214;5702.971485142713 22:48:43 INFO - PROCESS | 20906 | |5;yui.html;749.8650242956268;763;815.6085079162006;840.1892174052039;859.6260626627416;14974.700505989887;16265.83734162658;16286.185690715476;16310.7553386699;16415.67168656626;15307.540773776776;15413.383464661429;15420.306086226119;15513.534593962198;15535.611609709764;656.1273506236694;773.8529679360903;794.2811755361407;798.1180795221284;800.2957397490201;802.574635443216;806.0408114343912;810.2869474862113;814.0109766633539;816.7631386897792;868.3704314372093;872.0233338660709;873.3362644390246;873.7597160780805;877.32007694037;864.8140649760301;865.536937738307;865.8744482050131;866.1944391715701;870.2994089757742;633.8098570428899;636.8185067255856;637.1716768201366;637.2034956304619;638.450932198309;15139.54581362561;15186.164760938143;15310.923445382701;15341.693166136727;15346.309416076192;15188.392464301414;15219.315130819139;15487.070775753491;15583;15723.842761572352;11710.941445292805;11729.12031597625;11740.471678774476;11909.523619055228;12224.633261002184;3939.7833119178435;3952.980235098835;3958.188571342868;3990.142119444304;4122.876313710593;79444;79990;82365.17634823635;82422.58788706017;83765.16234837634;11606.477708503138;11782.469788859522;11796.351200684045;12133.69665758363;12162.331071790959;23348.18281360144;23350.18274360389;23353.88323058374;23357.41606459852;23399.649005264935;8445.57772111392;8484.618192181366;9104;9116.49859257734;9130.95434522823;4653.7207767534055;4866.197077482247;4885.854702548498;4986.675866068694;5062.594992400599;3268.2809781847955;3289.9177520562175;3293.9176520587175;3349.8325083745717;3361.0757041813695;592.733270028489;595.0627761276007;601.9367966363557;602.5149754447624;604.8699529601157;575.3067553597905;596.8269201931391;631.4979591224987;635.259922190652;688.9862202755917;9968.302218844756;10004.699859004242;10055.547500362502;10282.383057016454;10345.482725863676;709.815447983528;730.3682314797662;735.6064505489537;762.9618519074024;779.742684913977;4500.842470513517;4732.905341893143;4871.634627402888;4915.2028018646015;4983.626228032912;122384.98535131881;124587.37706311591;125189;126366;128918.35540822236;113479.43260283646;114059;114251;116017;117587;98356;99032.5048374768;99698;101142;101484;8822;9328.300377471853;9342.252619790537;9484.905150948678;9498.292514403114;54112;54694.45305546893;55143;55193.44806552044;55825;78662.21337786548;81393.59303203446;82830.58584707038;83437;84556.57721711352;11298.943505282421;11330.150238732293;11375.033122184706;11516.560429946257;11550.133739969704;13923.303834808421;14062.367193476523;14083.295835207993;14152.92923535417;14878.925605371904;13473.663158421117;13552.59342219735;13819;13854.861451385761;14300.928495357457;12156;12241.143119981516;12425.13024088305;12532.87467125317;12546.560870369858;12915.547955821501;13400.865991339962;13474.326283685972;13628.31858407056;13678.86321136776;10280.640177593748;10426;10646.095081918123;10916.617918372818;10950;9688.214209579302;10858;11140.554377824796;11329.943350283196;11347.54609815598 22:48:43 INFO - PROCESS | 20906 | __end_tp_report 22:48:43 INFO - PROCESS | 20906 | __start_cc_report 22:48:43 INFO - PROCESS | 20906 | _x_x_mozilla_cycle_collect,342 22:48:43 INFO - PROCESS | 20906 | __end_cc_report 22:48:43 INFO - PROCESS | 20906 | __startTimestamp1470721723545__endTimestamp 22:48:43 INFO - PROCESS | 20906 | 22:48:43 INFO - PROCESS | 20906 | ------- Summary: start ------- 22:48:43 INFO - PROCESS | 20906 | Number of tests: 6 22:48:43 INFO - PROCESS | 20906 | 22:48:43 INFO - PROCESS | 20906 | [#0] dojo.html Cycles:165 Average:5375.47 Median:5585.47 stddev:606.86 (10.9%) stddev-sans-first:581.04 22:48:43 INFO - PROCESS | 20906 | Values: 3065.7 3080.3 3099.2 3105.5 3106.8 5310.8 5350.9 5368.2 5382.6 5463.0 5306.2 5340.7 5357.1 5382.4 5434.5 4811.1 4881.7 4929.1 5003.7 5031.8 4930.7 4993.7 5036.8 5041.5 5078.6 4884.6 4926.6 4959.9 4972.2 5055.8 4996.4 5006.7 5021.3 5024.1 5053.2 4950.9 4962.0 4965.4 4975.9 5037.8 5221.1 5315.6 5398.6 5462.1 5523.6 5852.1 5865.7 5869.4 5872.0 5882.4 5862.6 5875.7 5876.9 5884.1 5894.4 5205.2 5294.3 5297.5 5342.8 5425.3 5840.6 5849.2 5865.5 5872.6 5883.9 5565.7 5585.5 5593.2 5624.9 5628.7 5564.3 5621.4 5628.3 5650.3 5662.6 5672.3 5746.8 5752.6 5755.2 5808.8 5776.5 5802.4 5822.2 5839.9 5847.7 4353.2 4387.8 4392.1 4483.3 4522.1 3939.3 3956.8 3973.7 3973.9 3980.5 5491.6 5568.5 5570.7 5581.4 5585.4 5658.9 5684.1 5717.3 5780.4 5837.1 5551.9 5566.9 5568.0 5570.0 5601.4 4931.1 4941.9 4985.3 4992.5 4995.8 5876.3 5979.6 5983.7 5991.3 5997.2 5797.3 5834.5 5847.6 5869.2 5881.9 6033.9 6047.3 6057.8 6059.0 6065.3 5435.9 5608.3 5647.9 5709.3 5719.9 5736.8 5749.9 5808.1 5809.7 5817.7 5618.0 5637.8 5648.0 5663.5 5664.7 5458.2 5589.2 5637.7 5653.2 5656.3 5563.0 5590.4 5621.0 5650.8 5676.8 5609.4 5657.2 5703.4 5726.7 5764.5 5334.4 5462.9 5483.2 5591.2 5614.4 22:48:43 INFO - PROCESS | 20906 | 22:48:43 INFO - PROCESS | 20906 | [#1] ext.html Cycles:180 Average:60828.57 Median:41796.58 stddev:121832.69 (291.5%) stddev-sans-first:122090.40 22:48:43 INFO - PROCESS | 20906 | Values: 549.8 567.2 576.9 601.6 613.7 36848.3 41086.4 41112.2 41236.4 41311.4 42245.0 42668.0 42699.6 42855.6 42876.6 8644.3 8811.4 8822.1 8833.9 8844.3 8597.9 8697.1 8703.7 8730.3 8757.9 8776.6 8781.6 8801.9 8827.3 8859.5 8723.0 8747.0 8757.2 8815.6 8822.9 8709.0 8710.5 8730.1 8761.8 8762.6 40674.6 40924.0 40958.6 41154.6 41331.4 3389.5 3405.7 3465.8 3481.5 3495.5 29923.3 32184.8 32333.5 32660.0 32918.3 4365.0 4380.5 4473.8 4498.1 4623.8 343862.0 345380.0 346104.0 346221.0 346793.0 58353.7 59147.0 59352.7 59448.4 59569.0 62049.4 62328.7 62810.0 62851.7 62914.0 14992.6 15211.7 15250.8 15259.7 15652.8 11775.8 11779.7 11815.0 11818.9 11915.2 19134.0 19181.9 19190.7 19293.7 19443.9 7239.9 7250.0 7395.2 7470.9 7548.7 937.1 937.6 956.7 1011.5 1085.0 30469.2 30537.5 30702.8 30785.0 31142.5 1073.4 1129.5 1161.5 1172.4 1176.1 15856.4 16467.9 16482.0 16583.3 16808.7 546998.0 552741.0 553264.0 553744.0 554395.0 57061.7 57213.7 57407.4 57430.4 57501.7 1287.7 1338.0 1338.4 1345.7 1346.1 29997.1 31189.8 31542.2 31865.8 32032.8 49276.5 49348.8 49349.0 49484.3 49559.0 453773.0 454438.0 454934.0 454941.0 457183.0 28036.4 28709.0 28922.0 29030.9 29126.4 47593.8 47944.0 48529.0 48853.5 49296.8 40069.6 40382.4 41690.4 41902.8 42424.4 40726.8 40758.0 40762.0 41589.6 42030.8 40628.0 40913.8 41938.0 42057.4 45157.8 31124.2 34895.5 36119.0 36300.8 36583.7 27360.2 27461.5 27603.5 27729.0 27761.6 22:48:43 INFO - PROCESS | 20906 | 22:48:43 INFO - PROCESS | 20906 | [#2] jquery.html Cycles:180 Average:26818.28 Median:13249.58 stddev:68335.17 (515.8%) stddev-sans-first:68498.08 22:48:43 INFO - PROCESS | 20906 | Values: 399.5 406.6 409.5 413.8 432.9 18623.6 19381.2 19944.5 20208.4 20406.4 10424.4 10438.6 10685.8 11409.3 11533.5 5083.5 5260.3 5265.9 5271.3 5282.9 5255.2 5792.4 5812.9 5828.1 5832.3 5609.8 5765.0 5767.5 5804.2 5815.4 5781.7 6121.8 6170.1 6243.2 6247.8 5340.5 5412.6 5429.5 5433.7 5479.7 22828.0 22899.9 23311.5 23601.6 23904.6 2133.4 2253.3 2594.5 2675.5 2699.4 10179.2 10411.6 12171.5 13426.5 13990.9 1856.9 1897.7 1898.5 1922.5 1942.7 78631.6 81052.0 81268.2 83025.6 84478.6 10872.2 11171.8 11210.0 11617.2 11624.5 15820.8 15882.8 15885.2 15899.6 15956.5 7822.5 7936.7 7940.6 7947.1 8205.2 7284.7 7307.2 7423.3 7638.3 7725.3 4778.5 4883.3 4886.4 4979.3 5030.2 1995.0 2068.2 2069.3 2094.7 2103.5 924.4 959.7 1015.9 1018.5 1046.8 19353.3 19698.7 19703.9 19708.3 19943.1 975.4 995.2 1012.5 1017.2 1037.0 10546.6 10591.0 10984.2 11020.3 11124.8 383820.0 415418.0 416517.0 416726.0 419366.0 91044.5 92062.0 92274.6 93368.5 94646.5 992.7 1009.5 1019.3 1045.2 1048.9 17091.3 17489.1 18158.5 18463.4 18656.5 43268.8 44191.6 44327.7 44599.1 45109.5 56190.0 58600.0 61770.4 62756.7 63282.0 7015.2 7207.7 7477.5 7668.6 8003.5 7296.4 11656.7 12804.4 12932.4 13768.7 12015.5 12336.3 12435.9 12631.0 12940.9 11824.9 12271.2 12348.8 12407.2 12448.2 11830.6 12348.0 12363.8 12415.9 12684.2 7295.3 7469.3 7717.8 7831.4 7858.9 11616.5 11834.1 11987.5 12072.9 12140.6 22:48:43 INFO - PROCESS | 20906 | 22:48:43 INFO - PROCESS | 20906 | [#3] mootools.html Cycles:180 Average:5908.74 Median:4449.64 stddev:3458.42 (77.7%) stddev-sans-first:3452.03 22:48:43 INFO - PROCESS | 20906 | Values: 1468.8 1491.2 1604.8 1683.4 1741.5 8061.9 8357.9 8612.2 9320.0 9332.4 8126.2 8336.3 8393.1 8431.3 8434.5 2261.8 2299.8 2301.3 2307.5 2307.8 2106.3 2128.0 2130.4 2152.5 2284.8 2239.7 2262.6 2281.7 2284.1 2326.2 2189.2 2273.0 2285.8 2295.4 2295.9 2189.1 2200.2 2205.2 2208.3 2212.0 8672.0 8778.8 8809.3 8817.1 8832.6 5091.2 5154.8 5208.0 5221.7 5235.8 3308.4 3389.8 3439.3 3453.1 3494.9 1135.2 1136.8 1150.4 1154.1 1165.8 12968.2 12971.5 12981.3 12992.2 13000.8 4446.6 4557.2 4718.4 4743.8 4745.5 10829.6 10880.8 10882.7 10934.9 10941.5 5245.4 5265.8 5275.3 5289.7 5299.9 4196.6 4655.1 4779.0 4820.9 4826.3 4081.2 4144.9 4193.2 4210.3 4233.2 1253.2 1261.2 1293.5 1293.8 1333.6 911.0 948.3 964.2 994.3 1032.9 6140.2 6288.5 6316.6 6347.4 6444.9 419.0 420.1 423.0 439.0 443.0 4274.5 4313.0 4404.2 4452.6 4584.8 10969.9 11406.5 11471.7 11495.3 11522.1 11358.9 11373.1 11379.0 11398.4 11438.9 8032.0 8239.6 8291.1 8364.1 8588.0 6088.9 6118.6 6266.4 6280.6 6376.2 10111.8 10814.4 10885.3 10885.6 10918.1 10251.7 10777.1 10791.9 10810.8 10877.0 7103.8 7622.3 7688.7 7860.1 7969.2 8479.8 8543.0 8551.7 8571.5 8571.7 7437.6 7479.4 7569.1 7806.0 8188.9 7649.8 7792.1 7811.3 7812.8 8187.3 6748.2 6897.1 6897.6 6944.7 6956.4 5393.5 5467.5 5623.5 5700.8 5834.1 5278.8 5310.8 5316.3 5320.5 5421.6 22:48:43 INFO - PROCESS | 20906 | 22:48:43 INFO - PROCESS | 20906 | [#4] prototype.html Cycles:180 Average:4772.48 Median:5349.25 stddev:1408.57 (26.3%) stddev-sans-first:1372.50 22:48:43 INFO - PROCESS | 20906 | Values: 331.0 336.3 338.3 340.5 345.3 5346.3 5443.6 5480.0 5510.6 5517.9 5373.7 5448.2 5483.6 5485.3 5491.9 4316.7 4343.3 4343.9 4352.4 4357.4 4075.2 4281.8 4286.2 4324.4 4375.2 4272.9 4276.4 4279.4 4301.4 4303.9 4293.4 4297.1 4319.3 4322.7 4351.3 3693.9 3779.6 3782.6 3809.2 3820.7 5329.8 5335.4 5340.4 5352.2 5356.9 4872.6 4875.8 4908.6 4910.2 4938.4 5517.4 5640.4 5642.4 5660.9 5666.7 4103.3 4121.7 4123.4 4159.1 4159.6 5843.8 5940.7 5958.6 5961.6 6018.5 4225.1 4234.5 4239.3 4239.5 4255.5 4296.6 4309.5 4313.4 4316.2 4321.2 4903.4 4903.8 4917.7 4919.9 4960.2 5501.2 5585.4 5766.8 5782.7 5789.5 1458.9 1477.3 1485.7 1490.4 1494.3 916.3 938.2 949.6 970.7 973.4 4843.5 4872.2 4903.3 4929.5 4935.1 5217.9 5220.4 5226.9 5257.7 5264.4 4718.5 4938.6 5012.8 5023.4 5025.3 2748.7 2756.0 2767.9 2769.5 2775.3 5357.4 5410.9 5413.5 5426.5 5437.9 5280.2 5321.2 5598.5 6024.8 6039.4 6206.5 6218.5 6227.2 6231.5 6239.7 5616.4 5954.8 5956.9 5973.9 5985.7 5849.4 5861.1 5864.9 5888.1 5905.3 6192.3 6235.4 6243.8 6244.3 6281.3 4093.2 4216.3 4224.3 4233.2 4257.5 5815.4 5879.5 5915.3 5933.2 5945.8 5789.9 5809.4 5834.4 5838.0 5846.6 5783.9 5797.4 5797.6 5834.5 5837.6 5570.4 5687.3 5698.5 5701.3 5791.4 5784.2 5805.6 5847.3 5862.4 5894.2 5399.3 5637.3 5683.7 5696.3 5703.0 22:48:43 INFO - PROCESS | 20906 | 22:48:43 INFO - PROCESS | 20906 | [#5] yui.html Cycles:180 Average:22426.35 Median:3946.38 stddev:33657.47 (852.9%) stddev-sans-first:33712.53 22:48:43 INFO - PROCESS | 20906 | Values: 749.9 763.0 815.6 840.2 859.6 14974.7 16265.8 16286.2 16310.8 16415.7 15307.5 15413.4 15420.3 15513.5 15535.6 656.1 773.9 794.3 798.1 800.3 802.6 806.0 810.3 814.0 816.8 868.4 872.0 873.3 873.8 877.3 864.8 865.5 865.9 866.2 870.3 633.8 636.8 637.2 637.2 638.5 15139.5 15186.2 15310.9 15341.7 15346.3 15188.4 15219.3 15487.1 15583.0 15723.8 11710.9 11729.1 11740.5 11909.5 12224.6 3939.8 3953.0 3958.2 3990.1 4122.9 79444.0 79990.0 82365.2 82422.6 83765.2 11606.5 11782.5 11796.4 12133.7 12162.3 23348.2 23350.2 23353.9 23357.4 23399.6 8445.6 8484.6 9104.0 9116.5 9131.0 4653.7 4866.2 4885.9 4986.7 5062.6 3268.3 3289.9 3293.9 3349.8 3361.1 592.7 595.1 601.9 602.5 604.9 575.3 596.8 631.5 635.3 689.0 9968.3 10004.7 10055.5 10282.4 10345.5 709.8 730.4 735.6 763.0 779.7 4500.8 4732.9 4871.6 4915.2 4983.6 122385.0 124587.4 125189.0 126366.0 128918.4 113479.4 114059.0 114251.0 116017.0 117587.0 98356.0 99032.5 99698.0 101142.0 101484.0 8822.0 9328.3 9342.3 9484.9 9498.3 54112.0 54694.5 55143.0 55193.4 55825.0 78662.2 81393.6 82830.6 83437.0 84556.6 11298.9 11330.2 11375.0 11516.6 11550.1 13923.3 14062.4 14083.3 14152.9 14878.9 13473.7 13552.6 13819.0 13854.9 14300.9 12156.0 12241.1 12425.1 12532.9 12546.6 12915.5 13400.9 13474.3 13628.3 13678.9 10280.6 10426.0 10646.1 10916.6 10950.0 9688.2 10858.0 11140.6 11329.9 11347.5 22:48:43 INFO - PROCESS | 20906 | -------- Summary: end -------- 22:48:43 INFO - PROCESS | 20906 | 22:48:44 INFO - TEST-INFO | 20906: exit 0 22:48:44 INFO - TEST-OK | dromaeo_css | took 1112799ms 22:48:44 INFO - TEST-START | kraken 22:48:44 INFO - operating with platform_type : linux_ 22:48:44 INFO - Initialising browser for kraken test... 22:48:44 INFO - TEST-INFO | started process 21154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9s_QBD/profile http://localhost:52099/getInfo.html) 22:48:48 INFO - PROCESS | 21154 | __metrics Screen width/height:1600/1200 22:48:48 INFO - PROCESS | 21154 | colorDepth:24 22:48:48 INFO - PROCESS | 21154 | Browser inner width/height: 1024/697 22:48:48 INFO - PROCESS | 21154 | __metrics 22:48:49 ERROR - PROCESS | 21154 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 22:48:50 INFO - TEST-INFO | 21154: exit 0 22:48:50 INFO - Browser initialized. 22:48:50 INFO - Running cycle 1/1 for kraken test... 22:48:50 INFO - TEST-INFO | started process 21273 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9s_QBD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:49:02 INFO - PROCESS | 21273 | RSS: Main: 163504128 22:49:02 INFO - PROCESS | 21273 | 22:49:04 INFO - PROCESS | 21273 | Cycle 1(1): loaded http://localhost:52099/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52099/tests/kraken/driver.html?testName=audio-beat-detection) 22:49:05 INFO - PROCESS | 21273 | RSS: Main: 168075264 22:49:05 INFO - PROCESS | 21273 | 22:49:08 INFO - PROCESS | 21273 | Cycle 1(1): loaded http://localhost:52099/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52099/tests/kraken/driver.html?testName=audio-dft) 22:49:08 INFO - PROCESS | 21273 | RSS: Main: 167882752 22:49:08 INFO - PROCESS | 21273 | 22:49:11 INFO - PROCESS | 21273 | Cycle 1(1): loaded http://localhost:52099/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52099/tests/kraken/driver.html?testName=audio-fft) 22:49:12 INFO - PROCESS | 21273 | RSS: Main: 163622912 22:49:12 INFO - PROCESS | 21273 | 22:49:14 INFO - PROCESS | 21273 | Cycle 1(1): loaded http://localhost:52099/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52099/tests/kraken/driver.html?testName=audio-oscillator) 22:49:15 INFO - PROCESS | 21273 | RSS: Main: 164835328 22:49:15 INFO - PROCESS | 21273 | 22:49:17 INFO - PROCESS | 21273 | Cycle 1(1): loaded http://localhost:52099/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52099/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:49:18 INFO - PROCESS | 21273 | RSS: Main: 165367808 22:49:18 INFO - PROCESS | 21273 | 22:49:21 INFO - PROCESS | 21273 | Cycle 1(1): loaded http://localhost:52099/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52099/tests/kraken/driver.html?testName=imaging-darkroom) 22:49:21 INFO - PROCESS | 21273 | RSS: Main: 165146624 22:49:21 INFO - PROCESS | 21273 | 22:49:25 INFO - PROCESS | 21273 | Cycle 1(1): loaded http://localhost:52099/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52099/tests/kraken/driver.html?testName=imaging-desaturate) 22:49:25 INFO - PROCESS | 21273 | RSS: Main: 162377728 22:49:25 INFO - PROCESS | 21273 | 22:49:28 INFO - PROCESS | 21273 | Cycle 1(1): loaded http://localhost:52099/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52099/tests/kraken/driver.html?testName=json-parse-financial) 22:49:29 INFO - PROCESS | 21273 | RSS: Main: 164622336 22:49:29 INFO - PROCESS | 21273 | 22:49:30 INFO - PROCESS | 21273 | Cycle 1(1): loaded http://localhost:52099/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52099/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:49:31 INFO - PROCESS | 21273 | RSS: Main: 164667392 22:49:31 INFO - PROCESS | 21273 | 22:49:33 INFO - PROCESS | 21273 | Cycle 1(1): loaded http://localhost:52099/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52099/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:49:33 INFO - PROCESS | 21273 | RSS: Main: 164507648 22:49:33 INFO - PROCESS | 21273 | 22:49:35 INFO - PROCESS | 21273 | Cycle 1(1): loaded http://localhost:52099/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52099/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:49:36 INFO - PROCESS | 21273 | RSS: Main: 164618240 22:49:36 INFO - PROCESS | 21273 | 22:49:39 INFO - PROCESS | 21273 | Cycle 1(1): loaded http://localhost:52099/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52099/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:49:39 INFO - PROCESS | 21273 | RSS: Main: 165199872 22:49:39 INFO - PROCESS | 21273 | 22:49:42 INFO - PROCESS | 21273 | Cycle 1(1): loaded http://localhost:52099/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52099/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:49:43 INFO - PROCESS | 21273 | RSS: Main: 165351424 22:49:43 INFO - PROCESS | 21273 | 22:49:45 INFO - PROCESS | 21273 | Cycle 1(1): loaded http://localhost:52099/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52099/tests/kraken/driver.html?testName=ai-astar) 22:49:45 INFO - PROCESS | 21273 | RSS: Main: 166060032 22:49:45 INFO - PROCESS | 21273 | 22:49:45 INFO - PROCESS | 21273 | __start_tp_report 22:49:45 INFO - PROCESS | 21273 | _x_x_mozilla_page_load 22:49:45 INFO - PROCESS | 21273 | _x_x_mozilla_page_load_details 22:49:45 INFO - PROCESS | 21273 | |i|pagename|runs| 22:49:45 INFO - PROCESS | 21273 | |0;ai-astar;101;112;107;112;112;113;112;111;111;112 22:49:45 INFO - PROCESS | 21273 | |1;audio-beat-detection;144;123;145;186;120;154;148;121;175;120 22:49:45 INFO - PROCESS | 21273 | |2;audio-dft;162;161;163;164;163;173;163;162;164;164 22:49:45 INFO - PROCESS | 21273 | |3;audio-fft;75;76;77;181;77;76;83;76;169;76 22:49:45 INFO - PROCESS | 21273 | |4;audio-oscillator;86;85;151;85;85;84;143;85;84;144 22:49:45 INFO - PROCESS | 21273 | |5;imaging-gaussian-blur;118;117;117;118;117;117;117;117;118;117 22:49:45 INFO - PROCESS | 21273 | |6;imaging-darkroom;148;148;147;148;148;149;147;148;147;147 22:49:45 INFO - PROCESS | 21273 | |7;imaging-desaturate;97;96;96;96;95;95;96;96;95;96 22:49:45 INFO - PROCESS | 21273 | |8;json-parse-financial;50;51;52;51;54;50;54;52;50;51 22:49:45 INFO - PROCESS | 21273 | |9;json-stringify-tinderbox;61;61;63;60;62;60;61;61;61;62 22:49:45 INFO - PROCESS | 21273 | |10;stanford-crypto-aes;76;82;78;82;78;77;79;76;76;80 22:49:45 INFO - PROCESS | 21273 | |11;stanford-crypto-ccm;139;124;138;127;126;131;121;134;150;140 22:49:45 INFO - PROCESS | 21273 | |12;stanford-crypto-pbkdf2;160;166;162;161;157;159;169;165;161;165 22:49:45 INFO - PROCESS | 21273 | |13;stanford-crypto-sha256-iterative;65;64;65;67;66;67;63;66;67;64 22:49:45 INFO - PROCESS | 21273 | __end_tp_report 22:49:45 INFO - PROCESS | 21273 | __start_cc_report 22:49:45 INFO - PROCESS | 21273 | _x_x_mozilla_cycle_collect,852 22:49:45 INFO - PROCESS | 21273 | __end_cc_report 22:49:45 INFO - PROCESS | 21273 | __startTimestamp1470721785263__endTimestamp 22:49:45 INFO - PROCESS | 21273 | 22:49:45 INFO - PROCESS | 21273 | ------- Summary: start ------- 22:49:45 INFO - PROCESS | 21273 | Number of tests: 14 22:49:45 INFO - PROCESS | 21273 | 22:49:45 INFO - PROCESS | 21273 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:3.65 (3.3%) stddev-sans-first:1.73 22:49:45 INFO - PROCESS | 21273 | Values: 101.0 112.0 107.0 112.0 112.0 113.0 112.0 111.0 111.0 112.0 22:49:45 INFO - PROCESS | 21273 | 22:49:45 INFO - PROCESS | 21273 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:146.50 stddev:23.48 (16.0%) stddev-sans-first:24.91 22:49:45 INFO - PROCESS | 21273 | Values: 144.0 123.0 145.0 186.0 120.0 154.0 148.0 121.0 175.0 120.0 22:49:45 INFO - PROCESS | 21273 | 22:49:45 INFO - PROCESS | 21273 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:3.35 (2.0%) stddev-sans-first:3.48 22:49:45 INFO - PROCESS | 21273 | Values: 162.0 161.0 163.0 164.0 163.0 173.0 163.0 162.0 164.0 164.0 22:49:45 INFO - PROCESS | 21273 | 22:49:45 INFO - PROCESS | 21273 | [#3] audio-fft Cycles:10 Average:96.60 Median:76.00 stddev:41.48 (54.6%) stddev-sans-first:43.25 22:49:45 INFO - PROCESS | 21273 | Values: 75.0 76.0 77.0 181.0 77.0 76.0 83.0 76.0 169.0 76.0 22:49:45 INFO - PROCESS | 21273 | 22:49:45 INFO - PROCESS | 21273 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:85.00 stddev:29.61 (34.8%) stddev-sans-first:30.75 22:49:45 INFO - PROCESS | 21273 | Values: 86.0 85.0 151.0 85.0 85.0 84.0 143.0 85.0 84.0 144.0 22:49:45 INFO - PROCESS | 21273 | 22:49:45 INFO - PROCESS | 21273 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 22:49:45 INFO - PROCESS | 21273 | Values: 118.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 22:49:45 INFO - PROCESS | 21273 | 22:49:45 INFO - PROCESS | 21273 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 22:49:45 INFO - PROCESS | 21273 | Values: 148.0 148.0 147.0 148.0 148.0 149.0 147.0 148.0 147.0 147.0 22:49:45 INFO - PROCESS | 21273 | 22:49:45 INFO - PROCESS | 21273 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 22:49:45 INFO - PROCESS | 21273 | Values: 97.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 96.0 22:49:45 INFO - PROCESS | 21273 | 22:49:45 INFO - PROCESS | 21273 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.50 stddev:1.51 (2.9%) stddev-sans-first:1.50 22:49:45 INFO - PROCESS | 21273 | Values: 50.0 51.0 52.0 51.0 54.0 50.0 54.0 52.0 50.0 51.0 22:49:45 INFO - PROCESS | 21273 | 22:49:45 INFO - PROCESS | 21273 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 22:49:45 INFO - PROCESS | 21273 | Values: 61.0 61.0 63.0 60.0 62.0 60.0 61.0 61.0 61.0 62.0 22:49:45 INFO - PROCESS | 21273 | 22:49:45 INFO - PROCESS | 21273 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.50 stddev:2.32 (3.0%) stddev-sans-first:2.29 22:49:45 INFO - PROCESS | 21273 | Values: 76.0 82.0 78.0 82.0 78.0 77.0 79.0 76.0 76.0 80.0 22:49:45 INFO - PROCESS | 21273 | 22:49:45 INFO - PROCESS | 21273 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:136.00 stddev:8.91 (6.5%) stddev-sans-first:9.18 22:49:45 INFO - PROCESS | 21273 | Values: 139.0 124.0 138.0 127.0 126.0 131.0 121.0 134.0 150.0 140.0 22:49:45 INFO - PROCESS | 21273 | 22:49:45 INFO - PROCESS | 21273 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:163.50 stddev:3.66 (2.2%) stddev-sans-first:3.77 22:49:45 INFO - PROCESS | 21273 | Values: 160.0 166.0 162.0 161.0 157.0 159.0 169.0 165.0 161.0 165.0 22:49:45 INFO - PROCESS | 21273 | 22:49:45 INFO - PROCESS | 21273 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:1.43 (2.2%) stddev-sans-first:1.51 22:49:45 INFO - PROCESS | 21273 | Values: 65.0 64.0 65.0 67.0 66.0 67.0 63.0 66.0 67.0 64.0 22:49:45 INFO - PROCESS | 21273 | -------- Summary: end -------- 22:49:45 INFO - PROCESS | 21273 | 22:49:46 INFO - TEST-INFO | 21273: exit 0 22:49:46 INFO - TEST-OK | kraken | took 61917ms 22:49:46 INFO - SUITE-END | took 1174s 22:49:46 INFO - Completed test suite (00:19:34) 22:49:46 INFO - javascript benchmark 22:49:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7272.244465374701, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3065.7240848323654, 3080.3069309405373, 3099.163225928999, 3105.456545104606, 3106.798058126222, 5310.8406747797535, 5350.89298214036, 5368.221607866857, 5382.569394448445, 5463.043967305715, 5306.177542480922, 5340.652857564256, 5357.062514060033, 5382.434844341346, 5434.510894019538, 4811.133995880731, 4881.707097574139, 4929.112759703252, 5003.699778013312, 5031.77357018935, 4930.654854160192, 4993.700377977315, 5036.84889453317, 5041.546260836524, 5078.5937125029905, 4884.633652476061, 4926.605871530269, 4959.851204463872, 4972.204447288453, 5055.823046193403, 4996.400431948189, 5006.724630145341, 5021.297018417425, 5024.070546948826, 5053.216751403538, 4950.851474455772, 4961.950380496185, 4965.379327584052, 4975.875603109951, 5037.773300201499, 5221.13851214553, 5315.6013299002725, 5398.595105367113, 5462.126059830408, 5523.585731070186, 5852.092925596539, 5865.677387743673, 5869.354371019184, 5871.970640146772, 5882.411758824126, 5862.589618726691, 5875.706214689249, 5876.942150412924, 5884.0585506318785, 5894.440028197314, 5205.193195054735, 5294.258803767476, 5297.49673780994, 5342.839714808562, 5425.26758887553, 5840.649561026352, 5849.239598852122, 5865.472107510259, 5872.559558033165, 5883.852903677443, 5565.749541270652, 5585.469380408855, 5593.161025846156, 5624.91562626561, 5628.662280263197, 5564.276644036249, 5621.353544342453, 5628.296462942132, 5650.26546548946, 5662.5753068520025, 5672.319321681424, 5746.827595172152, 5752.568557358215, 5755.194272801811, 5808.796692115756, 5776.537876969833, 5802.448767367094, 5822.243108395882, 5839.883202335929, 5847.678377689268, 4353.216421044179, 4387.758673273001, 4392.055708022726, 4483.349914262414, 4522.095580883836, 3939.27123482151, 3956.8219430125714, 3973.6821054315587, 3973.900652483653, 3980.5223373195404, 5491.588130890199, 5568.526675232651, 5570.693611851306, 5581.441855814467, 5585.357683866326, 5658.943410565924, 5684.062129748628, 5717.256756621613, 5780.393058728857, 5837.095250236135, 5551.916721249185, 5566.944330556643, 5567.972160139173, 5570.025245582007, 5601.383847776741, 4931.0630980113665, 4941.901161976741, 4985.326980857538, 4992.450830408652, 4995.825146119869, 5876.324222714357, 5979.551533634908, 5983.730732116978, 5991.2510936132985, 5997.220361352996, 5797.275340582427, 5834.474897259267, 5847.649141051551, 5869.236999190078, 5881.911771323519, 6033.939660603338, 6047.274327080779, 6057.787977420945, 6059.0, 6065.302490213682, 5435.891282174413, 5608.327000759935, 5647.915281270702, 5709.314882214161, 5719.8570035749435, 5736.827895163152, 5749.942500575108, 5808.07070868659, 5809.709514524341, 5817.650940943557, 5617.9719101404235, 5637.802676906289, 5648.011597970257, 5663.5469162467725, 5664.745086471036, 5458.181272809111, 5589.217509548585, 5637.718114094361, 5653.236813030353, 5656.264685590847, 5562.9986602411955, 5590.413006634408, 5620.971895140498, 5650.773969041193, 5676.801311954062, 5609.411011843861, 5657.179708942263, 5703.429657034263, 5726.713664316684, 5764.510016648632, 5334.359876814652, 5462.945370546403, 5483.177523371367, 5591.245181900392, 5614.354349249726], "value": 5334.3673187942695, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.8160302538365, 567.2144080448577, 576.9019266724657, 601.5548494114354, 613.6808859393113, 36848.26303473932, 41086.38370424442, 41112.17775644489, 41236.38145427821, 41311.38032929501, 42245.0, 42668.0, 42699.57300426995, 42855.571444285546, 42876.57123428765, 8644.265237454823, 8811.427257228292, 8822.073682263366, 8833.867491987625, 8844.336674749387, 8597.871031934526, 8697.130286971316, 8703.651853925836, 8730.345224108185, 8757.912420875773, 8776.64893404263, 8781.604827782734, 8801.867971980426, 8827.33794965377, 8859.512726800023, 8722.956385218096, 8746.956265218665, 8757.211850933414, 8815.559222038937, 8822.867656985087, 8708.95492540899, 8710.47737135774, 8730.126987301282, 8761.824763504757, 8762.649494020232, 40674.593254067375, 40924.0, 40958.59041409607, 41154.58845411537, 41331.38002929959, 3389.5085212644276, 3405.6594340565994, 3465.7747246428903, 3481.529993450877, 3495.4582039783872, 29923.25191870199, 32184.839075804706, 32333.51499727506, 32660.0, 32918.341633167205, 4364.956350436487, 4380.540043295472, 4473.753943533105, 4498.077894031716, 4623.838165664186, 343862.0, 345380.0, 346104.0, 346221.0, 346793.0, 58353.70823145942, 59147.0, 59352.70323648354, 59448.40551594515, 59569.0, 62049.37950620436, 62328.68835655793, 62810.0, 62851.685741571, 62914.0, 14992.625184370478, 15211.695766084838, 15250.847491524943, 15259.694806103817, 15652.843471565138, 11775.764484710258, 11779.705507362385, 11815.0, 11818.940905295418, 11915.165938384403, 19134.0, 19181.904090479456, 19190.712139317922, 19293.710594341097, 19443.90278048629, 7239.8552028960175, 7250.039961636888, 7395.2235015323695, 7470.925290747132, 7548.66031028605, 937.1378331934636, 937.6296362936602, 956.6890760502864, 1011.4942528735633, 1084.951177197028, 30469.23826904301, 30537.541936870966, 30702.846485767874, 30785.0, 31142.532862006636, 1073.355986408149, 1129.4691494997337, 1161.488944864257, 1172.4196522721309, 1176.1355403778216, 15856.44502442409, 16467.917660411622, 16482.0, 16583.336666533203, 16808.74786878198, 546998.0, 552741.0, 553264.0, 553744.0, 554395.0, 57061.71469142628, 57213.71393143007, 57407.42592574021, 57430.42569574251, 57501.712491437276, 1287.6909541709922, 1337.9933100334435, 1338.3709656461447, 1345.6703107738472, 1346.1250187378087, 29997.070404631842, 31189.8440507796, 31542.211444714067, 31865.840670797425, 32032.83983580067, 49276.507234927194, 49348.75325623349, 49349.0, 49484.257736133266, 49559.0, 453773.0, 454438.0, 454934.0, 454941.0, 457183.0, 28036.43927121487, 28709.0, 28922.0, 29030.854845725637, 29126.41747165087, 47593.762031189624, 47944.0, 48529.0, 48853.5114648849, 49296.75351623219, 40069.59930400775, 40382.39426408665, 41690.374644380965, 41902.79048604737, 42424.42352706759, 40726.79636601798, 40758.0, 40761.96190190419, 41589.58410415857, 42030.789846050575, 40628.0, 40913.795431022656, 41938.0, 42057.369139462324, 45157.77421112874, 31124.22189445282, 34895.476567850994, 36119.0, 36300.81849590735, 36583.69536417258, 27360.179194624194, 27461.45077098487, 27603.476800503795, 27729.0, 27761.583576246776], "value": 19887.319348193912, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.47469078162214, 406.5893447617905, 409.4636026804886, 413.7806962309976, 432.87879393769737, 18623.627527449444, 19381.224751009944, 19944.50138746532, 20208.39374818756, 20406.387808365736, 10424.374537527734, 10438.634647787329, 10685.78628427431, 11409.31544107354, 11533.480993355299, 5083.491650834924, 5260.263563101169, 5265.921011184835, 5271.288376069239, 5282.920756188661, 5255.211718242256, 5792.362840087587, 5812.912806307909, 5828.0966450200285, 5832.329282132567, 5609.80365687201, 5764.971175144139, 5767.538596912237, 5804.216430781833, 5815.360310365856, 5781.653100813944, 6121.816345509642, 6170.105334726484, 6243.157173781527, 6247.781327653511, 5340.492653197979, 5412.5940554458575, 5429.511343979021, 5433.7283135843445, 5479.698616576086, 22828.0, 22899.88550057239, 23311.533769324687, 23601.645975310385, 23904.641430378557, 2133.370655656585, 2253.3240027991537, 2594.5200137974534, 2675.5451573232403, 2699.35215548269, 10179.18566514677, 10411.583536658525, 12171.452284647123, 13426.530071447452, 13990.930045349809, 1856.9322639482352, 1897.7248298996706, 1898.4589392023206, 1922.4617107209863, 1942.7280180774703, 78631.606841966, 81052.0, 81268.18731812666, 83025.58487207585, 84478.57760711218, 10872.238943273895, 11171.83242251367, 11210.0, 11617.244879082833, 11624.488816453806, 15820.76268855968, 15882.808789340846, 15885.205739712968, 15899.602509937344, 15956.521304360887, 7822.530648161129, 7936.682532698743, 7940.563269020144, 7947.086085100172, 8205.220504052106, 7284.745033923788, 7307.19620841707, 7423.331900129015, 7638.274363935418, 7725.343345815556, 4778.474367819537, 4883.34074899891, 4886.389201349832, 4979.30289759434, 5030.170021946411, 1994.9925287729893, 2068.2244158440585, 2069.3378119001777, 2094.74863016439, 2103.4846462616756, 924.4314746430897, 959.6785076999283, 1015.8527013582989, 1018.5467466977273, 1046.8482070099792, 19353.322633707754, 19698.70451943222, 19703.901480492506, 19708.31020914261, 19943.102560384526, 975.4439969217619, 995.2386424385351, 1012.5494155101056, 1017.2014968249888, 1036.9533370998324, 10546.630867919586, 10591.0, 10984.176186786022, 11020.338779673086, 11124.777504449865, 383820.0, 415418.0, 416517.0, 416726.0, 419366.0, 91044.54477727569, 92062.0, 92274.61588076185, 93368.53315733378, 94646.5267673671, 992.7418871093568, 1009.4952523738131, 1019.3323373190572, 1045.1951996962448, 1048.8741351037925, 17091.316347345968, 17489.125543722508, 18158.546036348667, 18463.353782617545, 18656.533586659898, 43268.78365608152, 44191.55808441874, 44327.670169894955, 44599.10801784011, 45109.548904510535, 56190.0, 58600.0, 61770.38229617646, 62756.686216568625, 63282.0, 7015.158181018311, 7207.747728829466, 7477.476576639583, 7668.57822819728, 8003.5197888126895, 7296.4162866969455, 11656.708582285512, 12804.359782010675, 12932.41804118798, 13768.655783605089, 12015.519379224734, 12336.321502317458, 12435.937820311203, 12631.0, 12940.935295323463, 11824.940875295568, 12271.202371845802, 12348.81476777831, 12407.193532420364, 12448.190867593577, 11830.645080647595, 12348.0, 12363.814542781685, 12415.93792031034, 12684.23894566329, 7295.270472952662, 7469.290417410337, 7717.80705482345, 7831.412644051833, 7858.921410785819, 11616.477258523219, 11834.112441566745, 11987.460564274803, 12072.879271207526, 12140.635780926234], "value": 9115.5774265927, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1468.7870258812472, 1491.179851081905, 1604.783354247177, 1683.4108062178232, 1741.45144279552, 8061.91938080619, 8357.91642083579, 8612.181842724938, 9320.0, 9332.440053596789, 8126.1873812618705, 8336.291415229713, 8393.118722534138, 8431.325493960483, 8434.53610051447, 2261.762514935933, 2299.793018628323, 2301.2750983440246, 2307.4692820651176, 2307.8038366738765, 2106.273335699189, 2128.031745555776, 2130.360891732482, 2152.5049238675115, 2284.805791507724, 2239.6562062762373, 2262.558801033799, 2281.7147856517936, 2284.0635339510804, 2326.2439707095177, 2189.179057853305, 2273.0453209651905, 2285.828562857784, 2295.437617783637, 2295.8979689749012, 2189.1134090693295, 2200.1859312054644, 2205.195103787122, 2208.293346129239, 2212.037763572835, 8672.0, 8778.780530486789, 8809.295256379473, 8817.118288171196, 8832.55837208137, 5091.23631455281, 5154.768035438415, 5208.036513245024, 5221.686698798084, 5235.79576697358, 3308.371409432224, 3389.7796643218358, 3439.329330780499, 3453.1021934297014, 3494.947575786365, 1135.182668478694, 1136.8237923121928, 1150.3787954504558, 1154.0767386091177, 1165.8134698448293, 12968.157069790434, 12971.5459958901, 12981.286029268387, 12992.155509891827, 13000.804987925188, 4446.644268458515, 4557.225271703818, 4718.363020992191, 4743.762811859393, 4745.454272758677, 10829.620963266405, 10880.78238435227, 10882.673519794418, 10934.890651093547, 10941.45292735376, 5245.449227831099, 5265.842024739264, 5275.261463395128, 5289.68261904287, 5299.947000529945, 4196.643285320782, 4655.138799322136, 4779.02030083839, 4820.855374338776, 4826.32431459596, 4081.2449696806184, 4144.896377590524, 4193.161367726406, 4210.32634778434, 4233.216854881856, 1253.235526328957, 1261.2279746955542, 1293.5213970830853, 1293.8188653588504, 1333.5599252246736, 910.9908900911039, 948.3266880514774, 964.1997142371955, 994.3337963564285, 1032.902625542948, 6140.232470941132, 6288.465480434123, 6316.589421687576, 6347.39699728525, 6444.903326450107, 418.9601987811153, 420.0632589325821, 422.9894252643709, 439.03631528794625, 442.98228070876803, 4274.465691788527, 4312.956870431318, 4404.185225733249, 4452.643788496913, 4584.839530616412, 10969.890301097046, 11406.543738250377, 11471.680756712918, 11495.310281383145, 11522.07823374128, 11358.886411135949, 11373.090152787758, 11379.0, 11398.430078496041, 11438.94280528592, 8031.959840200761, 8239.588020598947, 8291.129431409736, 8364.121767214476, 8588.0, 6088.8782224356155, 6118.632882027093, 6266.404691554295, 6280.623162610258, 6376.171097757262, 10111.848322275024, 10814.35113893169, 10885.346879187275, 10885.619003334845, 10918.126549875831, 10251.692449226535, 10777.08394786452, 10791.892081079088, 10810.783784324112, 10876.966688164928, 7103.751368702071, 7622.31399174077, 7688.6540105696495, 7860.135385107519, 7969.242921922408, 8479.830403391774, 8543.0, 8551.74344769658, 8571.485710857369, 8571.742847714579, 7437.590932498764, 7479.439042071976, 7569.1295501018085, 7805.9609701953395, 8188.877166842383, 7649.847003060019, 7792.064952205772, 7811.257930496594, 7812.84374312522, 8187.321599072295, 6748.156480439945, 6897.068895699016, 6897.62063086515, 6944.722211111701, 6956.40870526011, 5393.487618676219, 5467.480589344006, 5623.522000629992, 5700.771969121189, 5834.066549352084, 5278.81524146653, 5310.761015754378, 5316.308879845596, 5320.467953204648, 5421.5933804964], "value": 4602.42615661816, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.9553210316608, 336.3139196040078, 338.30815981318204, 340.4654692133351, 345.33522968286076, 5346.315910488193, 5443.591730620199, 5480.013597552444, 5510.614257002011, 5517.889642207158, 5373.704446255454, 5448.237246785453, 5483.561315094793, 5485.286912701353, 5491.945080549193, 4316.661834831212, 4343.326784348431, 4343.869683909487, 4352.39066530686, 4357.433533640622, 4075.1849630073957, 4281.764502952336, 4286.207051695431, 4324.37296591994, 4375.190589740892, 4272.850450234242, 4276.4440622719, 4279.358096285551, 4301.376300436435, 4303.935440968388, 4293.441852559178, 4297.087795930796, 4319.287317592593, 4322.654187664979, 4351.303791393362, 3693.9261214775825, 3779.5842457329672, 3782.6217378262227, 3809.1619843634357, 3820.6752426043818, 5329.760160792774, 5335.413104558495, 5340.439253878365, 5352.190100197388, 5356.946430535684, 4872.634552408584, 4875.756212189376, 4908.631852611068, 4910.238912968495, 4938.407391113054, 5517.399954013331, 5640.351359593658, 5642.4357564243655, 5660.943390566124, 5666.660000399989, 4103.343465045608, 4121.711480196387, 4123.402106694542, 4159.064210552631, 4159.563245859172, 5843.766249350064, 5940.732667029951, 5958.5828991970575, 5961.552883533753, 6018.518518518552, 4225.056474021984, 4234.470691163605, 4239.27932251518, 4239.533651298355, 4255.468066491689, 4296.6347860432215, 4309.482862056573, 4313.41768861206, 4316.179925814085, 4321.178975994614, 4903.411590609078, 4903.754812259373, 4917.704937703749, 4919.926201106986, 4960.181570040975, 5501.202325662756, 5585.413531579125, 5766.769329226868, 5782.681952492653, 5789.53683705311, 1458.875995540391, 1477.2761346940138, 1485.68057867559, 1490.3740429019838, 1494.305148106136, 916.2669864108686, 938.1697197979837, 949.6011675096476, 970.6798753694969, 973.3527204408989, 4843.515648435199, 4872.244802055687, 4903.289023091703, 4929.545783993731, 4935.062338155811, 5217.921426358391, 5220.3735551734035, 5226.890000449726, 5257.684538927677, 5264.394594621591, 4718.528147185254, 4938.555530002317, 5012.7994880205115, 5023.422306434807, 5025.346704928409, 2748.670159580823, 2756.0, 2767.9308017299727, 2769.515334816399, 2775.292300463369, 5357.357117145967, 5410.945890541044, 5413.53984911287, 5426.484483974016, 5437.9124175165125, 5280.234366016906, 5321.210910180868, 5598.524125449382, 6024.789132380433, 6039.4262545058145, 6206.534509911775, 6218.502519798405, 6227.194113707064, 6231.470325022424, 6239.688015599293, 5616.382197958303, 5954.838806432704, 5956.851078723066, 5973.940260597338, 5985.730642121028, 5849.356570777126, 5861.0915308127305, 5864.882702346014, 5888.146218798164, 5905.320888097924, 6192.256929168529, 6235.438810506895, 6243.750249989949, 6244.250689917239, 6281.309056003927, 4093.2427500912427, 4216.325387937915, 4224.324108142682, 4233.1956928183545, 4257.531671516069, 5815.3603103657715, 5879.5002424794375, 5915.260592425947, 5933.169356290036, 5945.821625351246, 5789.855253618524, 5809.36097029318, 5834.445727656036, 5837.956715149664, 5846.619969701956, 5783.8554036149435, 5797.449242321973, 5797.565182611405, 5834.533237341087, 5837.620554663933, 5570.387257401601, 5687.289088863892, 5698.458646428583, 5701.258836351248, 5791.362950075572, 5784.190213370048, 5805.593608447368, 5847.327557330961, 5862.384449632727, 5894.174815525744, 5399.299220745453, 5637.308807357695, 5683.7442315095095, 5696.344920334214, 5702.971485142713], "value": 4322.580950986886, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.8650242956268, 763.0, 815.6085079162006, 840.1892174052039, 859.6260626627416, 14974.700505989887, 16265.83734162658, 16286.185690715476, 16310.7553386699, 16415.67168656626, 15307.540773776776, 15413.383464661429, 15420.306086226119, 15513.534593962198, 15535.611609709764, 656.1273506236694, 773.8529679360903, 794.2811755361407, 798.1180795221284, 800.2957397490201, 802.574635443216, 806.0408114343912, 810.2869474862113, 814.0109766633539, 816.7631386897792, 868.3704314372093, 872.0233338660709, 873.3362644390246, 873.7597160780805, 877.32007694037, 864.8140649760301, 865.536937738307, 865.8744482050131, 866.1944391715701, 870.2994089757742, 633.8098570428899, 636.8185067255856, 637.1716768201366, 637.2034956304619, 638.450932198309, 15139.54581362561, 15186.164760938143, 15310.923445382701, 15341.693166136727, 15346.309416076192, 15188.392464301414, 15219.315130819139, 15487.070775753491, 15583.0, 15723.842761572352, 11710.941445292805, 11729.12031597625, 11740.471678774476, 11909.523619055228, 12224.633261002184, 3939.7833119178435, 3952.980235098835, 3958.188571342868, 3990.142119444304, 4122.876313710593, 79444.0, 79990.0, 82365.17634823635, 82422.58788706017, 83765.16234837634, 11606.477708503138, 11782.469788859522, 11796.351200684045, 12133.69665758363, 12162.331071790959, 23348.18281360144, 23350.18274360389, 23353.88323058374, 23357.41606459852, 23399.649005264935, 8445.57772111392, 8484.618192181366, 9104.0, 9116.49859257734, 9130.95434522823, 4653.7207767534055, 4866.197077482247, 4885.854702548498, 4986.675866068694, 5062.594992400599, 3268.2809781847955, 3289.9177520562175, 3293.9176520587175, 3349.8325083745717, 3361.0757041813695, 592.733270028489, 595.0627761276007, 601.9367966363557, 602.5149754447624, 604.8699529601157, 575.3067553597905, 596.8269201931391, 631.4979591224987, 635.259922190652, 688.9862202755917, 9968.302218844756, 10004.699859004242, 10055.547500362502, 10282.383057016454, 10345.482725863676, 709.815447983528, 730.3682314797662, 735.6064505489537, 762.9618519074024, 779.742684913977, 4500.842470513517, 4732.905341893143, 4871.634627402888, 4915.2028018646015, 4983.626228032912, 122384.98535131881, 124587.37706311591, 125189.0, 126366.0, 128918.35540822236, 113479.43260283646, 114059.0, 114251.0, 116017.0, 117587.0, 98356.0, 99032.5048374768, 99698.0, 101142.0, 101484.0, 8822.0, 9328.300377471853, 9342.252619790537, 9484.905150948678, 9498.292514403114, 54112.0, 54694.45305546893, 55143.0, 55193.44806552044, 55825.0, 78662.21337786548, 81393.59303203446, 82830.58584707038, 83437.0, 84556.57721711352, 11298.943505282421, 11330.150238732293, 11375.033122184706, 11516.560429946257, 11550.133739969704, 13923.303834808421, 14062.367193476523, 14083.295835207993, 14152.92923535417, 14878.925605371904, 13473.663158421117, 13552.59342219735, 13819.0, 13854.861451385761, 14300.928495357457, 12156.0, 12241.143119981516, 12425.13024088305, 12532.87467125317, 12546.560870369858, 12915.547955821501, 13400.865991339962, 13474.326283685972, 13628.31858407056, 13678.86321136776, 10280.640177593748, 10426.0, 10646.095081918123, 10916.617918372818, 10950.0, 9688.214209579302, 10858.0, 11140.554377824796, 11329.943350283196, 11347.54609815598], "value": 7687.650171799891, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 107.0, 112.0, 112.0, 113.0, 112.0, 111.0, 111.0, 112.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 123.0, 145.0, 186.0, 120.0, 154.0, 148.0, 121.0, 175.0, 120.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 164.0, 163.0, 173.0, 163.0, 162.0, 164.0, 164.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 181.0, 77.0, 76.0, 83.0, 76.0, 169.0, 76.0], "value": 96.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 151.0, 85.0, 85.0, 84.0, 143.0, 85.0, 84.0, 144.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 148.0, 149.0, 147.0, 148.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 52.0, 51.0, 54.0, 50.0, 54.0, 52.0, 50.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 63.0, 60.0, 62.0, 60.0, 61.0, 61.0, 61.0, 62.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 78.0, 82.0, 78.0, 77.0, 79.0, 76.0, 76.0, 80.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 124.0, 138.0, 127.0, 126.0, 131.0, 121.0, 134.0, 150.0, 140.0], "value": 133.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 166.0, 162.0, 161.0, 157.0, 159.0, 169.0, 165.0, 161.0, 165.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 67.0, 66.0, 67.0, 63.0, 66.0, 67.0, 64.0], "value": 65.4, "unit": "score"}]}]} 22:49:46 INFO - Return code: 0 22:49:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:49:46 ERROR - # TBPL SUCCESS # 22:49:46 INFO - Running post-action listener: _resource_record_post_action 22:49:46 INFO - [mozharness: 2016-08-09 05:49:46.576229Z] Finished run-tests step (success) 22:49:46 INFO - Running post-run listener: _resource_record_post_run 22:49:46 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 559665152; Read time: 120; Write time: 552716 22:49:46 INFO - TinderboxPrint: CPU usage
13.4% 22:49:46 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 120 22:49:46 INFO - TinderboxPrint: I/O write bytes / time
559,665,152 / 552,716 22:49:46 INFO - TinderboxPrint: CPU idle
8,237.7 (86.6%) 22:49:46 INFO - TinderboxPrint: CPU user
1,215.1 (12.8%) 22:49:46 INFO - TinderboxPrint: Swap in / out
0 / 0 22:49:46 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 267350016; Read time: 0; Write time: 286688 22:49:46 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291340288; Read time: 100; Write time: 266028 22:49:47 INFO - Running post-run listener: _upload_blobber_files 22:49:47 INFO - Blob upload gear active. 22:49:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:49:47 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 22:49:47 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:49:47 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:49:47 INFO - (blobuploader) - INFO - Open directory for files ... 22:49:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:49:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:49:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:49:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:49:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:49:48 INFO - (blobuploader) - INFO - Done attempting. 22:49:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:49:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:49:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:49:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:49:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:49:49 INFO - (blobuploader) - INFO - Done attempting. 22:49:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:49:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:49:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:49:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:49:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:49:52 INFO - (blobuploader) - INFO - Done attempting. 22:49:52 INFO - (blobuploader) - INFO - Iteration through files over. 22:49:52 INFO - Return code: 0 22:49:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:49:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:49:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/71b45366029cd9f9435daeddc5f956861e507180bba89f179023725425855e22cf180379a2147a737056c9691845648e0d36552054117d3e7d2677fc68674a88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8340aa78f27af08dd02abc1322d47a2c00028bcddc3beae361ad5a927d6c700bdbb48f9b91ca3e53bd45a8e17b72c4b99fcd6c86bbe25cdabbd6236a891cfdb3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6d6888cefdfb19d0d3e4826b0c38fcc01058ababf629b01f43c4c61fefc44ddd28d10643df15f557b09c5ce6c5a52adbb3620b55ead46ba04e1a3a224d21dc8c"} 22:49:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:49:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:49:52 INFO - Contents: 22:49:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/71b45366029cd9f9435daeddc5f956861e507180bba89f179023725425855e22cf180379a2147a737056c9691845648e0d36552054117d3e7d2677fc68674a88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8340aa78f27af08dd02abc1322d47a2c00028bcddc3beae361ad5a927d6c700bdbb48f9b91ca3e53bd45a8e17b72c4b99fcd6c86bbe25cdabbd6236a891cfdb3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6d6888cefdfb19d0d3e4826b0c38fcc01058ababf629b01f43c4c61fefc44ddd28d10643df15f557b09c5ce6c5a52adbb3620b55ead46ba04e1a3a224d21dc8c"} 22:49:52 INFO - Running post-run listener: copy_logs_to_upload_dir 22:49:52 INFO - Copying logs to upload dir... 22:49:52 INFO - mkdir: /builds/slave/test/build/upload/logs 22:49:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.182836 ========= master_lag: 0.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-08-08 22:49:52.793043) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 22:49:52.797691) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260 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/Mozilla-Inbound/sha512/71b45366029cd9f9435daeddc5f956861e507180bba89f179023725425855e22cf180379a2147a737056c9691845648e0d36552054117d3e7d2677fc68674a88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8340aa78f27af08dd02abc1322d47a2c00028bcddc3beae361ad5a927d6c700bdbb48f9b91ca3e53bd45a8e17b72c4b99fcd6c86bbe25cdabbd6236a891cfdb3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6d6888cefdfb19d0d3e4826b0c38fcc01058ababf629b01f43c4c61fefc44ddd28d10643df15f557b09c5ce6c5a52adbb3620b55ead46ba04e1a3a224d21dc8c"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1470709839/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/71b45366029cd9f9435daeddc5f956861e507180bba89f179023725425855e22cf180379a2147a737056c9691845648e0d36552054117d3e7d2677fc68674a88", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8340aa78f27af08dd02abc1322d47a2c00028bcddc3beae361ad5a927d6c700bdbb48f9b91ca3e53bd45a8e17b72c4b99fcd6c86bbe25cdabbd6236a891cfdb3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6d6888cefdfb19d0d3e4826b0c38fcc01058ababf629b01f43c4c61fefc44ddd28d10643df15f557b09c5ce6c5a52adbb3620b55ead46ba04e1a3a224d21dc8c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 22:49:52.831035) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 22:49:52.831447) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1470717711.622702-1088450260 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 22:49:52.884884) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 22:49:52.885338) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 22:49:53.158609) ========= ========= Total master_lag: 0.51 =========