builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1468497026.29 results: success (0) buildid: 20160714032851 builduid: b8c91b2d3a244fe5944973e70acb95e3 revision: d868ba1645e6fbc6671c09f49f331ba4acae9ad6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 04:50:26.286239) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 04:50:26.286723) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 04:50:26.287076) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 04:50:26.467817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 04:50:26.468225) ========= 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=0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-14 04:50:26-- 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% 218M=0s 2016-07-14 04:50:26 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111428 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 04:50:26.593646) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 04:50:26.593956) ========= 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=0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017402 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 04:50:26.643903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 04:50:26.644258) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d868ba1645e6fbc6671c09f49f331ba4acae9ad6 --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 d868ba1645e6fbc6671c09f49f331ba4acae9ad6 --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=0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-14 04:50:26,994 truncating revision to first 12 chars 2016-07-14 04:50:26,994 Setting DEBUG logging. 2016-07-14 04:50:26,994 attempt 1/10 2016-07-14 04:50:26,994 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d868ba1645e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 04:50:27,395 unpacking tar archive at: fx-team-d868ba1645e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.746909 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 04:50:27.404897) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 04:50:27.405236) ========= script_repo_revision: d868ba1645e6fbc6671c09f49f331ba4acae9ad6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 04:50:27.405624) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 04:50:27.405923) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 04:50:27.415823) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-14 04:50:27.416103) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:50:27 INFO - MultiFileLogger online at 20160714 04:50:27 in /builds/slave/test 04:50:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 04:50:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:50:27 INFO - {'append_to_log': False, 04:50:27 INFO - 'base_work_dir': '/builds/slave/test', 04:50:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:50:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:50:27 INFO - 'branch': 'Fx-Team-Non-PGO', 04:50:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:50:27 INFO - 'config_files': ('talos/linux_config.py',), 04:50:27 INFO - 'default_actions': ('clobber', 04:50:27 INFO - 'read-buildbot-config', 04:50:27 INFO - 'download-and-extract', 04:50:27 INFO - 'populate-webroot', 04:50:27 INFO - 'create-virtualenv', 04:50:27 INFO - 'install', 04:50:27 INFO - 'run-tests'), 04:50:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:50:27 INFO - 'download_minidump_stackwalk': True, 04:50:27 INFO - 'download_symbols': 'ondemand', 04:50:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:50:27 INFO - 'tooltool.py': '/tools/tooltool.py', 04:50:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:50:27 INFO - '/tools/misc-python/virtualenv.py')}, 04:50:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:50:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:50:27 INFO - 'installer_path': 'installer.exe', 04:50:27 INFO - 'log_level': 'info', 04:50:27 INFO - 'log_name': 'talos', 04:50:27 INFO - 'log_to_console': True, 04:50:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:50:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:50:27 INFO - 'opt_config_files': (), 04:50:27 INFO - 'pip_index': False, 04:50:27 INFO - 'sps_profile': False, 04:50:27 INFO - 'sps_profile_interval': 0, 04:50:27 INFO - 'suite': 'dromaeojs', 04:50:27 INFO - 'system_bits': '32', 04:50:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:50:27 INFO - 'title': 'talos-linux64-ix-017', 04:50:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:50:27 INFO - 'use_talos_json': True, 04:50:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:50:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:50:27 INFO - 'work_dir': 'build'} 04:50:27 INFO - ##### 04:50:27 INFO - ##### Running clobber step. 04:50:27 INFO - ##### 04:50:27 INFO - Running pre-action listener: _resource_record_pre_action 04:50:27 INFO - Running main action method: clobber 04:50:27 INFO - rmtree: /builds/slave/test/build 04:50:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:50:28 INFO - Running post-action listener: _resource_record_post_action 04:50:28 INFO - ##### 04:50:28 INFO - ##### Finished clobber step (success) 04:50:28 INFO - ##### 04:50:28 INFO - ##### 04:50:28 INFO - ##### Running read-buildbot-config step. 04:50:28 INFO - ##### 04:50:28 INFO - Running pre-action listener: _resource_record_pre_action 04:50:28 INFO - Running main action method: read_buildbot_config 04:50:28 INFO - Using buildbot properties: 04:50:28 INFO - { 04:50:28 INFO - "project": "", 04:50:28 INFO - "product": "firefox", 04:50:28 INFO - "script_repo_revision": "production", 04:50:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:50:28 INFO - "repository": "", 04:50:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:50:28 INFO - "buildid": "20160714032851", 04:50:28 INFO - "pgo_build": "False", 04:50:28 INFO - "basedir": "/builds/slave/test", 04:50:28 INFO - "buildnumber": 3156, 04:50:28 INFO - "slavename": "talos-linux64-ix-017", 04:50:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:50:28 INFO - "platform": "ubuntu64_hw", 04:50:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:50:28 INFO - "branch": "fx-team", 04:50:28 INFO - "repo_path": "integration/fx-team", 04:50:28 INFO - "revision": "d868ba1645e6fbc6671c09f49f331ba4acae9ad6", 04:50:28 INFO - "stage_platform": "linux64", 04:50:28 INFO - "builduid": "b8c91b2d3a244fe5944973e70acb95e3", 04:50:28 INFO - "slavebuilddir": "test" 04:50:28 INFO - } 04:50:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:50:28 INFO - Running post-action listener: _resource_record_post_action 04:50:28 INFO - ##### 04:50:28 INFO - ##### Finished read-buildbot-config step (success) 04:50:28 INFO - ##### 04:50:28 INFO - ##### 04:50:28 INFO - ##### Running download-and-extract step. 04:50:28 INFO - ##### 04:50:28 INFO - Running pre-action listener: _resource_record_pre_action 04:50:28 INFO - Running main action method: download_and_extract 04:50:28 INFO - mkdir: /builds/slave/test/build/tests 04:50: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')]} 04:50:28 INFO - https://queue.taskcluster.net/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:50:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:50:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:50:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/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 04:50:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/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 04:50:29 INFO - Downloaded 1361 bytes. 04:50:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:50:29 INFO - Using the following test package requirements: 04:50:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:50:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:50:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:50:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:29 INFO - u'jsshell-linux-x86_64.zip'], 04:50:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:50:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:50:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:50:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:50:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:50:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:50:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:50:29 INFO - https://queue.taskcluster.net/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:50:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:50:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:50:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/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 04:50:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/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 04:50:30 INFO - Downloaded 22756103 bytes. 04:50:30 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'] 04:50:30 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 04:50:31 INFO - Return code: 0 04:50:31 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 04:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:50:31 INFO - https://queue.taskcluster.net/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:50:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:50:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:50:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/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 04:50:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/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 04:50:32 INFO - Downloaded 22756103 bytes. 04:50:32 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'] 04:50:32 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 04:50:33 INFO - Return code: 0 04:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:50:33 INFO - https://queue.taskcluster.net/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:50:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:50:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:50:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/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 04:50:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/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 04:50:34 INFO - Downloaded 14403317 bytes. 04:50:34 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'] 04:50:34 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 04:50:34 INFO - Return code: 0 04:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:50:35 INFO - https://queue.taskcluster.net/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:50:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:50:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:50:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/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 04:50:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bTKQF1ofQRmXg7HeOPXt-g/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 04:50:36 INFO - Downloaded 57059997 bytes. 04:50:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:50:36 INFO - mkdir: /builds/slave/test/properties 04:50:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:50:36 INFO - Writing to file /builds/slave/test/properties/build_url 04:50:36 INFO - Contents: 04:50:36 INFO - build_url:https://queue.taskcluster.net/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:50:37 INFO - Running post-action listener: _resource_record_post_action 04:50:37 INFO - Running post-action listener: set_extra_try_arguments 04:50:37 INFO - ##### 04:50:37 INFO - ##### Finished download-and-extract step (success) 04:50:37 INFO - ##### 04:50:37 INFO - ##### 04:50:37 INFO - ##### Running populate-webroot step. 04:50:37 INFO - ##### 04:50:37 INFO - Running pre-action listener: _resource_record_pre_action 04:50:37 INFO - Running main action method: populate_webroot 04:50:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:50:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:50:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:50:37 INFO - '--tppagecycles', 04:50:37 INFO - '7'], 04:50:37 INFO - 'tests': ['tsvgm']}}, 04:50:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:50:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:50:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:50:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:50:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:50:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:50:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:37 INFO - 'talos_options': ['--disable-e10s'], 04:50:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:50:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:50:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:37 INFO - 'talos_options': ['--disable-e10s'], 04:50:37 INFO - 'tests': ['damp', 'tps']}, 04:50:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:37 INFO - 'tests': ['damp', 'tps']}, 04:50:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:50:37 INFO - 'tests': ['dromaeo_dom']}, 04:50:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:50:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:50:37 INFO - 'tests': ['basic_compositor_video']}, 04:50:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:50:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:50:37 INFO - 'tests': ['a11yr', 04:50:37 INFO - 'ts_paint', 04:50:37 INFO - 'tpaint', 04:50:37 INFO - 'sessionrestore', 04:50:37 INFO - 'sessionrestore_no_auto_restore', 04:50:37 INFO - 'tabpaint']}, 04:50:37 INFO - 'other-e10s': {'tests': ['a11yr', 04:50:37 INFO - 'ts_paint', 04:50:37 INFO - 'tpaint', 04:50:37 INFO - 'sessionrestore', 04:50:37 INFO - 'sessionrestore_no_auto_restore', 04:50:37 INFO - 'tabpaint']}, 04:50:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:50:37 INFO - 'ts_paint', 04:50:37 INFO - 'tpaint', 04:50:37 INFO - 'sessionrestore', 04:50:37 INFO - 'sessionrestore_no_auto_restore', 04:50:37 INFO - 'tabpaint']}, 04:50:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:50:37 INFO - 'ts_paint', 04:50:37 INFO - 'tpaint', 04:50:37 INFO - 'sessionrestore', 04:50:37 INFO - 'sessionrestore_no_auto_restore', 04:50:37 INFO - 'tabpaint']}, 04:50:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:50:37 INFO - 'tests': ['a11yr', 04:50:37 INFO - 'ts_paint', 04:50:37 INFO - 'tpaint', 04:50:37 INFO - 'sessionrestore', 04:50:37 INFO - 'sessionrestore_no_auto_restore', 04:50:37 INFO - 'tabpaint']}, 04:50:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:50:37 INFO - 'tests': ['a11yr', 04:50:37 INFO - 'ts_paint', 04:50:37 INFO - 'tpaint', 04:50:37 INFO - 'sessionrestore', 04:50:37 INFO - 'sessionrestore_no_auto_restore', 04:50:37 INFO - 'tabpaint']}, 04:50:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:50:37 INFO - 'tests': ['tsvgx', 04:50:37 INFO - 'tsvgr_opacity', 04:50:37 INFO - 'tart', 04:50:37 INFO - 'tscrollx', 04:50:37 INFO - 'cart']}, 04:50:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:50:37 INFO - 'tsvgr_opacity', 04:50:37 INFO - 'tart', 04:50:37 INFO - 'tscrollx', 04:50:37 INFO - 'cart']}, 04:50:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:37 INFO - 'talos_options': ['--disable-e10s'], 04:50:37 INFO - 'tests': ['tp5o']}, 04:50:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:37 INFO - 'tests': ['tp5o']}, 04:50:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:37 INFO - 'talos_options': ['--disable-e10s', 04:50:37 INFO - '--xperf_path', 04:50:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:50:37 INFO - 'tests': ['tp5n']}, 04:50:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:37 INFO - 'talos_options': ['--xperf_path', 04:50:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:50:37 INFO - 'tests': ['tp5n']}}, 04:50:37 INFO - 'talos.zip': {'path': '', 04:50:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:50:37 INFO - Running post-action listener: _resource_record_post_action 04:50:37 INFO - ##### 04:50:37 INFO - ##### Finished populate-webroot step (success) 04:50:37 INFO - ##### 04:50:37 INFO - ##### 04:50:37 INFO - ##### Running create-virtualenv step. 04:50:37 INFO - ##### 04:50:37 INFO - Running pre-action listener: _resource_record_pre_action 04:50:37 INFO - Running main action method: create_virtualenv 04:50:37 INFO - Creating virtualenv /builds/slave/test/build/venv 04:50:37 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 04:50:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:50:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:50:37 INFO - Using real prefix '/usr' 04:50:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:50:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:50:40 INFO - Installing pip.................done. 04:50:40 INFO - Return code: 0 04:50:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:50: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')]} 04:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2495180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24933b0>, '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 0x24942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2494740>, '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': '0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806', '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 04:50: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', 'pip>=1.5'] in /builds/slave/test/build 04:50: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 pip>=1.5 04:50:40 INFO - Using env: {'DISPLAY': ':0', 04:50:40 INFO - 'HOME': '/home/cltbld', 04:50:40 INFO - 'LANG': 'en_US.UTF-8', 04:50:40 INFO - 'LANGUAGE': 'en_US:en', 04:50:40 INFO - 'LOGNAME': 'cltbld', 04:50:40 INFO - 'MAIL': '/var/mail/cltbld', 04:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:40 INFO - 'MOZ_NO_REMOTE': '1', 04:50:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:40 INFO - 'NO_EM_RESTART': '1', 04:50:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:40 INFO - 'PWD': '/builds/slave/test', 04:50:40 INFO - 'SHELL': '/bin/bash', 04:50:40 INFO - 'SHLVL': '1', 04:50:40 INFO - 'TERM': 'linux', 04:50:40 INFO - 'TMOUT': '86400', 04:50:40 INFO - 'USER': 'cltbld', 04:50:40 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806', 04:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:40 INFO - '_': '/tools/buildbot/bin/python'} 04:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:40 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 04:50:40 INFO - Cleaning up... 04:50:40 INFO - Return code: 0 04:50:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:50: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')]} 04:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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', '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 0x21d4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2495180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24933b0>, '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 0x24942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2494740>, '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': '0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806', '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 04:50: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:50: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 psutil>=3.1.1 04:50:40 INFO - Using env: {'DISPLAY': ':0', 04:50:40 INFO - 'HOME': '/home/cltbld', 04:50:40 INFO - 'LANG': 'en_US.UTF-8', 04:50:40 INFO - 'LANGUAGE': 'en_US:en', 04:50:40 INFO - 'LOGNAME': 'cltbld', 04:50:40 INFO - 'MAIL': '/var/mail/cltbld', 04:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:40 INFO - 'MOZ_NO_REMOTE': '1', 04:50:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:40 INFO - 'NO_EM_RESTART': '1', 04:50:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:40 INFO - 'PWD': '/builds/slave/test', 04:50:40 INFO - 'SHELL': '/bin/bash', 04:50:40 INFO - 'SHLVL': '1', 04:50:40 INFO - 'TERM': 'linux', 04:50:40 INFO - 'TMOUT': '86400', 04:50:40 INFO - 'USER': 'cltbld', 04:50:40 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806', 04:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:40 INFO - '_': '/tools/buildbot/bin/python'} 04:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:40 INFO - Downloading/unpacking psutil>=3.1.1 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:50:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:50:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:50:42 INFO - Installing collected packages: psutil 04:50:42 INFO - Running setup.py install for psutil 04:50:42 INFO - building 'psutil._psutil_linux' extension 04:50:42 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 04:50:42 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 04:50:42 INFO - building 'psutil._psutil_posix' extension 04:50:42 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 04:50:42 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 04:50:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:50:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:50:43 INFO - Successfully installed psutil 04:50:43 INFO - Cleaning up... 04:50:43 INFO - Return code: 0 04:50:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2495180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24933b0>, '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 0x24942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2494740>, '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': '0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806', '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 04:50:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:50:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:50:43 INFO - Using env: {'DISPLAY': ':0', 04:50:43 INFO - 'HOME': '/home/cltbld', 04:50:43 INFO - 'LANG': 'en_US.UTF-8', 04:50:43 INFO - 'LANGUAGE': 'en_US:en', 04:50:43 INFO - 'LOGNAME': 'cltbld', 04:50:43 INFO - 'MAIL': '/var/mail/cltbld', 04:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:43 INFO - 'MOZ_NO_REMOTE': '1', 04:50:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:43 INFO - 'NO_EM_RESTART': '1', 04:50:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:43 INFO - 'PWD': '/builds/slave/test', 04:50:43 INFO - 'SHELL': '/bin/bash', 04:50:43 INFO - 'SHLVL': '1', 04:50:43 INFO - 'TERM': 'linux', 04:50:43 INFO - 'TMOUT': '86400', 04:50:43 INFO - 'USER': 'cltbld', 04:50:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806', 04:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:43 INFO - '_': '/tools/buildbot/bin/python'} 04:50:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:50:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:50:45 INFO - Installing collected packages: mozsystemmonitor 04:50:45 INFO - Running setup.py install for mozsystemmonitor 04:50:45 INFO - Successfully installed mozsystemmonitor 04:50:45 INFO - Cleaning up... 04:50:45 INFO - Return code: 0 04:50:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:50: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')]} 04:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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', '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 0x21d4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2495180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24933b0>, '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 0x24942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2494740>, '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': '0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806', '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 04:50: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:50: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 jsonschema==2.5.1 04:50:45 INFO - Using env: {'DISPLAY': ':0', 04:50:45 INFO - 'HOME': '/home/cltbld', 04:50:45 INFO - 'LANG': 'en_US.UTF-8', 04:50:45 INFO - 'LANGUAGE': 'en_US:en', 04:50:45 INFO - 'LOGNAME': 'cltbld', 04:50:45 INFO - 'MAIL': '/var/mail/cltbld', 04:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:45 INFO - 'MOZ_NO_REMOTE': '1', 04:50:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:45 INFO - 'NO_EM_RESTART': '1', 04:50:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:45 INFO - 'PWD': '/builds/slave/test', 04:50:45 INFO - 'SHELL': '/bin/bash', 04:50:45 INFO - 'SHLVL': '1', 04:50:45 INFO - 'TERM': 'linux', 04:50:45 INFO - 'TMOUT': '86400', 04:50:45 INFO - 'USER': 'cltbld', 04:50:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806', 04:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:45 INFO - '_': '/tools/buildbot/bin/python'} 04:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:45 INFO - Downloading/unpacking jsonschema==2.5.1 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:50:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:47 INFO - Downloading functools32-3.2.3-2.tar.gz 04:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:50:47 INFO - warning: no files found matching '*.txt' 04:50:47 INFO - no previously-included directories found matching 'build' 04:50:47 INFO - no previously-included directories found matching 'dist' 04:50:47 INFO - no previously-included directories found matching '.git*' 04:50:47 INFO - Installing collected packages: jsonschema, functools32 04:50:47 INFO - Running setup.py install for functools32 04:50:48 INFO - warning: no files found matching '*.txt' 04:50:48 INFO - no previously-included directories found matching 'build' 04:50:48 INFO - no previously-included directories found matching 'dist' 04:50:48 INFO - no previously-included directories found matching '.git*' 04:50:48 INFO - Successfully installed jsonschema functools32 04:50:48 INFO - Cleaning up... 04:50:48 INFO - Return code: 0 04:50:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:50: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')]} 04:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21d4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2495180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24933b0>, '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 0x24942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2494740>, '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': '0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806', '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 04:50:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:50:48 INFO - Using env: {'DISPLAY': ':0', 04:50:48 INFO - 'HOME': '/home/cltbld', 04:50:48 INFO - 'LANG': 'en_US.UTF-8', 04:50:48 INFO - 'LANGUAGE': 'en_US:en', 04:50:48 INFO - 'LOGNAME': 'cltbld', 04:50:48 INFO - 'MAIL': '/var/mail/cltbld', 04:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:48 INFO - 'MOZ_NO_REMOTE': '1', 04:50:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:48 INFO - 'NO_EM_RESTART': '1', 04:50:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:48 INFO - 'PWD': '/builds/slave/test', 04:50:48 INFO - 'SHELL': '/bin/bash', 04:50:48 INFO - 'SHLVL': '1', 04:50:48 INFO - 'TERM': 'linux', 04:50:48 INFO - 'TMOUT': '86400', 04:50:48 INFO - 'USER': 'cltbld', 04:50:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806', 04:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:48 INFO - '_': '/tools/buildbot/bin/python'} 04:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:48 INFO - Downloading/unpacking blobuploader==1.2.4 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:50 INFO - Downloading blobuploader-1.2.4.tar.gz 04:50:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:50:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:50:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:50 INFO - Downloading docopt-0.6.1.tar.gz 04:50:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:50:51 INFO - Installing collected packages: blobuploader, requests, docopt 04:50:51 INFO - Running setup.py install for blobuploader 04:50:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:50:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:50:51 INFO - Running setup.py install for requests 04:50:51 INFO - Running setup.py install for docopt 04:50:51 INFO - Successfully installed blobuploader requests docopt 04:50:51 INFO - Cleaning up... 04:50:51 INFO - Return code: 0 04:50:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50:51 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')]} 04:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:51 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')]} 04:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:51 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 0x21d4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2495180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24933b0>, '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 0x24942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2494740>, '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': '0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806', '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 04:50:51 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 04:50:51 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 04:50:51 INFO - Using env: {'DISPLAY': ':0', 04:50:51 INFO - 'HOME': '/home/cltbld', 04:50:51 INFO - 'LANG': 'en_US.UTF-8', 04:50:51 INFO - 'LANGUAGE': 'en_US:en', 04:50:51 INFO - 'LOGNAME': 'cltbld', 04:50:51 INFO - 'MAIL': '/var/mail/cltbld', 04:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:51 INFO - 'MOZ_NO_REMOTE': '1', 04:50:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:51 INFO - 'NO_EM_RESTART': '1', 04:50:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:51 INFO - 'PWD': '/builds/slave/test', 04:50:51 INFO - 'SHELL': '/bin/bash', 04:50:51 INFO - 'SHLVL': '1', 04:50:51 INFO - 'TERM': 'linux', 04:50:51 INFO - 'TMOUT': '86400', 04:50:51 INFO - 'USER': 'cltbld', 04:50:51 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806', 04:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:51 INFO - '_': '/tools/buildbot/bin/python'} 04:50:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:50:51 INFO - Running setup.py (path:/tmp/pip-0T4L5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:50:51 INFO - Running setup.py (path:/tmp/pip-brXMd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:50:51 INFO - Running setup.py (path:/tmp/pip-9Jrr0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:50:52 INFO - Running setup.py (path:/tmp/pip-4lpPE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:50:52 INFO - Running setup.py (path:/tmp/pip-KwRGke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:50:52 INFO - Running setup.py (path:/tmp/pip-xoA8cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:50:52 INFO - Running setup.py (path:/tmp/pip-RL7Rfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:50:52 INFO - Running setup.py (path:/tmp/pip-lq9miz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:50:52 INFO - Running setup.py (path:/tmp/pip-mK3eMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:50:52 INFO - Running setup.py (path:/tmp/pip-OCAZYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:50:52 INFO - Running setup.py (path:/tmp/pip-6UtvBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:50:52 INFO - Running setup.py (path:/tmp/pip-3BkHnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:50:52 INFO - Running setup.py (path:/tmp/pip-mbuYr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:50:52 INFO - Running setup.py (path:/tmp/pip-JJ6XQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:52 INFO - Running setup.py (path:/tmp/pip-27Qa7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:50:52 INFO - Running setup.py (path:/tmp/pip-ZCNZEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:50:52 INFO - Running setup.py (path:/tmp/pip-V_deyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:50:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:50:53 INFO - Running setup.py install for manifestparser 04:50:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:50:53 INFO - Running setup.py install for mozcrash 04:50:53 INFO - Running setup.py install for mozdebug 04:50:53 INFO - Running setup.py install for mozdevice 04:50:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:50:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:50:53 INFO - Running setup.py install for mozfile 04:50:53 INFO - Running setup.py install for mozhttpd 04:50:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:50:53 INFO - Running setup.py install for mozinfo 04:50:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:50:53 INFO - Running setup.py install for mozInstall 04:50:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:50:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:50:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:50:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:50:53 INFO - Running setup.py install for mozleak 04:50:53 INFO - Running setup.py install for mozlog 04:50:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:50:54 INFO - Running setup.py install for moznetwork 04:50:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:50:54 INFO - Running setup.py install for mozprocess 04:50:54 INFO - Running setup.py install for mozprofile 04:50:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:50:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:50:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:50:54 INFO - Running setup.py install for mozrunner 04:50:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:50:54 INFO - Running setup.py install for mozscreenshot 04:50:54 INFO - Running setup.py install for moztest 04:50:54 INFO - Running setup.py install for mozversion 04:50:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:50:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:50:54 INFO - Cleaning up... 04:50:54 INFO - Return code: 0 04:50:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:54 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 0x21d4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2495180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24933b0>, '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 0x24942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2494740>, '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': '0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806', '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 04:50:54 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 04:50:54 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 04:50:54 INFO - Using env: {'DISPLAY': ':0', 04:50:54 INFO - 'HOME': '/home/cltbld', 04:50:54 INFO - 'LANG': 'en_US.UTF-8', 04:50:54 INFO - 'LANGUAGE': 'en_US:en', 04:50:54 INFO - 'LOGNAME': 'cltbld', 04:50:54 INFO - 'MAIL': '/var/mail/cltbld', 04:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:54 INFO - 'MOZ_NO_REMOTE': '1', 04:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:54 INFO - 'NO_EM_RESTART': '1', 04:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:54 INFO - 'PWD': '/builds/slave/test', 04:50:54 INFO - 'SHELL': '/bin/bash', 04:50:54 INFO - 'SHLVL': '1', 04:50:54 INFO - 'TERM': 'linux', 04:50:54 INFO - 'TMOUT': '86400', 04:50:54 INFO - 'USER': 'cltbld', 04:50:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806', 04:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:54 INFO - '_': '/tools/buildbot/bin/python'} 04:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:50:55 INFO - Running setup.py (path:/tmp/pip-kDyyf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:50:55 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)) 04:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:50:55 INFO - Running setup.py (path:/tmp/pip-OYIf8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:50:55 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)) 04:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:50:55 INFO - Running setup.py (path:/tmp/pip-_Vm5yX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:50:55 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)) 04:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:50:55 INFO - Running setup.py (path:/tmp/pip-nkUijs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:50:55 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)) 04:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:50:55 INFO - Running setup.py (path:/tmp/pip-5Gz0YK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:50:55 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)) 04:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:50:55 INFO - Running setup.py (path:/tmp/pip-FTo3Lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:50:55 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)) 04:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:50:55 INFO - Running setup.py (path:/tmp/pip-f_vmIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:50:55 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)) 04:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:50:55 INFO - Running setup.py (path:/tmp/pip-K41g3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:50:55 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)) 04:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:50:55 INFO - Running setup.py (path:/tmp/pip-5Wuoeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:50:55 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)) 04:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:50:55 INFO - Running setup.py (path:/tmp/pip-Wv9h7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:50:55 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)) 04:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:50:55 INFO - Running setup.py (path:/tmp/pip-QfGlxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:50:55 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)) 04:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:50:55 INFO - Running setup.py (path:/tmp/pip-rVrjqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:50:55 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)) 04:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:50:55 INFO - Running setup.py (path:/tmp/pip-2Kyhqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:50:56 INFO - Running setup.py (path:/tmp/pip-UFxnuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:50:56 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)) 04:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:56 INFO - Running setup.py (path:/tmp/pip-tzvXui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:56 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)) 04:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:50:56 INFO - Running setup.py (path:/tmp/pip-geie2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:50:56 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)) 04:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:50:56 INFO - Running setup.py (path:/tmp/pip-Z4qeVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:50:56 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)) 04:50:56 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)) 04:50:56 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)) 04:50:56 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)) 04:50:56 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)) 04:50:56 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)) 04:50:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:58 INFO - Downloading blessings-1.6.tar.gz 04:50:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:50:58 INFO - Installing collected packages: blessings 04:50:58 INFO - Running setup.py install for blessings 04:50:58 INFO - Successfully installed blessings 04:50:58 INFO - Cleaning up... 04:50:58 INFO - Return code: 0 04:50:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:50:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:50:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:50:58 INFO - Reading from file tmpfile_stdout 04:50:58 INFO - Current package versions: 04:50:58 INFO - argparse == 1.2.1 04:50:58 INFO - blessings == 1.6 04:50:58 INFO - blobuploader == 1.2.4 04:50:58 INFO - docopt == 0.6.1 04:50:58 INFO - functools32 == 3.2.3-2 04:50:58 INFO - jsonschema == 2.5.1 04:50:58 INFO - manifestparser == 1.1 04:50:58 INFO - mozInstall == 1.12 04:50:58 INFO - mozcrash == 0.17 04:50:58 INFO - mozdebug == 0.1 04:50:58 INFO - mozdevice == 0.48 04:50:58 INFO - mozfile == 1.2 04:50:58 INFO - mozhttpd == 0.7 04:50:58 INFO - mozinfo == 0.9 04:50:58 INFO - mozleak == 0.1 04:50:58 INFO - mozlog == 3.2 04:50:58 INFO - moznetwork == 0.27 04:50:58 INFO - mozprocess == 0.23 04:50:58 INFO - mozprofile == 0.28 04:50:58 INFO - mozrunner == 6.12 04:50:58 INFO - mozscreenshot == 0.1 04:50:58 INFO - mozsystemmonitor == 0.3 04:50:58 INFO - moztest == 0.7 04:50:58 INFO - mozversion == 1.4 04:50:58 INFO - psutil == 3.1.1 04:50:58 INFO - requests == 1.2.3 04:50:58 INFO - wsgiref == 0.1.2 04:50:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50:58 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')]} 04:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:58 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')]} 04:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:58 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 0x21d4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2495180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24933b0>, '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 0x24942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2494740>, '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': '0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806', '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 04:50:58 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 04:50:58 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 04:50:58 INFO - Using env: {'DISPLAY': ':0', 04:50:58 INFO - 'HOME': '/home/cltbld', 04:50:58 INFO - 'LANG': 'en_US.UTF-8', 04:50:58 INFO - 'LANGUAGE': 'en_US:en', 04:50:58 INFO - 'LOGNAME': 'cltbld', 04:50:58 INFO - 'MAIL': '/var/mail/cltbld', 04:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:58 INFO - 'MOZ_NO_REMOTE': '1', 04:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:58 INFO - 'NO_EM_RESTART': '1', 04:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:58 INFO - 'PWD': '/builds/slave/test', 04:50:58 INFO - 'SHELL': '/bin/bash', 04:50:58 INFO - 'SHLVL': '1', 04:50:58 INFO - 'TERM': 'linux', 04:50:58 INFO - 'TMOUT': '86400', 04:50:58 INFO - 'USER': 'cltbld', 04:50:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806', 04:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:58 INFO - '_': '/tools/buildbot/bin/python'} 04:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:58 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)) 04:50:58 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)) 04:50:58 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)) 04:50:58 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)) 04:50:58 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)) 04:50:58 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)) 04:50:58 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)) 04:50:58 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)) 04:50:58 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)) 04:50:58 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)) 04:50:58 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)) 04:50:58 INFO - Cleaning up... 04:50:58 INFO - Return code: 0 04:50:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:50:58 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')]} 04:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:58 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')]} 04:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:58 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 0x21d4030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23378a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2495180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24933b0>, '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 0x24942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2494740>, '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': '0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806', '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 04:50:58 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 04:50:58 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 04:50:58 INFO - Using env: {'DISPLAY': ':0', 04:50:58 INFO - 'HOME': '/home/cltbld', 04:50:58 INFO - 'LANG': 'en_US.UTF-8', 04:50:58 INFO - 'LANGUAGE': 'en_US:en', 04:50:58 INFO - 'LOGNAME': 'cltbld', 04:50:58 INFO - 'MAIL': '/var/mail/cltbld', 04:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:58 INFO - 'MOZ_NO_REMOTE': '1', 04:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:58 INFO - 'NO_EM_RESTART': '1', 04:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:58 INFO - 'PWD': '/builds/slave/test', 04:50:58 INFO - 'SHELL': '/bin/bash', 04:50:58 INFO - 'SHLVL': '1', 04:50:58 INFO - 'TERM': 'linux', 04:50:58 INFO - 'TMOUT': '86400', 04:50:58 INFO - 'USER': 'cltbld', 04:50:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806', 04:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:58 INFO - '_': '/tools/buildbot/bin/python'} 04:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:50:59 INFO - Cleaning up... 04:50:59 INFO - Return code: 0 04:50:59 INFO - Running post-action listener: _resource_record_post_action 04:50:59 INFO - Running post-action listener: _start_resource_monitoring 04:50:59 INFO - Starting resource monitoring. 04:50:59 INFO - ##### 04:50:59 INFO - ##### Finished create-virtualenv step (success) 04:50:59 INFO - ##### 04:50:59 INFO - ##### 04:50:59 INFO - ##### Running install step. 04:50:59 INFO - ##### 04:50:59 INFO - Running pre-action listener: _resource_record_pre_action 04:50:59 INFO - Running main action method: install 04:50:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:50:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:50:59 INFO - Reading from file tmpfile_stdout 04:50:59 INFO - Detecting whether we're running mozinstall >=1.0... 04:50:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:50:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:50:59 INFO - Reading from file tmpfile_stdout 04:50:59 INFO - Output received: 04:50:59 INFO - Usage: mozinstall [options] installer 04:50:59 INFO - Options: 04:50:59 INFO - -h, --help show this help message and exit 04:50:59 INFO - -d DEST, --destination=DEST 04:50:59 INFO - Directory to install application into. [default: 04:50:59 INFO - "/builds/slave/test"] 04:50:59 INFO - --app=APP Application being installed. [default: firefox] 04:50:59 INFO - mkdir: /builds/slave/test/build/application 04:50:59 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'] 04:50:59 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 04:51:15 INFO - Reading from file tmpfile_stdout 04:51:15 INFO - Output received: 04:51:15 INFO - /builds/slave/test/build/application/firefox/firefox 04:51:15 INFO - Running post-action listener: _resource_record_post_action 04:51:15 INFO - ##### 04:51:15 INFO - ##### Finished install step (success) 04:51:15 INFO - ##### 04:51:15 INFO - ##### 04:51:15 INFO - ##### Running run-tests step. 04:51:15 INFO - ##### 04:51:15 INFO - Running pre-action listener: _resource_record_pre_action 04:51:15 INFO - Running main action method: run_tests 04:51:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:51:15 INFO - Python 2.7.3 04:51:15 INFO - Return code: 0 04:51:15 INFO - grabbing minidump binary from tooltool 04:51:15 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')]} 04:51:15 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 0x24933b0>, '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 0x24942b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2494740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:51:15 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 04:51:15 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 04:51:15 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 04:51:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:51:15 INFO - Return code: 0 04:51:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:51:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:51:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:51:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:51:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:51:15 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:51:15 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:51:15 INFO - Using env: {'DISPLAY': ':0', 04:51:15 INFO - 'HOME': '/home/cltbld', 04:51:15 INFO - 'LANG': 'en_US.UTF-8', 04:51:15 INFO - 'LANGUAGE': 'en_US:en', 04:51:15 INFO - 'LOGNAME': 'cltbld', 04:51:15 INFO - 'MAIL': '/var/mail/cltbld', 04:51:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:51:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:15 INFO - 'MOZ_NO_REMOTE': '1', 04:51:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:15 INFO - 'NO_EM_RESTART': '1', 04:51:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:15 INFO - 'PWD': '/builds/slave/test', 04:51:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:51:15 INFO - 'SHELL': '/bin/bash', 04:51:15 INFO - 'SHLVL': '1', 04:51:15 INFO - 'TERM': 'linux', 04:51:15 INFO - 'TMOUT': '86400', 04:51:15 INFO - 'USER': 'cltbld', 04:51:15 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806', 04:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:15 INFO - '_': '/tools/buildbot/bin/python'} 04:51:15 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:51:16 INFO - mozversion application_buildid: 20160714032851 04:51:16 INFO - mozversion application_changeset: d868ba1645e6fbc6671c09f49f331ba4acae9ad6 04:51:16 INFO - mozversion application_display_name: Nightly 04:51:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:51:16 INFO - mozversion application_name: Firefox 04:51:16 INFO - mozversion application_remotingname: firefox 04:51:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:51:16 INFO - mozversion application_vendor: Mozilla 04:51:16 INFO - mozversion application_version: 50.0a1 04:51:16 INFO - mozversion platform_buildid: 20160714032851 04:51:16 INFO - mozversion platform_changeset: d868ba1645e6fbc6671c09f49f331ba4acae9ad6 04:51:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:51:16 INFO - mozversion platform_version: 50.0a1 04:51:16 INFO - using testdate: 1468497076 04:51:16 INFO - actual date: 1468497076 04:51:16 INFO - starting webserver on 'localhost:60606' 04:51:16 INFO - SUITE-START | Running 2 tests 04:51:16 INFO - TEST-START | dromaeo_css 04:51:16 INFO - operating with platform_type : linux_ 04:51:16 INFO - Initialising browser for dromaeo_css test... 04:51:16 INFO - TEST-INFO | started process 3700 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppd_ThC/profile http://localhost:60606/getInfo.html) 04:51:19 INFO - PROCESS | 3700 | __metrics Screen width/height:1600/1200 04:51:19 INFO - PROCESS | 3700 | colorDepth:24 04:51:19 INFO - PROCESS | 3700 | Browser inner width/height: 1024/697 04:51:19 INFO - PROCESS | 3700 | __metrics 04:51:20 INFO - PROCESS | 3700 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:51:20 INFO - PROCESS | 3700 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:51:21 INFO - TEST-INFO | 3700: exit 0 04:51:21 INFO - Browser initialized. 04:51:21 INFO - Running cycle 1/1 for dromaeo_css test... 04:51:21 INFO - TEST-INFO | started process 3784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppd_ThC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:33 INFO - PROCESS | 3784 | RSS: Main: 159170560 04:51:33 INFO - PROCESS | 3784 | 04:52:25 INFO - PROCESS | 3784 | 1468497145403 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] 04:54:37 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:60606/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60606/tests/dromaeo/cssquery-ext.html) 04:54:38 INFO - PROCESS | 3784 | RSS: Main: 261648384 04:54:38 INFO - PROCESS | 3784 | 04:57:40 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:60606/tests/dromaeo/cssquery-ext.html (next: http://localhost:60606/tests/dromaeo/cssquery-jquery.html) 04:57:41 INFO - PROCESS | 3784 | RSS: Main: 244424704 04:57:41 INFO - PROCESS | 3784 | 05:00:43 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:60606/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60606/tests/dromaeo/cssquery-mootools.html) 05:00:44 INFO - PROCESS | 3784 | RSS: Main: 244998144 05:00:44 INFO - PROCESS | 3784 | 05:03:46 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:60606/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60606/tests/dromaeo/cssquery-prototype.html) 05:03:47 INFO - PROCESS | 3784 | RSS: Main: 242352128 05:03:47 INFO - PROCESS | 3784 | 05:06:49 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:60606/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60606/tests/dromaeo/cssquery-yui.html) 05:06:50 INFO - PROCESS | 3784 | RSS: Main: 212332544 05:06:50 INFO - PROCESS | 3784 | 05:09:53 INFO - PROCESS | 3784 | Cycle 1(1): loaded http://localhost:60606/tests/dromaeo/cssquery-yui.html (next: http://localhost:60606/tests/dromaeo/cssquery-dojo.html) 05:09:53 INFO - PROCESS | 3784 | RSS: Main: 291508224 05:09:53 INFO - PROCESS | 3784 | 05:09:53 INFO - PROCESS | 3784 | __start_tp_report 05:09:53 INFO - PROCESS | 3784 | _x_x_mozilla_page_load 05:09:53 INFO - PROCESS | 3784 | _x_x_mozilla_page_load_details 05:09:53 INFO - PROCESS | 3784 | |i|pagename|runs| 05:09:53 INFO - PROCESS | 3784 | |0;dojo.html;2631.3816253180507;2642.960355594668;2674.2645772412584;2683.114572191177;2690.0315886280937;4571.862844114674;4623.445186577607;4635.165670179366;4675.859724208275;4681.344611754357;4655.86032419028;4733.313669517918;4735.479097299294;4794.041191761644;4794.976025119879;4316.20150272199;4345.087531618348;4345.608895199432;4397.494288156871;4458.219811532985;4409.955900441003;4441.555844415549;4478.888027799315;4496.303073023687;4496.887577810565;4185.91628167438;4252.340887162495;4324.783760811947;4329.718568293082;4419.18245124653;4247.91504169918;4326.09152078064;4338.089001309729;4340.934885976713;4347.152305300468;4327.7619730914785;4329.588689074533;4338.370936214263;4365.672574556921;4377.562243775629;4491.483479399878;4526.93209601853;4752.1683705351425;4755.310479980383;4785.569298763093;5006;5039;5061.291419201315;5110.080185566597;5111.872203194913;5115.181570948667;5152.098382782998;5158.871028224287;5159.690418574897;5169.4572069932865;4551.7724113794175;4683.2038553446;4750.738709370983;4810.278458231293;4812.446568644581;5152.845414637567;5183.144781111075;5208.583313335;5254.238135470412;5265.631405801557;4989.376327959005;5032.647714660012;5044.571211447068;5044.722540260321;5047.495250474996;4889.315495830587;4932.580730637936;4991.80032798684;5138.511841375063;5145.948540514547;4967.503249675004;4973.452920178777;5003;5007.173816320339;5017.874553136201;4928.457869634337;4933.4819843915875;4935.037667654773;4941.75291235444;4982.975085124624;4175.185838761473;4220.219259436953;4235.7035007549175;4245.893852653647;4292.334688123346;3718;3737.588865224823;3749.7187710921244;3760.9811950940616;3813.961860381416;4395.516493185747;4404.075144219686;4404.889877753082;4433.911321773547;4444.73331600105;4809.519048095162;5057.873553161126;5072.594192464594;5076.796928122908;5105.693658380509;4279.593438623326;4301.268784306675;4306.612404883575;4314.784260786948;4316.460442444694;4489.147062058199;4522.095580883836;4524.479684836286;4526;4550.613197878151;4670.276107203389;4777.474477807369;4780.235162374003;4782.306565548046;4820.132376172252;5053.8736531587;5113.079645663816;5124.692518448905;5130.256112863689;5136.203888397305;4873.805047798191;4876.5854902333695;4879.146149423766;4880.243562247857;4933.309336692794;4854;4992.350994370709;5056.721880296472;5064.6961182327705;5099.36257967754;5066.06277838601;5140.922886156636;5163.896722065613;5165.405978312542;5217.765200566059;5014.674046186986;5019.171836647059;5025.47232540578;5030.044291584587;5072.1123803335;4785.401824771903;4893.486183950634;4947.431045429822;5005.774740136775;5020.397552293748;4876.731779752005;4882.6826256293225;4900.852974410774;4936.185529387611;4941.579965702956;5001.8499445016705;5002;5003.799848006039;5010.824621138243;5037.596992240538;4684.5549672781035;4719.126961511994;4838.104950584153;4905.9018819624125;4939.061578300111 05:09:53 INFO - PROCESS | 3784 | |1;ext.html;572.1703529881672;572.1732097119661;583.238873270382;584.3163498706513;586.9757273557642;27586.862065689667;29820.701792982065;29911.700882991165;30021.699783002136;31545.369092618133;38123.618763812425;41991.58008419915;42079;42087;42097;7807.45347825651;7931.762047138566;7937.761867143995;7938.364930805551;7961.7213397531095;7757.961210193941;7832.060152781674;7847.843043139133;7856.646450909723;7857.803554911145;7856.057273127204;7864.960675196616;7882.330001949841;7904.328132108778;7907.051153861545;7763.184865589088;7814.413918956101;7816.413768967293;7846.960765196138;7856.4107691923045;7875.369970402354;7952.403569732293;7953.642086106139;7956.960215198945;7966.28303452692;38427.42358864619;38612.613873861184;38706.61293387058;38900.22199555993;38921.41617875734;2997.1757766614137;3136.0121561708215;3170.4927211646027;3191.1543440988157;3588.2644057968314;26123.346916327053;29933;30135;30261.69738302611;30933.845330773427;2987.910362689101;3087.7992930459673;3115.2367669920786;3128.389963957029;3187.0279564732746;254289;254795;256515;257119;257497;54506.454935450136;54893;54894;54905.45094549083;54923.176152357744;33634.159146021055;34331.76843505164;34602.653973460445;36187.27625447529;36208.81895590505;15526.534203973899;15620.218989050729;15668.216589170725;15694.450694225876;15694.9215253923;12005.519779208735;12085.274883506841;12102.394880255952;12105.515779368903;12116.09129315305;18752.437426877215;18849;18851.622967540574;18863.52841178954;18866.81133188678;6792.796216113525;6876.759313424006;6889.896651550231;6996.405305548984;7117.537360071578;790.5691398188002;841.2765022081005;877.1404024056333;877.2630989968458;953.2993249961273;27118.728812712015;27858.5821212682;28237.576436353473;28556.143315700563;28702.138935831957;973.8831340239217;1011.3123076308034;1038.9766080410789;1043.3062013760916;1053.9934362683618;14656.853431465763;14778.926105369404;14887.851121488864;14961.476348327757;15111.395544178109;373391;375304;376848;378575;381133;48519;49062.754686227054;49163.31275154378;49195.754021229666;49196;1056.2131212246773;1168.1881092640533;1187.1749134351542;1199.8080307150815;1203.4404002139047;28201.294967625974;29142.41715165727;29166.708332916398;29607;30068.398632027674;41555.584444155174;41562.168756624094;42078.36882446827;42115;42148.78925605475;297190;297554;298231;300116;300836;22294.554108917408;24658.876705616356;25399.746002540476;25432.491350173263;26749.598756019066;41077;41364.1727165449;41811.37282940819;42322.78838605787;42711.35932960946;35370;35457.64542354647;36182.09544761402;36588;36890.8155459221;36261.456078159375;36373;36451.45322820213;36511.45232821563;36712;35105.824470878506;35171.82414087913;36184.276314473034;37145;37287.81356093311;29844.164804343553;31719.365612688078;31974.52038219382;32094.839525803156;32110;24740.38149046288;24801.25596232116;25146;25522.489550209262;26032 05:09:53 INFO - PROCESS | 3784 | |2;jquery.html;342.6385163652346;361.90047736872356;362.67721727662376;364.48425477948695;378.93368660484407;12927.288999105045;13872.306384680776;14466.204358760277;17549.91225043873;17566.648667026653;14188;15661.686766264667;16488.752668709978;16500.25748841302;17310.56723581911;4731.219348807443;4858.5627293543575;4863.14894893394;4866.148424025799;4869.829555965542;3524.9295014099703;5720.370759216483;6006.129111278862;6012.338642749294;6140.692965351737;5381.623286369956;6046.54650901182;6052.061930400773;6065.636061836304;6076.240469941257;5584.246126772895;5597.776088956437;5610.523105536035;5626.352969408509;5629.662220266756;5332.120200166968;5386.407495175527;5438.891222175574;5443.319585051869;5487.451254874521;12912.289824059673;13102.86897131026;13114.60656180316;13137.934310328483;18163;1851.0559614596518;1851.1669748613178;1863.7577114975102;1881.1816859665953;1895.933642322512;9269.629214831466;9277.396969196981;9514.191293740041;9623.90376096237;9964.551595178162;1700.4898530440819;1771.052486919492;1823.7537932379225;1829.2865782344895;1850.5281153305955;68895.31104688939;71581.28418715799;73327.63336183339;73529;73547.26452735458;10201.693949181536;10258.076773090308;10340.12108970746;10566.788664226673;10582.417967011734;14177.85822141786;14260.42958281657;14266.643333916527;14286.214258215898;14297.142171469744;7295.963520182471;7473.327400533978;7526.473146879775;7598.658060387296;7617.847643047108;6980.860382792316;7080.044194033842;7219.675114619855;7233.493655444068;7245.384142347854;4360.607545320936;4500.257457519473;4520.434945631796;4591.632669386441;4635.443746750411;1835.6328734253202;1865.2538984406074;1875.5311172206948;1885.9622807543772;1938.4184744576853;749.6589051981335;795.6857041468587;813.3452570680658;879.9340049496185;896.7533928169674;16479.176041197894;17772.55568610795;18935.715964260547;19154.52113697169;19450;858.6865793985276;896.6010125494223;911.4485736129546;912.5528491039476;922.0548937339281;9715.757106072264;9772.267079969031;9875.901240987641;9950.303478756417;10097.798044039078;394093;417080;426060;427473;431225;83862;84059;84541;88279.96367736808;88371.55814220887;947.2516711797603;951.8952915179464;969.2149359019216;973.9659111931048;974.9512524373753;15550.377984880479;15611.843881561039;15687.764683529527;16149;16210.837891621404;28162.436751265268;29106.835726571546;38093.42859857049;39037.41443878287;41111.58888411077;51188.74405627948;53521.73239133779;54477.72761136169;55150.44849551453;55520.16719749126;4983.750812459435;6907.481938854506;6983.022376867141;7161.140663120459;7489.15412143382;9015.549222538715;11174.385408802595;11450.198486106226;11454.312741235553;11529.1929564933;9616.51917404113;9720.593546982505;9812.362196457207;9863.408195508293;9998.500074996367;9115.997240303694;9358.15776580111;9388.95305523468;9885.034489653219;9980.301378903407;10062.89937100649;10122.746931326776;10164.390136591532;10309.793804124025;10600;7227.49407541467;7247.311505406978;7280.5995670236525;7294.379977701955;7305.817354566178;7424.368928641126;8826.338024648048;9801.068898454636;9834.606615735576;9925.950370248103 05:09:53 INFO - PROCESS | 3784 | |3;mootools.html;1249.0569619936946;1317.7101037771693;1385.9168449893007;1390.8748212660857;1636.64812065406;6730.259671436144;7633.541987480755;7869.331106855924;7874.330681892039;8157.877631835512;7835.569043702609;7905.446618736676;7929.563873986928;7942.682292708299;7950.880736788953;2212.214663794358;2232.787885150908;2239.216274303989;2241;2243.046705150313;2194.9231776887814;2223.810976067028;2231.4532939429864;2231.8995645196005;2242.0583354990863;2209.9116035358566;2211.3476524425255;2220.955580888381;2227.454273702945;2253.864768113918;2164.621191291518;2180.2478145040095;2187.300063979519;2192.5614877024577;2193.035064571591;2165.8917054147228;2171.1098449635574;2175.184305885293;2175.2712841198218;2175.7824217578273;7780.961095194488;7917.247861453153;7929.405294602928;7960.880586791202;7964.044314682217;4491.573300536444;4595.264757638795;4693.155232058228;4699.78850951708;4704.200285951397;2685.503181911353;2751.2021513760988;2827;2843.8720257588457;2846.9893187918406;907.1880666803174;908.0499825757967;908.7182973278304;912.9315301352425;931.6785708930475;10206.081452669296;10346.63786767467;10363.689089327332;10365.792684146274;10391.220658450571;3888.183481468923;4091.059056416981;4189.392538081961;4199.139176468817;4254.255505286563;8920.375573709778;8958;8966.372353935161;8975.820483590292;8991.505467199368;4661.953380466152;4665.580097791215;4666.043461090469;4666.2067448533835;4671.789769460383;3724.571674257495;4158.563350848178;4237.724547904377;4237.940514871282;4335.783210839445;3633.8364773585254;3732.8880133596035;3799.3731034379016;3833.3483307837732;3863.5943225961432;1191.6127258640977;1196.4744950188579;1202.4709127983658;1205.048012070472;1217.6529689038582;791.9049714034353;831.0775039705921;846.8010017645848;849.1975083546113;867.2238346679686;5078.492150784966;5240.68555886648;5293.708846013429;5391.406945236021;5420.972895135499;411.3254263008668;411.59252340183;413.37167505391636;418.23880537422207;916.3631276263067;3227.2254658881698;3562.6615471530163;3741.5136032315627;3779.7543159694533;3897.9610203898164;9456.763580910394;9711.708648740549;9800.36297640651;9925.255605829592;9937.850932236022;9742.75643108928;9816.411015339103;9823;9842.557084931195;9844.80310393788;7305.050343455317;7380.926190738024;7450.2549745026145;7462.328390444777;7562.357199637982;5252.501012403815;5261.868453288698;5319;5409.918851217313;5433.9184912225555;9014.90985090167;9097.818043639223;9137.451752894847;9154.084591540792;9360.344775865624;9079.182873541413;9406.1064198901;9438.103380178873;9539.666111686058;9548.665796697082;6197.473214776614;6543.640099794557;6711.496637752286;6872.553284036521;6997.965010174917;7783.922160778547;7790.454668173174;7865.252800983897;7872.055353357634;7872.055353357634;6877.415419689382;6986.755463558954;7057.894131587927;7171.03191069199;7182.425405967615;6738.561993470409;6741.966290168518;6791.524593278423;6848.212455567674;6894.310568943066;6412.487001039999;6478.190226221723;6492.935070649233;6684.966575167287;6689;4688.742119183477;4696.2955556666775;4720.055988802184;4744.098621261949;4783.449903261169;4860.222364421676;4886.3403440536495;4905.558499735041;4957.157283261926;4961.3798275215595 05:09:53 INFO - PROCESS | 3784 | |4;prototype.html;297.77369199408446;300.5281707718881;303.29030069637054;307.6646455363653;308.8548382260337;4843.685160464567;4845.951540484594;4857.4656787753365;4884.829030983917;4902.19113846215;4834.854954351366;4837;4839.782209800559;4847.321375007502;4854.951450485494;3792.222594368148;3819.2361527694434;3821.29306078375;3843.7885916274595;3851.9422208666892;3572.2319701264223;3781.9810900945595;3855.9421608675893;3872.244912242114;3892.4550562921213;3726.2486631283255;3740.8503659853573;3745.8127093645344;3755.793431361274;3756.3238617049055;3731.6828069614116;3734.7572407793405;3736.1593641430595;3747.9437808432895;3750.962490375116;3121;3170.1282147409415;3255.9348813023844;3263.7552183586326;3316.4196265653413;4618.2610782275015;4651.465081515636;4655.534446555352;4661.300804879295;4672.953270467286;4213.831446742127;4242.787860606988;4243.663246077475;4255.8084886180195;4275.935860962088;4778.928316075262;4846.200376937801;4982.352294201731;5006.74966251686;5017.974910125426;3559.750817442754;3571.428571428559;3573.803440810754;3587.4798154267746;3587.712982961357;5234.26720259164;5259.500347466985;5294.867628309323;5298.549623282026;5319.601029922733;3586.9282614347567;3660.762050466711;3671.375866102769;3672.3573374659863;3674.871379501758;3708.7589306694977;3709.183979524554;3727.459518369821;3735.458358538051;3746.550413950343;4249.107687385684;4264.6801489888385;4267.893302667459;4279.272523670983;4288.292431748789;4857.368542089505;5003;5008.323876276729;5039.596832253411;5053.31780209667;1263.5261776833688;1277.6678063703505;1281.8077288406628;1282.5382862169797;1287.3884904670206;813.1502579804;827.1645637905639;841.478283464256;842.5997651115671;842.9789255268668;3991.940120898189;4009.5389030261895;4010.3783913493453;4053.8783836484954;4063.7402405253874;4540.931886021713;4544.795484203219;4553.749543775058;4556.270996640588;4562.2891415719105;4042.312806822847;4046.866877274368;4065.3698676705158;4073.185362927367;4090.2433049885867;2315.9884200579227;2438.7561243875825;2447.461558457172;2460.5940019896875;2463.913763018322;4389.934150987738;4402.6571895571515;4408.096340250241;4416.580424859633;4423.734575925455;4675.228587283128;4675.83104223944;4678.105367326239;4685.344051832746;4705.6941298816155;4402.3176407656865;4410.691251612357;4682.227432473604;5006.449290577961;5018.698878067327;5223.112070948024;5245.921311180412;5247.370315562004;5252.212168174804;5263.315768950012;5143.794248230029;5153.819616313411;5160.406553246425;5175.24041825781;5175.275461435327;4888.731119788304;4964.35463389757;4996.450390457119;5005.62457815658;5009.448960614257;3687.649673281034;3696.057505336122;3702;3712.2018765964367;3723.1064544509663;5211.5766168731725;5236.711980840938;5236.869078273074;5246.921296180637;5252.789888404421;4852.17513022794;5048.949510504848;5054.545090941833;5061.266116413173;5088.219123306813;5028.547430731252;5070.771815268248;5074.238864170404;5081.669691470042;5083.87290317745;4968.428630707371;4990.101781679187;4996.325496058131;5026.949730502648;5028.924566131438;4856.757162141949;4931.580815630711;4964.578010869117;4999.925001125059;5079.796808127633;4928.654994150375;4943.530364615356;4943.678660887031;4959.280904268933;4962.404511458648 05:09:53 INFO - PROCESS | 3784 | |5;yui.html;565.6379916853214;594.4560726934855;620.9970897001341;673.5846526021925;710.8649356622242;12456.318397016401;13504.257265850374;13516.121452105619;13522.323883805808;13705.10916790408;12973.091883568153;13222.338883055856;13227.206367617926;13237.867621323783;13243.735125297488;626.9310375858652;764.8432071425344;778.0585491555225;788.7791418402857;798.656577671601;779.4660657449665;784.1687810920414;785.8624740670389;786.0645831460572;786.7010535996313;847.2374862623657;847.6736456464275;848.4018766769412;848.8472075026493;849.7790574450656;653.7711800869705;806.3146325623233;819.9836003279901;827.8592639251342;829.2992421403904;607.5564837668483;614.2843587220882;615.5875563372551;616.2050954268988;616.8087892753216;12893.419796109103;12918;12940.741185176337;12945.482180712761;12948.223106613634;11784.469698863486;12112.697182570419;12200.816987745191;12210.938945305306;12579.622611321674;11144.60993865219;11279.67355367791;11376.658700239006;11532.769344613062;11807.055435565135;3905.511811023622;3981.243563722883;3990.4014397840265;4059.7970101494807;4081.0409553754844;56549.151762724;57435.13847292294;57454.425455745324;57691;57749.13376299359;9413.764655883657;9492.572834222477;9531.38046027006;9582.712518624452;9590.66432674853;17526.21132049061;18125.36561220351;18744.15651295695;18900.62198756017;18909.7163542547;6861.210960739579;6870.20992585849;6907.274736152732;7047;7080.92919070813;3727.7204209684382;3824.4263360495593;3852.5376954765047;3866.130120722815;3929.528456585228;2765.5160346939206;2865.498537755884;2868.4549935512605;2869.7560707339694;2870.4402641485126;443.60519137967236;457.88095095274804;495.1804763117047;503.2426198571127;507.0644660601185;435.3817579037774;438.6074463355279;476.8079800498753;500.31207090250905;508.8117396563295;7581.658825352873;8117.837643247102;8242.587870606445;8393.279377727551;8462.661493540189;486.3045844442411;492.47059411133176;509.13313384842064;514.8738559053056;531.2588938430945;3706.9629303707156;3889.7277190596387;3901.648851603369;3986.242613903349;4078;60926.39073609207;62109.689451552455;65991.67004164949;106115;106346.46826765971;87000.5649971746;88346;89630.55184724035;90692.54653726688;91157;48719.75640121777;60645.05807122523;81849;82228.17771822205;82718.75921861177;7170.81290206492;7280.381167600814;7493.662785174572;7535.8116047099265;7653.923460765321;47495.287570685774;48464.27303590378;49406;49488.25767613561;49847.750761247415;68811;70109.29890701231;71396.28603713897;71788.64105679438;73000.6349968268;9789.216862651114;10050.145737612385;10050.69847904564;10127.24045696561;10290.12533934594;11309.491072901574;11324.08325074331;11424.314541127558;11746.471408786454;11747.941260293645;8657.307415406627;8811.603477843384;8944.99513319157;9213.078692130734;9313.860292095489;9346.299027572823;9363.29775266844;9374.718758437259;9442.008589098321;9481.762955926157;9749.561269742737;10143.289969702346;10227.693169204937;10320.277580569287;10488.528016239135;8552.444091134057;8561.785955350917;8574.828503429771;8663.870041949249;8921.107889211027;8417.410781245255;8544;8602.78493037679;8621.827563448822;8689.175769612712 05:09:53 INFO - PROCESS | 3784 | __end_tp_report 05:09:53 INFO - PROCESS | 3784 | __start_cc_report 05:09:53 INFO - PROCESS | 3784 | _x_x_mozilla_cycle_collect,1043 05:09:53 INFO - PROCESS | 3784 | __end_cc_report 05:09:53 INFO - PROCESS | 3784 | __startTimestamp1468498193611__endTimestamp 05:09:53 INFO - PROCESS | 3784 | 05:09:53 INFO - PROCESS | 3784 | ------- Summary: start ------- 05:09:53 INFO - PROCESS | 3784 | Number of tests: 6 05:09:53 INFO - PROCESS | 3784 | 05:09:53 INFO - PROCESS | 3784 | [#0] dojo.html Cycles:165 Average:4683.09 Median:4812.45 stddev:497.12 (10.3%) stddev-sans-first:471.87 05:09:53 INFO - PROCESS | 3784 | Values: 2631.4 2643.0 2674.3 2683.1 2690.0 4571.9 4623.4 4635.2 4675.9 4681.3 4655.9 4733.3 4735.5 4794.0 4795.0 4316.2 4345.1 4345.6 4397.5 4458.2 4410.0 4441.6 4478.9 4496.3 4496.9 4185.9 4252.3 4324.8 4329.7 4419.2 4247.9 4326.1 4338.1 4340.9 4347.2 4327.8 4329.6 4338.4 4365.7 4377.6 4491.5 4526.9 4752.2 4755.3 4785.6 5006.0 5039.0 5061.3 5110.1 5111.9 5115.2 5152.1 5158.9 5159.7 5169.5 4551.8 4683.2 4750.7 4810.3 4812.4 5152.8 5183.1 5208.6 5254.2 5265.6 4989.4 5032.6 5044.6 5044.7 5047.5 4889.3 4932.6 4991.8 5138.5 5145.9 4967.5 4973.5 5003.0 5007.2 5017.9 4928.5 4933.5 4935.0 4941.8 4983.0 4175.2 4220.2 4235.7 4245.9 4292.3 3718.0 3737.6 3749.7 3761.0 3814.0 4395.5 4404.1 4404.9 4433.9 4444.7 4809.5 5057.9 5072.6 5076.8 5105.7 4279.6 4301.3 4306.6 4314.8 4316.5 4489.1 4522.1 4524.5 4526.0 4550.6 4670.3 4777.5 4780.2 4782.3 4820.1 5053.9 5113.1 5124.7 5130.3 5136.2 4873.8 4876.6 4879.1 4880.2 4933.3 4854.0 4992.4 5056.7 5064.7 5099.4 5066.1 5140.9 5163.9 5165.4 5217.8 5014.7 5019.2 5025.5 5030.0 5072.1 4785.4 4893.5 4947.4 5005.8 5020.4 4876.7 4882.7 4900.9 4936.2 4941.6 5001.8 5002.0 5003.8 5010.8 5037.6 4684.6 4719.1 4838.1 4905.9 4939.1 05:09:53 INFO - PROCESS | 3784 | 05:09:53 INFO - PROCESS | 3784 | [#1] ext.html Cycles:180 Average:46089.10 Median:19885.18 stddev:82698.41 (415.9%) stddev-sans-first:82859.78 05:09:53 INFO - PROCESS | 3784 | Values: 572.2 572.2 583.2 584.3 587.0 27586.9 29820.7 29911.7 30021.7 31545.4 38123.6 41991.6 42079.0 42087.0 42097.0 7807.5 7931.8 7937.8 7938.4 7961.7 7758.0 7832.1 7847.8 7856.6 7857.8 7856.1 7865.0 7882.3 7904.3 7907.1 7763.2 7814.4 7816.4 7847.0 7856.4 7875.4 7952.4 7953.6 7957.0 7966.3 38427.4 38612.6 38706.6 38900.2 38921.4 2997.2 3136.0 3170.5 3191.2 3588.3 26123.3 29933.0 30135.0 30261.7 30933.8 2987.9 3087.8 3115.2 3128.4 3187.0 254289.0 254795.0 256515.0 257119.0 257497.0 54506.5 54893.0 54894.0 54905.5 54923.2 33634.2 34331.8 34602.7 36187.3 36208.8 15526.5 15620.2 15668.2 15694.5 15694.9 12005.5 12085.3 12102.4 12105.5 12116.1 18752.4 18849.0 18851.6 18863.5 18866.8 6792.8 6876.8 6889.9 6996.4 7117.5 790.6 841.3 877.1 877.3 953.3 27118.7 27858.6 28237.6 28556.1 28702.1 973.9 1011.3 1039.0 1043.3 1054.0 14656.9 14778.9 14887.9 14961.5 15111.4 373391.0 375304.0 376848.0 378575.0 381133.0 48519.0 49062.8 49163.3 49195.8 49196.0 1056.2 1168.2 1187.2 1199.8 1203.4 28201.3 29142.4 29166.7 29607.0 30068.4 41555.6 41562.2 42078.4 42115.0 42148.8 297190.0 297554.0 298231.0 300116.0 300836.0 22294.6 24658.9 25399.7 25432.5 26749.6 41077.0 41364.2 41811.4 42322.8 42711.4 35370.0 35457.6 36182.1 36588.0 36890.8 36261.5 36373.0 36451.5 36511.5 36712.0 35105.8 35171.8 36184.3 37145.0 37287.8 29844.2 31719.4 31974.5 32094.8 32110.0 24740.4 24801.3 25146.0 25522.5 26032.0 05:09:53 INFO - PROCESS | 3784 | 05:09:53 INFO - PROCESS | 3784 | [#2] jquery.html Cycles:180 Average:25239.39 Median:5384.02 stddev:69394.05 (1288.9%) stddev-sans-first:69563.54 05:09:53 INFO - PROCESS | 3784 | Values: 342.6 361.9 362.7 364.5 378.9 12927.3 13872.3 14466.2 17549.9 17566.6 14188.0 15661.7 16488.8 16500.3 17310.6 4731.2 4858.6 4863.1 4866.1 4869.8 3524.9 5720.4 6006.1 6012.3 6140.7 5381.6 6046.5 6052.1 6065.6 6076.2 5584.2 5597.8 5610.5 5626.4 5629.7 5332.1 5386.4 5438.9 5443.3 5487.5 12912.3 13102.9 13114.6 13137.9 18163.0 1851.1 1851.2 1863.8 1881.2 1895.9 9269.6 9277.4 9514.2 9623.9 9964.6 1700.5 1771.1 1823.8 1829.3 1850.5 68895.3 71581.3 73327.6 73529.0 73547.3 10201.7 10258.1 10340.1 10566.8 10582.4 14177.9 14260.4 14266.6 14286.2 14297.1 7296.0 7473.3 7526.5 7598.7 7617.8 6980.9 7080.0 7219.7 7233.5 7245.4 4360.6 4500.3 4520.4 4591.6 4635.4 1835.6 1865.3 1875.5 1886.0 1938.4 749.7 795.7 813.3 879.9 896.8 16479.2 17772.6 18935.7 19154.5 19450.0 858.7 896.6 911.4 912.6 922.1 9715.8 9772.3 9875.9 9950.3 10097.8 394093.0 417080.0 426060.0 427473.0 431225.0 83862.0 84059.0 84541.0 88280.0 88371.6 947.3 951.9 969.2 974.0 975.0 15550.4 15611.8 15687.8 16149.0 16210.8 28162.4 29106.8 38093.4 39037.4 41111.6 51188.7 53521.7 54477.7 55150.4 55520.2 4983.8 6907.5 6983.0 7161.1 7489.2 9015.5 11174.4 11450.2 11454.3 11529.2 9616.5 9720.6 9812.4 9863.4 9998.5 9116.0 9358.2 9389.0 9885.0 9980.3 10062.9 10122.7 10164.4 10309.8 10600.0 7227.5 7247.3 7280.6 7294.4 7305.8 7424.4 8826.3 9801.1 9834.6 9926.0 05:09:53 INFO - PROCESS | 3784 | 05:09:53 INFO - PROCESS | 3784 | [#3] mootools.html Cycles:180 Average:5199.68 Median:5246.59 stddev:2929.87 (55.8%) stddev-sans-first:2923.04 05:09:53 INFO - PROCESS | 3784 | Values: 1249.1 1317.7 1385.9 1390.9 1636.6 6730.3 7633.5 7869.3 7874.3 8157.9 7835.6 7905.4 7929.6 7942.7 7950.9 2212.2 2232.8 2239.2 2241.0 2243.0 2194.9 2223.8 2231.5 2231.9 2242.1 2209.9 2211.3 2221.0 2227.5 2253.9 2164.6 2180.2 2187.3 2192.6 2193.0 2165.9 2171.1 2175.2 2175.3 2175.8 7781.0 7917.2 7929.4 7960.9 7964.0 4491.6 4595.3 4693.2 4699.8 4704.2 2685.5 2751.2 2827.0 2843.9 2847.0 907.2 908.0 908.7 912.9 931.7 10206.1 10346.6 10363.7 10365.8 10391.2 3888.2 4091.1 4189.4 4199.1 4254.3 8920.4 8958.0 8966.4 8975.8 8991.5 4662.0 4665.6 4666.0 4666.2 4671.8 3724.6 4158.6 4237.7 4237.9 4335.8 3633.8 3732.9 3799.4 3833.3 3863.6 1191.6 1196.5 1202.5 1205.0 1217.7 791.9 831.1 846.8 849.2 867.2 5078.5 5240.7 5293.7 5391.4 5421.0 411.3 411.6 413.4 418.2 916.4 3227.2 3562.7 3741.5 3779.8 3898.0 9456.8 9711.7 9800.4 9925.3 9937.9 9742.8 9816.4 9823.0 9842.6 9844.8 7305.1 7380.9 7450.3 7462.3 7562.4 5252.5 5261.9 5319.0 5409.9 5433.9 9014.9 9097.8 9137.5 9154.1 9360.3 9079.2 9406.1 9438.1 9539.7 9548.7 6197.5 6543.6 6711.5 6872.6 6998.0 7783.9 7790.5 7865.3 7872.1 7872.1 6877.4 6986.8 7057.9 7171.0 7182.4 6738.6 6742.0 6791.5 6848.2 6894.3 6412.5 6478.2 6492.9 6685.0 6689.0 4688.7 4696.3 4720.1 4744.1 4783.4 4860.2 4886.3 4905.6 4957.2 4961.4 05:09:53 INFO - PROCESS | 3784 | 05:09:53 INFO - PROCESS | 3784 | [#4] prototype.html Cycles:180 Average:4110.27 Median:4559.28 stddev:1203.82 (26.4%) stddev-sans-first:1172.69 05:09:53 INFO - PROCESS | 3784 | Values: 297.8 300.5 303.3 307.7 308.9 4843.7 4846.0 4857.5 4884.8 4902.2 4834.9 4837.0 4839.8 4847.3 4855.0 3792.2 3819.2 3821.3 3843.8 3851.9 3572.2 3782.0 3855.9 3872.2 3892.5 3726.2 3740.9 3745.8 3755.8 3756.3 3731.7 3734.8 3736.2 3747.9 3751.0 3121.0 3170.1 3255.9 3263.8 3316.4 4618.3 4651.5 4655.5 4661.3 4673.0 4213.8 4242.8 4243.7 4255.8 4275.9 4778.9 4846.2 4982.4 5006.7 5018.0 3559.8 3571.4 3573.8 3587.5 3587.7 5234.3 5259.5 5294.9 5298.5 5319.6 3586.9 3660.8 3671.4 3672.4 3674.9 3708.8 3709.2 3727.5 3735.5 3746.6 4249.1 4264.7 4267.9 4279.3 4288.3 4857.4 5003.0 5008.3 5039.6 5053.3 1263.5 1277.7 1281.8 1282.5 1287.4 813.2 827.2 841.5 842.6 843.0 3991.9 4009.5 4010.4 4053.9 4063.7 4540.9 4544.8 4553.7 4556.3 4562.3 4042.3 4046.9 4065.4 4073.2 4090.2 2316.0 2438.8 2447.5 2460.6 2463.9 4389.9 4402.7 4408.1 4416.6 4423.7 4675.2 4675.8 4678.1 4685.3 4705.7 4402.3 4410.7 4682.2 5006.4 5018.7 5223.1 5245.9 5247.4 5252.2 5263.3 5143.8 5153.8 5160.4 5175.2 5175.3 4888.7 4964.4 4996.5 5005.6 5009.4 3687.6 3696.1 3702.0 3712.2 3723.1 5211.6 5236.7 5236.9 5246.9 5252.8 4852.2 5048.9 5054.5 5061.3 5088.2 5028.5 5070.8 5074.2 5081.7 5083.9 4968.4 4990.1 4996.3 5026.9 5028.9 4856.8 4931.6 4964.6 4999.9 5079.8 4928.7 4943.5 4943.7 4959.3 4962.4 05:09:53 INFO - PROCESS | 3784 | 05:09:53 INFO - PROCESS | 3784 | [#5] yui.html Cycles:180 Average:17212.59 Median:57720.07 stddev:24980.17 (43.3%) stddev-sans-first:25018.98 05:09:53 INFO - PROCESS | 3784 | Values: 565.6 594.5 621.0 673.6 710.9 12456.3 13504.3 13516.1 13522.3 13705.1 12973.1 13222.3 13227.2 13237.9 13243.7 626.9 764.8 778.1 788.8 798.7 779.5 784.2 785.9 786.1 786.7 847.2 847.7 848.4 848.8 849.8 653.8 806.3 820.0 827.9 829.3 607.6 614.3 615.6 616.2 616.8 12893.4 12918.0 12940.7 12945.5 12948.2 11784.5 12112.7 12200.8 12210.9 12579.6 11144.6 11279.7 11376.7 11532.8 11807.1 3905.5 3981.2 3990.4 4059.8 4081.0 56549.2 57435.1 57454.4 57691.0 57749.1 9413.8 9492.6 9531.4 9582.7 9590.7 17526.2 18125.4 18744.2 18900.6 18909.7 6861.2 6870.2 6907.3 7047.0 7080.9 3727.7 3824.4 3852.5 3866.1 3929.5 2765.5 2865.5 2868.5 2869.8 2870.4 443.6 457.9 495.2 503.2 507.1 435.4 438.6 476.8 500.3 508.8 7581.7 8117.8 8242.6 8393.3 8462.7 486.3 492.5 509.1 514.9 531.3 3707.0 3889.7 3901.6 3986.2 4078.0 60926.4 62109.7 65991.7 106115.0 106346.5 87000.6 88346.0 89630.6 90692.5 91157.0 48719.8 60645.1 81849.0 82228.2 82718.8 7170.8 7280.4 7493.7 7535.8 7653.9 47495.3 48464.3 49406.0 49488.3 49847.8 68811.0 70109.3 71396.3 71788.6 73000.6 9789.2 10050.1 10050.7 10127.2 10290.1 11309.5 11324.1 11424.3 11746.5 11747.9 8657.3 8811.6 8945.0 9213.1 9313.9 9346.3 9363.3 9374.7 9442.0 9481.8 9749.6 10143.3 10227.7 10320.3 10488.5 8552.4 8561.8 8574.8 8663.9 8921.1 8417.4 8544.0 8602.8 8621.8 8689.2 05:09:53 INFO - PROCESS | 3784 | -------- Summary: end -------- 05:09:53 INFO - PROCESS | 3784 | 05:09:54 INFO - TEST-INFO | 3784: exit 0 05:09:54 INFO - TEST-OK | dromaeo_css | took 1118323ms 05:09:54 INFO - TEST-START | kraken 05:09:54 INFO - operating with platform_type : linux_ 05:09:54 INFO - Initialising browser for kraken test... 05:09:54 INFO - TEST-INFO | started process 3974 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFeFmhY/profile http://localhost:60606/getInfo.html) 05:09:58 INFO - PROCESS | 3974 | __metrics Screen width/height:1600/1200 05:09:58 INFO - PROCESS | 3974 | colorDepth:24 05:09:58 INFO - PROCESS | 3974 | Browser inner width/height: 1024/697 05:09:58 INFO - PROCESS | 3974 | __metrics 05:09:58 INFO - PROCESS | 3974 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:09:58 INFO - PROCESS | 3974 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:09:59 INFO - TEST-INFO | 3974: exit 0 05:09:59 INFO - Browser initialized. 05:09:59 INFO - Running cycle 1/1 for kraken test... 05:09:59 INFO - TEST-INFO | started process 4057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFeFmhY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:10:11 INFO - PROCESS | 4057 | RSS: Main: 158932992 05:10:11 INFO - PROCESS | 4057 | 05:10:14 INFO - PROCESS | 4057 | Cycle 1(1): loaded http://localhost:60606/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60606/tests/kraken/driver.html?testName=audio-beat-detection) 05:10:15 INFO - PROCESS | 4057 | RSS: Main: 217358336 05:10:15 INFO - PROCESS | 4057 | 05:10:18 INFO - PROCESS | 4057 | Cycle 1(1): loaded http://localhost:60606/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60606/tests/kraken/driver.html?testName=audio-dft) 05:10:18 INFO - PROCESS | 4057 | RSS: Main: 205139968 05:10:18 INFO - PROCESS | 4057 | 05:10:21 INFO - PROCESS | 4057 | Cycle 1(1): loaded http://localhost:60606/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60606/tests/kraken/driver.html?testName=audio-fft) 05:10:22 INFO - PROCESS | 4057 | RSS: Main: 271699968 05:10:22 INFO - PROCESS | 4057 | 05:10:24 INFO - PROCESS | 4057 | Cycle 1(1): loaded http://localhost:60606/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60606/tests/kraken/driver.html?testName=audio-oscillator) 05:10:25 INFO - PROCESS | 4057 | RSS: Main: 181731328 05:10:25 INFO - PROCESS | 4057 | 05:10:27 INFO - PROCESS | 4057 | Cycle 1(1): loaded http://localhost:60606/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60606/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:10:28 INFO - PROCESS | 4057 | RSS: Main: 186265600 05:10:28 INFO - PROCESS | 4057 | 05:10:31 INFO - PROCESS | 4057 | Cycle 1(1): loaded http://localhost:60606/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60606/tests/kraken/driver.html?testName=imaging-darkroom) 05:10:31 INFO - PROCESS | 4057 | RSS: Main: 221925376 05:10:31 INFO - PROCESS | 4057 | 05:10:35 INFO - PROCESS | 4057 | Cycle 1(1): loaded http://localhost:60606/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60606/tests/kraken/driver.html?testName=imaging-desaturate) 05:10:36 INFO - PROCESS | 4057 | RSS: Main: 217755648 05:10:36 INFO - PROCESS | 4057 | 05:10:38 INFO - PROCESS | 4057 | Cycle 1(1): loaded http://localhost:60606/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60606/tests/kraken/driver.html?testName=json-parse-financial) 05:10:39 INFO - PROCESS | 4057 | RSS: Main: 221081600 05:10:39 INFO - PROCESS | 4057 | 05:10:41 INFO - PROCESS | 4057 | Cycle 1(1): loaded http://localhost:60606/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60606/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:10:41 INFO - PROCESS | 4057 | RSS: Main: 207953920 05:10:41 INFO - PROCESS | 4057 | 05:10:43 INFO - PROCESS | 4057 | Cycle 1(1): loaded http://localhost:60606/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60606/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:10:44 INFO - PROCESS | 4057 | RSS: Main: 212819968 05:10:44 INFO - PROCESS | 4057 | 05:10:46 INFO - PROCESS | 4057 | Cycle 1(1): loaded http://localhost:60606/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60606/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:10:47 INFO - PROCESS | 4057 | RSS: Main: 210210816 05:10:47 INFO - PROCESS | 4057 | 05:10:49 INFO - PROCESS | 4057 | Cycle 1(1): loaded http://localhost:60606/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:10:50 INFO - PROCESS | 4057 | RSS: Main: 227688448 05:10:50 INFO - PROCESS | 4057 | 05:10:53 INFO - PROCESS | 4057 | Cycle 1(1): loaded http://localhost:60606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:10:54 INFO - PROCESS | 4057 | RSS: Main: 225476608 05:10:54 INFO - PROCESS | 4057 | 05:10:55 INFO - PROCESS | 4057 | Cycle 1(1): loaded http://localhost:60606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60606/tests/kraken/driver.html?testName=ai-astar) 05:10:56 INFO - PROCESS | 4057 | RSS: Main: 266625024 05:10:56 INFO - PROCESS | 4057 | 05:10:56 INFO - PROCESS | 4057 | __start_tp_report 05:10:56 INFO - PROCESS | 4057 | _x_x_mozilla_page_load 05:10:56 INFO - PROCESS | 4057 | _x_x_mozilla_page_load_details 05:10:56 INFO - PROCESS | 4057 | |i|pagename|runs| 05:10:56 INFO - PROCESS | 4057 | |0;ai-astar;103;113;113;113;114;113;112;113;114;111 05:10:56 INFO - PROCESS | 4057 | |1;audio-beat-detection;155;122;123;176;130;125;148;122;154;126 05:10:56 INFO - PROCESS | 4057 | |2;audio-dft;161;160;161;161;160;161;162;163;160;160 05:10:56 INFO - PROCESS | 4057 | |3;audio-fft;76;76;75;105;77;77;76;74;100;77 05:10:56 INFO - PROCESS | 4057 | |4;audio-oscillator;85;85;122;85;84;84;121;85;84;129 05:10:56 INFO - PROCESS | 4057 | |5;imaging-gaussian-blur;118;117;117;117;116;117;117;116;116;117 05:10:56 INFO - PROCESS | 4057 | |6;imaging-darkroom;147;147;147;147;145;146;147;147;146;146 05:10:56 INFO - PROCESS | 4057 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;94 05:10:56 INFO - PROCESS | 4057 | |8;json-parse-financial;66;66;65;65;74;65;66;65;66;65 05:10:56 INFO - PROCESS | 4057 | |9;json-stringify-tinderbox;65;66;65;65;67;66;66;65;65;65 05:10:56 INFO - PROCESS | 4057 | |10;stanford-crypto-aes;79;80;78;78;79;79;77;78;79;82 05:10:56 INFO - PROCESS | 4057 | |11;stanford-crypto-ccm;133;130;128;135;131;140;127;126;164;132 05:10:56 INFO - PROCESS | 4057 | |12;stanford-crypto-pbkdf2;164;170;164;164;164;163;163;163;162;164 05:10:56 INFO - PROCESS | 4057 | |13;stanford-crypto-sha256-iterative;71;65;69;67;68;65;66;66;65;66 05:10:56 INFO - PROCESS | 4057 | __end_tp_report 05:10:56 INFO - PROCESS | 4057 | __start_cc_report 05:10:56 INFO - PROCESS | 4057 | _x_x_mozilla_cycle_collect,1922 05:10:56 INFO - PROCESS | 4057 | __end_cc_report 05:10:56 INFO - PROCESS | 4057 | __startTimestamp1468498256018__endTimestamp 05:10:56 INFO - PROCESS | 4057 | 05:10:56 INFO - PROCESS | 4057 | ------- Summary: start ------- 05:10:56 INFO - PROCESS | 4057 | Number of tests: 14 05:10:56 INFO - PROCESS | 4057 | 05:10:56 INFO - PROCESS | 4057 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.25 (2.9%) stddev-sans-first:0.93 05:10:56 INFO - PROCESS | 4057 | Values: 103.0 113.0 113.0 113.0 114.0 113.0 112.0 113.0 114.0 111.0 05:10:56 INFO - PROCESS | 4057 | 05:10:56 INFO - PROCESS | 4057 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:139.00 stddev:18.86 (13.6%) stddev-sans-first:18.99 05:10:56 INFO - PROCESS | 4057 | Values: 155.0 122.0 123.0 176.0 130.0 125.0 148.0 122.0 154.0 126.0 05:10:56 INFO - PROCESS | 4057 | 05:10:56 INFO - PROCESS | 4057 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 05:10:56 INFO - PROCESS | 4057 | Values: 161.0 160.0 161.0 161.0 160.0 161.0 162.0 163.0 160.0 160.0 05:10:56 INFO - PROCESS | 4057 | 05:10:56 INFO - PROCESS | 4057 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:11.27 (14.8%) stddev-sans-first:11.79 05:10:56 INFO - PROCESS | 4057 | Values: 76.0 76.0 75.0 105.0 77.0 77.0 76.0 74.0 100.0 77.0 05:10:56 INFO - PROCESS | 4057 | 05:10:56 INFO - PROCESS | 4057 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:84.50 stddev:19.16 (22.7%) stddev-sans-first:19.87 05:10:56 INFO - PROCESS | 4057 | Values: 85.0 85.0 122.0 85.0 84.0 84.0 121.0 85.0 84.0 129.0 05:10:56 INFO - PROCESS | 4057 | 05:10:56 INFO - PROCESS | 4057 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.50 05:10:56 INFO - PROCESS | 4057 | Values: 118.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 05:10:56 INFO - PROCESS | 4057 | 05:10:56 INFO - PROCESS | 4057 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 05:10:56 INFO - PROCESS | 4057 | Values: 147.0 147.0 147.0 147.0 145.0 146.0 147.0 147.0 146.0 146.0 05:10:56 INFO - PROCESS | 4057 | 05:10:56 INFO - PROCESS | 4057 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:10:56 INFO - PROCESS | 4057 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 05:10:56 INFO - PROCESS | 4057 | 05:10:56 INFO - PROCESS | 4057 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.00 stddev:2.75 (4.2%) stddev-sans-first:2.92 05:10:56 INFO - PROCESS | 4057 | Values: 66.0 66.0 65.0 65.0 74.0 65.0 66.0 65.0 66.0 65.0 05:10:56 INFO - PROCESS | 4057 | 05:10:56 INFO - PROCESS | 4057 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 05:10:56 INFO - PROCESS | 4057 | Values: 65.0 66.0 65.0 65.0 67.0 66.0 66.0 65.0 65.0 65.0 05:10:56 INFO - PROCESS | 4057 | 05:10:56 INFO - PROCESS | 4057 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:1.37 (1.7%) stddev-sans-first:1.45 05:10:56 INFO - PROCESS | 4057 | Values: 79.0 80.0 78.0 78.0 79.0 79.0 77.0 78.0 79.0 82.0 05:10:56 INFO - PROCESS | 4057 | 05:10:56 INFO - PROCESS | 4057 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:132.50 stddev:11.12 (8.4%) stddev-sans-first:11.78 05:10:56 INFO - PROCESS | 4057 | Values: 133.0 130.0 128.0 135.0 131.0 140.0 127.0 126.0 164.0 132.0 05:10:56 INFO - PROCESS | 4057 | 05:10:56 INFO - PROCESS | 4057 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:164.00 stddev:2.18 (1.3%) stddev-sans-first:2.32 05:10:56 INFO - PROCESS | 4057 | Values: 164.0 170.0 164.0 164.0 164.0 163.0 163.0 163.0 162.0 164.0 05:10:56 INFO - PROCESS | 4057 | 05:10:56 INFO - PROCESS | 4057 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.50 stddev:1.99 (3.0%) stddev-sans-first:1.41 05:10:56 INFO - PROCESS | 4057 | Values: 71.0 65.0 69.0 67.0 68.0 65.0 66.0 66.0 65.0 66.0 05:10:56 INFO - PROCESS | 4057 | -------- Summary: end -------- 05:10:56 INFO - PROCESS | 4057 | 05:10:57 INFO - TEST-INFO | 4057: exit 0 05:10:57 INFO - TEST-OK | kraken | took 62637ms 05:10:57 INFO - SUITE-END | took 1180s 05:10:57 INFO - Completed test suite (00:19:41) 05:10:57 INFO - javascript benchmark 05:10:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2631.3816253180507, 2642.960355594668, 2674.2645772412584, 2683.114572191177, 2690.0315886280937, 4571.862844114674, 4623.445186577607, 4635.165670179366, 4675.859724208275, 4681.344611754357, 4655.86032419028, 4733.313669517918, 4735.479097299294, 4794.041191761644, 4794.976025119879, 4316.20150272199, 4345.087531618348, 4345.608895199432, 4397.494288156871, 4458.219811532985, 4409.955900441003, 4441.555844415549, 4478.888027799315, 4496.303073023687, 4496.887577810565, 4185.91628167438, 4252.340887162495, 4324.783760811947, 4329.718568293082, 4419.18245124653, 4247.91504169918, 4326.09152078064, 4338.089001309729, 4340.934885976713, 4347.152305300468, 4327.7619730914785, 4329.588689074533, 4338.370936214263, 4365.672574556921, 4377.562243775629, 4491.483479399878, 4526.93209601853, 4752.1683705351425, 4755.310479980383, 4785.569298763093, 5006.0, 5039.0, 5061.291419201315, 5110.080185566597, 5111.872203194913, 5115.181570948667, 5152.098382782998, 5158.871028224287, 5159.690418574897, 5169.4572069932865, 4551.7724113794175, 4683.2038553446, 4750.738709370983, 4810.278458231293, 4812.446568644581, 5152.845414637567, 5183.144781111075, 5208.583313335, 5254.238135470412, 5265.631405801557, 4989.376327959005, 5032.647714660012, 5044.571211447068, 5044.722540260321, 5047.495250474996, 4889.315495830587, 4932.580730637936, 4991.80032798684, 5138.511841375063, 5145.948540514547, 4967.503249675004, 4973.452920178777, 5003.0, 5007.173816320339, 5017.874553136201, 4928.457869634337, 4933.4819843915875, 4935.037667654773, 4941.75291235444, 4982.975085124624, 4175.185838761473, 4220.219259436953, 4235.7035007549175, 4245.893852653647, 4292.334688123346, 3718.0, 3737.588865224823, 3749.7187710921244, 3760.9811950940616, 3813.961860381416, 4395.516493185747, 4404.075144219686, 4404.889877753082, 4433.911321773547, 4444.73331600105, 4809.519048095162, 5057.873553161126, 5072.594192464594, 5076.796928122908, 5105.693658380509, 4279.593438623326, 4301.268784306675, 4306.612404883575, 4314.784260786948, 4316.460442444694, 4489.147062058199, 4522.095580883836, 4524.479684836286, 4526.0, 4550.613197878151, 4670.276107203389, 4777.474477807369, 4780.235162374003, 4782.306565548046, 4820.132376172252, 5053.8736531587, 5113.079645663816, 5124.692518448905, 5130.256112863689, 5136.203888397305, 4873.805047798191, 4876.5854902333695, 4879.146149423766, 4880.243562247857, 4933.309336692794, 4854.0, 4992.350994370709, 5056.721880296472, 5064.6961182327705, 5099.36257967754, 5066.06277838601, 5140.922886156636, 5163.896722065613, 5165.405978312542, 5217.765200566059, 5014.674046186986, 5019.171836647059, 5025.47232540578, 5030.044291584587, 5072.1123803335, 4785.401824771903, 4893.486183950634, 4947.431045429822, 5005.774740136775, 5020.397552293748, 4876.731779752005, 4882.6826256293225, 4900.852974410774, 4936.185529387611, 4941.579965702956, 5001.8499445016705, 5002.0, 5003.799848006039, 5010.824621138243, 5037.596992240538, 4684.5549672781035, 4719.126961511994, 4838.104950584153, 4905.9018819624125, 4939.061578300111], "value": 4651.390480667575, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.1703529881672, 572.1732097119661, 583.238873270382, 584.3163498706513, 586.9757273557642, 27586.862065689667, 29820.701792982065, 29911.700882991165, 30021.699783002136, 31545.369092618133, 38123.618763812425, 41991.58008419915, 42079.0, 42087.0, 42097.0, 7807.45347825651, 7931.762047138566, 7937.761867143995, 7938.364930805551, 7961.7213397531095, 7757.961210193941, 7832.060152781674, 7847.843043139133, 7856.646450909723, 7857.803554911145, 7856.057273127204, 7864.960675196616, 7882.330001949841, 7904.328132108778, 7907.051153861545, 7763.184865589088, 7814.413918956101, 7816.413768967293, 7846.960765196138, 7856.4107691923045, 7875.369970402354, 7952.403569732293, 7953.642086106139, 7956.960215198945, 7966.28303452692, 38427.42358864619, 38612.613873861184, 38706.61293387058, 38900.22199555993, 38921.41617875734, 2997.1757766614137, 3136.0121561708215, 3170.4927211646027, 3191.1543440988157, 3588.2644057968314, 26123.346916327053, 29933.0, 30135.0, 30261.69738302611, 30933.845330773427, 2987.910362689101, 3087.7992930459673, 3115.2367669920786, 3128.389963957029, 3187.0279564732746, 254289.0, 254795.0, 256515.0, 257119.0, 257497.0, 54506.454935450136, 54893.0, 54894.0, 54905.45094549083, 54923.176152357744, 33634.159146021055, 34331.76843505164, 34602.653973460445, 36187.27625447529, 36208.81895590505, 15526.534203973899, 15620.218989050729, 15668.216589170725, 15694.450694225876, 15694.9215253923, 12005.519779208735, 12085.274883506841, 12102.394880255952, 12105.515779368903, 12116.09129315305, 18752.437426877215, 18849.0, 18851.622967540574, 18863.52841178954, 18866.81133188678, 6792.796216113525, 6876.759313424006, 6889.896651550231, 6996.405305548984, 7117.537360071578, 790.5691398188002, 841.2765022081005, 877.1404024056333, 877.2630989968458, 953.2993249961273, 27118.728812712015, 27858.5821212682, 28237.576436353473, 28556.143315700563, 28702.138935831957, 973.8831340239217, 1011.3123076308034, 1038.9766080410789, 1043.3062013760916, 1053.9934362683618, 14656.853431465763, 14778.926105369404, 14887.851121488864, 14961.476348327757, 15111.395544178109, 373391.0, 375304.0, 376848.0, 378575.0, 381133.0, 48519.0, 49062.754686227054, 49163.31275154378, 49195.754021229666, 49196.0, 1056.2131212246773, 1168.1881092640533, 1187.1749134351542, 1199.8080307150815, 1203.4404002139047, 28201.294967625974, 29142.41715165727, 29166.708332916398, 29607.0, 30068.398632027674, 41555.584444155174, 41562.168756624094, 42078.36882446827, 42115.0, 42148.78925605475, 297190.0, 297554.0, 298231.0, 300116.0, 300836.0, 22294.554108917408, 24658.876705616356, 25399.746002540476, 25432.491350173263, 26749.598756019066, 41077.0, 41364.1727165449, 41811.37282940819, 42322.78838605787, 42711.35932960946, 35370.0, 35457.64542354647, 36182.09544761402, 36588.0, 36890.8155459221, 36261.456078159375, 36373.0, 36451.45322820213, 36511.45232821563, 36712.0, 35105.824470878506, 35171.82414087913, 36184.276314473034, 37145.0, 37287.81356093311, 29844.164804343553, 31719.365612688078, 31974.52038219382, 32094.839525803156, 32110.0, 24740.38149046288, 24801.25596232116, 25146.0, 25522.489550209262, 26032.0], "value": 17267.177505190855, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.6385163652346, 361.90047736872356, 362.67721727662376, 364.48425477948695, 378.93368660484407, 12927.288999105045, 13872.306384680776, 14466.204358760277, 17549.91225043873, 17566.648667026653, 14188.0, 15661.686766264667, 16488.752668709978, 16500.25748841302, 17310.56723581911, 4731.219348807443, 4858.5627293543575, 4863.14894893394, 4866.148424025799, 4869.829555965542, 3524.9295014099703, 5720.370759216483, 6006.129111278862, 6012.338642749294, 6140.692965351737, 5381.623286369956, 6046.54650901182, 6052.061930400773, 6065.636061836304, 6076.240469941257, 5584.246126772895, 5597.776088956437, 5610.523105536035, 5626.352969408509, 5629.662220266756, 5332.120200166968, 5386.407495175527, 5438.891222175574, 5443.319585051869, 5487.451254874521, 12912.289824059673, 13102.86897131026, 13114.60656180316, 13137.934310328483, 18163.0, 1851.0559614596518, 1851.1669748613178, 1863.7577114975102, 1881.1816859665953, 1895.933642322512, 9269.629214831466, 9277.396969196981, 9514.191293740041, 9623.90376096237, 9964.551595178162, 1700.4898530440819, 1771.052486919492, 1823.7537932379225, 1829.2865782344895, 1850.5281153305955, 68895.31104688939, 71581.28418715799, 73327.63336183339, 73529.0, 73547.26452735458, 10201.693949181536, 10258.076773090308, 10340.12108970746, 10566.788664226673, 10582.417967011734, 14177.85822141786, 14260.42958281657, 14266.643333916527, 14286.214258215898, 14297.142171469744, 7295.963520182471, 7473.327400533978, 7526.473146879775, 7598.658060387296, 7617.847643047108, 6980.860382792316, 7080.044194033842, 7219.675114619855, 7233.493655444068, 7245.384142347854, 4360.607545320936, 4500.257457519473, 4520.434945631796, 4591.632669386441, 4635.443746750411, 1835.6328734253202, 1865.2538984406074, 1875.5311172206948, 1885.9622807543772, 1938.4184744576853, 749.6589051981335, 795.6857041468587, 813.3452570680658, 879.9340049496185, 896.7533928169674, 16479.176041197894, 17772.55568610795, 18935.715964260547, 19154.52113697169, 19450.0, 858.6865793985276, 896.6010125494223, 911.4485736129546, 912.5528491039476, 922.0548937339281, 9715.757106072264, 9772.267079969031, 9875.901240987641, 9950.303478756417, 10097.798044039078, 394093.0, 417080.0, 426060.0, 427473.0, 431225.0, 83862.0, 84059.0, 84541.0, 88279.96367736808, 88371.55814220887, 947.2516711797603, 951.8952915179464, 969.2149359019216, 973.9659111931048, 974.9512524373753, 15550.377984880479, 15611.843881561039, 15687.764683529527, 16149.0, 16210.837891621404, 28162.436751265268, 29106.835726571546, 38093.42859857049, 39037.41443878287, 41111.58888411077, 51188.74405627948, 53521.73239133779, 54477.72761136169, 55150.44849551453, 55520.16719749126, 4983.750812459435, 6907.481938854506, 6983.022376867141, 7161.140663120459, 7489.15412143382, 9015.549222538715, 11174.385408802595, 11450.198486106226, 11454.312741235553, 11529.1929564933, 9616.51917404113, 9720.593546982505, 9812.362196457207, 9863.408195508293, 9998.500074996367, 9115.997240303694, 9358.15776580111, 9388.95305523468, 9885.034489653219, 9980.301378903407, 10062.89937100649, 10122.746931326776, 10164.390136591532, 10309.793804124025, 10600.0, 7227.49407541467, 7247.311505406978, 7280.5995670236525, 7294.379977701955, 7305.817354566178, 7424.368928641126, 8826.338024648048, 9801.068898454636, 9834.606615735576, 9925.950370248103], "value": 8143.502507317604, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1249.0569619936946, 1317.7101037771693, 1385.9168449893007, 1390.8748212660857, 1636.64812065406, 6730.259671436144, 7633.541987480755, 7869.331106855924, 7874.330681892039, 8157.877631835512, 7835.569043702609, 7905.446618736676, 7929.563873986928, 7942.682292708299, 7950.880736788953, 2212.214663794358, 2232.787885150908, 2239.216274303989, 2241.0, 2243.046705150313, 2194.9231776887814, 2223.810976067028, 2231.4532939429864, 2231.8995645196005, 2242.0583354990863, 2209.9116035358566, 2211.3476524425255, 2220.955580888381, 2227.454273702945, 2253.864768113918, 2164.621191291518, 2180.2478145040095, 2187.300063979519, 2192.5614877024577, 2193.035064571591, 2165.8917054147228, 2171.1098449635574, 2175.184305885293, 2175.2712841198218, 2175.7824217578273, 7780.961095194488, 7917.247861453153, 7929.405294602928, 7960.880586791202, 7964.044314682217, 4491.573300536444, 4595.264757638795, 4693.155232058228, 4699.78850951708, 4704.200285951397, 2685.503181911353, 2751.2021513760988, 2827.0, 2843.8720257588457, 2846.9893187918406, 907.1880666803174, 908.0499825757967, 908.7182973278304, 912.9315301352425, 931.6785708930475, 10206.081452669296, 10346.63786767467, 10363.689089327332, 10365.792684146274, 10391.220658450571, 3888.183481468923, 4091.059056416981, 4189.392538081961, 4199.139176468817, 4254.255505286563, 8920.375573709778, 8958.0, 8966.372353935161, 8975.820483590292, 8991.505467199368, 4661.953380466152, 4665.580097791215, 4666.043461090469, 4666.2067448533835, 4671.789769460383, 3724.571674257495, 4158.563350848178, 4237.724547904377, 4237.940514871282, 4335.783210839445, 3633.8364773585254, 3732.8880133596035, 3799.3731034379016, 3833.3483307837732, 3863.5943225961432, 1191.6127258640977, 1196.4744950188579, 1202.4709127983658, 1205.048012070472, 1217.6529689038582, 791.9049714034353, 831.0775039705921, 846.8010017645848, 849.1975083546113, 867.2238346679686, 5078.492150784966, 5240.68555886648, 5293.708846013429, 5391.406945236021, 5420.972895135499, 411.3254263008668, 411.59252340183, 413.37167505391636, 418.23880537422207, 916.3631276263067, 3227.2254658881698, 3562.6615471530163, 3741.5136032315627, 3779.7543159694533, 3897.9610203898164, 9456.763580910394, 9711.708648740549, 9800.36297640651, 9925.255605829592, 9937.850932236022, 9742.75643108928, 9816.411015339103, 9823.0, 9842.557084931195, 9844.80310393788, 7305.050343455317, 7380.926190738024, 7450.2549745026145, 7462.328390444777, 7562.357199637982, 5252.501012403815, 5261.868453288698, 5319.0, 5409.918851217313, 5433.9184912225555, 9014.90985090167, 9097.818043639223, 9137.451752894847, 9154.084591540792, 9360.344775865624, 9079.182873541413, 9406.1064198901, 9438.103380178873, 9539.666111686058, 9548.665796697082, 6197.473214776614, 6543.640099794557, 6711.496637752286, 6872.553284036521, 6997.965010174917, 7783.922160778547, 7790.454668173174, 7865.252800983897, 7872.055353357634, 7872.055353357634, 6877.415419689382, 6986.755463558954, 7057.894131587927, 7171.03191069199, 7182.425405967615, 6738.561993470409, 6741.966290168518, 6791.524593278423, 6848.212455567674, 6894.310568943066, 6412.487001039999, 6478.190226221723, 6492.935070649233, 6684.966575167287, 6689.0, 4688.742119183477, 4696.2955556666775, 4720.055988802184, 4744.098621261949, 4783.449903261169, 4860.222364421676, 4886.3403440536495, 4905.558499735041, 4957.157283261926, 4961.3798275215595], "value": 4125.876724228027, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.77369199408446, 300.5281707718881, 303.29030069637054, 307.6646455363653, 308.8548382260337, 4843.685160464567, 4845.951540484594, 4857.4656787753365, 4884.829030983917, 4902.19113846215, 4834.854954351366, 4837.0, 4839.782209800559, 4847.321375007502, 4854.951450485494, 3792.222594368148, 3819.2361527694434, 3821.29306078375, 3843.7885916274595, 3851.9422208666892, 3572.2319701264223, 3781.9810900945595, 3855.9421608675893, 3872.244912242114, 3892.4550562921213, 3726.2486631283255, 3740.8503659853573, 3745.8127093645344, 3755.793431361274, 3756.3238617049055, 3731.6828069614116, 3734.7572407793405, 3736.1593641430595, 3747.9437808432895, 3750.962490375116, 3121.0, 3170.1282147409415, 3255.9348813023844, 3263.7552183586326, 3316.4196265653413, 4618.2610782275015, 4651.465081515636, 4655.534446555352, 4661.300804879295, 4672.953270467286, 4213.831446742127, 4242.787860606988, 4243.663246077475, 4255.8084886180195, 4275.935860962088, 4778.928316075262, 4846.200376937801, 4982.352294201731, 5006.74966251686, 5017.974910125426, 3559.750817442754, 3571.428571428559, 3573.803440810754, 3587.4798154267746, 3587.712982961357, 5234.26720259164, 5259.500347466985, 5294.867628309323, 5298.549623282026, 5319.601029922733, 3586.9282614347567, 3660.762050466711, 3671.375866102769, 3672.3573374659863, 3674.871379501758, 3708.7589306694977, 3709.183979524554, 3727.459518369821, 3735.458358538051, 3746.550413950343, 4249.107687385684, 4264.6801489888385, 4267.893302667459, 4279.272523670983, 4288.292431748789, 4857.368542089505, 5003.0, 5008.323876276729, 5039.596832253411, 5053.31780209667, 1263.5261776833688, 1277.6678063703505, 1281.8077288406628, 1282.5382862169797, 1287.3884904670206, 813.1502579804, 827.1645637905639, 841.478283464256, 842.5997651115671, 842.9789255268668, 3991.940120898189, 4009.5389030261895, 4010.3783913493453, 4053.8783836484954, 4063.7402405253874, 4540.931886021713, 4544.795484203219, 4553.749543775058, 4556.270996640588, 4562.2891415719105, 4042.312806822847, 4046.866877274368, 4065.3698676705158, 4073.185362927367, 4090.2433049885867, 2315.9884200579227, 2438.7561243875825, 2447.461558457172, 2460.5940019896875, 2463.913763018322, 4389.934150987738, 4402.6571895571515, 4408.096340250241, 4416.580424859633, 4423.734575925455, 4675.228587283128, 4675.83104223944, 4678.105367326239, 4685.344051832746, 4705.6941298816155, 4402.3176407656865, 4410.691251612357, 4682.227432473604, 5006.449290577961, 5018.698878067327, 5223.112070948024, 5245.921311180412, 5247.370315562004, 5252.212168174804, 5263.315768950012, 5143.794248230029, 5153.819616313411, 5160.406553246425, 5175.24041825781, 5175.275461435327, 4888.731119788304, 4964.35463389757, 4996.450390457119, 5005.62457815658, 5009.448960614257, 3687.649673281034, 3696.057505336122, 3702.0, 3712.2018765964367, 3723.1064544509663, 5211.5766168731725, 5236.711980840938, 5236.869078273074, 5246.921296180637, 5252.789888404421, 4852.17513022794, 5048.949510504848, 5054.545090941833, 5061.266116413173, 5088.219123306813, 5028.547430731252, 5070.771815268248, 5074.238864170404, 5081.669691470042, 5083.87290317745, 4968.428630707371, 4990.101781679187, 4996.325496058131, 5026.949730502648, 5028.924566131438, 4856.757162141949, 4931.580815630711, 4964.578010869117, 4999.925001125059, 5079.796808127633, 4928.654994150375, 4943.530364615356, 4943.678660887031, 4959.280904268933, 4962.404511458648], "value": 3730.553328866857, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.6379916853214, 594.4560726934855, 620.9970897001341, 673.5846526021925, 710.8649356622242, 12456.318397016401, 13504.257265850374, 13516.121452105619, 13522.323883805808, 13705.10916790408, 12973.091883568153, 13222.338883055856, 13227.206367617926, 13237.867621323783, 13243.735125297488, 626.9310375858652, 764.8432071425344, 778.0585491555225, 788.7791418402857, 798.656577671601, 779.4660657449665, 784.1687810920414, 785.8624740670389, 786.0645831460572, 786.7010535996313, 847.2374862623657, 847.6736456464275, 848.4018766769412, 848.8472075026493, 849.7790574450656, 653.7711800869705, 806.3146325623233, 819.9836003279901, 827.8592639251342, 829.2992421403904, 607.5564837668483, 614.2843587220882, 615.5875563372551, 616.2050954268988, 616.8087892753216, 12893.419796109103, 12918.0, 12940.741185176337, 12945.482180712761, 12948.223106613634, 11784.469698863486, 12112.697182570419, 12200.816987745191, 12210.938945305306, 12579.622611321674, 11144.60993865219, 11279.67355367791, 11376.658700239006, 11532.769344613062, 11807.055435565135, 3905.511811023622, 3981.243563722883, 3990.4014397840265, 4059.7970101494807, 4081.0409553754844, 56549.151762724, 57435.13847292294, 57454.425455745324, 57691.0, 57749.13376299359, 9413.764655883657, 9492.572834222477, 9531.38046027006, 9582.712518624452, 9590.66432674853, 17526.21132049061, 18125.36561220351, 18744.15651295695, 18900.62198756017, 18909.7163542547, 6861.210960739579, 6870.20992585849, 6907.274736152732, 7047.0, 7080.92919070813, 3727.7204209684382, 3824.4263360495593, 3852.5376954765047, 3866.130120722815, 3929.528456585228, 2765.5160346939206, 2865.498537755884, 2868.4549935512605, 2869.7560707339694, 2870.4402641485126, 443.60519137967236, 457.88095095274804, 495.1804763117047, 503.2426198571127, 507.0644660601185, 435.3817579037774, 438.6074463355279, 476.8079800498753, 500.31207090250905, 508.8117396563295, 7581.658825352873, 8117.837643247102, 8242.587870606445, 8393.279377727551, 8462.661493540189, 486.3045844442411, 492.47059411133176, 509.13313384842064, 514.8738559053056, 531.2588938430945, 3706.9629303707156, 3889.7277190596387, 3901.648851603369, 3986.242613903349, 4078.0, 60926.39073609207, 62109.689451552455, 65991.67004164949, 106115.0, 106346.46826765971, 87000.5649971746, 88346.0, 89630.55184724035, 90692.54653726688, 91157.0, 48719.75640121777, 60645.05807122523, 81849.0, 82228.17771822205, 82718.75921861177, 7170.81290206492, 7280.381167600814, 7493.662785174572, 7535.8116047099265, 7653.923460765321, 47495.287570685774, 48464.27303590378, 49406.0, 49488.25767613561, 49847.750761247415, 68811.0, 70109.29890701231, 71396.28603713897, 71788.64105679438, 73000.6349968268, 9789.216862651114, 10050.145737612385, 10050.69847904564, 10127.24045696561, 10290.12533934594, 11309.491072901574, 11324.08325074331, 11424.314541127558, 11746.471408786454, 11747.941260293645, 8657.307415406627, 8811.603477843384, 8944.99513319157, 9213.078692130734, 9313.860292095489, 9346.299027572823, 9363.29775266844, 9374.718758437259, 9442.008589098321, 9481.762955926157, 9749.561269742737, 10143.289969702346, 10227.693169204937, 10320.277580569287, 10488.528016239135, 8552.444091134057, 8561.785955350917, 8574.828503429771, 8663.870041949249, 8921.107889211027, 8417.410781245255, 8544.0, 8602.78493037679, 8621.827563448822, 8689.175769612712], "value": 6282.175390534704, "unit": "score"}], "name": "dromaeo_css", "value": 6312.152195338459, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 113.0, 113.0, 114.0, 113.0, 112.0, 113.0, 114.0, 111.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 123.0, 176.0, 130.0, 125.0, 148.0, 122.0, 154.0, 126.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 160.0, 161.0, 162.0, 163.0, 160.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 105.0, 77.0, 77.0, 76.0, 74.0, 100.0, 77.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 122.0, 85.0, 84.0, 84.0, 121.0, 85.0, 84.0, 129.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 145.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 74.0, 65.0, 66.0, 65.0, 66.0, 65.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 67.0, 66.0, 66.0, 65.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 78.0, 78.0, 79.0, 79.0, 77.0, 78.0, 79.0, 82.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 128.0, 135.0, 131.0, 140.0, 127.0, 126.0, 164.0, 132.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 170.0, 164.0, 164.0, 164.0, 163.0, 163.0, 163.0, 162.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 65.0, 69.0, 67.0, 68.0, 65.0, 66.0, 66.0, 65.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1522.8999999999999, "alertThreshold": 2.0}]} 05:10:57 INFO - Return code: 0 05:10:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:10:57 INFO - # TBPL SUCCESS # 05:10:57 INFO - Running post-action listener: _resource_record_post_action 05:10:57 INFO - ##### 05:10:57 INFO - ##### Finished run-tests step (success) 05:10:57 INFO - ##### 05:10:57 INFO - Running post-run listener: _resource_record_post_run 05:10:57 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540418048; Read time: 12; Write time: 405000 05:10:57 INFO - TinderboxPrint: CPU usage
13.0% 05:10:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:10:57 INFO - TinderboxPrint: I/O write bytes / time
540,418,048 / 405,000 05:10:57 INFO - TinderboxPrint: CPU idle
8,319.8 (87.0%) 05:10:57 INFO - TinderboxPrint: CPU user
1,202.1 (12.6%) 05:10:57 INFO - TinderboxPrint: Swap in / out
0 / 0 05:10:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246693888; Read time: 0; Write time: 210968 05:10:57 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 289157120; Read time: 0; Write time: 193256 05:10:57 INFO - Running post-run listener: _upload_blobber_files 05:10:57 INFO - Blob upload gear active. 05:10:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:10:57 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 05:10:57 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'] 05:10:57 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 05:10:58 INFO - (blobuploader) - INFO - Open directory for files ... 05:10:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:10:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:10:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:59 INFO - (blobuploader) - INFO - Done attempting. 05:10:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:10:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:10:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:59 INFO - (blobuploader) - INFO - Done attempting. 05:10:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:10:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:11:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:03 INFO - (blobuploader) - INFO - Done attempting. 05:11:03 INFO - (blobuploader) - INFO - Iteration through files over. 05:11:03 INFO - Return code: 0 05:11:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:11:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:11:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e167020fd96e680fa30c145ecefc942992f4a8d36bb7ec0233c0da3c407d1baad51cca4f69be1cb8715e2ae699e9e17df128fc67f8e4655eee4a5eaeddd1a218", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff7f618eae46cbe864798499f6130c1d8190f4ce9ea0b68461181fa251f867312b8d4408c739fd4c38e1ff27ab40ff1fab1bba4aacac62dcce8505c25fbd614d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e48ee0b18f3f94bb2b27baab94fa119a4b616b8be9a236424c93a3b71c6cb8ce661a648882672d5d9940ce2073320247867a9b4e216a46dde5b1e46826e85c03"} 05:11:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:11:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:11:03 INFO - Contents: 05:11:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e167020fd96e680fa30c145ecefc942992f4a8d36bb7ec0233c0da3c407d1baad51cca4f69be1cb8715e2ae699e9e17df128fc67f8e4655eee4a5eaeddd1a218", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff7f618eae46cbe864798499f6130c1d8190f4ce9ea0b68461181fa251f867312b8d4408c739fd4c38e1ff27ab40ff1fab1bba4aacac62dcce8505c25fbd614d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e48ee0b18f3f94bb2b27baab94fa119a4b616b8be9a236424c93a3b71c6cb8ce661a648882672d5d9940ce2073320247867a9b4e216a46dde5b1e46826e85c03"} 05:11:03 INFO - Running post-run listener: copy_logs_to_upload_dir 05:11:03 INFO - Copying logs to upload dir... 05:11:03 INFO - mkdir: /builds/slave/test/build/upload/logs 05:11:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.661981 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-14 05:11:03.107739) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 05:11:03.115488) ========= 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=0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e167020fd96e680fa30c145ecefc942992f4a8d36bb7ec0233c0da3c407d1baad51cca4f69be1cb8715e2ae699e9e17df128fc67f8e4655eee4a5eaeddd1a218", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff7f618eae46cbe864798499f6130c1d8190f4ce9ea0b68461181fa251f867312b8d4408c739fd4c38e1ff27ab40ff1fab1bba4aacac62dcce8505c25fbd614d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e48ee0b18f3f94bb2b27baab94fa119a4b616b8be9a236424c93a3b71c6cb8ce661a648882672d5d9940ce2073320247867a9b4e216a46dde5b1e46826e85c03"} build_url:https://queue.taskcluster.net/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/bTKQF1ofQRmXg7HeOPXt-g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e167020fd96e680fa30c145ecefc942992f4a8d36bb7ec0233c0da3c407d1baad51cca4f69be1cb8715e2ae699e9e17df128fc67f8e4655eee4a5eaeddd1a218", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff7f618eae46cbe864798499f6130c1d8190f4ce9ea0b68461181fa251f867312b8d4408c739fd4c38e1ff27ab40ff1fab1bba4aacac62dcce8505c25fbd614d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e48ee0b18f3f94bb2b27baab94fa119a4b616b8be9a236424c93a3b71c6cb8ce661a648882672d5d9940ce2073320247867a9b4e216a46dde5b1e46826e85c03"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 05:11:03.143198) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:11:03.143560) ========= 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=0333a256a5e4f052382dd180000001b1-1468497025.270177-1225543806 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 05:11:03.224942) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 05:11:03.228289) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 05:11:03.228581) ========= ========= Total master_lag: 0.18 =========