builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1452515569.76 results: success (0) buildid: 20160111031132 builduid: a72522800f2c48aca8f2f6187155a2f8 revision: cfe7a05d27e4b4f20694b30990dae62d9adc99d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:49.757166) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:49.757730) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:49.758081) ========= 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=f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006274 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:49.799778) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:49.800117) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:49.827347) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:49.827672) ========= 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=f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:49.883608) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:49.883929) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:49.884364) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:49.884759) ========= 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=f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 04:32: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.8M=0s 2016-01-11 04:32:50 (83.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148346 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:50.046562) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:50.046906) ========= 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=f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021570 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:50.099803) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:50.100359) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cfe7a05d27e4b4f20694b30990dae62d9adc99d8 --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 cfe7a05d27e4b4f20694b30990dae62d9adc99d8 --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=f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 04:32:50,711 truncating revision to first 12 chars 2016-01-11 04:32:50,711 Setting DEBUG logging. 2016-01-11 04:32:50,711 attempt 1/10 2016-01-11 04:32:50,711 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cfe7a05d27e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 04:32:50,972 unpacking tar archive at: mozilla-central-cfe7a05d27e4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.572827 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:50.688290) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:50.688656) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:50.699878) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:50.700166) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 04:32:50.700618) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-01-11 04:32:50.700938) ========= /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=f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:32:51 INFO - MultiFileLogger online at 20160111 04:32:51 in /builds/slave/test 04:32: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:32:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:32:51 INFO - {'append_to_log': False, 04:32:51 INFO - 'base_work_dir': '/builds/slave/test', 04:32:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:32:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:32:51 INFO - 'branch': 'Firefox-Non-PGO', 04:32:51 INFO - 'buildbot_json_path': 'buildprops.json', 04:32:51 INFO - 'config_files': ('talos/linux_config.py',), 04:32:51 INFO - 'default_actions': ('clobber', 04:32:51 INFO - 'read-buildbot-config', 04:32:51 INFO - 'download-and-extract', 04:32:51 INFO - 'populate-webroot', 04:32:51 INFO - 'create-virtualenv', 04:32:51 INFO - 'install', 04:32:51 INFO - 'run-tests'), 04:32:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:32:51 INFO - 'download_minidump_stackwalk': True, 04:32:51 INFO - 'download_symbols': 'ondemand', 04:32:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:32:51 INFO - 'tooltool.py': '/tools/tooltool.py', 04:32:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:32:51 INFO - '/tools/misc-python/virtualenv.py')}, 04:32:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:32:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:32:51 INFO - 'installer_path': 'installer.exe', 04:32:51 INFO - 'log_level': 'info', 04:32:51 INFO - 'log_name': 'talos', 04:32:51 INFO - 'log_to_console': True, 04:32:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:32:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:32:51 INFO - 'opt_config_files': (), 04:32:51 INFO - 'pip_index': False, 04:32:51 INFO - 'sps_profile': False, 04:32:51 INFO - 'sps_profile_interval': 0, 04:32:51 INFO - 'suite': 'dromaeojs-e10s', 04:32:51 INFO - 'system_bits': '32', 04:32:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:32:51 INFO - 'title': 'talos-linux64-ix-034', 04:32:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:32:51 INFO - 'use_talos_json': True, 04:32:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:32:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:32:51 INFO - 'work_dir': 'build'} 04:32:51 INFO - ##### 04:32:51 INFO - ##### Running clobber step. 04:32:51 INFO - ##### 04:32:51 INFO - Running pre-action listener: _resource_record_pre_action 04:32:51 INFO - Running main action method: clobber 04:32:51 INFO - rmtree: /builds/slave/test/build 04:32:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:32:51 INFO - Running post-action listener: _resource_record_post_action 04:32:51 INFO - ##### 04:32:51 INFO - ##### Running read-buildbot-config step. 04:32:51 INFO - ##### 04:32:51 INFO - Running pre-action listener: _resource_record_pre_action 04:32:51 INFO - Running main action method: read_buildbot_config 04:32:51 INFO - Using buildbot properties: 04:32:51 INFO - { 04:32:51 INFO - "project": "", 04:32:51 INFO - "product": "firefox", 04:32:51 INFO - "script_repo_revision": "production", 04:32:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:32:51 INFO - "repository": "", 04:32:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:32:51 INFO - "buildid": "20160111031132", 04:32:51 INFO - "pgo_build": "False", 04:32:51 INFO - "basedir": "/builds/slave/test", 04:32:51 INFO - "buildnumber": 168, 04:32:51 INFO - "slavename": "talos-linux64-ix-034", 04:32:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:32:51 INFO - "platform": "ubuntu64_hw", 04:32:51 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:32:51 INFO - "branch": "mozilla-central", 04:32:51 INFO - "repo_path": "mozilla-central", 04:32:51 INFO - "revision": "cfe7a05d27e4b4f20694b30990dae62d9adc99d8", 04:32:51 INFO - "stage_platform": "linux64", 04:32:51 INFO - "builduid": "a72522800f2c48aca8f2f6187155a2f8", 04:32:51 INFO - "slavebuilddir": "test" 04:32:51 INFO - } 04:32:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:32:51 INFO - Running post-action listener: _resource_record_post_action 04:32:51 INFO - ##### 04:32:51 INFO - ##### Running download-and-extract step. 04:32:51 INFO - ##### 04:32:51 INFO - Running pre-action listener: _resource_record_pre_action 04:32:51 INFO - Running main action method: download_and_extract 04:32:51 INFO - mkdir: /builds/slave/test/build/tests 04:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:51 INFO - https://queue.taskcluster.net/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:32:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/test_packages.json 04:32:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/test_packages.json 04:32:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:32:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:32:55 INFO - Downloaded 1302 bytes. 04:32:55 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:32:55 INFO - Using the following test package requirements: 04:32:55 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:32:55 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:32:55 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:55 INFO - u'jsshell-linux-x86_64.zip'], 04:32:55 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:32:55 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:32:55 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:32:55 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:32:55 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:32:55 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:32:55 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:32:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:32:55 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:32: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:32:55 INFO - https://queue.taskcluster.net/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:32:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:32:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:32:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/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:32:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/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:33:02 INFO - Downloaded 22761282 bytes. 04:33:02 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:33:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:33:02 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:33:03 INFO - Return code: 0 04:33:03 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:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:03 INFO - https://queue.taskcluster.net/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:33:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:33:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:33:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/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:33:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/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:33:07 INFO - Downloaded 22761282 bytes. 04:33:07 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:33:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:33:07 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:33:08 INFO - Return code: 0 04:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:33:08 INFO - https://queue.taskcluster.net/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:33:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:33:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:33:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/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:33:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/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:33:10 INFO - Downloaded 11132285 bytes. 04:33:10 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:33:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:33:10 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:33:10 INFO - Return code: 0 04:33: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:33:10 INFO - https://queue.taskcluster.net/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:33:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:33:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:33:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/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:33:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CtSaJbA4Rpu70De88DWA5A/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:33:16 INFO - Downloaded 54050643 bytes. 04:33:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:33:16 INFO - mkdir: /builds/slave/test/properties 04:33:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:33:16 INFO - Writing to file /builds/slave/test/properties/build_url 04:33:16 INFO - Contents: 04:33:16 INFO - build_url:https://queue.taskcluster.net/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:33:16 INFO - Running post-action listener: _resource_record_post_action 04:33:16 INFO - Running post-action listener: set_extra_try_arguments 04:33:16 INFO - ##### 04:33:16 INFO - ##### Running populate-webroot step. 04:33:16 INFO - ##### 04:33:16 INFO - Running pre-action listener: _resource_record_pre_action 04:33:16 INFO - Running main action method: populate_webroot 04:33:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:33:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:33:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:33:16 INFO - '--tppagecycles', 04:33:16 INFO - '7'], 04:33:16 INFO - 'tests': ['tsvgm']}}, 04:33:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:33:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:33:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:33:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:33:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:33:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:33:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:33:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:16 INFO - 'talos_options': ['--e10s'], 04:33:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:33:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:16 INFO - 'tests': ['damp', 'tps']}, 04:33:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:16 INFO - 'talos_options': ['--e10s'], 04:33:16 INFO - 'tests': ['damp', 'tps']}, 04:33:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:33:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:33:16 INFO - 'other': {'tests': ['a11yr', 04:33:16 INFO - 'ts_paint', 04:33:16 INFO - 'tpaint', 04:33:16 INFO - 'sessionrestore', 04:33:16 INFO - 'sessionrestore_no_auto_restore']}, 04:33:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:33:16 INFO - 'tests': ['a11yr', 04:33:16 INFO - 'ts_paint', 04:33:16 INFO - 'tpaint', 04:33:16 INFO - 'sessionrestore', 04:33:16 INFO - 'sessionrestore_no_auto_restore']}, 04:33:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:33:16 INFO - 'tests': ['a11yr', 04:33:16 INFO - 'ts_paint', 04:33:16 INFO - 'tpaint', 04:33:16 INFO - 'sessionrestore', 04:33:16 INFO - 'sessionrestore_no_auto_restore']}, 04:33:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:33:16 INFO - 'tests': ['a11yr', 04:33:16 INFO - 'ts_paint', 04:33:16 INFO - 'tpaint', 04:33:16 INFO - 'sessionrestore', 04:33:16 INFO - 'sessionrestore_no_auto_restore']}, 04:33:16 INFO - 'other_l64': {'tests': ['a11yr', 04:33:16 INFO - 'ts_paint', 04:33:16 INFO - 'tpaint', 04:33:16 INFO - 'sessionrestore', 04:33:16 INFO - 'sessionrestore_no_auto_restore']}, 04:33:16 INFO - 'other_nol64': {'tests': ['a11yr', 04:33:16 INFO - 'ts_paint', 04:33:16 INFO - 'tpaint', 04:33:16 INFO - 'sessionrestore', 04:33:16 INFO - 'sessionrestore_no_auto_restore']}, 04:33:16 INFO - 'svgr': {'tests': ['tsvgx', 04:33:16 INFO - 'tsvgr_opacity', 04:33:16 INFO - 'tart', 04:33:16 INFO - 'tscrollx', 04:33:16 INFO - 'cart']}, 04:33:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:33:16 INFO - 'tests': ['tsvgx', 04:33:16 INFO - 'tsvgr_opacity', 04:33:16 INFO - 'tart', 04:33:16 INFO - 'tscrollx', 04:33:16 INFO - 'cart']}, 04:33:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:16 INFO - 'tests': ['tp5o']}, 04:33:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:16 INFO - 'talos_options': ['--e10s'], 04:33:16 INFO - 'tests': ['tp5o']}, 04:33:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:16 INFO - 'talos_options': ['--xperf_path', 04:33:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:33:16 INFO - 'tests': ['tp5n']}, 04:33:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:33:16 INFO - 'talos_options': ['--e10s', 04:33:16 INFO - '--xperf_path', 04:33:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:33:16 INFO - 'tests': ['tp5n']}}, 04:33:16 INFO - 'talos.zip': {'path': '', 04:33:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:33:16 INFO - Running post-action listener: _resource_record_post_action 04:33:16 INFO - ##### 04:33:16 INFO - ##### Running create-virtualenv step. 04:33:16 INFO - ##### 04:33:16 INFO - Running pre-action listener: _resource_record_pre_action 04:33:16 INFO - Running main action method: create_virtualenv 04:33:16 INFO - Creating virtualenv /builds/slave/test/build/venv 04:33:16 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:33:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:33:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:33:16 INFO - Using real prefix '/usr' 04:33:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:33:16 INFO - Installing distribute.............................................................................................................................................................................................done. 04:33:18 INFO - Installing pip.................done. 04:33:18 INFO - Return code: 0 04:33:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:33: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:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33: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:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:18 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 0x7ff4a79f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1127dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba3d0>, '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 0x1125ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1126360>, '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': 'f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668', '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:33:18 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:33:18 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:33:18 INFO - Using env: {'DISPLAY': ':0', 04:33:18 INFO - 'HOME': '/home/cltbld', 04:33:18 INFO - 'LANG': 'en_US.UTF-8', 04:33:18 INFO - 'LANGUAGE': 'en_US:en', 04:33:18 INFO - 'LOGNAME': 'cltbld', 04:33:18 INFO - 'MAIL': '/var/mail/cltbld', 04:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:18 INFO - 'MOZ_NO_REMOTE': '1', 04:33:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:18 INFO - 'NO_EM_RESTART': '1', 04:33:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:18 INFO - 'PWD': '/builds/slave/test', 04:33:18 INFO - 'SHELL': '/bin/bash', 04:33:18 INFO - 'SHLVL': '1', 04:33:18 INFO - 'TERM': 'linux', 04:33:18 INFO - 'TMOUT': '86400', 04:33:18 INFO - 'USER': 'cltbld', 04:33:18 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668', 04:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:18 INFO - '_': '/tools/buildbot/bin/python'} 04:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:18 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:33:18 INFO - Cleaning up... 04:33:19 INFO - Return code: 0 04:33:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff4a79f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1127dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba3d0>, '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 0x1125ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1126360>, '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': 'f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668', '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:33:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:33:19 INFO - Using env: {'DISPLAY': ':0', 04:33:19 INFO - 'HOME': '/home/cltbld', 04:33:19 INFO - 'LANG': 'en_US.UTF-8', 04:33:19 INFO - 'LANGUAGE': 'en_US:en', 04:33:19 INFO - 'LOGNAME': 'cltbld', 04:33:19 INFO - 'MAIL': '/var/mail/cltbld', 04:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:19 INFO - 'MOZ_NO_REMOTE': '1', 04:33:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:19 INFO - 'NO_EM_RESTART': '1', 04:33:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:19 INFO - 'PWD': '/builds/slave/test', 04:33:19 INFO - 'SHELL': '/bin/bash', 04:33:19 INFO - 'SHLVL': '1', 04:33:19 INFO - 'TERM': 'linux', 04:33:19 INFO - 'TMOUT': '86400', 04:33:19 INFO - 'USER': 'cltbld', 04:33:19 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668', 04:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:19 INFO - '_': '/tools/buildbot/bin/python'} 04:33:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:19 INFO - Downloading/unpacking psutil>=0.7.1 04:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:20 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:33:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:33:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:33:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:33:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:33:21 INFO - Installing collected packages: psutil 04:33:21 INFO - Running setup.py install for psutil 04:33:21 INFO - building 'psutil._psutil_linux' extension 04:33:21 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:33:21 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:33:21 INFO - building 'psutil._psutil_posix' extension 04:33:21 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:33:21 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:33:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:33:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:33:21 INFO - Successfully installed psutil 04:33:21 INFO - Cleaning up... 04:33:22 INFO - Return code: 0 04:33:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:33: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:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33: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:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33: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', '--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 0x7ff4a79f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1127dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba3d0>, '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 0x1125ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1126360>, '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': 'f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668', '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:33:22 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:33:22 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:33:22 INFO - Using env: {'DISPLAY': ':0', 04:33:22 INFO - 'HOME': '/home/cltbld', 04:33:22 INFO - 'LANG': 'en_US.UTF-8', 04:33:22 INFO - 'LANGUAGE': 'en_US:en', 04:33:22 INFO - 'LOGNAME': 'cltbld', 04:33:22 INFO - 'MAIL': '/var/mail/cltbld', 04:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:22 INFO - 'MOZ_NO_REMOTE': '1', 04:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:22 INFO - 'NO_EM_RESTART': '1', 04:33:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:22 INFO - 'PWD': '/builds/slave/test', 04:33:22 INFO - 'SHELL': '/bin/bash', 04:33:22 INFO - 'SHLVL': '1', 04:33:22 INFO - 'TERM': 'linux', 04:33:22 INFO - 'TMOUT': '86400', 04:33:22 INFO - 'USER': 'cltbld', 04:33:22 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668', 04:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:22 INFO - '_': '/tools/buildbot/bin/python'} 04:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:33:22 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:33:22 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:33:22 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:33:22 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:33:22 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:33:22 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:33:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:33:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:33:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:33:23 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:33:23 INFO - Installing collected packages: mozsystemmonitor 04:33:23 INFO - Running setup.py install for mozsystemmonitor 04:33:24 INFO - Successfully installed mozsystemmonitor 04:33:24 INFO - Cleaning up... 04:33:24 INFO - Return code: 0 04:33:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:33:24 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:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:24 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:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:24 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 0x7ff4a79f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1127dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba3d0>, '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 0x1125ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1126360>, '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': 'f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668', '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:33:24 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:33:24 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:33:24 INFO - Using env: {'DISPLAY': ':0', 04:33:24 INFO - 'HOME': '/home/cltbld', 04:33:24 INFO - 'LANG': 'en_US.UTF-8', 04:33:24 INFO - 'LANGUAGE': 'en_US:en', 04:33:24 INFO - 'LOGNAME': 'cltbld', 04:33:24 INFO - 'MAIL': '/var/mail/cltbld', 04:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:24 INFO - 'MOZ_NO_REMOTE': '1', 04:33:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:24 INFO - 'NO_EM_RESTART': '1', 04:33:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:24 INFO - 'PWD': '/builds/slave/test', 04:33:24 INFO - 'SHELL': '/bin/bash', 04:33:24 INFO - 'SHLVL': '1', 04:33:24 INFO - 'TERM': 'linux', 04:33:24 INFO - 'TMOUT': '86400', 04:33:24 INFO - 'USER': 'cltbld', 04:33:24 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668', 04:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:24 INFO - '_': '/tools/buildbot/bin/python'} 04:33:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:24 INFO - Downloading/unpacking blobuploader==1.2.4 04:33:24 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:33:24 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:33:24 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:33:24 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:33:24 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:33:24 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:33:26 INFO - Downloading blobuploader-1.2.4.tar.gz 04:33:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:33:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:33:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:33: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:33: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:33: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:33: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:33: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:33: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:33:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:33:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:33:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:33: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:33: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:33: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:33: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:33: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:33: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:33:26 INFO - Downloading docopt-0.6.1.tar.gz 04:33:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:33:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:33:26 INFO - Installing collected packages: blobuploader, requests, docopt 04:33:26 INFO - Running setup.py install for blobuploader 04:33:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:33:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:33:26 INFO - Running setup.py install for requests 04:33:27 INFO - Running setup.py install for docopt 04:33:27 INFO - Successfully installed blobuploader requests docopt 04:33:27 INFO - Cleaning up... 04:33:27 INFO - Return code: 0 04:33:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:27 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:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:27 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:33:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:27 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 0x7ff4a79f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1127dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba3d0>, '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 0x1125ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1126360>, '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': 'f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668', '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:33:27 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:33:27 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:33:27 INFO - Using env: {'DISPLAY': ':0', 04:33:27 INFO - 'HOME': '/home/cltbld', 04:33:27 INFO - 'LANG': 'en_US.UTF-8', 04:33:27 INFO - 'LANGUAGE': 'en_US:en', 04:33:27 INFO - 'LOGNAME': 'cltbld', 04:33:27 INFO - 'MAIL': '/var/mail/cltbld', 04:33:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:27 INFO - 'MOZ_NO_REMOTE': '1', 04:33:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:27 INFO - 'NO_EM_RESTART': '1', 04:33:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:27 INFO - 'PWD': '/builds/slave/test', 04:33:27 INFO - 'SHELL': '/bin/bash', 04:33:27 INFO - 'SHLVL': '1', 04:33:27 INFO - 'TERM': 'linux', 04:33:27 INFO - 'TMOUT': '86400', 04:33:27 INFO - 'USER': 'cltbld', 04:33:27 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668', 04:33:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:27 INFO - '_': '/tools/buildbot/bin/python'} 04:33:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:33:27 INFO - Running setup.py (path:/tmp/pip-stDMNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:33:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:33:27 INFO - Running setup.py (path:/tmp/pip-t7dNMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:33:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:33:27 INFO - Running setup.py (path:/tmp/pip-0L5nxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:33:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:33:27 INFO - Running setup.py (path:/tmp/pip-ak1MKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:33:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:33:27 INFO - Running setup.py (path:/tmp/pip-Ms06uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:33:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:33:27 INFO - Running setup.py (path:/tmp/pip-PApXiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:33:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:33:27 INFO - Running setup.py (path:/tmp/pip-6OWFYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:33:28 INFO - Running setup.py (path:/tmp/pip-eG53UY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:33:28 INFO - Running setup.py (path:/tmp/pip-X0Hgn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:33:28 INFO - Running setup.py (path:/tmp/pip-QGzkkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:33:28 INFO - Running setup.py (path:/tmp/pip-p8LKPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:33:28 INFO - Running setup.py (path:/tmp/pip-dsduJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:33:28 INFO - Running setup.py (path:/tmp/pip-s0mioB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:33:28 INFO - Running setup.py (path:/tmp/pip-TWOlxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:28 INFO - Running setup.py (path:/tmp/pip-9c4iyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:33:28 INFO - Running setup.py (path:/tmp/pip-IyOlWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:33:28 INFO - Running setup.py (path:/tmp/pip-q45EiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:33:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:33:28 INFO - Running setup.py install for manifestparser 04:33:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:33:28 INFO - Running setup.py install for mozcrash 04:33:28 INFO - Running setup.py install for mozdebug 04:33:29 INFO - Running setup.py install for mozdevice 04:33:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:33:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:33:29 INFO - Running setup.py install for mozfile 04:33:29 INFO - Running setup.py install for mozhttpd 04:33:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:33:29 INFO - Running setup.py install for mozinfo 04:33:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:33:29 INFO - Running setup.py install for mozInstall 04:33:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:33:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:33:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:33:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:33:29 INFO - Running setup.py install for mozleak 04:33:29 INFO - Running setup.py install for mozlog 04:33:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:33:29 INFO - Running setup.py install for moznetwork 04:33:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:33:29 INFO - Running setup.py install for mozprocess 04:33:29 INFO - Running setup.py install for mozprofile 04:33:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:33:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:33:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:33:30 INFO - Running setup.py install for mozrunner 04:33:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:33:30 INFO - Running setup.py install for mozscreenshot 04:33:30 INFO - Running setup.py install for moztest 04:33:30 INFO - Running setup.py install for mozversion 04:33:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:33:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:33:30 INFO - Cleaning up... 04:33:30 INFO - Return code: 0 04:33:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:30 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:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:30 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:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:30 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 0x7ff4a79f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1127dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba3d0>, '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 0x1125ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1126360>, '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': 'f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668', '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:33:30 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:33:30 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:33:30 INFO - Using env: {'DISPLAY': ':0', 04:33:30 INFO - 'HOME': '/home/cltbld', 04:33:30 INFO - 'LANG': 'en_US.UTF-8', 04:33:30 INFO - 'LANGUAGE': 'en_US:en', 04:33:30 INFO - 'LOGNAME': 'cltbld', 04:33:30 INFO - 'MAIL': '/var/mail/cltbld', 04:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:30 INFO - 'MOZ_NO_REMOTE': '1', 04:33:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:30 INFO - 'NO_EM_RESTART': '1', 04:33:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:30 INFO - 'PWD': '/builds/slave/test', 04:33:30 INFO - 'SHELL': '/bin/bash', 04:33:30 INFO - 'SHLVL': '1', 04:33:30 INFO - 'TERM': 'linux', 04:33:30 INFO - 'TMOUT': '86400', 04:33:30 INFO - 'USER': 'cltbld', 04:33:30 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668', 04:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:30 INFO - '_': '/tools/buildbot/bin/python'} 04:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:33:30 INFO - Running setup.py (path:/tmp/pip-t4iXrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:33:30 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:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:33:30 INFO - Running setup.py (path:/tmp/pip-Jy5czH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:33:30 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:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:33:30 INFO - Running setup.py (path:/tmp/pip-Vo6QVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:33:30 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:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:33:30 INFO - Running setup.py (path:/tmp/pip-PYDTHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:33:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:33:31 INFO - Running setup.py (path:/tmp/pip-dzszos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:33:31 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:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:33:31 INFO - Running setup.py (path:/tmp/pip-AnvH96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:33:31 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:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:33:31 INFO - Running setup.py (path:/tmp/pip-1VhxOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:33:31 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:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:33:31 INFO - Running setup.py (path:/tmp/pip-02zmzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:33:31 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:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:33:31 INFO - Running setup.py (path:/tmp/pip-nCQHb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:33:31 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:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:33:31 INFO - Running setup.py (path:/tmp/pip-ceBasW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:33:31 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:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:33:31 INFO - Running setup.py (path:/tmp/pip-uTTMUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:33:31 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:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:33:31 INFO - Running setup.py (path:/tmp/pip-MnVO76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:33:31 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:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:33:31 INFO - Running setup.py (path:/tmp/pip-Q9TtsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:33:31 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:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:33:31 INFO - Running setup.py (path:/tmp/pip-lSWz31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:33:31 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:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:31 INFO - Running setup.py (path:/tmp/pip-sEx71y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:31 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:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:33:31 INFO - Running setup.py (path:/tmp/pip-KPHQSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:33:31 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:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:33:31 INFO - Running setup.py (path:/tmp/pip-Fq3QV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:33:31 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:33:31 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:33:31 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:33:31 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:33:31 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:33:31 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:33:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:33:31 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:33:31 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:33:31 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:33:31 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:33:31 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:33:31 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:33:33 INFO - Downloading blessings-1.5.1.tar.gz 04:33:33 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:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:33:33 INFO - Installing collected packages: blessings 04:33:33 INFO - Running setup.py install for blessings 04:33:33 INFO - Successfully installed blessings 04:33:33 INFO - Cleaning up... 04:33:33 INFO - Return code: 0 04:33:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:33:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:33:34 INFO - Reading from file tmpfile_stdout 04:33:34 INFO - Current package versions: 04:33:34 INFO - argparse == 1.2.1 04:33:34 INFO - blessings == 1.5.1 04:33:34 INFO - blobuploader == 1.2.4 04:33:34 INFO - docopt == 0.6.1 04:33:34 INFO - manifestparser == 1.1 04:33:34 INFO - mozInstall == 1.12 04:33:34 INFO - mozcrash == 0.16 04:33:34 INFO - mozdebug == 0.1 04:33:34 INFO - mozdevice == 0.47 04:33:34 INFO - mozfile == 1.2 04:33:34 INFO - mozhttpd == 0.7 04:33:34 INFO - mozinfo == 0.9 04:33:34 INFO - mozleak == 0.1 04:33:34 INFO - mozlog == 3.1 04:33:34 INFO - moznetwork == 0.27 04:33:34 INFO - mozprocess == 0.22 04:33:34 INFO - mozprofile == 0.28 04:33:34 INFO - mozrunner == 6.11 04:33:34 INFO - mozscreenshot == 0.1 04:33:34 INFO - mozsystemmonitor == 0.0 04:33:34 INFO - moztest == 0.7 04:33:34 INFO - mozversion == 1.4 04:33:34 INFO - psutil == 3.1.1 04:33:34 INFO - requests == 1.2.3 04:33:34 INFO - wsgiref == 0.1.2 04:33:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:34 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 0x7ff4a79f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1127dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba3d0>, '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 0x1125ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1126360>, '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': 'f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668', '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:33:34 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:33:34 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:33:34 INFO - Using env: {'DISPLAY': ':0', 04:33:34 INFO - 'HOME': '/home/cltbld', 04:33:34 INFO - 'LANG': 'en_US.UTF-8', 04:33:34 INFO - 'LANGUAGE': 'en_US:en', 04:33:34 INFO - 'LOGNAME': 'cltbld', 04:33:34 INFO - 'MAIL': '/var/mail/cltbld', 04:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:34 INFO - 'MOZ_NO_REMOTE': '1', 04:33:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:34 INFO - 'NO_EM_RESTART': '1', 04:33:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:34 INFO - 'PWD': '/builds/slave/test', 04:33:34 INFO - 'SHELL': '/bin/bash', 04:33:34 INFO - 'SHLVL': '1', 04:33:34 INFO - 'TERM': 'linux', 04:33:34 INFO - 'TMOUT': '86400', 04:33:34 INFO - 'USER': 'cltbld', 04:33:34 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668', 04:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:34 INFO - '_': '/tools/buildbot/bin/python'} 04:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:34 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:33:34 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:33:34 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:33:34 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:33:34 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:33:34 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:33:34 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:33:34 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:33:34 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:33:34 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:33:34 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:33:34 INFO - Cleaning up... 04:33:34 INFO - Return code: 0 04:33:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:34 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 0x7ff4a79f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1127dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba3d0>, '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 0x1125ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1126360>, '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': 'f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668', '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:33:34 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:33:34 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:33:34 INFO - Using env: {'DISPLAY': ':0', 04:33:34 INFO - 'HOME': '/home/cltbld', 04:33:34 INFO - 'LANG': 'en_US.UTF-8', 04:33:34 INFO - 'LANGUAGE': 'en_US:en', 04:33:34 INFO - 'LOGNAME': 'cltbld', 04:33:34 INFO - 'MAIL': '/var/mail/cltbld', 04:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:34 INFO - 'MOZ_NO_REMOTE': '1', 04:33:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:34 INFO - 'NO_EM_RESTART': '1', 04:33:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:34 INFO - 'PWD': '/builds/slave/test', 04:33:34 INFO - 'SHELL': '/bin/bash', 04:33:34 INFO - 'SHLVL': '1', 04:33:34 INFO - 'TERM': 'linux', 04:33:34 INFO - 'TMOUT': '86400', 04:33:34 INFO - 'USER': 'cltbld', 04:33:34 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668', 04:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:34 INFO - '_': '/tools/buildbot/bin/python'} 04:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:34 INFO - Downloading/unpacking jsonschema 04:33:34 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:33:34 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:33:34 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:33:34 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:33:34 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:33:34 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:33:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:33:36 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:33:36 INFO - Downloading/unpacking functools32 (from jsonschema) 04:33:36 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:33:36 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:33:36 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:33:36 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:33:36 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:33:36 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:33:36 INFO - Downloading functools32-3.2.3-2.tar.gz 04:33:36 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:33:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:33:36 INFO - warning: no files found matching '*.txt' 04:33:36 INFO - no previously-included directories found matching 'build' 04:33:36 INFO - no previously-included directories found matching 'dist' 04:33:36 INFO - no previously-included directories found matching '.git*' 04:33:36 INFO - Installing collected packages: jsonschema, functools32 04:33:36 INFO - Running setup.py install for functools32 04:33:36 INFO - warning: no files found matching '*.txt' 04:33:36 INFO - no previously-included directories found matching 'build' 04:33:36 INFO - no previously-included directories found matching 'dist' 04:33:36 INFO - no previously-included directories found matching '.git*' 04:33:36 INFO - Successfully installed jsonschema functools32 04:33:36 INFO - Cleaning up... 04:33:36 INFO - Return code: 0 04:33:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:33:36 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:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:36 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:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:36 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 0x7ff4a79f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1127dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba3d0>, '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 0x1125ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1126360>, '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': 'f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668', '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:33:36 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:33:36 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:33:36 INFO - Using env: {'DISPLAY': ':0', 04:33:36 INFO - 'HOME': '/home/cltbld', 04:33:36 INFO - 'LANG': 'en_US.UTF-8', 04:33:36 INFO - 'LANGUAGE': 'en_US:en', 04:33:36 INFO - 'LOGNAME': 'cltbld', 04:33:36 INFO - 'MAIL': '/var/mail/cltbld', 04:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:36 INFO - 'MOZ_NO_REMOTE': '1', 04:33:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:36 INFO - 'NO_EM_RESTART': '1', 04:33:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:36 INFO - 'PWD': '/builds/slave/test', 04:33:36 INFO - 'SHELL': '/bin/bash', 04:33:36 INFO - 'SHLVL': '1', 04:33:36 INFO - 'TERM': 'linux', 04:33:36 INFO - 'TMOUT': '86400', 04:33:36 INFO - 'USER': 'cltbld', 04:33:36 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668', 04:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:36 INFO - '_': '/tools/buildbot/bin/python'} 04:33:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:36 INFO - Downloading/unpacking flake8 04:33:36 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:33:36 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:33:36 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:33:36 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:33:36 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:33:36 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:33:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:33:38 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:33:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:33:38 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:33:38 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:33:38 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:33:38 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:33:38 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:33:38 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:33:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:33:38 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:33:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:33:38 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:33:38 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:33:38 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:33:38 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:33:38 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:33:38 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:33:39 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:33:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:33:39 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:33:39 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:33:39 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:33:39 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:33:39 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:33:39 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:33:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:33:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:33:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:33:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:33:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:33:39 INFO - no previously-included directories found matching 'docs/_build' 04:33:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:33:39 INFO - Running setup.py install for pep8 04:33:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:33:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:33:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:33:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:33:39 INFO - no previously-included directories found matching 'docs/_build' 04:33:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:33:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:33:39 INFO - Cleaning up... 04:33:39 INFO - Return code: 0 04:33:39 INFO - Running post-action listener: _resource_record_post_action 04:33:39 INFO - Running post-action listener: _start_resource_monitoring 04:33:39 INFO - Starting resource monitoring. 04:33:39 INFO - ##### 04:33:39 INFO - ##### Running install step. 04:33:39 INFO - ##### 04:33:39 INFO - Running pre-action listener: _resource_record_pre_action 04:33:39 INFO - Running main action method: install 04:33:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:33:39 INFO - Reading from file tmpfile_stdout 04:33:39 INFO - Detecting whether we're running mozinstall >=1.0... 04:33:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:33:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:33:39 INFO - Reading from file tmpfile_stdout 04:33:39 INFO - Output received: 04:33:39 INFO - Usage: mozinstall [options] installer 04:33:39 INFO - Options: 04:33:39 INFO - -h, --help show this help message and exit 04:33:39 INFO - -d DEST, --destination=DEST 04:33:39 INFO - Directory to install application into. [default: 04:33:39 INFO - "/builds/slave/test"] 04:33:39 INFO - --app=APP Application being installed. [default: firefox] 04:33:39 INFO - mkdir: /builds/slave/test/build/application 04:33:39 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:33:39 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:33:55 INFO - Reading from file tmpfile_stdout 04:33:55 INFO - Output received: 04:33:55 INFO - /builds/slave/test/build/application/firefox/firefox 04:33:55 INFO - Running post-action listener: _resource_record_post_action 04:33:55 INFO - ##### 04:33:55 INFO - ##### Running run-tests step. 04:33:55 INFO - ##### 04:33:55 INFO - Running pre-action listener: _resource_record_pre_action 04:33:55 INFO - Running main action method: run_tests 04:33:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:33:55 INFO - Python 2.7.3 04:33:55 INFO - Return code: 0 04:33:55 INFO - grabbing minidump binary from tooltool 04:33: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:33:55 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 0x11ba3d0>, '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 0x1125ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1126360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:33:55 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:33:55 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:33:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:33:55 INFO - Return code: 0 04:33:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:33:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:33:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:33:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:33:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:33:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:33:56 INFO - Return code: 0 04:33:56 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/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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:33:56 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/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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:33:56 INFO - Using env: {'DISPLAY': ':0', 04:33:56 INFO - 'HOME': '/home/cltbld', 04:33:56 INFO - 'LANG': 'en_US.UTF-8', 04:33:56 INFO - 'LANGUAGE': 'en_US:en', 04:33:56 INFO - 'LOGNAME': 'cltbld', 04:33:56 INFO - 'MAIL': '/var/mail/cltbld', 04:33:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:33:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:33:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:56 INFO - 'MOZ_NO_REMOTE': '1', 04:33:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:33:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:33:56 INFO - 'NO_EM_RESTART': '1', 04:33:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:33:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:56 INFO - 'PWD': '/builds/slave/test', 04:33:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:33:56 INFO - 'SHELL': '/bin/bash', 04:33:56 INFO - 'SHLVL': '1', 04:33:56 INFO - 'TERM': 'linux', 04:33:56 INFO - 'TMOUT': '86400', 04:33:56 INFO - 'USER': 'cltbld', 04:33:56 INFO - 'XDG_SESSION_COOKIE': 'f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668', 04:33:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:56 INFO - '_': '/tools/buildbot/bin/python'} 04:33:56 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/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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:33:56 INFO - mozversion application_buildid: 20160111031132 04:33:56 INFO - mozversion application_changeset: cfe7a05d27e4b4f20694b30990dae62d9adc99d8 04:33:56 INFO - mozversion application_display_name: Nightly 04:33:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:33:56 INFO - mozversion application_name: Firefox 04:33:56 INFO - mozversion application_remotingname: firefox 04:33:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:33:56 INFO - mozversion application_vendor: Mozilla 04:33:56 INFO - mozversion application_version: 46.0a1 04:33:56 INFO - mozversion platform_buildid: 20160111031132 04:33:56 INFO - mozversion platform_changeset: cfe7a05d27e4b4f20694b30990dae62d9adc99d8 04:33:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:33:56 INFO - mozversion platform_version: 46.0a1 04:33:56 INFO - using testdate: 1452515636 04:33:56 INFO - actual date: 1452515636 04:33:56 INFO - starting webserver on 'localhost:53157' 04:33:56 INFO - SUITE-START | Running 3 tests 04:33:56 INFO - TEST-START | dromaeo_css 04:33:56 INFO - operating with platform_type : linux_ 04:33:56 INFO - Initialising browser for dromaeo_css test... 04:33:56 INFO - TEST-INFO | started process 3779 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP9fjSQ/profile http://localhost:53157/getInfo.html) 04:34:00 INFO - PROCESS | 3779 | 04:34:00 INFO - PROCESS | 3779 | (process:3860): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:34:00 INFO - PROCESS | 3779 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 04:34:01 INFO - PROCESS | 3779 | __metrics Screen width/height:1600/1200 04:34:01 INFO - PROCESS | 3779 | colorDepth:24 04:34:01 INFO - PROCESS | 3779 | Browser inner width/height: 1024/697 04:34:01 INFO - PROCESS | 3779 | __metrics 04:34:01 INFO - PROCESS | 3779 | 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:34:04 INFO - TEST-INFO | 3779: exit 0 04:34:04 INFO - Browser initialized. 04:34:04 INFO - Running cycle 1/1 for dromaeo_css test... 04:34:04 INFO - TEST-INFO | started process 3909 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP9fjSQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:34:05 INFO - PROCESS | 3909 | 04:34:05 INFO - PROCESS | 3909 | (process:3968): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:34:16 INFO - PROCESS | 3909 | RSS: Main: 150564864 04:34:16 INFO - PROCESS | 3909 | 04:35:06 INFO - PROCESS | 3909 | 1452515706025 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:37:17 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:53157/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53157/tests/dromaeo/cssquery-ext.html) 04:37:18 INFO - PROCESS | 3909 | RSS: Main: 154099712 04:37:18 INFO - PROCESS | 3909 | 04:40:20 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:53157/tests/dromaeo/cssquery-ext.html (next: http://localhost:53157/tests/dromaeo/cssquery-jquery.html) 04:40:21 INFO - PROCESS | 3909 | RSS: Main: 152887296 04:40:21 INFO - PROCESS | 3909 | 04:43:23 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:53157/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53157/tests/dromaeo/cssquery-mootools.html) 04:43:23 INFO - PROCESS | 3909 | RSS: Main: 153325568 04:43:23 INFO - PROCESS | 3909 | 04:46:25 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:53157/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53157/tests/dromaeo/cssquery-prototype.html) 04:46:26 INFO - PROCESS | 3909 | RSS: Main: 151846912 04:46:26 INFO - PROCESS | 3909 | 04:49:28 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:53157/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53157/tests/dromaeo/cssquery-yui.html) 04:49:29 INFO - PROCESS | 3909 | RSS: Main: 153612288 04:49:29 INFO - PROCESS | 3909 | 04:52:31 INFO - PROCESS | 3909 | Cycle 1(1): loaded http://localhost:53157/tests/dromaeo/cssquery-yui.html (next: http://localhost:53157/tests/dromaeo/cssquery-dojo.html) 04:52:31 INFO - PROCESS | 3909 | RSS: Main: 155684864 04:52:31 INFO - PROCESS | 3909 | 04:52:31 INFO - PROCESS | 3909 | __start_tp_report 04:52:31 INFO - PROCESS | 3909 | _x_x_mozilla_page_load 04:52:31 INFO - PROCESS | 3909 | _x_x_mozilla_page_load_details 04:52:31 INFO - PROCESS | 3909 | |i|pagename|runs| 04:52:31 INFO - PROCESS | 3909 | |0;dojo.html;2618.5024845279395;2684.9328766780814;2716.796240281978;2720.741529554692;2721.401291715822;4416.403785488958;4642.976785116078;4712.505186955367;4730.3141044548565;4733.692309999857;4517.819287228515;4532.52408497108;4558.635309175266;4647.860564183072;4679.74261415622;4235.512916014659;4346.130773845228;4400.031992961559;4404.031113155101;4442.711223770445;4301.720388174775;4319.69762116652;4320.179165958473;4335.826566937319;4417.779111044435;4089.89775255618;4196.643285320752;4332.155229730204;4371.956280437218;4387.122575484916;4250.149970006011;4306.784660766949;4323.524412314643;4329.9567004329865;4346.261135606923;4168.958310416918;4254.553271906436;4263.147370525907;4267.573242675708;4295.634871035965;4278.507971583276;4438.334249862546;4469.932951005705;4491.708038977488;4536.591706746409;4944.480829512921;4951;4965;4970.751462426864;5005.924911126336;4987.476314986947;4993.950060499385;4999.875003124915;5008.499150084999;5048.5203905628905;4446.644268458548;4560.429946256718;4583.495815460296;4674.883127921829;4711.01068775561;5083.339165908408;5089.51649593288;5104.438511763703;5110;5117.923231151536;4874.610031197496;4899.681520701143;4901.142300097468;4902;4938.6789858659795;4713.599344055725;4817.927731084036;4880.316755654211;4919.680220785637;4997.250412438163;4864.367632207861;4873.561379475864;4879.935344079531;4888.2178851384315;4934.284528743384;4705.435347758223;4876.097921884463;4878.853634390974;4892.070506603805;4919.4834542373255;4124.91750164995;4128.8348466061025;4184.916301673949;4191.455110835572;4227.556106608823;3686.225892562592;3701.9819549624067;3709.3694072007825;3709.795961222159;3740.4576336431064;4173.499180098347;4274.4870615525715;4324.091940692427;4326.913461730748;4351.782410879507;4888;4963.5780958618925;4972.676776009548;4980.078685443133;5015.799368025311;4279.037216626297;4328.264195086843;4331.480222373335;4333.544977777288;4375.890602734957;4279.700420970502;4359.9782001090425;4397.2085024695225;4447.2217361962175;4458.910821783546;4690.577847993697;4693.27254275581;4702.764861756898;4703.459102203222;4709.7174169549935;4923.6307276955085;4928.457869634409;4934.950650493449;4943.925841112458;4977.377827771528;4540.296254080623;4616.307553866947;4645.907081858411;4696.272077827942;4729.337892694956;4893.975530122327;4894.314795928502;4905.632077594266;4916.655834091723;4931.914978704679;4957.504249575014;4991.9500804991485;5004.674696144739;5005.674631148963;5045.571126454292;4586.449626044762;4677.602403795716;4714.434267887876;4786.473487916396;4802.183628783185;4746.145693775154;4766.404199475066;4791.784369703302;4795.592374648194;4829.154897892784;4559.088182363607;4649.256119020941;4685.5080216578135;4689.179393606037;4737.07627012743;4753.263244197155;4766.094442055998;4848.854534363974;4850.80596776125;4876.902461950812;4672.836450724209;4677.9942312403;4720.811167553396;4723.055388922298;4768.546988036131 04:52:31 INFO - PROCESS | 3909 | |1;ext.html;472.34108418755835;493.03611439635506;504.8258350868951;507.31005832068394;511.19231614049806;33533.66466335336;33685;34181.1454713632;34239.14402139944;34279;34096.82951585238;34609.82695086521;34657.48013779789;34684.653153468455;34868.651313486924;7398.6670599823;7566.281203285679;7618.123915749677;7618.5428874267445;7628.618569071552;7499.362554182901;7658.463907526475;7679.961600191991;7708.884366734504;7715.112762032354;7707.499012564193;7774.49465784725;7777.144514103444;7777.883331750028;7795.5712435816;7602.50583712057;7619.42854285928;7648.617569121521;7664.233576642347;7696.807579810522;7512.248775122444;7624.00887884577;7626.6186690665245;7633.9618301908695;7670;33459.330813383836;33958.49062264068;33971.32057358839;34068.148296292544;34176.14559636004;2958.216072740704;3252.0243926822095;3256.739460843127;3657.561092668897;3662.3957047087465;27825.443491130063;27859.16422507328;27998.440031199465;28224.71775282262;28238;3491.458823882302;3500.6674365935196;3525.3830579648716;3571.160777217352;3609.9278014439565;209497;210955;211472;211748;212468.99999999846;48076.79808004758;49065.754671226416;55096;56239.43760562342;57668;50076;50084.248736268986;50131.74934125379;50224.49775502271;50324.245136322985;13027.674308142183;13053.477860885458;13098.672533186747;13202.33988300581;13216.603501894959;9464.621415143454;9485.478298693639;9488.098630630078;9515.286353523514;9539.952300238454;19205.75453319352;19517.088557055085;19528.70706939397;19604.607907841764;19687.310944116885;7357.816054598571;7492.438067144986;7520.699172033057;7551;7649.694012239559;832.8334333133398;851.8935133108362;860.9397342185987;862.3704695572142;868.2229404682773;23664.7633523666;23902.402439939142;23982.88008559946;24067.51864962691;24250.393740156636;925.379995403068;936.864154697565;939.9013103624158;958.4297343080856;978.3542861711379;13804.792928106086;13918.58244252674;14023.929880350737;14039.438422463192;14401.711965760625;366036;372622;372862;373077;375017;45736;45913.770431148296;46296.30555541669;46494;46612;1255.2029461292145;1260.7982722764314;1270.1490001698885;1284.7303612306703;1292.3086148910288;25391.238262852145;26284.60573091367;26294.73705262923;27357;27896.44207115887;40291.597084028785;40829.183416332104;40914.18171636491;40914.79542602387;41026.1794764109;240364;240946;242185;243409;243435;29751.25621859471;40392.39411408772;41076.589234107276;41123.58876411317;41205.793971029954;35194.64805351914;36326.818365908;36340.454893176095;36591.08522286964;36846.44730329101;30611.387772243987;31059.37881242408;31335.529967050967;31565.684343156274;31948.68051319457;32890;33317.50023749597;33744.15639609029;33842.09289653036;33956.15109622279;33198.33603327968;33609.15977100494;33672;33736;33939.15152121217;28772.856135720023;30452.84773576118;30507;30669.23326916845;30812.69187308188;23585.29244122679;23640.763592363855;25285.74714252834;25616.871915640302;26062.86968565145 04:52:31 INFO - PROCESS | 3909 | |2;jquery.html;333.76969890775365;334.580101972025;337.9594448666159;340.2463543251697;340.59979524059224;11897;12247.326397048158;14632.926835365835;14678.04592701475;15083.170425626586;14106.506272280472;14731.48439804607;14903.7019259615;15624.218789060558;15687.529374118767;4931.5315045070665;4936.92594611082;5131.97360527894;5144.691318520882;5146.073706732786;4863.465018847924;5019.673721208128;5151.201563757623;5154.149565321717;5154.639175257734;5074.06129865976;5090.567301779334;5122;5566;5566.944330556683;5259.631825772198;5729.054705973509;5749.453801888814;5765.394633563478;5766.048601980689;5156.896862062776;5174.197999310113;5176.7929282828645;5184.559312458446;5267.578593712532;10942.398168100752;11436.19946603738;11438.485268162953;11439.828402573969;17784.46646600604;1777.8222177782247;1819.881707688996;1844.4598760035387;1892.0917959379437;1961.3919684897585;8934.927808662937;8983.10168983103;9185.540722963891;9192.540372981324;11918;1719.415398764426;1740.2516917725372;1779.6529676713046;1848.9815101848944;1853.2309091726918;49456.75271623655;49887.2516912243;50369.496305036846;50542.494575054145;51623.74188129073;9524.380915240627;9549.474778887228;9694.127528522467;9729.367591106555;9778.511074446391;12239.265644061385;12301;12335.568255111028;12455.501779928702;12499.75000500003;6509.479241660656;6680.498962577826;6822.317768223138;6880.449564034865;6934.930650693529;6427.389398007182;6447.484201263981;6451.806445806634;6494.675266236669;6564.8358791030605;3986.142979259473;4124.340105583153;4201.306784380543;4201.789910504463;4205.789710514462;1676.0530300380246;1743.8517725993433;1828.1681834765416;1839.9632007359778;1840.7699037620298;790.2018960849583;838.9622466989;861.3841103610948;877.2278408074852;931.7158266728712;14880.032797868103;14968.176750278839;15099.849001510063;15125.848741512444;15254;855.2473823035689;862.0991064337782;881.9857164261151;910.7677542226822;912.1608120529129;8612.8708069379;8631.180037896389;8706.95646521776;8720.520371379635;8767.649294028295;413036;418238;426480;427392;430345;43695.344569831475;61134.694326528974;61226;61798.38201617926;63099.36900631027;971.3540495570367;978.3005151316843;982.4841957971979;993.8310487217046;994.6618149829093;13278.53525126616;13313.933430332787;13539.390727417092;13616.523421680193;13850.168989860238;30817.22956926005;30851.69148308488;31359.529607056367;31502.84248578834;32321.838390807894;37606.43590346092;39441.40837887376;39479.01302467461;40962.18075638411;41133.794331028155;6358.77744278948;6488.740450381932;6516.218053833571;6714.261431242462;6852.109225800614;8497.787555310919;8706.869396958924;9479.146876781122;9654.082862128087;10097.242706797166;8172.18278172178;8272.131426200162;8470.207409183442;8697.304215662605;8781.473111613324;8573.356998225034;8778.078301778221;8977;9155.26757859383;9312.627494900127;8486.61810218554;8506.829863402574;8682.652693892174;8684.522351270742;8917.821643567222;6982.965085174542;7064.442472405276;7079.504434689522;7132.928670713434;7181.497295189287;7756.461643405858;8561.315094792526;8683.392162548562;8767.868481972902;8933.955330223307 04:52:31 INFO - PROCESS | 3909 | |3;mootools.html;1401.7546929287373;1418.9361478733458;1557.135789636752;1753.9123043847806;1767.7967033791117;6292.528060395466;6429.4534964528075;7344.302291282326;7532.171461139277;7535.321821036106;7167.354938055574;7305.6712447939835;7337.926620733804;7350.779476615697;7358.190599034102;2119.088791819517;2122.2784253353857;2133.7332833395826;2156.0728886578763;2157.1048015073725;2066.5143691232547;2097.2240271099713;2140.8715477071346;2145.4850835799375;2157.5361297321074;2085.8435617328687;2109.715188449563;2113.4505028692574;2127.127877570189;2128.968065479019;2124.044180118945;2133.0934352900035;2133.434639820449;2135.0392323454353;2141.1756473757637;2077.2314243729766;2151.376100930728;2153.7092492513466;2164.0910817456706;2167;7704.46068775186;7742.303192712627;7753.4960227585025;7759.573223472707;7761.7671469855995;4116.629503344713;4239.512456067561;4268.658507319407;4270.0605866709275;4301.419308393358;2876.1659118855505;2903.578981047757;2910.6507219133628;2914.606528118698;2916.7229113234207;933.0948979489951;974.8294048541477;976.5068640336656;990.2919412620012;994.8259054665477;10364.689059328231;10426.68719938403;10440.477976101165;10448;10453.477326133663;3877.263319969253;3886.4753258310334;3941.3299739044432;3947.1513624570857;3952.8023598819946;8802.943646762302;8848.513331766815;8859.24696400813;8882.822343553093;8903.910960890309;4292.5063617683745;4330.891727706832;4355.303151495746;4358.3244597087505;4372.23485889968;3240.513922911582;3313.93372132556;3917.490726205632;3956.3669812829808;3989.940150897739;3383.204946837491;3388.373150967079;3406.0633325835097;3422.863085476553;3435.4675025371107;1041.1514615588271;1088.7387027113436;1090.9781804364027;1092.6558134187705;1093.3439936038471;961.9326647134774;965.758560359896;976.5654283843763;1008.3899240959261;1147.3402793393832;6931;6981.05755722981;6995.440364770806;7007.544509606859;7162.033125528092;473.70630209270473;475.9452662943806;478.40438653876146;478.77258302306126;478.88506758377736;5491.560675145979;5505.476979686923;5534.418886016991;5545.195946587723;5573.804916827891;8995.595198216097;9265.72202833916;9281.071892810665;9305.11601397866;9411.764705882408;9050.502222377832;9062;9078.54607269647;9144.314176436794;9146.588403521857;6812.909934410471;7021.964890175618;7045.084139061992;7046.894296585555;7071.752488662872;7022.754203602849;7079.433645308466;7089.539179953286;7114.217436081924;7120.896261079541;8023.558704271088;8085.312748416451;8111.472754270953;8164.877526837221;8228.794280142805;8384.832303353776;8457.154284571494;8483.787905302417;8520;8545;6411.551191416556;6518.902216466851;6593.505487088391;6749.493787965824;6872.896906546506;6944.444444444332;6959.234484206632;6959.617221052688;6980.616066116209;7013;6550.7707230246715;6630.602163870183;6693.866122677617;6767.018782276444;6797.354251346114;6257.749690012349;6288.874222515616;6654.600723956578;6743.460523158234;6762.8647427052165;6608.7356505739235;6625.536212465081;6657.800265992028;6663.26704062543;6668.0331351954665;6216.813495595139;6326.177596912372;6335.461485773761;6337.04944258365;6356.4279214870885;6393.7122829471855;6393.904091438539;6443.065755465525;6443.323451037761;6455.838604034937 04:52:31 INFO - PROCESS | 3909 | |4;prototype.html;306.0695485723401;309.1113049981304;309.2516111011354;317.54432389521037;319.68191649308943;5520.365158006831;5632.549396048316;5674.801381951637;5678.829635110948;5693.914591281134;5521.4478552144865;5542.1132618781;5550.7224638768;5553.805616803413;5561.332640083186;4162.125953549758;4250.61744443;4277.850275240367;4283.507396649394;4296.699231053827;4186.518550366701;4241.575842415749;4253.702240843142;4258.574142585748;4267.48790145183;4211.452511173543;4212.53662097169;4220.26145424551;4221.32458806591;4223.1975924574235;4211.38934854446;4252.362145678142;4254.978725106385;4264.168487145008;4267.679924005681;3718.1634132320282;3719.4048952167796;3725.217704282104;3735.010222291095;3736.047307936486;5147.22791581262;5314.7608357624;5316.069687804618;5330.173823057432;5330.227117068003;4846.418429788413;4860.05228980349;4867.70793752376;4867.82962596311;4874.8050077997195;5863.208466856962;5865.912011319833;5874.853128671817;5874.882502349929;5878.823635290948;3994.1811928554575;3998.3602623580086;3998.3802510610903;3999.3001224785835;4009.1380353224195;5904.47124063714;6146.323904370515;6147.2008638877105;6153.1077993691115;6153.507719382484;4139.627433530996;4151.4395556600075;4158.8336466541605;4164.541900390955;4172.582741725803;4212.473440819897;4215.57844215576;4224.5353011168745;4232.894177645522;4244.554321796167;4842.7336496493035;4863.2461968394955;4866.82966096192;4872.317875497433;4873.122837889214;5722.7982123753645;5799.652020878676;5830.242068531149;5833.445822646841;5840.503557197686;1470.4265336518765;1474.4544518528214;1475.7196132734746;1479.3934486860335;1482.2959094430275;1000.2248257600418;1002.3935519010894;1002.9949850250848;1019.0879163148941;1024.774549599087;4977.626677999165;5051.26756620288;5062.6709263898465;5076.923846142311;5088.185890257541;5794.82615521535;5875.941240587625;5939.881202376015;6029.849253768691;6068.362821903636;5070.898582028339;5100.591952643779;5109.233614957786;5113.769880355393;5126.87182820425;3240.990585836796;3278.3115545735664;3309.7352211822995;3330.150811543041;3330.5012744264695;5623.578231632562;5785.190073389729;5785.4214578541805;5786.652800831964;5793.304803423532;6220.440160385587;6246.187995560548;6264.248290205113;6269.216347956505;6283.59156654816;5711.742971566289;5778.971105144531;5780.826575202751;5787.652740835563;5789.044807606698;6090.512758979183;6093.969530152321;6120.785772497941;6131.294901086432;6140;5765.308163020464;5887.20522729426;5980.491658209101;5997.160397544434;6008.459238668366;5770.365259821332;5798.15926690619;5799.565032622486;5803.883922321445;5813.273340832396;4149.792510374409;4151.564085771071;4184.8744537663915;4186.68599855006;4191.161767646422;5910.645361278337;6081.209442772588;6094.238220222473;6108.8778224436155;6116.204893363834;5834.474897259267;5845.678487683218;5864;5888.587798854211;5897.823065308047;5815.505682016907;5852.151438041546;5874.765009399576;5876.853078673067;5884.529237660891;5616.66300022;5690.886182276414;5732.656040637575;5746.626469279484;5780.710964451677;5908.409159084057;5911.527077833849;5912.438318359749;5917.142014407973;5929.229200203946;5619.690916999604;5769.451902069297;5770.451807078321;5781.595288329777;5786.508146807569 04:52:31 INFO - PROCESS | 3909 | |5;yui.html;748.4311922938565;788.4756636836504;791.357932290497;793.7817100297418;809.1140201479379;11119.499622516985;11158.442077896094;11167.162462815291;11229;11249.10007199422;10100.292979491438;10367.42979136149;10551.577936882515;10615.893841061586;11512.079033677306;759.4380158682591;774.1871035412794;774.3572834547313;774.7288449042846;779.4388040610779;764.0487592946789;767.474280118118;769.2884082223949;771.6488997506121;771.7260372567741;812.4028838803474;812.9552874591895;814.5519964019795;817.1093508076195;820.9384296177781;812.0823469479479;812.354178428151;815.808285053012;816.0370762500247;816.7141500474816;606.8452544601098;607.3622696169004;607.5413063137347;607.6870411737958;608.2154021312501;10235.948820255851;10358.326708763982;10399.272050956437;10443.164546836235;10464.476776161238;9627.181689556395;9734.075262850018;9857.950710246403;9884.202846038872;10065.295429319951;8522.40343175978;8791.60437780295;10438.373697578094;10616.04455598992;10717.142628589694;3930.1746633207063;3952.3676211805973;3974.4435778990965;3993.201359728037;4002.639762421367;33705.662943370495;35014.649853501396;35735.64264357375;38292.80853595714;38298.042548936224;9161.541922903829;9227.584758685874;9329.300302477206;9329.486878221764;9487.003864594257;14802.259887005823;14903.478378256708;14991.775123373158;15093.54719358421;15109.697806043818;6347.682615869188;6424.646644434601;6462.773802916875;6481.4166724994975;6592.703328350236;3574.088607405095;3682.392405253157;3730.5336832895887;3736.084659258499;3754.2303827715255;2625.973740262611;2637.5779875220255;2658.255688407249;2659.9601005984928;2679.5846643769855;483.54305181603047;515.1500024958773;527.3329238513284;530.8938212357544;539.3123767196777;460.5026571302985;518.4400847085215;569.829051284613;607.8601921557978;619.662284055191;7785.338246249019;7811.648475818602;7944.642491087915;8108.675652973933;8185.580960340695;519.9740012999334;599.6168011833511;609.7987664070846;618.5299172628835;638.86903184847;3635.690966267844;3881.146147847469;3953.189596132786;4055.533613634411;4073.9388909166387;45570.772146139054;49026.26460603022;49103;49308;49340.013199735804;42456.78771606184;43923.34114988278;44011.77994110009;44322.778386107864;44384;33840.66159338424;34282.657173428444;37029.25941481155;42615.78692106582;45348.546514534435;8021.358291336795;8201.384896132695;8405.537695426565;8473.718171440112;8538.14618538166;30405.93579224805;30980;31560.053198403166;31783.682163178997;31833.5224971621;36343.818280908425;38751.41872871853;39301.60698392979;39381.606183937794;39542.60457395505;9684.85472717924;9813.656522021694;9972.30193886421;9979.351342162736;10079.798404032024;11096.611618593633;11098.5560577576;11172.664820055412;11273.605423810128;11296.096312295162;10010.799784004133;10216.744581385525;10281.023302786223;10520.21098417637;10522.31604945676;9996.350237234556;10500.317479363817;10527.526261318106;10534.78930421372;10890.891091088988;10026.197904167504;10171.389716617026;10293.284568520832;10309.793804123725;10343;8517.276031537389;8724.69463568772;9163.816723665355;9223;9397.389169703947;8822.07368226327;9013.324000700104;9162.67930622425;9171.449713016973;9252.49111298885 04:52:31 INFO - PROCESS | 3909 | __end_tp_report 04:52:31 INFO - PROCESS | 3909 | __start_cc_report 04:52:31 INFO - PROCESS | 3909 | _x_x_mozilla_cycle_collect,336 04:52:31 INFO - PROCESS | 3909 | __end_cc_report 04:52:31 INFO - PROCESS | 3909 | __startTimestamp1452516751889__endTimestamp 04:52:31 INFO - PROCESS | 3909 | 04:52:31 INFO - PROCESS | 3909 | ------- Summary: start ------- 04:52:31 INFO - PROCESS | 3909 | Number of tests: 6 04:52:31 INFO - PROCESS | 3909 | 04:52:31 INFO - PROCESS | 3909 | [#0] dojo.html Cycles:165 Average:4570.91 Median:4690.58 stddev:457.44 (9.8%) stddev-sans-first:432.44 04:52:31 INFO - PROCESS | 3909 | Values: 2618.5 2684.9 2716.8 2720.7 2721.4 4416.4 4643.0 4712.5 4730.3 4733.7 4517.8 4532.5 4558.6 4647.9 4679.7 4235.5 4346.1 4400.0 4404.0 4442.7 4301.7 4319.7 4320.2 4335.8 4417.8 4089.9 4196.6 4332.2 4372.0 4387.1 4250.1 4306.8 4323.5 4330.0 4346.3 4169.0 4254.6 4263.1 4267.6 4295.6 4278.5 4438.3 4469.9 4491.7 4536.6 4944.5 4951.0 4965.0 4970.8 5005.9 4987.5 4994.0 4999.9 5008.5 5048.5 4446.6 4560.4 4583.5 4674.9 4711.0 5083.3 5089.5 5104.4 5110.0 5117.9 4874.6 4899.7 4901.1 4902.0 4938.7 4713.6 4817.9 4880.3 4919.7 4997.3 4864.4 4873.6 4879.9 4888.2 4934.3 4705.4 4876.1 4878.9 4892.1 4919.5 4124.9 4128.8 4184.9 4191.5 4227.6 3686.2 3702.0 3709.4 3709.8 3740.5 4173.5 4274.5 4324.1 4326.9 4351.8 4888.0 4963.6 4972.7 4980.1 5015.8 4279.0 4328.3 4331.5 4333.5 4375.9 4279.7 4360.0 4397.2 4447.2 4458.9 4690.6 4693.3 4702.8 4703.5 4709.7 4923.6 4928.5 4935.0 4943.9 4977.4 4540.3 4616.3 4645.9 4696.3 4729.3 4894.0 4894.3 4905.6 4916.7 4931.9 4957.5 4992.0 5004.7 5005.7 5045.6 4586.4 4677.6 4714.4 4786.5 4802.2 4746.1 4766.4 4791.8 4795.6 4829.2 4559.1 4649.3 4685.5 4689.2 4737.1 4753.3 4766.1 4848.9 4850.8 4876.9 4672.8 4678.0 4720.8 4723.1 4768.5 04:52:31 INFO - PROCESS | 3909 | 04:52:31 INFO - PROCESS | 3909 | [#1] ext.html Cycles:180 Average:42713.71 Median:19347.66 stddev:74637.12 (385.8%) stddev-sans-first:74779.11 04:52:31 INFO - PROCESS | 3909 | Values: 472.3 493.0 504.8 507.3 511.2 33533.7 33685.0 34181.1 34239.1 34279.0 34096.8 34609.8 34657.5 34684.7 34868.7 7398.7 7566.3 7618.1 7618.5 7628.6 7499.4 7658.5 7680.0 7708.9 7715.1 7707.5 7774.5 7777.1 7777.9 7795.6 7602.5 7619.4 7648.6 7664.2 7696.8 7512.2 7624.0 7626.6 7634.0 7670.0 33459.3 33958.5 33971.3 34068.1 34176.1 2958.2 3252.0 3256.7 3657.6 3662.4 27825.4 27859.2 27998.4 28224.7 28238.0 3491.5 3500.7 3525.4 3571.2 3609.9 209497.0 210955.0 211472.0 211748.0 212469.0 48076.8 49065.8 55096.0 56239.4 57668.0 50076.0 50084.2 50131.7 50224.5 50324.2 13027.7 13053.5 13098.7 13202.3 13216.6 9464.6 9485.5 9488.1 9515.3 9540.0 19205.8 19517.1 19528.7 19604.6 19687.3 7357.8 7492.4 7520.7 7551.0 7649.7 832.8 851.9 860.9 862.4 868.2 23664.8 23902.4 23982.9 24067.5 24250.4 925.4 936.9 939.9 958.4 978.4 13804.8 13918.6 14023.9 14039.4 14401.7 366036.0 372622.0 372862.0 373077.0 375017.0 45736.0 45913.8 46296.3 46494.0 46612.0 1255.2 1260.8 1270.1 1284.7 1292.3 25391.2 26284.6 26294.7 27357.0 27896.4 40291.6 40829.2 40914.2 40914.8 41026.2 240364.0 240946.0 242185.0 243409.0 243435.0 29751.3 40392.4 41076.6 41123.6 41205.8 35194.6 36326.8 36340.5 36591.1 36846.4 30611.4 31059.4 31335.5 31565.7 31948.7 32890.0 33317.5 33744.2 33842.1 33956.2 33198.3 33609.2 33672.0 33736.0 33939.2 28772.9 30452.8 30507.0 30669.2 30812.7 23585.3 23640.8 25285.7 25616.9 26062.9 04:52:31 INFO - PROCESS | 3909 | 04:52:31 INFO - PROCESS | 3909 | [#2] jquery.html Cycles:180 Average:22854.50 Median:28390.32 stddev:69099.22 (243.4%) stddev-sans-first:69272.37 04:52:31 INFO - PROCESS | 3909 | Values: 333.8 334.6 338.0 340.2 340.6 11897.0 12247.3 14632.9 14678.0 15083.2 14106.5 14731.5 14903.7 15624.2 15687.5 4931.5 4936.9 5132.0 5144.7 5146.1 4863.5 5019.7 5151.2 5154.1 5154.6 5074.1 5090.6 5122.0 5566.0 5566.9 5259.6 5729.1 5749.5 5765.4 5766.0 5156.9 5174.2 5176.8 5184.6 5267.6 10942.4 11436.2 11438.5 11439.8 17784.5 1777.8 1819.9 1844.5 1892.1 1961.4 8934.9 8983.1 9185.5 9192.5 11918.0 1719.4 1740.3 1779.7 1849.0 1853.2 49456.8 49887.3 50369.5 50542.5 51623.7 9524.4 9549.5 9694.1 9729.4 9778.5 12239.3 12301.0 12335.6 12455.5 12499.8 6509.5 6680.5 6822.3 6880.4 6934.9 6427.4 6447.5 6451.8 6494.7 6564.8 3986.1 4124.3 4201.3 4201.8 4205.8 1676.1 1743.9 1828.2 1840.0 1840.8 790.2 839.0 861.4 877.2 931.7 14880.0 14968.2 15099.8 15125.8 15254.0 855.2 862.1 882.0 910.8 912.2 8612.9 8631.2 8707.0 8720.5 8767.6 413036.0 418238.0 426480.0 427392.0 430345.0 43695.3 61134.7 61226.0 61798.4 63099.4 971.4 978.3 982.5 993.8 994.7 13278.5 13313.9 13539.4 13616.5 13850.2 30817.2 30851.7 31359.5 31502.8 32321.8 37606.4 39441.4 39479.0 40962.2 41133.8 6358.8 6488.7 6516.2 6714.3 6852.1 8497.8 8706.9 9479.1 9654.1 10097.2 8172.2 8272.1 8470.2 8697.3 8781.5 8573.4 8778.1 8977.0 9155.3 9312.6 8486.6 8506.8 8682.7 8684.5 8917.8 6983.0 7064.4 7079.5 7132.9 7181.5 7756.5 8561.3 8683.4 8767.9 8934.0 04:52:31 INFO - PROCESS | 3909 | 04:52:31 INFO - PROCESS | 3909 | [#3] mootools.html Cycles:180 Average:5206.28 Median:6393.81 stddev:2794.85 (43.7%) stddev-sans-first:2788.07 04:52:31 INFO - PROCESS | 3909 | Values: 1401.8 1418.9 1557.1 1753.9 1767.8 6292.5 6429.5 7344.3 7532.2 7535.3 7167.4 7305.7 7337.9 7350.8 7358.2 2119.1 2122.3 2133.7 2156.1 2157.1 2066.5 2097.2 2140.9 2145.5 2157.5 2085.8 2109.7 2113.5 2127.1 2129.0 2124.0 2133.1 2133.4 2135.0 2141.2 2077.2 2151.4 2153.7 2164.1 2167.0 7704.5 7742.3 7753.5 7759.6 7761.8 4116.6 4239.5 4268.7 4270.1 4301.4 2876.2 2903.6 2910.7 2914.6 2916.7 933.1 974.8 976.5 990.3 994.8 10364.7 10426.7 10440.5 10448.0 10453.5 3877.3 3886.5 3941.3 3947.2 3952.8 8802.9 8848.5 8859.2 8882.8 8903.9 4292.5 4330.9 4355.3 4358.3 4372.2 3240.5 3313.9 3917.5 3956.4 3989.9 3383.2 3388.4 3406.1 3422.9 3435.5 1041.2 1088.7 1091.0 1092.7 1093.3 961.9 965.8 976.6 1008.4 1147.3 6931.0 6981.1 6995.4 7007.5 7162.0 473.7 475.9 478.4 478.8 478.9 5491.6 5505.5 5534.4 5545.2 5573.8 8995.6 9265.7 9281.1 9305.1 9411.8 9050.5 9062.0 9078.5 9144.3 9146.6 6812.9 7022.0 7045.1 7046.9 7071.8 7022.8 7079.4 7089.5 7114.2 7120.9 8023.6 8085.3 8111.5 8164.9 8228.8 8384.8 8457.2 8483.8 8520.0 8545.0 6411.6 6518.9 6593.5 6749.5 6872.9 6944.4 6959.2 6959.6 6980.6 7013.0 6550.8 6630.6 6693.9 6767.0 6797.4 6257.7 6288.9 6654.6 6743.5 6762.9 6608.7 6625.5 6657.8 6663.3 6668.0 6216.8 6326.2 6335.5 6337.0 6356.4 6393.7 6393.9 6443.1 6443.3 6455.8 04:52:31 INFO - PROCESS | 3909 | 04:52:31 INFO - PROCESS | 3909 | [#4] prototype.html Cycles:180 Average:4839.00 Median:5520.91 stddev:1433.97 (26.0%) stddev-sans-first:1397.05 04:52:31 INFO - PROCESS | 3909 | Values: 306.1 309.1 309.3 317.5 319.7 5520.4 5632.5 5674.8 5678.8 5693.9 5521.4 5542.1 5550.7 5553.8 5561.3 4162.1 4250.6 4277.9 4283.5 4296.7 4186.5 4241.6 4253.7 4258.6 4267.5 4211.5 4212.5 4220.3 4221.3 4223.2 4211.4 4252.4 4255.0 4264.2 4267.7 3718.2 3719.4 3725.2 3735.0 3736.0 5147.2 5314.8 5316.1 5330.2 5330.2 4846.4 4860.1 4867.7 4867.8 4874.8 5863.2 5865.9 5874.9 5874.9 5878.8 3994.2 3998.4 3998.4 3999.3 4009.1 5904.5 6146.3 6147.2 6153.1 6153.5 4139.6 4151.4 4158.8 4164.5 4172.6 4212.5 4215.6 4224.5 4232.9 4244.6 4842.7 4863.2 4866.8 4872.3 4873.1 5722.8 5799.7 5830.2 5833.4 5840.5 1470.4 1474.5 1475.7 1479.4 1482.3 1000.2 1002.4 1003.0 1019.1 1024.8 4977.6 5051.3 5062.7 5076.9 5088.2 5794.8 5875.9 5939.9 6029.8 6068.4 5070.9 5100.6 5109.2 5113.8 5126.9 3241.0 3278.3 3309.7 3330.2 3330.5 5623.6 5785.2 5785.4 5786.7 5793.3 6220.4 6246.2 6264.2 6269.2 6283.6 5711.7 5779.0 5780.8 5787.7 5789.0 6090.5 6094.0 6120.8 6131.3 6140.0 5765.3 5887.2 5980.5 5997.2 6008.5 5770.4 5798.2 5799.6 5803.9 5813.3 4149.8 4151.6 4184.9 4186.7 4191.2 5910.6 6081.2 6094.2 6108.9 6116.2 5834.5 5845.7 5864.0 5888.6 5897.8 5815.5 5852.2 5874.8 5876.9 5884.5 5616.7 5690.9 5732.7 5746.6 5780.7 5908.4 5911.5 5912.4 5917.1 5929.2 5619.7 5769.5 5770.5 5781.6 5786.5 04:52:31 INFO - PROCESS | 3909 | 04:52:31 INFO - PROCESS | 3909 | [#5] yui.html Cycles:180 Average:11852.10 Median:472.02 stddev:13275.91 (2812.6%) stddev-sans-first:13286.96 04:52:31 INFO - PROCESS | 3909 | Values: 748.4 788.5 791.4 793.8 809.1 11119.5 11158.4 11167.2 11229.0 11249.1 10100.3 10367.4 10551.6 10615.9 11512.1 759.4 774.2 774.4 774.7 779.4 764.0 767.5 769.3 771.6 771.7 812.4 813.0 814.6 817.1 820.9 812.1 812.4 815.8 816.0 816.7 606.8 607.4 607.5 607.7 608.2 10235.9 10358.3 10399.3 10443.2 10464.5 9627.2 9734.1 9858.0 9884.2 10065.3 8522.4 8791.6 10438.4 10616.0 10717.1 3930.2 3952.4 3974.4 3993.2 4002.6 33705.7 35014.6 35735.6 38292.8 38298.0 9161.5 9227.6 9329.3 9329.5 9487.0 14802.3 14903.5 14991.8 15093.5 15109.7 6347.7 6424.6 6462.8 6481.4 6592.7 3574.1 3682.4 3730.5 3736.1 3754.2 2626.0 2637.6 2658.3 2660.0 2679.6 483.5 515.2 527.3 530.9 539.3 460.5 518.4 569.8 607.9 619.7 7785.3 7811.6 7944.6 8108.7 8185.6 520.0 599.6 609.8 618.5 638.9 3635.7 3881.1 3953.2 4055.5 4073.9 45570.8 49026.3 49103.0 49308.0 49340.0 42456.8 43923.3 44011.8 44322.8 44384.0 33840.7 34282.7 37029.3 42615.8 45348.5 8021.4 8201.4 8405.5 8473.7 8538.1 30405.9 30980.0 31560.1 31783.7 31833.5 36343.8 38751.4 39301.6 39381.6 39542.6 9684.9 9813.7 9972.3 9979.4 10079.8 11096.6 11098.6 11172.7 11273.6 11296.1 10010.8 10216.7 10281.0 10520.2 10522.3 9996.4 10500.3 10527.5 10534.8 10890.9 10026.2 10171.4 10293.3 10309.8 10343.0 8517.3 8724.7 9163.8 9223.0 9397.4 8822.1 9013.3 9162.7 9171.4 9252.5 04:52:31 INFO - PROCESS | 3909 | -------- Summary: end -------- 04:52:31 INFO - PROCESS | 3909 | 04:52:32 INFO - TEST-INFO | 3909: exit 0 04:52:32 INFO - TEST-OK | dromaeo_css | took 1115792ms 04:52:32 INFO - TEST-START | kraken 04:52:32 INFO - operating with platform_type : linux_ 04:52:32 INFO - Initialising browser for kraken test... 04:52:32 INFO - TEST-INFO | started process 4147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Jbwyw/profile http://localhost:53157/getInfo.html) 04:52:36 INFO - PROCESS | 4147 | 04:52:36 INFO - PROCESS | 4147 | (process:4217): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:52:36 INFO - PROCESS | 4147 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 04:52:37 INFO - PROCESS | 4147 | __metrics Screen width/height:1600/1200 04:52:37 INFO - PROCESS | 4147 | colorDepth:24 04:52:37 INFO - PROCESS | 4147 | Browser inner width/height: 1024/697 04:52:37 INFO - PROCESS | 4147 | __metrics 04:52:37 INFO - PROCESS | 4147 | 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:52:38 INFO - TEST-INFO | 4147: exit 0 04:52:38 INFO - Browser initialized. 04:52:38 INFO - Running cycle 1/1 for kraken test... 04:52:38 INFO - TEST-INFO | started process 4266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Jbwyw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:40 INFO - PROCESS | 4266 | 04:52:40 INFO - PROCESS | 4266 | (process:4323): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:52:50 INFO - PROCESS | 4266 | RSS: Main: 150581248 04:52:50 INFO - PROCESS | 4266 | 04:52:53 INFO - PROCESS | 4266 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53157/tests/kraken/driver.html?testName=audio-beat-detection) 04:52:53 INFO - PROCESS | 4266 | RSS: Main: 151433216 04:52:53 INFO - PROCESS | 4266 | 04:52:56 INFO - PROCESS | 4266 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53157/tests/kraken/driver.html?testName=audio-dft) 04:52:57 INFO - PROCESS | 4266 | RSS: Main: 152281088 04:52:57 INFO - PROCESS | 4266 | 04:53:00 INFO - PROCESS | 4266 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53157/tests/kraken/driver.html?testName=audio-fft) 04:53:00 INFO - PROCESS | 4266 | RSS: Main: 147275776 04:53:00 INFO - PROCESS | 4266 | 04:53:02 INFO - PROCESS | 4266 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53157/tests/kraken/driver.html?testName=audio-oscillator) 04:53:03 INFO - PROCESS | 4266 | RSS: Main: 147660800 04:53:03 INFO - PROCESS | 4266 | 04:53:05 INFO - PROCESS | 4266 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53157/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:53:06 INFO - PROCESS | 4266 | RSS: Main: 147369984 04:53:06 INFO - PROCESS | 4266 | 04:53:09 INFO - PROCESS | 4266 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53157/tests/kraken/driver.html?testName=imaging-darkroom) 04:53:09 INFO - PROCESS | 4266 | RSS: Main: 146452480 04:53:09 INFO - PROCESS | 4266 | 04:53:13 INFO - PROCESS | 4266 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53157/tests/kraken/driver.html?testName=imaging-desaturate) 04:53:14 INFO - PROCESS | 4266 | RSS: Main: 146268160 04:53:14 INFO - PROCESS | 4266 | 04:53:16 INFO - PROCESS | 4266 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53157/tests/kraken/driver.html?testName=json-parse-financial) 04:53:17 INFO - PROCESS | 4266 | RSS: Main: 146329600 04:53:17 INFO - PROCESS | 4266 | 04:53:19 INFO - PROCESS | 4266 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53157/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:53:19 INFO - PROCESS | 4266 | RSS: Main: 148824064 04:53:19 INFO - PROCESS | 4266 | 04:53:21 INFO - PROCESS | 4266 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53157/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:53:22 INFO - PROCESS | 4266 | RSS: Main: 149221376 04:53:22 INFO - PROCESS | 4266 | 04:53:24 INFO - PROCESS | 4266 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53157/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:53:25 INFO - PROCESS | 4266 | RSS: Main: 149319680 04:53:25 INFO - PROCESS | 4266 | 04:53:27 INFO - PROCESS | 4266 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53157/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:53:28 INFO - PROCESS | 4266 | RSS: Main: 147181568 04:53:28 INFO - PROCESS | 4266 | 04:53:30 INFO - PROCESS | 4266 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53157/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:53:31 INFO - PROCESS | 4266 | RSS: Main: 149008384 04:53:31 INFO - PROCESS | 4266 | 04:53:33 INFO - PROCESS | 4266 | Cycle 1(1): loaded http://localhost:53157/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53157/tests/kraken/driver.html?testName=ai-astar) 04:53:33 INFO - PROCESS | 4266 | RSS: Main: 148566016 04:53:33 INFO - PROCESS | 4266 | 04:53:33 INFO - PROCESS | 4266 | __start_tp_report 04:53:33 INFO - PROCESS | 4266 | _x_x_mozilla_page_load 04:53:33 INFO - PROCESS | 4266 | _x_x_mozilla_page_load_details 04:53:33 INFO - PROCESS | 4266 | |i|pagename|runs| 04:53:33 INFO - PROCESS | 4266 | |0;ai-astar;112;108;112;115;114;123;116;113;112;112 04:53:33 INFO - PROCESS | 4266 | |1;audio-beat-detection;159;137;165;163;149;155;153;134;163;136 04:53:33 INFO - PROCESS | 4266 | |2;audio-dft;163;164;164;162;165;163;168;162;165;161 04:53:33 INFO - PROCESS | 4266 | |3;audio-fft;73;72;73;73;133;73;72;73;74;92 04:53:33 INFO - PROCESS | 4266 | |4;audio-oscillator;96;98;133;96;97;97;140;98;99;136 04:53:33 INFO - PROCESS | 4266 | |5;imaging-gaussian-blur;110;109;110;109;109;110;110;113;110;110 04:53:33 INFO - PROCESS | 4266 | |6;imaging-darkroom;149;147;148;148;149;148;149;147;149;147 04:53:33 INFO - PROCESS | 4266 | |7;imaging-desaturate;96;98;96;96;95;96;97;96;96;96 04:53:33 INFO - PROCESS | 4266 | |8;json-parse-financial;73;72;73;75;73;73;72;73;70;74 04:53:33 INFO - PROCESS | 4266 | |9;json-stringify-tinderbox;68;69;67;67;68;67;69;69;68;68 04:53:33 INFO - PROCESS | 4266 | |10;stanford-crypto-aes;82;82;85;84;85;83;84;84;86;91 04:53:33 INFO - PROCESS | 4266 | |11;stanford-crypto-ccm;126;128;123;135;125;126;128;139;137;131 04:53:33 INFO - PROCESS | 4266 | |12;stanford-crypto-pbkdf2;136;154;150;139;161;146;146;146;162;146 04:53:33 INFO - PROCESS | 4266 | |13;stanford-crypto-sha256-iterative;75;71;71;72;73;71;71;71;70;72 04:53:33 INFO - PROCESS | 4266 | __end_tp_report 04:53:33 INFO - PROCESS | 4266 | __start_cc_report 04:53:33 INFO - PROCESS | 4266 | _x_x_mozilla_cycle_collect,809 04:53:33 INFO - PROCESS | 4266 | __end_cc_report 04:53:33 INFO - PROCESS | 4266 | __startTimestamp1452516813583__endTimestamp 04:53:33 INFO - PROCESS | 4266 | 04:53:33 INFO - PROCESS | 4266 | ------- Summary: start ------- 04:53:33 INFO - PROCESS | 4266 | Number of tests: 14 04:53:33 INFO - PROCESS | 4266 | 04:53:33 INFO - PROCESS | 4266 | [#0] ai-astar Cycles:10 Average:113.70 Median:113.50 stddev:3.92 (3.5%) stddev-sans-first:4.11 04:53:33 INFO - PROCESS | 4266 | Values: 112.0 108.0 112.0 115.0 114.0 123.0 116.0 113.0 112.0 112.0 04:53:33 INFO - PROCESS | 4266 | 04:53:33 INFO - PROCESS | 4266 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:157.00 stddev:11.93 (7.6%) stddev-sans-first:12.33 04:53:33 INFO - PROCESS | 4266 | Values: 159.0 137.0 165.0 163.0 149.0 155.0 153.0 134.0 163.0 136.0 04:53:33 INFO - PROCESS | 4266 | 04:53:33 INFO - PROCESS | 4266 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:2.00 (1.2%) stddev-sans-first:2.11 04:53:33 INFO - PROCESS | 4266 | Values: 163.0 164.0 164.0 162.0 165.0 163.0 168.0 162.0 165.0 161.0 04:53:33 INFO - PROCESS | 4266 | 04:53:33 INFO - PROCESS | 4266 | [#3] audio-fft Cycles:10 Average:80.80 Median:73.00 stddev:19.31 (26.5%) stddev-sans-first:20.27 04:53:33 INFO - PROCESS | 4266 | Values: 73.0 72.0 73.0 73.0 133.0 73.0 72.0 73.0 74.0 92.0 04:53:33 INFO - PROCESS | 4266 | 04:53:33 INFO - PROCESS | 4266 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:97.00 stddev:18.96 (19.5%) stddev-sans-first:19.51 04:53:33 INFO - PROCESS | 4266 | Values: 96.0 98.0 133.0 96.0 97.0 97.0 140.0 98.0 99.0 136.0 04:53:33 INFO - PROCESS | 4266 | 04:53:33 INFO - PROCESS | 4266 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:1.15 (1.0%) stddev-sans-first:1.22 04:53:33 INFO - PROCESS | 4266 | Values: 110.0 109.0 110.0 109.0 109.0 110.0 110.0 113.0 110.0 110.0 04:53:33 INFO - PROCESS | 4266 | 04:53:33 INFO - PROCESS | 4266 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.50 stddev:0.88 (0.6%) stddev-sans-first:0.87 04:53:33 INFO - PROCESS | 4266 | Values: 149.0 147.0 148.0 148.0 149.0 148.0 149.0 147.0 149.0 147.0 04:53:33 INFO - PROCESS | 4266 | 04:53:33 INFO - PROCESS | 4266 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 04:53:33 INFO - PROCESS | 4266 | Values: 96.0 98.0 96.0 96.0 95.0 96.0 97.0 96.0 96.0 96.0 04:53:33 INFO - PROCESS | 4266 | 04:53:33 INFO - PROCESS | 4266 | [#8] json-parse-financial Cycles:10 Average:72.80 Median:73.00 stddev:1.32 (1.8%) stddev-sans-first:1.39 04:53:33 INFO - PROCESS | 4266 | Values: 73.0 72.0 73.0 75.0 73.0 73.0 72.0 73.0 70.0 74.0 04:53:33 INFO - PROCESS | 4266 | 04:53:33 INFO - PROCESS | 4266 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 04:53:33 INFO - PROCESS | 4266 | Values: 68.0 69.0 67.0 67.0 68.0 67.0 69.0 69.0 68.0 68.0 04:53:33 INFO - PROCESS | 4266 | 04:53:33 INFO - PROCESS | 4266 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.50 stddev:2.59 (3.1%) stddev-sans-first:2.57 04:53:33 INFO - PROCESS | 4266 | Values: 82.0 82.0 85.0 84.0 85.0 83.0 84.0 84.0 86.0 91.0 04:53:33 INFO - PROCESS | 4266 | 04:53:33 INFO - PROCESS | 4266 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:129.50 stddev:5.47 (4.2%) stddev-sans-first:5.63 04:53:33 INFO - PROCESS | 4266 | Values: 126.0 128.0 123.0 135.0 125.0 126.0 128.0 139.0 137.0 131.0 04:53:33 INFO - PROCESS | 4266 | 04:53:33 INFO - PROCESS | 4266 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.60 Median:148.00 stddev:8.45 (5.7%) stddev-sans-first:7.63 04:53:33 INFO - PROCESS | 4266 | Values: 136.0 154.0 150.0 139.0 161.0 146.0 146.0 146.0 162.0 146.0 04:53:33 INFO - PROCESS | 4266 | 04:53:33 INFO - PROCESS | 4266 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:71.50 stddev:1.42 (2.0%) stddev-sans-first:0.87 04:53:33 INFO - PROCESS | 4266 | Values: 75.0 71.0 71.0 72.0 73.0 71.0 71.0 71.0 70.0 72.0 04:53:33 INFO - PROCESS | 4266 | -------- Summary: end -------- 04:53:33 INFO - PROCESS | 4266 | 04:53:34 INFO - TEST-INFO | 4266: exit 0 04:53:34 INFO - TEST-OK | kraken | took 61960ms 04:53:34 INFO - TEST-START | v8_7 04:53:34 INFO - operating with platform_type : linux_ 04:53:34 INFO - Initialising browser for v8_7 test... 04:53:34 INFO - TEST-INFO | started process 4553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptoOhgF/profile http://localhost:53157/getInfo.html) 04:53:38 INFO - PROCESS | 4553 | 04:53:38 INFO - PROCESS | 4553 | (process:4625): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:53:38 INFO - PROCESS | 4553 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 04:53:39 INFO - PROCESS | 4553 | __metrics Screen width/height:1600/1200 04:53:39 INFO - PROCESS | 4553 | colorDepth:24 04:53:39 INFO - PROCESS | 4553 | Browser inner width/height: 1024/697 04:53:39 INFO - PROCESS | 4553 | __metrics 04:53:39 INFO - PROCESS | 4553 | 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:53:40 INFO - TEST-INFO | 4553: exit 0 04:53:40 INFO - Browser initialized. 04:53:40 INFO - Running cycle 1/1 for v8_7 test... 04:53:40 INFO - TEST-INFO | started process 4674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptoOhgF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:42 INFO - PROCESS | 4674 | 04:53:42 INFO - PROCESS | 4674 | (process:4731): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:53:52 INFO - PROCESS | 4674 | RSS: Main: 150499328 04:53:52 INFO - PROCESS | 4674 | 04:54:15 INFO - PROCESS | 4674 | Cycle 1(1): loaded http://localhost:53157/tests/v8_7/run.html (next: http://localhost:53157/tests/v8_7/run.html) 04:54:15 INFO - PROCESS | 4674 | RSS: Main: 145510400 04:54:15 INFO - PROCESS | 4674 | 04:54:15 INFO - PROCESS | 4674 | __start_tp_report 04:54:15 INFO - PROCESS | 4674 | _x_x_mozilla_page_load 04:54:15 INFO - PROCESS | 4674 | _x_x_mozilla_page_load_details 04:54:15 INFO - PROCESS | 4674 | |i|pagename|runs| 04:54:15 INFO - PROCESS | 4674 | |0;Richards;167.42005692281936 04:54:15 INFO - PROCESS | 4674 | |1;DeltaBlue;186.74136321195144 04:54:15 INFO - PROCESS | 4674 | |2;Encrypt;277.9321845469705 04:54:15 INFO - PROCESS | 4674 | |3;Decrypt;5196.891191709845 04:54:15 INFO - PROCESS | 4674 | |4;RayTrace;1071.7344753747323 04:54:15 INFO - PROCESS | 4674 | |5;Earley;728.862973760933 04:54:15 INFO - PROCESS | 4674 | |6;Boyer;12759.493670886075 04:54:15 INFO - PROCESS | 4674 | |7;RegExp;43063.82978723404 04:54:15 INFO - PROCESS | 4674 | |8;Splay;593.3609958506224 04:54:15 INFO - PROCESS | 4674 | |9;NavierStokes;4845.410628019324 04:54:15 INFO - PROCESS | 4674 | __end_tp_report 04:54:15 INFO - PROCESS | 4674 | __startTimestamp1452516855334__endTimestamp 04:54:15 INFO - PROCESS | 4674 | 04:54:15 INFO - PROCESS | 4674 | ------- Summary: start ------- 04:54:15 INFO - PROCESS | 4674 | Number of tests: 10 04:54:15 INFO - PROCESS | 4674 | 04:54:15 INFO - PROCESS | 4674 | [#0] Richards Cycles:1 Average:167.42 Median:167.42 stddev:0.00 (0.0%) 04:54:15 INFO - PROCESS | 4674 | Values: 167.4 04:54:15 INFO - PROCESS | 4674 | 04:54:15 INFO - PROCESS | 4674 | [#1] DeltaBlue Cycles:1 Average:186.74 Median:186.74 stddev:0.00 (0.0%) 04:54:15 INFO - PROCESS | 4674 | Values: 186.7 04:54:15 INFO - PROCESS | 4674 | 04:54:15 INFO - PROCESS | 4674 | [#2] Encrypt Cycles:1 Average:277.93 Median:277.93 stddev:0.00 (0.0%) 04:54:15 INFO - PROCESS | 4674 | Values: 277.9 04:54:15 INFO - PROCESS | 4674 | 04:54:15 INFO - PROCESS | 4674 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 04:54:15 INFO - PROCESS | 4674 | Values: 5196.9 04:54:15 INFO - PROCESS | 4674 | 04:54:15 INFO - PROCESS | 4674 | [#4] RayTrace Cycles:1 Average:1071.73 Median:1071.73 stddev:0.00 (0.0%) 04:54:15 INFO - PROCESS | 4674 | Values: 1071.7 04:54:15 INFO - PROCESS | 4674 | 04:54:15 INFO - PROCESS | 4674 | [#5] Earley Cycles:1 Average:728.86 Median:728.86 stddev:0.00 (0.0%) 04:54:15 INFO - PROCESS | 4674 | Values: 728.9 04:54:15 INFO - PROCESS | 4674 | 04:54:15 INFO - PROCESS | 4674 | [#6] Boyer Cycles:1 Average:12759.49 Median:12759.49 stddev:0.00 (0.0%) 04:54:15 INFO - PROCESS | 4674 | Values: 12759.5 04:54:15 INFO - PROCESS | 4674 | 04:54:15 INFO - PROCESS | 4674 | [#7] RegExp Cycles:1 Average:43063.83 Median:43063.83 stddev:0.00 (0.0%) 04:54:15 INFO - PROCESS | 4674 | Values: 43063.8 04:54:15 INFO - PROCESS | 4674 | 04:54:15 INFO - PROCESS | 4674 | [#8] Splay Cycles:1 Average:593.36 Median:593.36 stddev:0.00 (0.0%) 04:54:15 INFO - PROCESS | 4674 | Values: 593.4 04:54:15 INFO - PROCESS | 4674 | 04:54:15 INFO - PROCESS | 4674 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 04:54:15 INFO - PROCESS | 4674 | Values: 4845.4 04:54:15 INFO - PROCESS | 4674 | -------- Summary: end -------- 04:54:15 INFO - PROCESS | 4674 | 04:54:16 INFO - TEST-INFO | 4674: exit 0 04:54:16 INFO - TEST-OK | v8_7 | took 41702ms 04:54:16 INFO - SUITE-END | took 1219s 04:54:16 INFO - Completed test suite (00:20:19) 04:54:16 INFO - Working with test: dromaeo_css 04:54:16 INFO - Generating results file: dromaeo_css 04:54:16 INFO - Working with test: kraken 04:54:16 INFO - Generating results file: kraken 04:54:16 INFO - javascript benchmark 04:54:16 INFO - Working with test: v8_7 04:54:16 INFO - Generating results file: v8_7 04:54:16 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:54:16 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 04:54:16 INFO - process_Request line: dromaeo_css 6224.69 graph.html#tests=[[72,94,43]] 04:54:16 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:54:16 INFO - process_Request line: kraken 1548.40 graph.html#tests=[[232,94,43]] 04:54:16 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:54:16 INFO - process_Request line: v8_7 20211.13 graph.html#tests=[[230,94,43]] 04:54:16 INFO - RETURN: dromaeo_css: 6224.69 04:54:16 INFO - RETURN: kraken: 1548.40 04:54:16 INFO - RETURN: v8_7: 20211.13 04:54:16 INFO - javascript benchmark 04:54:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2618.5024845279395, 2684.9328766780814, 2716.796240281978, 2720.741529554692, 2721.401291715822, 4416.403785488958, 4642.976785116078, 4712.505186955367, 4730.3141044548565, 4733.692309999857, 4517.819287228515, 4532.52408497108, 4558.635309175266, 4647.860564183072, 4679.74261415622, 4235.512916014659, 4346.130773845228, 4400.031992961559, 4404.031113155101, 4442.711223770445, 4301.720388174775, 4319.69762116652, 4320.179165958473, 4335.826566937319, 4417.779111044435, 4089.89775255618, 4196.643285320752, 4332.155229730204, 4371.956280437218, 4387.122575484916, 4250.149970006011, 4306.784660766949, 4323.524412314643, 4329.9567004329865, 4346.261135606923, 4168.958310416918, 4254.553271906436, 4263.147370525907, 4267.573242675708, 4295.634871035965, 4278.507971583276, 4438.334249862546, 4469.932951005705, 4491.708038977488, 4536.591706746409, 4944.480829512921, 4951.0, 4965.0, 4970.751462426864, 5005.924911126336, 4987.476314986947, 4993.950060499385, 4999.875003124915, 5008.499150084999, 5048.5203905628905, 4446.644268458548, 4560.429946256718, 4583.495815460296, 4674.883127921829, 4711.01068775561, 5083.339165908408, 5089.51649593288, 5104.438511763703, 5110.0, 5117.923231151536, 4874.610031197496, 4899.681520701143, 4901.142300097468, 4902.0, 4938.6789858659795, 4713.599344055725, 4817.927731084036, 4880.316755654211, 4919.680220785637, 4997.250412438163, 4864.367632207861, 4873.561379475864, 4879.935344079531, 4888.2178851384315, 4934.284528743384, 4705.435347758223, 4876.097921884463, 4878.853634390974, 4892.070506603805, 4919.4834542373255, 4124.91750164995, 4128.8348466061025, 4184.916301673949, 4191.455110835572, 4227.556106608823, 3686.225892562592, 3701.9819549624067, 3709.3694072007825, 3709.795961222159, 3740.4576336431064, 4173.499180098347, 4274.4870615525715, 4324.091940692427, 4326.913461730748, 4351.782410879507, 4888.0, 4963.5780958618925, 4972.676776009548, 4980.078685443133, 5015.799368025311, 4279.037216626297, 4328.264195086843, 4331.480222373335, 4333.544977777288, 4375.890602734957, 4279.700420970502, 4359.9782001090425, 4397.2085024695225, 4447.2217361962175, 4458.910821783546, 4690.577847993697, 4693.27254275581, 4702.764861756898, 4703.459102203222, 4709.7174169549935, 4923.6307276955085, 4928.457869634409, 4934.950650493449, 4943.925841112458, 4977.377827771528, 4540.296254080623, 4616.307553866947, 4645.907081858411, 4696.272077827942, 4729.337892694956, 4893.975530122327, 4894.314795928502, 4905.632077594266, 4916.655834091723, 4931.914978704679, 4957.504249575014, 4991.9500804991485, 5004.674696144739, 5005.674631148963, 5045.571126454292, 4586.449626044762, 4677.602403795716, 4714.434267887876, 4786.473487916396, 4802.183628783185, 4746.145693775154, 4766.404199475066, 4791.784369703302, 4795.592374648194, 4829.154897892784, 4559.088182363607, 4649.256119020941, 4685.5080216578135, 4689.179393606037, 4737.07627012743, 4753.263244197155, 4766.094442055998, 4848.854534363974, 4850.80596776125, 4876.902461950812, 4672.836450724209, 4677.9942312403, 4720.811167553396, 4723.055388922298, 4768.546988036131], "unit": "score", "name": "dojo.html", "value": 4543.758015953455}, {"lowerIsBetter": false, "replicates": [472.34108418755835, 493.03611439635506, 504.8258350868951, 507.31005832068394, 511.19231614049806, 33533.66466335336, 33685.0, 34181.1454713632, 34239.14402139944, 34279.0, 34096.82951585238, 34609.82695086521, 34657.48013779789, 34684.653153468455, 34868.651313486924, 7398.6670599823, 7566.281203285679, 7618.123915749677, 7618.5428874267445, 7628.618569071552, 7499.362554182901, 7658.463907526475, 7679.961600191991, 7708.884366734504, 7715.112762032354, 7707.499012564193, 7774.49465784725, 7777.144514103444, 7777.883331750028, 7795.5712435816, 7602.50583712057, 7619.42854285928, 7648.617569121521, 7664.233576642347, 7696.807579810522, 7512.248775122444, 7624.00887884577, 7626.6186690665245, 7633.9618301908695, 7670.0, 33459.330813383836, 33958.49062264068, 33971.32057358839, 34068.148296292544, 34176.14559636004, 2958.216072740704, 3252.0243926822095, 3256.739460843127, 3657.561092668897, 3662.3957047087465, 27825.443491130063, 27859.16422507328, 27998.440031199465, 28224.71775282262, 28238.0, 3491.458823882302, 3500.6674365935196, 3525.3830579648716, 3571.160777217352, 3609.9278014439565, 209497.0, 210955.0, 211472.0, 211748.0, 212468.99999999846, 48076.79808004758, 49065.754671226416, 55096.0, 56239.43760562342, 57668.0, 50076.0, 50084.248736268986, 50131.74934125379, 50224.49775502271, 50324.245136322985, 13027.674308142183, 13053.477860885458, 13098.672533186747, 13202.33988300581, 13216.603501894959, 9464.621415143454, 9485.478298693639, 9488.098630630078, 9515.286353523514, 9539.952300238454, 19205.75453319352, 19517.088557055085, 19528.70706939397, 19604.607907841764, 19687.310944116885, 7357.816054598571, 7492.438067144986, 7520.699172033057, 7551.0, 7649.694012239559, 832.8334333133398, 851.8935133108362, 860.9397342185987, 862.3704695572142, 868.2229404682773, 23664.7633523666, 23902.402439939142, 23982.88008559946, 24067.51864962691, 24250.393740156636, 925.379995403068, 936.864154697565, 939.9013103624158, 958.4297343080856, 978.3542861711379, 13804.792928106086, 13918.58244252674, 14023.929880350737, 14039.438422463192, 14401.711965760625, 366036.0, 372622.0, 372862.0, 373077.0, 375017.0, 45736.0, 45913.770431148296, 46296.30555541669, 46494.0, 46612.0, 1255.2029461292145, 1260.7982722764314, 1270.1490001698885, 1284.7303612306703, 1292.3086148910288, 25391.238262852145, 26284.60573091367, 26294.73705262923, 27357.0, 27896.44207115887, 40291.597084028785, 40829.183416332104, 40914.18171636491, 40914.79542602387, 41026.1794764109, 240364.0, 240946.0, 242185.0, 243409.0, 243435.0, 29751.25621859471, 40392.39411408772, 41076.589234107276, 41123.58876411317, 41205.793971029954, 35194.64805351914, 36326.818365908, 36340.454893176095, 36591.08522286964, 36846.44730329101, 30611.387772243987, 31059.37881242408, 31335.529967050967, 31565.684343156274, 31948.68051319457, 32890.0, 33317.50023749597, 33744.15639609029, 33842.09289653036, 33956.15109622279, 33198.33603327968, 33609.15977100494, 33672.0, 33736.0, 33939.15152121217, 28772.856135720023, 30452.84773576118, 30507.0, 30669.23326916845, 30812.69187308188, 23585.29244122679, 23640.763592363855, 25285.74714252834, 25616.871915640302, 26062.86968565145], "unit": "score", "name": "ext.html", "value": 16702.7100650992}, {"lowerIsBetter": false, "replicates": [333.76969890775365, 334.580101972025, 337.9594448666159, 340.2463543251697, 340.59979524059224, 11897.0, 12247.326397048158, 14632.926835365835, 14678.04592701475, 15083.170425626586, 14106.506272280472, 14731.48439804607, 14903.7019259615, 15624.218789060558, 15687.529374118767, 4931.5315045070665, 4936.92594611082, 5131.97360527894, 5144.691318520882, 5146.073706732786, 4863.465018847924, 5019.673721208128, 5151.201563757623, 5154.149565321717, 5154.639175257734, 5074.06129865976, 5090.567301779334, 5122.0, 5566.0, 5566.944330556683, 5259.631825772198, 5729.054705973509, 5749.453801888814, 5765.394633563478, 5766.048601980689, 5156.896862062776, 5174.197999310113, 5176.7929282828645, 5184.559312458446, 5267.578593712532, 10942.398168100752, 11436.19946603738, 11438.485268162953, 11439.828402573969, 17784.46646600604, 1777.8222177782247, 1819.881707688996, 1844.4598760035387, 1892.0917959379437, 1961.3919684897585, 8934.927808662937, 8983.10168983103, 9185.540722963891, 9192.540372981324, 11918.0, 1719.415398764426, 1740.2516917725372, 1779.6529676713046, 1848.9815101848944, 1853.2309091726918, 49456.75271623655, 49887.2516912243, 50369.496305036846, 50542.494575054145, 51623.74188129073, 9524.380915240627, 9549.474778887228, 9694.127528522467, 9729.367591106555, 9778.511074446391, 12239.265644061385, 12301.0, 12335.568255111028, 12455.501779928702, 12499.75000500003, 6509.479241660656, 6680.498962577826, 6822.317768223138, 6880.449564034865, 6934.930650693529, 6427.389398007182, 6447.484201263981, 6451.806445806634, 6494.675266236669, 6564.8358791030605, 3986.142979259473, 4124.340105583153, 4201.306784380543, 4201.789910504463, 4205.789710514462, 1676.0530300380246, 1743.8517725993433, 1828.1681834765416, 1839.9632007359778, 1840.7699037620298, 790.2018960849583, 838.9622466989, 861.3841103610948, 877.2278408074852, 931.7158266728712, 14880.032797868103, 14968.176750278839, 15099.849001510063, 15125.848741512444, 15254.0, 855.2473823035689, 862.0991064337782, 881.9857164261151, 910.7677542226822, 912.1608120529129, 8612.8708069379, 8631.180037896389, 8706.95646521776, 8720.520371379635, 8767.649294028295, 413036.0, 418238.0, 426480.0, 427392.0, 430345.0, 43695.344569831475, 61134.694326528974, 61226.0, 61798.38201617926, 63099.36900631027, 971.3540495570367, 978.3005151316843, 982.4841957971979, 993.8310487217046, 994.6618149829093, 13278.53525126616, 13313.933430332787, 13539.390727417092, 13616.523421680193, 13850.168989860238, 30817.22956926005, 30851.69148308488, 31359.529607056367, 31502.84248578834, 32321.838390807894, 37606.43590346092, 39441.40837887376, 39479.01302467461, 40962.18075638411, 41133.794331028155, 6358.77744278948, 6488.740450381932, 6516.218053833571, 6714.261431242462, 6852.109225800614, 8497.787555310919, 8706.869396958924, 9479.146876781122, 9654.082862128087, 10097.242706797166, 8172.18278172178, 8272.131426200162, 8470.207409183442, 8697.304215662605, 8781.473111613324, 8573.356998225034, 8778.078301778221, 8977.0, 9155.26757859383, 9312.627494900127, 8486.61810218554, 8506.829863402574, 8682.652693892174, 8684.522351270742, 8917.821643567222, 6982.965085174542, 7064.442472405276, 7079.504434689522, 7132.928670713434, 7181.497295189287, 7756.461643405858, 8561.315094792526, 8683.392162548562, 8767.868481972902, 8933.955330223307], "unit": "score", "name": "jquery.html", "value": 7420.649950572147}, {"lowerIsBetter": false, "replicates": [1401.7546929287373, 1418.9361478733458, 1557.135789636752, 1753.9123043847806, 1767.7967033791117, 6292.528060395466, 6429.4534964528075, 7344.302291282326, 7532.171461139277, 7535.321821036106, 7167.354938055574, 7305.6712447939835, 7337.926620733804, 7350.779476615697, 7358.190599034102, 2119.088791819517, 2122.2784253353857, 2133.7332833395826, 2156.0728886578763, 2157.1048015073725, 2066.5143691232547, 2097.2240271099713, 2140.8715477071346, 2145.4850835799375, 2157.5361297321074, 2085.8435617328687, 2109.715188449563, 2113.4505028692574, 2127.127877570189, 2128.968065479019, 2124.044180118945, 2133.0934352900035, 2133.434639820449, 2135.0392323454353, 2141.1756473757637, 2077.2314243729766, 2151.376100930728, 2153.7092492513466, 2164.0910817456706, 2167.0, 7704.46068775186, 7742.303192712627, 7753.4960227585025, 7759.573223472707, 7761.7671469855995, 4116.629503344713, 4239.512456067561, 4268.658507319407, 4270.0605866709275, 4301.419308393358, 2876.1659118855505, 2903.578981047757, 2910.6507219133628, 2914.606528118698, 2916.7229113234207, 933.0948979489951, 974.8294048541477, 976.5068640336656, 990.2919412620012, 994.8259054665477, 10364.689059328231, 10426.68719938403, 10440.477976101165, 10448.0, 10453.477326133663, 3877.263319969253, 3886.4753258310334, 3941.3299739044432, 3947.1513624570857, 3952.8023598819946, 8802.943646762302, 8848.513331766815, 8859.24696400813, 8882.822343553093, 8903.910960890309, 4292.5063617683745, 4330.891727706832, 4355.303151495746, 4358.3244597087505, 4372.23485889968, 3240.513922911582, 3313.93372132556, 3917.490726205632, 3956.3669812829808, 3989.940150897739, 3383.204946837491, 3388.373150967079, 3406.0633325835097, 3422.863085476553, 3435.4675025371107, 1041.1514615588271, 1088.7387027113436, 1090.9781804364027, 1092.6558134187705, 1093.3439936038471, 961.9326647134774, 965.758560359896, 976.5654283843763, 1008.3899240959261, 1147.3402793393832, 6931.0, 6981.05755722981, 6995.440364770806, 7007.544509606859, 7162.033125528092, 473.70630209270473, 475.9452662943806, 478.40438653876146, 478.77258302306126, 478.88506758377736, 5491.560675145979, 5505.476979686923, 5534.418886016991, 5545.195946587723, 5573.804916827891, 8995.595198216097, 9265.72202833916, 9281.071892810665, 9305.11601397866, 9411.764705882408, 9050.502222377832, 9062.0, 9078.54607269647, 9144.314176436794, 9146.588403521857, 6812.909934410471, 7021.964890175618, 7045.084139061992, 7046.894296585555, 7071.752488662872, 7022.754203602849, 7079.433645308466, 7089.539179953286, 7114.217436081924, 7120.896261079541, 8023.558704271088, 8085.312748416451, 8111.472754270953, 8164.877526837221, 8228.794280142805, 8384.832303353776, 8457.154284571494, 8483.787905302417, 8520.0, 8545.0, 6411.551191416556, 6518.902216466851, 6593.505487088391, 6749.493787965824, 6872.896906546506, 6944.444444444332, 6959.234484206632, 6959.617221052688, 6980.616066116209, 7013.0, 6550.7707230246715, 6630.602163870183, 6693.866122677617, 6767.018782276444, 6797.354251346114, 6257.749690012349, 6288.874222515616, 6654.600723956578, 6743.460523158234, 6762.8647427052165, 6608.7356505739235, 6625.536212465081, 6657.800265992028, 6663.26704062543, 6668.0331351954665, 6216.813495595139, 6326.177596912372, 6335.461485773761, 6337.04944258365, 6356.4279214870885, 6393.7122829471855, 6393.904091438539, 6443.065755465525, 6443.323451037761, 6455.838604034937], "unit": "score", "name": "mootools.html", "value": 4167.857338643039}, {"lowerIsBetter": false, "replicates": [306.0695485723401, 309.1113049981304, 309.2516111011354, 317.54432389521037, 319.68191649308943, 5520.365158006831, 5632.549396048316, 5674.801381951637, 5678.829635110948, 5693.914591281134, 5521.4478552144865, 5542.1132618781, 5550.7224638768, 5553.805616803413, 5561.332640083186, 4162.125953549758, 4250.61744443, 4277.850275240367, 4283.507396649394, 4296.699231053827, 4186.518550366701, 4241.575842415749, 4253.702240843142, 4258.574142585748, 4267.48790145183, 4211.452511173543, 4212.53662097169, 4220.26145424551, 4221.32458806591, 4223.1975924574235, 4211.38934854446, 4252.362145678142, 4254.978725106385, 4264.168487145008, 4267.679924005681, 3718.1634132320282, 3719.4048952167796, 3725.217704282104, 3735.010222291095, 3736.047307936486, 5147.22791581262, 5314.7608357624, 5316.069687804618, 5330.173823057432, 5330.227117068003, 4846.418429788413, 4860.05228980349, 4867.70793752376, 4867.82962596311, 4874.8050077997195, 5863.208466856962, 5865.912011319833, 5874.853128671817, 5874.882502349929, 5878.823635290948, 3994.1811928554575, 3998.3602623580086, 3998.3802510610903, 3999.3001224785835, 4009.1380353224195, 5904.47124063714, 6146.323904370515, 6147.2008638877105, 6153.1077993691115, 6153.507719382484, 4139.627433530996, 4151.4395556600075, 4158.8336466541605, 4164.541900390955, 4172.582741725803, 4212.473440819897, 4215.57844215576, 4224.5353011168745, 4232.894177645522, 4244.554321796167, 4842.7336496493035, 4863.2461968394955, 4866.82966096192, 4872.317875497433, 4873.122837889214, 5722.7982123753645, 5799.652020878676, 5830.242068531149, 5833.445822646841, 5840.503557197686, 1470.4265336518765, 1474.4544518528214, 1475.7196132734746, 1479.3934486860335, 1482.2959094430275, 1000.2248257600418, 1002.3935519010894, 1002.9949850250848, 1019.0879163148941, 1024.774549599087, 4977.626677999165, 5051.26756620288, 5062.6709263898465, 5076.923846142311, 5088.185890257541, 5794.82615521535, 5875.941240587625, 5939.881202376015, 6029.849253768691, 6068.362821903636, 5070.898582028339, 5100.591952643779, 5109.233614957786, 5113.769880355393, 5126.87182820425, 3240.990585836796, 3278.3115545735664, 3309.7352211822995, 3330.150811543041, 3330.5012744264695, 5623.578231632562, 5785.190073389729, 5785.4214578541805, 5786.652800831964, 5793.304803423532, 6220.440160385587, 6246.187995560548, 6264.248290205113, 6269.216347956505, 6283.59156654816, 5711.742971566289, 5778.971105144531, 5780.826575202751, 5787.652740835563, 5789.044807606698, 6090.512758979183, 6093.969530152321, 6120.785772497941, 6131.294901086432, 6140.0, 5765.308163020464, 5887.20522729426, 5980.491658209101, 5997.160397544434, 6008.459238668366, 5770.365259821332, 5798.15926690619, 5799.565032622486, 5803.883922321445, 5813.273340832396, 4149.792510374409, 4151.564085771071, 4184.8744537663915, 4186.68599855006, 4191.161767646422, 5910.645361278337, 6081.209442772588, 6094.238220222473, 6108.8778224436155, 6116.204893363834, 5834.474897259267, 5845.678487683218, 5864.0, 5888.587798854211, 5897.823065308047, 5815.505682016907, 5852.151438041546, 5874.765009399576, 5876.853078673067, 5884.529237660891, 5616.66300022, 5690.886182276414, 5732.656040637575, 5746.626469279484, 5780.710964451677, 5908.409159084057, 5911.527077833849, 5912.438318359749, 5917.142014407973, 5929.229200203946, 5619.690916999604, 5769.451902069297, 5770.451807078321, 5781.595288329777, 5786.508146807569], "unit": "score", "name": "prototype.html", "value": 4376.059735343983}, {"lowerIsBetter": false, "replicates": [748.4311922938565, 788.4756636836504, 791.357932290497, 793.7817100297418, 809.1140201479379, 11119.499622516985, 11158.442077896094, 11167.162462815291, 11229.0, 11249.10007199422, 10100.292979491438, 10367.42979136149, 10551.577936882515, 10615.893841061586, 11512.079033677306, 759.4380158682591, 774.1871035412794, 774.3572834547313, 774.7288449042846, 779.4388040610779, 764.0487592946789, 767.474280118118, 769.2884082223949, 771.6488997506121, 771.7260372567741, 812.4028838803474, 812.9552874591895, 814.5519964019795, 817.1093508076195, 820.9384296177781, 812.0823469479479, 812.354178428151, 815.808285053012, 816.0370762500247, 816.7141500474816, 606.8452544601098, 607.3622696169004, 607.5413063137347, 607.6870411737958, 608.2154021312501, 10235.948820255851, 10358.326708763982, 10399.272050956437, 10443.164546836235, 10464.476776161238, 9627.181689556395, 9734.075262850018, 9857.950710246403, 9884.202846038872, 10065.295429319951, 8522.40343175978, 8791.60437780295, 10438.373697578094, 10616.04455598992, 10717.142628589694, 3930.1746633207063, 3952.3676211805973, 3974.4435778990965, 3993.201359728037, 4002.639762421367, 33705.662943370495, 35014.649853501396, 35735.64264357375, 38292.80853595714, 38298.042548936224, 9161.541922903829, 9227.584758685874, 9329.300302477206, 9329.486878221764, 9487.003864594257, 14802.259887005823, 14903.478378256708, 14991.775123373158, 15093.54719358421, 15109.697806043818, 6347.682615869188, 6424.646644434601, 6462.773802916875, 6481.4166724994975, 6592.703328350236, 3574.088607405095, 3682.392405253157, 3730.5336832895887, 3736.084659258499, 3754.2303827715255, 2625.973740262611, 2637.5779875220255, 2658.255688407249, 2659.9601005984928, 2679.5846643769855, 483.54305181603047, 515.1500024958773, 527.3329238513284, 530.8938212357544, 539.3123767196777, 460.5026571302985, 518.4400847085215, 569.829051284613, 607.8601921557978, 619.662284055191, 7785.338246249019, 7811.648475818602, 7944.642491087915, 8108.675652973933, 8185.580960340695, 519.9740012999334, 599.6168011833511, 609.7987664070846, 618.5299172628835, 638.86903184847, 3635.690966267844, 3881.146147847469, 3953.189596132786, 4055.533613634411, 4073.9388909166387, 45570.772146139054, 49026.26460603022, 49103.0, 49308.0, 49340.013199735804, 42456.78771606184, 43923.34114988278, 44011.77994110009, 44322.778386107864, 44384.0, 33840.66159338424, 34282.657173428444, 37029.25941481155, 42615.78692106582, 45348.546514534435, 8021.358291336795, 8201.384896132695, 8405.537695426565, 8473.718171440112, 8538.14618538166, 30405.93579224805, 30980.0, 31560.053198403166, 31783.682163178997, 31833.5224971621, 36343.818280908425, 38751.41872871853, 39301.60698392979, 39381.606183937794, 39542.60457395505, 9684.85472717924, 9813.656522021694, 9972.30193886421, 9979.351342162736, 10079.798404032024, 11096.611618593633, 11098.5560577576, 11172.664820055412, 11273.605423810128, 11296.096312295162, 10010.799784004133, 10216.744581385525, 10281.023302786223, 10520.21098417637, 10522.31604945676, 9996.350237234556, 10500.317479363817, 10527.526261318106, 10534.78930421372, 10890.891091088988, 10026.197904167504, 10171.389716617026, 10293.284568520832, 10309.793804123725, 10343.0, 8517.276031537389, 8724.69463568772, 9163.816723665355, 9223.0, 9397.389169703947, 8822.07368226327, 9013.324000700104, 9162.67930622425, 9171.449713016973, 9252.49111298885], "unit": "score", "name": "yui.html", "value": 5662.688928885852}], "name": "dromaeo_css", "value": 6224.685514978789}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 112.0, 115.0, 114.0, 123.0, 116.0, 113.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.7}, {"lowerIsBetter": true, "replicates": [159.0, 137.0, 165.0, 163.0, 149.0, 155.0, 153.0, 134.0, 163.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 151.4}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 164.0, 162.0, 165.0, 163.0, 168.0, 162.0, 165.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 73.0, 133.0, 73.0, 72.0, 73.0, 74.0, 92.0], "unit": "score", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 133.0, 96.0, 97.0, 97.0, 140.0, 98.0, 99.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 113.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 148.0, 148.0, 149.0, 148.0, 149.0, 147.0, 149.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 148.1}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 96.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 75.0, 73.0, 73.0, 72.0, 73.0, 70.0, 74.0], "unit": "score", "name": "json-parse-financial", "value": 72.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 67.0, 68.0, 67.0, 69.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 85.0, 84.0, 85.0, 83.0, 84.0, 84.0, 86.0, 91.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [126.0, 128.0, 123.0, 135.0, 125.0, 126.0, 128.0, 139.0, 137.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.8}, {"lowerIsBetter": true, "replicates": [136.0, 154.0, 150.0, 139.0, 161.0, 146.0, 146.0, 146.0, 162.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.6}, {"lowerIsBetter": true, "replicates": [75.0, 71.0, 71.0, 72.0, 73.0, 71.0, 71.0, 71.0, 70.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.7}], "name": "kraken", "value": 1548.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.42005692281936], "unit": "score", "name": "Richards", "value": 210.8588460000001}, {"lowerIsBetter": false, "replicates": [186.74136321195144], "unit": "score", "name": "DeltaBlue", "value": 354.06189}, {"lowerIsBetter": false, "replicates": [277.9321845469705], "unit": "score", "name": "Encrypt", "value": 957.7192379999997}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1071.7344753747323], "unit": "score", "name": "RayTrace", "value": 690.4592667332666}, {"lowerIsBetter": false, "replicates": [728.862973760933], "unit": "score", "name": "Earley", "value": 914.3872360000001}, {"lowerIsBetter": false, "replicates": [12759.493670886075], "unit": "score", "name": "Boyer", "value": 52.23271527777782}, {"lowerIsBetter": false, "replicates": [43063.82978723404], "unit": "score", "name": "RegExp", "value": 21.154295948616586}, {"lowerIsBetter": false, "replicates": [593.3609958506224], "unit": "score", "name": "Splay", "value": 137.337979020979}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20211.132606973395}]} 04:54:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "20211.13"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1548.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6224.69"}}} 04:54:16 INFO - Return code: 0 04:54:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:54:16 INFO - # TBPL SUCCESS # 04:54:16 INFO - Running post-action listener: _resource_record_post_action 04:54:16 INFO - Running post-run listener: _resource_record_post_run 04:54:17 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4001792; Write bytes: 329572352; Read time: 352; Write time: 217732 04:54:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13557760; Read time: 0; Write time: 9376 04:54:17 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4001792; Write bytes: 316014592; Read time: 352; Write time: 208356 04:54:17 INFO - Running post-run listener: _upload_blobber_files 04:54:17 INFO - Blob upload gear active. 04:54:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:54:17 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:54:17 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:54:17 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:54:18 INFO - (blobuploader) - INFO - Open directory for files ... 04:54:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:54:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:54:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:19 INFO - (blobuploader) - INFO - Done attempting. 04:54:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:54:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:54:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:19 INFO - (blobuploader) - INFO - Done attempting. 04:54:19 INFO - (blobuploader) - INFO - Iteration through files over. 04:54:19 INFO - Return code: 0 04:54:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:54:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:54:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d8bc1ae1d4eb7f157584ca6b5485e17eddff9b04092966c41c99ed85a25493f195556c81afb6c2c6705e888c725c21d8f36f7a51e728132b4fab9df07bd12fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87d695a91d251aa8d6706ee716faefe544a33e276e91e7018d614b4d93acb845384236ca5c82b19579c3ddd3779c03108f2d542362889e5ed34a6eb6f0be2b15"} 04:54:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:54:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:54:19 INFO - Contents: 04:54:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d8bc1ae1d4eb7f157584ca6b5485e17eddff9b04092966c41c99ed85a25493f195556c81afb6c2c6705e888c725c21d8f36f7a51e728132b4fab9df07bd12fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87d695a91d251aa8d6706ee716faefe544a33e276e91e7018d614b4d93acb845384236ca5c82b19579c3ddd3779c03108f2d542362889e5ed34a6eb6f0be2b15"} 04:54:19 INFO - Copying logs to upload dir... 04:54:19 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1288.554347 ========= master_lag: 2.85 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2016-01-11 04:54:22.107389) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 04:54:22.113016) ========= 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=f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668 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/6d8bc1ae1d4eb7f157584ca6b5485e17eddff9b04092966c41c99ed85a25493f195556c81afb6c2c6705e888c725c21d8f36f7a51e728132b4fab9df07bd12fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87d695a91d251aa8d6706ee716faefe544a33e276e91e7018d614b4d93acb845384236ca5c82b19579c3ddd3779c03108f2d542362889e5ed34a6eb6f0be2b15"} build_url:https://queue.taskcluster.net/v1/task/CtSaJbA4Rpu70De88DWA5A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011226 build_url: 'https://queue.taskcluster.net/v1/task/CtSaJbA4Rpu70De88DWA5A/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/6d8bc1ae1d4eb7f157584ca6b5485e17eddff9b04092966c41c99ed85a25493f195556c81afb6c2c6705e888c725c21d8f36f7a51e728132b4fab9df07bd12fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/87d695a91d251aa8d6706ee716faefe544a33e276e91e7018d614b4d93acb845384236ca5c82b19579c3ddd3779c03108f2d542362889e5ed34a6eb6f0be2b15"}' ========= master_lag: 0.21 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 04:54:22.334449) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:54:22.334931) ========= 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=f919189b672bc2eeae365d21000001d6-1452497374.426900-1232475668 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 04:54:22.350862) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 04:54:22.351177) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 04:54:22.351475) ========= ========= Total master_lag: 3.22 =========