builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1460712013.19 results: success (0) buildid: 20160415014851 builduid: 82c794c2d287426992de7fc4aec04e81 revision: 529cff9c5663a3581dfb5e690727144f07e8e23c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 02:20:13.189707) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 02:20:13.190296) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 02:20:13.190590) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 02:20:13.208332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:20:13.208736) ========= 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-1460710976.837850-1060755040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 02:20:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 96.5M=0s 2016-04-15 02:20:13 (96.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085453 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:20:13.308241) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:20:13.308549) ========= 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-1460710976.837850-1060755040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018199 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:20:13.365638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:20:13.365991) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 529cff9c5663a3581dfb5e690727144f07e8e23c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 529cff9c5663a3581dfb5e690727144f07e8e23c --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-1460710976.837850-1060755040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 02:20:13,791 truncating revision to first 12 chars 2016-04-15 02:20:13,791 Setting DEBUG logging. 2016-04-15 02:20:13,791 attempt 1/10 2016-04-15 02:20:13,791 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/529cff9c5663?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 02:20:14,057 unpacking tar archive at: fx-team-529cff9c5663/testing/mozharness/ program finished with exit code 0 elapsedTime=0.557468 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:20:13.936410) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 02:20:13.936748) ========= script_repo_revision: 529cff9c5663a3581dfb5e690727144f07e8e23c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 02:20:13.937176) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 02:20:13.937446) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 02:20:13.947496) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-04-15 02:20:13.947785) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1460710976.837850-1060755040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:20:14 INFO - MultiFileLogger online at 20160415 02:20:14 in /builds/slave/test 02:20:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 02:20:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:20:14 INFO - {'append_to_log': False, 02:20:14 INFO - 'base_work_dir': '/builds/slave/test', 02:20:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:20:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:20:14 INFO - 'branch': 'Fx-Team-Non-PGO', 02:20:14 INFO - 'buildbot_json_path': 'buildprops.json', 02:20:14 INFO - 'config_files': ('talos/linux_config.py',), 02:20:14 INFO - 'default_actions': ('clobber', 02:20:14 INFO - 'read-buildbot-config', 02:20:14 INFO - 'download-and-extract', 02:20:14 INFO - 'populate-webroot', 02:20:14 INFO - 'create-virtualenv', 02:20:14 INFO - 'install', 02:20:14 INFO - 'run-tests'), 02:20:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:20:14 INFO - 'download_minidump_stackwalk': True, 02:20:14 INFO - 'download_symbols': 'ondemand', 02:20:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:20:14 INFO - 'tooltool.py': '/tools/tooltool.py', 02:20:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:20:14 INFO - '/tools/misc-python/virtualenv.py')}, 02:20:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:20:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:20:14 INFO - 'installer_path': 'installer.exe', 02:20:14 INFO - 'log_level': 'info', 02:20:14 INFO - 'log_name': 'talos', 02:20:14 INFO - 'log_to_console': True, 02:20:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:20:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:20:14 INFO - 'opt_config_files': (), 02:20:14 INFO - 'pip_index': False, 02:20:14 INFO - 'sps_profile': False, 02:20:14 INFO - 'sps_profile_interval': 0, 02:20:14 INFO - 'suite': 'dromaeojs', 02:20:14 INFO - 'system_bits': '32', 02:20:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:20:14 INFO - 'title': 'talos-linux64-ix-011', 02:20:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:20:14 INFO - 'use_talos_json': True, 02:20:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:20:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:20:14 INFO - 'work_dir': 'build'} 02:20:14 INFO - ##### 02:20:14 INFO - ##### Running clobber step. 02:20:14 INFO - ##### 02:20:14 INFO - Running pre-action listener: _resource_record_pre_action 02:20:14 INFO - Running main action method: clobber 02:20:14 INFO - rmtree: /builds/slave/test/build 02:20:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:20:14 INFO - Running post-action listener: _resource_record_post_action 02:20:14 INFO - ##### 02:20:14 INFO - ##### Running read-buildbot-config step. 02:20:14 INFO - ##### 02:20:14 INFO - Running pre-action listener: _resource_record_pre_action 02:20:14 INFO - Running main action method: read_buildbot_config 02:20:14 INFO - Using buildbot properties: 02:20:14 INFO - { 02:20:14 INFO - "project": "", 02:20:14 INFO - "product": "firefox", 02:20:14 INFO - "script_repo_revision": "production", 02:20:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:20:14 INFO - "repository": "", 02:20:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:20:14 INFO - "buildid": "20160415014851", 02:20:14 INFO - "pgo_build": "False", 02:20:14 INFO - "basedir": "/builds/slave/test", 02:20:14 INFO - "buildnumber": 2841, 02:20:14 INFO - "slavename": "talos-linux64-ix-011", 02:20:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:20:14 INFO - "platform": "ubuntu64_hw", 02:20:14 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:20:14 INFO - "branch": "fx-team", 02:20:14 INFO - "repo_path": "integration/fx-team", 02:20:14 INFO - "revision": "529cff9c5663a3581dfb5e690727144f07e8e23c", 02:20:14 INFO - "stage_platform": "linux64", 02:20:14 INFO - "builduid": "82c794c2d287426992de7fc4aec04e81", 02:20:14 INFO - "slavebuilddir": "test" 02:20:14 INFO - } 02:20:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:20:14 INFO - Running post-action listener: _resource_record_post_action 02:20:14 INFO - ##### 02:20:14 INFO - ##### Running download-and-extract step. 02:20:14 INFO - ##### 02:20:14 INFO - Running pre-action listener: _resource_record_pre_action 02:20:14 INFO - Running main action method: download_and_extract 02:20:14 INFO - mkdir: /builds/slave/test/build/tests 02:20: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:14 INFO - https://queue.taskcluster.net/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:20:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:20:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:20:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:20:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:20:15 INFO - Downloaded 1361 bytes. 02:20:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:20:15 INFO - Using the following test package requirements: 02:20:15 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:15 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:20:15 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:20:15 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:15 INFO - u'jsshell-linux-x86_64.zip'], 02:20:15 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:20:15 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:20:15 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:20:15 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:20:15 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:20:15 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:20:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:20:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:15 INFO - https://queue.taskcluster.net/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:20:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:20:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:20:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:20:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:20:17 INFO - Downloaded 22202881 bytes. 02:20:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:20:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:20:18 INFO - Return code: 0 02:20:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:20: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:18 INFO - https://queue.taskcluster.net/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:20:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:20:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:20:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:20:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:20:35 INFO - Downloaded 22202881 bytes. 02:20:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:20:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:20:37 INFO - Return code: 0 02:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:37 INFO - https://queue.taskcluster.net/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:20:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:20:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:20:38 INFO - Downloaded 10841076 bytes. 02:20:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:20:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:20:38 INFO - Return code: 0 02:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:38 INFO - https://queue.taskcluster.net/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:20:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:20:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:20:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:20:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:20:39 INFO - Downloaded 54448359 bytes. 02:20:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:20:39 INFO - mkdir: /builds/slave/test/properties 02:20:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:20:39 INFO - Writing to file /builds/slave/test/properties/build_url 02:20:39 INFO - Contents: 02:20:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:20:40 INFO - Running post-action listener: _resource_record_post_action 02:20:40 INFO - Running post-action listener: set_extra_try_arguments 02:20:40 INFO - ##### 02:20:40 INFO - ##### Running populate-webroot step. 02:20:40 INFO - ##### 02:20:40 INFO - Running pre-action listener: _resource_record_pre_action 02:20:40 INFO - Running main action method: populate_webroot 02:20:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:20:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:20:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:20:40 INFO - '--tppagecycles', 02:20:40 INFO - '7'], 02:20:40 INFO - 'tests': ['tsvgm']}}, 02:20:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:20:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:20:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:20:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:20:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:20:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:20:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:40 INFO - 'talos_options': ['--disable-e10s'], 02:20:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:20:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:40 INFO - 'talos_options': ['--disable-e10s'], 02:20:40 INFO - 'tests': ['damp', 'tps']}, 02:20:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:40 INFO - 'tests': ['damp', 'tps']}, 02:20:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:20:40 INFO - 'tests': ['dromaeo_dom']}, 02:20:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:20:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:20:40 INFO - 'tests': ['a11yr', 02:20:40 INFO - 'ts_paint', 02:20:40 INFO - 'tpaint', 02:20:40 INFO - 'sessionrestore', 02:20:40 INFO - 'sessionrestore_no_auto_restore', 02:20:40 INFO - 'tabpaint']}, 02:20:40 INFO - 'other-e10s': {'tests': ['a11yr', 02:20:40 INFO - 'ts_paint', 02:20:40 INFO - 'tpaint', 02:20:40 INFO - 'sessionrestore', 02:20:40 INFO - 'sessionrestore_no_auto_restore', 02:20:40 INFO - 'tabpaint']}, 02:20:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:20:40 INFO - 'ts_paint', 02:20:40 INFO - 'tpaint', 02:20:40 INFO - 'sessionrestore', 02:20:40 INFO - 'sessionrestore_no_auto_restore', 02:20:40 INFO - 'tabpaint']}, 02:20:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:20:40 INFO - 'ts_paint', 02:20:40 INFO - 'tpaint', 02:20:40 INFO - 'sessionrestore', 02:20:40 INFO - 'sessionrestore_no_auto_restore', 02:20:40 INFO - 'tabpaint']}, 02:20:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:20:40 INFO - 'tests': ['a11yr', 02:20:40 INFO - 'ts_paint', 02:20:40 INFO - 'tpaint', 02:20:40 INFO - 'sessionrestore', 02:20:40 INFO - 'sessionrestore_no_auto_restore', 02:20:40 INFO - 'tabpaint']}, 02:20:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:20:40 INFO - 'tests': ['a11yr', 02:20:40 INFO - 'ts_paint', 02:20:40 INFO - 'tpaint', 02:20:40 INFO - 'sessionrestore', 02:20:40 INFO - 'sessionrestore_no_auto_restore', 02:20:40 INFO - 'tabpaint']}, 02:20:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:20:40 INFO - 'tests': ['tsvgx', 02:20:40 INFO - 'tsvgr_opacity', 02:20:40 INFO - 'tart', 02:20:40 INFO - 'tscrollx', 02:20:40 INFO - 'cart']}, 02:20:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:20:40 INFO - 'tsvgr_opacity', 02:20:40 INFO - 'tart', 02:20:40 INFO - 'tscrollx', 02:20:40 INFO - 'cart']}, 02:20:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:40 INFO - 'talos_options': ['--disable-e10s'], 02:20:40 INFO - 'tests': ['tp5o']}, 02:20:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:40 INFO - 'tests': ['tp5o']}, 02:20:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:40 INFO - 'talos_options': ['--disable-e10s', 02:20:40 INFO - '--xperf_path', 02:20:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:40 INFO - 'tests': ['tp5n']}, 02:20:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:20:40 INFO - 'talos_options': ['--xperf_path', 02:20:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:20:40 INFO - 'tests': ['tp5n']}}, 02:20:40 INFO - 'talos.zip': {'path': '', 02:20:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:20:40 INFO - Running post-action listener: _resource_record_post_action 02:20:40 INFO - ##### 02:20:40 INFO - ##### Running create-virtualenv step. 02:20:40 INFO - ##### 02:20:40 INFO - Running pre-action listener: _resource_record_pre_action 02:20:40 INFO - Running main action method: create_virtualenv 02:20:40 INFO - Creating virtualenv /builds/slave/test/build/venv 02:20:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:20:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:20:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:20:40 INFO - Using real prefix '/usr' 02:20:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:20:41 INFO - Installing distribute.............................................................................................................................................................................................done. 02:20:43 INFO - Installing pip.................done. 02:20:43 INFO - Return code: 0 02:20:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6fefc1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2410>, '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 0x1ee3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee37a0>, '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-1460710976.837850-1060755040', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:20:43 INFO - Using env: {'DISPLAY': ':0', 02:20:43 INFO - 'HOME': '/home/cltbld', 02:20:43 INFO - 'LANG': 'en_US.UTF-8', 02:20:43 INFO - 'LANGUAGE': 'en_US:en', 02:20:43 INFO - 'LOGNAME': 'cltbld', 02:20:43 INFO - 'MAIL': '/var/mail/cltbld', 02:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:43 INFO - 'MOZ_NO_REMOTE': '1', 02:20:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:43 INFO - 'NO_EM_RESTART': '1', 02:20:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:43 INFO - 'PWD': '/builds/slave/test', 02:20:43 INFO - 'SHELL': '/bin/bash', 02:20:43 INFO - 'SHLVL': '1', 02:20:43 INFO - 'TERM': 'linux', 02:20:43 INFO - 'TMOUT': '86400', 02:20:43 INFO - 'USER': 'cltbld', 02:20:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460710976.837850-1060755040', 02:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:43 INFO - '_': '/tools/buildbot/bin/python'} 02:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:20:43 INFO - Cleaning up... 02:20:43 INFO - Return code: 0 02:20:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6fefc1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2410>, '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 0x1ee3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee37a0>, '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-1460710976.837850-1060755040', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:20:43 INFO - Using env: {'DISPLAY': ':0', 02:20:43 INFO - 'HOME': '/home/cltbld', 02:20:43 INFO - 'LANG': 'en_US.UTF-8', 02:20:43 INFO - 'LANGUAGE': 'en_US:en', 02:20:43 INFO - 'LOGNAME': 'cltbld', 02:20:43 INFO - 'MAIL': '/var/mail/cltbld', 02:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:43 INFO - 'MOZ_NO_REMOTE': '1', 02:20:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:43 INFO - 'NO_EM_RESTART': '1', 02:20:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:43 INFO - 'PWD': '/builds/slave/test', 02:20:43 INFO - 'SHELL': '/bin/bash', 02:20:43 INFO - 'SHLVL': '1', 02:20:43 INFO - 'TERM': 'linux', 02:20:43 INFO - 'TMOUT': '86400', 02:20:43 INFO - 'USER': 'cltbld', 02:20:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460710976.837850-1060755040', 02:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:43 INFO - '_': '/tools/buildbot/bin/python'} 02:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:43 INFO - Downloading/unpacking psutil>=0.7.1 02:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:20:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:45 INFO - Installing collected packages: psutil 02:20:45 INFO - Running setup.py install for psutil 02:20:45 INFO - building 'psutil._psutil_linux' extension 02:20:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:20:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:20:45 INFO - building 'psutil._psutil_posix' extension 02:20:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:20:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:20:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:46 INFO - Successfully installed psutil 02:20:46 INFO - Cleaning up... 02:20:46 INFO - Return code: 0 02:20:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6fefc1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2410>, '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 0x1ee3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee37a0>, '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-1460710976.837850-1060755040', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:20:46 INFO - Using env: {'DISPLAY': ':0', 02:20:46 INFO - 'HOME': '/home/cltbld', 02:20:46 INFO - 'LANG': 'en_US.UTF-8', 02:20:46 INFO - 'LANGUAGE': 'en_US:en', 02:20:46 INFO - 'LOGNAME': 'cltbld', 02:20:46 INFO - 'MAIL': '/var/mail/cltbld', 02:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:46 INFO - 'MOZ_NO_REMOTE': '1', 02:20:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:46 INFO - 'NO_EM_RESTART': '1', 02:20:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:46 INFO - 'PWD': '/builds/slave/test', 02:20:46 INFO - 'SHELL': '/bin/bash', 02:20:46 INFO - 'SHLVL': '1', 02:20:46 INFO - 'TERM': 'linux', 02:20:46 INFO - 'TMOUT': '86400', 02:20:46 INFO - 'USER': 'cltbld', 02:20:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460710976.837850-1060755040', 02:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:46 INFO - '_': '/tools/buildbot/bin/python'} 02:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:20:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:20:48 INFO - Installing collected packages: mozsystemmonitor 02:20:48 INFO - Running setup.py install for mozsystemmonitor 02:20:48 INFO - Successfully installed mozsystemmonitor 02:20:48 INFO - Cleaning up... 02:20:48 INFO - Return code: 0 02:20:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6fefc1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2410>, '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 0x1ee3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee37a0>, '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-1460710976.837850-1060755040', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:20:48 INFO - Using env: {'DISPLAY': ':0', 02:20:48 INFO - 'HOME': '/home/cltbld', 02:20:48 INFO - 'LANG': 'en_US.UTF-8', 02:20:48 INFO - 'LANGUAGE': 'en_US:en', 02:20:48 INFO - 'LOGNAME': 'cltbld', 02:20:48 INFO - 'MAIL': '/var/mail/cltbld', 02:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:48 INFO - 'MOZ_NO_REMOTE': '1', 02:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:48 INFO - 'NO_EM_RESTART': '1', 02:20:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:48 INFO - 'PWD': '/builds/slave/test', 02:20:48 INFO - 'SHELL': '/bin/bash', 02:20:48 INFO - 'SHLVL': '1', 02:20:48 INFO - 'TERM': 'linux', 02:20:48 INFO - 'TMOUT': '86400', 02:20:48 INFO - 'USER': 'cltbld', 02:20:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460710976.837850-1060755040', 02:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:48 INFO - '_': '/tools/buildbot/bin/python'} 02:20:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:48 INFO - Downloading/unpacking blobuploader==1.2.4 02:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:50 INFO - Downloading blobuploader-1.2.4.tar.gz 02:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:20:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:20:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:51 INFO - Downloading docopt-0.6.1.tar.gz 02:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:20:51 INFO - Installing collected packages: blobuploader, requests, docopt 02:20:51 INFO - Running setup.py install for blobuploader 02:20:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:20:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:20:51 INFO - Running setup.py install for requests 02:20:51 INFO - Running setup.py install for docopt 02:20:51 INFO - Successfully installed blobuploader requests docopt 02:20:51 INFO - Cleaning up... 02:20:51 INFO - Return code: 0 02:20:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6fefc1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2410>, '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 0x1ee3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee37a0>, '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-1460710976.837850-1060755040', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:20:51 INFO - Using env: {'DISPLAY': ':0', 02:20:51 INFO - 'HOME': '/home/cltbld', 02:20:51 INFO - 'LANG': 'en_US.UTF-8', 02:20:51 INFO - 'LANGUAGE': 'en_US:en', 02:20:51 INFO - 'LOGNAME': 'cltbld', 02:20:51 INFO - 'MAIL': '/var/mail/cltbld', 02:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:51 INFO - 'MOZ_NO_REMOTE': '1', 02:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:51 INFO - 'NO_EM_RESTART': '1', 02:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:51 INFO - 'PWD': '/builds/slave/test', 02:20:51 INFO - 'SHELL': '/bin/bash', 02:20:51 INFO - 'SHLVL': '1', 02:20:51 INFO - 'TERM': 'linux', 02:20:51 INFO - 'TMOUT': '86400', 02:20:51 INFO - 'USER': 'cltbld', 02:20:51 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460710976.837850-1060755040', 02:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:51 INFO - '_': '/tools/buildbot/bin/python'} 02:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:52 INFO - Running setup.py (path:/tmp/pip-Jhasuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:52 INFO - Running setup.py (path:/tmp/pip-xszCOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:52 INFO - Running setup.py (path:/tmp/pip-qyaCeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:52 INFO - Running setup.py (path:/tmp/pip-FwfIua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:52 INFO - Running setup.py (path:/tmp/pip-Y5oBEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:52 INFO - Running setup.py (path:/tmp/pip-F8rllc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:52 INFO - Running setup.py (path:/tmp/pip-iYxV9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:52 INFO - Running setup.py (path:/tmp/pip-fmf3HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:52 INFO - Running setup.py (path:/tmp/pip-5vE7Jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:52 INFO - Running setup.py (path:/tmp/pip-R9z3EB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:52 INFO - Running setup.py (path:/tmp/pip-pmhnQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:52 INFO - Running setup.py (path:/tmp/pip-Tb_XzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:52 INFO - Running setup.py (path:/tmp/pip-lrr53X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:52 INFO - Running setup.py (path:/tmp/pip-ekoM6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:53 INFO - Running setup.py (path:/tmp/pip-sNTua4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:53 INFO - Running setup.py (path:/tmp/pip-h8SGCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:53 INFO - Running setup.py (path:/tmp/pip-dmE_4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:20:53 INFO - Running setup.py install for manifestparser 02:20:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:20:53 INFO - Running setup.py install for mozcrash 02:20:53 INFO - Running setup.py install for mozdebug 02:20:53 INFO - Running setup.py install for mozdevice 02:20:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:20:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:20:53 INFO - Running setup.py install for mozfile 02:20:53 INFO - Running setup.py install for mozhttpd 02:20:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:20:53 INFO - Running setup.py install for mozinfo 02:20:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:20:53 INFO - Running setup.py install for mozInstall 02:20:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:20:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:20:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:20:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:20:54 INFO - Running setup.py install for mozleak 02:20:54 INFO - Running setup.py install for mozlog 02:20:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:20:54 INFO - Running setup.py install for moznetwork 02:20:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:20:54 INFO - Running setup.py install for mozprocess 02:20:54 INFO - Running setup.py install for mozprofile 02:20:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:20:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:20:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:20:54 INFO - Running setup.py install for mozrunner 02:20:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:20:54 INFO - Running setup.py install for mozscreenshot 02:20:54 INFO - Running setup.py install for moztest 02:20:54 INFO - Running setup.py install for mozversion 02:20:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:20:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:20:55 INFO - Cleaning up... 02:20:55 INFO - Return code: 0 02:20:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6fefc1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2410>, '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 0x1ee3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee37a0>, '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-1460710976.837850-1060755040', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:20:55 INFO - Using env: {'DISPLAY': ':0', 02:20:55 INFO - 'HOME': '/home/cltbld', 02:20:55 INFO - 'LANG': 'en_US.UTF-8', 02:20:55 INFO - 'LANGUAGE': 'en_US:en', 02:20:55 INFO - 'LOGNAME': 'cltbld', 02:20:55 INFO - 'MAIL': '/var/mail/cltbld', 02:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:55 INFO - 'MOZ_NO_REMOTE': '1', 02:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:55 INFO - 'NO_EM_RESTART': '1', 02:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:55 INFO - 'PWD': '/builds/slave/test', 02:20:55 INFO - 'SHELL': '/bin/bash', 02:20:55 INFO - 'SHLVL': '1', 02:20:55 INFO - 'TERM': 'linux', 02:20:55 INFO - 'TMOUT': '86400', 02:20:55 INFO - 'USER': 'cltbld', 02:20:55 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460710976.837850-1060755040', 02:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:55 INFO - '_': '/tools/buildbot/bin/python'} 02:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:55 INFO - Running setup.py (path:/tmp/pip-GXm8x1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:55 INFO - Running setup.py (path:/tmp/pip-AOoFaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:55 INFO - Running setup.py (path:/tmp/pip-fi2qrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:55 INFO - Running setup.py (path:/tmp/pip-Cv0Lxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:55 INFO - Running setup.py (path:/tmp/pip-S9fpn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:55 INFO - Running setup.py (path:/tmp/pip-zJDgw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:55 INFO - Running setup.py (path:/tmp/pip-0EghJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:55 INFO - Running setup.py (path:/tmp/pip-zSE_yI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:55 INFO - Running setup.py (path:/tmp/pip-IlHo0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:55 INFO - Running setup.py (path:/tmp/pip-o6ih5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:56 INFO - Running setup.py (path:/tmp/pip-c2Ayid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:56 INFO - Running setup.py (path:/tmp/pip-cALYQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:56 INFO - Running setup.py (path:/tmp/pip-nIT2EU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:56 INFO - Running setup.py (path:/tmp/pip-61LraW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:56 INFO - Running setup.py (path:/tmp/pip-VWQFrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:56 INFO - Running setup.py (path:/tmp/pip-JdU2wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:56 INFO - Running setup.py (path:/tmp/pip-tQGyha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:20:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:58 INFO - Downloading blessings-1.6.tar.gz 02:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:20:58 INFO - Installing collected packages: blessings 02:20:58 INFO - Running setup.py install for blessings 02:20:58 INFO - Successfully installed blessings 02:20:58 INFO - Cleaning up... 02:20:58 INFO - Return code: 0 02:20:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:20:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:58 INFO - Reading from file tmpfile_stdout 02:20:58 INFO - Current package versions: 02:20:58 INFO - argparse == 1.2.1 02:20:58 INFO - blessings == 1.6 02:20:58 INFO - blobuploader == 1.2.4 02:20:58 INFO - docopt == 0.6.1 02:20:58 INFO - manifestparser == 1.1 02:20:58 INFO - mozInstall == 1.12 02:20:58 INFO - mozcrash == 0.17 02:20:58 INFO - mozdebug == 0.1 02:20:58 INFO - mozdevice == 0.48 02:20:58 INFO - mozfile == 1.2 02:20:58 INFO - mozhttpd == 0.7 02:20:58 INFO - mozinfo == 0.9 02:20:58 INFO - mozleak == 0.1 02:20:58 INFO - mozlog == 3.1 02:20:58 INFO - moznetwork == 0.27 02:20:58 INFO - mozprocess == 0.22 02:20:58 INFO - mozprofile == 0.28 02:20:58 INFO - mozrunner == 6.11 02:20:58 INFO - mozscreenshot == 0.1 02:20:58 INFO - mozsystemmonitor == 0.0 02:20:58 INFO - moztest == 0.7 02:20:58 INFO - mozversion == 1.4 02:20:58 INFO - psutil == 3.1.1 02:20:58 INFO - requests == 1.2.3 02:20:58 INFO - wsgiref == 0.1.2 02:20:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6fefc1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2410>, '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 0x1ee3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee37a0>, '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-1460710976.837850-1060755040', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:20:58 INFO - Using env: {'DISPLAY': ':0', 02:20:58 INFO - 'HOME': '/home/cltbld', 02:20:58 INFO - 'LANG': 'en_US.UTF-8', 02:20:58 INFO - 'LANGUAGE': 'en_US:en', 02:20:58 INFO - 'LOGNAME': 'cltbld', 02:20:58 INFO - 'MAIL': '/var/mail/cltbld', 02:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:58 INFO - 'MOZ_NO_REMOTE': '1', 02:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:58 INFO - 'NO_EM_RESTART': '1', 02:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:58 INFO - 'PWD': '/builds/slave/test', 02:20:58 INFO - 'SHELL': '/bin/bash', 02:20:58 INFO - 'SHLVL': '1', 02:20:58 INFO - 'TERM': 'linux', 02:20:58 INFO - 'TMOUT': '86400', 02:20:58 INFO - 'USER': 'cltbld', 02:20:58 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460710976.837850-1060755040', 02:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:58 INFO - '_': '/tools/buildbot/bin/python'} 02:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:20:59 INFO - Cleaning up... 02:20:59 INFO - Return code: 0 02:20:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:20: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6fefc1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2410>, '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 0x1ee3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee37a0>, '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-1460710976.837850-1060755040', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:20:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:20:59 INFO - Using env: {'DISPLAY': ':0', 02:20:59 INFO - 'HOME': '/home/cltbld', 02:20:59 INFO - 'LANG': 'en_US.UTF-8', 02:20:59 INFO - 'LANGUAGE': 'en_US:en', 02:20:59 INFO - 'LOGNAME': 'cltbld', 02:20:59 INFO - 'MAIL': '/var/mail/cltbld', 02:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:59 INFO - 'MOZ_NO_REMOTE': '1', 02:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:20:59 INFO - 'NO_EM_RESTART': '1', 02:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:59 INFO - 'PWD': '/builds/slave/test', 02:20:59 INFO - 'SHELL': '/bin/bash', 02:20:59 INFO - 'SHLVL': '1', 02:20:59 INFO - 'TERM': 'linux', 02:20:59 INFO - 'TMOUT': '86400', 02:20:59 INFO - 'USER': 'cltbld', 02:20:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460710976.837850-1060755040', 02:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:59 INFO - '_': '/tools/buildbot/bin/python'} 02:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:59 INFO - Downloading/unpacking jsonschema 02:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:21:01 INFO - Downloading/unpacking functools32 (from jsonschema) 02:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:01 INFO - Downloading functools32-3.2.3-2.tar.gz 02:21:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:21:01 INFO - warning: no files found matching '*.txt' 02:21:01 INFO - no previously-included directories found matching 'build' 02:21:01 INFO - no previously-included directories found matching 'dist' 02:21:01 INFO - no previously-included directories found matching '.git*' 02:21:01 INFO - Installing collected packages: jsonschema, functools32 02:21:01 INFO - Running setup.py install for functools32 02:21:01 INFO - warning: no files found matching '*.txt' 02:21:01 INFO - no previously-included directories found matching 'build' 02:21:01 INFO - no previously-included directories found matching 'dist' 02:21:01 INFO - no previously-included directories found matching '.git*' 02:21:01 INFO - Successfully installed jsonschema functools32 02:21:01 INFO - Cleaning up... 02:21:01 INFO - Return code: 0 02:21:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:21:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:21:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:21:01 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6fefc1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e535a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2410>, '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 0x1ee3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee37a0>, '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-1460710976.837850-1060755040', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:21:01 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', 'flake8'] in /builds/slave/test/build 02:21:01 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 flake8 02:21:01 INFO - Using env: {'DISPLAY': ':0', 02:21:01 INFO - 'HOME': '/home/cltbld', 02:21:01 INFO - 'LANG': 'en_US.UTF-8', 02:21:01 INFO - 'LANGUAGE': 'en_US:en', 02:21:01 INFO - 'LOGNAME': 'cltbld', 02:21:01 INFO - 'MAIL': '/var/mail/cltbld', 02:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:01 INFO - 'MOZ_NO_REMOTE': '1', 02:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:01 INFO - 'NO_EM_RESTART': '1', 02:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:01 INFO - 'PWD': '/builds/slave/test', 02:21:01 INFO - 'SHELL': '/bin/bash', 02:21:01 INFO - 'SHLVL': '1', 02:21:01 INFO - 'TERM': 'linux', 02:21:01 INFO - 'TMOUT': '86400', 02:21:01 INFO - 'USER': 'cltbld', 02:21:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460710976.837850-1060755040', 02:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:01 INFO - '_': '/tools/buildbot/bin/python'} 02:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:21:01 INFO - Downloading/unpacking flake8 02:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:21:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:21:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21: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 02:21:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:21:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:21:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:21:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:21:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:21:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:21:04 INFO - no previously-included directories found matching 'docs/_build' 02:21:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:21:04 INFO - Running setup.py install for pep8 02:21:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:21:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:21:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:21:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:21:04 INFO - no previously-included directories found matching 'docs/_build' 02:21:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:21:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:21:04 INFO - Cleaning up... 02:21:04 INFO - Return code: 0 02:21:04 INFO - Running post-action listener: _resource_record_post_action 02:21:04 INFO - Running post-action listener: _start_resource_monitoring 02:21:04 INFO - Starting resource monitoring. 02:21:04 INFO - ##### 02:21:04 INFO - ##### Running install step. 02:21:04 INFO - ##### 02:21:04 INFO - Running pre-action listener: _resource_record_pre_action 02:21:04 INFO - Running main action method: install 02:21:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:21:04 INFO - Reading from file tmpfile_stdout 02:21:04 INFO - Detecting whether we're running mozinstall >=1.0... 02:21:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:21:05 INFO - Reading from file tmpfile_stdout 02:21:05 INFO - Output received: 02:21:05 INFO - Usage: mozinstall [options] installer 02:21:05 INFO - Options: 02:21:05 INFO - -h, --help show this help message and exit 02:21:05 INFO - -d DEST, --destination=DEST 02:21:05 INFO - Directory to install application into. [default: 02:21:05 INFO - "/builds/slave/test"] 02:21:05 INFO - --app=APP Application being installed. [default: firefox] 02:21:05 INFO - mkdir: /builds/slave/test/build/application 02:21:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:21:20 INFO - Reading from file tmpfile_stdout 02:21:20 INFO - Output received: 02:21:20 INFO - /builds/slave/test/build/application/firefox/firefox 02:21:20 INFO - Running post-action listener: _resource_record_post_action 02:21:20 INFO - ##### 02:21:20 INFO - ##### Running run-tests step. 02:21:20 INFO - ##### 02:21:20 INFO - Running pre-action listener: _resource_record_pre_action 02:21:20 INFO - Running main action method: run_tests 02:21:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:21:20 INFO - Python 2.7.3 02:21:20 INFO - Return code: 0 02:21:20 INFO - grabbing minidump binary from tooltool 02:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:21:20 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2410>, '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 0x1ee3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee37a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:21:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:21:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:21:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:21:20 INFO - Return code: 0 02:21:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:21:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:21:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:21:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:21:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:21:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:21:21 INFO - Return code: 0 02:21:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.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 02:21:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.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 02:21:21 INFO - Using env: {'DISPLAY': ':0', 02:21:21 INFO - 'HOME': '/home/cltbld', 02:21:21 INFO - 'LANG': 'en_US.UTF-8', 02:21:21 INFO - 'LANGUAGE': 'en_US:en', 02:21:21 INFO - 'LOGNAME': 'cltbld', 02:21:21 INFO - 'MAIL': '/var/mail/cltbld', 02:21:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:21:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:21:21 INFO - 'MOZ_NO_REMOTE': '1', 02:21:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:21:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:21:21 INFO - 'NO_EM_RESTART': '1', 02:21:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:21:21 INFO - 'PWD': '/builds/slave/test', 02:21:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:21:21 INFO - 'SHELL': '/bin/bash', 02:21:21 INFO - 'SHLVL': '1', 02:21:21 INFO - 'TERM': 'linux', 02:21:21 INFO - 'TMOUT': '86400', 02:21:21 INFO - 'USER': 'cltbld', 02:21:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460710976.837850-1060755040', 02:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:21:21 INFO - '_': '/tools/buildbot/bin/python'} 02:21:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.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 02:21:22 INFO - mozversion application_buildid: 20160415014851 02:21:22 INFO - mozversion application_changeset: 529cff9c5663a3581dfb5e690727144f07e8e23c 02:21:22 INFO - mozversion application_display_name: Nightly 02:21:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:21:22 INFO - mozversion application_name: Firefox 02:21:22 INFO - mozversion application_remotingname: firefox 02:21:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:21:22 INFO - mozversion application_vendor: Mozilla 02:21:22 INFO - mozversion application_version: 48.0a1 02:21:22 INFO - mozversion platform_buildid: 20160415014851 02:21:22 INFO - mozversion platform_changeset: 529cff9c5663a3581dfb5e690727144f07e8e23c 02:21:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:21:22 INFO - mozversion platform_version: 48.0a1 02:21:22 INFO - using testdate: 1460712082 02:21:22 INFO - actual date: 1460712082 02:21:22 INFO - starting webserver on 'localhost:39430' 02:21:22 INFO - SUITE-START | Running 2 tests 02:21:22 INFO - TEST-START | dromaeo_css 02:21:22 INFO - operating with platform_type : linux_ 02:21:22 INFO - Initialising browser for dromaeo_css test... 02:21:22 INFO - TEST-INFO | started process 16934 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5zpzaR/profile http://localhost:39430/getInfo.html) 02:21:27 INFO - PROCESS | 16934 | __metrics Screen width/height:1600/1200 02:21:27 INFO - PROCESS | 16934 | colorDepth:24 02:21:27 INFO - PROCESS | 16934 | Browser inner width/height: 1024/697 02:21:27 INFO - PROCESS | 16934 | __metrics 02:21:28 ERROR - PROCESS | 16934 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:21:29 INFO - TEST-INFO | 16934: exit 0 02:21:29 INFO - Browser initialized. 02:21:29 INFO - Running cycle 1/1 for dromaeo_css test... 02:21:29 INFO - TEST-INFO | started process 17015 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5zpzaR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:41 INFO - PROCESS | 17015 | RSS: Main: 155095040 02:21:41 INFO - PROCESS | 17015 | 02:22:31 INFO - PROCESS | 17015 | 1460712151917 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:24:44 INFO - PROCESS | 17015 | Cycle 1(1): loaded http://localhost:39430/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39430/tests/dromaeo/cssquery-ext.html) 02:24:45 INFO - PROCESS | 17015 | RSS: Main: 268595200 02:24:45 INFO - PROCESS | 17015 | 02:27:48 INFO - PROCESS | 17015 | Cycle 1(1): loaded http://localhost:39430/tests/dromaeo/cssquery-ext.html (next: http://localhost:39430/tests/dromaeo/cssquery-jquery.html) 02:27:48 INFO - PROCESS | 17015 | RSS: Main: 226680832 02:27:48 INFO - PROCESS | 17015 | 02:30:50 INFO - PROCESS | 17015 | Cycle 1(1): loaded http://localhost:39430/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39430/tests/dromaeo/cssquery-mootools.html) 02:30:51 INFO - PROCESS | 17015 | RSS: Main: 241016832 02:30:51 INFO - PROCESS | 17015 | 02:33:53 INFO - PROCESS | 17015 | Cycle 1(1): loaded http://localhost:39430/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39430/tests/dromaeo/cssquery-prototype.html) 02:33:54 INFO - PROCESS | 17015 | RSS: Main: 230141952 02:33:54 INFO - PROCESS | 17015 | 02:36:57 INFO - PROCESS | 17015 | Cycle 1(1): loaded http://localhost:39430/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39430/tests/dromaeo/cssquery-yui.html) 02:36:57 INFO - PROCESS | 17015 | RSS: Main: 215322624 02:36:57 INFO - PROCESS | 17015 | 02:40:00 INFO - PROCESS | 17015 | Cycle 1(1): loaded http://localhost:39430/tests/dromaeo/cssquery-yui.html (next: http://localhost:39430/tests/dromaeo/cssquery-dojo.html) 02:40:00 INFO - PROCESS | 17015 | RSS: Main: 286429184 02:40:00 INFO - PROCESS | 17015 | 02:40:00 INFO - PROCESS | 17015 | __start_tp_report 02:40:00 INFO - PROCESS | 17015 | _x_x_mozilla_page_load 02:40:00 INFO - PROCESS | 17015 | _x_x_mozilla_page_load_details 02:40:00 INFO - PROCESS | 17015 | |i|pagename|runs| 02:40:00 INFO - PROCESS | 17015 | |0;dojo.html;2632.670916135483;2704.2022603332016;2712.9864350678245;2721.8639068046605;2748.0381866346775;4596.862094137173;4677.859664210071;4686.250199968006;4700.083483720671;4719.480857105716;4668.789904454299;4696.506866778982;4718.292256161578;4784.545468180526;4788.90422191556;4187.602177793105;4233.9788301058525;4236.83052677894;4268.637165840907;4410.051838854645;4358.956410435902;4378.737275763465;4385.8464953726625;4424.048829501657;4434.9334759978465;4214.494260688737;4301.655867530621;4332.090261045184;4341.696081274328;4406.493253275882;4316.158349121923;4363.5418281080665;4369.541198174209;4369.825206991716;4422.093470838503;4266.57334266574;4271.380649805792;4286.228478873802;4287.099709061101;4324.459442569679;4468.865934021952;4574.336721175411;4631.58315751584;4631.791569379386;4633.698809577367;4946.826861059845;4976.850694479172;4994.500549944976;4995.400551933755;4998.3502144721315;4992.2511623256805;4996.525330093636;5012.398512178562;5023.598112151019;5071.137906555894;4557.840475583339;4675.064987002613;4720.645951553647;4749.715017098985;4750.643701722384;5130.589552835764;5135.075686376488;5140.408852981955;5146.562542183956;5151.690898546024;4887.413510378707;4942.110420124341;4943.777530011158;4946.1344264753525;4988.800447982113;4985.576226020757;4986.875328116754;5072.442031376546;5086;5086.4659210783075;4983.775730092155;4998.275250088716;4999.500049994971;5004.074246264453;5057.468965758616;4750.501197374226;4993.350864387679;4994.550490455877;5000.74996250186;5034.521720436553;4146.626803587692;4222.59885310895;4277.358396240526;4297.226499230106;4301.16127355169;3686.299603075407;3688.114852435396;3694.649008344203;3720.4977328060363;3729.5524537055726;4348.2825333819565;4348.326009468537;4362.76004819738;4369.75966321849;4405.7797110145;4898.583620392306;5030.522100400456;5054.595632349403;5144.948550514522;5154.278401023859;4336.176126535948;4352.869413917588;4355.695101342939;4355.978220108879;4400.44994375703;4514.864554063383;4516.887077823015;4523.457185137804;4525.456945166601;4557.680962332605;4633.559811817872;4686.226772582486;4712.552307530779;4737.763111844325;4759.547842954914;5057.115004874206;5062.088824011713;5070.4929507049;5086.720230387365;5124.103281925573;4606.286025666027;4744.193487107269;4776.331313616027;4781.306710527024;4785.617150628011;4915.680480768881;4931.3835770528685;4945.579625731853;4973.602111830973;4991.475895031114;4948;4973.651844370859;4974.900501989868;4991.575716064175;5020.824271150638;4753.47711751714;4850.927236091391;4852.44196917359;4871.5128487151005;4886.560209581155;4891;4909.582685471775;4918.114739346809;4918.360613120271;4967.7019378837385;4835.709857408426;4840.249761287007;4844.0554091951735;4847.830325938575;4880.487548807324;4807.591354734886;4901.975490122527;4941.061198372297;4967.4535801062575;4995.300657907823;4731.976340118277;4798.95201047985;4816.638752093677;4819;4819.638527110411 02:40:00 INFO - PROCESS | 17015 | |1;ext.html;569.4362581044767;584.777784441912;596.3112604941294;604.9153118563402;605.9848503787405;33279.168020799494;33676.83161584195;34376;34399.82800085999;34475;36468.452973205356;37242.255154896884;37261;37327.06682332936;37331;7192.748253811118;7569.05386826648;7777.300042996129;7786.610669466504;9456.338056336059;9581.808363832719;9760.707178784647;9781.070798274153;9790.118889299962;9792.55933482995;9740.4642744649;9822.214222862154;9827.70516884491;9851.605935762562;9853.556589953434;9659.903400966006;9744.90255097447;9777.120059194636;9779.608815647365;9780.804383912282;9654.22766178704;9970.302078854484;10023.799524009552;10048;10048.145907597864;36605;37087.25825483475;37102;37130.8143459281;37135.81432092849;3135.9216019599467;3154.5899033125775;3194.648588655246;3310.7351411886993;3314.701676849071;29370.412591748045;30210.24678540052;30607.540886886716;30613.234669133228;30953.690463095532;3385.1029477188563;3434.5708280622644;3487.337405892872;3602.8058305556833;3649.087728067983;171276;172131.13934430372;172370.1381493097;172560;172846;50498.74750626223;50604;50747.746261268454;50837.745811271445;51061;56274;56329.43670563324;56397;56401.71799140978;56457.15314270289;14347.354369053417;14823.70352592942;14834.10995340283;14834.406623735145;14853.183074930766;9652;11108.722281943015;11405.828912566318;11449.542018319175;11460.19778615489;18552.721709174373;18596.349127780464;18691.38320635112;18736;18740.437786866416;7039.26087760788;7517.323440890346;7523.360514356341;7529.736459223901;7583.4691571590565;775.7323723315448;799.9920000800034;819.2053707903324;825.9876101858476;895.5880295064343;27038.324041898715;28205.294867628472;28338.14985550437;28652.570211446844;28721.56917646237;950.1591091883732;1058.3226734889677;1066.919981001428;1067.9359238445718;1118.3345909184022;14509.274536273355;15070.472533461276;15127.54617361481;15243.314050867737;15306;331878;336163;337038;337131;337978;47089;48027;48080.759596201795;48137.75931120392;48152.27771583429;1088.450332582041;1235.857876344232;1244.2223610243416;1263.557754785836;1276.4511260158035;24279.635805463284;25171.244862654148;25951.480970380107;25973;26241.606375903993;37431.251374971805;37789.05527361728;37864.62135378611;37914.43128353132;38011.619883800806;226522;228131;228347;228474;228914;31438.52842207323;37649.81175094107;37719;38346.80826595849;38433.807830960664;35853.82073089618;36944.63055369412;42581.78709106435;43192.13615727731;43631;31629.36741265208;31828.840855795574;31834.681653183172;32181.195470113435;32861.83569082139;31461.52807707932;31998.56615834948;33751.83124084364;34230.14424639404;34461.65538344585;33977.83011085028;34482;34610.48084278688;34938.47592286067;34942.65057349394;30287.697123028487;31172;31334.216644584067;31553.842230788698;31671.366572668878;24396.26811195667;24701.25896223116;24726.653522137272;24921.252362429157;27294 02:40:00 INFO - PROCESS | 17015 | |2;jquery.html;388.7647972976349;388.828915277278;393.22338381696153;393.77339587185924;399.11994053112886;12711.42798574064;12941.352932353368;16081.517554473356;16852.988820670755;16853.915730421348;15907;15983.680326393465;16029.91985040076;16183.514494565152;16187.35250589978;4627.0977159454005;4745.92881106782;4752.144613969484;4764.309175169598;4768.308595253686;3440.2087519870447;4659.697119687209;4701.294805779126;4742.90514189716;5187.299714538545;5458.317710286215;5460.6177567570285;5461.453854614547;5467.152591348347;5473.28847249857;5374.91937620934;5418.485243901823;5436.429174936634;5444.5916556258435;5450.890982180374;5118.181091025455;5233.398159211702;5246.842594722164;5257.185136303879;5258.605604579672;12622.116451848375;15565.37738490459;20799.584008319747;20815.583688326147;20892.164313427445;1728.8444040036456;1837.338558119076;1977.439216215005;2020.464576887126;2205.2391924785925;9444.811103777954;9563.760905977406;9882.407055576688;9915.851262231072;12973.221606703628;1580.2256894121913;1606.943112815598;1682.2093616000461;1740.8694347923956;1788.534980904961;65913;66345.33654663488;66640.3335966639;66835.33164668389;69279.65360173167;10113.190944724405;10279.074883260542;10281.845772313422;10626.89373106259;10688.732781680364;14519.709605808035;14582.125072495684;14650.560483185522;14652.120872747457;14666;7205.963970180221;7239.20368759436;7357.963210183915;7468.626568671545;7553.471257012066;6824.976253561907;6843.589384636938;6952.478564107611;7018.508704390746;7027.508074434741;4443.688941774045;4516.909661806745;4533.659975501851;4593.311003349524;4623.029163875623;1852.2035524724497;1855.812280140711;1857.7956424793263;1922.865399422027;1926.25839051966;406.8901396622895;408.98568550100606;419.3939757051032;800.6197056398281;846.5217152308926;10394.896051039545;10561.63034293796;10821.783564328669;10885.618074082911;11006.504707288192;436.4304582519779;441.5077188934379;442.63261492960766;444.7709429643736;445.9464864216315;5782.6819524925695;5803.071508558611;5822.912656310159;5908.261467316585;6012.188354572164;383688;386928;404183;407636;409247;55538.72230638821;74705.62647186838;78407.60796195983;81305;83736.58131709302;445.23864192231645;451.05954085731616;455.35794529712945;456.21303251890885;457.5378867344007;10227.232957528364;10399.896001040195;10526.52630631608;10606.098481629147;10669.679909602724;32773;33205.83397083096;33928.321433571684;34360.48459273163;35223.29553408866;45276;47012.29481557711;49501.504984949686;50896.23655645242;51006.74496627493;7536.623168841426;7554.169041405551;7585.127710313384;7755.573443460664;7773.961130194313;9279.67521136757;10666;10941.671749847517;11099.223054386439;11312.547498100314;9222.95388523053;9327.160555550034;9779.85330220033;9782.75543111428;10053.246006549683;9206.631734730536;9380.108889655472;9428.858567121635;9447.433154010781;9781;8880.467171969702;9270;9672.177864881563;9708.514574271117;9722.75693107678;7263.745768898063;7445.516041457288;7475.887861682188;7502.549847009197;7528.548287102792;7266.491345605757;8268.83462330762;9333.953330233577;9460;9488.85766713486 02:40:00 INFO - PROCESS | 17015 | |3;mootools.html;1309.3060677840747;1401.0332870319478;1465.780132980053;1576.377330954273;1772.335374234662;6722.29415911329;7668.69325226991;7870.370370370371;7891.28978391946;7897.052353717555;7531.209223031571;7762.767116986485;7767.495112817663;7789.376849852012;7791.415643826722;1901.1729897494565;2184.486645638274;2201.8899055047264;2241.618924782791;2272.874991875446;2276.726792784868;2301.4361481436986;2305.654151877215;2305.8385912986096;2307.6999990001277;2171.326888664511;2177.3467959612053;2180.1606381543143;2182.1925887421676;2184.1045171479695;1872.0546124207324;2152.7847215278425;2214.7563767985507;2217.545403192342;2220.6891035254916;2112;2125.659894416886;2136.647453170225;2137.348108826807;2146.6672665736837;7796.454248202628;7893.1712170222445;7905.221325201784;7923.247291507298;7931.524108553505;4496.213162696515;4634.443866735979;4641.327007583882;4651.372064771246;4666.510016448258;3029.4092651932883;3040.1639549123947;3090.644575873781;3094.4584697677815;3104.9068527944196;1025.3031233308811;1027.5222021759917;1029.1303848248292;1769.1684908093175;1810.5654642885745;10416.791664166674;10478.266521343508;10528.789424211473;10534.736631584195;10578.682639520826;3962.5641179470235;4070.287699652549;4176.540580536139;4180.163967206571;4206.85276015338;8389.412741108186;8426.747197584082;8428.620712067848;8432.578371081421;8436.156384361515;4004.4593979812935;4508.616767574727;4514.45826500822;4515.390422293014;4531.410916580823;4139.81370838313;4282.700210985264;4294.377315289265;4330.242207613718;4339.7830108494445;3680.4111342185656;3746.38184699527;3822.7706337619834;3832.904177395532;3881.165549406891;1221.1085907287552;1237.962861114168;1251.7746805574902;1260.521002019227;1264.9873501265054;749.2881762325703;823.4153750836853;828.3456069704986;863.1368631368631;867.124204553393;5438.809641662602;5447.482489163603;5488.588355873326;5496.258005169251;5628.831135065954;830.8504469195602;871.1854416120821;877.5787621941504;902.2060586683676;907.0747837206013;3835;3885.533735951704;3924.17592305619;3933.174033453007;3940.9802950985063;9549.236061115094;9919.603215871428;9930.950345248228;9986.900130998742;10015.14871235953;9172.44965302084;9721.513924303756;9767.413955162712;9774.804503909882;9860.605575777032;7085.220625731268;7124.145102587619;7147.463940204506;7183.820404489929;7225.458090643223;5580.469855363734;5586.329640443173;5673.461021202979;5712.285964254468;5737.225474560881;9084.091590840862;9160.770980725536;9202.49386283734;9302.627894884128;9326.906730932604;8862.246709029805;9155.954220228856;9390.718278451657;9507.762305942406;9523.714288571355;6153.661548614869;6524.575902566318;6721.361470660279;6812.591244525344;6950.409215216763;7501.587412692136;7517.624118794148;7551.622418878924;7575.621218938921;7589.924100758922;6649;6768.221654509597;6813.931860681329;6869;7016.26329235423;6671.432928201158;6688.063671086149;6710.63091529951;6713.1944166700305;6876.140482439695;6252.781152659635;6406.0390941359165;6454.064160696579;6466.773662921775;6467;4648.935055604578;4682.976585117052;4741.35991641124;4772.880677983078;4779.235322348408;4669.953300466952;4867.659263851497;4902.558769710743;4942.777575009061;4943.8516844494725 02:40:00 INFO - PROCESS | 17015 | |4;prototype.html;318.9569408129903;321.373322022057;322.3327711636912;329.0408459341021;329.453107840984;5075.974620126899;5132.43543210247;5139.588832893369;5148.5623721983675;5149.789799397138;5047.728522165022;5051.6463847530595;5056.216286475593;5071.6703414278045;5099.317225315646;3791.165943492434;3864.613538646141;4004.1391100913297;4020.768473497208;4043.676505879537;4001.9594905324534;4020.8190631421658;4024.678025757947;4026.879193624196;4027.8187481563255;3789.5642001169945;3963.4649322341547;4000.6999475039343;4006.6994975376965;4021.6983726220506;3886.9805650971707;3972.1857019310974;3983.223271462066;4001.9399709004388;4011.7592944423136;3524.84138213781;3531;3532.4701294805727;3534.7879127252445;3553.626869178751;4842.539958703917;4843.806247750086;4844.128056949783;4868.513148685103;4921.384826896638;4265.7227280227;4559.977200114012;4569.743320586832;4569.931451028204;4641.280601506772;5322.65402748824;5374.5700343972385;5393.946060539383;5397;5398.055340315429;3800.277947190025;3802.4866643003393;3807.8857634271017;3808.390657494815;3819.9809000955097;5534.723263836792;5613.410591887834;5646.830595082113;5673.205751194836;5683.175939488792;3853.2678791029616;3869.813555341223;3875.6511913927884;3884.378499440076;3893.8637147699696;3880.5149356330458;3891.7081218908697;3897.2400381925254;3926.312895243321;3931.292367373843;4391.538888416734;4490.887727806831;4513.909721805546;4521.480029796616;4524.547545245449;5350.652207606493;5390.434004429479;5393.191021346751;5408.702521361284;5421.972890135524;1359.3814814259488;1381.378379729126;1381.4543255414055;1389.3122904162503;1389.9722005559831;868.561376504861;911.876896618948;920.4983284110176;934.1265916368218;945.4516380499294;4708.246680531099;4732.597729193058;4733.360996265529;4735.313379559944;4761.809527618926;5492.286002819687;5506.91739623906;5516.503514683698;5524.944750552523;5535.723213839373;4599.4710608280475;4671.878749100191;4710.458297295855;4737.147313483606;4737.905241895142;2919.9270018249713;2928.5753565733276;2928.726004188185;2936.721011503904;2951.4834903891733;5183.3261675981885;5186.455422180692;5189.532942035235;5205.6356055075785;5206.453322401093;5440.183972404092;5609.8597535061135;5628.887422251532;5630.831075067755;5631.352394474688;5155.407128180233;5160.535551800281;5160.638755287094;5170.889143131295;5188.688678679291;5460.563154947674;5478.808241711521;5479.369872464717;5487.368952570506;5492;5221.363211578128;5442.537384322377;5447.536959358499;5499.642523235977;5529.834104976857;5248.212768084818;5261.210818377274;5268.868278293074;5276.314079169683;5302.363716353908;3895.9415608765325;3929.6659783918685;3931.1548017176447;3938.409238614116;3940.5419994601034;5289;5578.30271216098;5583.916241256303;5601.719914004202;5605.691686957257;5369.140937449989;5404.702741349263;5409.810656626999;5412.810551630674;5449.509544141047;5217.582593392595;5409.810656627156;5413.891722165614;5415.729213539228;5424.996375670514;5118.800749531542;5296.841094767163;5335.199720042025;5344.331958505187;5349.973250133725;5232.319798426181;5449.482299181572;5453.7094420342755;5458.796726520636;5468.0430924587245;5314.1497360422145;5336.146216605324;5341.278927344914;5344.4922732340365;5346.465353464778 02:40:00 INFO - PROCESS | 17015 | |5;yui.html;665.1552528289074;709.492712710412;724.8912663100535;739.9408047356212;746.2686567164176;11126.666200014002;11386.658400247985;11410.08719302456;11426.542938282479;11461.083113350933;11448.656540303784;11498.022668073203;11519.136064795153;11520.769584608302;11523.884761152385;634.1882390540104;778.81697801017;811.2212276214841;813.9633716482742;814.3322475570035;803.2048272210499;804.6580203413555;809.5062012172571;810.8864758933754;811.5901469757764;671.2582596231167;853.4282031039219;856.092541905582;856.2037305306063;856.3448961544424;822.8107535266893;843.696269343039;844.7719115838751;845.3490812074668;846.2468403121227;613.7974468425409;615.1111643674892;623.3112410786061;623.6071275096706;624.2166081567649;11151.944240278746;11267.661970140909;11280.774384512264;11285.887141128565;11293.774124517464;12037.097217708619;12463.75072498554;12666;12914.861833460782;12958;9619.759506012335;9958.253131015203;9981.950090249575;10015.649452269208;10148.289619726622;3962.643362097425;4034.636882680573;4039.3738970459626;4048.655864251542;4162.979185104085;42969.785151074044;43222.91942701426;43473.78263108696;43489;43738;9531.571079301448;9782.510874456391;10015.649452269136;10238.129758970423;10374.740631484274;17103.74344384835;17246;17315.91342043282;17522.737158942626;17546.824531754773;6690.297518760557;6766.018927255619;6844.4182244508775;6944.097267355211;7157.4274058075225;3835.8657446989223;3863.2080423513676;3868.845246190177;3947.4473573699706;3970.5235371755575;2945.9558106627987;3026.379592183597;3027.4399236141385;3032.9545056824163;3034.332446861687;546.9179623056493;555.7582451633552;568.2499101186477;569.3765326966965;595.6188039654625;486.5888324365905;512.7641285008938;561.4974597735086;563.7688547695425;587.3949831673383;7681.423893208032;7682.500637458659;7738.961305193438;7891.092524359772;8001.719939802079;594.5154698920453;595.3332267860025;605.2071785960406;610.5725991805754;613.1783410230313;3796.6962642988497;3968.761874287552;4089.7750623715983;4111.48606424197;4115.9588404116175;41122.588774112475;44959.55040449619;53321.7333913328;54061.72969135129;54570.18144727832;38606.42090368647;38740.41889371662;39331.606683933365;39409.40885886714;40849;34947.65052349444;37504;38448.423273650915;38941;39724.404133938595;7303.8539229216185;7544.924550754642;7654.349380302737;7705.537667739954;7710.460267781202;26418.60372094382;26977;27224.591631125153;27239.319017024733;27283.454330912875;34364.14089647679;34725;35035.29929401448;35189;35926.820365898006;10231.232657550863;10303.124234440156;10585.682429527127;10679.733006674585;10842.132629389787;11179.385133817394;11306.604268850551;11403.429828508375;11562.30626162433;11873.762524749629;10546.630867919586;10732.892671073501;10822.891771082188;11209.215354925404;11287.379194144401;11031.282966607145;11419.429028548706;11433.771324573629;11481.081513479068;11548.249363791327;9895.752606184902;10334.689959301233;10356.689299321033;10768;10797.62208322705;9079.500627465553;9188.310876684409;9240;9461.243100552078;10091.646792362231;9227.30795190377;9566;9615.182709469495;9683.031696830261;9715.17421019193 02:40:00 INFO - PROCESS | 17015 | __end_tp_report 02:40:00 INFO - PROCESS | 17015 | __start_cc_report 02:40:00 INFO - PROCESS | 17015 | _x_x_mozilla_cycle_collect,1123 02:40:00 INFO - PROCESS | 17015 | __end_cc_report 02:40:00 INFO - PROCESS | 17015 | __startTimestamp1460713200774__endTimestamp 02:40:00 INFO - PROCESS | 17015 | 02:40:00 INFO - PROCESS | 17015 | ------- Summary: start ------- 02:40:00 INFO - PROCESS | 17015 | Number of tests: 6 02:40:00 INFO - PROCESS | 17015 | 02:40:00 INFO - PROCESS | 17015 | [#0] dojo.html Cycles:165 Average:4641.69 Median:4759.55 stddev:474.81 (10.0%) stddev-sans-first:449.35 02:40:00 INFO - PROCESS | 17015 | Values: 2632.7 2704.2 2713.0 2721.9 2748.0 4596.9 4677.9 4686.3 4700.1 4719.5 4668.8 4696.5 4718.3 4784.5 4788.9 4187.6 4234.0 4236.8 4268.6 4410.1 4359.0 4378.7 4385.8 4424.0 4434.9 4214.5 4301.7 4332.1 4341.7 4406.5 4316.2 4363.5 4369.5 4369.8 4422.1 4266.6 4271.4 4286.2 4287.1 4324.5 4468.9 4574.3 4631.6 4631.8 4633.7 4946.8 4976.9 4994.5 4995.4 4998.4 4992.3 4996.5 5012.4 5023.6 5071.1 4557.8 4675.1 4720.6 4749.7 4750.6 5130.6 5135.1 5140.4 5146.6 5151.7 4887.4 4942.1 4943.8 4946.1 4988.8 4985.6 4986.9 5072.4 5086.0 5086.5 4983.8 4998.3 4999.5 5004.1 5057.5 4750.5 4993.4 4994.6 5000.7 5034.5 4146.6 4222.6 4277.4 4297.2 4301.2 3686.3 3688.1 3694.6 3720.5 3729.6 4348.3 4348.3 4362.8 4369.8 4405.8 4898.6 5030.5 5054.6 5144.9 5154.3 4336.2 4352.9 4355.7 4356.0 4400.4 4514.9 4516.9 4523.5 4525.5 4557.7 4633.6 4686.2 4712.6 4737.8 4759.5 5057.1 5062.1 5070.5 5086.7 5124.1 4606.3 4744.2 4776.3 4781.3 4785.6 4915.7 4931.4 4945.6 4973.6 4991.5 4948.0 4973.7 4974.9 4991.6 5020.8 4753.5 4850.9 4852.4 4871.5 4886.6 4891.0 4909.6 4918.1 4918.4 4967.7 4835.7 4840.2 4844.1 4847.8 4880.5 4807.6 4902.0 4941.1 4967.5 4995.3 4732.0 4799.0 4816.6 4819.0 4819.6 02:40:00 INFO - PROCESS | 17015 | 02:40:00 INFO - PROCESS | 17015 | [#1] ext.html Cycles:180 Average:41093.64 Median:18905.29 stddev:66634.29 (352.5%) stddev-sans-first:66751.74 02:40:00 INFO - PROCESS | 17015 | Values: 569.4 584.8 596.3 604.9 606.0 33279.2 33676.8 34376.0 34399.8 34475.0 36468.5 37242.3 37261.0 37327.1 37331.0 7192.7 7569.1 7777.3 7786.6 9456.3 9581.8 9760.7 9781.1 9790.1 9792.6 9740.5 9822.2 9827.7 9851.6 9853.6 9659.9 9744.9 9777.1 9779.6 9780.8 9654.2 9970.3 10023.8 10048.0 10048.1 36605.0 37087.3 37102.0 37130.8 37135.8 3135.9 3154.6 3194.6 3310.7 3314.7 29370.4 30210.2 30607.5 30613.2 30953.7 3385.1 3434.6 3487.3 3602.8 3649.1 171276.0 172131.1 172370.1 172560.0 172846.0 50498.7 50604.0 50747.7 50837.7 51061.0 56274.0 56329.4 56397.0 56401.7 56457.2 14347.4 14823.7 14834.1 14834.4 14853.2 9652.0 11108.7 11405.8 11449.5 11460.2 18552.7 18596.3 18691.4 18736.0 18740.4 7039.3 7517.3 7523.4 7529.7 7583.5 775.7 800.0 819.2 826.0 895.6 27038.3 28205.3 28338.1 28652.6 28721.6 950.2 1058.3 1066.9 1067.9 1118.3 14509.3 15070.5 15127.5 15243.3 15306.0 331878.0 336163.0 337038.0 337131.0 337978.0 47089.0 48027.0 48080.8 48137.8 48152.3 1088.5 1235.9 1244.2 1263.6 1276.5 24279.6 25171.2 25951.5 25973.0 26241.6 37431.3 37789.1 37864.6 37914.4 38011.6 226522.0 228131.0 228347.0 228474.0 228914.0 31438.5 37649.8 37719.0 38346.8 38433.8 35853.8 36944.6 42581.8 43192.1 43631.0 31629.4 31828.8 31834.7 32181.2 32861.8 31461.5 31998.6 33751.8 34230.1 34461.7 33977.8 34482.0 34610.5 34938.5 34942.7 30287.7 31172.0 31334.2 31553.8 31671.4 24396.3 24701.3 24726.7 24921.3 27294.0 02:40:00 INFO - PROCESS | 17015 | 02:40:00 INFO - PROCESS | 17015 | [#2] jquery.html Cycles:180 Average:23586.28 Median:4625.06 stddev:65763.93 (1421.9%) stddev-sans-first:65925.35 02:40:00 INFO - PROCESS | 17015 | Values: 388.8 388.8 393.2 393.8 399.1 12711.4 12941.4 16081.5 16853.0 16853.9 15907.0 15983.7 16029.9 16183.5 16187.4 4627.1 4745.9 4752.1 4764.3 4768.3 3440.2 4659.7 4701.3 4742.9 5187.3 5458.3 5460.6 5461.5 5467.2 5473.3 5374.9 5418.5 5436.4 5444.6 5450.9 5118.2 5233.4 5246.8 5257.2 5258.6 12622.1 15565.4 20799.6 20815.6 20892.2 1728.8 1837.3 1977.4 2020.5 2205.2 9444.8 9563.8 9882.4 9915.9 12973.2 1580.2 1606.9 1682.2 1740.9 1788.5 65913.0 66345.3 66640.3 66835.3 69279.7 10113.2 10279.1 10281.8 10626.9 10688.7 14519.7 14582.1 14650.6 14652.1 14666.0 7206.0 7239.2 7358.0 7468.6 7553.5 6825.0 6843.6 6952.5 7018.5 7027.5 4443.7 4516.9 4533.7 4593.3 4623.0 1852.2 1855.8 1857.8 1922.9 1926.3 406.9 409.0 419.4 800.6 846.5 10394.9 10561.6 10821.8 10885.6 11006.5 436.4 441.5 442.6 444.8 445.9 5782.7 5803.1 5822.9 5908.3 6012.2 383688.0 386928.0 404183.0 407636.0 409247.0 55538.7 74705.6 78407.6 81305.0 83736.6 445.2 451.1 455.4 456.2 457.5 10227.2 10399.9 10526.5 10606.1 10669.7 32773.0 33205.8 33928.3 34360.5 35223.3 45276.0 47012.3 49501.5 50896.2 51006.7 7536.6 7554.2 7585.1 7755.6 7774.0 9279.7 10666.0 10941.7 11099.2 11312.5 9223.0 9327.2 9779.9 9782.8 10053.2 9206.6 9380.1 9428.9 9447.4 9781.0 8880.5 9270.0 9672.2 9708.5 9722.8 7263.7 7445.5 7475.9 7502.5 7528.5 7266.5 8268.8 9334.0 9460.0 9488.9 02:40:00 INFO - PROCESS | 17015 | 02:40:00 INFO - PROCESS | 17015 | [#3] mootools.html Cycles:180 Average:5198.34 Median:5191.33 stddev:2849.34 (54.9%) stddev-sans-first:2842.35 02:40:00 INFO - PROCESS | 17015 | Values: 1309.3 1401.0 1465.8 1576.4 1772.3 6722.3 7668.7 7870.4 7891.3 7897.1 7531.2 7762.8 7767.5 7789.4 7791.4 1901.2 2184.5 2201.9 2241.6 2272.9 2276.7 2301.4 2305.7 2305.8 2307.7 2171.3 2177.3 2180.2 2182.2 2184.1 1872.1 2152.8 2214.8 2217.5 2220.7 2112.0 2125.7 2136.6 2137.3 2146.7 7796.5 7893.2 7905.2 7923.2 7931.5 4496.2 4634.4 4641.3 4651.4 4666.5 3029.4 3040.2 3090.6 3094.5 3104.9 1025.3 1027.5 1029.1 1769.2 1810.6 10416.8 10478.3 10528.8 10534.7 10578.7 3962.6 4070.3 4176.5 4180.2 4206.9 8389.4 8426.7 8428.6 8432.6 8436.2 4004.5 4508.6 4514.5 4515.4 4531.4 4139.8 4282.7 4294.4 4330.2 4339.8 3680.4 3746.4 3822.8 3832.9 3881.2 1221.1 1238.0 1251.8 1260.5 1265.0 749.3 823.4 828.3 863.1 867.1 5438.8 5447.5 5488.6 5496.3 5628.8 830.9 871.2 877.6 902.2 907.1 3835.0 3885.5 3924.2 3933.2 3941.0 9549.2 9919.6 9931.0 9986.9 10015.1 9172.4 9721.5 9767.4 9774.8 9860.6 7085.2 7124.1 7147.5 7183.8 7225.5 5580.5 5586.3 5673.5 5712.3 5737.2 9084.1 9160.8 9202.5 9302.6 9326.9 8862.2 9156.0 9390.7 9507.8 9523.7 6153.7 6524.6 6721.4 6812.6 6950.4 7501.6 7517.6 7551.6 7575.6 7589.9 6649.0 6768.2 6813.9 6869.0 7016.3 6671.4 6688.1 6710.6 6713.2 6876.1 6252.8 6406.0 6454.1 6466.8 6467.0 4648.9 4683.0 4741.4 4772.9 4779.2 4670.0 4867.7 4902.6 4942.8 4943.9 02:40:00 INFO - PROCESS | 17015 | 02:40:00 INFO - PROCESS | 17015 | [#4] prototype.html Cycles:180 Average:4455.33 Median:5109.06 stddev:1297.35 (25.4%) stddev-sans-first:1263.29 02:40:00 INFO - PROCESS | 17015 | Values: 319.0 321.4 322.3 329.0 329.5 5076.0 5132.4 5139.6 5148.6 5149.8 5047.7 5051.6 5056.2 5071.7 5099.3 3791.2 3864.6 4004.1 4020.8 4043.7 4002.0 4020.8 4024.7 4026.9 4027.8 3789.6 3963.5 4000.7 4006.7 4021.7 3887.0 3972.2 3983.2 4001.9 4011.8 3524.8 3531.0 3532.5 3534.8 3553.6 4842.5 4843.8 4844.1 4868.5 4921.4 4265.7 4560.0 4569.7 4569.9 4641.3 5322.7 5374.6 5393.9 5397.0 5398.1 3800.3 3802.5 3807.9 3808.4 3820.0 5534.7 5613.4 5646.8 5673.2 5683.2 3853.3 3869.8 3875.7 3884.4 3893.9 3880.5 3891.7 3897.2 3926.3 3931.3 4391.5 4490.9 4513.9 4521.5 4524.5 5350.7 5390.4 5393.2 5408.7 5422.0 1359.4 1381.4 1381.5 1389.3 1390.0 868.6 911.9 920.5 934.1 945.5 4708.2 4732.6 4733.4 4735.3 4761.8 5492.3 5506.9 5516.5 5524.9 5535.7 4599.5 4671.9 4710.5 4737.1 4737.9 2919.9 2928.6 2928.7 2936.7 2951.5 5183.3 5186.5 5189.5 5205.6 5206.5 5440.2 5609.9 5628.9 5630.8 5631.4 5155.4 5160.5 5160.6 5170.9 5188.7 5460.6 5478.8 5479.4 5487.4 5492.0 5221.4 5442.5 5447.5 5499.6 5529.8 5248.2 5261.2 5268.9 5276.3 5302.4 3895.9 3929.7 3931.2 3938.4 3940.5 5289.0 5578.3 5583.9 5601.7 5605.7 5369.1 5404.7 5409.8 5412.8 5449.5 5217.6 5409.8 5413.9 5415.7 5425.0 5118.8 5296.8 5335.2 5344.3 5350.0 5232.3 5449.5 5453.7 5458.8 5468.0 5314.1 5336.1 5341.3 5344.5 5346.5 02:40:00 INFO - PROCESS | 17015 | 02:40:00 INFO - PROCESS | 17015 | [#5] yui.html Cycles:180 Average:12044.45 Median:22469.39 stddev:13113.57 (58.4%) stddev-sans-first:13122.51 02:40:00 INFO - PROCESS | 17015 | Values: 665.2 709.5 724.9 739.9 746.3 11126.7 11386.7 11410.1 11426.5 11461.1 11448.7 11498.0 11519.1 11520.8 11523.9 634.2 778.8 811.2 814.0 814.3 803.2 804.7 809.5 810.9 811.6 671.3 853.4 856.1 856.2 856.3 822.8 843.7 844.8 845.3 846.2 613.8 615.1 623.3 623.6 624.2 11151.9 11267.7 11280.8 11285.9 11293.8 12037.1 12463.8 12666.0 12914.9 12958.0 9619.8 9958.3 9982.0 10015.6 10148.3 3962.6 4034.6 4039.4 4048.7 4163.0 42969.8 43222.9 43473.8 43489.0 43738.0 9531.6 9782.5 10015.6 10238.1 10374.7 17103.7 17246.0 17315.9 17522.7 17546.8 6690.3 6766.0 6844.4 6944.1 7157.4 3835.9 3863.2 3868.8 3947.4 3970.5 2946.0 3026.4 3027.4 3033.0 3034.3 546.9 555.8 568.2 569.4 595.6 486.6 512.8 561.5 563.8 587.4 7681.4 7682.5 7739.0 7891.1 8001.7 594.5 595.3 605.2 610.6 613.2 3796.7 3968.8 4089.8 4111.5 4116.0 41122.6 44959.6 53321.7 54061.7 54570.2 38606.4 38740.4 39331.6 39409.4 40849.0 34947.7 37504.0 38448.4 38941.0 39724.4 7303.9 7544.9 7654.3 7705.5 7710.5 26418.6 26977.0 27224.6 27239.3 27283.5 34364.1 34725.0 35035.3 35189.0 35926.8 10231.2 10303.1 10585.7 10679.7 10842.1 11179.4 11306.6 11403.4 11562.3 11873.8 10546.6 10732.9 10822.9 11209.2 11287.4 11031.3 11419.4 11433.8 11481.1 11548.2 9895.8 10334.7 10356.7 10768.0 10797.6 9079.5 9188.3 9240.0 9461.2 10091.6 9227.3 9566.0 9615.2 9683.0 9715.2 02:40:00 INFO - PROCESS | 17015 | -------- Summary: end -------- 02:40:00 INFO - PROCESS | 17015 | 02:40:01 INFO - TEST-INFO | 17015: exit 0 02:40:01 INFO - TEST-OK | dromaeo_css | took 1119513ms 02:40:01 INFO - TEST-START | kraken 02:40:01 INFO - operating with platform_type : linux_ 02:40:01 INFO - Initialising browser for kraken test... 02:40:01 INFO - TEST-INFO | started process 17194 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwVYwPv/profile http://localhost:39430/getInfo.html) 02:40:06 INFO - PROCESS | 17194 | __metrics Screen width/height:1600/1200 02:40:06 INFO - PROCESS | 17194 | colorDepth:24 02:40:06 INFO - PROCESS | 17194 | Browser inner width/height: 1024/697 02:40:06 INFO - PROCESS | 17194 | __metrics 02:40:07 ERROR - PROCESS | 17194 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:40:08 INFO - TEST-INFO | 17194: exit 0 02:40:08 INFO - Browser initialized. 02:40:08 INFO - Running cycle 1/1 for kraken test... 02:40:08 INFO - TEST-INFO | started process 17275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwVYwPv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:40:20 INFO - PROCESS | 17275 | RSS: Main: 155205632 02:40:20 INFO - PROCESS | 17275 | 02:40:23 INFO - PROCESS | 17275 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39430/tests/kraken/driver.html?testName=audio-beat-detection) 02:40:24 INFO - PROCESS | 17275 | RSS: Main: 210632704 02:40:24 INFO - PROCESS | 17275 | 02:40:27 INFO - PROCESS | 17275 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39430/tests/kraken/driver.html?testName=audio-dft) 02:40:27 INFO - PROCESS | 17275 | RSS: Main: 195670016 02:40:27 INFO - PROCESS | 17275 | 02:40:30 INFO - PROCESS | 17275 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39430/tests/kraken/driver.html?testName=audio-fft) 02:40:31 INFO - PROCESS | 17275 | RSS: Main: 265523200 02:40:31 INFO - PROCESS | 17275 | 02:40:33 INFO - PROCESS | 17275 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39430/tests/kraken/driver.html?testName=audio-oscillator) 02:40:34 INFO - PROCESS | 17275 | RSS: Main: 174383104 02:40:34 INFO - PROCESS | 17275 | 02:40:36 INFO - PROCESS | 17275 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39430/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:40:37 INFO - PROCESS | 17275 | RSS: Main: 178737152 02:40:37 INFO - PROCESS | 17275 | 02:40:40 INFO - PROCESS | 17275 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39430/tests/kraken/driver.html?testName=imaging-darkroom) 02:40:40 INFO - PROCESS | 17275 | RSS: Main: 214712320 02:40:40 INFO - PROCESS | 17275 | 02:40:44 INFO - PROCESS | 17275 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39430/tests/kraken/driver.html?testName=imaging-desaturate) 02:40:45 INFO - PROCESS | 17275 | RSS: Main: 215719936 02:40:45 INFO - PROCESS | 17275 | 02:40:47 INFO - PROCESS | 17275 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39430/tests/kraken/driver.html?testName=json-parse-financial) 02:40:48 INFO - PROCESS | 17275 | RSS: Main: 215449600 02:40:48 INFO - PROCESS | 17275 | 02:40:50 INFO - PROCESS | 17275 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39430/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:40:50 INFO - PROCESS | 17275 | RSS: Main: 201129984 02:40:50 INFO - PROCESS | 17275 | 02:40:52 INFO - PROCESS | 17275 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39430/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:40:53 INFO - PROCESS | 17275 | RSS: Main: 205443072 02:40:53 INFO - PROCESS | 17275 | 02:40:55 INFO - PROCESS | 17275 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39430/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:40:56 INFO - PROCESS | 17275 | RSS: Main: 218701824 02:40:56 INFO - PROCESS | 17275 | 02:40:58 INFO - PROCESS | 17275 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:40:59 INFO - PROCESS | 17275 | RSS: Main: 225464320 02:40:59 INFO - PROCESS | 17275 | 02:41:02 INFO - PROCESS | 17275 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:41:03 INFO - PROCESS | 17275 | RSS: Main: 221167616 02:41:03 INFO - PROCESS | 17275 | 02:41:04 INFO - PROCESS | 17275 | Cycle 1(1): loaded http://localhost:39430/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39430/tests/kraken/driver.html?testName=ai-astar) 02:41:05 INFO - PROCESS | 17275 | RSS: Main: 283762688 02:41:05 INFO - PROCESS | 17275 | 02:41:05 INFO - PROCESS | 17275 | __start_tp_report 02:41:05 INFO - PROCESS | 17275 | _x_x_mozilla_page_load 02:41:05 INFO - PROCESS | 17275 | _x_x_mozilla_page_load_details 02:41:05 INFO - PROCESS | 17275 | |i|pagename|runs| 02:41:05 INFO - PROCESS | 17275 | |0;ai-astar;111;113;108;111;111;112;101;111;111;113 02:41:05 INFO - PROCESS | 17275 | |1;audio-beat-detection;168;133;159;189;133;158;160;134;201;132 02:41:05 INFO - PROCESS | 17275 | |2;audio-dft;161;160;161;170;162;162;162;162;162;161 02:41:05 INFO - PROCESS | 17275 | |3;audio-fft;73;76;124;117;75;78;74;117;107;73 02:41:05 INFO - PROCESS | 17275 | |4;audio-oscillator;95;95;162;93;95;95;150;94;93;145 02:41:05 INFO - PROCESS | 17275 | |5;imaging-gaussian-blur;117;117;118;117;117;118;119;117;117;117 02:41:05 INFO - PROCESS | 17275 | |6;imaging-darkroom;146;147;146;146;147;147;147;147;149;148 02:41:05 INFO - PROCESS | 17275 | |7;imaging-desaturate;96;95;95;95;95;96;96;95;96;96 02:41:05 INFO - PROCESS | 17275 | |8;json-parse-financial;65;66;65;64;65;66;66;86;64;64 02:41:05 INFO - PROCESS | 17275 | |9;json-stringify-tinderbox;65;65;66;64;65;65;64;64;65;64 02:41:05 INFO - PROCESS | 17275 | |10;stanford-crypto-aes;84;85;82;85;85;92;89;83;85;84 02:41:05 INFO - PROCESS | 17275 | |11;stanford-crypto-ccm;153;138;137;137;137;145;133;137;175;147 02:41:05 INFO - PROCESS | 17275 | |12;stanford-crypto-pbkdf2;180;169;171;171;181;170;179;174;174;174 02:41:05 INFO - PROCESS | 17275 | |13;stanford-crypto-sha256-iterative;84;73;74;74;71;72;71;71;70;70 02:41:05 INFO - PROCESS | 17275 | __end_tp_report 02:41:05 INFO - PROCESS | 17275 | __start_cc_report 02:41:05 INFO - PROCESS | 17275 | _x_x_mozilla_cycle_collect,1858 02:41:05 INFO - PROCESS | 17275 | __end_cc_report 02:41:05 INFO - PROCESS | 17275 | __startTimestamp1460713265164__endTimestamp 02:41:05 INFO - PROCESS | 17275 | 02:41:05 INFO - PROCESS | 17275 | ------- Summary: start ------- 02:41:05 INFO - PROCESS | 17275 | Number of tests: 14 02:41:05 INFO - PROCESS | 17275 | 02:41:05 INFO - PROCESS | 17275 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:3.52 (3.2%) stddev-sans-first:3.72 02:41:05 INFO - PROCESS | 17275 | Values: 111.0 113.0 108.0 111.0 111.0 112.0 101.0 111.0 111.0 113.0 02:41:05 INFO - PROCESS | 17275 | 02:41:05 INFO - PROCESS | 17275 | [#1] audio-beat-detection Cycles:10 Average:156.70 Median:159.50 stddev:24.50 (15.4%) stddev-sans-first:25.64 02:41:05 INFO - PROCESS | 17275 | Values: 168.0 133.0 159.0 189.0 133.0 158.0 160.0 134.0 201.0 132.0 02:41:05 INFO - PROCESS | 17275 | 02:41:05 INFO - PROCESS | 17275 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:2.79 (1.7%) stddev-sans-first:2.92 02:41:05 INFO - PROCESS | 17275 | Values: 161.0 160.0 161.0 170.0 162.0 162.0 162.0 162.0 162.0 161.0 02:41:05 INFO - PROCESS | 17275 | 02:41:05 INFO - PROCESS | 17275 | [#3] audio-fft Cycles:10 Average:91.40 Median:73.50 stddev:21.81 (29.7%) stddev-sans-first:22.10 02:41:05 INFO - PROCESS | 17275 | Values: 73.0 76.0 124.0 117.0 75.0 78.0 74.0 117.0 107.0 73.0 02:41:05 INFO - PROCESS | 17275 | 02:41:05 INFO - PROCESS | 17275 | [#4] audio-oscillator Cycles:10 Average:111.70 Median:94.50 stddev:28.35 (30.0%) stddev-sans-first:29.42 02:41:05 INFO - PROCESS | 17275 | Values: 95.0 95.0 162.0 93.0 95.0 95.0 150.0 94.0 93.0 145.0 02:41:05 INFO - PROCESS | 17275 | 02:41:05 INFO - PROCESS | 17275 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 02:41:05 INFO - PROCESS | 17275 | Values: 117.0 117.0 118.0 117.0 117.0 118.0 119.0 117.0 117.0 117.0 02:41:05 INFO - PROCESS | 17275 | 02:41:05 INFO - PROCESS | 17275 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 02:41:05 INFO - PROCESS | 17275 | Values: 146.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 149.0 148.0 02:41:05 INFO - PROCESS | 17275 | 02:41:05 INFO - PROCESS | 17275 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 02:41:05 INFO - PROCESS | 17275 | Values: 96.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 02:41:05 INFO - PROCESS | 17275 | 02:41:05 INFO - PROCESS | 17275 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:65.50 stddev:6.69 (10.2%) stddev-sans-first:7.05 02:41:05 INFO - PROCESS | 17275 | Values: 65.0 66.0 65.0 64.0 65.0 66.0 66.0 86.0 64.0 64.0 02:41:05 INFO - PROCESS | 17275 | 02:41:05 INFO - PROCESS | 17275 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 02:41:05 INFO - PROCESS | 17275 | Values: 65.0 65.0 66.0 64.0 65.0 65.0 64.0 64.0 65.0 64.0 02:41:05 INFO - PROCESS | 17275 | 02:41:05 INFO - PROCESS | 17275 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:2.95 (3.5%) stddev-sans-first:3.09 02:41:05 INFO - PROCESS | 17275 | Values: 84.0 85.0 82.0 85.0 85.0 92.0 89.0 83.0 85.0 84.0 02:41:05 INFO - PROCESS | 17275 | 02:41:05 INFO - PROCESS | 17275 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:141.50 stddev:12.49 (8.8%) stddev-sans-first:12.81 02:41:05 INFO - PROCESS | 17275 | Values: 153.0 138.0 137.0 137.0 137.0 145.0 133.0 137.0 175.0 147.0 02:41:05 INFO - PROCESS | 17275 | 02:41:05 INFO - PROCESS | 17275 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:174.00 stddev:4.32 (2.5%) stddev-sans-first:4.06 02:41:05 INFO - PROCESS | 17275 | Values: 180.0 169.0 171.0 171.0 181.0 170.0 179.0 174.0 174.0 174.0 02:41:05 INFO - PROCESS | 17275 | 02:41:05 INFO - PROCESS | 17275 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:72.50 stddev:4.14 (5.7%) stddev-sans-first:1.56 02:41:05 INFO - PROCESS | 17275 | Values: 84.0 73.0 74.0 74.0 71.0 72.0 71.0 71.0 70.0 70.0 02:41:05 INFO - PROCESS | 17275 | -------- Summary: end -------- 02:41:05 INFO - PROCESS | 17275 | 02:41:06 INFO - TEST-INFO | 17275: exit 0 02:41:06 INFO - TEST-OK | kraken | took 65231ms 02:41:06 INFO - SUITE-END | took 1184s 02:41:06 INFO - Completed test suite (00:19:44) 02:41:06 INFO - javascript benchmark 02:41:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2632.670916135483, 2704.2022603332016, 2712.9864350678245, 2721.8639068046605, 2748.0381866346775, 4596.862094137173, 4677.859664210071, 4686.250199968006, 4700.083483720671, 4719.480857105716, 4668.789904454299, 4696.506866778982, 4718.292256161578, 4784.545468180526, 4788.90422191556, 4187.602177793105, 4233.9788301058525, 4236.83052677894, 4268.637165840907, 4410.051838854645, 4358.956410435902, 4378.737275763465, 4385.8464953726625, 4424.048829501657, 4434.9334759978465, 4214.494260688737, 4301.655867530621, 4332.090261045184, 4341.696081274328, 4406.493253275882, 4316.158349121923, 4363.5418281080665, 4369.541198174209, 4369.825206991716, 4422.093470838503, 4266.57334266574, 4271.380649805792, 4286.228478873802, 4287.099709061101, 4324.459442569679, 4468.865934021952, 4574.336721175411, 4631.58315751584, 4631.791569379386, 4633.698809577367, 4946.826861059845, 4976.850694479172, 4994.500549944976, 4995.400551933755, 4998.3502144721315, 4992.2511623256805, 4996.525330093636, 5012.398512178562, 5023.598112151019, 5071.137906555894, 4557.840475583339, 4675.064987002613, 4720.645951553647, 4749.715017098985, 4750.643701722384, 5130.589552835764, 5135.075686376488, 5140.408852981955, 5146.562542183956, 5151.690898546024, 4887.413510378707, 4942.110420124341, 4943.777530011158, 4946.1344264753525, 4988.800447982113, 4985.576226020757, 4986.875328116754, 5072.442031376546, 5086.0, 5086.4659210783075, 4983.775730092155, 4998.275250088716, 4999.500049994971, 5004.074246264453, 5057.468965758616, 4750.501197374226, 4993.350864387679, 4994.550490455877, 5000.74996250186, 5034.521720436553, 4146.626803587692, 4222.59885310895, 4277.358396240526, 4297.226499230106, 4301.16127355169, 3686.299603075407, 3688.114852435396, 3694.649008344203, 3720.4977328060363, 3729.5524537055726, 4348.2825333819565, 4348.326009468537, 4362.76004819738, 4369.75966321849, 4405.7797110145, 4898.583620392306, 5030.522100400456, 5054.595632349403, 5144.948550514522, 5154.278401023859, 4336.176126535948, 4352.869413917588, 4355.695101342939, 4355.978220108879, 4400.44994375703, 4514.864554063383, 4516.887077823015, 4523.457185137804, 4525.456945166601, 4557.680962332605, 4633.559811817872, 4686.226772582486, 4712.552307530779, 4737.763111844325, 4759.547842954914, 5057.115004874206, 5062.088824011713, 5070.4929507049, 5086.720230387365, 5124.103281925573, 4606.286025666027, 4744.193487107269, 4776.331313616027, 4781.306710527024, 4785.617150628011, 4915.680480768881, 4931.3835770528685, 4945.579625731853, 4973.602111830973, 4991.475895031114, 4948.0, 4973.651844370859, 4974.900501989868, 4991.575716064175, 5020.824271150638, 4753.47711751714, 4850.927236091391, 4852.44196917359, 4871.5128487151005, 4886.560209581155, 4891.0, 4909.582685471775, 4918.114739346809, 4918.360613120271, 4967.7019378837385, 4835.709857408426, 4840.249761287007, 4844.0554091951735, 4847.830325938575, 4880.487548807324, 4807.591354734886, 4901.975490122527, 4941.061198372297, 4967.4535801062575, 4995.300657907823, 4731.976340118277, 4798.95201047985, 4816.638752093677, 4819.0, 4819.638527110411], "value": 4612.568040096932, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.4362581044767, 584.777784441912, 596.3112604941294, 604.9153118563402, 605.9848503787405, 33279.168020799494, 33676.83161584195, 34376.0, 34399.82800085999, 34475.0, 36468.452973205356, 37242.255154896884, 37261.0, 37327.06682332936, 37331.0, 7192.748253811118, 7569.05386826648, 7777.300042996129, 7786.610669466504, 9456.338056336059, 9581.808363832719, 9760.707178784647, 9781.070798274153, 9790.118889299962, 9792.55933482995, 9740.4642744649, 9822.214222862154, 9827.70516884491, 9851.605935762562, 9853.556589953434, 9659.903400966006, 9744.90255097447, 9777.120059194636, 9779.608815647365, 9780.804383912282, 9654.22766178704, 9970.302078854484, 10023.799524009552, 10048.0, 10048.145907597864, 36605.0, 37087.25825483475, 37102.0, 37130.8143459281, 37135.81432092849, 3135.9216019599467, 3154.5899033125775, 3194.648588655246, 3310.7351411886993, 3314.701676849071, 29370.412591748045, 30210.24678540052, 30607.540886886716, 30613.234669133228, 30953.690463095532, 3385.1029477188563, 3434.5708280622644, 3487.337405892872, 3602.8058305556833, 3649.087728067983, 171276.0, 172131.13934430372, 172370.1381493097, 172560.0, 172846.0, 50498.74750626223, 50604.0, 50747.746261268454, 50837.745811271445, 51061.0, 56274.0, 56329.43670563324, 56397.0, 56401.71799140978, 56457.15314270289, 14347.354369053417, 14823.70352592942, 14834.10995340283, 14834.406623735145, 14853.183074930766, 9652.0, 11108.722281943015, 11405.828912566318, 11449.542018319175, 11460.19778615489, 18552.721709174373, 18596.349127780464, 18691.38320635112, 18736.0, 18740.437786866416, 7039.26087760788, 7517.323440890346, 7523.360514356341, 7529.736459223901, 7583.4691571590565, 775.7323723315448, 799.9920000800034, 819.2053707903324, 825.9876101858476, 895.5880295064343, 27038.324041898715, 28205.294867628472, 28338.14985550437, 28652.570211446844, 28721.56917646237, 950.1591091883732, 1058.3226734889677, 1066.919981001428, 1067.9359238445718, 1118.3345909184022, 14509.274536273355, 15070.472533461276, 15127.54617361481, 15243.314050867737, 15306.0, 331878.0, 336163.0, 337038.0, 337131.0, 337978.0, 47089.0, 48027.0, 48080.759596201795, 48137.75931120392, 48152.27771583429, 1088.450332582041, 1235.857876344232, 1244.2223610243416, 1263.557754785836, 1276.4511260158035, 24279.635805463284, 25171.244862654148, 25951.480970380107, 25973.0, 26241.606375903993, 37431.251374971805, 37789.05527361728, 37864.62135378611, 37914.43128353132, 38011.619883800806, 226522.0, 228131.0, 228347.0, 228474.0, 228914.0, 31438.52842207323, 37649.81175094107, 37719.0, 38346.80826595849, 38433.807830960664, 35853.82073089618, 36944.63055369412, 42581.78709106435, 43192.13615727731, 43631.0, 31629.36741265208, 31828.840855795574, 31834.681653183172, 32181.195470113435, 32861.83569082139, 31461.52807707932, 31998.56615834948, 33751.83124084364, 34230.14424639404, 34461.65538344585, 33977.83011085028, 34482.0, 34610.48084278688, 34938.47592286067, 34942.65057349394, 30287.697123028487, 31172.0, 31334.216644584067, 31553.842230788698, 31671.366572668878, 24396.26811195667, 24701.25896223116, 24726.653522137272, 24921.252362429157, 27294.0], "value": 17477.256399712176, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.7647972976349, 388.828915277278, 393.22338381696153, 393.77339587185924, 399.11994053112886, 12711.42798574064, 12941.352932353368, 16081.517554473356, 16852.988820670755, 16853.915730421348, 15907.0, 15983.680326393465, 16029.91985040076, 16183.514494565152, 16187.35250589978, 4627.0977159454005, 4745.92881106782, 4752.144613969484, 4764.309175169598, 4768.308595253686, 3440.2087519870447, 4659.697119687209, 4701.294805779126, 4742.90514189716, 5187.299714538545, 5458.317710286215, 5460.6177567570285, 5461.453854614547, 5467.152591348347, 5473.28847249857, 5374.91937620934, 5418.485243901823, 5436.429174936634, 5444.5916556258435, 5450.890982180374, 5118.181091025455, 5233.398159211702, 5246.842594722164, 5257.185136303879, 5258.605604579672, 12622.116451848375, 15565.37738490459, 20799.584008319747, 20815.583688326147, 20892.164313427445, 1728.8444040036456, 1837.338558119076, 1977.439216215005, 2020.464576887126, 2205.2391924785925, 9444.811103777954, 9563.760905977406, 9882.407055576688, 9915.851262231072, 12973.221606703628, 1580.2256894121913, 1606.943112815598, 1682.2093616000461, 1740.8694347923956, 1788.534980904961, 65913.0, 66345.33654663488, 66640.3335966639, 66835.33164668389, 69279.65360173167, 10113.190944724405, 10279.074883260542, 10281.845772313422, 10626.89373106259, 10688.732781680364, 14519.709605808035, 14582.125072495684, 14650.560483185522, 14652.120872747457, 14666.0, 7205.963970180221, 7239.20368759436, 7357.963210183915, 7468.626568671545, 7553.471257012066, 6824.976253561907, 6843.589384636938, 6952.478564107611, 7018.508704390746, 7027.508074434741, 4443.688941774045, 4516.909661806745, 4533.659975501851, 4593.311003349524, 4623.029163875623, 1852.2035524724497, 1855.812280140711, 1857.7956424793263, 1922.865399422027, 1926.25839051966, 406.8901396622895, 408.98568550100606, 419.3939757051032, 800.6197056398281, 846.5217152308926, 10394.896051039545, 10561.63034293796, 10821.783564328669, 10885.618074082911, 11006.504707288192, 436.4304582519779, 441.5077188934379, 442.63261492960766, 444.7709429643736, 445.9464864216315, 5782.6819524925695, 5803.071508558611, 5822.912656310159, 5908.261467316585, 6012.188354572164, 383688.0, 386928.0, 404183.0, 407636.0, 409247.0, 55538.72230638821, 74705.62647186838, 78407.60796195983, 81305.0, 83736.58131709302, 445.23864192231645, 451.05954085731616, 455.35794529712945, 456.21303251890885, 457.5378867344007, 10227.232957528364, 10399.896001040195, 10526.52630631608, 10606.098481629147, 10669.679909602724, 32773.0, 33205.83397083096, 33928.321433571684, 34360.48459273163, 35223.29553408866, 45276.0, 47012.29481557711, 49501.504984949686, 50896.23655645242, 51006.74496627493, 7536.623168841426, 7554.169041405551, 7585.127710313384, 7755.573443460664, 7773.961130194313, 9279.67521136757, 10666.0, 10941.671749847517, 11099.223054386439, 11312.547498100314, 9222.95388523053, 9327.160555550034, 9779.85330220033, 9782.75543111428, 10053.246006549683, 9206.631734730536, 9380.108889655472, 9428.858567121635, 9447.433154010781, 9781.0, 8880.467171969702, 9270.0, 9672.177864881563, 9708.514574271117, 9722.75693107678, 7263.745768898063, 7445.516041457288, 7475.887861682188, 7502.549847009197, 7528.548287102792, 7266.491345605757, 8268.83462330762, 9333.953330233577, 9460.0, 9488.85766713486], "value": 7345.528021513666, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.3060677840747, 1401.0332870319478, 1465.780132980053, 1576.377330954273, 1772.335374234662, 6722.29415911329, 7668.69325226991, 7870.370370370371, 7891.28978391946, 7897.052353717555, 7531.209223031571, 7762.767116986485, 7767.495112817663, 7789.376849852012, 7791.415643826722, 1901.1729897494565, 2184.486645638274, 2201.8899055047264, 2241.618924782791, 2272.874991875446, 2276.726792784868, 2301.4361481436986, 2305.654151877215, 2305.8385912986096, 2307.6999990001277, 2171.326888664511, 2177.3467959612053, 2180.1606381543143, 2182.1925887421676, 2184.1045171479695, 1872.0546124207324, 2152.7847215278425, 2214.7563767985507, 2217.545403192342, 2220.6891035254916, 2112.0, 2125.659894416886, 2136.647453170225, 2137.348108826807, 2146.6672665736837, 7796.454248202628, 7893.1712170222445, 7905.221325201784, 7923.247291507298, 7931.524108553505, 4496.213162696515, 4634.443866735979, 4641.327007583882, 4651.372064771246, 4666.510016448258, 3029.4092651932883, 3040.1639549123947, 3090.644575873781, 3094.4584697677815, 3104.9068527944196, 1025.3031233308811, 1027.5222021759917, 1029.1303848248292, 1769.1684908093175, 1810.5654642885745, 10416.791664166674, 10478.266521343508, 10528.789424211473, 10534.736631584195, 10578.682639520826, 3962.5641179470235, 4070.287699652549, 4176.540580536139, 4180.163967206571, 4206.85276015338, 8389.412741108186, 8426.747197584082, 8428.620712067848, 8432.578371081421, 8436.156384361515, 4004.4593979812935, 4508.616767574727, 4514.45826500822, 4515.390422293014, 4531.410916580823, 4139.81370838313, 4282.700210985264, 4294.377315289265, 4330.242207613718, 4339.7830108494445, 3680.4111342185656, 3746.38184699527, 3822.7706337619834, 3832.904177395532, 3881.165549406891, 1221.1085907287552, 1237.962861114168, 1251.7746805574902, 1260.521002019227, 1264.9873501265054, 749.2881762325703, 823.4153750836853, 828.3456069704986, 863.1368631368631, 867.124204553393, 5438.809641662602, 5447.482489163603, 5488.588355873326, 5496.258005169251, 5628.831135065954, 830.8504469195602, 871.1854416120821, 877.5787621941504, 902.2060586683676, 907.0747837206013, 3835.0, 3885.533735951704, 3924.17592305619, 3933.174033453007, 3940.9802950985063, 9549.236061115094, 9919.603215871428, 9930.950345248228, 9986.900130998742, 10015.14871235953, 9172.44965302084, 9721.513924303756, 9767.413955162712, 9774.804503909882, 9860.605575777032, 7085.220625731268, 7124.145102587619, 7147.463940204506, 7183.820404489929, 7225.458090643223, 5580.469855363734, 5586.329640443173, 5673.461021202979, 5712.285964254468, 5737.225474560881, 9084.091590840862, 9160.770980725536, 9202.49386283734, 9302.627894884128, 9326.906730932604, 8862.246709029805, 9155.954220228856, 9390.718278451657, 9507.762305942406, 9523.714288571355, 6153.661548614869, 6524.575902566318, 6721.361470660279, 6812.591244525344, 6950.409215216763, 7501.587412692136, 7517.624118794148, 7551.622418878924, 7575.621218938921, 7589.924100758922, 6649.0, 6768.221654509597, 6813.931860681329, 6869.0, 7016.26329235423, 6671.432928201158, 6688.063671086149, 6710.63091529951, 6713.1944166700305, 6876.140482439695, 6252.781152659635, 6406.0390941359165, 6454.064160696579, 6466.773662921775, 6467.0, 4648.935055604578, 4682.976585117052, 4741.35991641124, 4772.880677983078, 4779.235322348408, 4669.953300466952, 4867.659263851497, 4902.558769710743, 4942.777575009061, 4943.8516844494725], "value": 4235.564582851963, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.9569408129903, 321.373322022057, 322.3327711636912, 329.0408459341021, 329.453107840984, 5075.974620126899, 5132.43543210247, 5139.588832893369, 5148.5623721983675, 5149.789799397138, 5047.728522165022, 5051.6463847530595, 5056.216286475593, 5071.6703414278045, 5099.317225315646, 3791.165943492434, 3864.613538646141, 4004.1391100913297, 4020.768473497208, 4043.676505879537, 4001.9594905324534, 4020.8190631421658, 4024.678025757947, 4026.879193624196, 4027.8187481563255, 3789.5642001169945, 3963.4649322341547, 4000.6999475039343, 4006.6994975376965, 4021.6983726220506, 3886.9805650971707, 3972.1857019310974, 3983.223271462066, 4001.9399709004388, 4011.7592944423136, 3524.84138213781, 3531.0, 3532.4701294805727, 3534.7879127252445, 3553.626869178751, 4842.539958703917, 4843.806247750086, 4844.128056949783, 4868.513148685103, 4921.384826896638, 4265.7227280227, 4559.977200114012, 4569.743320586832, 4569.931451028204, 4641.280601506772, 5322.65402748824, 5374.5700343972385, 5393.946060539383, 5397.0, 5398.055340315429, 3800.277947190025, 3802.4866643003393, 3807.8857634271017, 3808.390657494815, 3819.9809000955097, 5534.723263836792, 5613.410591887834, 5646.830595082113, 5673.205751194836, 5683.175939488792, 3853.2678791029616, 3869.813555341223, 3875.6511913927884, 3884.378499440076, 3893.8637147699696, 3880.5149356330458, 3891.7081218908697, 3897.2400381925254, 3926.312895243321, 3931.292367373843, 4391.538888416734, 4490.887727806831, 4513.909721805546, 4521.480029796616, 4524.547545245449, 5350.652207606493, 5390.434004429479, 5393.191021346751, 5408.702521361284, 5421.972890135524, 1359.3814814259488, 1381.378379729126, 1381.4543255414055, 1389.3122904162503, 1389.9722005559831, 868.561376504861, 911.876896618948, 920.4983284110176, 934.1265916368218, 945.4516380499294, 4708.246680531099, 4732.597729193058, 4733.360996265529, 4735.313379559944, 4761.809527618926, 5492.286002819687, 5506.91739623906, 5516.503514683698, 5524.944750552523, 5535.723213839373, 4599.4710608280475, 4671.878749100191, 4710.458297295855, 4737.147313483606, 4737.905241895142, 2919.9270018249713, 2928.5753565733276, 2928.726004188185, 2936.721011503904, 2951.4834903891733, 5183.3261675981885, 5186.455422180692, 5189.532942035235, 5205.6356055075785, 5206.453322401093, 5440.183972404092, 5609.8597535061135, 5628.887422251532, 5630.831075067755, 5631.352394474688, 5155.407128180233, 5160.535551800281, 5160.638755287094, 5170.889143131295, 5188.688678679291, 5460.563154947674, 5478.808241711521, 5479.369872464717, 5487.368952570506, 5492.0, 5221.363211578128, 5442.537384322377, 5447.536959358499, 5499.642523235977, 5529.834104976857, 5248.212768084818, 5261.210818377274, 5268.868278293074, 5276.314079169683, 5302.363716353908, 3895.9415608765325, 3929.6659783918685, 3931.1548017176447, 3938.409238614116, 3940.5419994601034, 5289.0, 5578.30271216098, 5583.916241256303, 5601.719914004202, 5605.691686957257, 5369.140937449989, 5404.702741349263, 5409.810656626999, 5412.810551630674, 5449.509544141047, 5217.582593392595, 5409.810656627156, 5413.891722165614, 5415.729213539228, 5424.996375670514, 5118.800749531542, 5296.841094767163, 5335.199720042025, 5344.331958505187, 5349.973250133725, 5232.319798426181, 5449.482299181572, 5453.7094420342755, 5458.796726520636, 5468.0430924587245, 5314.1497360422145, 5336.146216605324, 5341.278927344914, 5344.4922732340365, 5346.465353464778], "value": 4046.044849534037, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.1552528289074, 709.492712710412, 724.8912663100535, 739.9408047356212, 746.2686567164176, 11126.666200014002, 11386.658400247985, 11410.08719302456, 11426.542938282479, 11461.083113350933, 11448.656540303784, 11498.022668073203, 11519.136064795153, 11520.769584608302, 11523.884761152385, 634.1882390540104, 778.81697801017, 811.2212276214841, 813.9633716482742, 814.3322475570035, 803.2048272210499, 804.6580203413555, 809.5062012172571, 810.8864758933754, 811.5901469757764, 671.2582596231167, 853.4282031039219, 856.092541905582, 856.2037305306063, 856.3448961544424, 822.8107535266893, 843.696269343039, 844.7719115838751, 845.3490812074668, 846.2468403121227, 613.7974468425409, 615.1111643674892, 623.3112410786061, 623.6071275096706, 624.2166081567649, 11151.944240278746, 11267.661970140909, 11280.774384512264, 11285.887141128565, 11293.774124517464, 12037.097217708619, 12463.75072498554, 12666.0, 12914.861833460782, 12958.0, 9619.759506012335, 9958.253131015203, 9981.950090249575, 10015.649452269208, 10148.289619726622, 3962.643362097425, 4034.636882680573, 4039.3738970459626, 4048.655864251542, 4162.979185104085, 42969.785151074044, 43222.91942701426, 43473.78263108696, 43489.0, 43738.0, 9531.571079301448, 9782.510874456391, 10015.649452269136, 10238.129758970423, 10374.740631484274, 17103.74344384835, 17246.0, 17315.91342043282, 17522.737158942626, 17546.824531754773, 6690.297518760557, 6766.018927255619, 6844.4182244508775, 6944.097267355211, 7157.4274058075225, 3835.8657446989223, 3863.2080423513676, 3868.845246190177, 3947.4473573699706, 3970.5235371755575, 2945.9558106627987, 3026.379592183597, 3027.4399236141385, 3032.9545056824163, 3034.332446861687, 546.9179623056493, 555.7582451633552, 568.2499101186477, 569.3765326966965, 595.6188039654625, 486.5888324365905, 512.7641285008938, 561.4974597735086, 563.7688547695425, 587.3949831673383, 7681.423893208032, 7682.500637458659, 7738.961305193438, 7891.092524359772, 8001.719939802079, 594.5154698920453, 595.3332267860025, 605.2071785960406, 610.5725991805754, 613.1783410230313, 3796.6962642988497, 3968.761874287552, 4089.7750623715983, 4111.48606424197, 4115.9588404116175, 41122.588774112475, 44959.55040449619, 53321.7333913328, 54061.72969135129, 54570.18144727832, 38606.42090368647, 38740.41889371662, 39331.606683933365, 39409.40885886714, 40849.0, 34947.65052349444, 37504.0, 38448.423273650915, 38941.0, 39724.404133938595, 7303.8539229216185, 7544.924550754642, 7654.349380302737, 7705.537667739954, 7710.460267781202, 26418.60372094382, 26977.0, 27224.591631125153, 27239.319017024733, 27283.454330912875, 34364.14089647679, 34725.0, 35035.29929401448, 35189.0, 35926.820365898006, 10231.232657550863, 10303.124234440156, 10585.682429527127, 10679.733006674585, 10842.132629389787, 11179.385133817394, 11306.604268850551, 11403.429828508375, 11562.30626162433, 11873.762524749629, 10546.630867919586, 10732.892671073501, 10822.891771082188, 11209.215354925404, 11287.379194144401, 11031.282966607145, 11419.429028548706, 11433.771324573629, 11481.081513479068, 11548.249363791327, 9895.752606184902, 10334.689959301233, 10356.689299321033, 10768.0, 10797.62208322705, 9079.500627465553, 9188.310876684409, 9240.0, 9461.243100552078, 10091.646792362231, 9227.30795190377, 9566.0, 9615.182709469495, 9683.031696830261, 9715.17421019193], "value": 5836.126267338877, "unit": "score"}], "name": "dromaeo_css", "value": 6243.457085590754, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 108.0, 111.0, 111.0, 112.0, 101.0, 111.0, 111.0, 113.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 133.0, 159.0, 189.0, 133.0, 158.0, 160.0, 134.0, 201.0, 132.0], "value": 156.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 170.0, 162.0, 162.0, 162.0, 162.0, 162.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 124.0, 117.0, 75.0, 78.0, 74.0, 117.0, 107.0, 73.0], "value": 91.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 162.0, 93.0, 95.0, 95.0, 150.0, 94.0, 93.0, 145.0], "value": 111.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 119.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 149.0, 148.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 64.0, 65.0, 66.0, 66.0, 86.0, 64.0, 64.0], "value": 67.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 64.0, 65.0, 65.0, 64.0, 64.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 82.0, 85.0, 85.0, 92.0, 89.0, 83.0, 85.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 138.0, 137.0, 137.0, 137.0, 145.0, 133.0, 137.0, 175.0, 147.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 169.0, 171.0, 171.0, 181.0, 170.0, 179.0, 174.0, 174.0, 174.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 73.0, 74.0, 74.0, 71.0, 72.0, 71.0, 71.0, 70.0, 70.0], "value": 73.0, "unit": "score"}], "name": "kraken", "value": 1600.6000000000001, "alertThreshold": 2.0}]} 02:41:06 INFO - Return code: 0 02:41:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:41:06 ERROR - # TBPL SUCCESS # 02:41:06 INFO - Running post-action listener: _resource_record_post_action 02:41:06 INFO - Running post-run listener: _resource_record_post_run 02:41:08 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 525144064; Read time: 332; Write time: 865668 02:41:08 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234139648; Read time: 0; Write time: 452172 02:41:08 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 291004416; Read time: 332; Write time: 413496 02:41:08 INFO - Running post-run listener: _upload_blobber_files 02:41:08 INFO - Blob upload gear active. 02:41:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:41:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:41:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:41:08 INFO - (blobuploader) - INFO - Open directory for files ... 02:41:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:41:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:41:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:09 INFO - (blobuploader) - INFO - Done attempting. 02:41:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:41:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:41:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:41:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:41:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:41:09 INFO - (blobuploader) - INFO - Done attempting. 02:41:09 INFO - (blobuploader) - INFO - Iteration through files over. 02:41:09 INFO - Return code: 0 02:41:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:41:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:41:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7521078368b419b1c7e6d3302dc505ab277ae2debfc99b34e13c315db233cf26f3b3bf33faffdabac0f0f9e07575f998a34aeeb9373907cb89f9531a0ca6c2a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cef484a32ee6dc8f0c21f47298ca58bbee6b8520e8fda7b9fa2e89585476d60653c058ad67fac0d1ce29337f5f309859fe47684e51501eff7cd719503e446518"} 02:41:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:41:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:41:09 INFO - Contents: 02:41:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7521078368b419b1c7e6d3302dc505ab277ae2debfc99b34e13c315db233cf26f3b3bf33faffdabac0f0f9e07575f998a34aeeb9373907cb89f9531a0ca6c2a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cef484a32ee6dc8f0c21f47298ca58bbee6b8520e8fda7b9fa2e89585476d60653c058ad67fac0d1ce29337f5f309859fe47684e51501eff7cd719503e446518"} 02:41:09 INFO - Running post-run listener: copy_logs_to_upload_dir 02:41:09 INFO - Copying logs to upload dir... 02:41:09 INFO - mkdir: /builds/slave/test/build/upload/logs 02:41:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.626132 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-04-15 02:41:09.606280) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 02:41:09.609706) ========= 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-1460710976.837850-1060755040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7521078368b419b1c7e6d3302dc505ab277ae2debfc99b34e13c315db233cf26f3b3bf33faffdabac0f0f9e07575f998a34aeeb9373907cb89f9531a0ca6c2a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cef484a32ee6dc8f0c21f47298ca58bbee6b8520e8fda7b9fa2e89585476d60653c058ad67fac0d1ce29337f5f309859fe47684e51501eff7cd719503e446518"} build_url:https://queue.taskcluster.net/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/Or0LqzG2THmos0n6UDrykg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7521078368b419b1c7e6d3302dc505ab277ae2debfc99b34e13c315db233cf26f3b3bf33faffdabac0f0f9e07575f998a34aeeb9373907cb89f9531a0ca6c2a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cef484a32ee6dc8f0c21f47298ca58bbee6b8520e8fda7b9fa2e89585476d60653c058ad67fac0d1ce29337f5f309859fe47684e51501eff7cd719503e446518"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 02:41:09.636981) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:41:09.637469) ========= 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-1460710976.837850-1060755040 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:41:09.719193) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 02:41:09.719511) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 02:41:09.719920) ========= ========= Total master_lag: 0.19 =========