builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-069 starttime: 1468834158.75 results: success (0) buildid: 20160718015953 builduid: 85610e5d602b41c38a2653b307561653 revision: 76bb0b29a7509fe35db3beb571fec162cc781a80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 02:29:18.754822) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 02:29:18.755314) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 02:29:18.755629) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 02:29:18.770633) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 02:29:18.771046) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 02:29:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 29.4M=0s 2016-07-18 02:29:19 (29.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157133 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 02:29:19.022322) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 02:29:19.022736) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022360 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 02:29:19.074800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 02:29:19.075238) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 76bb0b29a7509fe35db3beb571fec162cc781a80 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 76bb0b29a7509fe35db3beb571fec162cc781a80 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 02:29:20,112 truncating revision to first 12 chars 2016-07-18 02:29:20,112 Setting DEBUG logging. 2016-07-18 02:29:20,112 attempt 1/10 2016-07-18 02:29:20,112 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/76bb0b29a750?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 02:29:20,461 unpacking tar archive at: fx-team-76bb0b29a750/testing/mozharness/ program finished with exit code 0 elapsedTime=0.700537 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 02:29:19.790142) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 02:29:19.790501) ========= script_repo_revision: 76bb0b29a7509fe35db3beb571fec162cc781a80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 02:29:19.791004) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 02:29:19.791317) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 02:29:19.802650) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-18 02:29:19.802979) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:29:20 INFO - MultiFileLogger online at 20160718 02:29:20 in /builds/slave/test 02:29:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:29:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:29:20 INFO - {'append_to_log': False, 02:29:20 INFO - 'base_work_dir': '/builds/slave/test', 02:29:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:29:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:29:20 INFO - 'branch': 'Fx-Team-Non-PGO', 02:29:20 INFO - 'buildbot_json_path': 'buildprops.json', 02:29:20 INFO - 'config_files': ('talos/linux_config.py',), 02:29:20 INFO - 'default_actions': ('clobber', 02:29:20 INFO - 'read-buildbot-config', 02:29:20 INFO - 'download-and-extract', 02:29:20 INFO - 'populate-webroot', 02:29:20 INFO - 'create-virtualenv', 02:29:20 INFO - 'install', 02:29:20 INFO - 'run-tests'), 02:29:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:29:20 INFO - 'download_minidump_stackwalk': True, 02:29:20 INFO - 'download_symbols': 'ondemand', 02:29:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:29:20 INFO - 'tooltool.py': '/tools/tooltool.py', 02:29:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:29:20 INFO - '/tools/misc-python/virtualenv.py')}, 02:29:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:29:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:29:20 INFO - 'installer_path': 'installer.exe', 02:29:20 INFO - 'log_level': 'info', 02:29:20 INFO - 'log_name': 'talos', 02:29:20 INFO - 'log_to_console': True, 02:29:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:29:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:29:20 INFO - 'opt_config_files': (), 02:29:20 INFO - 'pip_index': False, 02:29:20 INFO - 'sps_profile': False, 02:29:20 INFO - 'sps_profile_interval': 0, 02:29:20 INFO - 'suite': 'dromaeojs-e10s', 02:29:20 INFO - 'system_bits': '32', 02:29:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:29:20 INFO - 'title': 'talos-linux64-ix-069', 02:29:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:29:20 INFO - 'use_talos_json': True, 02:29:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:29:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:29:20 INFO - 'work_dir': 'build'} 02:29:20 INFO - ##### 02:29:20 INFO - ##### Running clobber step. 02:29:20 INFO - ##### 02:29:20 INFO - Running pre-action listener: _resource_record_pre_action 02:29:20 INFO - Running main action method: clobber 02:29:20 INFO - rmtree: /builds/slave/test/build 02:29:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:29:21 INFO - Running post-action listener: _resource_record_post_action 02:29:21 INFO - ##### 02:29:21 INFO - ##### Finished clobber step (success) 02:29:21 INFO - ##### 02:29:21 INFO - ##### 02:29:21 INFO - ##### Running read-buildbot-config step. 02:29:21 INFO - ##### 02:29:21 INFO - Running pre-action listener: _resource_record_pre_action 02:29:21 INFO - Running main action method: read_buildbot_config 02:29:21 INFO - Using buildbot properties: 02:29:21 INFO - { 02:29:21 INFO - "project": "", 02:29:21 INFO - "product": "firefox", 02:29:21 INFO - "script_repo_revision": "production", 02:29:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:29:21 INFO - "repository": "", 02:29:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:29:21 INFO - "buildid": "20160718015953", 02:29:21 INFO - "pgo_build": "False", 02:29:21 INFO - "basedir": "/builds/slave/test", 02:29:21 INFO - "buildnumber": 1483, 02:29:21 INFO - "slavename": "talos-linux64-ix-069", 02:29:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:29:21 INFO - "platform": "ubuntu64_hw", 02:29:21 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:29:21 INFO - "branch": "fx-team", 02:29:21 INFO - "repo_path": "integration/fx-team", 02:29:21 INFO - "revision": "76bb0b29a7509fe35db3beb571fec162cc781a80", 02:29:21 INFO - "stage_platform": "linux64", 02:29:21 INFO - "builduid": "85610e5d602b41c38a2653b307561653", 02:29:21 INFO - "slavebuilddir": "test" 02:29:21 INFO - } 02:29:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:29:21 INFO - Running post-action listener: _resource_record_post_action 02:29:21 INFO - ##### 02:29:21 INFO - ##### Finished read-buildbot-config step (success) 02:29:21 INFO - ##### 02:29:21 INFO - ##### 02:29:21 INFO - ##### Running download-and-extract step. 02:29:21 INFO - ##### 02:29:21 INFO - Running pre-action listener: _resource_record_pre_action 02:29:21 INFO - Running main action method: download_and_extract 02:29:21 INFO - mkdir: /builds/slave/test/build/tests 02:29:21 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:21 INFO - https://queue.taskcluster.net/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:29:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:29:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:29:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:29:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:29:22 INFO - Downloaded 1361 bytes. 02:29:22 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:29:22 INFO - Using the following test package requirements: 02:29:22 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:29:22 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:29:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:29:22 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:29:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:29:22 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:29:22 INFO - u'jsshell-linux-x86_64.zip'], 02:29:22 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:29:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:29:22 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:29:22 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:29:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:29:22 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:29:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:29:22 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:29:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:29:22 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:29:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:29:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:29:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:22 INFO - https://queue.taskcluster.net/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:29:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:29:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:29:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:29:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:29:27 INFO - Downloaded 22763853 bytes. 02:29:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:29:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:29:28 INFO - Return code: 0 02:29:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:29:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:28 INFO - https://queue.taskcluster.net/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:29:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:29:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:29:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:29:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:29:29 INFO - Downloaded 22763853 bytes. 02:29:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:29:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:29:30 INFO - Return code: 0 02:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:30 INFO - https://queue.taskcluster.net/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:29:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:29:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:29:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:29:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:29:32 INFO - Downloaded 14403317 bytes. 02:29:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:29:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:29:32 INFO - Return code: 0 02:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:32 INFO - https://queue.taskcluster.net/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:29:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:29:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:29:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:29:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:29:34 INFO - Downloaded 57075882 bytes. 02:29:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:29:34 INFO - mkdir: /builds/slave/test/properties 02:29:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:29:34 INFO - Writing to file /builds/slave/test/properties/build_url 02:29:34 INFO - Contents: 02:29:34 INFO - build_url:https://queue.taskcluster.net/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:29:34 INFO - Running post-action listener: _resource_record_post_action 02:29:34 INFO - Running post-action listener: set_extra_try_arguments 02:29:34 INFO - ##### 02:29:34 INFO - ##### Finished download-and-extract step (success) 02:29:34 INFO - ##### 02:29:34 INFO - ##### 02:29:34 INFO - ##### Running populate-webroot step. 02:29:34 INFO - ##### 02:29:34 INFO - Running pre-action listener: _resource_record_pre_action 02:29:34 INFO - Running main action method: populate_webroot 02:29:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:29:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:29:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:29:34 INFO - '--tppagecycles', 02:29:34 INFO - '7'], 02:29:34 INFO - 'tests': ['tsvgm']}}, 02:29:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:29:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:29:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:29:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:29:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:29:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:29:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:34 INFO - 'talos_options': ['--disable-e10s'], 02:29:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:29:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:29:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:35 INFO - 'talos_options': ['--disable-e10s'], 02:29:35 INFO - 'tests': ['damp', 'tps']}, 02:29:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:35 INFO - 'tests': ['damp', 'tps']}, 02:29:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:29:35 INFO - 'tests': ['dromaeo_dom']}, 02:29:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:29:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:29:35 INFO - 'tests': ['basic_compositor_video']}, 02:29:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:29:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:29:35 INFO - 'tests': ['a11yr', 02:29:35 INFO - 'ts_paint', 02:29:35 INFO - 'tpaint', 02:29:35 INFO - 'sessionrestore', 02:29:35 INFO - 'sessionrestore_no_auto_restore', 02:29:35 INFO - 'tabpaint']}, 02:29:35 INFO - 'other-e10s': {'tests': ['a11yr', 02:29:35 INFO - 'ts_paint', 02:29:35 INFO - 'tpaint', 02:29:35 INFO - 'sessionrestore', 02:29:35 INFO - 'sessionrestore_no_auto_restore', 02:29:35 INFO - 'tabpaint']}, 02:29:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:29:35 INFO - 'ts_paint', 02:29:35 INFO - 'tpaint', 02:29:35 INFO - 'sessionrestore', 02:29:35 INFO - 'sessionrestore_no_auto_restore', 02:29:35 INFO - 'tabpaint']}, 02:29:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:29:35 INFO - 'ts_paint', 02:29:35 INFO - 'tpaint', 02:29:35 INFO - 'sessionrestore', 02:29:35 INFO - 'sessionrestore_no_auto_restore', 02:29:35 INFO - 'tabpaint']}, 02:29:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:29:35 INFO - 'tests': ['a11yr', 02:29:35 INFO - 'ts_paint', 02:29:35 INFO - 'tpaint', 02:29:35 INFO - 'sessionrestore', 02:29:35 INFO - 'sessionrestore_no_auto_restore', 02:29:35 INFO - 'tabpaint']}, 02:29:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:29:35 INFO - 'tests': ['a11yr', 02:29:35 INFO - 'ts_paint', 02:29:35 INFO - 'tpaint', 02:29:35 INFO - 'sessionrestore', 02:29:35 INFO - 'sessionrestore_no_auto_restore', 02:29:35 INFO - 'tabpaint']}, 02:29:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:29:35 INFO - 'tests': ['tsvgx', 02:29:35 INFO - 'tsvgr_opacity', 02:29:35 INFO - 'tart', 02:29:35 INFO - 'tscrollx', 02:29:35 INFO - 'cart']}, 02:29:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:29:35 INFO - 'tsvgr_opacity', 02:29:35 INFO - 'tart', 02:29:35 INFO - 'tscrollx', 02:29:35 INFO - 'cart']}, 02:29:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:35 INFO - 'talos_options': ['--disable-e10s'], 02:29:35 INFO - 'tests': ['tp5o']}, 02:29:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:35 INFO - 'tests': ['tp5o']}, 02:29:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:35 INFO - 'talos_options': ['--disable-e10s', 02:29:35 INFO - '--xperf_path', 02:29:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:29:35 INFO - 'tests': ['tp5n']}, 02:29:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:35 INFO - 'talos_options': ['--xperf_path', 02:29:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:29:35 INFO - 'tests': ['tp5n']}}, 02:29:35 INFO - 'talos.zip': {'path': '', 02:29:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:29:35 INFO - Running post-action listener: _resource_record_post_action 02:29:35 INFO - ##### 02:29:35 INFO - ##### Finished populate-webroot step (success) 02:29:35 INFO - ##### 02:29:35 INFO - ##### 02:29:35 INFO - ##### Running create-virtualenv step. 02:29:35 INFO - ##### 02:29:35 INFO - Running pre-action listener: _resource_record_pre_action 02:29:35 INFO - Running main action method: create_virtualenv 02:29:35 INFO - Creating virtualenv /builds/slave/test/build/venv 02:29:35 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 02:29:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:29:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:29:35 INFO - Using real prefix '/usr' 02:29:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:29:35 INFO - Installing distribute.............................................................................................................................................................................................done. 02:29:37 INFO - Installing pip.................done. 02:29:37 INFO - Return code: 0 02:29:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2c570>, '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 0x1c2d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018', '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 02:29:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:29:37 INFO - Using env: {'DISPLAY': ':0', 02:29:37 INFO - 'HOME': '/home/cltbld', 02:29:37 INFO - 'LANG': 'en_US.UTF-8', 02:29:37 INFO - 'LANGUAGE': 'en_US:en', 02:29:37 INFO - 'LOGNAME': 'cltbld', 02:29:37 INFO - 'MAIL': '/var/mail/cltbld', 02:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:37 INFO - 'MOZ_NO_REMOTE': '1', 02:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:37 INFO - 'NO_EM_RESTART': '1', 02:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:37 INFO - 'PWD': '/builds/slave/test', 02:29:37 INFO - 'SHELL': '/bin/bash', 02:29:37 INFO - 'SHLVL': '1', 02:29:37 INFO - 'TERM': 'linux', 02:29:37 INFO - 'TMOUT': '86400', 02:29:37 INFO - 'USER': 'cltbld', 02:29:37 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018', 02:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:37 INFO - '_': '/tools/buildbot/bin/python'} 02:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:37 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 02:29:37 INFO - Cleaning up... 02:29:37 INFO - Return code: 0 02:29:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x196e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2c570>, '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 0x1c2d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018', '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 02:29:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:29:37 INFO - Using env: {'DISPLAY': ':0', 02:29:37 INFO - 'HOME': '/home/cltbld', 02:29:37 INFO - 'LANG': 'en_US.UTF-8', 02:29:37 INFO - 'LANGUAGE': 'en_US:en', 02:29:37 INFO - 'LOGNAME': 'cltbld', 02:29:37 INFO - 'MAIL': '/var/mail/cltbld', 02:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:37 INFO - 'MOZ_NO_REMOTE': '1', 02:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:37 INFO - 'NO_EM_RESTART': '1', 02:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:37 INFO - 'PWD': '/builds/slave/test', 02:29:37 INFO - 'SHELL': '/bin/bash', 02:29:37 INFO - 'SHLVL': '1', 02:29:37 INFO - 'TERM': 'linux', 02:29:37 INFO - 'TMOUT': '86400', 02:29:37 INFO - 'USER': 'cltbld', 02:29:37 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018', 02:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:37 INFO - '_': '/tools/buildbot/bin/python'} 02:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:37 INFO - Downloading/unpacking psutil>=3.1.1 02:29:37 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 02:29:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:29:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:29:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:29:40 INFO - Installing collected packages: psutil 02:29:40 INFO - Running setup.py install for psutil 02:29:40 INFO - building 'psutil._psutil_linux' extension 02:29:40 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 02:29:40 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 02:29:40 INFO - building 'psutil._psutil_posix' extension 02:29:40 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 02:29:40 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 02:29:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:29:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:29:40 INFO - Successfully installed psutil 02:29:40 INFO - Cleaning up... 02:29:40 INFO - Return code: 0 02:29:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2c570>, '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 0x1c2d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018', '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 02:29:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:29:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:29:40 INFO - Using env: {'DISPLAY': ':0', 02:29:40 INFO - 'HOME': '/home/cltbld', 02:29:40 INFO - 'LANG': 'en_US.UTF-8', 02:29:40 INFO - 'LANGUAGE': 'en_US:en', 02:29:40 INFO - 'LOGNAME': 'cltbld', 02:29:40 INFO - 'MAIL': '/var/mail/cltbld', 02:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:40 INFO - 'MOZ_NO_REMOTE': '1', 02:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:40 INFO - 'NO_EM_RESTART': '1', 02:29:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:40 INFO - 'PWD': '/builds/slave/test', 02:29:40 INFO - 'SHELL': '/bin/bash', 02:29:40 INFO - 'SHLVL': '1', 02:29:40 INFO - 'TERM': 'linux', 02:29:40 INFO - 'TMOUT': '86400', 02:29:40 INFO - 'USER': 'cltbld', 02:29:40 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018', 02:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:40 INFO - '_': '/tools/buildbot/bin/python'} 02:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:29:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:29:42 INFO - Installing collected packages: mozsystemmonitor 02:29:42 INFO - Running setup.py install for mozsystemmonitor 02:29:42 INFO - Successfully installed mozsystemmonitor 02:29:42 INFO - Cleaning up... 02:29:42 INFO - Return code: 0 02:29:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x196e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2c570>, '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 0x1c2d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018', '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 02:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:29:42 INFO - Using env: {'DISPLAY': ':0', 02:29:42 INFO - 'HOME': '/home/cltbld', 02:29:42 INFO - 'LANG': 'en_US.UTF-8', 02:29:42 INFO - 'LANGUAGE': 'en_US:en', 02:29:42 INFO - 'LOGNAME': 'cltbld', 02:29:42 INFO - 'MAIL': '/var/mail/cltbld', 02:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:42 INFO - 'MOZ_NO_REMOTE': '1', 02:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:42 INFO - 'NO_EM_RESTART': '1', 02:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:42 INFO - 'PWD': '/builds/slave/test', 02:29:42 INFO - 'SHELL': '/bin/bash', 02:29:42 INFO - 'SHLVL': '1', 02:29:42 INFO - 'TERM': 'linux', 02:29:42 INFO - 'TMOUT': '86400', 02:29:42 INFO - 'USER': 'cltbld', 02:29:42 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018', 02:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:42 INFO - '_': '/tools/buildbot/bin/python'} 02:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:43 INFO - Downloading/unpacking jsonschema==2.5.1 02:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:29:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:29: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 02:29: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 02:29: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 02:29: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 02:29: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 02:29: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 02:29:45 INFO - Downloading functools32-3.2.3-2.tar.gz 02:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:29:45 INFO - warning: no files found matching '*.txt' 02:29:45 INFO - no previously-included directories found matching 'build' 02:29:45 INFO - no previously-included directories found matching 'dist' 02:29:45 INFO - no previously-included directories found matching '.git*' 02:29:45 INFO - Installing collected packages: jsonschema, functools32 02:29:45 INFO - Running setup.py install for functools32 02:29:45 INFO - warning: no files found matching '*.txt' 02:29:45 INFO - no previously-included directories found matching 'build' 02:29:45 INFO - no previously-included directories found matching 'dist' 02:29:45 INFO - no previously-included directories found matching '.git*' 02:29:45 INFO - Successfully installed jsonschema functools32 02:29:45 INFO - Cleaning up... 02:29:45 INFO - Return code: 0 02:29:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:29:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:45 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 0x196e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2c570>, '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 0x1c2d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018', '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 02:29:45 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 02:29:45 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 02:29:45 INFO - Using env: {'DISPLAY': ':0', 02:29:45 INFO - 'HOME': '/home/cltbld', 02:29:45 INFO - 'LANG': 'en_US.UTF-8', 02:29:45 INFO - 'LANGUAGE': 'en_US:en', 02:29:45 INFO - 'LOGNAME': 'cltbld', 02:29:45 INFO - 'MAIL': '/var/mail/cltbld', 02:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:45 INFO - 'MOZ_NO_REMOTE': '1', 02:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:45 INFO - 'NO_EM_RESTART': '1', 02:29:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:45 INFO - 'PWD': '/builds/slave/test', 02:29:45 INFO - 'SHELL': '/bin/bash', 02:29:45 INFO - 'SHLVL': '1', 02:29:45 INFO - 'TERM': 'linux', 02:29:45 INFO - 'TMOUT': '86400', 02:29:45 INFO - 'USER': 'cltbld', 02:29:45 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018', 02:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:45 INFO - '_': '/tools/buildbot/bin/python'} 02:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:45 INFO - Downloading/unpacking blobuploader==1.2.4 02:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:47 INFO - Downloading blobuploader-1.2.4.tar.gz 02:29:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:29:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:29:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:29: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 02:29: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 02:29: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 02:29: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 02:29: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 02:29: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 02:29:48 INFO - Downloading docopt-0.6.1.tar.gz 02:29:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:29:48 INFO - Installing collected packages: blobuploader, requests, docopt 02:29:48 INFO - Running setup.py install for blobuploader 02:29:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:29:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:29:48 INFO - Running setup.py install for requests 02:29:48 INFO - Running setup.py install for docopt 02:29:48 INFO - Successfully installed blobuploader requests docopt 02:29:48 INFO - Cleaning up... 02:29:48 INFO - Return code: 0 02:29:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:48 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 0x196e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2c570>, '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 0x1c2d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018', '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 02:29:48 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 02:29:48 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 02:29:48 INFO - Using env: {'DISPLAY': ':0', 02:29:48 INFO - 'HOME': '/home/cltbld', 02:29:48 INFO - 'LANG': 'en_US.UTF-8', 02:29:48 INFO - 'LANGUAGE': 'en_US:en', 02:29:48 INFO - 'LOGNAME': 'cltbld', 02:29:48 INFO - 'MAIL': '/var/mail/cltbld', 02:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:48 INFO - 'MOZ_NO_REMOTE': '1', 02:29:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:48 INFO - 'NO_EM_RESTART': '1', 02:29:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:48 INFO - 'PWD': '/builds/slave/test', 02:29:48 INFO - 'SHELL': '/bin/bash', 02:29:48 INFO - 'SHLVL': '1', 02:29:48 INFO - 'TERM': 'linux', 02:29:48 INFO - 'TMOUT': '86400', 02:29:48 INFO - 'USER': 'cltbld', 02:29:48 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018', 02:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:48 INFO - '_': '/tools/buildbot/bin/python'} 02:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:29:49 INFO - Running setup.py (path:/tmp/pip-avFmuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:29:49 INFO - Running setup.py (path:/tmp/pip-ILiLSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:29:49 INFO - Running setup.py (path:/tmp/pip-ZcpQIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:29:49 INFO - Running setup.py (path:/tmp/pip-PJqTAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:29:49 INFO - Running setup.py (path:/tmp/pip-_mKK37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:29:49 INFO - Running setup.py (path:/tmp/pip-QdSkx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:29:49 INFO - Running setup.py (path:/tmp/pip-b_UNc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:29:49 INFO - Running setup.py (path:/tmp/pip-Uswo_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:29:49 INFO - Running setup.py (path:/tmp/pip-BFnNoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:29:49 INFO - Running setup.py (path:/tmp/pip-KoCPjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:29:49 INFO - Running setup.py (path:/tmp/pip-DicYOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:29:49 INFO - Running setup.py (path:/tmp/pip-kJ24mL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:29:50 INFO - Running setup.py (path:/tmp/pip-2LYJcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:29:50 INFO - Running setup.py (path:/tmp/pip-DIE7oD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:50 INFO - Running setup.py (path:/tmp/pip-zNF_x6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:29:50 INFO - Running setup.py (path:/tmp/pip-N6hZRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:29:50 INFO - Running setup.py (path:/tmp/pip-BwTF_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:29:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:29:50 INFO - Running setup.py install for manifestparser 02:29:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:29:50 INFO - Running setup.py install for mozcrash 02:29:50 INFO - Running setup.py install for mozdebug 02:29:50 INFO - Running setup.py install for mozdevice 02:29:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:29:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:29:50 INFO - Running setup.py install for mozfile 02:29:50 INFO - Running setup.py install for mozhttpd 02:29:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:29:51 INFO - Running setup.py install for mozinfo 02:29:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:29:51 INFO - Running setup.py install for mozInstall 02:29:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:29:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:29:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:29:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:29:51 INFO - Running setup.py install for mozleak 02:29:51 INFO - Running setup.py install for mozlog 02:29:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:29:51 INFO - Running setup.py install for moznetwork 02:29:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:29:51 INFO - Running setup.py install for mozprocess 02:29:51 INFO - Running setup.py install for mozprofile 02:29:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:29:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:29:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:29:51 INFO - Running setup.py install for mozrunner 02:29:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:29:51 INFO - Running setup.py install for mozscreenshot 02:29:51 INFO - Running setup.py install for moztest 02:29:52 INFO - Running setup.py install for mozversion 02:29:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:29:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:29:52 INFO - Cleaning up... 02:29:52 INFO - Return code: 0 02:29:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:52 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 0x196e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2c570>, '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 0x1c2d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018', '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 02:29:52 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 02:29:52 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 02:29:52 INFO - Using env: {'DISPLAY': ':0', 02:29:52 INFO - 'HOME': '/home/cltbld', 02:29:52 INFO - 'LANG': 'en_US.UTF-8', 02:29:52 INFO - 'LANGUAGE': 'en_US:en', 02:29:52 INFO - 'LOGNAME': 'cltbld', 02:29:52 INFO - 'MAIL': '/var/mail/cltbld', 02:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:52 INFO - 'MOZ_NO_REMOTE': '1', 02:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:52 INFO - 'NO_EM_RESTART': '1', 02:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:52 INFO - 'PWD': '/builds/slave/test', 02:29:52 INFO - 'SHELL': '/bin/bash', 02:29:52 INFO - 'SHLVL': '1', 02:29:52 INFO - 'TERM': 'linux', 02:29:52 INFO - 'TMOUT': '86400', 02:29:52 INFO - 'USER': 'cltbld', 02:29:52 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018', 02:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:52 INFO - '_': '/tools/buildbot/bin/python'} 02:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:29:52 INFO - Running setup.py (path:/tmp/pip-KWR8IU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:29:52 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)) 02:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:29:52 INFO - Running setup.py (path:/tmp/pip-CueEoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:29:52 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)) 02:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:29:52 INFO - Running setup.py (path:/tmp/pip-vtk9BM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:29:52 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)) 02:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:29:52 INFO - Running setup.py (path:/tmp/pip-2WipfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:29:52 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)) 02:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:29:52 INFO - Running setup.py (path:/tmp/pip-Wpw_pT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:29:52 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)) 02:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:29:52 INFO - Running setup.py (path:/tmp/pip-KeChjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:29:52 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)) 02:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:29:52 INFO - Running setup.py (path:/tmp/pip-c6jxha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:29:52 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)) 02:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:29:52 INFO - Running setup.py (path:/tmp/pip-O6vaf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:29:52 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)) 02:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:29:52 INFO - Running setup.py (path:/tmp/pip-5tayVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:29:53 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)) 02:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:29:53 INFO - Running setup.py (path:/tmp/pip-jBvNvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 02:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:29:53 INFO - Running setup.py (path:/tmp/pip-wIyUzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:29:53 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)) 02:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:29:53 INFO - Running setup.py (path:/tmp/pip-XeijNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:29:53 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)) 02:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:29:53 INFO - Running setup.py (path:/tmp/pip-Z_XGTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:29:53 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)) 02:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:29:53 INFO - Running setup.py (path:/tmp/pip-2Sumku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:29:53 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)) 02:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:53 INFO - Running setup.py (path:/tmp/pip-E6kp6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:53 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)) 02:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:29:53 INFO - Running setup.py (path:/tmp/pip-7pgq7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:29:53 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)) 02:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:29:53 INFO - Running setup.py (path:/tmp/pip-9qyImO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:29:53 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)) 02:29:53 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)) 02:29:53 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)) 02:29:53 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)) 02:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:29:53 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)) 02:29:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:29:53 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 02:29:53 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 02:29:53 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 02:29:53 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 02:29:53 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 02:29:53 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 02:29:55 INFO - Downloading blessings-1.6.tar.gz 02:29:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:29:55 INFO - Installing collected packages: blessings 02:29:55 INFO - Running setup.py install for blessings 02:29:55 INFO - Successfully installed blessings 02:29:55 INFO - Cleaning up... 02:29:55 INFO - Return code: 0 02:29:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:29:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:29:56 INFO - Reading from file tmpfile_stdout 02:29:56 INFO - Current package versions: 02:29:56 INFO - argparse == 1.2.1 02:29:56 INFO - blessings == 1.6 02:29:56 INFO - blobuploader == 1.2.4 02:29:56 INFO - docopt == 0.6.1 02:29:56 INFO - functools32 == 3.2.3-2 02:29:56 INFO - jsonschema == 2.5.1 02:29:56 INFO - manifestparser == 1.1 02:29:56 INFO - mozInstall == 1.12 02:29:56 INFO - mozcrash == 0.17 02:29:56 INFO - mozdebug == 0.1 02:29:56 INFO - mozdevice == 0.48 02:29:56 INFO - mozfile == 1.2 02:29:56 INFO - mozhttpd == 0.7 02:29:56 INFO - mozinfo == 0.9 02:29:56 INFO - mozleak == 0.1 02:29:56 INFO - mozlog == 3.2 02:29:56 INFO - moznetwork == 0.27 02:29:56 INFO - mozprocess == 0.23 02:29:56 INFO - mozprofile == 0.28 02:29:56 INFO - mozrunner == 6.12 02:29:56 INFO - mozscreenshot == 0.1 02:29:56 INFO - mozsystemmonitor == 0.3 02:29:56 INFO - moztest == 0.7 02:29:56 INFO - mozversion == 1.4 02:29:56 INFO - psutil == 3.1.1 02:29:56 INFO - requests == 1.2.3 02:29:56 INFO - wsgiref == 0.1.2 02:29:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:56 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 0x196e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2c570>, '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 0x1c2d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018', '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 02:29:56 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 02:29:56 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 02:29:56 INFO - Using env: {'DISPLAY': ':0', 02:29:56 INFO - 'HOME': '/home/cltbld', 02:29:56 INFO - 'LANG': 'en_US.UTF-8', 02:29:56 INFO - 'LANGUAGE': 'en_US:en', 02:29:56 INFO - 'LOGNAME': 'cltbld', 02:29:56 INFO - 'MAIL': '/var/mail/cltbld', 02:29:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:56 INFO - 'MOZ_NO_REMOTE': '1', 02:29:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:56 INFO - 'NO_EM_RESTART': '1', 02:29:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:56 INFO - 'PWD': '/builds/slave/test', 02:29:56 INFO - 'SHELL': '/bin/bash', 02:29:56 INFO - 'SHLVL': '1', 02:29:56 INFO - 'TERM': 'linux', 02:29:56 INFO - 'TMOUT': '86400', 02:29:56 INFO - 'USER': 'cltbld', 02:29:56 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018', 02:29:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:56 INFO - '_': '/tools/buildbot/bin/python'} 02:29:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:56 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)) 02:29:56 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)) 02:29:56 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)) 02:29:56 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)) 02:29:56 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)) 02:29:56 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)) 02:29:56 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)) 02:29:56 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)) 02:29:56 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)) 02:29:56 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)) 02:29:56 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)) 02:29:56 INFO - Cleaning up... 02:29:56 INFO - Return code: 0 02:29:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b9d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c2c570>, '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 0x1c2d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d900>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018', '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 02:29:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:29:56 INFO - Using env: {'DISPLAY': ':0', 02:29:56 INFO - 'HOME': '/home/cltbld', 02:29:56 INFO - 'LANG': 'en_US.UTF-8', 02:29:56 INFO - 'LANGUAGE': 'en_US:en', 02:29:56 INFO - 'LOGNAME': 'cltbld', 02:29:56 INFO - 'MAIL': '/var/mail/cltbld', 02:29:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:56 INFO - 'MOZ_NO_REMOTE': '1', 02:29:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:56 INFO - 'NO_EM_RESTART': '1', 02:29:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:56 INFO - 'PWD': '/builds/slave/test', 02:29:56 INFO - 'SHELL': '/bin/bash', 02:29:56 INFO - 'SHLVL': '1', 02:29:56 INFO - 'TERM': 'linux', 02:29:56 INFO - 'TMOUT': '86400', 02:29:56 INFO - 'USER': 'cltbld', 02:29:56 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018', 02:29:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:56 INFO - '_': '/tools/buildbot/bin/python'} 02:29:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:29:56 INFO - Cleaning up... 02:29:56 INFO - Return code: 0 02:29:56 INFO - Running post-action listener: _resource_record_post_action 02:29:56 INFO - Running post-action listener: _start_resource_monitoring 02:29:56 INFO - Starting resource monitoring. 02:29:56 INFO - ##### 02:29:56 INFO - ##### Finished create-virtualenv step (success) 02:29:56 INFO - ##### 02:29:56 INFO - ##### 02:29:56 INFO - ##### Running install step. 02:29:56 INFO - ##### 02:29:56 INFO - Running pre-action listener: _resource_record_pre_action 02:29:56 INFO - Running main action method: install 02:29:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:29:56 INFO - Reading from file tmpfile_stdout 02:29:56 INFO - Detecting whether we're running mozinstall >=1.0... 02:29:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:29:56 INFO - Reading from file tmpfile_stdout 02:29:56 INFO - Output received: 02:29:56 INFO - Usage: mozinstall [options] installer 02:29:56 INFO - Options: 02:29:56 INFO - -h, --help show this help message and exit 02:29:56 INFO - -d DEST, --destination=DEST 02:29:56 INFO - Directory to install application into. [default: 02:29:56 INFO - "/builds/slave/test"] 02:29:56 INFO - --app=APP Application being installed. [default: firefox] 02:29:56 INFO - mkdir: /builds/slave/test/build/application 02:29:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:30:13 INFO - Reading from file tmpfile_stdout 02:30:13 INFO - Output received: 02:30:13 INFO - /builds/slave/test/build/application/firefox/firefox 02:30:13 INFO - Running post-action listener: _resource_record_post_action 02:30:13 INFO - ##### 02:30:13 INFO - ##### Finished install step (success) 02:30:13 INFO - ##### 02:30:13 INFO - ##### 02:30:13 INFO - ##### Running run-tests step. 02:30:13 INFO - ##### 02:30:13 INFO - Running pre-action listener: _resource_record_pre_action 02:30:13 INFO - Running main action method: run_tests 02:30:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:30:13 INFO - Python 2.7.3 02:30:13 INFO - Return code: 0 02:30:13 INFO - grabbing minidump binary from tooltool 02:30:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:13 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 0x1c2c570>, '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 0x1c2d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c2d900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:30:13 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 02:30:13 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 02:30:13 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 02:30:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:30:13 INFO - Return code: 0 02:30:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:30:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:30:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:30:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:30:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:30:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 02:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 02:30:13 INFO - Using env: {'DISPLAY': ':0', 02:30:13 INFO - 'HOME': '/home/cltbld', 02:30:13 INFO - 'LANG': 'en_US.UTF-8', 02:30:13 INFO - 'LANGUAGE': 'en_US:en', 02:30:13 INFO - 'LOGNAME': 'cltbld', 02:30:13 INFO - 'MAIL': '/var/mail/cltbld', 02:30:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:30:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:13 INFO - 'MOZ_NO_REMOTE': '1', 02:30:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:13 INFO - 'NO_EM_RESTART': '1', 02:30:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:13 INFO - 'PWD': '/builds/slave/test', 02:30:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:30:13 INFO - 'SHELL': '/bin/bash', 02:30:13 INFO - 'SHLVL': '1', 02:30:13 INFO - 'TERM': 'linux', 02:30:13 INFO - 'TMOUT': '86400', 02:30:13 INFO - 'USER': 'cltbld', 02:30:13 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018', 02:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:13 INFO - '_': '/tools/buildbot/bin/python'} 02:30:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 02:30:13 INFO - mozversion application_buildid: 20160718015953 02:30:13 INFO - mozversion application_changeset: 76bb0b29a7509fe35db3beb571fec162cc781a80 02:30:13 INFO - mozversion application_display_name: Nightly 02:30:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:30:13 INFO - mozversion application_name: Firefox 02:30:13 INFO - mozversion application_remotingname: firefox 02:30:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:30:13 INFO - mozversion application_vendor: Mozilla 02:30:13 INFO - mozversion application_version: 50.0a1 02:30:13 INFO - mozversion platform_buildid: 20160718015953 02:30:13 INFO - mozversion platform_changeset: 76bb0b29a7509fe35db3beb571fec162cc781a80 02:30:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:30:13 INFO - mozversion platform_version: 50.0a1 02:30:13 INFO - using testdate: 1468834213 02:30:13 INFO - actual date: 1468834213 02:30:13 INFO - starting webserver on 'localhost:57182' 02:30:13 INFO - SUITE-START | Running 2 tests 02:30:13 INFO - TEST-START | dromaeo_css 02:30:13 INFO - operating with platform_type : linux_ 02:30:13 INFO - Initialising browser for dromaeo_css test... 02:30:13 INFO - TEST-INFO | started process 24469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNvtu0y/profile http://localhost:57182/getInfo.html) 02:30:16 INFO - PROCESS | 24469 | JavaScript error: , line 0: uncaught exception: undefined 02:30:18 INFO - PROCESS | 24469 | __metrics Screen width/height:1600/1200 02:30:18 INFO - PROCESS | 24469 | colorDepth:24 02:30:18 INFO - PROCESS | 24469 | Browser inner width/height: 1024/697 02:30:18 INFO - PROCESS | 24469 | __metrics 02:30:19 ERROR - PROCESS | 24469 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:30:20 INFO - TEST-INFO | 24469: exit 0 02:30:20 INFO - Browser initialized. 02:30:20 INFO - Running cycle 1/1 for dromaeo_css test... 02:30:20 INFO - TEST-INFO | started process 24589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNvtu0y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:30:32 INFO - PROCESS | 24589 | RSS: Main: 169594880 02:30:32 INFO - PROCESS | 24589 | 02:31:21 INFO - PROCESS | 24589 | 1468834281615 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] 02:33:36 INFO - PROCESS | 24589 | Cycle 1(1): loaded http://localhost:57182/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57182/tests/dromaeo/cssquery-ext.html) 02:33:37 INFO - PROCESS | 24589 | RSS: Main: 169811968 02:33:37 INFO - PROCESS | 24589 | 02:36:39 INFO - PROCESS | 24589 | Cycle 1(1): loaded http://localhost:57182/tests/dromaeo/cssquery-ext.html (next: http://localhost:57182/tests/dromaeo/cssquery-jquery.html) 02:36:40 INFO - PROCESS | 24589 | RSS: Main: 169738240 02:36:40 INFO - PROCESS | 24589 | 02:39:42 INFO - PROCESS | 24589 | Cycle 1(1): loaded http://localhost:57182/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57182/tests/dromaeo/cssquery-mootools.html) 02:39:43 INFO - PROCESS | 24589 | RSS: Main: 172093440 02:39:43 INFO - PROCESS | 24589 | 02:42:45 INFO - PROCESS | 24589 | Cycle 1(1): loaded http://localhost:57182/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57182/tests/dromaeo/cssquery-prototype.html) 02:42:45 INFO - PROCESS | 24589 | RSS: Main: 166887424 02:42:45 INFO - PROCESS | 24589 | 02:45:48 INFO - PROCESS | 24589 | Cycle 1(1): loaded http://localhost:57182/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57182/tests/dromaeo/cssquery-yui.html) 02:45:49 INFO - PROCESS | 24589 | RSS: Main: 169545728 02:45:49 INFO - PROCESS | 24589 | 02:48:51 INFO - PROCESS | 24589 | Cycle 1(1): loaded http://localhost:57182/tests/dromaeo/cssquery-yui.html (next: http://localhost:57182/tests/dromaeo/cssquery-dojo.html) 02:48:52 INFO - PROCESS | 24589 | RSS: Main: 172969984 02:48:52 INFO - PROCESS | 24589 | 02:48:52 INFO - PROCESS | 24589 | __start_tp_report 02:48:52 INFO - PROCESS | 24589 | _x_x_mozilla_page_load 02:48:52 INFO - PROCESS | 24589 | _x_x_mozilla_page_load_details 02:48:52 INFO - PROCESS | 24589 | |i|pagename|runs| 02:48:52 INFO - PROCESS | 24589 | |0;dojo.html;2626.7110617832036;2657.694365148008;2672.144913627639;2680.222735406732;2690.4484580660965;4778.7610619469015;4835.443923948743;4856;4858.295547145666;4908.484609116045;4601.056783359411;4793.376861008072;4794.904101917959;4809.5430934061205;4842.322074909515;4386.517483076859;4393.011572396217;4514.887127821814;4529.230030894756;4539.72761634303;4434.955650443502;4504.076664283814;4507.391502147234;4540.704854184468;4589.609883159936;4265.466816647919;4272.807723652443;4350.934735978963;4395.033092719596;4520.864374068783;4387.1445068211715;4406.647468202536;4439.622632076277;4452.443444569429;4461.330800379937;4406.845760398371;4415.646748260131;4467.642588592905;4502.729836209838;4503.549645035503;4821.85534433964;4837.153498137847;4871.2206047032305;4872.561469467765;4878.585320247783;5173.405058418292;5191.9480805192225;5208.062548741225;5221.660592061504;5238.214267859814;4991.051700176955;5147.047796157685;5232.136697444917;5238.79044838206;5241.030409374278;4820.25286080658;4857.587105096107;4863.197572400514;4870.318155458239;4933.728644924564;5321.122014867581;5355.250264962909;5361;5366.087765079946;5404.91892621611;4927;5053.2420136979745;5077.136886729265;5114.258432527337;5119.820806271762;5047.52048555394;5116.590672746172;5166.819161329336;5198.636095473281;5233.4243233244315;5116.872078198075;5117.104506711311;5118.948810511847;5133.948660513422;5134.460881607452;4953.6532442729385;5028.5977121830165;5046.066477701637;5100.056489549445;5165.992631436909;4055.148418832019;4059.7361171523758;4061.5532291447917;4091.4067460218102;4101.507819061672;3571.946420803638;3573.7319701022006;3588.2823435313044;3596.5684117906017;3598.298331825269;4360.040791025969;4416.668749843775;4445.222086134913;4460.0633866887665;4491.371208030879;5205.869853253699;5207.140821764367;5213.452587478336;5220.843374698765;5235.345581802275;4447.866564003085;4456.509783923766;4460.041091165415;4475.373447717322;4497.010657655311;4539.6368290536675;4647.907041859144;4662.254039353687;4698.248280275139;4704.200285951465;4881.194602890483;4882.92675609859;4893.437254715611;4910.607151427948;4946.431160416598;5048.823291184791;5215.504527069922;5216.113260745607;5219.347581552306;5268.367795864521;4857.635677324285;4903.730294833818;4921.089598424303;4921.212605983169;4930.802767889244;5122.79508819658;5154.819581314636;5159;5160.845174644766;5200.037992971313;5055.090083784954;5148.0476111919415;5226.2421948816445;5242.370915490165;5243.370795504564;4852.17513022794;4952.380952380952;4968.254761785616;4978.850634480971;5003.574696150868;4935.555799978019;4987.476314986874;4994.550490455731;4994.900101998012;5047.192449208109;4774.30772537987;4884.462709101925;4899.191633380595;4933.9013219736125;4949.059678661043;4892.192788189909;4913.729744864067;4955.900881982412;4958.752062396938;4971.130052240916;4844.757762111951;4898.510148985216;4950.455449900436;4973.602111830973;5022.121128802518 02:48:52 INFO - PROCESS | 24589 | |1;ext.html;553.6014069869694;557.7127779193714;560.2800401484094;561.1330494386173;569.9886002279954;27213.45573088537;27712.44575108499;40143.39784903225;41235;41416.792916035374;41361;41652;41673.58326416735;41715.37426938591;41864.162716745646;7600.657970391332;7757.224277572254;7804.453688241825;7817.765467035998;7819.5308281503;7659.731909383173;7748.263914928101;7748.41886858485;7754.495957762756;7767.378609711238;7695.884561731578;7715.421343399239;7715.8071048223965;7766.8446631067345;7775.883361749578;7677.11713152989;7731.420143489233;7746.341560967325;7754.108277548098;7762.029746281686;7711.884321735179;7722.961385193094;7743.070831500199;7773.494722843054;7786.571738554378;37764.81117594422;38180.80909595434;38281.808590957145;38303.8084809577;38408.231835363134;2882.214806575207;3080.1067690369764;3383.8477268522975;3613.8012409317475;3709.5548534176073;29139;29391.412171756445;29539.556906646416;29748.256293592833;29812.254693632833;3315.469524876008;3315.900522984314;3376.3584918865336;3381.7801842880135;3405.6764607362506;257611;257942;258483;258533;258966.70516647486;28760.712392876223;51987.96024079497;52392;52416.73791631017;52484.737576311876;33823.661763382544;33825;33869.49195762065;33971.49042764361;34050.48924266138;12559.120861539786;12827.743445131046;12860.228386296852;12863.163894346837;12885.61343159688;9357.344985850925;9398.389104708172;9404.200642945427;9406.576704048335;9420.057994200663;6432.71052802625;6457.354264573599;6498.870022599522;6585.604863708193;6627.569208001464;2998.8500574971163;3011.6084908961693;3034.135271447627;3063.4485792557552;3106.332138590214;833.5873742497381;900.5452246615417;934.8644446555347;940.4451373689556;978.9608415663436;28428.573571396446;28554.14337569876;29062.41875162485;29435;29446;880.3617377401333;938.441627231796;972.7762614598682;1051.71603667011;1092.4974511724695;14824.25878706082;14865.628359291104;14929.552113436614;15172.468963586442;15255.466058687893;419290;421942;421943;425285;426684;49452.752736236085;50010.249846252336;50047.74976125096;50160.247596286084;50176.498235017185;1137.4312843578211;1159.316003557888;1196.5991392883482;1198.4606926882936;1205.1864991130951;26136.60795088113;27852;27987;28186.2953426166;28260.43479130447;42342.57657423386;42611;42878;42955.7852210737;42958.78520607377;352573;353183;354529;355337;357066;25101.623475648244;25507.617385738857;25910.87044564765;25999.61000584955;26082.217533474028;42857.35713964231;43250.78374608107;43529.34705979476;43933.901652458946;44090.55909440864;37404.81297593495;38022.429663555624;38165.809170953966;38209.4268585977;38371.616283837924;37778;37787.62212377951;37812.243755125295;38491;39283.80358098191;36042.27915441729;36357.27285454329;36801;36972.26055478929;36995.26009479741;32525.837370812995;33318;33544.83227583847;33880.66119338775;34059.65940340565;25559.23322300334;25925.611115833653;26038.609420858324;26062.86968565145;26333.34166645849 02:48:52 INFO - PROCESS | 24589 | |2;jquery.html;365.99085022874425;367.4378201351932;368.2892018404479;376.98869033928975;384.1816929939229;15896.84103158968;17750;17817.821821781778;18313.81686183138;18336.633267334644;16279.267432965515;16741.91629041856;16962.915185424055;17008.234629441675;17609.911950440262;4596.195665758496;4705.341252224691;4753.976230118845;4758.262469317261;4762.880927976794;3462.9653703462895;4640.628749700033;5653.067243904751;5909.527237820986;5910.615809972338;5901.586888917777;5962.105684147369;5968.761249550034;5981.431763982437;5993.910091348634;5487.176923461473;5490.423505531941;5520.585956053292;5546.500814926656;5558.221848941152;4512.842050528216;5333.146696528575;5360.115580929142;5373.6775793452125;5394;19131.61736765257;19787.40637780869;20620.381388558366;20799.8960005199;20800;1955.9902200488907;2207.801297883198;2360.811135109187;2365.4086478380405;2422.2369953464604;8849.867251991162;9130.589123489459;9293.674721384787;9498.905010949871;9538.52307384628;1723.3451288510412;1751.702210624197;1751.7197248440316;1769.8495627871646;1810.7555480010294;66776;70636.29363706349;71725.64137179333;72383.63808180978;74243;9354.90645093554;9541.570629321697;9722.125008749246;9747.951260243795;9928.822776711382;12790.680232994064;12892.61322160318;12925.547605833939;12945.09384343087;13010;6514.9674251629385;6753.898691519631;6827.829304267334;6883.621400822903;6921.446284297244;6352.460040896575;6469.223693156851;6535.8366040848405;6590.275069742324;6628.580568092611;3768.0842172294924;3972.5232972042963;4032.6370626643743;4042.3532234842282;4048.2713111640187;1642.7330284207717;1687.9324827007028;1736.609262915859;1831.0478551153326;1848.3715536717311;818.5825229133185;852.9061803201643;900.9414388064755;931.5621657820814;945.4374647084974;16880.831191688172;16954.745678814827;17041.31834726597;17209.827901721073;17536.298548057934;835.0334961166487;847.3771777743353;860.3332417376583;873.0963452826294;893.2228960804013;9694.951525242328;9827.312088153903;9853.310268281151;9950.850737238947;9992.25058120644;370050;372905;382366;382971;385458;79578;82473.58763206266;82749;82932.26804793678;83281.58359208165;855.7047818502731;916.5508900638772;937.0629370629371;941.684535680541;948.9335746497679;15341.309641065956;15520.92239538795;15777.605559861095;15797.447089351817;15868.285927133076;35975;36190.63809361873;36635.81682091572;36996;38297;49815.50184498109;51573.22640160326;52413;52538;52826;7251.202367739439;7451.8882216765705;7463.813404664709;7527.661255243418;7580.204078571671;10382.896171038194;10775.946120269662;10880.945595271973;11094.389808560283;11181.664550063511;4772.546608072227;7034.366906978396;9259.72220833376;10107.241956853413;10293.125084367912;9115;9275.118863707938;9593.952030239805;9626.855597165908;9862.605495780088;9895.070461259986;9928.354656947275;10076.294659374067;10174.236932229964;10266.6406675766;7124.465665075244;7214.386777124003;7219.0976127984;7276.781696549112;7293.708251670086;7374.262573742582;8924.330675199257;9411.10594493522;9666.371685840399;9893.109620134222 02:48:52 INFO - PROCESS | 24589 | |3;mootools.html;1347.2859384526203;1411.2167746900473;1489.7095066462036;1634.452458426427;1694.1190580897926;6685.9331406685915;7455.0681164854395;7574.734884279052;7980.84038319234;7982.640781164847;7663.731769388072;7935.087464941534;7950.085740139885;7994;8012.158723334053;2150.419386765572;2190.2553131935138;2196.1654571262898;2197.9340619781433;2198.7471440784275;2163.4266919266406;2197.7142971413696;2218.92233771818;2220.3449982255192;2225.1099560175976;2148.806607405333;2152.7201463809683;2153.5046939203994;2155.245664017597;2191.5945550073207;2091.7385326834146;2096.9790302096935;2100.611386893422;2102.737157855268;2108.114591871418;2043.8773673579633;2075.3462659262436;2090.5400811821373;2095.528506086134;2102.3482720356737;7922.445428819985;7945.04659440865;8003.239692229287;8004.959975200145;8033.076196237449;4540.909181816378;4654.604358629521;4658.091672123937;4666.39336886206;4666.883327916796;2858.085412667947;2895.4353900989317;2917.2415172055416;2923.6053132827224;2925.8683359248885;919.6459363145237;925.9027802080752;943.5753910740126;965.2953344058806;970.1656575345197;10656.094231990213;10666.893331066667;10695.304805187716;10701.732456688567;10720.142388608892;4009.919801603952;4164.604362585549;4211.7262377945335;4246.49042114942;4250.341197114452;9121.589528471235;9150.08499150093;9183.90816091844;9186.586603602855;9223;4598.333241680005;4627.6529260305615;4628.143793398232;4641.489436162087;4656.67403281767;3710.350688629479;3979.6816254699556;4099.118689481776;4218.114196018871;4228.450301460791;3626.601073881871;3657.9817100914324;3733.6826369758874;3779.263043706506;3794.4118661607495;1187.7565099154654;1193.6777070191;1199.3943058755447;1201.6575276046285;1211.1764000479582;756.9318761311398;852.6205838401976;868.9087645797226;873.0527377795163;875.8292133034124;5322;5407.675539467645;5444.237806707064;5496.835094947158;5531.087370583889;395.1425406867105;402.63561476863487;407.34417587683805;408.33033824527797;409.75209997951407;3794.4877441545036;3820.465134881119;3821.2739579479808;3864.265789499986;3884.8251828667776;9358.11097945694;9578.473183974947;9622.085901839455;9723.222142228604;9760.804783904283;9656.565454554562;9658;9690.079442452956;9719.125278724949;9766.36518626287;7090.574565526085;7347.706091756377;7382.483226174224;7449.813754656177;7457.85084298311;5238.71187084714;5306.283651707125;5456.0451920914475;5498.945010550004;5581;8912.777180570278;8993.865092023756;9014.504202268938;9025.548722563713;9078.863817042882;8504.319654427754;8828;8861;9077.954610226907;9217.262618990331;6026.246719160105;6559.672016399257;6636.634985075674;6725.4283385910785;6803.285655006153;7647.279362143473;7650.4644674872225;7726.343260822893;7750.302472777477;7759.495632783851;6905.654717264217;6949;7006.5095443320515;7163.3552980232025;7198.028266183998;6802.693878775566;6861.519693621598;6923.446124310144;6995.055667484824;7010.509264351446;5964.731587078679;5989.5507836913275;6035.094735789667;6162.476189523941;6166.753329866755;4566.840160594364;4655.092257009851;4690.366800482027;4730.834420795256;4779.641526885428;4627.93058104122;4637.791299391603;4639.884002899955;4661.296646467021;4713.175194340908 02:48:52 INFO - PROCESS | 24589 | |4;prototype.html;300.40070060229846;305.3556994741096;306.5447810002147;306.887985885152;310.74984637366924;5093.286939828422;5130.897382052357;5131.4098878628965;5138.075146473633;5141.742912854361;5024.698518088917;5029.371328583927;5042.445331013586;5057.317262169606;5072.8985420291665;3744.438334249864;3820.140468394603;3894.415837624365;3909.7263191576603;3917.3144699677587;3901.55132159801;3909.0227443139215;3913.1782325711633;3921.6470517653406;3949.4470774091506;3897.766134031953;3909.569947305794;3915.7846318452475;3918.8628398006076;3935.60643935607;3826.215625796705;3928.0769019280447;3931.1499163106805;3931.2923673738715;3936.960630393688;3410.744194185446;3427.8971630850865;3428.3143371325837;3434.5191673165778;3434.708049815769;4910.607151427877;4911.705297682151;4927.384076990376;4932.309476673233;4959.950400495985;4361.255497800873;4498.145352383037;4525.456945166568;4543.250363689987;4550.726956382595;5281.947180528223;5306.7611957462;5315.325672413216;5318.840434786924;5355.946440535584;3763.4919285896326;3765.303418867491;3770.453284273765;3775.7923314217705;3799.3351163546545;5310.150375939831;5463.043967305705;5472.072441243916;5487.917681234785;5533.833984980457;3832.3676593361783;3844.9807750961627;3852;3864.8067596620617;3890.5720370759195;3907.7069219808627;3922.9803850981134;3926.2147570485445;3928.9017774555864;3932.7050471214775;4442.222611043055;4464.776761161929;4467.687261891637;4468.3074123510905;4480.484744254452;5126.026055049529;5282.603804714662;5337.839864804062;5349.251104845324;5355.518003379714;1331.0216990511965;1349.750296195207;1351.2905724494522;1351.6688411339285;1356.355731027754;815.1400272712227;845.8942632170979;853.8548446764065;858.3133493205411;864.6627815152095;4516;4639.9536004640195;4643.233866412004;4664.346991421204;4681.180793361216;5484.149956756709;5510.090835012258;5512.80705175317;5528.695921724263;5567.721613919288;4478.216312145361;4652.418447694038;4677.158111539888;4688.367070445514;4697.013627138271;2901.535754279347;2904.2158617173245;2946.8379239142055;2948.8673009714616;2956.364381657954;5089.9745501272255;5109.310243117132;5131.948680513222;5149.871253218699;5189.7405129743365;5381.327334083239;5492.835214943558;5507.347795661286;5548.91676624851;5551.778608706079;5084.237364395296;5119.232115182753;5121.795128194905;5144.382674079135;5194.636375453833;5463.399026107046;5464.23500709893;5546.83673367379;5548.8624831910165;5559.249501317432;5137.280780690631;5300.655457395257;5334.9466505336;5388.865278368072;5395.758975435593;5118.336540624237;5130.666506677054;5134.743262836918;5157.613179011514;5171.922421163761;3791.5071040764524;3793.7723736575895;3807.5621303550447;3808.904777380588;3811.580726120069;5229.150113188398;5454.063807348334;5457.7271136443815;5459.7270136492225;5509.47659972302;5231.973840130775;5258.4224732579305;5290.9735451322495;5291.576673866004;5312.5218730314455;5266.289050978222;5277.604179686462;5293.47065293483;5313.867153321198;5316.351930901433;4920.753962301942;5263.473652634706;5278.736063196748;5306.973465132804;5322.494363035506;5086.761824797078;5191.922121168261;5288.127458969227;5297.947020529746;5384.380796208487;5214.504622060898;5219.451957544555;5222.3472065991755;5250.396204436539;5272.894542109213 02:48:52 INFO - PROCESS | 24589 | |5;yui.html;591.0543130990416;596.7672607683002;613.6655522740106;696.4498046543231;706.4893828140503;12391.504339826408;12865.871341286584;12884.613461596144;14666.19335936523;15171.54485365438;14592.635184120401;14744.33650485728;14792;14825.110493370405;14885.106893586393;611.703323887914;747.506645613895;754.2683596910988;777.2266594738215;782.6947490478718;768.8923550702906;782.178712352031;784.6625950841136;784.8077221080815;785.9646315915769;810.2828996338225;814.0597609760736;815.1929589706208;816.4652152839869;821.983560328793;799.8200404908878;804.8028233082903;805.4241217529466;807.3662175192504;812.2730156509949;597.175897261776;597.2325561653298;597.235538510707;597.492131688066;598.0162632469606;13680;13914.30428478572;13935.09421887574;13935.651608709763;13941.790873136912;13224.140430871963;13243.072984891061;13510.392032358568;13595.388207530586;13646.658833529142;10760.873360702768;10890.40102794346;10933.617323393722;10982.780344393148;11039;3164.1456806662304;3175.936481270385;3199.8560064796907;3229.8869539566003;3244.772865899388;66335;68603.31396686069;69581.65209173973;70032;70537.29462705359;8932.28541716674;8968.506732129796;8990.685326013558;9022.413543119676;9312.115349041831;16934.661306774044;16944.98330100198;17021.829781702272;17116.346966220255;17202.397916072878;6421.5825971311715;6445.51658625605;6478.838029049311;6573.901391479131;6577.83555411109;3549.0949807798847;3552.5381700378784;3570.143165640228;3585.1216451969435;3587.8564857405413;2949.056301983345;3037.3166037641354;3059.479888418974;3060.0054982130896;3111.5332700094714;510.24483764029446;514.2286570144782;517.1647788821027;532.5074306266688;537.3632245788752;452.4434945017647;515.9974200128976;550.4577990679178;556.718856977232;576.5906206593365;7204.675789589481;7411.221821708643;7555.357794587411;7644.961775191088;7668.079830420385;548.4488089470057;548.9615726899078;587;591.3347484080409;603.2670305578743;3441.7934923904645;3670.889873303805;3673.5959044505616;3673.7244706647107;3775.093977445448;75965;92202;95119;97535.51232243793;108311;25038.123665671614;32347.51478727821;84298.57850710707;85723;85771.57114214389;74644.62677686685;75215;75709;77539.2246077532;78679;7756.767296981099;7974.803779433131;8076.1923807621115;8138.593070346577;8184.754457366289;45671.31493027541;46816.297755534375;47043.529564705284;47847.76076119597;47883.521164787904;58718.11922821247;59402.405975941416;67815.66092169705;67908.6604566974;68517.3148268511;10025.5488503019;10151.593936242467;10200.744981375525;10237.129843963347;10271.435071070864;12101.152919295917;12188.634340969786;12294.508219671114;12397.318147501974;12829.10196286251;10363.378197308186;10403.375797452178;10517.421541815274;10660.62687805923;10998.285111467729;10115.241356898408;10202.591896324064;10250.282480226313;10332.948335258276;10535;10161.847572286273;10232.437215953194;10359.741006474898;10417.42704151279;10506.474676266003;8252.33981281484;8349.916500834914;8807.251383632463;8816.691415800417;8825.470471771714;8144.429889907649;8393.664253429795;8493.532855692996;8612.870806938026;8848.734537963872 02:48:52 INFO - PROCESS | 24589 | __end_tp_report 02:48:52 INFO - PROCESS | 24589 | __start_cc_report 02:48:52 INFO - PROCESS | 24589 | _x_x_mozilla_cycle_collect,396 02:48:52 INFO - PROCESS | 24589 | __end_cc_report 02:48:52 INFO - PROCESS | 24589 | __startTimestamp1468835332121__endTimestamp 02:48:52 INFO - PROCESS | 24589 | 02:48:52 INFO - PROCESS | 24589 | ------- Summary: start ------- 02:48:52 INFO - PROCESS | 24589 | Number of tests: 6 02:48:52 INFO - PROCESS | 24589 | 02:48:52 INFO - PROCESS | 24589 | [#0] dojo.html Cycles:165 Average:4753.29 Median:4898.51 stddev:529.53 (10.8%) stddev-sans-first:504.19 02:48:52 INFO - PROCESS | 24589 | Values: 2626.7 2657.7 2672.1 2680.2 2690.4 4778.8 4835.4 4856.0 4858.3 4908.5 4601.1 4793.4 4794.9 4809.5 4842.3 4386.5 4393.0 4514.9 4529.2 4539.7 4435.0 4504.1 4507.4 4540.7 4589.6 4265.5 4272.8 4350.9 4395.0 4520.9 4387.1 4406.6 4439.6 4452.4 4461.3 4406.8 4415.6 4467.6 4502.7 4503.5 4821.9 4837.2 4871.2 4872.6 4878.6 5173.4 5191.9 5208.1 5221.7 5238.2 4991.1 5147.0 5232.1 5238.8 5241.0 4820.3 4857.6 4863.2 4870.3 4933.7 5321.1 5355.3 5361.0 5366.1 5404.9 4927.0 5053.2 5077.1 5114.3 5119.8 5047.5 5116.6 5166.8 5198.6 5233.4 5116.9 5117.1 5118.9 5133.9 5134.5 4953.7 5028.6 5046.1 5100.1 5166.0 4055.1 4059.7 4061.6 4091.4 4101.5 3571.9 3573.7 3588.3 3596.6 3598.3 4360.0 4416.7 4445.2 4460.1 4491.4 5205.9 5207.1 5213.5 5220.8 5235.3 4447.9 4456.5 4460.0 4475.4 4497.0 4539.6 4647.9 4662.3 4698.2 4704.2 4881.2 4882.9 4893.4 4910.6 4946.4 5048.8 5215.5 5216.1 5219.3 5268.4 4857.6 4903.7 4921.1 4921.2 4930.8 5122.8 5154.8 5159.0 5160.8 5200.0 5055.1 5148.0 5226.2 5242.4 5243.4 4852.2 4952.4 4968.3 4978.9 5003.6 4935.6 4987.5 4994.6 4994.9 5047.2 4774.3 4884.5 4899.2 4933.9 4949.1 4892.2 4913.7 4955.9 4958.8 4971.1 4844.8 4898.5 4950.5 4973.6 5022.1 02:48:52 INFO - PROCESS | 24589 | 02:48:52 INFO - PROCESS | 24589 | [#1] ext.html Cycles:180 Average:48586.38 Median:38094.12 stddev:93155.04 (244.5%) stddev-sans-first:93346.55 02:48:52 INFO - PROCESS | 24589 | Values: 553.6 557.7 560.3 561.1 570.0 27213.5 27712.4 40143.4 41235.0 41416.8 41361.0 41652.0 41673.6 41715.4 41864.2 7600.7 7757.2 7804.5 7817.8 7819.5 7659.7 7748.3 7748.4 7754.5 7767.4 7695.9 7715.4 7715.8 7766.8 7775.9 7677.1 7731.4 7746.3 7754.1 7762.0 7711.9 7723.0 7743.1 7773.5 7786.6 37764.8 38180.8 38281.8 38303.8 38408.2 2882.2 3080.1 3383.8 3613.8 3709.6 29139.0 29391.4 29539.6 29748.3 29812.3 3315.5 3315.9 3376.4 3381.8 3405.7 257611.0 257942.0 258483.0 258533.0 258966.7 28760.7 51988.0 52392.0 52416.7 52484.7 33823.7 33825.0 33869.5 33971.5 34050.5 12559.1 12827.7 12860.2 12863.2 12885.6 9357.3 9398.4 9404.2 9406.6 9420.1 6432.7 6457.4 6498.9 6585.6 6627.6 2998.9 3011.6 3034.1 3063.4 3106.3 833.6 900.5 934.9 940.4 979.0 28428.6 28554.1 29062.4 29435.0 29446.0 880.4 938.4 972.8 1051.7 1092.5 14824.3 14865.6 14929.6 15172.5 15255.5 419290.0 421942.0 421943.0 425285.0 426684.0 49452.8 50010.2 50047.7 50160.2 50176.5 1137.4 1159.3 1196.6 1198.5 1205.2 26136.6 27852.0 27987.0 28186.3 28260.4 42342.6 42611.0 42878.0 42955.8 42958.8 352573.0 353183.0 354529.0 355337.0 357066.0 25101.6 25507.6 25910.9 25999.6 26082.2 42857.4 43250.8 43529.3 43933.9 44090.6 37404.8 38022.4 38165.8 38209.4 38371.6 37778.0 37787.6 37812.2 38491.0 39283.8 36042.3 36357.3 36801.0 36972.3 36995.3 32525.8 33318.0 33544.8 33880.7 34059.7 25559.2 25925.6 26038.6 26062.9 26333.3 02:48:52 INFO - PROCESS | 24589 | 02:48:52 INFO - PROCESS | 24589 | [#2] jquery.html Cycles:180 Average:24029.45 Median:5366.90 stddev:62846.20 (1171.0%) stddev-sans-first:62997.39 02:48:52 INFO - PROCESS | 24589 | Values: 366.0 367.4 368.3 377.0 384.2 15896.8 17750.0 17817.8 18313.8 18336.6 16279.3 16741.9 16962.9 17008.2 17609.9 4596.2 4705.3 4754.0 4758.3 4762.9 3463.0 4640.6 5653.1 5909.5 5910.6 5901.6 5962.1 5968.8 5981.4 5993.9 5487.2 5490.4 5520.6 5546.5 5558.2 4512.8 5333.1 5360.1 5373.7 5394.0 19131.6 19787.4 20620.4 20799.9 20800.0 1956.0 2207.8 2360.8 2365.4 2422.2 8849.9 9130.6 9293.7 9498.9 9538.5 1723.3 1751.7 1751.7 1769.8 1810.8 66776.0 70636.3 71725.6 72383.6 74243.0 9354.9 9541.6 9722.1 9748.0 9928.8 12790.7 12892.6 12925.5 12945.1 13010.0 6515.0 6753.9 6827.8 6883.6 6921.4 6352.5 6469.2 6535.8 6590.3 6628.6 3768.1 3972.5 4032.6 4042.4 4048.3 1642.7 1687.9 1736.6 1831.0 1848.4 818.6 852.9 900.9 931.6 945.4 16880.8 16954.7 17041.3 17209.8 17536.3 835.0 847.4 860.3 873.1 893.2 9695.0 9827.3 9853.3 9950.9 9992.3 370050.0 372905.0 382366.0 382971.0 385458.0 79578.0 82473.6 82749.0 82932.3 83281.6 855.7 916.6 937.1 941.7 948.9 15341.3 15520.9 15777.6 15797.4 15868.3 35975.0 36190.6 36635.8 36996.0 38297.0 49815.5 51573.2 52413.0 52538.0 52826.0 7251.2 7451.9 7463.8 7527.7 7580.2 10382.9 10775.9 10880.9 11094.4 11181.7 4772.5 7034.4 9259.7 10107.2 10293.1 9115.0 9275.1 9594.0 9626.9 9862.6 9895.1 9928.4 10076.3 10174.2 10266.6 7124.5 7214.4 7219.1 7276.8 7293.7 7374.3 8924.3 9411.1 9666.4 9893.1 02:48:52 INFO - PROCESS | 24589 | 02:48:52 INFO - PROCESS | 24589 | [#3] mootools.html Cycles:180 Average:5164.44 Median:5272.50 stddev:2913.41 (55.3%) stddev-sans-first:2907.46 02:48:52 INFO - PROCESS | 24589 | Values: 1347.3 1411.2 1489.7 1634.5 1694.1 6685.9 7455.1 7574.7 7980.8 7982.6 7663.7 7935.1 7950.1 7994.0 8012.2 2150.4 2190.3 2196.2 2197.9 2198.7 2163.4 2197.7 2218.9 2220.3 2225.1 2148.8 2152.7 2153.5 2155.2 2191.6 2091.7 2097.0 2100.6 2102.7 2108.1 2043.9 2075.3 2090.5 2095.5 2102.3 7922.4 7945.0 8003.2 8005.0 8033.1 4540.9 4654.6 4658.1 4666.4 4666.9 2858.1 2895.4 2917.2 2923.6 2925.9 919.6 925.9 943.6 965.3 970.2 10656.1 10666.9 10695.3 10701.7 10720.1 4009.9 4164.6 4211.7 4246.5 4250.3 9121.6 9150.1 9183.9 9186.6 9223.0 4598.3 4627.7 4628.1 4641.5 4656.7 3710.4 3979.7 4099.1 4218.1 4228.5 3626.6 3658.0 3733.7 3779.3 3794.4 1187.8 1193.7 1199.4 1201.7 1211.2 756.9 852.6 868.9 873.1 875.8 5322.0 5407.7 5444.2 5496.8 5531.1 395.1 402.6 407.3 408.3 409.8 3794.5 3820.5 3821.3 3864.3 3884.8 9358.1 9578.5 9622.1 9723.2 9760.8 9656.6 9658.0 9690.1 9719.1 9766.4 7090.6 7347.7 7382.5 7449.8 7457.9 5238.7 5306.3 5456.0 5498.9 5581.0 8912.8 8993.9 9014.5 9025.5 9078.9 8504.3 8828.0 8861.0 9078.0 9217.3 6026.2 6559.7 6636.6 6725.4 6803.3 7647.3 7650.5 7726.3 7750.3 7759.5 6905.7 6949.0 7006.5 7163.4 7198.0 6802.7 6861.5 6923.4 6995.1 7010.5 5964.7 5989.6 6035.1 6162.5 6166.8 4566.8 4655.1 4690.4 4730.8 4779.6 4627.9 4637.8 4639.9 4661.3 4713.2 02:48:52 INFO - PROCESS | 24589 | 02:48:52 INFO - PROCESS | 24589 | [#4] prototype.html Cycles:180 Average:4393.36 Median:5078.57 stddev:1285.07 (25.3%) stddev-sans-first:1251.42 02:48:52 INFO - PROCESS | 24589 | Values: 300.4 305.4 306.5 306.9 310.7 5093.3 5130.9 5131.4 5138.1 5141.7 5024.7 5029.4 5042.4 5057.3 5072.9 3744.4 3820.1 3894.4 3909.7 3917.3 3901.6 3909.0 3913.2 3921.6 3949.4 3897.8 3909.6 3915.8 3918.9 3935.6 3826.2 3928.1 3931.1 3931.3 3937.0 3410.7 3427.9 3428.3 3434.5 3434.7 4910.6 4911.7 4927.4 4932.3 4960.0 4361.3 4498.1 4525.5 4543.3 4550.7 5281.9 5306.8 5315.3 5318.8 5355.9 3763.5 3765.3 3770.5 3775.8 3799.3 5310.2 5463.0 5472.1 5487.9 5533.8 3832.4 3845.0 3852.0 3864.8 3890.6 3907.7 3923.0 3926.2 3928.9 3932.7 4442.2 4464.8 4467.7 4468.3 4480.5 5126.0 5282.6 5337.8 5349.3 5355.5 1331.0 1349.8 1351.3 1351.7 1356.4 815.1 845.9 853.9 858.3 864.7 4516.0 4640.0 4643.2 4664.3 4681.2 5484.1 5510.1 5512.8 5528.7 5567.7 4478.2 4652.4 4677.2 4688.4 4697.0 2901.5 2904.2 2946.8 2948.9 2956.4 5090.0 5109.3 5131.9 5149.9 5189.7 5381.3 5492.8 5507.3 5548.9 5551.8 5084.2 5119.2 5121.8 5144.4 5194.6 5463.4 5464.2 5546.8 5548.9 5559.2 5137.3 5300.7 5334.9 5388.9 5395.8 5118.3 5130.7 5134.7 5157.6 5171.9 3791.5 3793.8 3807.6 3808.9 3811.6 5229.2 5454.1 5457.7 5459.7 5509.5 5232.0 5258.4 5291.0 5291.6 5312.5 5266.3 5277.6 5293.5 5313.9 5316.4 4920.8 5263.5 5278.7 5307.0 5322.5 5086.8 5191.9 5288.1 5297.9 5384.4 5214.5 5219.5 5222.3 5250.4 5272.9 02:48:52 INFO - PROCESS | 24589 | 02:48:52 INFO - PROCESS | 24589 | [#5] yui.html Cycles:180 Average:17178.09 Median:548.71 stddev:24893.99 (4536.9%) stddev-sans-first:24932.67 02:48:52 INFO - PROCESS | 24589 | Values: 591.1 596.8 613.7 696.4 706.5 12391.5 12865.9 12884.6 14666.2 15171.5 14592.6 14744.3 14792.0 14825.1 14885.1 611.7 747.5 754.3 777.2 782.7 768.9 782.2 784.7 784.8 786.0 810.3 814.1 815.2 816.5 822.0 799.8 804.8 805.4 807.4 812.3 597.2 597.2 597.2 597.5 598.0 13680.0 13914.3 13935.1 13935.7 13941.8 13224.1 13243.1 13510.4 13595.4 13646.7 10760.9 10890.4 10933.6 10982.8 11039.0 3164.1 3175.9 3199.9 3229.9 3244.8 66335.0 68603.3 69581.7 70032.0 70537.3 8932.3 8968.5 8990.7 9022.4 9312.1 16934.7 16945.0 17021.8 17116.3 17202.4 6421.6 6445.5 6478.8 6573.9 6577.8 3549.1 3552.5 3570.1 3585.1 3587.9 2949.1 3037.3 3059.5 3060.0 3111.5 510.2 514.2 517.2 532.5 537.4 452.4 516.0 550.5 556.7 576.6 7204.7 7411.2 7555.4 7645.0 7668.1 548.4 549.0 587.0 591.3 603.3 3441.8 3670.9 3673.6 3673.7 3775.1 75965.0 92202.0 95119.0 97535.5 108311.0 25038.1 32347.5 84298.6 85723.0 85771.6 74644.6 75215.0 75709.0 77539.2 78679.0 7756.8 7974.8 8076.2 8138.6 8184.8 45671.3 46816.3 47043.5 47847.8 47883.5 58718.1 59402.4 67815.7 67908.7 68517.3 10025.5 10151.6 10200.7 10237.1 10271.4 12101.2 12188.6 12294.5 12397.3 12829.1 10363.4 10403.4 10517.4 10660.6 10998.3 10115.2 10202.6 10250.3 10332.9 10535.0 10161.8 10232.4 10359.7 10417.4 10506.5 8252.3 8349.9 8807.3 8816.7 8825.5 8144.4 8393.7 8493.5 8612.9 8848.7 02:48:52 INFO - PROCESS | 24589 | -------- Summary: end -------- 02:48:52 INFO - PROCESS | 24589 | 02:48:52 INFO - TEST-INFO | 24589: exit 0 02:48:52 INFO - TEST-OK | dromaeo_css | took 1119545ms 02:48:52 INFO - TEST-START | kraken 02:48:52 INFO - operating with platform_type : linux_ 02:48:52 INFO - Initialising browser for kraken test... 02:48:52 INFO - TEST-INFO | started process 24837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbX2qXb/profile http://localhost:57182/getInfo.html) 02:48:56 INFO - PROCESS | 24837 | JavaScript error: , line 0: uncaught exception: undefined 02:48:57 INFO - PROCESS | 24837 | __metrics Screen width/height:1600/1200 02:48:57 INFO - PROCESS | 24837 | colorDepth:24 02:48:57 INFO - PROCESS | 24837 | Browser inner width/height: 1024/697 02:48:57 INFO - PROCESS | 24837 | __metrics 02:48:58 ERROR - PROCESS | 24837 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:48:59 INFO - TEST-INFO | 24837: exit 0 02:48:59 INFO - Browser initialized. 02:48:59 INFO - Running cycle 1/1 for kraken test... 02:48:59 INFO - TEST-INFO | started process 24958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbX2qXb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:11 INFO - PROCESS | 24958 | RSS: Main: 170094592 02:49:11 INFO - PROCESS | 24958 | 02:49:14 INFO - PROCESS | 24958 | Cycle 1(1): loaded http://localhost:57182/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57182/tests/kraken/driver.html?testName=audio-beat-detection) 02:49:15 INFO - PROCESS | 24958 | RSS: Main: 175050752 02:49:15 INFO - PROCESS | 24958 | 02:49:17 INFO - PROCESS | 24958 | Cycle 1(1): loaded http://localhost:57182/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57182/tests/kraken/driver.html?testName=audio-dft) 02:49:18 INFO - PROCESS | 24958 | RSS: Main: 174723072 02:49:18 INFO - PROCESS | 24958 | 02:49:21 INFO - PROCESS | 24958 | Cycle 1(1): loaded http://localhost:57182/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57182/tests/kraken/driver.html?testName=audio-fft) 02:49:22 INFO - PROCESS | 24958 | RSS: Main: 168628224 02:49:22 INFO - PROCESS | 24958 | 02:49:24 INFO - PROCESS | 24958 | Cycle 1(1): loaded http://localhost:57182/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57182/tests/kraken/driver.html?testName=audio-oscillator) 02:49:24 INFO - PROCESS | 24958 | RSS: Main: 169988096 02:49:24 INFO - PROCESS | 24958 | 02:49:27 INFO - PROCESS | 24958 | Cycle 1(1): loaded http://localhost:57182/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57182/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:49:27 INFO - PROCESS | 24958 | RSS: Main: 170024960 02:49:27 INFO - PROCESS | 24958 | 02:49:30 INFO - PROCESS | 24958 | Cycle 1(1): loaded http://localhost:57182/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57182/tests/kraken/driver.html?testName=imaging-darkroom) 02:49:31 INFO - PROCESS | 24958 | RSS: Main: 169775104 02:49:31 INFO - PROCESS | 24958 | 02:49:35 INFO - PROCESS | 24958 | Cycle 1(1): loaded http://localhost:57182/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57182/tests/kraken/driver.html?testName=imaging-desaturate) 02:49:35 INFO - PROCESS | 24958 | RSS: Main: 167772160 02:49:35 INFO - PROCESS | 24958 | 02:49:38 INFO - PROCESS | 24958 | Cycle 1(1): loaded http://localhost:57182/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57182/tests/kraken/driver.html?testName=json-parse-financial) 02:49:39 INFO - PROCESS | 24958 | RSS: Main: 169201664 02:49:39 INFO - PROCESS | 24958 | 02:49:41 INFO - PROCESS | 24958 | Cycle 1(1): loaded http://localhost:57182/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57182/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:49:41 INFO - PROCESS | 24958 | RSS: Main: 169197568 02:49:41 INFO - PROCESS | 24958 | 02:49:43 INFO - PROCESS | 24958 | Cycle 1(1): loaded http://localhost:57182/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57182/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:49:44 INFO - PROCESS | 24958 | RSS: Main: 169619456 02:49:44 INFO - PROCESS | 24958 | 02:49:46 INFO - PROCESS | 24958 | Cycle 1(1): loaded http://localhost:57182/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57182/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:49:47 INFO - PROCESS | 24958 | RSS: Main: 169705472 02:49:47 INFO - PROCESS | 24958 | 02:49:49 INFO - PROCESS | 24958 | Cycle 1(1): loaded http://localhost:57182/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57182/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:49:50 INFO - PROCESS | 24958 | RSS: Main: 170049536 02:49:50 INFO - PROCESS | 24958 | 02:49:53 INFO - PROCESS | 24958 | Cycle 1(1): loaded http://localhost:57182/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57182/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:49:54 INFO - PROCESS | 24958 | RSS: Main: 169725952 02:49:54 INFO - PROCESS | 24958 | 02:49:55 INFO - PROCESS | 24958 | Cycle 1(1): loaded http://localhost:57182/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57182/tests/kraken/driver.html?testName=ai-astar) 02:49:56 INFO - PROCESS | 24958 | RSS: Main: 170905600 02:49:56 INFO - PROCESS | 24958 | 02:49:56 INFO - PROCESS | 24958 | __start_tp_report 02:49:56 INFO - PROCESS | 24958 | _x_x_mozilla_page_load 02:49:56 INFO - PROCESS | 24958 | _x_x_mozilla_page_load_details 02:49:56 INFO - PROCESS | 24958 | |i|pagename|runs| 02:49:56 INFO - PROCESS | 24958 | |0;ai-astar;106;114;107;114;115;116;117;115;114;114 02:49:56 INFO - PROCESS | 24958 | |1;audio-beat-detection;153;128;150;169;132;148;153;132;200;129 02:49:56 INFO - PROCESS | 24958 | |2;audio-dft;162;162;164;167;168;165;164;162;162;163 02:49:56 INFO - PROCESS | 24958 | |3;audio-fft;75;76;76;149;77;78;75;78;175;77 02:49:56 INFO - PROCESS | 24958 | |4;audio-oscillator;86;85;134;86;86;85;138;87;85;131 02:49:56 INFO - PROCESS | 24958 | |5;imaging-gaussian-blur;117;118;119;118;118;117;121;118;118;117 02:49:56 INFO - PROCESS | 24958 | |6;imaging-darkroom;148;149;150;148;148;149;149;149;148;149 02:49:56 INFO - PROCESS | 24958 | |7;imaging-desaturate;100;95;95;95;95;96;98;96;96;95 02:49:56 INFO - PROCESS | 24958 | |8;json-parse-financial;63;63;64;64;68;67;65;64;69;64 02:49:56 INFO - PROCESS | 24958 | |9;json-stringify-tinderbox;66;66;67;66;66;65;66;65;65;66 02:49:56 INFO - PROCESS | 24958 | |10;stanford-crypto-aes;80;79;80;81;80;79;85;80;84;79 02:49:56 INFO - PROCESS | 24958 | |11;stanford-crypto-ccm;155;129;134;137;128;141;132;139;174;129 02:49:56 INFO - PROCESS | 24958 | |12;stanford-crypto-pbkdf2;167;166;164;162;164;167;167;167;165;164 02:49:56 INFO - PROCESS | 24958 | |13;stanford-crypto-sha256-iterative;67;67;70;68;67;66;69;67;67;67 02:49:56 INFO - PROCESS | 24958 | __end_tp_report 02:49:56 INFO - PROCESS | 24958 | __start_cc_report 02:49:56 INFO - PROCESS | 24958 | _x_x_mozilla_cycle_collect,1027 02:49:56 INFO - PROCESS | 24958 | __end_cc_report 02:49:56 INFO - PROCESS | 24958 | __startTimestamp1468835396108__endTimestamp 02:49:56 INFO - PROCESS | 24958 | 02:49:56 INFO - PROCESS | 24958 | ------- Summary: start ------- 02:49:56 INFO - PROCESS | 24958 | Number of tests: 14 02:49:56 INFO - PROCESS | 24958 | 02:49:56 INFO - PROCESS | 24958 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.50 stddev:3.68 (3.2%) stddev-sans-first:2.83 02:49:56 INFO - PROCESS | 24958 | Values: 106.0 114.0 107.0 114.0 115.0 116.0 117.0 115.0 114.0 114.0 02:49:56 INFO - PROCESS | 24958 | 02:49:56 INFO - PROCESS | 24958 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:151.50 stddev:22.24 (14.7%) stddev-sans-first:23.55 02:49:56 INFO - PROCESS | 24958 | Values: 153.0 128.0 150.0 169.0 132.0 148.0 153.0 132.0 200.0 129.0 02:49:56 INFO - PROCESS | 24958 | 02:49:56 INFO - PROCESS | 24958 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.18 (1.3%) stddev-sans-first:2.20 02:49:56 INFO - PROCESS | 24958 | Values: 162.0 162.0 164.0 167.0 168.0 165.0 164.0 162.0 162.0 163.0 02:49:56 INFO - PROCESS | 24958 | 02:49:56 INFO - PROCESS | 24958 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.50 stddev:36.58 (47.8%) stddev-sans-first:38.18 02:49:56 INFO - PROCESS | 24958 | Values: 75.0 76.0 76.0 149.0 77.0 78.0 75.0 78.0 175.0 77.0 02:49:56 INFO - PROCESS | 24958 | 02:49:56 INFO - PROCESS | 24958 | [#4] audio-oscillator Cycles:10 Average:100.30 Median:85.50 stddev:23.55 (27.5%) stddev-sans-first:24.41 02:49:56 INFO - PROCESS | 24958 | Values: 86.0 85.0 134.0 86.0 86.0 85.0 138.0 87.0 85.0 131.0 02:49:56 INFO - PROCESS | 24958 | 02:49:56 INFO - PROCESS | 24958 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.20 (1.0%) stddev-sans-first:1.20 02:49:56 INFO - PROCESS | 24958 | Values: 117.0 118.0 119.0 118.0 118.0 117.0 121.0 118.0 118.0 117.0 02:49:56 INFO - PROCESS | 24958 | 02:49:56 INFO - PROCESS | 24958 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 02:49:56 INFO - PROCESS | 24958 | Values: 148.0 149.0 150.0 148.0 148.0 149.0 149.0 149.0 148.0 149.0 02:49:56 INFO - PROCESS | 24958 | 02:49:56 INFO - PROCESS | 24958 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.50 stddev:1.66 (1.7%) stddev-sans-first:1.00 02:49:56 INFO - PROCESS | 24958 | Values: 100.0 95.0 95.0 95.0 95.0 96.0 98.0 96.0 96.0 95.0 02:49:56 INFO - PROCESS | 24958 | 02:49:56 INFO - PROCESS | 24958 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:64.50 stddev:2.13 (3.3%) stddev-sans-first:2.12 02:49:56 INFO - PROCESS | 24958 | Values: 63.0 63.0 64.0 64.0 68.0 67.0 65.0 64.0 69.0 64.0 02:49:56 INFO - PROCESS | 24958 | 02:49:56 INFO - PROCESS | 24958 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 02:49:56 INFO - PROCESS | 24958 | Values: 66.0 66.0 67.0 66.0 66.0 65.0 66.0 65.0 65.0 66.0 02:49:56 INFO - PROCESS | 24958 | 02:49:56 INFO - PROCESS | 24958 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:2.11 (2.6%) stddev-sans-first:2.22 02:49:56 INFO - PROCESS | 24958 | Values: 80.0 79.0 80.0 81.0 80.0 79.0 85.0 80.0 84.0 79.0 02:49:56 INFO - PROCESS | 24958 | 02:49:56 INFO - PROCESS | 24958 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:138.00 stddev:14.44 (10.5%) stddev-sans-first:14.23 02:49:56 INFO - PROCESS | 24958 | Values: 155.0 129.0 134.0 137.0 128.0 141.0 132.0 139.0 174.0 129.0 02:49:56 INFO - PROCESS | 24958 | 02:49:56 INFO - PROCESS | 24958 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:166.50 stddev:1.77 (1.1%) stddev-sans-first:1.76 02:49:56 INFO - PROCESS | 24958 | Values: 167.0 166.0 164.0 162.0 164.0 167.0 167.0 167.0 165.0 164.0 02:49:56 INFO - PROCESS | 24958 | 02:49:56 INFO - PROCESS | 24958 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.00 stddev:1.18 (1.8%) stddev-sans-first:1.24 02:49:56 INFO - PROCESS | 24958 | Values: 67.0 67.0 70.0 68.0 67.0 66.0 69.0 67.0 67.0 67.0 02:49:56 INFO - PROCESS | 24958 | -------- Summary: end -------- 02:49:56 INFO - PROCESS | 24958 | 02:49:57 INFO - TEST-INFO | 24958: exit 0 02:49:57 INFO - TEST-OK | kraken | took 64233ms 02:49:57 INFO - SUITE-END | took 1183s 02:49:57 INFO - Completed test suite (00:19:43) 02:49:57 INFO - javascript benchmark 02:49:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6331.802719940664, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2626.7110617832036, 2657.694365148008, 2672.144913627639, 2680.222735406732, 2690.4484580660965, 4778.7610619469015, 4835.443923948743, 4856.0, 4858.295547145666, 4908.484609116045, 4601.056783359411, 4793.376861008072, 4794.904101917959, 4809.5430934061205, 4842.322074909515, 4386.517483076859, 4393.011572396217, 4514.887127821814, 4529.230030894756, 4539.72761634303, 4434.955650443502, 4504.076664283814, 4507.391502147234, 4540.704854184468, 4589.609883159936, 4265.466816647919, 4272.807723652443, 4350.934735978963, 4395.033092719596, 4520.864374068783, 4387.1445068211715, 4406.647468202536, 4439.622632076277, 4452.443444569429, 4461.330800379937, 4406.845760398371, 4415.646748260131, 4467.642588592905, 4502.729836209838, 4503.549645035503, 4821.85534433964, 4837.153498137847, 4871.2206047032305, 4872.561469467765, 4878.585320247783, 5173.405058418292, 5191.9480805192225, 5208.062548741225, 5221.660592061504, 5238.214267859814, 4991.051700176955, 5147.047796157685, 5232.136697444917, 5238.79044838206, 5241.030409374278, 4820.25286080658, 4857.587105096107, 4863.197572400514, 4870.318155458239, 4933.728644924564, 5321.122014867581, 5355.250264962909, 5361.0, 5366.087765079946, 5404.91892621611, 4927.0, 5053.2420136979745, 5077.136886729265, 5114.258432527337, 5119.820806271762, 5047.52048555394, 5116.590672746172, 5166.819161329336, 5198.636095473281, 5233.4243233244315, 5116.872078198075, 5117.104506711311, 5118.948810511847, 5133.948660513422, 5134.460881607452, 4953.6532442729385, 5028.5977121830165, 5046.066477701637, 5100.056489549445, 5165.992631436909, 4055.148418832019, 4059.7361171523758, 4061.5532291447917, 4091.4067460218102, 4101.507819061672, 3571.946420803638, 3573.7319701022006, 3588.2823435313044, 3596.5684117906017, 3598.298331825269, 4360.040791025969, 4416.668749843775, 4445.222086134913, 4460.0633866887665, 4491.371208030879, 5205.869853253699, 5207.140821764367, 5213.452587478336, 5220.843374698765, 5235.345581802275, 4447.866564003085, 4456.509783923766, 4460.041091165415, 4475.373447717322, 4497.010657655311, 4539.6368290536675, 4647.907041859144, 4662.254039353687, 4698.248280275139, 4704.200285951465, 4881.194602890483, 4882.92675609859, 4893.437254715611, 4910.607151427948, 4946.431160416598, 5048.823291184791, 5215.504527069922, 5216.113260745607, 5219.347581552306, 5268.367795864521, 4857.635677324285, 4903.730294833818, 4921.089598424303, 4921.212605983169, 4930.802767889244, 5122.79508819658, 5154.819581314636, 5159.0, 5160.845174644766, 5200.037992971313, 5055.090083784954, 5148.0476111919415, 5226.2421948816445, 5242.370915490165, 5243.370795504564, 4852.17513022794, 4952.380952380952, 4968.254761785616, 4978.850634480971, 5003.574696150868, 4935.555799978019, 4987.476314986874, 4994.550490455731, 4994.900101998012, 5047.192449208109, 4774.30772537987, 4884.462709101925, 4899.191633380595, 4933.9013219736125, 4949.059678661043, 4892.192788189909, 4913.729744864067, 4955.900881982412, 4958.752062396938, 4971.130052240916, 4844.757762111951, 4898.510148985216, 4950.455449900436, 4973.602111830973, 5022.121128802518], "value": 4717.494148626537, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.6014069869694, 557.7127779193714, 560.2800401484094, 561.1330494386173, 569.9886002279954, 27213.45573088537, 27712.44575108499, 40143.39784903225, 41235.0, 41416.792916035374, 41361.0, 41652.0, 41673.58326416735, 41715.37426938591, 41864.162716745646, 7600.657970391332, 7757.224277572254, 7804.453688241825, 7817.765467035998, 7819.5308281503, 7659.731909383173, 7748.263914928101, 7748.41886858485, 7754.495957762756, 7767.378609711238, 7695.884561731578, 7715.421343399239, 7715.8071048223965, 7766.8446631067345, 7775.883361749578, 7677.11713152989, 7731.420143489233, 7746.341560967325, 7754.108277548098, 7762.029746281686, 7711.884321735179, 7722.961385193094, 7743.070831500199, 7773.494722843054, 7786.571738554378, 37764.81117594422, 38180.80909595434, 38281.808590957145, 38303.8084809577, 38408.231835363134, 2882.214806575207, 3080.1067690369764, 3383.8477268522975, 3613.8012409317475, 3709.5548534176073, 29139.0, 29391.412171756445, 29539.556906646416, 29748.256293592833, 29812.254693632833, 3315.469524876008, 3315.900522984314, 3376.3584918865336, 3381.7801842880135, 3405.6764607362506, 257611.0, 257942.0, 258483.0, 258533.0, 258966.70516647486, 28760.712392876223, 51987.96024079497, 52392.0, 52416.73791631017, 52484.737576311876, 33823.661763382544, 33825.0, 33869.49195762065, 33971.49042764361, 34050.48924266138, 12559.120861539786, 12827.743445131046, 12860.228386296852, 12863.163894346837, 12885.61343159688, 9357.344985850925, 9398.389104708172, 9404.200642945427, 9406.576704048335, 9420.057994200663, 6432.71052802625, 6457.354264573599, 6498.870022599522, 6585.604863708193, 6627.569208001464, 2998.8500574971163, 3011.6084908961693, 3034.135271447627, 3063.4485792557552, 3106.332138590214, 833.5873742497381, 900.5452246615417, 934.8644446555347, 940.4451373689556, 978.9608415663436, 28428.573571396446, 28554.14337569876, 29062.41875162485, 29435.0, 29446.0, 880.3617377401333, 938.441627231796, 972.7762614598682, 1051.71603667011, 1092.4974511724695, 14824.25878706082, 14865.628359291104, 14929.552113436614, 15172.468963586442, 15255.466058687893, 419290.0, 421942.0, 421943.0, 425285.0, 426684.0, 49452.752736236085, 50010.249846252336, 50047.74976125096, 50160.247596286084, 50176.498235017185, 1137.4312843578211, 1159.316003557888, 1196.5991392883482, 1198.4606926882936, 1205.1864991130951, 26136.60795088113, 27852.0, 27987.0, 28186.2953426166, 28260.43479130447, 42342.57657423386, 42611.0, 42878.0, 42955.7852210737, 42958.78520607377, 352573.0, 353183.0, 354529.0, 355337.0, 357066.0, 25101.623475648244, 25507.617385738857, 25910.87044564765, 25999.61000584955, 26082.217533474028, 42857.35713964231, 43250.78374608107, 43529.34705979476, 43933.901652458946, 44090.55909440864, 37404.81297593495, 38022.429663555624, 38165.809170953966, 38209.4268585977, 38371.616283837924, 37778.0, 37787.62212377951, 37812.243755125295, 38491.0, 39283.80358098191, 36042.27915441729, 36357.27285454329, 36801.0, 36972.26055478929, 36995.26009479741, 32525.837370812995, 33318.0, 33544.83227583847, 33880.66119338775, 34059.65940340565, 25559.23322300334, 25925.611115833653, 26038.609420858324, 26062.86968565145, 26333.34166645849], "value": 16463.464179627692, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.99085022874425, 367.4378201351932, 368.2892018404479, 376.98869033928975, 384.1816929939229, 15896.84103158968, 17750.0, 17817.821821781778, 18313.81686183138, 18336.633267334644, 16279.267432965515, 16741.91629041856, 16962.915185424055, 17008.234629441675, 17609.911950440262, 4596.195665758496, 4705.341252224691, 4753.976230118845, 4758.262469317261, 4762.880927976794, 3462.9653703462895, 4640.628749700033, 5653.067243904751, 5909.527237820986, 5910.615809972338, 5901.586888917777, 5962.105684147369, 5968.761249550034, 5981.431763982437, 5993.910091348634, 5487.176923461473, 5490.423505531941, 5520.585956053292, 5546.500814926656, 5558.221848941152, 4512.842050528216, 5333.146696528575, 5360.115580929142, 5373.6775793452125, 5394.0, 19131.61736765257, 19787.40637780869, 20620.381388558366, 20799.8960005199, 20800.0, 1955.9902200488907, 2207.801297883198, 2360.811135109187, 2365.4086478380405, 2422.2369953464604, 8849.867251991162, 9130.589123489459, 9293.674721384787, 9498.905010949871, 9538.52307384628, 1723.3451288510412, 1751.702210624197, 1751.7197248440316, 1769.8495627871646, 1810.7555480010294, 66776.0, 70636.29363706349, 71725.64137179333, 72383.63808180978, 74243.0, 9354.90645093554, 9541.570629321697, 9722.125008749246, 9747.951260243795, 9928.822776711382, 12790.680232994064, 12892.61322160318, 12925.547605833939, 12945.09384343087, 13010.0, 6514.9674251629385, 6753.898691519631, 6827.829304267334, 6883.621400822903, 6921.446284297244, 6352.460040896575, 6469.223693156851, 6535.8366040848405, 6590.275069742324, 6628.580568092611, 3768.0842172294924, 3972.5232972042963, 4032.6370626643743, 4042.3532234842282, 4048.2713111640187, 1642.7330284207717, 1687.9324827007028, 1736.609262915859, 1831.0478551153326, 1848.3715536717311, 818.5825229133185, 852.9061803201643, 900.9414388064755, 931.5621657820814, 945.4374647084974, 16880.831191688172, 16954.745678814827, 17041.31834726597, 17209.827901721073, 17536.298548057934, 835.0334961166487, 847.3771777743353, 860.3332417376583, 873.0963452826294, 893.2228960804013, 9694.951525242328, 9827.312088153903, 9853.310268281151, 9950.850737238947, 9992.25058120644, 370050.0, 372905.0, 382366.0, 382971.0, 385458.0, 79578.0, 82473.58763206266, 82749.0, 82932.26804793678, 83281.58359208165, 855.7047818502731, 916.5508900638772, 937.0629370629371, 941.684535680541, 948.9335746497679, 15341.309641065956, 15520.92239538795, 15777.605559861095, 15797.447089351817, 15868.285927133076, 35975.0, 36190.63809361873, 36635.81682091572, 36996.0, 38297.0, 49815.50184498109, 51573.22640160326, 52413.0, 52538.0, 52826.0, 7251.202367739439, 7451.8882216765705, 7463.813404664709, 7527.661255243418, 7580.204078571671, 10382.896171038194, 10775.946120269662, 10880.945595271973, 11094.389808560283, 11181.664550063511, 4772.546608072227, 7034.366906978396, 9259.72220833376, 10107.241956853413, 10293.125084367912, 9115.0, 9275.118863707938, 9593.952030239805, 9626.855597165908, 9862.605495780088, 9895.070461259986, 9928.354656947275, 10076.294659374067, 10174.236932229964, 10266.6406675766, 7124.465665075244, 7214.386777124003, 7219.0976127984, 7276.781696549112, 7293.708251670086, 7374.262573742582, 8924.330675199257, 9411.10594493522, 9666.371685840399, 9893.109620134222], "value": 8066.333919487828, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.2859384526203, 1411.2167746900473, 1489.7095066462036, 1634.452458426427, 1694.1190580897926, 6685.9331406685915, 7455.0681164854395, 7574.734884279052, 7980.84038319234, 7982.640781164847, 7663.731769388072, 7935.087464941534, 7950.085740139885, 7994.0, 8012.158723334053, 2150.419386765572, 2190.2553131935138, 2196.1654571262898, 2197.9340619781433, 2198.7471440784275, 2163.4266919266406, 2197.7142971413696, 2218.92233771818, 2220.3449982255192, 2225.1099560175976, 2148.806607405333, 2152.7201463809683, 2153.5046939203994, 2155.245664017597, 2191.5945550073207, 2091.7385326834146, 2096.9790302096935, 2100.611386893422, 2102.737157855268, 2108.114591871418, 2043.8773673579633, 2075.3462659262436, 2090.5400811821373, 2095.528506086134, 2102.3482720356737, 7922.445428819985, 7945.04659440865, 8003.239692229287, 8004.959975200145, 8033.076196237449, 4540.909181816378, 4654.604358629521, 4658.091672123937, 4666.39336886206, 4666.883327916796, 2858.085412667947, 2895.4353900989317, 2917.2415172055416, 2923.6053132827224, 2925.8683359248885, 919.6459363145237, 925.9027802080752, 943.5753910740126, 965.2953344058806, 970.1656575345197, 10656.094231990213, 10666.893331066667, 10695.304805187716, 10701.732456688567, 10720.142388608892, 4009.919801603952, 4164.604362585549, 4211.7262377945335, 4246.49042114942, 4250.341197114452, 9121.589528471235, 9150.08499150093, 9183.90816091844, 9186.586603602855, 9223.0, 4598.333241680005, 4627.6529260305615, 4628.143793398232, 4641.489436162087, 4656.67403281767, 3710.350688629479, 3979.6816254699556, 4099.118689481776, 4218.114196018871, 4228.450301460791, 3626.601073881871, 3657.9817100914324, 3733.6826369758874, 3779.263043706506, 3794.4118661607495, 1187.7565099154654, 1193.6777070191, 1199.3943058755447, 1201.6575276046285, 1211.1764000479582, 756.9318761311398, 852.6205838401976, 868.9087645797226, 873.0527377795163, 875.8292133034124, 5322.0, 5407.675539467645, 5444.237806707064, 5496.835094947158, 5531.087370583889, 395.1425406867105, 402.63561476863487, 407.34417587683805, 408.33033824527797, 409.75209997951407, 3794.4877441545036, 3820.465134881119, 3821.2739579479808, 3864.265789499986, 3884.8251828667776, 9358.11097945694, 9578.473183974947, 9622.085901839455, 9723.222142228604, 9760.804783904283, 9656.565454554562, 9658.0, 9690.079442452956, 9719.125278724949, 9766.36518626287, 7090.574565526085, 7347.706091756377, 7382.483226174224, 7449.813754656177, 7457.85084298311, 5238.71187084714, 5306.283651707125, 5456.0451920914475, 5498.945010550004, 5581.0, 8912.777180570278, 8993.865092023756, 9014.504202268938, 9025.548722563713, 9078.863817042882, 8504.319654427754, 8828.0, 8861.0, 9077.954610226907, 9217.262618990331, 6026.246719160105, 6559.672016399257, 6636.634985075674, 6725.4283385910785, 6803.285655006153, 7647.279362143473, 7650.4644674872225, 7726.343260822893, 7750.302472777477, 7759.495632783851, 6905.654717264217, 6949.0, 7006.5095443320515, 7163.3552980232025, 7198.028266183998, 6802.693878775566, 6861.519693621598, 6923.446124310144, 6995.055667484824, 7010.509264351446, 5964.731587078679, 5989.5507836913275, 6035.094735789667, 6162.476189523941, 6166.753329866755, 4566.840160594364, 4655.092257009851, 4690.366800482027, 4730.834420795256, 4779.641526885428, 4627.93058104122, 4637.791299391603, 4639.884002899955, 4661.296646467021, 4713.175194340908], "value": 4083.18429802371, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.40070060229846, 305.3556994741096, 306.5447810002147, 306.887985885152, 310.74984637366924, 5093.286939828422, 5130.897382052357, 5131.4098878628965, 5138.075146473633, 5141.742912854361, 5024.698518088917, 5029.371328583927, 5042.445331013586, 5057.317262169606, 5072.8985420291665, 3744.438334249864, 3820.140468394603, 3894.415837624365, 3909.7263191576603, 3917.3144699677587, 3901.55132159801, 3909.0227443139215, 3913.1782325711633, 3921.6470517653406, 3949.4470774091506, 3897.766134031953, 3909.569947305794, 3915.7846318452475, 3918.8628398006076, 3935.60643935607, 3826.215625796705, 3928.0769019280447, 3931.1499163106805, 3931.2923673738715, 3936.960630393688, 3410.744194185446, 3427.8971630850865, 3428.3143371325837, 3434.5191673165778, 3434.708049815769, 4910.607151427877, 4911.705297682151, 4927.384076990376, 4932.309476673233, 4959.950400495985, 4361.255497800873, 4498.145352383037, 4525.456945166568, 4543.250363689987, 4550.726956382595, 5281.947180528223, 5306.7611957462, 5315.325672413216, 5318.840434786924, 5355.946440535584, 3763.4919285896326, 3765.303418867491, 3770.453284273765, 3775.7923314217705, 3799.3351163546545, 5310.150375939831, 5463.043967305705, 5472.072441243916, 5487.917681234785, 5533.833984980457, 3832.3676593361783, 3844.9807750961627, 3852.0, 3864.8067596620617, 3890.5720370759195, 3907.7069219808627, 3922.9803850981134, 3926.2147570485445, 3928.9017774555864, 3932.7050471214775, 4442.222611043055, 4464.776761161929, 4467.687261891637, 4468.3074123510905, 4480.484744254452, 5126.026055049529, 5282.603804714662, 5337.839864804062, 5349.251104845324, 5355.518003379714, 1331.0216990511965, 1349.750296195207, 1351.2905724494522, 1351.6688411339285, 1356.355731027754, 815.1400272712227, 845.8942632170979, 853.8548446764065, 858.3133493205411, 864.6627815152095, 4516.0, 4639.9536004640195, 4643.233866412004, 4664.346991421204, 4681.180793361216, 5484.149956756709, 5510.090835012258, 5512.80705175317, 5528.695921724263, 5567.721613919288, 4478.216312145361, 4652.418447694038, 4677.158111539888, 4688.367070445514, 4697.013627138271, 2901.535754279347, 2904.2158617173245, 2946.8379239142055, 2948.8673009714616, 2956.364381657954, 5089.9745501272255, 5109.310243117132, 5131.948680513222, 5149.871253218699, 5189.7405129743365, 5381.327334083239, 5492.835214943558, 5507.347795661286, 5548.91676624851, 5551.778608706079, 5084.237364395296, 5119.232115182753, 5121.795128194905, 5144.382674079135, 5194.636375453833, 5463.399026107046, 5464.23500709893, 5546.83673367379, 5548.8624831910165, 5559.249501317432, 5137.280780690631, 5300.655457395257, 5334.9466505336, 5388.865278368072, 5395.758975435593, 5118.336540624237, 5130.666506677054, 5134.743262836918, 5157.613179011514, 5171.922421163761, 3791.5071040764524, 3793.7723736575895, 3807.5621303550447, 3808.904777380588, 3811.580726120069, 5229.150113188398, 5454.063807348334, 5457.7271136443815, 5459.7270136492225, 5509.47659972302, 5231.973840130775, 5258.4224732579305, 5290.9735451322495, 5291.576673866004, 5312.5218730314455, 5266.289050978222, 5277.604179686462, 5293.47065293483, 5313.867153321198, 5316.351930901433, 4920.753962301942, 5263.473652634706, 5278.736063196748, 5306.973465132804, 5322.494363035506, 5086.761824797078, 5191.922121168261, 5288.127458969227, 5297.947020529746, 5384.380796208487, 5214.504622060898, 5219.451957544555, 5222.3472065991755, 5250.396204436539, 5272.894542109213], "value": 3979.057611236224, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.0543130990416, 596.7672607683002, 613.6655522740106, 696.4498046543231, 706.4893828140503, 12391.504339826408, 12865.871341286584, 12884.613461596144, 14666.19335936523, 15171.54485365438, 14592.635184120401, 14744.33650485728, 14792.0, 14825.110493370405, 14885.106893586393, 611.703323887914, 747.506645613895, 754.2683596910988, 777.2266594738215, 782.6947490478718, 768.8923550702906, 782.178712352031, 784.6625950841136, 784.8077221080815, 785.9646315915769, 810.2828996338225, 814.0597609760736, 815.1929589706208, 816.4652152839869, 821.983560328793, 799.8200404908878, 804.8028233082903, 805.4241217529466, 807.3662175192504, 812.2730156509949, 597.175897261776, 597.2325561653298, 597.235538510707, 597.492131688066, 598.0162632469606, 13680.0, 13914.30428478572, 13935.09421887574, 13935.651608709763, 13941.790873136912, 13224.140430871963, 13243.072984891061, 13510.392032358568, 13595.388207530586, 13646.658833529142, 10760.873360702768, 10890.40102794346, 10933.617323393722, 10982.780344393148, 11039.0, 3164.1456806662304, 3175.936481270385, 3199.8560064796907, 3229.8869539566003, 3244.772865899388, 66335.0, 68603.31396686069, 69581.65209173973, 70032.0, 70537.29462705359, 8932.28541716674, 8968.506732129796, 8990.685326013558, 9022.413543119676, 9312.115349041831, 16934.661306774044, 16944.98330100198, 17021.829781702272, 17116.346966220255, 17202.397916072878, 6421.5825971311715, 6445.51658625605, 6478.838029049311, 6573.901391479131, 6577.83555411109, 3549.0949807798847, 3552.5381700378784, 3570.143165640228, 3585.1216451969435, 3587.8564857405413, 2949.056301983345, 3037.3166037641354, 3059.479888418974, 3060.0054982130896, 3111.5332700094714, 510.24483764029446, 514.2286570144782, 517.1647788821027, 532.5074306266688, 537.3632245788752, 452.4434945017647, 515.9974200128976, 550.4577990679178, 556.718856977232, 576.5906206593365, 7204.675789589481, 7411.221821708643, 7555.357794587411, 7644.961775191088, 7668.079830420385, 548.4488089470057, 548.9615726899078, 587.0, 591.3347484080409, 603.2670305578743, 3441.7934923904645, 3670.889873303805, 3673.5959044505616, 3673.7244706647107, 3775.093977445448, 75965.0, 92202.0, 95119.0, 97535.51232243793, 108311.0, 25038.123665671614, 32347.51478727821, 84298.57850710707, 85723.0, 85771.57114214389, 74644.62677686685, 75215.0, 75709.0, 77539.2246077532, 78679.0, 7756.767296981099, 7974.803779433131, 8076.1923807621115, 8138.593070346577, 8184.754457366289, 45671.31493027541, 46816.297755534375, 47043.529564705284, 47847.76076119597, 47883.521164787904, 58718.11922821247, 59402.405975941416, 67815.66092169705, 67908.6604566974, 68517.3148268511, 10025.5488503019, 10151.593936242467, 10200.744981375525, 10237.129843963347, 10271.435071070864, 12101.152919295917, 12188.634340969786, 12294.508219671114, 12397.318147501974, 12829.10196286251, 10363.378197308186, 10403.375797452178, 10517.421541815274, 10660.62687805923, 10998.285111467729, 10115.241356898408, 10202.591896324064, 10250.282480226313, 10332.948335258276, 10535.0, 10161.847572286273, 10232.437215953194, 10359.741006474898, 10417.42704151279, 10506.474676266003, 8252.33981281484, 8349.916500834914, 8807.251383632463, 8816.691415800417, 8825.470471771714, 8144.429889907649, 8393.664253429795, 8493.532855692996, 8612.870806938026, 8848.734537963872], "value": 6330.403743501096, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 107.0, 114.0, 115.0, 116.0, 117.0, 115.0, 114.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 128.0, 150.0, 169.0, 132.0, 148.0, 153.0, 132.0, 200.0, 129.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 167.0, 168.0, 165.0, 164.0, 162.0, 162.0, 163.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 149.0, 77.0, 78.0, 75.0, 78.0, 175.0, 77.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 134.0, 86.0, 86.0, 85.0, 138.0, 87.0, 85.0, 131.0], "value": 100.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 119.0, 118.0, 118.0, 117.0, 121.0, 118.0, 118.0, 117.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 150.0, 148.0, 148.0, 149.0, 149.0, 149.0, 148.0, 149.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 95.0, 95.0, 95.0, 96.0, 98.0, 96.0, 96.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 64.0, 68.0, 67.0, 65.0, 64.0, 69.0, 64.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 80.0, 81.0, 80.0, 79.0, 85.0, 80.0, 84.0, 79.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 129.0, 134.0, 137.0, 128.0, 141.0, 132.0, 139.0, 174.0, 129.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 164.0, 162.0, 164.0, 167.0, 167.0, 167.0, 165.0, 164.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 70.0, 68.0, 67.0, 66.0, 69.0, 67.0, 67.0, 67.0], "value": 67.5, "unit": "score"}]}]} 02:49:57 INFO - Return code: 0 02:49:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:49:57 ERROR - # TBPL SUCCESS # 02:49:57 INFO - Running post-action listener: _resource_record_post_action 02:49:57 INFO - ##### 02:49:57 INFO - ##### Finished run-tests step (success) 02:49:57 INFO - ##### 02:49:57 INFO - Running post-run listener: _resource_record_post_run 02:49:57 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 553222144; Read time: 0; Write time: 793692 02:49:57 INFO - TinderboxPrint: CPU usage
13.3% 02:49:57 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:49:57 INFO - TinderboxPrint: I/O write bytes / time
553,222,144 / 793,692 02:49:57 INFO - TinderboxPrint: CPU idle
8,298.5 (86.6%) 02:49:57 INFO - TinderboxPrint: CPU user
1,222.3 (12.8%) 02:49:57 INFO - TinderboxPrint: Swap in / out
0 / 0 02:49:57 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 264822784; Read time: 0; Write time: 461060 02:49:57 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288399360; Read time: 0; Write time: 332632 02:49:58 INFO - Running post-run listener: _upload_blobber_files 02:49:58 INFO - Blob upload gear active. 02:49:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:49:58 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 02:49:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:49:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:49:58 INFO - (blobuploader) - INFO - Open directory for files ... 02:49:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:49:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:49:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:49:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:49:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:49:59 INFO - (blobuploader) - INFO - Done attempting. 02:49:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:49:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:49:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:50:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:50:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:50:12 INFO - (blobuploader) - INFO - Done attempting. 02:50:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:50:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:50:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:50:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:50:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:50:12 INFO - (blobuploader) - INFO - Done attempting. 02:50:12 INFO - (blobuploader) - INFO - Iteration through files over. 02:50:12 INFO - Return code: 0 02:50:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:50:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:50:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e5024f0cb32f5d32e7a18782120e079b3ce5a97b02f73bdf6b36bd63fedcc61722ad3833e7f6bbec428a1089d2e6ad1a9827c8f566b237c0736d6b536ce37620", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4847adacb80657ed0b437486c8c9dc4ae407dab50309bb3d765dd7b38012edb59866917dae43089e10bee33b3bc78f8eaa67c7cfd1d22540141230dc87573f63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2ff85dd196390020b5cbd7bb69e666d78c25048105816ae0e92100e515cb60b2b58aa2ab87576f86078db12acfc2fd02a2794453c19c2c276785d3b85dcb43c9"} 02:50:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:50:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:50:12 INFO - Contents: 02:50:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e5024f0cb32f5d32e7a18782120e079b3ce5a97b02f73bdf6b36bd63fedcc61722ad3833e7f6bbec428a1089d2e6ad1a9827c8f566b237c0736d6b536ce37620", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4847adacb80657ed0b437486c8c9dc4ae407dab50309bb3d765dd7b38012edb59866917dae43089e10bee33b3bc78f8eaa67c7cfd1d22540141230dc87573f63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2ff85dd196390020b5cbd7bb69e666d78c25048105816ae0e92100e515cb60b2b58aa2ab87576f86078db12acfc2fd02a2794453c19c2c276785d3b85dcb43c9"} 02:50:12 INFO - Running post-run listener: copy_logs_to_upload_dir 02:50:12 INFO - Copying logs to upload dir... 02:50:12 INFO - mkdir: /builds/slave/test/build/upload/logs 02:50:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.949463 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-18 02:50:11.744132) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 02:50:11.747348) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e5024f0cb32f5d32e7a18782120e079b3ce5a97b02f73bdf6b36bd63fedcc61722ad3833e7f6bbec428a1089d2e6ad1a9827c8f566b237c0736d6b536ce37620", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4847adacb80657ed0b437486c8c9dc4ae407dab50309bb3d765dd7b38012edb59866917dae43089e10bee33b3bc78f8eaa67c7cfd1d22540141230dc87573f63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2ff85dd196390020b5cbd7bb69e666d78c25048105816ae0e92100e515cb60b2b58aa2ab87576f86078db12acfc2fd02a2794453c19c2c276785d3b85dcb43c9"} build_url:https://queue.taskcluster.net/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011167 build_url: 'https://queue.taskcluster.net/v1/task/ONqcWpO9SYevQzYF6YUImw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e5024f0cb32f5d32e7a18782120e079b3ce5a97b02f73bdf6b36bd63fedcc61722ad3833e7f6bbec428a1089d2e6ad1a9827c8f566b237c0736d6b536ce37620", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4847adacb80657ed0b437486c8c9dc4ae407dab50309bb3d765dd7b38012edb59866917dae43089e10bee33b3bc78f8eaa67c7cfd1d22540141230dc87573f63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2ff85dd196390020b5cbd7bb69e666d78c25048105816ae0e92100e515cb60b2b58aa2ab87576f86078db12acfc2fd02a2794453c19c2c276785d3b85dcb43c9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 02:50:11.772488) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 02:50:11.772827) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1468832951.314606-48951018 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 02:50:11.857952) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 02:50:11.858260) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 02:50:11.858566) ========= ========= Total master_lag: 0.22 =========