builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-067 starttime: 1453197758.43 results: success (0) buildid: 20160119004438 builduid: cfd32c596c734c50a46fdf32e6216582 revision: d83a10007bccd01700592fd1d92760c2e1dfca81 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:38.428447) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:38.429124) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:38.429730) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006370 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:38.464699) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:38.465062) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:38.482983) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:38.483280) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:38.533416) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:38.533769) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:38.534198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:38.534542) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 02:02:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.3M=0s 2016-01-19 02:02:39 (35.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143138 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:38.692841) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:38.693208) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014766 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:38.743246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:38.743641) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev d83a10007bccd01700592fd1d92760c2e1dfca81 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev d83a10007bccd01700592fd1d92760c2e1dfca81 --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=e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 02:02:40,096 truncating revision to first 12 chars 2016-01-19 02:02:40,096 Setting DEBUG logging. 2016-01-19 02:02:40,096 attempt 1/10 2016-01-19 02:02:40,096 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/d83a10007bcc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 02:02:40,335 unpacking tar archive at: b2g-inbound-d83a10007bcc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.518929 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:39.276065) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:39.276495) ========= echo '%(revision)s' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004678 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:39.327473) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:39.327831) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:39.337926) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:39.338231) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 02:02:39.339177) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-19 02:02:39.339619) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-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', 'B2G-Inbound-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-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=e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:02:40 INFO - MultiFileLogger online at 20160119 02:02:40 in /builds/slave/test 02:02:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 02:02:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:02:40 INFO - {'append_to_log': False, 02:02:40 INFO - 'base_work_dir': '/builds/slave/test', 02:02:40 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 02:02:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:02:40 INFO - 'branch': 'B2G-Inbound-Non-PGO', 02:02:40 INFO - 'buildbot_json_path': 'buildprops.json', 02:02:40 INFO - 'config_files': ('talos/linux_config.py',), 02:02:40 INFO - 'default_actions': ('clobber', 02:02:40 INFO - 'read-buildbot-config', 02:02:40 INFO - 'download-and-extract', 02:02:40 INFO - 'populate-webroot', 02:02:40 INFO - 'create-virtualenv', 02:02:40 INFO - 'install', 02:02:40 INFO - 'run-tests'), 02:02:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:02:40 INFO - 'download_minidump_stackwalk': True, 02:02:40 INFO - 'download_symbols': 'ondemand', 02:02:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:02:40 INFO - 'tooltool.py': '/tools/tooltool.py', 02:02:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:02:40 INFO - '/tools/misc-python/virtualenv.py')}, 02:02:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:02:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:02:40 INFO - 'installer_path': 'installer.exe', 02:02:40 INFO - 'log_level': 'info', 02:02:40 INFO - 'log_name': 'talos', 02:02:40 INFO - 'log_to_console': True, 02:02:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:02:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:02:40 INFO - 'opt_config_files': (), 02:02:40 INFO - 'pip_index': False, 02:02:40 INFO - 'sps_profile': False, 02:02:40 INFO - 'sps_profile_interval': 0, 02:02:40 INFO - 'suite': 'dromaeojs', 02:02:40 INFO - 'system_bits': '32', 02:02:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:02:40 INFO - 'title': 'talos-linux64-ix-067', 02:02:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:02:40 INFO - 'use_talos_json': True, 02:02:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:02:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:02:40 INFO - 'work_dir': 'build'} 02:02:40 INFO - ##### 02:02:40 INFO - ##### Running clobber step. 02:02:40 INFO - ##### 02:02:40 INFO - Running pre-action listener: _resource_record_pre_action 02:02:40 INFO - Running main action method: clobber 02:02:40 INFO - rmtree: /builds/slave/test/build 02:02:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:02:41 INFO - Running post-action listener: _resource_record_post_action 02:02:41 INFO - ##### 02:02:41 INFO - ##### Running read-buildbot-config step. 02:02:41 INFO - ##### 02:02:41 INFO - Running pre-action listener: _resource_record_pre_action 02:02:41 INFO - Running main action method: read_buildbot_config 02:02:41 INFO - Using buildbot properties: 02:02:41 INFO - { 02:02:41 INFO - "project": "", 02:02:41 INFO - "product": "firefox", 02:02:41 INFO - "script_repo_revision": "production", 02:02:41 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 02:02:41 INFO - "repository": "", 02:02:41 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 02:02:41 INFO - "buildid": "20160119004438", 02:02:41 INFO - "pgo_build": "False", 02:02:41 INFO - "basedir": "/builds/slave/test", 02:02:41 INFO - "buildnumber": 837, 02:02:41 INFO - "slavename": "talos-linux64-ix-067", 02:02:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:02:41 INFO - "platform": "ubuntu64_hw", 02:02:41 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 02:02:41 INFO - "branch": "b2g-inbound", 02:02:41 INFO - "repo_path": "integration/b2g-inbound", 02:02:41 INFO - "revision": "d83a10007bccd01700592fd1d92760c2e1dfca81", 02:02:41 INFO - "stage_platform": "linux64", 02:02:41 INFO - "builduid": "cfd32c596c734c50a46fdf32e6216582", 02:02:41 INFO - "slavebuilddir": "test" 02:02:41 INFO - } 02:02:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 02:02:41 INFO - Running post-action listener: _resource_record_post_action 02:02:41 INFO - ##### 02:02:41 INFO - ##### Running download-and-extract step. 02:02:41 INFO - ##### 02:02:41 INFO - Running pre-action listener: _resource_record_pre_action 02:02:41 INFO - Running main action method: download_and_extract 02:02:41 INFO - mkdir: /builds/slave/test/build/tests 02:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:02:41 INFO - https://queue.taskcluster.net/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:02:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/test_packages.json 02:02:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/test_packages.json 02:02:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:02:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:02:46 INFO - Downloaded 1448 bytes. 02:02:46 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:02:46 INFO - Using the following test package requirements: 02:02:46 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:02:46 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:02:46 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:02:46 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:46 INFO - u'jsshell-linux-x86_64.zip'], 02:02:46 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:02:46 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:02:46 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:02:46 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:02:46 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:02:46 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 02:02:46 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:02:46 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:02:46 INFO - https://queue.taskcluster.net/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:02:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:02:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:02:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:02:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:02:47 INFO - Downloaded 21215676 bytes. 02:02:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:02:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:02:48 INFO - Return code: 0 02:02:48 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:02:48 INFO - https://queue.taskcluster.net/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:02:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:02:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:02:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 02:02:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:02:50 INFO - Downloaded 21215676 bytes. 02:02:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:02:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:02:52 INFO - Return code: 0 02:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:02:52 INFO - https://queue.taskcluster.net/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:02:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:02:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:02:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 02:02:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:02:53 INFO - Downloaded 11132144 bytes. 02:02:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:02:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:02:53 INFO - Return code: 0 02:02:53 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:02:53 INFO - https://queue.taskcluster.net/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:02:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:02:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:02:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:02:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:02:54 INFO - Downloaded 54180824 bytes. 02:02:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:02:54 INFO - mkdir: /builds/slave/test/properties 02:02:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:02:54 INFO - Writing to file /builds/slave/test/properties/build_url 02:02:54 INFO - Contents: 02:02:54 INFO - build_url:https://queue.taskcluster.net/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:02:54 INFO - Running post-action listener: _resource_record_post_action 02:02:54 INFO - Running post-action listener: set_extra_try_arguments 02:02:54 INFO - ##### 02:02:54 INFO - ##### Running populate-webroot step. 02:02:54 INFO - ##### 02:02:54 INFO - Running pre-action listener: _resource_record_pre_action 02:02:54 INFO - Running main action method: populate_webroot 02:02:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:02:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:02:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:02:54 INFO - '--tppagecycles', 02:02:54 INFO - '7'], 02:02:54 INFO - 'tests': ['tsvgm']}}, 02:02:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:02:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:02:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:02:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:02:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:02:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:02:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:02:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:55 INFO - 'talos_options': ['--e10s'], 02:02:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:02:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:55 INFO - 'tests': ['damp', 'tps']}, 02:02:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:55 INFO - 'talos_options': ['--e10s'], 02:02:55 INFO - 'tests': ['damp', 'tps']}, 02:02:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:02:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:02:55 INFO - 'other': {'tests': ['a11yr', 02:02:55 INFO - 'ts_paint', 02:02:55 INFO - 'tpaint', 02:02:55 INFO - 'sessionrestore', 02:02:55 INFO - 'sessionrestore_no_auto_restore']}, 02:02:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:02:55 INFO - 'tests': ['a11yr', 02:02:55 INFO - 'ts_paint', 02:02:55 INFO - 'tpaint', 02:02:55 INFO - 'sessionrestore', 02:02:55 INFO - 'sessionrestore_no_auto_restore']}, 02:02:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:02:55 INFO - 'tests': ['a11yr', 02:02:55 INFO - 'ts_paint', 02:02:55 INFO - 'tpaint', 02:02:55 INFO - 'sessionrestore', 02:02:55 INFO - 'sessionrestore_no_auto_restore']}, 02:02:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:02:55 INFO - 'tests': ['a11yr', 02:02:55 INFO - 'ts_paint', 02:02:55 INFO - 'tpaint', 02:02:55 INFO - 'sessionrestore', 02:02:55 INFO - 'sessionrestore_no_auto_restore']}, 02:02:55 INFO - 'other_l64': {'tests': ['a11yr', 02:02:55 INFO - 'ts_paint', 02:02:55 INFO - 'tpaint', 02:02:55 INFO - 'sessionrestore', 02:02:55 INFO - 'sessionrestore_no_auto_restore']}, 02:02:55 INFO - 'other_nol64': {'tests': ['a11yr', 02:02:55 INFO - 'ts_paint', 02:02:55 INFO - 'tpaint', 02:02:55 INFO - 'sessionrestore', 02:02:55 INFO - 'sessionrestore_no_auto_restore']}, 02:02:55 INFO - 'svgr': {'tests': ['tsvgx', 02:02:55 INFO - 'tsvgr_opacity', 02:02:55 INFO - 'tart', 02:02:55 INFO - 'tscrollx', 02:02:55 INFO - 'cart']}, 02:02:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:02:55 INFO - 'tests': ['tsvgx', 02:02:55 INFO - 'tsvgr_opacity', 02:02:55 INFO - 'tart', 02:02:55 INFO - 'tscrollx', 02:02:55 INFO - 'cart']}, 02:02:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:55 INFO - 'tests': ['tp5o']}, 02:02:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:55 INFO - 'talos_options': ['--e10s'], 02:02:55 INFO - 'tests': ['tp5o']}, 02:02:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:55 INFO - 'talos_options': ['--xperf_path', 02:02:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:02:55 INFO - 'tests': ['tp5n']}, 02:02:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:55 INFO - 'talos_options': ['--e10s', 02:02:55 INFO - '--xperf_path', 02:02:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:02:55 INFO - 'tests': ['tp5n']}}, 02:02:55 INFO - 'talos.zip': {'path': '', 02:02:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:02:55 INFO - Running post-action listener: _resource_record_post_action 02:02:55 INFO - ##### 02:02:55 INFO - ##### Running create-virtualenv step. 02:02:55 INFO - ##### 02:02:55 INFO - Running pre-action listener: _resource_record_pre_action 02:02:55 INFO - Running main action method: create_virtualenv 02:02:55 INFO - Creating virtualenv /builds/slave/test/build/venv 02:02:55 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:02:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:02:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:02:55 INFO - Using real prefix '/usr' 02:02:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:02:55 INFO - Installing distribute.............................................................................................................................................................................................done. 02:02:57 INFO - Installing pip.................done. 02:02:57 INFO - Return code: 0 02:02:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:02:57 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:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:57 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:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fa455debf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c573d0>, '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 0x2bc2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3360>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848', '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:02:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:02:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:02:57 INFO - Using env: {'DISPLAY': ':0', 02:02:57 INFO - 'HOME': '/home/cltbld', 02:02:57 INFO - 'LANG': 'en_US.UTF-8', 02:02:57 INFO - 'LANGUAGE': 'en_US:en', 02:02:57 INFO - 'LOGNAME': 'cltbld', 02:02:57 INFO - 'MAIL': '/var/mail/cltbld', 02:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:57 INFO - 'MOZ_NO_REMOTE': '1', 02:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:57 INFO - 'NO_EM_RESTART': '1', 02:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:57 INFO - 'PWD': '/builds/slave/test', 02:02:57 INFO - 'SHELL': '/bin/bash', 02:02:57 INFO - 'SHLVL': '1', 02:02:57 INFO - 'TERM': 'linux', 02:02:57 INFO - 'TMOUT': '86400', 02:02:57 INFO - 'USER': 'cltbld', 02:02:57 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848', 02:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:57 INFO - '_': '/tools/buildbot/bin/python'} 02:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:57 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:02:57 INFO - Cleaning up... 02:02:57 INFO - Return code: 0 02:02:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:02:57 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:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:57 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:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fa455debf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c573d0>, '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 0x2bc2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3360>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848', '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:02:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:02:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:02:57 INFO - Using env: {'DISPLAY': ':0', 02:02:57 INFO - 'HOME': '/home/cltbld', 02:02:57 INFO - 'LANG': 'en_US.UTF-8', 02:02:57 INFO - 'LANGUAGE': 'en_US:en', 02:02:57 INFO - 'LOGNAME': 'cltbld', 02:02:57 INFO - 'MAIL': '/var/mail/cltbld', 02:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:57 INFO - 'MOZ_NO_REMOTE': '1', 02:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:02:57 INFO - 'NO_EM_RESTART': '1', 02:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:57 INFO - 'PWD': '/builds/slave/test', 02:02:57 INFO - 'SHELL': '/bin/bash', 02:02:57 INFO - 'SHLVL': '1', 02:02:57 INFO - 'TERM': 'linux', 02:02:57 INFO - 'TMOUT': '86400', 02:02:57 INFO - 'USER': 'cltbld', 02:02:57 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848', 02:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:57 INFO - '_': '/tools/buildbot/bin/python'} 02:02:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:58 INFO - Downloading/unpacking psutil>=0.7.1 02:02:58 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:02:58 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:02:58 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:02:58 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:02:58 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:02:58 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:02:59 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:02:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:02:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:02:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:02:59 INFO - Installing collected packages: psutil 02:02:59 INFO - Running setup.py install for psutil 02:02:59 INFO - building 'psutil._psutil_linux' extension 02:02:59 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:03:00 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:03:00 INFO - building 'psutil._psutil_posix' extension 02:03:00 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:03:00 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:03:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:03:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:03:00 INFO - Successfully installed psutil 02:03:00 INFO - Cleaning up... 02:03:00 INFO - Return code: 0 02:03:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:03:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fa455debf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c573d0>, '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 0x2bc2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3360>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848', '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:03:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:03:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:03:00 INFO - Using env: {'DISPLAY': ':0', 02:03:00 INFO - 'HOME': '/home/cltbld', 02:03:00 INFO - 'LANG': 'en_US.UTF-8', 02:03:00 INFO - 'LANGUAGE': 'en_US:en', 02:03:00 INFO - 'LOGNAME': 'cltbld', 02:03:00 INFO - 'MAIL': '/var/mail/cltbld', 02:03:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:00 INFO - 'MOZ_NO_REMOTE': '1', 02:03:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:00 INFO - 'NO_EM_RESTART': '1', 02:03:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:00 INFO - 'PWD': '/builds/slave/test', 02:03:00 INFO - 'SHELL': '/bin/bash', 02:03:00 INFO - 'SHLVL': '1', 02:03:00 INFO - 'TERM': 'linux', 02:03:00 INFO - 'TMOUT': '86400', 02:03:00 INFO - 'USER': 'cltbld', 02:03:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848', 02:03:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:00 INFO - '_': '/tools/buildbot/bin/python'} 02:03:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:03:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:03:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:03:02 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:03:02 INFO - Installing collected packages: mozsystemmonitor 02:03:02 INFO - Running setup.py install for mozsystemmonitor 02:03:02 INFO - Successfully installed mozsystemmonitor 02:03:02 INFO - Cleaning up... 02:03:02 INFO - Return code: 0 02:03:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fa455debf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c573d0>, '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 0x2bc2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3360>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848', '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:03:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:03:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:03:02 INFO - Using env: {'DISPLAY': ':0', 02:03:02 INFO - 'HOME': '/home/cltbld', 02:03:02 INFO - 'LANG': 'en_US.UTF-8', 02:03:02 INFO - 'LANGUAGE': 'en_US:en', 02:03:02 INFO - 'LOGNAME': 'cltbld', 02:03:02 INFO - 'MAIL': '/var/mail/cltbld', 02:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:02 INFO - 'MOZ_NO_REMOTE': '1', 02:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:02 INFO - 'NO_EM_RESTART': '1', 02:03:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:02 INFO - 'PWD': '/builds/slave/test', 02:03:02 INFO - 'SHELL': '/bin/bash', 02:03:02 INFO - 'SHLVL': '1', 02:03:02 INFO - 'TERM': 'linux', 02:03:02 INFO - 'TMOUT': '86400', 02:03:02 INFO - 'USER': 'cltbld', 02:03:02 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848', 02:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:02 INFO - '_': '/tools/buildbot/bin/python'} 02:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:02 INFO - Downloading/unpacking blobuploader==1.2.4 02:03:02 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:03:02 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:03:02 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:03:02 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:03:02 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:03:02 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:03:04 INFO - Downloading blobuploader-1.2.4.tar.gz 02:03:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:03:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:03:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:03: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:03: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:03: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:03: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:03: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:03: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:03:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:03:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:03:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:03: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:03: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:03: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:03: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:03: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:03: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:03:05 INFO - Downloading docopt-0.6.1.tar.gz 02:03:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:03:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:03:05 INFO - Installing collected packages: blobuploader, requests, docopt 02:03:05 INFO - Running setup.py install for blobuploader 02:03:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:03:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:03:05 INFO - Running setup.py install for requests 02:03:05 INFO - Running setup.py install for docopt 02:03:05 INFO - Successfully installed blobuploader requests docopt 02:03:05 INFO - Cleaning up... 02:03:05 INFO - Return code: 0 02:03:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:03:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fa455debf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c573d0>, '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 0x2bc2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3360>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848', '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:03:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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:03:05 INFO - Using env: {'DISPLAY': ':0', 02:03:05 INFO - 'HOME': '/home/cltbld', 02:03:05 INFO - 'LANG': 'en_US.UTF-8', 02:03:05 INFO - 'LANGUAGE': 'en_US:en', 02:03:05 INFO - 'LOGNAME': 'cltbld', 02:03:05 INFO - 'MAIL': '/var/mail/cltbld', 02:03:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:05 INFO - 'MOZ_NO_REMOTE': '1', 02:03:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:05 INFO - 'NO_EM_RESTART': '1', 02:03:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:05 INFO - 'PWD': '/builds/slave/test', 02:03:05 INFO - 'SHELL': '/bin/bash', 02:03:05 INFO - 'SHLVL': '1', 02:03:05 INFO - 'TERM': 'linux', 02:03:05 INFO - 'TMOUT': '86400', 02:03:05 INFO - 'USER': 'cltbld', 02:03:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848', 02:03:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:05 INFO - '_': '/tools/buildbot/bin/python'} 02:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:03:06 INFO - Running setup.py (path:/tmp/pip-NntpPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:03:06 INFO - Running setup.py (path:/tmp/pip-IpIr7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:03:06 INFO - Running setup.py (path:/tmp/pip-l9A_qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:03:06 INFO - Running setup.py (path:/tmp/pip-L7WdzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:03:06 INFO - Running setup.py (path:/tmp/pip-9c17k4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:03:06 INFO - Running setup.py (path:/tmp/pip-js0QcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:03:06 INFO - Running setup.py (path:/tmp/pip-196QXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:03:06 INFO - Running setup.py (path:/tmp/pip-9cCT8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:03:06 INFO - Running setup.py (path:/tmp/pip-GTkF_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:03:06 INFO - Running setup.py (path:/tmp/pip-3Zcy89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:03:06 INFO - Running setup.py (path:/tmp/pip-pKoq1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:03:06 INFO - Running setup.py (path:/tmp/pip-xd3qCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:03:06 INFO - Running setup.py (path:/tmp/pip-_oeIZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:03:06 INFO - Running setup.py (path:/tmp/pip-XAyQZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:03:07 INFO - Running setup.py (path:/tmp/pip-i2PBrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:03:07 INFO - Running setup.py (path:/tmp/pip-qlzKRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:03:07 INFO - Running setup.py (path:/tmp/pip-Z63X4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:03:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:03:07 INFO - Running setup.py install for manifestparser 02:03:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:03:07 INFO - Running setup.py install for mozcrash 02:03:07 INFO - Running setup.py install for mozdebug 02:03:07 INFO - Running setup.py install for mozdevice 02:03:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:03:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:03:07 INFO - Running setup.py install for mozfile 02:03:07 INFO - Running setup.py install for mozhttpd 02:03:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:03:07 INFO - Running setup.py install for mozinfo 02:03:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:03:07 INFO - Running setup.py install for mozInstall 02:03:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:03:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:03:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:03:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:03:08 INFO - Running setup.py install for mozleak 02:03:08 INFO - Running setup.py install for mozlog 02:03:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:03:08 INFO - Running setup.py install for moznetwork 02:03:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:03:08 INFO - Running setup.py install for mozprocess 02:03:08 INFO - Running setup.py install for mozprofile 02:03:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:03:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:03:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:03:08 INFO - Running setup.py install for mozrunner 02:03:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:03:08 INFO - Running setup.py install for mozscreenshot 02:03:08 INFO - Running setup.py install for moztest 02:03:08 INFO - Running setup.py install for mozversion 02:03:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:03:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:03:08 INFO - Cleaning up... 02:03:09 INFO - Return code: 0 02:03:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:03:09 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:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:09 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:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fa455debf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c573d0>, '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 0x2bc2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3360>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848', '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:03:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:03:09 INFO - Using env: {'DISPLAY': ':0', 02:03:09 INFO - 'HOME': '/home/cltbld', 02:03:09 INFO - 'LANG': 'en_US.UTF-8', 02:03:09 INFO - 'LANGUAGE': 'en_US:en', 02:03:09 INFO - 'LOGNAME': 'cltbld', 02:03:09 INFO - 'MAIL': '/var/mail/cltbld', 02:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:09 INFO - 'MOZ_NO_REMOTE': '1', 02:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:09 INFO - 'NO_EM_RESTART': '1', 02:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:09 INFO - 'PWD': '/builds/slave/test', 02:03:09 INFO - 'SHELL': '/bin/bash', 02:03:09 INFO - 'SHLVL': '1', 02:03:09 INFO - 'TERM': 'linux', 02:03:09 INFO - 'TMOUT': '86400', 02:03:09 INFO - 'USER': 'cltbld', 02:03:09 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848', 02:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:09 INFO - '_': '/tools/buildbot/bin/python'} 02:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:03:09 INFO - Running setup.py (path:/tmp/pip-GquU3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:03:09 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:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:03:09 INFO - Running setup.py (path:/tmp/pip-YPnBTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:03:09 INFO - Running setup.py (path:/tmp/pip-d5gmbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:03:09 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:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:03:09 INFO - Running setup.py (path:/tmp/pip-yKX4fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:03:09 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:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:03:09 INFO - Running setup.py (path:/tmp/pip-9spqSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:03:09 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:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:03:09 INFO - Running setup.py (path:/tmp/pip-Y62wo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:03:09 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:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:03:09 INFO - Running setup.py (path:/tmp/pip-UQiede-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:03:09 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:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:03:09 INFO - Running setup.py (path:/tmp/pip-j35Zlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:03:09 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:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:03:09 INFO - Running setup.py (path:/tmp/pip-vO9APT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:03:09 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:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:03:09 INFO - Running setup.py (path:/tmp/pip-b6xNZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:03:09 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:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:03:09 INFO - Running setup.py (path:/tmp/pip-6qXRTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:03:10 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:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:03:10 INFO - Running setup.py (path:/tmp/pip-E83ViX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:03:10 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:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:03:10 INFO - Running setup.py (path:/tmp/pip-5mIMPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:03:10 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:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:03:10 INFO - Running setup.py (path:/tmp/pip-tcYLF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:03:10 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:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:03:10 INFO - Running setup.py (path:/tmp/pip-qErxUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:03:10 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:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:03:10 INFO - Running setup.py (path:/tmp/pip-0S4x9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:03:10 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:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:03:10 INFO - Running setup.py (path:/tmp/pip-NUFt8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:03:10 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:03:10 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:03:10 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:03:10 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:03:10 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:03:10 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:03:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:12 INFO - Downloading blessings-1.5.1.tar.gz 02:03:12 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 02:03:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:03:12 INFO - Installing collected packages: blessings 02:03:12 INFO - Running setup.py install for blessings 02:03:12 INFO - Successfully installed blessings 02:03:12 INFO - Cleaning up... 02:03:12 INFO - Return code: 0 02:03:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:03:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:03:12 INFO - Reading from file tmpfile_stdout 02:03:12 INFO - Current package versions: 02:03:12 INFO - argparse == 1.2.1 02:03:12 INFO - blessings == 1.5.1 02:03:12 INFO - blobuploader == 1.2.4 02:03:12 INFO - docopt == 0.6.1 02:03:12 INFO - manifestparser == 1.1 02:03:12 INFO - mozInstall == 1.12 02:03:12 INFO - mozcrash == 0.16 02:03:12 INFO - mozdebug == 0.1 02:03:12 INFO - mozdevice == 0.48 02:03:12 INFO - mozfile == 1.2 02:03:12 INFO - mozhttpd == 0.7 02:03:12 INFO - mozinfo == 0.9 02:03:12 INFO - mozleak == 0.1 02:03:12 INFO - mozlog == 3.1 02:03:12 INFO - moznetwork == 0.27 02:03:12 INFO - mozprocess == 0.22 02:03:12 INFO - mozprofile == 0.28 02:03:12 INFO - mozrunner == 6.11 02:03:12 INFO - mozscreenshot == 0.1 02:03:12 INFO - mozsystemmonitor == 0.0 02:03:12 INFO - moztest == 0.7 02:03:12 INFO - mozversion == 1.4 02:03:12 INFO - psutil == 3.1.1 02:03:12 INFO - requests == 1.2.3 02:03:12 INFO - wsgiref == 0.1.2 02:03:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:03:12 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:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:12 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:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fa455debf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c573d0>, '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 0x2bc2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3360>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848', '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:03:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:03:12 INFO - Using env: {'DISPLAY': ':0', 02:03:12 INFO - 'HOME': '/home/cltbld', 02:03:12 INFO - 'LANG': 'en_US.UTF-8', 02:03:12 INFO - 'LANGUAGE': 'en_US:en', 02:03:12 INFO - 'LOGNAME': 'cltbld', 02:03:12 INFO - 'MAIL': '/var/mail/cltbld', 02:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:12 INFO - 'MOZ_NO_REMOTE': '1', 02:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:12 INFO - 'NO_EM_RESTART': '1', 02:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:12 INFO - 'PWD': '/builds/slave/test', 02:03:12 INFO - 'SHELL': '/bin/bash', 02:03:12 INFO - 'SHLVL': '1', 02:03:12 INFO - 'TERM': 'linux', 02:03:12 INFO - 'TMOUT': '86400', 02:03:12 INFO - 'USER': 'cltbld', 02:03:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848', 02:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:12 INFO - '_': '/tools/buildbot/bin/python'} 02:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:12 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:03:12 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:03:12 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:03:12 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:03:12 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:03:12 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:03:12 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:03:12 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:03:12 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:03:12 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:03:12 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:03:12 INFO - Cleaning up... 02:03:12 INFO - Return code: 0 02:03:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:03:12 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:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:12 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:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fa455debf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c573d0>, '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 0x2bc2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3360>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848', '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:03:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:03:12 INFO - Using env: {'DISPLAY': ':0', 02:03:12 INFO - 'HOME': '/home/cltbld', 02:03:12 INFO - 'LANG': 'en_US.UTF-8', 02:03:12 INFO - 'LANGUAGE': 'en_US:en', 02:03:12 INFO - 'LOGNAME': 'cltbld', 02:03:12 INFO - 'MAIL': '/var/mail/cltbld', 02:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:12 INFO - 'MOZ_NO_REMOTE': '1', 02:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:12 INFO - 'NO_EM_RESTART': '1', 02:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:12 INFO - 'PWD': '/builds/slave/test', 02:03:12 INFO - 'SHELL': '/bin/bash', 02:03:12 INFO - 'SHLVL': '1', 02:03:12 INFO - 'TERM': 'linux', 02:03:12 INFO - 'TMOUT': '86400', 02:03:12 INFO - 'USER': 'cltbld', 02:03:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848', 02:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:12 INFO - '_': '/tools/buildbot/bin/python'} 02:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:13 INFO - Downloading/unpacking jsonschema 02:03:13 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:03:13 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:03:13 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:03:13 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:03:13 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:03:13 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:03:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:03:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 02:03:14 INFO - Downloading/unpacking functools32 (from jsonschema) 02:03:14 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:03:14 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:03:14 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:03:14 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:03:14 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:03:14 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:03:14 INFO - Downloading functools32-3.2.3-2.tar.gz 02:03:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 02:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:03:15 INFO - warning: no files found matching '*.txt' 02:03:15 INFO - no previously-included directories found matching 'build' 02:03:15 INFO - no previously-included directories found matching 'dist' 02:03:15 INFO - no previously-included directories found matching '.git*' 02:03:15 INFO - Installing collected packages: jsonschema, functools32 02:03:15 INFO - Running setup.py install for functools32 02:03:15 INFO - warning: no files found matching '*.txt' 02:03:15 INFO - no previously-included directories found matching 'build' 02:03:15 INFO - no previously-included directories found matching 'dist' 02:03:15 INFO - no previously-included directories found matching '.git*' 02:03:15 INFO - Successfully installed jsonschema functools32 02:03:15 INFO - Cleaning up... 02:03:15 INFO - Return code: 0 02:03:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:03: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:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03: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:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fa455debf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c573d0>, '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 0x2bc2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3360>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848', '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:03:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:03:15 INFO - Using env: {'DISPLAY': ':0', 02:03:15 INFO - 'HOME': '/home/cltbld', 02:03:15 INFO - 'LANG': 'en_US.UTF-8', 02:03:15 INFO - 'LANGUAGE': 'en_US:en', 02:03:15 INFO - 'LOGNAME': 'cltbld', 02:03:15 INFO - 'MAIL': '/var/mail/cltbld', 02:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:15 INFO - 'MOZ_NO_REMOTE': '1', 02:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:15 INFO - 'NO_EM_RESTART': '1', 02:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:15 INFO - 'PWD': '/builds/slave/test', 02:03:15 INFO - 'SHELL': '/bin/bash', 02:03:15 INFO - 'SHLVL': '1', 02:03:15 INFO - 'TERM': 'linux', 02:03:15 INFO - 'TMOUT': '86400', 02:03:15 INFO - 'USER': 'cltbld', 02:03:15 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848', 02:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:15 INFO - '_': '/tools/buildbot/bin/python'} 02:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:15 INFO - Downloading/unpacking flake8 02:03:15 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:03:15 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:03:15 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:03:15 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:03:15 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:03:15 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:03:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:03:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 02:03:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:03:17 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:03:17 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:03:17 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:03:17 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:03:17 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:03:17 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:03:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:03:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 02:03:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:03:17 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:03:17 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:03:17 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:03:17 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:03:17 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:03:17 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:03:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 02:03:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:03:17 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:03:17 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:03:17 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:03:17 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:03:17 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:03:17 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:03:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 02:03:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:03:17 INFO - no previously-included directories found matching 'docs/_build' 02:03:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:03:17 INFO - Running setup.py install for pep8 02:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:03:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:03:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:03:17 INFO - no previously-included directories found matching 'docs/_build' 02:03:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:03:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:03:18 INFO - Cleaning up... 02:03:18 INFO - Return code: 0 02:03:18 INFO - Running post-action listener: _resource_record_post_action 02:03:18 INFO - Running post-action listener: _start_resource_monitoring 02:03:18 INFO - Starting resource monitoring. 02:03:18 INFO - ##### 02:03:18 INFO - ##### Running install step. 02:03:18 INFO - ##### 02:03:18 INFO - Running pre-action listener: _resource_record_pre_action 02:03:18 INFO - Running main action method: install 02:03:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:03:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:03:18 INFO - Reading from file tmpfile_stdout 02:03:18 INFO - Detecting whether we're running mozinstall >=1.0... 02:03:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:03:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:03:18 INFO - Reading from file tmpfile_stdout 02:03:18 INFO - Output received: 02:03:18 INFO - Usage: mozinstall [options] installer 02:03:18 INFO - Options: 02:03:18 INFO - -h, --help show this help message and exit 02:03:18 INFO - -d DEST, --destination=DEST 02:03:18 INFO - Directory to install application into. [default: 02:03:18 INFO - "/builds/slave/test"] 02:03:18 INFO - --app=APP Application being installed. [default: firefox] 02:03:18 INFO - mkdir: /builds/slave/test/build/application 02:03:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:03:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:03:34 INFO - Reading from file tmpfile_stdout 02:03:34 INFO - Output received: 02:03:34 INFO - /builds/slave/test/build/application/firefox/firefox 02:03:34 INFO - Running post-action listener: _resource_record_post_action 02:03:34 INFO - ##### 02:03:34 INFO - ##### Running run-tests step. 02:03:34 INFO - ##### 02:03:34 INFO - Running pre-action listener: _resource_record_pre_action 02:03:34 INFO - Running main action method: run_tests 02:03:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:03:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:03:34 INFO - Python 2.7.3 02:03:34 INFO - Return code: 0 02:03:34 INFO - grabbing minidump binary from tooltool 02:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:34 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 0x2c573d0>, '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 0x2bc2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc3360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:03:34 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:03:34 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:03:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:03:34 INFO - Return code: 0 02:03:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:03:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:03:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:03:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:03:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:03:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:03:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:03:35 INFO - Return code: 0 02:03:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:03:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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:03:35 INFO - Using env: {'DISPLAY': ':0', 02:03:35 INFO - 'HOME': '/home/cltbld', 02:03:35 INFO - 'LANG': 'en_US.UTF-8', 02:03:35 INFO - 'LANGUAGE': 'en_US:en', 02:03:35 INFO - 'LOGNAME': 'cltbld', 02:03:35 INFO - 'MAIL': '/var/mail/cltbld', 02:03:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:03:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:35 INFO - 'MOZ_NO_REMOTE': '1', 02:03:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:03:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:35 INFO - 'NO_EM_RESTART': '1', 02:03:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:35 INFO - 'PWD': '/builds/slave/test', 02:03:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:03:35 INFO - 'SHELL': '/bin/bash', 02:03:35 INFO - 'SHLVL': '1', 02:03:35 INFO - 'TERM': 'linux', 02:03:35 INFO - 'TMOUT': '86400', 02:03:35 INFO - 'USER': 'cltbld', 02:03:35 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848', 02:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:35 INFO - '_': '/tools/buildbot/bin/python'} 02:03:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:03:35 INFO - mozversion application_buildid: 20160119004438 02:03:35 INFO - mozversion application_changeset: d83a10007bccd01700592fd1d92760c2e1dfca81 02:03:35 INFO - mozversion application_display_name: Nightly 02:03:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:03:35 INFO - mozversion application_name: Firefox 02:03:35 INFO - mozversion application_remotingname: firefox 02:03:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 02:03:35 INFO - mozversion application_vendor: Mozilla 02:03:35 INFO - mozversion application_version: 46.0a1 02:03:35 INFO - mozversion platform_buildid: 20160119004438 02:03:35 INFO - mozversion platform_changeset: d83a10007bccd01700592fd1d92760c2e1dfca81 02:03:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 02:03:35 INFO - mozversion platform_version: 46.0a1 02:03:35 INFO - using testdate: 1453197815 02:03:35 INFO - actual date: 1453197815 02:03:35 INFO - starting webserver on 'localhost:46693' 02:03:35 INFO - SUITE-START | Running 3 tests 02:03:35 INFO - TEST-START | dromaeo_css 02:03:35 INFO - operating with platform_type : linux_ 02:03:35 INFO - Initialising browser for dromaeo_css test... 02:03:35 INFO - TEST-INFO | started process 30275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPvBQSa/profile http://localhost:46693/getInfo.html) 02:03:39 INFO - PROCESS | 30275 | __metrics Screen width/height:1600/1200 02:03:39 INFO - PROCESS | 30275 | colorDepth:24 02:03:39 INFO - PROCESS | 30275 | Browser inner width/height: 1024/697 02:03:39 INFO - PROCESS | 30275 | __metrics 02:03:39 INFO - PROCESS | 30275 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:03:39 INFO - PROCESS | 30275 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:03:40 INFO - TEST-INFO | 30275: exit 0 02:03:40 INFO - Browser initialized. 02:03:40 INFO - Running cycle 1/1 for dromaeo_css test... 02:03:40 INFO - TEST-INFO | started process 30366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPvBQSa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:03:51 INFO - PROCESS | 30366 | RSS: Main: 149770240 02:03:51 INFO - PROCESS | 30366 | 02:04:43 INFO - PROCESS | 30366 | 1453197883214 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:06:54 INFO - PROCESS | 30366 | Cycle 1(1): loaded http://localhost:46693/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46693/tests/dromaeo/cssquery-ext.html) 02:06:55 INFO - PROCESS | 30366 | RSS: Main: 237113344 02:06:55 INFO - PROCESS | 30366 | 02:09:57 INFO - PROCESS | 30366 | Cycle 1(1): loaded http://localhost:46693/tests/dromaeo/cssquery-ext.html (next: http://localhost:46693/tests/dromaeo/cssquery-jquery.html) 02:09:58 INFO - PROCESS | 30366 | RSS: Main: 226488320 02:09:58 INFO - PROCESS | 30366 | 02:13:00 INFO - PROCESS | 30366 | Cycle 1(1): loaded http://localhost:46693/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46693/tests/dromaeo/cssquery-mootools.html) 02:13:01 INFO - PROCESS | 30366 | RSS: Main: 240652288 02:13:01 INFO - PROCESS | 30366 | 02:16:03 INFO - PROCESS | 30366 | Cycle 1(1): loaded http://localhost:46693/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46693/tests/dromaeo/cssquery-prototype.html) 02:16:03 INFO - PROCESS | 30366 | RSS: Main: 204386304 02:16:03 INFO - PROCESS | 30366 | 02:19:06 INFO - PROCESS | 30366 | Cycle 1(1): loaded http://localhost:46693/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46693/tests/dromaeo/cssquery-yui.html) 02:19:07 INFO - PROCESS | 30366 | RSS: Main: 209891328 02:19:07 INFO - PROCESS | 30366 | 02:22:09 INFO - PROCESS | 30366 | Cycle 1(1): loaded http://localhost:46693/tests/dromaeo/cssquery-yui.html (next: http://localhost:46693/tests/dromaeo/cssquery-dojo.html) 02:22:09 INFO - PROCESS | 30366 | RSS: Main: 248434688 02:22:09 INFO - PROCESS | 30366 | 02:22:09 INFO - PROCESS | 30366 | __start_tp_report 02:22:09 INFO - PROCESS | 30366 | _x_x_mozilla_page_load 02:22:09 INFO - PROCESS | 30366 | _x_x_mozilla_page_load_details 02:22:09 INFO - PROCESS | 30366 | |i|pagename|runs| 02:22:09 INFO - PROCESS | 30366 | |0;dojo.html;2552.629868669043;2620.6855177378716;2625.6192852036465;2636.4858852523753;2638.947221055579;4296.48442186938;4389.890252743683;4418.33724941259;4446.199684056873;4478.753668548233;4348.565143485658;4376.868693939187;4400.185965596367;4410.580994805488;4497.685162038659;4097.836086556549;4103.753774773523;4108.075682971323;4120.052387950773;4120.876373708794;4080.0411903202726;4110.095778928646;4158.37624356346;4162.188373267214;4192.056787222866;3932.8230229639594;4003.259397011533;4023.517177938637;4082.81627326771;4097.364908439196;4062.0454193264854;4069.0844559974066;4072.6538244249273;4111.218868414991;4112.321466957948;4055.797210139481;4058.188362327546;4058.7767672777986;4068.4100805383055;4087.509498860126;4241.045764702948;4282.036541778106;4309.892252693708;4322.654187664979;4389.539098394686;4635.258358662598;4654.394928659286;4658.161530924433;4693.741844198567;4699.506551812079;4676.415448068991;4679.251319788817;4686.789094490756;4722.338872557844;4730.219513780256;4283;4328.458942632171;4349.3475978603465;4354.194474022316;4384.934225986613;4815.783289751969;4834.105690447279;4834.444038935568;4859.271109333628;4879.463259041502;4626.467956185014;4632;4633.258678611406;4663.067386522709;4681.087187998308;4531.274996000624;4616.6075883550275;4716.080364328923;4718.669693121517;4766.118268120409;4567.954320456753;4590.2426099693175;4626.7223966562115;4657.231556793091;4671.906561868744;4621.6764826462495;4656.4877863434995;4657.720536767804;4661.417322834645;4696.319033740157;3911.159100793286;3991.880243592697;4000.139969906484;4020.8592699255387;4031.274370613318;3436.7078798302423;3492.1793378556017;3492.4586689063235;3513.982430087833;3518.489818976234;4097.631213190767;4113.197926404382;4118.567550407164;4144.461220041375;4160.50073991123;4718.41019872516;4723.716577005391;4724.763761811896;4732.98240878206;4783.617310615143;3986.900327491836;4023.1752490739327;4066.67466602677;4076.0421300994244;4160.687948403821;4189.183109293719;4190.937135942963;4191.538930717618;4193.853215137456;4217.91564168721;4449.555044495524;4464.910701785946;4470.865874023784;4502.864914052584;4506.3465797459185;4565.223911935045;4655.301704744315;4655.976720116378;4689.6248300136585;4786.521347865186;4455.2426087564545;4459.843905463294;4467.5755803198645;4474.328850672425;4489.887752806206;4602.953970460387;4604.907901842012;4606.147862645421;4612.907741845077;4646.697964632288;4543.45478542577;4611.33135695329;4627.62978961689;4631.351610774427;4694.647901407477;4493.528179541232;4503.369528266111;4512.300593408027;4513.052259025641;4555.681102322806;4499.662525310549;4504.819807207806;4506.41416615851;4510.571495707903;4550.2492088804975;4347.521772604948;4414.668899832461;4421.579949904753;4437.556244375537;4525.570070843265;4550.385697930737;4577.633789296915;4582.152301824173;4602.838900638596;4604.976975115103;4477.283634618446;4491.7754112293605;4495.056038232008;4496.482904466028;4534.931976020296 02:22:09 INFO - PROCESS | 30366 | |1;ext.html;519.5817367019548;543.0713479949287;552.6131707804535;552.7259666468788;560.263253821225;24156.87921560394;36266.45600315994;36481.81759091201;36521.269574608494;36584.45123323152;38720.80639596805;39349.21301573967;39350.80324598373;39376.40935385964;39447.40828887569;7735.690572377112;7934.960325198366;7938.563379014152;7943.801404964894;7948.125706172316;7631.923680763204;7763.728269510569;7764.068311802592;7768.766936991871;7780.844383112334;7744.38044956405;7792.10390805059;7827.295543401093;7828.491148075385;7830.843383132334;7691.653875575613;7764.883526747103;7779.844403111906;7780.649870755801;7780.688772449095;7657.387409007321;7789.61051947406;7792.181820908836;7792.766217013499;7794;36132.63867361319;36604.450933236025;36637.267254655024;36638;36691.63308366909;2944.9411011779644;3210.871565137392;3265.2489927316615;3265.330607225513;3301.339732053575;27227;27260.59109113345;27466.862665686742;27994.16017519478;28205.29486762827;3351.346487434951;3358.697717205463;3361.8151001694896;3377.290768938526;3523.4010218262956;213824;214397;214466;214637;214804;45171;52478.737606311726;52906.735466322425;52938.94122117613;52989.20516192183;39734.006649833405;60994.39005609976;62545;62587.68706156531;62618.0607290891;14976;15260.618484537976;15266.16036118002;15274.694506109816;15278;9053.411528250643;9071.637134514678;10890.183236257313;10945.179111566506;11153.442327883735;17590.384336548414;18443.81556184421;18551.16519756587;18561;18574;6833.214180369222;7151.106111736033;7153.535020223773;7170.498065135391;7258.346748792528;793.5754371411383;805.287320721166;907.8502047162144;975.9414435133915;1011.1354791653177;24869.875650621994;25973.870130649604;25989;26107.477850442883;26126.477470450485;915.3272444462186;992.8510723391549;994.9701508954743;1054.372648274291;1064.893510648929;13383.531576394975;13685.863141368658;13688.818145642697;13847.446102155802;13983.37074831635;255288;258857;259044;259961;260478;45775.77112114418;46087.76956115198;46093;46130;46229.76885115553;1160.7388337623968;1166.4692564882957;1170.5961443302047;1173.5423184957874;1183.721825371037;24849;25669;25999.480010400064;26423.603645944942;26472;40239.79880100581;40330.59669403268;40382.39426408665;40481.797591011855;40687.38968915528;242947;244078;244256;244854;245627;27725.72274277312;27846.44307113887;28222.343313353067;28300.15099547017;29161.125166245045;33027.66972330246;33029.50455743214;33177.33645327032;33923.66076339205;33963.49054764131;28229.858850705616;28591.571126432704;28820.135395938156;29323;29804.552931706476;28966.13101606955;29453;30709;31510.21224469315;32232.35535289328;29030.564541531472;30060.24849378783;30110.548341774454;30166.547501787052;30218;25722.742772572783;26360;28562.285942851595;29781.851090745273;32113.51829722509;22458.42791004614;22689;22870.313890583308;22927.312180634606;23031.88484057569 02:22:09 INFO - PROCESS | 30366 | |2;jquery.html;299.8066247270509;324.2071345459608;324.39840857437247;324.7239846130789;330.9685579869913;11370.658880233595;14682.41270349186;14978.925105374485;16056.27746751396;16129.112898790561;13761.31193440329;13811;14381.712365752679;14407.207603581799;15247.61880952974;4348.630366418858;4563.338315944186;4567.817287308504;4567.931481027787;4569.337446070318;4383.956160438387;4449.199144154051;4461.709988850731;4463.821447142111;4588.426446694163;4985.576226020793;4995.526319735687;4997.375328083989;5007.0486607544635;5011.072951503965;4631.930521042187;4893.828715994923;4922.3354847095725;4973.278874563186;4984.327115839352;4515.954840451619;4683.2975053741875;4718.363020992157;4722.456917454502;4726.338312636233;10189.745256368577;10400.32397894142;10441.530131144116;10460.11089057431;10462.163026957902;1757.8154293799096;1821.5537193387704;1866.412080194748;1894.232835701543;1991.9900400497904;8372.41393102483;8457.53483558404;9334.01992790754;9342.813143737087;11996.340201288926;1666.1169580122555;1666.3251383189827;1734.7051001329805;1751.7109676903424;1754.3421217043608;48732;50207.24689129666;51643.74178129123;52055.73972130115;52086;8090.312323452455;8560.272376847914;8756.474611523328;8946.747455356255;9208.90791092094;10344.741381465523;10714.571417143383;10810.891891080988;10822.621208257673;10829;6762.459003279726;6943.826404339831;6946.270641582662;6962.756303529352;7014.894776578355;6923.376896079377;6936.93063069373;6978.406835419046;6985.161780586261;6995.230524642286;3748.4002559590335;3826.6938644908896;3845.0195200224325;3850.614938506127;3866.5360156781367;1544.637010302578;1594.226800001998;1595.0828273742413;1605.7189991751397;1609.332127167236;812.8821320908553;847.2163248994656;863.6847550644095;915.2632131134368;977.3793641037992;14318.57044288673;14388.712225755426;16363.345466181458;16443;16676.33294668224;749.5802350683525;839.504692231574;913.862920561921;931.2736065868634;944.4994153098869;7792.493487923267;8329;8575.099614540384;8586.356023298278;9179.862302065474;451711;452593;456648;461092.5016748509;466217;48053.27920081132;58878;61072.38927610667;61279;64129.679351603874;1015.5988384588046;1035.7048241251207;1041.8176819056634;1045.4720366215165;1047.7433028907967;13713.382897769823;13914.304284785518;13948.721025579634;14331.641708957359;14332.785008224677;26366.945322186897;27355.589666154625;27513.17460476189;27532.311692207855;27771.44457110806;32259.838700806347;32429;32479;32648;32899.177520562174;5863.560232982458;6061.696915154136;6177.073438984188;6223.719932602953;6253.9362010537325;7634.236576342321;9419.811603768023;9487.956324804403;9640.180584650103;9785.461799601091;8429.578521074045;8462.280706140047;8550.700725474579;8574.142585741376;8625.439346442461;7908.3673306136525;8665.39342246062;8758.562071896253;9151.771205719644;9295.581698823435;8887.9559800292;8986.32602554824;9007.63969441215;9201.171894529256;9249.12133347331;6317.778877739257;6337.2395312562785;6412.6793660317735;6445.236455119867;6517.608943463408;7586.544807311579;8691.652333906573;8869.73390798277;8933.553322333988;8955.910440895508 02:22:09 INFO - PROCESS | 30366 | |3;mootools.html;1230.501646833033;1360.9792655508368;1377.6004958562019;1472.9926350368246;1685.3090233004464;5934.406559344064;6079.361667024965;6639.668016599175;6755.324467553242;6830.453563714903;6753.290904455023;6770.830729231771;6793.422559082472;6798.592084474935;6802.14973128359;1765.5144835170302;1814.4193857965456;2081.510844951435;2105.799949004842;2106.220698341616;2065.2771529964466;2130.052126803573;2130.084063852543;2130.6271402504576;2132.3070002249333;2053.6485723846263;2063.566651003291;2071.5339048713995;2086.4992401823606;2086.4992401823606;2046.94882627934;2053.0863765624226;2053.301877361704;2056.8251698605486;2061.5361543652707;2055.6094342074957;2067.1008111471556;2068.2761033638108;2073.5645514441985;2075.6575165097893;7039.788806335818;7067.43460523157;7071.717131314741;7088.787336379917;7100.076989991319;3933.724639275252;3986.4219688145345;4011.2178125265586;4015.036391266104;4025.2955732746946;2539.149384956042;2648.284963059963;2655.9907235250676;2656.8405895646324;2678.1429942418436;842.6713581703141;873.807762292301;877.1316396767219;1738.3394310162184;1764.1796564597523;9010.14403631654;9113.954430227872;9118.361714679975;9132.589033493508;9133.08669133088;3534.9823250884097;3595.658412450813;3647.6899463545365;3648.3068217038676;3654.086478380405;7545.471816972759;7547.320741133324;7553.660085296175;7554.43341749371;7566.432517561095;4111.1366613011605;4117.155983023473;4150.211459822624;4161.2509748245;4165.97917010413;3841.5390153181797;3841.654251117413;3842.8270727817317;3845.3270677631303;3851.1334949636666;2784.7911406644175;2813.563897595876;3043.8782448702245;3067.2945222598482;3073.969260307413;916.3310783128354;917.4816228830689;917.8393781088416;918.4351623751345;920.2316066084894;878.4026861733954;878.6997229861905;897.52879738138;897.9595918183697;1122.0742887117997;6703.329667033355;6726.428253598499;6735.595864248161;6736.966315168491;6737.562058466184;1021.4790456867051;1038.7697940867845;1041.1982773264544;1069.983950240747;1072.1369297715257;5080.339555857789;5151.974240128776;5156.432792392834;5162.483751624883;5164.25118357836;8153.6738530458115;8258.298044666271;8283.95858020706;8380.413371063967;8422.578871056423;8391.370647201484;8397.412181147261;8423.410361274775;8446.61990210442;8465.111163327761;6526.41262286406;6547.836304092436;6648.900266496006;6665.133532640726;6690.732370705117;6394.0408938659575;6432;6438.484921206198;6464.5798023128345;6470.644114573555;7018.824529386806;7165.462590305644;7191.20896701352;7520.623968801648;7566.583837888969;7161.928380716335;7379.557226566423;7384.778456646309;7420.888686669597;7484.738034168996;6004.279486461653;6118.357572454828;6118.724657390339;6122.724477398617;6123;5499.450054994469;5568.248286481273;6303.747850085945;6539;6585.539012269095;6205.069239614094;6228.937710622836;6242.781502647385;6303.779367722108;6410.903836442364;6055.031195008777;6169.876602468015;6190.071489276645;6313.55805093639;6323.494120470444;6132.356102609162;6151.0773383992755;6183.319834818257;6308.842278943063;6359.96820015897;5662.320521537442;5689.914651280317;5721.113227449752;5756.597038207453;5785.045467497984;5862.765489380377;5863.618864773776;5882.23530940975;5885.558583106199;5891.970540147272 02:22:09 INFO - PROCESS | 30366 | |4;prototype.html;283.31296605731103;286.351414047183;292.08722741433024;293.8795094011456;295.14555362226366;5291.4708529147065;5293.073712100377;5295.549878260348;5331.360236771583;5411.972940135303;5294.973525132378;5354.464553544643;5380.757865896035;5388.272583201267;5388.838334849951;4089.5092588889224;4090.468239128909;4094.1811637672436;4096.73371230869;4103.9794801025955;3844.615538446147;3906.8241929113115;3957.2679054375035;3997.1406147678244;4024.557298697141;3945.5857135000842;3980.6417422431973;4016.799160042001;4017.0158311213795;4020.7386519876113;3771.6039815819217;3873.6513713765617;3972.165845172517;3978.3435733104;3995.021219801138;3384.4754063120254;3456.1359660084977;3456.2741824216946;3470.444728843398;3471.7222622190166;5093.745312734349;5105.617078719074;5137.101007323741;5143.948560514385;5154.278401023859;4631.62946964242;4635.11932732783;4640.721556706575;4642.396488456479;4644.512326205733;5467.617266791326;5596.3284405871555;5599.608027438081;5599.776008959637;5604.439556044404;3788.3370410178386;3797.0886987123167;3800.220954704279;3801.7718936863876;3806.6764325032404;5840.357560668365;5912.733926973297;5917.881642367129;5920.940790592082;5925.4963328117165;3884.1843212925037;3885.106425522146;3885.9805700971315;3887.5723670396233;3890.183061557105;3938.7242892997215;3941.7437866538585;3945.763254204757;3946.9145984854395;3948.348522493814;4462.062966776948;4599.333096701027;4607.815687372535;4608.746518941423;4609.078184363141;5619.297587801525;5627.268455100811;5627.971860140673;5631.042722737145;5631.831045068655;1375.5048182654436;1393.909395889264;1394.17743531317;1395.7557427450358;1395.9232242226774;913.1872633356318;918.1736437206434;924.699472671371;935.5649622925372;939.4034787909726;4960.727160006234;4968.056069346812;4972.179590367621;4980.576650984634;4992.825251116194;5873.735681894325;5875.177475153482;5880.617759845682;5880.94119058804;5884.6469211847425;4958.7024778513405;4960.479149689303;4964.205727083649;4965.3048573199785;4968.453470118284;3036.316828713566;3068.2789544457037;3141.8114913105287;3162.5572419861237;3166.1134882233014;5407.432219616883;5432.212329212242;5503.2020357048;5520.475554822286;5526.778928842801;6027.7890273841085;6047.3045599755715;6059.0608455689435;6090.9390906090375;6137.815865524041;5586.608937374426;5594.720263986866;5599.440055994368;5600.747966341606;5604.766951270714;5676.943230567642;5884.382139875423;5885.911711324248;5900.64596124234;5908.7045647718305;5753.424657534213;5765.827025189251;5768.480836724715;5769.394213607511;5771.278590176228;5594.216809646571;5595.328560572594;5598.664080155204;5598.916016259841;5609.186667933209;3769.7172712047254;3867.41988701697;3901.5708272090615;3902.512185976753;3907.3552863778295;5855.2095467113095;5865.794697185578;5903.468687818117;5925.4370834770625;5937.7921772737745;5598.944010559842;5600.047991841316;5606.579506536945;5611.438856114356;5612.354579223278;5590.8043218487155;5592.664440133605;5596.300462442195;5596.776128954796;5599.32808063035;5330.413654497925;5447.918281225864;5454.400015998158;5455.809046683347;5461.290032295776;5666.490015898589;5667.3765885753355;5672.773089076556;5677.034904066401;5677.574181936288;5518.889622207453;5539.19681646151;5540.833774986757;5541.833744987657;5557.610967232416 02:22:09 INFO - PROCESS | 30366 | |5;yui.html;660.3000819131719;699.6152116336017;713.119297667381;733.9504508552769;771.8726410142327;10929.781404371917;11003.17476189285;11010.559577616907;11016.228863979524;11039.668809935705;10289.948550257257;10331.948340258288;10349.068583827455;10353.223508236875;10373;591.0985746736219;600.6996501749126;748.120957874498;754.4077898849405;762.6263131065765;777.4363586399871;778.9688412463495;782.3662833105175;782.7651704488659;783.0094929913664;812.7114874219656;814.7067055859885;817.7015389382863;819.172635638004;820.1552401026952;626.1015442839517;635.5741653092439;796.2555011064674;812.7236739508536;813.0893399392718;595.0924839619614;599.6192417814675;599.865030368168;600.2197143713155;600.5555888642417;9998.350107243006;10013.749656258578;10059.245556583212;10060;10095.545700443497;10728.463576821207;11019.393933333664;11161;11161.944190278997;11204.21570490066;9307.255419566418;9313.534323283877;9524.190443812284;9585;9606.66376676813;3182.9204269893207;3219.2917558137174;3231.4021905947475;3257.7719559630837;3323.501474778778;37768.43347349792;37824.24351512954;37907.43138852919;37923.241535169414;38374.80812595947;8667.913320866837;8868.467891926504;8893.199612034818;9197.022640132403;9240.630374784932;15152.31814568347;15216.163111029;15227.695446091016;15242.771358429633;15278.923605382124;6215.720292586754;6342.714577843916;6385.042243663488;6432.195975503062;6489.1888513935755;3397.2016576104597;3454.4990976308295;3460.5155278261063;3477.8956631301103;3540.1149712571855;2541.1995221505167;2541.7204107548155;2546.503431830812;2551.668283123219;2568.7174410814796;444.45110288793313;449.7054429348782;450.3537423796862;454.4183445190162;458.86234129760936;552.7567870137127;554.4621716934568;562.1343131577325;565.6945249565189;601.3535449391921;6949.513534052669;7390.29792169743;7438.442116841258;7912.643931023003;8227.506349619041;464.7729992818961;484.9030193961222;487.2763945540869;512.6155383462403;577.9164067373674;3477.3740726669444;3492.371373152806;3515.1036485695986;3610.1335679436747;3621.7102631789394;41599;44996.55003449923;45480;45619;45685.7715711426;36398.8180059098;36449.81775091161;36760.63239367626;37516.43725344067;37634.247315053544;34183.82908085443;34295.65704342975;34397;34811;34935.825320873744;7339.431238965426;7612.657430415756;7624.085109786861;7773.650185741542;7925.881111783443;27423.45153096887;27858;27958.44083118367;28213.294667633472;28420.715792841806;34308.31383372368;34365;34643;37228.62771372252;37431.25137497289;8832.337574681796;8838.911610883808;8931.642734290555;8999.685011024583;9080.909190908007;10046.949765251127;10200.948995254976;10205.84691229647;10247;10632;8501.617427215913;8574.485530868167;8577.228049475578;8609.973018886929;8853.468791872509;9118.133777291147;9147;9201.217896478875;9619.134277914742;9820.165285950774;9962.501874906371;10071.244656650928;10102.39385636864;10129.59481620727;10134.645287414905;8490.660373584988;8576.356773241907;8601.741947741577;8657.91342086571;8731.476111433334;8441.620127094418;8816.51509167002;8830.690925817566;8850.822983540163;8885 02:22:09 INFO - PROCESS | 30366 | __end_tp_report 02:22:09 INFO - PROCESS | 30366 | __start_cc_report 02:22:09 INFO - PROCESS | 30366 | _x_x_mozilla_cycle_collect,851 02:22:09 INFO - PROCESS | 30366 | __end_cc_report 02:22:09 INFO - PROCESS | 30366 | __startTimestamp1453198929938__endTimestamp 02:22:09 INFO - PROCESS | 30366 | 02:22:09 INFO - PROCESS | 30366 | ------- Summary: start ------- 02:22:09 INFO - PROCESS | 30366 | Number of tests: 6 02:22:09 INFO - PROCESS | 30366 | 02:22:09 INFO - PROCESS | 30366 | [#0] dojo.html Cycles:165 Average:4342.99 Median:4470.87 stddev:421.85 (9.4%) stddev-sans-first:399.08 02:22:09 INFO - PROCESS | 30366 | Values: 2552.6 2620.7 2625.6 2636.5 2638.9 4296.5 4389.9 4418.3 4446.2 4478.8 4348.6 4376.9 4400.2 4410.6 4497.7 4097.8 4103.8 4108.1 4120.1 4120.9 4080.0 4110.1 4158.4 4162.2 4192.1 3932.8 4003.3 4023.5 4082.8 4097.4 4062.0 4069.1 4072.7 4111.2 4112.3 4055.8 4058.2 4058.8 4068.4 4087.5 4241.0 4282.0 4309.9 4322.7 4389.5 4635.3 4654.4 4658.2 4693.7 4699.5 4676.4 4679.3 4686.8 4722.3 4730.2 4283.0 4328.5 4349.3 4354.2 4384.9 4815.8 4834.1 4834.4 4859.3 4879.5 4626.5 4632.0 4633.3 4663.1 4681.1 4531.3 4616.6 4716.1 4718.7 4766.1 4568.0 4590.2 4626.7 4657.2 4671.9 4621.7 4656.5 4657.7 4661.4 4696.3 3911.2 3991.9 4000.1 4020.9 4031.3 3436.7 3492.2 3492.5 3514.0 3518.5 4097.6 4113.2 4118.6 4144.5 4160.5 4718.4 4723.7 4724.8 4733.0 4783.6 3986.9 4023.2 4066.7 4076.0 4160.7 4189.2 4190.9 4191.5 4193.9 4217.9 4449.6 4464.9 4470.9 4502.9 4506.3 4565.2 4655.3 4656.0 4689.6 4786.5 4455.2 4459.8 4467.6 4474.3 4489.9 4603.0 4604.9 4606.1 4612.9 4646.7 4543.5 4611.3 4627.6 4631.4 4694.6 4493.5 4503.4 4512.3 4513.1 4555.7 4499.7 4504.8 4506.4 4510.6 4550.2 4347.5 4414.7 4421.6 4437.6 4525.6 4550.4 4577.6 4582.2 4602.8 4605.0 4477.3 4491.8 4495.1 4496.5 4534.9 02:22:09 INFO - PROCESS | 30366 | 02:22:09 INFO - PROCESS | 30366 | [#1] ext.html Cycles:180 Average:39397.76 Median:3283.34 stddev:62507.94 (1903.8%) stddev-sans-first:62615.13 02:22:09 INFO - PROCESS | 30366 | Values: 519.6 543.1 552.6 552.7 560.3 24156.9 36266.5 36481.8 36521.3 36584.5 38720.8 39349.2 39350.8 39376.4 39447.4 7735.7 7935.0 7938.6 7943.8 7948.1 7631.9 7763.7 7764.1 7768.8 7780.8 7744.4 7792.1 7827.3 7828.5 7830.8 7691.7 7764.9 7779.8 7780.6 7780.7 7657.4 7789.6 7792.2 7792.8 7794.0 36132.6 36604.5 36637.3 36638.0 36691.6 2944.9 3210.9 3265.2 3265.3 3301.3 27227.0 27260.6 27466.9 27994.2 28205.3 3351.3 3358.7 3361.8 3377.3 3523.4 213824.0 214397.0 214466.0 214637.0 214804.0 45171.0 52478.7 52906.7 52938.9 52989.2 39734.0 60994.4 62545.0 62587.7 62618.1 14976.0 15260.6 15266.2 15274.7 15278.0 9053.4 9071.6 10890.2 10945.2 11153.4 17590.4 18443.8 18551.2 18561.0 18574.0 6833.2 7151.1 7153.5 7170.5 7258.3 793.6 805.3 907.9 975.9 1011.1 24869.9 25973.9 25989.0 26107.5 26126.5 915.3 992.9 995.0 1054.4 1064.9 13383.5 13685.9 13688.8 13847.4 13983.4 255288.0 258857.0 259044.0 259961.0 260478.0 45775.8 46087.8 46093.0 46130.0 46229.8 1160.7 1166.5 1170.6 1173.5 1183.7 24849.0 25669.0 25999.5 26423.6 26472.0 40239.8 40330.6 40382.4 40481.8 40687.4 242947.0 244078.0 244256.0 244854.0 245627.0 27725.7 27846.4 28222.3 28300.2 29161.1 33027.7 33029.5 33177.3 33923.7 33963.5 28229.9 28591.6 28820.1 29323.0 29804.6 28966.1 29453.0 30709.0 31510.2 32232.4 29030.6 30060.2 30110.5 30166.5 30218.0 25722.7 26360.0 28562.3 29781.9 32113.5 22458.4 22689.0 22870.3 22927.3 23031.9 02:22:09 INFO - PROCESS | 30366 | 02:22:09 INFO - PROCESS | 30366 | [#2] jquery.html Cycles:180 Average:23328.02 Median:4724.40 stddev:74704.90 (1581.3%) stddev-sans-first:74894.45 02:22:09 INFO - PROCESS | 30366 | Values: 299.8 324.2 324.4 324.7 331.0 11370.7 14682.4 14978.9 16056.3 16129.1 13761.3 13811.0 14381.7 14407.2 15247.6 4348.6 4563.3 4567.8 4567.9 4569.3 4384.0 4449.2 4461.7 4463.8 4588.4 4985.6 4995.5 4997.4 5007.0 5011.1 4631.9 4893.8 4922.3 4973.3 4984.3 4516.0 4683.3 4718.4 4722.5 4726.3 10189.7 10400.3 10441.5 10460.1 10462.2 1757.8 1821.6 1866.4 1894.2 1992.0 8372.4 8457.5 9334.0 9342.8 11996.3 1666.1 1666.3 1734.7 1751.7 1754.3 48732.0 50207.2 51643.7 52055.7 52086.0 8090.3 8560.3 8756.5 8946.7 9208.9 10344.7 10714.6 10810.9 10822.6 10829.0 6762.5 6943.8 6946.3 6962.8 7014.9 6923.4 6936.9 6978.4 6985.2 6995.2 3748.4 3826.7 3845.0 3850.6 3866.5 1544.6 1594.2 1595.1 1605.7 1609.3 812.9 847.2 863.7 915.3 977.4 14318.6 14388.7 16363.3 16443.0 16676.3 749.6 839.5 913.9 931.3 944.5 7792.5 8329.0 8575.1 8586.4 9179.9 451711.0 452593.0 456648.0 461092.5 466217.0 48053.3 58878.0 61072.4 61279.0 64129.7 1015.6 1035.7 1041.8 1045.5 1047.7 13713.4 13914.3 13948.7 14331.6 14332.8 26366.9 27355.6 27513.2 27532.3 27771.4 32259.8 32429.0 32479.0 32648.0 32899.2 5863.6 6061.7 6177.1 6223.7 6253.9 7634.2 9419.8 9488.0 9640.2 9785.5 8429.6 8462.3 8550.7 8574.1 8625.4 7908.4 8665.4 8758.6 9151.8 9295.6 8888.0 8986.3 9007.6 9201.2 9249.1 6317.8 6337.2 6412.7 6445.2 6517.6 7586.5 8691.7 8869.7 8933.6 8955.9 02:22:09 INFO - PROCESS | 30366 | 02:22:09 INFO - PROCESS | 30366 | [#3] mootools.html Cycles:180 Average:4800.14 Median:6120.72 stddev:2454.20 (40.1%) stddev-sans-first:2446.42 02:22:09 INFO - PROCESS | 30366 | Values: 1230.5 1361.0 1377.6 1473.0 1685.3 5934.4 6079.4 6639.7 6755.3 6830.5 6753.3 6770.8 6793.4 6798.6 6802.1 1765.5 1814.4 2081.5 2105.8 2106.2 2065.3 2130.1 2130.1 2130.6 2132.3 2053.6 2063.6 2071.5 2086.5 2086.5 2046.9 2053.1 2053.3 2056.8 2061.5 2055.6 2067.1 2068.3 2073.6 2075.7 7039.8 7067.4 7071.7 7088.8 7100.1 3933.7 3986.4 4011.2 4015.0 4025.3 2539.1 2648.3 2656.0 2656.8 2678.1 842.7 873.8 877.1 1738.3 1764.2 9010.1 9114.0 9118.4 9132.6 9133.1 3535.0 3595.7 3647.7 3648.3 3654.1 7545.5 7547.3 7553.7 7554.4 7566.4 4111.1 4117.2 4150.2 4161.3 4166.0 3841.5 3841.7 3842.8 3845.3 3851.1 2784.8 2813.6 3043.9 3067.3 3074.0 916.3 917.5 917.8 918.4 920.2 878.4 878.7 897.5 898.0 1122.1 6703.3 6726.4 6735.6 6737.0 6737.6 1021.5 1038.8 1041.2 1070.0 1072.1 5080.3 5152.0 5156.4 5162.5 5164.3 8153.7 8258.3 8284.0 8380.4 8422.6 8391.4 8397.4 8423.4 8446.6 8465.1 6526.4 6547.8 6648.9 6665.1 6690.7 6394.0 6432.0 6438.5 6464.6 6470.6 7018.8 7165.5 7191.2 7520.6 7566.6 7161.9 7379.6 7384.8 7420.9 7484.7 6004.3 6118.4 6118.7 6122.7 6123.0 5499.5 5568.2 6303.7 6539.0 6585.5 6205.1 6228.9 6242.8 6303.8 6410.9 6055.0 6169.9 6190.1 6313.6 6323.5 6132.4 6151.1 6183.3 6308.8 6360.0 5662.3 5689.9 5721.1 5756.6 5785.0 5862.8 5863.6 5882.2 5885.6 5892.0 02:22:09 INFO - PROCESS | 30366 | 02:22:09 INFO - PROCESS | 30366 | [#4] prototype.html Cycles:180 Average:4630.02 Median:5342.91 stddev:1406.30 (26.3%) stddev-sans-first:1371.88 02:22:09 INFO - PROCESS | 30366 | Values: 283.3 286.4 292.1 293.9 295.1 5291.5 5293.1 5295.5 5331.4 5412.0 5295.0 5354.5 5380.8 5388.3 5388.8 4089.5 4090.5 4094.2 4096.7 4104.0 3844.6 3906.8 3957.3 3997.1 4024.6 3945.6 3980.6 4016.8 4017.0 4020.7 3771.6 3873.7 3972.2 3978.3 3995.0 3384.5 3456.1 3456.3 3470.4 3471.7 5093.7 5105.6 5137.1 5143.9 5154.3 4631.6 4635.1 4640.7 4642.4 4644.5 5467.6 5596.3 5599.6 5599.8 5604.4 3788.3 3797.1 3800.2 3801.8 3806.7 5840.4 5912.7 5917.9 5920.9 5925.5 3884.2 3885.1 3886.0 3887.6 3890.2 3938.7 3941.7 3945.8 3946.9 3948.3 4462.1 4599.3 4607.8 4608.7 4609.1 5619.3 5627.3 5628.0 5631.0 5631.8 1375.5 1393.9 1394.2 1395.8 1395.9 913.2 918.2 924.7 935.6 939.4 4960.7 4968.1 4972.2 4980.6 4992.8 5873.7 5875.2 5880.6 5880.9 5884.6 4958.7 4960.5 4964.2 4965.3 4968.5 3036.3 3068.3 3141.8 3162.6 3166.1 5407.4 5432.2 5503.2 5520.5 5526.8 6027.8 6047.3 6059.1 6090.9 6137.8 5586.6 5594.7 5599.4 5600.7 5604.8 5676.9 5884.4 5885.9 5900.6 5908.7 5753.4 5765.8 5768.5 5769.4 5771.3 5594.2 5595.3 5598.7 5598.9 5609.2 3769.7 3867.4 3901.6 3902.5 3907.4 5855.2 5865.8 5903.5 5925.4 5937.8 5598.9 5600.0 5606.6 5611.4 5612.4 5590.8 5592.7 5596.3 5596.8 5599.3 5330.4 5447.9 5454.4 5455.8 5461.3 5666.5 5667.4 5672.8 5677.0 5677.6 5518.9 5539.2 5540.8 5541.8 5557.6 02:22:09 INFO - PROCESS | 30366 | 02:22:09 INFO - PROCESS | 30366 | [#5] yui.html Cycles:180 Average:11075.83 Median:499.95 stddev:12154.24 (2431.1%) stddev-sans-first:12163.17 02:22:09 INFO - PROCESS | 30366 | Values: 660.3 699.6 713.1 734.0 771.9 10929.8 11003.2 11010.6 11016.2 11039.7 10289.9 10331.9 10349.1 10353.2 10373.0 591.1 600.7 748.1 754.4 762.6 777.4 779.0 782.4 782.8 783.0 812.7 814.7 817.7 819.2 820.2 626.1 635.6 796.3 812.7 813.1 595.1 599.6 599.9 600.2 600.6 9998.4 10013.7 10059.2 10060.0 10095.5 10728.5 11019.4 11161.0 11161.9 11204.2 9307.3 9313.5 9524.2 9585.0 9606.7 3182.9 3219.3 3231.4 3257.8 3323.5 37768.4 37824.2 37907.4 37923.2 38374.8 8667.9 8868.5 8893.2 9197.0 9240.6 15152.3 15216.2 15227.7 15242.8 15278.9 6215.7 6342.7 6385.0 6432.2 6489.2 3397.2 3454.5 3460.5 3477.9 3540.1 2541.2 2541.7 2546.5 2551.7 2568.7 444.5 449.7 450.4 454.4 458.9 552.8 554.5 562.1 565.7 601.4 6949.5 7390.3 7438.4 7912.6 8227.5 464.8 484.9 487.3 512.6 577.9 3477.4 3492.4 3515.1 3610.1 3621.7 41599.0 44996.6 45480.0 45619.0 45685.8 36398.8 36449.8 36760.6 37516.4 37634.2 34183.8 34295.7 34397.0 34811.0 34935.8 7339.4 7612.7 7624.1 7773.7 7925.9 27423.5 27858.0 27958.4 28213.3 28420.7 34308.3 34365.0 34643.0 37228.6 37431.3 8832.3 8838.9 8931.6 8999.7 9080.9 10046.9 10200.9 10205.8 10247.0 10632.0 8501.6 8574.5 8577.2 8610.0 8853.5 9118.1 9147.0 9201.2 9619.1 9820.2 9962.5 10071.2 10102.4 10129.6 10134.6 8490.7 8576.4 8601.7 8657.9 8731.5 8441.6 8816.5 8830.7 8850.8 8885.0 02:22:09 INFO - PROCESS | 30366 | -------- Summary: end -------- 02:22:09 INFO - PROCESS | 30366 | 02:22:10 INFO - TEST-INFO | 30366: exit 0 02:22:10 INFO - TEST-OK | dromaeo_css | took 1115324ms 02:22:10 INFO - TEST-START | kraken 02:22:10 INFO - operating with platform_type : linux_ 02:22:10 INFO - Initialising browser for kraken test... 02:22:10 INFO - TEST-INFO | started process 30564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6jzvR0/profile http://localhost:46693/getInfo.html) 02:22:14 INFO - PROCESS | 30564 | __metrics Screen width/height:1600/1200 02:22:14 INFO - PROCESS | 30564 | colorDepth:24 02:22:14 INFO - PROCESS | 30564 | Browser inner width/height: 1024/697 02:22:14 INFO - PROCESS | 30564 | __metrics 02:22:14 INFO - PROCESS | 30564 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:22:14 INFO - PROCESS | 30564 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:22:15 INFO - TEST-INFO | 30564: exit 0 02:22:15 INFO - Browser initialized. 02:22:15 INFO - Running cycle 1/1 for kraken test... 02:22:15 INFO - TEST-INFO | started process 30643 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6jzvR0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:22:27 INFO - PROCESS | 30643 | RSS: Main: 149495808 02:22:27 INFO - PROCESS | 30643 | 02:22:29 INFO - PROCESS | 30643 | Cycle 1(1): loaded http://localhost:46693/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46693/tests/kraken/driver.html?testName=audio-beat-detection) 02:22:30 INFO - PROCESS | 30643 | RSS: Main: 187281408 02:22:30 INFO - PROCESS | 30643 | 02:22:33 INFO - PROCESS | 30643 | Cycle 1(1): loaded http://localhost:46693/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46693/tests/kraken/driver.html?testName=audio-dft) 02:22:33 INFO - PROCESS | 30643 | RSS: Main: 177213440 02:22:33 INFO - PROCESS | 30643 | 02:22:36 INFO - PROCESS | 30643 | Cycle 1(1): loaded http://localhost:46693/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46693/tests/kraken/driver.html?testName=audio-fft) 02:22:37 INFO - PROCESS | 30643 | RSS: Main: 162222080 02:22:37 INFO - PROCESS | 30643 | 02:22:39 INFO - PROCESS | 30643 | Cycle 1(1): loaded http://localhost:46693/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46693/tests/kraken/driver.html?testName=audio-oscillator) 02:22:39 INFO - PROCESS | 30643 | RSS: Main: 164864000 02:22:39 INFO - PROCESS | 30643 | 02:22:42 INFO - PROCESS | 30643 | Cycle 1(1): loaded http://localhost:46693/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46693/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:22:42 INFO - PROCESS | 30643 | RSS: Main: 165646336 02:22:42 INFO - PROCESS | 30643 | 02:22:45 INFO - PROCESS | 30643 | Cycle 1(1): loaded http://localhost:46693/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46693/tests/kraken/driver.html?testName=imaging-darkroom) 02:22:46 INFO - PROCESS | 30643 | RSS: Main: 164827136 02:22:46 INFO - PROCESS | 30643 | 02:22:49 INFO - PROCESS | 30643 | Cycle 1(1): loaded http://localhost:46693/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46693/tests/kraken/driver.html?testName=imaging-desaturate) 02:22:50 INFO - PROCESS | 30643 | RSS: Main: 167821312 02:22:50 INFO - PROCESS | 30643 | 02:22:53 INFO - PROCESS | 30643 | Cycle 1(1): loaded http://localhost:46693/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46693/tests/kraken/driver.html?testName=json-parse-financial) 02:22:53 INFO - PROCESS | 30643 | RSS: Main: 167444480 02:22:53 INFO - PROCESS | 30643 | 02:22:55 INFO - PROCESS | 30643 | Cycle 1(1): loaded http://localhost:46693/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46693/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:22:56 INFO - PROCESS | 30643 | RSS: Main: 183406592 02:22:56 INFO - PROCESS | 30643 | 02:22:58 INFO - PROCESS | 30643 | Cycle 1(1): loaded http://localhost:46693/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46693/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:22:58 INFO - PROCESS | 30643 | RSS: Main: 178114560 02:22:58 INFO - PROCESS | 30643 | 02:23:00 INFO - PROCESS | 30643 | Cycle 1(1): loaded http://localhost:46693/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46693/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:23:01 INFO - PROCESS | 30643 | RSS: Main: 187920384 02:23:01 INFO - PROCESS | 30643 | 02:23:03 INFO - PROCESS | 30643 | Cycle 1(1): loaded http://localhost:46693/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46693/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:23:04 INFO - PROCESS | 30643 | RSS: Main: 195051520 02:23:04 INFO - PROCESS | 30643 | 02:23:07 INFO - PROCESS | 30643 | Cycle 1(1): loaded http://localhost:46693/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46693/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:23:07 INFO - PROCESS | 30643 | RSS: Main: 193925120 02:23:07 INFO - PROCESS | 30643 | 02:23:09 INFO - PROCESS | 30643 | Cycle 1(1): loaded http://localhost:46693/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46693/tests/kraken/driver.html?testName=ai-astar) 02:23:09 INFO - PROCESS | 30643 | RSS: Main: 251002880 02:23:09 INFO - PROCESS | 30643 | 02:23:09 INFO - PROCESS | 30643 | __start_tp_report 02:23:09 INFO - PROCESS | 30643 | _x_x_mozilla_page_load 02:23:09 INFO - PROCESS | 30643 | _x_x_mozilla_page_load_details 02:23:09 INFO - PROCESS | 30643 | |i|pagename|runs| 02:23:09 INFO - PROCESS | 30643 | |0;ai-astar;114;115;109;115;114;114;114;114;106;114 02:23:09 INFO - PROCESS | 30643 | |1;audio-beat-detection;157;129;151;167;136;151;152;140;168;130 02:23:09 INFO - PROCESS | 30643 | |2;audio-dft;160;161;161;160;162;161;162;162;163;163 02:23:09 INFO - PROCESS | 30643 | |3;audio-fft;72;71;102;98;71;72;71;109;98;73 02:23:09 INFO - PROCESS | 30643 | |4;audio-oscillator;97;98;133;98;97;98;134;99;97;133 02:23:09 INFO - PROCESS | 30643 | |5;imaging-gaussian-blur;109;110;110;109;109;109;109;109;110;109 02:23:09 INFO - PROCESS | 30643 | |6;imaging-darkroom;147;147;148;147;147;147;148;147;147;147 02:23:09 INFO - PROCESS | 30643 | |7;imaging-desaturate;97;97;97;96;97;97;96;95;96;96 02:23:09 INFO - PROCESS | 30643 | |8;json-parse-financial;68;69;67;68;68;70;69;69;77;66 02:23:09 INFO - PROCESS | 30643 | |9;json-stringify-tinderbox;67;68;68;69;68;69;69;69;69;69 02:23:09 INFO - PROCESS | 30643 | |10;stanford-crypto-aes;82;85;84;85;84;85;84;84;84;89 02:23:09 INFO - PROCESS | 30643 | |11;stanford-crypto-ccm;136;143;125;127;128;120;121;121;120;123 02:23:09 INFO - PROCESS | 30643 | |12;stanford-crypto-pbkdf2;152;139;158;149;157;136;152;151;150;149 02:23:09 INFO - PROCESS | 30643 | |13;stanford-crypto-sha256-iterative;71;70;70;71;71;70;71;72;69;69 02:23:09 INFO - PROCESS | 30643 | __end_tp_report 02:23:09 INFO - PROCESS | 30643 | __start_cc_report 02:23:09 INFO - PROCESS | 30643 | _x_x_mozilla_cycle_collect,1010 02:23:09 INFO - PROCESS | 30643 | __end_cc_report 02:23:09 INFO - PROCESS | 30643 | __startTimestamp1453198989724__endTimestamp 02:23:09 INFO - PROCESS | 30643 | 02:23:09 INFO - PROCESS | 30643 | ------- Summary: start ------- 02:23:09 INFO - PROCESS | 30643 | Number of tests: 14 02:23:09 INFO - PROCESS | 30643 | 02:23:09 INFO - PROCESS | 30643 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:2.96 (2.6%) stddev-sans-first:3.11 02:23:09 INFO - PROCESS | 30643 | Values: 114.0 115.0 109.0 115.0 114.0 114.0 114.0 114.0 106.0 114.0 02:23:09 INFO - PROCESS | 30643 | 02:23:09 INFO - PROCESS | 30643 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:151.50 stddev:14.02 (9.3%) stddev-sans-first:14.50 02:23:09 INFO - PROCESS | 30643 | Values: 157.0 129.0 151.0 167.0 136.0 151.0 152.0 140.0 168.0 130.0 02:23:09 INFO - PROCESS | 30643 | 02:23:09 INFO - PROCESS | 30643 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 02:23:09 INFO - PROCESS | 30643 | Values: 160.0 161.0 161.0 160.0 162.0 161.0 162.0 162.0 163.0 163.0 02:23:09 INFO - PROCESS | 30643 | 02:23:09 INFO - PROCESS | 30643 | [#3] audio-fft Cycles:10 Average:83.70 Median:72.00 stddev:15.83 (22.0%) stddev-sans-first:16.22 02:23:09 INFO - PROCESS | 30643 | Values: 72.0 71.0 102.0 98.0 71.0 72.0 71.0 109.0 98.0 73.0 02:23:09 INFO - PROCESS | 30643 | 02:23:09 INFO - PROCESS | 30643 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:97.50 stddev:17.22 (17.7%) stddev-sans-first:17.76 02:23:09 INFO - PROCESS | 30643 | Values: 97.0 98.0 133.0 98.0 97.0 98.0 134.0 99.0 97.0 133.0 02:23:09 INFO - PROCESS | 30643 | 02:23:09 INFO - PROCESS | 30643 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 02:23:09 INFO - PROCESS | 30643 | Values: 109.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 02:23:09 INFO - PROCESS | 30643 | 02:23:09 INFO - PROCESS | 30643 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 02:23:09 INFO - PROCESS | 30643 | Values: 147.0 147.0 148.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 02:23:09 INFO - PROCESS | 30643 | 02:23:09 INFO - PROCESS | 30643 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 02:23:09 INFO - PROCESS | 30643 | Values: 97.0 97.0 97.0 96.0 97.0 97.0 96.0 95.0 96.0 96.0 02:23:09 INFO - PROCESS | 30643 | 02:23:09 INFO - PROCESS | 30643 | [#8] json-parse-financial Cycles:10 Average:69.10 Median:69.00 stddev:3.00 (4.3%) stddev-sans-first:3.15 02:23:09 INFO - PROCESS | 30643 | Values: 68.0 69.0 67.0 68.0 68.0 70.0 69.0 69.0 77.0 66.0 02:23:09 INFO - PROCESS | 30643 | 02:23:09 INFO - PROCESS | 30643 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.71 (1.0%) stddev-sans-first:0.50 02:23:09 INFO - PROCESS | 30643 | Values: 67.0 68.0 68.0 69.0 68.0 69.0 69.0 69.0 69.0 69.0 02:23:09 INFO - PROCESS | 30643 | 02:23:09 INFO - PROCESS | 30643 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.50 stddev:1.78 (2.1%) stddev-sans-first:1.62 02:23:09 INFO - PROCESS | 30643 | Values: 82.0 85.0 84.0 85.0 84.0 85.0 84.0 84.0 84.0 89.0 02:23:09 INFO - PROCESS | 30643 | 02:23:09 INFO - PROCESS | 30643 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:126.00 stddev:7.63 (6.1%) stddev-sans-first:7.26 02:23:09 INFO - PROCESS | 30643 | Values: 136.0 143.0 125.0 127.0 128.0 120.0 121.0 121.0 120.0 123.0 02:23:09 INFO - PROCESS | 30643 | 02:23:09 INFO - PROCESS | 30643 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.30 Median:151.50 stddev:6.96 (4.6%) stddev-sans-first:7.31 02:23:09 INFO - PROCESS | 30643 | Values: 152.0 139.0 158.0 149.0 157.0 136.0 152.0 151.0 150.0 149.0 02:23:09 INFO - PROCESS | 30643 | 02:23:09 INFO - PROCESS | 30643 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:71.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 02:23:09 INFO - PROCESS | 30643 | Values: 71.0 70.0 70.0 71.0 71.0 70.0 71.0 72.0 69.0 69.0 02:23:09 INFO - PROCESS | 30643 | -------- Summary: end -------- 02:23:09 INFO - PROCESS | 30643 | 02:23:10 INFO - TEST-INFO | 30643: exit 0 02:23:10 INFO - TEST-OK | kraken | took 60082ms 02:23:10 INFO - TEST-START | v8_7 02:23:10 INFO - operating with platform_type : linux_ 02:23:10 INFO - Initialising browser for v8_7 test... 02:23:10 INFO - TEST-INFO | started process 30889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQgoIcQ/profile http://localhost:46693/getInfo.html) 02:23:14 INFO - PROCESS | 30889 | __metrics Screen width/height:1600/1200 02:23:14 INFO - PROCESS | 30889 | colorDepth:24 02:23:14 INFO - PROCESS | 30889 | Browser inner width/height: 1024/697 02:23:14 INFO - PROCESS | 30889 | __metrics 02:23:14 INFO - PROCESS | 30889 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:23:14 INFO - PROCESS | 30889 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:23:15 INFO - TEST-INFO | 30889: exit 0 02:23:15 INFO - Browser initialized. 02:23:15 INFO - Running cycle 1/1 for v8_7 test... 02:23:15 INFO - TEST-INFO | started process 30969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQgoIcQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:23:27 INFO - PROCESS | 30969 | RSS: Main: 150175744 02:23:27 INFO - PROCESS | 30969 | 02:23:49 INFO - PROCESS | 30969 | Cycle 1(1): loaded http://localhost:46693/tests/v8_7/run.html (next: http://localhost:46693/tests/v8_7/run.html) 02:23:50 INFO - PROCESS | 30969 | RSS: Main: 448954368 02:23:50 INFO - PROCESS | 30969 | 02:23:50 INFO - PROCESS | 30969 | __start_tp_report 02:23:50 INFO - PROCESS | 30969 | _x_x_mozilla_page_load 02:23:50 INFO - PROCESS | 30969 | _x_x_mozilla_page_load_details 02:23:50 INFO - PROCESS | 30969 | |i|pagename|runs| 02:23:50 INFO - PROCESS | 30969 | |0;Richards;170.35775127768312 02:23:50 INFO - PROCESS | 30969 | |1;DeltaBlue;188.25301204819277 02:23:50 INFO - PROCESS | 30969 | |2;Encrypt;278.1641168289291 02:23:50 INFO - PROCESS | 30969 | |3;Decrypt;5251.308900523561 02:23:50 INFO - PROCESS | 30969 | |4;RayTrace;2024.2914979757086 02:23:50 INFO - PROCESS | 30969 | |5;Earley;802.7265437048917 02:23:50 INFO - PROCESS | 30969 | |6;Boyer;12304.878048780487 02:23:50 INFO - PROCESS | 30969 | |7;RegExp;44434.782608695656 02:23:50 INFO - PROCESS | 30969 | |8;Splay;609.167671893848 02:23:50 INFO - PROCESS | 30969 | |9;NavierStokes;4840.579710144928 02:23:50 INFO - PROCESS | 30969 | __end_tp_report 02:23:50 INFO - PROCESS | 30969 | __startTimestamp1453199030055__endTimestamp 02:23:50 INFO - PROCESS | 30969 | 02:23:50 INFO - PROCESS | 30969 | ------- Summary: start ------- 02:23:50 INFO - PROCESS | 30969 | Number of tests: 10 02:23:50 INFO - PROCESS | 30969 | 02:23:50 INFO - PROCESS | 30969 | [#0] Richards Cycles:1 Average:170.36 Median:170.36 stddev:0.00 (0.0%) 02:23:50 INFO - PROCESS | 30969 | Values: 170.4 02:23:50 INFO - PROCESS | 30969 | 02:23:50 INFO - PROCESS | 30969 | [#1] DeltaBlue Cycles:1 Average:188.25 Median:188.25 stddev:0.00 (0.0%) 02:23:50 INFO - PROCESS | 30969 | Values: 188.3 02:23:50 INFO - PROCESS | 30969 | 02:23:50 INFO - PROCESS | 30969 | [#2] Encrypt Cycles:1 Average:278.16 Median:278.16 stddev:0.00 (0.0%) 02:23:50 INFO - PROCESS | 30969 | Values: 278.2 02:23:50 INFO - PROCESS | 30969 | 02:23:50 INFO - PROCESS | 30969 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 02:23:50 INFO - PROCESS | 30969 | Values: 5251.3 02:23:50 INFO - PROCESS | 30969 | 02:23:50 INFO - PROCESS | 30969 | [#4] RayTrace Cycles:1 Average:2024.29 Median:2024.29 stddev:0.00 (0.0%) 02:23:50 INFO - PROCESS | 30969 | Values: 2024.3 02:23:50 INFO - PROCESS | 30969 | 02:23:50 INFO - PROCESS | 30969 | [#5] Earley Cycles:1 Average:802.73 Median:802.73 stddev:0.00 (0.0%) 02:23:50 INFO - PROCESS | 30969 | Values: 802.7 02:23:50 INFO - PROCESS | 30969 | 02:23:50 INFO - PROCESS | 30969 | [#6] Boyer Cycles:1 Average:12304.88 Median:12304.88 stddev:0.00 (0.0%) 02:23:50 INFO - PROCESS | 30969 | Values: 12304.9 02:23:50 INFO - PROCESS | 30969 | 02:23:50 INFO - PROCESS | 30969 | [#7] RegExp Cycles:1 Average:44434.78 Median:44434.78 stddev:0.00 (0.0%) 02:23:50 INFO - PROCESS | 30969 | Values: 44434.8 02:23:50 INFO - PROCESS | 30969 | 02:23:50 INFO - PROCESS | 30969 | [#8] Splay Cycles:1 Average:609.17 Median:609.17 stddev:0.00 (0.0%) 02:23:50 INFO - PROCESS | 30969 | Values: 609.2 02:23:50 INFO - PROCESS | 30969 | 02:23:50 INFO - PROCESS | 30969 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 02:23:50 INFO - PROCESS | 30969 | Values: 4840.6 02:23:50 INFO - PROCESS | 30969 | -------- Summary: end -------- 02:23:50 INFO - PROCESS | 30969 | 02:23:50 INFO - TEST-INFO | 30969: exit 0 02:23:50 INFO - TEST-OK | v8_7 | took 40294ms 02:23:50 INFO - SUITE-END | took 1215s 02:23:51 INFO - Completed test suite (00:20:15) 02:23:51 INFO - Working with test: dromaeo_css 02:23:51 INFO - Generating results file: dromaeo_css 02:23:51 INFO - Working with test: kraken 02:23:51 INFO - Generating results file: kraken 02:23:51 INFO - javascript benchmark 02:23:51 INFO - Working with test: v8_7 02:23:51 INFO - Generating results file: v8_7 02:23:51 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:23:51 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 02:23:51 INFO - process_Request line: dromaeo_css 5953.99 graph.html#tests=[[72,203,35]] 02:23:51 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:23:51 INFO - process_Request line: kraken 1535.80 graph.html#tests=[[232,203,35]] 02:23:51 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:23:51 INFO - process_Request line: v8_7 18674.17 graph.html#tests=[[230,203,35]] 02:23:51 INFO - RETURN: dromaeo_css: 5953.99 02:23:51 INFO - RETURN: kraken: 1535.80 02:23:51 INFO - RETURN: v8_7: 18674.17 02:23:51 INFO - javascript benchmark 02:23:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2552.629868669043, 2620.6855177378716, 2625.6192852036465, 2636.4858852523753, 2638.947221055579, 4296.48442186938, 4389.890252743683, 4418.33724941259, 4446.199684056873, 4478.753668548233, 4348.565143485658, 4376.868693939187, 4400.185965596367, 4410.580994805488, 4497.685162038659, 4097.836086556549, 4103.753774773523, 4108.075682971323, 4120.052387950773, 4120.876373708794, 4080.0411903202726, 4110.095778928646, 4158.37624356346, 4162.188373267214, 4192.056787222866, 3932.8230229639594, 4003.259397011533, 4023.517177938637, 4082.81627326771, 4097.364908439196, 4062.0454193264854, 4069.0844559974066, 4072.6538244249273, 4111.218868414991, 4112.321466957948, 4055.797210139481, 4058.188362327546, 4058.7767672777986, 4068.4100805383055, 4087.509498860126, 4241.045764702948, 4282.036541778106, 4309.892252693708, 4322.654187664979, 4389.539098394686, 4635.258358662598, 4654.394928659286, 4658.161530924433, 4693.741844198567, 4699.506551812079, 4676.415448068991, 4679.251319788817, 4686.789094490756, 4722.338872557844, 4730.219513780256, 4283.0, 4328.458942632171, 4349.3475978603465, 4354.194474022316, 4384.934225986613, 4815.783289751969, 4834.105690447279, 4834.444038935568, 4859.271109333628, 4879.463259041502, 4626.467956185014, 4632.0, 4633.258678611406, 4663.067386522709, 4681.087187998308, 4531.274996000624, 4616.6075883550275, 4716.080364328923, 4718.669693121517, 4766.118268120409, 4567.954320456753, 4590.2426099693175, 4626.7223966562115, 4657.231556793091, 4671.906561868744, 4621.6764826462495, 4656.4877863434995, 4657.720536767804, 4661.417322834645, 4696.319033740157, 3911.159100793286, 3991.880243592697, 4000.139969906484, 4020.8592699255387, 4031.274370613318, 3436.7078798302423, 3492.1793378556017, 3492.4586689063235, 3513.982430087833, 3518.489818976234, 4097.631213190767, 4113.197926404382, 4118.567550407164, 4144.461220041375, 4160.50073991123, 4718.41019872516, 4723.716577005391, 4724.763761811896, 4732.98240878206, 4783.617310615143, 3986.900327491836, 4023.1752490739327, 4066.67466602677, 4076.0421300994244, 4160.687948403821, 4189.183109293719, 4190.937135942963, 4191.538930717618, 4193.853215137456, 4217.91564168721, 4449.555044495524, 4464.910701785946, 4470.865874023784, 4502.864914052584, 4506.3465797459185, 4565.223911935045, 4655.301704744315, 4655.976720116378, 4689.6248300136585, 4786.521347865186, 4455.2426087564545, 4459.843905463294, 4467.5755803198645, 4474.328850672425, 4489.887752806206, 4602.953970460387, 4604.907901842012, 4606.147862645421, 4612.907741845077, 4646.697964632288, 4543.45478542577, 4611.33135695329, 4627.62978961689, 4631.351610774427, 4694.647901407477, 4493.528179541232, 4503.369528266111, 4512.300593408027, 4513.052259025641, 4555.681102322806, 4499.662525310549, 4504.819807207806, 4506.41416615851, 4510.571495707903, 4550.2492088804975, 4347.521772604948, 4414.668899832461, 4421.579949904753, 4437.556244375537, 4525.570070843265, 4550.385697930737, 4577.633789296915, 4582.152301824173, 4602.838900638596, 4604.976975115103, 4477.283634618446, 4491.7754112293605, 4495.056038232008, 4496.482904466028, 4534.931976020296], "unit": "score", "name": "dojo.html", "value": 4318.65243683428}, {"lowerIsBetter": false, "replicates": [519.5817367019548, 543.0713479949287, 552.6131707804535, 552.7259666468788, 560.263253821225, 24156.87921560394, 36266.45600315994, 36481.81759091201, 36521.269574608494, 36584.45123323152, 38720.80639596805, 39349.21301573967, 39350.80324598373, 39376.40935385964, 39447.40828887569, 7735.690572377112, 7934.960325198366, 7938.563379014152, 7943.801404964894, 7948.125706172316, 7631.923680763204, 7763.728269510569, 7764.068311802592, 7768.766936991871, 7780.844383112334, 7744.38044956405, 7792.10390805059, 7827.295543401093, 7828.491148075385, 7830.843383132334, 7691.653875575613, 7764.883526747103, 7779.844403111906, 7780.649870755801, 7780.688772449095, 7657.387409007321, 7789.61051947406, 7792.181820908836, 7792.766217013499, 7794.0, 36132.63867361319, 36604.450933236025, 36637.267254655024, 36638.0, 36691.63308366909, 2944.9411011779644, 3210.871565137392, 3265.2489927316615, 3265.330607225513, 3301.339732053575, 27227.0, 27260.59109113345, 27466.862665686742, 27994.16017519478, 28205.29486762827, 3351.346487434951, 3358.697717205463, 3361.8151001694896, 3377.290768938526, 3523.4010218262956, 213824.0, 214397.0, 214466.0, 214637.0, 214804.0, 45171.0, 52478.737606311726, 52906.735466322425, 52938.94122117613, 52989.20516192183, 39734.006649833405, 60994.39005609976, 62545.0, 62587.68706156531, 62618.0607290891, 14976.0, 15260.618484537976, 15266.16036118002, 15274.694506109816, 15278.0, 9053.411528250643, 9071.637134514678, 10890.183236257313, 10945.179111566506, 11153.442327883735, 17590.384336548414, 18443.81556184421, 18551.16519756587, 18561.0, 18574.0, 6833.214180369222, 7151.106111736033, 7153.535020223773, 7170.498065135391, 7258.346748792528, 793.5754371411383, 805.287320721166, 907.8502047162144, 975.9414435133915, 1011.1354791653177, 24869.875650621994, 25973.870130649604, 25989.0, 26107.477850442883, 26126.477470450485, 915.3272444462186, 992.8510723391549, 994.9701508954743, 1054.372648274291, 1064.893510648929, 13383.531576394975, 13685.863141368658, 13688.818145642697, 13847.446102155802, 13983.37074831635, 255288.0, 258857.0, 259044.0, 259961.0, 260478.0, 45775.77112114418, 46087.76956115198, 46093.0, 46130.0, 46229.76885115553, 1160.7388337623968, 1166.4692564882957, 1170.5961443302047, 1173.5423184957874, 1183.721825371037, 24849.0, 25669.0, 25999.480010400064, 26423.603645944942, 26472.0, 40239.79880100581, 40330.59669403268, 40382.39426408665, 40481.797591011855, 40687.38968915528, 242947.0, 244078.0, 244256.0, 244854.0, 245627.0, 27725.72274277312, 27846.44307113887, 28222.343313353067, 28300.15099547017, 29161.125166245045, 33027.66972330246, 33029.50455743214, 33177.33645327032, 33923.66076339205, 33963.49054764131, 28229.858850705616, 28591.571126432704, 28820.135395938156, 29323.0, 29804.552931706476, 28966.13101606955, 29453.0, 30709.0, 31510.21224469315, 32232.35535289328, 29030.564541531472, 30060.24849378783, 30110.548341774454, 30166.547501787052, 30218.0, 25722.742772572783, 26360.0, 28562.285942851595, 29781.851090745273, 32113.51829722509, 22458.42791004614, 22689.0, 22870.313890583308, 22927.312180634606, 23031.88484057569], "unit": "score", "name": "ext.html", "value": 16406.71118446971}, {"lowerIsBetter": false, "replicates": [299.8066247270509, 324.2071345459608, 324.39840857437247, 324.7239846130789, 330.9685579869913, 11370.658880233595, 14682.41270349186, 14978.925105374485, 16056.27746751396, 16129.112898790561, 13761.31193440329, 13811.0, 14381.712365752679, 14407.207603581799, 15247.61880952974, 4348.630366418858, 4563.338315944186, 4567.817287308504, 4567.931481027787, 4569.337446070318, 4383.956160438387, 4449.199144154051, 4461.709988850731, 4463.821447142111, 4588.426446694163, 4985.576226020793, 4995.526319735687, 4997.375328083989, 5007.0486607544635, 5011.072951503965, 4631.930521042187, 4893.828715994923, 4922.3354847095725, 4973.278874563186, 4984.327115839352, 4515.954840451619, 4683.2975053741875, 4718.363020992157, 4722.456917454502, 4726.338312636233, 10189.745256368577, 10400.32397894142, 10441.530131144116, 10460.11089057431, 10462.163026957902, 1757.8154293799096, 1821.5537193387704, 1866.412080194748, 1894.232835701543, 1991.9900400497904, 8372.41393102483, 8457.53483558404, 9334.01992790754, 9342.813143737087, 11996.340201288926, 1666.1169580122555, 1666.3251383189827, 1734.7051001329805, 1751.7109676903424, 1754.3421217043608, 48732.0, 50207.24689129666, 51643.74178129123, 52055.73972130115, 52086.0, 8090.312323452455, 8560.272376847914, 8756.474611523328, 8946.747455356255, 9208.90791092094, 10344.741381465523, 10714.571417143383, 10810.891891080988, 10822.621208257673, 10829.0, 6762.459003279726, 6943.826404339831, 6946.270641582662, 6962.756303529352, 7014.894776578355, 6923.376896079377, 6936.93063069373, 6978.406835419046, 6985.161780586261, 6995.230524642286, 3748.4002559590335, 3826.6938644908896, 3845.0195200224325, 3850.614938506127, 3866.5360156781367, 1544.637010302578, 1594.226800001998, 1595.0828273742413, 1605.7189991751397, 1609.332127167236, 812.8821320908553, 847.2163248994656, 863.6847550644095, 915.2632131134368, 977.3793641037992, 14318.57044288673, 14388.712225755426, 16363.345466181458, 16443.0, 16676.33294668224, 749.5802350683525, 839.504692231574, 913.862920561921, 931.2736065868634, 944.4994153098869, 7792.493487923267, 8329.0, 8575.099614540384, 8586.356023298278, 9179.862302065474, 451711.0, 452593.0, 456648.0, 461092.5016748509, 466217.0, 48053.27920081132, 58878.0, 61072.38927610667, 61279.0, 64129.679351603874, 1015.5988384588046, 1035.7048241251207, 1041.8176819056634, 1045.4720366215165, 1047.7433028907967, 13713.382897769823, 13914.304284785518, 13948.721025579634, 14331.641708957359, 14332.785008224677, 26366.945322186897, 27355.589666154625, 27513.17460476189, 27532.311692207855, 27771.44457110806, 32259.838700806347, 32429.0, 32479.0, 32648.0, 32899.177520562174, 5863.560232982458, 6061.696915154136, 6177.073438984188, 6223.719932602953, 6253.9362010537325, 7634.236576342321, 9419.811603768023, 9487.956324804403, 9640.180584650103, 9785.461799601091, 8429.578521074045, 8462.280706140047, 8550.700725474579, 8574.142585741376, 8625.439346442461, 7908.3673306136525, 8665.39342246062, 8758.562071896253, 9151.771205719644, 9295.581698823435, 8887.9559800292, 8986.32602554824, 9007.63969441215, 9201.171894529256, 9249.12133347331, 6317.778877739257, 6337.2395312562785, 6412.6793660317735, 6445.236455119867, 6517.608943463408, 7586.544807311579, 8691.652333906573, 8869.73390798277, 8933.553322333988, 8955.910440895508], "unit": "score", "name": "jquery.html", "value": 7130.570648429467}, {"lowerIsBetter": false, "replicates": [1230.501646833033, 1360.9792655508368, 1377.6004958562019, 1472.9926350368246, 1685.3090233004464, 5934.406559344064, 6079.361667024965, 6639.668016599175, 6755.324467553242, 6830.453563714903, 6753.290904455023, 6770.830729231771, 6793.422559082472, 6798.592084474935, 6802.14973128359, 1765.5144835170302, 1814.4193857965456, 2081.510844951435, 2105.799949004842, 2106.220698341616, 2065.2771529964466, 2130.052126803573, 2130.084063852543, 2130.6271402504576, 2132.3070002249333, 2053.6485723846263, 2063.566651003291, 2071.5339048713995, 2086.4992401823606, 2086.4992401823606, 2046.94882627934, 2053.0863765624226, 2053.301877361704, 2056.8251698605486, 2061.5361543652707, 2055.6094342074957, 2067.1008111471556, 2068.2761033638108, 2073.5645514441985, 2075.6575165097893, 7039.788806335818, 7067.43460523157, 7071.717131314741, 7088.787336379917, 7100.076989991319, 3933.724639275252, 3986.4219688145345, 4011.2178125265586, 4015.036391266104, 4025.2955732746946, 2539.149384956042, 2648.284963059963, 2655.9907235250676, 2656.8405895646324, 2678.1429942418436, 842.6713581703141, 873.807762292301, 877.1316396767219, 1738.3394310162184, 1764.1796564597523, 9010.14403631654, 9113.954430227872, 9118.361714679975, 9132.589033493508, 9133.08669133088, 3534.9823250884097, 3595.658412450813, 3647.6899463545365, 3648.3068217038676, 3654.086478380405, 7545.471816972759, 7547.320741133324, 7553.660085296175, 7554.43341749371, 7566.432517561095, 4111.1366613011605, 4117.155983023473, 4150.211459822624, 4161.2509748245, 4165.97917010413, 3841.5390153181797, 3841.654251117413, 3842.8270727817317, 3845.3270677631303, 3851.1334949636666, 2784.7911406644175, 2813.563897595876, 3043.8782448702245, 3067.2945222598482, 3073.969260307413, 916.3310783128354, 917.4816228830689, 917.8393781088416, 918.4351623751345, 920.2316066084894, 878.4026861733954, 878.6997229861905, 897.52879738138, 897.9595918183697, 1122.0742887117997, 6703.329667033355, 6726.428253598499, 6735.595864248161, 6736.966315168491, 6737.562058466184, 1021.4790456867051, 1038.7697940867845, 1041.1982773264544, 1069.983950240747, 1072.1369297715257, 5080.339555857789, 5151.974240128776, 5156.432792392834, 5162.483751624883, 5164.25118357836, 8153.6738530458115, 8258.298044666271, 8283.95858020706, 8380.413371063967, 8422.578871056423, 8391.370647201484, 8397.412181147261, 8423.410361274775, 8446.61990210442, 8465.111163327761, 6526.41262286406, 6547.836304092436, 6648.900266496006, 6665.133532640726, 6690.732370705117, 6394.0408938659575, 6432.0, 6438.484921206198, 6464.5798023128345, 6470.644114573555, 7018.824529386806, 7165.462590305644, 7191.20896701352, 7520.623968801648, 7566.583837888969, 7161.928380716335, 7379.557226566423, 7384.778456646309, 7420.888686669597, 7484.738034168996, 6004.279486461653, 6118.357572454828, 6118.724657390339, 6122.724477398617, 6123.0, 5499.450054994469, 5568.248286481273, 6303.747850085945, 6539.0, 6585.539012269095, 6205.069239614094, 6228.937710622836, 6242.781502647385, 6303.779367722108, 6410.903836442364, 6055.031195008777, 6169.876602468015, 6190.071489276645, 6313.55805093639, 6323.494120470444, 6132.356102609162, 6151.0773383992755, 6183.319834818257, 6308.842278943063, 6359.96820015897, 5662.320521537442, 5689.914651280317, 5721.113227449752, 5756.597038207453, 5785.045467497984, 5862.765489380377, 5863.618864773776, 5882.23530940975, 5885.558583106199, 5891.970540147272], "unit": "score", "name": "mootools.html", "value": 3973.066424954802}, {"lowerIsBetter": false, "replicates": [283.31296605731103, 286.351414047183, 292.08722741433024, 293.8795094011456, 295.14555362226366, 5291.4708529147065, 5293.073712100377, 5295.549878260348, 5331.360236771583, 5411.972940135303, 5294.973525132378, 5354.464553544643, 5380.757865896035, 5388.272583201267, 5388.838334849951, 4089.5092588889224, 4090.468239128909, 4094.1811637672436, 4096.73371230869, 4103.9794801025955, 3844.615538446147, 3906.8241929113115, 3957.2679054375035, 3997.1406147678244, 4024.557298697141, 3945.5857135000842, 3980.6417422431973, 4016.799160042001, 4017.0158311213795, 4020.7386519876113, 3771.6039815819217, 3873.6513713765617, 3972.165845172517, 3978.3435733104, 3995.021219801138, 3384.4754063120254, 3456.1359660084977, 3456.2741824216946, 3470.444728843398, 3471.7222622190166, 5093.745312734349, 5105.617078719074, 5137.101007323741, 5143.948560514385, 5154.278401023859, 4631.62946964242, 4635.11932732783, 4640.721556706575, 4642.396488456479, 4644.512326205733, 5467.617266791326, 5596.3284405871555, 5599.608027438081, 5599.776008959637, 5604.439556044404, 3788.3370410178386, 3797.0886987123167, 3800.220954704279, 3801.7718936863876, 3806.6764325032404, 5840.357560668365, 5912.733926973297, 5917.881642367129, 5920.940790592082, 5925.4963328117165, 3884.1843212925037, 3885.106425522146, 3885.9805700971315, 3887.5723670396233, 3890.183061557105, 3938.7242892997215, 3941.7437866538585, 3945.763254204757, 3946.9145984854395, 3948.348522493814, 4462.062966776948, 4599.333096701027, 4607.815687372535, 4608.746518941423, 4609.078184363141, 5619.297587801525, 5627.268455100811, 5627.971860140673, 5631.042722737145, 5631.831045068655, 1375.5048182654436, 1393.909395889264, 1394.17743531317, 1395.7557427450358, 1395.9232242226774, 913.1872633356318, 918.1736437206434, 924.699472671371, 935.5649622925372, 939.4034787909726, 4960.727160006234, 4968.056069346812, 4972.179590367621, 4980.576650984634, 4992.825251116194, 5873.735681894325, 5875.177475153482, 5880.617759845682, 5880.94119058804, 5884.6469211847425, 4958.7024778513405, 4960.479149689303, 4964.205727083649, 4965.3048573199785, 4968.453470118284, 3036.316828713566, 3068.2789544457037, 3141.8114913105287, 3162.5572419861237, 3166.1134882233014, 5407.432219616883, 5432.212329212242, 5503.2020357048, 5520.475554822286, 5526.778928842801, 6027.7890273841085, 6047.3045599755715, 6059.0608455689435, 6090.9390906090375, 6137.815865524041, 5586.608937374426, 5594.720263986866, 5599.440055994368, 5600.747966341606, 5604.766951270714, 5676.943230567642, 5884.382139875423, 5885.911711324248, 5900.64596124234, 5908.7045647718305, 5753.424657534213, 5765.827025189251, 5768.480836724715, 5769.394213607511, 5771.278590176228, 5594.216809646571, 5595.328560572594, 5598.664080155204, 5598.916016259841, 5609.186667933209, 3769.7172712047254, 3867.41988701697, 3901.5708272090615, 3902.512185976753, 3907.3552863778295, 5855.2095467113095, 5865.794697185578, 5903.468687818117, 5925.4370834770625, 5937.7921772737745, 5598.944010559842, 5600.047991841316, 5606.579506536945, 5611.438856114356, 5612.354579223278, 5590.8043218487155, 5592.664440133605, 5596.300462442195, 5596.776128954796, 5599.32808063035, 5330.413654497925, 5447.918281225864, 5454.400015998158, 5455.809046683347, 5461.290032295776, 5666.490015898589, 5667.3765885753355, 5672.773089076556, 5677.034904066401, 5677.574181936288, 5518.889622207453, 5539.19681646151, 5540.833774986757, 5541.833744987657, 5557.610967232416], "unit": "score", "name": "prototype.html", "value": 4170.951828521679}, {"lowerIsBetter": false, "replicates": [660.3000819131719, 699.6152116336017, 713.119297667381, 733.9504508552769, 771.8726410142327, 10929.781404371917, 11003.17476189285, 11010.559577616907, 11016.228863979524, 11039.668809935705, 10289.948550257257, 10331.948340258288, 10349.068583827455, 10353.223508236875, 10373.0, 591.0985746736219, 600.6996501749126, 748.120957874498, 754.4077898849405, 762.6263131065765, 777.4363586399871, 778.9688412463495, 782.3662833105175, 782.7651704488659, 783.0094929913664, 812.7114874219656, 814.7067055859885, 817.7015389382863, 819.172635638004, 820.1552401026952, 626.1015442839517, 635.5741653092439, 796.2555011064674, 812.7236739508536, 813.0893399392718, 595.0924839619614, 599.6192417814675, 599.865030368168, 600.2197143713155, 600.5555888642417, 9998.350107243006, 10013.749656258578, 10059.245556583212, 10060.0, 10095.545700443497, 10728.463576821207, 11019.393933333664, 11161.0, 11161.944190278997, 11204.21570490066, 9307.255419566418, 9313.534323283877, 9524.190443812284, 9585.0, 9606.66376676813, 3182.9204269893207, 3219.2917558137174, 3231.4021905947475, 3257.7719559630837, 3323.501474778778, 37768.43347349792, 37824.24351512954, 37907.43138852919, 37923.241535169414, 38374.80812595947, 8667.913320866837, 8868.467891926504, 8893.199612034818, 9197.022640132403, 9240.630374784932, 15152.31814568347, 15216.163111029, 15227.695446091016, 15242.771358429633, 15278.923605382124, 6215.720292586754, 6342.714577843916, 6385.042243663488, 6432.195975503062, 6489.1888513935755, 3397.2016576104597, 3454.4990976308295, 3460.5155278261063, 3477.8956631301103, 3540.1149712571855, 2541.1995221505167, 2541.7204107548155, 2546.503431830812, 2551.668283123219, 2568.7174410814796, 444.45110288793313, 449.7054429348782, 450.3537423796862, 454.4183445190162, 458.86234129760936, 552.7567870137127, 554.4621716934568, 562.1343131577325, 565.6945249565189, 601.3535449391921, 6949.513534052669, 7390.29792169743, 7438.442116841258, 7912.643931023003, 8227.506349619041, 464.7729992818961, 484.9030193961222, 487.2763945540869, 512.6155383462403, 577.9164067373674, 3477.3740726669444, 3492.371373152806, 3515.1036485695986, 3610.1335679436747, 3621.7102631789394, 41599.0, 44996.55003449923, 45480.0, 45619.0, 45685.7715711426, 36398.8180059098, 36449.81775091161, 36760.63239367626, 37516.43725344067, 37634.247315053544, 34183.82908085443, 34295.65704342975, 34397.0, 34811.0, 34935.825320873744, 7339.431238965426, 7612.657430415756, 7624.085109786861, 7773.650185741542, 7925.881111783443, 27423.45153096887, 27858.0, 27958.44083118367, 28213.294667633472, 28420.715792841806, 34308.31383372368, 34365.0, 34643.0, 37228.62771372252, 37431.25137497289, 8832.337574681796, 8838.911610883808, 8931.642734290555, 8999.685011024583, 9080.909190908007, 10046.949765251127, 10200.948995254976, 10205.84691229647, 10247.0, 10632.0, 8501.617427215913, 8574.485530868167, 8577.228049475578, 8609.973018886929, 8853.468791872509, 9118.133777291147, 9147.0, 9201.217896478875, 9619.134277914742, 9820.165285950774, 9962.501874906371, 10071.244656650928, 10102.39385636864, 10129.59481620727, 10134.645287414905, 8490.660373584988, 8576.356773241907, 8601.741947741577, 8657.91342086571, 8731.476111433334, 8441.620127094418, 8816.51509167002, 8830.690925817566, 8850.822983540163, 8885.0], "unit": "score", "name": "yui.html", "value": 5320.456592730652}], "name": "dromaeo_css", "value": 5953.991618122885}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 115.0, 109.0, 115.0, 114.0, 114.0, 114.0, 114.0, 106.0, 114.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [157.0, 129.0, 151.0, 167.0, 136.0, 151.0, 152.0, 140.0, 168.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.1}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 160.0, 162.0, 161.0, 162.0, 162.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 102.0, 98.0, 71.0, 72.0, 71.0, 109.0, 98.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.7}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 133.0, 98.0, 97.0, 98.0, 134.0, 99.0, 97.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 96.0, 97.0, 97.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 68.0, 68.0, 70.0, 69.0, 69.0, 77.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 69.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 84.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [136.0, 143.0, 125.0, 127.0, 128.0, 120.0, 121.0, 121.0, 120.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.4}, {"lowerIsBetter": true, "replicates": [152.0, 139.0, 158.0, 149.0, 157.0, 136.0, 152.0, 151.0, 150.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.3}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 70.0, 71.0, 71.0, 70.0, 71.0, 72.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1535.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [170.35775127768312], "unit": "score", "name": "Richards", "value": 207.22274000000007}, {"lowerIsBetter": false, "replicates": [188.25301204819277], "unit": "score", "name": "DeltaBlue", "value": 351.2188160000002}, {"lowerIsBetter": false, "replicates": [278.1641168289291], "unit": "score", "name": "Encrypt", "value": 956.9206949999998}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [2024.2914979757086], "unit": "score", "name": "RayTrace", "value": 365.55456600000014}, {"lowerIsBetter": false, "replicates": [802.7265437048917], "unit": "score", "name": "Earley", "value": 830.2491118881122}, {"lowerIsBetter": false, "replicates": [12304.878048780487], "unit": "score", "name": "Boyer", "value": 54.16250346878094}, {"lowerIsBetter": false, "replicates": [44434.782608695656], "unit": "score", "name": "RegExp", "value": 20.5016193737769}, {"lowerIsBetter": false, "replicates": [609.167671893848], "unit": "score", "name": "Splay", "value": 133.7743346534653}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 18674.168977006502}]} 02:23:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "18674.17"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1535.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "5953.99"}}} 02:23:51 INFO - Return code: 0 02:23:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:23:51 INFO - # TBPL SUCCESS # 02:23:51 INFO - Running post-action listener: _resource_record_post_action 02:23:51 INFO - Running post-run listener: _resource_record_post_run 02:23:52 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 8192; Write bytes: 559640576; Read time: 24; Write time: 438756 02:23:52 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246669312; Read time: 0; Write time: 231332 02:23:52 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 8192; Write bytes: 312971264; Read time: 24; Write time: 207424 02:23:52 INFO - Running post-run listener: _upload_blobber_files 02:23:52 INFO - Blob upload gear active. 02:23:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:23:52 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:23:52 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', 'B2G-Inbound-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:23:52 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 B2G-Inbound-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:23:52 INFO - (blobuploader) - INFO - Open directory for files ... 02:23:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:23:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:23:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:23:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:23:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:23:53 INFO - (blobuploader) - INFO - Done attempting. 02:23:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:23:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:23:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:23:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:23:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:23:54 INFO - (blobuploader) - INFO - Done attempting. 02:23:54 INFO - (blobuploader) - INFO - Iteration through files over. 02:23:54 INFO - Return code: 0 02:23:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:23:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:23:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/b1b2c23ba38ba45a9a8f9d0c0c9c10d33a16e55d0e8c6b6f19f5597d5dce448a9bedfb2a6e7d52b305de5704c73d7b3610b1514e9b54ea289199b362861b4c08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/31f070a041de77018e825ff6adc17c2d51eea31c3b391a799bffc4c0f30b71f6d96d4e2d0db824bd19c6305176322b820d5e499f12a15f30155699e834f2caaa"} 02:23:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:23:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:23:54 INFO - Contents: 02:23:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/b1b2c23ba38ba45a9a8f9d0c0c9c10d33a16e55d0e8c6b6f19f5597d5dce448a9bedfb2a6e7d52b305de5704c73d7b3610b1514e9b54ea289199b362861b4c08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/31f070a041de77018e825ff6adc17c2d51eea31c3b391a799bffc4c0f30b71f6d96d4e2d0db824bd19c6305176322b820d5e499f12a15f30155699e834f2caaa"} 02:23:54 INFO - Running post-run listener: copy_logs_to_upload_dir 02:23:54 INFO - Copying logs to upload dir... 02:23:54 INFO - mkdir: /builds/slave/test/build/upload/logs 02:23:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.837056 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-19 02:23:53.191103) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 02:23:53.197570) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/b1b2c23ba38ba45a9a8f9d0c0c9c10d33a16e55d0e8c6b6f19f5597d5dce448a9bedfb2a6e7d52b305de5704c73d7b3610b1514e9b54ea289199b362861b4c08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/31f070a041de77018e825ff6adc17c2d51eea31c3b391a799bffc4c0f30b71f6d96d4e2d0db824bd19c6305176322b820d5e499f12a15f30155699e834f2caaa"} build_url:https://queue.taskcluster.net/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/JkENlHHCQVCjrOpiqKT4SQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/b1b2c23ba38ba45a9a8f9d0c0c9c10d33a16e55d0e8c6b6f19f5597d5dce448a9bedfb2a6e7d52b305de5704c73d7b3610b1514e9b54ea289199b362861b4c08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound-Non-PGO/sha512/31f070a041de77018e825ff6adc17c2d51eea31c3b391a799bffc4c0f30b71f6d96d4e2d0db824bd19c6305176322b820d5e499f12a15f30155699e834f2caaa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 02:23:53.228798) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:23:53.230084) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453189843.910655-1632105848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 02:23:53.315141) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 02:23:53.315746) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 02:23:53.316291) ========= ========= Total master_lag: 0.30 =========