builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1452903098.14 results: success (0) buildid: 20160115151123 builduid: 00e01ac8d48b43099e15a5d1137e3745 revision: 9879757aa0d4f88df8c79cde4a777ac7eff0152f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:38.138038) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:38.138463) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:38.138759) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006377 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:38.166407) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:38.166726) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:38.192814) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:38.193108) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004593 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:38.260319) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:38.260605) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:38.260970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:38.261285) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 16:11:38-- 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% 43.3M=0s 2016-01-15 16:11:38 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098236 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:38.381635) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:38.382227) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017468 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:38.435771) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-15 16:11:38.436790) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9879757aa0d4f88df8c79cde4a777ac7eff0152f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9879757aa0d4f88df8c79cde4a777ac7eff0152f --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=82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 16:11:38,697 truncating revision to first 12 chars 2016-01-15 16:11:38,698 Setting DEBUG logging. 2016-01-15 16:11:38,698 attempt 1/10 2016-01-15 16:11:38,698 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9879757aa0d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 16:11:40,034 unpacking tar archive at: mozilla-central-9879757aa0d4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.669573 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-15 16:11:40.118839) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:40.122247) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.003953 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:40.175220) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:40.175511) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:40.186240) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:40.186603) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 16:11:40.187095) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-01-15 16:11:40.187373) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:11:40 INFO - MultiFileLogger online at 20160115 16:11:40 in /builds/slave/test 16:11:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:11:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:11:40 INFO - {'append_to_log': False, 16:11:40 INFO - 'base_work_dir': '/builds/slave/test', 16:11:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:11:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:11:40 INFO - 'branch': 'Firefox-Non-PGO', 16:11:40 INFO - 'buildbot_json_path': 'buildprops.json', 16:11:40 INFO - 'config_files': ('talos/linux_config.py',), 16:11:40 INFO - 'default_actions': ('clobber', 16:11:40 INFO - 'read-buildbot-config', 16:11:40 INFO - 'download-and-extract', 16:11:40 INFO - 'populate-webroot', 16:11:40 INFO - 'create-virtualenv', 16:11:40 INFO - 'install', 16:11:40 INFO - 'run-tests'), 16:11:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:11:40 INFO - 'download_minidump_stackwalk': True, 16:11:40 INFO - 'download_symbols': 'ondemand', 16:11:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:11:40 INFO - 'tooltool.py': '/tools/tooltool.py', 16:11:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:11:40 INFO - '/tools/misc-python/virtualenv.py')}, 16:11:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:11:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:11:40 INFO - 'installer_path': 'installer.exe', 16:11:40 INFO - 'log_level': 'info', 16:11:40 INFO - 'log_name': 'talos', 16:11:40 INFO - 'log_to_console': True, 16:11:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:11:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:11:40 INFO - 'opt_config_files': (), 16:11:40 INFO - 'pip_index': False, 16:11:40 INFO - 'sps_profile': False, 16:11:40 INFO - 'sps_profile_interval': 0, 16:11:40 INFO - 'suite': 'dromaeojs', 16:11:40 INFO - 'system_bits': '32', 16:11:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:11:40 INFO - 'title': 'talos-linux64-ix-066', 16:11:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:11:40 INFO - 'use_talos_json': True, 16:11:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:11:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:11:40 INFO - 'work_dir': 'build'} 16:11:40 INFO - ##### 16:11:40 INFO - ##### Running clobber step. 16:11:40 INFO - ##### 16:11:40 INFO - Running pre-action listener: _resource_record_pre_action 16:11:40 INFO - Running main action method: clobber 16:11:40 INFO - rmtree: /builds/slave/test/build 16:11:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:11:40 INFO - Running post-action listener: _resource_record_post_action 16:11:40 INFO - ##### 16:11:40 INFO - ##### Running read-buildbot-config step. 16:11:40 INFO - ##### 16:11:40 INFO - Running pre-action listener: _resource_record_pre_action 16:11:40 INFO - Running main action method: read_buildbot_config 16:11:40 INFO - Using buildbot properties: 16:11:40 INFO - { 16:11:40 INFO - "project": "", 16:11:40 INFO - "product": "firefox", 16:11:40 INFO - "script_repo_revision": "production", 16:11:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:11:40 INFO - "repository": "", 16:11:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 16:11:40 INFO - "buildid": "20160115151123", 16:11:40 INFO - "pgo_build": "False", 16:11:40 INFO - "basedir": "/builds/slave/test", 16:11:40 INFO - "buildnumber": 441, 16:11:40 INFO - "slavename": "talos-linux64-ix-066", 16:11:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:11:40 INFO - "platform": "ubuntu64_hw", 16:11:40 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:11:40 INFO - "branch": "mozilla-central", 16:11:40 INFO - "repo_path": "mozilla-central", 16:11:40 INFO - "revision": "9879757aa0d4f88df8c79cde4a777ac7eff0152f", 16:11:40 INFO - "stage_platform": "linux64", 16:11:40 INFO - "builduid": "00e01ac8d48b43099e15a5d1137e3745", 16:11:40 INFO - "slavebuilddir": "test" 16:11:40 INFO - } 16:11:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:11:40 INFO - Running post-action listener: _resource_record_post_action 16:11:40 INFO - ##### 16:11:40 INFO - ##### Running download-and-extract step. 16:11:40 INFO - ##### 16:11:40 INFO - Running pre-action listener: _resource_record_pre_action 16:11:40 INFO - Running main action method: download_and_extract 16:11:40 INFO - mkdir: /builds/slave/test/build/tests 16:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:40 INFO - https://queue.taskcluster.net/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/test_packages.json 16:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/test_packages.json 16:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:11:41 INFO - Downloaded 1448 bytes. 16:11:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:11:41 INFO - Using the following test package requirements: 16:11:41 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:11:41 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:11:41 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:11:41 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:41 INFO - u'jsshell-linux-x86_64.zip'], 16:11:41 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:11:41 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:11:41 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:11:41 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:11:41 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:11:41 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:11:41 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:11:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:11:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:11: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')]} 16:11:41 INFO - https://queue.taskcluster.net/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:11:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:11:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:11:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/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 16:11:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/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 16:11:46 INFO - Downloaded 21172379 bytes. 16:11:46 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'] 16:11:46 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 16:11:48 INFO - Return code: 0 16:11: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 16:11: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')]} 16:11:48 INFO - https://queue.taskcluster.net/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:11:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:11:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:11:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/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 16:11:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/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 16:11:50 INFO - Downloaded 21172379 bytes. 16:11: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'] 16:11: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 16:11:51 INFO - Return code: 0 16:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:51 INFO - https://queue.taskcluster.net/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:11:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:11:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:11:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/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 16:11:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/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 16:11:53 INFO - Downloaded 11132144 bytes. 16:11: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'] 16:11: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 16:11:54 INFO - Return code: 0 16:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:54 INFO - https://queue.taskcluster.net/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:11:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:11:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:11:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/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 16:11:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aro-i2jNSLuZZyiq6RbnZw/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 16:11:57 INFO - Downloaded 54125056 bytes. 16:11:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:11:57 INFO - mkdir: /builds/slave/test/properties 16:11:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:11:57 INFO - Writing to file /builds/slave/test/properties/build_url 16:11:57 INFO - Contents: 16:11:57 INFO - build_url:https://queue.taskcluster.net/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:11:57 INFO - Running post-action listener: _resource_record_post_action 16:11:57 INFO - Running post-action listener: set_extra_try_arguments 16:11:57 INFO - ##### 16:11:57 INFO - ##### Running populate-webroot step. 16:11:57 INFO - ##### 16:11:57 INFO - Running pre-action listener: _resource_record_pre_action 16:11:57 INFO - Running main action method: populate_webroot 16:11:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:11:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:11:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:11:57 INFO - '--tppagecycles', 16:11:57 INFO - '7'], 16:11:57 INFO - 'tests': ['tsvgm']}}, 16:11:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:11:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:11:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:11:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:11:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:11:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:11:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:57 INFO - 'talos_options': ['--e10s'], 16:11:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:57 INFO - 'tests': ['damp', 'tps']}, 16:11:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:57 INFO - 'talos_options': ['--e10s'], 16:11:57 INFO - 'tests': ['damp', 'tps']}, 16:11:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:11:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:11:57 INFO - 'other': {'tests': ['a11yr', 16:11:57 INFO - 'ts_paint', 16:11:57 INFO - 'tpaint', 16:11:57 INFO - 'sessionrestore', 16:11:57 INFO - 'sessionrestore_no_auto_restore']}, 16:11:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:11:57 INFO - 'tests': ['a11yr', 16:11:57 INFO - 'ts_paint', 16:11:57 INFO - 'tpaint', 16:11:57 INFO - 'sessionrestore', 16:11:57 INFO - 'sessionrestore_no_auto_restore']}, 16:11:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:11:57 INFO - 'tests': ['a11yr', 16:11:57 INFO - 'ts_paint', 16:11:57 INFO - 'tpaint', 16:11:57 INFO - 'sessionrestore', 16:11:57 INFO - 'sessionrestore_no_auto_restore']}, 16:11:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:11:57 INFO - 'tests': ['a11yr', 16:11:57 INFO - 'ts_paint', 16:11:57 INFO - 'tpaint', 16:11:57 INFO - 'sessionrestore', 16:11:57 INFO - 'sessionrestore_no_auto_restore']}, 16:11:57 INFO - 'other_l64': {'tests': ['a11yr', 16:11:57 INFO - 'ts_paint', 16:11:57 INFO - 'tpaint', 16:11:57 INFO - 'sessionrestore', 16:11:57 INFO - 'sessionrestore_no_auto_restore']}, 16:11:57 INFO - 'other_nol64': {'tests': ['a11yr', 16:11:57 INFO - 'ts_paint', 16:11:57 INFO - 'tpaint', 16:11:57 INFO - 'sessionrestore', 16:11:57 INFO - 'sessionrestore_no_auto_restore']}, 16:11:57 INFO - 'svgr': {'tests': ['tsvgx', 16:11:57 INFO - 'tsvgr_opacity', 16:11:57 INFO - 'tart', 16:11:57 INFO - 'tscrollx', 16:11:57 INFO - 'cart']}, 16:11:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:11:57 INFO - 'tests': ['tsvgx', 16:11:57 INFO - 'tsvgr_opacity', 16:11:57 INFO - 'tart', 16:11:57 INFO - 'tscrollx', 16:11:57 INFO - 'cart']}, 16:11:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:57 INFO - 'tests': ['tp5o']}, 16:11:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:57 INFO - 'talos_options': ['--e10s'], 16:11:57 INFO - 'tests': ['tp5o']}, 16:11:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:57 INFO - 'talos_options': ['--xperf_path', 16:11:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:57 INFO - 'tests': ['tp5n']}, 16:11:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:57 INFO - 'talos_options': ['--e10s', 16:11:57 INFO - '--xperf_path', 16:11:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:57 INFO - 'tests': ['tp5n']}}, 16:11:57 INFO - 'talos.zip': {'path': '', 16:11:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:11:57 INFO - Running post-action listener: _resource_record_post_action 16:11:57 INFO - ##### 16:11:57 INFO - ##### Running create-virtualenv step. 16:11:57 INFO - ##### 16:11:57 INFO - Running pre-action listener: _resource_record_pre_action 16:11:57 INFO - Running main action method: create_virtualenv 16:11:57 INFO - Creating virtualenv /builds/slave/test/build/venv 16:11:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:11:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:11:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:11:57 INFO - Using real prefix '/usr' 16:11:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:11:57 INFO - Installing distribute.............................................................................................................................................................................................done. 16:12:00 INFO - Installing pip.................done. 16:12:00 INFO - Return code: 0 16:12:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12: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')]} 16:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bc8774f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b653d0>, '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 0x2ad0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1360>, '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': '82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452', '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 16:12: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', 'pip>=1.5'] in /builds/slave/test/build 16:12: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 pip>=1.5 16:12:00 INFO - Using env: {'DISPLAY': ':0', 16:12:00 INFO - 'HOME': '/home/cltbld', 16:12:00 INFO - 'LANG': 'en_US.UTF-8', 16:12:00 INFO - 'LANGUAGE': 'en_US:en', 16:12:00 INFO - 'LOGNAME': 'cltbld', 16:12:00 INFO - 'MAIL': '/var/mail/cltbld', 16:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:00 INFO - 'MOZ_NO_REMOTE': '1', 16:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:00 INFO - 'NO_EM_RESTART': '1', 16:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:00 INFO - 'PWD': '/builds/slave/test', 16:12:00 INFO - 'SHELL': '/bin/bash', 16:12:00 INFO - 'SHLVL': '1', 16:12:00 INFO - 'TERM': 'linux', 16:12:00 INFO - 'TMOUT': '86400', 16:12:00 INFO - 'USER': 'cltbld', 16:12:00 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452', 16:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:00 INFO - '_': '/tools/buildbot/bin/python'} 16:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:12:00 INFO - Cleaning up... 16:12:00 INFO - Return code: 0 16:12:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12: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')]} 16:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12: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', '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 0x7f8bc8774f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b653d0>, '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 0x2ad0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1360>, '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': '82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452', '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 16:12: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', 'psutil>=0.7.1'] in /builds/slave/test/build 16:12: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 psutil>=0.7.1 16:12:00 INFO - Using env: {'DISPLAY': ':0', 16:12:00 INFO - 'HOME': '/home/cltbld', 16:12:00 INFO - 'LANG': 'en_US.UTF-8', 16:12:00 INFO - 'LANGUAGE': 'en_US:en', 16:12:00 INFO - 'LOGNAME': 'cltbld', 16:12:00 INFO - 'MAIL': '/var/mail/cltbld', 16:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:00 INFO - 'MOZ_NO_REMOTE': '1', 16:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:00 INFO - 'NO_EM_RESTART': '1', 16:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:00 INFO - 'PWD': '/builds/slave/test', 16:12:00 INFO - 'SHELL': '/bin/bash', 16:12:00 INFO - 'SHLVL': '1', 16:12:00 INFO - 'TERM': 'linux', 16:12:00 INFO - 'TMOUT': '86400', 16:12:00 INFO - 'USER': 'cltbld', 16:12:00 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452', 16:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:00 INFO - '_': '/tools/buildbot/bin/python'} 16:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:00 INFO - Downloading/unpacking psutil>=0.7.1 16:12: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 16:12: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 16:12: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 16:12: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 16:12: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 16:12: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 16:12:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:12:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:12:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:02 INFO - Installing collected packages: psutil 16:12:02 INFO - Running setup.py install for psutil 16:12:02 INFO - building 'psutil._psutil_linux' extension 16:12:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:12:03 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 16:12:03 INFO - building 'psutil._psutil_posix' extension 16:12:03 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 16:12:03 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 16:12:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:03 INFO - Successfully installed psutil 16:12:03 INFO - Cleaning up... 16:12:03 INFO - Return code: 0 16:12:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:12:03 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')]} 16:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:03 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')]} 16:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:03 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 0x7f8bc8774f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b653d0>, '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 0x2ad0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1360>, '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': '82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452', '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 16:12:03 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 16:12:03 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 16:12:03 INFO - Using env: {'DISPLAY': ':0', 16:12:03 INFO - 'HOME': '/home/cltbld', 16:12:03 INFO - 'LANG': 'en_US.UTF-8', 16:12:03 INFO - 'LANGUAGE': 'en_US:en', 16:12:03 INFO - 'LOGNAME': 'cltbld', 16:12:03 INFO - 'MAIL': '/var/mail/cltbld', 16:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:03 INFO - 'MOZ_NO_REMOTE': '1', 16:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:03 INFO - 'NO_EM_RESTART': '1', 16:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:03 INFO - 'PWD': '/builds/slave/test', 16:12:03 INFO - 'SHELL': '/bin/bash', 16:12:03 INFO - 'SHLVL': '1', 16:12:03 INFO - 'TERM': 'linux', 16:12:03 INFO - 'TMOUT': '86400', 16:12:03 INFO - 'USER': 'cltbld', 16:12:03 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452', 16:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:03 INFO - '_': '/tools/buildbot/bin/python'} 16:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:12:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:12:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:12:06 INFO - Installing collected packages: mozsystemmonitor 16:12:06 INFO - Running setup.py install for mozsystemmonitor 16:12:06 INFO - Successfully installed mozsystemmonitor 16:12:06 INFO - Cleaning up... 16:12:06 INFO - Return code: 0 16:12:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:12:06 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')]} 16:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:06 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')]} 16:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:06 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 0x7f8bc8774f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b653d0>, '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 0x2ad0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1360>, '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': '82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452', '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 16:12:06 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 16:12:06 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 16:12:06 INFO - Using env: {'DISPLAY': ':0', 16:12:06 INFO - 'HOME': '/home/cltbld', 16:12:06 INFO - 'LANG': 'en_US.UTF-8', 16:12:06 INFO - 'LANGUAGE': 'en_US:en', 16:12:06 INFO - 'LOGNAME': 'cltbld', 16:12:06 INFO - 'MAIL': '/var/mail/cltbld', 16:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:06 INFO - 'MOZ_NO_REMOTE': '1', 16:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:06 INFO - 'NO_EM_RESTART': '1', 16:12:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:06 INFO - 'PWD': '/builds/slave/test', 16:12:06 INFO - 'SHELL': '/bin/bash', 16:12:06 INFO - 'SHLVL': '1', 16:12:06 INFO - 'TERM': 'linux', 16:12:06 INFO - 'TMOUT': '86400', 16:12:06 INFO - 'USER': 'cltbld', 16:12:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452', 16:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:06 INFO - '_': '/tools/buildbot/bin/python'} 16:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:06 INFO - Downloading/unpacking blobuploader==1.2.4 16:12:06 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 16:12:06 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 16:12:06 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 16:12:06 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 16:12:06 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 16:12:06 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 16:12:08 INFO - Downloading blobuploader-1.2.4.tar.gz 16:12:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:12:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:12:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:12:09 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 16:12:09 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 16:12:09 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 16:12:09 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 16:12:09 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 16:12:09 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 16:12:09 INFO - Downloading docopt-0.6.1.tar.gz 16:12:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:12:09 INFO - Installing collected packages: blobuploader, requests, docopt 16:12:09 INFO - Running setup.py install for blobuploader 16:12:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:12:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:12:09 INFO - Running setup.py install for requests 16:12:09 INFO - Running setup.py install for docopt 16:12:09 INFO - Successfully installed blobuploader requests docopt 16:12:09 INFO - Cleaning up... 16:12:09 INFO - Return code: 0 16:12:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12: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')]} 16:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:09 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 0x7f8bc8774f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b653d0>, '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 0x2ad0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1360>, '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': '82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452', '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 16:12:09 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 16:12:09 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 16:12:09 INFO - Using env: {'DISPLAY': ':0', 16:12:09 INFO - 'HOME': '/home/cltbld', 16:12:09 INFO - 'LANG': 'en_US.UTF-8', 16:12:09 INFO - 'LANGUAGE': 'en_US:en', 16:12:09 INFO - 'LOGNAME': 'cltbld', 16:12:09 INFO - 'MAIL': '/var/mail/cltbld', 16:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:09 INFO - 'MOZ_NO_REMOTE': '1', 16:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:09 INFO - 'NO_EM_RESTART': '1', 16:12:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:09 INFO - 'PWD': '/builds/slave/test', 16:12:09 INFO - 'SHELL': '/bin/bash', 16:12:09 INFO - 'SHLVL': '1', 16:12:09 INFO - 'TERM': 'linux', 16:12:09 INFO - 'TMOUT': '86400', 16:12:09 INFO - 'USER': 'cltbld', 16:12:09 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452', 16:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:09 INFO - '_': '/tools/buildbot/bin/python'} 16:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:10 INFO - Running setup.py (path:/tmp/pip-9b5yCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:10 INFO - Running setup.py (path:/tmp/pip-awXQZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:10 INFO - Running setup.py (path:/tmp/pip-dMjKBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:10 INFO - Running setup.py (path:/tmp/pip-bTYNqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:10 INFO - Running setup.py (path:/tmp/pip-oe07dA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:10 INFO - Running setup.py (path:/tmp/pip-Fs5HI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:10 INFO - Running setup.py (path:/tmp/pip-RhIakG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:10 INFO - Running setup.py (path:/tmp/pip-srZSFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:10 INFO - Running setup.py (path:/tmp/pip-pvKB8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:10 INFO - Running setup.py (path:/tmp/pip-XSUDeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:10 INFO - Running setup.py (path:/tmp/pip-38Q2kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:10 INFO - Running setup.py (path:/tmp/pip-kbqJon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:10 INFO - Running setup.py (path:/tmp/pip-O0l5AM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:11 INFO - Running setup.py (path:/tmp/pip-A9W7Qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:11 INFO - Running setup.py (path:/tmp/pip-9QL4zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:11 INFO - Running setup.py (path:/tmp/pip-HGKiJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:11 INFO - Running setup.py (path:/tmp/pip-hnqG3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:12:11 INFO - Running setup.py install for manifestparser 16:12:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:12:11 INFO - Running setup.py install for mozcrash 16:12:11 INFO - Running setup.py install for mozdebug 16:12:11 INFO - Running setup.py install for mozdevice 16:12:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:12:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:12:11 INFO - Running setup.py install for mozfile 16:12:11 INFO - Running setup.py install for mozhttpd 16:12:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:12:11 INFO - Running setup.py install for mozinfo 16:12:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:12:12 INFO - Running setup.py install for mozInstall 16:12:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:12:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:12:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:12:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:12:12 INFO - Running setup.py install for mozleak 16:12:12 INFO - Running setup.py install for mozlog 16:12:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:12:12 INFO - Running setup.py install for moznetwork 16:12:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:12:12 INFO - Running setup.py install for mozprocess 16:12:12 INFO - Running setup.py install for mozprofile 16:12:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:12:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:12:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:12:12 INFO - Running setup.py install for mozrunner 16:12:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:12:12 INFO - Running setup.py install for mozscreenshot 16:12:12 INFO - Running setup.py install for moztest 16:12:12 INFO - Running setup.py install for mozversion 16:12:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:12:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:12:13 INFO - Cleaning up... 16:12:13 INFO - Return code: 0 16:12:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:13 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 0x7f8bc8774f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b653d0>, '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 0x2ad0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1360>, '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': '82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452', '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 16:12:13 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 16:12:13 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 16:12:13 INFO - Using env: {'DISPLAY': ':0', 16:12:13 INFO - 'HOME': '/home/cltbld', 16:12:13 INFO - 'LANG': 'en_US.UTF-8', 16:12:13 INFO - 'LANGUAGE': 'en_US:en', 16:12:13 INFO - 'LOGNAME': 'cltbld', 16:12:13 INFO - 'MAIL': '/var/mail/cltbld', 16:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:13 INFO - 'MOZ_NO_REMOTE': '1', 16:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:13 INFO - 'NO_EM_RESTART': '1', 16:12:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:13 INFO - 'PWD': '/builds/slave/test', 16:12:13 INFO - 'SHELL': '/bin/bash', 16:12:13 INFO - 'SHLVL': '1', 16:12:13 INFO - 'TERM': 'linux', 16:12:13 INFO - 'TMOUT': '86400', 16:12:13 INFO - 'USER': 'cltbld', 16:12:13 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452', 16:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:13 INFO - '_': '/tools/buildbot/bin/python'} 16:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:13 INFO - Running setup.py (path:/tmp/pip-88glBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:13 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)) 16:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:13 INFO - Running setup.py (path:/tmp/pip-SBT3qN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:13 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)) 16:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:13 INFO - Running setup.py (path:/tmp/pip-s20KG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:13 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)) 16:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:13 INFO - Running setup.py (path:/tmp/pip-iRx4Gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:13 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)) 16:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:13 INFO - Running setup.py (path:/tmp/pip-upDWIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:13 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)) 16:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:13 INFO - Running setup.py (path:/tmp/pip-uiTIW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:13 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)) 16:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:13 INFO - Running setup.py (path:/tmp/pip-q_E8vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:13 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)) 16:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:13 INFO - Running setup.py (path:/tmp/pip-B1E5fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:13 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)) 16:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:13 INFO - Running setup.py (path:/tmp/pip-fgSsEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:13 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)) 16:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:13 INFO - Running setup.py (path:/tmp/pip-lt3osl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:14 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)) 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:14 INFO - Running setup.py (path:/tmp/pip-ytf4JP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:14 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)) 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:14 INFO - Running setup.py (path:/tmp/pip-2lYSSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:14 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)) 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:14 INFO - Running setup.py (path:/tmp/pip-ZD_I8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:14 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)) 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:14 INFO - Running setup.py (path:/tmp/pip-ItDrIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:14 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)) 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:14 INFO - Running setup.py (path:/tmp/pip-m01ejw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:14 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)) 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:14 INFO - Running setup.py (path:/tmp/pip-uiQSEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:14 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)) 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:14 INFO - Running setup.py (path:/tmp/pip-LoSQ5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:14 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)) 16:12:14 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)) 16:12:14 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)) 16:12:14 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)) 16:12:14 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)) 16:12:14 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)) 16:12:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:12: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 16:12: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 16:12: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 16:12: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 16:12: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 16:12: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 16:12:16 INFO - Downloading blessings-1.5.1.tar.gz 16:12:16 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 16:12:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:12:16 INFO - Installing collected packages: blessings 16:12:16 INFO - Running setup.py install for blessings 16:12:16 INFO - Successfully installed blessings 16:12:16 INFO - Cleaning up... 16:12:16 INFO - Return code: 0 16:12:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:16 INFO - Reading from file tmpfile_stdout 16:12:16 INFO - Current package versions: 16:12:16 INFO - argparse == 1.2.1 16:12:16 INFO - blessings == 1.5.1 16:12:16 INFO - blobuploader == 1.2.4 16:12:16 INFO - docopt == 0.6.1 16:12:16 INFO - manifestparser == 1.1 16:12:16 INFO - mozInstall == 1.12 16:12:16 INFO - mozcrash == 0.16 16:12:16 INFO - mozdebug == 0.1 16:12:16 INFO - mozdevice == 0.48 16:12:16 INFO - mozfile == 1.2 16:12:16 INFO - mozhttpd == 0.7 16:12:16 INFO - mozinfo == 0.9 16:12:16 INFO - mozleak == 0.1 16:12:16 INFO - mozlog == 3.1 16:12:16 INFO - moznetwork == 0.27 16:12:16 INFO - mozprocess == 0.22 16:12:16 INFO - mozprofile == 0.28 16:12:16 INFO - mozrunner == 6.11 16:12:16 INFO - mozscreenshot == 0.1 16:12:16 INFO - mozsystemmonitor == 0.0 16:12:16 INFO - moztest == 0.7 16:12:16 INFO - mozversion == 1.4 16:12:16 INFO - psutil == 3.1.1 16:12:16 INFO - requests == 1.2.3 16:12:16 INFO - wsgiref == 0.1.2 16:12:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:16 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')]} 16:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:16 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')]} 16:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:16 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 0x7f8bc8774f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b653d0>, '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 0x2ad0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1360>, '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': '82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452', '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 16:12:16 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 16:12:16 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 16:12:16 INFO - Using env: {'DISPLAY': ':0', 16:12:16 INFO - 'HOME': '/home/cltbld', 16:12:16 INFO - 'LANG': 'en_US.UTF-8', 16:12:16 INFO - 'LANGUAGE': 'en_US:en', 16:12:16 INFO - 'LOGNAME': 'cltbld', 16:12:16 INFO - 'MAIL': '/var/mail/cltbld', 16:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:16 INFO - 'MOZ_NO_REMOTE': '1', 16:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:16 INFO - 'NO_EM_RESTART': '1', 16:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:16 INFO - 'PWD': '/builds/slave/test', 16:12:16 INFO - 'SHELL': '/bin/bash', 16:12:16 INFO - 'SHLVL': '1', 16:12:16 INFO - 'TERM': 'linux', 16:12:16 INFO - 'TMOUT': '86400', 16:12:16 INFO - 'USER': 'cltbld', 16:12:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452', 16:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:16 INFO - '_': '/tools/buildbot/bin/python'} 16:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:16 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)) 16:12:16 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)) 16:12:16 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)) 16:12:16 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)) 16:12:16 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)) 16:12:16 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)) 16:12:16 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)) 16:12:16 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)) 16:12:16 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)) 16:12:16 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)) 16:12:16 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)) 16:12:16 INFO - Cleaning up... 16:12:16 INFO - Return code: 0 16:12:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:12:16 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')]} 16:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:16 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')]} 16:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:16 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 0x7f8bc8774f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b653d0>, '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 0x2ad0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1360>, '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': '82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452', '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 16:12:16 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 16:12:16 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 16:12:16 INFO - Using env: {'DISPLAY': ':0', 16:12:16 INFO - 'HOME': '/home/cltbld', 16:12:16 INFO - 'LANG': 'en_US.UTF-8', 16:12:16 INFO - 'LANGUAGE': 'en_US:en', 16:12:16 INFO - 'LOGNAME': 'cltbld', 16:12:16 INFO - 'MAIL': '/var/mail/cltbld', 16:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:16 INFO - 'MOZ_NO_REMOTE': '1', 16:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:16 INFO - 'NO_EM_RESTART': '1', 16:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:16 INFO - 'PWD': '/builds/slave/test', 16:12:16 INFO - 'SHELL': '/bin/bash', 16:12:16 INFO - 'SHLVL': '1', 16:12:16 INFO - 'TERM': 'linux', 16:12:16 INFO - 'TMOUT': '86400', 16:12:16 INFO - 'USER': 'cltbld', 16:12:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452', 16:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:16 INFO - '_': '/tools/buildbot/bin/python'} 16:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:17 INFO - Downloading/unpacking jsonschema 16:12: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 16:12: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 16:12: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 16:12: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 16:12: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 16:12: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 16:12:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:12:18 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 16:12:18 INFO - Downloading/unpacking functools32 (from jsonschema) 16:12:18 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 16:12:18 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 16:12:18 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 16:12:18 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 16:12:18 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 16:12:18 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 16:12:19 INFO - Downloading functools32-3.2.3-2.tar.gz 16:12:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:12:19 INFO - warning: no files found matching '*.txt' 16:12:19 INFO - no previously-included directories found matching 'build' 16:12:19 INFO - no previously-included directories found matching 'dist' 16:12:19 INFO - no previously-included directories found matching '.git*' 16:12:19 INFO - Installing collected packages: jsonschema, functools32 16:12:19 INFO - Running setup.py install for functools32 16:12:19 INFO - warning: no files found matching '*.txt' 16:12:19 INFO - no previously-included directories found matching 'build' 16:12:19 INFO - no previously-included directories found matching 'dist' 16:12:19 INFO - no previously-included directories found matching '.git*' 16:12:19 INFO - Successfully installed jsonschema functools32 16:12:19 INFO - Cleaning up... 16:12:19 INFO - Return code: 0 16:12:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:12:19 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')]} 16:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:19 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')]} 16:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:19 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 0x7f8bc8774f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ad2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b653d0>, '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 0x2ad0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1360>, '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': '82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452', '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 16:12:19 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 16:12:19 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 16:12:19 INFO - Using env: {'DISPLAY': ':0', 16:12:19 INFO - 'HOME': '/home/cltbld', 16:12:19 INFO - 'LANG': 'en_US.UTF-8', 16:12:19 INFO - 'LANGUAGE': 'en_US:en', 16:12:19 INFO - 'LOGNAME': 'cltbld', 16:12:19 INFO - 'MAIL': '/var/mail/cltbld', 16:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:19 INFO - 'MOZ_NO_REMOTE': '1', 16:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:19 INFO - 'NO_EM_RESTART': '1', 16:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:19 INFO - 'PWD': '/builds/slave/test', 16:12:19 INFO - 'SHELL': '/bin/bash', 16:12:19 INFO - 'SHLVL': '1', 16:12:19 INFO - 'TERM': 'linux', 16:12:19 INFO - 'TMOUT': '86400', 16:12:19 INFO - 'USER': 'cltbld', 16:12:19 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452', 16:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:19 INFO - '_': '/tools/buildbot/bin/python'} 16:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:19 INFO - Downloading/unpacking flake8 16:12:19 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 16:12:19 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 16:12:19 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 16:12:19 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 16:12:19 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 16:12:19 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 16:12:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:12:21 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 16:12:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:12:21 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 16:12:21 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 16:12:21 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 16:12:21 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 16:12:21 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 16:12:21 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 16:12:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:12:21 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 16:12:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:12:21 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 16:12:21 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 16:12:21 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 16:12:21 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 16:12:21 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 16:12:21 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 16:12:21 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 16:12:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:12:21 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 16:12:21 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 16:12:21 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 16:12:21 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 16:12:21 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 16:12:21 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 16:12:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:12:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:12:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:12:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:12:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:12:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:12:21 INFO - no previously-included directories found matching 'docs/_build' 16:12:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:12:21 INFO - Running setup.py install for pep8 16:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:12:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:12:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:12:22 INFO - no previously-included directories found matching 'docs/_build' 16:12:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:12:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:12:22 INFO - Cleaning up... 16:12:22 INFO - Return code: 0 16:12:22 INFO - Running post-action listener: _resource_record_post_action 16:12:22 INFO - Running post-action listener: _start_resource_monitoring 16:12:22 INFO - Starting resource monitoring. 16:12:22 INFO - ##### 16:12:22 INFO - ##### Running install step. 16:12:22 INFO - ##### 16:12:22 INFO - Running pre-action listener: _resource_record_pre_action 16:12:22 INFO - Running main action method: install 16:12:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:22 INFO - Reading from file tmpfile_stdout 16:12:22 INFO - Detecting whether we're running mozinstall >=1.0... 16:12:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:12:22 INFO - Reading from file tmpfile_stdout 16:12:22 INFO - Output received: 16:12:22 INFO - Usage: mozinstall [options] installer 16:12:22 INFO - Options: 16:12:22 INFO - -h, --help show this help message and exit 16:12:22 INFO - -d DEST, --destination=DEST 16:12:22 INFO - Directory to install application into. [default: 16:12:22 INFO - "/builds/slave/test"] 16:12:22 INFO - --app=APP Application being installed. [default: firefox] 16:12:22 INFO - mkdir: /builds/slave/test/build/application 16:12:22 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'] 16:12:22 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 16:12:38 INFO - Reading from file tmpfile_stdout 16:12:38 INFO - Output received: 16:12:38 INFO - /builds/slave/test/build/application/firefox/firefox 16:12:38 INFO - Running post-action listener: _resource_record_post_action 16:12:38 INFO - ##### 16:12:38 INFO - ##### Running run-tests step. 16:12:38 INFO - ##### 16:12:38 INFO - Running pre-action listener: _resource_record_pre_action 16:12:38 INFO - Running main action method: run_tests 16:12:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:12:38 INFO - Python 2.7.3 16:12:38 INFO - Return code: 0 16:12:38 INFO - grabbing minidump binary from tooltool 16:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:12:38 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 0x2b653d0>, '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 0x2ad0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ad1360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:12:38 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 16:12:38 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 16:12:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:12:38 INFO - Return code: 0 16:12:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:12:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:12:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:12:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:12:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:12:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:12:39 INFO - Return code: 0 16:12:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 16:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 16:12:39 INFO - Using env: {'DISPLAY': ':0', 16:12:39 INFO - 'HOME': '/home/cltbld', 16:12:39 INFO - 'LANG': 'en_US.UTF-8', 16:12:39 INFO - 'LANGUAGE': 'en_US:en', 16:12:39 INFO - 'LOGNAME': 'cltbld', 16:12:39 INFO - 'MAIL': '/var/mail/cltbld', 16:12:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:12:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:39 INFO - 'MOZ_NO_REMOTE': '1', 16:12:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:39 INFO - 'NO_EM_RESTART': '1', 16:12:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:39 INFO - 'PWD': '/builds/slave/test', 16:12:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:12:39 INFO - 'SHELL': '/bin/bash', 16:12:39 INFO - 'SHLVL': '1', 16:12:39 INFO - 'TERM': 'linux', 16:12:39 INFO - 'TMOUT': '86400', 16:12:39 INFO - 'USER': 'cltbld', 16:12:39 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452', 16:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:39 INFO - '_': '/tools/buildbot/bin/python'} 16:12:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 16:12:39 INFO - mozversion application_buildid: 20160115151123 16:12:39 INFO - mozversion application_changeset: 9879757aa0d4f88df8c79cde4a777ac7eff0152f 16:12:39 INFO - mozversion application_display_name: Nightly 16:12:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:12:39 INFO - mozversion application_name: Firefox 16:12:39 INFO - mozversion application_remotingname: firefox 16:12:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:12:39 INFO - mozversion application_vendor: Mozilla 16:12:39 INFO - mozversion application_version: 46.0a1 16:12:39 INFO - mozversion platform_buildid: 20160115151123 16:12:39 INFO - mozversion platform_changeset: 9879757aa0d4f88df8c79cde4a777ac7eff0152f 16:12:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:12:39 INFO - mozversion platform_version: 46.0a1 16:12:39 INFO - using testdate: 1452903159 16:12:39 INFO - actual date: 1452903159 16:12:39 INFO - starting webserver on 'localhost:39321' 16:12:39 INFO - SUITE-START | Running 3 tests 16:12:39 INFO - TEST-START | dromaeo_css 16:12:39 INFO - operating with platform_type : linux_ 16:12:39 INFO - Initialising browser for dromaeo_css test... 16:12:39 INFO - TEST-INFO | started process 8990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwkCT9v/profile http://localhost:39321/getInfo.html) 16:12:44 INFO - PROCESS | 8990 | __metrics Screen width/height:1600/1200 16:12:44 INFO - PROCESS | 8990 | colorDepth:24 16:12:44 INFO - PROCESS | 8990 | Browser inner width/height: 1024/697 16:12:44 INFO - PROCESS | 8990 | __metrics 16:12:44 INFO - PROCESS | 8990 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:12:44 INFO - PROCESS | 8990 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:12:45 INFO - TEST-INFO | 8990: exit 0 16:12:45 INFO - Browser initialized. 16:12:45 INFO - Running cycle 1/1 for dromaeo_css test... 16:12:45 INFO - TEST-INFO | started process 9087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwkCT9v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:57 INFO - PROCESS | 9087 | RSS: Main: 149520384 16:12:57 INFO - PROCESS | 9087 | 16:13:48 INFO - PROCESS | 9087 | 1452903228734 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] 16:16:00 INFO - PROCESS | 9087 | Cycle 1(1): loaded http://localhost:39321/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39321/tests/dromaeo/cssquery-ext.html) 16:16:01 INFO - PROCESS | 9087 | RSS: Main: 252768256 16:16:01 INFO - PROCESS | 9087 | 16:19:03 INFO - PROCESS | 9087 | Cycle 1(1): loaded http://localhost:39321/tests/dromaeo/cssquery-ext.html (next: http://localhost:39321/tests/dromaeo/cssquery-jquery.html) 16:19:04 INFO - PROCESS | 9087 | RSS: Main: 223207424 16:19:04 INFO - PROCESS | 9087 | 16:22:06 INFO - PROCESS | 9087 | Cycle 1(1): loaded http://localhost:39321/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39321/tests/dromaeo/cssquery-mootools.html) 16:22:07 INFO - PROCESS | 9087 | RSS: Main: 231899136 16:22:07 INFO - PROCESS | 9087 | 16:25:09 INFO - PROCESS | 9087 | Cycle 1(1): loaded http://localhost:39321/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39321/tests/dromaeo/cssquery-prototype.html) 16:25:09 INFO - PROCESS | 9087 | RSS: Main: 211050496 16:25:09 INFO - PROCESS | 9087 | 16:28:12 INFO - PROCESS | 9087 | Cycle 1(1): loaded http://localhost:39321/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39321/tests/dromaeo/cssquery-yui.html) 16:28:13 INFO - PROCESS | 9087 | RSS: Main: 188649472 16:28:13 INFO - PROCESS | 9087 | 16:31:15 INFO - PROCESS | 9087 | Cycle 1(1): loaded http://localhost:39321/tests/dromaeo/cssquery-yui.html (next: http://localhost:39321/tests/dromaeo/cssquery-dojo.html) 16:31:15 INFO - PROCESS | 9087 | RSS: Main: 261197824 16:31:15 INFO - PROCESS | 9087 | 16:31:15 INFO - PROCESS | 9087 | __start_tp_report 16:31:15 INFO - PROCESS | 9087 | _x_x_mozilla_page_load 16:31:15 INFO - PROCESS | 9087 | _x_x_mozilla_page_load_details 16:31:15 INFO - PROCESS | 9087 | |i|pagename|runs| 16:31:15 INFO - PROCESS | 9087 | |0;dojo.html;2567.7303883092277;2600.2589262060314;2633.4338117304787;2640.339915021245;2659.2554084856242;4358.259095953687;4463.933041004388;4485.977570112145;4491.258942274525;4522.773861306934;4437.2013037653205;4471.463424389078;4498.32525121232;4519.322101684741;4561.133384656921;4100.343944968806;4115.588441155883;4132.214879172962;4179.728317659357;4216.894577635569;4009.6992725545556;4087;4155.709100362976;4188.287991041515;4211.8525851595205;4078.5105787305415;4114.732542384735;4115.444415003996;4141.937870931938;4145.564715704868;4090.5704900985265;4100.835966561334;4103.4460347853255;4137.2552940470705;4151.294279972412;4019.718619696622;4092.877213683594;4097.078157414588;4115.300398932189;4146.1914926589325;4296.935545966813;4314.460692413449;4363.716358436692;4435.379046933432;4466.709663871838;4711.411073615798;4734.171519983989;4740.051989602093;4779.259214821674;4785.234362502018;4655.511171326996;4750.71495710255;4750.952490475085;4755.548222918817;4788.880277993043;4390.670699697535;4419.646428285761;4458.152950939311;4489.865304040884;4491.169133710208;4860.465348811628;4862.197737373364;4865.0756356292195;4865.343178670834;4875.683080599821;4656.5110663379855;4656.95343046572;4658.604018658384;4706.88232794176;4706.905861882743;4620.861374158781;4678.111158879802;4682.906341873144;4687.437507499122;4755.334253204554;4732.384789977281;4736.431628204568;4736.550027747358;4753.524647535219;4778.235482322812;4691.108689349013;4698.95301046992;4703.270992996091;4713.6936099153445;4745.335653008581;3911.413288006822;3930.8820735377985;3976.4631774710624;3979.721419500607;3990.521137463523;3520.77114987525;3548.1129717570607;3549.5208146900354;3560.038789526865;3575.535180426528;4128.02991297045;4128.587141285908;4130.277201489727;4133.111381053088;4173.582641735802;4608.9308660370125;4688.976555117202;4691.061787642485;4694.201985662446;4778.784954677048;4112.732672376286;4121.216968775923;4143.212789569972;4150;4170.332746760504;4222.915541689211;4250.341197114452;4254.7021708480725;4273.764942928106;4283.400323954649;4436.86689399312;4463;4522.615577675934;4523.2988886722615;4541.409616749801;4776.23580227162;4785.162596545521;4795.496472870438;4805.183118869731;4838.395200599925;4548.11311794197;4549.567791059844;4554.681172317906;4559.863204103882;4602.723836569682;4546.318052292183;4598.655100867381;4632.073585283024;4634.76826158684;4713.0338280651695;4769.046190761931;4782.952170478251;4785.162596545521;4805.447373552086;4829.492903245108;4632.791524381343;4635.490096089495;4636.629069674351;4638.049199914077;4684.320773487893;4513.074819661896;4524.434445694288;4591.540845915381;4591.908161836812;4626.32918226862;4525.751083690297;4540.205464043713;4556.726596404226;4568.4974652787505;4598.954010459986;4644.930326045044;4656.045510670372;4660.953390466052;4670.556297151765;4698.882527936692;4417.580329868786;4463.04044630406;4464.732116073046;4473.776311184492;4554.88612784683 16:31:15 INFO - PROCESS | 9087 | |1;ext.html;502.8189851653406;514.6474664854575;519.8310549071552;532.0104605433895;537.6559002238566;24614.507709845813;25094.623580646305;25777.871110644443;26096.73903260967;26228.737712622868;35436.468452973226;35537.82231088841;35867.64132358676;35877.82061089691;35914;7483.775486735407;7778.261065198825;7778.299953004229;7782.18287079857;7786.1435242123325;7528.849423011564;7666.923330766676;7678.692852285902;7681.539107653531;7685.03937007874;7659.923400766004;7741.690332386698;7915.920840791605;7923.524588524678;7937.801554961144;7808.531488110703;7888.723894663688;7892.408069394818;7916;7921.049474063092;7789.415793815429;7916.366690664733;7923.762287131395;7930.088039875431;7930.563818989954;36182.45726314108;36643.81678091619;36665.45001824948;36665.633343666756;36698.26603467942;2692.0846912049997;2731.412746259564;2773.8751756171023;2820.774338052951;2823.731745484176;26392.472150557074;26782.19653410401;27323.180304590893;27400.58899116515;27432.314192145157;3322.900312990614;3494.458358954341;3506.08841701157;3511.736619753503;3615.8915232542804;206363;210111;211339;211464;211777;46636.7668161657;53556.73221633945;54050;54070.45929540733;54081.1887821683;40627.59372406297;64471;66047.66976165089;66258.66870665616;66303;10962.232643714864;11109.388983605979;11136.109111271078;11137.276077054965;11167.218294719292;7302.087239095114;7420.406367490587;7934.404919631051;8172.305354044854;8202;17698.380556680455;17847.821521784877;17919.641607167785;18056.09719514019;18088.819111808978;7246.275372462712;7487;7629.934202309178;7707;7712.537247765152;778.497868874584;815.2703330519153;881.3169793410159;890.3900827932887;899.6086702284528;25815.354616134373;25902.481950361263;27237.591436128474;28335.773839763337;28580.428391432055;835.7868743470498;843.7131375332293;859.2009431229017;881.2201201936333;983.4640121133999;11927.940360298317;12659.746805063847;12684.936575317064;12733.917617002659;12878.742425151631;299560;304643;304868;304952;305842;46812.531874681496;47121.76439117782;47192.29211561829;47287.29069063967;47310;1114.9442527873573;1126.1722633864267;1131.9151063670092;1145.238416453066;1145.856767904012;23779.765918865916;24102.07183425357;24598;24832.50334993326;24856.254312370656;33611.83194084014;34158.31683366269;34309.31381372408;34427.13932151716;34881.825590871886;211483;244825.7758711195;244931;245055;245647;22927.656085158404;24749.876250618632;25229.24312270635;25289.62065569055;25462.23613291604;27669.031583894466;27817;27833.304167395978;27963.440731184855;28021.57967630528;27507.31231719223;27886.3028424291;27938.16185514438;28041;28269;27552.58671119975;27957.72042279551;27966;28158.85920570384;33231.66768332382;26747.741487144158;26777.33056673599;29031.419371612028;29627.703722963357;30137.547936781404;26193.189770659385;27955.58066629043;28044.579331310455;28170.43659126847;28973.710262897945;21196;21407.46481337979;21612.243571474923;22111.88944055334;23436.296911092693 16:31:15 INFO - PROCESS | 9087 | |2;jquery.html;327.23590416377755;332.9910371574131;333.9148517128132;334.89450822990773;336.03222718570515;11687.5909343173;12127;14239.857601423995;14786.556403307904;15219.619509512253;13632.386542605582;13830.446782128703;13936.163830170171;13957.023008389417;14378.06542574732;4513.961788788581;4703.106409782139;4811.783469743852;4946.826861059863;4974.10466116099;4776.880577985544;4872.123017856784;4873.195922672755;4873.805047798101;4874.878128046792;4670.1126785910565;4852.29641701953;4911.533404326601;4911.631627627924;4913.803447862081;4720.504347043562;4758.333833263346;4763.69036012658;4766.976165119169;4773.140834649762;4599.885002874921;4783.1868582341085;4783.210770222909;4793.5925446337105;4795.112904112715;10650.786984260349;13329.666758331023;16964.830351696448;17665.911670441696;17685.823141768546;1622.7160246956735;1676.1200369805827;1711.2299465240692;1796.694561924476;1807.1957978699484;8270.627821748036;8545.27365173961;8555.700550480766;11400.429978501124;11865.940670296679;1633.232380781031;1708.1288542843115;1736.513776142682;1760.8239176082418;1804.170081762391;48570.514294856956;49636;50001;50203.24695129576;50601.49398506005;8173.550454724928;9087.681931132378;9145.176934075966;9169.220616247694;9234.81530369389;9707.854382184272;9904.801903961881;10781.784364312827;11762.176647634755;11889.227200231957;5855.736491857877;5972.492338151305;6006.819795406057;6086.330503644595;6140.17107690456;5517.972410137923;5560.165975103767;5563.082091454865;5567.053600887859;5573.41479144692;3963.524377074712;4023.396490526386;4058.2086493134148;4082.755034697928;4093.3246014407887;1572.4024870549347;1620.3437607768872;1634.8528632423138;1636.8444997725196;1645.983540164607;671.7245929169018;701.242657929435;750.4484204109975;824.5135370131651;838.5807096451774;13777.517786877412;14743.926280368743;15206.923965380101;15233.314500847488;15320.15739134336;755.5908231148868;764.1594246329105;774.8643987302199;791.6279348706099;831.5218749219223;6893.965530172417;8207.7948051298;8571.785705357415;8800.207981281716;8892.61578461628;431017;434395;437800;437951;439652;60032.39967600355;63015.054774178425;63167.68416157982;63324.05013924795;64098.679506603105;916.6837441082815;986.5215370545279;1025.825609646362;1037.4138611684223;1041.250299784154;13669.521566745514;13699.178049317074;13813.723725525635;13825.723485530434;14145.363458644591;29625.703742962294;29657.43968693773;30824.38351232918;31148.377032459677;31620.209494762814;36400.81799590985;39970.800145999085;40899.38650920298;42138.7893060545;42296.788516057226;5838.562107842014;6298.968505157445;6300.306966233802;6329.430351268408;6443.581167224115;6562.639054851838;9298.163165315154;9502.572384242587;9692.95153524256;9699.515024248618;7633.847323053619;7744.2642948919765;8035.758927232192;8043;8104.2300981409035;8000.879986800319;8018.558979256197;8304.916950830657;8380.916190838014;8511.361647876558;6421.422072013354;7659.851022346693;7867.645955931882;8031.317338026333;8115.9188408117525;6216.564840461305;6248.0940263660605;6292.748290068346;6308.274548426806;6370.904436433365;7297.854042919218;7568.924310756822;7819.1398946117015;8212.958935205525;8265 16:31:15 INFO - PROCESS | 9087 | |3;mootools.html;1171.3791690404078;1300.6098170548837;1377.5867239828053;1450.1444147952707;1664.39249673869;5980.88038239235;6172.22847144107;6658.733650653968;6804.979253112036;6813.659317034141;6932.8266793330195;6933.375996160345;6993.475489338294;7000.579965202091;7013.403860671836;1739.1478175693946;1793.3723196881117;2075.5537559424683;2097.423208617635;2102.632039393108;2048.5902819436096;2104.2424727098232;2109.915603375863;2110.4090854560745;2112.2818241797786;1984.65268577999;2018.9091490882872;2028.3306508852118;2033.1257559249516;2038.164352615428;2035.653938830395;2037.633226019316;2039.39837747864;2040.1941233212947;2041.9387418377398;2009.1461129020108;2061.2167376397024;2064.6283668939586;2069.048237810609;2070.089160769272;7018.298170182992;7058.047163632895;7071.222165561784;7079.256678048782;7085.822854428629;3896.4350169225304;4005.759654420744;4009.599040095967;4030.4760381150554;4033.8588149414923;2521.7856482199036;2530.367408147963;2653.7478939500716;2682.752520078173;2692.4749673813612;775.6121939030485;1576.5822057154862;1584.9762253566205;1669.1487341455822;1722.2511079749338;9550.235981121494;9731.65939192132;9748;9752.512374381253;9761.414315141114;3641.198936234024;3644.3986742187244;3644.872429464956;3714.1271801126713;3714.665680088805;7697.229637183479;7705.537667739954;7722.53664780115;7723.691052357843;7725.575093369806;3994.5406278277787;4021.658159056513;4022.5172979242093;4025.597440255951;4029.7783621901076;3724.2365315110337;3727.9254414912093;3730.9067273318383;3734.178480734234;3734.2158146788934;2790.581412788098;2825.3784167483122;2980.569326723185;3014.1861697341596;3022.3955208958296;923.5613083785282;930.0467021303218;931.0596297739332;945.9290553208399;949.378157306965;795.244517708168;813.4427916876958;814.9918500815035;836.9707060252983;850.9531975741394;6399.680015999182;6435.806925792233;6436.098946147543;6441.935580644227;6446.226452825597;967.264878692199;968.4409794006996;987.9407235565889;995.4475266227313;996.5515518016921;4963.6277279204205;5020.949790502048;5028.120078986163;5031.647784655039;5111.514406131486;8040.437169398203;8377.49735015901;8378.12029736881;8444.78888027792;8597.097304783032;8367.95816020916;8574;8581.95709021451;8585.656573737106;8593.44142630727;6584.308647591934;6608.140941677551;6627.602343859384;6684.598924064571;6685.53201275906;6057.394260574084;6131.356207598316;6166.753329866934;6173.444390004921;6180.567360284737;7374.151972523014;7393.482456228013;7647.235276472308;7654.923450765644;7656.9234307658435;7910.248526389983;7964.800879978047;8008.239217274349;8013.719519816778;8020.358371330163;5882.764689412375;6017.2779266488305;6024.5481588881885;6029.87940241184;6043.456088952015;5581.330240371181;5697.572682048946;6415.133956915756;6454.0641606967665;6477.838054048687;5249.238860365149;6014.278286605635;6081.847953801191;6107.755689772359;6328.177336946167;6065.120557519223;6074.51403887679;6151.538634602333;6231.937680623136;6320.273168585672;6128.693565321805;6178.042403427476;6181.041938499539;6181.35095814933;6185.907211391923;5531.3362396512675;5651.321841378896;5677.659340439587;5681.4034526374135;5682.687452190169;5473.31583552056;5514.228008078952;5528.336599608073;5533.391326954113;5536.363318218457 16:31:15 INFO - PROCESS | 9087 | |4;prototype.html;280.6646057960737;284.19147525290555;288.37710545222325;291.09614646522544;294.1997766076272;5163.483651634835;5291.338582677161;5307.071262529056;5322.840314790553;5365.248865158881;5234.241035049916;5266.104762190427;5274.077036518613;5277.445868183833;5291.68249905005;4019.618136277049;4021.095253567953;4030;4036.2734707752666;4041.535223449297;3778.3765678663126;3850.0374906273432;3924.62716041977;3986.4418981342637;4004.1991601679633;3959.6634286085573;3961.2869683456966;3969.6427321541055;3980.2835489611857;3983.063979964706;3720.6651401374006;3852.6339997700175;3972.503437070366;3986.1429792594586;3986.302397080514;3359.5968483781858;3408.84660190292;3422.640622734627;3424.178197232671;3433.570803649544;5038.168702164176;5056.494350564951;5060.5951523878;5062.215356619729;5064.746762661852;4556.248219043887;4559.316102584606;4561.521040290755;4566.13243483737;4567.908641827178;5301.973490132525;5454.91817622736;5479.835604931818;5488.4785945335125;5489.6980666063355;3698.1863989922176;3708.313961917054;3710.9814450927843;3739.5325584301963;3740.7942563159017;5747.59766816323;5817.767289308465;5820.796272130455;5820.854478638025;5823.67969761663;3818.5608655004476;3825.6556909877686;3826.1773718650625;3829.061879839457;3833.271678381099;3873.6126387361037;3890.591487893787;3893.610638936084;3902.9804850975565;3907.1794923066473;4355.5426680198125;4444.577765112309;4452.354408610733;4454.888627784331;4527.750973696412;5458.590605704588;5460.235567020621;5494.313210848644;5503.504684578327;5513.365962914316;1340.7050448901225;1362.455017992791;1369.7739872920856;1369.9520516781865;1370.6847425092085;903.9231665308391;911.9270458363447;912.9224015958717;928.4522131942186;928.8513837785922;4869.63477739171;4874.683145595525;4879.585235255043;4880.8779780505065;4881.755912204447;5747.051736463521;5757.827265182052;5760.049591817303;5761.683107429131;5762.30852297727;4864.221724524059;4866.659333846667;4871.415430148405;4875.0493653737185;4879.56083952446;3009.6689364169924;3056.9847150764103;3089.1350421881907;3092.876284948622;3095.5511450839504;5421.701806400686;5424.7016414096815;5433.538149257357;5435.103207970719;5440.4287549807495;5871.647701137946;5877.735501902424;5878.676672782953;5883.294004719461;5898.233229680114;5424.321959755031;5429.728513574306;5432.103702889058;5432.75552600134;5435.510804027656;5595.132754423071;5715.514181294637;5724.198612194379;5727.770889164387;5734.168545560954;5599.468050535193;5602.775888964396;5605.32736071674;5607.299087614048;5609.719514024201;5424.945750542444;5428.728563571726;5428.918566221589;5430;5430.864228394322;3763.7929913855;3861.7296789224483;3862.517185351831;3863.5750067493113;3865.574786773509;5714.628549144292;5715.257016587817;5717.113847353667;5718.771249149988;5719.313682357977;5506.807261745819;5508.283923090133;5514.448555144453;5514.558835293247;5516.475934786189;5511.779528818963;5513.531349835149;5519.172124181245;5520.447955204448;5526.723663816712;5249.553787928069;5381.838544843661;5387.730613469389;5388.919166212431;5390.13757798766;5336.359636843604;5530.364008139116;5534.612577119563;5537.944620553904;5543.916841247304;5343.145096784496;5346.0911645021215;5455.236266922713;5462.91805622908;5465.37148227943 16:31:15 INFO - PROCESS | 9087 | |5;yui.html;671.3018460800768;671.946244300456;694.5728377048115;699.5452955578874;725.3109545931367;10840.349579025264;12114.81827772583;12165.270083794956;12233.632991010261;12239.571614993478;10976.506057227423;11351.545938162464;11360.60237891674;11390.54437822486;11394.829077563843;462.9120467111238;736.9520981136209;747.6523416611275;749.6401727170961;749.8687729647318;606.5026678123941;752.086215248473;765.5980610179672;766.5285849202728;767.1599598439727;801.7033697531922;806.052887856766;809.7570728781371;810.2586133687669;810.4124509730427;621.1459243540132;630.7949916277182;781.2421950707861;800.5076877720219;803.04036676172;591.3081694417542;592.1236569876606;592.1413949772847;592.4312659846553;594.8245267646055;10484.161267098614;10507.73730656732;10545.73635659107;10554.947225263824;10560.155187585051;10538.625370727932;10775.572047308851;10937.343759374464;11015.944920275348;11154.163437742121;8717.956410217908;8854.424462409987;8992.190702836711;9006.234470070052;9342.486163261017;3144.2296637324002;3152.4168028914723;3178.539111828772;3197.4244635965515;3259.951100733491;40618;40739.7963010186;40768.38847417291;41077.58922410767;41120.58879411197;8943.195112439782;9086.909130908738;9130.771730706785;9156.90117185942;9207.493587852732;13863.029587928748;13902.721945561032;13924.443022278996;13930.58208253754;13930.86069139316;5912.23140991677;5979;6088.6042407243385;6187.3503282155625;6325.335839736854;3520.718342532591;3576.088097535112;3584.211473475831;3593.82030898454;3700.962990370062;2502.749725027483;2527.696676398844;2528.860912649785;2531.873406329713;2535.4168541235617;434.5024946436313;440.4560367945585;452.9796159172845;456.68032377335334;464.79084412014055;430.87719999799907;457.6796242630172;491.97540122993706;502.38207005383583;503.42358000089695;6635;6773.051772751819;6822.522423430312;6896.2069362023;7137.89293160603;449.4202478802308;483.7798801545288;492.2616075886171;522.1775703267369;534.5029122915726;3083.321669232765;3239.5642934629027;3266.085496061059;3306.9575990089174;3316.369889720945;44715.329270060975;45368;45491.31763023557;45522.317165242544;45584.77207613941;39488.21023579512;39706.60293397087;40254.39618405726;40687.79656101701;40762.79618601888;16601.41895033668;16603.584910377096;16767.916160419365;16822;16917.91541042287;6254.781082662085;6310.936890631035;6415.486761059197;6493.545451818327;6767.93232067673;27684.58473122945;28366.85816570904;28468.715312846605;28709.28226794263;29028.7097129026;33557;34204.14489637779;34314.313713726086;34383.140421488664;37212.44181337228;7784.92215077842;7803.297703206738;7813;7817.0619525657285;7878.487898286593;8993.415427997159;9114.13415725505;9161.816763664823;9162;9185.448873067637;8619.525926074126;8721.869171962553;8844.292456603585;8845.159709827556;8884.466931984101;8376.623051962799;8530.872036919576;8586.82826343457;8619.8707019396;8626.741197764077;8130;8132.390070744599;8203.958980205061;8398.538080405391;8414.284785793032;7212.3148300911325;7259.455540834564;7379.3358597726465;7506.361959233526;7642.617869106633;7473.43949203801;7743.612819359122;7786.4938778979185;7814.374850011872;7892.763217103496 16:31:15 INFO - PROCESS | 9087 | __end_tp_report 16:31:15 INFO - PROCESS | 9087 | __start_cc_report 16:31:15 INFO - PROCESS | 9087 | _x_x_mozilla_cycle_collect,876 16:31:15 INFO - PROCESS | 9087 | __end_cc_report 16:31:15 INFO - PROCESS | 9087 | __startTimestamp1452904275876__endTimestamp 16:31:15 INFO - PROCESS | 9087 | 16:31:15 INFO - PROCESS | 9087 | ------- Summary: start ------- 16:31:15 INFO - PROCESS | 9087 | Number of tests: 6 16:31:15 INFO - PROCESS | 9087 | 16:31:15 INFO - PROCESS | 9087 | [#0] dojo.html Cycles:165 Average:4397.68 Median:4523.30 stddev:434.73 (9.6%) stddev-sans-first:411.68 16:31:15 INFO - PROCESS | 9087 | Values: 2567.7 2600.3 2633.4 2640.3 2659.3 4358.3 4463.9 4486.0 4491.3 4522.8 4437.2 4471.5 4498.3 4519.3 4561.1 4100.3 4115.6 4132.2 4179.7 4216.9 4009.7 4087.0 4155.7 4188.3 4211.9 4078.5 4114.7 4115.4 4141.9 4145.6 4090.6 4100.8 4103.4 4137.3 4151.3 4019.7 4092.9 4097.1 4115.3 4146.2 4296.9 4314.5 4363.7 4435.4 4466.7 4711.4 4734.2 4740.1 4779.3 4785.2 4655.5 4750.7 4751.0 4755.5 4788.9 4390.7 4419.6 4458.2 4489.9 4491.2 4860.5 4862.2 4865.1 4865.3 4875.7 4656.5 4657.0 4658.6 4706.9 4706.9 4620.9 4678.1 4682.9 4687.4 4755.3 4732.4 4736.4 4736.6 4753.5 4778.2 4691.1 4699.0 4703.3 4713.7 4745.3 3911.4 3930.9 3976.5 3979.7 3990.5 3520.8 3548.1 3549.5 3560.0 3575.5 4128.0 4128.6 4130.3 4133.1 4173.6 4608.9 4689.0 4691.1 4694.2 4778.8 4112.7 4121.2 4143.2 4150.0 4170.3 4222.9 4250.3 4254.7 4273.8 4283.4 4436.9 4463.0 4522.6 4523.3 4541.4 4776.2 4785.2 4795.5 4805.2 4838.4 4548.1 4549.6 4554.7 4559.9 4602.7 4546.3 4598.7 4632.1 4634.8 4713.0 4769.0 4783.0 4785.2 4805.4 4829.5 4632.8 4635.5 4636.6 4638.0 4684.3 4513.1 4524.4 4591.5 4591.9 4626.3 4525.8 4540.2 4556.7 4568.5 4599.0 4644.9 4656.0 4661.0 4670.6 4698.9 4417.6 4463.0 4464.7 4473.8 4554.9 16:31:15 INFO - PROCESS | 9087 | 16:31:15 INFO - PROCESS | 9087 | [#1] ext.html Cycles:180 Average:39364.69 Median:304755.50 stddev:66694.63 (21.9%) stddev-sans-first:66817.90 16:31:15 INFO - PROCESS | 9087 | Values: 502.8 514.6 519.8 532.0 537.7 24614.5 25094.6 25777.9 26096.7 26228.7 35436.5 35537.8 35867.6 35877.8 35914.0 7483.8 7778.3 7778.3 7782.2 7786.1 7528.8 7666.9 7678.7 7681.5 7685.0 7659.9 7741.7 7915.9 7923.5 7937.8 7808.5 7888.7 7892.4 7916.0 7921.0 7789.4 7916.4 7923.8 7930.1 7930.6 36182.5 36643.8 36665.5 36665.6 36698.3 2692.1 2731.4 2773.9 2820.8 2823.7 26392.5 26782.2 27323.2 27400.6 27432.3 3322.9 3494.5 3506.1 3511.7 3615.9 206363.0 210111.0 211339.0 211464.0 211777.0 46636.8 53556.7 54050.0 54070.5 54081.2 40627.6 64471.0 66047.7 66258.7 66303.0 10962.2 11109.4 11136.1 11137.3 11167.2 7302.1 7420.4 7934.4 8172.3 8202.0 17698.4 17847.8 17919.6 18056.1 18088.8 7246.3 7487.0 7629.9 7707.0 7712.5 778.5 815.3 881.3 890.4 899.6 25815.4 25902.5 27237.6 28335.8 28580.4 835.8 843.7 859.2 881.2 983.5 11927.9 12659.7 12684.9 12733.9 12878.7 299560.0 304643.0 304868.0 304952.0 305842.0 46812.5 47121.8 47192.3 47287.3 47310.0 1114.9 1126.2 1131.9 1145.2 1145.9 23779.8 24102.1 24598.0 24832.5 24856.3 33611.8 34158.3 34309.3 34427.1 34881.8 211483.0 244825.8 244931.0 245055.0 245647.0 22927.7 24749.9 25229.2 25289.6 25462.2 27669.0 27817.0 27833.3 27963.4 28021.6 27507.3 27886.3 27938.2 28041.0 28269.0 27552.6 27957.7 27966.0 28158.9 33231.7 26747.7 26777.3 29031.4 29627.7 30137.5 26193.2 27955.6 28044.6 28170.4 28973.7 21196.0 21407.5 21612.2 22111.9 23436.3 16:31:15 INFO - PROCESS | 9087 | 16:31:15 INFO - PROCESS | 9087 | [#2] jquery.html Cycles:180 Average:23042.79 Median:4872.66 stddev:71327.64 (1463.8%) stddev-sans-first:71507.34 16:31:15 INFO - PROCESS | 9087 | Values: 327.2 333.0 333.9 334.9 336.0 11687.6 12127.0 14239.9 14786.6 15219.6 13632.4 13830.4 13936.2 13957.0 14378.1 4514.0 4703.1 4811.8 4946.8 4974.1 4776.9 4872.1 4873.2 4873.8 4874.9 4670.1 4852.3 4911.5 4911.6 4913.8 4720.5 4758.3 4763.7 4767.0 4773.1 4599.9 4783.2 4783.2 4793.6 4795.1 10650.8 13329.7 16964.8 17665.9 17685.8 1622.7 1676.1 1711.2 1796.7 1807.2 8270.6 8545.3 8555.7 11400.4 11865.9 1633.2 1708.1 1736.5 1760.8 1804.2 48570.5 49636.0 50001.0 50203.2 50601.5 8173.6 9087.7 9145.2 9169.2 9234.8 9707.9 9904.8 10781.8 11762.2 11889.2 5855.7 5972.5 6006.8 6086.3 6140.2 5518.0 5560.2 5563.1 5567.1 5573.4 3963.5 4023.4 4058.2 4082.8 4093.3 1572.4 1620.3 1634.9 1636.8 1646.0 671.7 701.2 750.4 824.5 838.6 13777.5 14743.9 15206.9 15233.3 15320.2 755.6 764.2 774.9 791.6 831.5 6894.0 8207.8 8571.8 8800.2 8892.6 431017.0 434395.0 437800.0 437951.0 439652.0 60032.4 63015.1 63167.7 63324.1 64098.7 916.7 986.5 1025.8 1037.4 1041.3 13669.5 13699.2 13813.7 13825.7 14145.4 29625.7 29657.4 30824.4 31148.4 31620.2 36400.8 39970.8 40899.4 42138.8 42296.8 5838.6 6299.0 6300.3 6329.4 6443.6 6562.6 9298.2 9502.6 9693.0 9699.5 7633.8 7744.3 8035.8 8043.0 8104.2 8000.9 8018.6 8304.9 8380.9 8511.4 6421.4 7659.9 7867.6 8031.3 8115.9 6216.6 6248.1 6292.7 6308.3 6370.9 7297.9 7568.9 7819.1 8213.0 8265.0 16:31:15 INFO - PROCESS | 9087 | 16:31:15 INFO - PROCESS | 9087 | [#3] mootools.html Cycles:180 Average:4803.94 Median:6069.82 stddev:2512.72 (41.4%) stddev-sans-first:2504.93 16:31:15 INFO - PROCESS | 9087 | Values: 1171.4 1300.6 1377.6 1450.1 1664.4 5980.9 6172.2 6658.7 6805.0 6813.7 6932.8 6933.4 6993.5 7000.6 7013.4 1739.1 1793.4 2075.6 2097.4 2102.6 2048.6 2104.2 2109.9 2110.4 2112.3 1984.7 2018.9 2028.3 2033.1 2038.2 2035.7 2037.6 2039.4 2040.2 2041.9 2009.1 2061.2 2064.6 2069.0 2070.1 7018.3 7058.0 7071.2 7079.3 7085.8 3896.4 4005.8 4009.6 4030.5 4033.9 2521.8 2530.4 2653.7 2682.8 2692.5 775.6 1576.6 1585.0 1669.1 1722.3 9550.2 9731.7 9748.0 9752.5 9761.4 3641.2 3644.4 3644.9 3714.1 3714.7 7697.2 7705.5 7722.5 7723.7 7725.6 3994.5 4021.7 4022.5 4025.6 4029.8 3724.2 3727.9 3730.9 3734.2 3734.2 2790.6 2825.4 2980.6 3014.2 3022.4 923.6 930.0 931.1 945.9 949.4 795.2 813.4 815.0 837.0 851.0 6399.7 6435.8 6436.1 6441.9 6446.2 967.3 968.4 987.9 995.4 996.6 4963.6 5020.9 5028.1 5031.6 5111.5 8040.4 8377.5 8378.1 8444.8 8597.1 8368.0 8574.0 8582.0 8585.7 8593.4 6584.3 6608.1 6627.6 6684.6 6685.5 6057.4 6131.4 6166.8 6173.4 6180.6 7374.2 7393.5 7647.2 7654.9 7656.9 7910.2 7964.8 8008.2 8013.7 8020.4 5882.8 6017.3 6024.5 6029.9 6043.5 5581.3 5697.6 6415.1 6454.1 6477.8 5249.2 6014.3 6081.8 6107.8 6328.2 6065.1 6074.5 6151.5 6231.9 6320.3 6128.7 6178.0 6181.0 6181.4 6185.9 5531.3 5651.3 5677.7 5681.4 5682.7 5473.3 5514.2 5528.3 5533.4 5536.4 16:31:15 INFO - PROCESS | 9087 | 16:31:15 INFO - PROCESS | 9087 | [#4] prototype.html Cycles:180 Average:4541.76 Median:5284.39 stddev:1367.56 (25.9%) stddev-sans-first:1333.48 16:31:15 INFO - PROCESS | 9087 | Values: 280.7 284.2 288.4 291.1 294.2 5163.5 5291.3 5307.1 5322.8 5365.2 5234.2 5266.1 5274.1 5277.4 5291.7 4019.6 4021.1 4030.0 4036.3 4041.5 3778.4 3850.0 3924.6 3986.4 4004.2 3959.7 3961.3 3969.6 3980.3 3983.1 3720.7 3852.6 3972.5 3986.1 3986.3 3359.6 3408.8 3422.6 3424.2 3433.6 5038.2 5056.5 5060.6 5062.2 5064.7 4556.2 4559.3 4561.5 4566.1 4567.9 5302.0 5454.9 5479.8 5488.5 5489.7 3698.2 3708.3 3711.0 3739.5 3740.8 5747.6 5817.8 5820.8 5820.9 5823.7 3818.6 3825.7 3826.2 3829.1 3833.3 3873.6 3890.6 3893.6 3903.0 3907.2 4355.5 4444.6 4452.4 4454.9 4527.8 5458.6 5460.2 5494.3 5503.5 5513.4 1340.7 1362.5 1369.8 1370.0 1370.7 903.9 911.9 912.9 928.5 928.9 4869.6 4874.7 4879.6 4880.9 4881.8 5747.1 5757.8 5760.0 5761.7 5762.3 4864.2 4866.7 4871.4 4875.0 4879.6 3009.7 3057.0 3089.1 3092.9 3095.6 5421.7 5424.7 5433.5 5435.1 5440.4 5871.6 5877.7 5878.7 5883.3 5898.2 5424.3 5429.7 5432.1 5432.8 5435.5 5595.1 5715.5 5724.2 5727.8 5734.2 5599.5 5602.8 5605.3 5607.3 5609.7 5424.9 5428.7 5428.9 5430.0 5430.9 3763.8 3861.7 3862.5 3863.6 3865.6 5714.6 5715.3 5717.1 5718.8 5719.3 5506.8 5508.3 5514.4 5514.6 5516.5 5511.8 5513.5 5519.2 5520.4 5526.7 5249.6 5381.8 5387.7 5388.9 5390.1 5336.4 5530.4 5534.6 5537.9 5543.9 5343.1 5346.1 5455.2 5462.9 5465.4 16:31:15 INFO - PROCESS | 9087 | 16:31:15 INFO - PROCESS | 9087 | [#5] yui.html Cycles:180 Average:10506.17 Median:562.91 stddev:12015.07 (2134.5%) stddev-sans-first:12026.08 16:31:15 INFO - PROCESS | 9087 | Values: 671.3 671.9 694.6 699.5 725.3 10840.3 12114.8 12165.3 12233.6 12239.6 10976.5 11351.5 11360.6 11390.5 11394.8 462.9 737.0 747.7 749.6 749.9 606.5 752.1 765.6 766.5 767.2 801.7 806.1 809.8 810.3 810.4 621.1 630.8 781.2 800.5 803.0 591.3 592.1 592.1 592.4 594.8 10484.2 10507.7 10545.7 10554.9 10560.2 10538.6 10775.6 10937.3 11015.9 11154.2 8718.0 8854.4 8992.2 9006.2 9342.5 3144.2 3152.4 3178.5 3197.4 3260.0 40618.0 40739.8 40768.4 41077.6 41120.6 8943.2 9086.9 9130.8 9156.9 9207.5 13863.0 13902.7 13924.4 13930.6 13930.9 5912.2 5979.0 6088.6 6187.4 6325.3 3520.7 3576.1 3584.2 3593.8 3701.0 2502.7 2527.7 2528.9 2531.9 2535.4 434.5 440.5 453.0 456.7 464.8 430.9 457.7 492.0 502.4 503.4 6635.0 6773.1 6822.5 6896.2 7137.9 449.4 483.8 492.3 522.2 534.5 3083.3 3239.6 3266.1 3307.0 3316.4 44715.3 45368.0 45491.3 45522.3 45584.8 39488.2 39706.6 40254.4 40687.8 40762.8 16601.4 16603.6 16767.9 16822.0 16917.9 6254.8 6310.9 6415.5 6493.5 6767.9 27684.6 28366.9 28468.7 28709.3 29028.7 33557.0 34204.1 34314.3 34383.1 37212.4 7784.9 7803.3 7813.0 7817.1 7878.5 8993.4 9114.1 9161.8 9162.0 9185.4 8619.5 8721.9 8844.3 8845.2 8884.5 8376.6 8530.9 8586.8 8619.9 8626.7 8130.0 8132.4 8204.0 8398.5 8414.3 7212.3 7259.5 7379.3 7506.4 7642.6 7473.4 7743.6 7786.5 7814.4 7892.8 16:31:15 INFO - PROCESS | 9087 | -------- Summary: end -------- 16:31:15 INFO - PROCESS | 9087 | 16:31:16 INFO - TEST-INFO | 9087: exit 0 16:31:16 INFO - TEST-OK | dromaeo_css | took 1117296ms 16:31:16 INFO - TEST-START | kraken 16:31:16 INFO - operating with platform_type : linux_ 16:31:16 INFO - Initialising browser for kraken test... 16:31:16 INFO - TEST-INFO | started process 9287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzU7Gwb/profile http://localhost:39321/getInfo.html) 16:31:21 INFO - PROCESS | 9287 | __metrics Screen width/height:1600/1200 16:31:21 INFO - PROCESS | 9287 | colorDepth:24 16:31:21 INFO - PROCESS | 9287 | Browser inner width/height: 1024/697 16:31:21 INFO - PROCESS | 9287 | __metrics 16:31:21 INFO - PROCESS | 9287 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:31:21 INFO - PROCESS | 9287 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:31:22 INFO - TEST-INFO | 9287: exit 0 16:31:22 INFO - Browser initialized. 16:31:22 INFO - Running cycle 1/1 for kraken test... 16:31:22 INFO - TEST-INFO | started process 9372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzU7Gwb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:31:34 INFO - PROCESS | 9372 | RSS: Main: 149340160 16:31:34 INFO - PROCESS | 9372 | 16:31:36 INFO - PROCESS | 9372 | Cycle 1(1): loaded http://localhost:39321/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39321/tests/kraken/driver.html?testName=audio-beat-detection) 16:31:37 INFO - PROCESS | 9372 | RSS: Main: 187052032 16:31:37 INFO - PROCESS | 9372 | 16:31:40 INFO - PROCESS | 9372 | Cycle 1(1): loaded http://localhost:39321/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39321/tests/kraken/driver.html?testName=audio-dft) 16:31:40 INFO - PROCESS | 9372 | RSS: Main: 178163712 16:31:40 INFO - PROCESS | 9372 | 16:31:43 INFO - PROCESS | 9372 | Cycle 1(1): loaded http://localhost:39321/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39321/tests/kraken/driver.html?testName=audio-fft) 16:31:44 INFO - PROCESS | 9372 | RSS: Main: 162803712 16:31:44 INFO - PROCESS | 9372 | 16:31:46 INFO - PROCESS | 9372 | Cycle 1(1): loaded http://localhost:39321/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39321/tests/kraken/driver.html?testName=audio-oscillator) 16:31:47 INFO - PROCESS | 9372 | RSS: Main: 163782656 16:31:47 INFO - PROCESS | 9372 | 16:31:49 INFO - PROCESS | 9372 | Cycle 1(1): loaded http://localhost:39321/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39321/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:31:49 INFO - PROCESS | 9372 | RSS: Main: 166277120 16:31:49 INFO - PROCESS | 9372 | 16:31:52 INFO - PROCESS | 9372 | Cycle 1(1): loaded http://localhost:39321/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39321/tests/kraken/driver.html?testName=imaging-darkroom) 16:31:53 INFO - PROCESS | 9372 | RSS: Main: 166494208 16:31:53 INFO - PROCESS | 9372 | 16:31:56 INFO - PROCESS | 9372 | Cycle 1(1): loaded http://localhost:39321/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39321/tests/kraken/driver.html?testName=imaging-desaturate) 16:31:57 INFO - PROCESS | 9372 | RSS: Main: 166125568 16:31:57 INFO - PROCESS | 9372 | 16:32:00 INFO - PROCESS | 9372 | Cycle 1(1): loaded http://localhost:39321/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39321/tests/kraken/driver.html?testName=json-parse-financial) 16:32:00 INFO - PROCESS | 9372 | RSS: Main: 166105088 16:32:00 INFO - PROCESS | 9372 | 16:32:02 INFO - PROCESS | 9372 | Cycle 1(1): loaded http://localhost:39321/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39321/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:32:03 INFO - PROCESS | 9372 | RSS: Main: 175271936 16:32:03 INFO - PROCESS | 9372 | 16:32:05 INFO - PROCESS | 9372 | Cycle 1(1): loaded http://localhost:39321/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39321/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:32:05 INFO - PROCESS | 9372 | RSS: Main: 174411776 16:32:05 INFO - PROCESS | 9372 | 16:32:07 INFO - PROCESS | 9372 | Cycle 1(1): loaded http://localhost:39321/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39321/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:32:08 INFO - PROCESS | 9372 | RSS: Main: 183169024 16:32:08 INFO - PROCESS | 9372 | 16:32:10 INFO - PROCESS | 9372 | Cycle 1(1): loaded http://localhost:39321/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39321/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:32:11 INFO - PROCESS | 9372 | RSS: Main: 189915136 16:32:11 INFO - PROCESS | 9372 | 16:32:14 INFO - PROCESS | 9372 | Cycle 1(1): loaded http://localhost:39321/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39321/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:32:14 INFO - PROCESS | 9372 | RSS: Main: 186404864 16:32:14 INFO - PROCESS | 9372 | 16:32:16 INFO - PROCESS | 9372 | Cycle 1(1): loaded http://localhost:39321/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39321/tests/kraken/driver.html?testName=ai-astar) 16:32:16 INFO - PROCESS | 9372 | RSS: Main: 243306496 16:32:16 INFO - PROCESS | 9372 | 16:32:16 INFO - PROCESS | 9372 | __start_tp_report 16:32:16 INFO - PROCESS | 9372 | _x_x_mozilla_page_load 16:32:16 INFO - PROCESS | 9372 | _x_x_mozilla_page_load_details 16:32:16 INFO - PROCESS | 9372 | |i|pagename|runs| 16:32:16 INFO - PROCESS | 9372 | |0;ai-astar;113;113;109;113;114;113;103;112;113;112 16:32:16 INFO - PROCESS | 9372 | |1;audio-beat-detection;160;141;156;168;133;156;156;130;177;132 16:32:16 INFO - PROCESS | 9372 | |2;audio-dft;160;162;159;161;161;160;160;161;162;164 16:32:16 INFO - PROCESS | 9372 | |3;audio-fft;74;72;97;91;72;73;73;110;92;73 16:32:16 INFO - PROCESS | 9372 | |4;audio-oscillator;98;98;130;97;99;98;139;98;98;146 16:32:16 INFO - PROCESS | 9372 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;109 16:32:16 INFO - PROCESS | 9372 | |6;imaging-darkroom;148;146;147;147;147;147;147;147;146;146 16:32:16 INFO - PROCESS | 9372 | |7;imaging-desaturate;95;96;95;95;96;95;96;95;95;95 16:32:16 INFO - PROCESS | 9372 | |8;json-parse-financial;67;66;68;66;67;66;67;77;65;66 16:32:16 INFO - PROCESS | 9372 | |9;json-stringify-tinderbox;68;68;68;68;68;68;68;68;68;68 16:32:16 INFO - PROCESS | 9372 | |10;stanford-crypto-aes;82;92;84;91;84;83;84;84;84;85 16:32:16 INFO - PROCESS | 9372 | |11;stanford-crypto-ccm;124;122;130;122;129;121;128;120;121;120 16:32:16 INFO - PROCESS | 9372 | |12;stanford-crypto-pbkdf2;158;142;152;149;151;137;149;150;151;148 16:32:16 INFO - PROCESS | 9372 | |13;stanford-crypto-sha256-iterative;74;71;71;74;72;72;71;71;71;71 16:32:16 INFO - PROCESS | 9372 | __end_tp_report 16:32:16 INFO - PROCESS | 9372 | __start_cc_report 16:32:16 INFO - PROCESS | 9372 | _x_x_mozilla_cycle_collect,996 16:32:16 INFO - PROCESS | 9372 | __end_cc_report 16:32:16 INFO - PROCESS | 9372 | __startTimestamp1452904336790__endTimestamp 16:32:16 INFO - PROCESS | 9372 | 16:32:16 INFO - PROCESS | 9372 | ------- Summary: start ------- 16:32:16 INFO - PROCESS | 9372 | Number of tests: 14 16:32:16 INFO - PROCESS | 9372 | 16:32:16 INFO - PROCESS | 9372 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:3.27 (2.9%) stddev-sans-first:3.43 16:32:16 INFO - PROCESS | 9372 | Values: 113.0 113.0 109.0 113.0 114.0 113.0 103.0 112.0 113.0 112.0 16:32:16 INFO - PROCESS | 9372 | 16:32:16 INFO - PROCESS | 9372 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:156.00 stddev:16.15 (10.4%) stddev-sans-first:16.79 16:32:16 INFO - PROCESS | 9372 | Values: 160.0 141.0 156.0 168.0 133.0 156.0 156.0 130.0 177.0 132.0 16:32:16 INFO - PROCESS | 9372 | 16:32:16 INFO - PROCESS | 9372 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.41 (0.9%) stddev-sans-first:1.45 16:32:16 INFO - PROCESS | 9372 | Values: 160.0 162.0 159.0 161.0 161.0 160.0 160.0 161.0 162.0 164.0 16:32:16 INFO - PROCESS | 9372 | 16:32:16 INFO - PROCESS | 9372 | [#3] audio-fft Cycles:10 Average:82.70 Median:73.50 stddev:13.71 (18.7%) stddev-sans-first:14.18 16:32:16 INFO - PROCESS | 9372 | Values: 74.0 72.0 97.0 91.0 72.0 73.0 73.0 110.0 92.0 73.0 16:32:16 INFO - PROCESS | 9372 | 16:32:16 INFO - PROCESS | 9372 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:98.00 stddev:19.85 (20.3%) stddev-sans-first:20.57 16:32:16 INFO - PROCESS | 9372 | Values: 98.0 98.0 130.0 97.0 99.0 98.0 139.0 98.0 98.0 146.0 16:32:16 INFO - PROCESS | 9372 | 16:32:16 INFO - PROCESS | 9372 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:32:16 INFO - PROCESS | 9372 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 16:32:16 INFO - PROCESS | 9372 | 16:32:16 INFO - PROCESS | 9372 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 16:32:16 INFO - PROCESS | 9372 | Values: 148.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 146.0 16:32:16 INFO - PROCESS | 9372 | 16:32:16 INFO - PROCESS | 9372 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:32:16 INFO - PROCESS | 9372 | Values: 95.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 16:32:16 INFO - PROCESS | 9372 | 16:32:16 INFO - PROCESS | 9372 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:67.00 stddev:3.44 (5.1%) stddev-sans-first:3.64 16:32:16 INFO - PROCESS | 9372 | Values: 67.0 66.0 68.0 66.0 67.0 66.0 67.0 77.0 65.0 66.0 16:32:16 INFO - PROCESS | 9372 | 16:32:16 INFO - PROCESS | 9372 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:32:16 INFO - PROCESS | 9372 | Values: 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 16:32:16 INFO - PROCESS | 9372 | 16:32:16 INFO - PROCESS | 9372 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:84.00 stddev:3.37 (4.0%) stddev-sans-first:3.35 16:32:16 INFO - PROCESS | 9372 | Values: 82.0 92.0 84.0 91.0 84.0 83.0 84.0 84.0 84.0 85.0 16:32:16 INFO - PROCESS | 9372 | 16:32:16 INFO - PROCESS | 9372 | [#11] stanford-crypto-ccm Cycles:10 Average:123.70 Median:123.00 stddev:3.86 (3.1%) stddev-sans-first:4.09 16:32:16 INFO - PROCESS | 9372 | Values: 124.0 122.0 130.0 122.0 129.0 121.0 128.0 120.0 121.0 120.0 16:32:16 INFO - PROCESS | 9372 | 16:32:16 INFO - PROCESS | 9372 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.70 Median:150.50 stddev:5.70 (3.8%) stddev-sans-first:4.95 16:32:16 INFO - PROCESS | 9372 | Values: 158.0 142.0 152.0 149.0 151.0 137.0 149.0 150.0 151.0 148.0 16:32:16 INFO - PROCESS | 9372 | 16:32:16 INFO - PROCESS | 9372 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:71.50 stddev:1.23 (1.7%) stddev-sans-first:1.01 16:32:16 INFO - PROCESS | 9372 | Values: 74.0 71.0 71.0 74.0 72.0 72.0 71.0 71.0 71.0 71.0 16:32:16 INFO - PROCESS | 9372 | -------- Summary: end -------- 16:32:16 INFO - PROCESS | 9372 | 16:32:17 INFO - TEST-INFO | 9372: exit 0 16:32:17 INFO - TEST-OK | kraken | took 61239ms 16:32:17 INFO - TEST-START | v8_7 16:32:17 INFO - operating with platform_type : linux_ 16:32:17 INFO - Initialising browser for v8_7 test... 16:32:17 INFO - TEST-INFO | started process 9622 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG_EYLZ/profile http://localhost:39321/getInfo.html) 16:32:22 INFO - PROCESS | 9622 | __metrics Screen width/height:1600/1200 16:32:22 INFO - PROCESS | 9622 | colorDepth:24 16:32:22 INFO - PROCESS | 9622 | Browser inner width/height: 1024/697 16:32:22 INFO - PROCESS | 9622 | __metrics 16:32:22 INFO - PROCESS | 9622 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:32:22 INFO - PROCESS | 9622 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:32:23 INFO - TEST-INFO | 9622: exit 0 16:32:23 INFO - Browser initialized. 16:32:23 INFO - Running cycle 1/1 for v8_7 test... 16:32:23 INFO - TEST-INFO | started process 9704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG_EYLZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:35 INFO - PROCESS | 9704 | RSS: Main: 149585920 16:32:35 INFO - PROCESS | 9704 | 16:32:58 INFO - PROCESS | 9704 | Cycle 1(1): loaded http://localhost:39321/tests/v8_7/run.html (next: http://localhost:39321/tests/v8_7/run.html) 16:32:58 INFO - PROCESS | 9704 | RSS: Main: 451039232 16:32:58 INFO - PROCESS | 9704 | 16:32:58 INFO - PROCESS | 9704 | __start_tp_report 16:32:58 INFO - PROCESS | 9704 | _x_x_mozilla_page_load 16:32:58 INFO - PROCESS | 9704 | _x_x_mozilla_page_load_details 16:32:58 INFO - PROCESS | 9704 | |i|pagename|runs| 16:32:58 INFO - PROCESS | 9704 | |0;Richards;169.52025767079166 16:32:58 INFO - PROCESS | 9704 | |1;DeltaBlue;187.68768768768768 16:32:58 INFO - PROCESS | 9704 | |2;Encrypt;279.09572983533354 16:32:58 INFO - PROCESS | 9704 | |3;Decrypt;5170.103092783505 16:32:58 INFO - PROCESS | 9704 | |4;RayTrace;2026.3157894736842 16:32:58 INFO - PROCESS | 9704 | |5;Earley;805.8017727639001 16:32:58 INFO - PROCESS | 9704 | |6;Boyer;12407.407407407407 16:32:58 INFO - PROCESS | 9704 | |7;RegExp;44782.608695652176 16:32:58 INFO - PROCESS | 9704 | |8;Splay;594.1770647653001 16:32:58 INFO - PROCESS | 9704 | |9;NavierStokes;4850.241545893719 16:32:58 INFO - PROCESS | 9704 | __end_tp_report 16:32:58 INFO - PROCESS | 9704 | __startTimestamp1452904378424__endTimestamp 16:32:58 INFO - PROCESS | 9704 | 16:32:58 INFO - PROCESS | 9704 | ------- Summary: start ------- 16:32:58 INFO - PROCESS | 9704 | Number of tests: 10 16:32:58 INFO - PROCESS | 9704 | 16:32:58 INFO - PROCESS | 9704 | [#0] Richards Cycles:1 Average:169.52 Median:169.52 stddev:0.00 (0.0%) 16:32:58 INFO - PROCESS | 9704 | Values: 169.5 16:32:58 INFO - PROCESS | 9704 | 16:32:58 INFO - PROCESS | 9704 | [#1] DeltaBlue Cycles:1 Average:187.69 Median:187.69 stddev:0.00 (0.0%) 16:32:58 INFO - PROCESS | 9704 | Values: 187.7 16:32:58 INFO - PROCESS | 9704 | 16:32:58 INFO - PROCESS | 9704 | [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 16:32:58 INFO - PROCESS | 9704 | Values: 279.1 16:32:58 INFO - PROCESS | 9704 | 16:32:58 INFO - PROCESS | 9704 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 16:32:58 INFO - PROCESS | 9704 | Values: 5170.1 16:32:58 INFO - PROCESS | 9704 | 16:32:58 INFO - PROCESS | 9704 | [#4] RayTrace Cycles:1 Average:2026.32 Median:2026.32 stddev:0.00 (0.0%) 16:32:58 INFO - PROCESS | 9704 | Values: 2026.3 16:32:58 INFO - PROCESS | 9704 | 16:32:58 INFO - PROCESS | 9704 | [#5] Earley Cycles:1 Average:805.80 Median:805.80 stddev:0.00 (0.0%) 16:32:58 INFO - PROCESS | 9704 | Values: 805.8 16:32:58 INFO - PROCESS | 9704 | 16:32:58 INFO - PROCESS | 9704 | [#6] Boyer Cycles:1 Average:12407.41 Median:12407.41 stddev:0.00 (0.0%) 16:32:58 INFO - PROCESS | 9704 | Values: 12407.4 16:32:58 INFO - PROCESS | 9704 | 16:32:58 INFO - PROCESS | 9704 | [#7] RegExp Cycles:1 Average:44782.61 Median:44782.61 stddev:0.00 (0.0%) 16:32:58 INFO - PROCESS | 9704 | Values: 44782.6 16:32:58 INFO - PROCESS | 9704 | 16:32:58 INFO - PROCESS | 9704 | [#8] Splay Cycles:1 Average:594.18 Median:594.18 stddev:0.00 (0.0%) 16:32:58 INFO - PROCESS | 9704 | Values: 594.2 16:32:58 INFO - PROCESS | 9704 | 16:32:58 INFO - PROCESS | 9704 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 16:32:58 INFO - PROCESS | 9704 | Values: 4850.2 16:32:58 INFO - PROCESS | 9704 | -------- Summary: end -------- 16:32:58 INFO - PROCESS | 9704 | 16:32:59 INFO - TEST-INFO | 9704: exit 0 16:32:59 INFO - TEST-OK | v8_7 | took 41509ms 16:32:59 INFO - SUITE-END | took 1220s 16:32:59 INFO - Completed test suite (00:20:20) 16:32:59 INFO - Working with test: dromaeo_css 16:32:59 INFO - Generating results file: dromaeo_css 16:32:59 INFO - Working with test: kraken 16:32:59 INFO - Generating results file: kraken 16:32:59 INFO - javascript benchmark 16:32:59 INFO - Working with test: v8_7 16:32:59 INFO - Generating results file: v8_7 16:32:59 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:32:59 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 16:32:59 INFO - process_Request line: dromaeo_css 5827.77 graph.html#tests=[[72,94,35]] 16:32:59 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:32:59 INFO - process_Request line: kraken 1532.30 graph.html#tests=[[232,94,35]] 16:32:59 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:32:59 INFO - process_Request line: v8_7 18715.89 graph.html#tests=[[230,94,35]] 16:32:59 INFO - RETURN: dromaeo_css: 5827.77 16:32:59 INFO - RETURN: kraken: 1532.30 16:32:59 INFO - RETURN: v8_7: 18715.89 16:32:59 INFO - javascript benchmark 16:33:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2567.7303883092277, 2600.2589262060314, 2633.4338117304787, 2640.339915021245, 2659.2554084856242, 4358.259095953687, 4463.933041004388, 4485.977570112145, 4491.258942274525, 4522.773861306934, 4437.2013037653205, 4471.463424389078, 4498.32525121232, 4519.322101684741, 4561.133384656921, 4100.343944968806, 4115.588441155883, 4132.214879172962, 4179.728317659357, 4216.894577635569, 4009.6992725545556, 4087.0, 4155.709100362976, 4188.287991041515, 4211.8525851595205, 4078.5105787305415, 4114.732542384735, 4115.444415003996, 4141.937870931938, 4145.564715704868, 4090.5704900985265, 4100.835966561334, 4103.4460347853255, 4137.2552940470705, 4151.294279972412, 4019.718619696622, 4092.877213683594, 4097.078157414588, 4115.300398932189, 4146.1914926589325, 4296.935545966813, 4314.460692413449, 4363.716358436692, 4435.379046933432, 4466.709663871838, 4711.411073615798, 4734.171519983989, 4740.051989602093, 4779.259214821674, 4785.234362502018, 4655.511171326996, 4750.71495710255, 4750.952490475085, 4755.548222918817, 4788.880277993043, 4390.670699697535, 4419.646428285761, 4458.152950939311, 4489.865304040884, 4491.169133710208, 4860.465348811628, 4862.197737373364, 4865.0756356292195, 4865.343178670834, 4875.683080599821, 4656.5110663379855, 4656.95343046572, 4658.604018658384, 4706.88232794176, 4706.905861882743, 4620.861374158781, 4678.111158879802, 4682.906341873144, 4687.437507499122, 4755.334253204554, 4732.384789977281, 4736.431628204568, 4736.550027747358, 4753.524647535219, 4778.235482322812, 4691.108689349013, 4698.95301046992, 4703.270992996091, 4713.6936099153445, 4745.335653008581, 3911.413288006822, 3930.8820735377985, 3976.4631774710624, 3979.721419500607, 3990.521137463523, 3520.77114987525, 3548.1129717570607, 3549.5208146900354, 3560.038789526865, 3575.535180426528, 4128.02991297045, 4128.587141285908, 4130.277201489727, 4133.111381053088, 4173.582641735802, 4608.9308660370125, 4688.976555117202, 4691.061787642485, 4694.201985662446, 4778.784954677048, 4112.732672376286, 4121.216968775923, 4143.212789569972, 4150.0, 4170.332746760504, 4222.915541689211, 4250.341197114452, 4254.7021708480725, 4273.764942928106, 4283.400323954649, 4436.86689399312, 4463.0, 4522.615577675934, 4523.2988886722615, 4541.409616749801, 4776.23580227162, 4785.162596545521, 4795.496472870438, 4805.183118869731, 4838.395200599925, 4548.11311794197, 4549.567791059844, 4554.681172317906, 4559.863204103882, 4602.723836569682, 4546.318052292183, 4598.655100867381, 4632.073585283024, 4634.76826158684, 4713.0338280651695, 4769.046190761931, 4782.952170478251, 4785.162596545521, 4805.447373552086, 4829.492903245108, 4632.791524381343, 4635.490096089495, 4636.629069674351, 4638.049199914077, 4684.320773487893, 4513.074819661896, 4524.434445694288, 4591.540845915381, 4591.908161836812, 4626.32918226862, 4525.751083690297, 4540.205464043713, 4556.726596404226, 4568.4974652787505, 4598.954010459986, 4644.930326045044, 4656.045510670372, 4660.953390466052, 4670.556297151765, 4698.882527936692, 4417.580329868786, 4463.04044630406, 4464.732116073046, 4473.776311184492, 4554.88612784683], "unit": "score", "name": "dojo.html", "value": 4372.055483377456}, {"lowerIsBetter": false, "replicates": [502.8189851653406, 514.6474664854575, 519.8310549071552, 532.0104605433895, 537.6559002238566, 24614.507709845813, 25094.623580646305, 25777.871110644443, 26096.73903260967, 26228.737712622868, 35436.468452973226, 35537.82231088841, 35867.64132358676, 35877.82061089691, 35914.0, 7483.775486735407, 7778.261065198825, 7778.299953004229, 7782.18287079857, 7786.1435242123325, 7528.849423011564, 7666.923330766676, 7678.692852285902, 7681.539107653531, 7685.03937007874, 7659.923400766004, 7741.690332386698, 7915.920840791605, 7923.524588524678, 7937.801554961144, 7808.531488110703, 7888.723894663688, 7892.408069394818, 7916.0, 7921.049474063092, 7789.415793815429, 7916.366690664733, 7923.762287131395, 7930.088039875431, 7930.563818989954, 36182.45726314108, 36643.81678091619, 36665.45001824948, 36665.633343666756, 36698.26603467942, 2692.0846912049997, 2731.412746259564, 2773.8751756171023, 2820.774338052951, 2823.731745484176, 26392.472150557074, 26782.19653410401, 27323.180304590893, 27400.58899116515, 27432.314192145157, 3322.900312990614, 3494.458358954341, 3506.08841701157, 3511.736619753503, 3615.8915232542804, 206363.0, 210111.0, 211339.0, 211464.0, 211777.0, 46636.7668161657, 53556.73221633945, 54050.0, 54070.45929540733, 54081.1887821683, 40627.59372406297, 64471.0, 66047.66976165089, 66258.66870665616, 66303.0, 10962.232643714864, 11109.388983605979, 11136.109111271078, 11137.276077054965, 11167.218294719292, 7302.087239095114, 7420.406367490587, 7934.404919631051, 8172.305354044854, 8202.0, 17698.380556680455, 17847.821521784877, 17919.641607167785, 18056.09719514019, 18088.819111808978, 7246.275372462712, 7487.0, 7629.934202309178, 7707.0, 7712.537247765152, 778.497868874584, 815.2703330519153, 881.3169793410159, 890.3900827932887, 899.6086702284528, 25815.354616134373, 25902.481950361263, 27237.591436128474, 28335.773839763337, 28580.428391432055, 835.7868743470498, 843.7131375332293, 859.2009431229017, 881.2201201936333, 983.4640121133999, 11927.940360298317, 12659.746805063847, 12684.936575317064, 12733.917617002659, 12878.742425151631, 299560.0, 304643.0, 304868.0, 304952.0, 305842.0, 46812.531874681496, 47121.76439117782, 47192.29211561829, 47287.29069063967, 47310.0, 1114.9442527873573, 1126.1722633864267, 1131.9151063670092, 1145.238416453066, 1145.856767904012, 23779.765918865916, 24102.07183425357, 24598.0, 24832.50334993326, 24856.254312370656, 33611.83194084014, 34158.31683366269, 34309.31381372408, 34427.13932151716, 34881.825590871886, 211483.0, 244825.7758711195, 244931.0, 245055.0, 245647.0, 22927.656085158404, 24749.876250618632, 25229.24312270635, 25289.62065569055, 25462.23613291604, 27669.031583894466, 27817.0, 27833.304167395978, 27963.440731184855, 28021.57967630528, 27507.31231719223, 27886.3028424291, 27938.16185514438, 28041.0, 28269.0, 27552.58671119975, 27957.72042279551, 27966.0, 28158.85920570384, 33231.66768332382, 26747.741487144158, 26777.33056673599, 29031.419371612028, 29627.703722963357, 30137.547936781404, 26193.189770659385, 27955.58066629043, 28044.579331310455, 28170.43659126847, 28973.710262897945, 21196.0, 21407.46481337979, 21612.243571474923, 22111.88944055334, 23436.296911092693], "unit": "score", "name": "ext.html", "value": 15571.050176949015}, {"lowerIsBetter": false, "replicates": [327.23590416377755, 332.9910371574131, 333.9148517128132, 334.89450822990773, 336.03222718570515, 11687.5909343173, 12127.0, 14239.857601423995, 14786.556403307904, 15219.619509512253, 13632.386542605582, 13830.446782128703, 13936.163830170171, 13957.023008389417, 14378.06542574732, 4513.961788788581, 4703.106409782139, 4811.783469743852, 4946.826861059863, 4974.10466116099, 4776.880577985544, 4872.123017856784, 4873.195922672755, 4873.805047798101, 4874.878128046792, 4670.1126785910565, 4852.29641701953, 4911.533404326601, 4911.631627627924, 4913.803447862081, 4720.504347043562, 4758.333833263346, 4763.69036012658, 4766.976165119169, 4773.140834649762, 4599.885002874921, 4783.1868582341085, 4783.210770222909, 4793.5925446337105, 4795.112904112715, 10650.786984260349, 13329.666758331023, 16964.830351696448, 17665.911670441696, 17685.823141768546, 1622.7160246956735, 1676.1200369805827, 1711.2299465240692, 1796.694561924476, 1807.1957978699484, 8270.627821748036, 8545.27365173961, 8555.700550480766, 11400.429978501124, 11865.940670296679, 1633.232380781031, 1708.1288542843115, 1736.513776142682, 1760.8239176082418, 1804.170081762391, 48570.514294856956, 49636.0, 50001.0, 50203.24695129576, 50601.49398506005, 8173.550454724928, 9087.681931132378, 9145.176934075966, 9169.220616247694, 9234.81530369389, 9707.854382184272, 9904.801903961881, 10781.784364312827, 11762.176647634755, 11889.227200231957, 5855.736491857877, 5972.492338151305, 6006.819795406057, 6086.330503644595, 6140.17107690456, 5517.972410137923, 5560.165975103767, 5563.082091454865, 5567.053600887859, 5573.41479144692, 3963.524377074712, 4023.396490526386, 4058.2086493134148, 4082.755034697928, 4093.3246014407887, 1572.4024870549347, 1620.3437607768872, 1634.8528632423138, 1636.8444997725196, 1645.983540164607, 671.7245929169018, 701.242657929435, 750.4484204109975, 824.5135370131651, 838.5807096451774, 13777.517786877412, 14743.926280368743, 15206.923965380101, 15233.314500847488, 15320.15739134336, 755.5908231148868, 764.1594246329105, 774.8643987302199, 791.6279348706099, 831.5218749219223, 6893.965530172417, 8207.7948051298, 8571.785705357415, 8800.207981281716, 8892.61578461628, 431017.0, 434395.0, 437800.0, 437951.0, 439652.0, 60032.39967600355, 63015.054774178425, 63167.68416157982, 63324.05013924795, 64098.679506603105, 916.6837441082815, 986.5215370545279, 1025.825609646362, 1037.4138611684223, 1041.250299784154, 13669.521566745514, 13699.178049317074, 13813.723725525635, 13825.723485530434, 14145.363458644591, 29625.703742962294, 29657.43968693773, 30824.38351232918, 31148.377032459677, 31620.209494762814, 36400.81799590985, 39970.800145999085, 40899.38650920298, 42138.7893060545, 42296.788516057226, 5838.562107842014, 6298.968505157445, 6300.306966233802, 6329.430351268408, 6443.581167224115, 6562.639054851838, 9298.163165315154, 9502.572384242587, 9692.95153524256, 9699.515024248618, 7633.847323053619, 7744.2642948919765, 8035.758927232192, 8043.0, 8104.2300981409035, 8000.879986800319, 8018.558979256197, 8304.916950830657, 8380.916190838014, 8511.361647876558, 6421.422072013354, 7659.851022346693, 7867.645955931882, 8031.317338026333, 8115.9188408117525, 6216.564840461305, 6248.0940263660605, 6292.748290068346, 6308.274548426806, 6370.904436433365, 7297.854042919218, 7568.924310756822, 7819.1398946117015, 8212.958935205525, 8265.0], "unit": "score", "name": "jquery.html", "value": 7056.150097040051}, {"lowerIsBetter": false, "replicates": [1171.3791690404078, 1300.6098170548837, 1377.5867239828053, 1450.1444147952707, 1664.39249673869, 5980.88038239235, 6172.22847144107, 6658.733650653968, 6804.979253112036, 6813.659317034141, 6932.8266793330195, 6933.375996160345, 6993.475489338294, 7000.579965202091, 7013.403860671836, 1739.1478175693946, 1793.3723196881117, 2075.5537559424683, 2097.423208617635, 2102.632039393108, 2048.5902819436096, 2104.2424727098232, 2109.915603375863, 2110.4090854560745, 2112.2818241797786, 1984.65268577999, 2018.9091490882872, 2028.3306508852118, 2033.1257559249516, 2038.164352615428, 2035.653938830395, 2037.633226019316, 2039.39837747864, 2040.1941233212947, 2041.9387418377398, 2009.1461129020108, 2061.2167376397024, 2064.6283668939586, 2069.048237810609, 2070.089160769272, 7018.298170182992, 7058.047163632895, 7071.222165561784, 7079.256678048782, 7085.822854428629, 3896.4350169225304, 4005.759654420744, 4009.599040095967, 4030.4760381150554, 4033.8588149414923, 2521.7856482199036, 2530.367408147963, 2653.7478939500716, 2682.752520078173, 2692.4749673813612, 775.6121939030485, 1576.5822057154862, 1584.9762253566205, 1669.1487341455822, 1722.2511079749338, 9550.235981121494, 9731.65939192132, 9748.0, 9752.512374381253, 9761.414315141114, 3641.198936234024, 3644.3986742187244, 3644.872429464956, 3714.1271801126713, 3714.665680088805, 7697.229637183479, 7705.537667739954, 7722.53664780115, 7723.691052357843, 7725.575093369806, 3994.5406278277787, 4021.658159056513, 4022.5172979242093, 4025.597440255951, 4029.7783621901076, 3724.2365315110337, 3727.9254414912093, 3730.9067273318383, 3734.178480734234, 3734.2158146788934, 2790.581412788098, 2825.3784167483122, 2980.569326723185, 3014.1861697341596, 3022.3955208958296, 923.5613083785282, 930.0467021303218, 931.0596297739332, 945.9290553208399, 949.378157306965, 795.244517708168, 813.4427916876958, 814.9918500815035, 836.9707060252983, 850.9531975741394, 6399.680015999182, 6435.806925792233, 6436.098946147543, 6441.935580644227, 6446.226452825597, 967.264878692199, 968.4409794006996, 987.9407235565889, 995.4475266227313, 996.5515518016921, 4963.6277279204205, 5020.949790502048, 5028.120078986163, 5031.647784655039, 5111.514406131486, 8040.437169398203, 8377.49735015901, 8378.12029736881, 8444.78888027792, 8597.097304783032, 8367.95816020916, 8574.0, 8581.95709021451, 8585.656573737106, 8593.44142630727, 6584.308647591934, 6608.140941677551, 6627.602343859384, 6684.598924064571, 6685.53201275906, 6057.394260574084, 6131.356207598316, 6166.753329866934, 6173.444390004921, 6180.567360284737, 7374.151972523014, 7393.482456228013, 7647.235276472308, 7654.923450765644, 7656.9234307658435, 7910.248526389983, 7964.800879978047, 8008.239217274349, 8013.719519816778, 8020.358371330163, 5882.764689412375, 6017.2779266488305, 6024.5481588881885, 6029.87940241184, 6043.456088952015, 5581.330240371181, 5697.572682048946, 6415.133956915756, 6454.0641606967665, 6477.838054048687, 5249.238860365149, 6014.278286605635, 6081.847953801191, 6107.755689772359, 6328.177336946167, 6065.120557519223, 6074.51403887679, 6151.538634602333, 6231.937680623136, 6320.273168585672, 6128.693565321805, 6178.042403427476, 6181.041938499539, 6181.35095814933, 6185.907211391923, 5531.3362396512675, 5651.321841378896, 5677.659340439587, 5681.4034526374135, 5682.687452190169, 5473.31583552056, 5514.228008078952, 5528.336599608073, 5533.391326954113, 5536.363318218457], "unit": "score", "name": "mootools.html", "value": 3957.139428070731}, {"lowerIsBetter": false, "replicates": [280.6646057960737, 284.19147525290555, 288.37710545222325, 291.09614646522544, 294.1997766076272, 5163.483651634835, 5291.338582677161, 5307.071262529056, 5322.840314790553, 5365.248865158881, 5234.241035049916, 5266.104762190427, 5274.077036518613, 5277.445868183833, 5291.68249905005, 4019.618136277049, 4021.095253567953, 4030.0, 4036.2734707752666, 4041.535223449297, 3778.3765678663126, 3850.0374906273432, 3924.62716041977, 3986.4418981342637, 4004.1991601679633, 3959.6634286085573, 3961.2869683456966, 3969.6427321541055, 3980.2835489611857, 3983.063979964706, 3720.6651401374006, 3852.6339997700175, 3972.503437070366, 3986.1429792594586, 3986.302397080514, 3359.5968483781858, 3408.84660190292, 3422.640622734627, 3424.178197232671, 3433.570803649544, 5038.168702164176, 5056.494350564951, 5060.5951523878, 5062.215356619729, 5064.746762661852, 4556.248219043887, 4559.316102584606, 4561.521040290755, 4566.13243483737, 4567.908641827178, 5301.973490132525, 5454.91817622736, 5479.835604931818, 5488.4785945335125, 5489.6980666063355, 3698.1863989922176, 3708.313961917054, 3710.9814450927843, 3739.5325584301963, 3740.7942563159017, 5747.59766816323, 5817.767289308465, 5820.796272130455, 5820.854478638025, 5823.67969761663, 3818.5608655004476, 3825.6556909877686, 3826.1773718650625, 3829.061879839457, 3833.271678381099, 3873.6126387361037, 3890.591487893787, 3893.610638936084, 3902.9804850975565, 3907.1794923066473, 4355.5426680198125, 4444.577765112309, 4452.354408610733, 4454.888627784331, 4527.750973696412, 5458.590605704588, 5460.235567020621, 5494.313210848644, 5503.504684578327, 5513.365962914316, 1340.7050448901225, 1362.455017992791, 1369.7739872920856, 1369.9520516781865, 1370.6847425092085, 903.9231665308391, 911.9270458363447, 912.9224015958717, 928.4522131942186, 928.8513837785922, 4869.63477739171, 4874.683145595525, 4879.585235255043, 4880.8779780505065, 4881.755912204447, 5747.051736463521, 5757.827265182052, 5760.049591817303, 5761.683107429131, 5762.30852297727, 4864.221724524059, 4866.659333846667, 4871.415430148405, 4875.0493653737185, 4879.56083952446, 3009.6689364169924, 3056.9847150764103, 3089.1350421881907, 3092.876284948622, 3095.5511450839504, 5421.701806400686, 5424.7016414096815, 5433.538149257357, 5435.103207970719, 5440.4287549807495, 5871.647701137946, 5877.735501902424, 5878.676672782953, 5883.294004719461, 5898.233229680114, 5424.321959755031, 5429.728513574306, 5432.103702889058, 5432.75552600134, 5435.510804027656, 5595.132754423071, 5715.514181294637, 5724.198612194379, 5727.770889164387, 5734.168545560954, 5599.468050535193, 5602.775888964396, 5605.32736071674, 5607.299087614048, 5609.719514024201, 5424.945750542444, 5428.728563571726, 5428.918566221589, 5430.0, 5430.864228394322, 3763.7929913855, 3861.7296789224483, 3862.517185351831, 3863.5750067493113, 3865.574786773509, 5714.628549144292, 5715.257016587817, 5717.113847353667, 5718.771249149988, 5719.313682357977, 5506.807261745819, 5508.283923090133, 5514.448555144453, 5514.558835293247, 5516.475934786189, 5511.779528818963, 5513.531349835149, 5519.172124181245, 5520.447955204448, 5526.723663816712, 5249.553787928069, 5381.838544843661, 5387.730613469389, 5388.919166212431, 5390.13757798766, 5336.359636843604, 5530.364008139116, 5534.612577119563, 5537.944620553904, 5543.916841247304, 5343.145096784496, 5346.0911645021215, 5455.236266922713, 5462.91805622908, 5465.37148227943], "unit": "score", "name": "prototype.html", "value": 4096.232087295512}, {"lowerIsBetter": false, "replicates": [671.3018460800768, 671.946244300456, 694.5728377048115, 699.5452955578874, 725.3109545931367, 10840.349579025264, 12114.81827772583, 12165.270083794956, 12233.632991010261, 12239.571614993478, 10976.506057227423, 11351.545938162464, 11360.60237891674, 11390.54437822486, 11394.829077563843, 462.9120467111238, 736.9520981136209, 747.6523416611275, 749.6401727170961, 749.8687729647318, 606.5026678123941, 752.086215248473, 765.5980610179672, 766.5285849202728, 767.1599598439727, 801.7033697531922, 806.052887856766, 809.7570728781371, 810.2586133687669, 810.4124509730427, 621.1459243540132, 630.7949916277182, 781.2421950707861, 800.5076877720219, 803.04036676172, 591.3081694417542, 592.1236569876606, 592.1413949772847, 592.4312659846553, 594.8245267646055, 10484.161267098614, 10507.73730656732, 10545.73635659107, 10554.947225263824, 10560.155187585051, 10538.625370727932, 10775.572047308851, 10937.343759374464, 11015.944920275348, 11154.163437742121, 8717.956410217908, 8854.424462409987, 8992.190702836711, 9006.234470070052, 9342.486163261017, 3144.2296637324002, 3152.4168028914723, 3178.539111828772, 3197.4244635965515, 3259.951100733491, 40618.0, 40739.7963010186, 40768.38847417291, 41077.58922410767, 41120.58879411197, 8943.195112439782, 9086.909130908738, 9130.771730706785, 9156.90117185942, 9207.493587852732, 13863.029587928748, 13902.721945561032, 13924.443022278996, 13930.58208253754, 13930.86069139316, 5912.23140991677, 5979.0, 6088.6042407243385, 6187.3503282155625, 6325.335839736854, 3520.718342532591, 3576.088097535112, 3584.211473475831, 3593.82030898454, 3700.962990370062, 2502.749725027483, 2527.696676398844, 2528.860912649785, 2531.873406329713, 2535.4168541235617, 434.5024946436313, 440.4560367945585, 452.9796159172845, 456.68032377335334, 464.79084412014055, 430.87719999799907, 457.6796242630172, 491.97540122993706, 502.38207005383583, 503.42358000089695, 6635.0, 6773.051772751819, 6822.522423430312, 6896.2069362023, 7137.89293160603, 449.4202478802308, 483.7798801545288, 492.2616075886171, 522.1775703267369, 534.5029122915726, 3083.321669232765, 3239.5642934629027, 3266.085496061059, 3306.9575990089174, 3316.369889720945, 44715.329270060975, 45368.0, 45491.31763023557, 45522.317165242544, 45584.77207613941, 39488.21023579512, 39706.60293397087, 40254.39618405726, 40687.79656101701, 40762.79618601888, 16601.41895033668, 16603.584910377096, 16767.916160419365, 16822.0, 16917.91541042287, 6254.781082662085, 6310.936890631035, 6415.486761059197, 6493.545451818327, 6767.93232067673, 27684.58473122945, 28366.85816570904, 28468.715312846605, 28709.28226794263, 29028.7097129026, 33557.0, 34204.14489637779, 34314.313713726086, 34383.140421488664, 37212.44181337228, 7784.92215077842, 7803.297703206738, 7813.0, 7817.0619525657285, 7878.487898286593, 8993.415427997159, 9114.13415725505, 9161.816763664823, 9162.0, 9185.448873067637, 8619.525926074126, 8721.869171962553, 8844.292456603585, 8845.159709827556, 8884.466931984101, 8376.623051962799, 8530.872036919576, 8586.82826343457, 8619.8707019396, 8626.741197764077, 8130.0, 8132.390070744599, 8203.958980205061, 8398.538080405391, 8414.284785793032, 7212.3148300911325, 7259.455540834564, 7379.3358597726465, 7506.361959233526, 7642.617869106633, 7473.43949203801, 7743.612819359122, 7786.4938778979185, 7814.374850011872, 7892.763217103496], "unit": "score", "name": "yui.html", "value": 5030.760351055508}], "name": "dromaeo_css", "value": 5827.770507577457}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 113.0, 109.0, 113.0, 114.0, 113.0, 103.0, 112.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [160.0, 141.0, 156.0, 168.0, 133.0, 156.0, 156.0, 130.0, 177.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 150.9}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 159.0, 161.0, 161.0, 160.0, 160.0, 161.0, 162.0, 164.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 97.0, 91.0, 72.0, 73.0, 73.0, 110.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 82.7}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 130.0, 97.0, 99.0, 98.0, 139.0, 98.0, 98.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 68.0, 66.0, 67.0, 66.0, 67.0, 77.0, 65.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 67.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [82.0, 92.0, 84.0, 91.0, 84.0, 83.0, 84.0, 84.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [124.0, 122.0, 130.0, 122.0, 129.0, 121.0, 128.0, 120.0, 121.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.7}, {"lowerIsBetter": true, "replicates": [158.0, 142.0, 152.0, 149.0, 151.0, 137.0, 149.0, 150.0, 151.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.7}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 71.0, 74.0, 72.0, 72.0, 71.0, 71.0, 71.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.8}], "name": "kraken", "value": 1532.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.52025767079166], "unit": "score", "name": "Richards", "value": 208.24649800000003}, {"lowerIsBetter": false, "replicates": [187.68768768768768], "unit": "score", "name": "DeltaBlue", "value": 352.2767040000001}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [2026.3157894736842], "unit": "score", "name": "RayTrace", "value": 365.18937662337675}, {"lowerIsBetter": false, "replicates": [805.8017727639001], "unit": "score", "name": "Earley", "value": 827.0805830000004}, {"lowerIsBetter": false, "replicates": [12407.407407407407], "unit": "score", "name": "Boyer", "value": 53.71492835820899}, {"lowerIsBetter": false, "replicates": [44782.608695652176], "unit": "score", "name": "RegExp", "value": 20.34238349514563}, {"lowerIsBetter": false, "replicates": [594.1770647653001], "unit": "score", "name": "Splay", "value": 137.14935300000005}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 18715.89225213779}]} 16:33:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "18715.89"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1532.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "5827.77"}}} 16:33:00 INFO - Return code: 0 16:33:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:33:00 INFO - # TBPL SUCCESS # 16:33:00 INFO - Running post-action listener: _resource_record_post_action 16:33:00 INFO - Running post-run listener: _resource_record_post_run 16:33:01 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 413696; Write bytes: 311541760; Read time: 324; Write time: 206300 16:33:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5476352; Read time: 0; Write time: 376 16:33:01 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 413696; Write bytes: 306065408; Read time: 324; Write time: 205924 16:33:01 INFO - Running post-run listener: _upload_blobber_files 16:33:01 INFO - Blob upload gear active. 16:33:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:33:01 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 16:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:33:01 INFO - (blobuploader) - INFO - Open directory for files ... 16:33:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:33:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:33:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:03 INFO - (blobuploader) - INFO - Done attempting. 16:33:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:33:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:33:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:05 INFO - (blobuploader) - INFO - Done attempting. 16:33:05 INFO - (blobuploader) - INFO - Iteration through files over. 16:33:05 INFO - Return code: 0 16:33:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:33:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:33:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d767709c36bebc8cecf479ea061290bd548420fd759bc75a8400a0aff684ee74acc6b74006b150f95a5d241fa3e7d771a006e0053c0731a42fabb89272c36f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4aafc10205a11b92e7c06677a7ea0189ef288822df10818e326133f11cf5d4924e4f154b723f3c14d32c882b13edc289ea066c101081917daab858c153f76fd"} 16:33:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:33:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:33:05 INFO - Contents: 16:33:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d767709c36bebc8cecf479ea061290bd548420fd759bc75a8400a0aff684ee74acc6b74006b150f95a5d241fa3e7d771a006e0053c0731a42fabb89272c36f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4aafc10205a11b92e7c06677a7ea0189ef288822df10818e326133f11cf5d4924e4f154b723f3c14d32c882b13edc289ea066c101081917daab858c153f76fd"} 16:33:05 INFO - Running post-run listener: copy_logs_to_upload_dir 16:33:05 INFO - Copying logs to upload dir... 16:33:05 INFO - mkdir: /builds/slave/test/build/upload/logs 16:33:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.722632 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-01-15 16:33:04.901155) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 16:33:04.904382) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1d767709c36bebc8cecf479ea061290bd548420fd759bc75a8400a0aff684ee74acc6b74006b150f95a5d241fa3e7d771a006e0053c0731a42fabb89272c36f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4aafc10205a11b92e7c06677a7ea0189ef288822df10818e326133f11cf5d4924e4f154b723f3c14d32c882b13edc289ea066c101081917daab858c153f76fd"} build_url:https://queue.taskcluster.net/v1/task/aro-i2jNSLuZZyiq6RbnZw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/aro-i2jNSLuZZyiq6RbnZw/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/Firefox-Non-PGO/sha512/1d767709c36bebc8cecf479ea061290bd548420fd759bc75a8400a0aff684ee74acc6b74006b150f95a5d241fa3e7d771a006e0053c0731a42fabb89272c36f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4aafc10205a11b92e7c06677a7ea0189ef288822df10818e326133f11cf5d4924e4f154b723f3c14d32c882b13edc289ea066c101081917daab858c153f76fd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 16:33:04.930447) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 16:33:04.930995) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1452902958.732414-1940083452 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 16:33:05.012620) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 16:33:05.013007) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 16:33:05.013387) ========= ========= Total master_lag: 0.29 =========