builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1470754947.47 results: success (0) buildid: 20160809064320 builduid: 4d73ae11f4f44869bd5fe66d6e0c21c8 revision: 643a67968688ec383af3d008ef081a6939a0cb53 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 08:02:27.471554) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 08:02:27.471928) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 08:02:27.472194) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 08:02:27.555696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:02:27.555968) ========= 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-1470753306.668560-1316512920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 08:02:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2016-08-09 08:02:28 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080922 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:02:27.651717) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:02:27.652070) ========= 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-1470753306.668560-1316512920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013924 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:02:27.701741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 08:02:27.702069) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 643a67968688ec383af3d008ef081a6939a0cb53 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 643a67968688ec383af3d008ef081a6939a0cb53 --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-1470753306.668560-1316512920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 08:02:28,184 truncating revision to first 12 chars 2016-08-09 08:02:28,184 Setting DEBUG logging. 2016-08-09 08:02:28,184 attempt 1/10 2016-08-09 08:02:28,184 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/643a67968688?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 08:02:29,103 unpacking tar archive at: mozilla-central-643a67968688/testing/mozharness/ program finished with exit code 0 elapsedTime=1.246658 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 08:02:28.963896) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 08:02:28.964228) ========= script_repo_revision: 643a67968688ec383af3d008ef081a6939a0cb53 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 08:02:28.964632) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 08:02:28.964926) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 08:02:28.978994) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-09 08:02:28.979384) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=14ef55db36f7623abb31b9cf000001d5-1470753306.668560-1316512920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:02:29 INFO - MultiFileLogger online at 20160809 08:02:29 in /builds/slave/test 08:02:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:02:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:02:29 INFO - {'append_to_log': False, 08:02:29 INFO - 'base_work_dir': '/builds/slave/test', 08:02:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:02:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:02:29 INFO - 'branch': 'Firefox-Non-PGO', 08:02:29 INFO - 'buildbot_json_path': 'buildprops.json', 08:02:29 INFO - 'config_files': ('talos/linux_config.py',), 08:02:29 INFO - 'default_actions': ('clobber', 08:02:29 INFO - 'read-buildbot-config', 08:02:29 INFO - 'download-and-extract', 08:02:29 INFO - 'populate-webroot', 08:02:29 INFO - 'create-virtualenv', 08:02:29 INFO - 'install', 08:02:29 INFO - 'run-tests'), 08:02:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:02:29 INFO - 'download_minidump_stackwalk': True, 08:02:29 INFO - 'download_symbols': 'ondemand', 08:02:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:02:29 INFO - 'tooltool.py': '/tools/tooltool.py', 08:02:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:02:29 INFO - '/tools/misc-python/virtualenv.py')}, 08:02:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:02:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:02:29 INFO - 'installer_path': 'installer.exe', 08:02:29 INFO - 'log_level': 'info', 08:02:29 INFO - 'log_name': 'talos', 08:02:29 INFO - 'log_to_console': True, 08:02:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:02:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:02:29 INFO - 'opt_config_files': (), 08:02:29 INFO - 'pip_index': False, 08:02:29 INFO - 'sps_profile': False, 08:02:29 INFO - 'sps_profile_interval': 0, 08:02:29 INFO - 'suite': 'dromaeojs-e10s', 08:02:29 INFO - 'system_bits': '32', 08:02:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:02:29 INFO - 'title': 'talos-linux64-ix-036', 08:02:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:02:29 INFO - 'use_talos_json': True, 08:02:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:02:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:02:29 INFO - 'work_dir': 'build'} 08:02:29 INFO - [mozharness: 2016-08-09 15:02:29.553752Z] Running clobber step. 08:02:29 INFO - Running pre-action listener: _resource_record_pre_action 08:02:29 INFO - Running main action method: clobber 08:02:29 INFO - rmtree: /builds/slave/test/build 08:02:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:02:30 INFO - Running post-action listener: _resource_record_post_action 08:02:30 INFO - [mozharness: 2016-08-09 15:02:30.017218Z] Finished clobber step (success) 08:02:30 INFO - [mozharness: 2016-08-09 15:02:30.017328Z] Running read-buildbot-config step. 08:02:30 INFO - Running pre-action listener: _resource_record_pre_action 08:02:30 INFO - Running main action method: read_buildbot_config 08:02:30 INFO - Using buildbot properties: 08:02:30 INFO - { 08:02:30 INFO - "project": "", 08:02:30 INFO - "product": "firefox", 08:02:30 INFO - "script_repo_revision": "production", 08:02:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:02:30 INFO - "repository": "", 08:02:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:02:30 INFO - "buildid": "20160809064320", 08:02:30 INFO - "pgo_build": "False", 08:02:30 INFO - "basedir": "/builds/slave/test", 08:02:30 INFO - "buildnumber": 412, 08:02:30 INFO - "slavename": "talos-linux64-ix-036", 08:02:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:02:30 INFO - "platform": "ubuntu64_hw", 08:02:30 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:02:30 INFO - "branch": "mozilla-central", 08:02:30 INFO - "repo_path": "mozilla-central", 08:02:30 INFO - "revision": "643a67968688ec383af3d008ef081a6939a0cb53", 08:02:30 INFO - "stage_platform": "linux64", 08:02:30 INFO - "builduid": "4d73ae11f4f44869bd5fe66d6e0c21c8", 08:02:30 INFO - "slavebuilddir": "test" 08:02:30 INFO - } 08:02:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:02:30 INFO - Running post-action listener: _resource_record_post_action 08:02:30 INFO - [mozharness: 2016-08-09 15:02:30.019801Z] Finished read-buildbot-config step (success) 08:02:30 INFO - [mozharness: 2016-08-09 15:02:30.019888Z] Running download-and-extract step. 08:02:30 INFO - Running pre-action listener: _resource_record_pre_action 08:02:30 INFO - Running main action method: download_and_extract 08:02:30 INFO - mkdir: /builds/slave/test/build/tests 08:02: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')]} 08:02:30 INFO - trying https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:02:30 INFO - Downloading https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:02:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:02:30 INFO - Downloaded 1361 bytes. 08:02:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:02:30 INFO - Using the following test package requirements: 08:02:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:02:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:02:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:02:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:30 INFO - u'jsshell-linux-x86_64.zip'], 08:02:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:02:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:02:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:02:30 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:02:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:02:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:02:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:02:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:02: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')]} 08:02:30 INFO - trying https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:02:30 INFO - Downloading https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:02:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:02:31 INFO - Downloaded 20258229 bytes. 08:02:31 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'] 08:02:31 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 08:02:32 INFO - Return code: 0 08:02:32 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 08:02:32 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')]} 08:02:32 INFO - trying https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:02:32 INFO - Downloading https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:02:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:02:33 INFO - Downloaded 20258229 bytes. 08:02:33 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'] 08:02:33 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 08:02:34 INFO - Return code: 0 08:02:34 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')]} 08:02:34 INFO - trying https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:02:34 INFO - Downloading https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:02:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:02:35 INFO - Downloaded 14413723 bytes. 08:02:35 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'] 08:02:35 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 08:02:35 INFO - Return code: 0 08:02: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')]} 08:02:35 INFO - trying https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:02:35 INFO - Downloading https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:02:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:02:37 INFO - Downloaded 56135384 bytes. 08:02:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:02:37 INFO - mkdir: /builds/slave/test/properties 08:02:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:02:37 INFO - Writing to file /builds/slave/test/properties/build_url 08:02:37 INFO - Contents: 08:02:37 INFO - build_url:https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:02:38 INFO - Running post-action listener: _resource_record_post_action 08:02:38 INFO - Running post-action listener: set_extra_try_arguments 08:02:38 INFO - [mozharness: 2016-08-09 15:02:38.426118Z] Finished download-and-extract step (success) 08:02:38 INFO - [mozharness: 2016-08-09 15:02:38.426351Z] Running populate-webroot step. 08:02:38 INFO - Running pre-action listener: _resource_record_pre_action 08:02:38 INFO - Running main action method: populate_webroot 08:02:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:02:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:02:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:02:38 INFO - '--tppagecycles', 08:02:38 INFO - '7'], 08:02:38 INFO - 'tests': ['tsvgm']}}, 08:02:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:02:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:02:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:02:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:02:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:02:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:02:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:38 INFO - 'talos_options': ['--disable-e10s'], 08:02:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:02:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:02:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:38 INFO - 'talos_options': ['--disable-e10s'], 08:02:38 INFO - 'tests': ['damp', 'tps']}, 08:02:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:38 INFO - 'tests': ['damp', 'tps']}, 08:02:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:02:38 INFO - 'tests': ['dromaeo_dom']}, 08:02:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:02:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:02:38 INFO - 'tests': ['basic_compositor_video']}, 08:02:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:02:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:02:38 INFO - 'tests': ['a11yr', 08:02:38 INFO - 'ts_paint', 08:02:38 INFO - 'tpaint', 08:02:38 INFO - 'sessionrestore', 08:02:38 INFO - 'sessionrestore_no_auto_restore', 08:02:38 INFO - 'tabpaint']}, 08:02:38 INFO - 'other-e10s': {'tests': ['a11yr', 08:02:38 INFO - 'ts_paint', 08:02:38 INFO - 'tpaint', 08:02:38 INFO - 'sessionrestore', 08:02:38 INFO - 'sessionrestore_no_auto_restore', 08:02:38 INFO - 'tabpaint']}, 08:02:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:02:38 INFO - 'ts_paint', 08:02:38 INFO - 'tpaint', 08:02:38 INFO - 'sessionrestore', 08:02:38 INFO - 'sessionrestore_no_auto_restore', 08:02:38 INFO - 'tabpaint']}, 08:02:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:02:38 INFO - 'ts_paint', 08:02:38 INFO - 'tpaint', 08:02:38 INFO - 'sessionrestore', 08:02:38 INFO - 'sessionrestore_no_auto_restore', 08:02:38 INFO - 'tabpaint']}, 08:02:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:02:38 INFO - 'tests': ['a11yr', 08:02:38 INFO - 'ts_paint', 08:02:38 INFO - 'tpaint', 08:02:38 INFO - 'sessionrestore', 08:02:38 INFO - 'sessionrestore_no_auto_restore', 08:02:38 INFO - 'tabpaint']}, 08:02:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:02:38 INFO - 'tests': ['a11yr', 08:02:38 INFO - 'ts_paint', 08:02:38 INFO - 'tpaint', 08:02:38 INFO - 'sessionrestore', 08:02:38 INFO - 'sessionrestore_no_auto_restore', 08:02:38 INFO - 'tabpaint']}, 08:02:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:02:38 INFO - 'tests': ['tsvgx', 08:02:38 INFO - 'tsvgr_opacity', 08:02:38 INFO - 'tart', 08:02:38 INFO - 'tscrollx', 08:02:38 INFO - 'cart']}, 08:02:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:02:38 INFO - 'tsvgr_opacity', 08:02:38 INFO - 'tart', 08:02:38 INFO - 'tscrollx', 08:02:38 INFO - 'cart']}, 08:02:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:38 INFO - 'talos_options': ['--disable-e10s'], 08:02:38 INFO - 'tests': ['tp5o']}, 08:02:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:38 INFO - 'tests': ['tp5o']}, 08:02:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:38 INFO - 'talos_options': ['--disable-e10s', 08:02:38 INFO - '--xperf_path', 08:02:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:02:38 INFO - 'tests': ['tp5n']}, 08:02:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:02:38 INFO - 'talos_options': ['--xperf_path', 08:02:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:02:38 INFO - 'tests': ['tp5n']}}, 08:02:38 INFO - 'talos.zip': {'path': '', 08:02:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:02:38 INFO - Running post-action listener: _resource_record_post_action 08:02:38 INFO - [mozharness: 2016-08-09 15:02:38.443943Z] Finished populate-webroot step (success) 08:02:38 INFO - [mozharness: 2016-08-09 15:02:38.444031Z] Running create-virtualenv step. 08:02:38 INFO - Running pre-action listener: _resource_record_pre_action 08:02:38 INFO - Running main action method: create_virtualenv 08:02:38 INFO - Creating virtualenv /builds/slave/test/build/venv 08:02:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:02:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:02:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:02:38 INFO - Using real prefix '/usr' 08:02:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:02:39 INFO - Installing distribute.............................................................................................................................................................................................done. 08:02:40 INFO - Installing pip.................done. 08:02:41 INFO - Return code: 0 08:02:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9570>, '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 0x28ba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba900>, '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-1470753306.668560-1316512920', '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 08:02:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:02:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:02:41 INFO - Using env: {'DISPLAY': ':0', 08:02:41 INFO - 'HOME': '/home/cltbld', 08:02:41 INFO - 'LANG': 'en_US.UTF-8', 08:02:41 INFO - 'LANGUAGE': 'en_US:en', 08:02:41 INFO - 'LOGNAME': 'cltbld', 08:02:41 INFO - 'MAIL': '/var/mail/cltbld', 08:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:41 INFO - 'MOZ_NO_REMOTE': '1', 08:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:41 INFO - 'NO_EM_RESTART': '1', 08:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:41 INFO - 'PWD': '/builds/slave/test', 08:02:41 INFO - 'SHELL': '/bin/bash', 08:02:41 INFO - 'SHLVL': '1', 08:02:41 INFO - 'TERM': 'linux', 08:02:41 INFO - 'TMOUT': '86400', 08:02:41 INFO - 'USER': 'cltbld', 08:02:41 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470753306.668560-1316512920', 08:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:41 INFO - '_': '/tools/buildbot/bin/python'} 08:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:02:41 INFO - Cleaning up... 08:02:41 INFO - Return code: 0 08:02:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9570>, '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 0x28ba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba900>, '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-1470753306.668560-1316512920', '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 08:02:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:02:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:02:41 INFO - Using env: {'DISPLAY': ':0', 08:02:41 INFO - 'HOME': '/home/cltbld', 08:02:41 INFO - 'LANG': 'en_US.UTF-8', 08:02:41 INFO - 'LANGUAGE': 'en_US:en', 08:02:41 INFO - 'LOGNAME': 'cltbld', 08:02:41 INFO - 'MAIL': '/var/mail/cltbld', 08:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:41 INFO - 'MOZ_NO_REMOTE': '1', 08:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:41 INFO - 'NO_EM_RESTART': '1', 08:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:41 INFO - 'PWD': '/builds/slave/test', 08:02:41 INFO - 'SHELL': '/bin/bash', 08:02:41 INFO - 'SHLVL': '1', 08:02:41 INFO - 'TERM': 'linux', 08:02:41 INFO - 'TMOUT': '86400', 08:02:41 INFO - 'USER': 'cltbld', 08:02:41 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470753306.668560-1316512920', 08:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:41 INFO - '_': '/tools/buildbot/bin/python'} 08:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:41 INFO - Downloading/unpacking psutil>=3.1.1 08:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:02:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:43 INFO - Installing collected packages: psutil 08:02:43 INFO - Running setup.py install for psutil 08:02:43 INFO - building 'psutil._psutil_linux' extension 08:02:43 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 08:02:43 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 08:02:43 INFO - building 'psutil._psutil_posix' extension 08:02:43 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 08:02:43 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 08:02:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:02:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:02:43 INFO - Successfully installed psutil 08:02:43 INFO - Cleaning up... 08:02:44 INFO - Return code: 0 08:02:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9570>, '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 0x28ba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba900>, '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-1470753306.668560-1316512920', '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 08:02:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:02:44 INFO - Using env: {'DISPLAY': ':0', 08:02:44 INFO - 'HOME': '/home/cltbld', 08:02:44 INFO - 'LANG': 'en_US.UTF-8', 08:02:44 INFO - 'LANGUAGE': 'en_US:en', 08:02:44 INFO - 'LOGNAME': 'cltbld', 08:02:44 INFO - 'MAIL': '/var/mail/cltbld', 08:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:44 INFO - 'MOZ_NO_REMOTE': '1', 08:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:44 INFO - 'NO_EM_RESTART': '1', 08:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:44 INFO - 'PWD': '/builds/slave/test', 08:02:44 INFO - 'SHELL': '/bin/bash', 08:02:44 INFO - 'SHLVL': '1', 08:02:44 INFO - 'TERM': 'linux', 08:02:44 INFO - 'TMOUT': '86400', 08:02:44 INFO - 'USER': 'cltbld', 08:02:44 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470753306.668560-1316512920', 08:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:44 INFO - '_': '/tools/buildbot/bin/python'} 08:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:02:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:02:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:02:46 INFO - Installing collected packages: mozsystemmonitor 08:02:46 INFO - Running setup.py install for mozsystemmonitor 08:02:46 INFO - Successfully installed mozsystemmonitor 08:02:46 INFO - Cleaning up... 08:02:46 INFO - Return code: 0 08:02:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:02: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')]} 08:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:46 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 0x25fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9570>, '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 0x28ba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba900>, '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-1470753306.668560-1316512920', '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 08:02:46 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 08:02:46 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 08:02:46 INFO - Using env: {'DISPLAY': ':0', 08:02:46 INFO - 'HOME': '/home/cltbld', 08:02:46 INFO - 'LANG': 'en_US.UTF-8', 08:02:46 INFO - 'LANGUAGE': 'en_US:en', 08:02:46 INFO - 'LOGNAME': 'cltbld', 08:02:46 INFO - 'MAIL': '/var/mail/cltbld', 08:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:46 INFO - 'MOZ_NO_REMOTE': '1', 08:02:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:46 INFO - 'NO_EM_RESTART': '1', 08:02:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:46 INFO - 'PWD': '/builds/slave/test', 08:02:46 INFO - 'SHELL': '/bin/bash', 08:02:46 INFO - 'SHLVL': '1', 08:02:46 INFO - 'TERM': 'linux', 08:02:46 INFO - 'TMOUT': '86400', 08:02:46 INFO - 'USER': 'cltbld', 08:02:46 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470753306.668560-1316512920', 08:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:46 INFO - '_': '/tools/buildbot/bin/python'} 08:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:46 INFO - Downloading/unpacking jsonschema==2.5.1 08:02:46 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 08:02:46 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 08:02:46 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 08:02:46 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 08:02:46 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 08:02:46 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 08:02:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:02:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:48 INFO - Downloading functools32-3.2.3-2.tar.gz 08:02:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:02:48 INFO - warning: no files found matching '*.txt' 08:02:48 INFO - no previously-included directories found matching 'build' 08:02:48 INFO - no previously-included directories found matching 'dist' 08:02:48 INFO - no previously-included directories found matching '.git*' 08:02:48 INFO - Installing collected packages: jsonschema, functools32 08:02:48 INFO - Running setup.py install for functools32 08:02:48 INFO - warning: no files found matching '*.txt' 08:02:48 INFO - no previously-included directories found matching 'build' 08:02:48 INFO - no previously-included directories found matching 'dist' 08:02:48 INFO - no previously-included directories found matching '.git*' 08:02:48 INFO - Successfully installed jsonschema functools32 08:02:48 INFO - Cleaning up... 08:02:48 INFO - Return code: 0 08:02:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9570>, '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 0x28ba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba900>, '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-1470753306.668560-1316512920', '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 08:02:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:02:48 INFO - Using env: {'DISPLAY': ':0', 08:02:48 INFO - 'HOME': '/home/cltbld', 08:02:48 INFO - 'LANG': 'en_US.UTF-8', 08:02:48 INFO - 'LANGUAGE': 'en_US:en', 08:02:48 INFO - 'LOGNAME': 'cltbld', 08:02:48 INFO - 'MAIL': '/var/mail/cltbld', 08:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:48 INFO - 'MOZ_NO_REMOTE': '1', 08:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:48 INFO - 'NO_EM_RESTART': '1', 08:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:48 INFO - 'PWD': '/builds/slave/test', 08:02:48 INFO - 'SHELL': '/bin/bash', 08:02:48 INFO - 'SHLVL': '1', 08:02:48 INFO - 'TERM': 'linux', 08:02:48 INFO - 'TMOUT': '86400', 08:02:48 INFO - 'USER': 'cltbld', 08:02:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470753306.668560-1316512920', 08:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:48 INFO - '_': '/tools/buildbot/bin/python'} 08:02:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:02:49 INFO - Cleaning up... 08:02:49 INFO - Return code: 0 08:02:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:02: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')]} 08:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02: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')]} 08:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9570>, '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 0x28ba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba900>, '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-1470753306.668560-1316512920', '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 08:02:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:02:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:02:49 INFO - Using env: {'DISPLAY': ':0', 08:02:49 INFO - 'HOME': '/home/cltbld', 08:02:49 INFO - 'LANG': 'en_US.UTF-8', 08:02:49 INFO - 'LANGUAGE': 'en_US:en', 08:02:49 INFO - 'LOGNAME': 'cltbld', 08:02:49 INFO - 'MAIL': '/var/mail/cltbld', 08:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:49 INFO - 'MOZ_NO_REMOTE': '1', 08:02:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:49 INFO - 'NO_EM_RESTART': '1', 08:02:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:49 INFO - 'PWD': '/builds/slave/test', 08:02:49 INFO - 'SHELL': '/bin/bash', 08:02:49 INFO - 'SHLVL': '1', 08:02:49 INFO - 'TERM': 'linux', 08:02:49 INFO - 'TMOUT': '86400', 08:02:49 INFO - 'USER': 'cltbld', 08:02:49 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470753306.668560-1316512920', 08:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:49 INFO - '_': '/tools/buildbot/bin/python'} 08:02:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:49 INFO - Downloading/unpacking blobuploader==1.2.4 08:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:51 INFO - Downloading blobuploader-1.2.4.tar.gz 08:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:02:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:02:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02: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 08:02:51 INFO - Downloading docopt-0.6.1.tar.gz 08:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:02:51 INFO - Installing collected packages: blobuploader, requests, docopt 08:02:51 INFO - Running setup.py install for blobuploader 08:02:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:02:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:02:52 INFO - Running setup.py install for requests 08:02:52 INFO - Running setup.py install for docopt 08:02:52 INFO - Successfully installed blobuploader requests docopt 08:02:52 INFO - Cleaning up... 08:02:52 INFO - Return code: 0 08:02:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:52 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 0x25fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9570>, '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 0x28ba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba900>, '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-1470753306.668560-1316512920', '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 08:02:52 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 08:02:52 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 08:02:52 INFO - Using env: {'DISPLAY': ':0', 08:02:52 INFO - 'HOME': '/home/cltbld', 08:02:52 INFO - 'LANG': 'en_US.UTF-8', 08:02:52 INFO - 'LANGUAGE': 'en_US:en', 08:02:52 INFO - 'LOGNAME': 'cltbld', 08:02:52 INFO - 'MAIL': '/var/mail/cltbld', 08:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:52 INFO - 'MOZ_NO_REMOTE': '1', 08:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:52 INFO - 'NO_EM_RESTART': '1', 08:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:52 INFO - 'PWD': '/builds/slave/test', 08:02:52 INFO - 'SHELL': '/bin/bash', 08:02:52 INFO - 'SHLVL': '1', 08:02:52 INFO - 'TERM': 'linux', 08:02:52 INFO - 'TMOUT': '86400', 08:02:52 INFO - 'USER': 'cltbld', 08:02:52 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470753306.668560-1316512920', 08:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:52 INFO - '_': '/tools/buildbot/bin/python'} 08:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:52 INFO - Running setup.py (path:/tmp/pip-KYGNM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:52 INFO - Running setup.py (path:/tmp/pip-cPWqsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:52 INFO - Running setup.py (path:/tmp/pip-9lYyZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:52 INFO - Running setup.py (path:/tmp/pip-0KjR7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:53 INFO - Running setup.py (path:/tmp/pip-mqBoLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:53 INFO - Running setup.py (path:/tmp/pip-mUUbSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:53 INFO - Running setup.py (path:/tmp/pip-C3gaEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:53 INFO - Running setup.py (path:/tmp/pip-wbKTAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:53 INFO - Running setup.py (path:/tmp/pip-yJVmtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:53 INFO - Running setup.py (path:/tmp/pip-URYHO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:53 INFO - Running setup.py (path:/tmp/pip-kY1mHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:53 INFO - Running setup.py (path:/tmp/pip-6hz8V0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:53 INFO - Running setup.py (path:/tmp/pip-GqfuRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:53 INFO - Running setup.py (path:/tmp/pip-GZwkfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:53 INFO - Running setup.py (path:/tmp/pip-ZsF0tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:53 INFO - Running setup.py (path:/tmp/pip-oBGhfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:53 INFO - Running setup.py (path:/tmp/pip-apOfyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:02:53 INFO - Running setup.py install for manifestparser 08:02:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:02:54 INFO - Running setup.py install for mozcrash 08:02:54 INFO - Running setup.py install for mozdebug 08:02:54 INFO - Running setup.py install for mozdevice 08:02:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:02:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:02:54 INFO - Running setup.py install for mozfile 08:02:54 INFO - Running setup.py install for mozhttpd 08:02:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:02:54 INFO - Running setup.py install for mozinfo 08:02:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:02:54 INFO - Running setup.py install for mozInstall 08:02:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:02:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:02:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:02:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:02:54 INFO - Running setup.py install for mozleak 08:02:54 INFO - Running setup.py install for mozlog 08:02:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:02:55 INFO - Running setup.py install for moznetwork 08:02:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:02:55 INFO - Running setup.py install for mozprocess 08:02:55 INFO - Running setup.py install for mozprofile 08:02:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:02:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:02:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:02:55 INFO - Running setup.py install for mozrunner 08:02:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:02:55 INFO - Running setup.py install for mozscreenshot 08:02:55 INFO - Running setup.py install for moztest 08:02:55 INFO - Running setup.py install for mozversion 08:02:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:02:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:02:55 INFO - Cleaning up... 08:02:55 INFO - Return code: 0 08:02:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:55 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')]} 08:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:55 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')]} 08:02:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:55 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 0x25fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9570>, '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 0x28ba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba900>, '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-1470753306.668560-1316512920', '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 08:02:55 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 08:02:55 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 08:02:55 INFO - Using env: {'DISPLAY': ':0', 08:02:55 INFO - 'HOME': '/home/cltbld', 08:02:55 INFO - 'LANG': 'en_US.UTF-8', 08:02:55 INFO - 'LANGUAGE': 'en_US:en', 08:02:55 INFO - 'LOGNAME': 'cltbld', 08:02:55 INFO - 'MAIL': '/var/mail/cltbld', 08:02:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:55 INFO - 'MOZ_NO_REMOTE': '1', 08:02:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:55 INFO - 'NO_EM_RESTART': '1', 08:02:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:55 INFO - 'PWD': '/builds/slave/test', 08:02:55 INFO - 'SHELL': '/bin/bash', 08:02:55 INFO - 'SHLVL': '1', 08:02:55 INFO - 'TERM': 'linux', 08:02:55 INFO - 'TMOUT': '86400', 08:02:55 INFO - 'USER': 'cltbld', 08:02:55 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470753306.668560-1316512920', 08:02:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:55 INFO - '_': '/tools/buildbot/bin/python'} 08:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:02:56 INFO - Running setup.py (path:/tmp/pip-jc3Eg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:02:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:02:56 INFO - Running setup.py (path:/tmp/pip-hMwSmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:02:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:02:56 INFO - Running setup.py (path:/tmp/pip-KIFkwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:02:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:02:56 INFO - Running setup.py (path:/tmp/pip-qgRs34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:02:56 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)) 08:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:02:56 INFO - Running setup.py (path:/tmp/pip-aebcqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:02:56 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)) 08:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:02:56 INFO - Running setup.py (path:/tmp/pip-0JWjpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:02:56 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)) 08:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:02:56 INFO - Running setup.py (path:/tmp/pip-7cJ6ZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:02:56 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)) 08:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:02:56 INFO - Running setup.py (path:/tmp/pip-4s0xli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:02:56 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)) 08:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:02:56 INFO - Running setup.py (path:/tmp/pip-wOfK3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:02:56 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)) 08:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:02:56 INFO - Running setup.py (path:/tmp/pip-Vn26e3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:02:56 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)) 08:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:02:56 INFO - Running setup.py (path:/tmp/pip-N2sPYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:02:56 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)) 08:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:02:56 INFO - Running setup.py (path:/tmp/pip-i9mL_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:02:56 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)) 08:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:02:56 INFO - Running setup.py (path:/tmp/pip-mKy70f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:02:56 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)) 08:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:02:56 INFO - Running setup.py (path:/tmp/pip-_XJcHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:57 INFO - Running setup.py (path:/tmp/pip-oa2e8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:02:57 INFO - Running setup.py (path:/tmp/pip-lpgnd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:02:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:02:57 INFO - Running setup.py (path:/tmp/pip-m3dwYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:02:57 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)) 08:02:57 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)) 08:02:57 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)) 08:02:57 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)) 08:02:57 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)) 08:02:57 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)) 08:02:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:02:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:02:59 INFO - Downloading blessings-1.6.tar.gz 08:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:02:59 INFO - Installing collected packages: blessings 08:02:59 INFO - Running setup.py install for blessings 08:02:59 INFO - Successfully installed blessings 08:02:59 INFO - Cleaning up... 08:02:59 INFO - Return code: 0 08:02:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:02:59 INFO - Reading from file tmpfile_stdout 08:02:59 INFO - Current package versions: 08:02:59 INFO - argparse == 1.2.1 08:02:59 INFO - blessings == 1.6 08:02:59 INFO - blobuploader == 1.2.4 08:02:59 INFO - docopt == 0.6.1 08:02:59 INFO - functools32 == 3.2.3-2 08:02:59 INFO - jsonschema == 2.5.1 08:02:59 INFO - manifestparser == 1.1 08:02:59 INFO - mozInstall == 1.12 08:02:59 INFO - mozcrash == 0.17 08:02:59 INFO - mozdebug == 0.1 08:02:59 INFO - mozdevice == 0.48 08:02:59 INFO - mozfile == 1.2 08:02:59 INFO - mozhttpd == 0.7 08:02:59 INFO - mozinfo == 0.9 08:02:59 INFO - mozleak == 0.1 08:02:59 INFO - mozlog == 3.3 08:02:59 INFO - moznetwork == 0.27 08:02:59 INFO - mozprocess == 0.23 08:02:59 INFO - mozprofile == 0.28 08:02:59 INFO - mozrunner == 6.12 08:02:59 INFO - mozscreenshot == 0.1 08:02:59 INFO - mozsystemmonitor == 0.3 08:02:59 INFO - moztest == 0.7 08:02:59 INFO - mozversion == 1.4 08:02:59 INFO - psutil == 3.1.1 08:02:59 INFO - requests == 1.2.3 08:02:59 INFO - wsgiref == 0.1.2 08:02:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:02:59 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')]} 08:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:59 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')]} 08:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:59 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 0x25fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9570>, '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 0x28ba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba900>, '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-1470753306.668560-1316512920', '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 08:02:59 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 08:02:59 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 08:02:59 INFO - Using env: {'DISPLAY': ':0', 08:02:59 INFO - 'HOME': '/home/cltbld', 08:02:59 INFO - 'LANG': 'en_US.UTF-8', 08:02:59 INFO - 'LANGUAGE': 'en_US:en', 08:02:59 INFO - 'LOGNAME': 'cltbld', 08:02:59 INFO - 'MAIL': '/var/mail/cltbld', 08:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:59 INFO - 'MOZ_NO_REMOTE': '1', 08:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:59 INFO - 'NO_EM_RESTART': '1', 08:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:59 INFO - 'PWD': '/builds/slave/test', 08:02:59 INFO - 'SHELL': '/bin/bash', 08:02:59 INFO - 'SHLVL': '1', 08:02:59 INFO - 'TERM': 'linux', 08:02:59 INFO - 'TMOUT': '86400', 08:02:59 INFO - 'USER': 'cltbld', 08:02:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470753306.668560-1316512920', 08:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:59 INFO - '_': '/tools/buildbot/bin/python'} 08:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:02:59 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)) 08:02:59 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)) 08:02:59 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)) 08:02:59 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)) 08:02:59 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)) 08:02:59 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)) 08:02:59 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)) 08:02:59 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)) 08:02:59 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)) 08:02:59 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)) 08:02:59 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)) 08:02:59 INFO - Cleaning up... 08:02:59 INFO - Return code: 0 08:02:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:02:59 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')]} 08:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:59 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')]} 08:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:02:59 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 0x25fb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x275e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b9570>, '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 0x28ba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba900>, '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-1470753306.668560-1316512920', '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 08:02:59 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 08:02:59 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 08:02:59 INFO - Using env: {'DISPLAY': ':0', 08:02:59 INFO - 'HOME': '/home/cltbld', 08:02:59 INFO - 'LANG': 'en_US.UTF-8', 08:02:59 INFO - 'LANGUAGE': 'en_US:en', 08:02:59 INFO - 'LOGNAME': 'cltbld', 08:02:59 INFO - 'MAIL': '/var/mail/cltbld', 08:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:02:59 INFO - 'MOZ_NO_REMOTE': '1', 08:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:02:59 INFO - 'NO_EM_RESTART': '1', 08:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:02:59 INFO - 'PWD': '/builds/slave/test', 08:02:59 INFO - 'SHELL': '/bin/bash', 08:02:59 INFO - 'SHLVL': '1', 08:02:59 INFO - 'TERM': 'linux', 08:02:59 INFO - 'TMOUT': '86400', 08:02:59 INFO - 'USER': 'cltbld', 08:02:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470753306.668560-1316512920', 08:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:02:59 INFO - '_': '/tools/buildbot/bin/python'} 08:03:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:03:00 INFO - Cleaning up... 08:03:00 INFO - Return code: 0 08:03:00 INFO - Running post-action listener: _resource_record_post_action 08:03:00 INFO - Running post-action listener: _start_resource_monitoring 08:03:00 INFO - Starting resource monitoring. 08:03:00 INFO - [mozharness: 2016-08-09 15:03:00.062038Z] Finished create-virtualenv step (success) 08:03:00 INFO - [mozharness: 2016-08-09 15:03:00.062474Z] Running install step. 08:03:00 INFO - Running pre-action listener: _resource_record_pre_action 08:03:00 INFO - Running main action method: install 08:03:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:03:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:03:00 INFO - Reading from file tmpfile_stdout 08:03:00 INFO - Detecting whether we're running mozinstall >=1.0... 08:03:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:03:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:03:00 INFO - Reading from file tmpfile_stdout 08:03:00 INFO - Output received: 08:03:00 INFO - Usage: mozinstall [options] installer 08:03:00 INFO - Options: 08:03:00 INFO - -h, --help show this help message and exit 08:03:00 INFO - -d DEST, --destination=DEST 08:03:00 INFO - Directory to install application into. [default: 08:03:00 INFO - "/builds/slave/test"] 08:03:00 INFO - --app=APP Application being installed. [default: firefox] 08:03:00 INFO - mkdir: /builds/slave/test/build/application 08:03:00 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'] 08:03:00 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 08:03:16 INFO - Reading from file tmpfile_stdout 08:03:16 INFO - Output received: 08:03:16 INFO - /builds/slave/test/build/application/firefox/firefox 08:03:16 INFO - Running post-action listener: _resource_record_post_action 08:03:16 INFO - [mozharness: 2016-08-09 15:03:16.746963Z] Finished install step (success) 08:03:16 INFO - [mozharness: 2016-08-09 15:03:16.747211Z] Running run-tests step. 08:03:16 INFO - Running pre-action listener: _resource_record_pre_action 08:03:16 INFO - Running main action method: run_tests 08:03:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:03:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:03:16 INFO - Python 2.7.3 08:03:16 INFO - Return code: 0 08:03:16 INFO - grabbing minidump binary from tooltool 08:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:03:16 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 0x28b9570>, '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 0x28ba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28ba900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:03:16 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 08:03:16 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 08:03:16 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 08:03:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:03:16 INFO - Return code: 0 08:03:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:03:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:03:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:03:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:03:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:03:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:03:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:03:16 INFO - Using env: {'DISPLAY': ':0', 08:03:16 INFO - 'HOME': '/home/cltbld', 08:03:16 INFO - 'LANG': 'en_US.UTF-8', 08:03:16 INFO - 'LANGUAGE': 'en_US:en', 08:03:16 INFO - 'LOGNAME': 'cltbld', 08:03:16 INFO - 'MAIL': '/var/mail/cltbld', 08:03:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:03:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:16 INFO - 'MOZ_NO_REMOTE': '1', 08:03:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:03:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:03:16 INFO - 'NO_EM_RESTART': '1', 08:03:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:16 INFO - 'PWD': '/builds/slave/test', 08:03:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:03:16 INFO - 'SHELL': '/bin/bash', 08:03:16 INFO - 'SHLVL': '1', 08:03:16 INFO - 'TERM': 'linux', 08:03:16 INFO - 'TMOUT': '86400', 08:03:16 INFO - 'USER': 'cltbld', 08:03:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1470753306.668560-1316512920', 08:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:16 INFO - '_': '/tools/buildbot/bin/python'} 08:03:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:03:17 INFO - mozversion application_buildid: 20160809064320 08:03:17 INFO - mozversion application_changeset: 643a67968688ec383af3d008ef081a6939a0cb53 08:03:17 INFO - mozversion application_display_name: Nightly 08:03:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:03:17 INFO - mozversion application_name: Firefox 08:03:17 INFO - mozversion application_remotingname: firefox 08:03:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:03:17 INFO - mozversion application_vendor: Mozilla 08:03:17 INFO - mozversion application_version: 51.0a1 08:03:17 INFO - mozversion platform_buildid: 20160809064320 08:03:17 INFO - mozversion platform_changeset: 643a67968688ec383af3d008ef081a6939a0cb53 08:03:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:03:17 INFO - mozversion platform_version: 51.0a1 08:03:17 INFO - using testdate: 1470754997 08:03:17 INFO - actual date: 1470754997 08:03:17 INFO - starting webserver on 'localhost:46333' 08:03:17 INFO - SUITE-START | Running 2 tests 08:03:17 INFO - TEST-START | dromaeo_css 08:03:17 INFO - operating with platform_type : linux_ 08:03:17 INFO - Initialising browser for dromaeo_css test... 08:03:17 INFO - TEST-INFO | started process 15095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsIX41k/profile http://localhost:46333/getInfo.html) 08:03:21 INFO - PROCESS | 15095 | __metrics Screen width/height:1600/1200 08:03:21 INFO - PROCESS | 15095 | colorDepth:24 08:03:21 INFO - PROCESS | 15095 | Browser inner width/height: 1024/697 08:03:21 INFO - PROCESS | 15095 | __metrics 08:03:22 ERROR - PROCESS | 15095 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 08:03:23 INFO - TEST-INFO | 15095: exit 0 08:03:23 INFO - Browser initialized. 08:03:23 INFO - Running cycle 1/1 for dromaeo_css test... 08:03:23 INFO - TEST-INFO | started process 15216 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsIX41k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:03:35 INFO - PROCESS | 15216 | RSS: Main: 165212160 08:03:35 INFO - PROCESS | 15216 | 08:04:24 INFO - PROCESS | 15216 | 1470755064973 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] 08:06:37 INFO - PROCESS | 15216 | Cycle 1(1): loaded http://localhost:46333/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46333/tests/dromaeo/cssquery-ext.html) 08:06:38 INFO - PROCESS | 15216 | RSS: Main: 167235584 08:06:38 INFO - PROCESS | 15216 | 08:09:41 INFO - PROCESS | 15216 | Cycle 1(1): loaded http://localhost:46333/tests/dromaeo/cssquery-ext.html (next: http://localhost:46333/tests/dromaeo/cssquery-jquery.html) 08:09:41 INFO - PROCESS | 15216 | RSS: Main: 166502400 08:09:41 INFO - PROCESS | 15216 | 08:12:43 INFO - PROCESS | 15216 | Cycle 1(1): loaded http://localhost:46333/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46333/tests/dromaeo/cssquery-mootools.html) 08:12:44 INFO - PROCESS | 15216 | RSS: Main: 170303488 08:12:44 INFO - PROCESS | 15216 | 08:15:46 INFO - PROCESS | 15216 | Cycle 1(1): loaded http://localhost:46333/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46333/tests/dromaeo/cssquery-prototype.html) 08:15:47 INFO - PROCESS | 15216 | RSS: Main: 164790272 08:15:47 INFO - PROCESS | 15216 | 08:18:49 INFO - PROCESS | 15216 | Cycle 1(1): loaded http://localhost:46333/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46333/tests/dromaeo/cssquery-yui.html) 08:18:50 INFO - PROCESS | 15216 | RSS: Main: 166903808 08:18:50 INFO - PROCESS | 15216 | 08:21:53 INFO - PROCESS | 15216 | Cycle 1(1): loaded http://localhost:46333/tests/dromaeo/cssquery-yui.html (next: http://localhost:46333/tests/dromaeo/cssquery-dojo.html) 08:21:53 INFO - PROCESS | 15216 | RSS: Main: 170274816 08:21:53 INFO - PROCESS | 15216 | 08:21:53 INFO - PROCESS | 15216 | __start_tp_report 08:21:53 INFO - PROCESS | 15216 | _x_x_mozilla_page_load 08:21:53 INFO - PROCESS | 15216 | _x_x_mozilla_page_load_details 08:21:53 INFO - PROCESS | 15216 | |i|pagename|runs| 08:21:53 INFO - PROCESS | 15216 | |0;dojo.html;2646.9867650661745;2694.178275625934;2700.1224602004354;2730.4948584511867;2733.5216337140996;4621.491635920054;4889.853304400869;4924.261360795882;4938.308636790852;4956;4762.166620841356;4809.495003024685;4847.733374664392;4847.975760121203;4852.344933433994;4319.546447622994;4334.804933777972;4385.254506733863;4443.355713421552;4492.910141797162;4436.866893993185;4465.017696106851;4466.620337271336;4484.260097083978;4513.526079761627;4319.805608747614;4435.401220835211;4442.111577684476;4477.955220447787;4485.439320084989;4450.643948484114;4452.9554704453185;4459;4463.973286144205;4533.569310915458;4476.1271552047365;4499.865004049884;4504.774761261924;4508.436445444319;4529.547045295477;4821.276808478721;4862.44081930579;4895.461499235082;4897.8775530611665;4912.778924948386;5247.501487358695;5266.4733526647415;5278.630495865291;5279.260903473479;5312.043832110218;5115.590752739772;5289.629725919187;5310.176922577007;5323.973380133075;5324.281222035014;4833.178359678898;4850.054239423349;4857.95142048575;4890.731009794425;4928.8767780805765;5323.973380133075;5327.946720532823;5341.7062061586985;5349.063913815066;5397.298351214396;4944.283078953532;5105.978804239167;5106.948930510647;5113.667611605309;5115.87210319745;5201.375834899836;5204.193350030751;5220.3735551734035;5228.92156617651;5246;5142.5628821549835;5147.0735267651435;5149.9742501287255;5161.225816127536;5242.9737851311265;4960.950390496121;5176.9741151294;5188.9740551297;5192.8961420771375;5201.869953251199;4281.443412356373;4371.803268852909;4392;4411.713238639478;4468.955310446919;3846.3845784674318;3848.9615103848605;3856.325143099946;3875.7093218008763;3882.592327805596;4470.284754439339;4500.234960056799;4505.774711264424;4512.300593408027;4548.317752337176;5023.799048038038;5205.011047900886;5206.557442617344;5235.973820130875;5303.0719624066405;4469.7988590513505;4496.258117410591;4496.752678602708;4499.167653984024;4542.341360502709;4696.2486002239475;4706.717596944194;4712.717236965793;4713.6936099153445;4754.429468463806;4647.34937108805;4828.5412885775095;4832.782524786463;4849.927251091307;4922.507749225048;5219.425863154974;5238.711870846988;5249;5282.867928301823;5286.286351342519;4675.766211689333;4925.088858561035;4927.310176575354;4937.1113199624415;4968.975155124346;4957.281194226889;5052.823151189691;5114.74426278692;5118.053160165381;5137;5157.458466861076;5200.323957885451;5211.557017653542;5250.921236181537;5252.7898884045735;5025.145725226794;5044.0920634286185;5045.520675535819;5066;5097.388313402415;4880.438749543848;5041.445441001413;5062.367204099488;5065.898682026265;5068.670536415121;4995.600351971906;4997.225430058346;5036.395632523974;5042.571381432473;5069.087564238325;5133.8973220534635;5143.3570803649545;5150.381954165524;5151.278820965143;5209.374875015023;4844.031193761332;4982.6512144149565;4995.375578052744;5023.447420783637;5029.4216165140015 08:21:53 INFO - PROCESS | 15216 | |1;ext.html;545.5799034743247;549.3353042818189;553.698234462218;560.7224423910166;575.7380391921677;35249.64750352496;39451.40822887656;39542.80228598853;39577.406338904904;39642.40536391949;39333;40105;40126.59873401265;40157;40172;7575.469717119818;7635.618219089051;7659.425543084263;7690;7696.461247712635;7713.267239612228;7718.7684369468725;7761.611919404036;7762.262585054411;7801.609919504031;7768.417368697342;7883.251091146332;7888.053433587977;7888.605569721491;7897.605119744018;7770.145284018753;7822.295993360596;7837.647305871193;7844.0979287382115;7846.843063138763;7652.2347765223585;7689.231076892322;7694.769156925301;7697.846043079107;7716.382689384835;38862.61137388618;38915.80542097271;38932.02669933246;39043.804780975915;39044.41433378502;2735.2067900308884;3131.3580715953176;3208.1658768720067;3226.7418606511424;3256.788308759923;25892.870535647202;27084.86457567719;28439.431211375864;28807.855960720273;28968.565471517944;3350.849211785451;3369.4608862582113;3401.8299085045896;3460.9653903460894;3534.0458076319505;218078;271097;272591;272733.63633181906;274736;31850.522242166386;58035.70982145147;58314.70842645845;58448.70775646094;58553.70723146357;32665.346693066007;34510.137246568534;34545;34635.13412164716;34671.30657386838;13121.540746073842;13153.73692526144;13211.273379964194;13211.405486752927;13226.07417480767;10878.72803179911;11002.889971100347;11016.339019658846;11018.338899666045;11048;7856.803579910434;7889.605519723991;7917.524948502993;7987.081485629227;8037.879431808527;3097.0863595239457;3110.331278775074;3111.5799367085156;3114.143610507129;3119.859606317721;802.4342838299102;817.721974528663;826.4256341842482;873.724776695339;909.486140330711;27839.164825055283;28869.27826804347;29106.7089329104;29226.26934326616;29521.557176642367;892.2727976698969;902.4855832175729;914.6053214305326;915.2220612479339;925.2551695884878;15247;15297.847021529642;15354.232288385536;15442.741433021807;15583.84416155824;404815;409918;412195;413117;414703;50499;51221.487785122416;51266.74366628143;51268.23097653538;51393.48606513887;1147.2944139354238;1192.5468322037743;1195.462042081067;1197.6227488341144;1204.6145233525187;27355.589666154625;27737;28281.292967675974;28626.42747145004;28933.85533072321;44465.333020005375;44494;45166;45200.32199517076;45372.31941520814;312596;314030;315332;315687;315807;25703;26170.345741356618;26219.868900655376;26266.343341416617;26272.474550509265;43156;43327.48353807602;43879;44576.55423445854;44596;37201.44197837089;37333.81333093317;37358.813205933795;37889;38246.617533824305;36446.81776591206;37382.62617373792;37849.4322585156;38440.42339364856;38617.2276554473;30154;35531;35599.82200088983;36206;36207.094822629646;31746.523802142525;33456.99629011133;33882.49176262407;34052.65947340594;34223.31553368869;25211.87394063018;25270.49459010846;25613.61579576345;25616.61575076338;25734.613980789927 08:21:53 INFO - PROCESS | 15216 | |2;jquery.html;351.825846206128;361.87334432948467;364.6699736738252;366.6297039989613;380.32871980953604;15775.526734197963;15851.128187949658;16964.491065268045;17119.57201069974;17164.656706865855;16233;16869.91565042173;17355.132243387812;17406.564835879108;17499.125043747827;5058;5265.947340526584;5275.920861187066;5277.70972596507;5286.867828304285;5165.173572228444;5171.301874246985;5217.686938783685;5218.895622087556;5230.137027390476;5163.974180129113;5177.094008548508;5204.401493828202;5207.86980325493;5216.8695782605355;5004.12427825131;5035.269885866529;5139.460356662571;5139.794408223666;5156.458571849939;5082.288479612857;5246.160614301732;5251.973740131313;5256.369235691742;5277.313949186581;12707.872921270762;12837;12854.421551030133;12887.420066097047;17463.563410914703;1836.917338719761;1968.803119688034;2226.3877433705698;2294.139697613395;2385.546746118232;9209.677661281823;9212.355135140542;9515.57179926905;9575.61697532098;9729.610815567368;1724.879258451909;1783.777027871516;1811.610503741702;1823.124900047971;1824.6259516799025;71788.92316615256;74384;75020.62489687571;75188;75398.62300688516;9157.130072643089;9214.76963075915;9265.814683706423;9516.714498565054;9627.614895404246;12502.187357821713;12550;12558.87441125577;12582.496700132075;12681.365931703562;7058.329458701415;7221.494495385377;7258.455615828834;7384.446166537424;7411.444141689287;7110.32451917067;7184.994100825888;7343.88984165238;7344.889826652605;7373.668184931691;3896.4155376693725;4005.839766409369;4088.7342322748927;4131.648809851136;4169.353750168668;1695.3218712514847;1709.2991873332123;1717.1500107446893;1717.8711596630053;1753.7544743735887;713.4577720932025;779.3375630713848;795.5226863881625;860.0582362313257;897.4256475855458;17155.742663860052;17407.73888391675;17898;18398.988055657068;18716.719249211274;752.1125072414494;814.104485066434;820.6512232301368;848.4230723108222;884.6196135661598;8474.576271186415;9956.303058785961;9996.850047249298;10020.24848136378;10078.748031299276;274454;280332;280879;389260;393097;48225;48637.270440943415;85095.57452212699;89614.55192723994;89907.10092899117;934.3739694404765;943.7168849345169;947.1996163242187;955.6941778630771;961.7018724195522;15683.607909802346;15928;16240.51278461648;16294.511164664606;16387.918060409622;26873.596896046965;28121.859390702917;29209;37460.812695937435;39654.80172599119;53814.73092634512;54750.45249547613;55330.17004745013;55749.44250557443;56860.715696421255;6779.15260592426;7179.282071792779;7460.142083660448;7720.613969301625;7868.331191848757;10558.260921735406;11727.179097463095;11856.11079169083;11949.820752688891;12140.15018948665;9453.392923202935;9560.235181185628;9574.377665451724;9592.679166459386;10425.218108641731;9947.900520994697;10422.322549034288;10595.258331916692;10783.892161078289;10836.241463097824;9750.658726944523;10218.642347517802;10388.480575971322;10604.628837990633;10845.891541084804;7131.82170445743;7188.7124515020905;7202.639868006683;7287.562746235243;7532.585707786125;8490.745277641681;9701.70894873155;9868.210543156674;9903.702888913343;10125.18998480105 08:21:53 INFO - PROCESS | 15216 | |3;mootools.html;1351.7228968061545;1395.9302034898253;1437.5759151050438;1604.6469776649133;1649.7772800671912;6462.838429039276;7222.205557388683;7363.8159046023875;7957.72147974821;7959.522428654278;7312.963435182816;7466.440016998719;7484.663190156442;7486.438517111224;7489.5131816431895;2130.605837919982;2174.749903761064;2176.3688530326267;2178.9019494122804;2181.2474696229856;2096.570203108367;2128.5955668423026;2156.956860862782;2162.686410470481;2174.695542624034;2149.8172655324315;2151.204054499837;2169.3491952414292;2178.9564208715815;2187.201671389947;2088.3004193595166;2091.3203208956998;2094.2356040045424;2094.6229678657837;2096.2663067926255;2033.30867505049;2106.9157233710635;2111.3771437425994;2114.1543382647064;2117.565898990719;7483.8877416838795;7522.924770752332;7534.284242996907;7565;7567.054118235221;4448.822047118111;4523.389342438762;4527.637788976874;4564.977175114103;4573.131105090022;2809.044924725583;2817.563277691961;2854.0296299258353;2885.5960165576626;2904.3320036391747;822.4191254711261;857.065798279878;860.1183786618766;861.9827603447895;864.464032299978;10433.16534677224;10460.11089057431;10471.214658900613;10497;10538.262321637412;3983.382575700771;4064.9187016260103;4261.083866968616;4269.274223382033;4280.614744672932;9100.317476189311;9102.635894564144;9109;9122.543872806333;9126.771830704285;4646.83736069236;4655.185342565105;4670.95329046712;4673.883152921204;4677.18149323867;3483.5645544306963;4130.710850240454;4237.618614324726;4267.76527291002;4272.444582204355;3475.09647491654;3512.1034641293413;3559.1635965548076;3571.339302229096;3628.600853906068;1131.0838221040983;1139.7036770439745;1151.476078384333;1154.3593305715408;1163.1741463560797;811.975640730779;827.6027506796651;837.3468694418364;838.9622466989;845.8477474054606;4922.950770492249;4932.482089380635;4985.700857948535;5105.030044291572;5108.540231379194;395.93269144245545;412.4658567155541;412.58947347388937;412.76884944431214;414.56884839766906;3346.1801858544814;3424.5719285089363;3444.8277586121094;3451.551298331251;3603.3513967486106;9044.276457883485;9483.241340692728;9553.283503737108;9590.040995900354;9596.808063838684;9469.526523673789;9514.524273786283;9532.142107210384;9533;9572.473513956798;6954.200266969363;7063.223045464994;7137.964310178416;7362.5214361066355;7469.439792015621;4943.65394422387;5014.949850501448;5113.105206588906;5135;5163.586913046872;8371.121032291765;8591.398602097794;8644.438111522732;8664.35017373712;8808.647654093764;8775.42959707617;8810.471371717718;8811.911880881109;8844.601992910462;8876.955615221883;5967.880642387215;6707.128073350628;6844.760433385007;6861.2109607393795;7005.614691192033;7578.658960346687;7687.461877668509;7696.114946780968;7697.538147711155;7697.6151192441275;6719.731210751711;6746.595204287759;6853.554518956252;6951.44388448933;6963.442924566124;6692.364225398579;6723.361280678328;6774.3225677431865;6832.829179270558;6918.654067296716;5821.650700957786;5893.675847828411;5920.319163296276;5936.762529498772;5984.551158663031;4420.756858372821;4445.2887537993765;4516.88707782308;4521.502634710114;4527.683062185615;4464.285714285698;4507.481639611487;4579.816807327669;4601.562851529099;4707.670463067552 08:21:53 INFO - PROCESS | 15216 | |4;prototype.html;297.1412617535323;297.8287484696299;304.5918469251203;304.86433537076;305.0619345512548;5106.438291787905;5174.042802081608;5174.4825517448235;5178.508041736034;5190.688558686482;5074.086664400406;5078.339815823947;5079.466656001113;5089.414717307502;5104.770285337159;3760.3043436964113;3917.84328626856;3920.411938209263;3972.781497017663;3987.501562304712;3950.4666869972616;3950.802459877009;3955.4857868477056;3972.00113913996;3989.421533877586;3940.5074365704286;3979.8806035818825;3995.5604883462943;4007.937896457441;4010.9598904010877;3717.3494638438165;3908.925045612451;3933.8229779659696;4013.7993100344866;4018.859339923103;3406.7685665888885;3410.5054767058637;3415.2486452980306;3420.863165473378;3424.3493736190044;4941.604671626261;4945.901081978341;4953.653244272902;4955.653104282702;4993.226049962225;4210.284251677192;4520.186366454037;4523.660725445605;4525.298578720303;4569.126658070209;5284.735763211824;5310.575153987672;5310.92033619496;5316.229146773735;5324.148136298212;3698.1679122197293;3701.4262789267705;3708.295423869456;3728.291624591319;3729.8881033568764;5383.784648614051;5624.859378515529;5627.943720562783;5630.352509461423;5633.774649014034;3838.347480928249;3844.0966372902344;3846.249981253685;3850.210706805098;3853.9229215415535;3907.33575292201;3928.783916884599;3932.2725295820364;3933.174033453007;3940.9014774630864;4497.527759585197;4518.683692141584;4526.932096018562;4535.659825513099;4541.68208225421;5259.8422047338645;5359.651622644516;5378.757955891994;5379.488948549882;5424.918626220609;1329.8537160912485;1349.743548725739;1357.1992524410448;1361.1084739495645;1361.455417832855;799.9840003199903;809.380823669893;836.1220718245818;844.6199210355364;856.6316483911978;4508.639308855284;4613.008203236321;4640.512746161672;4679.883002924886;4688.578027977498;5487.451254874561;5525.723713814293;5526.45259327389;5543.667379957215;5556.833295001156;4459.799309031101;4638.466576343763;4659.44086709597;4670.743109128963;4696.882577935579;2868.9713102869123;2917.1977706130983;2924.298168439559;2928.794984351075;2948.395578906319;5093.770780314895;5120.92318615221;5158.690478571298;5160.535551800356;5171.172612382001;5293.5765138789575;5588.413216612278;5591.10542313228;5618.4662457066515;5699;5093.516115968977;5105.463926287761;5119.769610367617;5122.92315615266;5123.897522049539;5485.780568777363;5514.290569923337;5520.779168833202;5521.171824226398;5531.446855314597;5159.742012899415;5432.456754324536;5440.830221502396;5471.480209380103;5480.369757477941;5180.352455943007;5205.111163304402;5208.270842082187;5217.634765566374;5224.145428372873;3874.205787813548;3901.9804900975314;3911.3741801311653;3913.6086391360636;3915.393114067324;5465.125579907196;5504.779808807763;5517.227588137584;5532.834014979557;5551.528120109836;5369;5380.596455265949;5383.757730902197;5388.56891448691;5399.163129714901;5189.740512974261;5414.566834653139;5422.078246697992;5423.430539793265;5423.783048678167;5225.16397376418;5253.185756207794;5263.157894736823;5269.657472264291;5272.393674727302;5119.0529751996;5258.368995720538;5367.570594352364;5390.51485366319;5425.782968681208;5248.527632513092;5267.128660434654;5305.124654431976;5330.866728331823;5359.196120581944 08:21:53 INFO - PROCESS | 15216 | |5;yui.html;599.0744300056413;610.7221214347472;623.6476390839177;633.4109278371113;695.843435227074;11849.526018959243;12597.874021259784;12613.864752172303;12834.229946203235;12840.293783841873;12340.81488777669;12341.321227332493;12399.938000310009;12450.066245031636;12462.937685311583;748.057447616005;766.1495739728924;766.7853001159656;770.8111512679374;772.069656064441;632.0645444741785;738.7303634173514;761.6915149364517;768.8654485465021;772.5210369570874;803.2329125684956;809.4212637963855;810.8337790752881;812.544974814106;812.5612169428501;802.8514724775906;803.2690251870828;803.6102490292203;807.7172989453703;808.3048578222724;587.309910854744;588.2382314902169;588.2822955993681;591.0336599659545;593.0807248764442;11680.182387232897;11689.649310520697;11701.473433695504;11722.824157637642;11757.529698812037;13572.864271357357;13770.05280801765;14083.436662533486;14139.151650900978;14421.567352979428;9972.15236704881;10022.448765317977;10221.182305415548;10249.897501024969;10285.537150828231;3300.352902162455;3316.4859446785786;3328.8335583220983;3336.0492259705866;3357.9328413431595;63698;63832;65088.67455662739;65683.3431665682;66646.66676666634;10331.535080921376;10362.844557331646;10375.63685271027;10631.362118272928;11034.117270618332;19302.71045934312;19352.516187095436;19474.707879381822;19499.31752388688;20434.591308173753;6741.157355330583;6794.660266986631;6822.351876571718;6892.724291028303;7194.928050719531;3543.6633519815578;3588.246468241646;3620.9094772630897;3646.4894914711963;3705.388610879175;3020.6828283030404;3111.004478566837;3115.6261248650308;3116.7350775184364;3124.375124975014;500.759635375022;517.4851023231909;520.622548652224;545.4845171313071;575.0569066730566;539.5440852479649;551.8151419274589;568.3170673649101;574.7442388137239;591.8313280714975;8248.587570621445;8280.130586288473;8303.8339233215;8368.58157092143;8502.234798868132;483.4126536258463;540.6620861961275;578.82635209437;589.5666684986531;592.1739173852452;3856.5950575189763;3886.9310939491866;4010.2581022510344;4017.337139371971;4052.2908491014546;100536.49731751294;105044.47477762715;106737;107476;110592.4470377659;60108;67733.66133169303;68717.31282687109;90008;96653;41727.165456690695;41958.16083678309;42885.35671964923;71330;74169.88745168826;8076.636551355085;8534.82930341402;8590.484570925764;8632.30941524664;8701.390902636755;31419.84290078535;31501;39104;42349.36475952925;43276.13447731091;64223.036654449286;65250.673746630964;66319;66353.66823165854;67223.32776672367;10362.844557331495;10543.103836173705;10672.413017284123;10975.451227438436;11420.143489238175;12390.380480975735;12473.126881118598;12488.875111248772;12812.807807882702;13208.471661133448;11252.887471125512;11257.549698011988;11784.234024788362;11823.349715765715;11983.700407489883;10923.180761443082;10959.232853700483;11142.331460112418;11266.830997535208;11658.591949281734;11345.262557933707;11374.829377559508;11751.529938802352;11821.290722556674;11910;9019.864702029343;9180.219681326895;9276.814463710823;9410.482423466776;9443.338966272295;7895.7236496722335;8018.077921038922;8072.394570407126;9608.183304418922;10561.102306303743 08:21:53 INFO - PROCESS | 15216 | __end_tp_report 08:21:53 INFO - PROCESS | 15216 | __start_cc_report 08:21:53 INFO - PROCESS | 15216 | _x_x_mozilla_cycle_collect,379 08:21:53 INFO - PROCESS | 15216 | __end_cc_report 08:21:53 INFO - PROCESS | 15216 | __startTimestamp1470756113676__endTimestamp 08:21:53 INFO - PROCESS | 15216 | 08:21:53 INFO - PROCESS | 15216 | ------- Summary: start ------- 08:21:53 INFO - PROCESS | 15216 | Number of tests: 6 08:21:53 INFO - PROCESS | 15216 | 08:21:53 INFO - PROCESS | 15216 | [#0] dojo.html Cycles:165 Average:4805.51 Median:4928.88 stddev:510.97 (10.4%) stddev-sans-first:483.67 08:21:53 INFO - PROCESS | 15216 | Values: 2647.0 2694.2 2700.1 2730.5 2733.5 4621.5 4889.9 4924.3 4938.3 4956.0 4762.2 4809.5 4847.7 4848.0 4852.3 4319.5 4334.8 4385.3 4443.4 4492.9 4436.9 4465.0 4466.6 4484.3 4513.5 4319.8 4435.4 4442.1 4478.0 4485.4 4450.6 4453.0 4459.0 4464.0 4533.6 4476.1 4499.9 4504.8 4508.4 4529.5 4821.3 4862.4 4895.5 4897.9 4912.8 5247.5 5266.5 5278.6 5279.3 5312.0 5115.6 5289.6 5310.2 5324.0 5324.3 4833.2 4850.1 4858.0 4890.7 4928.9 5324.0 5327.9 5341.7 5349.1 5397.3 4944.3 5106.0 5106.9 5113.7 5115.9 5201.4 5204.2 5220.4 5228.9 5246.0 5142.6 5147.1 5150.0 5161.2 5243.0 4961.0 5177.0 5189.0 5192.9 5201.9 4281.4 4371.8 4392.0 4411.7 4469.0 3846.4 3849.0 3856.3 3875.7 3882.6 4470.3 4500.2 4505.8 4512.3 4548.3 5023.8 5205.0 5206.6 5236.0 5303.1 4469.8 4496.3 4496.8 4499.2 4542.3 4696.2 4706.7 4712.7 4713.7 4754.4 4647.3 4828.5 4832.8 4849.9 4922.5 5219.4 5238.7 5249.0 5282.9 5286.3 4675.8 4925.1 4927.3 4937.1 4969.0 4957.3 5052.8 5114.7 5118.1 5137.0 5157.5 5200.3 5211.6 5250.9 5252.8 5025.1 5044.1 5045.5 5066.0 5097.4 4880.4 5041.4 5062.4 5065.9 5068.7 4995.6 4997.2 5036.4 5042.6 5069.1 5133.9 5143.4 5150.4 5151.3 5209.4 4844.0 4982.7 4995.4 5023.4 5029.4 08:21:53 INFO - PROCESS | 15216 | 08:21:53 INFO - PROCESS | 15216 | [#1] ext.html Cycles:180 Average:47552.47 Median:37370.72 stddev:88545.06 (236.9%) stddev-sans-first:88723.11 08:21:53 INFO - PROCESS | 15216 | Values: 545.6 549.3 553.7 560.7 575.7 35249.6 39451.4 39542.8 39577.4 39642.4 39333.0 40105.0 40126.6 40157.0 40172.0 7575.5 7635.6 7659.4 7690.0 7696.5 7713.3 7718.8 7761.6 7762.3 7801.6 7768.4 7883.3 7888.1 7888.6 7897.6 7770.1 7822.3 7837.6 7844.1 7846.8 7652.2 7689.2 7694.8 7697.8 7716.4 38862.6 38915.8 38932.0 39043.8 39044.4 2735.2 3131.4 3208.2 3226.7 3256.8 25892.9 27084.9 28439.4 28807.9 28968.6 3350.8 3369.5 3401.8 3461.0 3534.0 218078.0 271097.0 272591.0 272733.6 274736.0 31850.5 58035.7 58314.7 58448.7 58553.7 32665.3 34510.1 34545.0 34635.1 34671.3 13121.5 13153.7 13211.3 13211.4 13226.1 10878.7 11002.9 11016.3 11018.3 11048.0 7856.8 7889.6 7917.5 7987.1 8037.9 3097.1 3110.3 3111.6 3114.1 3119.9 802.4 817.7 826.4 873.7 909.5 27839.2 28869.3 29106.7 29226.3 29521.6 892.3 902.5 914.6 915.2 925.3 15247.0 15297.8 15354.2 15442.7 15583.8 404815.0 409918.0 412195.0 413117.0 414703.0 50499.0 51221.5 51266.7 51268.2 51393.5 1147.3 1192.5 1195.5 1197.6 1204.6 27355.6 27737.0 28281.3 28626.4 28933.9 44465.3 44494.0 45166.0 45200.3 45372.3 312596.0 314030.0 315332.0 315687.0 315807.0 25703.0 26170.3 26219.9 26266.3 26272.5 43156.0 43327.5 43879.0 44576.6 44596.0 37201.4 37333.8 37358.8 37889.0 38246.6 36446.8 37382.6 37849.4 38440.4 38617.2 30154.0 35531.0 35599.8 36206.0 36207.1 31746.5 33457.0 33882.5 34052.7 34223.3 25211.9 25270.5 25613.6 25616.6 25734.6 08:21:53 INFO - PROCESS | 15216 | 08:21:53 INFO - PROCESS | 15216 | [#2] jquery.html Cycles:180 Average:22222.36 Median:5160.22 stddev:54912.14 (1064.1%) stddev-sans-first:55041.63 08:21:53 INFO - PROCESS | 15216 | Values: 351.8 361.9 364.7 366.6 380.3 15775.5 15851.1 16964.5 17119.6 17164.7 16233.0 16869.9 17355.1 17406.6 17499.1 5058.0 5265.9 5275.9 5277.7 5286.9 5165.2 5171.3 5217.7 5218.9 5230.1 5164.0 5177.1 5204.4 5207.9 5216.9 5004.1 5035.3 5139.5 5139.8 5156.5 5082.3 5246.2 5252.0 5256.4 5277.3 12707.9 12837.0 12854.4 12887.4 17463.6 1836.9 1968.8 2226.4 2294.1 2385.5 9209.7 9212.4 9515.6 9575.6 9729.6 1724.9 1783.8 1811.6 1823.1 1824.6 71788.9 74384.0 75020.6 75188.0 75398.6 9157.1 9214.8 9265.8 9516.7 9627.6 12502.2 12550.0 12558.9 12582.5 12681.4 7058.3 7221.5 7258.5 7384.4 7411.4 7110.3 7185.0 7343.9 7344.9 7373.7 3896.4 4005.8 4088.7 4131.6 4169.4 1695.3 1709.3 1717.2 1717.9 1753.8 713.5 779.3 795.5 860.1 897.4 17155.7 17407.7 17898.0 18399.0 18716.7 752.1 814.1 820.7 848.4 884.6 8474.6 9956.3 9996.9 10020.2 10078.7 274454.0 280332.0 280879.0 389260.0 393097.0 48225.0 48637.3 85095.6 89614.6 89907.1 934.4 943.7 947.2 955.7 961.7 15683.6 15928.0 16240.5 16294.5 16387.9 26873.6 28121.9 29209.0 37460.8 39654.8 53814.7 54750.5 55330.2 55749.4 56860.7 6779.2 7179.3 7460.1 7720.6 7868.3 10558.3 11727.2 11856.1 11949.8 12140.2 9453.4 9560.2 9574.4 9592.7 10425.2 9947.9 10422.3 10595.3 10783.9 10836.2 9750.7 10218.6 10388.5 10604.6 10845.9 7131.8 7188.7 7202.6 7287.6 7532.6 8490.7 9701.7 9868.2 9903.7 10125.2 08:21:53 INFO - PROCESS | 15216 | 08:21:53 INFO - PROCESS | 15216 | [#3] mootools.html Cycles:180 Average:5036.74 Median:4927.72 stddev:2852.52 (57.9%) stddev-sans-first:2847.08 08:21:53 INFO - PROCESS | 15216 | Values: 1351.7 1395.9 1437.6 1604.6 1649.8 6462.8 7222.2 7363.8 7957.7 7959.5 7313.0 7466.4 7484.7 7486.4 7489.5 2130.6 2174.7 2176.4 2178.9 2181.2 2096.6 2128.6 2157.0 2162.7 2174.7 2149.8 2151.2 2169.3 2179.0 2187.2 2088.3 2091.3 2094.2 2094.6 2096.3 2033.3 2106.9 2111.4 2114.2 2117.6 7483.9 7522.9 7534.3 7565.0 7567.1 4448.8 4523.4 4527.6 4565.0 4573.1 2809.0 2817.6 2854.0 2885.6 2904.3 822.4 857.1 860.1 862.0 864.5 10433.2 10460.1 10471.2 10497.0 10538.3 3983.4 4064.9 4261.1 4269.3 4280.6 9100.3 9102.6 9109.0 9122.5 9126.8 4646.8 4655.2 4671.0 4673.9 4677.2 3483.6 4130.7 4237.6 4267.8 4272.4 3475.1 3512.1 3559.2 3571.3 3628.6 1131.1 1139.7 1151.5 1154.4 1163.2 812.0 827.6 837.3 839.0 845.8 4923.0 4932.5 4985.7 5105.0 5108.5 395.9 412.5 412.6 412.8 414.6 3346.2 3424.6 3444.8 3451.6 3603.4 9044.3 9483.2 9553.3 9590.0 9596.8 9469.5 9514.5 9532.1 9533.0 9572.5 6954.2 7063.2 7138.0 7362.5 7469.4 4943.7 5014.9 5113.1 5135.0 5163.6 8371.1 8591.4 8644.4 8664.4 8808.6 8775.4 8810.5 8811.9 8844.6 8877.0 5967.9 6707.1 6844.8 6861.2 7005.6 7578.7 7687.5 7696.1 7697.5 7697.6 6719.7 6746.6 6853.6 6951.4 6963.4 6692.4 6723.4 6774.3 6832.8 6918.7 5821.7 5893.7 5920.3 5936.8 5984.6 4420.8 4445.3 4516.9 4521.5 4527.7 4464.3 4507.5 4579.8 4601.6 4707.7 08:21:53 INFO - PROCESS | 15216 | 08:21:53 INFO - PROCESS | 15216 | [#4] prototype.html Cycles:180 Average:4424.87 Median:5099.27 stddev:1304.39 (25.6%) stddev-sans-first:1270.72 08:21:53 INFO - PROCESS | 15216 | Values: 297.1 297.8 304.6 304.9 305.1 5106.4 5174.0 5174.5 5178.5 5190.7 5074.1 5078.3 5079.5 5089.4 5104.8 3760.3 3917.8 3920.4 3972.8 3987.5 3950.5 3950.8 3955.5 3972.0 3989.4 3940.5 3979.9 3995.6 4007.9 4011.0 3717.3 3908.9 3933.8 4013.8 4018.9 3406.8 3410.5 3415.2 3420.9 3424.3 4941.6 4945.9 4953.7 4955.7 4993.2 4210.3 4520.2 4523.7 4525.3 4569.1 5284.7 5310.6 5310.9 5316.2 5324.1 3698.2 3701.4 3708.3 3728.3 3729.9 5383.8 5624.9 5627.9 5630.4 5633.8 3838.3 3844.1 3846.2 3850.2 3853.9 3907.3 3928.8 3932.3 3933.2 3940.9 4497.5 4518.7 4526.9 4535.7 4541.7 5259.8 5359.7 5378.8 5379.5 5424.9 1329.9 1349.7 1357.2 1361.1 1361.5 800.0 809.4 836.1 844.6 856.6 4508.6 4613.0 4640.5 4679.9 4688.6 5487.5 5525.7 5526.5 5543.7 5556.8 4459.8 4638.5 4659.4 4670.7 4696.9 2869.0 2917.2 2924.3 2928.8 2948.4 5093.8 5120.9 5158.7 5160.5 5171.2 5293.6 5588.4 5591.1 5618.5 5699.0 5093.5 5105.5 5119.8 5122.9 5123.9 5485.8 5514.3 5520.8 5521.2 5531.4 5159.7 5432.5 5440.8 5471.5 5480.4 5180.4 5205.1 5208.3 5217.6 5224.1 3874.2 3902.0 3911.4 3913.6 3915.4 5465.1 5504.8 5517.2 5532.8 5551.5 5369.0 5380.6 5383.8 5388.6 5399.2 5189.7 5414.6 5422.1 5423.4 5423.8 5225.2 5253.2 5263.2 5269.7 5272.4 5119.1 5258.4 5367.6 5390.5 5425.8 5248.5 5267.1 5305.1 5330.9 5359.2 08:21:53 INFO - PROCESS | 15216 | 08:21:53 INFO - PROCESS | 15216 | [#5] yui.html Cycles:180 Average:17118.05 Median:42617.36 stddev:24957.50 (58.6%) stddev-sans-first:24996.69 08:21:53 INFO - PROCESS | 15216 | Values: 599.1 610.7 623.6 633.4 695.8 11849.5 12597.9 12613.9 12834.2 12840.3 12340.8 12341.3 12399.9 12450.1 12462.9 748.1 766.1 766.8 770.8 772.1 632.1 738.7 761.7 768.9 772.5 803.2 809.4 810.8 812.5 812.6 802.9 803.3 803.6 807.7 808.3 587.3 588.2 588.3 591.0 593.1 11680.2 11689.6 11701.5 11722.8 11757.5 13572.9 13770.1 14083.4 14139.2 14421.6 9972.2 10022.4 10221.2 10249.9 10285.5 3300.4 3316.5 3328.8 3336.0 3357.9 63698.0 63832.0 65088.7 65683.3 66646.7 10331.5 10362.8 10375.6 10631.4 11034.1 19302.7 19352.5 19474.7 19499.3 20434.6 6741.2 6794.7 6822.4 6892.7 7194.9 3543.7 3588.2 3620.9 3646.5 3705.4 3020.7 3111.0 3115.6 3116.7 3124.4 500.8 517.5 520.6 545.5 575.1 539.5 551.8 568.3 574.7 591.8 8248.6 8280.1 8303.8 8368.6 8502.2 483.4 540.7 578.8 589.6 592.2 3856.6 3886.9 4010.3 4017.3 4052.3 100536.5 105044.5 106737.0 107476.0 110592.4 60108.0 67733.7 68717.3 90008.0 96653.0 41727.2 41958.2 42885.4 71330.0 74169.9 8076.6 8534.8 8590.5 8632.3 8701.4 31419.8 31501.0 39104.0 42349.4 43276.1 64223.0 65250.7 66319.0 66353.7 67223.3 10362.8 10543.1 10672.4 10975.5 11420.1 12390.4 12473.1 12488.9 12812.8 13208.5 11252.9 11257.5 11784.2 11823.3 11983.7 10923.2 10959.2 11142.3 11266.8 11658.6 11345.3 11374.8 11751.5 11821.3 11910.0 9019.9 9180.2 9276.8 9410.5 9443.3 7895.7 8018.1 8072.4 9608.2 10561.1 08:21:53 INFO - PROCESS | 15216 | -------- Summary: end -------- 08:21:53 INFO - PROCESS | 15216 | 08:21:54 INFO - TEST-INFO | 15216: exit 0 08:21:54 INFO - TEST-OK | dromaeo_css | took 1117465ms 08:21:54 INFO - TEST-START | kraken 08:21:54 INFO - operating with platform_type : linux_ 08:21:54 INFO - Initialising browser for kraken test... 08:21:54 INFO - TEST-INFO | started process 15460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp20x_Cv/profile http://localhost:46333/getInfo.html) 08:21:59 INFO - PROCESS | 15460 | __metrics Screen width/height:1600/1200 08:21:59 INFO - PROCESS | 15460 | colorDepth:24 08:21:59 INFO - PROCESS | 15460 | Browser inner width/height: 1024/697 08:21:59 INFO - PROCESS | 15460 | __metrics 08:21:59 ERROR - PROCESS | 15460 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 08:22:00 INFO - TEST-INFO | 15460: exit 0 08:22:00 INFO - Browser initialized. 08:22:00 INFO - Running cycle 1/1 for kraken test... 08:22:00 INFO - TEST-INFO | started process 15580 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp20x_Cv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:22:12 INFO - PROCESS | 15580 | RSS: Main: 164929536 08:22:12 INFO - PROCESS | 15580 | 08:22:15 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46333/tests/kraken/driver.html?testName=audio-beat-detection) 08:22:16 INFO - PROCESS | 15580 | RSS: Main: 170156032 08:22:16 INFO - PROCESS | 15580 | 08:22:19 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46333/tests/kraken/driver.html?testName=audio-dft) 08:22:19 INFO - PROCESS | 15580 | RSS: Main: 169009152 08:22:19 INFO - PROCESS | 15580 | 08:22:22 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46333/tests/kraken/driver.html?testName=audio-fft) 08:22:23 INFO - PROCESS | 15580 | RSS: Main: 165462016 08:22:23 INFO - PROCESS | 15580 | 08:22:25 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46333/tests/kraken/driver.html?testName=audio-oscillator) 08:22:26 INFO - PROCESS | 15580 | RSS: Main: 166047744 08:22:26 INFO - PROCESS | 15580 | 08:22:28 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46333/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:22:29 INFO - PROCESS | 15580 | RSS: Main: 166678528 08:22:29 INFO - PROCESS | 15580 | 08:22:32 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46333/tests/kraken/driver.html?testName=imaging-darkroom) 08:22:33 INFO - PROCESS | 15580 | RSS: Main: 166502400 08:22:33 INFO - PROCESS | 15580 | 08:22:36 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46333/tests/kraken/driver.html?testName=imaging-desaturate) 08:22:37 INFO - PROCESS | 15580 | RSS: Main: 164007936 08:22:37 INFO - PROCESS | 15580 | 08:22:40 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46333/tests/kraken/driver.html?testName=json-parse-financial) 08:22:40 INFO - PROCESS | 15580 | RSS: Main: 165773312 08:22:40 INFO - PROCESS | 15580 | 08:22:42 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46333/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:22:43 INFO - PROCESS | 15580 | RSS: Main: 165875712 08:22:43 INFO - PROCESS | 15580 | 08:22:45 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46333/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:22:45 INFO - PROCESS | 15580 | RSS: Main: 166113280 08:22:45 INFO - PROCESS | 15580 | 08:22:47 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46333/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:22:48 INFO - PROCESS | 15580 | RSS: Main: 166596608 08:22:48 INFO - PROCESS | 15580 | 08:22:51 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46333/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:22:52 INFO - PROCESS | 15580 | RSS: Main: 166985728 08:22:52 INFO - PROCESS | 15580 | 08:22:55 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46333/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:22:55 INFO - PROCESS | 15580 | RSS: Main: 166805504 08:22:55 INFO - PROCESS | 15580 | 08:22:57 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:46333/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46333/tests/kraken/driver.html?testName=ai-astar) 08:22:57 INFO - PROCESS | 15580 | RSS: Main: 167456768 08:22:57 INFO - PROCESS | 15580 | 08:22:57 INFO - PROCESS | 15580 | __start_tp_report 08:22:57 INFO - PROCESS | 15580 | _x_x_mozilla_page_load 08:22:57 INFO - PROCESS | 15580 | _x_x_mozilla_page_load_details 08:22:57 INFO - PROCESS | 15580 | |i|pagename|runs| 08:22:57 INFO - PROCESS | 15580 | |0;ai-astar;106;115;111;116;116;117;117;117;113;115 08:22:57 INFO - PROCESS | 15580 | |1;audio-beat-detection;158;129;147;188;126;152;149;125;194;122 08:22:57 INFO - PROCESS | 15580 | |2;audio-dft;165;165;167;168;162;164;165;163;164;164 08:22:57 INFO - PROCESS | 15580 | |3;audio-fft;77;77;76;175;77;77;75;76;160;77 08:22:57 INFO - PROCESS | 15580 | |4;audio-oscillator;86;86;157;86;85;85;136;85;85;139 08:22:57 INFO - PROCESS | 15580 | |5;imaging-gaussian-blur;117;117;118;118;118;117;117;118;118;117 08:22:57 INFO - PROCESS | 15580 | |6;imaging-darkroom;149;148;147;148;148;147;148;147;146;146 08:22:57 INFO - PROCESS | 15580 | |7;imaging-desaturate;95;96;96;96;96;96;98;96;96;96 08:22:57 INFO - PROCESS | 15580 | |8;json-parse-financial;62;65;64;64;64;65;65;63;63;63 08:22:57 INFO - PROCESS | 15580 | |9;json-stringify-tinderbox;66;66;66;66;67;66;67;66;66;65 08:22:57 INFO - PROCESS | 15580 | |10;stanford-crypto-aes;80;84;85;88;87;80;81;80;87;81 08:22:57 INFO - PROCESS | 15580 | |11;stanford-crypto-ccm;140;134;132;153;151;136;132;132;149;132 08:22:57 INFO - PROCESS | 15580 | |12;stanford-crypto-pbkdf2;171;171;170;165;166;170;170;166;165;170 08:22:57 INFO - PROCESS | 15580 | |13;stanford-crypto-sha256-iterative;68;71;69;69;69;68;73;67;68;68 08:22:57 INFO - PROCESS | 15580 | __end_tp_report 08:22:57 INFO - PROCESS | 15580 | __start_cc_report 08:22:57 INFO - PROCESS | 15580 | _x_x_mozilla_cycle_collect,972 08:22:57 INFO - PROCESS | 15580 | __end_cc_report 08:22:57 INFO - PROCESS | 15580 | __startTimestamp1470756177746__endTimestamp 08:22:57 INFO - PROCESS | 15580 | 08:22:57 INFO - PROCESS | 15580 | ------- Summary: start ------- 08:22:57 INFO - PROCESS | 15580 | Number of tests: 14 08:22:57 INFO - PROCESS | 15580 | 08:22:57 INFO - PROCESS | 15580 | [#0] ai-astar Cycles:10 Average:114.30 Median:116.00 stddev:3.50 (3.0%) stddev-sans-first:2.05 08:22:57 INFO - PROCESS | 15580 | Values: 106.0 115.0 111.0 116.0 116.0 117.0 117.0 117.0 113.0 115.0 08:22:57 INFO - PROCESS | 15580 | 08:22:57 INFO - PROCESS | 15580 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:150.50 stddev:25.55 (17.0%) stddev-sans-first:26.89 08:22:57 INFO - PROCESS | 15580 | Values: 158.0 129.0 147.0 188.0 126.0 152.0 149.0 125.0 194.0 122.0 08:22:57 INFO - PROCESS | 15580 | 08:22:57 INFO - PROCESS | 15580 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.00 stddev:1.77 (1.1%) stddev-sans-first:1.87 08:22:57 INFO - PROCESS | 15580 | Values: 165.0 165.0 167.0 168.0 162.0 164.0 165.0 163.0 164.0 164.0 08:22:57 INFO - PROCESS | 15580 | 08:22:57 INFO - PROCESS | 15580 | [#3] audio-fft Cycles:10 Average:94.70 Median:77.00 stddev:38.54 (50.0%) stddev-sans-first:40.34 08:22:57 INFO - PROCESS | 15580 | Values: 77.0 77.0 76.0 175.0 77.0 77.0 75.0 76.0 160.0 77.0 08:22:57 INFO - PROCESS | 15580 | 08:22:57 INFO - PROCESS | 15580 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:85.00 stddev:28.80 (33.9%) stddev-sans-first:29.88 08:22:57 INFO - PROCESS | 15580 | Values: 86.0 86.0 157.0 86.0 85.0 85.0 136.0 85.0 85.0 139.0 08:22:57 INFO - PROCESS | 15580 | 08:22:57 INFO - PROCESS | 15580 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:22:57 INFO - PROCESS | 15580 | Values: 117.0 117.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 117.0 08:22:57 INFO - PROCESS | 15580 | 08:22:57 INFO - PROCESS | 15580 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:0.83 08:22:57 INFO - PROCESS | 15580 | Values: 149.0 148.0 147.0 148.0 148.0 147.0 148.0 147.0 146.0 146.0 08:22:57 INFO - PROCESS | 15580 | 08:22:57 INFO - PROCESS | 15580 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 08:22:57 INFO - PROCESS | 15580 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 98.0 96.0 96.0 96.0 08:22:57 INFO - PROCESS | 15580 | 08:22:57 INFO - PROCESS | 15580 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:1.03 (1.6%) stddev-sans-first:0.87 08:22:57 INFO - PROCESS | 15580 | Values: 62.0 65.0 64.0 64.0 64.0 65.0 65.0 63.0 63.0 63.0 08:22:57 INFO - PROCESS | 15580 | 08:22:57 INFO - PROCESS | 15580 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 08:22:57 INFO - PROCESS | 15580 | Values: 66.0 66.0 66.0 66.0 67.0 66.0 67.0 66.0 66.0 65.0 08:22:57 INFO - PROCESS | 15580 | 08:22:57 INFO - PROCESS | 15580 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:84.50 stddev:3.27 (3.9%) stddev-sans-first:3.24 08:22:57 INFO - PROCESS | 15580 | Values: 80.0 84.0 85.0 88.0 87.0 80.0 81.0 80.0 87.0 81.0 08:22:57 INFO - PROCESS | 15580 | 08:22:57 INFO - PROCESS | 15580 | [#11] stanford-crypto-ccm Cycles:10 Average:139.10 Median:138.00 stddev:8.63 (6.3%) stddev-sans-first:9.15 08:22:57 INFO - PROCESS | 15580 | Values: 140.0 134.0 132.0 153.0 151.0 136.0 132.0 132.0 149.0 132.0 08:22:57 INFO - PROCESS | 15580 | 08:22:57 INFO - PROCESS | 15580 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:170.00 stddev:2.55 (1.5%) stddev-sans-first:2.52 08:22:57 INFO - PROCESS | 15580 | Values: 171.0 171.0 170.0 165.0 166.0 170.0 170.0 166.0 165.0 170.0 08:22:57 INFO - PROCESS | 15580 | 08:22:57 INFO - PROCESS | 15580 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.76 (2.6%) stddev-sans-first:1.83 08:22:57 INFO - PROCESS | 15580 | Values: 68.0 71.0 69.0 69.0 69.0 68.0 73.0 67.0 68.0 68.0 08:22:57 INFO - PROCESS | 15580 | -------- Summary: end -------- 08:22:57 INFO - PROCESS | 15580 | 08:22:58 INFO - TEST-INFO | 15580: exit 0 08:22:58 INFO - TEST-OK | kraken | took 64424ms 08:22:58 INFO - SUITE-END | took 1181s 08:22:58 INFO - Completed test suite (00:19:41) 08:22:58 INFO - javascript benchmark 08:22:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6330.713129885275, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2646.9867650661745, 2694.178275625934, 2700.1224602004354, 2730.4948584511867, 2733.5216337140996, 4621.491635920054, 4889.853304400869, 4924.261360795882, 4938.308636790852, 4956.0, 4762.166620841356, 4809.495003024685, 4847.733374664392, 4847.975760121203, 4852.344933433994, 4319.546447622994, 4334.804933777972, 4385.254506733863, 4443.355713421552, 4492.910141797162, 4436.866893993185, 4465.017696106851, 4466.620337271336, 4484.260097083978, 4513.526079761627, 4319.805608747614, 4435.401220835211, 4442.111577684476, 4477.955220447787, 4485.439320084989, 4450.643948484114, 4452.9554704453185, 4459.0, 4463.973286144205, 4533.569310915458, 4476.1271552047365, 4499.865004049884, 4504.774761261924, 4508.436445444319, 4529.547045295477, 4821.276808478721, 4862.44081930579, 4895.461499235082, 4897.8775530611665, 4912.778924948386, 5247.501487358695, 5266.4733526647415, 5278.630495865291, 5279.260903473479, 5312.043832110218, 5115.590752739772, 5289.629725919187, 5310.176922577007, 5323.973380133075, 5324.281222035014, 4833.178359678898, 4850.054239423349, 4857.95142048575, 4890.731009794425, 4928.8767780805765, 5323.973380133075, 5327.946720532823, 5341.7062061586985, 5349.063913815066, 5397.298351214396, 4944.283078953532, 5105.978804239167, 5106.948930510647, 5113.667611605309, 5115.87210319745, 5201.375834899836, 5204.193350030751, 5220.3735551734035, 5228.92156617651, 5246.0, 5142.5628821549835, 5147.0735267651435, 5149.9742501287255, 5161.225816127536, 5242.9737851311265, 4960.950390496121, 5176.9741151294, 5188.9740551297, 5192.8961420771375, 5201.869953251199, 4281.443412356373, 4371.803268852909, 4392.0, 4411.713238639478, 4468.955310446919, 3846.3845784674318, 3848.9615103848605, 3856.325143099946, 3875.7093218008763, 3882.592327805596, 4470.284754439339, 4500.234960056799, 4505.774711264424, 4512.300593408027, 4548.317752337176, 5023.799048038038, 5205.011047900886, 5206.557442617344, 5235.973820130875, 5303.0719624066405, 4469.7988590513505, 4496.258117410591, 4496.752678602708, 4499.167653984024, 4542.341360502709, 4696.2486002239475, 4706.717596944194, 4712.717236965793, 4713.6936099153445, 4754.429468463806, 4647.34937108805, 4828.5412885775095, 4832.782524786463, 4849.927251091307, 4922.507749225048, 5219.425863154974, 5238.711870846988, 5249.0, 5282.867928301823, 5286.286351342519, 4675.766211689333, 4925.088858561035, 4927.310176575354, 4937.1113199624415, 4968.975155124346, 4957.281194226889, 5052.823151189691, 5114.74426278692, 5118.053160165381, 5137.0, 5157.458466861076, 5200.323957885451, 5211.557017653542, 5250.921236181537, 5252.7898884045735, 5025.145725226794, 5044.0920634286185, 5045.520675535819, 5066.0, 5097.388313402415, 4880.438749543848, 5041.445441001413, 5062.367204099488, 5065.898682026265, 5068.670536415121, 4995.600351971906, 4997.225430058346, 5036.395632523974, 5042.571381432473, 5069.087564238325, 5133.8973220534635, 5143.3570803649545, 5150.381954165524, 5151.278820965143, 5209.374875015023, 4844.031193761332, 4982.6512144149565, 4995.375578052744, 5023.447420783637, 5029.4216165140015], "value": 4772.557983139187, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.5799034743247, 549.3353042818189, 553.698234462218, 560.7224423910166, 575.7380391921677, 35249.64750352496, 39451.40822887656, 39542.80228598853, 39577.406338904904, 39642.40536391949, 39333.0, 40105.0, 40126.59873401265, 40157.0, 40172.0, 7575.469717119818, 7635.618219089051, 7659.425543084263, 7690.0, 7696.461247712635, 7713.267239612228, 7718.7684369468725, 7761.611919404036, 7762.262585054411, 7801.609919504031, 7768.417368697342, 7883.251091146332, 7888.053433587977, 7888.605569721491, 7897.605119744018, 7770.145284018753, 7822.295993360596, 7837.647305871193, 7844.0979287382115, 7846.843063138763, 7652.2347765223585, 7689.231076892322, 7694.769156925301, 7697.846043079107, 7716.382689384835, 38862.61137388618, 38915.80542097271, 38932.02669933246, 39043.804780975915, 39044.41433378502, 2735.2067900308884, 3131.3580715953176, 3208.1658768720067, 3226.7418606511424, 3256.788308759923, 25892.870535647202, 27084.86457567719, 28439.431211375864, 28807.855960720273, 28968.565471517944, 3350.849211785451, 3369.4608862582113, 3401.8299085045896, 3460.9653903460894, 3534.0458076319505, 218078.0, 271097.0, 272591.0, 272733.63633181906, 274736.0, 31850.522242166386, 58035.70982145147, 58314.70842645845, 58448.70775646094, 58553.70723146357, 32665.346693066007, 34510.137246568534, 34545.0, 34635.13412164716, 34671.30657386838, 13121.540746073842, 13153.73692526144, 13211.273379964194, 13211.405486752927, 13226.07417480767, 10878.72803179911, 11002.889971100347, 11016.339019658846, 11018.338899666045, 11048.0, 7856.803579910434, 7889.605519723991, 7917.524948502993, 7987.081485629227, 8037.879431808527, 3097.0863595239457, 3110.331278775074, 3111.5799367085156, 3114.143610507129, 3119.859606317721, 802.4342838299102, 817.721974528663, 826.4256341842482, 873.724776695339, 909.486140330711, 27839.164825055283, 28869.27826804347, 29106.7089329104, 29226.26934326616, 29521.557176642367, 892.2727976698969, 902.4855832175729, 914.6053214305326, 915.2220612479339, 925.2551695884878, 15247.0, 15297.847021529642, 15354.232288385536, 15442.741433021807, 15583.84416155824, 404815.0, 409918.0, 412195.0, 413117.0, 414703.0, 50499.0, 51221.487785122416, 51266.74366628143, 51268.23097653538, 51393.48606513887, 1147.2944139354238, 1192.5468322037743, 1195.462042081067, 1197.6227488341144, 1204.6145233525187, 27355.589666154625, 27737.0, 28281.292967675974, 28626.42747145004, 28933.85533072321, 44465.333020005375, 44494.0, 45166.0, 45200.32199517076, 45372.31941520814, 312596.0, 314030.0, 315332.0, 315687.0, 315807.0, 25703.0, 26170.345741356618, 26219.868900655376, 26266.343341416617, 26272.474550509265, 43156.0, 43327.48353807602, 43879.0, 44576.55423445854, 44596.0, 37201.44197837089, 37333.81333093317, 37358.813205933795, 37889.0, 38246.617533824305, 36446.81776591206, 37382.62617373792, 37849.4322585156, 38440.42339364856, 38617.2276554473, 30154.0, 35531.0, 35599.82200088983, 36206.0, 36207.094822629646, 31746.523802142525, 33456.99629011133, 33882.49176262407, 34052.65947340594, 34223.31553368869, 25211.87394063018, 25270.49459010846, 25613.61579576345, 25616.61575076338, 25734.613980789927], "value": 16569.168127918616, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.825846206128, 361.87334432948467, 364.6699736738252, 366.6297039989613, 380.32871980953604, 15775.526734197963, 15851.128187949658, 16964.491065268045, 17119.57201069974, 17164.656706865855, 16233.0, 16869.91565042173, 17355.132243387812, 17406.564835879108, 17499.125043747827, 5058.0, 5265.947340526584, 5275.920861187066, 5277.70972596507, 5286.867828304285, 5165.173572228444, 5171.301874246985, 5217.686938783685, 5218.895622087556, 5230.137027390476, 5163.974180129113, 5177.094008548508, 5204.401493828202, 5207.86980325493, 5216.8695782605355, 5004.12427825131, 5035.269885866529, 5139.460356662571, 5139.794408223666, 5156.458571849939, 5082.288479612857, 5246.160614301732, 5251.973740131313, 5256.369235691742, 5277.313949186581, 12707.872921270762, 12837.0, 12854.421551030133, 12887.420066097047, 17463.563410914703, 1836.917338719761, 1968.803119688034, 2226.3877433705698, 2294.139697613395, 2385.546746118232, 9209.677661281823, 9212.355135140542, 9515.57179926905, 9575.61697532098, 9729.610815567368, 1724.879258451909, 1783.777027871516, 1811.610503741702, 1823.124900047971, 1824.6259516799025, 71788.92316615256, 74384.0, 75020.62489687571, 75188.0, 75398.62300688516, 9157.130072643089, 9214.76963075915, 9265.814683706423, 9516.714498565054, 9627.614895404246, 12502.187357821713, 12550.0, 12558.87441125577, 12582.496700132075, 12681.365931703562, 7058.329458701415, 7221.494495385377, 7258.455615828834, 7384.446166537424, 7411.444141689287, 7110.32451917067, 7184.994100825888, 7343.88984165238, 7344.889826652605, 7373.668184931691, 3896.4155376693725, 4005.839766409369, 4088.7342322748927, 4131.648809851136, 4169.353750168668, 1695.3218712514847, 1709.2991873332123, 1717.1500107446893, 1717.8711596630053, 1753.7544743735887, 713.4577720932025, 779.3375630713848, 795.5226863881625, 860.0582362313257, 897.4256475855458, 17155.742663860052, 17407.73888391675, 17898.0, 18398.988055657068, 18716.719249211274, 752.1125072414494, 814.104485066434, 820.6512232301368, 848.4230723108222, 884.6196135661598, 8474.576271186415, 9956.303058785961, 9996.850047249298, 10020.24848136378, 10078.748031299276, 274454.0, 280332.0, 280879.0, 389260.0, 393097.0, 48225.0, 48637.270440943415, 85095.57452212699, 89614.55192723994, 89907.10092899117, 934.3739694404765, 943.7168849345169, 947.1996163242187, 955.6941778630771, 961.7018724195522, 15683.607909802346, 15928.0, 16240.51278461648, 16294.511164664606, 16387.918060409622, 26873.596896046965, 28121.859390702917, 29209.0, 37460.812695937435, 39654.80172599119, 53814.73092634512, 54750.45249547613, 55330.17004745013, 55749.44250557443, 56860.715696421255, 6779.15260592426, 7179.282071792779, 7460.142083660448, 7720.613969301625, 7868.331191848757, 10558.260921735406, 11727.179097463095, 11856.11079169083, 11949.820752688891, 12140.15018948665, 9453.392923202935, 9560.235181185628, 9574.377665451724, 9592.679166459386, 10425.218108641731, 9947.900520994697, 10422.322549034288, 10595.258331916692, 10783.892161078289, 10836.241463097824, 9750.658726944523, 10218.642347517802, 10388.480575971322, 10604.628837990633, 10845.891541084804, 7131.82170445743, 7188.7124515020905, 7202.639868006683, 7287.562746235243, 7532.585707786125, 8490.745277641681, 9701.70894873155, 9868.210543156674, 9903.702888913343, 10125.18998480105], "value": 7980.414672679886, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.7228968061545, 1395.9302034898253, 1437.5759151050438, 1604.6469776649133, 1649.7772800671912, 6462.838429039276, 7222.205557388683, 7363.8159046023875, 7957.72147974821, 7959.522428654278, 7312.963435182816, 7466.440016998719, 7484.663190156442, 7486.438517111224, 7489.5131816431895, 2130.605837919982, 2174.749903761064, 2176.3688530326267, 2178.9019494122804, 2181.2474696229856, 2096.570203108367, 2128.5955668423026, 2156.956860862782, 2162.686410470481, 2174.695542624034, 2149.8172655324315, 2151.204054499837, 2169.3491952414292, 2178.9564208715815, 2187.201671389947, 2088.3004193595166, 2091.3203208956998, 2094.2356040045424, 2094.6229678657837, 2096.2663067926255, 2033.30867505049, 2106.9157233710635, 2111.3771437425994, 2114.1543382647064, 2117.565898990719, 7483.8877416838795, 7522.924770752332, 7534.284242996907, 7565.0, 7567.054118235221, 4448.822047118111, 4523.389342438762, 4527.637788976874, 4564.977175114103, 4573.131105090022, 2809.044924725583, 2817.563277691961, 2854.0296299258353, 2885.5960165576626, 2904.3320036391747, 822.4191254711261, 857.065798279878, 860.1183786618766, 861.9827603447895, 864.464032299978, 10433.16534677224, 10460.11089057431, 10471.214658900613, 10497.0, 10538.262321637412, 3983.382575700771, 4064.9187016260103, 4261.083866968616, 4269.274223382033, 4280.614744672932, 9100.317476189311, 9102.635894564144, 9109.0, 9122.543872806333, 9126.771830704285, 4646.83736069236, 4655.185342565105, 4670.95329046712, 4673.883152921204, 4677.18149323867, 3483.5645544306963, 4130.710850240454, 4237.618614324726, 4267.76527291002, 4272.444582204355, 3475.09647491654, 3512.1034641293413, 3559.1635965548076, 3571.339302229096, 3628.600853906068, 1131.0838221040983, 1139.7036770439745, 1151.476078384333, 1154.3593305715408, 1163.1741463560797, 811.975640730779, 827.6027506796651, 837.3468694418364, 838.9622466989, 845.8477474054606, 4922.950770492249, 4932.482089380635, 4985.700857948535, 5105.030044291572, 5108.540231379194, 395.93269144245545, 412.4658567155541, 412.58947347388937, 412.76884944431214, 414.56884839766906, 3346.1801858544814, 3424.5719285089363, 3444.8277586121094, 3451.551298331251, 3603.3513967486106, 9044.276457883485, 9483.241340692728, 9553.283503737108, 9590.040995900354, 9596.808063838684, 9469.526523673789, 9514.524273786283, 9532.142107210384, 9533.0, 9572.473513956798, 6954.200266969363, 7063.223045464994, 7137.964310178416, 7362.5214361066355, 7469.439792015621, 4943.65394422387, 5014.949850501448, 5113.105206588906, 5135.0, 5163.586913046872, 8371.121032291765, 8591.398602097794, 8644.438111522732, 8664.35017373712, 8808.647654093764, 8775.42959707617, 8810.471371717718, 8811.911880881109, 8844.601992910462, 8876.955615221883, 5967.880642387215, 6707.128073350628, 6844.760433385007, 6861.2109607393795, 7005.614691192033, 7578.658960346687, 7687.461877668509, 7696.114946780968, 7697.538147711155, 7697.6151192441275, 6719.731210751711, 6746.595204287759, 6853.554518956252, 6951.44388448933, 6963.442924566124, 6692.364225398579, 6723.361280678328, 6774.3225677431865, 6832.829179270558, 6918.654067296716, 5821.650700957786, 5893.675847828411, 5920.319163296276, 5936.762529498772, 5984.551158663031, 4420.756858372821, 4445.2887537993765, 4516.88707782308, 4521.502634710114, 4527.683062185615, 4464.285714285698, 4507.481639611487, 4579.816807327669, 4601.562851529099, 4707.670463067552], "value": 3980.9144869307756, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.1412617535323, 297.8287484696299, 304.5918469251203, 304.86433537076, 305.0619345512548, 5106.438291787905, 5174.042802081608, 5174.4825517448235, 5178.508041736034, 5190.688558686482, 5074.086664400406, 5078.339815823947, 5079.466656001113, 5089.414717307502, 5104.770285337159, 3760.3043436964113, 3917.84328626856, 3920.411938209263, 3972.781497017663, 3987.501562304712, 3950.4666869972616, 3950.802459877009, 3955.4857868477056, 3972.00113913996, 3989.421533877586, 3940.5074365704286, 3979.8806035818825, 3995.5604883462943, 4007.937896457441, 4010.9598904010877, 3717.3494638438165, 3908.925045612451, 3933.8229779659696, 4013.7993100344866, 4018.859339923103, 3406.7685665888885, 3410.5054767058637, 3415.2486452980306, 3420.863165473378, 3424.3493736190044, 4941.604671626261, 4945.901081978341, 4953.653244272902, 4955.653104282702, 4993.226049962225, 4210.284251677192, 4520.186366454037, 4523.660725445605, 4525.298578720303, 4569.126658070209, 5284.735763211824, 5310.575153987672, 5310.92033619496, 5316.229146773735, 5324.148136298212, 3698.1679122197293, 3701.4262789267705, 3708.295423869456, 3728.291624591319, 3729.8881033568764, 5383.784648614051, 5624.859378515529, 5627.943720562783, 5630.352509461423, 5633.774649014034, 3838.347480928249, 3844.0966372902344, 3846.249981253685, 3850.210706805098, 3853.9229215415535, 3907.33575292201, 3928.783916884599, 3932.2725295820364, 3933.174033453007, 3940.9014774630864, 4497.527759585197, 4518.683692141584, 4526.932096018562, 4535.659825513099, 4541.68208225421, 5259.8422047338645, 5359.651622644516, 5378.757955891994, 5379.488948549882, 5424.918626220609, 1329.8537160912485, 1349.743548725739, 1357.1992524410448, 1361.1084739495645, 1361.455417832855, 799.9840003199903, 809.380823669893, 836.1220718245818, 844.6199210355364, 856.6316483911978, 4508.639308855284, 4613.008203236321, 4640.512746161672, 4679.883002924886, 4688.578027977498, 5487.451254874561, 5525.723713814293, 5526.45259327389, 5543.667379957215, 5556.833295001156, 4459.799309031101, 4638.466576343763, 4659.44086709597, 4670.743109128963, 4696.882577935579, 2868.9713102869123, 2917.1977706130983, 2924.298168439559, 2928.794984351075, 2948.395578906319, 5093.770780314895, 5120.92318615221, 5158.690478571298, 5160.535551800356, 5171.172612382001, 5293.5765138789575, 5588.413216612278, 5591.10542313228, 5618.4662457066515, 5699.0, 5093.516115968977, 5105.463926287761, 5119.769610367617, 5122.92315615266, 5123.897522049539, 5485.780568777363, 5514.290569923337, 5520.779168833202, 5521.171824226398, 5531.446855314597, 5159.742012899415, 5432.456754324536, 5440.830221502396, 5471.480209380103, 5480.369757477941, 5180.352455943007, 5205.111163304402, 5208.270842082187, 5217.634765566374, 5224.145428372873, 3874.205787813548, 3901.9804900975314, 3911.3741801311653, 3913.6086391360636, 3915.393114067324, 5465.125579907196, 5504.779808807763, 5517.227588137584, 5532.834014979557, 5551.528120109836, 5369.0, 5380.596455265949, 5383.757730902197, 5388.56891448691, 5399.163129714901, 5189.740512974261, 5414.566834653139, 5422.078246697992, 5423.430539793265, 5423.783048678167, 5225.16397376418, 5253.185756207794, 5263.157894736823, 5269.657472264291, 5272.393674727302, 5119.0529751996, 5258.368995720538, 5367.570594352364, 5390.51485366319, 5425.782968681208, 5248.527632513092, 5267.128660434654, 5305.124654431976, 5330.866728331823, 5359.196120581944], "value": 4000.6826216905756, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.0744300056413, 610.7221214347472, 623.6476390839177, 633.4109278371113, 695.843435227074, 11849.526018959243, 12597.874021259784, 12613.864752172303, 12834.229946203235, 12840.293783841873, 12340.81488777669, 12341.321227332493, 12399.938000310009, 12450.066245031636, 12462.937685311583, 748.057447616005, 766.1495739728924, 766.7853001159656, 770.8111512679374, 772.069656064441, 632.0645444741785, 738.7303634173514, 761.6915149364517, 768.8654485465021, 772.5210369570874, 803.2329125684956, 809.4212637963855, 810.8337790752881, 812.544974814106, 812.5612169428501, 802.8514724775906, 803.2690251870828, 803.6102490292203, 807.7172989453703, 808.3048578222724, 587.309910854744, 588.2382314902169, 588.2822955993681, 591.0336599659545, 593.0807248764442, 11680.182387232897, 11689.649310520697, 11701.473433695504, 11722.824157637642, 11757.529698812037, 13572.864271357357, 13770.05280801765, 14083.436662533486, 14139.151650900978, 14421.567352979428, 9972.15236704881, 10022.448765317977, 10221.182305415548, 10249.897501024969, 10285.537150828231, 3300.352902162455, 3316.4859446785786, 3328.8335583220983, 3336.0492259705866, 3357.9328413431595, 63698.0, 63832.0, 65088.67455662739, 65683.3431665682, 66646.66676666634, 10331.535080921376, 10362.844557331646, 10375.63685271027, 10631.362118272928, 11034.117270618332, 19302.71045934312, 19352.516187095436, 19474.707879381822, 19499.31752388688, 20434.591308173753, 6741.157355330583, 6794.660266986631, 6822.351876571718, 6892.724291028303, 7194.928050719531, 3543.6633519815578, 3588.246468241646, 3620.9094772630897, 3646.4894914711963, 3705.388610879175, 3020.6828283030404, 3111.004478566837, 3115.6261248650308, 3116.7350775184364, 3124.375124975014, 500.759635375022, 517.4851023231909, 520.622548652224, 545.4845171313071, 575.0569066730566, 539.5440852479649, 551.8151419274589, 568.3170673649101, 574.7442388137239, 591.8313280714975, 8248.587570621445, 8280.130586288473, 8303.8339233215, 8368.58157092143, 8502.234798868132, 483.4126536258463, 540.6620861961275, 578.82635209437, 589.5666684986531, 592.1739173852452, 3856.5950575189763, 3886.9310939491866, 4010.2581022510344, 4017.337139371971, 4052.2908491014546, 100536.49731751294, 105044.47477762715, 106737.0, 107476.0, 110592.4470377659, 60108.0, 67733.66133169303, 68717.31282687109, 90008.0, 96653.0, 41727.165456690695, 41958.16083678309, 42885.35671964923, 71330.0, 74169.88745168826, 8076.636551355085, 8534.82930341402, 8590.484570925764, 8632.30941524664, 8701.390902636755, 31419.84290078535, 31501.0, 39104.0, 42349.36475952925, 43276.13447731091, 64223.036654449286, 65250.673746630964, 66319.0, 66353.66823165854, 67223.32776672367, 10362.844557331495, 10543.103836173705, 10672.413017284123, 10975.451227438436, 11420.143489238175, 12390.380480975735, 12473.126881118598, 12488.875111248772, 12812.807807882702, 13208.471661133448, 11252.887471125512, 11257.549698011988, 11784.234024788362, 11823.349715765715, 11983.700407489883, 10923.180761443082, 10959.232853700483, 11142.331460112418, 11266.830997535208, 11658.591949281734, 11345.262557933707, 11374.829377559508, 11751.529938802352, 11821.290722556674, 11910.0, 9019.864702029343, 9180.219681326895, 9276.814463710823, 9410.482423466776, 9443.338966272295, 7895.7236496722335, 8018.077921038922, 8072.394570407126, 9608.183304418922, 10561.102306303743], "value": 6404.364050617284, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 111.0, 116.0, 116.0, 117.0, 117.0, 117.0, 113.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 129.0, 147.0, 188.0, 126.0, 152.0, 149.0, 125.0, 194.0, 122.0], "value": 149.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 167.0, 168.0, 162.0, 164.0, 165.0, 163.0, 164.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 175.0, 77.0, 77.0, 75.0, 76.0, 160.0, 77.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 157.0, 86.0, 85.0, 85.0, 136.0, 85.0, 85.0, 139.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 146.0, 146.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 63.0, 63.0, 63.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 66.0, 66.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 85.0, 88.0, 87.0, 80.0, 81.0, 80.0, 87.0, 81.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 132.0, 153.0, 151.0, 136.0, 132.0, 132.0, 149.0, 132.0], "value": 139.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 170.0, 165.0, 166.0, 170.0, 170.0, 166.0, 165.0, 170.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 69.0, 69.0, 69.0, 68.0, 73.0, 67.0, 68.0, 68.0], "value": 69.0, "unit": "score"}]}]} 08:22:58 INFO - Return code: 0 08:22:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:22:59 ERROR - # TBPL SUCCESS # 08:22:59 INFO - Running post-action listener: _resource_record_post_action 08:22:59 INFO - [mozharness: 2016-08-09 15:22:59.033752Z] Finished run-tests step (success) 08:22:59 INFO - Running post-run listener: _resource_record_post_run 08:22:59 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 537919488; Read time: 0; Write time: 547552 08:22:59 INFO - TinderboxPrint: CPU usage
13.3% 08:22:59 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:22:59 INFO - TinderboxPrint: I/O write bytes / time
537,919,488 / 547,552 08:22:59 INFO - TinderboxPrint: CPU idle
8,283.5 (86.6%) 08:22:59 INFO - TinderboxPrint: CPU user
1,219.4 (12.8%) 08:22:59 INFO - TinderboxPrint: Swap in / out
0 / 0 08:22:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 251281408; Read time: 0; Write time: 308124 08:22:59 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 286638080; Read time: 0; Write time: 239428 08:22:59 INFO - Running post-run listener: _upload_blobber_files 08:22:59 INFO - Blob upload gear active. 08:22:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:22:59 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 08:22:59 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:22:59 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:23:00 INFO - (blobuploader) - INFO - Open directory for files ... 08:23:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:23:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:23:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:00 INFO - (blobuploader) - INFO - Done attempting. 08:23:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:23:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:23:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:02 INFO - (blobuploader) - INFO - Done attempting. 08:23:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:23:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:23:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:23:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:23:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:23:05 INFO - (blobuploader) - INFO - Done attempting. 08:23:05 INFO - (blobuploader) - INFO - Iteration through files over. 08:23:05 INFO - Return code: 0 08:23:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:23:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:23:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7befb7310642a96f0e46cb133aa7de12b4dc362b0a4af7d2251b12acf0972500347560b5484bc7f0a9c5b882f53b736e5f861a68ad347bdec962b1a617282a7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad345481c85dc32ddf3acb6a2a73b65f02bcfb6d14cebb8b6921dcca48e98eb8ca6a4b5e66ede39242392a1c8c264edc6d4ccd75daa2bb6976b1f55ac1bc3c9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d81c8685ae5616f45bc00fd598b307f4659c2777ed3fcde2de47a39dc740857abd0b1fe5524b83dd204a4a3d3cfe57a44f4b1be7ba58205cccdc1a6308e3069b"} 08:23:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:23:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:23:05 INFO - Contents: 08:23:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7befb7310642a96f0e46cb133aa7de12b4dc362b0a4af7d2251b12acf0972500347560b5484bc7f0a9c5b882f53b736e5f861a68ad347bdec962b1a617282a7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad345481c85dc32ddf3acb6a2a73b65f02bcfb6d14cebb8b6921dcca48e98eb8ca6a4b5e66ede39242392a1c8c264edc6d4ccd75daa2bb6976b1f55ac1bc3c9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d81c8685ae5616f45bc00fd598b307f4659c2777ed3fcde2de47a39dc740857abd0b1fe5524b83dd204a4a3d3cfe57a44f4b1be7ba58205cccdc1a6308e3069b"} 08:23:05 INFO - Running post-run listener: copy_logs_to_upload_dir 08:23:05 INFO - Copying logs to upload dir... 08:23:05 INFO - mkdir: /builds/slave/test/build/upload/logs 08:23:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.567575 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-09 08:23:05.566809) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 08:23:05.570665) ========= 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-1470753306.668560-1316512920 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/Firefox-Non-PGO/sha512/7befb7310642a96f0e46cb133aa7de12b4dc362b0a4af7d2251b12acf0972500347560b5484bc7f0a9c5b882f53b736e5f861a68ad347bdec962b1a617282a7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad345481c85dc32ddf3acb6a2a73b65f02bcfb6d14cebb8b6921dcca48e98eb8ca6a4b5e66ede39242392a1c8c264edc6d4ccd75daa2bb6976b1f55ac1bc3c9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d81c8685ae5616f45bc00fd598b307f4659c2777ed3fcde2de47a39dc740857abd0b1fe5524b83dd204a4a3d3cfe57a44f4b1be7ba58205cccdc1a6308e3069b"} build_url:https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/NMaAu8K6TiCjUSd-lPa88Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7befb7310642a96f0e46cb133aa7de12b4dc362b0a4af7d2251b12acf0972500347560b5484bc7f0a9c5b882f53b736e5f861a68ad347bdec962b1a617282a7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ad345481c85dc32ddf3acb6a2a73b65f02bcfb6d14cebb8b6921dcca48e98eb8ca6a4b5e66ede39242392a1c8c264edc6d4ccd75daa2bb6976b1f55ac1bc3c9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d81c8685ae5616f45bc00fd598b307f4659c2777ed3fcde2de47a39dc740857abd0b1fe5524b83dd204a4a3d3cfe57a44f4b1be7ba58205cccdc1a6308e3069b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 08:23:05.596761) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:23:05.597079) ========= 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-1470753306.668560-1316512920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004378 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 08:23:05.680070) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 08:23:05.680391) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 08:23:05.680698) ========= ========= Total master_lag: 0.18 =========