builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1452687349.8 results: success (0) buildid: 20160113025830 builduid: e4188deaab8b4e19bd6bdf9c93b5bf37 revision: 531d1f6d1cde1182e9f7f9dff81a4fc5abc0a601 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 04:15:49.800772) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 04:15:49.801220) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 04:15:49.801611) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006486 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 04:15:49.835249) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 04:15:49.835578) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 04:15:49.891838) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:15:49.892158) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004595 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:15:49.953856) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 04:15:49.954155) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 04:15:49.954628) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:15:49.954967) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 04:15:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-01-13 04:15:50 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178172 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:15:50.150553) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:15:50.150903) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019728 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:15:50.208282) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 04:15:50.208651) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 531d1f6d1cde1182e9f7f9dff81a4fc5abc0a601 --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 531d1f6d1cde1182e9f7f9dff81a4fc5abc0a601 --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=20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 04:15:50,723 truncating revision to first 12 chars 2016-01-13 04:15:50,723 Setting DEBUG logging. 2016-01-13 04:15:50,723 attempt 1/10 2016-01-13 04:15:50,723 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/531d1f6d1cde?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 04:15:51,462 unpacking tar archive at: mozilla-central-531d1f6d1cde/testing/mozharness/ program finished with exit code 0 elapsedTime=1.041118 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 04:15:51.264353) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 04:15:51.264732) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 04:15:51.306489) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 04:15:51.306869) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 04:15:51.307365) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-13 04:15:51.307718) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:15:51 INFO - MultiFileLogger online at 20160113 04:15:51 in /builds/slave/test 04:15:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 04:15:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:15:51 INFO - {'append_to_log': False, 04:15:51 INFO - 'base_work_dir': '/builds/slave/test', 04:15:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:15:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:15:51 INFO - 'branch': 'Firefox-Non-PGO', 04:15:51 INFO - 'buildbot_json_path': 'buildprops.json', 04:15:51 INFO - 'config_files': ('talos/linux_config.py',), 04:15:51 INFO - 'default_actions': ('clobber', 04:15:51 INFO - 'read-buildbot-config', 04:15:51 INFO - 'download-and-extract', 04:15:51 INFO - 'populate-webroot', 04:15:51 INFO - 'create-virtualenv', 04:15:51 INFO - 'install', 04:15:51 INFO - 'run-tests'), 04:15:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:15:51 INFO - 'download_minidump_stackwalk': True, 04:15:51 INFO - 'download_symbols': 'ondemand', 04:15:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:15:51 INFO - 'tooltool.py': '/tools/tooltool.py', 04:15:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:15:51 INFO - '/tools/misc-python/virtualenv.py')}, 04:15:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:15:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:15:51 INFO - 'installer_path': 'installer.exe', 04:15:51 INFO - 'log_level': 'info', 04:15:51 INFO - 'log_name': 'talos', 04:15:51 INFO - 'log_to_console': True, 04:15:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:15:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:15:51 INFO - 'opt_config_files': (), 04:15:51 INFO - 'pip_index': False, 04:15:51 INFO - 'sps_profile': False, 04:15:51 INFO - 'sps_profile_interval': 0, 04:15:51 INFO - 'suite': 'dromaeojs-e10s', 04:15:51 INFO - 'system_bits': '32', 04:15:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:15:51 INFO - 'title': 'talos-linux64-ix-015', 04:15:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:15:51 INFO - 'use_talos_json': True, 04:15:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:15:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:15:51 INFO - 'work_dir': 'build'} 04:15:51 INFO - ##### 04:15:51 INFO - ##### Running clobber step. 04:15:51 INFO - ##### 04:15:51 INFO - Running pre-action listener: _resource_record_pre_action 04:15:51 INFO - Running main action method: clobber 04:15:51 INFO - rmtree: /builds/slave/test/build 04:15:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:15:52 INFO - Running post-action listener: _resource_record_post_action 04:15:52 INFO - ##### 04:15:52 INFO - ##### Running read-buildbot-config step. 04:15:52 INFO - ##### 04:15:52 INFO - Running pre-action listener: _resource_record_pre_action 04:15:52 INFO - Running main action method: read_buildbot_config 04:15:52 INFO - Using buildbot properties: 04:15:52 INFO - { 04:15:52 INFO - "project": "", 04:15:52 INFO - "product": "firefox", 04:15:52 INFO - "script_repo_revision": "production", 04:15:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:15:52 INFO - "repository": "", 04:15:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:15:52 INFO - "buildid": "20160113025830", 04:15:52 INFO - "pgo_build": "False", 04:15:52 INFO - "basedir": "/builds/slave/test", 04:15:52 INFO - "buildnumber": 171, 04:15:52 INFO - "slavename": "talos-linux64-ix-015", 04:15:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:15:52 INFO - "platform": "ubuntu64_hw", 04:15:52 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:15:52 INFO - "branch": "mozilla-central", 04:15:52 INFO - "repo_path": "mozilla-central", 04:15:52 INFO - "revision": "531d1f6d1cde1182e9f7f9dff81a4fc5abc0a601", 04:15:52 INFO - "stage_platform": "linux64", 04:15:52 INFO - "builduid": "e4188deaab8b4e19bd6bdf9c93b5bf37", 04:15:52 INFO - "slavebuilddir": "test" 04:15:52 INFO - } 04:15:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:15:52 INFO - Running post-action listener: _resource_record_post_action 04:15:52 INFO - ##### 04:15:52 INFO - ##### Running download-and-extract step. 04:15:52 INFO - ##### 04:15:52 INFO - Running pre-action listener: _resource_record_pre_action 04:15:52 INFO - Running main action method: download_and_extract 04:15:52 INFO - mkdir: /builds/slave/test/build/tests 04:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:52 INFO - https://queue.taskcluster.net/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:15:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/test_packages.json 04:15:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/test_packages.json 04:15:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:15:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:15:55 INFO - Downloaded 1448 bytes. 04:15:55 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:15:55 INFO - Using the following test package requirements: 04:15:55 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:15:55 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:15:55 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:15:55 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:55 INFO - u'jsshell-linux-x86_64.zip'], 04:15:55 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:15:55 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:15:55 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:15:55 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:15:55 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:15:55 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:15:55 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:15:55 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:55 INFO - https://queue.taskcluster.net/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:15:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:15:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:15:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/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 04:15:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/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 04:15:57 INFO - Downloaded 22760516 bytes. 04:15:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:15:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:15:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:15:59 INFO - Return code: 0 04:15:59 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 04:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:59 INFO - https://queue.taskcluster.net/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:15:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:15:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:15:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/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 04:15:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/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 04:16:01 INFO - Downloaded 22760516 bytes. 04:16:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:16:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:16:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:16:02 INFO - Return code: 0 04:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:02 INFO - https://queue.taskcluster.net/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:16:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/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 04:16:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/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 04:16:04 INFO - Downloaded 11132279 bytes. 04:16:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:16:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:16:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:16:04 INFO - Return code: 0 04:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:04 INFO - https://queue.taskcluster.net/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:16:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:16:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:16:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/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 04:16:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/azbpTzfQTTGbyg0p4T99zg/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 04:16:08 INFO - Downloaded 53905873 bytes. 04:16:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:16:08 INFO - mkdir: /builds/slave/test/properties 04:16:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:16:08 INFO - Writing to file /builds/slave/test/properties/build_url 04:16:08 INFO - Contents: 04:16:08 INFO - build_url:https://queue.taskcluster.net/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:16:08 INFO - Running post-action listener: _resource_record_post_action 04:16:08 INFO - Running post-action listener: set_extra_try_arguments 04:16:08 INFO - ##### 04:16:08 INFO - ##### Running populate-webroot step. 04:16:08 INFO - ##### 04:16:08 INFO - Running pre-action listener: _resource_record_pre_action 04:16:08 INFO - Running main action method: populate_webroot 04:16:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:16:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:16:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:16:08 INFO - '--tppagecycles', 04:16:08 INFO - '7'], 04:16:08 INFO - 'tests': ['tsvgm']}}, 04:16:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:16:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:16:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:16:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:16:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:16:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:16:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:08 INFO - 'talos_options': ['--e10s'], 04:16:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:16:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:08 INFO - 'tests': ['damp', 'tps']}, 04:16:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:08 INFO - 'talos_options': ['--e10s'], 04:16:08 INFO - 'tests': ['damp', 'tps']}, 04:16:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:16:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:16:08 INFO - 'other': {'tests': ['a11yr', 04:16:08 INFO - 'ts_paint', 04:16:08 INFO - 'tpaint', 04:16:08 INFO - 'sessionrestore', 04:16:08 INFO - 'sessionrestore_no_auto_restore']}, 04:16:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:16:08 INFO - 'tests': ['a11yr', 04:16:08 INFO - 'ts_paint', 04:16:08 INFO - 'tpaint', 04:16:08 INFO - 'sessionrestore', 04:16:08 INFO - 'sessionrestore_no_auto_restore']}, 04:16:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:16:08 INFO - 'tests': ['a11yr', 04:16:08 INFO - 'ts_paint', 04:16:08 INFO - 'tpaint', 04:16:08 INFO - 'sessionrestore', 04:16:08 INFO - 'sessionrestore_no_auto_restore']}, 04:16:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:16:08 INFO - 'tests': ['a11yr', 04:16:08 INFO - 'ts_paint', 04:16:08 INFO - 'tpaint', 04:16:08 INFO - 'sessionrestore', 04:16:08 INFO - 'sessionrestore_no_auto_restore']}, 04:16:08 INFO - 'other_l64': {'tests': ['a11yr', 04:16:08 INFO - 'ts_paint', 04:16:08 INFO - 'tpaint', 04:16:08 INFO - 'sessionrestore', 04:16:08 INFO - 'sessionrestore_no_auto_restore']}, 04:16:08 INFO - 'other_nol64': {'tests': ['a11yr', 04:16:08 INFO - 'ts_paint', 04:16:08 INFO - 'tpaint', 04:16:08 INFO - 'sessionrestore', 04:16:08 INFO - 'sessionrestore_no_auto_restore']}, 04:16:08 INFO - 'svgr': {'tests': ['tsvgx', 04:16:08 INFO - 'tsvgr_opacity', 04:16:08 INFO - 'tart', 04:16:08 INFO - 'tscrollx', 04:16:08 INFO - 'cart']}, 04:16:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:16:08 INFO - 'tests': ['tsvgx', 04:16:08 INFO - 'tsvgr_opacity', 04:16:08 INFO - 'tart', 04:16:08 INFO - 'tscrollx', 04:16:08 INFO - 'cart']}, 04:16:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:08 INFO - 'tests': ['tp5o']}, 04:16:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:08 INFO - 'talos_options': ['--e10s'], 04:16:08 INFO - 'tests': ['tp5o']}, 04:16:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:08 INFO - 'talos_options': ['--xperf_path', 04:16:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:08 INFO - 'tests': ['tp5n']}, 04:16:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:16:08 INFO - 'talos_options': ['--e10s', 04:16:08 INFO - '--xperf_path', 04:16:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:16:08 INFO - 'tests': ['tp5n']}}, 04:16:08 INFO - 'talos.zip': {'path': '', 04:16:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:16:08 INFO - Running post-action listener: _resource_record_post_action 04:16:08 INFO - ##### 04:16:08 INFO - ##### Running create-virtualenv step. 04:16:08 INFO - ##### 04:16:08 INFO - Running pre-action listener: _resource_record_pre_action 04:16:08 INFO - Running main action method: create_virtualenv 04:16:08 INFO - Creating virtualenv /builds/slave/test/build/venv 04:16:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:16:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:16:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:16:08 INFO - Using real prefix '/usr' 04:16:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:16:08 INFO - Installing distribute.............................................................................................................................................................................................done. 04:16:10 INFO - Installing pip.................done. 04:16:10 INFO - Return code: 0 04:16:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:10 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 0x7f0228260f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11803d0>, '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 0x10ebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:16:10 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 04:16:10 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 04:16:10 INFO - Using env: {'DISPLAY': ':0', 04:16:10 INFO - 'HOME': '/home/cltbld', 04:16:10 INFO - 'LANG': 'en_US.UTF-8', 04:16:10 INFO - 'LANGUAGE': 'en_US:en', 04:16:10 INFO - 'LOGNAME': 'cltbld', 04:16:10 INFO - 'MAIL': '/var/mail/cltbld', 04:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:10 INFO - 'MOZ_NO_REMOTE': '1', 04:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:10 INFO - 'NO_EM_RESTART': '1', 04:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:10 INFO - 'PWD': '/builds/slave/test', 04:16:10 INFO - 'SHELL': '/bin/bash', 04:16:10 INFO - 'SHLVL': '1', 04:16:10 INFO - 'TERM': 'linux', 04:16:10 INFO - 'TMOUT': '86400', 04:16:10 INFO - 'USER': 'cltbld', 04:16:10 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123', 04:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:10 INFO - '_': '/tools/buildbot/bin/python'} 04:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:16:10 INFO - Cleaning up... 04:16:10 INFO - Return code: 0 04:16:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:10 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 0x7f0228260f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11803d0>, '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 0x10ebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:16:10 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 04:16:10 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 04:16:10 INFO - Using env: {'DISPLAY': ':0', 04:16:10 INFO - 'HOME': '/home/cltbld', 04:16:10 INFO - 'LANG': 'en_US.UTF-8', 04:16:10 INFO - 'LANGUAGE': 'en_US:en', 04:16:10 INFO - 'LOGNAME': 'cltbld', 04:16:10 INFO - 'MAIL': '/var/mail/cltbld', 04:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:10 INFO - 'MOZ_NO_REMOTE': '1', 04:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:10 INFO - 'NO_EM_RESTART': '1', 04:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:10 INFO - 'PWD': '/builds/slave/test', 04:16:10 INFO - 'SHELL': '/bin/bash', 04:16:10 INFO - 'SHLVL': '1', 04:16:10 INFO - 'TERM': 'linux', 04:16:10 INFO - 'TMOUT': '86400', 04:16:10 INFO - 'USER': 'cltbld', 04:16:10 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123', 04:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:10 INFO - '_': '/tools/buildbot/bin/python'} 04:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:11 INFO - Downloading/unpacking psutil>=0.7.1 04:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:12 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:16:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:16:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:16:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:12 INFO - Installing collected packages: psutil 04:16:12 INFO - Running setup.py install for psutil 04:16:13 INFO - building 'psutil._psutil_linux' extension 04:16:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:16:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:16:13 INFO - building 'psutil._psutil_posix' extension 04:16:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:16:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:16:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:16:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:16:13 INFO - Successfully installed psutil 04:16:13 INFO - Cleaning up... 04:16:13 INFO - Return code: 0 04:16:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:16: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')]} 04:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16: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')]} 04:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16: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', '--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 0x7f0228260f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11803d0>, '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 0x10ebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:16:13 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 04:16:13 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 04:16:13 INFO - Using env: {'DISPLAY': ':0', 04:16:13 INFO - 'HOME': '/home/cltbld', 04:16:13 INFO - 'LANG': 'en_US.UTF-8', 04:16:13 INFO - 'LANGUAGE': 'en_US:en', 04:16:13 INFO - 'LOGNAME': 'cltbld', 04:16:13 INFO - 'MAIL': '/var/mail/cltbld', 04:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:13 INFO - 'MOZ_NO_REMOTE': '1', 04:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:13 INFO - 'NO_EM_RESTART': '1', 04:16:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:13 INFO - 'PWD': '/builds/slave/test', 04:16:13 INFO - 'SHELL': '/bin/bash', 04:16:13 INFO - 'SHLVL': '1', 04:16:13 INFO - 'TERM': 'linux', 04:16:13 INFO - 'TMOUT': '86400', 04:16:13 INFO - 'USER': 'cltbld', 04:16:13 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123', 04:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:13 INFO - '_': '/tools/buildbot/bin/python'} 04:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:16:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:16:15 INFO - Installing collected packages: mozsystemmonitor 04:16:15 INFO - Running setup.py install for mozsystemmonitor 04:16:15 INFO - Successfully installed mozsystemmonitor 04:16:15 INFO - Cleaning up... 04:16:15 INFO - Return code: 0 04:16:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0228260f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11803d0>, '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 0x10ebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:16:15 INFO - Using env: {'DISPLAY': ':0', 04:16:15 INFO - 'HOME': '/home/cltbld', 04:16:15 INFO - 'LANG': 'en_US.UTF-8', 04:16:15 INFO - 'LANGUAGE': 'en_US:en', 04:16:15 INFO - 'LOGNAME': 'cltbld', 04:16:15 INFO - 'MAIL': '/var/mail/cltbld', 04:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:15 INFO - 'MOZ_NO_REMOTE': '1', 04:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:15 INFO - 'NO_EM_RESTART': '1', 04:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:15 INFO - 'PWD': '/builds/slave/test', 04:16:15 INFO - 'SHELL': '/bin/bash', 04:16:15 INFO - 'SHLVL': '1', 04:16:15 INFO - 'TERM': 'linux', 04:16:15 INFO - 'TMOUT': '86400', 04:16:15 INFO - 'USER': 'cltbld', 04:16:15 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123', 04:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:15 INFO - '_': '/tools/buildbot/bin/python'} 04:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:15 INFO - Downloading/unpacking blobuploader==1.2.4 04:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:17 INFO - Downloading blobuploader-1.2.4.tar.gz 04:16:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:16:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:16:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:16:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:16:18 INFO - Downloading docopt-0.6.1.tar.gz 04:16:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:16:18 INFO - Installing collected packages: blobuploader, requests, docopt 04:16:18 INFO - Running setup.py install for blobuploader 04:16:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:16:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:16:18 INFO - Running setup.py install for requests 04:16:18 INFO - Running setup.py install for docopt 04:16:18 INFO - Successfully installed blobuploader requests docopt 04:16:18 INFO - Cleaning up... 04:16:18 INFO - Return code: 0 04:16:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:18 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 0x7f0228260f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11803d0>, '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 0x10ebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:16:18 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 04:16:18 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 04:16:18 INFO - Using env: {'DISPLAY': ':0', 04:16:18 INFO - 'HOME': '/home/cltbld', 04:16:18 INFO - 'LANG': 'en_US.UTF-8', 04:16:18 INFO - 'LANGUAGE': 'en_US:en', 04:16:18 INFO - 'LOGNAME': 'cltbld', 04:16:18 INFO - 'MAIL': '/var/mail/cltbld', 04:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:18 INFO - 'MOZ_NO_REMOTE': '1', 04:16:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:18 INFO - 'NO_EM_RESTART': '1', 04:16:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:18 INFO - 'PWD': '/builds/slave/test', 04:16:18 INFO - 'SHELL': '/bin/bash', 04:16:18 INFO - 'SHLVL': '1', 04:16:18 INFO - 'TERM': 'linux', 04:16:18 INFO - 'TMOUT': '86400', 04:16:18 INFO - 'USER': 'cltbld', 04:16:18 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123', 04:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:18 INFO - '_': '/tools/buildbot/bin/python'} 04:16:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:19 INFO - Running setup.py (path:/tmp/pip-7wlshQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:19 INFO - Running setup.py (path:/tmp/pip-04DxUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:19 INFO - Running setup.py (path:/tmp/pip-baKZDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:19 INFO - Running setup.py (path:/tmp/pip-5xKCI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:19 INFO - Running setup.py (path:/tmp/pip-oWDERJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:19 INFO - Running setup.py (path:/tmp/pip-ypb1x3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:19 INFO - Running setup.py (path:/tmp/pip-mmi6BK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:19 INFO - Running setup.py (path:/tmp/pip-lFe0qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:19 INFO - Running setup.py (path:/tmp/pip-6BKkRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:19 INFO - Running setup.py (path:/tmp/pip-JCaBRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:19 INFO - Running setup.py (path:/tmp/pip-HfAxYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:19 INFO - Running setup.py (path:/tmp/pip-uLDIzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:20 INFO - Running setup.py (path:/tmp/pip-YjrFZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:20 INFO - Running setup.py (path:/tmp/pip-yW7Pfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:20 INFO - Running setup.py (path:/tmp/pip-tnGhC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:20 INFO - Running setup.py (path:/tmp/pip-Bd5isU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:20 INFO - Running setup.py (path:/tmp/pip-JXqrmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:16:20 INFO - Running setup.py install for manifestparser 04:16:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:16:20 INFO - Running setup.py install for mozcrash 04:16:20 INFO - Running setup.py install for mozdebug 04:16:20 INFO - Running setup.py install for mozdevice 04:16:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:16:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:16:20 INFO - Running setup.py install for mozfile 04:16:20 INFO - Running setup.py install for mozhttpd 04:16:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:16:20 INFO - Running setup.py install for mozinfo 04:16:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:16:21 INFO - Running setup.py install for mozInstall 04:16:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:16:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:16:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:16:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:16:21 INFO - Running setup.py install for mozleak 04:16:21 INFO - Running setup.py install for mozlog 04:16:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:16:21 INFO - Running setup.py install for moznetwork 04:16:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:16:21 INFO - Running setup.py install for mozprocess 04:16:21 INFO - Running setup.py install for mozprofile 04:16:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:16:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:16:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:16:21 INFO - Running setup.py install for mozrunner 04:16:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:16:21 INFO - Running setup.py install for mozscreenshot 04:16:21 INFO - Running setup.py install for moztest 04:16:22 INFO - Running setup.py install for mozversion 04:16:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:16:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:16:22 INFO - Cleaning up... 04:16:22 INFO - Return code: 0 04:16:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:22 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 0x7f0228260f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11803d0>, '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 0x10ebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:16:22 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 04:16:22 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 04:16:22 INFO - Using env: {'DISPLAY': ':0', 04:16:22 INFO - 'HOME': '/home/cltbld', 04:16:22 INFO - 'LANG': 'en_US.UTF-8', 04:16:22 INFO - 'LANGUAGE': 'en_US:en', 04:16:22 INFO - 'LOGNAME': 'cltbld', 04:16:22 INFO - 'MAIL': '/var/mail/cltbld', 04:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:22 INFO - 'MOZ_NO_REMOTE': '1', 04:16:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:22 INFO - 'NO_EM_RESTART': '1', 04:16:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:22 INFO - 'PWD': '/builds/slave/test', 04:16:22 INFO - 'SHELL': '/bin/bash', 04:16:22 INFO - 'SHLVL': '1', 04:16:22 INFO - 'TERM': 'linux', 04:16:22 INFO - 'TMOUT': '86400', 04:16:22 INFO - 'USER': 'cltbld', 04:16:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123', 04:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:22 INFO - '_': '/tools/buildbot/bin/python'} 04:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:22 INFO - Running setup.py (path:/tmp/pip-ZWcuVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:22 INFO - Running setup.py (path:/tmp/pip-CE8D76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:22 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)) 04:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:22 INFO - Running setup.py (path:/tmp/pip-Sp5p6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:22 INFO - Running setup.py (path:/tmp/pip-reQ3Yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:22 INFO - Running setup.py (path:/tmp/pip-dN6p6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:22 INFO - Running setup.py (path:/tmp/pip-TfybHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:22 INFO - Running setup.py (path:/tmp/pip-aRZaD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:22 INFO - Running setup.py (path:/tmp/pip-aaIMc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:22 INFO - Running setup.py (path:/tmp/pip-AqpgEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:23 INFO - Running setup.py (path:/tmp/pip-S4hTfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:23 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)) 04:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:23 INFO - Running setup.py (path:/tmp/pip-HsemHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:23 INFO - Running setup.py (path:/tmp/pip-Q5bpvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:23 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)) 04:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:23 INFO - Running setup.py (path:/tmp/pip-QGRyEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:23 INFO - Running setup.py (path:/tmp/pip-iAXaRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:23 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)) 04:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:23 INFO - Running setup.py (path:/tmp/pip-By2qxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:23 INFO - Running setup.py (path:/tmp/pip-fzMHEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:23 INFO - Running setup.py (path:/tmp/pip-7bI4Jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:16:23 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)) 04:16:23 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)) 04:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:16:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:25 INFO - Downloading blessings-1.5.1.tar.gz 04:16:25 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 04:16:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:16:25 INFO - Installing collected packages: blessings 04:16:25 INFO - Running setup.py install for blessings 04:16:25 INFO - Successfully installed blessings 04:16:25 INFO - Cleaning up... 04:16:25 INFO - Return code: 0 04:16:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:16:25 INFO - Reading from file tmpfile_stdout 04:16:25 INFO - Current package versions: 04:16:25 INFO - argparse == 1.2.1 04:16:25 INFO - blessings == 1.5.1 04:16:25 INFO - blobuploader == 1.2.4 04:16:25 INFO - docopt == 0.6.1 04:16:25 INFO - manifestparser == 1.1 04:16:25 INFO - mozInstall == 1.12 04:16:25 INFO - mozcrash == 0.16 04:16:25 INFO - mozdebug == 0.1 04:16:25 INFO - mozdevice == 0.48 04:16:25 INFO - mozfile == 1.2 04:16:25 INFO - mozhttpd == 0.7 04:16:25 INFO - mozinfo == 0.9 04:16:25 INFO - mozleak == 0.1 04:16:25 INFO - mozlog == 3.1 04:16:25 INFO - moznetwork == 0.27 04:16:25 INFO - mozprocess == 0.22 04:16:25 INFO - mozprofile == 0.28 04:16:25 INFO - mozrunner == 6.11 04:16:25 INFO - mozscreenshot == 0.1 04:16:25 INFO - mozsystemmonitor == 0.0 04:16:25 INFO - moztest == 0.7 04:16:25 INFO - mozversion == 1.4 04:16:25 INFO - psutil == 3.1.1 04:16:25 INFO - requests == 1.2.3 04:16:25 INFO - wsgiref == 0.1.2 04:16:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:25 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 0x7f0228260f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11803d0>, '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 0x10ebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:16:25 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 04:16:25 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 04:16:25 INFO - Using env: {'DISPLAY': ':0', 04:16:25 INFO - 'HOME': '/home/cltbld', 04:16:25 INFO - 'LANG': 'en_US.UTF-8', 04:16:25 INFO - 'LANGUAGE': 'en_US:en', 04:16:25 INFO - 'LOGNAME': 'cltbld', 04:16:25 INFO - 'MAIL': '/var/mail/cltbld', 04:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:25 INFO - 'MOZ_NO_REMOTE': '1', 04:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:25 INFO - 'NO_EM_RESTART': '1', 04:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:25 INFO - 'PWD': '/builds/slave/test', 04:16:25 INFO - 'SHELL': '/bin/bash', 04:16:25 INFO - 'SHLVL': '1', 04:16:25 INFO - 'TERM': 'linux', 04:16:25 INFO - 'TMOUT': '86400', 04:16:25 INFO - 'USER': 'cltbld', 04:16:25 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123', 04:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:25 INFO - '_': '/tools/buildbot/bin/python'} 04:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:16:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:16:26 INFO - Cleaning up... 04:16:26 INFO - Return code: 0 04:16:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:26 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 0x7f0228260f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11803d0>, '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 0x10ebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:16:26 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 04:16:26 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 04:16:26 INFO - Using env: {'DISPLAY': ':0', 04:16:26 INFO - 'HOME': '/home/cltbld', 04:16:26 INFO - 'LANG': 'en_US.UTF-8', 04:16:26 INFO - 'LANGUAGE': 'en_US:en', 04:16:26 INFO - 'LOGNAME': 'cltbld', 04:16:26 INFO - 'MAIL': '/var/mail/cltbld', 04:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:26 INFO - 'MOZ_NO_REMOTE': '1', 04:16:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:26 INFO - 'NO_EM_RESTART': '1', 04:16:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:26 INFO - 'PWD': '/builds/slave/test', 04:16:26 INFO - 'SHELL': '/bin/bash', 04:16:26 INFO - 'SHLVL': '1', 04:16:26 INFO - 'TERM': 'linux', 04:16:26 INFO - 'TMOUT': '86400', 04:16:26 INFO - 'USER': 'cltbld', 04:16:26 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123', 04:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:26 INFO - '_': '/tools/buildbot/bin/python'} 04:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:26 INFO - Downloading/unpacking jsonschema 04:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:16:27 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 04:16:27 INFO - Downloading/unpacking functools32 (from jsonschema) 04:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:28 INFO - Downloading functools32-3.2.3-2.tar.gz 04:16:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:16:28 INFO - warning: no files found matching '*.txt' 04:16:28 INFO - no previously-included directories found matching 'build' 04:16:28 INFO - no previously-included directories found matching 'dist' 04:16:28 INFO - no previously-included directories found matching '.git*' 04:16:28 INFO - Installing collected packages: jsonschema, functools32 04:16:28 INFO - Running setup.py install for functools32 04:16:28 INFO - warning: no files found matching '*.txt' 04:16:28 INFO - no previously-included directories found matching 'build' 04:16:28 INFO - no previously-included directories found matching 'dist' 04:16:28 INFO - no previously-included directories found matching '.git*' 04:16:28 INFO - Successfully installed jsonschema functools32 04:16:28 INFO - Cleaning up... 04:16:28 INFO - Return code: 0 04:16:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:28 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 0x7f0228260f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11803d0>, '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 0x10ebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec360>, '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': '20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:16:28 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 04:16:28 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 04:16:28 INFO - Using env: {'DISPLAY': ':0', 04:16:28 INFO - 'HOME': '/home/cltbld', 04:16:28 INFO - 'LANG': 'en_US.UTF-8', 04:16:28 INFO - 'LANGUAGE': 'en_US:en', 04:16:28 INFO - 'LOGNAME': 'cltbld', 04:16:28 INFO - 'MAIL': '/var/mail/cltbld', 04:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:28 INFO - 'MOZ_NO_REMOTE': '1', 04:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:28 INFO - 'NO_EM_RESTART': '1', 04:16:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:28 INFO - 'PWD': '/builds/slave/test', 04:16:28 INFO - 'SHELL': '/bin/bash', 04:16:28 INFO - 'SHLVL': '1', 04:16:28 INFO - 'TERM': 'linux', 04:16:28 INFO - 'TMOUT': '86400', 04:16:28 INFO - 'USER': 'cltbld', 04:16:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123', 04:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:28 INFO - '_': '/tools/buildbot/bin/python'} 04:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:28 INFO - Downloading/unpacking flake8 04:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:16:30 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 04:16:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:16:30 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 04:16:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:30 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 04:16:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:16:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:16:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:16:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:16:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:16:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:16:30 INFO - no previously-included directories found matching 'docs/_build' 04:16:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:16:31 INFO - Running setup.py install for pep8 04:16:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:16:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:16:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:16:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:16:31 INFO - no previously-included directories found matching 'docs/_build' 04:16:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:16:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:16:31 INFO - Cleaning up... 04:16:31 INFO - Return code: 0 04:16:31 INFO - Running post-action listener: _resource_record_post_action 04:16:31 INFO - Running post-action listener: _start_resource_monitoring 04:16:31 INFO - Starting resource monitoring. 04:16:31 INFO - ##### 04:16:31 INFO - ##### Running install step. 04:16:31 INFO - ##### 04:16:31 INFO - Running pre-action listener: _resource_record_pre_action 04:16:31 INFO - Running main action method: install 04:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:16:31 INFO - Reading from file tmpfile_stdout 04:16:31 INFO - Detecting whether we're running mozinstall >=1.0... 04:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:16:31 INFO - Reading from file tmpfile_stdout 04:16:31 INFO - Output received: 04:16:31 INFO - Usage: mozinstall [options] installer 04:16:31 INFO - Options: 04:16:31 INFO - -h, --help show this help message and exit 04:16:31 INFO - -d DEST, --destination=DEST 04:16:31 INFO - Directory to install application into. [default: 04:16:31 INFO - "/builds/slave/test"] 04:16:31 INFO - --app=APP Application being installed. [default: firefox] 04:16:31 INFO - mkdir: /builds/slave/test/build/application 04:16:31 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'] 04:16:31 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 04:16:47 INFO - Reading from file tmpfile_stdout 04:16:47 INFO - Output received: 04:16:47 INFO - /builds/slave/test/build/application/firefox/firefox 04:16:47 INFO - Running post-action listener: _resource_record_post_action 04:16:47 INFO - ##### 04:16:47 INFO - ##### Running run-tests step. 04:16:47 INFO - ##### 04:16:47 INFO - Running pre-action listener: _resource_record_pre_action 04:16:47 INFO - Running main action method: run_tests 04:16:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:16:47 INFO - Python 2.7.3 04:16:47 INFO - Return code: 0 04:16:47 INFO - grabbing minidump binary from tooltool 04:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:47 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 0x11803d0>, '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 0x10ebed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:16:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:16:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:16:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:16:47 INFO - Return code: 0 04:16:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:16:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:16:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:16:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:16:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:16:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:16:48 INFO - Return code: 0 04:16:48 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:16:48 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:16:48 INFO - Using env: {'DISPLAY': ':0', 04:16:48 INFO - 'HOME': '/home/cltbld', 04:16:48 INFO - 'LANG': 'en_US.UTF-8', 04:16:48 INFO - 'LANGUAGE': 'en_US:en', 04:16:48 INFO - 'LOGNAME': 'cltbld', 04:16:48 INFO - 'MAIL': '/var/mail/cltbld', 04:16:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:16:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:48 INFO - 'MOZ_NO_REMOTE': '1', 04:16:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:48 INFO - 'NO_EM_RESTART': '1', 04:16:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:48 INFO - 'PWD': '/builds/slave/test', 04:16:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:16:48 INFO - 'SHELL': '/bin/bash', 04:16:48 INFO - 'SHLVL': '1', 04:16:48 INFO - 'TERM': 'linux', 04:16:48 INFO - 'TMOUT': '86400', 04:16:48 INFO - 'USER': 'cltbld', 04:16:48 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123', 04:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:48 INFO - '_': '/tools/buildbot/bin/python'} 04:16:48 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:16:48 INFO - mozversion application_buildid: 20160113025830 04:16:48 INFO - mozversion application_changeset: 531d1f6d1cde1182e9f7f9dff81a4fc5abc0a601 04:16:48 INFO - mozversion application_display_name: Nightly 04:16:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:16:48 INFO - mozversion application_name: Firefox 04:16:48 INFO - mozversion application_remotingname: firefox 04:16:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:16:48 INFO - mozversion application_vendor: Mozilla 04:16:48 INFO - mozversion application_version: 46.0a1 04:16:48 INFO - mozversion platform_buildid: 20160113025830 04:16:48 INFO - mozversion platform_changeset: 531d1f6d1cde1182e9f7f9dff81a4fc5abc0a601 04:16:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:16:48 INFO - mozversion platform_version: 46.0a1 04:16:48 INFO - using testdate: 1452687408 04:16:48 INFO - actual date: 1452687408 04:16:48 INFO - starting webserver on 'localhost:57654' 04:16:48 INFO - SUITE-START | Running 3 tests 04:16:48 INFO - TEST-START | dromaeo_css 04:16:48 INFO - operating with platform_type : linux_ 04:16:48 INFO - Initialising browser for dromaeo_css test... 04:16:48 INFO - TEST-INFO | started process 24055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXNAPG7/profile http://localhost:57654/getInfo.html) 04:16:52 INFO - PROCESS | 24055 | 04:16:52 INFO - PROCESS | 24055 | (process:24139): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:16:52 INFO - PROCESS | 24055 | __metrics Screen width/height:1600/1200 04:16:52 INFO - PROCESS | 24055 | colorDepth:24 04:16:52 INFO - PROCESS | 24055 | Browser inner width/height: 1024/697 04:16:52 INFO - PROCESS | 24055 | __metrics 04:16:53 INFO - PROCESS | 24055 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:16:53 INFO - TEST-INFO | 24055: exit 0 04:16:53 INFO - Browser initialized. 04:16:53 INFO - Running cycle 1/1 for dromaeo_css test... 04:16:53 INFO - TEST-INFO | started process 24188 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXNAPG7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:16:55 INFO - PROCESS | 24188 | 04:16:55 INFO - PROCESS | 24188 | (process:24244): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:17:05 INFO - PROCESS | 24188 | RSS: Main: 150331392 04:17:05 INFO - PROCESS | 24188 | 04:17:55 INFO - PROCESS | 24188 | 1452687475561 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:20:06 INFO - PROCESS | 24188 | Cycle 1(1): loaded http://localhost:57654/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57654/tests/dromaeo/cssquery-ext.html) 04:20:07 INFO - PROCESS | 24188 | RSS: Main: 155910144 04:20:07 INFO - PROCESS | 24188 | 04:23:09 INFO - PROCESS | 24188 | Cycle 1(1): loaded http://localhost:57654/tests/dromaeo/cssquery-ext.html (next: http://localhost:57654/tests/dromaeo/cssquery-jquery.html) 04:23:09 INFO - PROCESS | 24188 | RSS: Main: 151654400 04:23:09 INFO - PROCESS | 24188 | 04:26:11 INFO - PROCESS | 24188 | Cycle 1(1): loaded http://localhost:57654/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57654/tests/dromaeo/cssquery-mootools.html) 04:26:12 INFO - PROCESS | 24188 | RSS: Main: 152592384 04:26:12 INFO - PROCESS | 24188 | 04:29:14 INFO - PROCESS | 24188 | Cycle 1(1): loaded http://localhost:57654/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57654/tests/dromaeo/cssquery-prototype.html) 04:29:14 INFO - PROCESS | 24188 | RSS: Main: 150810624 04:29:14 INFO - PROCESS | 24188 | 04:32:17 INFO - PROCESS | 24188 | Cycle 1(1): loaded http://localhost:57654/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57654/tests/dromaeo/cssquery-yui.html) 04:32:18 INFO - PROCESS | 24188 | RSS: Main: 150474752 04:32:18 INFO - PROCESS | 24188 | 04:35:20 INFO - PROCESS | 24188 | Cycle 1(1): loaded http://localhost:57654/tests/dromaeo/cssquery-yui.html (next: http://localhost:57654/tests/dromaeo/cssquery-dojo.html) 04:35:21 INFO - PROCESS | 24188 | RSS: Main: 152670208 04:35:21 INFO - PROCESS | 24188 | 04:35:21 INFO - PROCESS | 24188 | __start_tp_report 04:35:21 INFO - PROCESS | 24188 | _x_x_mozilla_page_load 04:35:21 INFO - PROCESS | 24188 | _x_x_mozilla_page_load_details 04:35:21 INFO - PROCESS | 24188 | |i|pagename|runs| 04:35:21 INFO - PROCESS | 24188 | |0;dojo.html;2629.894804207832;2636.9736302636975;2665.8267212631176;2673.157955244098;2675.0904692404583;4389.253826849435;4488.236999710049;4510.4587449506025;4526.411566496359;4551.294549344852;4461.118826620845;4464.441944756897;4470.329450582414;4492.460904691434;4577.404937358147;4177.937330940038;4222.598853108965;4236.809343579531;4252.723572967762;4316.179925814085;269.8331749846308;4188.748675079505;4280.764557949312;4280.957190428087;4323.935140972888;4055.71609987301;4140.4617399738145;4169.478815148106;4177.728447650893;4224.197402493516;4194.727342722713;4210.32634778434;4214.726042807208;4221.6833737469815;4267.082577245876;4138.772367519785;4179.205950869356;4204.621584057419;4222.429971953778;4231.048014196812;4388.1223755249075;4434.955650443519;4451.465824101128;4470.195364834329;4513.300438432048;4765.0231702500905;4817.638677099197;4819.855404337875;4843.806247750086;4855.028994201174;4803.159447096744;4844.806207751686;4881.731504767236;4890.682105663156;4900;4465.531119232466;4468.218061839165;4481.238189507759;4520.954790452086;4526.977365113154;4904.558589726942;4917.680350777188;4924.187509060965;4960.578350840146;4972.403311602631;4627.167109920179;4718.811247550059;4720.244760838249;4739.9763001185465;4778.474367819537;4881.145799485076;4881.292212629149;4883.438404583519;4899.167141585867;4929.334539837076;4824.541668541483;4828.855134345975;4834.6374021948495;4838.854834354975;4863.8540843774745;4630.907381852411;4701.3653156824075;4719.528047195322;4787.114383838932;4789.784459699322;4028.1540876415693;4028.617281358266;4035.6771458283856;4045.19096180765;4058.0463591056077;3567.5897271813556;3571.464280357915;3599.0642432967616;3606.4590311453494;3623.710103191738;4070.2063097695664;4137.358709400048;4137.379393091061;4145.709800313949;4162.438070860395;4748.596369308579;4800;4826.686265392738;4847.321375007502;4878.975605121952;4199.874003779892;4200.033992181754;4207.957920420757;4214.662826973896;4250.787460626956;4266.0188156724125;4268.487781466244;4311.8706438806885;4344.761038142932;4360.607545320936;4538.88652783683;4546.681732278708;4552.886177845514;4576.97711511447;4587.63298936091;4820.421549414093;4832.057748738962;4839.032193561231;4842.685225460334;4875.561199492063;4507.706999045052;4533.977330113328;4561.110583436198;4600.033992861537;4613.215753322011;4736.834210802605;4743.1225223333795;4745.667803253739;4747.43030836288;4747.928781068218;4770.403699537558;4790.137775200497;4798.1123492154065;4828.637852161172;4842.249451335048;4635.142498637762;4663.253879379283;4708.482066972561;4716.481187069351;4753.263244197155;4708.317293992421;4733.9053218936115;4738.620910327097;4740.715557066587;4808.158572249912;4502.077074199847;4618.03021365517;4652.813887444464;4656.138614356355;4683.461401938821;4730.219513780187;4740.549647783455;4752.857414277439;4769.594584460359;4793.832215872428;4634.83778067766;4662.650301227353;4664.370310008106;4673.252279635242;4682.531746825291 04:35:21 INFO - PROCESS | 24188 | |1;ext.html;481.63395819177435;515.1037195280213;518.5229588778324;538.717173483921;540.9026375252454;31918.680813191862;32361.83819080907;32493;32493.187670308253;32549.349013019753;32758;33288.33423331532;33336.16659583506;33339;33380.83309583455;7261.164966028921;7435.293647103516;7454.40364770817;7469.887951680702;7501;7403.037605111328;7549.886751698701;7552.055993000875;7559.811004724871;7560.735374261902;7323.523970941898;7481.8877716834295;7490.550566965972;7529.058867641545;7541.095068591777;7526.435517336222;7533.133689625681;7555.848883022309;7574.886376704354;7606.429517786133;7425.997490338789;7524.172341042481;7540.622968851536;7558.886616700754;7569.924300756977;32750;33260.667393325995;33300.66699333;33304.33391332184;33306.83346583252;2920.211542883431;2972.5689774982507;3056.2512184514712;3218.678132186786;3436.5532480777338;26839.59740603873;27052;27128.86435567829;27412.588811167847;27478.313042173904;3421.6578342165835;3463.9653603463894;3486.546748922624;3501.1947252132154;3587.6232995535615;211505;211828;211843.99999999846;211943;212241;43978.34032489515;44872.55127448749;50748.492515075115;56606;57980.71009645009;49984;50364.244536331986;50610.240846387336;50639;50661.74669126631;13726.245056521788;13823.723525529433;13856.93071534636;14023.78964315536;14130.788038179435;10756.193285503463;10833.187510936712;10868.891311086945;10893.291936024134;10897.400642964712;17274.395396161075;17330.65338693219;17450.738238926428;17599.560010999827;17602.823971760376;7209.387202087882;7389.926100739031;7442.553446793209;7451.2921272479025;7533.359664428475;914.131575003749;923.9399439036441;977.8728765260471;982.4400091947664;1009.1271050541376;25799.226023219333;26164;26506.337341566614;26590.867045664647;26775.464490710077;960.3325688646463;964.6141543382703;974.6150270643057;988.7874107067015;1043.4417586591137;12471.251724896536;12628.305443200528;13841.930790345983;14133.929330353283;14505.202213878338;193851;193855;197042;197492;197637;40231.59768402337;40506.39240411396;40557.39163912544;40569.18861622751;40826.59173408228;1231.3473858854643;1243.9937800311122;1244.5706231349989;1248.7190382164122;1360.149906308557;23911.402214944068;25658.230253092435;26503.867480662473;26551.203463896112;26682.198369170957;37559.81220093882;37710.057248569006;37868.810655946545;38019.239615206985;38093.238135236585;243265;244663;245198.77400612884;245834;245941;26806.59790103189;28145.014924477546;28508.57237141403;28614;28735;32755;33171;33334;33501.66498334985;33642.15894602556;27903.16290511288;27962.161135165978;28258.576121357786;28632;29153.125406237847;28083.578746318413;28289;28444.57333140046;28809.135725928256;29150;28295.575566366108;28377.574336384558;28647.42705145927;28831.855840720662;28895.711042890143;26885.327866803487;28050.751092225517;28065.298367540974;28634.85682571574;28866.711332886403;22361.77638223662;22395;22530.324090277318;22575;22689.546209076056 04:35:21 INFO - PROCESS | 24188 | |2;jquery.html;338.3469903087043;340.9045467269164;342.6187993445554;345.86165533786465;348.195668006904;13684.726305473885;13793.448262069518;14856.925715371408;15485;16068.839311606866;10339.483025848696;10646.25476216665;12953.611391658265;15240;15249.695006099872;4547.772611369435;4644.767761611923;4737.692050016755;4927.2609108633815;5113.258577506259;5055.39335279767;5059.6964182149;5071.670341427814;5108.310378098946;5114.6164037697135;5153.896922061575;5765.855853603673;5769.394213607574;5781.739821708013;5790.652560846363;5776.306843178824;5790.36306006339;5798.681072541009;5886.352501224862;6142.385761423867;5644.294463192101;5886.58793884424;5888.705564721747;5896.997510423195;5913.763449462016;17718.911405443017;18137.54656133594;18496.44510664682;19963.50091247716;20085;1741.8084010758807;1807.7198034304704;1882.4729075858781;1897.9810201897942;1959.6968016269163;12247.326397048158;12969.805452918214;13050.673733156653;13072.411741471562;13665.931670341684;1798.3256278895415;1853.851691864661;1897.459224121119;1902.9809701902943;1904.7619047619048;43389.56610433887;43715.90710232238;43915.34126988098;44215;55954.16068758972;13636.727265454636;13932.860671393359;13979.09135906163;14075.718485630436;14101.78847317291;20268.290609828586;20501.17995280202;20528;20592.27927022547;20631.277905273244;7922.247386498273;7931.841363172704;7991.72028978983;8052.315553177928;8269.669213231524;6647.800565983028;6682.398584127452;6683.699233534503;6718.126643536309;6730.360615741497;3975.383815508601;4167.249895018926;4183.769892655872;4228.281192197333;7362.411007119417;1754.1317048061292;1759.2874885671324;1777.2002598830577;1808.430344441523;1843.7050071988417;835.8620827563384;847.584683505078;868.9956550217208;944.8236945003515;958.3626888119322;12005.939970300093;12313.26120432777;13393.598192054254;14941.477048303257;15315.770263446057;818.6476379227056;829.5271695133716;844.3371953016853;851.7998270406573;943.834828904939;7833.2249109860395;8361.331093512505;8406.201410865959;8552.315814734806;8680.56597170139;441676;443289;443797;456309;458239;62026;63405;64552.67723661446;64791;65554.67222663856;1034.5965073621294;1067.5569638599893;1068.4123731947398;1072.2815713471994;1073.5759375046812;13751.449942002608;13806.240656763974;13851.445942162603;13872.653183670085;14212;29507.114786556438;29973.250668733457;30026.549601755552;30396;30703.078907632807;39073.609263907;39256.2148757029;39487;39602.207955840146;40740;6132.938670613236;6190.442860142609;6398.584092034003;6463.741450341934;6586.242582103119;3191.4255434022098;3740.0275928258307;7121.537100088478;9949.204063675033;10405.323653962469;7888.092869320101;8109.553974531457;8154.714584989497;8314.459560128815;8551.401401901807;8645.783855403664;8809.383343165917;8983.505907175168;8998.460092394216;9121.133492318218;8170.060443049126;8185.754427367188;8216.712415065444;8312.83374332522;8513.82972340562;6418.807435776934;6542.967285163544;6614.66926653675;6742.730290788313;6816.7614133505085;7189.388901943394;8302.916970830456;8308.210719981593;8389.874151887849;8449.619767110618 04:35:21 INFO - PROCESS | 24188 | |3;mootools.html;1368.445779459319;1394.7838085096807;1498.183489997951;1698.150924537731;1727.265911987405;5978.103284507326;6148.446639802417;6601.966990165049;6786.660666966651;6808.829779255521;6502.73989040439;6597.670116494168;6656.76701315454;6714.72420240154;6733.158355205599;2033.2273735980343;2062.298818401743;2063.319104695447;2063.5357044664906;2066.1012459580056;2011.5272910865936;2030.0560239488634;2043.3461292386442;2069.524009477821;2074.4917495213695;2056.177528988409;2077.044559502631;2079.064421010551;2089.550746589483;2090.080364639561;2043.3461292386442;2043.8773673579633;2048.139781291861;2049.385184444661;2050.169681279084;2008.3774030050731;2040.36748607932;2071.513194399315;2074.4917495213767;2076.4289820299387;6890.931090689079;6949.339812717834;6959.512834101615;6970.581765094111;6978.371946524837;4078.632923036911;4152.771597562133;4169.541350451448;4181.268278051329;4187.330027195664;2685.2615530729204;2736.835789852615;2753.6695596528543;2877.7122287771263;2880.942381152386;817.1828171828172;853.5348235211825;884.6107712606432;889.0398369760643;934.2059249637754;9200.401973871743;9246.35275530713;9276.35065545419;9290.16388525036;9305.720828375159;3721.3673675475234;3729.4965179700393;3731.3470142724914;3765.7740535567955;3802.7718336899875;8103.0681471631515;8118.837623247502;8123.309518690978;8128.268455839003;8140.552269625227;4145.419641250227;4152.8131234094535;4170.541240463546;4172.123853990696;4182.832686692498;3307.751918606114;3384.1877949292484;3698.2973235085246;3781.1303400218103;3798.639129282714;3266.950995735066;3268.8202148881564;3335.93328133436;3338.4157772389735;3350;1046.2780681329857;1072.5441687282873;1085.7285678580356;1090.0026475774578;1090.1333439915286;809.283783851284;826.5040975414703;1161.4425075963584;1167.1829719196426;1170.976580468386;6487.870242595121;6540.771073012422;6542.34576542342;6584.8024559263295;6593.703283352261;1032.6385764982197;1043.634727845248;1047.0681093826502;1055.5250137438184;1060.379677888444;4980.178270585386;5038.193888977819;5052.393712754493;5075;5095.694258344437;7885.448018638755;8289;8308.418410711312;8474.788130296793;8521.744347669579;8256.958715206385;8338.833223335621;8345.248927596424;8375.916240837514;8381.161883811692;6563.507736919654;6589.439897608757;6647.800565983028;6669;6694.163229596203;6209.844753881189;6250.937490625036;6253;6253.030780229072;6273.1844860167885;7337.0828646419195;7520.699172033276;7579.242075792376;7592.316691497792;7675.731349402744;7532.54804711719;7593.772186834404;7664.271894170045;7668.348190403878;7687.500312479671;5065.3161823153405;5212.374515058217;5841.32824725162;5872.236609240771;5901.114832774946;6134.263888333428;6247.281562620356;6257.405546473078;6262.561620686691;6288.339724328879;5937.3468918418075;5994.340622531605;6062.514998800174;6080.4831589313635;6230.7507699691505;5590.133529302964;5679.0345641240265;5681.460261275172;5690.544756419559;5773.538116950718;6013.699315034319;6035.336113027652;6066.696665166813;6230.719617617127;6262.906056409249;5738.741756620879;5783.074708046693;5786.971065144648;5792.304923409218;5807.245058142415;5660.207570940154;5732.197492350991;5744.224529688606;5751.7411716472025;5754.251947246831 04:35:21 INFO - PROCESS | 24188 | |4;prototype.html;294.2217833829521;294.45819691767144;300.6467400804056;303.7403020417544;308.69747647305655;5494.807681731135;5527.778888844451;5565.443455654433;5636.267285252921;5690.943090569093;5466.1527463243265;5580.441955804417;5606.971965140179;5615.241942337783;5625.831225063244;4133.441985331987;4291.313389857623;4295.806688699;4302.720323178984;4312.159128969836;4249.022724773304;4264.7441153530735;4286;4291.678124140686;4306.806193721274;4206.284931561627;4225.795648240252;4252.468441444819;4254.3618457231505;4268.829246830123;4248.468941382327;4261.083866968585;4269.6370808481315;4279.87160385189;4281.250781113293;3700.093477098101;3701.2597480503737;3705.888823335304;3709.0541911812584;3715.1826598148364;5268.288781014552;5275.4460781618145;5386.461353864583;5390.811321603725;5396.7301634918485;4847;4881.414230292352;4914.852554423373;4923.58149557288;4925.753712314406;5835.35811060783;5850.97074514629;5853.736581853785;5900.557458190653;5911.881762364728;3970.861019864291;4060.2488539620263;4061.451704019949;4062.7765472898977;4084.14233011068;6138.693065346715;6160.383961603849;6162.506999440034;6164.260288765377;6208.068789681539;4186.581341865789;4215.957840421618;4223.598758118035;4226.450561426995;4231.153769246163;4279.529251782302;4284.3145096784365;4286.914261714748;4287.721298115613;4299.591538803808;4674.462436819741;4888.388951381077;4891.119598472238;4893.314935908976;4895.290182923527;5875.941240587625;5880.8235752927485;5909.172715819789;5922.2597175353085;5935.703214839327;1496.790449337072;1513.311443293299;1519.802425684676;1526.3207872496632;1526.4199604150351;1023.1712313026472;1028.8456731490337;1032.7211652853687;1057.6351158850184;1058.941758203306;5081.618878584121;5095.108356037678;5096.694198348111;5101.821436249714;5118.360204974379;6089.878202435926;6112.541559383064;6118.296395914527;6124.265088189446;6130.2030736004035;5097.566706829887;5100.515451032146;5102.69383836971;5103.97448012765;5113.207452844815;3227.8708851646143;3260.0708797992456;3295.07737833407;3331.0839519132433;3332.3835090508333;5479.589030822624;5740.512056475163;5778.711064446761;5780.71096445176;5787.247657804459;6200.844978875564;6234.688265586793;6316.494680425555;6330.8100756977365;6349.206349206349;5658.462446067617;5702.059160238514;5737.77048918047;5740.196372507852;5749.999999999916;6153.969230153821;6155.353687862889;6160.7535698571555;6161.969190154021;6174.289956654862;5818.592698511064;6019.398060193946;6026.005709057957;6032.577719559588;6036.577439579363;5732.770689172553;5750.6837123958585;5755.02164632022;5765.308163020464;5776.133579963039;3992.840286388512;4009.719319647597;4013.0769922918475;4013.91972160561;4018.2365350583295;6047.758089676539;6175.9073613894925;6194.101855230876;6200.534959877937;6200.627962322275;5938.673372964528;5950.077737950624;5956.493698035715;5958.165856779968;5962.9105563415715;5928.229330187048;5931.08068249422;5960.135780311917;5963.91054134197;5972.880542389041;5643.435656434488;5782.7686892523825;5810.68041257718;5812.68030258323;5813.854653633693;5905.852353691193;5941.197938278277;5965.433283838029;5969.194158788508;5975.7012149391485;5778.8266352009505;5802.506786923159;5803.535717142703;5817.040188368872;5830.18377427169 04:35:21 INFO - PROCESS | 24188 | |5;yui.html;712.3304094151497;739.781764379508;744.9416776046959;753.07371932523;768.5888049893305;11202.663920082401;11364.431778411066;11369.886301136987;11369.943150284258;11400.54397824087;10847.186461015435;10899.891001089987;10921.890781092186;10936.781264374707;10956.561737530508;595.5325069820192;605.5518916002171;643.6524276890497;652.8498445357546;775.5153029356652;775.2247752247753;780.8087018680432;781.1641543548405;783.5729527407548;786.1273985875673;825.8265764189528;827.668932427031;828.1345993436843;828.4408024583412;831.6548632317581;815.2947700239309;818.3248819723722;819.6147810529042;819.9709364747264;820.3150369441464;609.0438012320658;609.1441524657819;611.4741322462723;612.5956868466835;615.7690865925279;10680;10694.251402401835;10731.35611863283;10737;10777.245592808507;11615;12027.639170824888;12221.755564888652;12241.632751017394;12251.387430628522;9194.08059194082;9371.906280937172;9440.57517411718;9585.329026968115;9592;3177.8252196129206;3212.9196770080703;3213.5340375645633;3227.3545290941906;3349.949750753716;38879.833604991894;38993.61006389928;39087.60912390868;39158.41262381067;39233;9263.536823158815;9371;9528.618855245713;9542.236621070298;9564.66523671682;16343.365663433562;16486.83513164877;16658.33366665344;16688.666226675643;16729.83270167283;6402.551821372459;6418.26189988148;6505.121808555785;6600.636964966973;6710.698018589078;3618.81905904709;3731.384321586962;3749.962500374961;3776.981115094407;3791.526059242595;2483.7392073832348;2497.775200231988;2503.2740505253273;2505.0981646607206;2509.824312298158;458.2050143001889;466.0981001761602;470.571779680496;476.10492274523676;477.1340017867559;418.33275924900346;429.61549413275566;450.6980323183475;499.2436458764974;575.246427180395;7405.925940740523;7452.888206676904;7582.772516824504;7682.654280557276;7684.769456916301;386.64621870988293;540.6728928997978;589.3252226200976;591.2756872830834;595.475981136597;3469.7918124912585;3480.2517458746493;3587.0852932502044;4012.9398059029136;4045.292073887058;40889.182216355504;41070.91968102404;41187;41297.587024129374;41391;37184.62815371866;37668.43497347542;37784.24431511409;41048.58951410507;41248.38127428091;36909.892703219484;37657;37990.62009379926;38128.809355953046;38239.61760382416;8055.718049868226;8067.314278286177;8120.878186827084;8162.551059691774;8450.704225352083;28798.856005719837;29463.558046629747;29735.85132074326;29771.55342669905;29910.102696919126;32801;33328.83335583306;36592.26815463623;37059.81470092632;37294.44058339181;9980;10244.385336879812;10301.639442619473;10357.119644830274;10537.315074520131;11480.483378247833;11687.357195354338;11691.064714822624;12432.627021189379;12460.813087803872;10419.583216671248;10471.528781205016;10914.454277286262;11030.50362733663;11034.227604067639;10187.694369168938;10433.53049112807;10554.208434367607;10961.671149865517;11357.204995650225;9449.43303401798;9754.561044753145;9896.604135834774;10076.345037572535;10117.392956422638;8609.52912897325;8675.392722509616;8816;9022.909770902206;9130.497822619554;8645.308375329832;9116.954415227881;9135.177833994972;9258.72223833286;9314.813703725751 04:35:21 INFO - PROCESS | 24188 | __end_tp_report 04:35:21 INFO - PROCESS | 24188 | __start_cc_report 04:35:21 INFO - PROCESS | 24188 | _x_x_mozilla_cycle_collect,331 04:35:21 INFO - PROCESS | 24188 | __end_cc_report 04:35:21 INFO - PROCESS | 24188 | __startTimestamp1452688521035__endTimestamp 04:35:21 INFO - PROCESS | 24188 | 04:35:21 INFO - PROCESS | 24188 | ------- Summary: start ------- 04:35:21 INFO - PROCESS | 24188 | Number of tests: 6 04:35:21 INFO - PROCESS | 24188 | 04:35:21 INFO - PROCESS | 24188 | [#0] dojo.html Cycles:165 Average:4447.65 Median:4577.40 stddev:552.18 (12.1%) stddev-sans-first:535.14 04:35:21 INFO - PROCESS | 24188 | Values: 2629.9 2637.0 2665.8 2673.2 2675.1 4389.3 4488.2 4510.5 4526.4 4551.3 4461.1 4464.4 4470.3 4492.5 4577.4 4177.9 4222.6 4236.8 4252.7 4316.2 269.8 4188.7 4280.8 4281.0 4323.9 4055.7 4140.5 4169.5 4177.7 4224.2 4194.7 4210.3 4214.7 4221.7 4267.1 4138.8 4179.2 4204.6 4222.4 4231.0 4388.1 4435.0 4451.5 4470.2 4513.3 4765.0 4817.6 4819.9 4843.8 4855.0 4803.2 4844.8 4881.7 4890.7 4900.0 4465.5 4468.2 4481.2 4521.0 4527.0 4904.6 4917.7 4924.2 4960.6 4972.4 4627.2 4718.8 4720.2 4740.0 4778.5 4881.1 4881.3 4883.4 4899.2 4929.3 4824.5 4828.9 4834.6 4838.9 4863.9 4630.9 4701.4 4719.5 4787.1 4789.8 4028.2 4028.6 4035.7 4045.2 4058.0 3567.6 3571.5 3599.1 3606.5 3623.7 4070.2 4137.4 4137.4 4145.7 4162.4 4748.6 4800.0 4826.7 4847.3 4879.0 4199.9 4200.0 4208.0 4214.7 4250.8 4266.0 4268.5 4311.9 4344.8 4360.6 4538.9 4546.7 4552.9 4577.0 4587.6 4820.4 4832.1 4839.0 4842.7 4875.6 4507.7 4534.0 4561.1 4600.0 4613.2 4736.8 4743.1 4745.7 4747.4 4747.9 4770.4 4790.1 4798.1 4828.6 4842.2 4635.1 4663.3 4708.5 4716.5 4753.3 4708.3 4733.9 4738.6 4740.7 4808.2 4502.1 4618.0 4652.8 4656.1 4683.5 4730.2 4740.5 4752.9 4769.6 4793.8 4634.8 4662.7 4664.4 4673.3 4682.5 04:35:21 INFO - PROCESS | 24188 | 04:35:21 INFO - PROCESS | 24188 | [#1] ext.html Cycles:180 Average:36646.43 Median:17568.68 stddev:56766.71 (323.1%) stddev-sans-first:56861.01 04:35:21 INFO - PROCESS | 24188 | Values: 481.6 515.1 518.5 538.7 540.9 31918.7 32361.8 32493.0 32493.2 32549.3 32758.0 33288.3 33336.2 33339.0 33380.8 7261.2 7435.3 7454.4 7469.9 7501.0 7403.0 7549.9 7552.1 7559.8 7560.7 7323.5 7481.9 7490.6 7529.1 7541.1 7526.4 7533.1 7555.8 7574.9 7606.4 7426.0 7524.2 7540.6 7558.9 7569.9 32750.0 33260.7 33300.7 33304.3 33306.8 2920.2 2972.6 3056.3 3218.7 3436.6 26839.6 27052.0 27128.9 27412.6 27478.3 3421.7 3464.0 3486.5 3501.2 3587.6 211505.0 211828.0 211844.0 211943.0 212241.0 43978.3 44872.6 50748.5 56606.0 57980.7 49984.0 50364.2 50610.2 50639.0 50661.7 13726.2 13823.7 13856.9 14023.8 14130.8 10756.2 10833.2 10868.9 10893.3 10897.4 17274.4 17330.7 17450.7 17599.6 17602.8 7209.4 7389.9 7442.6 7451.3 7533.4 914.1 923.9 977.9 982.4 1009.1 25799.2 26164.0 26506.3 26590.9 26775.5 960.3 964.6 974.6 988.8 1043.4 12471.3 12628.3 13841.9 14133.9 14505.2 193851.0 193855.0 197042.0 197492.0 197637.0 40231.6 40506.4 40557.4 40569.2 40826.6 1231.3 1244.0 1244.6 1248.7 1360.1 23911.4 25658.2 26503.9 26551.2 26682.2 37559.8 37710.1 37868.8 38019.2 38093.2 243265.0 244663.0 245198.8 245834.0 245941.0 26806.6 28145.0 28508.6 28614.0 28735.0 32755.0 33171.0 33334.0 33501.7 33642.2 27903.2 27962.2 28258.6 28632.0 29153.1 28083.6 28289.0 28444.6 28809.1 29150.0 28295.6 28377.6 28647.4 28831.9 28895.7 26885.3 28050.8 28065.3 28634.9 28866.7 22361.8 22395.0 22530.3 22575.0 22689.5 04:35:21 INFO - PROCESS | 24188 | 04:35:21 INFO - PROCESS | 24188 | [#2] jquery.html Cycles:180 Average:24094.31 Median:457274.00 stddev:73213.32 (16.0%) stddev-sans-first:73396.98 04:35:21 INFO - PROCESS | 24188 | Values: 338.3 340.9 342.6 345.9 348.2 13684.7 13793.4 14856.9 15485.0 16068.8 10339.5 10646.3 12953.6 15240.0 15249.7 4547.8 4644.8 4737.7 4927.3 5113.3 5055.4 5059.7 5071.7 5108.3 5114.6 5153.9 5765.9 5769.4 5781.7 5790.7 5776.3 5790.4 5798.7 5886.4 6142.4 5644.3 5886.6 5888.7 5897.0 5913.8 17718.9 18137.5 18496.4 19963.5 20085.0 1741.8 1807.7 1882.5 1898.0 1959.7 12247.3 12969.8 13050.7 13072.4 13665.9 1798.3 1853.9 1897.5 1903.0 1904.8 43389.6 43715.9 43915.3 44215.0 55954.2 13636.7 13932.9 13979.1 14075.7 14101.8 20268.3 20501.2 20528.0 20592.3 20631.3 7922.2 7931.8 7991.7 8052.3 8269.7 6647.8 6682.4 6683.7 6718.1 6730.4 3975.4 4167.2 4183.8 4228.3 7362.4 1754.1 1759.3 1777.2 1808.4 1843.7 835.9 847.6 869.0 944.8 958.4 12005.9 12313.3 13393.6 14941.5 15315.8 818.6 829.5 844.3 851.8 943.8 7833.2 8361.3 8406.2 8552.3 8680.6 441676.0 443289.0 443797.0 456309.0 458239.0 62026.0 63405.0 64552.7 64791.0 65554.7 1034.6 1067.6 1068.4 1072.3 1073.6 13751.4 13806.2 13851.4 13872.7 14212.0 29507.1 29973.3 30026.5 30396.0 30703.1 39073.6 39256.2 39487.0 39602.2 40740.0 6132.9 6190.4 6398.6 6463.7 6586.2 3191.4 3740.0 7121.5 9949.2 10405.3 7888.1 8109.6 8154.7 8314.5 8551.4 8645.8 8809.4 8983.5 8998.5 9121.1 8170.1 8185.8 8216.7 8312.8 8513.8 6418.8 6543.0 6614.7 6742.7 6816.8 7189.4 8302.9 8308.2 8389.9 8449.6 04:35:21 INFO - PROCESS | 24188 | 04:35:21 INFO - PROCESS | 24188 | [#3] mootools.html Cycles:180 Average:4792.48 Median:5778.31 stddev:2451.62 (42.4%) stddev-sans-first:2444.99 04:35:21 INFO - PROCESS | 24188 | Values: 1368.4 1394.8 1498.2 1698.2 1727.3 5978.1 6148.4 6602.0 6786.7 6808.8 6502.7 6597.7 6656.8 6714.7 6733.2 2033.2 2062.3 2063.3 2063.5 2066.1 2011.5 2030.1 2043.3 2069.5 2074.5 2056.2 2077.0 2079.1 2089.6 2090.1 2043.3 2043.9 2048.1 2049.4 2050.2 2008.4 2040.4 2071.5 2074.5 2076.4 6890.9 6949.3 6959.5 6970.6 6978.4 4078.6 4152.8 4169.5 4181.3 4187.3 2685.3 2736.8 2753.7 2877.7 2880.9 817.2 853.5 884.6 889.0 934.2 9200.4 9246.4 9276.4 9290.2 9305.7 3721.4 3729.5 3731.3 3765.8 3802.8 8103.1 8118.8 8123.3 8128.3 8140.6 4145.4 4152.8 4170.5 4172.1 4182.8 3307.8 3384.2 3698.3 3781.1 3798.6 3267.0 3268.8 3335.9 3338.4 3350.0 1046.3 1072.5 1085.7 1090.0 1090.1 809.3 826.5 1161.4 1167.2 1171.0 6487.9 6540.8 6542.3 6584.8 6593.7 1032.6 1043.6 1047.1 1055.5 1060.4 4980.2 5038.2 5052.4 5075.0 5095.7 7885.4 8289.0 8308.4 8474.8 8521.7 8257.0 8338.8 8345.2 8375.9 8381.2 6563.5 6589.4 6647.8 6669.0 6694.2 6209.8 6250.9 6253.0 6253.0 6273.2 7337.1 7520.7 7579.2 7592.3 7675.7 7532.5 7593.8 7664.3 7668.3 7687.5 5065.3 5212.4 5841.3 5872.2 5901.1 6134.3 6247.3 6257.4 6262.6 6288.3 5937.3 5994.3 6062.5 6080.5 6230.8 5590.1 5679.0 5681.5 5690.5 5773.5 6013.7 6035.3 6066.7 6230.7 6262.9 5738.7 5783.1 5787.0 5792.3 5807.2 5660.2 5732.2 5744.2 5751.7 5754.3 04:35:21 INFO - PROCESS | 24188 | 04:35:21 INFO - PROCESS | 24188 | [#4] prototype.html Cycles:180 Average:4866.75 Median:5472.87 stddev:1447.65 (26.5%) stddev-sans-first:1410.44 04:35:21 INFO - PROCESS | 24188 | Values: 294.2 294.5 300.6 303.7 308.7 5494.8 5527.8 5565.4 5636.3 5690.9 5466.2 5580.4 5607.0 5615.2 5625.8 4133.4 4291.3 4295.8 4302.7 4312.2 4249.0 4264.7 4286.0 4291.7 4306.8 4206.3 4225.8 4252.5 4254.4 4268.8 4248.5 4261.1 4269.6 4279.9 4281.3 3700.1 3701.3 3705.9 3709.1 3715.2 5268.3 5275.4 5386.5 5390.8 5396.7 4847.0 4881.4 4914.9 4923.6 4925.8 5835.4 5851.0 5853.7 5900.6 5911.9 3970.9 4060.2 4061.5 4062.8 4084.1 6138.7 6160.4 6162.5 6164.3 6208.1 4186.6 4216.0 4223.6 4226.5 4231.2 4279.5 4284.3 4286.9 4287.7 4299.6 4674.5 4888.4 4891.1 4893.3 4895.3 5875.9 5880.8 5909.2 5922.3 5935.7 1496.8 1513.3 1519.8 1526.3 1526.4 1023.2 1028.8 1032.7 1057.6 1058.9 5081.6 5095.1 5096.7 5101.8 5118.4 6089.9 6112.5 6118.3 6124.3 6130.2 5097.6 5100.5 5102.7 5104.0 5113.2 3227.9 3260.1 3295.1 3331.1 3332.4 5479.6 5740.5 5778.7 5780.7 5787.2 6200.8 6234.7 6316.5 6330.8 6349.2 5658.5 5702.1 5737.8 5740.2 5750.0 6154.0 6155.4 6160.8 6162.0 6174.3 5818.6 6019.4 6026.0 6032.6 6036.6 5732.8 5750.7 5755.0 5765.3 5776.1 3992.8 4009.7 4013.1 4013.9 4018.2 6047.8 6175.9 6194.1 6200.5 6200.6 5938.7 5950.1 5956.5 5958.2 5962.9 5928.2 5931.1 5960.1 5963.9 5972.9 5643.4 5782.8 5810.7 5812.7 5813.9 5905.9 5941.2 5965.4 5969.2 5975.7 5778.8 5802.5 5803.5 5817.0 5830.2 04:35:21 INFO - PROCESS | 24188 | 04:35:21 INFO - PROCESS | 24188 | [#5] yui.html Cycles:180 Average:11537.97 Median:40968.89 stddev:12310.64 (30.0%) stddev-sans-first:12318.33 04:35:21 INFO - PROCESS | 24188 | Values: 712.3 739.8 744.9 753.1 768.6 11202.7 11364.4 11369.9 11369.9 11400.5 10847.2 10899.9 10921.9 10936.8 10956.6 595.5 605.6 643.7 652.8 775.5 775.2 780.8 781.2 783.6 786.1 825.8 827.7 828.1 828.4 831.7 815.3 818.3 819.6 820.0 820.3 609.0 609.1 611.5 612.6 615.8 10680.0 10694.3 10731.4 10737.0 10777.2 11615.0 12027.6 12221.8 12241.6 12251.4 9194.1 9371.9 9440.6 9585.3 9592.0 3177.8 3212.9 3213.5 3227.4 3349.9 38879.8 38993.6 39087.6 39158.4 39233.0 9263.5 9371.0 9528.6 9542.2 9564.7 16343.4 16486.8 16658.3 16688.7 16729.8 6402.6 6418.3 6505.1 6600.6 6710.7 3618.8 3731.4 3750.0 3777.0 3791.5 2483.7 2497.8 2503.3 2505.1 2509.8 458.2 466.1 470.6 476.1 477.1 418.3 429.6 450.7 499.2 575.2 7405.9 7452.9 7582.8 7682.7 7684.8 386.6 540.7 589.3 591.3 595.5 3469.8 3480.3 3587.1 4012.9 4045.3 40889.2 41070.9 41187.0 41297.6 41391.0 37184.6 37668.4 37784.2 41048.6 41248.4 36909.9 37657.0 37990.6 38128.8 38239.6 8055.7 8067.3 8120.9 8162.6 8450.7 28798.9 29463.6 29735.9 29771.6 29910.1 32801.0 33328.8 36592.3 37059.8 37294.4 9980.0 10244.4 10301.6 10357.1 10537.3 11480.5 11687.4 11691.1 12432.6 12460.8 10419.6 10471.5 10914.5 11030.5 11034.2 10187.7 10433.5 10554.2 10961.7 11357.2 9449.4 9754.6 9896.6 10076.3 10117.4 8609.5 8675.4 8816.0 9022.9 9130.5 8645.3 9117.0 9135.2 9258.7 9314.8 04:35:21 INFO - PROCESS | 24188 | -------- Summary: end -------- 04:35:21 INFO - PROCESS | 24188 | 04:35:21 INFO - TEST-INFO | 24188: exit 0 04:35:21 INFO - TEST-OK | dromaeo_css | took 1113333ms 04:35:21 INFO - TEST-START | kraken 04:35:21 INFO - operating with platform_type : linux_ 04:35:21 INFO - Initialising browser for kraken test... 04:35:21 INFO - TEST-INFO | started process 24426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLy8CGp/profile http://localhost:57654/getInfo.html) 04:35:25 INFO - PROCESS | 24426 | 04:35:25 INFO - PROCESS | 24426 | (process:24496): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:35:26 INFO - PROCESS | 24426 | __metrics Screen width/height:1600/1200 04:35:26 INFO - PROCESS | 24426 | colorDepth:24 04:35:26 INFO - PROCESS | 24426 | Browser inner width/height: 1024/697 04:35:26 INFO - PROCESS | 24426 | __metrics 04:35:26 INFO - PROCESS | 24426 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:35:27 INFO - TEST-INFO | 24426: exit 0 04:35:27 INFO - Browser initialized. 04:35:27 INFO - Running cycle 1/1 for kraken test... 04:35:27 INFO - TEST-INFO | started process 24545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLy8CGp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:35:28 INFO - PROCESS | 24545 | 04:35:28 INFO - PROCESS | 24545 | (process:24605): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:35:39 INFO - PROCESS | 24545 | RSS: Main: 150200320 04:35:39 INFO - PROCESS | 24545 | 04:35:41 INFO - PROCESS | 24545 | Cycle 1(1): loaded http://localhost:57654/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57654/tests/kraken/driver.html?testName=audio-beat-detection) 04:35:42 INFO - PROCESS | 24545 | RSS: Main: 151080960 04:35:42 INFO - PROCESS | 24545 | 04:35:45 INFO - PROCESS | 24545 | Cycle 1(1): loaded http://localhost:57654/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57654/tests/kraken/driver.html?testName=audio-dft) 04:35:45 INFO - PROCESS | 24545 | RSS: Main: 153726976 04:35:45 INFO - PROCESS | 24545 | 04:35:48 INFO - PROCESS | 24545 | Cycle 1(1): loaded http://localhost:57654/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57654/tests/kraken/driver.html?testName=audio-fft) 04:35:49 INFO - PROCESS | 24545 | RSS: Main: 146440192 04:35:49 INFO - PROCESS | 24545 | 04:35:51 INFO - PROCESS | 24545 | Cycle 1(1): loaded http://localhost:57654/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57654/tests/kraken/driver.html?testName=audio-oscillator) 04:35:52 INFO - PROCESS | 24545 | RSS: Main: 146743296 04:35:52 INFO - PROCESS | 24545 | 04:35:54 INFO - PROCESS | 24545 | Cycle 1(1): loaded http://localhost:57654/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57654/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:35:54 INFO - PROCESS | 24545 | RSS: Main: 147394560 04:35:54 INFO - PROCESS | 24545 | 04:35:57 INFO - PROCESS | 24545 | Cycle 1(1): loaded http://localhost:57654/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57654/tests/kraken/driver.html?testName=imaging-darkroom) 04:35:58 INFO - PROCESS | 24545 | RSS: Main: 147234816 04:35:58 INFO - PROCESS | 24545 | 04:36:02 INFO - PROCESS | 24545 | Cycle 1(1): loaded http://localhost:57654/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57654/tests/kraken/driver.html?testName=imaging-desaturate) 04:36:02 INFO - PROCESS | 24545 | RSS: Main: 147386368 04:36:02 INFO - PROCESS | 24545 | 04:36:05 INFO - PROCESS | 24545 | Cycle 1(1): loaded http://localhost:57654/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57654/tests/kraken/driver.html?testName=json-parse-financial) 04:36:06 INFO - PROCESS | 24545 | RSS: Main: 148283392 04:36:06 INFO - PROCESS | 24545 | 04:36:07 INFO - PROCESS | 24545 | Cycle 1(1): loaded http://localhost:57654/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57654/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:36:08 INFO - PROCESS | 24545 | RSS: Main: 149037056 04:36:08 INFO - PROCESS | 24545 | 04:36:10 INFO - PROCESS | 24545 | Cycle 1(1): loaded http://localhost:57654/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57654/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:36:11 INFO - PROCESS | 24545 | RSS: Main: 148197376 04:36:11 INFO - PROCESS | 24545 | 04:36:13 INFO - PROCESS | 24545 | Cycle 1(1): loaded http://localhost:57654/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57654/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:36:13 INFO - PROCESS | 24545 | RSS: Main: 148017152 04:36:13 INFO - PROCESS | 24545 | 04:36:16 INFO - PROCESS | 24545 | Cycle 1(1): loaded http://localhost:57654/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:36:16 INFO - PROCESS | 24545 | RSS: Main: 149454848 04:36:16 INFO - PROCESS | 24545 | 04:36:19 INFO - PROCESS | 24545 | Cycle 1(1): loaded http://localhost:57654/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:36:20 INFO - PROCESS | 24545 | RSS: Main: 149237760 04:36:20 INFO - PROCESS | 24545 | 04:36:22 INFO - PROCESS | 24545 | Cycle 1(1): loaded http://localhost:57654/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57654/tests/kraken/driver.html?testName=ai-astar) 04:36:22 INFO - PROCESS | 24545 | RSS: Main: 149622784 04:36:22 INFO - PROCESS | 24545 | 04:36:22 INFO - PROCESS | 24545 | __start_tp_report 04:36:22 INFO - PROCESS | 24545 | _x_x_mozilla_page_load 04:36:22 INFO - PROCESS | 24545 | _x_x_mozilla_page_load_details 04:36:22 INFO - PROCESS | 24545 | |i|pagename|runs| 04:36:22 INFO - PROCESS | 24545 | |0;ai-astar;115;109;119;114;114;124;117;115;115;115 04:36:22 INFO - PROCESS | 24545 | |1;audio-beat-detection;150;144;164;172;134;160;154;138;168;132 04:36:22 INFO - PROCESS | 24545 | |2;audio-dft;161;161;164;162;170;164;167;163;166;163 04:36:22 INFO - PROCESS | 24545 | |3;audio-fft;75;76;73;149;74;73;74;72;157;73 04:36:22 INFO - PROCESS | 24545 | |4;audio-oscillator;98;98;136;98;98;97;146;99;97;144 04:36:22 INFO - PROCESS | 24545 | |5;imaging-gaussian-blur;110;111;109;111;109;110;110;111;110;109 04:36:22 INFO - PROCESS | 24545 | |6;imaging-darkroom;149;151;148;148;149;149;149;151;148;148 04:36:22 INFO - PROCESS | 24545 | |7;imaging-desaturate;95;99;97;97;97;96;96;96;97;96 04:36:22 INFO - PROCESS | 24545 | |8;json-parse-financial;71;72;72;70;72;72;71;80;69;70 04:36:22 INFO - PROCESS | 24545 | |9;json-stringify-tinderbox;66;67;69;65;72;67;68;67;66;67 04:36:22 INFO - PROCESS | 24545 | |10;stanford-crypto-aes;81;85;86;86;94;92;84;85;84;85 04:36:22 INFO - PROCESS | 24545 | |11;stanford-crypto-ccm;125;124;122;124;126;122;130;124;123;140 04:36:22 INFO - PROCESS | 24545 | |12;stanford-crypto-pbkdf2;135;149;148;147;148;140;147;144;148;147 04:36:22 INFO - PROCESS | 24545 | |13;stanford-crypto-sha256-iterative;76;73;72;71;72;71;73;72;72;70 04:36:22 INFO - PROCESS | 24545 | __end_tp_report 04:36:22 INFO - PROCESS | 24545 | __start_cc_report 04:36:22 INFO - PROCESS | 24545 | _x_x_mozilla_cycle_collect,796 04:36:22 INFO - PROCESS | 24545 | __end_cc_report 04:36:22 INFO - PROCESS | 24545 | __startTimestamp1452688582258__endTimestamp 04:36:22 INFO - PROCESS | 24545 | 04:36:22 INFO - PROCESS | 24545 | ------- Summary: start ------- 04:36:22 INFO - PROCESS | 24545 | Number of tests: 14 04:36:22 INFO - PROCESS | 24545 | 04:36:22 INFO - PROCESS | 24545 | [#0] ai-astar Cycles:10 Average:115.70 Median:115.00 stddev:3.86 (3.4%) stddev-sans-first:4.09 04:36:22 INFO - PROCESS | 24545 | Values: 115.0 109.0 119.0 114.0 114.0 124.0 117.0 115.0 115.0 115.0 04:36:22 INFO - PROCESS | 24545 | 04:36:22 INFO - PROCESS | 24545 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:157.00 stddev:14.35 (9.1%) stddev-sans-first:15.21 04:36:22 INFO - PROCESS | 24545 | Values: 150.0 144.0 164.0 172.0 134.0 160.0 154.0 138.0 168.0 132.0 04:36:22 INFO - PROCESS | 24545 | 04:36:22 INFO - PROCESS | 24545 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.85 (1.7%) stddev-sans-first:2.79 04:36:22 INFO - PROCESS | 24545 | Values: 161.0 161.0 164.0 162.0 170.0 164.0 167.0 163.0 166.0 163.0 04:36:22 INFO - PROCESS | 24545 | 04:36:22 INFO - PROCESS | 24545 | [#3] audio-fft Cycles:10 Average:89.60 Median:73.50 stddev:33.49 (45.6%) stddev-sans-first:35.10 04:36:22 INFO - PROCESS | 24545 | Values: 75.0 76.0 73.0 149.0 74.0 73.0 74.0 72.0 157.0 73.0 04:36:22 INFO - PROCESS | 24545 | 04:36:22 INFO - PROCESS | 24545 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:98.00 stddev:21.48 (21.9%) stddev-sans-first:22.25 04:36:22 INFO - PROCESS | 24545 | Values: 98.0 98.0 136.0 98.0 98.0 97.0 146.0 99.0 97.0 144.0 04:36:22 INFO - PROCESS | 24545 | 04:36:22 INFO - PROCESS | 24545 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 04:36:22 INFO - PROCESS | 24545 | Values: 110.0 111.0 109.0 111.0 109.0 110.0 110.0 111.0 110.0 109.0 04:36:22 INFO - PROCESS | 24545 | 04:36:22 INFO - PROCESS | 24545 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:1.15 (0.8%) stddev-sans-first:1.22 04:36:22 INFO - PROCESS | 24545 | Values: 149.0 151.0 148.0 148.0 149.0 149.0 149.0 151.0 148.0 148.0 04:36:22 INFO - PROCESS | 24545 | 04:36:22 INFO - PROCESS | 24545 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:1.07 (1.1%) stddev-sans-first:0.97 04:36:22 INFO - PROCESS | 24545 | Values: 95.0 99.0 97.0 97.0 97.0 96.0 96.0 96.0 97.0 96.0 04:36:22 INFO - PROCESS | 24545 | 04:36:22 INFO - PROCESS | 24545 | [#8] json-parse-financial Cycles:10 Average:71.90 Median:72.00 stddev:3.03 (4.2%) stddev-sans-first:3.20 04:36:22 INFO - PROCESS | 24545 | Values: 71.0 72.0 72.0 70.0 72.0 72.0 71.0 80.0 69.0 70.0 04:36:22 INFO - PROCESS | 24545 | 04:36:22 INFO - PROCESS | 24545 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.00 stddev:1.96 (2.9%) stddev-sans-first:2.01 04:36:22 INFO - PROCESS | 24545 | Values: 66.0 67.0 69.0 65.0 72.0 67.0 68.0 67.0 66.0 67.0 04:36:22 INFO - PROCESS | 24545 | 04:36:22 INFO - PROCESS | 24545 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:85.50 stddev:3.88 (4.5%) stddev-sans-first:3.63 04:36:22 INFO - PROCESS | 24545 | Values: 81.0 85.0 86.0 86.0 94.0 92.0 84.0 85.0 84.0 85.0 04:36:22 INFO - PROCESS | 24545 | 04:36:22 INFO - PROCESS | 24545 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:124.50 stddev:5.44 (4.4%) stddev-sans-first:5.75 04:36:22 INFO - PROCESS | 24545 | Values: 125.0 124.0 122.0 124.0 126.0 122.0 130.0 124.0 123.0 140.0 04:36:22 INFO - PROCESS | 24545 | 04:36:22 INFO - PROCESS | 24545 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.30 Median:147.50 stddev:4.47 (3.0%) stddev-sans-first:2.79 04:36:22 INFO - PROCESS | 24545 | Values: 135.0 149.0 148.0 147.0 148.0 140.0 147.0 144.0 148.0 147.0 04:36:22 INFO - PROCESS | 24545 | 04:36:22 INFO - PROCESS | 24545 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:72.00 stddev:1.62 (2.2%) stddev-sans-first:0.97 04:36:22 INFO - PROCESS | 24545 | Values: 76.0 73.0 72.0 71.0 72.0 71.0 73.0 72.0 72.0 70.0 04:36:22 INFO - PROCESS | 24545 | -------- Summary: end -------- 04:36:22 INFO - PROCESS | 24545 | 04:36:23 INFO - TEST-INFO | 24545: exit 0 04:36:23 INFO - TEST-OK | kraken | took 61522ms 04:36:23 INFO - TEST-START | v8_7 04:36:23 INFO - operating with platform_type : linux_ 04:36:23 INFO - Initialising browser for v8_7 test... 04:36:23 INFO - TEST-INFO | started process 24833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpExQD5y/profile http://localhost:57654/getInfo.html) 04:36:26 INFO - PROCESS | 24833 | 04:36:26 INFO - PROCESS | 24833 | (process:24906): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:36:27 INFO - PROCESS | 24833 | __metrics Screen width/height:1600/1200 04:36:27 INFO - PROCESS | 24833 | colorDepth:24 04:36:27 INFO - PROCESS | 24833 | Browser inner width/height: 1024/697 04:36:27 INFO - PROCESS | 24833 | __metrics 04:36:27 INFO - PROCESS | 24833 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:36:28 INFO - TEST-INFO | 24833: exit 0 04:36:28 INFO - Browser initialized. 04:36:28 INFO - Running cycle 1/1 for v8_7 test... 04:36:28 INFO - TEST-INFO | started process 24955 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpExQD5y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:36:30 INFO - PROCESS | 24955 | 04:36:30 INFO - PROCESS | 24955 | (process:25011): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:36:40 INFO - PROCESS | 24955 | RSS: Main: 150065152 04:36:40 INFO - PROCESS | 24955 | 04:37:02 INFO - PROCESS | 24955 | Cycle 1(1): loaded http://localhost:57654/tests/v8_7/run.html (next: http://localhost:57654/tests/v8_7/run.html) 04:37:03 INFO - PROCESS | 24955 | RSS: Main: 144269312 04:37:03 INFO - PROCESS | 24955 | 04:37:03 INFO - PROCESS | 24955 | __start_tp_report 04:37:03 INFO - PROCESS | 24955 | _x_x_mozilla_page_load 04:37:03 INFO - PROCESS | 24955 | _x_x_mozilla_page_load_details 04:37:03 INFO - PROCESS | 24955 | |i|pagename|runs| 04:37:03 INFO - PROCESS | 24955 | |0;Richards;166.88918558077435 04:37:03 INFO - PROCESS | 24955 | |1;DeltaBlue;187.0907390084191 04:37:03 INFO - PROCESS | 24955 | |2;Encrypt;278.2415136338342 04:37:03 INFO - PROCESS | 24955 | |3;Decrypt;5256.544502617801 04:37:03 INFO - PROCESS | 24955 | |4;RayTrace;1112.3470522803113 04:37:03 INFO - PROCESS | 24955 | |5;Earley;707.2135785007072 04:37:03 INFO - PROCESS | 24955 | |6;Boyer;12382.716049382716 04:37:03 INFO - PROCESS | 24955 | |7;RegExp;43042.55319148936 04:37:03 INFO - PROCESS | 24955 | |8;Splay;936.8616527390901 04:37:03 INFO - PROCESS | 24955 | |9;NavierStokes;4850.241545893719 04:37:03 INFO - PROCESS | 24955 | __end_tp_report 04:37:03 INFO - PROCESS | 24955 | __startTimestamp1452688623238__endTimestamp 04:37:03 INFO - PROCESS | 24955 | 04:37:03 INFO - PROCESS | 24955 | ------- Summary: start ------- 04:37:03 INFO - PROCESS | 24955 | Number of tests: 10 04:37:03 INFO - PROCESS | 24955 | 04:37:03 INFO - PROCESS | 24955 | [#0] Richards Cycles:1 Average:166.89 Median:166.89 stddev:0.00 (0.0%) 04:37:03 INFO - PROCESS | 24955 | Values: 166.9 04:37:03 INFO - PROCESS | 24955 | 04:37:03 INFO - PROCESS | 24955 | [#1] DeltaBlue Cycles:1 Average:187.09 Median:187.09 stddev:0.00 (0.0%) 04:37:03 INFO - PROCESS | 24955 | Values: 187.1 04:37:03 INFO - PROCESS | 24955 | 04:37:03 INFO - PROCESS | 24955 | [#2] Encrypt Cycles:1 Average:278.24 Median:278.24 stddev:0.00 (0.0%) 04:37:03 INFO - PROCESS | 24955 | Values: 278.2 04:37:03 INFO - PROCESS | 24955 | 04:37:03 INFO - PROCESS | 24955 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 04:37:03 INFO - PROCESS | 24955 | Values: 5256.5 04:37:03 INFO - PROCESS | 24955 | 04:37:03 INFO - PROCESS | 24955 | [#4] RayTrace Cycles:1 Average:1112.35 Median:1112.35 stddev:0.00 (0.0%) 04:37:03 INFO - PROCESS | 24955 | Values: 1112.3 04:37:03 INFO - PROCESS | 24955 | 04:37:03 INFO - PROCESS | 24955 | [#5] Earley Cycles:1 Average:707.21 Median:707.21 stddev:0.00 (0.0%) 04:37:03 INFO - PROCESS | 24955 | Values: 707.2 04:37:03 INFO - PROCESS | 24955 | 04:37:03 INFO - PROCESS | 24955 | [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 04:37:03 INFO - PROCESS | 24955 | Values: 12382.7 04:37:03 INFO - PROCESS | 24955 | 04:37:03 INFO - PROCESS | 24955 | [#7] RegExp Cycles:1 Average:43042.55 Median:43042.55 stddev:0.00 (0.0%) 04:37:03 INFO - PROCESS | 24955 | Values: 43042.6 04:37:03 INFO - PROCESS | 24955 | 04:37:03 INFO - PROCESS | 24955 | [#8] Splay Cycles:1 Average:936.86 Median:936.86 stddev:0.00 (0.0%) 04:37:03 INFO - PROCESS | 24955 | Values: 936.9 04:37:03 INFO - PROCESS | 24955 | 04:37:03 INFO - PROCESS | 24955 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 04:37:03 INFO - PROCESS | 24955 | Values: 4850.2 04:37:03 INFO - PROCESS | 24955 | -------- Summary: end -------- 04:37:03 INFO - PROCESS | 24955 | 04:37:04 INFO - TEST-INFO | 24955: exit 0 04:37:04 INFO - TEST-OK | v8_7 | took 40944ms 04:37:04 INFO - SUITE-END | took 1215s 04:37:04 INFO - Completed test suite (00:20:15) 04:37:04 INFO - Working with test: dromaeo_css 04:37:04 INFO - Generating results file: dromaeo_css 04:37:04 INFO - Working with test: kraken 04:37:04 INFO - Generating results file: kraken 04:37:04 INFO - javascript benchmark 04:37:04 INFO - Working with test: v8_7 04:37:04 INFO - Generating results file: v8_7 04:37:04 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:37:04 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 04:37:04 INFO - process_Request line: dromaeo_css 6118.16 graph.html#tests=[[72,94,43]] 04:37:04 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:37:04 INFO - process_Request line: kraken 1556.70 graph.html#tests=[[232,94,43]] 04:37:04 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:37:04 INFO - process_Request line: v8_7 19333.54 graph.html#tests=[[230,94,43]] 04:37:04 INFO - RETURN: dromaeo_css: 6118.16 04:37:04 INFO - RETURN: kraken: 1556.70 04:37:04 INFO - RETURN: v8_7: 19333.54 04:37:04 INFO - javascript benchmark 04:37:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2629.894804207832, 2636.9736302636975, 2665.8267212631176, 2673.157955244098, 2675.0904692404583, 4389.253826849435, 4488.236999710049, 4510.4587449506025, 4526.411566496359, 4551.294549344852, 4461.118826620845, 4464.441944756897, 4470.329450582414, 4492.460904691434, 4577.404937358147, 4177.937330940038, 4222.598853108965, 4236.809343579531, 4252.723572967762, 4316.179925814085, 269.8331749846308, 4188.748675079505, 4280.764557949312, 4280.957190428087, 4323.935140972888, 4055.71609987301, 4140.4617399738145, 4169.478815148106, 4177.728447650893, 4224.197402493516, 4194.727342722713, 4210.32634778434, 4214.726042807208, 4221.6833737469815, 4267.082577245876, 4138.772367519785, 4179.205950869356, 4204.621584057419, 4222.429971953778, 4231.048014196812, 4388.1223755249075, 4434.955650443519, 4451.465824101128, 4470.195364834329, 4513.300438432048, 4765.0231702500905, 4817.638677099197, 4819.855404337875, 4843.806247750086, 4855.028994201174, 4803.159447096744, 4844.806207751686, 4881.731504767236, 4890.682105663156, 4900.0, 4465.531119232466, 4468.218061839165, 4481.238189507759, 4520.954790452086, 4526.977365113154, 4904.558589726942, 4917.680350777188, 4924.187509060965, 4960.578350840146, 4972.403311602631, 4627.167109920179, 4718.811247550059, 4720.244760838249, 4739.9763001185465, 4778.474367819537, 4881.145799485076, 4881.292212629149, 4883.438404583519, 4899.167141585867, 4929.334539837076, 4824.541668541483, 4828.855134345975, 4834.6374021948495, 4838.854834354975, 4863.8540843774745, 4630.907381852411, 4701.3653156824075, 4719.528047195322, 4787.114383838932, 4789.784459699322, 4028.1540876415693, 4028.617281358266, 4035.6771458283856, 4045.19096180765, 4058.0463591056077, 3567.5897271813556, 3571.464280357915, 3599.0642432967616, 3606.4590311453494, 3623.710103191738, 4070.2063097695664, 4137.358709400048, 4137.379393091061, 4145.709800313949, 4162.438070860395, 4748.596369308579, 4800.0, 4826.686265392738, 4847.321375007502, 4878.975605121952, 4199.874003779892, 4200.033992181754, 4207.957920420757, 4214.662826973896, 4250.787460626956, 4266.0188156724125, 4268.487781466244, 4311.8706438806885, 4344.761038142932, 4360.607545320936, 4538.88652783683, 4546.681732278708, 4552.886177845514, 4576.97711511447, 4587.63298936091, 4820.421549414093, 4832.057748738962, 4839.032193561231, 4842.685225460334, 4875.561199492063, 4507.706999045052, 4533.977330113328, 4561.110583436198, 4600.033992861537, 4613.215753322011, 4736.834210802605, 4743.1225223333795, 4745.667803253739, 4747.43030836288, 4747.928781068218, 4770.403699537558, 4790.137775200497, 4798.1123492154065, 4828.637852161172, 4842.249451335048, 4635.142498637762, 4663.253879379283, 4708.482066972561, 4716.481187069351, 4753.263244197155, 4708.317293992421, 4733.9053218936115, 4738.620910327097, 4740.715557066587, 4808.158572249912, 4502.077074199847, 4618.03021365517, 4652.813887444464, 4656.138614356355, 4683.461401938821, 4730.219513780187, 4740.549647783455, 4752.857414277439, 4769.594584460359, 4793.832215872428, 4634.83778067766, 4662.650301227353, 4664.370310008106, 4673.252279635242, 4682.531746825291], "unit": "score", "name": "dojo.html", "value": 4417.589852005121}, {"lowerIsBetter": false, "replicates": [481.63395819177435, 515.1037195280213, 518.5229588778324, 538.717173483921, 540.9026375252454, 31918.680813191862, 32361.83819080907, 32493.0, 32493.187670308253, 32549.349013019753, 32758.0, 33288.33423331532, 33336.16659583506, 33339.0, 33380.83309583455, 7261.164966028921, 7435.293647103516, 7454.40364770817, 7469.887951680702, 7501.0, 7403.037605111328, 7549.886751698701, 7552.055993000875, 7559.811004724871, 7560.735374261902, 7323.523970941898, 7481.8877716834295, 7490.550566965972, 7529.058867641545, 7541.095068591777, 7526.435517336222, 7533.133689625681, 7555.848883022309, 7574.886376704354, 7606.429517786133, 7425.997490338789, 7524.172341042481, 7540.622968851536, 7558.886616700754, 7569.924300756977, 32750.0, 33260.667393325995, 33300.66699333, 33304.33391332184, 33306.83346583252, 2920.211542883431, 2972.5689774982507, 3056.2512184514712, 3218.678132186786, 3436.5532480777338, 26839.59740603873, 27052.0, 27128.86435567829, 27412.588811167847, 27478.313042173904, 3421.6578342165835, 3463.9653603463894, 3486.546748922624, 3501.1947252132154, 3587.6232995535615, 211505.0, 211828.0, 211843.99999999846, 211943.0, 212241.0, 43978.34032489515, 44872.55127448749, 50748.492515075115, 56606.0, 57980.71009645009, 49984.0, 50364.244536331986, 50610.240846387336, 50639.0, 50661.74669126631, 13726.245056521788, 13823.723525529433, 13856.93071534636, 14023.78964315536, 14130.788038179435, 10756.193285503463, 10833.187510936712, 10868.891311086945, 10893.291936024134, 10897.400642964712, 17274.395396161075, 17330.65338693219, 17450.738238926428, 17599.560010999827, 17602.823971760376, 7209.387202087882, 7389.926100739031, 7442.553446793209, 7451.2921272479025, 7533.359664428475, 914.131575003749, 923.9399439036441, 977.8728765260471, 982.4400091947664, 1009.1271050541376, 25799.226023219333, 26164.0, 26506.337341566614, 26590.867045664647, 26775.464490710077, 960.3325688646463, 964.6141543382703, 974.6150270643057, 988.7874107067015, 1043.4417586591137, 12471.251724896536, 12628.305443200528, 13841.930790345983, 14133.929330353283, 14505.202213878338, 193851.0, 193855.0, 197042.0, 197492.0, 197637.0, 40231.59768402337, 40506.39240411396, 40557.39163912544, 40569.18861622751, 40826.59173408228, 1231.3473858854643, 1243.9937800311122, 1244.5706231349989, 1248.7190382164122, 1360.149906308557, 23911.402214944068, 25658.230253092435, 26503.867480662473, 26551.203463896112, 26682.198369170957, 37559.81220093882, 37710.057248569006, 37868.810655946545, 38019.239615206985, 38093.238135236585, 243265.0, 244663.0, 245198.77400612884, 245834.0, 245941.0, 26806.59790103189, 28145.014924477546, 28508.57237141403, 28614.0, 28735.0, 32755.0, 33171.0, 33334.0, 33501.66498334985, 33642.15894602556, 27903.16290511288, 27962.161135165978, 28258.576121357786, 28632.0, 29153.125406237847, 28083.578746318413, 28289.0, 28444.57333140046, 28809.135725928256, 29150.0, 28295.575566366108, 28377.574336384558, 28647.42705145927, 28831.855840720662, 28895.711042890143, 26885.327866803487, 28050.751092225517, 28065.298367540974, 28634.85682571574, 28866.711332886403, 22361.77638223662, 22395.0, 22530.324090277318, 22575.0, 22689.546209076056], "unit": "score", "name": "ext.html", "value": 15840.380974410959}, {"lowerIsBetter": false, "replicates": [338.3469903087043, 340.9045467269164, 342.6187993445554, 345.86165533786465, 348.195668006904, 13684.726305473885, 13793.448262069518, 14856.925715371408, 15485.0, 16068.839311606866, 10339.483025848696, 10646.25476216665, 12953.611391658265, 15240.0, 15249.695006099872, 4547.772611369435, 4644.767761611923, 4737.692050016755, 4927.2609108633815, 5113.258577506259, 5055.39335279767, 5059.6964182149, 5071.670341427814, 5108.310378098946, 5114.6164037697135, 5153.896922061575, 5765.855853603673, 5769.394213607574, 5781.739821708013, 5790.652560846363, 5776.306843178824, 5790.36306006339, 5798.681072541009, 5886.352501224862, 6142.385761423867, 5644.294463192101, 5886.58793884424, 5888.705564721747, 5896.997510423195, 5913.763449462016, 17718.911405443017, 18137.54656133594, 18496.44510664682, 19963.50091247716, 20085.0, 1741.8084010758807, 1807.7198034304704, 1882.4729075858781, 1897.9810201897942, 1959.6968016269163, 12247.326397048158, 12969.805452918214, 13050.673733156653, 13072.411741471562, 13665.931670341684, 1798.3256278895415, 1853.851691864661, 1897.459224121119, 1902.9809701902943, 1904.7619047619048, 43389.56610433887, 43715.90710232238, 43915.34126988098, 44215.0, 55954.16068758972, 13636.727265454636, 13932.860671393359, 13979.09135906163, 14075.718485630436, 14101.78847317291, 20268.290609828586, 20501.17995280202, 20528.0, 20592.27927022547, 20631.277905273244, 7922.247386498273, 7931.841363172704, 7991.72028978983, 8052.315553177928, 8269.669213231524, 6647.800565983028, 6682.398584127452, 6683.699233534503, 6718.126643536309, 6730.360615741497, 3975.383815508601, 4167.249895018926, 4183.769892655872, 4228.281192197333, 7362.411007119417, 1754.1317048061292, 1759.2874885671324, 1777.2002598830577, 1808.430344441523, 1843.7050071988417, 835.8620827563384, 847.584683505078, 868.9956550217208, 944.8236945003515, 958.3626888119322, 12005.939970300093, 12313.26120432777, 13393.598192054254, 14941.477048303257, 15315.770263446057, 818.6476379227056, 829.5271695133716, 844.3371953016853, 851.7998270406573, 943.834828904939, 7833.2249109860395, 8361.331093512505, 8406.201410865959, 8552.315814734806, 8680.56597170139, 441676.0, 443289.0, 443797.0, 456309.0, 458239.0, 62026.0, 63405.0, 64552.67723661446, 64791.0, 65554.67222663856, 1034.5965073621294, 1067.5569638599893, 1068.4123731947398, 1072.2815713471994, 1073.5759375046812, 13751.449942002608, 13806.240656763974, 13851.445942162603, 13872.653183670085, 14212.0, 29507.114786556438, 29973.250668733457, 30026.549601755552, 30396.0, 30703.078907632807, 39073.609263907, 39256.2148757029, 39487.0, 39602.207955840146, 40740.0, 6132.938670613236, 6190.442860142609, 6398.584092034003, 6463.741450341934, 6586.242582103119, 3191.4255434022098, 3740.0275928258307, 7121.537100088478, 9949.204063675033, 10405.323653962469, 7888.092869320101, 8109.553974531457, 8154.714584989497, 8314.459560128815, 8551.401401901807, 8645.783855403664, 8809.383343165917, 8983.505907175168, 8998.460092394216, 9121.133492318218, 8170.060443049126, 8185.754427367188, 8216.712415065444, 8312.83374332522, 8513.82972340562, 6418.807435776934, 6542.967285163544, 6614.66926653675, 6742.730290788313, 6816.7614133505085, 7189.388901943394, 8302.916970830456, 8308.210719981593, 8389.874151887849, 8449.619767110618], "unit": "score", "name": "jquery.html", "value": 7745.8900183961105}, {"lowerIsBetter": false, "replicates": [1368.445779459319, 1394.7838085096807, 1498.183489997951, 1698.150924537731, 1727.265911987405, 5978.103284507326, 6148.446639802417, 6601.966990165049, 6786.660666966651, 6808.829779255521, 6502.73989040439, 6597.670116494168, 6656.76701315454, 6714.72420240154, 6733.158355205599, 2033.2273735980343, 2062.298818401743, 2063.319104695447, 2063.5357044664906, 2066.1012459580056, 2011.5272910865936, 2030.0560239488634, 2043.3461292386442, 2069.524009477821, 2074.4917495213695, 2056.177528988409, 2077.044559502631, 2079.064421010551, 2089.550746589483, 2090.080364639561, 2043.3461292386442, 2043.8773673579633, 2048.139781291861, 2049.385184444661, 2050.169681279084, 2008.3774030050731, 2040.36748607932, 2071.513194399315, 2074.4917495213767, 2076.4289820299387, 6890.931090689079, 6949.339812717834, 6959.512834101615, 6970.581765094111, 6978.371946524837, 4078.632923036911, 4152.771597562133, 4169.541350451448, 4181.268278051329, 4187.330027195664, 2685.2615530729204, 2736.835789852615, 2753.6695596528543, 2877.7122287771263, 2880.942381152386, 817.1828171828172, 853.5348235211825, 884.6107712606432, 889.0398369760643, 934.2059249637754, 9200.401973871743, 9246.35275530713, 9276.35065545419, 9290.16388525036, 9305.720828375159, 3721.3673675475234, 3729.4965179700393, 3731.3470142724914, 3765.7740535567955, 3802.7718336899875, 8103.0681471631515, 8118.837623247502, 8123.309518690978, 8128.268455839003, 8140.552269625227, 4145.419641250227, 4152.8131234094535, 4170.541240463546, 4172.123853990696, 4182.832686692498, 3307.751918606114, 3384.1877949292484, 3698.2973235085246, 3781.1303400218103, 3798.639129282714, 3266.950995735066, 3268.8202148881564, 3335.93328133436, 3338.4157772389735, 3350.0, 1046.2780681329857, 1072.5441687282873, 1085.7285678580356, 1090.0026475774578, 1090.1333439915286, 809.283783851284, 826.5040975414703, 1161.4425075963584, 1167.1829719196426, 1170.976580468386, 6487.870242595121, 6540.771073012422, 6542.34576542342, 6584.8024559263295, 6593.703283352261, 1032.6385764982197, 1043.634727845248, 1047.0681093826502, 1055.5250137438184, 1060.379677888444, 4980.178270585386, 5038.193888977819, 5052.393712754493, 5075.0, 5095.694258344437, 7885.448018638755, 8289.0, 8308.418410711312, 8474.788130296793, 8521.744347669579, 8256.958715206385, 8338.833223335621, 8345.248927596424, 8375.916240837514, 8381.161883811692, 6563.507736919654, 6589.439897608757, 6647.800565983028, 6669.0, 6694.163229596203, 6209.844753881189, 6250.937490625036, 6253.0, 6253.030780229072, 6273.1844860167885, 7337.0828646419195, 7520.699172033276, 7579.242075792376, 7592.316691497792, 7675.731349402744, 7532.54804711719, 7593.772186834404, 7664.271894170045, 7668.348190403878, 7687.500312479671, 5065.3161823153405, 5212.374515058217, 5841.32824725162, 5872.236609240771, 5901.114832774946, 6134.263888333428, 6247.281562620356, 6257.405546473078, 6262.561620686691, 6288.339724328879, 5937.3468918418075, 5994.340622531605, 6062.514998800174, 6080.4831589313635, 6230.7507699691505, 5590.133529302964, 5679.0345641240265, 5681.460261275172, 5690.544756419559, 5773.538116950718, 6013.699315034319, 6035.336113027652, 6066.696665166813, 6230.719617617127, 6262.906056409249, 5738.741756620879, 5783.074708046693, 5786.971065144648, 5792.304923409218, 5807.245058142415, 5660.207570940154, 5732.197492350991, 5744.224529688606, 5751.7411716472025, 5754.251947246831], "unit": "score", "name": "mootools.html", "value": 3972.600140169603}, {"lowerIsBetter": false, "replicates": [294.2217833829521, 294.45819691767144, 300.6467400804056, 303.7403020417544, 308.69747647305655, 5494.807681731135, 5527.778888844451, 5565.443455654433, 5636.267285252921, 5690.943090569093, 5466.1527463243265, 5580.441955804417, 5606.971965140179, 5615.241942337783, 5625.831225063244, 4133.441985331987, 4291.313389857623, 4295.806688699, 4302.720323178984, 4312.159128969836, 4249.022724773304, 4264.7441153530735, 4286.0, 4291.678124140686, 4306.806193721274, 4206.284931561627, 4225.795648240252, 4252.468441444819, 4254.3618457231505, 4268.829246830123, 4248.468941382327, 4261.083866968585, 4269.6370808481315, 4279.87160385189, 4281.250781113293, 3700.093477098101, 3701.2597480503737, 3705.888823335304, 3709.0541911812584, 3715.1826598148364, 5268.288781014552, 5275.4460781618145, 5386.461353864583, 5390.811321603725, 5396.7301634918485, 4847.0, 4881.414230292352, 4914.852554423373, 4923.58149557288, 4925.753712314406, 5835.35811060783, 5850.97074514629, 5853.736581853785, 5900.557458190653, 5911.881762364728, 3970.861019864291, 4060.2488539620263, 4061.451704019949, 4062.7765472898977, 4084.14233011068, 6138.693065346715, 6160.383961603849, 6162.506999440034, 6164.260288765377, 6208.068789681539, 4186.581341865789, 4215.957840421618, 4223.598758118035, 4226.450561426995, 4231.153769246163, 4279.529251782302, 4284.3145096784365, 4286.914261714748, 4287.721298115613, 4299.591538803808, 4674.462436819741, 4888.388951381077, 4891.119598472238, 4893.314935908976, 4895.290182923527, 5875.941240587625, 5880.8235752927485, 5909.172715819789, 5922.2597175353085, 5935.703214839327, 1496.790449337072, 1513.311443293299, 1519.802425684676, 1526.3207872496632, 1526.4199604150351, 1023.1712313026472, 1028.8456731490337, 1032.7211652853687, 1057.6351158850184, 1058.941758203306, 5081.618878584121, 5095.108356037678, 5096.694198348111, 5101.821436249714, 5118.360204974379, 6089.878202435926, 6112.541559383064, 6118.296395914527, 6124.265088189446, 6130.2030736004035, 5097.566706829887, 5100.515451032146, 5102.69383836971, 5103.97448012765, 5113.207452844815, 3227.8708851646143, 3260.0708797992456, 3295.07737833407, 3331.0839519132433, 3332.3835090508333, 5479.589030822624, 5740.512056475163, 5778.711064446761, 5780.71096445176, 5787.247657804459, 6200.844978875564, 6234.688265586793, 6316.494680425555, 6330.8100756977365, 6349.206349206349, 5658.462446067617, 5702.059160238514, 5737.77048918047, 5740.196372507852, 5749.999999999916, 6153.969230153821, 6155.353687862889, 6160.7535698571555, 6161.969190154021, 6174.289956654862, 5818.592698511064, 6019.398060193946, 6026.005709057957, 6032.577719559588, 6036.577439579363, 5732.770689172553, 5750.6837123958585, 5755.02164632022, 5765.308163020464, 5776.133579963039, 3992.840286388512, 4009.719319647597, 4013.0769922918475, 4013.91972160561, 4018.2365350583295, 6047.758089676539, 6175.9073613894925, 6194.101855230876, 6200.534959877937, 6200.627962322275, 5938.673372964528, 5950.077737950624, 5956.493698035715, 5958.165856779968, 5962.9105563415715, 5928.229330187048, 5931.08068249422, 5960.135780311917, 5963.91054134197, 5972.880542389041, 5643.435656434488, 5782.7686892523825, 5810.68041257718, 5812.68030258323, 5813.854653633693, 5905.852353691193, 5941.197938278277, 5965.433283838029, 5969.194158788508, 5975.7012149391485, 5778.8266352009505, 5802.506786923159, 5803.535717142703, 5817.040188368872, 5830.18377427169], "unit": "score", "name": "prototype.html", "value": 4397.978895791315}, {"lowerIsBetter": false, "replicates": [712.3304094151497, 739.781764379508, 744.9416776046959, 753.07371932523, 768.5888049893305, 11202.663920082401, 11364.431778411066, 11369.886301136987, 11369.943150284258, 11400.54397824087, 10847.186461015435, 10899.891001089987, 10921.890781092186, 10936.781264374707, 10956.561737530508, 595.5325069820192, 605.5518916002171, 643.6524276890497, 652.8498445357546, 775.5153029356652, 775.2247752247753, 780.8087018680432, 781.1641543548405, 783.5729527407548, 786.1273985875673, 825.8265764189528, 827.668932427031, 828.1345993436843, 828.4408024583412, 831.6548632317581, 815.2947700239309, 818.3248819723722, 819.6147810529042, 819.9709364747264, 820.3150369441464, 609.0438012320658, 609.1441524657819, 611.4741322462723, 612.5956868466835, 615.7690865925279, 10680.0, 10694.251402401835, 10731.35611863283, 10737.0, 10777.245592808507, 11615.0, 12027.639170824888, 12221.755564888652, 12241.632751017394, 12251.387430628522, 9194.08059194082, 9371.906280937172, 9440.57517411718, 9585.329026968115, 9592.0, 3177.8252196129206, 3212.9196770080703, 3213.5340375645633, 3227.3545290941906, 3349.949750753716, 38879.833604991894, 38993.61006389928, 39087.60912390868, 39158.41262381067, 39233.0, 9263.536823158815, 9371.0, 9528.618855245713, 9542.236621070298, 9564.66523671682, 16343.365663433562, 16486.83513164877, 16658.33366665344, 16688.666226675643, 16729.83270167283, 6402.551821372459, 6418.26189988148, 6505.121808555785, 6600.636964966973, 6710.698018589078, 3618.81905904709, 3731.384321586962, 3749.962500374961, 3776.981115094407, 3791.526059242595, 2483.7392073832348, 2497.775200231988, 2503.2740505253273, 2505.0981646607206, 2509.824312298158, 458.2050143001889, 466.0981001761602, 470.571779680496, 476.10492274523676, 477.1340017867559, 418.33275924900346, 429.61549413275566, 450.6980323183475, 499.2436458764974, 575.246427180395, 7405.925940740523, 7452.888206676904, 7582.772516824504, 7682.654280557276, 7684.769456916301, 386.64621870988293, 540.6728928997978, 589.3252226200976, 591.2756872830834, 595.475981136597, 3469.7918124912585, 3480.2517458746493, 3587.0852932502044, 4012.9398059029136, 4045.292073887058, 40889.182216355504, 41070.91968102404, 41187.0, 41297.587024129374, 41391.0, 37184.62815371866, 37668.43497347542, 37784.24431511409, 41048.58951410507, 41248.38127428091, 36909.892703219484, 37657.0, 37990.62009379926, 38128.809355953046, 38239.61760382416, 8055.718049868226, 8067.314278286177, 8120.878186827084, 8162.551059691774, 8450.704225352083, 28798.856005719837, 29463.558046629747, 29735.85132074326, 29771.55342669905, 29910.102696919126, 32801.0, 33328.83335583306, 36592.26815463623, 37059.81470092632, 37294.44058339181, 9980.0, 10244.385336879812, 10301.639442619473, 10357.119644830274, 10537.315074520131, 11480.483378247833, 11687.357195354338, 11691.064714822624, 12432.627021189379, 12460.813087803872, 10419.583216671248, 10471.528781205016, 10914.454277286262, 11030.50362733663, 11034.227604067639, 10187.694369168938, 10433.53049112807, 10554.208434367607, 10961.671149865517, 11357.204995650225, 9449.43303401798, 9754.561044753145, 9896.604135834774, 10076.345037572535, 10117.392956422638, 8609.52912897325, 8675.392722509616, 8816.0, 9022.909770902206, 9130.497822619554, 8645.308375329832, 9116.954415227881, 9135.177833994972, 9258.72223833286, 9314.813703725751], "unit": "score", "name": "yui.html", "value": 5537.712322285835}], "name": "dromaeo_css", "value": 6118.155573851398}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 109.0, 119.0, 114.0, 114.0, 124.0, 117.0, 115.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.7}, {"lowerIsBetter": true, "replicates": [150.0, 144.0, 164.0, 172.0, 134.0, 160.0, 154.0, 138.0, 168.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 151.6}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 164.0, 162.0, 170.0, 164.0, 167.0, 163.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 73.0, 149.0, 74.0, 73.0, 74.0, 72.0, 157.0, 73.0], "unit": "score", "name": "audio-fft", "value": 89.6}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 136.0, 98.0, 98.0, 97.0, 146.0, 99.0, 97.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 111.1}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 109.0, 111.0, 109.0, 110.0, 110.0, 111.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [149.0, 151.0, 148.0, 148.0, 149.0, 149.0, 149.0, 151.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 149.0}, {"lowerIsBetter": true, "replicates": [95.0, 99.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 70.0, 72.0, 72.0, 71.0, 80.0, 69.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 71.9}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 69.0, 65.0, 72.0, 67.0, 68.0, 67.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [81.0, 85.0, 86.0, 86.0, 94.0, 92.0, 84.0, 85.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [125.0, 124.0, 122.0, 124.0, 126.0, 122.0, 130.0, 124.0, 123.0, 140.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [135.0, 149.0, 148.0, 147.0, 148.0, 140.0, 147.0, 144.0, 148.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.3}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 72.0, 71.0, 72.0, 71.0, 73.0, 72.0, 72.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.2}], "name": "kraken", "value": 1556.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.88918558077435], "unit": "score", "name": "Richards", "value": 211.52958400000006}, {"lowerIsBetter": false, "replicates": [187.0907390084191], "unit": "score", "name": "DeltaBlue", "value": 353.40070999999995}, {"lowerIsBetter": false, "replicates": [278.2415136338342], "unit": "score", "name": "Encrypt", "value": 956.654514}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1112.3470522803113], "unit": "score", "name": "RayTrace", "value": 665.2501110000002}, {"lowerIsBetter": false, "replicates": [707.2135785007072], "unit": "score", "name": "Earley", "value": 942.3786820000003}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [43042.55319148936], "unit": "score", "name": "RegExp", "value": 21.16475284231339}, {"lowerIsBetter": false, "replicates": [936.8616527390901], "unit": "score", "name": "Splay", "value": 86.98296035678892}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19333.543820542633}]} 04:37:04 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "19333.54"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1556.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6118.16"}}} 04:37:04 INFO - Return code: 0 04:37:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:37:04 INFO - # TBPL SUCCESS # 04:37:04 INFO - Running post-action listener: _resource_record_post_action 04:37:04 INFO - Running post-run listener: _resource_record_post_run 04:37:05 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 541618176; Read time: 0; Write time: 382136 04:37:05 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 231239680; Read time: 0; Write time: 225984 04:37:05 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 0; Write bytes: 309514240; Read time: 0; Write time: 156112 04:37:05 INFO - Running post-run listener: _upload_blobber_files 04:37:05 INFO - Blob upload gear active. 04:37:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:37:05 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 04:37:05 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'] 04:37:05 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 04:37:06 INFO - (blobuploader) - INFO - Open directory for files ... 04:37:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:37:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:37:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:07 INFO - (blobuploader) - INFO - Done attempting. 04:37:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:37:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:37:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:07 INFO - (blobuploader) - INFO - Done attempting. 04:37:07 INFO - (blobuploader) - INFO - Iteration through files over. 04:37:07 INFO - Return code: 0 04:37:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:37:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:37:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4313ef532153b1ef6bbe10c65618fa76a2b85323da0d2bead594ec798eb4669d50d9c767c7995e051c8da2911de3541abcb8a33459fda08128484476c3b89e08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bc5f9227f08e3e85ff44f2a87dfa833eae0fc85cdb542a57b09cf6da61c12c84d2b3b2de33b681635744b45efa44c83a29b21101d78d6352d3e624e5934cadf"} 04:37:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:37:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:37:07 INFO - Contents: 04:37:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4313ef532153b1ef6bbe10c65618fa76a2b85323da0d2bead594ec798eb4669d50d9c767c7995e051c8da2911de3541abcb8a33459fda08128484476c3b89e08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bc5f9227f08e3e85ff44f2a87dfa833eae0fc85cdb542a57b09cf6da61c12c84d2b3b2de33b681635744b45efa44c83a29b21101d78d6352d3e624e5934cadf"} 04:37:07 INFO - Copying logs to upload dir... 04:37:07 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1276.090522 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-13 04:37:07.421522) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 04:37:07.424974) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4313ef532153b1ef6bbe10c65618fa76a2b85323da0d2bead594ec798eb4669d50d9c767c7995e051c8da2911de3541abcb8a33459fda08128484476c3b89e08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bc5f9227f08e3e85ff44f2a87dfa833eae0fc85cdb542a57b09cf6da61c12c84d2b3b2de33b681635744b45efa44c83a29b21101d78d6352d3e624e5934cadf"} build_url:https://queue.taskcluster.net/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011477 build_url: 'https://queue.taskcluster.net/v1/task/azbpTzfQTTGbyg0p4T99zg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4313ef532153b1ef6bbe10c65618fa76a2b85323da0d2bead594ec798eb4669d50d9c767c7995e051c8da2911de3541abcb8a33459fda08128484476c3b89e08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bc5f9227f08e3e85ff44f2a87dfa833eae0fc85cdb542a57b09cf6da61c12c84d2b3b2de33b681635744b45efa44c83a29b21101d78d6352d3e624e5934cadf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 04:37:07.449951) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:37:07.450325) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452683337.204389-949229123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:37:07.535638) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 04:37:07.535979) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 04:37:07.536318) ========= ========= Total master_lag: 0.27 =========