builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1471966482.11 results: success (0) buildid: 20160823070554 builduid: 8e6b88c416b0411497f38d1021bc05a8 revision: 052656fc513c05da969590ac5934abd67271a897 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 08:34:42.113447) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 08:34:42.113902) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 08:34:42.114195) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 08:34:42.129189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:34:42.129572) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-23 08:34:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.8M=0s 2016-08-23 08:34:42 (38.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084242 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:34:42.227744) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:34:42.228073) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018229 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:34:42.278095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:34:42.278495) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 052656fc513c05da969590ac5934abd67271a897 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 052656fc513c05da969590ac5934abd67271a897 --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=5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-23 08:34:42,470 truncating revision to first 12 chars 2016-08-23 08:34:42,470 Setting DEBUG logging. 2016-08-23 08:34:42,470 attempt 1/10 2016-08-23 08:34:42,470 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/052656fc513c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 08:34:42,738 unpacking tar archive at: mozilla-central-052656fc513c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542829 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:34:42.834993) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 08:34:42.835327) ========= script_repo_revision: 052656fc513c05da969590ac5934abd67271a897 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 08:34:42.835713) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 08:34:42.835990) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 08:34:42.842222) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-23 08:34:42.842560) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:34:43 INFO - MultiFileLogger online at 20160823 08:34:43 in /builds/slave/test 08:34:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:34:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:34:43 INFO - {'append_to_log': False, 08:34:43 INFO - 'base_work_dir': '/builds/slave/test', 08:34:43 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:34:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:34:43 INFO - 'branch': 'Firefox-Non-PGO', 08:34:43 INFO - 'buildbot_json_path': 'buildprops.json', 08:34:43 INFO - 'config_files': ('talos/linux_config.py',), 08:34:43 INFO - 'default_actions': ('clobber', 08:34:43 INFO - 'read-buildbot-config', 08:34:43 INFO - 'download-and-extract', 08:34:43 INFO - 'populate-webroot', 08:34:43 INFO - 'create-virtualenv', 08:34:43 INFO - 'install', 08:34:43 INFO - 'run-tests'), 08:34:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:34:43 INFO - 'download_minidump_stackwalk': True, 08:34:43 INFO - 'download_symbols': 'ondemand', 08:34:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:34:43 INFO - 'tooltool.py': '/tools/tooltool.py', 08:34:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:34:43 INFO - '/tools/misc-python/virtualenv.py')}, 08:34:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:34:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:34:43 INFO - 'installer_path': 'installer.exe', 08:34:43 INFO - 'log_level': 'info', 08:34:43 INFO - 'log_name': 'talos', 08:34:43 INFO - 'log_to_console': True, 08:34:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:34:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:34:43 INFO - 'opt_config_files': (), 08:34:43 INFO - 'pip_index': False, 08:34:43 INFO - 'sps_profile': False, 08:34:43 INFO - 'sps_profile_interval': 0, 08:34:43 INFO - 'suite': 'dromaeojs', 08:34:43 INFO - 'system_bits': '32', 08:34:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:34:43 INFO - 'title': 'talos-linux64-ix-011', 08:34:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:34:43 INFO - 'use_talos_json': True, 08:34:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:34:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:34:43 INFO - 'work_dir': 'build'} 08:34:43 INFO - [mozharness: 2016-08-23 15:34:43.132476Z] Running clobber step. 08:34:43 INFO - Running pre-action listener: _resource_record_pre_action 08:34:43 INFO - Running main action method: clobber 08:34:43 INFO - rmtree: /builds/slave/test/build 08:34:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:34:43 INFO - Running post-action listener: _resource_record_post_action 08:34:43 INFO - [mozharness: 2016-08-23 15:34:43.595577Z] Finished clobber step (success) 08:34:43 INFO - [mozharness: 2016-08-23 15:34:43.595678Z] Running read-buildbot-config step. 08:34:43 INFO - Running pre-action listener: _resource_record_pre_action 08:34:43 INFO - Running main action method: read_buildbot_config 08:34:43 INFO - Using buildbot properties: 08:34:43 INFO - { 08:34:43 INFO - "project": "", 08:34:43 INFO - "product": "firefox", 08:34:43 INFO - "script_repo_revision": "production", 08:34:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:34:43 INFO - "repository": "", 08:34:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:34:43 INFO - "buildid": "20160823070554", 08:34:43 INFO - "pgo_build": "False", 08:34:43 INFO - "basedir": "/builds/slave/test", 08:34:43 INFO - "buildnumber": 607, 08:34:43 INFO - "slavename": "talos-linux64-ix-011", 08:34:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:34:43 INFO - "platform": "ubuntu64_hw", 08:34:43 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:34:43 INFO - "branch": "mozilla-central", 08:34:43 INFO - "repo_path": "mozilla-central", 08:34:43 INFO - "revision": "052656fc513c05da969590ac5934abd67271a897", 08:34:43 INFO - "stage_platform": "linux64", 08:34:43 INFO - "builduid": "8e6b88c416b0411497f38d1021bc05a8", 08:34:43 INFO - "slavebuilddir": "test" 08:34:43 INFO - } 08:34:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:34:43 INFO - Running post-action listener: _resource_record_post_action 08:34:43 INFO - [mozharness: 2016-08-23 15:34:43.598112Z] Finished read-buildbot-config step (success) 08:34:43 INFO - [mozharness: 2016-08-23 15:34:43.598200Z] Running download-and-extract step. 08:34:43 INFO - Running pre-action listener: _resource_record_pre_action 08:34:43 INFO - Running main action method: download_and_extract 08:34:43 INFO - mkdir: /builds/slave/test/build/tests 08:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:43 INFO - trying https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:34:43 INFO - Downloading https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:34:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:34:44 INFO - Downloaded 1361 bytes. 08:34:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:34:44 INFO - Using the following test package requirements: 08:34:44 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:34:44 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:34:44 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:34:44 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:44 INFO - u'jsshell-linux-x86_64.zip'], 08:34:44 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:34:44 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:34:44 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:34:44 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:34:44 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:34:44 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:34:44 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:34:44 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:44 INFO - trying https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:34:44 INFO - Downloading https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:34:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:34:44 INFO - Downloaded 20324416 bytes. 08:34:44 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:34:49 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:49 INFO - trying https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:34:49 INFO - Downloading https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:34:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:34:50 INFO - Downloaded 20324416 bytes. 08:34:50 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:34: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:54 INFO - trying https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:34:54 INFO - Downloading https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:34:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:34:55 INFO - Downloaded 14413981 bytes. 08:34:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 08:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:55 INFO - trying https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:34:55 INFO - Downloading https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:34:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:34:56 INFO - Downloaded 55732415 bytes. 08:34:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:34:56 INFO - mkdir: /builds/slave/test/properties 08:34:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:34:56 INFO - Writing to file /builds/slave/test/properties/build_url 08:34:56 INFO - Contents: 08:34:56 INFO - build_url:https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:34:57 INFO - Running post-action listener: _resource_record_post_action 08:34:57 INFO - Running post-action listener: set_extra_try_arguments 08:34:57 INFO - [mozharness: 2016-08-23 15:34:57.373671Z] Finished download-and-extract step (success) 08:34:57 INFO - [mozharness: 2016-08-23 15:34:57.373894Z] Running populate-webroot step. 08:34:57 INFO - Running pre-action listener: _resource_record_pre_action 08:34:57 INFO - Running main action method: populate_webroot 08:34:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:34:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:34:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:34:57 INFO - '--tppagecycles', 08:34:57 INFO - '7'], 08:34:57 INFO - 'tests': ['tsvgm']}}, 08:34:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:34:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:34:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:34:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:34:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:34:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:34:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:57 INFO - 'talos_options': ['--disable-e10s'], 08:34:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:34:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:34:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:57 INFO - 'talos_options': ['--disable-e10s'], 08:34:57 INFO - 'tests': ['damp', 'tps']}, 08:34:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:57 INFO - 'tests': ['damp', 'tps']}, 08:34:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:34:57 INFO - 'tests': ['dromaeo_dom']}, 08:34:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:34:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:34:57 INFO - 'tests': ['basic_compositor_video']}, 08:34:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:34:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:34:57 INFO - 'tests': ['a11yr', 08:34:57 INFO - 'ts_paint', 08:34:57 INFO - 'tpaint', 08:34:57 INFO - 'sessionrestore', 08:34:57 INFO - 'sessionrestore_no_auto_restore', 08:34:57 INFO - 'tabpaint']}, 08:34:57 INFO - 'other-e10s': {'tests': ['a11yr', 08:34:57 INFO - 'ts_paint', 08:34:57 INFO - 'tpaint', 08:34:57 INFO - 'sessionrestore', 08:34:57 INFO - 'sessionrestore_no_auto_restore', 08:34:57 INFO - 'tabpaint']}, 08:34:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:34:57 INFO - 'ts_paint', 08:34:57 INFO - 'tpaint', 08:34:57 INFO - 'sessionrestore', 08:34:57 INFO - 'sessionrestore_no_auto_restore', 08:34:57 INFO - 'tabpaint']}, 08:34:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:34:57 INFO - 'ts_paint', 08:34:57 INFO - 'tpaint', 08:34:57 INFO - 'sessionrestore', 08:34:57 INFO - 'sessionrestore_no_auto_restore', 08:34:57 INFO - 'tabpaint']}, 08:34:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:34:57 INFO - 'tests': ['a11yr', 08:34:57 INFO - 'ts_paint', 08:34:57 INFO - 'tpaint', 08:34:57 INFO - 'sessionrestore', 08:34:57 INFO - 'sessionrestore_no_auto_restore', 08:34:57 INFO - 'tabpaint']}, 08:34:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:34:57 INFO - 'tests': ['a11yr', 08:34:57 INFO - 'ts_paint', 08:34:57 INFO - 'tpaint', 08:34:57 INFO - 'sessionrestore', 08:34:57 INFO - 'sessionrestore_no_auto_restore', 08:34:57 INFO - 'tabpaint']}, 08:34:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:34:57 INFO - 'tests': ['tsvgx', 08:34:57 INFO - 'tsvgr_opacity', 08:34:57 INFO - 'tart', 08:34:57 INFO - 'tscrollx', 08:34:57 INFO - 'cart']}, 08:34:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:34:57 INFO - 'tsvgr_opacity', 08:34:57 INFO - 'tart', 08:34:57 INFO - 'tscrollx', 08:34:57 INFO - 'cart']}, 08:34:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:57 INFO - 'talos_options': ['--disable-e10s'], 08:34:57 INFO - 'tests': ['tp5o']}, 08:34:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:57 INFO - 'tests': ['tp5o']}, 08:34:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:57 INFO - 'talos_options': ['--disable-e10s', 08:34:57 INFO - '--xperf_path', 08:34:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:34:57 INFO - 'tests': ['tp5n']}, 08:34:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:57 INFO - 'talos_options': ['--xperf_path', 08:34:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:34:57 INFO - 'tests': ['tp5n']}}, 08:34:57 INFO - 'talos.zip': {'path': '', 08:34:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:34:57 INFO - Running post-action listener: _resource_record_post_action 08:34:57 INFO - [mozharness: 2016-08-23 15:34:57.394493Z] Finished populate-webroot step (success) 08:34:57 INFO - [mozharness: 2016-08-23 15:34:57.394581Z] Running create-virtualenv step. 08:34:57 INFO - Running pre-action listener: _resource_record_pre_action 08:34:57 INFO - Running main action method: create_virtualenv 08:34:57 INFO - Creating virtualenv /builds/slave/test/build/venv 08:34:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:34:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:34:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:34:57 INFO - Using real prefix '/usr' 08:34:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:34:58 INFO - Installing distribute.............................................................................................................................................................................................done. 08:34:59 INFO - Installing pip.................done. 08:34:59 INFO - Return code: 0 08:34:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64e8418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7090>, '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 0x2cba9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbae40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:34:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:34:59 INFO - Using env: {'DISPLAY': ':0', 08:34:59 INFO - 'HOME': '/home/cltbld', 08:34:59 INFO - 'LANG': 'en_US.UTF-8', 08:34:59 INFO - 'LANGUAGE': 'en_US:en', 08:34:59 INFO - 'LOGNAME': 'cltbld', 08:34:59 INFO - 'MAIL': '/var/mail/cltbld', 08:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:59 INFO - 'MOZ_NO_REMOTE': '1', 08:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:34:59 INFO - 'NO_EM_RESTART': '1', 08:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:59 INFO - 'PWD': '/builds/slave/test', 08:34:59 INFO - 'SHELL': '/bin/bash', 08:34:59 INFO - 'SHLVL': '1', 08:34:59 INFO - 'TERM': 'linux', 08:34:59 INFO - 'TMOUT': '86400', 08:34:59 INFO - 'USER': 'cltbld', 08:34:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 08:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:59 INFO - '_': '/tools/buildbot/bin/python'} 08:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:35:00 INFO - Cleaning up... 08:35:00 INFO - Return code: 0 08:35:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f64e8418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7090>, '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 0x2cba9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbae40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:35:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:35:00 INFO - Using env: {'DISPLAY': ':0', 08:35:00 INFO - 'HOME': '/home/cltbld', 08:35:00 INFO - 'LANG': 'en_US.UTF-8', 08:35:00 INFO - 'LANGUAGE': 'en_US:en', 08:35:00 INFO - 'LOGNAME': 'cltbld', 08:35:00 INFO - 'MAIL': '/var/mail/cltbld', 08:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:00 INFO - 'MOZ_NO_REMOTE': '1', 08:35:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:00 INFO - 'NO_EM_RESTART': '1', 08:35:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:00 INFO - 'PWD': '/builds/slave/test', 08:35:00 INFO - 'SHELL': '/bin/bash', 08:35:00 INFO - 'SHLVL': '1', 08:35:00 INFO - 'TERM': 'linux', 08:35:00 INFO - 'TMOUT': '86400', 08:35:00 INFO - 'USER': 'cltbld', 08:35:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 08:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:00 INFO - '_': '/tools/buildbot/bin/python'} 08:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:00 INFO - Downloading/unpacking psutil>=3.1.1 08:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:35:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:35:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:35:02 INFO - Installing collected packages: psutil 08:35:02 INFO - Running setup.py install for psutil 08:35:02 INFO - building 'psutil._psutil_linux' extension 08:35:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:35:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:35:02 INFO - building 'psutil._psutil_posix' extension 08:35:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:35:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:35:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:35:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:35:02 INFO - Successfully installed psutil 08:35:02 INFO - Cleaning up... 08:35:02 INFO - Return code: 0 08:35:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:02 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 0x7f64e8418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7090>, '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 0x2cba9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbae40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:35:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:35:02 INFO - Using env: {'DISPLAY': ':0', 08:35:02 INFO - 'HOME': '/home/cltbld', 08:35:02 INFO - 'LANG': 'en_US.UTF-8', 08:35:02 INFO - 'LANGUAGE': 'en_US:en', 08:35:02 INFO - 'LOGNAME': 'cltbld', 08:35:02 INFO - 'MAIL': '/var/mail/cltbld', 08:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:02 INFO - 'MOZ_NO_REMOTE': '1', 08:35:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:02 INFO - 'NO_EM_RESTART': '1', 08:35:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:02 INFO - 'PWD': '/builds/slave/test', 08:35:02 INFO - 'SHELL': '/bin/bash', 08:35:02 INFO - 'SHLVL': '1', 08:35:02 INFO - 'TERM': 'linux', 08:35:02 INFO - 'TMOUT': '86400', 08:35:02 INFO - 'USER': 'cltbld', 08:35:02 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 08:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:02 INFO - '_': '/tools/buildbot/bin/python'} 08:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:35:05 INFO - Installing collected packages: mozsystemmonitor 08:35:05 INFO - Running setup.py install for mozsystemmonitor 08:35:05 INFO - Successfully installed mozsystemmonitor 08:35:05 INFO - Cleaning up... 08:35:05 INFO - Return code: 0 08:35:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:05 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 0x7f64e8418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7090>, '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 0x2cba9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbae40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:35:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:35:05 INFO - Using env: {'DISPLAY': ':0', 08:35:05 INFO - 'HOME': '/home/cltbld', 08:35:05 INFO - 'LANG': 'en_US.UTF-8', 08:35:05 INFO - 'LANGUAGE': 'en_US:en', 08:35:05 INFO - 'LOGNAME': 'cltbld', 08:35:05 INFO - 'MAIL': '/var/mail/cltbld', 08:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:05 INFO - 'MOZ_NO_REMOTE': '1', 08:35:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:05 INFO - 'NO_EM_RESTART': '1', 08:35:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:05 INFO - 'PWD': '/builds/slave/test', 08:35:05 INFO - 'SHELL': '/bin/bash', 08:35:05 INFO - 'SHLVL': '1', 08:35:05 INFO - 'TERM': 'linux', 08:35:05 INFO - 'TMOUT': '86400', 08:35:05 INFO - 'USER': 'cltbld', 08:35:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 08:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:05 INFO - '_': '/tools/buildbot/bin/python'} 08:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:05 INFO - Downloading/unpacking jsonschema==2.5.1 08:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:35:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:07 INFO - Downloading functools32-3.2.3-2.tar.gz 08:35:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:35:07 INFO - warning: no files found matching '*.txt' 08:35:07 INFO - no previously-included directories found matching 'build' 08:35:07 INFO - no previously-included directories found matching 'dist' 08:35:07 INFO - no previously-included directories found matching '.git*' 08:35:07 INFO - Installing collected packages: jsonschema, functools32 08:35:07 INFO - Running setup.py install for functools32 08:35:07 INFO - warning: no files found matching '*.txt' 08:35:07 INFO - no previously-included directories found matching 'build' 08:35:07 INFO - no previously-included directories found matching 'dist' 08:35:07 INFO - no previously-included directories found matching '.git*' 08:35:07 INFO - Successfully installed jsonschema functools32 08:35:07 INFO - Cleaning up... 08:35:07 INFO - Return code: 0 08:35:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f64e8418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7090>, '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 0x2cba9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbae40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:35:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:35:07 INFO - Using env: {'DISPLAY': ':0', 08:35:07 INFO - 'HOME': '/home/cltbld', 08:35:07 INFO - 'LANG': 'en_US.UTF-8', 08:35:07 INFO - 'LANGUAGE': 'en_US:en', 08:35:07 INFO - 'LOGNAME': 'cltbld', 08:35:07 INFO - 'MAIL': '/var/mail/cltbld', 08:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:07 INFO - 'MOZ_NO_REMOTE': '1', 08:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:07 INFO - 'NO_EM_RESTART': '1', 08:35:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:07 INFO - 'PWD': '/builds/slave/test', 08:35:07 INFO - 'SHELL': '/bin/bash', 08:35:07 INFO - 'SHLVL': '1', 08:35:07 INFO - 'TERM': 'linux', 08:35:07 INFO - 'TMOUT': '86400', 08:35:07 INFO - 'USER': 'cltbld', 08:35:07 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 08:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:07 INFO - '_': '/tools/buildbot/bin/python'} 08:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:35:08 INFO - Cleaning up... 08:35:08 INFO - Return code: 0 08:35:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:08 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 0x7f64e8418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7090>, '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 0x2cba9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbae40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:35:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:35:08 INFO - Using env: {'DISPLAY': ':0', 08:35:08 INFO - 'HOME': '/home/cltbld', 08:35:08 INFO - 'LANG': 'en_US.UTF-8', 08:35:08 INFO - 'LANGUAGE': 'en_US:en', 08:35:08 INFO - 'LOGNAME': 'cltbld', 08:35:08 INFO - 'MAIL': '/var/mail/cltbld', 08:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:08 INFO - 'MOZ_NO_REMOTE': '1', 08:35:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:08 INFO - 'NO_EM_RESTART': '1', 08:35:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:08 INFO - 'PWD': '/builds/slave/test', 08:35:08 INFO - 'SHELL': '/bin/bash', 08:35:08 INFO - 'SHLVL': '1', 08:35:08 INFO - 'TERM': 'linux', 08:35:08 INFO - 'TMOUT': '86400', 08:35:08 INFO - 'USER': 'cltbld', 08:35:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 08:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:08 INFO - '_': '/tools/buildbot/bin/python'} 08:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:08 INFO - Downloading/unpacking blobuploader==1.2.4 08:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:10 INFO - Downloading blobuploader-1.2.4.tar.gz 08:35:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:35:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:35:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:10 INFO - Downloading docopt-0.6.1.tar.gz 08:35:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:35:10 INFO - Installing collected packages: blobuploader, requests, docopt 08:35:10 INFO - Running setup.py install for blobuploader 08:35:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:35:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:35:11 INFO - Running setup.py install for requests 08:35:11 INFO - Running setup.py install for docopt 08:35:11 INFO - Successfully installed blobuploader requests docopt 08:35:11 INFO - Cleaning up... 08:35:11 INFO - Return code: 0 08:35:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:11 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 0x7f64e8418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7090>, '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 0x2cba9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbae40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:35:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:35:11 INFO - Using env: {'DISPLAY': ':0', 08:35:11 INFO - 'HOME': '/home/cltbld', 08:35:11 INFO - 'LANG': 'en_US.UTF-8', 08:35:11 INFO - 'LANGUAGE': 'en_US:en', 08:35:11 INFO - 'LOGNAME': 'cltbld', 08:35:11 INFO - 'MAIL': '/var/mail/cltbld', 08:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:11 INFO - 'MOZ_NO_REMOTE': '1', 08:35:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:11 INFO - 'NO_EM_RESTART': '1', 08:35:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:11 INFO - 'PWD': '/builds/slave/test', 08:35:11 INFO - 'SHELL': '/bin/bash', 08:35:11 INFO - 'SHLVL': '1', 08:35:11 INFO - 'TERM': 'linux', 08:35:11 INFO - 'TMOUT': '86400', 08:35:11 INFO - 'USER': 'cltbld', 08:35:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 08:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:11 INFO - '_': '/tools/buildbot/bin/python'} 08:35:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:35:11 INFO - Running setup.py (path:/tmp/pip-3SKK_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:35:11 INFO - Running setup.py (path:/tmp/pip-oZEyc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:35:11 INFO - Running setup.py (path:/tmp/pip-ad4lDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:35:11 INFO - Running setup.py (path:/tmp/pip-VtIgLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:35:12 INFO - Running setup.py (path:/tmp/pip-eSEBN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:35:12 INFO - Running setup.py (path:/tmp/pip-nsYyYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:35:12 INFO - Running setup.py (path:/tmp/pip-K69Y9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:35:12 INFO - Running setup.py (path:/tmp/pip-egEKG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:35:12 INFO - Running setup.py (path:/tmp/pip-IrM0zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:35:12 INFO - Running setup.py (path:/tmp/pip-uAz0lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:35:12 INFO - Running setup.py (path:/tmp/pip-_pmDSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:35:12 INFO - Running setup.py (path:/tmp/pip-SqG9Kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:35:12 INFO - Running setup.py (path:/tmp/pip-WH89mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:35:12 INFO - Running setup.py (path:/tmp/pip-cSTG2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:12 INFO - Running setup.py (path:/tmp/pip-CPXlUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:35:12 INFO - Running setup.py (path:/tmp/pip-t4hQ9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:35:12 INFO - Running setup.py (path:/tmp/pip-ZvkKqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:35:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:35:12 INFO - Running setup.py install for manifestparser 08:35:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:35:13 INFO - Running setup.py install for mozcrash 08:35:13 INFO - Running setup.py install for mozdebug 08:35:13 INFO - Running setup.py install for mozdevice 08:35:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:35:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:35:13 INFO - Running setup.py install for mozfile 08:35:13 INFO - Running setup.py install for mozhttpd 08:35:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:35:13 INFO - Running setup.py install for mozinfo 08:35:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:35:13 INFO - Running setup.py install for mozInstall 08:35:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:35:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:35:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:35:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:35:13 INFO - Running setup.py install for mozleak 08:35:13 INFO - Running setup.py install for mozlog 08:35:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:35:14 INFO - Running setup.py install for moznetwork 08:35:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:35:14 INFO - Running setup.py install for mozprocess 08:35:14 INFO - Running setup.py install for mozprofile 08:35:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:35:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:35:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:35:14 INFO - Running setup.py install for mozrunner 08:35:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:35:14 INFO - Running setup.py install for mozscreenshot 08:35:14 INFO - Running setup.py install for moztest 08:35:14 INFO - Running setup.py install for mozversion 08:35:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:35:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:35:14 INFO - Cleaning up... 08:35:14 INFO - Return code: 0 08:35:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:14 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 0x7f64e8418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7090>, '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 0x2cba9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbae40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:35:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:35:14 INFO - Using env: {'DISPLAY': ':0', 08:35:14 INFO - 'HOME': '/home/cltbld', 08:35:14 INFO - 'LANG': 'en_US.UTF-8', 08:35:14 INFO - 'LANGUAGE': 'en_US:en', 08:35:14 INFO - 'LOGNAME': 'cltbld', 08:35:14 INFO - 'MAIL': '/var/mail/cltbld', 08:35:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:14 INFO - 'MOZ_NO_REMOTE': '1', 08:35:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:14 INFO - 'NO_EM_RESTART': '1', 08:35:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:14 INFO - 'PWD': '/builds/slave/test', 08:35:14 INFO - 'SHELL': '/bin/bash', 08:35:14 INFO - 'SHLVL': '1', 08:35:14 INFO - 'TERM': 'linux', 08:35:14 INFO - 'TMOUT': '86400', 08:35:14 INFO - 'USER': 'cltbld', 08:35:14 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 08:35:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:14 INFO - '_': '/tools/buildbot/bin/python'} 08:35:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:35:14 INFO - Running setup.py (path:/tmp/pip-guxVwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:35:15 INFO - Running setup.py (path:/tmp/pip-EHB1KK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:35:15 INFO - Running setup.py (path:/tmp/pip-6NDc74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:35:15 INFO - Running setup.py (path:/tmp/pip-XAMt7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:35:15 INFO - Running setup.py (path:/tmp/pip-Vv6iMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:35:15 INFO - Running setup.py (path:/tmp/pip-2I2e7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:35:15 INFO - Running setup.py (path:/tmp/pip-zpdURj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:35:15 INFO - Running setup.py (path:/tmp/pip-BRcwKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:35:15 INFO - Running setup.py (path:/tmp/pip-_bHbeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:35:15 INFO - Running setup.py (path:/tmp/pip-zKGtct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:35:15 INFO - Running setup.py (path:/tmp/pip-r2zfXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:35:15 INFO - Running setup.py (path:/tmp/pip-kUfSyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:35:15 INFO - Running setup.py (path:/tmp/pip-EeaVmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:35:15 INFO - Running setup.py (path:/tmp/pip-Z8PKYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:15 INFO - Running setup.py (path:/tmp/pip-yAbpDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:35:16 INFO - Running setup.py (path:/tmp/pip-RCsY5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:35:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:35:16 INFO - Running setup.py (path:/tmp/pip-i5EcZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:35:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:35:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:35:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:35:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:35:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:35:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:35:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:18 INFO - Downloading blessings-1.6.tar.gz 08:35:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:35:18 INFO - Installing collected packages: blessings 08:35:18 INFO - Running setup.py install for blessings 08:35:18 INFO - Successfully installed blessings 08:35:18 INFO - Cleaning up... 08:35:18 INFO - Return code: 0 08:35:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:35:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:35:18 INFO - Reading from file tmpfile_stdout 08:35:18 INFO - Current package versions: 08:35:18 INFO - argparse == 1.2.1 08:35:18 INFO - blessings == 1.6 08:35:18 INFO - blobuploader == 1.2.4 08:35:18 INFO - docopt == 0.6.1 08:35:18 INFO - functools32 == 3.2.3-2 08:35:18 INFO - jsonschema == 2.5.1 08:35:18 INFO - manifestparser == 1.1 08:35:18 INFO - mozInstall == 1.12 08:35:18 INFO - mozcrash == 0.17 08:35:18 INFO - mozdebug == 0.1 08:35:18 INFO - mozdevice == 0.48 08:35:18 INFO - mozfile == 1.2 08:35:18 INFO - mozhttpd == 0.7 08:35:18 INFO - mozinfo == 0.9 08:35:18 INFO - mozleak == 0.1 08:35:18 INFO - mozlog == 3.3 08:35:18 INFO - moznetwork == 0.27 08:35:18 INFO - mozprocess == 0.23 08:35:18 INFO - mozprofile == 0.28 08:35:18 INFO - mozrunner == 6.12 08:35:18 INFO - mozscreenshot == 0.1 08:35:18 INFO - mozsystemmonitor == 0.3 08:35:18 INFO - moztest == 0.7 08:35:18 INFO - mozversion == 1.4 08:35:18 INFO - psutil == 3.1.1 08:35:18 INFO - requests == 1.2.3 08:35:18 INFO - wsgiref == 0.1.2 08:35:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:18 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 0x7f64e8418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7090>, '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 0x2cba9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbae40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:35:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:35:18 INFO - Using env: {'DISPLAY': ':0', 08:35:18 INFO - 'HOME': '/home/cltbld', 08:35:18 INFO - 'LANG': 'en_US.UTF-8', 08:35:18 INFO - 'LANGUAGE': 'en_US:en', 08:35:18 INFO - 'LOGNAME': 'cltbld', 08:35:18 INFO - 'MAIL': '/var/mail/cltbld', 08:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:18 INFO - 'MOZ_NO_REMOTE': '1', 08:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:18 INFO - 'NO_EM_RESTART': '1', 08:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:18 INFO - 'PWD': '/builds/slave/test', 08:35:18 INFO - 'SHELL': '/bin/bash', 08:35:18 INFO - 'SHLVL': '1', 08:35:18 INFO - 'TERM': 'linux', 08:35:18 INFO - 'TMOUT': '86400', 08:35:18 INFO - 'USER': 'cltbld', 08:35:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 08:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:18 INFO - '_': '/tools/buildbot/bin/python'} 08:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:35:18 INFO - Cleaning up... 08:35:18 INFO - Return code: 0 08:35:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:18 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 0x7f64e8418f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbd230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cb7090>, '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 0x2cba9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbae40>, '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': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:35:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:35:18 INFO - Using env: {'DISPLAY': ':0', 08:35:18 INFO - 'HOME': '/home/cltbld', 08:35:18 INFO - 'LANG': 'en_US.UTF-8', 08:35:18 INFO - 'LANGUAGE': 'en_US:en', 08:35:18 INFO - 'LOGNAME': 'cltbld', 08:35:18 INFO - 'MAIL': '/var/mail/cltbld', 08:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:18 INFO - 'MOZ_NO_REMOTE': '1', 08:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:18 INFO - 'NO_EM_RESTART': '1', 08:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:18 INFO - 'PWD': '/builds/slave/test', 08:35:18 INFO - 'SHELL': '/bin/bash', 08:35:18 INFO - 'SHLVL': '1', 08:35:18 INFO - 'TERM': 'linux', 08:35:18 INFO - 'TMOUT': '86400', 08:35:18 INFO - 'USER': 'cltbld', 08:35:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 08:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:18 INFO - '_': '/tools/buildbot/bin/python'} 08:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:35:18 INFO - Cleaning up... 08:35:19 INFO - Return code: 0 08:35:19 INFO - Running post-action listener: _resource_record_post_action 08:35:19 INFO - Running post-action listener: _start_resource_monitoring 08:35:19 INFO - Starting resource monitoring. 08:35:19 INFO - [mozharness: 2016-08-23 15:35:19.028803Z] Finished create-virtualenv step (success) 08:35:19 INFO - [mozharness: 2016-08-23 15:35:19.029263Z] Running install step. 08:35:19 INFO - Running pre-action listener: _resource_record_pre_action 08:35:19 INFO - Running main action method: install 08:35:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:35:19 INFO - Reading from file tmpfile_stdout 08:35:19 INFO - Detecting whether we're running mozinstall >=1.0... 08:35:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:35:19 INFO - Reading from file tmpfile_stdout 08:35:19 INFO - Output received: 08:35:19 INFO - Usage: mozinstall [options] installer 08:35:19 INFO - Options: 08:35:19 INFO - -h, --help show this help message and exit 08:35:19 INFO - -d DEST, --destination=DEST 08:35:19 INFO - Directory to install application into. [default: 08:35:19 INFO - "/builds/slave/test"] 08:35:19 INFO - --app=APP Application being installed. [default: firefox] 08:35:19 INFO - mkdir: /builds/slave/test/build/application 08:35:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:35:35 INFO - Reading from file tmpfile_stdout 08:35:35 INFO - Output received: 08:35:35 INFO - /builds/slave/test/build/application/firefox/firefox 08:35:35 INFO - Running post-action listener: _resource_record_post_action 08:35:35 INFO - [mozharness: 2016-08-23 15:35:35.396136Z] Finished install step (success) 08:35:35 INFO - [mozharness: 2016-08-23 15:35:35.396385Z] Running run-tests step. 08:35:35 INFO - Running pre-action listener: _resource_record_pre_action 08:35:35 INFO - Running main action method: run_tests 08:35:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:35:35 INFO - Python 2.7.3 08:35:35 INFO - Return code: 0 08:35:35 INFO - grabbing minidump binary from tooltool 08:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:35:35 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 0x2cb7090>, '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 0x2cba9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cbae40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:35:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:35:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:35:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:35:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:35:35 INFO - Return code: 0 08:35:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:35:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:35:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:35:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:35:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:35:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 08:35:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 08:35:35 INFO - Using env: {'DISPLAY': ':0', 08:35:35 INFO - 'HOME': '/home/cltbld', 08:35:35 INFO - 'LANG': 'en_US.UTF-8', 08:35:35 INFO - 'LANGUAGE': 'en_US:en', 08:35:35 INFO - 'LOGNAME': 'cltbld', 08:35:35 INFO - 'MAIL': '/var/mail/cltbld', 08:35:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:35:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:35 INFO - 'MOZ_NO_REMOTE': '1', 08:35:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:35:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:35:35 INFO - 'NO_EM_RESTART': '1', 08:35:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:35 INFO - 'PWD': '/builds/slave/test', 08:35:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:35:35 INFO - 'SHELL': '/bin/bash', 08:35:35 INFO - 'SHLVL': '1', 08:35:35 INFO - 'TERM': 'linux', 08:35:35 INFO - 'TMOUT': '86400', 08:35:35 INFO - 'USER': 'cltbld', 08:35:35 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592', 08:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:35 INFO - '_': '/tools/buildbot/bin/python'} 08:35:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 08:35:35 INFO - mozversion application_buildid: 20160823070554 08:35:35 INFO - mozversion application_changeset: 052656fc513c05da969590ac5934abd67271a897 08:35:35 INFO - mozversion application_display_name: Nightly 08:35:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:35:35 INFO - mozversion application_name: Firefox 08:35:35 INFO - mozversion application_remotingname: firefox 08:35:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:35:35 INFO - mozversion application_vendor: Mozilla 08:35:35 INFO - mozversion application_version: 51.0a1 08:35:35 INFO - mozversion platform_buildid: 20160823070554 08:35:35 INFO - mozversion platform_changeset: 052656fc513c05da969590ac5934abd67271a897 08:35:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:35:35 INFO - mozversion platform_version: 51.0a1 08:35:35 INFO - using testdate: 1471966535 08:35:35 INFO - actual date: 1471966535 08:35:35 INFO - starting webserver on 'localhost:51803' 08:35:35 INFO - SUITE-START | Running 2 tests 08:35:35 INFO - TEST-START | dromaeo_css 08:35:35 INFO - operating with platform_type : linux_ 08:35:35 INFO - Initialising browser for dromaeo_css test... 08:35:35 INFO - TEST-INFO | started process 30694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS4vVlP/profile http://localhost:51803/getInfo.html) 08:35:40 INFO - PROCESS | 30694 | __metrics Screen width/height:1600/1200 08:35:40 INFO - PROCESS | 30694 | colorDepth:24 08:35:40 INFO - PROCESS | 30694 | Browser inner width/height: 1024/697 08:35:40 INFO - PROCESS | 30694 | __metrics 08:35:41 INFO - PROCESS | 30694 | 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" 08:35:41 INFO - PROCESS | 30694 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:35:41 INFO - PROCESS | 30694 | console.error: PushService: 08:35:41 INFO - PROCESS | 30694 | stateChangeProcessEnqueue: Error transitioning state 08:35:41 INFO - PROCESS | 30694 | UnknownError 08:35:42 INFO - TEST-INFO | 30694: exit 0 08:35:42 INFO - Browser initialized. 08:35:42 INFO - Running cycle 1/1 for dromaeo_css test... 08:35:42 INFO - TEST-INFO | started process 30772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS4vVlP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:35:54 INFO - PROCESS | 30772 | RSS: Main: 183300096 08:35:54 INFO - PROCESS | 30772 | 08:36:45 INFO - PROCESS | 30772 | 1471966605995 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:38:59 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:51803/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51803/tests/dromaeo/cssquery-ext.html) 08:39:00 INFO - PROCESS | 30772 | RSS: Main: 269447168 08:39:00 INFO - PROCESS | 30772 | 08:42:03 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:51803/tests/dromaeo/cssquery-ext.html (next: http://localhost:51803/tests/dromaeo/cssquery-jquery.html) 08:42:03 INFO - PROCESS | 30772 | RSS: Main: 271101952 08:42:03 INFO - PROCESS | 30772 | 08:45:06 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:51803/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51803/tests/dromaeo/cssquery-mootools.html) 08:45:06 INFO - PROCESS | 30772 | RSS: Main: 253370368 08:45:06 INFO - PROCESS | 30772 | 08:48:09 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:51803/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51803/tests/dromaeo/cssquery-prototype.html) 08:48:09 INFO - PROCESS | 30772 | RSS: Main: 220454912 08:48:09 INFO - PROCESS | 30772 | 08:51:13 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:51803/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51803/tests/dromaeo/cssquery-yui.html) 08:51:13 INFO - PROCESS | 30772 | RSS: Main: 220532736 08:51:13 INFO - PROCESS | 30772 | 08:54:16 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:51803/tests/dromaeo/cssquery-yui.html (next: http://localhost:51803/tests/dromaeo/cssquery-dojo.html) 08:54:16 INFO - PROCESS | 30772 | RSS: Main: 303026176 08:54:16 INFO - PROCESS | 30772 | 08:54:16 INFO - PROCESS | 30772 | __start_tp_report 08:54:16 INFO - PROCESS | 30772 | _x_x_mozilla_page_load 08:54:16 INFO - PROCESS | 30772 | _x_x_mozilla_page_load_details 08:54:16 INFO - PROCESS | 30772 | |i|pagename|runs| 08:54:16 INFO - PROCESS | 30772 | |0;dojo.html;2569.6881283759813;2594.4940736556377;2602.700689420716;2638.4723055388927;2652.854093024883;4556.20266453371;4585.082983403316;4610.861674149773;4658.184817656909;4670.76646167692;4609.6081833044145;4632.235681112621;4648.279516674912;4667;4693.765311734408;4212.431321771567;4245.80893859777;4281.100968796556;4344.500382456011;4451.866444006685;4376.343548467739;4391.429114215148;4445.0443154721725;4455.576720211575;4457.531959144292;4237.555056719031;4264.65882729384;4356.4336636237085;4372.715773474746;4468.97765511172;4215.852445164404;4234.6823988201;4260.510041345254;4283.828646854122;4303.203907277164;4215.957840421618;4265.808038638238;4267.957320426787;4277.893052673677;4325.653947684209;4577.244754615484;4595.103954728829;4646.303054541812;4649.442066951988;4695.295705644146;4904.926426103611;4941.431735350445;4962.6526143169995;5018.824341148043;5028.547430731215;4910.901781964377;4923.90152196954;4934.087193869145;4963.975180124113;5011.473795251519;4538.704984176018;4657.813687452498;4661.836835710734;4669.112868554964;4671.85984420468;5005.199168133154;5086.9745651271505;5131;5146.150885103991;5192.948070519246;4941.728204948762;4951.455339912607;4954.40547134339;4958.256261560723;5023.899522009539;5017.448080711119;5023.949760502348;5026.271190677331;5028.622853286018;5028.924566131438;4855.344528488679;4871.318015477836;4881.804727810848;4917.360743103445;4954.752262386938;4853.733044682576;4855.854324370274;4863.2461968394955;4886.780094895738;4920.188168952082;4218.17745539623;4236.830526778956;4263.467066616673;4272.33778764292;4318.1363727254675;3669.43123815809;3684.0421490412687;3690.040589446763;3727.589965103836;3757;4339.414179085846;4365.650747940157;4408.7575183365225;4417.558244175557;4421.270490369117;4999.0501804657;5031.622628302819;5032.421271553818;5034.244863270465;5094.872628184251;4291.742495450283;4328.156009578102;4340.414044104005;4357.477102747691;4363.105563359567;4463.040446303995;4464.6428285737065;4487.057717879216;4528.773561321921;4539;4683.78922948475;4716.64625153108;4718.150732867979;4721.4570324413135;4770.308305295713;4906.509349065065;4963.404391473046;5008.173651347487;5008.599312054954;5050.368703912011;4671.579557839811;4712.387389639325;4726.3146843708155;4740.407449068866;4779.545943135397;4941.184704523714;4942.802287908444;4942.92585611209;4946.208606622923;5006.449290577961;4912.1649319615035;5001.224810154432;5025.070361983045;5027.924581131213;5079.72061536619;4820.204666230173;4839;4865.56209941107;4874.683145595525;4934.8766280843265;4835.879103022453;4848.903021939471;4850.83022094225;4863.805447782049;4913.287573301923;4741.241401375902;4791.496892826342;4813.7593120344545;4831.396075490564;4899.902001960012;4863.2461968394955;4893.21708526634;4901.2893130496595;4903.362562866804;4981.925271120864;4803.879903002313;4811.759412029454;4815.3258543803195;4824.276358546246;4871.95128048715 08:54:16 INFO - PROCESS | 30772 | |1;ext.html;520.6641716093118;531.7607076815432;573.1889376532207;586.3579380578268;587.6063037764698;27959.440811183766;37589;39022.80488597553;39163;42197.15605687884;39546.40680389797;39753.60246397535;39978.80010599943;40041.799791001074;40086;7502.774916752493;7603.65783539742;7654.923450765476;7656.502327348732;7656.502327348732;7639.7326093586735;7714.4599878008285;7729.768106956801;7730.7680769577;7733.961330193341;7399.3710534604625;7490.9625451872935;7494.175640679521;7498.737544185955;7528.058992625922;7652.387808975269;7678.884816727754;7714.228577142297;7714.6142692865415;7768.495047821873;7607.847843043163;7680.577568233745;7680.692772289101;7683.078030636303;7684.346830519413;37467.81266093652;37853;37880.24239515222;37880.24239515222;37884.62115378839;2382.642603609455;2470.9135180268786;2512.1458704040715;2520.143151328539;2713.7150599187;27426.862865685744;27798.722012780017;28056.158315250574;28094.85952570224;28668.283292917844;3341.298327351259;3431.227973705921;3456.807401446522;3560.5193298904574;3574.070741607175;253237;255477;255880;255880;255923;52061.47938520642;52547.804134276346;52563.21155182675;52575.737121314145;52584.47415525872;32039.359212815612;32920;33091;34767.9569612912;55774;12965.481380744854;13147.34263286851;13178.538751143855;13194.736105277841;13196.14225075367;9750.561224744763;9810.754731131636;9813.313068085308;9835.655752048644;9842.311038227399;17667.936374633908;17671.558211044827;17688.115594220493;17715.911420442815;17761.911190443963;6567;6670.733170673118;6706.362895524917;6757.68225196082;6890.793276201722;766.2108028730416;873.9737807865774;933.1788026536605;955.5365647660878;961.990380096204;26541.46917061648;26884.193474195807;27201.86399067992;27276.727232727815;27708.861455692593;837.4598384042258;871.1506281375608;884.9115088491228;905.248643625789;989.7030890732896;14273.714525709427;14443.638909027148;14472.85527144736;14771.261436928111;14880;376954;378380;379401;381867;383952;47249.291260631115;47830.28254576184;48028.27957580639;48051.75974120177;48061;1056.2183983851894;1120.1263014848432;1165.0795871261778;1179.8614337164677;1183.621241202807;26739.465210696068;28051.158465246077;28951.7104828949;29017.274568135967;29451.41097178087;40150.39774403328;40764.38853417142;40812.59187408206;40870;40888.1822363557;280245;280433;281482;281700;282528;22002.229921952654;23779.762202377755;24797;24833.87583062073;25946.74053259443;40285.39571906482;40506.39240411455;40870.59129408668;41300.38049429321;41896.3715544261;34823.65176348204;34837.65162348445;34891.82554087213;35639.28721425609;35651.64348356587;31535.36929261448;31555.526667100472;31657.36685266328;31793.841030794698;32493.512597311532;34229;34494.48258276078;35714.64285357113;36906.63093369139;36934.44598331081;30197;31785.682143179198;32876.67123328832;33195.336093278485;33302.833485832416;24648.507029859662;25086.121985730413;25422.74577254204;25619.35951601225;25829.870850646377 08:54:16 INFO - PROCESS | 30772 | |2;jquery.html;368.3645711148268;371.39833469778955;374.75828090881373;381.8071873703779;391.6318660459168;15898.68202635948;16908.661826763473;17008.744868826947;17097.40159094432;17107.657846843056;15192.468263610775;15813.367465301375;15927.362905483797;15943.123128227942;16013.599660008505;4832.154372984723;5109.054824857395;5110.974445127769;5112.463191364909;5114.514121158484;3707.258548290339;3900.356441187215;5034.169362055275;5758.107493338539;5981.58128930975;6071.453569178773;6073.392660733935;6078.939210607904;6081.483073938721;6083.148359229712;5834.854128646775;5977.282726072855;5982.132590774357;5996.100584912255;6024.3674414186535;4623.8150473981;5284.603654725873;5296.311479507678;5298.841034768963;5301.390340110898;12045.337506437143;12329.815052774216;12361.752764944651;12372.1958072725;12379.257244565355;1703.880728349016;1734.9913250433792;1768.32803534656;1863.8974856382893;1885.77370715515;8941.731748047569;8992;9040.186383225542;9268.536573171314;9490.335676502647;1655.246862677479;1667.1497536256597;1703.0973584000499;1712.5889786451287;1714.5113642611796;67383.66308168428;69775.65112174458;69870;71578.28421715768;72129;9871.555779989918;9969.252306077073;10041.899581004243;10182.134518566005;10256.897431025744;13544.93227533856;13652.726945461036;13655.863441365658;13661.931690341484;13688.589342319747;6407;6544.803655890331;6642.60505293884;6694.09629699994;6735.259121496631;6026.6986650667295;6105.755769769248;6244.65654389013;6250.874982500415;6254.21822272216;4240;4246.787660617018;4283.079137985285;4283.700140990163;4388.539203383662;1630.4293497276096;1713.7857767779028;1801.783785945695;1809.7375880497254;1820.144532069925;776.2043904997423;808.9393295502861;847.9872801907976;886.7561420609384;891.0554811899278;16560.254788534545;16812.411565595146;17290;17471.737923931152;17854.5536361592;822.6051495282298;838.2497664590279;866.0213958227163;891.3359547137425;930.4091901642506;9415.105564971316;9954.253430992705;10039.648612298535;10059.949700251598;10064.446455444875;366118;366282;367650;400604;403623;47759.283610745864;49025;79750;83022.16977830265;84040;876.7238319929329;915.1397686174975;951.286535098676;951.6193522591019;956.53129966316;14766.33551490164;15840.44558440449;16487.917560412123;16552.503424897273;16672.583185420463;25837.741622583533;25992.61011084873;37034.44448333331;37255;38673.41989870211;50704.23943640775;50777.49222507876;51298.04880243568;52245;54603.18095228495;4277.098873194716;7285.672144753393;7443.776686699408;7576.6969321228735;7787.727429539939;5859.384764599826;9377.531123443665;9493.952530237304;11074.833877491683;11355.886441135814;9583.664571739955;9833.262505311986;10004.24968127408;10091.798164036825;10541.420221887563;9822.607095716092;10227.795444090927;10378.169746420419;10668.519916603927;10733.463326833471;10507.106895913626;10525.842112368167;10533.36799792015;10820.350778953289;11092.500837462172;6349.365063493614;6737.9326206737305;6752.324767523209;6846.110005699227;7074.257202993612;7904.6838126474295;9583.233341332538;10288.691339259834;10349.63776267827;10368.481575921023 08:54:16 INFO - PROCESS | 30772 | |3;mootools.html;1364.8976326775492;1389.6525868532867;1454.716330315589;1578.5185518416893;1637.4269005847948;7046.2601426850215;7603.961980190092;7616.543007419558;7627.771166864989;7652.19651936547;6641.501887358455;7169.533980291278;7479.663415146318;7487;7744.767656970286;2091.870389989404;2125.362391282617;2132.562824620949;2136.1455417832835;2136.177571634924;2112.3768488295914;2129.7231359923267;2168.2844661261747;2170.967435488469;2172.913083476659;2121.501447159916;2136.7863213678584;2143.6355819510723;2145.09905839547;2148.591767564166;2086.1446806809213;2093.455701517601;2094.968575471369;2095.9101267340898;2096.863703859244;2074.3362124120285;2116.8518203725744;2118.5762847430574;2120.120150137691;2121.3847984084596;7549.50928189666;7629.351505122016;7639.121501027397;7642.5032372895585;7645.120811106738;4171.10321280923;4292.077203401283;4298.763568003758;4300.784960751981;4304.720193187432;2726.168518601826;2787.7351651593267;2831.419558990402;2835.036087730161;2842.459932612797;928.3312583937021;965.5896244096231;982.6020461713018;987.521052289639;994.7562847102506;10534.525946332433;10575.471226438724;10581.206409519316;10587.576496940113;10594.205434592359;3820.8089595520114;3906.6679332257077;3981.880543583697;4062.0502158963864;4062.289099407592;8958.372913896095;8967.686130985385;8984.55077246135;8985.820283594292;8986.55067246635;4257.446531950888;4277.272863613193;4281.036766727524;4282.907858496126;4284.828606855691;3479.565054368204;3753.9249215016093;3937.8186544036676;3954.584768599313;3955.327594308917;3470;3518.40187168182;3642.7267954903486;3649.61679023704;3669.743117981716;1156.7512984708328;1163.2962057954985;1182.9290242585473;1195.2649120790652;1207.710149564116;640.7533099756535;709.6558169287891;731.8536292741474;736.296836521121;752.3341842469454;4761.166795810788;4933.28467372229;4958.181899986534;4974.328465657162;5034.949650503521;342.9796355841352;367.6286950180284;368.29655358265586;373.31869338457426;381.09870157078865;3262.9347413051605;3308.1912130533083;3321.153105957965;3332.9666703332655;3437;8990.145936136056;9174.495402752913;9237.3533852631;9280.303977201736;9387.155156035853;9093.77265568366;9231.261499080058;9238.676646317346;9255.814883702424;9311.301652375963;7117.3238542338395;7141.678624461912;7192.496525243288;7203.711851525985;7207.387372073327;4798.749278046637;4811.013742182774;4843.588294994965;4899.853004409873;4977.303177555217;8264.586770661323;8465.915340846514;8724.91275087241;8742.344324175585;8760.299176066026;8604.569771511524;8644.394892357475;8762.868556971778;8830.205281524693;8854.778630534289;5939.881202376015;6323.083152942706;6551.80344589663;6605.174353205849;6612.272650008592;6953.65231738401;7190.424766018601;7200.675969581486;7201.927980720336;7203.279672032755;6391.936080639134;6468.482521398371;6545.443637290884;6676.49926255523;6697.229818570927;6338.841528961812;6363.936360636334;6392.328805475358;6397.96801015992;6398.872022559616;6016.8796624068145;6083.482903953037;6094.664793436404;6102.176206212104;6102.633841969496;4328.112736888993;4338.349247612883;4375.365571992107;4486.5631102609;4517.706349087299;4379.934300985424;4384.298512238027;4386.846460373871;4387.473503179639;4447.444069491314 08:54:16 INFO - PROCESS | 30772 | |4;prototype.html;296.1426669790955;298.935728818304;304.61314131053564;306.5907014136127;308.8764494202317;4836.782344794484;4874.049560335736;4874.415070191573;4877.878053048676;4901.142300097482;4808.567228949394;4821.951780482203;4873.171560834658;4873.658843880929;4888.340074089997;3644.6173151819075;3721.981390093046;3766.9452553285123;3829.6936245100324;3835.405512145608;3818.0836599216127;3820.4842346283313;3822.73240873139;3827.870778120461;3835.6356146166067;3772.9811350943346;3781.73527853049;3783.4487859977417;3786.678132358753;3791.791451470168;3625.963740362602;3673.1000904778502;3746.8875933722034;3760.699144068468;3819.2743378758087;3330.383878982396;3337.8664853405835;3339.716124129452;3350.212700015494;3380.7126394256516;4679.485256621769;4713.457952335491;4730.195866702668;4734.502877197879;4741.691790033637;4150.211459822624;4365.956340436618;4369.71596846204;4374.496932852699;4380.518143004267;4950.9504904950845;4952.059108769358;4984.925226121611;4994.625403094746;4997.800087996476;3655.817209139532;3667.3948798448223;3670.8164591770574;3687.340696686502;3697.4453831925157;5110.412302585176;5312.256284120226;5326.280952071459;5353.2601904380845;5357.249985002064;3704.7406681532575;3736.795290778454;3738.831752571141;3746.7751934883995;3747.981260093682;3792.943105853414;3803.904902377463;3808.4858544096746;3809.2381523694817;3819.6371344722206;4318.438602981592;4340.500842403164;4341.544137865479;4345.34819777036;4360.280553708666;4847.442544107473;5067.619928505377;5069.264956581349;5121.106574785234;5133.640645154804;1266.7276535544902;1281.4681907008674;1286.498265676387;1286.8289856230786;1289.8581156072823;783.7805414483839;817.804195734443;821.5399376349263;828.9751307460785;829.4069740135832;4356.150550642657;4465.240909045405;4530.77346132692;4532.456105267323;4532.864014079583;5184.455632158644;5189.922151167735;5198.8960220796125;5208.801975545645;5234.502722241381;4484.887877803016;4515.977420112944;4528.977355113203;4532.5694059064335;4532.9546704533195;2582.690077190749;2766.695663477016;2770.612114303999;2787.7909156812916;2790.5953636722966;4917.237828136645;4933.260010998379;4955.4548999610015;4969.279454479152;4976.975115124401;5116.130257856174;5333.2266821310695;5349.919751203735;5365.517103460707;5381.704006279614;4923.261510773341;4940.677881395738;4957.950420495821;4958.727270000185;4964.304997300381;5211.827338848729;5238.895222095613;5254.13306804373;5261.947380526146;5270.947290527046;4943.283223932438;5145.7941682333785;5156.9742151289;5162.741862906914;5186.948130518646;4884.340614017062;4891.437484689164;4924.926126108039;4934.358533390637;4938.975305123451;3636.1455058061865;3660.1764602965186;3697.22358304759;3719.6652301293016;3720;5016.448190699093;5258.579313654822;5261.34302177398;5278.498542638443;5280.419153892992;5001.8499445016705;5041.571466425395;5071.315372424676;5073.213651883964;5089.13484707608;5050.671706339076;5076.7207803571155;5077.289179514944;5138.3063286457345;5169.431362550192;4864.343313652612;5007.69953802773;5050.444451110301;5059.316992206005;5060.291559181644;4905.23968784839;4919.950800492093;5085.7457127144235;5103.285540024325;5179.404368497671;5009.824656137018;5024.196128619404;5058.2685349910635;5066.721330326867;5068.543831055223 08:54:16 INFO - PROCESS | 30772 | |5;yui.html;564.6583816790842;578.2771535580523;594.0317282828988;602.1900543768629;617.0620656601965;11403.258788178762;11745;12381.628551143458;12510.749785004295;12550;12650.62048138555;12712.046596505254;12771.808422873664;12775;12776.616701498946;737.7491652838034;751.2112282103797;755.3202118093704;756.1493320014984;757.1293013034999;618.035864052078;725.314577724051;750.4896670264218;753.0661979145874;757.6514803190539;787.9527228366288;789.5144486141039;789.72754399732;790.2018960849555;790.2374208888422;781.7850091224901;783.3380793229712;783.5847001089431;783.6395258181243;783.7256960063961;469.8026828731941;480.61550759392696;482.66695979773846;482.80929033032106;549.8295528386213;10514.474276286155;10860.837087443615;10882.61910833117;10887.83668244977;10891.67324980252;11581.768364632744;11799.46902389386;11852;11970.521179152824;12629.24224546521;11222.943885280603;11255;11316.151288653384;11341.092712582973;11484.13868959823;3935.7917916322053;3978.8010599469912;4003.3794761811964;4019.1760689058674;4055.9188816223805;62883.81184119962;63624.68187659078;63690;63716.681416593085;66756.6662166686;9664.661736839318;9815.558299876522;10098.747531311776;10138.797224055625;10156.746081348025;19094.71357929632;19233.03834808254;19239.51901202481;19246;19261.13324900383;6685.6322902240845;6761.29006454325;6780.084688567079;6959.4432445404245;7060.435165186773;3722.3113723961155;3728.2357116790995;3738.700903927679;3779.962200377961;3856.9807150964066;2597.38961344084;2663.067926225844;2687.798415118874;2693.111273279813;2712.8372297662204;502.379561241866;503.92189210672404;507.73851466494784;513.946409859786;514.5497689521668;399.97400168988923;450.6867726929818;457.61103062396694;467.1917582582152;475.9737175427497;6704.631245281556;6944.930550694529;7075.080239568926;7123.501354905107;7373.594452305175;397.6477454263063;430.25351015987235;463.6105671236178;488.66526429395975;492.7511606638696;3169.3185965017633;3340.6993370596765;3427.9657203428146;3498.1079824644553;3575.928481430357;98935.17037274002;99809;101197;103726;103778;68183.65908170427;69554.65222673955;70149.64925175444;86223;90420.5478972601;71308;71570.64214678893;71947.64026179835;72077;72349.6382518084;7427.7771666850085;8061.879071814044;8198.1391953844;8265.752027439186;8289.502629842229;39248;41779.77905020576;42333;42466.36300455558;43458.56541434545;53300.73349633227;57822.4217757817;59526;60078;60266.39733602608;10135.442550659785;10679.89320106789;10708.464576771286;10766.623168189075;10821.458927053773;9426.434413935185;9451.858222126812;9550.665726699532;10316.43259620728;11827.645170644895;8969.237614802814;10328.741781455523;10350.482475876326;10920.344779313267;11269.830952535882;10550.208734344802;10659.840102398315;10958.232923695265;11038.779224415628;11407.429628518375;10808.405537695502;10896.564137434414;11023.944880275547;11250.268732532359;11646.068314534647;8815;8871.733847984571;9312.44125352481;9370.718878433658;9418.529073546433;8570.52862092566;9408.153266206074;9438.339316248072;9630;9727.708168754949 08:54:16 INFO - PROCESS | 30772 | __end_tp_report 08:54:16 INFO - PROCESS | 30772 | __start_cc_report 08:54:16 INFO - PROCESS | 30772 | _x_x_mozilla_cycle_collect,1088 08:54:16 INFO - PROCESS | 30772 | __end_cc_report 08:54:16 INFO - PROCESS | 30772 | __startTimestamp1471967656888__endTimestamp 08:54:16 INFO - PROCESS | 30772 | 08:54:16 INFO - PROCESS | 30772 | ------- Summary: start ------- 08:54:16 INFO - PROCESS | 30772 | Number of tests: 6 08:54:16 INFO - PROCESS | 30772 | 08:54:16 INFO - PROCESS | 30772 | [#0] dojo.html Cycles:165 Average:4619.93 Median:4740.41 stddev:476.58 (10.1%) stddev-sans-first:450.08 08:54:16 INFO - PROCESS | 30772 | Values: 2569.7 2594.5 2602.7 2638.5 2652.9 4556.2 4585.1 4610.9 4658.2 4670.8 4609.6 4632.2 4648.3 4667.0 4693.8 4212.4 4245.8 4281.1 4344.5 4451.9 4376.3 4391.4 4445.0 4455.6 4457.5 4237.6 4264.7 4356.4 4372.7 4469.0 4215.9 4234.7 4260.5 4283.8 4303.2 4216.0 4265.8 4268.0 4277.9 4325.7 4577.2 4595.1 4646.3 4649.4 4695.3 4904.9 4941.4 4962.7 5018.8 5028.5 4910.9 4923.9 4934.1 4964.0 5011.5 4538.7 4657.8 4661.8 4669.1 4671.9 5005.2 5087.0 5131.0 5146.2 5192.9 4941.7 4951.5 4954.4 4958.3 5023.9 5017.4 5023.9 5026.3 5028.6 5028.9 4855.3 4871.3 4881.8 4917.4 4954.8 4853.7 4855.9 4863.2 4886.8 4920.2 4218.2 4236.8 4263.5 4272.3 4318.1 3669.4 3684.0 3690.0 3727.6 3757.0 4339.4 4365.7 4408.8 4417.6 4421.3 4999.1 5031.6 5032.4 5034.2 5094.9 4291.7 4328.2 4340.4 4357.5 4363.1 4463.0 4464.6 4487.1 4528.8 4539.0 4683.8 4716.6 4718.2 4721.5 4770.3 4906.5 4963.4 5008.2 5008.6 5050.4 4671.6 4712.4 4726.3 4740.4 4779.5 4941.2 4942.8 4942.9 4946.2 5006.4 4912.2 5001.2 5025.1 5027.9 5079.7 4820.2 4839.0 4865.6 4874.7 4934.9 4835.9 4848.9 4850.8 4863.8 4913.3 4741.2 4791.5 4813.8 4831.4 4899.9 4863.2 4893.2 4901.3 4903.4 4981.9 4803.9 4811.8 4815.3 4824.3 4872.0 08:54:16 INFO - PROCESS | 30772 | 08:54:16 INFO - PROCESS | 30772 | [#1] ext.html Cycles:180 Average:45247.26 Median:37528.41 stddev:81648.66 (217.6%) stddev-sans-first:81808.65 08:54:16 INFO - PROCESS | 30772 | Values: 520.7 531.8 573.2 586.4 587.6 27959.4 37589.0 39022.8 39163.0 42197.2 39546.4 39753.6 39978.8 40041.8 40086.0 7502.8 7603.7 7654.9 7656.5 7656.5 7639.7 7714.5 7729.8 7730.8 7734.0 7399.4 7491.0 7494.2 7498.7 7528.1 7652.4 7678.9 7714.2 7714.6 7768.5 7607.8 7680.6 7680.7 7683.1 7684.3 37467.8 37853.0 37880.2 37880.2 37884.6 2382.6 2470.9 2512.1 2520.1 2713.7 27426.9 27798.7 28056.2 28094.9 28668.3 3341.3 3431.2 3456.8 3560.5 3574.1 253237.0 255477.0 255880.0 255880.0 255923.0 52061.5 52547.8 52563.2 52575.7 52584.5 32039.4 32920.0 33091.0 34768.0 55774.0 12965.5 13147.3 13178.5 13194.7 13196.1 9750.6 9810.8 9813.3 9835.7 9842.3 17667.9 17671.6 17688.1 17715.9 17761.9 6567.0 6670.7 6706.4 6757.7 6890.8 766.2 874.0 933.2 955.5 962.0 26541.5 26884.2 27201.9 27276.7 27708.9 837.5 871.2 884.9 905.2 989.7 14273.7 14443.6 14472.9 14771.3 14880.0 376954.0 378380.0 379401.0 381867.0 383952.0 47249.3 47830.3 48028.3 48051.8 48061.0 1056.2 1120.1 1165.1 1179.9 1183.6 26739.5 28051.2 28951.7 29017.3 29451.4 40150.4 40764.4 40812.6 40870.0 40888.2 280245.0 280433.0 281482.0 281700.0 282528.0 22002.2 23779.8 24797.0 24833.9 25946.7 40285.4 40506.4 40870.6 41300.4 41896.4 34823.7 34837.7 34891.8 35639.3 35651.6 31535.4 31555.5 31657.4 31793.8 32493.5 34229.0 34494.5 35714.6 36906.6 36934.4 30197.0 31785.7 32876.7 33195.3 33302.8 24648.5 25086.1 25422.7 25619.4 25829.9 08:54:16 INFO - PROCESS | 30772 | 08:54:16 INFO - PROCESS | 30772 | [#2] jquery.html Cycles:180 Average:23383.24 Median:4506.18 stddev:62976.33 (1397.6%) stddev-sans-first:63129.28 08:54:16 INFO - PROCESS | 30772 | Values: 368.4 371.4 374.8 381.8 391.6 15898.7 16908.7 17008.7 17097.4 17107.7 15192.5 15813.4 15927.4 15943.1 16013.6 4832.2 5109.1 5111.0 5112.5 5114.5 3707.3 3900.4 5034.2 5758.1 5981.6 6071.5 6073.4 6078.9 6081.5 6083.1 5834.9 5977.3 5982.1 5996.1 6024.4 4623.8 5284.6 5296.3 5298.8 5301.4 12045.3 12329.8 12361.8 12372.2 12379.3 1703.9 1735.0 1768.3 1863.9 1885.8 8941.7 8992.0 9040.2 9268.5 9490.3 1655.2 1667.1 1703.1 1712.6 1714.5 67383.7 69775.7 69870.0 71578.3 72129.0 9871.6 9969.3 10041.9 10182.1 10256.9 13544.9 13652.7 13655.9 13661.9 13688.6 6407.0 6544.8 6642.6 6694.1 6735.3 6026.7 6105.8 6244.7 6250.9 6254.2 4240.0 4246.8 4283.1 4283.7 4388.5 1630.4 1713.8 1801.8 1809.7 1820.1 776.2 808.9 848.0 886.8 891.1 16560.3 16812.4 17290.0 17471.7 17854.6 822.6 838.2 866.0 891.3 930.4 9415.1 9954.3 10039.6 10059.9 10064.4 366118.0 366282.0 367650.0 400604.0 403623.0 47759.3 49025.0 79750.0 83022.2 84040.0 876.7 915.1 951.3 951.6 956.5 14766.3 15840.4 16487.9 16552.5 16672.6 25837.7 25992.6 37034.4 37255.0 38673.4 50704.2 50777.5 51298.0 52245.0 54603.2 4277.1 7285.7 7443.8 7576.7 7787.7 5859.4 9377.5 9494.0 11074.8 11355.9 9583.7 9833.3 10004.2 10091.8 10541.4 9822.6 10227.8 10378.2 10668.5 10733.5 10507.1 10525.8 10533.4 10820.4 11092.5 6349.4 6737.9 6752.3 6846.1 7074.3 7904.7 9583.2 10288.7 10349.6 10368.5 08:54:16 INFO - PROCESS | 30772 | 08:54:16 INFO - PROCESS | 30772 | [#3] mootools.html Cycles:180 Average:4930.63 Median:4779.96 stddev:2812.43 (58.8%) stddev-sans-first:2807.55 08:54:16 INFO - PROCESS | 30772 | Values: 1364.9 1389.7 1454.7 1578.5 1637.4 7046.3 7604.0 7616.5 7627.8 7652.2 6641.5 7169.5 7479.7 7487.0 7744.8 2091.9 2125.4 2132.6 2136.1 2136.2 2112.4 2129.7 2168.3 2171.0 2172.9 2121.5 2136.8 2143.6 2145.1 2148.6 2086.1 2093.5 2095.0 2095.9 2096.9 2074.3 2116.9 2118.6 2120.1 2121.4 7549.5 7629.4 7639.1 7642.5 7645.1 4171.1 4292.1 4298.8 4300.8 4304.7 2726.2 2787.7 2831.4 2835.0 2842.5 928.3 965.6 982.6 987.5 994.8 10534.5 10575.5 10581.2 10587.6 10594.2 3820.8 3906.7 3981.9 4062.1 4062.3 8958.4 8967.7 8984.6 8985.8 8986.6 4257.4 4277.3 4281.0 4282.9 4284.8 3479.6 3753.9 3937.8 3954.6 3955.3 3470.0 3518.4 3642.7 3649.6 3669.7 1156.8 1163.3 1182.9 1195.3 1207.7 640.8 709.7 731.9 736.3 752.3 4761.2 4933.3 4958.2 4974.3 5034.9 343.0 367.6 368.3 373.3 381.1 3262.9 3308.2 3321.2 3333.0 3437.0 8990.1 9174.5 9237.4 9280.3 9387.2 9093.8 9231.3 9238.7 9255.8 9311.3 7117.3 7141.7 7192.5 7203.7 7207.4 4798.7 4811.0 4843.6 4899.9 4977.3 8264.6 8465.9 8724.9 8742.3 8760.3 8604.6 8644.4 8762.9 8830.2 8854.8 5939.9 6323.1 6551.8 6605.2 6612.3 6953.7 7190.4 7200.7 7201.9 7203.3 6391.9 6468.5 6545.4 6676.5 6697.2 6338.8 6363.9 6392.3 6398.0 6398.9 6016.9 6083.5 6094.7 6102.2 6102.6 4328.1 4338.3 4375.4 4486.6 4517.7 4379.9 4384.3 4386.8 4387.5 4447.4 08:54:16 INFO - PROCESS | 30772 | 08:54:16 INFO - PROCESS | 30772 | [#4] prototype.html Cycles:180 Average:4224.54 Median:4873.42 stddev:1229.13 (25.2%) stddev-sans-first:1196.68 08:54:16 INFO - PROCESS | 30772 | Values: 296.1 298.9 304.6 306.6 308.9 4836.8 4874.0 4874.4 4877.9 4901.1 4808.6 4822.0 4873.2 4873.7 4888.3 3644.6 3722.0 3766.9 3829.7 3835.4 3818.1 3820.5 3822.7 3827.9 3835.6 3773.0 3781.7 3783.4 3786.7 3791.8 3626.0 3673.1 3746.9 3760.7 3819.3 3330.4 3337.9 3339.7 3350.2 3380.7 4679.5 4713.5 4730.2 4734.5 4741.7 4150.2 4366.0 4369.7 4374.5 4380.5 4951.0 4952.1 4984.9 4994.6 4997.8 3655.8 3667.4 3670.8 3687.3 3697.4 5110.4 5312.3 5326.3 5353.3 5357.2 3704.7 3736.8 3738.8 3746.8 3748.0 3792.9 3803.9 3808.5 3809.2 3819.6 4318.4 4340.5 4341.5 4345.3 4360.3 4847.4 5067.6 5069.3 5121.1 5133.6 1266.7 1281.5 1286.5 1286.8 1289.9 783.8 817.8 821.5 829.0 829.4 4356.2 4465.2 4530.8 4532.5 4532.9 5184.5 5189.9 5198.9 5208.8 5234.5 4484.9 4516.0 4529.0 4532.6 4533.0 2582.7 2766.7 2770.6 2787.8 2790.6 4917.2 4933.3 4955.5 4969.3 4977.0 5116.1 5333.2 5349.9 5365.5 5381.7 4923.3 4940.7 4958.0 4958.7 4964.3 5211.8 5238.9 5254.1 5261.9 5270.9 4943.3 5145.8 5157.0 5162.7 5186.9 4884.3 4891.4 4924.9 4934.4 4939.0 3636.1 3660.2 3697.2 3719.7 3720.0 5016.4 5258.6 5261.3 5278.5 5280.4 5001.8 5041.6 5071.3 5073.2 5089.1 5050.7 5076.7 5077.3 5138.3 5169.4 4864.3 5007.7 5050.4 5059.3 5060.3 4905.2 4920.0 5085.7 5103.3 5179.4 5009.8 5024.2 5058.3 5066.7 5068.5 08:54:16 INFO - PROCESS | 30772 | 08:54:16 INFO - PROCESS | 30772 | [#5] yui.html Cycles:180 Average:17099.08 Median:478.29 stddev:24973.12 (5221.3%) stddev-sans-first:25012.32 08:54:16 INFO - PROCESS | 30772 | Values: 564.7 578.3 594.0 602.2 617.1 11403.3 11745.0 12381.6 12510.7 12550.0 12650.6 12712.0 12771.8 12775.0 12776.6 737.7 751.2 755.3 756.1 757.1 618.0 725.3 750.5 753.1 757.7 788.0 789.5 789.7 790.2 790.2 781.8 783.3 783.6 783.6 783.7 469.8 480.6 482.7 482.8 549.8 10514.5 10860.8 10882.6 10887.8 10891.7 11581.8 11799.5 11852.0 11970.5 12629.2 11222.9 11255.0 11316.2 11341.1 11484.1 3935.8 3978.8 4003.4 4019.2 4055.9 62883.8 63624.7 63690.0 63716.7 66756.7 9664.7 9815.6 10098.7 10138.8 10156.7 19094.7 19233.0 19239.5 19246.0 19261.1 6685.6 6761.3 6780.1 6959.4 7060.4 3722.3 3728.2 3738.7 3780.0 3857.0 2597.4 2663.1 2687.8 2693.1 2712.8 502.4 503.9 507.7 513.9 514.5 400.0 450.7 457.6 467.2 476.0 6704.6 6944.9 7075.1 7123.5 7373.6 397.6 430.3 463.6 488.7 492.8 3169.3 3340.7 3428.0 3498.1 3575.9 98935.2 99809.0 101197.0 103726.0 103778.0 68183.7 69554.7 70149.6 86223.0 90420.5 71308.0 71570.6 71947.6 72077.0 72349.6 7427.8 8061.9 8198.1 8265.8 8289.5 39248.0 41779.8 42333.0 42466.4 43458.6 53300.7 57822.4 59526.0 60078.0 60266.4 10135.4 10679.9 10708.5 10766.6 10821.5 9426.4 9451.9 9550.7 10316.4 11827.6 8969.2 10328.7 10350.5 10920.3 11269.8 10550.2 10659.8 10958.2 11038.8 11407.4 10808.4 10896.6 11023.9 11250.3 11646.1 8815.0 8871.7 9312.4 9370.7 9418.5 8570.5 9408.2 9438.3 9630.0 9727.7 08:54:16 INFO - PROCESS | 30772 | -------- Summary: end -------- 08:54:16 INFO - PROCESS | 30772 | 08:54:17 INFO - TEST-INFO | 30772: exit 0 08:54:17 INFO - TEST-OK | dromaeo_css | took 1122245ms 08:54:17 INFO - TEST-START | kraken 08:54:17 INFO - operating with platform_type : linux_ 08:54:17 INFO - Initialising browser for kraken test... 08:54:17 INFO - TEST-INFO | started process 31076 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxCv2jE/profile http://localhost:51803/getInfo.html) 08:54:23 INFO - PROCESS | 31076 | __metrics Screen width/height:1600/1200 08:54:23 INFO - PROCESS | 31076 | colorDepth:24 08:54:23 INFO - PROCESS | 31076 | Browser inner width/height: 1024/697 08:54:23 INFO - PROCESS | 31076 | __metrics 08:54:23 INFO - PROCESS | 31076 | 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" 08:54:23 INFO - PROCESS | 31076 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:54:24 INFO - PROCESS | 31076 | console.error: PushService: 08:54:24 INFO - PROCESS | 31076 | stateChangeProcessEnqueue: Error transitioning state 08:54:24 INFO - PROCESS | 31076 | UnknownError 08:54:25 INFO - TEST-INFO | 31076: exit 0 08:54:25 INFO - Browser initialized. 08:54:25 INFO - Running cycle 1/1 for kraken test... 08:54:25 INFO - TEST-INFO | started process 31156 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxCv2jE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:37 INFO - PROCESS | 31156 | RSS: Main: 184819712 08:54:37 INFO - PROCESS | 31156 | 08:54:40 INFO - PROCESS | 31156 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51803/tests/kraken/driver.html?testName=audio-beat-detection) 08:54:41 INFO - PROCESS | 31156 | RSS: Main: 245227520 08:54:41 INFO - PROCESS | 31156 | 08:54:43 INFO - PROCESS | 31156 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51803/tests/kraken/driver.html?testName=audio-dft) 08:54:44 INFO - PROCESS | 31156 | RSS: Main: 226975744 08:54:44 INFO - PROCESS | 31156 | 08:54:47 INFO - PROCESS | 31156 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51803/tests/kraken/driver.html?testName=audio-fft) 08:54:48 INFO - PROCESS | 31156 | RSS: Main: 305561600 08:54:48 INFO - PROCESS | 31156 | 08:54:50 INFO - PROCESS | 31156 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51803/tests/kraken/driver.html?testName=audio-oscillator) 08:54:51 INFO - PROCESS | 31156 | RSS: Main: 213876736 08:54:51 INFO - PROCESS | 31156 | 08:54:53 INFO - PROCESS | 31156 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51803/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:54:53 INFO - PROCESS | 31156 | RSS: Main: 215056384 08:54:53 INFO - PROCESS | 31156 | 08:54:57 INFO - PROCESS | 31156 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51803/tests/kraken/driver.html?testName=imaging-darkroom) 08:54:57 INFO - PROCESS | 31156 | RSS: Main: 253337600 08:54:57 INFO - PROCESS | 31156 | 08:55:01 INFO - PROCESS | 31156 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51803/tests/kraken/driver.html?testName=imaging-desaturate) 08:55:01 INFO - PROCESS | 31156 | RSS: Main: 247836672 08:55:01 INFO - PROCESS | 31156 | 08:55:04 INFO - PROCESS | 31156 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51803/tests/kraken/driver.html?testName=json-parse-financial) 08:55:05 INFO - PROCESS | 31156 | RSS: Main: 250834944 08:55:05 INFO - PROCESS | 31156 | 08:55:07 INFO - PROCESS | 31156 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51803/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:55:07 INFO - PROCESS | 31156 | RSS: Main: 214646784 08:55:07 INFO - PROCESS | 31156 | 08:55:09 INFO - PROCESS | 31156 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51803/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:55:10 INFO - PROCESS | 31156 | RSS: Main: 221900800 08:55:10 INFO - PROCESS | 31156 | 08:55:12 INFO - PROCESS | 31156 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51803/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:55:13 INFO - PROCESS | 31156 | RSS: Main: 222892032 08:55:13 INFO - PROCESS | 31156 | 08:55:16 INFO - PROCESS | 31156 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:55:16 INFO - PROCESS | 31156 | RSS: Main: 218476544 08:55:16 INFO - PROCESS | 31156 | 08:55:19 INFO - PROCESS | 31156 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:55:20 INFO - PROCESS | 31156 | RSS: Main: 221892608 08:55:20 INFO - PROCESS | 31156 | 08:55:22 INFO - PROCESS | 31156 | Cycle 1(1): loaded http://localhost:51803/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51803/tests/kraken/driver.html?testName=ai-astar) 08:55:22 INFO - PROCESS | 31156 | RSS: Main: 272764928 08:55:22 INFO - PROCESS | 31156 | 08:55:22 INFO - PROCESS | 31156 | __start_tp_report 08:55:22 INFO - PROCESS | 31156 | _x_x_mozilla_page_load 08:55:22 INFO - PROCESS | 31156 | _x_x_mozilla_page_load_details 08:55:22 INFO - PROCESS | 31156 | |i|pagename|runs| 08:55:22 INFO - PROCESS | 31156 | |0;ai-astar;114;115;127;114;112;114;113;113;114;112 08:55:22 INFO - PROCESS | 31156 | |1;audio-beat-detection;150;125;144;185;123;148;147;128;189;121 08:55:22 INFO - PROCESS | 31156 | |2;audio-dft;162;162;164;161;162;161;161;162;158;159 08:55:22 INFO - PROCESS | 31156 | |3;audio-fft;76;77;76;165;76;77;76;76;158;77 08:55:22 INFO - PROCESS | 31156 | |4;audio-oscillator;86;86;165;88;88;88;146;86;87;143 08:55:22 INFO - PROCESS | 31156 | |5;imaging-gaussian-blur;117;118;116;117;117;117;117;117;118;117 08:55:22 INFO - PROCESS | 31156 | |6;imaging-darkroom;147;147;146;146;147;147;147;147;146;147 08:55:22 INFO - PROCESS | 31156 | |7;imaging-desaturate;95;95;94;94;94;95;95;94;95;95 08:55:22 INFO - PROCESS | 31156 | |8;json-parse-financial;65;66;66;67;67;73;66;67;66;70 08:55:22 INFO - PROCESS | 31156 | |9;json-stringify-tinderbox;65;66;66;66;65;65;67;65;66;66 08:55:22 INFO - PROCESS | 31156 | |10;stanford-crypto-aes;83;82;88;83;85;82;91;83;83;85 08:55:22 INFO - PROCESS | 31156 | |11;stanford-crypto-ccm;135;137;131;134;133;143;132;144;164;134 08:55:22 INFO - PROCESS | 31156 | |12;stanford-crypto-pbkdf2;173;175;174;173;173;174;179;169;170;169 08:55:22 INFO - PROCESS | 31156 | |13;stanford-crypto-sha256-iterative;70;69;73;70;70;72;69;68;74;68 08:55:22 INFO - PROCESS | 31156 | __end_tp_report 08:55:22 INFO - PROCESS | 31156 | __start_cc_report 08:55:22 INFO - PROCESS | 31156 | _x_x_mozilla_cycle_collect,1978 08:55:22 INFO - PROCESS | 31156 | __end_cc_report 08:55:22 INFO - PROCESS | 31156 | __startTimestamp1471967722371__endTimestamp 08:55:22 INFO - PROCESS | 31156 | 08:55:22 INFO - PROCESS | 31156 | ------- Summary: start ------- 08:55:22 INFO - PROCESS | 31156 | Number of tests: 14 08:55:22 INFO - PROCESS | 31156 | 08:55:22 INFO - PROCESS | 31156 | [#0] ai-astar Cycles:10 Average:114.80 Median:114.00 stddev:4.39 (3.9%) stddev-sans-first:4.65 08:55:22 INFO - PROCESS | 31156 | Values: 114.0 115.0 127.0 114.0 112.0 114.0 113.0 113.0 114.0 112.0 08:55:22 INFO - PROCESS | 31156 | 08:55:22 INFO - PROCESS | 31156 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:147.50 stddev:24.30 (16.5%) stddev-sans-first:25.73 08:55:22 INFO - PROCESS | 31156 | Values: 150.0 125.0 144.0 185.0 123.0 148.0 147.0 128.0 189.0 121.0 08:55:22 INFO - PROCESS | 31156 | 08:55:22 INFO - PROCESS | 31156 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.69 (1.0%) stddev-sans-first:1.76 08:55:22 INFO - PROCESS | 31156 | Values: 162.0 162.0 164.0 161.0 162.0 161.0 161.0 162.0 158.0 159.0 08:55:22 INFO - PROCESS | 31156 | 08:55:22 INFO - PROCESS | 31156 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.00 stddev:35.93 (47.3%) stddev-sans-first:37.56 08:55:22 INFO - PROCESS | 31156 | Values: 76.0 77.0 76.0 165.0 76.0 77.0 76.0 76.0 158.0 77.0 08:55:22 INFO - PROCESS | 31156 | 08:55:22 INFO - PROCESS | 31156 | [#4] audio-oscillator Cycles:10 Average:106.30 Median:86.50 stddev:31.59 (36.5%) stddev-sans-first:32.64 08:55:22 INFO - PROCESS | 31156 | Values: 86.0 86.0 165.0 88.0 88.0 88.0 146.0 86.0 87.0 143.0 08:55:22 INFO - PROCESS | 31156 | 08:55:22 INFO - PROCESS | 31156 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:55:22 INFO - PROCESS | 31156 | Values: 117.0 118.0 116.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 08:55:22 INFO - PROCESS | 31156 | 08:55:22 INFO - PROCESS | 31156 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 08:55:22 INFO - PROCESS | 31156 | Values: 147.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 08:55:22 INFO - PROCESS | 31156 | 08:55:22 INFO - PROCESS | 31156 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:55:22 INFO - PROCESS | 31156 | Values: 95.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 95.0 95.0 08:55:22 INFO - PROCESS | 31156 | 08:55:22 INFO - PROCESS | 31156 | [#8] json-parse-financial Cycles:10 Average:67.30 Median:67.00 stddev:2.41 (3.6%) stddev-sans-first:2.40 08:55:22 INFO - PROCESS | 31156 | Values: 65.0 66.0 66.0 67.0 67.0 73.0 66.0 67.0 66.0 70.0 08:55:22 INFO - PROCESS | 31156 | 08:55:22 INFO - PROCESS | 31156 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 08:55:22 INFO - PROCESS | 31156 | Values: 65.0 66.0 66.0 66.0 65.0 65.0 67.0 65.0 66.0 66.0 08:55:22 INFO - PROCESS | 31156 | 08:55:22 INFO - PROCESS | 31156 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:2.92 (3.5%) stddev-sans-first:3.04 08:55:22 INFO - PROCESS | 31156 | Values: 83.0 82.0 88.0 83.0 85.0 82.0 91.0 83.0 83.0 85.0 08:55:22 INFO - PROCESS | 31156 | 08:55:22 INFO - PROCESS | 31156 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:136.00 stddev:9.91 (7.3%) stddev-sans-first:10.42 08:55:22 INFO - PROCESS | 31156 | Values: 135.0 137.0 131.0 134.0 133.0 143.0 132.0 144.0 164.0 134.0 08:55:22 INFO - PROCESS | 31156 | 08:55:22 INFO - PROCESS | 31156 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:173.50 stddev:3.03 (1.7%) stddev-sans-first:3.22 08:55:22 INFO - PROCESS | 31156 | Values: 173.0 175.0 174.0 173.0 173.0 174.0 179.0 169.0 170.0 169.0 08:55:22 INFO - PROCESS | 31156 | 08:55:22 INFO - PROCESS | 31156 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.00 stddev:2.06 (2.9%) stddev-sans-first:2.18 08:55:22 INFO - PROCESS | 31156 | Values: 70.0 69.0 73.0 70.0 70.0 72.0 69.0 68.0 74.0 68.0 08:55:22 INFO - PROCESS | 31156 | -------- Summary: end -------- 08:55:22 INFO - PROCESS | 31156 | 08:55:23 INFO - TEST-INFO | 31156: exit 0 08:55:23 INFO - TEST-OK | kraken | took 65807ms 08:55:23 INFO - SUITE-END | took 1188s 08:55:24 INFO - Completed test suite (00:19:48) 08:55:24 INFO - javascript benchmark 08:55:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2569.6881283759813, 2594.4940736556377, 2602.700689420716, 2638.4723055388927, 2652.854093024883, 4556.20266453371, 4585.082983403316, 4610.861674149773, 4658.184817656909, 4670.76646167692, 4609.6081833044145, 4632.235681112621, 4648.279516674912, 4667.0, 4693.765311734408, 4212.431321771567, 4245.80893859777, 4281.100968796556, 4344.500382456011, 4451.866444006685, 4376.343548467739, 4391.429114215148, 4445.0443154721725, 4455.576720211575, 4457.531959144292, 4237.555056719031, 4264.65882729384, 4356.4336636237085, 4372.715773474746, 4468.97765511172, 4215.852445164404, 4234.6823988201, 4260.510041345254, 4283.828646854122, 4303.203907277164, 4215.957840421618, 4265.808038638238, 4267.957320426787, 4277.893052673677, 4325.653947684209, 4577.244754615484, 4595.103954728829, 4646.303054541812, 4649.442066951988, 4695.295705644146, 4904.926426103611, 4941.431735350445, 4962.6526143169995, 5018.824341148043, 5028.547430731215, 4910.901781964377, 4923.90152196954, 4934.087193869145, 4963.975180124113, 5011.473795251519, 4538.704984176018, 4657.813687452498, 4661.836835710734, 4669.112868554964, 4671.85984420468, 5005.199168133154, 5086.9745651271505, 5131.0, 5146.150885103991, 5192.948070519246, 4941.728204948762, 4951.455339912607, 4954.40547134339, 4958.256261560723, 5023.899522009539, 5017.448080711119, 5023.949760502348, 5026.271190677331, 5028.622853286018, 5028.924566131438, 4855.344528488679, 4871.318015477836, 4881.804727810848, 4917.360743103445, 4954.752262386938, 4853.733044682576, 4855.854324370274, 4863.2461968394955, 4886.780094895738, 4920.188168952082, 4218.17745539623, 4236.830526778956, 4263.467066616673, 4272.33778764292, 4318.1363727254675, 3669.43123815809, 3684.0421490412687, 3690.040589446763, 3727.589965103836, 3757.0, 4339.414179085846, 4365.650747940157, 4408.7575183365225, 4417.558244175557, 4421.270490369117, 4999.0501804657, 5031.622628302819, 5032.421271553818, 5034.244863270465, 5094.872628184251, 4291.742495450283, 4328.156009578102, 4340.414044104005, 4357.477102747691, 4363.105563359567, 4463.040446303995, 4464.6428285737065, 4487.057717879216, 4528.773561321921, 4539.0, 4683.78922948475, 4716.64625153108, 4718.150732867979, 4721.4570324413135, 4770.308305295713, 4906.509349065065, 4963.404391473046, 5008.173651347487, 5008.599312054954, 5050.368703912011, 4671.579557839811, 4712.387389639325, 4726.3146843708155, 4740.407449068866, 4779.545943135397, 4941.184704523714, 4942.802287908444, 4942.92585611209, 4946.208606622923, 5006.449290577961, 4912.1649319615035, 5001.224810154432, 5025.070361983045, 5027.924581131213, 5079.72061536619, 4820.204666230173, 4839.0, 4865.56209941107, 4874.683145595525, 4934.8766280843265, 4835.879103022453, 4848.903021939471, 4850.83022094225, 4863.805447782049, 4913.287573301923, 4741.241401375902, 4791.496892826342, 4813.7593120344545, 4831.396075490564, 4899.902001960012, 4863.2461968394955, 4893.21708526634, 4901.2893130496595, 4903.362562866804, 4981.925271120864, 4803.879903002313, 4811.759412029454, 4815.3258543803195, 4824.276358546246, 4871.95128048715], "value": 4589.761886613903, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [520.6641716093118, 531.7607076815432, 573.1889376532207, 586.3579380578268, 587.6063037764698, 27959.440811183766, 37589.0, 39022.80488597553, 39163.0, 42197.15605687884, 39546.40680389797, 39753.60246397535, 39978.80010599943, 40041.799791001074, 40086.0, 7502.774916752493, 7603.65783539742, 7654.923450765476, 7656.502327348732, 7656.502327348732, 7639.7326093586735, 7714.4599878008285, 7729.768106956801, 7730.7680769577, 7733.961330193341, 7399.3710534604625, 7490.9625451872935, 7494.175640679521, 7498.737544185955, 7528.058992625922, 7652.387808975269, 7678.884816727754, 7714.228577142297, 7714.6142692865415, 7768.495047821873, 7607.847843043163, 7680.577568233745, 7680.692772289101, 7683.078030636303, 7684.346830519413, 37467.81266093652, 37853.0, 37880.24239515222, 37880.24239515222, 37884.62115378839, 2382.642603609455, 2470.9135180268786, 2512.1458704040715, 2520.143151328539, 2713.7150599187, 27426.862865685744, 27798.722012780017, 28056.158315250574, 28094.85952570224, 28668.283292917844, 3341.298327351259, 3431.227973705921, 3456.807401446522, 3560.5193298904574, 3574.070741607175, 253237.0, 255477.0, 255880.0, 255880.0, 255923.0, 52061.47938520642, 52547.804134276346, 52563.21155182675, 52575.737121314145, 52584.47415525872, 32039.359212815612, 32920.0, 33091.0, 34767.9569612912, 55774.0, 12965.481380744854, 13147.34263286851, 13178.538751143855, 13194.736105277841, 13196.14225075367, 9750.561224744763, 9810.754731131636, 9813.313068085308, 9835.655752048644, 9842.311038227399, 17667.936374633908, 17671.558211044827, 17688.115594220493, 17715.911420442815, 17761.911190443963, 6567.0, 6670.733170673118, 6706.362895524917, 6757.68225196082, 6890.793276201722, 766.2108028730416, 873.9737807865774, 933.1788026536605, 955.5365647660878, 961.990380096204, 26541.46917061648, 26884.193474195807, 27201.86399067992, 27276.727232727815, 27708.861455692593, 837.4598384042258, 871.1506281375608, 884.9115088491228, 905.248643625789, 989.7030890732896, 14273.714525709427, 14443.638909027148, 14472.85527144736, 14771.261436928111, 14880.0, 376954.0, 378380.0, 379401.0, 381867.0, 383952.0, 47249.291260631115, 47830.28254576184, 48028.27957580639, 48051.75974120177, 48061.0, 1056.2183983851894, 1120.1263014848432, 1165.0795871261778, 1179.8614337164677, 1183.621241202807, 26739.465210696068, 28051.158465246077, 28951.7104828949, 29017.274568135967, 29451.41097178087, 40150.39774403328, 40764.38853417142, 40812.59187408206, 40870.0, 40888.1822363557, 280245.0, 280433.0, 281482.0, 281700.0, 282528.0, 22002.229921952654, 23779.762202377755, 24797.0, 24833.87583062073, 25946.74053259443, 40285.39571906482, 40506.39240411455, 40870.59129408668, 41300.38049429321, 41896.3715544261, 34823.65176348204, 34837.65162348445, 34891.82554087213, 35639.28721425609, 35651.64348356587, 31535.36929261448, 31555.526667100472, 31657.36685266328, 31793.841030794698, 32493.512597311532, 34229.0, 34494.48258276078, 35714.64285357113, 36906.63093369139, 36934.44598331081, 30197.0, 31785.682143179198, 32876.67123328832, 33195.336093278485, 33302.833485832416, 24648.507029859662, 25086.121985730413, 25422.74577254204, 25619.35951601225, 25829.870850646377], "value": 16718.32702363561, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.3645711148268, 371.39833469778955, 374.75828090881373, 381.8071873703779, 391.6318660459168, 15898.68202635948, 16908.661826763473, 17008.744868826947, 17097.40159094432, 17107.657846843056, 15192.468263610775, 15813.367465301375, 15927.362905483797, 15943.123128227942, 16013.599660008505, 4832.154372984723, 5109.054824857395, 5110.974445127769, 5112.463191364909, 5114.514121158484, 3707.258548290339, 3900.356441187215, 5034.169362055275, 5758.107493338539, 5981.58128930975, 6071.453569178773, 6073.392660733935, 6078.939210607904, 6081.483073938721, 6083.148359229712, 5834.854128646775, 5977.282726072855, 5982.132590774357, 5996.100584912255, 6024.3674414186535, 4623.8150473981, 5284.603654725873, 5296.311479507678, 5298.841034768963, 5301.390340110898, 12045.337506437143, 12329.815052774216, 12361.752764944651, 12372.1958072725, 12379.257244565355, 1703.880728349016, 1734.9913250433792, 1768.32803534656, 1863.8974856382893, 1885.77370715515, 8941.731748047569, 8992.0, 9040.186383225542, 9268.536573171314, 9490.335676502647, 1655.246862677479, 1667.1497536256597, 1703.0973584000499, 1712.5889786451287, 1714.5113642611796, 67383.66308168428, 69775.65112174458, 69870.0, 71578.28421715768, 72129.0, 9871.555779989918, 9969.252306077073, 10041.899581004243, 10182.134518566005, 10256.897431025744, 13544.93227533856, 13652.726945461036, 13655.863441365658, 13661.931690341484, 13688.589342319747, 6407.0, 6544.803655890331, 6642.60505293884, 6694.09629699994, 6735.259121496631, 6026.6986650667295, 6105.755769769248, 6244.65654389013, 6250.874982500415, 6254.21822272216, 4240.0, 4246.787660617018, 4283.079137985285, 4283.700140990163, 4388.539203383662, 1630.4293497276096, 1713.7857767779028, 1801.783785945695, 1809.7375880497254, 1820.144532069925, 776.2043904997423, 808.9393295502861, 847.9872801907976, 886.7561420609384, 891.0554811899278, 16560.254788534545, 16812.411565595146, 17290.0, 17471.737923931152, 17854.5536361592, 822.6051495282298, 838.2497664590279, 866.0213958227163, 891.3359547137425, 930.4091901642506, 9415.105564971316, 9954.253430992705, 10039.648612298535, 10059.949700251598, 10064.446455444875, 366118.0, 366282.0, 367650.0, 400604.0, 403623.0, 47759.283610745864, 49025.0, 79750.0, 83022.16977830265, 84040.0, 876.7238319929329, 915.1397686174975, 951.286535098676, 951.6193522591019, 956.53129966316, 14766.33551490164, 15840.44558440449, 16487.917560412123, 16552.503424897273, 16672.583185420463, 25837.741622583533, 25992.61011084873, 37034.44448333331, 37255.0, 38673.41989870211, 50704.23943640775, 50777.49222507876, 51298.04880243568, 52245.0, 54603.18095228495, 4277.098873194716, 7285.672144753393, 7443.776686699408, 7576.6969321228735, 7787.727429539939, 5859.384764599826, 9377.531123443665, 9493.952530237304, 11074.833877491683, 11355.886441135814, 9583.664571739955, 9833.262505311986, 10004.24968127408, 10091.798164036825, 10541.420221887563, 9822.607095716092, 10227.795444090927, 10378.169746420419, 10668.519916603927, 10733.463326833471, 10507.106895913626, 10525.842112368167, 10533.36799792015, 10820.350778953289, 11092.500837462172, 6349.365063493614, 6737.9326206737305, 6752.324767523209, 6846.110005699227, 7074.257202993612, 7904.6838126474295, 9583.233341332538, 10288.691339259834, 10349.63776267827, 10368.481575921023], "value": 7875.141445492511, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.8976326775492, 1389.6525868532867, 1454.716330315589, 1578.5185518416893, 1637.4269005847948, 7046.2601426850215, 7603.961980190092, 7616.543007419558, 7627.771166864989, 7652.19651936547, 6641.501887358455, 7169.533980291278, 7479.663415146318, 7487.0, 7744.767656970286, 2091.870389989404, 2125.362391282617, 2132.562824620949, 2136.1455417832835, 2136.177571634924, 2112.3768488295914, 2129.7231359923267, 2168.2844661261747, 2170.967435488469, 2172.913083476659, 2121.501447159916, 2136.7863213678584, 2143.6355819510723, 2145.09905839547, 2148.591767564166, 2086.1446806809213, 2093.455701517601, 2094.968575471369, 2095.9101267340898, 2096.863703859244, 2074.3362124120285, 2116.8518203725744, 2118.5762847430574, 2120.120150137691, 2121.3847984084596, 7549.50928189666, 7629.351505122016, 7639.121501027397, 7642.5032372895585, 7645.120811106738, 4171.10321280923, 4292.077203401283, 4298.763568003758, 4300.784960751981, 4304.720193187432, 2726.168518601826, 2787.7351651593267, 2831.419558990402, 2835.036087730161, 2842.459932612797, 928.3312583937021, 965.5896244096231, 982.6020461713018, 987.521052289639, 994.7562847102506, 10534.525946332433, 10575.471226438724, 10581.206409519316, 10587.576496940113, 10594.205434592359, 3820.8089595520114, 3906.6679332257077, 3981.880543583697, 4062.0502158963864, 4062.289099407592, 8958.372913896095, 8967.686130985385, 8984.55077246135, 8985.820283594292, 8986.55067246635, 4257.446531950888, 4277.272863613193, 4281.036766727524, 4282.907858496126, 4284.828606855691, 3479.565054368204, 3753.9249215016093, 3937.8186544036676, 3954.584768599313, 3955.327594308917, 3470.0, 3518.40187168182, 3642.7267954903486, 3649.61679023704, 3669.743117981716, 1156.7512984708328, 1163.2962057954985, 1182.9290242585473, 1195.2649120790652, 1207.710149564116, 640.7533099756535, 709.6558169287891, 731.8536292741474, 736.296836521121, 752.3341842469454, 4761.166795810788, 4933.28467372229, 4958.181899986534, 4974.328465657162, 5034.949650503521, 342.9796355841352, 367.6286950180284, 368.29655358265586, 373.31869338457426, 381.09870157078865, 3262.9347413051605, 3308.1912130533083, 3321.153105957965, 3332.9666703332655, 3437.0, 8990.145936136056, 9174.495402752913, 9237.3533852631, 9280.303977201736, 9387.155156035853, 9093.77265568366, 9231.261499080058, 9238.676646317346, 9255.814883702424, 9311.301652375963, 7117.3238542338395, 7141.678624461912, 7192.496525243288, 7203.711851525985, 7207.387372073327, 4798.749278046637, 4811.013742182774, 4843.588294994965, 4899.853004409873, 4977.303177555217, 8264.586770661323, 8465.915340846514, 8724.91275087241, 8742.344324175585, 8760.299176066026, 8604.569771511524, 8644.394892357475, 8762.868556971778, 8830.205281524693, 8854.778630534289, 5939.881202376015, 6323.083152942706, 6551.80344589663, 6605.174353205849, 6612.272650008592, 6953.65231738401, 7190.424766018601, 7200.675969581486, 7201.927980720336, 7203.279672032755, 6391.936080639134, 6468.482521398371, 6545.443637290884, 6676.49926255523, 6697.229818570927, 6338.841528961812, 6363.936360636334, 6392.328805475358, 6397.96801015992, 6398.872022559616, 6016.8796624068145, 6083.482903953037, 6094.664793436404, 6102.176206212104, 6102.633841969496, 4328.112736888993, 4338.349247612883, 4375.365571992107, 4486.5631102609, 4517.706349087299, 4379.934300985424, 4384.298512238027, 4386.846460373871, 4387.473503179639, 4447.444069491314], "value": 3892.408537426939, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.1426669790955, 298.935728818304, 304.61314131053564, 306.5907014136127, 308.8764494202317, 4836.782344794484, 4874.049560335736, 4874.415070191573, 4877.878053048676, 4901.142300097482, 4808.567228949394, 4821.951780482203, 4873.171560834658, 4873.658843880929, 4888.340074089997, 3644.6173151819075, 3721.981390093046, 3766.9452553285123, 3829.6936245100324, 3835.405512145608, 3818.0836599216127, 3820.4842346283313, 3822.73240873139, 3827.870778120461, 3835.6356146166067, 3772.9811350943346, 3781.73527853049, 3783.4487859977417, 3786.678132358753, 3791.791451470168, 3625.963740362602, 3673.1000904778502, 3746.8875933722034, 3760.699144068468, 3819.2743378758087, 3330.383878982396, 3337.8664853405835, 3339.716124129452, 3350.212700015494, 3380.7126394256516, 4679.485256621769, 4713.457952335491, 4730.195866702668, 4734.502877197879, 4741.691790033637, 4150.211459822624, 4365.956340436618, 4369.71596846204, 4374.496932852699, 4380.518143004267, 4950.9504904950845, 4952.059108769358, 4984.925226121611, 4994.625403094746, 4997.800087996476, 3655.817209139532, 3667.3948798448223, 3670.8164591770574, 3687.340696686502, 3697.4453831925157, 5110.412302585176, 5312.256284120226, 5326.280952071459, 5353.2601904380845, 5357.249985002064, 3704.7406681532575, 3736.795290778454, 3738.831752571141, 3746.7751934883995, 3747.981260093682, 3792.943105853414, 3803.904902377463, 3808.4858544096746, 3809.2381523694817, 3819.6371344722206, 4318.438602981592, 4340.500842403164, 4341.544137865479, 4345.34819777036, 4360.280553708666, 4847.442544107473, 5067.619928505377, 5069.264956581349, 5121.106574785234, 5133.640645154804, 1266.7276535544902, 1281.4681907008674, 1286.498265676387, 1286.8289856230786, 1289.8581156072823, 783.7805414483839, 817.804195734443, 821.5399376349263, 828.9751307460785, 829.4069740135832, 4356.150550642657, 4465.240909045405, 4530.77346132692, 4532.456105267323, 4532.864014079583, 5184.455632158644, 5189.922151167735, 5198.8960220796125, 5208.801975545645, 5234.502722241381, 4484.887877803016, 4515.977420112944, 4528.977355113203, 4532.5694059064335, 4532.9546704533195, 2582.690077190749, 2766.695663477016, 2770.612114303999, 2787.7909156812916, 2790.5953636722966, 4917.237828136645, 4933.260010998379, 4955.4548999610015, 4969.279454479152, 4976.975115124401, 5116.130257856174, 5333.2266821310695, 5349.919751203735, 5365.517103460707, 5381.704006279614, 4923.261510773341, 4940.677881395738, 4957.950420495821, 4958.727270000185, 4964.304997300381, 5211.827338848729, 5238.895222095613, 5254.13306804373, 5261.947380526146, 5270.947290527046, 4943.283223932438, 5145.7941682333785, 5156.9742151289, 5162.741862906914, 5186.948130518646, 4884.340614017062, 4891.437484689164, 4924.926126108039, 4934.358533390637, 4938.975305123451, 3636.1455058061865, 3660.1764602965186, 3697.22358304759, 3719.6652301293016, 3720.0, 5016.448190699093, 5258.579313654822, 5261.34302177398, 5278.498542638443, 5280.419153892992, 5001.8499445016705, 5041.571466425395, 5071.315372424676, 5073.213651883964, 5089.13484707608, 5050.671706339076, 5076.7207803571155, 5077.289179514944, 5138.3063286457345, 5169.431362550192, 4864.343313652612, 5007.69953802773, 5050.444451110301, 5059.316992206005, 5060.291559181644, 4905.23968784839, 4919.950800492093, 5085.7457127144235, 5103.285540024325, 5179.404368497671, 5009.824656137018, 5024.196128619404, 5058.2685349910635, 5066.721330326867, 5068.543831055223], "value": 3829.716179077103, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.6583816790842, 578.2771535580523, 594.0317282828988, 602.1900543768629, 617.0620656601965, 11403.258788178762, 11745.0, 12381.628551143458, 12510.749785004295, 12550.0, 12650.62048138555, 12712.046596505254, 12771.808422873664, 12775.0, 12776.616701498946, 737.7491652838034, 751.2112282103797, 755.3202118093704, 756.1493320014984, 757.1293013034999, 618.035864052078, 725.314577724051, 750.4896670264218, 753.0661979145874, 757.6514803190539, 787.9527228366288, 789.5144486141039, 789.72754399732, 790.2018960849555, 790.2374208888422, 781.7850091224901, 783.3380793229712, 783.5847001089431, 783.6395258181243, 783.7256960063961, 469.8026828731941, 480.61550759392696, 482.66695979773846, 482.80929033032106, 549.8295528386213, 10514.474276286155, 10860.837087443615, 10882.61910833117, 10887.83668244977, 10891.67324980252, 11581.768364632744, 11799.46902389386, 11852.0, 11970.521179152824, 12629.24224546521, 11222.943885280603, 11255.0, 11316.151288653384, 11341.092712582973, 11484.13868959823, 3935.7917916322053, 3978.8010599469912, 4003.3794761811964, 4019.1760689058674, 4055.9188816223805, 62883.81184119962, 63624.68187659078, 63690.0, 63716.681416593085, 66756.6662166686, 9664.661736839318, 9815.558299876522, 10098.747531311776, 10138.797224055625, 10156.746081348025, 19094.71357929632, 19233.03834808254, 19239.51901202481, 19246.0, 19261.13324900383, 6685.6322902240845, 6761.29006454325, 6780.084688567079, 6959.4432445404245, 7060.435165186773, 3722.3113723961155, 3728.2357116790995, 3738.700903927679, 3779.962200377961, 3856.9807150964066, 2597.38961344084, 2663.067926225844, 2687.798415118874, 2693.111273279813, 2712.8372297662204, 502.379561241866, 503.92189210672404, 507.73851466494784, 513.946409859786, 514.5497689521668, 399.97400168988923, 450.6867726929818, 457.61103062396694, 467.1917582582152, 475.9737175427497, 6704.631245281556, 6944.930550694529, 7075.080239568926, 7123.501354905107, 7373.594452305175, 397.6477454263063, 430.25351015987235, 463.6105671236178, 488.66526429395975, 492.7511606638696, 3169.3185965017633, 3340.6993370596765, 3427.9657203428146, 3498.1079824644553, 3575.928481430357, 98935.17037274002, 99809.0, 101197.0, 103726.0, 103778.0, 68183.65908170427, 69554.65222673955, 70149.64925175444, 86223.0, 90420.5478972601, 71308.0, 71570.64214678893, 71947.64026179835, 72077.0, 72349.6382518084, 7427.7771666850085, 8061.879071814044, 8198.1391953844, 8265.752027439186, 8289.502629842229, 39248.0, 41779.77905020576, 42333.0, 42466.36300455558, 43458.56541434545, 53300.73349633227, 57822.4217757817, 59526.0, 60078.0, 60266.39733602608, 10135.442550659785, 10679.89320106789, 10708.464576771286, 10766.623168189075, 10821.458927053773, 9426.434413935185, 9451.858222126812, 9550.665726699532, 10316.43259620728, 11827.645170644895, 8969.237614802814, 10328.741781455523, 10350.482475876326, 10920.344779313267, 11269.830952535882, 10550.208734344802, 10659.840102398315, 10958.232923695265, 11038.779224415628, 11407.429628518375, 10808.405537695502, 10896.564137434414, 11023.944880275547, 11250.268732532359, 11646.068314534647, 8815.0, 8871.733847984571, 9312.44125352481, 9370.718878433658, 9418.529073546433, 8570.52862092566, 9408.153266206074, 9438.339316248072, 9630.0, 9727.708168754949], "value": 6142.967868723745, "unit": "score"}], "name": "dromaeo_css", "value": 6173.180558547022, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 127.0, 114.0, 112.0, 114.0, 113.0, 113.0, 114.0, 112.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 144.0, 185.0, 123.0, 148.0, 147.0, 128.0, 189.0, 121.0], "value": 146.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 161.0, 162.0, 161.0, 161.0, 162.0, 158.0, 159.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 165.0, 76.0, 77.0, 76.0, 76.0, 158.0, 77.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 165.0, 88.0, 88.0, 88.0, 146.0, 86.0, 87.0, 143.0], "value": 106.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 67.0, 67.0, 73.0, 66.0, 67.0, 66.0, 70.0], "value": 67.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 67.0, 65.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 88.0, 83.0, 85.0, 82.0, 91.0, 83.0, 83.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 137.0, 131.0, 134.0, 133.0, 143.0, 132.0, 144.0, 164.0, 134.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 174.0, 173.0, 173.0, 174.0, 179.0, 169.0, 170.0, 169.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 73.0, 70.0, 70.0, 72.0, 69.0, 68.0, 74.0, 68.0], "value": 70.3, "unit": "score"}], "name": "kraken", "value": 1579.5000000000002, "alertThreshold": 2.0}]} 08:55:24 INFO - Return code: 0 08:55:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:55:24 INFO - # TBPL SUCCESS # 08:55:24 INFO - Running post-action listener: _resource_record_post_action 08:55:24 INFO - [mozharness: 2016-08-23 15:55:24.124567Z] Finished run-tests step (success) 08:55:24 INFO - Running post-run listener: _resource_record_post_run 08:55:24 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 0; Write bytes: 402771968; Read time: 0; Write time: 565252 08:55:24 INFO - TinderboxPrint: CPU usage
13.3% 08:55:24 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:55:24 INFO - TinderboxPrint: I/O write bytes / time
402,771,968 / 565,252 08:55:24 INFO - TinderboxPrint: CPU idle
8,337.6 (86.7%) 08:55:24 INFO - TinderboxPrint: CPU user
1,207.8 (12.6%) 08:55:24 INFO - TinderboxPrint: Swap in / out
0 / 0 08:55:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114139136; Read time: 0; Write time: 212844 08:55:24 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 288632832; Read time: 0; Write time: 352408 08:55:24 INFO - Running post-run listener: _upload_blobber_files 08:55:24 INFO - Blob upload gear active. 08:55:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:55:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:55:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:55:25 INFO - (blobuploader) - INFO - Open directory for files ... 08:55:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:55:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:55:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:25 INFO - (blobuploader) - INFO - Done attempting. 08:55:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:55:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:55:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:26 INFO - (blobuploader) - INFO - Done attempting. 08:55:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:55:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:55:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:30 INFO - (blobuploader) - INFO - Done attempting. 08:55:30 INFO - (blobuploader) - INFO - Iteration through files over. 08:55:30 INFO - Return code: 0 08:55:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:55:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:55:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f7d1260355487db05355abd686b6a32d6449007d07a0181e786194acae17ef0bc39d2e04490a6d311dd88b6b7f006448286c6ca8d3e0c7d16f1ecd7fafcaf48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa639bc8ad6e7a1dfba7a8db6af8a2add25d5ffc136ebb8b8af5cc29d86729c614cf1791361fddba2fa02aea2ce1f16bb4e00a5d7387331b528680d719234b24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/165f784733079259a6a598392041a7bde20d114eea6ae8e55b222841202929dcafdd21a8940585afb33bb2ae8e0f1e2a251389132f1105387976eadb7d2c33b6"} 08:55:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:55:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:55:30 INFO - Contents: 08:55:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f7d1260355487db05355abd686b6a32d6449007d07a0181e786194acae17ef0bc39d2e04490a6d311dd88b6b7f006448286c6ca8d3e0c7d16f1ecd7fafcaf48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa639bc8ad6e7a1dfba7a8db6af8a2add25d5ffc136ebb8b8af5cc29d86729c614cf1791361fddba2fa02aea2ce1f16bb4e00a5d7387331b528680d719234b24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/165f784733079259a6a598392041a7bde20d114eea6ae8e55b222841202929dcafdd21a8940585afb33bb2ae8e0f1e2a251389132f1105387976eadb7d2c33b6"} 08:55:30 INFO - Running post-run listener: copy_logs_to_upload_dir 08:55:30 INFO - Copying logs to upload dir... 08:55:30 INFO - mkdir: /builds/slave/test/build/upload/logs 08:55:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.058453 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-23 08:55:29.915723) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 08:55:29.919583) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f7d1260355487db05355abd686b6a32d6449007d07a0181e786194acae17ef0bc39d2e04490a6d311dd88b6b7f006448286c6ca8d3e0c7d16f1ecd7fafcaf48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa639bc8ad6e7a1dfba7a8db6af8a2add25d5ffc136ebb8b8af5cc29d86729c614cf1791361fddba2fa02aea2ce1f16bb4e00a5d7387331b528680d719234b24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/165f784733079259a6a598392041a7bde20d114eea6ae8e55b222841202929dcafdd21a8940585afb33bb2ae8e0f1e2a251389132f1105387976eadb7d2c33b6"} build_url:https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://queue.taskcluster.net/v1/task/K8MyMRPORtS1yOaSi-Xdyg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f7d1260355487db05355abd686b6a32d6449007d07a0181e786194acae17ef0bc39d2e04490a6d311dd88b6b7f006448286c6ca8d3e0c7d16f1ecd7fafcaf48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa639bc8ad6e7a1dfba7a8db6af8a2add25d5ffc136ebb8b8af5cc29d86729c614cf1791361fddba2fa02aea2ce1f16bb4e00a5d7387331b528680d719234b24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/165f784733079259a6a598392041a7bde20d114eea6ae8e55b222841202929dcafdd21a8940585afb33bb2ae8e0f1e2a251389132f1105387976eadb7d2c33b6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 08:55:29.947116) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:55:29.947546) ========= 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=5cf47e208febbcd81da23b2e0000026f-1471966481.241625-832425592 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:55:30.031837) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 08:55:30.032193) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 08:55:30.033964) ========= ========= Total master_lag: 0.17 =========